Jun 12 05:23:35 DEBUG[19990]: chan_sip.c:1394 __sip_ack: Stopping retransmission on '21b8de7748f352a17459c28002fcf5a7@202.5.145.56' of Request 102: Match Found
Jun 12 05:23:53 DEBUG[19990]: chan_sip.c:7042 check_user_full: Setting NAT on RTP to 524288
Jun 12 05:23:53 DEBUG[19990]: chan_sip.c:1394 __sip_ack: Stopping retransmission on '15066115e110ff6fMDE4MjZkYzQzMjUzOGUxNmZkOGVhNGE2MWQwMzA2ZGM.' of Response 1: Match Found
Jun 12 05:23:53 DEBUG[19990]: chan_sip.c:7042 check_user_full: Setting NAT on RTP to 524288
Jun 12 05:23:53 DEBUG[19990]: chan_sip.c:10354 handle_request_invite: Checking SIP call limits for device 701
Jun 12 05:23:53 DEBUG[19990]: chan_sip.c:6047 build_route: build_route: Contact hop: <sip:701@192.168.129.109:58956>
    -- Executing AddQueueMember("SIP/701-da61", "techsupport|SIP/701") in new stack
Jun 12 05:23:53 WARNING[20033]: app_queue.c:2840 aqm_exec: Unable to add interface 'SIP/701' to queue 'techsupport': Already there
    -- Executing Playback("SIP/701-da61", "agent-loginok") in new stack
    -- Playing 'agent-loginok' (language 'en')
Jun 12 05:23:53 DEBUG[20033]: chan_sip.c:2981 sip_rtp_read: Oooh, format changed to 4
Jun 12 05:23:53 DEBUG[19990]: chan_sip.c:1394 __sip_ack: Stopping retransmission on '15066115e110ff6fMDE4MjZkYzQzMjUzOGUxNmZkOGVhNGE2MWQwMzA2ZGM.' of Response 2: Match Found
  == Spawn extension (default, 104, 2) exited non-zero on 'SIP/701-da61'
Jun 12 05:23:53 DEBUG[20033]: pbx.c:1519 pbx_substitute_variables_helper_full: Function result is '"Testing Client" <701>'
Jun 12 05:23:53 DEBUG[20033]: pbx.c:1519 pbx_substitute_variables_helper_full: Function result is '701'
Jun 12 05:23:53 DEBUG[20033]: pbx.c:1519 pbx_substitute_variables_helper_full: Function result is '104'
Jun 12 05:23:53 DEBUG[20033]: pbx.c:1519 pbx_substitute_variables_helper_full: Function result is 'default'
Jun 12 05:23:53 DEBUG[20033]: pbx.c:1519 pbx_substitute_variables_helper_full: Function result is 'SIP/701-da61'
Jun 12 05:23:53 DEBUG[20033]: pbx.c:1519 pbx_substitute_variables_helper_full: Function result is '(null)'
Jun 12 05:23:53 DEBUG[20033]: pbx.c:1519 pbx_substitute_variables_helper_full: Function result is 'Playback'
Jun 12 05:23:53 DEBUG[20033]: pbx.c:1519 pbx_substitute_variables_helper_full: Function result is 'agent-loginok'
Jun 12 05:23:53 DEBUG[20033]: pbx.c:1519 pbx_substitute_variables_helper_full: Function result is '2006-06-12 05:23:53'
Jun 12 05:23:53 DEBUG[20033]: pbx.c:1519 pbx_substitute_variables_helper_full: Function result is '2006-06-12 05:23:53'
Jun 12 05:23:53 DEBUG[20033]: pbx.c:1519 pbx_substitute_variables_helper_full: Function result is '2006-06-12 05:23:53'
Jun 12 05:23:53 DEBUG[20033]: pbx.c:1519 pbx_substitute_variables_helper_full: Function result is '0'
Jun 12 05:23:53 DEBUG[20033]: pbx.c:1519 pbx_substitute_variables_helper_full: Function result is '0'
Jun 12 05:23:53 DEBUG[20033]: pbx.c:1519 pbx_substitute_variables_helper_full: Function result is 'ANSWERED'
Jun 12 05:23:53 DEBUG[20033]: pbx.c:1519 pbx_substitute_variables_helper_full: Function result is 'DOCUMENTATION'
Jun 12 05:23:53 DEBUG[20033]: pbx.c:1519 pbx_substitute_variables_helper_full: Function result is '(null)'
Jun 12 05:23:53 DEBUG[20033]: pbx.c:1519 pbx_substitute_variables_helper_full: Function result is '1150104233.5'
Jun 12 05:23:53 DEBUG[20033]: pbx.c:1519 pbx_substitute_variables_helper_full: Function result is '(null)'
Jun 12 05:23:53 DEBUG[20033]: chan_sip.c:2419 sip_hangup: update_call_counter(701) - decrement call limit counter
    -- Unregistered SIP '701'
    -- Registered SIP '1' at 192.168.129.109 port 23420 expires 3600
    -- Saved useragent "eyeBeam release 1002l stamp 29115" for peer 1
