Project

General

Profile

Edit History

IO-sipit29 » History » Version 9

Adrian Georgescu, 10/24/2011 03:34 PM

1 1 Adrian Georgescu 
= SIPIT 29 =
2 2 Adrian Georgescu 





    3
    3
    Adrian Georgescu
    
== Sending BYE exception when using TCP transport ==





    4
    2
    Adrian Georgescu
    





    5
    6
    Adrian Georgescu
    
The problem occurs when proxy is stateless and is requesting authorization for the BYE.





    6
    
    
    
 





    7
    
    
    





    8
    5
    Adrian Georgescu
    
{{{





    9
    
    
    
SENDING: Packet 188, +0:14:23.287009





    10
    
    
    
2011-10-24 11:35:51.825513: 132.177.252.163:51280 -(SIP over tls)-> 132.177.253.22:5061





    11
    
    
    
INVITE sip:ag02@cisco.sipit.net SIP/2.0





    12
    
    
    
Via: SIP/2.0/tls 132.177.252.163:51280;rport;branch=z9hG4bKPjGqaVmgy6QI4hqusA17.VmYbSEjEn1S-y





    13
    
    
    
Max-Forwards: 70





    14
    
    
    
From: "Adrian Georgescu" <sip:ag01@cisco.sipit.net>;tag=tG4TWxTurelH-rGZRnivbJ96jCHFsQS8





    15
    
    
    
To: <sip:ag02@cisco.sipit.net>





    16
    
    
    
Contact: <sip:doszpemb@132.177.252.163:51544;transport=tls>





    17
    
    
    
Call-ID: wm-ihLWnDBKwk743UftUCoP-H5qoETv-





    18
    
    
    
CSeq: 4485 INVITE





    19
    
    
    
Allow: SUBSCRIBE, NOTIFY, PRACK, INVITE, ACK, BYE, CANCEL, UPDATE, MESSAGE, REFER





    20
    
    
    
Supported: 100rel, replaces, norefersub





    21
    
    
    
User-Agent: Blink Pro 1.3.1 (MacOSX)





    22
    
    
    
Proxy-Authorization: Digest username="cisco", realm="h1.cisco.sipit.net", nonce="5f8327823b80b7c1ad635e68c6ab5ef8b1ac0010d74c76ea30d139be4b0e", uri="sip:ag02@cisco.sipit.net", response="02829cb450bd6f420e8f980f80dec000", algorithm=MD5, cnonce="WMYZEu5MhMBRJr97hlz3Nxqd9pidFkvZ", opaque="AQAAANXGRIqnJLpaa2+oaGI3teAaoA95", qop=auth, nc=00000001





    23
    
    
    
Content-Type: application/sdp





    24
    
    
    
Content-Length:   269





    25
    
    
    





    26
    
    
    
v=0





    27
    
    
    
o=- 3528437751 3528437751 IN IP4 132.177.252.163





    28
    
    
    
s=Blink Pro 1.3.1 (MacOSX)





    29
    
    
    
c=IN IP4 132.177.252.163





    30
    
    
    
t=0 0





    31
    
    
    
m=audio 50004 RTP/AVP 9 0 101





    32
    
    
    
a=rtcp:50005





    33
    
    
    
a=rtpmap:9 G722/8000





    34
    
    
    
a=rtpmap:0 PCMU/8000





    35
    
    
    
a=rtpmap:101 telephone-event/8000





    36
    
    
    
a=fmtp:101 0-15





    37
    
    
    
a=sendrecv





    38
    
    
    





    39
    
    
    
RECEIVED: Packet 189, +0:14:23.333731





    40
    
    
    
2011-10-24 11:35:51.872235: 132.177.253.22:5061 -(SIP over tls)-> 132.177.252.163:51280





    41
    
    
    
SIP/2.0 100 Trying





    42
    
    
    
Via: SIP/2.0/tls 132.177.252.163:51280;branch=z9hG4bKPjGqaVmgy6QI4hqusA17.VmYbSEjEn1S-y;received=132.177.252.163;rport=51280;ingress-zone=DefaultZone





    43
    
    
    
Call-ID: wm-ihLWnDBKwk743UftUCoP-H5qoETv-





    44
    
    
    
CSeq: 4485 INVITE





    45
    
    
    
From: "Adrian Georgescu" <sip:ag01@cisco.sipit.net>;tag=tG4TWxTurelH-rGZRnivbJ96jCHFsQS8





    46
    
    
    
To: <sip:ag02@cisco.sipit.net>





    47
    
    
    
Server: TANDBERG/4103 (X7.1PreAlpha29 (TEST SW))





    48
    
    
    
Content-Length: 0





    49
    
    
    





    50
    
    
    
RECEIVED: Packet 190, +0:14:23.380310





    51
    
    
    
2011-10-24 11:35:51.918814: 132.177.253.22:5061 -(SIP over tls)-> 132.177.252.163:51280





    52
    
    
    
SIP/2.0 180 Ringing





    53
    
    
    
Via: SIP/2.0/tls 132.177.252.163:51280;rport=51280;received=132.177.252.163;branch=z9hG4bKPjGqaVmgy6QI4hqusA17.VmYbSEjEn1S-y;ingress-zone=DefaultZone





    54
    
    
    
Call-ID: wm-ihLWnDBKwk743UftUCoP-H5qoETv-





    55
    
    
    
CSeq: 4485 INVITE





    56
    
    
    
Contact: <sip:qwbivsgz@132.177.252.111:60868>





    57
    
    
    
From: "Adrian Georgescu" <sip:ag01@cisco.sipit.net>;tag=tG4TWxTurelH-rGZRnivbJ96jCHFsQS8





    58
    
    
    
To: <sip:ag02@cisco.sipit.net>;tag=nkEDOGe3nL5K7PwTs1-DzrwUmbdzAYUy





    59
    
    
    
Record-Route: <sip:proxy-call-id=9041af5c-fe23-11e0-8ac1-000c29ab0f7b@132.177.253.22:5060;transport=udp;lr>





    60
    
    
    
Record-Route: <sip:proxy-call-id=9041af5c-fe23-11e0-8ac1-000c29ab0f7b@132.177.253.22:5061;transport=tls;lr>





    61
    
    
    
Allow: SUBSCRIBE,NOTIFY,PRACK,INVITE,ACK,BYE,CANCEL,UPDATE,MESSAGE,REFER





    62
    
    
    
Server: Blink Pro 1.3.1 (MacOSX)





    63
    
    
    
Content-Length: 0





    64
    
    
    





    65
    
    
    
RECEIVED: Packet 191, +0:14:28.691178





    66
    
    
    
2011-10-24 11:35:57.229682: 132.177.253.22:5061 -(SIP over tls)-> 132.177.252.163:51280





    67
    
    
    
SIP/2.0 200 OK





    68
    
    
    
Via: SIP/2.0/tls 132.177.252.163:51280;rport=51280;received=132.177.252.163;branch=z9hG4bKPjGqaVmgy6QI4hqusA17.VmYbSEjEn1S-y;ingress-zone=DefaultZone





    69
    
    
    
Call-ID: wm-ihLWnDBKwk743UftUCoP-H5qoETv-





    70
    
    
    
CSeq: 4485 INVITE





    71
    
    
    
Contact: <sip:qwbivsgz@132.177.252.111:60868>





    72
    
    
    
From: "Adrian Georgescu" <sip:ag01@cisco.sipit.net>;tag=tG4TWxTurelH-rGZRnivbJ96jCHFsQS8





    73
    
    
    
To: <sip:ag02@cisco.sipit.net>;tag=nkEDOGe3nL5K7PwTs1-DzrwUmbdzAYUy





    74
    
    
    
Record-Route: <sip:proxy-call-id=9041af5c-fe23-11e0-8ac1-000c29ab0f7b@132.177.253.22:5060;transport=udp;lr>





    75
    
    
    
Record-Route: <sip:proxy-call-id=9041af5c-fe23-11e0-8ac1-000c29ab0f7b@132.177.253.22:5061;transport=tls;lr>





    76
    
    
    
Allow: SUBSCRIBE,NOTIFY,PRACK,INVITE,ACK,BYE,CANCEL,UPDATE,MESSAGE,REFER





    77
    
    
    
Server: Blink Pro 1.3.1 (MacOSX)





    78
    
    
    
Supported: 100rel,replaces,norefersub





    79
    
    
    
Content-Type: application/sdp





    80
    
    
    
Content-Length: 255





    81
    
    
    





    82
    
    
    
v=0





    83
    
    
    
o=- 3528437757 3528437758 IN IP4 132.177.252.111





    84
    
    
    
s=Blink Pro 1.3.1 (MacOSX)





    85
    
    
    
c=IN IP4 132.177.252.111





    86
    
    
    
b=AS:384





    87
    
    
    
t=0 0





    88
    
    
    
m=audio 50018 RTP/AVP 9 101





    89
    
    
    
a=rtcp:50019





    90
    
    
    
a=rtpmap:9 G722/8000





    91
    
    
    
a=rtpmap:101 telephone-event/8000





    92
    
    
    
a=fmtp:101 0-15





    93
    
    
    
a=sendrecv





    94
    
    
    





    95
    
    
    
SENDING: Packet 192, +0:14:28.691472





    96
    
    
    
2011-10-24 11:35:57.229976: 132.177.252.163:51280 -(SIP over tls)-> 132.177.253.22:5061





    97
    
    
    
ACK sip:qwbivsgz@132.177.252.111:60868 SIP/2.0





    98
    
    
    
Via: SIP/2.0/tls 132.177.252.163:51280;rport;branch=z9hG4bKPjydOyhHyq82C92apBgV97cGE2r.G2e4GO





    99
    
    
    
Max-Forwards: 70





    100
    
    
    
From: "Adrian Georgescu" <sip:ag01@cisco.sipit.net>;tag=tG4TWxTurelH-rGZRnivbJ96jCHFsQS8





    101
    
    
    
To: <sip:ag02@cisco.sipit.net>;tag=nkEDOGe3nL5K7PwTs1-DzrwUmbdzAYUy





    102
    
    
    
Call-ID: wm-ihLWnDBKwk743UftUCoP-H5qoETv-





    103
    
    
    
CSeq: 4485 ACK





    104
    
    
    
Route: <sip:proxy-call-id=9041af5c-fe23-11e0-8ac1-000c29ab0f7b@132.177.253.22:5061;transport=tls;lr>





    105
    
    
    
Route: <sip:proxy-call-id=9041af5c-fe23-11e0-8ac1-000c29ab0f7b@132.177.253.22:5060;transport=udp;lr>





    106
    
    
    
User-Agent: Blink Pro 1.3.1 (MacOSX)





    107
    
    
    
Content-Length:  0





    108
    
    
    





    109
    
    
    
SENDING: Packet 193, +0:14:32.184140





    110
    
    
    
2011-10-24 11:36:00.722644: 132.177.252.163:51280 -(SIP over tls)-> 132.177.253.22:5061





    111
    
    
    
BYE sip:qwbivsgz@132.177.252.111:60868 SIP/2.0





    112
    
    
    
Via: SIP/2.0/tls 132.177.252.163:51280;rport;branch=z9hG4bKPjqWIKkD-f1CW8BystKkNHu3QQ.HhB920m





    113
    
    
    
Max-Forwards: 70





    114
    
    
    
From: "Adrian Georgescu" <sip:ag01@cisco.sipit.net>;tag=tG4TWxTurelH-rGZRnivbJ96jCHFsQS8





    115
    
    
    
To: <sip:ag02@cisco.sipit.net>;tag=nkEDOGe3nL5K7PwTs1-DzrwUmbdzAYUy





    116
    
    
    
Call-ID: wm-ihLWnDBKwk743UftUCoP-H5qoETv-





    117
    
    
    
CSeq: 4486 BYE





    118
    
    
    
Route: <sip:proxy-call-id=9041af5c-fe23-11e0-8ac1-000c29ab0f7b@132.177.253.22:5061;transport=tls;lr>





    119
    
    
    
Route: <sip:proxy-call-id=9041af5c-fe23-11e0-8ac1-000c29ab0f7b@132.177.253.22:5060;transport=udp;lr>





    120
    
    
    
User-Agent: Blink Pro 1.3.1 (MacOSX)





    121
    
    
    
Content-Length:  0





    122
    
    
    





    123
    
    
    
RECEIVED: Packet 194, +0:14:32.185918





    124
    
    
    
2011-10-24 11:36:00.724422: 132.177.253.22:5061 -(SIP over tls)-> 132.177.252.163:51280





    125
    
    
    
SIP/2.0 407 Proxy Authentication Required





    126
    
    
    
Via: SIP/2.0/tls 132.177.252.163:51280;branch=z9hG4bKPjqWIKkD-f1CW8BystKkNHu3QQ.HhB920m;received=132.177.252.163;rport=51280





    127
    
    
    
Call-ID: wm-ihLWnDBKwk743UftUCoP-H5qoETv-





    128
    
    
    
CSeq: 4486 BYE





    129
    
    
    
From: "Adrian Georgescu" <sip:ag01@cisco.sipit.net>;tag=tG4TWxTurelH-rGZRnivbJ96jCHFsQS8





    130
    
    
    
To: <sip:ag02@cisco.sipit.net>;tag=nkEDOGe3nL5K7PwTs1-DzrwUmbdzAYUy





    131
    
    
    
Server: TANDBERG/4103 (X7.1PreAlpha29 (TEST SW))





    132
    
    
    
Proxy-Authenticate: Digest realm="h1.cisco.sipit.net", nonce="ecf10cc969b2858a1f46ce145b58ba291426098f076e4fa29924531f706e", opaque="AQAAANXGRIqnJLpaa2+oaGI3teAaoA95", stale=FALSE, algorithm=MD5, qop="auth"





    133
    
    
    
Content-Length: 0





    134
    
    
    





    135
    
    
    
SENDING: Packet 195, +0:14:32.186342





    136
    
    
    
2011-10-24 11:36:00.724846: 132.177.252.163:51280 -(SIP over tls)-> 132.177.253.22:5061





    137
    
    
    
BYE sip:qwbivsgz@132.177.252.111:60868 SIP/2.0





    138
    
    
    
Via: SIP/2.0/tls 132.177.252.163:51280;rport;branch=z9hG4bKPj7LZjnOhpR57.YTxGAv42MyoF7RSBupjk





    139
    
    
    
Max-Forwards: 70





    140
    
    
    
From: "Adrian Georgescu" <sip:ag01@cisco.sipit.net>;tag=tG4TWxTurelH-rGZRnivbJ96jCHFsQS8





    141
    
    
    
To: <sip:ag02@cisco.sipit.net>;tag=nkEDOGe3nL5K7PwTs1-DzrwUmbdzAYUy





    142
    
    
    
Call-ID: wm-ihLWnDBKwk743UftUCoP-H5qoETv-





    143
    
    
    
CSeq: 4487 BYE





    144
    
    
    
Route: <sip:proxy-call-id=9041af5c-fe23-11e0-8ac1-000c29ab0f7b@132.177.253.22:5061;transport=tls;lr>





    145
    
    
    
Route: <sip:proxy-call-id=9041af5c-fe23-11e0-8ac1-000c29ab0f7b@132.177.253.22:5060;transport=udp;lr>





    146
    
    
    
User-Agent: Blink Pro 1.3.1 (MacOSX)





    147
    
    
    
Proxy-Authorization: Digest username="cisco", realm="h1.cisco.sipit.net", nonce="ecf10cc969b2858a1f46ce145b58ba291426098f076e4fa29924531f706e", uri="sip:qwbivsgz@132.177.252.111:60868", response="6ed728af6b1b5443c953ec89d17151c6", algorithm=MD5, cnonce="WMYZEu5MhMBRJr97hlz3Nxqd9pidFkvZ", opaque="AQAAANXGRIqnJLpaa2+oaGI3teAaoA95", qop=auth, nc=00000001





    148
    
    
    
Content-Length:  0





    149
    
    
    





    150
    
    
    
RECEIVED: Packet 196, +0:14:32.203260





    151
    
    
    
2011-10-24 11:36:00.741764: 132.177.253.22:5061 -(SIP over tls)-> 132.177.252.163:51280





    152
    
    
    
SIP/2.0 200 OK





    153
    
    
    
Via: SIP/2.0/tls 132.177.252.163:51280;rport=51280;received=132.177.252.163;branch=z9hG4bKPj7LZjnOhpR57.YTxGAv42MyoF7RSBupjk;ingress-zone=DefaultZone





    154
    
    
    
Call-ID: wm-ihLWnDBKwk743UftUCoP-H5qoETv-





    155
    
    
    
CSeq: 4487 BYE





    156
    
    
    
From: "Adrian Georgescu" <sip:ag01@cisco.sipit.net>;tag=tG4TWxTurelH-rGZRnivbJ96jCHFsQS8





    157
    
    
    
To: <sip:ag02@cisco.sipit.net>;tag=nkEDOGe3nL5K7PwTs1-DzrwUmbdzAYUy





    158
    
    
    
Server: Blink Pro 1.3.1 (MacOSX)





    159
    
    
    
Content-Length: 0





    160
    
    
    





    161
    
    
    
2011-10-24 11:36:12.346891: DNS lookup A h1.cisco.sipit.net succeeded, ttl=600: 132.177.253.22





    162
    
    
    





    163
    
    
    





    164
    
    
    
}}}





    165
    2
    Adrian Georgescu
    





    166
    
    
    
