Mar 17 21:25:53 DEBUG[38720]: chan_sip.c:7023 check_user_full: Setting NAT on RTP to 0 Mar 17 21:25:53 DEBUG[38720]: chan_sip.c:1394 __sip_ack: Stopping retransmission on '659d32ef-b57112ec@192.168.21.54' of Response 101: Match Found Mar 17 21:25:53 DEBUG[38720]: chan_sip.c:7023 check_user_full: Setting NAT on RTP to 0 Mar 17 21:25:53 DEBUG[38720]: chan_sip.c:10335 handle_request_invite: Checking SIP call limits for device 204 Mar 17 21:25:53 DEBUG[38720]: chan_sip.c:6033 build_route: build_route: Contact hop: 204 -- Executing Macro("SIP/204-6bee", "dodial|SIP/202") in new stack -- Executing Dial("SIP/204-6bee", "SIP/202") in new stack Mar 17 21:25:53 DEBUG[38720]: chan_sip.c:1864 create_addr_from_peer: Setting NAT on RTP to 0 Mar 17 21:25:53 DEBUG[38720]: chan_sip.c:2058 sip_call: Outgoing Call for 202 -- Called 202 Mar 17 21:25:53 DEBUG[38720]: chan_sip.c:1447 __sip_semi_ack: (Provisional) Stopping retransmission (but retaining packet) on '69a4550523c9f1721f0a85b96bd1449a@192.168.21.9' Request 102: Found Mar 17 21:25:53 DEBUG[38720]: chan_sip.c:1447 __sip_semi_ack: (Provisional) Stopping retransmission (but retaining packet) on '69a4550523c9f1721f0a85b96bd1449a@192.168.21.9' Request 102: Found -- SIP/202-11c2 is ringing Mar 17 21:25:54 DEBUG[38720]: chan_sip.c:1372 __sip_ack: Acked pending invite 102 Mar 17 21:25:54 DEBUG[38720]: chan_sip.c:1394 __sip_ack: Stopping retransmission on '69a4550523c9f1721f0a85b96bd1449a@192.168.21.9' of Request 102: Match Found Mar 17 21:25:54 DEBUG[38720]: chan_sip.c:6033 build_route: build_route: Contact hop: -- SIP/202-11c2 answered SIP/204-6bee -- Attempting native bridge of SIP/204-6bee and SIP/202-11c2 Mar 17 21:25:54 DEBUG[38720]: chan_sip.c:1394 __sip_ack: Stopping retransmission on '659d32ef-b57112ec@192.168.21.54' of Response 102: Match Found -- Started music on hold, class 'default', on channel 'SIP/204-6bee' Mar 17 21:25:55 DEBUG[38720]: channel.c:1984 ast_read: Auto-deactivating generator -- Stopped music on hold on SIP/204-6bee Mar 17 21:25:55 DEBUG[38720]: chan_sip.c:1394 __sip_ack: Stopping retransmission on '69a4550523c9f1721f0a85b96bd1449a@192.168.21.9' of Response 1: Match Found Mar 17 21:25:58 DEBUG[38720]: chan_sip.c:6747 get_refer_info: Unsupervised transfer to (Refer-To): 203 Mar 17 21:25:58 DEBUG[38720]: chan_sip.c:6749 get_refer_info: Transferred by (Referred-by: ) 202 Mar 17 21:25:58 DEBUG[38720]: chan_sip.c:6750 get_refer_info: Transfer Contact Info (REFER_CONTACT) Mar 17 21:25:58 DEBUG[38720]: chan_sip.c:10521 handle_request_refer: 202 Accepted (blind) Mar 17 21:25:58 DEBUG[38720]: chan_sip.c:10526 handle_request_refer: Got SIP blind transfer, applying to 'SIP/204-6bee' Mar 17 21:25:58 DEBUG[38720]: channel.c:3248 ast_generic_bridge: Nobody there, continuing... Mar 17 21:25:58 DEBUG[38720]: channel.c:3264 ast_generic_bridge: Didn't get a frame from channel: SIP/204-6bee Mar 17 21:25:58 DEBUG[38720]: channel.c:3539 ast_channel_bridge: Bridge stops bridging channels SIP/204-6bee and SIP/202-11c2 Mar 17 21:25:58 DEBUG[38720]: chan_sip.c:2416 sip_hangup: update_call_counter(202) - decrement call limit counter Mar 17 21:25:58 DEBUG[38720]: app_dial.c:1587 dial_exec_full: Exiting with DIALSTATUS=ANSWER. == Spawn extension (OriginateInternal, 203, 0) exited non-zero on 'SIP/204-6bee' in macro 'dodial' == Spawn extension (OriginateInternal, 203, 0) exited non-zero on 'SIP/204-6bee' -- Executing Macro("SIP/204-6bee", "dodial|SIP/203") in new stack -- Executing Dial("SIP/204-6bee", "SIP/203") in new stack Mar 17 21:25:58 DEBUG[38720]: chan_sip.c:1864 create_addr_from_peer: Setting NAT on RTP to 0 Mar 17 21:25:58 DEBUG[38720]: chan_sip.c:2058 sip_call: Outgoing Call for 203 -- Called 203 Mar 17 21:25:58 DEBUG[38720]: chan_sip.c:1447 __sip_semi_ack: (Provisional) Stopping retransmission (but retaining packet) on '6f3c1b8f533582565e0006c753bd2307@192.168.21.9' Request 102: Found Mar 17 21:25:58 DEBUG[38720]: chan_sip.c:1394 __sip_ack: Stopping retransmission on '69a4550523c9f1721f0a85b96bd1449a@192.168.21.9' of Request 103: Match Found Mar 17 21:25:58 DEBUG[38720]: chan_sip.c:1447 __sip_semi_ack: (Provisional) Stopping retransmission (but retaining packet) on '6f3c1b8f533582565e0006c753bd2307@192.168.21.9' Request 102: Found -- SIP/203-cb84 is ringing Mar 17 21:25:58 DEBUG[38720]: channel.c:2036 ast_indicate: Driver for channel 'SIP/204-6bee' does not support indication 3, emulating it Mar 17 21:25:58 DEBUG[38720]: chan_sip.c:1394 __sip_ack: Stopping retransmission on '69a4550523c9f1721f0a85b96bd1449a@192.168.21.9' of Request 104: Match Found -- Incoming call: Got SIP response 500 "Internal Server Error" back from 192.168.21.52 Mar 17 21:25:58 DEBUG[38720]: chan_sip.c:10923 handle_request: That's odd... Got a response on a call we dont know about. Cseq 104 Cmd SIP/2.0 Mar 17 21:25:59 DEBUG[38720]: chan_sip.c:10923 handle_request: That's odd... Got a response on a call we dont know about. Cseq 104 Cmd SIP/2.0 Mar 17 21:26:01 DEBUG[38720]: chan_sip.c:1372 __sip_ack: Acked pending invite 102 Mar 17 21:26:01 DEBUG[38720]: chan_sip.c:1394 __sip_ack: Stopping retransmission on '6f3c1b8f533582565e0006c753bd2307@192.168.21.9' of Request 102: Match Found Mar 17 21:26:01 DEBUG[38720]: chan_sip.c:6033 build_route: build_route: Contact hop: -- SIP/203-cb84 answered SIP/204-6bee -- Attempting native bridge of SIP/204-6bee and SIP/203-cb84 Mar 17 21:26:02 DEBUG[38720]: channel.c:3264 ast_generic_bridge: Didn't get a frame from channel: SIP/203-cb84 Mar 17 21:26:02 DEBUG[38720]: channel.c:3539 ast_channel_bridge: Bridge stops bridging channels SIP/204-6bee and SIP/203-cb84 Mar 17 21:26:02 DEBUG[38720]: chan_sip.c:2416 sip_hangup: update_call_counter(203) - decrement call limit counter Mar 17 21:26:02 DEBUG[38720]: app_dial.c:1587 dial_exec_full: Exiting with DIALSTATUS=ANSWER. == Spawn extension (macro-dodial, s, 1) exited non-zero on 'SIP/204-6bee' in macro 'dodial' == Spawn extension (OriginateInternal, 203, 1) exited non-zero on 'SIP/204-6bee' Mar 17 21:26:02 DEBUG[38720]: pbx.c:1510 pbx_substitute_variables_helper_full: Function result is '"Kitchen Phone" <204>' Mar 17 21:26:02 DEBUG[38720]: pbx.c:1510 pbx_substitute_variables_helper_full: Function result is '204' Mar 17 21:26:02 DEBUG[38720]: pbx.c:1510 pbx_substitute_variables_helper_full: Function result is '203' Mar 17 21:26:02 DEBUG[38720]: pbx.c:1510 pbx_substitute_variables_helper_full: Function result is 'OriginateInternal' Mar 17 21:26:02 DEBUG[38720]: pbx.c:1510 pbx_substitute_variables_helper_full: Function result is 'SIP/204-6bee' Mar 17 21:26:02 DEBUG[38720]: pbx.c:1510 pbx_substitute_variables_helper_full: Function result is 'SIP/203-cb84' Mar 17 21:26:02 DEBUG[38720]: pbx.c:1510 pbx_substitute_variables_helper_full: Function result is 'Dial' Mar 17 21:26:02 DEBUG[38720]: pbx.c:1510 pbx_substitute_variables_helper_full: Function result is 'SIP/203' Mar 17 21:26:02 DEBUG[38720]: pbx.c:1510 pbx_substitute_variables_helper_full: Function result is '2006-03-17 21:25:53' Mar 17 21:26:02 DEBUG[38720]: pbx.c:1510 pbx_substitute_variables_helper_full: Function result is '2006-03-17 21:25:54' Mar 17 21:26:02 DEBUG[38720]: pbx.c:1510 pbx_substitute_variables_helper_full: Function result is '2006-03-17 21:26:02' Mar 17 21:26:02 DEBUG[38720]: pbx.c:1510 pbx_substitute_variables_helper_full: Function result is '9' Mar 17 21:26:02 DEBUG[38720]: pbx.c:1510 pbx_substitute_variables_helper_full: Function result is '8' Mar 17 21:26:02 DEBUG[38720]: pbx.c:1510 pbx_substitute_variables_helper_full: Function result is 'ANSWERED' Mar 17 21:26:02 DEBUG[38720]: pbx.c:1510 pbx_substitute_variables_helper_full: Function result is 'DOCUMENTATION' Mar 17 21:26:02 DEBUG[38720]: pbx.c:1510 pbx_substitute_variables_helper_full: Function result is '(null)' Mar 17 21:26:02 DEBUG[38720]: pbx.c:1510 pbx_substitute_variables_helper_full: Function result is '1142652353.11' Mar 17 21:26:02 DEBUG[38720]: pbx.c:1510 pbx_substitute_variables_helper_full: Function result is '(null)' Mar 17 21:26:02 DEBUG[38720]: chan_sip.c:2416 sip_hangup: update_call_counter(204) - decrement call limit counter Mar 17 21:26:02 DEBUG[38720]: chan_sip.c:1394 __sip_ack: Stopping retransmission on '659d32ef-b57112ec@192.168.21.54' of Request 102: Match Found