Jun 12 05:23:59 DEBUG[19990]: chan_sip.c:1394 __sip_ack: Stopping retransmission on '063966a00a405a830d1703102cd723ce@202.5.145.56' of Request 102: Match Found
    -- Registered SIP '701' at 192.168.129.109 port 14074 expires 3600
    -- Saved useragent "eyeBeam release 1002l stamp 29115" for peer 701
Jun 12 05:24:02 DEBUG[19990]: chan_sip.c:1394 __sip_ack: Stopping retransmission on '78c2f8437e3f083566d9ca4f7e4aa59c@202.5.145.56' of Request 102: Match Found
Jun 12 05:24:04 DEBUG[19990]: chan_sip.c:7042 check_user_full: Setting NAT on RTP to 524288
Jun 12 05:24:04 DEBUG[19990]: chan_sip.c:1394 __sip_ack: Stopping retransmission on '3e2b0a3b6f277a29MDE4MjZkYzQzMjUzOGUxNmZkOGVhNGE2MWQwMzA2ZGM.' of Response 1: Match Found
Jun 12 05:24:05 DEBUG[19990]: chan_sip.c:7042 check_user_full: Setting NAT on RTP to 524288
Jun 12 05:24:05 DEBUG[19990]: chan_sip.c:10354 handle_request_invite: Checking SIP call limits for device 1
Jun 12 05:24:05 DEBUG[19990]: chan_sip.c:6047 build_route: build_route: Contact hop: <sip:1@192.168.129.109:23420>
    -- Executing Goto("SIP/1-c229", "mainmenu|s|1") in new stack
    -- Goto (mainmenu,s,1)
    -- Executing GotoIfTime("SIP/1-c229", "*|*|1|jan?holiday|s|1") in new stack
    -- Executing GotoIfTime("SIP/1-c229", "*|*|4|jul?holiday|s|1") in new stack
    -- Executing GotoIfTime("SIP/1-c229", "17:00-23:59|*|24|nov?holiday|s|1") in new stack
    -- Executing GotoIfTime("SIP/1-c229", "*|*|25|nov?holiday|s|1") in new stack
    -- Executing GotoIfTime("SIP/1-c229", "17:00-23:59|*|24|dec?holiday|s|1") in new stack
    -- Executing GotoIfTime("SIP/1-c229", "*|*|25|dec?holiday|s|1") in new stack
    -- Executing GotoIfTime("SIP/1-c229", "07:00-18:59|mon-fri|*|*?day|s|1") in new stack
    -- Executing GotoIfTime("SIP/1-c229", "19:01-09:59|mon-fri|*|*?night|s|1") in new stack
    -- Goto (night,s,1)
    -- Executing Set("SIP/1-c229", "CALLERID(name)=Maxim Support") in new stack
    -- Executing Wait("SIP/1-c229", "2") in new stack
    -- Executing Answer("SIP/1-c229", "") in new stack
    -- Executing BackGround("SIP/1-c229", "night-msg") in new stack
    -- Playing 'night-msg' (language 'en')
Jun 12 05:24:07 DEBUG[20042]: chan_sip.c:2981 sip_rtp_read: Oooh, format changed to 4
Jun 12 05:24:07 DEBUG[19990]: chan_sip.c:1394 __sip_ack: Stopping retransmission on '3e2b0a3b6f277a29MDE4MjZkYzQzMjUzOGUxNmZkOGVhNGE2MWQwMzA2ZGM.' of Response 2: Match Found
Jun 12 05:24:09 DEBUG[20042]: pbx.c:2297 __ast_pbx_run: Oooh, got something to jump out with ('3')!
Jun 12 05:24:09 DEBUG[19990]: chan_sip.c:1394 __sip_ack: Stopping retransmission on '6958b5035db2778360af6d2a241d6c31@202.5.145.56' of Request 102: Match Found
Jun 12 05:24:09 DEBUG[19990]: chan_sip.c:1394 __sip_ack: Stopping retransmission on '5206abe84f8686496f9b2c6559105099@202.5.145.56' of Request 102: Match Found
Jun 12 05:24:09 DEBUG[19990]: chan_sip.c:10950 handle_request: That's odd...  Got a response on a call we dont know about. Cseq 102 Cmd SIP/2.0
Jun 12 05:24:13 DEBUG[19990]: chan_sip.c:1316 __sip_autodestruct: Auto destroying call '736e3b1f0e1be042MDE4MjZkYzQzMjUzOGUxNmZkOGVhNGE2MWQwMzA2ZGM.'
  == CDR updated on SIP/1-c229
    -- Executing Playback("SIP/1-c229", "quality") in new stack
    -- Playing 'quality' (language 'en')