{{{





    167
    
    
    
2011-10-24 10:42:21.419 Blink Pro[1668:a0f] [Session with ag02@cisco.sipit.net] Ending session with audio stream





    168
    
    
    
2011-10-24 10:42:21.457 Blink Pro[1668:6527] Traceback (most recent call last):





    169
    
    
    
  File "/Users/adigeo/work/blink/build/Release/Blink Pro.app/Contents/Resources/lib/twisted/internet/base.py", line 757, in runUntilCurrent





    170
    
    
    
    call.func(*call.args, **call.kw)





    171
    
    
    
  File "/Users/adigeo/work/blink/build/Release/Blink Pro.app/Contents/Resources/lib/eventlet/coros.py", line 253, in _do_acquire





    172
    
    
    
    waiter.switch()





    173
    
    
    
  File "/Users/adigeo/work/blink/build/Release/Blink Pro.app/Contents/Resources/lib/eventlet/api.py", line 235, in _spawn_startup





    174
    
    
    
    return cb(*args, **kw)





    175
    
    
    
  File "/Users/adigeo/work/blink/build/Release/Blink Pro.app/Contents/Resources/lib/sipsimple/session.py", line 1904, in end





    176
    
    
    
    TimestampedNotificationData(originator='local', method='BYE', code=notification.data.code, reason=notification.data.reason))





    177
    
    
    
AttributeError: 'NotificationData' object has no attribute 'code'





    178
    
    
    
2011-10-24 10:42:21.474 Blink Pro[1668:a0f] [Session with ag02@cisco.sipit.net] Session will end (local)





    179
    
    
    
2011-10-24 10:42:21.643 Blink Pro[1668:a0f] [Session with ag02@cisco.sipit.net] Audio stream ended





    180
    
    
    
}}}





    181
    
    
    





    182
    
    
    





    183
    
    
    





    184
    
    
    
