[Apr  3 21:21:51] NOTICE[21267] chan_iax2.c: Restricting registration for peer '2249' to 60 seconds (requested 300)
[Apr  3 21:21:51] NOTICE[21268] chan_iax2.c: Restricting registration for peer '2159' to 60 seconds (requested 300)
[Apr  3 21:22:46] NOTICE[21272] chan_iax2.c: Restricting registration for peer '2249' to 60 seconds (requested 300)
[Apr  3 21:22:46] NOTICE[21275] chan_iax2.c: Restricting registration for peer '2159' to 60 seconds (requested 300)
[Apr  3 21:22:54] VERBOSE[22984] logger.c:     -- Executing [72033594@from-internal:1] Macro("SIP/2214-0911d980", "pinsets|2|1") in new stack
[Apr  3 21:22:54] VERBOSE[22984] logger.c:     -- Executing [s@macro-pinsets:1] GotoIf("SIP/2214-0911d980", "1 = 1?cdr|1") in new stack
[Apr  3 21:22:54] VERBOSE[22984] logger.c:     -- Goto (macro-pinsets,cdr,1)
[Apr  3 21:22:54] DEBUG[22984] app_macro.c: Executed application: GotoIf
[Apr  3 21:22:54] VERBOSE[22984] logger.c:     -- Executing [cdr@macro-pinsets:1] Authenticate("SIP/2214-0911d980", "/etc/asterisk/pinset_2|a") in new stack
[Apr  3 21:22:54] VERBOSE[22984] logger.c:     -- <SIP/2214-0911d980> Playing 'agent-pass' (language 'es')
[Apr  3 21:23:03] WARNING[22984] app_authenticate.c: EEEEEEEEEEEEEEEEEEEELASTIX: The passwords '4384' and '4384' are equal
[Apr  3 21:23:03] VERBOSE[22984] logger.c:     -- <SIP/2214-0911d980> Playing 'auth-thankyou' (language 'es')
[Apr  3 21:23:04] DEBUG[22984] app_macro.c: Executed application: Authenticate
[Apr  3 21:23:04] VERBOSE[22984] logger.c:     -- Executing [72033594@from-internal:2] Macro("SIP/2214-0911d980", "dialout-trunk|4|72033594||") in new stack
[Apr  3 21:23:04] VERBOSE[22984] logger.c:     -- Executing [s@macro-dialout-trunk:1] Set("SIP/2214-0911d980", "DIAL_TRUNK=4") in new stack
[Apr  3 21:23:04] DEBUG[22984] app_macro.c: Executed application: Set
[Apr  3 21:23:04] VERBOSE[22984] logger.c:     -- Executing [s@macro-dialout-trunk:2] Set("SIP/2214-0911d980", "DIAL_NUMBER=72033594") in new stack
[Apr  3 21:23:04] DEBUG[22984] app_macro.c: Executed application: Set
[Apr  3 21:23:04] VERBOSE[22984] logger.c:     -- Executing [s@macro-dialout-trunk:3] Set("SIP/2214-0911d980", "ROUTE_PASSWD=") in new stack
[Apr  3 21:23:04] DEBUG[22984] app_macro.c: Executed application: Set
[Apr  3 21:23:04] VERBOSE[22984] logger.c:     -- Executing [s@macro-dialout-trunk:4] GotoIf("SIP/2214-0911d980", "1?noauth") in new stack
[Apr  3 21:23:04] VERBOSE[22984] logger.c:     -- Goto (macro-dialout-trunk,s,6)
[Apr  3 21:23:04] DEBUG[22984] app_macro.c: Executed application: GotoIf
[Apr  3 21:23:04] VERBOSE[22984] logger.c:     -- Executing [s@macro-dialout-trunk:6] GotoIf("SIP/2214-0911d980", "0?disabletrunk|1") in new stack
[Apr  3 21:23:04] DEBUG[22984] app_macro.c: Executed application: GotoIf
[Apr  3 21:23:04] VERBOSE[22984] logger.c:     -- Executing [s@macro-dialout-trunk:7] Set("SIP/2214-0911d980", "_NODEST=") in new stack
[Apr  3 21:23:04] DEBUG[22984] app_macro.c: Executed application: Set
[Apr  3 21:23:04] VERBOSE[22984] logger.c:     -- Executing [s@macro-dialout-trunk:8] Set("SIP/2214-0911d980", "DIAL_TRUNK_OPTIONS=tr") in new stack
[Apr  3 21:23:04] DEBUG[22984] app_macro.c: Executed application: Set
[Apr  3 21:23:04] VERBOSE[22984] logger.c:     -- Executing [s@macro-dialout-trunk:9] Set("SIP/2214-0911d980", "GROUP()=OUT_4") in new stack
[Apr  3 21:23:04] DEBUG[22984] app_macro.c: Executed application: Set
[Apr  3 21:23:04] VERBOSE[22984] logger.c:     -- Executing [s@macro-dialout-trunk:10] Macro("SIP/2214-0911d980", "user-callerid|SKIPTTL") in new stack
[Apr  3 21:23:04] VERBOSE[22984] logger.c:     -- Executing [s@macro-user-callerid:1] NoOp("SIP/2214-0911d980", "user-callerid: device 2214") in new stack
[Apr  3 21:23:04] DEBUG[22984] app_macro.c: Executed application: Noop
[Apr  3 21:23:04] VERBOSE[22984] logger.c:     -- Executing [s@macro-user-callerid:2] Set("SIP/2214-0911d980", "AMPUSER=2214") in new stack
[Apr  3 21:23:04] DEBUG[22984] app_macro.c: Executed application: Set
[Apr  3 21:23:04] VERBOSE[22984] logger.c:     -- Executing [s@macro-user-callerid:3] GotoIf("SIP/2214-0911d980", "0?report") in new stack
[Apr  3 21:23:04] DEBUG[22984] app_macro.c: Executed application: GotoIf
[Apr  3 21:23:04] VERBOSE[22984] logger.c:     -- Executing [s@macro-user-callerid:4] GotoIf("SIP/2214-0911d980", "0?start") in new stack
[Apr  3 21:23:04] DEBUG[22984] app_macro.c: Executed application: GotoIf
[Apr  3 21:23:04] VERBOSE[22984] logger.c:     -- Executing [s@macro-user-callerid:5] Set("SIP/2214-0911d980", "REALCALLERIDNUM=2214") in new stack
[Apr  3 21:23:04] DEBUG[22984] app_macro.c: Executed application: Set
[Apr  3 21:23:04] VERBOSE[22984] logger.c:     -- Executing [s@macro-user-callerid:6] NoOp("SIP/2214-0911d980", "REALCALLERIDNUM is 2214") in new stack
[Apr  3 21:23:04] DEBUG[22984] app_macro.c: Executed application: NoOp
[Apr  3 21:23:04] VERBOSE[22984] logger.c:     -- Executing [s@macro-user-callerid:7] Set("SIP/2214-0911d980", "AMPUSER=2214") in new stack
[Apr  3 21:23:04] DEBUG[22984] app_macro.c: Executed application: Set
[Apr  3 21:23:04] VERBOSE[22984] logger.c:     -- Executing [s@macro-user-callerid:8] Set("SIP/2214-0911d980", "AMPUSERCIDNAME=Seguridad") in new stack
[Apr  3 21:23:04] DEBUG[22984] app_macro.c: Executed application: Set
[Apr  3 21:23:04] VERBOSE[22984] logger.c:     -- Executing [s@macro-user-callerid:9] GotoIf("SIP/2214-0911d980", "0?report") in new stack
[Apr  3 21:23:04] DEBUG[22984] app_macro.c: Executed application: GotoIf
[Apr  3 21:23:04] VERBOSE[22984] logger.c:     -- Executing [s@macro-user-callerid:10] Set("SIP/2214-0911d980", "AMPUSERCID=2214") in new stack
[Apr  3 21:23:04] DEBUG[22984] app_macro.c: Executed application: Set
[Apr  3 21:23:04] VERBOSE[22984] logger.c:     -- Executing [s@macro-user-callerid:11] Set("SIP/2214-0911d980", "CALLERID(all)="Seguridad" <2214>") in new stack
[Apr  3 21:23:04] DEBUG[22984] app_macro.c: Executed application: Set
[Apr  3 21:23:04] VERBOSE[22984] logger.c:     -- Executing [s@macro-user-callerid:12] Set("SIP/2214-0911d980", "REALCALLERIDNUM=2214") in new stack
[Apr  3 21:23:04] DEBUG[22984] app_macro.c: Executed application: Set
[Apr  3 21:23:04] VERBOSE[22984] logger.c:     -- Executing [s@macro-user-callerid:13] NoOp("SIP/2214-0911d980", "TTL:  ARG1: SKIPTTL") in new stack
[Apr  3 21:23:04] DEBUG[22984] app_macro.c: Executed application: Noop
[Apr  3 21:23:04] VERBOSE[22984] logger.c:     -- Executing [s@macro-user-callerid:14] GotoIf("SIP/2214-0911d980", "1?continue") in new stack
[Apr  3 21:23:04] VERBOSE[22984] logger.c:     -- Goto (macro-user-callerid,s,23)
[Apr  3 21:23:04] DEBUG[22984] app_macro.c: Executed application: GotoIf
[Apr  3 21:23:04] VERBOSE[22984] logger.c:     -- Executing [s@macro-user-callerid:23] NoOp("SIP/2214-0911d980", "Using CallerID "Seguridad" <2214>") in new stack
[Apr  3 21:23:04] DEBUG[22984] app_macro.c: Executed application: NoOp
[Apr  3 21:23:04] DEBUG[22984] app_macro.c: Executed application: Macro
[Apr  3 21:23:04] VERBOSE[22984] logger.c:     -- Executing [s@macro-dialout-trunk:11] Macro("SIP/2214-0911d980", "record-enable|2214|OUT") in new stack
[Apr  3 21:23:04] VERBOSE[22984] logger.c:     -- Executing [s@macro-record-enable:1] GotoIf("SIP/2214-0911d980", "0?2:4") in new stack
[Apr  3 21:23:04] VERBOSE[22984] logger.c:     -- Goto (macro-record-enable,s,4)
[Apr  3 21:23:04] DEBUG[22984] app_macro.c: Executed application: GotoIf
[Apr  3 21:23:04] VERBOSE[22984] logger.c:     -- Executing [s@macro-record-enable:4] AGI("SIP/2214-0911d980", "recordingcheck|20080403-212304|1207272174.467") in new stack
[Apr  3 21:23:04] VERBOSE[22984] logger.c:     -- Launched AGI Script /var/lib/asterisk/agi-bin/recordingcheck
[Apr  3 21:23:04] VERBOSE[22984] logger.c:   recordingcheck|20080403-212304|1207272174.467: Outbound recording not enabled
[Apr  3 21:23:04] VERBOSE[22984] logger.c:     -- AGI Script recordingcheck completed, returning 0
[Apr  3 21:23:04] DEBUG[22984] app_macro.c: Executed application: AGI
[Apr  3 21:23:04] VERBOSE[22984] logger.c:     -- Executing [s@macro-record-enable:5] NoOp("SIP/2214-0911d980", "No recording needed") in new stack
[Apr  3 21:23:04] DEBUG[22984] app_macro.c: Executed application: Noop
[Apr  3 21:23:04] DEBUG[22984] app_macro.c: Executed application: Macro
[Apr  3 21:23:04] VERBOSE[22984] logger.c:     -- Executing [s@macro-dialout-trunk:12] GotoIf("SIP/2214-0911d980", "0?skipoutcid") in new stack
[Apr  3 21:23:04] DEBUG[22984] app_macro.c: Executed application: GotoIf
[Apr  3 21:23:04] VERBOSE[22984] logger.c:     -- Executing [s@macro-dialout-trunk:13] Set("SIP/2214-0911d980", "DIAL_TRUNK_OPTIONS=") in new stack
[Apr  3 21:23:04] DEBUG[22984] app_macro.c: Executed application: Set
[Apr  3 21:23:04] VERBOSE[22984] logger.c:     -- Executing [s@macro-dialout-trunk:14] Macro("SIP/2214-0911d980", "outbound-callerid|4") in new stack
[Apr  3 21:23:04] VERBOSE[22984] logger.c:     -- Executing [s@macro-outbound-callerid:1] GotoIf("SIP/2214-0911d980", "1?start") in new stack
[Apr  3 21:23:04] VERBOSE[22984] logger.c:     -- Goto (macro-outbound-callerid,s,3)
[Apr  3 21:23:04] DEBUG[22984] app_macro.c: Executed application: GotoIf
[Apr  3 21:23:04] VERBOSE[22984] logger.c:     -- Executing [s@macro-outbound-callerid:3] NoOp("SIP/2214-0911d980", "REALCALLERIDNUM is 2214") in new stack
[Apr  3 21:23:04] DEBUG[22984] app_macro.c: Executed application: NoOp
[Apr  3 21:23:04] VERBOSE[22984] logger.c:     -- Executing [s@macro-outbound-callerid:4] GotoIf("SIP/2214-0911d980", "1?normcid") in new stack
[Apr  3 21:23:04] VERBOSE[22984] logger.c:     -- Goto (macro-outbound-callerid,s,9)
[Apr  3 21:23:04] DEBUG[22984] app_macro.c: Executed application: GotoIf
[Apr  3 21:23:04] VERBOSE[22984] logger.c:     -- Executing [s@macro-outbound-callerid:9] Set("SIP/2214-0911d980", "USEROUTCID=") in new stack
[Apr  3 21:23:04] DEBUG[22984] app_macro.c: Executed application: Set
[Apr  3 21:23:04] DEBUG[22984] func_db.c: DB: DEVICE/2214/emergency_cid not found in database.
[Apr  3 21:23:04] VERBOSE[22984] logger.c:     -- Executing [s@macro-outbound-callerid:10] Set("SIP/2214-0911d980", "EMERGENCYCID=") in new stack
[Apr  3 21:23:04] DEBUG[22984] app_macro.c: Executed application: Set
[Apr  3 21:23:04] VERBOSE[22984] logger.c:     -- Executing [s@macro-outbound-callerid:11] Set("SIP/2214-0911d980", "TRUNKOUTCID=") in new stack
[Apr  3 21:23:04] DEBUG[22984] app_macro.c: Executed application: Set
[Apr  3 21:23:04] VERBOSE[22984] logger.c:     -- Executing [s@macro-outbound-callerid:12] GotoIf("SIP/2214-0911d980", "1?trunkcid") in new stack
[Apr  3 21:23:04] VERBOSE[22984] logger.c:     -- Goto (macro-outbound-callerid,s,16)
[Apr  3 21:23:04] DEBUG[22984] app_macro.c: Executed application: GotoIf
[Apr  3 21:23:04] VERBOSE[22984] logger.c:     -- Executing [s@macro-outbound-callerid:16] GotoIf("SIP/2214-0911d980", "1?usercid") in new stack
[Apr  3 21:23:04] VERBOSE[22984] logger.c:     -- Goto (macro-outbound-callerid,s,18)
[Apr  3 21:23:04] DEBUG[22984] app_macro.c: Executed application: GotoIf
[Apr  3 21:23:04] VERBOSE[22984] logger.c:     -- Executing [s@macro-outbound-callerid:18] GotoIf("SIP/2214-0911d980", "1?report") in new stack
[Apr  3 21:23:04] VERBOSE[22984] logger.c:     -- Goto (macro-outbound-callerid,s,22)
[Apr  3 21:23:04] DEBUG[22984] app_macro.c: Executed application: GotoIf
[Apr  3 21:23:04] VERBOSE[22984] logger.c:     -- Executing [s@macro-outbound-callerid:22] NoOp("SIP/2214-0911d980", "CallerID set to "Seguridad" <2214>") in new stack
[Apr  3 21:23:04] DEBUG[22984] app_macro.c: Executed application: NoOp
[Apr  3 21:23:04] DEBUG[22984] app_macro.c: Executed application: Macro
[Apr  3 21:23:04] VERBOSE[22984] logger.c:     -- Executing [s@macro-dialout-trunk:15] GotoIf("SIP/2214-0911d980", "1?nomax") in new stack
[Apr  3 21:23:04] VERBOSE[22984] logger.c:     -- Goto (macro-dialout-trunk,s,17)
[Apr  3 21:23:04] DEBUG[22984] app_macro.c: Executed application: GotoIf
[Apr  3 21:23:04] VERBOSE[22984] logger.c:     -- Executing [s@macro-dialout-trunk:17] AGI("SIP/2214-0911d980", "fixlocalprefix") in new stack
[Apr  3 21:23:04] VERBOSE[22984] logger.c:     -- Launched AGI Script /var/lib/asterisk/agi-bin/fixlocalprefix
[Apr  3 21:23:04] VERBOSE[22984] logger.c:        >  fixlocalprefix: Using pattern 010|.
[Apr  3 21:23:04] VERBOSE[22984] logger.c:        >  fixlocalprefix: Using pattern 011|.
[Apr  3 21:23:04] VERBOSE[22984] logger.c:        >  fixlocalprefix: Using pattern 012|.
[Apr  3 21:23:04] VERBOSE[22984] logger.c:        >  fixlocalprefix: Using pattern 013|.
[Apr  3 21:23:04] VERBOSE[22984] logger.c:        >  fixlocalprefix: Using pattern 014|.
[Apr  3 21:23:04] VERBOSE[22984] logger.c:        >  fixlocalprefix: Using pattern 016|.
[Apr  3 21:23:04] VERBOSE[22984] logger.c:        >  fixlocalprefix: Using pattern 017|.
[Apr  3 21:23:04] VERBOSE[22984] logger.c:        >  fixlocalprefix: Using pattern 021|.
[Apr  3 21:23:04] VERBOSE[22984] logger.c:        >  fixlocalprefix: Using pattern 0|.
[Apr  3 21:23:04] VERBOSE[22984] logger.c:     -- AGI Script fixlocalprefix completed, returning 0
[Apr  3 21:23:04] DEBUG[22984] app_macro.c: Executed application: AGI
[Apr  3 21:23:04] VERBOSE[22984] logger.c:     -- Executing [s@macro-dialout-trunk:18] Set("SIP/2214-0911d980", "OUTNUM=72033594") in new stack
[Apr  3 21:23:04] DEBUG[22984] app_macro.c: Executed application: Set
[Apr  3 21:23:04] VERBOSE[22984] logger.c:     -- Executing [s@macro-dialout-trunk:19] Set("SIP/2214-0911d980", "custom=ZAP/g3") in new stack
[Apr  3 21:23:04] DEBUG[22984] app_macro.c: Executed application: Set
[Apr  3 21:23:04] VERBOSE[22984] logger.c:     -- Executing [s@macro-dialout-trunk:20] GotoIf("SIP/2214-0911d980", "1?gocall") in new stack
[Apr  3 21:23:04] VERBOSE[22984] logger.c:     -- Goto (macro-dialout-trunk,s,24)
[Apr  3 21:23:04] DEBUG[22984] app_macro.c: Executed application: GotoIf
[Apr  3 21:23:04] VERBOSE[22984] logger.c:     -- Executing [s@macro-dialout-trunk:24] GotoIf("SIP/2214-0911d980", "0?customtrunk") in new stack
[Apr  3 21:23:04] DEBUG[22984] app_macro.c: Executed application: GotoIf
[Apr  3 21:23:04] VERBOSE[22984] logger.c:     -- Executing [s@macro-dialout-trunk:25] Dial("SIP/2214-0911d980", "ZAP/g3/72033594|300|") in new stack
[Apr  3 21:23:04] DEBUG[22984] dsp.c: dsp busy pattern set to 0,0
[Apr  3 21:23:04] DEBUG[22984] chan_zap.c: Dialing '72033594'
[Apr  3 21:23:04] DEBUG[22984] chan_zap.c: Deferring dialing...
[Apr  3 21:23:04] VERBOSE[22984] logger.c:     -- Called g3/72033594
[Apr  3 21:23:07] VERBOSE[22984] logger.c:     -- Zap/7-1 answered SIP/2214-0911d980
[Apr  3 21:23:20] DEBUG[22984] chan_zap.c: Ignoring Polarity switch to IDLE on channel 7, state 6
[Apr  3 21:23:20] DEBUG[22984] chan_zap.c: Polarity Reversal event occured - DEBUG 2: channel 7, state 6, pol= 0, aonp= 0, honp= 0, pdelay= 600, tv= 386390240
[Apr  3 21:23:25] VERBOSE[22984] logger.c:     -- Started music on hold, class 'default', on Zap/7-1
[Apr  3 21:23:40] VERBOSE[22987] logger.c:     -- Executing [72550394@from-internal:1] Macro("SIP/2214-0912c6b0", "pinsets|2|1") in new stack
[Apr  3 21:23:40] VERBOSE[22987] logger.c:     -- Executing [s@macro-pinsets:1] GotoIf("SIP/2214-0912c6b0", "1 = 1?cdr|1") in new stack
[Apr  3 21:23:40] VERBOSE[22987] logger.c:     -- Goto (macro-pinsets,cdr,1)
[Apr  3 21:23:40] DEBUG[22987] app_macro.c: Executed application: GotoIf
[Apr  3 21:23:40] VERBOSE[22987] logger.c:     -- Executing [cdr@macro-pinsets:1] Authenticate("SIP/2214-0912c6b0", "/etc/asterisk/pinset_2|a") in new stack
[Apr  3 21:23:40] VERBOSE[22987] logger.c:     -- <SIP/2214-0912c6b0> Playing 'agent-pass' (language 'es')
[Apr  3 21:23:41] NOTICE[21270] chan_iax2.c: Restricting registration for peer '2249' to 60 seconds (requested 300)
[Apr  3 21:23:41] NOTICE[21268] chan_iax2.c: Restricting registration for peer '2159' to 60 seconds (requested 300)
[Apr  3 21:24:11] VERBOSE[22987] logger.c:     -- <SIP/2214-0912c6b0> Playing 'auth-incorrect' (language 'es')
[Apr  3 21:24:18] VERBOSE[22984] logger.c:     -- Stopped music on hold on Zap/7-1
[Apr  3 21:24:18] VERBOSE[22984] logger.c:     -- Hungup 'Zap/7-1'
[Apr  3 21:24:18] VERBOSE[22984] logger.c:   == Spawn extension (macro-dialout-trunk, s, 25) exited non-zero on 'SIP/2214-0911d980' in macro 'dialout-trunk'
[Apr  3 21:24:18] VERBOSE[22984] logger.c:   == Spawn extension (macro-dialout-trunk, s, 25) exited non-zero on 'SIP/2214-0911d980'
[Apr  3 21:24:18] VERBOSE[22984] logger.c:     -- Executing [h@macro-dialout-trunk:1] Macro("SIP/2214-0911d980", "hangupcall") in new stack
[Apr  3 21:24:18] VERBOSE[22984] logger.c:     -- Executing [s@macro-hangupcall:1] ResetCDR("SIP/2214-0911d980", "w") in new stack
[Apr  3 21:24:18] DEBUG[22984] app_macro.c: Executed application: ResetCDR
[Apr  3 21:24:18] VERBOSE[22984] logger.c:     -- Executing [s@macro-hangupcall:2] NoCDR("SIP/2214-0911d980", "") in new stack
[Apr  3 21:24:18] DEBUG[22984] app_macro.c: Executed application: NoCDR
[Apr  3 21:24:18] VERBOSE[22984] logger.c:     -- Executing [s@macro-hangupcall:3] GotoIf("SIP/2214-0911d980", "1?skiprg") in new stack
[Apr  3 21:24:18] VERBOSE[22984] logger.c:     -- Goto (macro-hangupcall,s,6)
[Apr  3 21:24:18] DEBUG[22984] app_macro.c: Executed application: GotoIf
[Apr  3 21:24:18] VERBOSE[22984] logger.c:     -- Executing [s@macro-hangupcall:6] GotoIf("SIP/2214-0911d980", "1?skipblkvm") in new stack
[Apr  3 21:24:18] VERBOSE[22984] logger.c:     -- Goto (macro-hangupcall,s,9)
[Apr  3 21:24:18] DEBUG[22984] app_macro.c: Executed application: GotoIf
[Apr  3 21:24:18] VERBOSE[22984] logger.c:     -- Executing [s@macro-hangupcall:9] GotoIf("SIP/2214-0911d980", "1?theend") in new stack
[Apr  3 21:24:18] VERBOSE[22984] logger.c:     -- Goto (macro-hangupcall,s,11)
[Apr  3 21:24:18] DEBUG[22984] app_macro.c: Executed application: GotoIf
[Apr  3 21:24:18] VERBOSE[22984] logger.c:     -- Executing [s@macro-hangupcall:11] Hangup("SIP/2214-0911d980", "") in new stack
[Apr  3 21:24:18] VERBOSE[22984] logger.c:   == Spawn extension (macro-hangupcall, s, 11) exited non-zero on 'SIP/2214-0911d980' in macro 'hangupcall'
[Apr  3 21:24:18] VERBOSE[22984] logger.c:   == Spawn extension (macro-hangupcall, s, 11) exited non-zero on 'SIP/2214-0911d980'
[Apr  3 21:24:18] WARNING[22987] app_authenticate.c: EEEEEEEEEEEEEEEEEEEELASTIX: Canal equivocado o mas de 3 intentos
[Apr  3 21:24:18] WARNING[22987] file.c: Failed to write frame
[Apr  3 21:24:18] VERBOSE[22987] logger.c:     -- <SIP/2214-0912c6b0> Playing 'vm-goodbye' (language 'es')
[Apr  3 21:24:18] VERBOSE[22987] logger.c:   == Spawn extension (macro-pinsets, cdr, 1) exited non-zero on 'SIP/2214-0912c6b0' in macro 'pinsets'
[Apr  3 21:24:18] VERBOSE[22987] logger.c:   == Spawn extension (macro-pinsets, cdr, 1) exited non-zero on 'SIP/2214-0912c6b0'
[Apr  3 21:24:36] NOTICE[21273] chan_iax2.c: Restricting registration for peer '2249' to 60 seconds (requested 300)
[Apr  3 21:24:36] NOTICE[21269] chan_iax2.c: Restricting registration for peer '2159' to 60 seconds (requested 300)
[Apr  3 21:25:01] VERBOSE[21250] logger.c:     -- Remote UNIX connection
[Apr  3 21:25:01] VERBOSE[22991] logger.c:     -- Remote UNIX connection disconnected
[Apr  3 21:25:31] NOTICE[21271] chan_iax2.c: Restricting registration for peer '2249' to 60 seconds (requested 300)
[Apr  3 21:25:31] NOTICE[21273] chan_iax2.c: Restricting registration for peer '2159' to 60 seconds (requested 300)
[Apr  3 21:26:01] VERBOSE[22932] logger.c:     -- Remote UNIX connection disconnected