Jun 12 05:24:14 DEBUG[19990]: chan_sip.c:1316 __sip_autodestruct: Auto destroying call 'bf749b783d2bd513MDE4MjZkYzQzMjUzOGUxNmZkOGVhNGE2MWQwMzA2ZGM.'
Jun 12 05:24:17 DEBUG[19990]: chan_sip.c:1316 __sip_autodestruct: Auto destroying call '89429d000179d109MDE4MjZkYzQzMjUzOGUxNmZkOGVhNGE2MWQwMzA2ZGM.'
    -- Executing Playback("SIP/1-c229", "please-wait") in new stack
Jun 12 05:24:18 WARNING[20042]: file.c:509 ast_openstream_full: File please-wait does not exist in any format
Jun 12 05:24:18 WARNING[20042]: file.c:821 ast_streamfile: Unable to open please-wait (format ulaw): No such file or directory
Jun 12 05:24:18 WARNING[20042]: app_playback.c:132 playback_exec: ast_streamfile failed on SIP/1-c229 for please-wait
    -- Executing SetMusicOnHold("SIP/1-c229", "default") in new stack
    -- Executing SetCallerID("SIP/1-c229", "3") in new stack
Jun 12 05:24:18 WARNING[20042]: pbx.c:1697 pbx_extension_helper: No application 'SetCallerIDName' for extension (night, 3, 5)
  == Spawn extension (night, 3, 5) exited non-zero on 'SIP/1-c229'
Jun 12 05:24:18 DEBUG[20042]: pbx.c:1519 pbx_substitute_variables_helper_full: Function result is '3'
Jun 12 05:24:18 DEBUG[20042]: pbx.c:1519 pbx_substitute_variables_helper_full: Function result is '3'
Jun 12 05:24:18 DEBUG[20042]: pbx.c:1519 pbx_substitute_variables_helper_full: Function result is '3'
Jun 12 05:24:18 DEBUG[20042]: pbx.c:1519 pbx_substitute_variables_helper_full: Function result is 'night'
Jun 12 05:24:18 DEBUG[20042]: pbx.c:1519 pbx_substitute_variables_helper_full: Function result is 'SIP/1-c229'
Jun 12 05:24:18 DEBUG[20042]: pbx.c:1519 pbx_substitute_variables_helper_full: Function result is '(null)'
Jun 12 05:24:18 DEBUG[20042]: pbx.c:1519 pbx_substitute_variables_helper_full: Function result is 'SetCallerID'
Jun 12 05:24:18 DEBUG[20042]: pbx.c:1519 pbx_substitute_variables_helper_full: Function result is '3'
Jun 12 05:24:18 DEBUG[20042]: pbx.c:1519 pbx_substitute_variables_helper_full: Function result is '2006-06-12 05:24:05'
Jun 12 05:24:18 DEBUG[20042]: pbx.c:1519 pbx_substitute_variables_helper_full: Function result is '2006-06-12 05:24:07'
Jun 12 05:24:18 DEBUG[20042]: pbx.c:1519 pbx_substitute_variables_helper_full: Function result is '2006-06-12 05:24:18'
Jun 12 05:24:18 DEBUG[20042]: pbx.c:1519 pbx_substitute_variables_helper_full: Function result is '13'
Jun 12 05:24:18 DEBUG[20042]: pbx.c:1519 pbx_substitute_variables_helper_full: Function result is '11'
Jun 12 05:24:18 DEBUG[20042]: pbx.c:1519 pbx_substitute_variables_helper_full: Function result is 'ANSWERED'
Jun 12 05:24:18 DEBUG[20042]: pbx.c:1519 pbx_substitute_variables_helper_full: Function result is 'DOCUMENTATION'
Jun 12 05:24:18 DEBUG[20042]: pbx.c:1519 pbx_substitute_variables_helper_full: Function result is '(null)'
Jun 12 05:24:18 DEBUG[20042]: pbx.c:1519 pbx_substitute_variables_helper_full: Function result is '1150104245.6'
Jun 12 05:24:18 DEBUG[20042]: pbx.c:1519 pbx_substitute_variables_helper_full: Function result is '(null)'
Jun 12 05:24:18 DEBUG[20042]: chan_sip.c:2419 sip_hangup: update_call_counter(1) - decrement call limit counter
Jun 12 05:24:18 DEBUG[19990]: chan_sip.c:1394 __sip_ack: Stopping retransmission on '3e2b0a3b6f277a29MDE4MjZkYzQzMjUzOGUxNmZkOGVhNGE2MWQwMzA2ZGM.' of Request 102: Match Found
mbox*CLI>