[Spce-user] t.38 fax from client to upstream SIP prover

Thu Sep 19 03:39:00 EDT 2013

Matthew,

I don't think Sipwise ("the company") is rejecting the request, but maybe
your SPCE ("the product") box is not properly configured :)
Jokes aside, I might be wrong but apparently you're missing the proper
rewrite rules for 086xxxx to be handled inbound - is this the format your
fax re-invite is coming in?

Sep 18 23:15:50 spce /usr/sbin/kamailio[2655]: INFO: <script>:
Applying caller-out peer rewrite rules to first user-provided caller
CLI using dpid '3' -
R=sip:086XXXXXXX@<myUpstreamProviderIP>:5060;transport=udp
ID=acebb4d0-0-13c4-55013-bd-1a5a4d0c-bd
Sep 18 23:15:50 spce /usr/sbin/kamailio[2655]: INFO: <script>: No
matching rewrite rules for '0' found -
R=sip:086XXXXXXX@<myUpstreamProviderIP>:5060;transport=udp
ID=acebb4d0-0-13c4-55013-bd-1a5a4d0c-bd

Best,

Lorenzo Mangani

HOMER DEV TEAM
QXIP - Capture Engineering

On Thu, Sep 19, 2013 at 12:10 AM, Matthew Ogden <matthew at tenacit.net> wrote:

> Hi All,
>
>
>
> When trying to send a fax out from a subscriber to a fax machine, my
> upstream provider does a reverse invite for T.38. But Sipwise is rejecting
> this request.
>
>
>
> The log file is attached, and is below from the proxy.
>
>
>
> Inbound faxes in the reverse (though to a different client) work with the
> reinvite. Why is spce saying 404 not found this way around?
>
>
>
> Sep 18 23:15:50 spce /usr/sbin/kamailio[2657]: INFO: <script>: New request
> - M=INVITE R=sip:086XXXXXXX@<mysipserverIP>:5060 F=sip:TN001FAX
> T=sip:086XXXXXXX@<mysipserverIP>:5060 IP=<myclientIP>:5060 (127.0.0.1:5060)
> ID=acebb4d0-0-13c4-55013-bd-1a5a4d0c-bd
>
> Sep 18 23:15:50 spce /usr/sbin/kamailio[2657]: INFO: <script>:
> Authentication failed, no credentials - R=sip:086XXXXXXX@<mysipserverIP>:5060
> ID=acebb4d0-0-13c4-55013-bd-1a5a4d0c-bd
>
> Sep 18 23:15:50 spce /usr/sbin/kamailio[2655]: INFO: <script>: New request
> - M=INVITE R=sip:086XXXXXXX@<mysipserverIP>:5060 F=sip:TN001FAX
> T=sip:086XXXXXXX@<mysipserverIP>:5060 IP=<myclientIP>:5060 (127.0.0.1:5060)
> ID=acebb4d0-0-13c4-55013-bd-1a5a4d0c-bd
>
> Sep 18 23:15:50 spce /usr/sbin/kamailio[2655]: INFO: <script>: Clear
> caller preferences - R=sip:086XXXXXXX@<mysipserverIP>:5060
> ID=acebb4d0-0-13c4-55013-bd-1a5a4d0c-bd
>
> Sep 18 23:15:50 spce /usr/sbin/kamailio[2655]: INFO: <script>: Load caller
> preferences for uuid 'b2e626b6-6c30-480a-9171-8ea7e0db82de' and domain part
> of uri 'sip:@mysipdns' - R=sip:086XXXXXXX@<mysipserverIP>:5060
> ID=acebb4d0-0-13c4-55013-bd-1a5a4d0c-bd
>
> Sep 18 23:15:50 spce /usr/sbin/kamailio[2655]: INFO: <script>: Load
> dialplan IDs for domain 'sip:@mysipdns' - R=sip:086XXXXXXX@<mysipserverIP>:5060
> ID=acebb4d0-0-13c4-55013-bd-1a5a4d0c-bd
>
> Sep 18 23:15:50 spce /usr/sbin/kamailio[2655]: INFO: <script>: Fetched
> dialplan IDs caller_in='<null>', callee_in='<null>' - R=sip:086XXXXXXX@<mysipserverIP>:5060
> ID=acebb4d0-0-13c4-55013-bd-1a5a4d0c-bd
>
> Sep 18 23:15:50 spce /usr/sbin/kamailio[2655]: INFO: <script>: Use
> 'P-NGCP-Src-Ip' for CDR IP - R=sip:086XXXXXXX@<mysipserverIP>:5060
> ID=acebb4d0-0-13c4-55013-bd-1a5a4d0c-bd
>
> Sep 18 23:15:50 spce /usr/sbin/kamailio[2655]: INFO: <script>: Dialog set
> total - R=sip:086XXXXXXX@<mysipserverIP>:5060
> ID=acebb4d0-0-13c4-55013-bd-1a5a4d0c-bd
>
> Sep 18 23:15:50 spce /usr/sbin/kamailio[2655]: INFO: <script>: Dialog set
> user, userout, account, accountout to
> 'b2e626b6-6c30-480a-9171-8ea7e0db82de/2' - R=sip:086XXXXXXX@<mysipserverIP>:5060
> ID=acebb4d0-0-13c4-55013-bd-1a5a4d0c-bd
>
> Sep 18 23:15:50 spce /usr/sbin/kamailio[2655]: INFO: <script>: IP
> authorization for caller not provisioned, allow call - R=sip:086XXXXXXX@<mysipserverIP>:5060
> ID=acebb4d0-0-13c4-55013-bd-1a5a4d0c-bd
>
> Sep 18 23:15:50 spce /usr/sbin/kamailio[2655]: INFO: <script>:
> User-Provided CLI '0' taken from From-User - R=sip:086XXXXXXX@<mysipserverIP>:5060
> ID=acebb4d0-0-13c4-55013-bd-1a5a4d0c-bd
>
> Sep 18 23:15:50 spce /usr/sbin/kamailio[2655]: INFO: <script>: Setting
> '0 at TN001FAX' as initiating user-provided CLI - R=sip:086XXXXXXX@<mysipserverIP>:5060
> ID=acebb4d0-0-13c4-55013-bd-1a5a4d0c-bd
>
> Sep 18 23:15:50 spce /usr/sbin/kamailio[2655]: INFO: <script>: Setting
> '27XXXXX2533 at mysipdns' as initiating network-provided CLI -
> R=sip:086XXXXXXX@<mysipserverIP>:5060
> ID=acebb4d0-0-13c4-55013-bd-1a5a4d0c-bd
>
> Sep 18 23:15:50 spce /usr/sbin/kamailio[2655]: INFO: <script>: Searching
> for callee - R=sip:086XXXXXXX@<mysipserverIP>:5060
> ID=acebb4d0-0-13c4-55013-bd-1a5a4d0c-bd
>
> Sep 18 23:15:50 spce /usr/sbin/kamailio[2655]: INFO: <script>: Clear
> callee preferences - R=sip:086XXXXXXX@<mysipserverIP>:5060
> ID=acebb4d0-0-13c4-55013-bd-1a5a4d0c-bd
>
> Sep 18 23:15:50 spce /usr/sbin/kamailio[2655]: INFO: <script>: Callee is
> not local - R=sip:086XXXXXXX@<mysipserverIP>:5060
> ID=acebb4d0-0-13c4-55013-bd-1a5a4d0c-bd
>
> Sep 18 23:15:50 spce /usr/sbin/kamailio[2655]: INFO: <script>: Check
> Administrative NCOS level - R=sip:086XXXXXXX@<mysipserverIP>:5060
> ID=acebb4d0-0-13c4-55013-bd-1a5a4d0c-bd
>
> Sep 18 23:15:50 spce /usr/sbin/kamailio[2655]: INFO: <script>: Check User
> NCOS level - R=sip:086XXXXXXX@<mysipserverIP>:5060
> ID=acebb4d0-0-13c4-55013-bd-1a5a4d0c-bd
>
> Sep 18 23:15:50 spce /usr/sbin/kamailio[2655]: INFO: <script>: Checking
> URI '086XXXXXXX@<mysipserverIP>' and CLI '086XXXXXXX' against block out
> lists - R=sip:086XXXXXXX@<mysipserverIP>:5060
> ID=acebb4d0-0-13c4-55013-bd-1a5a4d0c-bd
>
> Sep 18 23:15:50 spce /usr/sbin/kamailio[2655]: INFO: <script>: Admin
> caller block mode is 'open' - R=sip:086XXXXXXX@<mysipserverIP>:5060
> ID=acebb4d0-0-13c4-55013-bd-1a5a4d0c-bd
>
> Sep 18 23:15:50 spce /usr/sbin/kamailio[2655]: INFO: <script>: Caller
> block mode is 'open' - R=sip:086XXXXXXX@<mysipserverIP>:5060
> ID=acebb4d0-0-13c4-55013-bd-1a5a4d0c-bd
>
> Sep 18 23:15:50 spce /usr/sbin/kamailio[2655]: INFO: <script>: Call to SIP
> Peering - R=sip:086XXXXXXX@<mysipserverIP>:5060
> ID=acebb4d0-0-13c4-55013-bd-1a5a4d0c-bd
>
> Sep 18 23:15:50 spce /usr/sbin/kamailio[2655]: INFO: <script>: Load gws
> matching calling part 'sip:0 at mysipdns' and called user '086XXXXXXX' and
> called part 'sip:086XXXXXXX@<mysipserverIP>:5060' - R=sip:086XXXXXXX@<mysipserverIP>:5060
> ID=acebb4d0-0-13c4-55013-bd-1a5a4d0c-bd
>
> Sep 18 23:15:50 spce /usr/sbin/kamailio[2655]: INFO: <script>: Dialog set
> mark type to outgoing - R=sip:086XXXXXXX@<mysipserverIP>:5060
> ID=acebb4d0-0-13c4-55013-bd-1a5a4d0c-bd
>
> Sep 18 23:15:50 spce /usr/sbin/kamailio[2655]: INFO: <script>: Load peer
> preferences for peer host '2' - R=sip:086XXXXXXX@<myUpstreamProviderIP>:5060;transport=udp
> ID=acebb4d0-0-13c4-55013-bd-1a5a4d0c-bd
>
> Sep 18 23:15:50 spce /usr/sbin/kamailio[2655]: INFO: <script>: Load
> dialplan IDs for peer host '2' - R=sip:086XXXXXXX@<myUpstreamProviderIP>:5060;transport=udp
> ID=acebb4d0-0-13c4-55013-bd-1a5a4d0c-bd
>
> Sep 18 23:15:50 spce /usr/sbin/kamailio[2655]: INFO: <script>: Fetched
> dialplan IDs caller_out='3', callee_out='4' - R=sip:086XXXXXXX@<myUpstreamProviderIP>:5060;transport=udp
> ID=acebb4d0-0-13c4-55013-bd-1a5a4d0c-bd
>
> Sep 18 23:15:50 spce /usr/sbin/kamailio[2655]: INFO: <script>: Dialog set
> mark peer and peerout to '2' - R=sip:086XXXXXXX@<myUpstreamProviderIP>:5060;transport=udp
> ID=acebb4d0-0-13c4-55013-bd-1a5a4d0c-bd
>
> Sep 18 23:15:50 spce /usr/sbin/kamailio[2655]: INFO: <script>: Setting acc
> source-leg for uuid 'b2e626b6-6c30-480a-9171-8ea7e0db82de':
> 'b2e626b6-6c30-480a-9171-8ea7e0db82de|<null>|mysipdns|0|TN001FAX|TN001|2|||0|call|<myclientIP>|1379538950.578478'
> - R=sip:086XXXXXXX@<myUpstreamProviderIP>:5060;transport=udp
> ID=acebb4d0-0-13c4-55013-bd-1a5a4d0c-bd
>
> Sep 18 23:15:50 spce /usr/sbin/kamailio[2655]: INFO: <script>: Setting acc
> destination-leg for uuid '0':
> '0|||<null>|086XXXXXXX|0|086XXXXXXX|<myUpstreamProviderIP>|086XXXXXXX|<mysipserverIP>'
> - R=sip:086XXXXXXX@<myUpstreamProviderIP>:5060;transport=udp
> ID=acebb4d0-0-13c4-55013-bd-1a5a4d0c-bd
>
> Sep 18 23:15:50 spce /usr/sbin/kamailio[2655]: INFO: <script>: Relaying
> request, du='<null>' - R=sip:086XXXXXXX@<myUpstreamProviderIP>:5060;transport=udp
> ID=acebb4d0-0-13c4-55013-bd-1a5a4d0c-bd
>
> Sep 18 23:15:50 spce /usr/sbin/kamailio[2655]: INFO: <script>: Use
> mediaproxy for forward direction for IPv4/IPv4 - R=sip:086XXXXXXX@<myUpstreamProviderIP>:5060;transport=udp
> ID=acebb4d0-0-13c4-55013-bd-1a5a4d0c-bd
>
> Sep 18 23:15:50 spce /usr/sbin/kamailio[2655]: INFO: <script>: Remove
> existing ICE candidates (if any) for callee - R=sip:086XXXXXXX@<myUpstreamProviderIP>:5060;transport=udp
> ID=acebb4d0-0-13c4-55013-bd-1a5a4d0c-bd
>
> Sep 18 23:15:50 spce /usr/sbin/kamailio[2655]: INFO: <script>: Setting
> P-Caller-UUID to 'b2e626b6-6c30-480a-9171-8ea7e0db82de' - R=sip:086XXXXXXX@<myUpstreamProviderIP>:5060;transport=udp
> ID=acebb4d0-0-13c4-55013-bd-1a5a4d0c-bd
>
> Sep 18 23:15:50 spce /usr/sbin/kamailio[2655]: INFO: <script>: Setting
> P-Callee-UUID to '0' - R=sip:086XXXXXXX@<myUpstreamProviderIP>:5060;transport=udp
> ID=acebb4d0-0-13c4-55013-bd-1a5a4d0c-bd
>
> Sep 18 23:15:50 spce /usr/sbin/kamailio[2655]: INFO: <script>: Sessions
> Timers enabled for caller with interval 300 and method
> UPDATE_FALLBACK_INVITE - R=sip:086XXXXXXX@<myUpstreamProviderIP>:5060;transport=udp
> ID=acebb4d0-0-13c4-55013-bd-1a5a4d0c-bd
>
> Sep 18 23:15:50 spce /usr/sbin/kamailio[2655]: INFO: <script>: Sessions
> Timers enabled for callee with interval 300 and method
> UPDATE_FALLBACK_INVITE - R=sip:086XXXXXXX@<myUpstreamProviderIP>:5060;transport=udp
> ID=acebb4d0-0-13c4-55013-bd-1a5a4d0c-bd
>
> Sep 18 23:15:50 spce /usr/sbin/kamailio[2655]: INFO: <script>: Applying
> caller-out peer rewrite rules to first user-provided caller CLI using dpid
> '3' - R=sip:086XXXXXXX@<myUpstreamProviderIP>:5060;transport=udp
> ID=acebb4d0-0-13c4-55013-bd-1a5a4d0c-bd
>
> Sep 18 23:15:50 spce /usr/sbin/kamailio[2655]: INFO: <script>: No matching
> rewrite rules for '0' found - R=sip:086XXXXXXX@<myUpstreamProviderIP>:5060;transport=udp
> ID=acebb4d0-0-13c4-55013-bd-1a5a4d0c-bd
>
> Sep 18 23:15:50 spce /usr/sbin/kamailio[2655]: INFO: <script>: Applying
> caller-out peer rewrite rules to first network-provided caller CLI using
> dpid '3' - R=sip:086XXXXXXX@<myUpstreamProviderIP>:5060;transport=udp
> ID=acebb4d0-0-13c4-55013-bd-1a5a4d0c-bd
>
> Sep 18 23:15:50 spce /usr/sbin/kamailio[2655]: INFO: <script>: No matching
> rewrite rules for '27XXXXX2533' found - R=sip:086XXXXXXX@<myUpstreamProviderIP>:5060;transport=udp
> ID=acebb4d0-0-13c4-55013-bd-1a5a4d0c-bd
>
> Sep 18 23:15:50 spce /usr/sbin/kamailio[2655]: INFO: <script>: Prepare
> From display-name setting - R=sip:086XXXXXXX@<myUpstreamProviderIP>:5060;transport=udp
> ID=acebb4d0-0-13c4-55013-bd-1a5a4d0c-bd
>
> Sep 18 23:15:50 spce /usr/sbin/kamailio[2655]: INFO: <script>: No selector
> set, not setting CLI - R=sip:086XXXXXXX@<myUpstreamProviderIP>:5060;transport=udp
> ID=acebb4d0-0-13c4-55013-bd-1a5a4d0c-bd
>
> Sep 18 23:15:50 spce /usr/sbin/kamailio[2655]: INFO: <script>: Prepare
> From username setting - R=sip:086XXXXXXX@<myUpstreamProviderIP>:5060;transport=udp
> ID=acebb4d0-0-13c4-55013-bd-1a5a4d0c-bd
>
> Sep 18 23:15:50 spce /usr/sbin/kamailio[2655]: INFO: <script>: Setting
> caller_cli_userprov/caller_domain_userprov '0 at TN001FAX' for upn -
> R=sip:086XXXXXXX@<myUpstreamProviderIP>:5060;transport=udp
> ID=acebb4d0-0-13c4-55013-bd-1a5a4d0c-bd
>
> Sep 18 23:15:50 spce /usr/sbin/kamailio[2655]: INFO: <script>: Setting
> From to '<sip:27XXXXX2533 at mysipdns>' - R=sip:086XXXXXXX@<myUpstreamProviderIP>:5060;transport=udp
> ID=acebb4d0-0-13c4-55013-bd-1a5a4d0c-bd
>
> Sep 18 23:15:50 spce /usr/sbin/kamailio[2655]: INFO: <script>: Prepare PAI
> username setting - R=sip:086XXXXXXX@<myUpstreamProviderIP>:5060;transport=udp
> ID=acebb4d0-0-13c4-55013-bd-1a5a4d0c-bd
>
> Sep 18 23:15:50 spce /usr/sbin/kamailio[2655]: INFO: <script>: No selector
> set, not setting CLI - R=sip:086XXXXXXX@<myUpstreamProviderIP>:5060;transport=udp
> ID=acebb4d0-0-13c4-55013-bd-1a5a4d0c-bd
>
> Sep 18 23:15:50 spce /usr/sbin/kamailio[2655]: INFO: <script>: Prepare PPI
> username setting - R=sip:086XXXXXXX@<myUpstreamProviderIP>:5060;transport=udp
> ID=acebb4d0-0-13c4-55013-bd-1a5a4d0c-bd
>
> Sep 18 23:15:50 spce /usr/sbin/kamailio[2655]: INFO: <script>: No selector
> set, not setting CLI - R=sip:086XXXXXXX@<myUpstreamProviderIP>:5060;transport=udp
> ID=acebb4d0-0-13c4-55013-bd-1a5a4d0c-bd
>
> Sep 18 23:15:50 spce /usr/sbin/kamailio[2655]: INFO: <script>: Prepare
> Diversion setting - R=sip:086XXXXXXX@<myUpstreamProviderIP>:5060;transport=udp
> ID=acebb4d0-0-13c4-55013-bd-1a5a4d0c-bd
>
> Sep 18 23:15:50 spce /usr/sbin/kamailio[2655]: INFO: <script>: No selector
> set, not setting CLI - R=sip:086XXXXXXX@<myUpstreamProviderIP>:5060;transport=udp
> ID=acebb4d0-0-13c4-55013-bd-1a5a4d0c-bd
>
> Sep 18 23:15:50 spce /usr/sbin/kamailio[2655]: INFO: <script>: Applying
> callee-out peer rewrite rules to called party using dpid '4' -
> R=sip:086XXXXXXX@<myUpstreamProviderIP>:5060;transport=udp
> ID=acebb4d0-0-13c4-55013-bd-1a5a4d0c-bd
>
> Sep 18 23:15:50 spce /usr/sbin/kamailio[2655]: INFO: <script>: Rewriting
> called party '086XXXXXXX' to '2786XXXXXXX' - R=sip:086XXXXXXX@<myUpstreamProviderIP>:5060;transport=udp
> ID=acebb4d0-0-13c4-55013-bd-1a5a4d0c-bd
>
> Sep 18 23:15:50 spce /usr/sbin/kamailio[2655]: INFO: <script>: Setting
> P-Called-Party-ID '<sip:2786XXXXXXX@<myUpstreamProviderIP>>' -
> R=sip:2786XXXXXXX@<myUpstreamProviderIP>:5060;transport=udp
> ID=acebb4d0-0-13c4-55013-bd-1a5a4d0c-bd
>
> Sep 18 23:15:50 spce /usr/sbin/kamailio[2655]: INFO: <script>: Writing sbc
> parameters
> ;aleg_sst_enable=yes;aleg_sst_expires=300;aleg_sst_min_timer=90;aleg_sst_max_timer=7200;aleg_sst_refresh_method=UPDATE_FALLBACK_INVITE;sst_enable=yes;sst_expires=300;sst_min_timer=90;sst_max_timer=7200;sst_refresh_method=UPDATE_FALLBACK_INVITE
> - R=sip:2786XXXXXXX@<myUpstreamProviderIP>:5060;transport=udp
> ID=acebb4d0-0-13c4-55013-bd-1a5a4d0c-bd
>
> Sep 18 23:15:50 spce /usr/sbin/kamailio[2655]: INFO: <script>: Setting
> 'sip:<myUpstreamProviderIP>:5060' taken from R-URI as next hop after lb for
> PSTN call - R=sip:2786XXXXXXX@<myUpstreamProviderIP>:5060;transport=udp
> ID=acebb4d0-0-13c4-55013-bd-1a5a4d0c-bd
>
> Sep 18 23:15:50 spce /usr/sbin/kamailio[2655]: INFO: <script>: Appending
> P-D-URI 'sip:127.0.0.1:5060;received='sip:<myUpstreamProviderIP>:5060;transport=udp''
> - R=sip:2786XXXXXXX@<myUpstreamProviderIP>:5060;transport=udp
> ID=acebb4d0-0-13c4-55013-bd-1a5a4d0c-bd
>
> Sep 18 23:15:50 spce /usr/sbin/kamailio[2655]: INFO: <script>: Forcing
> request via B2BUA 'sip:127.0.0.1:5080' - R=sip:2786XXXXXXX@<myUpstreamProviderIP>:5060;transport=udp
> ID=acebb4d0-0-13c4-55013-bd-1a5a4d0c-bd
>
> Sep 18 23:15:50 spce /usr/sbin/kamailio[2655]: INFO: <script>: Request
> leaving server, D-URI='sip:127.0.0.1:5080' - R=sip:2786XXXXXXX@<myUpstreamProviderIP>:5060;transport=udp
> ID=acebb4d0-0-13c4-55013-bd-1a5a4d0c-bd
>
> Sep 18 23:15:50 spce /usr/sbin/kamailio[2647]: INFO: <script>: NAT-Reply -
> S=100 - Connecting M=INVITE IP=<myclientIP>:5060 (127.0.0.1:5080)
> ID=acebb4d0-0-13c4-55013-bd-1a5a4d0c-bd
>
> Sep 18 23:15:52 spce /usr/sbin/kamailio[2653]: INFO: <script>: NAT-Reply -
> S=183 - Session Progress M=INVITE IP=<myclientIP>:5060 (127.0.0.1:5080)
> ID=acebb4d0-0-13c4-55013-bd-1a5a4d0c-bd
>
> Sep 18 23:15:52 spce /usr/sbin/kamailio[2653]: INFO: <script>: Remove
> existing ICE candidates (if any) for caller -
> ID=acebb4d0-0-13c4-55013-bd-1a5a4d0c-bd
>
> Sep 18 23:15:52 spce /usr/sbin/kamailio[2653]: INFO: <script>: Use
> mediaproxy for backward direction - ID=acebb4d0-0-13c4-55013-bd-1a5a4d0c-bd
>
> Sep 18 23:15:52 spce /usr/sbin/kamailio[2659]: INFO: <script>: NAT-Reply -
> S=200 - OK M=INVITE IP=<myclientIP>:5060 (127.0.0.1:5080)
> ID=acebb4d0-0-13c4-55013-bd-1a5a4d0c-bd
>
> Sep 18 23:15:52 spce /usr/sbin/kamailio[2659]: INFO: <script>: Remove
> existing ICE candidates (if any) for caller -
> ID=acebb4d0-0-13c4-55013-bd-1a5a4d0c-bd
>
> Sep 18 23:15:52 spce /usr/sbin/kamailio[2659]: INFO: <script>: Use
> mediaproxy for backward direction - ID=acebb4d0-0-13c4-55013-bd-1a5a4d0c-bd
>
> Sep 18 23:15:52 spce /usr/sbin/kamailio[2651]: INFO: <script>: New request
> - M=ACK R=sip:127.0.0.1:5080 F=sip:TN001FAX T=sip:086XXXXXXX@<mysipserverIP>:5060
> IP=<myclientIP>:5060 (127.0.0.1:5060)
> ID=acebb4d0-0-13c4-55013-bd-1a5a4d0c-bd
>
> Sep 18 23:15:52 spce /usr/sbin/kamailio[2651]: INFO: <script>: Relaying
> request, du='<null>' - R=sip:127.0.0.1:5080ID=acebb4d0-0-13c4-55013-bd-1a5a4d0c-bd
>
> Sep 18 23:15:56 spce /usr/sbin/kamailio[2649]: INFO: <script>: New request
> - M=INVITE R=sip:<myclientIP>:5060 F=sip:086XXXXXXX@<mysipserverIP>:5060
> T=sip:27XXXXX2533 at mysipdns IP=127.0.0.1:5080 (127.0.0.1:5080)
> ID=acebb4d0-0-13c4-55013-bd-1a5a4d0c-bd
>
> Sep 18 23:15:56 spce /usr/sbin/kamailio[2649]: INFO: <script>: Remove
> existing ICE candidates (if any) for caller - R=sip:<myclientIP>:5060
> ID=acebb4d0-0-13c4-55013-bd-1a5a4d0c-bd
>
> Sep 18 23:15:56 spce /usr/sbin/kamailio[2649]: INFO: <script>: Use
> mediaproxy for forward direction for IPv4/IPv4 - R=sip:<myclientIP>:5060
> ID=acebb4d0-0-13c4-55013-bd-1a5a4d0c-bd
>
> Sep 18 23:15:56 spce /usr/sbin/kamailio[2649]: INFO: <script>: Relaying
> request,
> du='sip:127.0.0.1;r2=on;lr=on;ftag=acfc5ab0-0-13c4-55013-bd-5bb91ef2-bd;ngcplb=yes'
> - R=sip:<myclientIP>:5060 ID=acebb4d0-0-13c4-55013-bd-1a5a4d0c-bd
>
> Sep 18 23:15:56 spce /usr/sbin/kamailio[2655]: INFO: <script>: NAT-Reply -
> S=200 - OK M=INVITE IP=127.0.0.1:5080 (127.0.0.1:5060)
> ID=acebb4d0-0-13c4-55013-bd-1a5a4d0c-bd
>
> Sep 18 23:15:56 spce /usr/sbin/kamailio[2655]: INFO: <script>: Remove
> existing ICE candidates (if any) for callee -
> ID=acebb4d0-0-13c4-55013-bd-1a5a4d0c-bd
>
> Sep 18 23:15:56 spce /usr/sbin/kamailio[2655]: INFO: <script>: Use
> mediaproxy for backward direction - ID=acebb4d0-0-13c4-55013-bd-1a5a4d0c-bd
>
> Sep 18 23:15:56 spce /usr/sbin/kamailio[2647]: INFO: <script>: New request
> - M=ACK R=sip:<mysipserverIP>:5060 F=sip:2786XXXXXXX@<myUpstreamProviderIP>
> T=sip:27XXXXX2533 at mysipdns IP=<myUpstreamProviderIP>:5060 (127.0.0.1:5060)
> ID=acebb4d0-0-13c4-55013-bd-1a5a4d0c-bd_b2b-1
>
> Sep 18 23:15:56 spce /usr/sbin/kamailio[2647]: INFO: <script>: Dropping
> mis-routed request - R=sip:<mysipserverIP>:5060
> ID=acebb4d0-0-13c4-55013-bd-1a5a4d0c-bd_b2b-1
>
> Sep 18 23:15:56 spce /usr/sbin/kamailio[2653]: INFO: <script>: New request
> - M=INVITE
> R=sip:127.0.0.1;r2=on;lr=on;ftag=49E8355A-523A18060008DB67-B1DA1700;ngcplb=yes
> F=sip:2786XXXXXXX@<myUpstreamProviderIP> T=sip:27XXXXX2533 at mysipdnsIP=<myUpstreamProviderIP>:5060 (
> 127.0.0.1:5060) ID=acebb4d0-0-13c4-55013-bd-1a5a4d0c-bd_b2b-1
>
> Sep 18 23:15:56 spce /usr/sbin/kamailio[2653]: INFO: <script>: Call from
> PSTN -
> R=sip:127.0.0.1;r2=on;lr=on;ftag=49E8355A-523A18060008DB67-B1DA1700;ngcplb=yes
> ID=acebb4d0-0-13c4-55013-bd-1a5a4d0c-bd_b2b-1
>
> Sep 18 23:15:56 spce /usr/sbin/kamailio[2653]: INFO: <script>: Load peer
> preferences for peer host '2' -
> R=sip:127.0.0.1;r2=on;lr=on;ftag=49E8355A-523A18060008DB67-B1DA1700;ngcplb=yes
> ID=acebb4d0-0-13c4-55013-bd-1a5a4d0c-bd_b2b-1
>
> Sep 18 23:15:56 spce /usr/sbin/kamailio[2653]: INFO: <script>: Load
> dialplan IDs for peer host '2' -
> R=sip:127.0.0.1;r2=on;lr=on;ftag=49E8355A-523A18060008DB67-B1DA1700;ngcplb=yes
> ID=acebb4d0-0-13c4-55013-bd-1a5a4d0c-bd_b2b-1
>
> Sep 18 23:15:56 spce /usr/sbin/kamailio[2653]: INFO: <script>: Fetched
> dialplan IDs caller_in='1', callee_in='2' -
> R=sip:127.0.0.1;r2=on;lr=on;ftag=49E8355A-523A18060008DB67-B1DA1700;ngcplb=yes
> ID=acebb4d0-0-13c4-55013-bd-1a5a4d0c-bd_b2b-1
>
> Sep 18 23:15:56 spce /usr/sbin/kamailio[2653]: INFO: <script>: Use
> 'P-NGCP-Src-Ip' for CDR IP -
> R=sip:127.0.0.1;r2=on;lr=on;ftag=49E8355A-523A18060008DB67-B1DA1700;ngcplb=yes
> ID=acebb4d0-0-13c4-55013-bd-1a5a4d0c-bd_b2b-1
>
> Sep 18 23:15:56 spce /usr/sbin/kamailio[2653]: INFO: <script>: Dialog set
> mark total -
> R=sip:127.0.0.1;r2=on;lr=on;ftag=49E8355A-523A18060008DB67-B1DA1700;ngcplb=yes
> ID=acebb4d0-0-13c4-55013-bd-1a5a4d0c-bd_b2b-1
>
> Sep 18 23:15:56 spce /usr/sbin/kamailio[2653]: INFO: <script>: Dialog set
> mark peer to '2' -
> R=sip:127.0.0.1;r2=on;lr=on;ftag=49E8355A-523A18060008DB67-B1DA1700;ngcplb=yes
> ID=acebb4d0-0-13c4-55013-bd-1a5a4d0c-bd_b2b-1
>
> Sep 18 23:15:56 spce /usr/sbin/kamailio[2653]: INFO: <script>: IP
> authorization for caller not provisioned, allow call -
> R=sip:127.0.0.1;r2=on;lr=on;ftag=49E8355A-523A18060008DB67-B1DA1700;ngcplb=yes
> ID=acebb4d0-0-13c4-55013-bd-1a5a4d0c-bd_b2b-1
>
> Sep 18 23:15:56 spce /usr/sbin/kamailio[2653]: INFO: <script>:
> User-Provided CLI '2786XXXXXXX' taken from From-User -
> R=sip:127.0.0.1;r2=on;lr=on;ftag=49E8355A-523A18060008DB67-B1DA1700;ngcplb=yes
> ID=acebb4d0-0-13c4-55013-bd-1a5a4d0c-bd_b2b-1
>
> Sep 18 23:15:56 spce /usr/sbin/kamailio[2653]: INFO: <script>:
> Network-Provided CLI '2786XXXXXXX' taken from From-User -
> R=sip:127.0.0.1;r2=on;lr=on;ftag=49E8355A-523A18060008DB67-B1DA1700;ngcplb=yes
> ID=acebb4d0-0-13c4-55013-bd-1a5a4d0c-bd_b2b-1
>
> Sep 18 23:15:56 spce /usr/sbin/kamailio[2653]: INFO: <script>: Applying
> caller-in peer rewrite rules on user-provided CLI using dpid '1' -
> R=sip:127.0.0.1;r2=on;lr=on;ftag=49E8355A-523A18060008DB67-B1DA1700;ngcplb=yes
> ID=acebb4d0-0-13c4-55013-bd-1a5a4d0c-bd_b2b-1
>
> Sep 18 23:15:56 spce /usr/sbin/kamailio[2653]: INFO: <script>: Rewriting
> user-provided CLI '2786XXXXXXX' to '086XXXXXXX' -
> R=sip:127.0.0.1;r2=on;lr=on;ftag=49E8355A-523A18060008DB67-B1DA1700;ngcplb=yes
> ID=acebb4d0-0-13c4-55013-bd-1a5a4d0c-bd_b2b-1
>
> Sep 18 23:15:56 spce /usr/sbin/kamailio[2653]: INFO: <script>: Applying
> caller-in peer rewrite rules on network-provided CLI using dpid '1' -
> R=sip:127.0.0.1;r2=on;lr=on;ftag=49E8355A-523A18060008DB67-B1DA1700;ngcplb=yes
> ID=acebb4d0-0-13c4-55013-bd-1a5a4d0c-bd_b2b-1
>
> Sep 18 23:15:56 spce /usr/sbin/kamailio[2653]: INFO: <script>: Rewriting
> network-provided CLI '2786XXXXXXX' to '086XXXXXXX' -
> R=sip:127.0.0.1;r2=on;lr=on;ftag=49E8355A-523A18060008DB67-B1DA1700;ngcplb=yes
> ID=acebb4d0-0-13c4-55013-bd-1a5a4d0c-bd_b2b-1
>
> Sep 18 23:15:56 spce /usr/sbin/kamailio[2653]: INFO: <script>: Setting
> '086XXXXXXX@<myUpstreamProviderIP>' as initiating user-provided CLI -
> R=sip:127.0.0.1;r2=on;lr=on;ftag=49E8355A-523A18060008DB67-B1DA1700;ngcplb=yes
> ID=acebb4d0-0-13c4-55013-bd-1a5a4d0c-bd_b2b-1
>
> Sep 18 23:15:56 spce /usr/sbin/kamailio[2653]: INFO: <script>: Setting
> '086XXXXXXX@<myUpstreamProviderIP>' as initiating network-provided CLI -
> R=sip:127.0.0.1;r2=on;lr=on;ftag=49E8355A-523A18060008DB67-B1DA1700;ngcplb=yes
> ID=acebb4d0-0-13c4-55013-bd-1a5a4d0c-bd_b2b-1
>
> Sep 18 23:15:56 spce /usr/sbin/kamailio[2653]: INFO: <script>: Searching
> for callee -
> R=sip:127.0.0.1;r2=on;lr=on;ftag=49E8355A-523A18060008DB67-B1DA1700;ngcplb=yes
> ID=acebb4d0-0-13c4-55013-bd-1a5a4d0c-bd_b2b-1
>
> Sep 18 23:15:56 spce /usr/sbin/kamailio[2653]: INFO: <script>: Applying
> callee-in peer rewrite rules using dpid '2' -
> R=sip:127.0.0.1;r2=on;lr=on;ftag=49E8355A-523A18060008DB67-B1DA1700;ngcplb=yes
> ID=acebb4d0-0-13c4-55013-bd-1a5a4d0c-bd_b2b-1
>
> Sep 18 23:15:56 spce /usr/sbin/kamailio[2653]: INFO: <script>: No matching
> rewrite rules for '<null>' found -
> R=sip:127.0.0.1;r2=on;lr=on;ftag=49E8355A-523A18060008DB67-B1DA1700;ngcplb=yes
> ID=acebb4d0-0-13c4-55013-bd-1a5a4d0c-bd_b2b-1
>
> Sep 18 23:15:56 spce /usr/sbin/kamailio[2653]: INFO: <script>: Skipping
> internal services for unauthenticated call -
> R=sip:127.0.0.1;r2=on;lr=on;ftag=49E8355A-523A18060008DB67-B1DA1700;ngcplb=yes
> ID=acebb4d0-0-13c4-55013-bd-1a5a4d0c-bd_b2b-1
>
> Sep 18 23:15:56 spce /usr/sbin/kamailio[2653]: INFO: <script>: Clear
> callee preferences -
> R=sip:127.0.0.1;r2=on;lr=on;ftag=49E8355A-523A18060008DB67-B1DA1700;ngcplb=yes
> ID=acebb4d0-0-13c4-55013-bd-1a5a4d0c-bd_b2b-1
>
> Sep 18 23:15:56 spce /usr/sbin/kamailio[2653]: INFO: <script>: Callee is
> not local -
> R=sip:127.0.0.1;r2=on;lr=on;ftag=49E8355A-523A18060008DB67-B1DA1700;ngcplb=yes
> ID=acebb4d0-0-13c4-55013-bd-1a5a4d0c-bd_b2b-1
>
> Sep 18 23:15:56 spce /usr/sbin/kamailio[2653]: INFO: <script>: Check
> Administrative NCOS level -
> R=sip:127.0.0.1;r2=on;lr=on;ftag=49E8355A-523A18060008DB67-B1DA1700;ngcplb=yes
> ID=acebb4d0-0-13c4-55013-bd-1a5a4d0c-bd_b2b-1
>
> Sep 18 23:15:56 spce /usr/sbin/kamailio[2653]: INFO: <script>: Check User
> NCOS level -
> R=sip:127.0.0.1;r2=on;lr=on;ftag=49E8355A-523A18060008DB67-B1DA1700;ngcplb=yes
> ID=acebb4d0-0-13c4-55013-bd-1a5a4d0c-bd_b2b-1
>
> Sep 18 23:15:56 spce /usr/sbin/kamailio[2653]: INFO: <script>: Checking
> URI '@127.0.0.1' and CLI '<null>' against block out lists -
> R=sip:127.0.0.1;r2=on;lr=on;ftag=49E8355A-523A18060008DB67-B1DA1700;ngcplb=yes
> ID=acebb4d0-0-13c4-55013-bd-1a5a4d0c-bd_b2b-1
>
> Sep 18 23:15:56 spce /usr/sbin/kamailio[2653]: INFO: <script>: Admin
> caller block mode is 'open' -
> R=sip:127.0.0.1;r2=on;lr=on;ftag=49E8355A-523A18060008DB67-B1DA1700;ngcplb=yes
> ID=acebb4d0-0-13c4-55013-bd-1a5a4d0c-bd_b2b-1
>
> Sep 18 23:15:56 spce /usr/sbin/kamailio[2653]: INFO: <script>: Caller
> block mode is 'open' -
> R=sip:127.0.0.1;r2=on;lr=on;ftag=49E8355A-523A18060008DB67-B1DA1700;ngcplb=yes
> ID=acebb4d0-0-13c4-55013-bd-1a5a4d0c-bd_b2b-1
>
> Sep 18 23:15:56 spce /usr/sbin/kamailio[2653]: INFO: <script>: Call to
> unknown user -
> R=sip:127.0.0.1;r2=on;lr=on;ftag=49E8355A-523A18060008DB67-B1DA1700;ngcplb=yes
> ID=acebb4d0-0-13c4-55013-bd-1a5a4d0c-bd_b2b-1
>
> Sep 18 23:15:56 spce /usr/sbin/kamailio[2653]: INFO: <script>: Accounting
> failed request for uuid '0' -
> R=sip:127.0.0.1;r2=on;lr=on;ftag=49E8355A-523A18060008DB67-B1DA1700;ngcplb=yes
> ID=acebb4d0-0-13c4-55013-bd-1a5a4d0c-bd_b2b-1
>
> Sep 18 23:15:56 spce /usr/sbin/kamailio[2653]: INFO: <script>: Setting acc
> source-leg for uuid '0':
> '0|2786XXXXXXX|<myUpstreamProviderIP>|086XXXXXXX|||<null>|||0|call|<myUpstreamProviderIP>|1379538956.820574'
> -
> R=sip:127.0.0.1;r2=on;lr=on;ftag=49E8355A-523A18060008DB67-B1DA1700;ngcplb=yes
> ID=acebb4d0-0-13c4-55013-bd-1a5a4d0c-bd_b2b-1
>
> Sep 18 23:15:56 spce /usr/sbin/kamailio[2653]: INFO: <script>: Setting acc
> destination-leg for uuid '0':
> '0|||<null>|<null>|0|<null>|127.0.0.1|<null>|127.0.0.1' -
> R=sip:127.0.0.1;r2=on;lr=on;ftag=49E8355A-523A18060008DB67-B1DA1700;ngcplb=yes
> ID=acebb4d0-0-13c4-55013-bd-1a5a4d0c-bd_b2b-1
>
> Sep 18 23:15:56 spce /usr/sbin/kamailio[2659]: INFO: <script>: New request
> - M=ACK R=sip:<mysipserverIP>:5060 F=sip:2786XXXXXXX@<myUpstreamProviderIP>
> T=sip:27XXXXX2533 at mysipdns IP=<myUpstreamProviderIP>:5060 (127.0.0.1:5060)
> ID=acebb4d0-0-13c4-55013-bd-1a5a4d0c-bd_b2b-1
>
> Sep 18 23:15:56 spce /usr/sbin/kamailio[2651]: INFO: <script>: NAT-Reply -
> S=200 - OK M=INVITE IP=127.0.0.1:5080 (127.0.0.1:5060)
> ID=acebb4d0-0-13c4-55013-bd-1a5a4d0c-bd
>
> Sep 18 23:15:56 spce /usr/sbin/kamailio[2651]: INFO: <script>: Remove
> existing ICE candidates (if any) for callee -
> ID=acebb4d0-0-13c4-55013-bd-1a5a4d0c-bd
>
> Sep 18 23:15:56 spce /usr/sbin/kamailio[2651]: INFO: <script>: Use
> mediaproxy for backward direction - ID=acebb4d0-0-13c4-55013-bd-1a5a4d0c-bd
>
> Sep 18 23:15:57 spce /usr/sbin/kamailio[2648]: INFO: <script>: NAT-Reply -
> S=200 - OK M=INVITE IP=127.0.0.1:5080 (127.0.0.1:5060)
> ID=acebb4d0-0-13c4-55013-bd-1a5a4d0c-bd
>
> Sep 18 23:15:57 spce /usr/sbin/kamailio[2648]: INFO: <script>: Remove
> existing ICE candidates (if any) for callee -
> ID=acebb4d0-0-13c4-55013-bd-1a5a4d0c-bd
>
> Sep 18 23:15:57 spce /usr/sbin/kamailio[2648]: INFO: <script>: Use
> mediaproxy for backward direction - ID=acebb4d0-0-13c4-55013-bd-1a5a4d0c-bd
>
> Sep 18 23:15:59 spce /usr/sbin/kamailio[2647]: INFO: <script>: NAT-Reply -
> S=200 - OK M=INVITE IP=127.0.0.1:5080 (127.0.0.1:5060)
> ID=acebb4d0-0-13c4-55013-bd-1a5a4d0c-bd
>
> Sep 18 23:15:59 spce /usr/sbin/kamailio[2647]: INFO: <script>: Remove
> existing ICE candidates (if any) for callee -
> ID=acebb4d0-0-13c4-55013-bd-1a5a4d0c-bd
>
> Sep 18 23:15:59 spce /usr/sbin/kamailio[2647]: INFO: <script>: Use
> mediaproxy for backward direction - ID=acebb4d0-0-13c4-55013-bd-1a5a4d0c-bd
>
> Sep 18 23:16:28 spce /usr/sbin/kamailio[2648]: INFO: <script>: New request
> - M=ACK R=sip:<myclientIP>:5060 F=sip:086XXXXXXX@<mysipserverIP>:5060
> T=sip:27XXXXX2533 at mysipdns IP=127.0.0.1:5080 (127.0.0.1:5080)
> ID=acebb4d0-0-13c4-55013-bd-1a5a4d0c-bd
>
> Sep 18 23:16:28 spce /usr/sbin/kamailio[2657]: INFO: <script>: New request
> - M=BYE R=sip:<myclientIP>:5060 F=sip:086XXXXXXX@<mysipserverIP>:5060
> T=sip:27XXXXX2533 at mysipdns IP=127.0.0.1:5080 (127.0.0.1:5080)
> ID=acebb4d0-0-13c4-55013-bd-1a5a4d0c-bd
>
> Sep 18 23:16:28 spce /usr/sbin/kamailio[2657]: INFO: <script>: Stop
> mediaproxy for all branches - R=sip:<myclientIP>:5060
> ID=acebb4d0-0-13c4-55013-bd-1a5a4d0c-bd
>
> Sep 18 23:16:28 spce /usr/sbin/kamailio[2648]: INFO: <script>: Relaying
> request,
> du='sip:127.0.0.1;r2=on;lr=on;ftag=acfc5ab0-0-13c4-55013-bd-5bb91ef2-bd;ngcplb=yes'
> - R=sip:<myclientIP>:5060 ID=acebb4d0-0-13c4-55013-bd-1a5a4d0c-bd
>
> Sep 18 23:16:28 spce /usr/sbin/kamailio[2657]: INFO: <script>: Relaying
> request,
> du='sip:127.0.0.1;r2=on;lr=on;ftag=acfc5ab0-0-13c4-55013-bd-5bb91ef2-bd;ngcplb=yes'
> - R=sip:<myclientIP>:5060 ID=acebb4d0-0-13c4-55013-bd-1a5a4d0c-bd
>
> Sep 18 23:16:28 spce /usr/sbin/kamailio[2649]: INFO: <script>: New request
> - M=BYE R=sip:127.0.0.1:5080 F=sip:TN001FAX T=sip:086XXXXXXX@<mysipserverIP>:5060
> IP=<myclientIP>:5060 (127.0.0.1:5060)
> ID=acebb4d0-0-13c4-55013-bd-1a5a4d0c-bd
>
> Sep 18 23:16:28 spce /usr/sbin/kamailio[2649]: INFO: <script>: Stop
> mediaproxy for all branches - R=sip:127.0.0.1:5080ID=acebb4d0-0-13c4-55013-bd-1a5a4d0c-bd
>
> Sep 18 23:16:28 spce /usr/sbin/kamailio[2649]: INFO: <script>: Relaying
> request, du='<null>' - R=sip:127.0.0.1:5080ID=acebb4d0-0-13c4-55013-bd-1a5a4d0c-bd
>
> Sep 18 23:16:28 spce /usr/sbin/kamailio[2655]: INFO: <script>: NAT-Reply -
> S=200 - OK M=BYE IP=<myclientIP>:5060 (127.0.0.1:5080)
> ID=acebb4d0-0-13c4-55013-bd-1a5a4d0c-bd
>
> Sep 18 23:16:28 spce /usr/sbin/kamailio[2647]: INFO: <script>: NAT-Reply -
> S=200 - OK M=BYE IP=127.0.0.1:5080 (127.0.0.1:5060)
> ID=acebb4d0-0-13c4-55013-bd-1a5a4d0c-bd
>
> _______________________________________________
> Spce-user mailing list
> Spce-user at lists.sipwise.com
> http://lists.sipwise.com/listinfo/spce-user
>
>
-------------- next part --------------
An HTML attachment was scrubbed...
URL: <http://lists.sipwise.com/pipermail/spce-user_lists.sipwise.com/attachments/20130919/f2db39a6/attachment-0001.html>