{{{





    185
    
    
    
2011-10-24 10:31:00.239837: Notification name=SIPInvitationChangedState





    186
    
    
    
sender=<sipsimple.core._core.Invitation object at 0x18c5ab10>





    187
    
    
    
data=NotificationData(originator='local', body=None, prev_sub_state='normal',





    188
    
    
    
timestamp=datetime.datetime(2011, 10, 24, 10, 31, 0, 232073), headers={'Via':





    189
    
    
    
[FrozenViaHeader('tls', '132.177.252.163', 50951, frozendict({'rport': 0,





    190
    
    
    
'branch': 'z9hG4bKPj5bKvhluLSr5OxNTM0vdb4umkCpVNtox8'}))], 'From':





    191
    
    
    
FrozenFromHeader(FrozenSIPURI('cisco.sipit.net', 'ag01', None, None, False,





    192
    
    
    
frozendict({}), frozendict({})), u'Adrian Georgescu', frozendict({'tag':





    193
    
    
    
'kfOPAVWAfIHorykAJBu31vAmIZif780n'})), 'Route':





    194
    
    
    
[FrozenRouteHeader(FrozenSIPURI('132.177.253.22',





    195
    
    
    
'proxy-call-id=844482fa-fe1a-11e0-bd41-000c29ab0f7b', None, 5061, False,





    196
    
    
    
frozendict({'lr': 1, 'transport': 'tls'}), frozendict({})), None,





    197
    
    
    
frozendict({})), FrozenRouteHeader(FrozenSIPURI('132.177.253.22',





    198
    
    
    
'proxy-call-id=844482fa-fe1a-11e0-bd41-000c29ab0f7b', None, 5061, False,





    199
    
    
    
frozendict({'lr': 1, 'transport': 'tls'}), frozendict({})), None,





    200
    
    
    
frozendict({}))], 'User-Agent': FrozenHeader('User-Agent', 'Blink Pro 1.3.1





    201
    
    
    
(MacOSX)'), 'To': FrozenToHeader(FrozenSIPURI('cisco.sipit.net', 'ag02', None,





    202
    
    
    
None, False, frozendict({}), frozendict({})), None, frozendict({'tag':





    203
    
    
    
'-9Gm-krVFw154HwQh5W.UsZY12oHT9di'})), 'CSeq': (8401, 'BYE'), 'Call-ID':





    204
    
    
    
FrozenHeader('Call-ID', 'JzYfmKI6hZg0iBD9t4WdpKNhW6SyQzlm'), 'Max-Forwards':





    205
    
    
    
70}, state='disconnecting', prev_state='connected', method='BYE',





    206
    
    
    
request_uri=FrozenSIPURI('132.177.252.111', 'qwbivsgz', None, 51564, False,





    207
    
    
    
frozendict({'transport': 'tls'}), frozendict({})))





    208
    
    
    





    209
    
    
    





    210
    
    
    
2011-10-24 10:31:00.259586: Notification name=SIPInvitationChangedState





    211
    
    
    
sender=<sipsimple.core._core.Invitation object at 0x18c5ab10>





    212
    
    
    
data=NotificationData(originator='local', disconnect_reason='user request',





    213
    
    
    
state='disconnected', prev_state='disconnecting',





    214
    1
    Adrian Georgescu
    
timestamp=datetime.datetime(2011, 10, 24, 10, 31, 0, 250102))





    215
    3
    Adrian Georgescu
    
}}}





    216
    
    
    





    217
    
    
    





    218
    
    
    
