Jan 12 16:03:17 [20309] DBG:core:parse_msg: SIP Request:
Jan 12 16:03:17 [20309] DBG:core:parse_msg:  method:  <INVITE>
Jan 12 16:03:17 [20309] DBG:core:parse_msg:  uri:     <sip:1001@vmopensips1.skycomuk.com:5060>
Jan 12 16:03:17 [20309] DBG:core:parse_msg:  version: <SIP/2.0>
Jan 12 16:03:17 [20309] DBG:core:parse_headers: flags=2
Jan 12 16:03:17 [20309] DBG:core:parse_via_param: found param type 232, <branch> = <z9hG4bK305b33da50b0bb55a>; state=16
Jan 12 16:03:17 [20309] DBG:core:parse_via: end of header reached, state=5
Jan 12 16:03:17 [20309] DBG:core:parse_headers: via found, flags=2
Jan 12 16:03:17 [20309] DBG:core:parse_headers: this is the first via
Jan 12 16:03:17 [20309] DBG:core:receive_msg: After parse_msg...
Jan 12 16:03:17 [20309] DBG:core:receive_msg: preparing to run routing scripts...
Jan 12 16:03:17 [20309] DBG:core:parse_headers: flags=100
Jan 12 16:03:17 [20309] DBG:maxfwd:is_maxfwd_present: value = 70 
Jan 12 16:03:17 [20309] DBG:core:parse_headers: flags=8
Jan 12 16:03:17 [20309] DBG:core:parse_to: end of header reached, state=10
Jan 12 16:03:17 [20309] DBG:core:parse_to: display={"1001"}, ruri={sip:1001@vmopensips1.skycomuk.com:5060}
Jan 12 16:03:17 [20309] DBG:core:get_hdr_field: <To> [49]; uri=[sip:1001@vmopensips1.skycomuk.com:5060] 
Jan 12 16:03:17 [20309] DBG:core:get_hdr_field: to body ["1001" <sip:1001@vmopensips1.skycomuk.com:5060>
]
Jan 12 16:03:17 [20309] DBG:uri:has_totag: no totag
Jan 12 16:03:17 [20309] DBG:core:parse_headers: flags=78
Jan 12 16:03:17 [20309] DBG:core:get_hdr_field: cseq <CSeq>: <4671> <INVITE>
Jan 12 16:03:17 [20309] DBG:tm:t_lookup_request: start searching: hash=17063, isACK=0
Jan 12 16:03:17 [20309] DBG:tm:matching_3261: RFC3261 transaction matching failed
Jan 12 16:03:17 [20309] DBG:tm:t_lookup_request: no transaction found
Jan 12 16:03:17 [20309] DBG:core:parse_to_param: tag=3da87ae9c5
Jan 12 16:03:17 [20309] DBG:core:parse_to: end of header reached, state=29
Jan 12 16:03:17 [20309] DBG:core:parse_to: display={"1000"}, ruri={sip:1000@vmopensips1.skycomuk.com:5060}
Jan 12 16:03:17 [20309] DBG:core:grep_sock_info: checking if host==us: 24==13 &&  [vmopensips1.skycomuk.com] == [212.84.166.33]
Jan 12 16:03:17 [20309] DBG:core:grep_sock_info: checking if port 5060 matches port 5060
Jan 12 16:03:17 [20309] DBG:core:grep_sock_info: checking if host==us: 24==13 &&  [vmopensips1.skycomuk.com] == [212.84.166.33]
Jan 12 16:03:17 [20309] DBG:core:grep_sock_info: checking if port 5060 matches port 5060
Jan 12 16:03:17 [20309] DBG:core:parse_headers: flags=10000
Jan 12 16:03:17 [20309] DBG:core:get_hdr_field: content_length=595
Jan 12 16:03:17 [20309] DBG:core:get_hdr_field: found end of header
Jan 12 16:03:17 [20309] DBG:auth:pre_auth: credentials with given realm not found
Jan 12 16:03:17 [20309] DBG:auth:reserve_nonce_index: second= 21, sec_monit= -1,  index= 2
Jan 12 16:03:17 [20309] DBG:auth:build_auth_hf: nonce index= 2
Jan 12 16:03:17 [20309] DBG:auth:build_auth_hf: 'Proxy-Authenticate: Digest realm="vmopensips1.skycomuk.com", nonce="4d2dd0e300000002977a8489c7d0972ef195cbc9144a4f03"
'
Jan 12 16:03:17 [20309] DBG:core:parse_headers: flags=ffffffffffffffff
Jan 12 16:03:17 [20309] DBG:core:check_ip_address: params 212.84.178.71, 212.84.178.71, 0
Jan 12 16:03:17 [20309] DBG:core:destroy_avp_list: destroying list (nil)
Jan 12 16:03:17 [20309] DBG:core:receive_msg: cleaning up
Jan 12 16:03:17 [20309] DBG:core:parse_msg: SIP Request:
Jan 12 16:03:17 [20309] DBG:core:parse_msg:  method:  <ACK>
Jan 12 16:03:17 [20309] DBG:core:parse_msg:  uri:     <sip:1001@vmopensips1.skycomuk.com:5060>
Jan 12 16:03:17 [20309] DBG:core:parse_msg:  version: <SIP/2.0>
Jan 12 16:03:17 [20309] DBG:core:parse_headers: flags=2
Jan 12 16:03:17 [20309] DBG:core:parse_via_param: found param type 232, <branch> = <z9hG4bK305b33da50b0bb55a>; state=16
Jan 12 16:03:17 [20309] DBG:core:parse_via: end of header reached, state=5
Jan 12 16:03:17 [20309] DBG:core:parse_headers: via found, flags=2
Jan 12 16:03:17 [20309] DBG:core:parse_headers: this is the first via
Jan 12 16:03:17 [20309] DBG:core:receive_msg: After parse_msg...
Jan 12 16:03:17 [20309] DBG:core:receive_msg: preparing to run routing scripts...
Jan 12 16:03:17 [20309] DBG:core:parse_headers: flags=8
Jan 12 16:03:17 [20309] DBG:core:parse_to_param: tag=b3addd350d7d55a695048985db4db659.0e06
Jan 12 16:03:17 [20309] DBG:core:parse_to: end of header reached, state=29
Jan 12 16:03:17 [20309] DBG:core:parse_to: display={"1001"}, ruri={sip:1001@vmopensips1.skycomuk.com:5060}
Jan 12 16:03:17 [20309] DBG:core:get_hdr_field: <To> [91]; uri=[sip:1001@vmopensips1.skycomuk.com:5060] 
Jan 12 16:03:17 [20309] DBG:core:get_hdr_field: to body ["1001" <sip:1001@vmopensips1.skycomuk.com:5060>]
Jan 12 16:03:17 [20309] DBG:sl:sl_filter_ACK: local ACK found -> dropping it!
Jan 12 16:03:17 [20309] DBG:core:destroy_avp_list: destroying list (nil)
Jan 12 16:03:17 [20309] DBG:core:receive_msg: cleaning up