[reSIProcate] repro TLS : sending responses
Byron Campen
bcampen at estacado.net
Thu Apr 12 14:15:03 CDT 2007
What revision is this? Looking at the line numbers, this is pre-1.0
code. I recall a problem similar to the one you're experiencing being
fixed in 1.1. Grabbing 1.1 will probably solve your problem.
Best regards,
Byron Campen
> Hi Byron,
>
>
> Below is extract from repro log.
> You may see that repro is trying to establish new
> connection instead of reusing existing one:
>
> DEBUG | 20070412-145333.555 | repro | RESIP:TRANSPORT
> | 11784 | tcpbasetransport.cxx:172 | Processing write
> for [ V4 169.254.2.1:5061 TLS target
> domain=unspecified received on: Transport: [ V4
> 0.0.0.0:5061 TLS target domain=unspecified
> connectionId=0 ] connectionId=2 ]
> DEBUG | 20070412-145333.555 | repro | RESIP:TRANSPORT
> | 11784 | connectionmanager.cxx:59 | connection id 2
> exists, but does not match the destination. Cid -> [
> V4 169.254.2.1:1220 TLS target domain=unspecified
> received on: Transport: [ V4 0.0.0.0:5061 TLS target
> domain=unspecified connectionId=0 ] connectionId=2 ],
> tuple -> [ V4 169.254.2.1:5061 TLS target
> domain=unspecified received on: Transport: [ V4
> 0.0.0.0:5061 TLS target domain=unspecified
> connectionId=0 ] connectionId=2 ]
> DEBUG | 20070412-145333.570 | repro | RESIP:TRANSPORT
> | 11784 | connectionmanager.cxx:76 | Could not find a
> connection for [ V4 169.254.2.1:5061 TLS target
> domain=unspecified received on: Transport: [ V4
> 0.0.0.0:5061 TLS target domain=unspecified
> connectionId=0 ] connectionId=2 ]
> DEBUG | 20070412-145333.570 | repro | RESIP:TRANSPORT
> | 11784 | internaltransport.cxx:86 | Creating fd=1332
> V4/TCP
> DEBUG | 20070412-145333.570 | repro | RESIP:TRANSPORT
> | 11784 | tcpbasetransport.cxx:212 | Opening new
> connection to [ V4 169.254.2.1:5061 TLS target
> domain=unspecified received on: Transport: [ V4
> 0.0.0.0:5061 TLS target domain=unspecified
> connectionId=0 ] connectionId=2 ]
>
> full log:
>
> DEBUG | 20070412-145331.929 | repro | RESIP:TRANSPORT
> | 11784 | tcpbasetransport.cxx:110 | Received TCP
> connection from: [ V4 169.254.2.1:1220 TLS target
> domain=unspecified received on: Transport: [ V4
> 0.0.0.0:5061 TLS target domain=unspecified
> connectionId=0 ] connectionId=0 ] as fd=1460
> DEBUG | 20070412-145331.929 | repro | RESIP:TRANSPORT
> | 11784 | connectionbase.cxx:66 |
> ConnectionBase::ConnectionBase, who: [ V4
> 169.254.2.1:1220 TLS target domain=unspecified
> received on: Transport: [ V4 0.0.0.0:5061 TLS target
> domain=unspecified connectionId=0 ] connectionId=0 ]
> 01797BA8
> DEBUG | 20070412-145331.929 | repro | RESIP:TRANSPORT
> | 11784 | connectionbase.cxx:79 | No compression
> library available: 01797BA8
> INFO | 20070412-145331.929 | repro | RESIP:TRANSPORT |
> 11784 | tlsconnection.cxx:39 | Creating TLS connection
> for domain example [ V4 169.254.2.1:1220 TLS target
> domain=unspecified received on: Transport: [ V4
> 0.0.0.0:5061 TLS target domain=unspecified
> connectionId=0 ] connectionId=0 ] on 1460
> DEBUG | 20070412-145331.929 | repro | RESIP:TRANSPORT
> | 11784 | tlsconnection.cxx:46 | Trying to form TLS
> connection - acting as server
> DEBUG | 20070412-145332.148 | repro | RESIP:TRANSPORT
> | 11784 | tcpbasetransport.cxx:143 |
> TcpBaseTransport::processSomeReads() CONN: 01797BA8
> 1460 [ V4 169.254.2.1:1220 TLS target
> domain=unspecified received on: Transport: [ V4
> 0.0.0.0:5061 TLS target domain=unspecified
> connectionId=0 ] connectionId=2 ]
> DEBUG | 20070412-145332.148 | repro | RESIP:TRANSPORT
> | 11784 | connectionbase.cxx:472 | Creating buffer for
> CONN_BASE: 01797BA8 [ V4 169.254.2.1:1220 TLS target
> domain=unspecified received on: Transport: [ V4
> 0.0.0.0:5061 TLS target domain=unspecified
> connectionId=0 ] connectionId=2 ]
> DEBUG | 20070412-145332.914 | repro | RESIP:TRANSPORT
> | 11784 | tcpbasetransport.cxx:147 |
> TcpBaseTransport::processSomeReads() read=0
> DEBUG | 20070412-145333.101 | repro | RESIP:TRANSPORT
> | 11784 | tcpbasetransport.cxx:143 |
> TcpBaseTransport::processSomeReads() CONN: 01797BA8
> 1460 [ V4 169.254.2.1:1220 TLS target
> domain=unspecified received on: Transport: [ V4
> 0.0.0.0:5061 TLS target domain=unspecified
> connectionId=0 ] connectionId=2 ]
> DEBUG | 20070412-145333.101 | repro | RESIP:TRANSPORT
> | 11784 | connectionbase.cxx:472 | Creating buffer for
> CONN_BASE: 01797BA8 [ V4 169.254.2.1:1220 TLS target
> domain=unspecified received on: Transport: [ V4
> 0.0.0.0:5061 TLS target domain=unspecified
> connectionId=0 ] connectionId=2 ]
> INFO | 20070412-145333.211 | repro | RESIP:TRANSPORT |
> 11784 | tlsconnection.cxx:248 | TLS connected
> INFO | 20070412-145333.211 | repro | RESIP:TRANSPORT |
> 11784 | tlsconnection.cxx:252 | TLS handshake starting
> INFO | 20070412-145333.211 | repro | RESIP:TRANSPORT |
> 11784 | tlsconnection.cxx:569 | TLS sessions set up
> with TLSv1 TLSv1/SSLv3 AES256-SHA
> DEBUG | 20070412-145333.211 | repro | RESIP:TRANSPORT
> | 11784 | tlsconnection.cxx:575 | No peer certificate
> in TLS connection
> INFO | 20070412-145333.211 | repro | RESIP:TRANSPORT |
> 11784 | tlsconnection.cxx:308 | TLS handshake done for
> peer
> STACK | 20070412-145333.211 | repro | RESIP:TRANSPORT
> | 11784 | tlsconnection.cxx:348 |
> STACK | 20070412-145333.211 | repro | RESIP:TRANSPORT
> | 11784 | tlsconnection.cxx:377 | Got TLS read got
> condition of 2
> DEBUG | 20070412-145333.211 | repro | RESIP:TRANSPORT
> | 11784 | tcpbasetransport.cxx:147 |
> TcpBaseTransport::processSomeReads() read=0
> DEBUG | 20070412-145333.430 | repro | RESIP:TRANSPORT
> | 11784 | tcpbasetransport.cxx:143 |
> TcpBaseTransport::processSomeReads() CONN: 01797BA8
> 1460 [ V4 169.254.2.1:1220 TLS target
> domain=unspecified received on: Transport: [ V4
> 0.0.0.0:5061 TLS target domain=unspecified
> connectionId=0 ] connectionId=2 ]
> DEBUG | 20070412-145333.430 | repro | RESIP:TRANSPORT
> | 11784 | connectionbase.cxx:472 | Creating buffer for
> CONN_BASE: 01797BA8 [ V4 169.254.2.1:1220 TLS target
> domain=unspecified received on: Transport: [ V4
> 0.0.0.0:5061 TLS target domain=unspecified
> connectionId=0 ] connectionId=2 ]
> STACK | 20070412-145333.430 | repro | RESIP:TRANSPORT
> | 11784 | tlsconnection.cxx:348 | SSL_read returned
> 373 bytes [REGISTER sips:example SIP/2.0
>
> From:
> <sips:test at example;user=phone>;tag=4b80a8-0-13c4-45018-9f16-2c6fc799-9
> f16
>
> To: <sips:test at example;user=phone>
>
> Call-ID: 4c8970-0-13c4-45018-9ea4-60fa331e-9ea4
>
> CSeq: 2 REGISTER
>
> Via: SIP/2.0/TLS
> 169.254.2.1:5061;branch=z9hG4bK-9f16-26d70c8-54a1d977
>
> Max-Forwards: 70
>
> Contact: <sips:169.254.2.1:5061>;expires=3600
>
> Content-Length: 0
>
>
>
> ]
> STACK | 20070412-145333.430 | repro | RESIP:TRANSPORT
> | 11784 | tlsconnection.cxx:392 | SSL bytesRead=373
> DEBUG | 20070412-145333.430 | repro | RESIP:TRANSPORT
> | 11784 | connectionbase.cxx:118 | In State:
> NewMessage
> DEBUG | 20070412-145333.430 | repro | RESIP:TRANSPORT
> | 11784 | connectionbase.cxx:146 |
> ConnectionBase::process setting source [ V4
> 169.254.2.1:1220 TLS target domain=unspecified
> received on: Transport: [ V4 0.0.0.0:5061 TLS target
> domain=unspecified connectionId=0 ] connectionId=2 ]
> DEBUG | 20070412-145333.430 | repro | RESIP:TRANSPORT
> | 11784 | transport.cxx:287 | incoming from: [ V4
> 169.254.2.1:1220 TLS target domain=unspecified
> received on: Transport: [ V4 0.0.0.0:5061 TLS target
> domain=unspecified connectionId=0 ] connectionId=2 ]
> STACK | 20070412-145333.430 | repro | RESIP:TRANSPORT
> | 11784 | transport.cxx:288 |
>
> REGISTER sips:example SIP/2.0
>
> Via: SIP/2.0/TLS
> 169.254.2.1:5061;branch=z9hG4bK-9f16-26d70c8-54a1d977
>
> Max-Forwards: 70
>
> Contact: <sips:169.254.2.1:5061>;expires=3600
>
> To: <sips:test at example;user=phone>
>
> From:
> <sips:test at example;user=phone>;tag=4b80a8-0-13c4-45018-9f16-2c6fc799-9
> f16
>
> Call-ID: 4c8970-0-13c4-45018-9ea4-60fa331e-9ea4
>
> CSeq: 2 REGISTER
>
> Content-Length: 0
>
>
>
>
> DEBUG | 20070412-145333.430 | repro | RESIP:TRANSPORT
> | 11784 | connectionbase.cxx:258 | ##Connection:
> CONN_BASE: 01797BA8 [ V4 169.254.2.1:1220 TLS target
> domain=unspecified received on: Transport: [ V4
> 0.0.0.0:5061 TLS target domain=unspecified
> connectionId=0 ] connectionId=2 ] received: REGISTER
> sips:example SIP/2.0
>
> Via: SIP/2.0/TLS
> 169.254.2.1:5061;branch=z9hG4bK-9f16-26d70c8-54a1d977
>
> Max-Forwards: 70
>
> Contact: <sips:169.254.2.1:5061>;expires=3600
>
> To: <sips:test at example;user=phone>
>
> From:
> <sips:test at example;user=phone>;tag=4b80a8-0-13c4-45018-9f16-2c6fc799-9
> f16
>
> Call-ID: 4c8970-0-13c4-45018-9ea4-60fa331e-9ea4
>
> CSeq: 2 REGISTER
>
> Content-Length: 0
>
>
>
>
> DEBUG | 20070412-145333.430 | repro | RESIP:TRANSPORT
> | 11784 | tcpbasetransport.cxx:147 |
> TcpBaseTransport::processSomeReads() read=373
> STACK | 20070412-145333.430 | repro |
> RESIP:TRANSACTION | 11784 | transactionstate.cxx:277 |
> No matching transaction for SipReq: REGISTER example
> tid=-9f16-26d70c8-54a1d977 cseq=REGISTER
> contact=169.254.2.1:5061 / 2 from(wire) tlsd=example
> DEBUG | 20070412-145333.430 | repro |
> RESIP:TRANSACTION | 11784 | transactionuser.cxx:66 |
> Checking if SipReq: REGISTER example
> tid=-9f16-26d70c8-54a1d977 cseq=REGISTER
> contact=169.254.2.1:5061 / 2 from(wire) tlsd=example
> is for me
> DEBUG | 20070412-145333.430 | repro |
> RESIP:TRANSACTION | 11784 | transactionuser.cxx:71 |
> Checking rule...
> DEBUG | 20070412-145333.430 | repro |
> RESIP:TRANSACTION | 11784 | messagefilterrule.cxx:42 |
> Matching rule for:
>
> REGISTER sips:example SIP/2.0
>
> Via: SIP/2.0/TLS
> 169.254.2.1:5061;branch=z9hG4bK-9f16-26d70c8-54a1d977
>
> Max-Forwards: 70
>
> Contact: <sips:169.254.2.1:5061>;expires=3600
>
> To: <sips:test at example;user=phone>
>
> From:
> <sips:test at example;user=phone>;tag=4b80a8-0-13c4-45018-9f16-2c6fc799-9
> f16
>
> Call-ID: 4c8970-0-13c4-45018-9ea4-60fa331e-9ea4
>
> CSeq: 2 REGISTER
>
> Content-Length: 0
>
>
>
>
> DEBUG | 20070412-145333.430 | repro |
> RESIP:TRANSACTION | 11784 | transactionuser.cxx:74 |
> Match!
> STACK | 20070412-145333.430 | repro |
> RESIP:TRANSACTION | 11784 | transactionstate.cxx:52 |
> Creating new TransactionState:
> tid=-9f16-26d70c8-54a1d977 [ ServerNonInvite/Trying
> reliable target=[ V4 0.0.0.0:0 UNKNOWN_TRANSPORT
> target domain=unspecified connectionId=0 ]]
> DEBUG | 20070412-145333.430 | repro | RESIP | 11784 |
> helper.cxx:302 | Helper::makeResponse(SipReq:
> REGISTER example tid=-9f16-26d70c8-54a1d977
> cseq=REGISTER contact=169.254.2.1:5061 / 2 from(wire)
> tlsd=example code=100 reason=
> DEBUG | 20070412-145333.430 | repro |
> RESIP:TRANSACTION | 11784 | timerqueue.cxx:85 | Adding
> timer: Timer Trying tid=-9f16-26d70c8-54a1d977 ms=3500
> DEBUG | 20070412-145333.430 | repro |
> RESIP:TRANSACTION | 11784 | transactionstate.cxx:1763
> | Send to TU: TU: DialogUsageManager size=0
>
> REGISTER sips:example SIP/2.0
>
> Via: SIP/2.0/TLS
> 169.254.2.1:5061;branch=z9hG4bK-9f16-26d70c8-54a1d977
>
> Max-Forwards: 70
>
> Contact: <sips:169.254.2.1:5061>;expires=3600
>
> To: <sips:test at example;user=phone>
>
> From:
> <sips:test at example;user=phone>;tag=4b80a8-0-13c4-45018-9f16-2c6fc799-9
> f16
>
> Call-ID: 4c8970-0-13c4-45018-9ea4-60fa331e-9ea4
>
> CSeq: 2 REGISTER
>
> Content-Length: 0
>
>
>
>
> INFO | 20070412-145333.430 | repro | RESIP:DUM | 12196
> | DialogUsageManager.cxx:1190 | Got: SipReq: REGISTER
> example tid=-9f16-26d70c8-54a1d977 cseq=REGISTER
> contact=169.254.2.1:5061 / 2 from(wire) tlsd=example
> DEBUG | 20070412-145333.445 | repro | RESIP:DUM |
> 12196 | DialogUsageManager.cxx:1456 |
> DialogUsageManager::processRequest: SipReq: REGISTER
> example tid=-9f16-26d70c8-54a1d977 cseq=REGISTER
> contact=169.254.2.1:5061 / 2 from(wire) tlsd=example
> DEBUG | 20070412-145333.445 | repro | RESIP:DUM |
> 12196 | DialogSetId.cxx:31 | ********** Generated
> Local Tag ***********
> STACK | 20070412-145333.445 | repro | RESIP:DUM |
> 12196 | DialogUsageManager.cxx:1752 | Looking for
> dialogSet:
> 4c8970-0-13c4-45018-9ea4-60fa331e-9ea4-1b23cf15 in
> map:
> STACK | 20070412-145333.445 | repro | RESIP:DUM |
> 12196 | DialogUsageManager.cxx:1753 | []
> DEBUG | 20070412-145333.445 | repro | RESIP:DUM |
> 12196 | DialogSetId.cxx:31 | ********** Generated
> Local Tag ***********
> DEBUG | 20070412-145333.461 | repro | RESIP:DUM |
> 12196 | DialogSetId.cxx:31 | ********** Generated
> Local Tag ***********
> DEBUG | 20070412-145333.461 | repro | RESIP:DUM |
> 12196 | DialogSet.cxx:84 | ************* Created
> DialogSet(UAS) --
> 4c8970-0-13c4-45018-9ea4-60fa331e-9ea4-0e5c615d*************
> STACK | 20070412-145333.461 | repro | RESIP:DUM |
> 12196 | DialogUsageManager.cxx:1602 | ***********
> Calling AppDialogSetFactory *************
> STACK | 20070412-145333.476 | repro | RESIP:TEST |
> 12196 | Handled.cxx:16 | &&&&&& Handled::Handled
> 1this(0179CBA8) 01795ED8
> STACK | 20070412-145333.476 | repro | RESIP:DUM |
> 12196 | DialogUsageManager.cxx:1608 | *************
> Adding DialogSet ***************
> STACK | 20070412-145333.476 | repro | RESIP:DUM |
> 12196 | DialogUsageManager.cxx:1609 | Before: []
> STACK | 20070412-145333.476 | repro | RESIP:DUM |
> 12196 | DialogUsageManager.cxx:1611 | After:
> Req[4c8970-0-13c4-45018-9ea4-60fa331e-9ea4-0e5c615d ->
> 0179C6D8]
> DEBUG | 20070412-145333.476 | repro | RESIP:DUM |
> 12196 | DialogSetId.cxx:31 | ********** Generated
> Local Tag ***********
> DEBUG | 20070412-145333.476 | repro | RESIP:DUM |
> 12196 | DialogId.cxx:50 | DialogId::DialogId:
> 4c8970-0-13c4-45018-9ea4-60fa331e-9ea4-
> eb5e680d-4b80a8-0-13c4-45018-9f16-2c6fc799-9f16
> STACK | 20070412-145333.476 | repro | RESIP:DUM |
> 12196 | DialogSet.cxx:433 | No matching dialog for
>
> REGISTER sips:example SIP/2.0
>
> Via: SIP/2.0/TLS
> 169.254.2.1:5061;branch=z9hG4bK-9f16-26d70c8-54a1d977
>
> Max-Forwards: 70
>
> Contact: <sips:169.254.2.1:5061>;expires=3600
>
> To: <sips:test at example;user=phone>
>
> From:
> <sips:test at example;user=phone>;tag=4b80a8-0-13c4-45018-9f16-2c6fc799-9
> f16
>
> Call-ID: 4c8970-0-13c4-45018-9ea4-60fa331e-9ea4
>
> CSeq: 2 REGISTER
>
> Content-Length: 0
>
>
>
>
> STACK | 20070412-145333.492 | repro | RESIP:TEST |
> 12196 | Handled.cxx:16 | &&&&&& Handled::Handled
> 2this(0179CDB8) 01795ED8
> DEBUG | 20070412-145333.492 | repro | RESIP:DUM |
> 12196 | ServerRegistration.cxx:105 | got a
> registration
> INFO | 20070412-145333.523 | repro | RESIP:DUM | 12196
> | ServerRegistration.cxx:214 | Adding
> sips:test at example ->
> <sips:169.254.2.1:5061>;expires=3600
> DEBUG | 20070412-145333.523 | repro | REPRO:APP |
> 12196 | registrar.cxx:51 | Registrar::onAdd SipReq:
> REGISTER example tid=-9f16-26d70c8-54a1d977
> cseq=REGISTER contact=169.254.2.1:5061 / 2 from(wire)
> tlsd=example
> DEBUG | 20070412-145333.523 | repro | RESIP | 12196 |
> helper.cxx:302 | Helper::makeResponse(SipReq:
> REGISTER example tid=-9f16-26d70c8-54a1d977
> cseq=REGISTER contact=169.254.2.1:5061 / 2 from(wire)
> tlsd=example code=200 reason=
> INFO | 20070412-145333.523 | repro | RESIP:DUM | 12196
> | ServerRegistration.cxx:42 | accepted a registration
> sips:test at example
> STACK | 20070412-145333.539 | repro | RESIP:DUM |
> 12196 | DialogUsageManager.cxx:1752 | Looking for
> dialogSet:
> 4c8970-0-13c4-45018-9ea4-60fa331e-9ea4-ff439e30 in
> map:
> STACK | 20070412-145333.539 | repro | RESIP:DUM |
> 12196 | DialogUsageManager.cxx:1753 |
> [4c8970-0-13c4-45018-9ea4-60fa331e-9ea4-0e5c615d ->
> 0179C6D8]
> DEBUG | 20070412-145333.539 | repro | RESIP:DUM |
> 12196 | DialogUsageManager.cxx:800 | SEND:
>
> SIP/2.0 200 OK
>
> Via: SIP/2.0/TLS
> 169.254.2.1:5061;branch=z9hG4bK-9f16-26d70c8-54a1d977
>
> Contact: <sips:169.254.2.1:5061>;expires=3600
>
> To: <sips:test at example;user=phone>;tag=ff439e30
>
> From:
> <sips:test at example;user=phone>;tag=4b80a8-0-13c4-45018-9f16-2c6fc799-9
> f16
>
> Call-ID: 4c8970-0-13c4-45018-9ea4-60fa331e-9ea4
>
> CSeq: 2 REGISTER
>
> Content-Length: 0
>
>
>
>
> DEBUG | 20070412-145333.555 | repro | RESIP | 12196 |
> sipstack.cxx:283 | SEND: SipResp: 200
> tid=-9f16-26d70c8-54a1d977 cseq=REGISTER
> contact=169.254.2.1:5061 / 2 from(tu)
> STACK | 20070412-145333.555 | repro |
> RESIP:TRANSACTION | 11784 | transactionstate.cxx:242 |
> Found matching transaction for SipResp: 200
> tid=-9f16-26d70c8-54a1d977 cseq=REGISTER
> contact=169.254.2.1:5061 / 2 from(tu) ->
> tid=-9f16-26d70c8-54a1d977 [ ServerNonInvite/Trying
> reliable target=[ V4 169.254.2.1:5061 TLS target
> domain=unspecified received on: Transport: [ V4
> 0.0.0.0:5061 TLS target domain=unspecified
> connectionId=0 ] connectionId=2 ]]
> STACK | 20070412-145333.555 | repro |
> RESIP:TRANSACTION | 11784 | transactionstate.cxx:906 |
> TransactionState::processServerNonInvite: SipResp: 200
> tid=-9f16-26d70c8-54a1d977 cseq=REGISTER
> contact=169.254.2.1:5061 / 2 from(tu)
> STACK | 20070412-145333.555 | repro |
> RESIP:TRANSACTION | 11784 | transactionstate.cxx:1650
> | tid=-9f16-26d70c8-54a1d977 sending to : [ V4
> 169.254.2.1:5061 TLS target domain=unspecified
> received on: Transport: [ V4 0.0.0.0:5061 TLS target
> domain=unspecified connectionId=0 ] connectionId=2 ]
> DEBUG | 20070412-145333.555 | repro | RESIP:TRANSPORT
> | 11784 | transportselector.cxx:520 | Looked up source
> for destination: [ V4 169.254.2.1:5061 TLS target
> domain=unspecified received on: Transport: [ V4
> 0.0.0.0:5061 TLS target domain=unspecified
> connectionId=0 ] connectionId=2 ] -> [ V4
> 169.254.2.2:0 TLS target domain=unspecified received
> on: Transport: [ V4 0.0.0.0:5061 TLS target
> domain=unspecified connectionId=0 ] connectionId=2 ]
> sent-by=169.254.2.1 sent-port=5061
> DEBUG | 20070412-145333.555 | repro | RESIP:TRANSPORT
> | 11784 | transportselector.cxx:868 | Transmitting to
> [ V4 169.254.2.1:5061 TLS target domain=unspecified
> received on: Transport: [ V4 0.0.0.0:5061 TLS target
> domain=unspecified connectionId=0 ] connectionId=2 ]
> tlsDomain= via [ V4 169.254.2.2:5061 TLS target
> domain=unspecified received on: Transport: [ V4
> 0.0.0.0:5061 TLS target domain=unspecified
> connectionId=0 ] connectionId=2 ]
>
> SIP/2.0 200 OK
>
> Via: SIP/2.0/TLS
> 169.254.2.1:5061;branch=z9hG4bK-9f16-26d70c8-54a1d977
>
> Contact: <sips:169.254.2.1:5061>;expires=3600
>
> To: <sips:test at example;user=phone>;tag=ff439e30
>
> From:
> <sips:test at example;user=phone>;tag=4b80a8-0-13c4-45018-9f16-2c6fc799-9
> f16
>
> Call-ID: 4c8970-0-13c4-45018-9ea4-60fa331e-9ea4
>
> CSeq: 2 REGISTER
>
> Content-Length: 0
>
>
>
>
> DEBUG | 20070412-145333.555 | repro | RESIP:TRANSPORT
> | 11784 | transport.cxx:213 | Adding message to tx
> buffer to: [ V4 169.254.2.1:5061 TLS target
> domain=unspecified received on: Transport: [ V4
> 0.0.0.0:5061 TLS target domain=unspecified
> connectionId=0 ] connectionId=2 ]
> DEBUG | 20070412-145333.555 | repro | RESIP:TRANSPORT
> | 11784 | tcpbasetransport.cxx:172 | Processing write
> for [ V4 169.254.2.1:5061 TLS target
> domain=unspecified received on: Transport: [ V4
> 0.0.0.0:5061 TLS target domain=unspecified
> connectionId=0 ] connectionId=2 ]
> DEBUG | 20070412-145333.555 | repro | RESIP:TRANSPORT
> | 11784 | connectionmanager.cxx:59 | connection id 2
> exists, but does not match the destination. Cid -> [
> V4 169.254.2.1:1220 TLS target domain=unspecified
> received on: Transport: [ V4 0.0.0.0:5061 TLS target
> domain=unspecified connectionId=0 ] connectionId=2 ],
> tuple -> [ V4 169.254.2.1:5061 TLS target
> domain=unspecified received on: Transport: [ V4
> 0.0.0.0:5061 TLS target domain=unspecified
> connectionId=0 ] connectionId=2 ]
> DEBUG | 20070412-145333.570 | repro | RESIP:TRANSPORT
> | 11784 | connectionmanager.cxx:76 | Could not find a
> connection for [ V4 169.254.2.1:5061 TLS target
> domain=unspecified received on: Transport: [ V4
> 0.0.0.0:5061 TLS target domain=unspecified
> connectionId=0 ] connectionId=2 ]
> DEBUG | 20070412-145333.570 | repro | RESIP:TRANSPORT
> | 11784 | internaltransport.cxx:86 | Creating fd=1332
> V4/TCP
> DEBUG | 20070412-145333.570 | repro | RESIP:TRANSPORT
> | 11784 | tcpbasetransport.cxx:212 | Opening new
> connection to [ V4 169.254.2.1:5061 TLS target
> domain=unspecified received on: Transport: [ V4
> 0.0.0.0:5061 TLS target domain=unspecified
> connectionId=0 ] connectionId=2 ]
> DEBUG | 20070412-145333.570 | repro | RESIP:TRANSPORT
> | 11784 | connectionbase.cxx:66 |
> ConnectionBase::ConnectionBase, who: [ V4
> 169.254.2.1:5061 TLS target domain=unspecified
> received on: Transport: [ V4 0.0.0.0:5061 TLS target
> domain=unspecified connectionId=0 ] connectionId=2 ]
> 017A2D20
> DEBUG | 20070412-145333.570 | repro | RESIP:TRANSPORT
> | 11784 | connectionbase.cxx:79 | No compression
> library available: 017A2D20
> INFO | 20070412-145333.570 | repro | RESIP:TRANSPORT |
> 11784 | tlsconnection.cxx:39 | Creating TLS connection
> for domain example [ V4 169.254.2.1:5061 TLS target
> domain=unspecified received on: Transport: [ V4
> 0.0.0.0:5061 TLS target domain=unspecified
> connectionId=0 ] connectionId=2 ] on 1332
> DEBUG | 20070412-145333.570 | repro | RESIP:TRANSPORT
> | 11784 | tlsconnection.cxx:56 | Trying to form TLS
> connection - acting as client
>
> --- Byron Campen <bcampen at estacado.net> wrote:
>
>> I am not seeing any code that would cause what
>> you're describing.
>> For responses, the port in the sent-by portion of
>> the Via is ignored
>> entirely. rport can override the port we send back
>> to, but that
>> should never be set by anything other then the
>> receiver of the
>> request, and it will be set to the same port as the
>> source anyway.
>> Could you provide a message trace?
>>
>> Best regards,
>> Byron Campen
>>
>>> RFC 3261 defines at "18.2.2 Sending Responses"
>>>
>>> "If the "sent-protocol" is a reliable transport
>>> protocol such as
>>> TCP or SCTP, or TLS over those, the
>> response
>>> MUST be sent using
>>> the existing connection to the source of
>> the
>>> original request
>>> that created the transaction, if that
>>> connection is still open.
>>> This requires the server transport to
>>> maintain an association
>>> between server transactions and transport
>>> connections."
>>>
>>> I noticed that repro is trying to locate
>> connection
>>> for sending response based on data retrieved from
>> Via
>>> header of request (REGISTER in my case). Since Via
>>> header has 5061 port and REGISTER was sent from
>>> different port it failed to locate already
>> established
>>> connection for sending response. Should it be
>> fixed?
>>>
>>> Thanks,
>>> Boris
>>>
>>>
>>>
>>>
>>> _______________________________________________
>>> resiprocate-devel mailing list
>>> resiprocate-devel at list.resiprocate.org
>>>
>>
> https://list.resiprocate.org/mailman/listinfo/resiprocate-devel
>>
>>
>
>
>
>
-------------- next part --------------
A non-text attachment was scrubbed...
Name: smime.p7s
Type: application/pkcs7-signature
Size: 2423 bytes
Desc: not available
URL: <http://list.resiprocate.org/pipermail/resiprocate-devel/attachments/20070412/398536b5/attachment.bin>
More information about the resiprocate-devel
mailing list