200 OK rdata seems to be none for received 200OK for the sent out BYE





    219
    
    
    





    220
    
    
    





    221
    
    
    
=== UDP trace that works ===





    222
    
    
    





    223
    
    
    
{{{





    224
    
    
    
2011-10-24 10:46:07.277414: Notification name=SIPInvitationChangedState





    225
    
    
    
sender=<sipsimple.core._core.Invitation object at 0x18c5abf8>





    226
    
    
    
data=NotificationData(originator='local', body=None, prev_sub_state='normal',





    227
    
    
    
timestamp=datetime.datetime(2011, 10, 24, 10, 46, 7, 268879), headers={'Via':





    228
    
    
    
[FrozenViaHeader('UDP', '132.177.252.163', 60653, frozendict({'rport': 0,





    229
    
    
    
'branch': 'z9hG4bKPjVWjI8ftu8DW7rR5WhnOsbgpAWQFpbFYT'}))], 'From':





    230
    
    
    
FrozenFromHeader(FrozenSIPURI('cisco.sipit.net', 'ag01', None, None, False,





    231
    
    
    
frozendict({}), frozendict({})), u'Adrian Georgescu', frozendict({'tag':





    232
    
    
    
'M5uaZcSknKymRnkGTjRG88C8DG99m5Hy'})), 'Route':





    233
    
    
    
[FrozenRouteHeader(FrozenSIPURI('132.177.253.22',





    234
    
    
    
'proxy-call-id=99e57f04-fe1c-11e0-ba17-000c29ab0f7b', None, 5060, False,





    235
    
    
    
frozendict({'lr': 1, 'transport': 'udp'}), frozendict({})), None,





    236
    
    
    
frozendict({})), FrozenRouteHeader(FrozenSIPURI('132.177.253.22',





    237
    
    
    
'proxy-call-id=99e57f04-fe1c-11e0-ba17-000c29ab0f7b', None, 5060, False,





    238
    
    
    
frozendict({'lr': 1, 'transport': 'tcp'}), frozendict({})), None,





    239
    
    
    
frozendict({}))], 'User-Agent': FrozenHeader('User-Agent', 'Blink Pro 1.3.1





    240
    
    
    
(MacOSX)'), 'To': FrozenToHeader(FrozenSIPURI('cisco.sipit.net', 'ag02', None,





    241
    
    
    
None, False, frozendict({}), frozendict({})), None, frozendict({'tag':





    242
    
    
    
'hNd9U3UKc.VP-1WWYP-S8MegH2yeRc5e'})), 'CSeq': (28697, 'BYE'), 'Call-ID':





    243
    
    
    
FrozenHeader('Call-ID', '41QYdm0-Eny2uHKzgETWx57HhGq47xPl'), 'Max-Forwards':





    244
    
    
    
70}, state='disconnecting', prev_state='connected', method='BYE',





    245
    
    
    
request_uri=FrozenSIPURI('132.177.252.111', 'qwbivsgz', None, 51252, False,





    246
    
    
    
frozendict({'transport': 'tcp'}), frozendict({})))





    247
    
    
    





    248
    
    
    





    249
    
    
    
2011-10-24 10:46:07.293137: Notification name=SIPInvitationChangedState





    250
    
    
    
sender=<sipsimple.core._core.Invitation object at 0x18c5abf8>





    251
    
    
    
data=NotificationData(originator='remote', body=None, code=200,





    252
    
    
    
disconnect_reason='user request', timestamp=datetime.datetime(2011, 10, 24, 10,





    253
    
    
    
46, 7, 287860), state='disconnected', headers={'Content-Length': 0, 'Via':





    254
    
    
    
[FrozenViaHeader('UDP', '132.177.252.163', 60653, frozendict({'received':





    255
    
    
    
'132.177.252.163', 'ingress-zone': 'DefaultSubZone', 'rport': 60653, 'branch':





    256
    
    
    
'z9hG4bKPjB6pOFsn58EsyG4sXhsB.72oClDLkXjEW'}))], 'From':





    257
    
    
    
FrozenFromHeader(FrozenSIPURI('cisco.sipit.net', 'ag01', None, None, False,





    258
    
    
    
frozendict({}), frozendict({})), u'Adrian Georgescu', frozendict({'tag':





    259
    
    
    
'M5uaZcSknKymRnkGTjRG88C8DG99m5Hy'})), 'Server': FrozenHeader('Server', 'Blink





    260
    
    
    
Pro 1.3.1 (MacOSX)'), 'To': FrozenToHeader(FrozenSIPURI('cisco.sipit.net',





    261
    
    
    
'ag02', None, None, False, frozendict({}), frozendict({})), None,





    262
    
    
    
frozendict({'tag': 'hNd9U3UKc.VP-1WWYP-S8MegH2yeRc5e'})), 'CSeq': (28698,





    263
    
    
    
'BYE'), 'Call-ID': FrozenHeader('Call-ID', '41QYdm0-Eny2uHKzgETWx57HhGq47xPl')},





    264
    
    
    
reason='OK', prev_state='disconnecting')





    265
    2
    Adrian Georgescu
    
}}}





    266
    7
    Adrian Georgescu
    





    267
    
    
    





    268
    9
    Adrian Georgescu
    
