[Oct  1 17:28:36] VERBOSE[23316] logger.c: AGI Rx << EXEC Dial Local/701@parkedcalls/n|600|ot
[Oct  1 17:28:36] VERBOSE[23316] logger.c:     -- AGI Script Executing Application: (Dial) Options: (Local/701@parkedcalls/n|600|ot)
[Oct  1 17:28:36] DEBUG[23316] rtp.c: Channel 'Local/701@parkedcalls-b6d9,1' has no RTP, not doing anything
[Oct  1 17:28:36] DEBUG[23316] channel.c: Copying hard-transferable variable ENSWITCH-PRESENTATION.
[Oct  1 17:28:36] DEBUG[23316] channel.c: Copying hard-transferable variable ENSWITCH-DNUMBER.
[Oct  1 17:28:36] DEBUG[23316] channel.c: Copying hard-transferable variable ENSWITCH-DTYPE.
[Oct  1 17:28:36] DEBUG[23316] channel.c: Copying hard-transferable variable ENSWITCH-DCUSTOMER.
[Oct  1 17:28:36] DEBUG[23316] channel.c: Copying hard-transferable variable ENSWITCH-MUSIC.
[Oct  1 17:28:36] DEBUG[23316] channel.c: Copying hard-transferable variable TRANSFER_CONTEXT.
[Oct  1 17:28:36] DEBUG[23316] channel.c: Copying hard-transferable variable ENSWITCH-CALLID.
[Oct  1 17:28:36] DEBUG[23316] channel.c: Not copying variable SIPCALLID.
[Oct  1 17:28:36] DEBUG[23316] channel.c: Not copying variable SIPUSERAGENT.
[Oct  1 17:28:36] DEBUG[23316] channel.c: Not copying variable SIPDOMAIN.
[Oct  1 17:28:36] DEBUG[23316] channel.c: Not copying variable SIPURI.
[Oct  1 17:28:36] VERBOSE[23316] logger.c:     -- Called 701@parkedcalls/n
[Oct  1 17:28:36] DEBUG[23317] pbx.c: Launching 'ParkedCall'
[Oct  1 17:28:36] VERBOSE[23317] logger.c:     -- Executing [701@parkedcalls:1] ParkedCall("Local/701@parkedcalls-b6d9,2", "701") in new s
tack
[Oct  1 17:28:36] DEBUG[23317] res_features.c: Notification of state change to metermaids 701@parkedcalls
[Oct  1 17:28:36] DEBUG[23317] devicestate.c: Notification of state change to be queued on device/channel park:701@parkedcalls
[Oct  1 17:28:36] DEBUG[4927] devicestate.c: Checking if I can find provider for "park" - number: 701@parkedcalls
[Oct  1 17:28:36] DEBUG[4927] devicestate.c: Checking provider SLA with park
[Oct  1 17:28:36] DEBUG[4927] devicestate.c: Checking provider Meetme with park
[Oct  1 17:28:36] DEBUG[4927] devicestate.c: Checking provider Park with park
[Oct  1 17:28:36] DEBUG[4927] res_features.c: Checking state of exten 701 in context parkedcalls
[Oct  1 17:28:36] DEBUG[4927] devicestate.c: Changing state for park:701@parkedcalls - state 1 (Not in use)
[Oct  1 17:28:36] DEBUG[23317] devicestate.c: Notification of state change to be queued on device/channel Local/701@parkedcalls-b6d9,2
[Oct  1 17:28:36] DEBUG[4927] devicestate.c: No provider found, checking channel drivers for Local - 701@parkedcalls-b6d9,2
[Oct  1 17:28:36] DEBUG[4927] chan_local.c: Checking if extension 701@parkedcalls-b6d9,2 exists (devicestate)
[Oct  1 17:28:36] DEBUG[4927] devicestate.c: Changing state for Local/701@parkedcalls-b6d9,2 - state 4 (Invalid)
[Oct  1 17:28:36] DEBUG[23317] devicestate.c: Notification of state change to be queued on device/channel Local/701@parkedcalls
[Oct  1 17:28:36] DEBUG[4943] app_queue.c: Device 'Local/701@parkedcalls-b6d9,2' changed to state '4' (Invalid) but we don't care because 
they're not a member of any queue.
[Oct  1 17:28:36] DEBUG[4927] devicestate.c: No provider found, checking channel drivers for Local - 701@parkedcalls
[Oct  1 17:28:36] DEBUG[4927] chan_local.c: Checking if extension 701@parkedcalls exists (devicestate)
[Oct  1 17:28:36] DEBUG[4927] devicestate.c: Changing state for Local/701@parkedcalls - state 4 (Invalid)
[Oct  1 17:28:36] VERBOSE[23317] logger.c:     -- Stopped music on hold on Local/*7@from-internal-0e98,2
[Oct  1 17:28:36] DEBUG[4943] app_queue.c: Device 'Local/701@parkedcalls' changed to state '4' (Invalid) but we don't care because they're
 not a member of any queue.
[Oct  1 17:28:36] DEBUG[23317] channel.c: Set channel Local/*7@from-internal-0e98,2 to write format ulaw
[Oct  1 17:28:36] DEBUG[23317] channel.c: Scheduling timer at 0 sample intervals
[Oct  1 17:28:36] VERBOSE[23317] logger.c:     -- Channel Local/701@parkedcalls-b6d9,2 connected to parked call 701
[Oct  1 17:28:36] DEBUG[4984] channel.c: Internal timing is enabled (option_internal_timing=1048576 chan->timingfd=27)
[Oct  1 17:28:36] DEBUG[23316] devicestate.c: Notification of state change to be queued on device/channel Local/701@parkedcalls-b6d9,1
[Oct  1 17:28:36] DEBUG[4927] devicestate.c: No provider found, checking channel drivers for Local - 701@parkedcalls-b6d9,1
[Oct  1 17:28:36] DEBUG[4927] chan_local.c: Checking if extension 701@parkedcalls-b6d9,1 exists (devicestate)
[Oct  1 17:28:36] DEBUG[4927] devicestate.c: Changing state for Local/701@parkedcalls-b6d9,1 - state 4 (Invalid)
[Oct  1 17:28:36] DEBUG[23316] devicestate.c: Notification of state change to be queued on device/channel Local/701@parkedcalls
[Oct  1 17:28:36] DEBUG[4943] app_queue.c: Device 'Local/701@parkedcalls-b6d9,1' changed to state '4' (Invalid) but we don't care because 
they're not a member of any queue.
[Oct  1 17:28:36] DEBUG[4927] devicestate.c: No provider found, checking channel drivers for Local - 701@parkedcalls
[Oct  1 17:28:36] DEBUG[4927] chan_local.c: Checking if extension 701@parkedcalls exists (devicestate)
[Oct  1 17:28:36] DEBUG[4927] devicestate.c: Changing state for Local/701@parkedcalls - state 4 (Invalid)
[Oct  1 17:28:36] DEBUG[4943] app_queue.c: Device 'Local/701@parkedcalls' changed to state '4' (Invalid) but we don't care because they're
 not a member of any queue.
[Oct  1 17:28:36] VERBOSE[23316] logger.c:     -- Local/701@parkedcalls-b6d9,1 answered SIP/66.1.1.229-168271b0
[Oct  1 17:28:36] DEBUG[23316] devicestate.c: Notification of state change to be queued on device/channel SIP/66.1.1.229-168271b0
[Oct  1 17:28:36] DEBUG[4927] devicestate.c: No provider found, checking channel drivers for SIP - 66.1.1.229-168271b0
[Oct  1 17:28:36] DEBUG[4927] chan_sip.c: Checking device state for peer 66.1.1.229-168271b0
[Oct  1 17:28:36] DEBUG[4927] res_config_mysql.c: MySQL RealTime: Everything is fine.
[Oct  1 17:28:36] DEBUG[4927] res_config_mysql.c: MySQL RealTime: Retrieve SQL: SELECT * FROM sippeers WHERE name = '66.1.1.229-168271
b0' AND host = 'dynamic'
[Oct  1 17:28:36] DEBUG[4927] res_config_mysql.c: MySQL RealTime: Everything is fine.
[Oct  1 17:28:36] DEBUG[4927] res_config_mysql.c: MySQL RealTime: Retrieve SQL: SELECT * FROM sippeers WHERE name = '66.1.1.229-168271
b0'
[Oct  1 17:28:36] DEBUG[23316] devicestate.c: Notification of state change to be queued on device/channel SIP/66.1.1.229
[Oct  1 17:28:36] DEBUG[23316] chan_sip.c: SIP answering channel: SIP/66.1.1.229-168271b0
[Oct  1 17:28:36] DEBUG[23316] chan_sip.c: Setting framing from config on incoming call
[Oct  1 17:28:36] DEBUG[23316] chan_sip.c: ** Our capability: 0xc (ulaw|alaw) Video flag: True
[Oct  1 17:28:36] DEBUG[23316] chan_sip.c: ** Our prefcodec: 0x0 (nothing) 
[Oct  1 17:28:36] DEBUG[23316] chan_sip.c: -- Done with adding codecs to SDP
[Oct  1 17:28:36] DEBUG[23316] channel.c: Internal timing is enabled (option_internal_timing=1048576 chan->timingfd=36)
[Oct  1 17:28:36] DEBUG[23316] chan_sip.c: Done building SDP. Settling with this capability: 0xc (ulaw|alaw)
[Oct  1 17:28:36] DEBUG[4927] devicestate.c: Changing state for SIP/66.1.1.229-168271b0 - state 4 (Invalid)
[Oct  1 17:28:36] DEBUG[4927] devicestate.c: No provider found, checking channel drivers for SIP - 66.1.1.229
[Oct  1 17:28:36] DEBUG[4943] app_queue.c: Device 'SIP/66.1.1.229-168271b0' changed to state '4' (Invalid) but we don't care because t
hey're not a member of any queue.
[Oct  1 17:28:36] DEBUG[4927] chan_sip.c: Checking device state for peer 66.1.1.229
[Oct  1 17:28:36] DEBUG[4927] devicestate.c: Changing state for SIP/66.1.1.229 - state 1 (Not in use)
[Oct  1 17:28:36] DEBUG[4943] app_queue.c: Device 'SIP/66.1.1.229' changed to state '1' (Not in use) but we don't care because they're
 not a member of any queue.
[Oct  1 17:28:36] DEBUG[4984] channel.c: Internal timing is enabled (option_internal_timing=1048576 chan->timingfd=27)
[Oct  1 17:28:36] DEBUG[4984] channel.c: Internal timing is enabled (option_internal_timing=1048576 chan->timingfd=27)
[Oct  1 17:28:36] DEBUG[4984] channel.c: Internal timing is enabled (option_internal_timing=1048576 chan->timingfd=27)
[Oct  1 17:28:37] DEBUG[4984] channel.c: Internal timing is enabled (option_internal_timing=1048576 chan->timingfd=27)
[Oct  1 17:28:37] DEBUG[4984] channel.c: Internal timing is enabled (option_internal_timing=1048576 chan->timingfd=27)
[Oct  1 17:28:37] DEBUG[4984] channel.c: Internal timing is enabled (option_internal_timing=1048576 chan->timingfd=27)
[Oct  1 17:28:37] DEBUG[4984] channel.c: Internal timing is enabled (option_internal_timing=1048576 chan->timingfd=27)
[Oct  1 17:28:37] DEBUG[4984] channel.c: Internal timing is enabled (option_internal_timing=1048576 chan->timingfd=27)
[Oct  1 17:28:37] DEBUG[4984] channel.c: Internal timing is enabled (option_internal_timing=1048576 chan->timingfd=27)
[Oct  1 17:28:37] DEBUG[4984] channel.c: Internal timing is enabled (option_internal_timing=1048576 chan->timingfd=27)
[Oct  1 17:28:37] DEBUG[4984] channel.c: Internal timing is enabled (option_internal_timing=1048576 chan->timingfd=27)
[Oct  1 17:28:37] DEBUG[4984] channel.c: Internal timing is enabled (option_internal_timing=1048576 chan->timingfd=27)
[Oct  1 17:28:37] DEBUG[4984] channel.c: Internal timing is enabled (option_internal_timing=1048576 chan->timingfd=27)
[Oct  1 17:28:37] DEBUG[4984] channel.c: Internal timing is enabled (option_internal_timing=1048576 chan->timingfd=27)
[Oct  1 17:28:37] DEBUG[4984] channel.c: Internal timing is enabled (option_internal_timing=1048576 chan->timingfd=27)
[Oct  1 17:28:37] DEBUG[4984] channel.c: Internal timing is enabled (option_internal_timing=1048576 chan->timingfd=27)
[Oct  1 17:28:37] DEBUG[4984] channel.c: Internal timing is enabled (option_internal_timing=1048576 chan->timingfd=27)
[Oct  1 17:28:37] DEBUG[4984] channel.c: Internal timing is enabled (option_internal_timing=1048576 chan->timingfd=27)
[Oct  1 17:28:37] DEBUG[4984] channel.c: Internal timing is enabled (option_internal_timing=1048576 chan->timingfd=27)
[Oct  1 17:28:37] DEBUG[4984] channel.c: Internal timing is enabled (option_internal_timing=1048576 chan->timingfd=27)
[Oct  1 17:28:37] DEBUG[4984] channel.c: Internal timing is enabled (option_internal_timing=1048576 chan->timingfd=27)
[Oct  1 17:28:37] DEBUG[4984] channel.c: Internal timing is enabled (option_internal_timing=1048576 chan->timingfd=27)
[Oct  1 17:28:37] DEBUG[4984] channel.c: Internal timing is enabled (option_internal_timing=1048576 chan->timingfd=27)
[Oct  1 17:28:37] DEBUG[4984] channel.c: Internal timing is enabled (option_internal_timing=1048576 chan->timingfd=27)
[Oct  1 17:28:37] DEBUG[4984] channel.c: Internal timing is enabled (option_internal_timing=1048576 chan->timingfd=27)
[Oct  1 17:28:37] DEBUG[4984] channel.c: Internal timing is enabled (option_internal_timing=1048576 chan->timingfd=27)
[Oct  1 17:28:37] DEBUG[4984] channel.c: Internal timing is enabled (option_internal_timing=1048576 chan->timingfd=27)
[Oct  1 17:28:37] DEBUG[4984] channel.c: Internal timing is enabled (option_internal_timing=1048576 chan->timingfd=27)
[Oct  1 17:28:37] DEBUG[4984] channel.c: Internal timing is enabled (option_internal_timing=1048576 chan->timingfd=27)
[Oct  1 17:28:37] DEBUG[4984] channel.c: Internal timing is enabled (option_internal_timing=1048576 chan->timingfd=27)
[Oct  1 17:28:37] DEBUG[4984] channel.c: Internal timing is enabled (option_internal_timing=1048576 chan->timingfd=27)
[Oct  1 17:28:37] DEBUG[4984] channel.c: Internal timing is enabled (option_internal_timing=1048576 chan->timingfd=27)
[Oct  1 17:28:37] DEBUG[4984] channel.c: Internal timing is enabled (option_internal_timing=1048576 chan->timingfd=27)
[Oct  1 17:28:37] DEBUG[4984] channel.c: Internal timing is enabled (option_internal_timing=1048576 chan->timingfd=27)
[Oct  1 17:28:37] DEBUG[4984] channel.c: Internal timing is enabled (option_internal_timing=1048576 chan->timingfd=27)
[Oct  1 17:28:37] DEBUG[4984] channel.c: Internal timing is enabled (option_internal_timing=1048576 chan->timingfd=27)