Skip to content

Instantly share code, notes, and snippets.

@nshopik nshopik/debug Secret
Created Oct 9, 2015

Embed
What would you like to do?
DEBUG | 20151009-170802.508 | repro | RESIP:TRANSPORT | 3003157312 | ConnectionBase.cxx:137 | In State: NewMessage
DEBUG | 20151009-170802.508 | repro | RESIP:TRANSPORT | 3003157312 | ConnectionBase.cxx:183 | ConnectionBase::process setting source [ V4 83.69.202.99:59118 TCP flowKey=41 transportKey=1 ]
DEBUG | 20151009-170802.508 | repro | RESIP:TRANSPORT | 3003157312 | Transport.cxx:392 | incoming from: [ V4 83.69.202.99:59118 TCP flowKey=41 transportKey=1 ]
DEBUG | 20151009-170802.508 | repro | RESIP:TRANSPORT | 3003157312 | ConnectionBase.cxx:438 | ##Connection: CONN_BASE: 0xaff00468 [ V4 83.69.202.99:59118 TCP flowKey=41 transportKey=1 ] received: INVITE sip:202@tools.a33842.net;transport=tcp SIP/2.0
Via: SIP/2.0/TCP 192.168.20.69:51792;branch=z9hG4bK7d4915a73e7b8341;rport=59118;received=83.69.202.99
Max-Forwards: 70
Contact: <sip:200-0x1d62570@192.168.20.69:51792;transport=tcp>
To: <sip:202@tools.a33842.net;transport=tcp>
From: <sip:200@tools.a33842.net>;tag=c4a21a647a3e7e7d
Call-ID: cb402c900dc6b17f
CSeq: 54309 INVITE
Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, REFER, NOTIFY, SUBSCRIBE, INFO, MESSAGE
Content-Type: application/sdp
Supported: gruu
User-Agent: baresip v0.4.14 (x86_64/linux)
Content-Length: 335
v=0
o=- 1537643373 8569226 IN IP4 192.168.20.69
s=-
c=IN IP4 192.168.20.69
t=0 0
a=tool:baresip 0.4.14
m=audio 62856 RTP/AVP 0 8 101
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-15
a=sendrecv
a=label:1
a=rtcp-rsize
a=ssrc:1060798781 cname:sip:200@tools.a33842.net
a=ptime:20
DEBUG | 20151009-170802.508 | repro | RESIP:TRANSPORT | 3003157312 | Connection.cxx:426 | Connection::performReads() read=884
DEBUG | 20151009-170802.508 | repro | RESIP:TRANSPORT | 3003157312 | ConnectionBase.cxx:1017 | Creating buffer for CONN_BASE: 0xaff00468 [ V4 83.69.202.99:59118 TCP flowKey=41 transportKey=1 ]
DEBUG | 20151009-170802.508 | repro | RESIP:TRANSACTION | 3011550016 | TuSelector.cxx:189 | TuSelector::selectTransactionUser: Checking which TU message belongs to:
INVITE sip:202@tools.a33842.net;transport=tcp SIP/2.0
Via: SIP/2.0/TCP 192.168.20.69:51792;branch=z9hG4bK7d4915a73e7b8341;rport=59118;received=83.69.202.99
Max-Forwards: 70
Contact: <sip:200-0x1d62570@192.168.20.69:51792;transport=tcp>
To: <sip:202@tools.a33842.net;transport=tcp>
From: <sip:200@tools.a33842.net>;tag=c4a21a647a3e7e7d
Call-ID: cb402c900dc6b17f
CSeq: 54309 INVITE
Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, REFER, NOTIFY, SUBSCRIBE, INFO, MESSAGE
Content-Type: application/sdp
Supported: gruu
User-Agent: baresip v0.4.14 (x86_64/linux)
Content-Length: 335
v=0
o=- 1537643373 8569226 IN IP4 192.168.20.69
s=-
c=IN IP4 192.168.20.69
t=0 0
a=tool:baresip 0.4.14
m=audio 62856 RTP/AVP 0 8 101
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-15
a=sendrecv
a=label:1
a=rtcp-rsize
a=ssrc:1060798781 cname:sip:200@tools.a33842.net
a=ptime:20
DEBUG | 20151009-170802.509 | repro | RESIP:TRANSACTION | 3011550016 | TransactionUser.cxx:83 | TransactionUser::isForMe: TU=DialogUsageManager, Checking rule... : SipReq: INVITE 202@tools.a33842.net tid=7d4915a73e7b8341 cseq=54309 INVITE contact=200-0x1d62570@192.168.20.69:51792 / 54309 from(wire)
DEBUG | 20151009-170802.509 | repro | RESIP:TRANSACTION | 3011550016 | MessageFilterRule.cxx:66 | MessageFilterRule::matches: Method is not in list. Rule does not match.
DEBUG | 20151009-170802.509 | repro | RESIP:TRANSACTION | 3011550016 | TransactionUser.cxx:83 | TransactionUser::isForMe: TU=DialogUsageManager, Checking rule... : SipReq: INVITE 202@tools.a33842.net tid=7d4915a73e7b8341 cseq=54309 INVITE contact=200-0x1d62570@192.168.20.69:51792 / 54309 from(wire)
DEBUG | 20151009-170802.509 | repro | RESIP:TRANSACTION | 3011550016 | MessageFilterRule.cxx:66 | MessageFilterRule::matches: Method is not in list. Rule does not match.
DEBUG | 20151009-170802.509 | repro | RESIP:TRANSACTION | 3011550016 | TransactionUser.cxx:90 | TransactionUser::isForMe: TU=DialogUsageManager, No matching rule found : SipReq: INVITE 202@tools.a33842.net tid=7d4915a73e7b8341 cseq=54309 INVITE contact=200-0x1d62570@192.168.20.69:51792 / 54309 from(wire)
DEBUG | 20151009-170802.509 | repro | RESIP:TRANSACTION | 3011550016 | TransactionUser.cxx:83 | TransactionUser::isForMe: TU=Proxy, Checking rule... : SipReq: INVITE 202@tools.a33842.net tid=7d4915a73e7b8341 cseq=54309 INVITE contact=200-0x1d62570@192.168.20.69:51792 / 54309 from(wire)
DEBUG | 20151009-170802.509 | repro | RESIP:TRANSACTION | 3011550016 | TransactionUser.cxx:86 | TransactionUser::isForMe: TU=Proxy, Match! : SipReq: INVITE 202@tools.a33842.net tid=7d4915a73e7b8341 cseq=54309 INVITE contact=200-0x1d62570@192.168.20.69:51792 / 54309 from(wire)
DEBUG | 20151009-170802.509 | repro | RESIP | 3011550016 | Helper.cxx:374 | Helper::makeResponse(SipReq: INVITE 202@tools.a33842.net tid=7d4915a73e7b8341 cseq=54309 INVITE contact=200-0x1d62570@192.168.20.69:51792 / 54309 from(wire) code=100 reason=
DEBUG | 20151009-170802.510 | repro | RESIP:TRANSACTION | 3011550016 | TimerQueue.cxx:50 | Adding timer: Timer Trying tid=7d4915a73e7b8341 ms=80
DEBUG | 20151009-170802.510 | repro | RESIP:TRANSACTION | 3011550016 | TuSelector.cxx:70 | Send to TU: Proxy size=0
INVITE sip:202@tools.a33842.net;transport=tcp SIP/2.0
Via: SIP/2.0/TCP 192.168.20.69:51792;branch=z9hG4bK7d4915a73e7b8341;rport=59118;received=83.69.202.99
Max-Forwards: 70
Contact: <sip:200-0x1d62570@192.168.20.69:51792;transport=tcp>
To: <sip:202@tools.a33842.net;transport=tcp>
From: <sip:200@tools.a33842.net>;tag=c4a21a647a3e7e7d
Call-ID: cb402c900dc6b17f
CSeq: 54309 INVITE
Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, REFER, NOTIFY, SUBSCRIBE, INFO, MESSAGE
Content-Type: application/sdp
Supported: gruu
User-Agent: baresip v0.4.14 (x86_64/linux)
Content-Length: 335
v=0
o=- 1537643373 8569226 IN IP4 192.168.20.69
s=-
c=IN IP4 192.168.20.69
t=0 0
a=tool:baresip 0.4.14
m=audio 62856 RTP/AVP 0 8 101
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-15
a=sendrecv
a=label:1
a=rtcp-rsize
a=ssrc:1060798781 cname:sip:200@tools.a33842.net
a=ptime:20
DEBUG | 20151009-170802.510 | repro | REPRO:APP | 2977979200 | Proxy.cxx:167 | Got: INVITE sip:202@tools.a33842.net;transport=tcp SIP/2.0
Via: SIP/2.0/TCP 192.168.20.69:51792;branch=z9hG4bK7d4915a73e7b8341;rport=59118;received=83.69.202.99
Max-Forwards: 70
Contact: <sip:200-0x1d62570@192.168.20.69:51792;transport=tcp>
To: <sip:202@tools.a33842.net;transport=tcp>
From: <sip:200@tools.a33842.net>;tag=c4a21a647a3e7e7d
Call-ID: cb402c900dc6b17f
CSeq: 54309 INVITE
Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, REFER, NOTIFY, SUBSCRIBE, INFO, MESSAGE
Content-Type: application/sdp
Supported: gruu
User-Agent: baresip v0.4.14 (x86_64/linux)
Content-Length: 335
v=0
o=- 1537643373 8569226 IN IP4 192.168.20.69
s=-
c=IN IP4 192.168.20.69
t=0 0
a=tool:baresip 0.4.14
m=audio 62856 RTP/AVP 0 8 101
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-15
a=sendrecv
a=label:1
a=rtcp-rsize
a=ssrc:1060798781 cname:sip:200@tools.a33842.net
a=ptime:20
INFO | 20151009-170802.510 | repro | REPRO:APP | 2977979200 | Proxy.cxx:366 | New RequestContext tid=7d4915a73e7b8341 : SipReq: INVITE 202@tools.a33842.net tid=7d4915a73e7b8341 cseq=54309 INVITE contact=200-0x1d62570@192.168.20.69:51792 / 54309 from(wire)
INFO | 20151009-170802.510 | repro | REPRO:APP | 2977979200 | Proxy.cxx:376 | Inserting new RequestContext tid=7d4915a73e7b8341 -> numtrans=1 final=0
INFO | 20151009-170802.510 | repro | REPRO:APP | 2977979200 | RequestContext.cxx:92 | RequestContext::process(SipMessage) 7d4915a73e7b8341
DEBUG | 20151009-170802.510 | repro | REPRO:APP | 2977979200 | RequestContext.cxx:152 | Got a request.
DEBUG | 20151009-170802.511 | repro | REPRO:APP | 2977979200 | ProcessorChain.cxx:95 | Chain invoking RequestProcessor: StrictRouteFixup
DEBUG | 20151009-170802.511 | repro | REPRO:APP | 2977979200 | monkeys/StrictRouteFixup.cxx:39 | Monkey handling request: StrictRouteFixup; reqcontext = numtrans=1 final=0 req=SipReq: INVITE 202@tools.a33842.net tid=7d4915a73e7b8341 cseq=54309 INVITE contact=200-0x1d62570@192.168.20.69:51792 / 54309 from(wire)
DEBUG | 20151009-170802.511 | repro | REPRO:APP | 2977979200 | ProcessorChain.cxx:95 | Chain invoking RequestProcessor: IsTrustedNode
DEBUG | 20151009-170802.511 | repro | REPRO:APP | 2977979200 | monkeys/IsTrustedNode.cxx:36 | Monkey handling request: IsTrustedNode; reqcontext = numtrans=1 final=0 req=SipReq: INVITE 202@tools.a33842.net tid=7d4915a73e7b8341 cseq=54309 INVITE contact=200-0x1d62570@192.168.20.69:51792 / 54309 from(wire)
INFO | 20151009-170802.511 | repro | REPRO:APP | 2977979200 | AclStore.cxx:558 | AclStore - source address NOT trusted: 83.69.202.99:59118 TCP
DEBUG | 20151009-170802.511 | repro | REPRO:APP | 2977979200 | ProcessorChain.cxx:95 | Chain invoking RequestProcessor: DigestAuthenticator
DEBUG | 20151009-170802.511 | repro | REPRO:APP | 2977979200 | monkeys/DigestAuthenticator.cxx:51 | Monkey handling request: DigestAuthenticator; reqcontext = numtrans=1 final=0 req=SipReq: INVITE 202@tools.a33842.net tid=7d4915a73e7b8341 cseq=54309 INVITE contact=200-0x1d62570@192.168.20.69:51792 / 54309 from(wire)
DEBUG | 20151009-170802.511 | repro | RESIP | 2977979200 | Helper.cxx:374 | Helper::makeResponse(SipReq: INVITE 202@tools.a33842.net tid=7d4915a73e7b8341 cseq=54309 INVITE contact=200-0x1d62570@192.168.20.69:51792 / 54309 from(wire) code=407 reason=
DEBUG | 20151009-170802.511 | repro | REPRO:APP | 2977979200 | RequestContext.cxx:937 | tid of orig req: 7d4915a73e7b8341
DEBUG | 20151009-170802.511 | repro | REPRO:APP | 2977979200 | RequestContext.cxx:972 | Ensuring orig tid matches tid of response: 7d4915a73e7b8341 == 7d4915a73e7b8341
DEBUG | 20151009-170802.512 | repro | REPRO:APP | 2977979200 | RequestContext.cxx:979 | Sending final response.
DEBUG | 20151009-170802.512 | repro | RESIP | 2977979200 | SipStack.cxx:822 | SEND: SipResp: 407 tid=7d4915a73e7b8341 cseq=54309 INVITE / 54309 from(tu)
DEBUG | 20151009-170802.512 | repro | REPRO:APP | 2977979200 | ProcessorChain.cxx:101 | RequestProcessor aborted all chains: DigestAuthenticator
DEBUG | 20151009-170802.512 | repro | RESIP:TRANSACTION | 3011550016 | TimerQueue.cxx:50 | Adding timer: Timer H tid=7d4915a73e7b8341 ms=32000
DEBUG | 20151009-170802.512 | repro | RESIP:TRANSPORT | 3011550016 | TransportSelector.cxx:1072 | Found transport: [ V4 194.149.90.25:5060 TCP transportKey=1 ]
DEBUG | 20151009-170802.513 | repro | RESIP:TRANSPORT | 3011550016 | TransportSelector.cxx:1288 | Transmitting to [ V4 83.69.202.99:59118 TCP flowKey=41 transportKey=1 ] tlsDomain= via [ V4 194.149.90.25:5060 TCP transportKey=1 ]
SIP/2.0 407 Proxy Authentication Required
Via: SIP/2.0/TCP 192.168.20.69:51792;branch=z9hG4bK7d4915a73e7b8341;rport=59118;received=83.69.202.99
Proxy-Authenticate: Digest nonce="1444399682:f6e54acc50c805849a5b7b3764595298",algorithm=MD5,realm="tools.a33842.net"
To: <sip:202@tools.a33842.net;transport=tcp>;tag=d41d8852
From: <sip:200@tools.a33842.net>;tag=c4a21a647a3e7e7d
Call-ID: cb402c900dc6b17f
CSeq: 54309 INVITE
Server: repro 1.10.0~beta2
Content-Length: 0
sigcomp id=
DEBUG | 20151009-170802.513 | repro | RESIP:TRANSPORT | 3003157312 | TcpBaseTransport.cxx:309 | Processing write for [ V4 83.69.202.99:59118 TCP flowKey=41 transportKey=1 ]
DEBUG | 20151009-170802.513 | repro | RESIP:TRANSPORT | 3003157312 | ConnectionManager.cxx:65 | Found fd 41
DEBUG | 20151009-170802.517 | repro | RESIP:TRANSPORT | 3003157312 | ConnectionBase.cxx:137 | In State: NewMessage
DEBUG | 20151009-170802.518 | repro | RESIP:TRANSPORT | 3003157312 | ConnectionBase.cxx:183 | ConnectionBase::process setting source [ V4 83.69.202.99:59118 TCP flowKey=41 transportKey=1 ]
DEBUG | 20151009-170802.518 | repro | RESIP:TRANSPORT | 3003157312 | Transport.cxx:392 | incoming from: [ V4 83.69.202.99:59118 TCP flowKey=41 transportKey=1 ]
DEBUG | 20151009-170802.518 | repro | RESIP:TRANSPORT | 3003157312 | ConnectionBase.cxx:438 | ##Connection: CONN_BASE: 0xaff00468 [ V4 83.69.202.99:59118 TCP flowKey=41 transportKey=1 ] received: ACK sip:202@tools.a33842.net;transport=tcp SIP/2.0
Via: SIP/2.0/TCP 192.168.20.69:51792;branch=z9hG4bK7d4915a73e7b8341;rport=59118;received=83.69.202.99
Max-Forwards: 70
To: <sip:202@tools.a33842.net;transport=tcp>;tag=d41d8852
From: <sip:200@tools.a33842.net>;tag=c4a21a647a3e7e7d
Call-ID: cb402c900dc6b17f
CSeq: 54309 ACK
User-Agent: baresip v0.4.14 (x86_64/linux)
Content-Length: 0
DEBUG | 20151009-170802.518 | repro | RESIP:TRANSPORT | 3003157312 | Connection.cxx:426 | Connection::performReads() read=368
DEBUG | 20151009-170802.518 | repro | RESIP:TRANSPORT | 3003157312 | ConnectionBase.cxx:1017 | Creating buffer for CONN_BASE: 0xaff00468 [ V4 83.69.202.99:59118 TCP flowKey=41 transportKey=1 ]
DEBUG | 20151009-170802.519 | repro | RESIP:TRANSACTION | 3011550016 | TuSelector.cxx:70 | Send to TU: Proxy size=0
ServerTransactionTerminated 7d4915a73e7b8341
DEBUG | 20151009-170802.519 | repro | REPRO:APP | 2977979200 | Proxy.cxx:167 | Got: ServerTransactionTerminated 7d4915a73e7b8341
INFO | 20151009-170802.519 | repro | REPRO:APP | 2977979200 | RequestContext.cxx:75 | RequestContext::process(TransactionTerminated) 7d4915a73e7b8341 : numtrans=1 final=1 req=SipReq: INVITE 202@tools.a33842.net tid=7d4915a73e7b8341 cseq=54309 INVITE contact=200-0x1d62570@192.168.20.69:51792 / 54309 from(wire)
DEBUG | 20151009-170802.519 | repro | REPRO:APP | 2977979200 | RequestContext.cxx:58 | RequestContext::~RequestContext() 0xafe0d5a0
DEBUG | 20151009-170802.558 | repro | RESIP:TRANSPORT | 3003157312 | ConnectionBase.cxx:137 | In State: NewMessage
DEBUG | 20151009-170802.558 | repro | RESIP:TRANSPORT | 3003157312 | ConnectionBase.cxx:183 | ConnectionBase::process setting source [ V4 83.69.202.99:59118 TCP flowKey=41 transportKey=1 ]
DEBUG | 20151009-170802.558 | repro | RESIP:TRANSPORT | 3003157312 | Transport.cxx:392 | incoming from: [ V4 83.69.202.99:59118 TCP flowKey=41 transportKey=1 ]
DEBUG | 20151009-170802.558 | repro | RESIP:TRANSPORT | 3003157312 | ConnectionBase.cxx:438 | ##Connection: CONN_BASE: 0xaff00468 [ V4 83.69.202.99:59118 TCP flowKey=41 transportKey=1 ] received: INVITE sip:202@tools.a33842.net;transport=tcp SIP/2.0
Via: SIP/2.0/TCP 192.168.20.69:51792;branch=z9hG4bK281212fb10a87742;rport=59118;received=83.69.202.99
Max-Forwards: 70
Contact: <sip:200-0x1d62570@192.168.20.69:51792;transport=tcp>
To: <sip:202@tools.a33842.net;transport=tcp>
From: <sip:200@tools.a33842.net>;tag=c4a21a647a3e7e7d
Call-ID: cb402c900dc6b17f
CSeq: 54310 INVITE
Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, REFER, NOTIFY, SUBSCRIBE, INFO, MESSAGE
Content-Type: application/sdp
Proxy-Authorization: Digest username="200", realm="tools.a33842.net", nonce="1444399682:f6e54acc50c805849a5b7b3764595298", uri="sip:202@tools.a33842.net;transport=tcp", response="f1fad58c8402c53e0f61973ccf4586da"
Supported: gruu
User-Agent: baresip v0.4.14 (x86_64/linux)
Content-Length: 335
v=0
o=- 1537643373 8569226 IN IP4 192.168.20.69
s=-
c=IN IP4 192.168.20.69
t=0 0
a=tool:baresip 0.4.14
m=audio 62856 RTP/AVP 0 8 101
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-15
a=sendrecv
a=label:1
a=rtcp-rsize
a=ssrc:1060798781 cname:sip:200@tools.a33842.net
a=ptime:20
DEBUG | 20151009-170802.559 | repro | RESIP:TRANSPORT | 3003157312 | Connection.cxx:426 | Connection::performReads() read=1098
DEBUG | 20151009-170802.559 | repro | RESIP:TRANSPORT | 3003157312 | ConnectionBase.cxx:1017 | Creating buffer for CONN_BASE: 0xaff00468 [ V4 83.69.202.99:59118 TCP flowKey=41 transportKey=1 ]
DEBUG | 20151009-170802.559 | repro | RESIP:TRANSACTION | 3011550016 | TuSelector.cxx:189 | TuSelector::selectTransactionUser: Checking which TU message belongs to:
INVITE sip:202@tools.a33842.net;transport=tcp SIP/2.0
Via: SIP/2.0/TCP 192.168.20.69:51792;branch=z9hG4bK281212fb10a87742;rport=59118;received=83.69.202.99
Max-Forwards: 70
Contact: <sip:200-0x1d62570@192.168.20.69:51792;transport=tcp>
To: <sip:202@tools.a33842.net;transport=tcp>
From: <sip:200@tools.a33842.net>;tag=c4a21a647a3e7e7d
Call-ID: cb402c900dc6b17f
CSeq: 54310 INVITE
Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, REFER, NOTIFY, SUBSCRIBE, INFO, MESSAGE
Content-Type: application/sdp
Proxy-Authorization: Digest username="200", realm="tools.a33842.net", nonce="1444399682:f6e54acc50c805849a5b7b3764595298", uri="sip:202@tools.a33842.net;transport=tcp", response="f1fad58c8402c53e0f61973ccf4586da"
Supported: gruu
User-Agent: baresip v0.4.14 (x86_64/linux)
Content-Length: 335
v=0
o=- 1537643373 8569226 IN IP4 192.168.20.69
s=-
c=IN IP4 192.168.20.69
t=0 0
a=tool:baresip 0.4.14
m=audio 62856 RTP/AVP 0 8 101
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-15
a=sendrecv
a=label:1
a=rtcp-rsize
a=ssrc:1060798781 cname:sip:200@tools.a33842.net
a=ptime:20
DEBUG | 20151009-170802.559 | repro | RESIP:TRANSACTION | 3011550016 | TransactionUser.cxx:83 | TransactionUser::isForMe: TU=DialogUsageManager, Checking rule... : SipReq: INVITE 202@tools.a33842.net tid=281212fb10a87742 cseq=54310 INVITE contact=200-0x1d62570@192.168.20.69:51792 / 54310 from(wire)
DEBUG | 20151009-170802.560 | repro | RESIP:TRANSACTION | 3011550016 | MessageFilterRule.cxx:66 | MessageFilterRule::matches: Method is not in list. Rule does not match.
DEBUG | 20151009-170802.560 | repro | RESIP:TRANSACTION | 3011550016 | TransactionUser.cxx:83 | TransactionUser::isForMe: TU=DialogUsageManager, Checking rule... : SipReq: INVITE 202@tools.a33842.net tid=281212fb10a87742 cseq=54310 INVITE contact=200-0x1d62570@192.168.20.69:51792 / 54310 from(wire)
DEBUG | 20151009-170802.560 | repro | RESIP:TRANSACTION | 3011550016 | MessageFilterRule.cxx:66 | MessageFilterRule::matches: Method is not in list. Rule does not match.
DEBUG | 20151009-170802.560 | repro | RESIP:TRANSACTION | 3011550016 | TransactionUser.cxx:90 | TransactionUser::isForMe: TU=DialogUsageManager, No matching rule found : SipReq: INVITE 202@tools.a33842.net tid=281212fb10a87742 cseq=54310 INVITE contact=200-0x1d62570@192.168.20.69:51792 / 54310 from(wire)
DEBUG | 20151009-170802.560 | repro | RESIP:TRANSACTION | 3011550016 | TransactionUser.cxx:83 | TransactionUser::isForMe: TU=Proxy, Checking rule... : SipReq: INVITE 202@tools.a33842.net tid=281212fb10a87742 cseq=54310 INVITE contact=200-0x1d62570@192.168.20.69:51792 / 54310 from(wire)
DEBUG | 20151009-170802.560 | repro | RESIP:TRANSACTION | 3011550016 | TransactionUser.cxx:86 | TransactionUser::isForMe: TU=Proxy, Match! : SipReq: INVITE 202@tools.a33842.net tid=281212fb10a87742 cseq=54310 INVITE contact=200-0x1d62570@192.168.20.69:51792 / 54310 from(wire)
DEBUG | 20151009-170802.560 | repro | RESIP | 3011550016 | Helper.cxx:374 | Helper::makeResponse(SipReq: INVITE 202@tools.a33842.net tid=281212fb10a87742 cseq=54310 INVITE contact=200-0x1d62570@192.168.20.69:51792 / 54310 from(wire) code=100 reason=
DEBUG | 20151009-170802.561 | repro | RESIP:TRANSACTION | 3011550016 | TimerQueue.cxx:50 | Adding timer: Timer Trying tid=281212fb10a87742 ms=80
DEBUG | 20151009-170802.561 | repro | RESIP:TRANSACTION | 3011550016 | TuSelector.cxx:70 | Send to TU: Proxy size=0
INVITE sip:202@tools.a33842.net;transport=tcp SIP/2.0
Via: SIP/2.0/TCP 192.168.20.69:51792;branch=z9hG4bK281212fb10a87742;rport=59118;received=83.69.202.99
Max-Forwards: 70
Contact: <sip:200-0x1d62570@192.168.20.69:51792;transport=tcp>
To: <sip:202@tools.a33842.net;transport=tcp>
From: <sip:200@tools.a33842.net>;tag=c4a21a647a3e7e7d
Call-ID: cb402c900dc6b17f
CSeq: 54310 INVITE
Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, REFER, NOTIFY, SUBSCRIBE, INFO, MESSAGE
Content-Type: application/sdp
Proxy-Authorization: Digest username="200", realm="tools.a33842.net", nonce="1444399682:f6e54acc50c805849a5b7b3764595298", uri="sip:202@tools.a33842.net;transport=tcp", response="f1fad58c8402c53e0f61973ccf4586da"
Supported: gruu
User-Agent: baresip v0.4.14 (x86_64/linux)
Content-Length: 335
v=0
o=- 1537643373 8569226 IN IP4 192.168.20.69
s=-
c=IN IP4 192.168.20.69
t=0 0
a=tool:baresip 0.4.14
m=audio 62856 RTP/AVP 0 8 101
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-15
a=sendrecv
a=label:1
a=rtcp-rsize
a=ssrc:1060798781 cname:sip:200@tools.a33842.net
a=ptime:20
DEBUG | 20151009-170802.561 | repro | REPRO:APP | 2977979200 | Proxy.cxx:167 | Got: INVITE sip:202@tools.a33842.net;transport=tcp SIP/2.0
Via: SIP/2.0/TCP 192.168.20.69:51792;branch=z9hG4bK281212fb10a87742;rport=59118;received=83.69.202.99
Max-Forwards: 70
Contact: <sip:200-0x1d62570@192.168.20.69:51792;transport=tcp>
To: <sip:202@tools.a33842.net;transport=tcp>
From: <sip:200@tools.a33842.net>;tag=c4a21a647a3e7e7d
Call-ID: cb402c900dc6b17f
CSeq: 54310 INVITE
Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, REFER, NOTIFY, SUBSCRIBE, INFO, MESSAGE
Content-Type: application/sdp
Proxy-Authorization: Digest username="200", realm="tools.a33842.net", nonce="1444399682:f6e54acc50c805849a5b7b3764595298", uri="sip:202@tools.a33842.net;transport=tcp", response="f1fad58c8402c53e0f61973ccf4586da"
Supported: gruu
User-Agent: baresip v0.4.14 (x86_64/linux)
Content-Length: 335
v=0
o=- 1537643373 8569226 IN IP4 192.168.20.69
s=-
c=IN IP4 192.168.20.69
t=0 0
a=tool:baresip 0.4.14
m=audio 62856 RTP/AVP 0 8 101
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-15
a=sendrecv
a=label:1
a=rtcp-rsize
a=ssrc:1060798781 cname:sip:200@tools.a33842.net
a=ptime:20
INFO | 20151009-170802.561 | repro | REPRO:APP | 2977979200 | Proxy.cxx:366 | New RequestContext tid=281212fb10a87742 : SipReq: INVITE 202@tools.a33842.net tid=281212fb10a87742 cseq=54310 INVITE contact=200-0x1d62570@192.168.20.69:51792 / 54310 from(wire)
INFO | 20151009-170802.561 | repro | REPRO:APP | 2977979200 | Proxy.cxx:376 | Inserting new RequestContext tid=281212fb10a87742 -> numtrans=1 final=0
INFO | 20151009-170802.561 | repro | REPRO:APP | 2977979200 | RequestContext.cxx:92 | RequestContext::process(SipMessage) 281212fb10a87742
DEBUG | 20151009-170802.562 | repro | REPRO:APP | 2977979200 | RequestContext.cxx:152 | Got a request.
DEBUG | 20151009-170802.562 | repro | REPRO:APP | 2977979200 | ProcessorChain.cxx:95 | Chain invoking RequestProcessor: StrictRouteFixup
DEBUG | 20151009-170802.562 | repro | REPRO:APP | 2977979200 | monkeys/StrictRouteFixup.cxx:39 | Monkey handling request: StrictRouteFixup; reqcontext = numtrans=1 final=0 req=SipReq: INVITE 202@tools.a33842.net tid=281212fb10a87742 cseq=54310 INVITE contact=200-0x1d62570@192.168.20.69:51792 / 54310 from(wire)
DEBUG | 20151009-170802.562 | repro | REPRO:APP | 2977979200 | ProcessorChain.cxx:95 | Chain invoking RequestProcessor: IsTrustedNode
DEBUG | 20151009-170802.562 | repro | REPRO:APP | 2977979200 | monkeys/IsTrustedNode.cxx:36 | Monkey handling request: IsTrustedNode; reqcontext = numtrans=1 final=0 req=SipReq: INVITE 202@tools.a33842.net tid=281212fb10a87742 cseq=54310 INVITE contact=200-0x1d62570@192.168.20.69:51792 / 54310 from(wire)
INFO | 20151009-170802.562 | repro | REPRO:APP | 2977979200 | AclStore.cxx:558 | AclStore - source address NOT trusted: 83.69.202.99:59118 TCP
DEBUG | 20151009-170802.562 | repro | REPRO:APP | 2977979200 | ProcessorChain.cxx:95 | Chain invoking RequestProcessor: DigestAuthenticator
DEBUG | 20151009-170802.562 | repro | REPRO:APP | 2977979200 | monkeys/DigestAuthenticator.cxx:51 | Monkey handling request: DigestAuthenticator; reqcontext = numtrans=1 final=0 req=SipReq: INVITE 202@tools.a33842.net tid=281212fb10a87742 cseq=54310 INVITE contact=200-0x1d62570@192.168.20.69:51792 / 54310 from(wire)
INFO | 20151009-170802.562 | repro | REPRO:APP | 2977979200 | monkeys/DigestAuthenticator.cxx:383 | Request user auth info for 200 at realm tools.a33842.net
DEBUG | 20151009-170802.562 | repro | REPRO:APP | 2977979200 | ProcessorChain.cxx:107 | RequestProcessor waiting for async response: DigestAuthenticator
DEBUG | 20151009-170802.562 | repro | REPRO:APP | 3053513536 | UserAuthGrabber.cxx:31 | Grabbed user info for 200@tools.a33842.net : f987fc1e0174ee22c81b1135d7220912
DEBUG | 20151009-170802.563 | repro | RESIP:TRANSACTION | 3053513536 | TuSelector.cxx:70 | Send to TU: Proxy size=0
UserInfoMessage(tid=281212fb10a87742)
DEBUG | 20151009-170802.563 | repro | REPRO:APP | 2977979200 | Proxy.cxx:167 | Got: UserInfoMessage(tid=281212fb10a87742)
DEBUG | 20151009-170802.563 | repro | REPRO:APP | 2977979200 | Proxy.cxx:438 | Trying to dispatch : UserInfoMessage(tid=281212fb10a87742)
DEBUG | 20151009-170802.563 | repro | REPRO:APP | 2977979200 | Proxy.cxx:443 | Sending UserInfoMessage(tid=281212fb10a87742) to numtrans=1 final=0 req=SipReq: INVITE 202@tools.a33842.net tid=281212fb10a87742 cseq=54310 INVITE contact=200-0x1d62570@192.168.20.69:51792 / 54310 from(wire)
INFO | 20151009-170802.563 | repro | REPRO:APP | 2977979200 | RequestContext.cxx:657 | RequestContext::process(ApplicationMessage) UserInfoMessage(tid=281212fb10a87742)
DEBUG | 20151009-170802.563 | repro | REPRO:APP | 2977979200 | ProcessorChain.cxx:95 | Chain invoking RequestProcessor: DigestAuthenticator
DEBUG | 20151009-170802.563 | repro | REPRO:APP | 2977979200 | monkeys/DigestAuthenticator.cxx:51 | Monkey handling request: DigestAuthenticator; reqcontext = numtrans=1 final=0 req=SipReq: INVITE 202@tools.a33842.net tid=281212fb10a87742 cseq=54310 INVITE contact=200-0x1d62570@192.168.20.69:51792 / 54310 from(wire)
INFO | 20151009-170802.563 | repro | REPRO:APP | 2977979200 | monkeys/DigestAuthenticator.cxx:113 | Received user auth info for 200 at realm tools.a33842.net
DEBUG | 20151009-170802.563 | repro | RESIP | 2977979200 | Helper.cxx:775 | Authenticating: realm=tools.a33842.net expires=3000
INFO | 20151009-170802.564 | repro | REPRO:APP | 2977979200 | monkeys/DigestAuthenticator.cxx:169 | Authentication ok for 200
INFO | 20151009-170802.564 | repro | REPRO:APP | 2977979200 | monkeys/DigestAuthenticator.cxx:272 | Identity-Info=http://:5080/cert?domain=tools.a33842.net
DEBUG | 20151009-170802.564 | repro | REPRO:APP | 2977979200 | ProcessorChain.cxx:95 | Chain invoking RequestProcessor: AmIResponsible
DEBUG | 20151009-170802.564 | repro | REPRO:APP | 2977979200 | monkeys/AmIResponsible.cxx:32 | Monkey handling request: AmIResponsible; reqcontext = numtrans=1 final=0 identity=200 req=SipReq: INVITE 202@tools.a33842.net tid=281212fb10a87742 cseq=54310 INVITE contact=200-0x1d62570@192.168.20.69:51792 / 54310 from(wire)
DEBUG | 20151009-170802.564 | repro | REPRO:APP | 2977979200 | Proxy.cxx:595 | Proxy::isMyUri sip:202@tools.a33842.net;transport=tcp 1
DEBUG | 20151009-170802.564 | repro | REPRO:APP | 2977979200 | ProcessorChain.cxx:95 | Chain invoking RequestProcessor: RequestFilter
DEBUG | 20151009-170802.564 | repro | REPRO:APP | 2977979200 | monkeys/RequestFilter.cxx:154 | Monkey handling request: RequestFilter; reqcontext = numtrans=1 final=0 identity=200 req=SipReq: INVITE 202@tools.a33842.net tid=281212fb10a87742 cseq=54310 INVITE contact=200-0x1d62570@192.168.20.69:51792 / 54310 from(wire)
DEBUG | 20151009-170802.564 | repro | REPRO:APP | 2977979200 | monkeys/RequestFilter.cxx:147 | Request is accepted
DEBUG | 20151009-170802.564 | repro | REPRO:APP | 2977979200 | ProcessorChain.cxx:95 | Chain invoking RequestProcessor: StaticRoute
DEBUG | 20151009-170802.564 | repro | REPRO:APP | 2977979200 | monkeys/StaticRoute.cxx:39 | Monkey handling request: StaticRoute; reqcontext = numtrans=1 final=0 identity=200 req=SipReq: INVITE 202@tools.a33842.net tid=281212fb10a87742 cseq=54310 INVITE contact=200-0x1d62570@192.168.20.69:51792 / 54310 from(wire)
DEBUG | 20151009-170802.564 | repro | REPRO:APP | 2977979200 | RouteStore.cxx:298 | Consider route reqUri=sip:202@tools.a33842.net;transport=tcp method=INVITE event=
DEBUG | 20151009-170802.564 | repro | REPRO:APP | 2977979200 | RouteStore.cxx:344 | Route matched
DEBUG | 20151009-170802.565 | repro | REPRO:APP | 2977979200 | monkeys/StaticRoute.cxx:68 | target domain nkofs.ru is not local
INFO | 20151009-170802.565 | repro | REPRO:APP | 2977979200 | monkeys/StaticRoute.cxx:100 | Adding target sip:$1@nkofs.ru
INFO | 20151009-170802.565 | repro | REPRO:APP | 2977979200 | ResponseContext.cxx:64 | Adding candidate <sip:$1@nkofs.ru>
DEBUG | 20151009-170802.565 | repro | REPRO:APP | 2977979200 | ProcessorChain.cxx:113 | RequestProcessor skipping current chain: StaticRoute
INFO | 20151009-170802.565 | repro | REPRO:APP | 2977979200 | RequestContext.cxx:723 | numtrans=1 final=0 identity=200 req=SipReq: INVITE 202@tools.a33842.net tid=281212fb10a87742 cseq=54310 INVITE contact=200-0x1d62570@192.168.20.69:51792 / 54310 from(wire) there are 1 candidates -> continue
DEBUG | 20151009-170802.565 | repro | REPRO:APP | 2977979200 | ProcessorChain.cxx:95 | Chain invoking TargetProcessor: QValueTargetHandler
DEBUG | 20151009-170802.565 | repro | REPRO:APP | 2977979200 | monkeys/QValueTargetHandler.cxx:106 | No ForkControlMessage for me.
DEBUG | 20151009-170802.565 | repro | REPRO:APP | 2977979200 | ProcessorChain.cxx:95 | Chain invoking TargetProcessor: SimpleTargetHandler
DEBUG | 20151009-170802.565 | repro | REPRO:APP | 2977979200 | Proxy.cxx:595 | Proxy::isMyUri sip:$1@nkofs.ru 0
DEBUG | 20151009-170802.565 | repro | REPRO:APP | 2977979200 | ResponseContext.cxx:563 | Set tuple dest: [ V4 0.0.0.0:0 UNKNOWN_TRANSPORT ]
INFO | 20151009-170802.566 | repro | REPRO:APP | 2977979200 | RequestContext.cxx:890 | Updating timer C.
INFO | 20151009-170802.566 | repro | REPRO:APP | 2977979200 | Proxy.cxx:554 | Posting timer C
DEBUG | 20151009-170802.566 | repro | RESIP:TRANSACTION | 2977979200 | TimerQueue.cxx:124 | Adding application timer: TimerCMessage(tid=281212fb10a87742) ms=180000
INFO | 20151009-170802.566 | repro | REPRO:APP | 2977979200 | Proxy.cxx:540 | add client transaction tid=0871be793dac463c 0xafe0d5a0
DEBUG | 20151009-170802.566 | repro | REPRO:APP | 2977979200 | Proxy.cxx:595 | Proxy::isMyUri sip:$1@nkofs.ru 0
DEBUG | 20151009-170802.566 | repro | RESIP | 2977979200 | SipStack.cxx:822 | SEND: SipReq: INVITE $1@nkofs.ru tid=0871be793dac463c cseq=54310 INVITE contact=200-0x1d62570@192.168.20.69:51792 / 54310 from(wire)
INFO | 20151009-170802.567 | repro | REPRO:APP | 2977979200 | ResponseContext.cxx:234 | Creating new client transaction 0871be793dac463c -> sip:$1@nkofs.ru
DEBUG | 20151009-170802.567 | repro | REPRO:APP | 2977979200 | ProcessorChain.cxx:101 | TargetProcessor aborted all chains: SimpleTargetHandler
DEBUG | 20151009-170802.567 | repro | RESIP:TRANSACTION | 3011550016 | TimerQueue.cxx:50 | Adding timer: Timer B tid=0871be793dac463c ms=32000
DEBUG | 20151009-170802.567 | repro | RESIP:TRANSPORT | 3011550016 | TransportSelector.cxx:556 | Looking up dns entries for sip:$1@nkofs.ru
DEBUG | 20151009-170802.567 | repro | RESIP:DNS | 3011550016 | DnsResult.cxx:261 | DnsResult::lookup sip:$1@nkofs.ru
DEBUG | 20151009-170802.568 | repro | RESIP:DNS | 3019942720 | dns/DnsStub.cxx:73 | nkofs.ru lookup failed: DNS server returned answer with no data
DEBUG | 20151009-170802.568 | repro | RESIP:DNS | 3019942720 | dns/DnsStub.cxx:67 | _sip._tcp.nkofs.ru (SRV) --> p=5 w=0 dummy.nkofs.ru:5060_sip._tcp.nkofs.ru (SRV) --> p=10 w=0 pluto.foxq.org:5060_sip._tcp.nkofs.ru (SRV) --> p=15 w=0 nbn.foxq.org:5060
DEBUG | 20151009-170802.568 | repro | RESIP:DNS | 3019942720 | dns/DnsStub.cxx:49 | dummy.nkofs.ru(A)--> 78.107.130.72
DEBUG | 20151009-170802.568 | repro | RESIP:TRANSPORT | 3011550016 | TransportSelector.cxx:871 | Looked up source for destination: [ V4 78.107.130.72:5060 TCP targetDomain=nkofs.ru ] -> [ V4 194.149.90.25:0 TCP targetDomain=nkofs.ru ] sent-by= sent-port=0
DEBUG | 20151009-170802.568 | repro | RESIP:TRANSPORT | 3011550016 | TransportSelector.cxx:1481 | findTransportBySource([ V4 194.149.90.25:0 TCP targetDomain=nkofs.ru ])
DEBUG | 20151009-170802.568 | repro | RESIP:TRANSPORT | 3011550016 | TransportSelector.cxx:1495 | should port be ignored: 1
DEBUG | 20151009-170802.568 | repro | RESIP:TRANSPORT | 3011550016 | TransportSelector.cxx:1537 | findTransport (any port, specific interface) => Transport: [ V4 194.149.90.25:55060 TCP transportKey=2 ] on 194.149.90.25 key: [ V4 194.149.90.25:5060 TCP transportKey=1 ] search: [ V4 194.149.90.25:0 TCP targetDomain=nkofs.ru ]
DEBUG | 20151009-170802.568 | repro | RESIP:TRANSPORT | 3011550016 | TransportSelector.cxx:979 | Found transport: [ V4 194.149.90.25:0 TCP targetDomain=nkofs.ru ]
DEBUG | 20151009-170802.569 | repro | RESIP | 3011550016 | DateCategory.cxx:191 | Set date: day=5 month=9 year=2015 14:8:2
DEBUG | 20151009-170802.569 | repro | RESIP | 3011550016 | SipMessage.cxx:557 | Indentity Canonical String is: sip:200@tools.a33842.net|sip:202@tools.a33842.net;transport=tcp|cb402c900dc6b17f|54310 INVITE|Fri, 09 Oct 2015 14:08:02 GMT|sip:200-0x1d62570@192.168.20.69:51792;transport=tcp|v=0
o=- 1537643373 8569226 IN IP4 192.168.20.69
s=-
c=IN IP4 192.168.20.69
t=0 0
a=tool:baresip 0.4.14
m=audio 62856 RTP/AVP 0 8 101
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-15
a=sendrecv
a=label:1
a=rtcp-rsize
a=ssrc:1060798781 cname:sip:200@tools.a33842.net
a=ptime:20
DEBUG | 20151009-170802.569 | repro | RESIP | 3011550016 | ssl/Security.cxx:1751 | Compute identity for sip:200@tools.a33842.net|sip:202@tools.a33842.net;transport=tcp|cb402c900dc6b17f|54310 INVITE|Fri, 09 Oct 2015 14:08:02 GMT|sip:200-0x1d62570@192.168.20.69:51792;transport=tcp|v=0
o=- 1537643373 8569226 IN IP4 192.168.20.69
s=-
c=IN IP4 192.168.20.69
t=0 0
a=tool:baresip 0.4.14
m=audio 62856 RTP/AVP 0 8 101
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-15
a=sendrecv
a=label:1
a=rtcp-rsize
a=ssrc:1060798781 cname:sip:200@tools.a33842.net
a=ptime:20
INFO | 20151009-170802.569 | repro | RESIP | 3011550016 | ssl/Security.cxx:1756 | No private key for tools.a33842.net
DEBUG | 20151009-170802.569 | repro | RESIP | 3011550016 | BaseException.cxx:21 | BaseException at ssl/Security.cxx:1757 Missing private key when computing identity
INFO | 20151009-170802.569 | repro | RESIP:TRANSPORT | 3011550016 | TransportSelector.cxx:1246 | Couldn't add identity header: SecurityException Missing private key when computing identity @ ssl/Security.cxx:1757
DEBUG | 20151009-170802.569 | repro | REPRO:APP | 3011550016 | RRDecorator.cxx:60 | Proxy::decorateMessage called.
DEBUG | 20151009-170802.569 | repro | RESIP:TRANSPORT | 3011550016 | TransportSelector.cxx:1288 | Transmitting to [ V4 78.107.130.72:5060 TCP targetDomain=nkofs.ru transportKey=2 ] tlsDomain= via [ V4 194.149.90.25:55060 TCP targetDomain=nkofs.ru ]
INVITE sip:$1@nkofs.ru SIP/2.0
Via: SIP/2.0/TCP 194.149.90.25:55060;branch=z9hG4bK-524287-1---0871be793dac463c;rport
Via: SIP/2.0/TCP 192.168.20.69:51792;branch=z9hG4bK281212fb10a87742;rport=59118;received=83.69.202.99
Max-Forwards: 69
Contact: <sip:200-0x1d62570@192.168.20.69:51792;transport=tcp>
To: <sip:202@tools.a33842.net;transport=tcp>
From: <sip:200@tools.a33842.net>;tag=c4a21a647a3e7e7d
Call-ID: cb402c900dc6b17f
CSeq: 54310 INVITE
Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, REFER, NOTIFY, SUBSCRIBE, INFO, MESSAGE
Content-Type: application/sdp
Date: Fri, 09 Oct 2015 14:08:02 GMT
Supported: gruu
User-Agent: baresip v0.4.14 (x86_64/linux)
Content-Length: 335
v=0
o=- 1537643373 8569226 IN IP4 192.168.20.69
s=-
c=IN IP4 192.168.20.69
t=0 0
a=tool:baresip 0.4.14
m=audio 62856 RTP/AVP 0 8 101
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-15
a=sendrecv
a=label:1
a=rtcp-rsize
a=ssrc:1060798781 cname:sip:200@tools.a33842.net
a=ptime:20
sigcomp id=
DEBUG | 20151009-170802.570 | repro | RESIP:TRANSPORT | 3003157312 | TcpBaseTransport.cxx:309 | Processing write for [ V4 78.107.130.72:5060 TCP targetDomain=nkofs.ru transportKey=2 ]
DEBUG | 20151009-170802.570 | repro | RESIP:TRANSPORT | 3003157312 | ConnectionManager.cxx:93 | Could not find a connection for [ V4 78.107.130.72:5060 TCP targetDomain=nkofs.ru transportKey=2 ]
DEBUG | 20151009-170802.570 | repro | RESIP:TRANSPORT | 3003157312 | InternalTransport.cxx:121 | Creating fd=43 V4/TCP
DEBUG | 20151009-170802.570 | repro | RESIP:TRANSPORT | 3003157312 | TcpBaseTransport.cxx:241 | Opening new connection to [ V4 78.107.130.72:5060 TCP targetDomain=nkofs.ru transportKey=2 ]
DEBUG | 20151009-170802.570 | repro | RESIP:TRANSPORT | 3003157312 | ConnectionBase.cxx:71 | ConnectionBase::ConnectionBase, who: [ V4 78.107.130.72:5060 TCP targetDomain=nkofs.ru transportKey=2 ] 0xaff00708
DEBUG | 20151009-170802.570 | repro | RESIP:TRANSPORT | 3003157312 | ConnectionBase.cxx:84 | No compression library available: 0xaff00708
INFO | 20151009-170802.570 | repro | RESIP:TRANSPORT | 3003157312 | Connection.cxx:43 | Connection::Connection: new connection created to who: [ V4 78.107.130.72:5060 TCP targetDomain=nkofs.ru flowKey=43 transportKey=2 ]
DEBUG | 20151009-170802.570 | repro | RESIP:TRANSPORT | 3003157312 | ConnectionManager.cxx:187 | ConnectionManager::addConnection() 43:[ V4 78.107.130.72:5060 TCP targetDomain=nkofs.ru flowKey=43 transportKey=2 ], totalConnections=1
DEBUG | 20151009-170802.570 | repro | RESIP:TRANSPORT | 3003157312 | ConnectionManager.cxx:248 | recycling connections not used in last 7200 seconds
DEBUG | 20151009-170802.571 | repro | RESIP:TRANSPORT | 3003157312 | TcpConnection.cxx:18 | Creating TCP connection [ V4 78.107.130.72:5060 TCP targetDomain=nkofs.ru transportKey=2 ] on 43
DEBUG | 20151009-170802.596 | repro | RESIP:TRANSACTION | 3011550016 | TimerQueue.cxx:50 | Adding timer: TcpConnectTimer tid=0871be793dac463c ms=2000
DEBUG | 20151009-170802.641 | repro | RESIP:TRANSPORT | 3011550016 | TransportSelector.cxx:1072 | Found transport: [ V4 194.149.90.25:5060 TCP transportKey=1 ]
DEBUG | 20151009-170802.641 | repro | RESIP:TRANSPORT | 3011550016 | TransportSelector.cxx:1288 | Transmitting to [ V4 83.69.202.99:59118 TCP flowKey=41 transportKey=1 ] tlsDomain= via [ V4 194.149.90.25:5060 TCP transportKey=1 ]
SIP/2.0 100 Trying
Via: SIP/2.0/TCP 192.168.20.69:51792;branch=z9hG4bK281212fb10a87742;rport=59118;received=83.69.202.99
To: <sip:202@tools.a33842.net;transport=tcp>
From: <sip:200@tools.a33842.net>;tag=c4a21a647a3e7e7d
Call-ID: cb402c900dc6b17f
CSeq: 54310 INVITE
Content-Length: 0
sigcomp id=
DEBUG | 20151009-170802.646 | repro | RESIP:TRANSPORT | 3003157312 | TcpBaseTransport.cxx:309 | Processing write for [ V4 83.69.202.99:59118 TCP flowKey=41 transportKey=1 ]
DEBUG | 20151009-170802.646 | repro | RESIP:TRANSPORT | 3003157312 | ConnectionManager.cxx:65 | Found fd 41
DEBUG | 20151009-170804.596 | repro | RESIP | 3011550016 | Helper.cxx:374 | Helper::makeResponse(SipReq: INVITE $1@nkofs.ru tid=0871be793dac463c cseq=54310 INVITE contact=200-0x1d62570@192.168.20.69:51792 / 54310 from(tu) code=408 reason=
DEBUG | 20151009-170804.596 | repro | RESIP:DNS | 3019942720 | DnsResult.cxx:187 | Remove vip nkofs.ru(1)
DEBUG | 20151009-170804.596 | repro | RESIP:DNS | 3019942720 | dns/RRVip.cxx:96 | removed vip nkofs.ru(1): 78.107.130.66
DEBUG | 20151009-170804.596 | repro | RESIP:TRANSACTION | 3011550016 | TuSelector.cxx:70 | Send to TU: Proxy size=0
SIP/2.0 408 Request Timeout
Via: SIP/2.0/TCP 194.149.90.25:55060;branch=z9hG4bK-524287-1---0871be793dac463c;rport
Via: SIP/2.0/TCP 192.168.20.69:51792;branch=z9hG4bK281212fb10a87742;rport=59118;received=83.69.202.99
To: <sip:202@tools.a33842.net;transport=tcp>;tag=5689b226
From: <sip:200@tools.a33842.net>;tag=c4a21a647a3e7e7d
Call-ID: cb402c900dc6b17f
CSeq: 54310 INVITE
Content-Length: 0
DEBUG | 20151009-170804.597 | repro | RESIP:TRANSACTION | 3011550016 | TuSelector.cxx:70 | Send to TU: Proxy size=0
ClientTransactionTerminated 0871be793dac463c
DEBUG | 20151009-170804.597 | repro | REPRO:APP | 2977979200 | Proxy.cxx:167 | Got: SIP/2.0 408 Request Timeout
Via: SIP/2.0/TCP 194.149.90.25:55060;branch=z9hG4bK-524287-1---0871be793dac463c;rport
Via: SIP/2.0/TCP 192.168.20.69:51792;branch=z9hG4bK281212fb10a87742;rport=59118;received=83.69.202.99
To: <sip:202@tools.a33842.net;transport=tcp>;tag=5689b226
From: <sip:200@tools.a33842.net>;tag=c4a21a647a3e7e7d
Call-ID: cb402c900dc6b17f
CSeq: 54310 INVITE
Content-Length: 0
INFO | 20151009-170804.597 | repro | REPRO:APP | 2977979200 | Proxy.cxx:410 | Looking up RequestContext tid=0871be793dac463c
INFO | 20151009-170804.597 | repro | REPRO:APP | 2977979200 | RequestContext.cxx:92 | RequestContext::process(SipMessage) 0871be793dac463c
DEBUG | 20151009-170804.597 | repro | REPRO:APP | 2977979200 | ProcessorChain.cxx:95 | Chain invoking ResponseProcessor: OutboundTargetHandler
DEBUG | 20151009-170804.597 | repro | REPRO:APP | 2977979200 | monkeys/OutboundTargetHandler.cxx:40 | Looking for tid 0871be793dac463c
INFO | 20151009-170804.597 | repro | REPRO:APP | 2977979200 | ResponseContext.cxx:966 | processResponse:
SIP/2.0 408 Request Timeout
Via: SIP/2.0/TCP 194.149.90.25:55060;branch=z9hG4bK-524287-1---0871be793dac463c;rport
Via: SIP/2.0/TCP 192.168.20.69:51792;branch=z9hG4bK281212fb10a87742;rport=59118;received=83.69.202.99
To: <sip:202@tools.a33842.net;transport=tcp>;tag=5689b226
From: <sip:200@tools.a33842.net>;tag=c4a21a647a3e7e7d
Call-ID: cb402c900dc6b17f
CSeq: 54310 INVITE
Content-Length: 0
DEBUG | 20151009-170804.597 | repro | REPRO:APP | 2977979200 | ResponseContext.cxx:1047 | Search for 0871be793dac463c in [0871be793dac463c -> Target: sip:$1@nkofs.ru status=1]
DEBUG | 20151009-170804.597 | repro | REPRO:APP | 2977979200 | ResponseContext.cxx:1136 | forwardedFinal=0 outstanding client transactions: [0871be793dac463c -> Target: sip:$1@nkofs.ru status=1]
INFO | 20151009-170804.597 | repro | REPRO:APP | 2977979200 | ResponseContext.cxx:1262 | Terminating client transaction: 0871be793dac463c all = 0
INFO | 20151009-170804.597 | repro | REPRO:APP | 2977979200 | ResponseContext.cxx:1267 | client transactions: [0871be793dac463c -> Target: sip:$1@nkofs.ru status=1]
INFO | 20151009-170804.597 | repro | REPRO:APP | 2977979200 | ResponseContext.cxx:1435 | Forwarding best response: SipResp: 408 tid=281212fb10a87742 cseq=54310 INVITE / 54310 from(wire)
INFO | 20151009-170804.597 | repro | REPRO:APP | 2977979200 | ResponseContext.cxx:249 | Cancel all proceeding client transactions: 0
DEBUG | 20151009-170804.598 | repro | REPRO:APP | 2977979200 | RequestContext.cxx:937 | tid of orig req: 281212fb10a87742
DEBUG | 20151009-170804.598 | repro | REPRO:APP | 2977979200 | RequestContext.cxx:972 | Ensuring orig tid matches tid of response: 281212fb10a87742 == 281212fb10a87742
DEBUG | 20151009-170804.598 | repro | REPRO:APP | 2977979200 | RequestContext.cxx:979 | Sending final response.
DEBUG | 20151009-170804.598 | repro | RESIP | 2977979200 | SipStack.cxx:822 | SEND: SipResp: 408 tid=281212fb10a87742 cseq=54310 INVITE / 54310 from(wire)
DEBUG | 20151009-170804.598 | repro | REPRO:APP | 2977979200 | ProcessorChain.cxx:95 | Chain invoking TargetProcessor: QValueTargetHandler
DEBUG | 20151009-170804.598 | repro | RESIP:TRANSACTION | 3011550016 | TimerQueue.cxx:50 | Adding timer: Timer H tid=281212fb10a87742 ms=32000
DEBUG | 20151009-170804.598 | repro | REPRO:APP | 2977979200 | monkeys/QValueTargetHandler.cxx:106 | No ForkControlMessage for me.
DEBUG | 20151009-170804.598 | repro | RESIP:TRANSPORT | 3011550016 | TransportSelector.cxx:1072 | Found transport: [ V4 194.149.90.25:5060 TCP transportKey=1 ]
DEBUG | 20151009-170804.598 | repro | REPRO:APP | 2977979200 | ProcessorChain.cxx:95 | Chain invoking TargetProcessor: SimpleTargetHandler
DEBUG | 20151009-170804.598 | repro | REPRO:APP | 2977979200 | Proxy.cxx:167 | Got: ClientTransactionTerminated 0871be793dac463c
INFO | 20151009-170804.598 | repro | REPRO:APP | 2977979200 | RequestContext.cxx:75 | RequestContext::process(TransactionTerminated) 0871be793dac463c : numtrans=2 final=1 identity=200 req=SipReq: INVITE 202@tools.a33842.net tid=281212fb10a87742 cseq=54310 INVITE contact=200-0x1d62570@192.168.20.69:51792 / 54310 from(wire)
DEBUG | 20151009-170804.598 | repro | RESIP:TRANSPORT | 3011550016 | TransportSelector.cxx:1288 | Transmitting to [ V4 83.69.202.99:59118 TCP flowKey=41 transportKey=1 ] tlsDomain= via [ V4 194.149.90.25:5060 TCP transportKey=1 ]
SIP/2.0 408 Request Timeout
Via: SIP/2.0/TCP 192.168.20.69:51792;branch=z9hG4bK281212fb10a87742;rport=59118;received=83.69.202.99
To: <sip:202@tools.a33842.net;transport=tcp>;tag=5689b226
From: <sip:200@tools.a33842.net>;tag=c4a21a647a3e7e7d
Call-ID: cb402c900dc6b17f
CSeq: 54310 INVITE
Server: repro 1.10.0~beta2
Content-Length: 0
sigcomp id=
DEBUG | 20151009-170804.598 | repro | RESIP:TRANSPORT | 3003157312 | TcpBaseTransport.cxx:309 | Processing write for [ V4 83.69.202.99:59118 TCP flowKey=41 transportKey=1 ]
DEBUG | 20151009-170804.599 | repro | RESIP:TRANSPORT | 3003157312 | ConnectionManager.cxx:65 | Found fd 41
DEBUG | 20151009-170804.603 | repro | RESIP:TRANSPORT | 3003157312 | ConnectionBase.cxx:137 | In State: NewMessage
DEBUG | 20151009-170804.603 | repro | RESIP:TRANSPORT | 3003157312 | ConnectionBase.cxx:183 | ConnectionBase::process setting source [ V4 83.69.202.99:59118 TCP flowKey=41 transportKey=1 ]
DEBUG | 20151009-170804.603 | repro | RESIP:TRANSPORT | 3003157312 | Transport.cxx:392 | incoming from: [ V4 83.69.202.99:59118 TCP flowKey=41 transportKey=1 ]
DEBUG | 20151009-170804.603 | repro | RESIP:TRANSPORT | 3003157312 | ConnectionBase.cxx:438 | ##Connection: CONN_BASE: 0xaff00468 [ V4 83.69.202.99:59118 TCP flowKey=41 transportKey=1 ] received: ACK sip:202@tools.a33842.net;transport=tcp SIP/2.0
Via: SIP/2.0/TCP 192.168.20.69:51792;branch=z9hG4bK281212fb10a87742;rport=59118;received=83.69.202.99
Max-Forwards: 70
To: <sip:202@tools.a33842.net;transport=tcp>;tag=5689b226
From: <sip:200@tools.a33842.net>;tag=c4a21a647a3e7e7d
Call-ID: cb402c900dc6b17f
CSeq: 54310 ACK
User-Agent: baresip v0.4.14 (x86_64/linux)
Content-Length: 0
DEBUG | 20151009-170804.604 | repro | RESIP:TRANSPORT | 3003157312 | Connection.cxx:426 | Connection::performReads() read=368
DEBUG | 20151009-170804.604 | repro | RESIP:TRANSPORT | 3003157312 | ConnectionBase.cxx:1017 | Creating buffer for CONN_BASE: 0xaff00468 [ V4 83.69.202.99:59118 TCP flowKey=41 transportKey=1 ]
DEBUG | 20151009-170804.604 | repro | RESIP:TRANSACTION | 3011550016 | TuSelector.cxx:70 | Send to TU: Proxy size=0
ServerTransactionTerminated 281212fb10a87742
DEBUG | 20151009-170804.604 | repro | REPRO:APP | 2977979200 | Proxy.cxx:167 | Got: ServerTransactionTerminated 281212fb10a87742
INFO | 20151009-170804.604 | repro | REPRO:APP | 2977979200 | RequestContext.cxx:75 | RequestContext::process(TransactionTerminated) 281212fb10a87742 : numtrans=1 final=1 identity=200 req=SipReq: INVITE 202@tools.a33842.net tid=281212fb10a87742 cseq=54310 INVITE contact=200-0x1d62570@192.168.20.69:51792 / 54310 from(wire)
DEBUG | 20151009-170804.604 | repro | REPRO:APP | 2977979200 | RequestContext.cxx:58 | RequestContext::~RequestContext() 0xafe0d5a0
DEBUG | 20151009-170806.115 | repro | RESIP:TRANSPORT | 3003157312 | ConnectionBase.cxx:137 | In State: NewMessage
DEBUG | 20151009-170806.115 | repro | RESIP:TRANSPORT | 3003157312 | ConnectionBase.cxx:183 | ConnectionBase::process setting source [ V4 83.69.202.99:59118 TCP flowKey=41 transportKey=1 ]
DEBUG | 20151009-170806.116 | repro | RESIP:TRANSPORT | 3003157312 | Transport.cxx:392 | incoming from: [ V4 83.69.202.99:59118 TCP flowKey=41 transportKey=1 ]
DEBUG | 20151009-170806.116 | repro | RESIP:TRANSPORT | 3003157312 | ConnectionBase.cxx:438 | ##Connection: CONN_BASE: 0xaff00468 [ V4 83.69.202.99:59118 TCP flowKey=41 transportKey=1 ] received: INVITE sip:202@tools.a33842.net;transport=tcp SIP/2.0
Via: SIP/2.0/TCP 192.168.20.69:51792;branch=z9hG4bKf7394925e8a39a49;rport=59118;received=83.69.202.99
Max-Forwards: 70
Contact: <sip:200-0x1d62570@192.168.20.69:51792;transport=tcp>
To: <sip:202@tools.a33842.net;transport=tcp>
From: <sip:200@tools.a33842.net>;tag=b57fefeb093c834a
Call-ID: dd44d5cba0b20ee2
CSeq: 27673 INVITE
Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, REFER, NOTIFY, SUBSCRIBE, INFO, MESSAGE
Content-Type: application/sdp
Supported: gruu
User-Agent: baresip v0.4.14 (x86_64/linux)
Content-Length: 337
v=0
o=- 2178251043 1273685869 IN IP4 192.168.20.69
s=-
c=IN IP4 192.168.20.69
t=0 0
a=tool:baresip 0.4.14
m=audio 58846 RTP/AVP 0 8 101
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-15
a=sendrecv
a=label:1
a=rtcp-rsize
a=ssrc:714692746 cname:sip:200@tools.a33842.net
a=ptime:20
DEBUG | 20151009-170806.116 | repro | RESIP:TRANSPORT | 3003157312 | Connection.cxx:426 | Connection::performReads() read=886
DEBUG | 20151009-170806.116 | repro | RESIP:TRANSPORT | 3003157312 | ConnectionBase.cxx:1017 | Creating buffer for CONN_BASE: 0xaff00468 [ V4 83.69.202.99:59118 TCP flowKey=41 transportKey=1 ]
DEBUG | 20151009-170806.116 | repro | RESIP:TRANSACTION | 3011550016 | TuSelector.cxx:189 | TuSelector::selectTransactionUser: Checking which TU message belongs to:
INVITE sip:202@tools.a33842.net;transport=tcp SIP/2.0
Via: SIP/2.0/TCP 192.168.20.69:51792;branch=z9hG4bKf7394925e8a39a49;rport=59118;received=83.69.202.99
Max-Forwards: 70
Contact: <sip:200-0x1d62570@192.168.20.69:51792;transport=tcp>
To: <sip:202@tools.a33842.net;transport=tcp>
From: <sip:200@tools.a33842.net>;tag=b57fefeb093c834a
Call-ID: dd44d5cba0b20ee2
CSeq: 27673 INVITE
Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, REFER, NOTIFY, SUBSCRIBE, INFO, MESSAGE
Content-Type: application/sdp
Supported: gruu
User-Agent: baresip v0.4.14 (x86_64/linux)
Content-Length: 337
v=0
o=- 2178251043 1273685869 IN IP4 192.168.20.69
s=-
c=IN IP4 192.168.20.69
t=0 0
a=tool:baresip 0.4.14
m=audio 58846 RTP/AVP 0 8 101
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-15
a=sendrecv
a=label:1
a=rtcp-rsize
a=ssrc:714692746 cname:sip:200@tools.a33842.net
a=ptime:20
DEBUG | 20151009-170806.117 | repro | RESIP:TRANSACTION | 3011550016 | TransactionUser.cxx:83 | TransactionUser::isForMe: TU=DialogUsageManager, Checking rule... : SipReq: INVITE 202@tools.a33842.net tid=f7394925e8a39a49 cseq=27673 INVITE contact=200-0x1d62570@192.168.20.69:51792 / 27673 from(wire)
DEBUG | 20151009-170806.117 | repro | RESIP:TRANSACTION | 3011550016 | MessageFilterRule.cxx:66 | MessageFilterRule::matches: Method is not in list. Rule does not match.
DEBUG | 20151009-170806.117 | repro | RESIP:TRANSACTION | 3011550016 | TransactionUser.cxx:83 | TransactionUser::isForMe: TU=DialogUsageManager, Checking rule... : SipReq: INVITE 202@tools.a33842.net tid=f7394925e8a39a49 cseq=27673 INVITE contact=200-0x1d62570@192.168.20.69:51792 / 27673 from(wire)
DEBUG | 20151009-170806.117 | repro | RESIP:TRANSACTION | 3011550016 | MessageFilterRule.cxx:66 | MessageFilterRule::matches: Method is not in list. Rule does not match.
DEBUG | 20151009-170806.117 | repro | RESIP:TRANSACTION | 3011550016 | TransactionUser.cxx:90 | TransactionUser::isForMe: TU=DialogUsageManager, No matching rule found : SipReq: INVITE 202@tools.a33842.net tid=f7394925e8a39a49 cseq=27673 INVITE contact=200-0x1d62570@192.168.20.69:51792 / 27673 from(wire)
DEBUG | 20151009-170806.117 | repro | RESIP:TRANSACTION | 3011550016 | TransactionUser.cxx:83 | TransactionUser::isForMe: TU=Proxy, Checking rule... : SipReq: INVITE 202@tools.a33842.net tid=f7394925e8a39a49 cseq=27673 INVITE contact=200-0x1d62570@192.168.20.69:51792 / 27673 from(wire)
DEBUG | 20151009-170806.117 | repro | RESIP:TRANSACTION | 3011550016 | TransactionUser.cxx:86 | TransactionUser::isForMe: TU=Proxy, Match! : SipReq: INVITE 202@tools.a33842.net tid=f7394925e8a39a49 cseq=27673 INVITE contact=200-0x1d62570@192.168.20.69:51792 / 27673 from(wire)
DEBUG | 20151009-170806.117 | repro | RESIP | 3011550016 | Helper.cxx:374 | Helper::makeResponse(SipReq: INVITE 202@tools.a33842.net tid=f7394925e8a39a49 cseq=27673 INVITE contact=200-0x1d62570@192.168.20.69:51792 / 27673 from(wire) code=100 reason=
DEBUG | 20151009-170806.117 | repro | RESIP:TRANSACTION | 3011550016 | TimerQueue.cxx:50 | Adding timer: Timer Trying tid=f7394925e8a39a49 ms=80
DEBUG | 20151009-170806.117 | repro | RESIP:TRANSACTION | 3011550016 | TuSelector.cxx:70 | Send to TU: Proxy size=0
INVITE sip:202@tools.a33842.net;transport=tcp SIP/2.0
Via: SIP/2.0/TCP 192.168.20.69:51792;branch=z9hG4bKf7394925e8a39a49;rport=59118;received=83.69.202.99
Max-Forwards: 70
Contact: <sip:200-0x1d62570@192.168.20.69:51792;transport=tcp>
To: <sip:202@tools.a33842.net;transport=tcp>
From: <sip:200@tools.a33842.net>;tag=b57fefeb093c834a
Call-ID: dd44d5cba0b20ee2
CSeq: 27673 INVITE
Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, REFER, NOTIFY, SUBSCRIBE, INFO, MESSAGE
Content-Type: application/sdp
Supported: gruu
User-Agent: baresip v0.4.14 (x86_64/linux)
Content-Length: 337
v=0
o=- 2178251043 1273685869 IN IP4 192.168.20.69
s=-
c=IN IP4 192.168.20.69
t=0 0
a=tool:baresip 0.4.14
m=audio 58846 RTP/AVP 0 8 101
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-15
a=sendrecv
a=label:1
a=rtcp-rsize
a=ssrc:714692746 cname:sip:200@tools.a33842.net
a=ptime:20
DEBUG | 20151009-170806.118 | repro | REPRO:APP | 2977979200 | Proxy.cxx:167 | Got: INVITE sip:202@tools.a33842.net;transport=tcp SIP/2.0
Via: SIP/2.0/TCP 192.168.20.69:51792;branch=z9hG4bKf7394925e8a39a49;rport=59118;received=83.69.202.99
Max-Forwards: 70
Contact: <sip:200-0x1d62570@192.168.20.69:51792;transport=tcp>
To: <sip:202@tools.a33842.net;transport=tcp>
From: <sip:200@tools.a33842.net>;tag=b57fefeb093c834a
Call-ID: dd44d5cba0b20ee2
CSeq: 27673 INVITE
Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, REFER, NOTIFY, SUBSCRIBE, INFO, MESSAGE
Content-Type: application/sdp
Supported: gruu
User-Agent: baresip v0.4.14 (x86_64/linux)
Content-Length: 337
v=0
o=- 2178251043 1273685869 IN IP4 192.168.20.69
s=-
c=IN IP4 192.168.20.69
t=0 0
a=tool:baresip 0.4.14
m=audio 58846 RTP/AVP 0 8 101
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-15
a=sendrecv
a=label:1
a=rtcp-rsize
a=ssrc:714692746 cname:sip:200@tools.a33842.net
a=ptime:20
INFO | 20151009-170806.118 | repro | REPRO:APP | 2977979200 | Proxy.cxx:366 | New RequestContext tid=f7394925e8a39a49 : SipReq: INVITE 202@tools.a33842.net tid=f7394925e8a39a49 cseq=27673 INVITE contact=200-0x1d62570@192.168.20.69:51792 / 27673 from(wire)
INFO | 20151009-170806.118 | repro | REPRO:APP | 2977979200 | Proxy.cxx:376 | Inserting new RequestContext tid=f7394925e8a39a49 -> numtrans=1 final=0
INFO | 20151009-170806.118 | repro | REPRO:APP | 2977979200 | RequestContext.cxx:92 | RequestContext::process(SipMessage) f7394925e8a39a49
DEBUG | 20151009-170806.118 | repro | REPRO:APP | 2977979200 | RequestContext.cxx:152 | Got a request.
DEBUG | 20151009-170806.118 | repro | REPRO:APP | 2977979200 | ProcessorChain.cxx:95 | Chain invoking RequestProcessor: StrictRouteFixup
DEBUG | 20151009-170806.118 | repro | REPRO:APP | 2977979200 | monkeys/StrictRouteFixup.cxx:39 | Monkey handling request: StrictRouteFixup; reqcontext = numtrans=1 final=0 req=SipReq: INVITE 202@tools.a33842.net tid=f7394925e8a39a49 cseq=27673 INVITE contact=200-0x1d62570@192.168.20.69:51792 / 27673 from(wire)
DEBUG | 20151009-170806.119 | repro | REPRO:APP | 2977979200 | ProcessorChain.cxx:95 | Chain invoking RequestProcessor: IsTrustedNode
DEBUG | 20151009-170806.119 | repro | REPRO:APP | 2977979200 | monkeys/IsTrustedNode.cxx:36 | Monkey handling request: IsTrustedNode; reqcontext = numtrans=1 final=0 req=SipReq: INVITE 202@tools.a33842.net tid=f7394925e8a39a49 cseq=27673 INVITE contact=200-0x1d62570@192.168.20.69:51792 / 27673 from(wire)
INFO | 20151009-170806.119 | repro | REPRO:APP | 2977979200 | AclStore.cxx:558 | AclStore - source address NOT trusted: 83.69.202.99:59118 TCP
DEBUG | 20151009-170806.119 | repro | REPRO:APP | 2977979200 | ProcessorChain.cxx:95 | Chain invoking RequestProcessor: DigestAuthenticator
DEBUG | 20151009-170806.119 | repro | REPRO:APP | 2977979200 | monkeys/DigestAuthenticator.cxx:51 | Monkey handling request: DigestAuthenticator; reqcontext = numtrans=1 final=0 req=SipReq: INVITE 202@tools.a33842.net tid=f7394925e8a39a49 cseq=27673 INVITE contact=200-0x1d62570@192.168.20.69:51792 / 27673 from(wire)
DEBUG | 20151009-170806.119 | repro | RESIP | 2977979200 | Helper.cxx:374 | Helper::makeResponse(SipReq: INVITE 202@tools.a33842.net tid=f7394925e8a39a49 cseq=27673 INVITE contact=200-0x1d62570@192.168.20.69:51792 / 27673 from(wire) code=407 reason=
DEBUG | 20151009-170806.119 | repro | REPRO:APP | 2977979200 | RequestContext.cxx:937 | tid of orig req: f7394925e8a39a49
DEBUG | 20151009-170806.119 | repro | REPRO:APP | 2977979200 | RequestContext.cxx:972 | Ensuring orig tid matches tid of response: f7394925e8a39a49 == f7394925e8a39a49
DEBUG | 20151009-170806.119 | repro | REPRO:APP | 2977979200 | RequestContext.cxx:979 | Sending final response.
DEBUG | 20151009-170806.119 | repro | RESIP | 2977979200 | SipStack.cxx:822 | SEND: SipResp: 407 tid=f7394925e8a39a49 cseq=27673 INVITE / 27673 from(tu)
DEBUG | 20151009-170806.120 | repro | REPRO:APP | 2977979200 | ProcessorChain.cxx:101 | RequestProcessor aborted all chains: DigestAuthenticator
DEBUG | 20151009-170806.120 | repro | RESIP:TRANSACTION | 3011550016 | TimerQueue.cxx:50 | Adding timer: Timer H tid=f7394925e8a39a49 ms=32000
DEBUG | 20151009-170806.120 | repro | RESIP:TRANSPORT | 3011550016 | TransportSelector.cxx:1072 | Found transport: [ V4 194.149.90.25:5060 TCP transportKey=1 ]
DEBUG | 20151009-170806.120 | repro | RESIP:TRANSPORT | 3011550016 | TransportSelector.cxx:1288 | Transmitting to [ V4 83.69.202.99:59118 TCP flowKey=41 transportKey=1 ] tlsDomain= via [ V4 194.149.90.25:5060 TCP transportKey=1 ]
SIP/2.0 407 Proxy Authentication Required
Via: SIP/2.0/TCP 192.168.20.69:51792;branch=z9hG4bKf7394925e8a39a49;rport=59118;received=83.69.202.99
Proxy-Authenticate: Digest nonce="1444399686:30f77d321c6124b4174b4f9aec4e996d",algorithm=MD5,realm="tools.a33842.net"
To: <sip:202@tools.a33842.net;transport=tcp>;tag=035da529
From: <sip:200@tools.a33842.net>;tag=b57fefeb093c834a
Call-ID: dd44d5cba0b20ee2
CSeq: 27673 INVITE
Server: repro 1.10.0~beta2
Content-Length: 0
sigcomp id=
DEBUG | 20151009-170806.121 | repro | RESIP:TRANSPORT | 3003157312 | TcpBaseTransport.cxx:309 | Processing write for [ V4 83.69.202.99:59118 TCP flowKey=41 transportKey=1 ]
DEBUG | 20151009-170806.121 | repro | RESIP:TRANSPORT | 3003157312 | ConnectionManager.cxx:65 | Found fd 41
DEBUG | 20151009-170806.125 | repro | RESIP:TRANSPORT | 3003157312 | ConnectionBase.cxx:137 | In State: NewMessage
DEBUG | 20151009-170806.125 | repro | RESIP:TRANSPORT | 3003157312 | ConnectionBase.cxx:183 | ConnectionBase::process setting source [ V4 83.69.202.99:59118 TCP flowKey=41 transportKey=1 ]
DEBUG | 20151009-170806.126 | repro | RESIP:TRANSPORT | 3003157312 | Transport.cxx:392 | incoming from: [ V4 83.69.202.99:59118 TCP flowKey=41 transportKey=1 ]
DEBUG | 20151009-170806.126 | repro | RESIP:TRANSPORT | 3003157312 | ConnectionBase.cxx:438 | ##Connection: CONN_BASE: 0xaff00468 [ V4 83.69.202.99:59118 TCP flowKey=41 transportKey=1 ] received: ACK sip:202@tools.a33842.net;transport=tcp SIP/2.0
Via: SIP/2.0/TCP 192.168.20.69:51792;branch=z9hG4bKf7394925e8a39a49;rport=59118;received=83.69.202.99
Max-Forwards: 70
To: <sip:202@tools.a33842.net;transport=tcp>;tag=035da529
From: <sip:200@tools.a33842.net>;tag=b57fefeb093c834a
Call-ID: dd44d5cba0b20ee2
CSeq: 27673 ACK
User-Agent: baresip v0.4.14 (x86_64/linux)
Content-Length: 0
DEBUG | 20151009-170806.126 | repro | RESIP:TRANSPORT | 3003157312 | Connection.cxx:426 | Connection::performReads() read=368
DEBUG | 20151009-170806.126 | repro | RESIP:TRANSPORT | 3003157312 | ConnectionBase.cxx:1017 | Creating buffer for CONN_BASE: 0xaff00468 [ V4 83.69.202.99:59118 TCP flowKey=41 transportKey=1 ]
DEBUG | 20151009-170806.126 | repro | RESIP:TRANSACTION | 3011550016 | TuSelector.cxx:70 | Send to TU: Proxy size=0
ServerTransactionTerminated f7394925e8a39a49
DEBUG | 20151009-170806.126 | repro | REPRO:APP | 2977979200 | Proxy.cxx:167 | Got: ServerTransactionTerminated f7394925e8a39a49
INFO | 20151009-170806.127 | repro | REPRO:APP | 2977979200 | RequestContext.cxx:75 | RequestContext::process(TransactionTerminated) f7394925e8a39a49 : numtrans=1 final=1 req=SipReq: INVITE 202@tools.a33842.net tid=f7394925e8a39a49 cseq=27673 INVITE contact=200-0x1d62570@192.168.20.69:51792 / 27673 from(wire)
DEBUG | 20151009-170806.127 | repro | REPRO:APP | 2977979200 | RequestContext.cxx:58 | RequestContext::~RequestContext() 0xafe0d5a0
DEBUG | 20151009-170806.180 | repro | RESIP:TRANSPORT | 3003157312 | ConnectionBase.cxx:137 | In State: NewMessage
DEBUG | 20151009-170806.180 | repro | RESIP:TRANSPORT | 3003157312 | ConnectionBase.cxx:183 | ConnectionBase::process setting source [ V4 83.69.202.99:59118 TCP flowKey=41 transportKey=1 ]
DEBUG | 20151009-170806.180 | repro | RESIP:TRANSPORT | 3003157312 | Transport.cxx:392 | incoming from: [ V4 83.69.202.99:59118 TCP flowKey=41 transportKey=1 ]
DEBUG | 20151009-170806.180 | repro | RESIP:TRANSPORT | 3003157312 | ConnectionBase.cxx:438 | ##Connection: CONN_BASE: 0xaff00468 [ V4 83.69.202.99:59118 TCP flowKey=41 transportKey=1 ] received: INVITE sip:202@tools.a33842.net;transport=tcp SIP/2.0
Via: SIP/2.0/TCP 192.168.20.69:51792;branch=z9hG4bK1e7d6a998badd1fd;rport=59118;received=83.69.202.99
Max-Forwards: 70
Contact: <sip:200-0x1d62570@192.168.20.69:51792;transport=tcp>
To: <sip:202@tools.a33842.net;transport=tcp>
From: <sip:200@tools.a33842.net>;tag=b57fefeb093c834a
Call-ID: dd44d5cba0b20ee2
CSeq: 27674 INVITE
Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, REFER, NOTIFY, SUBSCRIBE, INFO, MESSAGE
Content-Type: application/sdp
Proxy-Authorization: Digest username="200", realm="tools.a33842.net", nonce="1444399686:30f77d321c6124b4174b4f9aec4e996d", uri="sip:202@tools.a33842.net;transport=tcp", response="6818258081865a19822ac22699940b82"
Supported: gruu
User-Agent: baresip v0.4.14 (x86_64/linux)
Content-Length: 337
v=0
o=- 2178251043 1273685869 IN IP4 192.168.20.69
s=-
c=IN IP4 192.168.20.69
t=0 0
a=tool:baresip 0.4.14
m=audio 58846 RTP/AVP 0 8 101
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-15
a=sendrecv
a=label:1
a=rtcp-rsize
a=ssrc:714692746 cname:sip:200@tools.a33842.net
a=ptime:20
DEBUG | 20151009-170806.181 | repro | RESIP:TRANSPORT | 3003157312 | Connection.cxx:426 | Connection::performReads() read=1100
DEBUG | 20151009-170806.181 | repro | RESIP:TRANSPORT | 3003157312 | ConnectionBase.cxx:1017 | Creating buffer for CONN_BASE: 0xaff00468 [ V4 83.69.202.99:59118 TCP flowKey=41 transportKey=1 ]
DEBUG | 20151009-170806.181 | repro | RESIP:TRANSACTION | 3011550016 | TuSelector.cxx:189 | TuSelector::selectTransactionUser: Checking which TU message belongs to:
INVITE sip:202@tools.a33842.net;transport=tcp SIP/2.0
Via: SIP/2.0/TCP 192.168.20.69:51792;branch=z9hG4bK1e7d6a998badd1fd;rport=59118;received=83.69.202.99
Max-Forwards: 70
Contact: <sip:200-0x1d62570@192.168.20.69:51792;transport=tcp>
To: <sip:202@tools.a33842.net;transport=tcp>
From: <sip:200@tools.a33842.net>;tag=b57fefeb093c834a
Call-ID: dd44d5cba0b20ee2
CSeq: 27674 INVITE
Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, REFER, NOTIFY, SUBSCRIBE, INFO, MESSAGE
Content-Type: application/sdp
Proxy-Authorization: Digest username="200", realm="tools.a33842.net", nonce="1444399686:30f77d321c6124b4174b4f9aec4e996d", uri="sip:202@tools.a33842.net;transport=tcp", response="6818258081865a19822ac22699940b82"
Supported: gruu
User-Agent: baresip v0.4.14 (x86_64/linux)
Content-Length: 337
v=0
o=- 2178251043 1273685869 IN IP4 192.168.20.69
s=-
c=IN IP4 192.168.20.69
t=0 0
a=tool:baresip 0.4.14
m=audio 58846 RTP/AVP 0 8 101
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-15
a=sendrecv
a=label:1
a=rtcp-rsize
a=ssrc:714692746 cname:sip:200@tools.a33842.net
a=ptime:20
DEBUG | 20151009-170806.181 | repro | RESIP:TRANSACTION | 3011550016 | TransactionUser.cxx:83 | TransactionUser::isForMe: TU=DialogUsageManager, Checking rule... : SipReq: INVITE 202@tools.a33842.net tid=1e7d6a998badd1fd cseq=27674 INVITE contact=200-0x1d62570@192.168.20.69:51792 / 27674 from(wire)
DEBUG | 20151009-170806.181 | repro | RESIP:TRANSACTION | 3011550016 | MessageFilterRule.cxx:66 | MessageFilterRule::matches: Method is not in list. Rule does not match.
DEBUG | 20151009-170806.181 | repro | RESIP:TRANSACTION | 3011550016 | TransactionUser.cxx:83 | TransactionUser::isForMe: TU=DialogUsageManager, Checking rule... : SipReq: INVITE 202@tools.a33842.net tid=1e7d6a998badd1fd cseq=27674 INVITE contact=200-0x1d62570@192.168.20.69:51792 / 27674 from(wire)
DEBUG | 20151009-170806.181 | repro | RESIP:TRANSACTION | 3011550016 | MessageFilterRule.cxx:66 | MessageFilterRule::matches: Method is not in list. Rule does not match.
DEBUG | 20151009-170806.182 | repro | RESIP:TRANSACTION | 3011550016 | TransactionUser.cxx:90 | TransactionUser::isForMe: TU=DialogUsageManager, No matching rule found : SipReq: INVITE 202@tools.a33842.net tid=1e7d6a998badd1fd cseq=27674 INVITE contact=200-0x1d62570@192.168.20.69:51792 / 27674 from(wire)
DEBUG | 20151009-170806.182 | repro | RESIP:TRANSACTION | 3011550016 | TransactionUser.cxx:83 | TransactionUser::isForMe: TU=Proxy, Checking rule... : SipReq: INVITE 202@tools.a33842.net tid=1e7d6a998badd1fd cseq=27674 INVITE contact=200-0x1d62570@192.168.20.69:51792 / 27674 from(wire)
DEBUG | 20151009-170806.182 | repro | RESIP:TRANSACTION | 3011550016 | TransactionUser.cxx:86 | TransactionUser::isForMe: TU=Proxy, Match! : SipReq: INVITE 202@tools.a33842.net tid=1e7d6a998badd1fd cseq=27674 INVITE contact=200-0x1d62570@192.168.20.69:51792 / 27674 from(wire)
DEBUG | 20151009-170806.182 | repro | RESIP | 3011550016 | Helper.cxx:374 | Helper::makeResponse(SipReq: INVITE 202@tools.a33842.net tid=1e7d6a998badd1fd cseq=27674 INVITE contact=200-0x1d62570@192.168.20.69:51792 / 27674 from(wire) code=100 reason=
DEBUG | 20151009-170806.182 | repro | RESIP:TRANSACTION | 3011550016 | TimerQueue.cxx:50 | Adding timer: Timer Trying tid=1e7d6a998badd1fd ms=80
DEBUG | 20151009-170806.182 | repro | RESIP:TRANSACTION | 3011550016 | TuSelector.cxx:70 | Send to TU: Proxy size=0
INVITE sip:202@tools.a33842.net;transport=tcp SIP/2.0
Via: SIP/2.0/TCP 192.168.20.69:51792;branch=z9hG4bK1e7d6a998badd1fd;rport=59118;received=83.69.202.99
Max-Forwards: 70
Contact: <sip:200-0x1d62570@192.168.20.69:51792;transport=tcp>
To: <sip:202@tools.a33842.net;transport=tcp>
From: <sip:200@tools.a33842.net>;tag=b57fefeb093c834a
Call-ID: dd44d5cba0b20ee2
CSeq: 27674 INVITE
Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, REFER, NOTIFY, SUBSCRIBE, INFO, MESSAGE
Content-Type: application/sdp
Proxy-Authorization: Digest username="200", realm="tools.a33842.net", nonce="1444399686:30f77d321c6124b4174b4f9aec4e996d", uri="sip:202@tools.a33842.net;transport=tcp", response="6818258081865a19822ac22699940b82"
Supported: gruu
User-Agent: baresip v0.4.14 (x86_64/linux)
Content-Length: 337
v=0
o=- 2178251043 1273685869 IN IP4 192.168.20.69
s=-
c=IN IP4 192.168.20.69
t=0 0
a=tool:baresip 0.4.14
m=audio 58846 RTP/AVP 0 8 101
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-15
a=sendrecv
a=label:1
a=rtcp-rsize
a=ssrc:714692746 cname:sip:200@tools.a33842.net
a=ptime:20
DEBUG | 20151009-170806.182 | repro | REPRO:APP | 2977979200 | Proxy.cxx:167 | Got: INVITE sip:202@tools.a33842.net;transport=tcp SIP/2.0
Via: SIP/2.0/TCP 192.168.20.69:51792;branch=z9hG4bK1e7d6a998badd1fd;rport=59118;received=83.69.202.99
Max-Forwards: 70
Contact: <sip:200-0x1d62570@192.168.20.69:51792;transport=tcp>
To: <sip:202@tools.a33842.net;transport=tcp>
From: <sip:200@tools.a33842.net>;tag=b57fefeb093c834a
Call-ID: dd44d5cba0b20ee2
CSeq: 27674 INVITE
Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, REFER, NOTIFY, SUBSCRIBE, INFO, MESSAGE
Content-Type: application/sdp
Proxy-Authorization: Digest username="200", realm="tools.a33842.net", nonce="1444399686:30f77d321c6124b4174b4f9aec4e996d", uri="sip:202@tools.a33842.net;transport=tcp", response="6818258081865a19822ac22699940b82"
Supported: gruu
User-Agent: baresip v0.4.14 (x86_64/linux)
Content-Length: 337
v=0
o=- 2178251043 1273685869 IN IP4 192.168.20.69
s=-
c=IN IP4 192.168.20.69
t=0 0
a=tool:baresip 0.4.14
m=audio 58846 RTP/AVP 0 8 101
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-15
a=sendrecv
a=label:1
a=rtcp-rsize
a=ssrc:714692746 cname:sip:200@tools.a33842.net
a=ptime:20
INFO | 20151009-170806.183 | repro | REPRO:APP | 2977979200 | Proxy.cxx:366 | New RequestContext tid=1e7d6a998badd1fd : SipReq: INVITE 202@tools.a33842.net tid=1e7d6a998badd1fd cseq=27674 INVITE contact=200-0x1d62570@192.168.20.69:51792 / 27674 from(wire)
INFO | 20151009-170806.183 | repro | REPRO:APP | 2977979200 | Proxy.cxx:376 | Inserting new RequestContext tid=1e7d6a998badd1fd -> numtrans=1 final=0
INFO | 20151009-170806.183 | repro | REPRO:APP | 2977979200 | RequestContext.cxx:92 | RequestContext::process(SipMessage) 1e7d6a998badd1fd
DEBUG | 20151009-170806.183 | repro | REPRO:APP | 2977979200 | RequestContext.cxx:152 | Got a request.
DEBUG | 20151009-170806.183 | repro | REPRO:APP | 2977979200 | ProcessorChain.cxx:95 | Chain invoking RequestProcessor: StrictRouteFixup
DEBUG | 20151009-170806.183 | repro | REPRO:APP | 2977979200 | monkeys/StrictRouteFixup.cxx:39 | Monkey handling request: StrictRouteFixup; reqcontext = numtrans=1 final=0 req=SipReq: INVITE 202@tools.a33842.net tid=1e7d6a998badd1fd cseq=27674 INVITE contact=200-0x1d62570@192.168.20.69:51792 / 27674 from(wire)
DEBUG | 20151009-170806.183 | repro | REPRO:APP | 2977979200 | ProcessorChain.cxx:95 | Chain invoking RequestProcessor: IsTrustedNode
DEBUG | 20151009-170806.183 | repro | REPRO:APP | 2977979200 | monkeys/IsTrustedNode.cxx:36 | Monkey handling request: IsTrustedNode; reqcontext = numtrans=1 final=0 req=SipReq: INVITE 202@tools.a33842.net tid=1e7d6a998badd1fd cseq=27674 INVITE contact=200-0x1d62570@192.168.20.69:51792 / 27674 from(wire)
INFO | 20151009-170806.183 | repro | REPRO:APP | 2977979200 | AclStore.cxx:558 | AclStore - source address NOT trusted: 83.69.202.99:59118 TCP
DEBUG | 20151009-170806.183 | repro | REPRO:APP | 2977979200 | ProcessorChain.cxx:95 | Chain invoking RequestProcessor: DigestAuthenticator
DEBUG | 20151009-170806.183 | repro | REPRO:APP | 2977979200 | monkeys/DigestAuthenticator.cxx:51 | Monkey handling request: DigestAuthenticator; reqcontext = numtrans=1 final=0 req=SipReq: INVITE 202@tools.a33842.net tid=1e7d6a998badd1fd cseq=27674 INVITE contact=200-0x1d62570@192.168.20.69:51792 / 27674 from(wire)
INFO | 20151009-170806.184 | repro | REPRO:APP | 2977979200 | monkeys/DigestAuthenticator.cxx:383 | Request user auth info for 200 at realm tools.a33842.net
DEBUG | 20151009-170806.184 | repro | REPRO:APP | 2977979200 | ProcessorChain.cxx:107 | RequestProcessor waiting for async response: DigestAuthenticator
DEBUG | 20151009-170806.184 | repro | REPRO:APP | 3045120832 | UserAuthGrabber.cxx:31 | Grabbed user info for 200@tools.a33842.net : f987fc1e0174ee22c81b1135d7220912
DEBUG | 20151009-170806.184 | repro | RESIP:TRANSACTION | 3045120832 | TuSelector.cxx:70 | Send to TU: Proxy size=0
UserInfoMessage(tid=1e7d6a998badd1fd)
DEBUG | 20151009-170806.184 | repro | REPRO:APP | 2977979200 | Proxy.cxx:167 | Got: UserInfoMessage(tid=1e7d6a998badd1fd)
DEBUG | 20151009-170806.184 | repro | REPRO:APP | 2977979200 | Proxy.cxx:438 | Trying to dispatch : UserInfoMessage(tid=1e7d6a998badd1fd)
DEBUG | 20151009-170806.184 | repro | REPRO:APP | 2977979200 | Proxy.cxx:443 | Sending UserInfoMessage(tid=1e7d6a998badd1fd) to numtrans=1 final=0 req=SipReq: INVITE 202@tools.a33842.net tid=1e7d6a998badd1fd cseq=27674 INVITE contact=200-0x1d62570@192.168.20.69:51792 / 27674 from(wire)
INFO | 20151009-170806.184 | repro | REPRO:APP | 2977979200 | RequestContext.cxx:657 | RequestContext::process(ApplicationMessage) UserInfoMessage(tid=1e7d6a998badd1fd)
DEBUG | 20151009-170806.184 | repro | REPRO:APP | 2977979200 | ProcessorChain.cxx:95 | Chain invoking RequestProcessor: DigestAuthenticator
DEBUG | 20151009-170806.185 | repro | REPRO:APP | 2977979200 | monkeys/DigestAuthenticator.cxx:51 | Monkey handling request: DigestAuthenticator; reqcontext = numtrans=1 final=0 req=SipReq: INVITE 202@tools.a33842.net tid=1e7d6a998badd1fd cseq=27674 INVITE contact=200-0x1d62570@192.168.20.69:51792 / 27674 from(wire)
INFO | 20151009-170806.185 | repro | REPRO:APP | 2977979200 | monkeys/DigestAuthenticator.cxx:113 | Received user auth info for 200 at realm tools.a33842.net
DEBUG | 20151009-170806.185 | repro | RESIP | 2977979200 | Helper.cxx:775 | Authenticating: realm=tools.a33842.net expires=3000
INFO | 20151009-170806.185 | repro | REPRO:APP | 2977979200 | monkeys/DigestAuthenticator.cxx:169 | Authentication ok for 200
INFO | 20151009-170806.185 | repro | REPRO:APP | 2977979200 | monkeys/DigestAuthenticator.cxx:272 | Identity-Info=http://:5080/cert?domain=tools.a33842.net
DEBUG | 20151009-170806.185 | repro | REPRO:APP | 2977979200 | ProcessorChain.cxx:95 | Chain invoking RequestProcessor: AmIResponsible
DEBUG | 20151009-170806.185 | repro | REPRO:APP | 2977979200 | monkeys/AmIResponsible.cxx:32 | Monkey handling request: AmIResponsible; reqcontext = numtrans=1 final=0 identity=200 req=SipReq: INVITE 202@tools.a33842.net tid=1e7d6a998badd1fd cseq=27674 INVITE contact=200-0x1d62570@192.168.20.69:51792 / 27674 from(wire)
DEBUG | 20151009-170806.185 | repro | REPRO:APP | 2977979200 | Proxy.cxx:595 | Proxy::isMyUri sip:202@tools.a33842.net;transport=tcp 1
DEBUG | 20151009-170806.185 | repro | REPRO:APP | 2977979200 | ProcessorChain.cxx:95 | Chain invoking RequestProcessor: RequestFilter
DEBUG | 20151009-170806.185 | repro | REPRO:APP | 2977979200 | monkeys/RequestFilter.cxx:154 | Monkey handling request: RequestFilter; reqcontext = numtrans=1 final=0 identity=200 req=SipReq: INVITE 202@tools.a33842.net tid=1e7d6a998badd1fd cseq=27674 INVITE contact=200-0x1d62570@192.168.20.69:51792 / 27674 from(wire)
DEBUG | 20151009-170806.185 | repro | REPRO:APP | 2977979200 | monkeys/RequestFilter.cxx:147 | Request is accepted
DEBUG | 20151009-170806.186 | repro | REPRO:APP | 2977979200 | ProcessorChain.cxx:95 | Chain invoking RequestProcessor: StaticRoute
DEBUG | 20151009-170806.186 | repro | REPRO:APP | 2977979200 | monkeys/StaticRoute.cxx:39 | Monkey handling request: StaticRoute; reqcontext = numtrans=1 final=0 identity=200 req=SipReq: INVITE 202@tools.a33842.net tid=1e7d6a998badd1fd cseq=27674 INVITE contact=200-0x1d62570@192.168.20.69:51792 / 27674 from(wire)
DEBUG | 20151009-170806.186 | repro | REPRO:APP | 2977979200 | RouteStore.cxx:298 | Consider route reqUri=sip:202@tools.a33842.net;transport=tcp method=INVITE event=
DEBUG | 20151009-170806.186 | repro | REPRO:APP | 2977979200 | RouteStore.cxx:344 | Route matched
DEBUG | 20151009-170806.186 | repro | REPRO:APP | 2977979200 | monkeys/StaticRoute.cxx:68 | target domain nkofs.ru is not local
INFO | 20151009-170806.186 | repro | REPRO:APP | 2977979200 | monkeys/StaticRoute.cxx:100 | Adding target sip:$1@nkofs.ru
INFO | 20151009-170806.186 | repro | REPRO:APP | 2977979200 | ResponseContext.cxx:64 | Adding candidate <sip:$1@nkofs.ru>
DEBUG | 20151009-170806.186 | repro | REPRO:APP | 2977979200 | ProcessorChain.cxx:113 | RequestProcessor skipping current chain: StaticRoute
INFO | 20151009-170806.186 | repro | REPRO:APP | 2977979200 | RequestContext.cxx:723 | numtrans=1 final=0 identity=200 req=SipReq: INVITE 202@tools.a33842.net tid=1e7d6a998badd1fd cseq=27674 INVITE contact=200-0x1d62570@192.168.20.69:51792 / 27674 from(wire) there are 1 candidates -> continue
DEBUG | 20151009-170806.186 | repro | REPRO:APP | 2977979200 | ProcessorChain.cxx:95 | Chain invoking TargetProcessor: QValueTargetHandler
DEBUG | 20151009-170806.187 | repro | REPRO:APP | 2977979200 | monkeys/QValueTargetHandler.cxx:106 | No ForkControlMessage for me.
DEBUG | 20151009-170806.187 | repro | REPRO:APP | 2977979200 | ProcessorChain.cxx:95 | Chain invoking TargetProcessor: SimpleTargetHandler
DEBUG | 20151009-170806.187 | repro | REPRO:APP | 2977979200 | Proxy.cxx:595 | Proxy::isMyUri sip:$1@nkofs.ru 0
DEBUG | 20151009-170806.187 | repro | REPRO:APP | 2977979200 | ResponseContext.cxx:563 | Set tuple dest: [ V4 0.0.0.0:0 UNKNOWN_TRANSPORT ]
INFO | 20151009-170806.187 | repro | REPRO:APP | 2977979200 | RequestContext.cxx:890 | Updating timer C.
INFO | 20151009-170806.187 | repro | REPRO:APP | 2977979200 | Proxy.cxx:554 | Posting timer C
DEBUG | 20151009-170806.187 | repro | RESIP:TRANSACTION | 2977979200 | TimerQueue.cxx:124 | Adding application timer: TimerCMessage(tid=1e7d6a998badd1fd) ms=180000
INFO | 20151009-170806.188 | repro | REPRO:APP | 2977979200 | Proxy.cxx:540 | add client transaction tid=0de39277d95da007 0xafe0d5a0
DEBUG | 20151009-170806.188 | repro | REPRO:APP | 2977979200 | Proxy.cxx:595 | Proxy::isMyUri sip:$1@nkofs.ru 0
DEBUG | 20151009-170806.188 | repro | RESIP | 2977979200 | SipStack.cxx:822 | SEND: SipReq: INVITE $1@nkofs.ru tid=0de39277d95da007 cseq=27674 INVITE contact=200-0x1d62570@192.168.20.69:51792 / 27674 from(wire)
DEBUG | 20151009-170806.188 | repro | RESIP:TRANSACTION | 3011550016 | TimerQueue.cxx:50 | Adding timer: Timer B tid=0de39277d95da007 ms=32000
DEBUG | 20151009-170806.189 | repro | RESIP:TRANSPORT | 3011550016 | TransportSelector.cxx:556 | Looking up dns entries for sip:$1@nkofs.ru
DEBUG | 20151009-170806.189 | repro | RESIP:DNS | 3011550016 | DnsResult.cxx:261 | DnsResult::lookup sip:$1@nkofs.ru
DEBUG | 20151009-170806.189 | repro | RESIP:DNS | 3019942720 | dns/DnsStub.cxx:73 | nkofs.ru lookup failed: DNS server returned answer with no data
DEBUG | 20151009-170806.189 | repro | RESIP:DNS | 3019942720 | dns/DnsStub.cxx:67 | _sip._tcp.nkofs.ru (SRV) --> p=5 w=0 dummy.nkofs.ru:5060_sip._tcp.nkofs.ru (SRV) --> p=10 w=0 pluto.foxq.org:5060_sip._tcp.nkofs.ru (SRV) --> p=15 w=0 nbn.foxq.org:5060
DEBUG | 20151009-170806.189 | repro | RESIP:DNS | 3019942720 | dns/DnsStub.cxx:49 | dummy.nkofs.ru(A)--> 78.107.130.72
DEBUG | 20151009-170806.190 | repro | RESIP:DNS | 3019942720 | dns/DnsStub.cxx:49 | pluto.foxq.org(A)--> 78.107.130.66
INFO | 20151009-170806.188 | repro | REPRO:APP | 2977979200 | ResponseContext.cxx:234 | Creating new client transaction 0de39277d95da007 -> sip:$1@nkofs.ru
DEBUG | 20151009-170806.190 | repro | REPRO:APP | 2977979200 | ProcessorChain.cxx:101 | TargetProcessor aborted all chains: SimpleTargetHandler
DEBUG | 20151009-170806.190 | repro | RESIP:TRANSPORT | 3011550016 | TransportSelector.cxx:871 | Looked up source for destination: [ V4 78.107.130.66:5060 TCP targetDomain=nkofs.ru ] -> [ V4 194.149.90.25:0 TCP targetDomain=nkofs.ru ] sent-by= sent-port=0
DEBUG | 20151009-170806.190 | repro | RESIP:TRANSPORT | 3011550016 | TransportSelector.cxx:1481 | findTransportBySource([ V4 194.149.90.25:0 TCP targetDomain=nkofs.ru ])
DEBUG | 20151009-170806.191 | repro | RESIP:TRANSPORT | 3011550016 | TransportSelector.cxx:1495 | should port be ignored: 1
DEBUG | 20151009-170806.191 | repro | RESIP:TRANSPORT | 3011550016 | TransportSelector.cxx:1537 | findTransport (any port, specific interface) => Transport: [ V4 194.149.90.25:55060 TCP transportKey=2 ] on 194.149.90.25 key: [ V4 194.149.90.25:5060 TCP transportKey=1 ] search: [ V4 194.149.90.25:0 TCP targetDomain=nkofs.ru ]
DEBUG | 20151009-170806.191 | repro | RESIP:TRANSPORT | 3011550016 | TransportSelector.cxx:979 | Found transport: [ V4 194.149.90.25:0 TCP targetDomain=nkofs.ru ]
DEBUG | 20151009-170806.191 | repro | RESIP | 3011550016 | DateCategory.cxx:191 | Set date: day=5 month=9 year=2015 14:8:6
DEBUG | 20151009-170806.191 | repro | RESIP | 3011550016 | SipMessage.cxx:557 | Indentity Canonical String is: sip:200@tools.a33842.net|sip:202@tools.a33842.net;transport=tcp|dd44d5cba0b20ee2|27674 INVITE|Fri, 09 Oct 2015 14:08:06 GMT|sip:200-0x1d62570@192.168.20.69:51792;transport=tcp|v=0
o=- 2178251043 1273685869 IN IP4 192.168.20.69
s=-
c=IN IP4 192.168.20.69
t=0 0
a=tool:baresip 0.4.14
m=audio 58846 RTP/AVP 0 8 101
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-15
a=sendrecv
a=label:1
a=rtcp-rsize
a=ssrc:714692746 cname:sip:200@tools.a33842.net
a=ptime:20
DEBUG | 20151009-170806.191 | repro | RESIP | 3011550016 | ssl/Security.cxx:1751 | Compute identity for sip:200@tools.a33842.net|sip:202@tools.a33842.net;transport=tcp|dd44d5cba0b20ee2|27674 INVITE|Fri, 09 Oct 2015 14:08:06 GMT|sip:200-0x1d62570@192.168.20.69:51792;transport=tcp|v=0
o=- 2178251043 1273685869 IN IP4 192.168.20.69
s=-
c=IN IP4 192.168.20.69
t=0 0
a=tool:baresip 0.4.14
m=audio 58846 RTP/AVP 0 8 101
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-15
a=sendrecv
a=label:1
a=rtcp-rsize
a=ssrc:714692746 cname:sip:200@tools.a33842.net
a=ptime:20
INFO | 20151009-170806.191 | repro | RESIP | 3011550016 | ssl/Security.cxx:1756 | No private key for tools.a33842.net
DEBUG | 20151009-170806.191 | repro | RESIP | 3011550016 | BaseException.cxx:21 | BaseException at ssl/Security.cxx:1757 Missing private key when computing identity
INFO | 20151009-170806.191 | repro | RESIP:TRANSPORT | 3011550016 | TransportSelector.cxx:1246 | Couldn't add identity header: SecurityException Missing private key when computing identity @ ssl/Security.cxx:1757
DEBUG | 20151009-170806.191 | repro | REPRO:APP | 3011550016 | RRDecorator.cxx:60 | Proxy::decorateMessage called.
DEBUG | 20151009-170806.191 | repro | RESIP:TRANSPORT | 3011550016 | TransportSelector.cxx:1288 | Transmitting to [ V4 78.107.130.66:5060 TCP targetDomain=nkofs.ru transportKey=2 ] tlsDomain= via [ V4 194.149.90.25:55060 TCP targetDomain=nkofs.ru ]
INVITE sip:$1@nkofs.ru SIP/2.0
Via: SIP/2.0/TCP 194.149.90.25:55060;branch=z9hG4bK-524287-1---0de39277d95da007;rport
Via: SIP/2.0/TCP 192.168.20.69:51792;branch=z9hG4bK1e7d6a998badd1fd;rport=59118;received=83.69.202.99
Max-Forwards: 69
Contact: <sip:200-0x1d62570@192.168.20.69:51792;transport=tcp>
To: <sip:202@tools.a33842.net;transport=tcp>
From: <sip:200@tools.a33842.net>;tag=b57fefeb093c834a
Call-ID: dd44d5cba0b20ee2
CSeq: 27674 INVITE
Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, REFER, NOTIFY, SUBSCRIBE, INFO, MESSAGE
Content-Type: application/sdp
Date: Fri, 09 Oct 2015 14:08:06 GMT
Supported: gruu
User-Agent: baresip v0.4.14 (x86_64/linux)
Content-Length: 337
v=0
o=- 2178251043 1273685869 IN IP4 192.168.20.69
s=-
c=IN IP4 192.168.20.69
t=0 0
a=tool:baresip 0.4.14
m=audio 58846 RTP/AVP 0 8 101
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-15
a=sendrecv
a=label:1
a=rtcp-rsize
a=ssrc:714692746 cname:sip:200@tools.a33842.net
a=ptime:20
sigcomp id=
DEBUG | 20151009-170806.192 | repro | RESIP:TRANSPORT | 3003157312 | TcpBaseTransport.cxx:309 | Processing write for [ V4 78.107.130.66:5060 TCP targetDomain=nkofs.ru transportKey=2 ]
DEBUG | 20151009-170806.192 | repro | RESIP:TRANSPORT | 3003157312 | ConnectionManager.cxx:89 | Found connection for tuple [ V4 78.107.130.66:5060 TCP targetDomain=nkofs.ru transportKey=2 ]
DEBUG | 20151009-170806.262 | repro | RESIP:TRANSPORT | 3011550016 | TransportSelector.cxx:1072 | Found transport: [ V4 194.149.90.25:5060 TCP transportKey=1 ]
DEBUG | 20151009-170806.262 | repro | RESIP:TRANSPORT | 3011550016 | TransportSelector.cxx:1288 | Transmitting to [ V4 83.69.202.99:59118 TCP flowKey=41 transportKey=1 ] tlsDomain= via [ V4 194.149.90.25:5060 TCP transportKey=1 ]
SIP/2.0 100 Trying
Via: SIP/2.0/TCP 192.168.20.69:51792;branch=z9hG4bK1e7d6a998badd1fd;rport=59118;received=83.69.202.99
To: <sip:202@tools.a33842.net;transport=tcp>
From: <sip:200@tools.a33842.net>;tag=b57fefeb093c834a
Call-ID: dd44d5cba0b20ee2
CSeq: 27674 INVITE
Content-Length: 0
sigcomp id=
DEBUG | 20151009-170806.267 | repro | RESIP:TRANSPORT | 3003157312 | TcpBaseTransport.cxx:309 | Processing write for [ V4 83.69.202.99:59118 TCP flowKey=41 transportKey=1 ]
DEBUG | 20151009-170806.267 | repro | RESIP:TRANSPORT | 3003157312 | ConnectionManager.cxx:65 | Found fd 41
DEBUG | 20151009-170806.371 | repro | RESIP:TRANSPORT | 3003157312 | ConnectionBase.cxx:137 | In State: NewMessage
DEBUG | 20151009-170806.371 | repro | RESIP:TRANSPORT | 3003157312 | ConnectionBase.cxx:183 | ConnectionBase::process setting source [ V4 78.107.130.66:5060 TCP targetDomain=nkofs.ru flowKey=44 transportKey=2 ]
DEBUG | 20151009-170806.372 | repro | RESIP:TRANSPORT | 3003157312 | Transport.cxx:392 | incoming from: [ V4 78.107.130.66:5060 TCP targetDomain=nkofs.ru flowKey=44 transportKey=2 ]
DEBUG | 20151009-170806.372 | repro | RESIP:TRANSPORT | 3003157312 | ConnectionBase.cxx:438 | ##Connection: CONN_BASE: 0xaff02e40 [ V4 78.107.130.66:5060 TCP targetDomain=nkofs.ru flowKey=44 transportKey=2 ] received: SIP/2.0 100 Trying
Via: SIP/2.0/TCP 194.149.90.25:55060;branch=z9hG4bK-524287-1---0de39277d95da007;rport
Via: SIP/2.0/TCP 192.168.20.69:51792;branch=z9hG4bK1e7d6a998badd1fd;rport=59118;received=83.69.202.99
To: <sip:202@tools.a33842.net;transport=tcp>
From: <sip:200@tools.a33842.net>;tag=b57fefeb093c834a
Call-ID: dd44d5cba0b20ee2
CSeq: 27674 INVITE
Date: Fri, 09 Oct 2015 14:08:06 GMT
Server: Cisco-SIPGateway/IOS-12.x
Allow-Events: telephone-event
Content-Length: 0
DEBUG | 20151009-170806.372 | repro | RESIP:TRANSPORT | 3003157312 | Connection.cxx:426 | Connection::performReads() read=476
DEBUG | 20151009-170806.372 | repro | RESIP:TRANSPORT | 3003157312 | ConnectionBase.cxx:1017 | Creating buffer for CONN_BASE: 0xaff02e40 [ V4 78.107.130.66:5060 TCP targetDomain=nkofs.ru flowKey=44 transportKey=2 ]
DEBUG | 20151009-170806.372 | repro | RESIP:DNS | 3019942720 | DnsResult.cxx:253 | Whitelisting _sip._tcp.nkofs.ru(33): pluto.foxq.org:5060
DEBUG | 20151009-170806.372 | repro | RESIP:TRANSACTION | 3011550016 | TuSelector.cxx:70 | Send to TU: Proxy size=0
SIP/2.0 100 Trying
Via: SIP/2.0/TCP 194.149.90.25:55060;branch=z9hG4bK-524287-1---0de39277d95da007;rport
Via: SIP/2.0/TCP 192.168.20.69:51792;branch=z9hG4bK1e7d6a998badd1fd;rport=59118;received=83.69.202.99
To: <sip:202@tools.a33842.net;transport=tcp>
From: <sip:200@tools.a33842.net>;tag=b57fefeb093c834a
Call-ID: dd44d5cba0b20ee2
CSeq: 27674 INVITE
Date: Fri, 09 Oct 2015 14:08:06 GMT
Server: Cisco-SIPGateway/IOS-12.x
Allow-Events: telephone-event
Content-Length: 0
DEBUG | 20151009-170806.372 | repro | RESIP:DNS | 3019942720 | dns/RRVip.cxx:128 | updating an existing vip: pluto.foxq.org:5060 with pluto.foxq.org:5060
DEBUG | 20151009-170806.373 | repro | RESIP:DNS | 3019942720 | DnsResult.cxx:253 | Whitelisting nkofs.ru(1): 78.107.130.66
DEBUG | 20151009-170806.373 | repro | REPRO:APP | 2977979200 | Proxy.cxx:167 | Got: SIP/2.0 100 Trying
Via: SIP/2.0/TCP 194.149.90.25:55060;branch=z9hG4bK-524287-1---0de39277d95da007;rport
Via: SIP/2.0/TCP 192.168.20.69:51792;branch=z9hG4bK1e7d6a998badd1fd;rport=59118;received=83.69.202.99
To: <sip:202@tools.a33842.net;transport=tcp>
From: <sip:200@tools.a33842.net>;tag=b57fefeb093c834a
Call-ID: dd44d5cba0b20ee2
CSeq: 27674 INVITE
Date: Fri, 09 Oct 2015 14:08:06 GMT
Server: Cisco-SIPGateway/IOS-12.x
Allow-Events: telephone-event
Content-Length: 0
INFO | 20151009-170806.373 | repro | REPRO:APP | 2977979200 | Proxy.cxx:410 | Looking up RequestContext tid=0de39277d95da007
INFO | 20151009-170806.373 | repro | REPRO:APP | 2977979200 | RequestContext.cxx:92 | RequestContext::process(SipMessage) 0de39277d95da007
DEBUG | 20151009-170806.373 | repro | REPRO:APP | 2977979200 | ProcessorChain.cxx:95 | Chain invoking ResponseProcessor: OutboundTargetHandler
INFO | 20151009-170806.373 | repro | REPRO:APP | 2977979200 | ResponseContext.cxx:966 | processResponse:
SIP/2.0 100 Trying
Via: SIP/2.0/TCP 194.149.90.25:55060;branch=z9hG4bK-524287-1---0de39277d95da007;rport
Via: SIP/2.0/TCP 192.168.20.69:51792;branch=z9hG4bK1e7d6a998badd1fd;rport=59118;received=83.69.202.99
To: <sip:202@tools.a33842.net;transport=tcp>
From: <sip:200@tools.a33842.net>;tag=b57fefeb093c834a
Call-ID: dd44d5cba0b20ee2
CSeq: 27674 INVITE
Date: Fri, 09 Oct 2015 14:08:06 GMT
Server: Cisco-SIPGateway/IOS-12.x
Allow-Events: telephone-event
Content-Length: 0
DEBUG | 20151009-170806.373 | repro | REPRO:APP | 2977979200 | ResponseContext.cxx:1047 | Search for 0de39277d95da007 in [0de39277d95da007 -> Target: sip:$1@nkofs.ru status=1]
INFO | 20151009-170806.373 | repro | REPRO:APP | 2977979200 | RequestContext.cxx:890 | Updating timer C.
INFO | 20151009-170806.373 | repro | REPRO:APP | 2977979200 | Proxy.cxx:554 | Posting timer C
DEBUG | 20151009-170806.374 | repro | RESIP:TRANSACTION | 2977979200 | TimerQueue.cxx:124 | Adding application timer: TimerCMessage(tid=1e7d6a998badd1fd) ms=180000
DEBUG | 20151009-170806.374 | repro | REPRO:APP | 2977979200 | ProcessorChain.cxx:95 | Chain invoking TargetProcessor: QValueTargetHandler
DEBUG | 20151009-170806.374 | repro | REPRO:APP | 2977979200 | monkeys/QValueTargetHandler.cxx:106 | No ForkControlMessage for me.
DEBUG | 20151009-170806.374 | repro | REPRO:APP | 2977979200 | ProcessorChain.cxx:95 | Chain invoking TargetProcessor: SimpleTargetHandler
DEBUG | 20151009-170806.374 | repro | REPRO:APP | 2977979200 | ProcessorChain.cxx:101 | TargetProcessor aborted all chains: SimpleTargetHandler
DEBUG | 20151009-170806.374 | repro | RESIP:TRANSPORT | 3003157312 | ConnectionBase.cxx:137 | In State: NewMessage
DEBUG | 20151009-170806.374 | repro | RESIP:TRANSPORT | 3003157312 | ConnectionBase.cxx:183 | ConnectionBase::process setting source [ V4 78.107.130.66:5060 TCP targetDomain=nkofs.ru flowKey=44 transportKey=2 ]
DEBUG | 20151009-170806.374 | repro | RESIP:TRANSPORT | 3003157312 | Transport.cxx:392 | incoming from: [ V4 78.107.130.66:5060 TCP targetDomain=nkofs.ru flowKey=44 transportKey=2 ]
DEBUG | 20151009-170806.374 | repro | RESIP:TRANSPORT | 3003157312 | ConnectionBase.cxx:438 | ##Connection: CONN_BASE: 0xaff02e40 [ V4 78.107.130.66:5060 TCP targetDomain=nkofs.ru flowKey=44 transportKey=2 ] received: SIP/2.0 403 Forbidden
Via: SIP/2.0/TCP 194.149.90.25:55060;branch=z9hG4bK-524287-1---0de39277d95da007;rport
Via: SIP/2.0/TCP 192.168.20.69:51792;branch=z9hG4bK1e7d6a998badd1fd;rport=59118;received=83.69.202.99
To: <sip:202@tools.a33842.net;transport=tcp>;tag=F03797B4-F61
From: <sip:200@tools.a33842.net>;tag=b57fefeb093c834a
Call-ID: dd44d5cba0b20ee2
CSeq: 27674 INVITE
Date: Fri, 09 Oct 2015 14:08:06 GMT
Server: Cisco-SIPGateway/IOS-12.x
Allow-Events: telephone-event
Reason: Q.850;cause=21
Content-Length: 0
DEBUG | 20151009-170806.375 | repro | RESIP:TRANSPORT | 3003157312 | Connection.cxx:426 | Connection::performReads() read=520
DEBUG | 20151009-170806.375 | repro | RESIP:TRANSPORT | 3003157312 | ConnectionBase.cxx:1017 | Creating buffer for CONN_BASE: 0xaff02e40 [ V4 78.107.130.66:5060 TCP targetDomain=nkofs.ru flowKey=44 transportKey=2 ]
DEBUG | 20151009-170806.375 | repro | RESIP:TRANSPORT | 3011550016 | TransportSelector.cxx:678 | source: [ V4 194.149.90.25:55060 TCP ]
DEBUG | 20151009-170806.375 | repro | RESIP:TRANSPORT | 3011550016 | TransportSelector.cxx:1481 | findTransportBySource([ V4 194.149.90.25:55060 TCP ])
DEBUG | 20151009-170806.375 | repro | RESIP:TRANSPORT | 3011550016 | TransportSelector.cxx:1495 | should port be ignored: 0
DEBUG | 20151009-170806.375 | repro | RESIP:TRANSPORT | 3011550016 | TransportSelector.cxx:1504 | findTransport (exact) => Transport: [ V4 194.149.90.25:55060 TCP transportKey=2 ] on 194.149.90.25
DEBUG | 20151009-170806.375 | repro | RESIP:TRANSPORT | 3011550016 | TransportSelector.cxx:940 | Found transport: [ V4 194.149.90.25:55060 TCP ]
DEBUG | 20151009-170806.375 | repro | RESIP:TRANSPORT | 3011550016 | TransportSelector.cxx:1288 | Transmitting to [ V4 78.107.130.66:5060 TCP targetDomain=nkofs.ru transportKey=2 ] tlsDomain= via [ V4 194.149.90.25:55060 TCP ]
ACK sip:$1@nkofs.ru SIP/2.0
Via: SIP/2.0/TCP 194.149.90.25:55060;branch=z9hG4bK-524287-1---0de39277d95da007;rport
Max-Forwards: 70
To: <sip:202@tools.a33842.net;transport=tcp>;tag=F03797B4-F61
From: <sip:200@tools.a33842.net>;tag=b57fefeb093c834a
Call-ID: dd44d5cba0b20ee2
CSeq: 27674 ACK
Content-Length: 0
sigcomp id=
DEBUG | 20151009-170806.376 | repro | RESIP:DNS | 3019942720 | DnsResult.cxx:253 | Whitelisting _sip._tcp.nkofs.ru(33): pluto.foxq.org:5060
DEBUG | 20151009-170806.376 | repro | RESIP:TRANSPORT | 3003157312 | TcpBaseTransport.cxx:309 | Processing write for [ V4 78.107.130.66:5060 TCP targetDomain=nkofs.ru transportKey=2 ]
DEBUG | 20151009-170806.376 | repro | RESIP:DNS | 3019942720 | dns/RRVip.cxx:128 | updating an existing vip: pluto.foxq.org:5060 with pluto.foxq.org:5060
DEBUG | 20151009-170806.376 | repro | RESIP:TRANSPORT | 3003157312 | ConnectionManager.cxx:89 | Found connection for tuple [ V4 78.107.130.66:5060 TCP targetDomain=nkofs.ru transportKey=2 ]
DEBUG | 20151009-170806.376 | repro | RESIP:DNS | 3019942720 | DnsResult.cxx:253 | Whitelisting nkofs.ru(1): 78.107.130.66
DEBUG | 20151009-170806.376 | repro | RESIP:DNS | 3019942720 | dns/RRVip.cxx:128 | updating an existing vip: 78.107.130.66 with 78.107.130.66
DEBUG | 20151009-170806.376 | repro | RESIP:TRANSACTION | 3011550016 | TuSelector.cxx:70 | Send to TU: Proxy size=0
SIP/2.0 403 Forbidden
Via: SIP/2.0/TCP 194.149.90.25:55060;branch=z9hG4bK-524287-1---0de39277d95da007;rport
Via: SIP/2.0/TCP 192.168.20.69:51792;branch=z9hG4bK1e7d6a998badd1fd;rport=59118;received=83.69.202.99
To: <sip:202@tools.a33842.net;transport=tcp>;tag=F03797B4-F61
From: <sip:200@tools.a33842.net>;tag=b57fefeb093c834a
Call-ID: dd44d5cba0b20ee2
CSeq: 27674 INVITE
Date: Fri, 09 Oct 2015 14:08:06 GMT
Server: Cisco-SIPGateway/IOS-12.x
Allow-Events: telephone-event
Reason: Q.850;cause=21
Content-Length: 0
DEBUG | 20151009-170806.376 | repro | REPRO:APP | 2977979200 | Proxy.cxx:167 | Got: SIP/2.0 403 Forbidden
Via: SIP/2.0/TCP 194.149.90.25:55060;branch=z9hG4bK-524287-1---0de39277d95da007;rport
Via: SIP/2.0/TCP 192.168.20.69:51792;branch=z9hG4bK1e7d6a998badd1fd;rport=59118;received=83.69.202.99
To: <sip:202@tools.a33842.net;transport=tcp>;tag=F03797B4-F61
From: <sip:200@tools.a33842.net>;tag=b57fefeb093c834a
Call-ID: dd44d5cba0b20ee2
CSeq: 27674 INVITE
Date: Fri, 09 Oct 2015 14:08:06 GMT
Server: Cisco-SIPGateway/IOS-12.x
Allow-Events: telephone-event
Reason: Q.850;cause=21
Content-Length: 0
INFO | 20151009-170806.376 | repro | REPRO:APP | 2977979200 | Proxy.cxx:410 | Looking up RequestContext tid=0de39277d95da007
INFO | 20151009-170806.376 | repro | REPRO:APP | 2977979200 | RequestContext.cxx:92 | RequestContext::process(SipMessage) 0de39277d95da007
DEBUG | 20151009-170806.377 | repro | REPRO:APP | 2977979200 | ProcessorChain.cxx:95 | Chain invoking ResponseProcessor: OutboundTargetHandler
DEBUG | 20151009-170806.377 | repro | REPRO:APP | 2977979200 | monkeys/OutboundTargetHandler.cxx:40 | Looking for tid 0de39277d95da007
INFO | 20151009-170806.377 | repro | REPRO:APP | 2977979200 | ResponseContext.cxx:966 | processResponse:
SIP/2.0 403 Forbidden
Via: SIP/2.0/TCP 194.149.90.25:55060;branch=z9hG4bK-524287-1---0de39277d95da007;rport
Via: SIP/2.0/TCP 192.168.20.69:51792;branch=z9hG4bK1e7d6a998badd1fd;rport=59118;received=83.69.202.99
To: <sip:202@tools.a33842.net;transport=tcp>;tag=F03797B4-F61
From: <sip:200@tools.a33842.net>;tag=b57fefeb093c834a
Call-ID: dd44d5cba0b20ee2
CSeq: 27674 INVITE
Date: Fri, 09 Oct 2015 14:08:06 GMT
Server: Cisco-SIPGateway/IOS-12.x
Allow-Events: telephone-event
Reason: Q.850;cause=21
Content-Length: 0
DEBUG | 20151009-170806.377 | repro | REPRO:APP | 2977979200 | ResponseContext.cxx:1047 | Search for 0de39277d95da007 in [0de39277d95da007 -> Target: sip:$1@nkofs.ru status=1]
DEBUG | 20151009-170806.377 | repro | REPRO:APP | 2977979200 | ResponseContext.cxx:1136 | forwardedFinal=0 outstanding client transactions: [0de39277d95da007 -> Target: sip:$1@nkofs.ru status=1]
INFO | 20151009-170806.377 | repro | REPRO:APP | 2977979200 | ResponseContext.cxx:1262 | Terminating client transaction: 0de39277d95da007 all = 0
INFO | 20151009-170806.377 | repro | REPRO:APP | 2977979200 | ResponseContext.cxx:1267 | client transactions: [0de39277d95da007 -> Target: sip:$1@nkofs.ru status=1]
INFO | 20151009-170806.377 | repro | REPRO:APP | 2977979200 | ResponseContext.cxx:1435 | Forwarding best response: SipResp: 403 tid=1e7d6a998badd1fd cseq=27674 INVITE / 27674 from(wire)
INFO | 20151009-170806.377 | repro | REPRO:APP | 2977979200 | ResponseContext.cxx:249 | Cancel all proceeding client transactions: 0
DEBUG | 20151009-170806.377 | repro | REPRO:APP | 2977979200 | RequestContext.cxx:937 | tid of orig req: 1e7d6a998badd1fd
DEBUG | 20151009-170806.377 | repro | REPRO:APP | 2977979200 | RequestContext.cxx:972 | Ensuring orig tid matches tid of response: 1e7d6a998badd1fd == 1e7d6a998badd1fd
DEBUG | 20151009-170806.377 | repro | REPRO:APP | 2977979200 | RequestContext.cxx:979 | Sending final response.
DEBUG | 20151009-170806.378 | repro | RESIP | 2977979200 | SipStack.cxx:822 | SEND: SipResp: 403 tid=1e7d6a998badd1fd cseq=27674 INVITE / 27674 from(wire)
DEBUG | 20151009-170806.378 | repro | REPRO:APP | 2977979200 | ProcessorChain.cxx:95 | Chain invoking TargetProcessor: QValueTargetHandler
DEBUG | 20151009-170806.378 | repro | REPRO:APP | 2977979200 | monkeys/QValueTargetHandler.cxx:106 | No ForkControlMessage for me.
DEBUG | 20151009-170806.378 | repro | REPRO:APP | 2977979200 | ProcessorChain.cxx:95 | Chain invoking TargetProcessor: SimpleTargetHandler
DEBUG | 20151009-170806.378 | repro | RESIP:TRANSACTION | 3011550016 | TuSelector.cxx:70 | Send to TU: Proxy size=0
ClientTransactionTerminated 0de39277d95da007
DEBUG | 20151009-170806.378 | repro | RESIP:TRANSACTION | 3011550016 | TimerQueue.cxx:50 | Adding timer: Timer H tid=1e7d6a998badd1fd ms=32000
DEBUG | 20151009-170806.378 | repro | RESIP:TRANSPORT | 3011550016 | TransportSelector.cxx:1072 | Found transport: [ V4 194.149.90.25:5060 TCP transportKey=1 ]
DEBUG | 20151009-170806.378 | repro | RESIP:TRANSPORT | 3011550016 | TransportSelector.cxx:1288 | Transmitting to [ V4 83.69.202.99:59118 TCP flowKey=41 transportKey=1 ] tlsDomain= via [ V4 194.149.90.25:5060 TCP transportKey=1 ]
SIP/2.0 403 Forbidden
Via: SIP/2.0/TCP 192.168.20.69:51792;branch=z9hG4bK1e7d6a998badd1fd;rport=59118;received=83.69.202.99
To: <sip:202@tools.a33842.net;transport=tcp>;tag=F03797B4-F61
From: <sip:200@tools.a33842.net>;tag=b57fefeb093c834a
Call-ID: dd44d5cba0b20ee2
CSeq: 27674 INVITE
Date: Fri, 09 Oct 2015 14:08:06 GMT
Server: Cisco-SIPGateway/IOS-12.x
Allow-Events: telephone-event
Reason: Q.850;cause=21
Content-Length: 0
sigcomp id=
DEBUG | 20151009-170806.379 | repro | RESIP:TRANSPORT | 3003157312 | TcpBaseTransport.cxx:309 | Processing write for [ V4 83.69.202.99:59118 TCP flowKey=41 transportKey=1 ]
DEBUG | 20151009-170806.379 | repro | RESIP:TRANSPORT | 3003157312 | ConnectionManager.cxx:65 | Found fd 41
DEBUG | 20151009-170806.379 | repro | REPRO:APP | 2977979200 | Proxy.cxx:167 | Got: ClientTransactionTerminated 0de39277d95da007
INFO | 20151009-170806.379 | repro | REPRO:APP | 2977979200 | RequestContext.cxx:75 | RequestContext::process(TransactionTerminated) 0de39277d95da007 : numtrans=2 final=1 identity=200 req=SipReq: INVITE 202@tools.a33842.net tid=1e7d6a998badd1fd cseq=27674 INVITE contact=200-0x1d62570@192.168.20.69:51792 / 27674 from(wire)
DEBUG | 20151009-170806.383 | repro | RESIP:TRANSPORT | 3003157312 | ConnectionBase.cxx:137 | In State: NewMessage
DEBUG | 20151009-170806.383 | repro | RESIP:TRANSPORT | 3003157312 | ConnectionBase.cxx:183 | ConnectionBase::process setting source [ V4 83.69.202.99:59118 TCP flowKey=41 transportKey=1 ]
DEBUG | 20151009-170806.383 | repro | RESIP:TRANSPORT | 3003157312 | Transport.cxx:392 | incoming from: [ V4 83.69.202.99:59118 TCP flowKey=41 transportKey=1 ]
DEBUG | 20151009-170806.383 | repro | RESIP:TRANSPORT | 3003157312 | ConnectionBase.cxx:438 | ##Connection: CONN_BASE: 0xaff00468 [ V4 83.69.202.99:59118 TCP flowKey=41 transportKey=1 ] received: ACK sip:202@tools.a33842.net;transport=tcp SIP/2.0
Via: SIP/2.0/TCP 192.168.20.69:51792;branch=z9hG4bK1e7d6a998badd1fd;rport=59118;received=83.69.202.99
Max-Forwards: 70
To: <sip:202@tools.a33842.net;transport=tcp>;tag=F03797B4-F61
From: <sip:200@tools.a33842.net>;tag=b57fefeb093c834a
Call-ID: dd44d5cba0b20ee2
CSeq: 27674 ACK
User-Agent: baresip v0.4.14 (x86_64/linux)
Content-Length: 0
DEBUG | 20151009-170806.384 | repro | RESIP:TRANSPORT | 3003157312 | Connection.cxx:426 | Connection::performReads() read=372
DEBUG | 20151009-170806.384 | repro | RESIP:TRANSPORT | 3003157312 | ConnectionBase.cxx:1017 | Creating buffer for CONN_BASE: 0xaff00468 [ V4 83.69.202.99:59118 TCP flowKey=41 transportKey=1 ]
DEBUG | 20151009-170806.384 | repro | RESIP:TRANSACTION | 3011550016 | TuSelector.cxx:70 | Send to TU: Proxy size=0
ServerTransactionTerminated 1e7d6a998badd1fd
DEBUG | 20151009-170806.384 | repro | REPRO:APP | 2977979200 | Proxy.cxx:167 | Got: ServerTransactionTerminated 1e7d6a998badd1fd
INFO | 20151009-170806.384 | repro | REPRO:APP | 2977979200 | RequestContext.cxx:75 | RequestContext::process(TransactionTerminated) 1e7d6a998badd1fd : numtrans=1 final=1 identity=200 req=SipReq: INVITE 202@tools.a33842.net tid=1e7d6a998badd1fd cseq=27674 INVITE contact=200-0x1d62570@192.168.20.69:51792 / 27674 from(wire)
DEBUG | 20151009-170806.385 | repro | REPRO:APP | 2977979200 | RequestContext.cxx:58 | RequestContext::~RequestContext() 0xafe0d5a0
INFO | 20151009-170807.320 | repro | RESIP:TRANSPORT | 3003157312 | Connection.cxx:522 | Exception on socket 43 code: 113; closing connection
DEBUG | 20151009-170807.320 | repro | RESIP:TRANSPORT | 3003157312 | ConnectionBase.cxx:115 | ConnectionBase::~ConnectionBase 0xaff00708
INFO | 20151009-170807.321 | repro | RESIP:TRANSACTION | 3011550016 | TuSelector.cxx:102 | Sending ConnectionTerminated [ V4 78.107.130.72:5060 TCP targetDomain=nkofs.ru flowKey=43 transportKey=2 ] to TUs
DEBUG | 20151009-170807.321 | repro | RESIP:DUM | 2986371904 | DialogUsageManager.cxx:1458 | connection terminated message
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment
You can’t perform that action at this time.