== MSRP Error (Solved) ==





    269
    7
    Adrian Georgescu
    





    270
    9
    Adrian Georgescu
    
Incoming session is cancelled by remote before we have the chance to initialize msrp media stream.





    271
    8
    Adrian Georgescu
    





    272
    7
    Adrian Georgescu
    
{{{





    273
    
    
    
2011-10-24 13:24:24.311 Blink Pro[3997:a0f] [Session with ag02@cisco.sipit.net] Session ended





    274
    
    
    
2011-10-24 13:25:07.452 Blink Pro[3997:6527] Account('ag01@cisco.sipit.net') registered contact "sip:ohwvastb@132.177.252.163:52017;transport=tls" at 132.177.253.22:5061;transport=tls for 93 seconds





    275
    
    
    
2011-10-24 13:26:10.570 Blink Pro[3997:6527] Account('ag01@cisco.sipit.net') registered contact "sip:ohwvastb@132.177.252.163:52017;transport=tls" at 132.177.253.22:5061;transport=tls for 93 seconds





    276
    
    
    
2011-10-24 13:26:43.250 Blink Pro[3997:a0f] Incoming session request from GES <ges@georgescu.info> with chat streams





    277
    
    
    
2011-10-24 13:27:13.688 Blink Pro[3997:6527] Account('ag01@cisco.sipit.net') registered contact "sip:ohwvastb@132.177.252.163:52017;transport=tls" at 132.177.253.22:5061;transport=tls for 93 seconds





    278
    
    
    
2011-10-24 13:27:21.438 Blink Pro[3997:a0f] Accepting session to ges@georgescu.info





    279
    
    
    
2011-10-24 13:27:21.440 Blink Pro[3997:a0f] [Session with ges@georgescu.info] Handling incoming chat stream





    280
    
    
    
2011-10-24 13:27:21.730 Blink Pro[3997:6527] Starting factory <eventlet.twistedutil.protocol.GreenInstanceFactory instance at 0x1885c620>





    281
    
    
    
2011-10-24 13:27:21.740 Blink Pro[3997:6527] /etc/resolv.conf changed, reparsing





    282
    
    
    
2011-10-24 13:27:21.740 Blink Pro[3997:6527] Resolver added ('132.177.252.2', 53) to server list





    283
    
    
    
2011-10-24 13:27:21.742 Blink Pro[3997:6527] <class 'twisted.names.dns.DNSDatagramProtocol'> starting on 54952





    284
    
    
    
2011-10-24 13:27:21.742 Blink Pro[3997:6527] Starting protocol <twisted.names.dns.DNSDatagramProtocol object at 0x18c0a490>





    285
    
    
    
2011-10-24 13:27:21.939 Blink Pro[3997:6527] (Port 54952 Closed)





    286
    
    
    
2011-10-24 13:27:21.940 Blink Pro[3997:6527] Stopping protocol <twisted.names.dns.DNSDatagramProtocol object at 0x18c0a490>





    287
    
    
    
2011-10-24 13:27:23.978 Blink Pro[3997:6527] Traceback (most recent call last):





    288
    
    
    
  File "/Users/adigeo/work/blink/build/Release/Blink Pro.app/Contents/Resources/lib/twisted/internet/base.py", line 757, in runUntilCurrent





    289
    
    
    
    call.func(*call.args, **call.kw)





    290
    
    
    
  File "/Users/adigeo/work/blink/build/Release/Blink Pro.app/Contents/Resources/lib/eventlet/hubs/twistedr.py", line 159, in call_if_greenlet_alive





    291
    
    
    
    return func(*args1, **kwargs1)





    292
    
    
    
  File "/Users/adigeo/work/blink/build/Release/Blink Pro.app/Contents/Resources/lib/eventlet/api.py", line 235, in _spawn_startup





    293
    
    
    
    return cb(*args, **kw)





    294
    
    
    
  File "/Users/adigeo/work/blink/build/Release/Blink Pro.app/Contents/Resources/lib/sipsimple/streams/msrp.py", line 260, in end





    295
    
    
    
    notification_center.remove_observer(self, sender=self)





    296
    
    
    
  File "/Users/adigeo/work/blink/build/Release/Blink Pro.app/Contents/Resources/lib/application/notification.py", line 164, in remove_observer





    297
    1
    Adrian Georgescu
    
    raise KeyError("observer %r not registered for %r events from %r" % (observer, name, sender))





    298
    
    
    
KeyError: 'observer <sipsimple.streams.msrp.ChatStream object at 0x1860cfd0> not registered for Any events from <sipsimple.streams.msrp.ChatStream object at 0x1860cfd0>'





    299
    9
    Adrian Georgescu
    
}}}





    300
    
    
    





    301
    
    
    
