Here is the info I have been able to gather on the matter from /var/log/asterisk/messages. I have also provided an address to screenshots with my calltime and callmenu configurations. Telephone numbers have been changed for privacy. Certain lines have been removed since they were repetitive.
http://s1192.photobucket.com/albums/aa334/AlSam1/
[Oct 2 06:24:53] VERBOSE[2905]: [Oct 2 06:24:53] -- Accepting call from '787xxxxxxx' to '787xxxxxxx' on channel 0/1, span 1
[Oct 2 06:24:53] DEBUG[2905]: Enabled echo cancellation on channel 1
[Oct 2 06:24:53] VERBOSE[9634]: [Oct 2 06:24:53] -- Executing AGI("Zap/1-1", "agi-DID_route.agi") in new stack
[Oct 2 06:24:53] VERBOSE[9634]: [Oct 2 06:24:53] -- Launched AGI Script /var/lib/asterisk/agi-bin/agi-DID_route.agi
[Oct 2 06:24:53] DEBUG[2905]: Echo cancellation already on
[Oct 2 06:24:53] VERBOSE[9634]: [Oct 2 06:24:53] -- AGI Script agi-DID_route.agi completed, returning 0
[Oct 2 06:24:53] VERBOSE[9634]: [Oct 2 06:24:53] -- Executing AGI("Zap/1-1", "agi-VDAD_inbound_calltime_check.agi|CALLMENU-----YES-----InitCallMenu-----730am430pm-----INGROUP-----AftHrsVM-----CID|LB|998|Inbound|1") in new stack
[Oct 2 06:24:53] VERBOSE[9634]: [Oct 2 06:24:53] -- Launched AGI Script /var/lib/asterisk/agi-bin/agi-VDAD_inbound_calltime_check.agi
[Oct 2 06:24:53] DEBUG[9634]: Scheduling timer at 160 sample intervals
[Oct 2 06:24:53] DEBUG[9634]: Scheduling timer at 0 sample intervals
[Oct 2 06:24:53] DEBUG[9634]: Scheduling timer at 0 sample intervals
[Oct 2 06:24:53] DEBUG[9634]: Scheduling timer at 160 sample intervals
[Oct 2 06:24:53] DEBUG[9634]: Scheduling timer at 0 sample intervals
[Oct 2 06:24:53] DEBUG[9634]: Scheduling timer at 0 sample intervals
[Oct 2 06:24:53] VERBOSE[9634]: [Oct 2 06:24:53] -- AGI Script agi-VDAD_inbound_calltime_check.agi completed, returning 0
[Oct 2 06:24:53] VERBOSE[9634]: [Oct 2 06:24:53] -- Executing BackGround("Zap/1-1", "SaludoNew") in new stack
[Oct 2 06:24:53] DEBUG[2852]: Avoiding initial deadlock for 'Zap/1-1'
[Oct 2 06:24:53] DEBUG[9634]: Scheduling timer at 160 sample intervals
[Oct 2 06:24:53] VERBOSE[9634]: [Oct 2 06:24:53] -- Playing 'SaludoNew' (language 'en')
[Oct 2 06:24:53] DEBUG[2972]: Manager received command 'Command'
[Oct 2 06:24:57] DEBUG[9634]: Scheduling timer at 66 sample intervals
[Oct 2 06:24:57] DEBUG[9634]: Scheduling timer at 0 sample intervals
[Oct 2 06:24:57] DEBUG[9634]: Scheduling timer at 0 sample intervals
[Oct 2 06:24:57] VERBOSE[9634]: [Oct 2 06:24:57] -- Executing WaitExten("Zap/1-1", "1") in new stack
[Oct 2 06:24:57] DEBUG[2972]: Manager received command 'Command'
[Oct 2 06:24:58] DEBUG[2972]: Manager received command 'Command'
[Oct 2 06:24:58] VERBOSE[9634]: [Oct 2 06:24:58] -- Timeout on Zap/1-1, going to 't'
[Oct 2 06:24:58] VERBOSE[9634]: [Oct 2 06:24:58] -- Executing Goto("Zap/1-1", "CallCenter|s|1") in new stack
[Oct 2 06:24:58] VERBOSE[9634]: [Oct 2 06:24:58] -- Goto (CallCenter,s,1)
[Oct 2 06:24:58] VERBOSE[9634]: [Oct 2 06:24:58] -- Executing AGI("Zap/1-1", "agi-VDAD_inbound_calltime_check.agi|CALLMENU-----YES-----CallCenter--------------------") in new stack
[Oct 2 06:24:58] VERBOSE[9634]: [Oct 2 06:24:58] -- Launched AGI Script /var/lib/asterisk/agi-bin/agi-VDAD_inbound_calltime_check.agi
[Oct 2 06:24:58] DEBUG[9634]: Scheduling timer at 160 sample intervals
[Oct 2 06:24:58] DEBUG[9634]: Scheduling timer at 0 sample intervals
[Oct 2 06:24:58] DEBUG[9634]: Scheduling timer at 0 sample intervals
[Oct 2 06:24:58] DEBUG[9634]: Scheduling timer at 160 sample intervals
[Oct 2 06:24:58] DEBUG[9634]: Scheduling timer at 0 sample intervals
[Oct 2 06:24:58] DEBUG[9634]: Scheduling timer at 0 sample intervals
[Oct 2 06:24:58] VERBOSE[9634]: [Oct 2 06:24:58] -- AGI Script agi-VDAD_inbound_calltime_check.agi completed, returning 0
[Oct 2 06:24:58] VERBOSE[9634]: [Oct 2 06:24:58] -- Executing BackGround("Zap/1-1", "MainMenuNew") in new stack
[Oct 2 06:24:58] DEBUG[9634]: Scheduling timer at 160 sample intervals
[Oct 2 06:24:58] VERBOSE[9634]: [Oct 2 06:24:58] -- Playing 'MainMenuNew' (language 'en')
[Oct 2 06:24:58] DEBUG[2972]: Manager received command 'Command'
[Oct 2 06:25:01] DEBUG[9682]: Manager received command 'Login'
[Oct 2 06:25:01] VERBOSE[9682]: [Oct 2 06:25:01] == Parsing '/etc/asterisk/manager.conf': [Oct 2 06:25:01] VERBOSE[9682]: [Oct 2 06:25:01] == Parsing '/etc/asterisk/manager.conf': [Oct 2 06:25:01] Found
[Oct 2 06:25:01] VERBOSE[9682]: [Oct 2 06:25:01] == Manager 'sendcron' logged on from 127.0.0.1
[Oct 2 06:25:01] DEBUG[9682]: Manager received command 'Command'
[Oct 2 06:25:01] DEBUG[9682]: Manager received command 'Ping'
[Oct 2 06:25:01] DEBUG[9686]: Manager received command 'Login'
[Oct 2 06:25:01] VERBOSE[9686]: [Oct 2 06:25:01] == Parsing '/etc/asterisk/manager.conf': [Oct 2 06:25:01] VERBOSE[9686]: [Oct 2 06:25:01] == Parsing '/etc/asterisk/manager.conf': [Oct 2 06:25:01] Found
[Oct 2 06:25:01] VERBOSE[9686]: [Oct 2 06:25:01] == Manager 'sendcron' logged on from 127.0.0.1
[Oct 2 06:25:01] DEBUG[9686]: Manager received command 'MailboxCount'
[Oct 2 06:25:01] DEBUG[9686]: Manager received command 'Ping'
[Oct 2 06:25:01] DEBUG[2972]: Manager received command 'Command'
[Oct 2 06:25:01] DEBUG[9686]: Manager received command 'MailboxCount'
[Oct 2 06:25:01] DEBUG[9686]: Manager received command 'Ping'
[Oct 2 06:25:01] DEBUG[9682]: Manager received command 'Logoff'
[Oct 2 06:25:01] VERBOSE[9682]: [Oct 2 06:25:01] == Manager 'sendcron' logged off from 127.0.0.1
[Oct 2 06:25:06] DEBUG[9686]: Manager received command 'MailboxCount'
[Oct 2 06:25:06] DEBUG[9686]: Manager received command 'Ping'
[Oct 2 06:25:06] DEBUG[9697]: Manager received command 'Login'
[Oct 2 06:25:06] VERBOSE[9697]: [Oct 2 06:25:06] == Parsing '/etc/asterisk/manager.conf': [Oct 2 06:25:06] VERBOSE[9697]: [Oct 2 06:25:06] == Parsing '/etc/asterisk/manager.conf': [Oct 2 06:25:06] Found
[Oct 2 06:25:06] VERBOSE[9697]: [Oct 2 06:25:06] == Manager 'sendcron' logged on from 127.0.0.1
[Oct 2 06:25:06] DEBUG[9697]: Manager received command 'Command'
[Oct 2 06:25:06] DEBUG[9697]: Manager received command 'Ping'
[Oct 2 06:25:06] DEBUG[9686]: Manager received command 'MailboxCount'
[Oct 2 06:25:06] DEBUG[9686]: Manager received command 'Ping'
[Oct 2 06:25:06] DEBUG[9686]: Manager received command 'MailboxCount'
[Oct 2 06:25:06] DEBUG[9686]: Manager received command 'Ping'
[Oct 2 06:25:06] DEBUG[9697]: Manager received command 'Logoff'
[Oct 2 06:25:06] VERBOSE[9697]: [Oct 2 06:25:06] == Manager 'sendcron' logged off from 127.0.0.1
[Oct 2 06:25:06] DEBUG[9686]: Manager received command 'MailboxCount'
[Oct 2 06:25:06] DEBUG[9686]: Manager received command 'Ping'
[Oct 2 06:25:07] VERBOSE[2905]: [Oct 2 06:25:07] -- Channel 0/1, span 1 got hangup request, cause 16