Hi,
We use vicidial_conference start from 8600051 to 8600299 for our conference . We set In-group as DID Destination. This In-group has many agents assigned.
Please check below log for that delay in call.
When Inbound calls landed on vicidial
[Mar 13 16:10:42] VERBOSE[3503] sig_pri.c: [Mar 13 16:10:42] -- Accepting call from '23930200' to '33832803' on channel 0/27, span 2
[Mar 13 16:10:42] VERBOSE[16990] pbx.c: [Mar 13 16:10:42] -- Executing [33832803@from-pstn:1] AGI("DAHDI/i2/23930200-4df", "agi-DID_route.agi") in new stack
[Mar 13 16:10:42] VERBOSE[16990] res_agi.c: [Mar 13 16:10:42] -- Launched AGI Script /var/lib/asterisk/agi-bin/agi-DID_route.agi
[Mar 13 16:10:42] VERBOSE[16696] res_musiconhold.c: [Mar 13 16:10:42] -- Stopped music on hold on DAHDI/i2/23930200-4de
[Mar 13 16:10:42] VERBOSE[16696] res_agi.c: [Mar 13 16:10:42] -- Playing 'sip-silence' (escape_digits=) (sample_offset 0)
[Mar 13 16:10:42] VERBOSE[16696] res_agi.c: [Mar 13 16:10:42] -- Playing 'sip-silence' (escape_digits=) (sample_offset 0)
[Mar 13 16:10:42] VERBOSE[16990] res_agi.c: [Mar 13 16:10:42] -- <DAHDI/i2/23930200-4df>AGI Script agi-DID_route.agi completed, returning 0
[Mar 13 16:10:42] VERBOSE[16990] pbx.c: [Mar 13 16:10:42] -- Executing [99909*8***DID@default:1] Answer("DAHDI/i2/23930200-4df", "") in new stack
[Mar 13 16:10:42] VERBOSE[16696] res_agi.c: [Mar 13 16:10:42] -- Playing 'sip-silence' (escape_digits=) (sample_offset 0)
[Mar 13 16:10:42] VERBOSE[16990] pbx.c: [Mar 13 16:10:42] -- Executing [99909*8***DID@default:2] AGI("DAHDI/i2/23930200-4df", "agi-VDAD_ALL_inbound.agi") in new stack
[Mar 13 16:10:42] VERBOSE[16990] res_agi.c: [Mar 13 16:10:42] -- Launched AGI Script /var/lib/asterisk/agi-bin/agi-VDAD_ALL_inbound.agi
[Mar 13 16:10:42] VERBOSE[16696] res_agi.c: [Mar 13 16:10:42] -- Playing 'generic_hold' (escape_digits=) (sample_offset 0)
[Mar 13 16:10:42] VERBOSE[16990] res_agi.c: [Mar 13 16:10:42] -- Playing 'sip-silence' (escape_digits=) (sample_offset 0)
[Mar 13 16:10:42] VERBOSE[16990] res_agi.c: [Mar 13 16:10:42] -- Playing 'sip-silence' (escape_digits=) (sample_offset 0)
[Mar 13 16:10:44] VERBOSE[16990] res_musiconhold.c: [Mar 13 16:10:44] -- Started music on hold, class 'default', on DAHDI/i2/23930200-4df
[Mar 13 16:10:47] VERBOSE[16990] res_musiconhold.c: [Mar 13 16:10:47] -- Stopped music on hold on DAHDI/i2/23930200-4df
[Mar 13 16:10:47] VERBOSE[16990] res_agi.c: [Mar 13 16:10:47] -- Playing 'sip-silence' (escape_digits=) (sample_offset 0)
[Mar 13 16:10:47] VERBOSE[16990] res_agi.c: [Mar 13 16:10:47] -- Playing 'sip-silence' (escape_digits=) (sample_offset 0)
[Mar 13 16:10:47] VERBOSE[16990] res_agi.c: [Mar 13 16:10:47] -- Playing 'sip-silence' (escape_digits=) (sample_offset 0)
[Mar 13 16:10:47] VERBOSE[16990] res_agi.c: [Mar 13 16:10:47] -- Playing 'generic_hold' (escape_digits=) (sample_offset 0)
[Mar 13 16:10:53] VERBOSE[16990] res_musiconhold.c: [Mar 13 16:10:53] -- Started music on hold, class 'default', on DAHDI/i2/23930200-4df
[Mar 13 16:11:54] VERBOSE[16990] res_musiconhold.c: [Mar 13 16:11:54] -- Stopped music on hold on DAHDI/i2/23930200-4df
[Mar 13 16:11:54] VERBOSE[16990] res_agi.c: [Mar 13 16:11:54] -- Playing 'sip-silence' (escape_digits=) (sample_offset 0)
[Mar 13 16:11:54] VERBOSE[16990] res_agi.c: [Mar 13 16:11:54] -- Playing 'sip-silence' (escape_digits=) (sample_offset 0)
[Mar 13 16:11:54] VERBOSE[16990] res_agi.c: [Mar 13 16:11:54] -- Playing 'sip-silence' (escape_digits=) (sample_offset 0)
[Mar 13 16:11:54] VERBOSE[16990] res_agi.c: [Mar 13 16:11:54] -- Playing 'generic_hold' (escape_digits=) (sample_offset 0)
[Mar 13 16:12:00] VERBOSE[16990] res_musiconhold.c: [Mar 13 16:12:00] -- Started music on hold, class 'default', on DAHDI/i2/23930200-4df
[Mar 13 16:13:02] VERBOSE[16990] res_musiconhold.c: [Mar 13 16:13:02] -- Stopped music on hold on DAHDI/i2/23930200-4df
[Mar 13 16:13:02] VERBOSE[16990] res_agi.c: [Mar 13 16:13:02] -- Playing 'sip-silence' (escape_digits=) (sample_offset 0)
[Mar 13 16:13:02] VERBOSE[16990] res_agi.c: [Mar 13 16:13:02] -- Playing 'sip-silence' (escape_digits=) (sample_offset 0)
[Mar 13 16:13:02] VERBOSE[16990] res_agi.c: [Mar 13 16:13:02] -- Playing 'sip-silence' (escape_digits=) (sample_offset 0)
[Mar 13 16:13:02] VERBOSE[16990] res_agi.c: [Mar 13 16:13:02] -- Playing 'generic_hold' (escape_digits=) (sample_offset 0)
[Mar 13 16:13:08] VERBOSE[16990] res_musiconhold.c: [Mar 13 16:13:08] -- Started music on hold, class 'default', on DAHDI/i2/23930200-4df
[Mar 13 16:14:10] VERBOSE[16990] res_musiconhold.c: [Mar 13 16:14:10] -- Stopped music on hold on DAHDI/i2/23930200-4df
[Mar 13 16:14:10] VERBOSE[16990] res_agi.c: [Mar 13 16:14:10] -- Playing 'sip-silence' (escape_digits=) (sample_offset 0)
[Mar 13 16:14:10] VERBOSE[16990] res_agi.c: [Mar 13 16:14:10] -- Playing 'sip-silence' (escape_digits=) (sample_offset 0)
[Mar 13 16:14:10] VERBOSE[16990] res_agi.c: [Mar 13 16:14:10] -- Playing 'sip-silence' (escape_digits=) (sample_offset 0)
[Mar 13 16:14:10] VERBOSE[16990] res_agi.c: [Mar 13 16:14:10] -- Playing 'generic_hold' (escape_digits=) (sample_offset 0)
[Mar 13 16:13:08] VERBOSE[16990] res_musiconhold.c: [Mar 13 16:13:08] -- Started music on hold, class 'default', on DAHDI/i2/23930200-4df
[Mar 13 16:14:10] VERBOSE[16990] res_musiconhold.c: [Mar 13 16:14:10] -- Stopped music on hold on DAHDI/i2/23930200-4df
[Mar 13 16:14:10] VERBOSE[16990] res_agi.c: [Mar 13 16:14:10] -- Playing 'sip-silence' (escape_digits=) (sample_offset 0)
[Mar 13 16:14:10] VERBOSE[16990] res_agi.c: [Mar 13 16:14:10] -- Playing 'sip-silence' (escape_digits=) (sample_offset 0)
[Mar 13 16:14:10] VERBOSE[16990] res_agi.c: [Mar 13 16:14:10] -- Playing 'sip-silence' (escape_digits=) (sample_offset 0)
[Mar 13 16:14:10] VERBOSE[16990] res_agi.c: [Mar 13 16:14:10] -- Playing 'generic_hold' (escape_digits=) (sample_offset 0)
[Mar 13 16:14:16] VERBOSE[16990] res_musiconhold.c: [Mar 13 16:14:16] -- Started music on hold, class 'default', on DAHDI/i2/23930200-4df
[Mar 13 16:14:26] VERBOSE[16990] res_musiconhold.c: [Mar 13 16:14:26] -- Stopped music on hold on DAHDI/i2/23930200-4df
[Mar 13 16:14:26] VERBOSE[16990] res_agi.c: [Mar 13 16:14:26] -- Playing 'sip-silence' (escape_digits=) (sample_offset 0)
[Mar 13 16:14:26] VERBOSE[16990] res_agi.c: [Mar 13 16:14:26] -- Playing 'sip-silence' (escape_digits=) (sample_offset 0)
[Mar 13 16:14:27] VERBOSE[16990] res_agi.c: [Mar 13 16:14:27] -- <DAHDI/i2/23930200-4df>AGI Script agi-VDAD_ALL_inbound.agi completed, returning 0
[Mar 13 16:14:27] VERBOSE[16990] pbx.c: [Mar 13 16:14:27] -- Executing [192*168*001*248*8600057@default:1] Goto("DAHDI/i2/23930200-4df", "default,8600057,1") in new stack
[Mar 13 16:14:27] VERBOSE[16990] pbx.c: [Mar 13 16:14:27] -- Goto (default,8600057,1)
[Mar 13 16:14:27] VERBOSE[16990] pbx.c: [Mar 13 16:14:27] -- Executing [8600057@default:1] MeetMe("DAHDI/i2/23930200-4df", "8600057,F") in new stack
2nd call log
Mar 13 16:10:23] VERBOSE[16010] pbx.c: [Mar 13 16:10:23] -- Executing [8600057@default:1] MeetMe("SIP/cc104-00000060", "8600057,F") in new stack
[Mar 13 16:10:23] VERBOSE[16010] config.c: [Mar 13 16:10:23] == Parsing '/etc/asterisk/meetme.conf': [Mar 13 16:10:23] VERBOSE[16010] config.c: [Mar 13 16:10:23] == Found
[Mar 13 16:10:23] VERBOSE[16010] config.c: [Mar 13 16:10:23] == Parsing '/etc/asterisk/meetme-vicidial.conf': [Mar 13 16:10:23] VERBOSE[16010] config.c: [Mar 13 16:10:23] == Found
[Mar 13 16:10:23] VERBOSE[16010] app_meetme.c: [Mar 13 16:10:23] -- Created MeetMe conference 1019 for conference '8600057'
[Mar 13 16:10:23] VERBOSE[16010] file.c: [Mar 13 16:10:23] -- <SIP/cc104-00000060> Playing 'conf-onlyperson.ulaw' (language 'en')
[Mar 13 16:14:25] VERBOSE[27737] pbx.c: [Mar 13 16:14:25] -- Executing [192*168*001*248*78600057@default:1] Goto("Local/192*168*001*248*78600057@default-00000802;2", "default,78600057,1") in new stack
[Mar 13 16:14:25] VERBOSE[27737] pbx.c: [Mar 13 16:14:25] -- Goto (default,78600057,1)
[Mar 13 16:14:25] VERBOSE[27737] pbx.c: [Mar 13 16:14:25] -- Executing [h@default:1] AGI("Local/192*168*001*248*78600057@default-00000802;2", "agi://127.0.0.1:4577/call_log--HVcauses--PRI-----NODEBUG-----0---------------") in new stack
[Mar 13 16:14:25] VERBOSE[27737] res_agi.c: [Mar 13 16:14:25] -- <Local/192*168*001*248*78600057@default-00000802;2>AGI Script
agi://127.0.0.1:4577/call_log--HVcauses ... ---------- completed, returning 0
[Mar 13 16:14:34] VERBOSE[28137] pbx.c: [Mar 13 16:14:34] -- Executing [58600057@default:1] MeetMe("Local/58600057@default-00000805;2", "8600057,Fmq") in new stack
[Mar 13 16:14:34] VERBOSE[28136] pbx.c: [Mar 13 16:14:34] > Channel Local/58600057@default-00000805;1 was answered.
[Mar 13 16:14:34] VERBOSE[28138] pbx.c: [Mar 13 16:14:34] -- Executing [8310@default:1] Answer("Local/58600057@default-00000805;1", "") in new stack
[Mar 13 16:14:34] VERBOSE[28138] pbx.c: [Mar 13 16:14:34] -- Executing [8310@default:2] Monitor("Local/58600057@default-00000805;1", "gsm,20140313-161433_23930200_101") in new stack
[Mar 13 16:14:34] VERBOSE[28138] pbx.c: [Mar 13 16:14:34] -- Executing [8310@default:3] Wait("Local/58600057@default-00000805;1", "3600") in new stack
hangup log
[Mar 13 16:28:27] VERBOSE[16990] pbx.c: [Mar 13 16:28:27] == Spawn extension (default, 8600057, 1) exited non-zero on 'DAHDI/i2/23930200-4df'
[Mar 13 16:28:27] VERBOSE[16990] pbx.c: [Mar 13 16:28:27] -- Executing [h@default:1] AGI("DAHDI/i2/23930200-4df", "agi://127.0.0.1:4577/call_log--HVcauses--PRI-----NODEBUG-----16---------------") in new stack
[Mar 13 16:28:27] VERBOSE[16990] res_agi.c: [Mar 13 16:28:27] -- <DAHDI/i2/23930200-4df>AGI Script
agi://127.0.0.1:4577/call_log--HVcauses ... ---------- completed, returning 0
[Mar 13 16:28:27] VERBOSE[16990] chan_dahdi.c: [Mar 13 16:28:27] -- Hungup 'DAHDI/i2/23930200-4df'
I have set '5' in "Recording Delay".