== Multiple reconnect for MSRP and cancel ==





    302
    
    
    





    303
    
    
    





    304
    
    
    





    305
    
    
    
{{{





    306
    
    
    
2011-10-24 15:31:07.196 Blink Pro[3997:a0f] [Session with agp@conference.sip2sip.info] Initiating DNS Lookup of Account('31208005169@ag-projects.com') to sip:agp@conference.sip2sip.info





    307
    
    
    
2011-10-24 15:31:07.205 Blink Pro[3997:a0f] Starting DNS Lookup for sip:agp@conference.sip2sip.info via proxy of account 31208005169@ag-projects.com





    308
    
    
    
2011-10-24 15:31:07.212 Blink Pro[3997:6527] DNS Lookup for sip:agp@conference.sip2sip.info succeeded: 85.17.186.7:5060 (UDP), 81.23.228.129:5060 (UDP)





    309
    
    
    
2011-10-24 15:31:07.248 Blink Pro[3997:a0f] [Session with agp@conference.sip2sip.info] Connecting session





    310
    
    
    
2011-10-24 15:31:07.262 Blink Pro[3997:a0f] Starting Outgoing Session to agp@conference.sip2sip.info with ['chat']





    311
    
    
    
2011-10-24 15:31:07.287 Blink Pro[3997:a0f] [Session with agp@conference.sip2sip.info] Ending session with chat stream





    312
    
    
    
2011-10-24 15:31:07.317 Blink Pro[3997:a0f] [Session with agp@conference.sip2sip.info] Session cancelled





    313
    
    
    
2011-10-24 15:31:07.364 Blink Pro[3997:a0f] [Session with agp@conference.sip2sip.info] Re-establishing session to agp@conference.sip2sip.info





    314
    
    
    
2011-10-24 15:31:07.414 Blink Pro[3997:a0f] [Session with agp@conference.sip2sip.info] Initiating DNS Lookup of Account('31208005169@ag-projects.com') to sip:agp@conference.sip2sip.info





    315
    
    
    
2011-10-24 15:31:07.423 Blink Pro[3997:a0f] Starting DNS Lookup for sip:agp@conference.sip2sip.info via proxy of account 31208005169@ag-projects.com





    316
    
    
    
2011-10-24 15:31:07.430 Blink Pro[3997:6527] DNS Lookup for sip:agp@conference.sip2sip.info succeeded: 85.17.186.7:5060 (UDP), 81.23.228.129:5060 (UDP)





    317
    
    
    
2011-10-24 15:31:07.470 Blink Pro[3997:a0f] [Session with agp@conference.sip2sip.info] Connecting session





    318
    
    
    
2011-10-24 15:31:07.473 Blink Pro[3997:a0f] Starting Outgoing Session to agp@conference.sip2sip.info with ['chat']





    319
    
    
    
2011-10-24 15:31:07.501 Blink Pro[3997:a0f] [Session with agp@conference.sip2sip.info] Ending session with chat stream





    320
    
    
    
2011-10-24 15:31:07.532 Blink Pro[3997:a0f] [Session with agp@conference.sip2sip.info] Session cancelled





    321
    
    
    
2011-10-24 15:31:07.625 Blink Pro[3997:a0f] [Session with agp@conference.sip2sip.info] Re-establishing session to agp@conference.sip2sip.info





    322
    
    
    
2011-10-24 15:31:07.696 Blink Pro[3997:6527] Traceback (most recent call last):





    323
    
    
    
  File "/Users/adigeo/work/blink/build/Release/Blink Pro.app/Contents/Resources/lib/twisted/internet/base.py", line 757, in runUntilCurrent





    324
    
    
    
    call.func(*call.args, **call.kw)





    325
    
    
    
  File "/Users/adigeo/work/blink/build/Release/Blink Pro.app/Contents/Resources/lib/eventlet/api.py", line 239, in _spawn





    326
    
    
    
    g.switch()





    327
    
    
    
  File "/Users/adigeo/work/blink/build/Release/Blink Pro.app/Contents/Resources/lib/eventlet/api.py", line 235, in _spawn_startup





    328
    
    
    
    return cb(*args, **kw)





    329
    
    
    
  File "/Users/adigeo/work/blink/build/Release/Blink Pro.app/Contents/Resources/lib/sipsimple/session.py", line 2175, in handle_notification





    330
    
    
    
    handler(notification)





    331
    
    
    
  File "/Users/adigeo/work/blink/build/Release/Blink Pro.app/Contents/Resources/lib/sipsimple/session.py", line 2310, in _NH_SIPInvitationChangedState





    332
    
    
    
    elif notification.data.state == 'connected' and notification.data.sub_state == 'normal' and notification.data.prev_sub_state == 'received_proposal':





    333
    
    
    
AttributeError: 'NotificationData' object has no attribute 'prev_sub_state'





    334
    
    
    
2011-10-24 15:31:07.696 Blink Pro[3997:a0f] [Session with agp@conference.sip2sip.info] Initiating DNS Lookup of Account('31208005169@ag-projects.com') to sip:agp@conference.sip2sip.info





    335
    
    
    
2011-10-24 15:31:07.706 Blink Pro[3997:a0f] Starting DNS Lookup for sip:agp@conference.sip2sip.info via proxy of account 31208005169@ag-projects.com





    336
    
    
    
2011-10-24 15:31:07.714 Blink Pro[3997:6527] DNS Lookup for sip:agp@conference.sip2sip.info succeeded: 85.17.186.7:5060 (UDP), 81.23.228.129:5060 (UDP)





    337
    
    
    
2011-10-24 15:31:07.775 Blink Pro[3997:a0f] [Session with agp@conference.sip2sip.info] Connecting session





    338
    
    
    
2011-10-24 15:31:07.782 Blink Pro[3997:a0f] Starting Outgoing Session to agp@conference.sip2sip.info with ['chat']





    339
    
    
    
2011-10-24 15:31:07.804 Blink Pro[3997:a0f] [Session with agp@conference.sip2sip.info] Ending session with chat stream





    340
    
    
    
2011-10-24 15:31:08.075 Blink Pro[3997:6527] Traceback (most recent call last):





    341
    
    
    
  File "/Users/adigeo/work/blink/build/Release/Blink Pro.app/Contents/Resources/lib/twisted/internet/base.py", line 757, in runUntilCurrent





    342
    
    
    
    call.func(*call.args, **call.kw)





    343
    
    
    
  File "/Users/adigeo/work/blink/build/Release/Blink Pro.app/Contents/Resources/lib/eventlet/api.py", line 239, in _spawn





    344
    
    
    
    g.switch()





    345
    
    
    
  File "/Users/adigeo/work/blink/build/Release/Blink Pro.app/Contents/Resources/lib/eventlet/api.py", line 235, in _spawn_startup





    346
    
    
    
    return cb(*args, **kw)





    347
    
    
    
  File "/Users/adigeo/work/blink/build/Release/Blink Pro.app/Contents/Resources/lib/sipsimple/session.py", line 2175, in handle_notification





    348
    
    
    
    handler(notification)





    349
    
    
    
  File "/Users/adigeo/work/blink/build/Release/Blink Pro.app/Contents/Resources/lib/sipsimple/session.py", line 2310, in _NH_SIPInvitationChangedState





    350
    
    
    
    elif notification.data.state == 'connected' and notification.data.sub_state == 'normal' and notification.data.prev_sub_state == 'received_proposal':





    351
    
    
    
AttributeError: 'NotificationData' object has no attribute 'prev_sub_state'





    352
    
    
    
2011-10-24 15:31:08.477 Blink Pro[3997:6527] *** __NSAutoreleaseNoPool(): Object 0x1e5e4af0 of class NSCFString autoreleased with no pool in place - just leaking





    353
    
    
    
2011-10-24 15:31:08.551 Blink Pro[3997:6527] *** attempt to pop an unknown autorelease pool (0x24d0e00)





    354
    
    
    
2011-10-24 15:31:08.760 Blink Pro[3997:a0f] [Session with agp@conference.sip2sip.info] Session cancelled





    355
    
    
    
2011-10-24 15:31:08.775 Blink Pro[3997:a0f] [Session with agp@conference.sip2sip.info] Chat stream ended





    356
    
    
    
2011-10-24 15:31:17.812 Blink Pro[3997:6527] Traceback (most recent call last):





    357
    
    
    
  File "/Users/adigeo/work/blink/build/Release/Blink Pro.app/Contents/Resources/lib/twisted/internet/base.py", line 757, in runUntilCurrent





    358
    
    
    
    call.func(*call.args, **call.kw)





    359
    
    
    
  File "/Users/adigeo/work/blink/build/Release/Blink Pro.app/Contents/Resources/lib/eventlet/api.py", line 239, in _spawn





    360
    
    
    
    g.switch()





    361
    
    
    
  File "/Users/adigeo/work/blink/build/Release/Blink Pro.app/Contents/Resources/lib/eventlet/api.py", line 235, in _spawn_startup





    362
    
    
    
    return cb(*args, **kw)





    363
    
    
    
  File "/Users/adigeo/work/blink/build/Release/Blink Pro.app/Contents/Resources/lib/sipsimple/session.py", line 2175, in handle_notification





    364
    
    
    
    handler(notification)





    365
    
    
    
  File "/Users/adigeo/work/blink/build/Release/Blink Pro.app/Contents/Resources/lib/sipsimple/session.py", line 2328, in _NH_SIPInvitationChangedState





    366
    
    
    
    for stream in self.streams:





    367
    
    
    
TypeError: 'NoneType' object is not iterable





    368
    
    
    
2011-10-24 15:31:18.005 Blink Pro[3997:6527] Traceback (most recent call last):





    369
    
    
    
  File "/Users/adigeo/work/blink/build/Release/Blink Pro.app/Contents/Resources/lib/twisted/internet/base.py", line 757, in runUntilCurrent





    370
    
    
    
    call.func(*call.args, **call.kw)





    371
    
    
    
  File "/Users/adigeo/work/blink/build/Release/Blink Pro.app/Contents/Resources/lib/eventlet/api.py", line 239, in _spawn





    372
    
    
    
    g.switch()





    373
    
    
    
  File "/Users/adigeo/work/blink/build/Release/Blink Pro.app/Contents/Resources/lib/eventlet/api.py", line 235, in _spawn_startup





    374
    
    
    
    return cb(*args, **kw)





    375
    
    
    
  File "/Users/adigeo/work/blink/build/Release/Blink Pro.app/Contents/Resources/lib/sipsimple/session.py", line 2175, in handle_notification





    376
    
    
    
    handler(notification)





    377
    
    
    
  File "/Users/adigeo/work/blink/build/Release/Blink Pro.app/Contents/Resources/lib/sipsimple/session.py", line 2328, in _NH_SIPInvitationChangedState





    378
    
    
    
    for stream in self.streams:





    379
    
    
    
TypeError: 'NoneType' object is not iterable





    380
    
    
    
2011-10-24 15:32:02.401 Blink Pro[3997:6527] Account('ag01@cisco.sipit.net') registered contact "sip:ohwvastb@132.177.252.163:52016;transport=tcp" at 132.177.253.22:5060;transport=tcp for 93 seconds





    381
    
    
    
2011-10-24 15:32:14.921 Blink Pro[3997:a0f] Re-establishing session to agp@conference.sip2sip.info





    382
    
    
    
2011-10-24 15:32:14.922 Blink Pro[3997:a0f] Re-establishing session to agp@conference.sip2sip.info





    383
    
    
    
2011-10-24 15:32:14.970 Blink Pro[3997:a0f] [Session with agp@conference.sip2sip.info] Initiating DNS Lookup of Account('31208005169@ag-projects.com') to sip:agp@conference.sip2sip.info





    384
    
    
    
2011-10-24 15:32:14.981 Blink Pro[3997:a0f] Starting DNS Lookup for sip:agp@conference.sip2sip.info via proxy of account 31208005169@ag-projects.com





    385
    
    
    
2011-10-24 15:32:15.465 Blink Pro[3997:6527] DNS Lookup for sip:agp@conference.sip2sip.info succeeded: 81.23.228.129:5060 (UDP), 81.23.228.150:5060 (UDP), 85.17.186.7:5060 (UDP)





    386
    
    
    
2011-10-24 15:32:15.501 Blink Pro[3997:a0f] [Session with agp@conference.sip2sip.info] Connecting session





    387
    
    
    
2011-10-24 15:32:15.512 Blink Pro[3997:a0f] Starting Outgoing Session to agp@conference.sip2sip.info with ['chat']





    388
    
    
    
2011-10-24 15:32:15.772 Blink Pro[3997:a0f] [Session with agp@conference.sip2sip.info] Ending session with chat stream





    389
    
    
    
2011-10-24 15:32:26.048 Blink Pro[3997:6527] Traceback (most recent call last):





    390
    
    
    
  File "/Users/adigeo/work/blink/build/Release/Blink Pro.app/Contents/Resources/lib/twisted/internet/base.py", line 757, in runUntilCurrent





    391
    
    
    
    call.func(*call.args, **call.kw)





    392
    
    
    
  File "/Users/adigeo/work/blink/build/Release/Blink Pro.app/Contents/Resources/lib/eventlet/coros.py", line 253, in _do_acquire





    393
    
    
    
    waiter.switch()





    394
    
    
    
  File "/Users/adigeo/work/blink/build/Release/Blink Pro.app/Contents/Resources/lib/eventlet/api.py", line 235, in _spawn_startup





    395
    
    
    
    return cb(*args, **kw)





    396
    
    
    
  File "/Users/adigeo/work/blink/build/Release/Blink Pro.app/Contents/Resources/lib/sipsimple/session.py", line 1898, in end





    397
    
    
    
    TimestampedNotificationData(originator='local', method='INVITE', code=notification.data.code, reason=notification.data.reason))





    398
    
    
    
AttributeError: 'NotificationData' object has no attribute 'code'





    399
    
    
    
2011-10-24 15:32:26.057 Blink Pro[3997:a0f] [Session with agp@conference.sip2sip.info] Chat stream ended





    400
    
    
    
2011-10-24 15:32:28.717 Blink Pro[3997:a0f] Re-establishing session to agp@conference.sip2sip.info





    401
    
    
    
2011-10-24 15:32:28.718 Blink Pro[3997:a0f] Re-establishing session to agp@conference.sip2sip.info





    402
    
    
    
2011-10-24 15:32:28.762 Blink Pro[3997:a0f] [Session with agp@conference.sip2sip.info] Proposing chat stream





    403
    
    
    
2011-10-24 15:32:28.763 Blink Pro[3997:a0f] [Session with agp@conference.sip2sip.info] IllegalStateError: cannot call add_stream in terminated state





    404
    
    
    
2011-10-24 15:32:41.751 Blink Pro[3997:a0f] [Session with agp@conference.sip2sip.info] Cancelling proposal





    405
    
    
    
2011-10-24 15:32:41.752 Blink Pro[3997:a0f] [Session with agp@conference.sip2sip.info] IllegalStateError: cannot call cancel_proposal in terminated state





    406
    
    
    
2011-10-24 15:33:05.520 Blink Pro[3997:6527] Account('ag01@cisco.sipit.net') registered contact "sip:ohwvastb@132.177.252.163:52016;transport=tcp" at 132.177.253.22:5060;transport=tcp for 93 seconds





    407
    7
    Adrian Georgescu
    
}}}