[Sep 29 15:28:36] VERBOSE[29043] asterisk.c: Asterisk Ready.
[Sep 29 15:28:36] VERBOSE[29043] astmm.c:  Asterisk Malloc Debugger Started (see /var/log/asterisk/mmlog))
[Sep 29 15:28:36] VERBOSE[29043] config.c:   == Parsing '/etc/asterisk/cli.conf': [Sep 29 15:28:36] VERBOSE[29043] config.c:   == Found
[Sep 29 15:28:40] VERBOSE[29048] netsock.c:   == Using UDPTL CoS mark 5
[Sep 29 15:28:40] NOTICE[29048] channel.c: Allocated channel SIP/2001-073f5cb0(0x73fefa0)
[Sep 29 15:28:40] VERBOSE[29081] pbx.c:     -- Executing [667@internal:1] Dial("SIP/2001-073f5cb0", "Local/2000@internal,5,tTkKg") in new stack
[Sep 29 15:28:40] NOTICE[29081] channel.c: Allocated channel Local/2000@internal-f0b4;1(0x7408f50)
[Sep 29 15:28:40] NOTICE[29081] channel.c: Allocated channel Local/2000@internal-f0b4;2(0x740dee0)
[Sep 29 15:28:40] VERBOSE[29081] app_dial.c:     -- Called 2000@internal
[Sep 29 15:28:40] VERBOSE[29082] pbx.c:     -- Executing [2000@internal:1] Dial("Local/2000@internal-f0b4;2", "SIP/2000,10,Tt") in new stack
[Sep 29 15:28:40] VERBOSE[29082] netsock.c:   == Using UDPTL CoS mark 5
[Sep 29 15:28:40] NOTICE[29082] channel.c: Allocated channel SIP/2000-07416640(0x741faf0)
[Sep 29 15:28:40] VERBOSE[29082] app_dial.c:     -- Called 2000
[Sep 29 15:28:40] VERBOSE[29082] app_dial.c:     -- SIP/2000-07416640 is ringing
[Sep 29 15:28:40] VERBOSE[29081] app_dial.c:     -- Local/2000@internal-f0b4;1 is ringing
[Sep 29 15:28:42] VERBOSE[29082] app_dial.c:     -- SIP/2000-07416640 answered Local/2000@internal-f0b4;2
[Sep 29 15:28:42] VERBOSE[29081] app_dial.c:     -- Local/2000@internal-f0b4;1 answered SIP/2001-073f5cb0
[Sep 29 15:28:42] NOTICE[29082] channel.c: Release called for channel (0x742e880)
[Sep 29 15:28:42] NOTICE[29082] channel.c: Release called for channel Local/2000@internal-f0b4;1<ZOMBIE>(0x741faf0)
[Sep 29 15:28:42] NOTICE[29082] channel.c: Channel destructor called for Local/2000@internal-f0b4;1<ZOMBIE>(0x741faf0)
[Sep 29 15:28:42] VERBOSE[29082] pbx.c:   == Spawn extension (internal, 2000, 1) exited non-zero on 'Local/2000@internal-f0b4;2'
[Sep 29 15:28:42] NOTICE[29082] channel.c: Release called for channel Local/2000@internal-f0b4;2(0x740dee0)
[Sep 29 15:28:42] NOTICE[29082] channel.c: Channel destructor called for Local/2000@internal-f0b4;2(0x740dee0)
[Sep 29 15:28:42] VERBOSE[29048] chan_sip.c:        > Saved useragent "PolycomSoundPointIP-SPIP_430-UA/3.1.3.0439" for peer 666
[Sep 29 15:28:46] NOTICE[29081] channel.c: Release called for channel (0x7415440)
[Sep 29 15:28:46] NOTICE[29081] channel.c: Release called for channel SIP/2000-07416640(0x7408f50)
[Sep 29 15:28:46] NOTICE[29081] channel.c: Channel destructor called for SIP/2000-07416640(0x7408f50)
[Sep 29 15:28:46] VERBOSE[29081] pbx.c:     -- Executing [667@internal:2] Hangup("SIP/2001-073f5cb0", "") in new stack
[Sep 29 15:28:46] VERBOSE[29081] pbx.c:   == Spawn extension (internal, 667, 2) exited non-zero on 'SIP/2001-073f5cb0'
[Sep 29 15:28:46] NOTICE[29081] channel.c: Release called for channel SIP/2001-073f5cb0(0x73fefa0)
[Sep 29 15:29:13] VERBOSE[29043] asterisk.c: Beginning asterisk shutdown....
[Sep 29 15:29:13] VERBOSE[29043] asterisk.c: Executing last minute cleanups
[Sep 29 15:29:13] VERBOSE[29043] res_musiconhold.c:   == Destroying musiconhold processes
[Sep 29 15:29:13] VERBOSE[29043] asterisk.c: Asterisk cleanly ending (0).