[Sep 27 11:34:54]     -- Starting simple switch on 'Zap/4-1'
[Sep 27 11:34:59]     -- Executing NoOp("Zap/4-1", "Reached DID s") in new stack
[Sep 27 11:34:59]     -- Executing Goto("Zap/4-1", "2788269|1") in new stack
[Sep 27 11:34:59]     -- Goto (incomingroute,2788269,1)
[Sep 27 11:34:59]     -- Executing NoOp("Zap/4-1", "Reached DID 2788269") in new stack
[Sep 27 11:34:59]     -- Executing Answer("Zap/4-1", "") in new stack
[Sep 27 11:34:59]     -- Executing Macro("Zap/4-1", "stdexten|105|SIP/105") in new stack
[Sep 27 11:34:59]     -- Executing NoOp("Zap/4-1", "extension s@") in new stack
[Sep 27 11:34:59]     -- Executing Dial("Zap/4-1", "SIP/105|20") in new stack
[Sep 27 11:34:59]     -- Called 105
[Sep 27 11:35:00]     -- SIP/105-260f is ringing
[Sep 27 11:35:00]     -- SIP/105-260f is ringing
[Sep 27 11:35:01] WARNING[8067]: chan_zap.c:3860 zt_handle_event: Ring/Off-hook in strange state 6 on channel 4
[Sep 27 11:35:20]     -- Nobody picked up in 20000 ms
[Sep 27 11:35:20]     -- Executing Goto("Zap/4-1", "s-NOANSWER|1") in new stack
[Sep 27 11:35:20]     -- Goto (macro-stdexten,s-NOANSWER,1)
[Sep 27 11:35:20]     -- Executing GotoIf("Zap/4-1", "0?2:3") in new stack
[Sep 27 11:35:20]     -- Goto (macro-stdexten,s-NOANSWER,3)
[Sep 27 11:35:20]     -- Executing VoiceMail("Zap/4-1", "u105") in new stack
[Sep 27 11:35:20]     -- Playing '/var/spool/asterisk/voicemail/default/105/unavail' (language 'en')
[Sep 27 11:35:35]     -- Playing 'vm-intro' (language 'en')
[Sep 27 11:35:41]     -- Playing 'beep' (language 'en')
[Sep 27 11:35:41]     -- Recording the message
[Sep 27 11:35:41]     -- x=0, open writing:  /var/spool/asterisk/voicemail/default/105/INBOX/msg0000 format: gsm, 0x86628a8
[Sep 27 11:35:51]     -- Recording automatically stopped after a silence of 10 seconds
[Sep 27 11:35:51]     -- Playing 'auth-thankyou' (language 'en')
[Sep 27 11:35:52]     -- Playing 'vm-review' (language 'en')
[Sep 27 11:36:01]     -- Playing 'vm-reachoper' (language 'en')
[Sep 27 11:36:11]     -- Playing 'vm-review' (language 'en')
[Sep 27 11:36:20]     -- Playing 'vm-reachoper' (language 'en')
[Sep 27 11:36:30]     -- Playing 'vm-review' (language 'en')
[Sep 27 11:36:38]     -- Playing 'vm-reachoper' (language 'en')
[Sep 27 11:36:48]     -- Playing 'vm-review' (language 'en')
[Sep 27 11:36:57]     -- Playing 'vm-reachoper' (language 'en')
[Sep 27 11:37:07]     -- Playing 'vm-goodbye' (language 'en')
[Sep 27 11:37:08]     -- Executing Goto("Zap/4-1", "incoming|0|1") in new stack
[Sep 27 11:37:08]     -- Goto (incoming,0,1)
[Sep 27 11:37:08]   == Channel 'Zap/4-1' jumping out of macro 'stdexten'
[Sep 27 11:37:08]     -- Executing Playback("Zap/4-1", "transfer|skip") in new stack
[Sep 27 11:37:08]     -- Playing 'transfer' (language 'en')
[Sep 27 11:37:09]     -- Zap/2-1 answered SIP/110-f6da
[Sep 27 11:37:10]     -- Executing Macro("Zap/4-1", "stdexten|100|SIP/100") in new stack
[Sep 27 11:37:10]     -- Executing NoOp("Zap/4-1", "extension s@") in new stack
[Sep 27 11:37:10]     -- Executing Dial("Zap/4-1", "SIP/100|20") in new stack
[Sep 27 11:37:10]     -- Called 100
[Sep 27 11:37:11]     -- SIP/100-ec00 is ringing
[Sep 27 11:37:13]     -- SIP/100-ec00 answered Zap/4-1
[Sep 27 11:37:22]   == Spawn extension (macro-stdexten, s, 2) exited non-zero on 'Zap/4-1' in macro 'stdexten'
[Sep 27 11:37:22]   == Spawn extension (incoming, 0, 2) exited non-zero on 'Zap/4-1'
[Sep 27 11:37:22]     -- Hungup 'Zap/4-1'