[Mar 24 13:34:42] VERBOSE[12172] logger.c: -- Executing [411@from-internal:1] Answer("SIP/290-000000cd", "") in new stack
[Mar 24 13:34:42] VERBOSE[12172] logger.c: -- Executing [411@from-internal:2] Wait("SIP/290-000000cd", "1") in new stack
[Mar 24 13:34:43] VERBOSE[12172] logger.c: -- Executing [411@from-internal:3] Goto("SIP/290-000000cd", "pbdirectory|1") in new stack
[Mar 24 13:34:43] VERBOSE[12172] logger.c: -- Goto (from-internal,pbdirectory,1)
[Mar 24 13:34:43] VERBOSE[12172] logger.c: -- Executing [pbdirectory@from-internal:1] Macro("SIP/290-000000cd", "user-callerid|") in new stack
[Mar 24 13:34:43] VERBOSE[12172] logger.c: -- Executing [s@macro-user-callerid:1] Set("SIP/290-000000cd", "AMPUSER=290") in new stack
[Mar 24 13:34:43] DEBUG[12172] app_macro.c: Executed application: Set
[Mar 24 13:34:43] VERBOSE[12172] logger.c: -- Executing [s@macro-user-callerid:2] GotoIf("SIP/290-000000cd", "0?report") in new stack
[Mar 24 13:34:43] DEBUG[12172] app_macro.c: Executed application: GotoIf
[Mar 24 13:34:43] VERBOSE[12172] logger.c: -- Executing [s@macro-user-callerid:3] ExecIf("SIP/290-000000cd", "1|Set|REALCALLERIDNUM=290") in new stack
[Mar 24 13:34:43] DEBUG[12172] app_macro.c: Executed application: ExecIf
[Mar 24 13:34:43] VERBOSE[12172] logger.c: -- Executing [s@macro-user-callerid:4] Set("SIP/290-000000cd", "AMPUSER=290") in new stack
[Mar 24 13:34:43] DEBUG[12172] app_macro.c: Executed application: Set
[Mar 24 13:34:43] VERBOSE[12172] logger.c: -- Executing [s@macro-user-callerid:5] Set("SIP/290-000000cd", "AMPUSERCIDNAME=Christian") in new stack
[Mar 24 13:34:43] DEBUG[12172] app_macro.c: Executed application: Set
[Mar 24 13:34:43] VERBOSE[12172] logger.c: -- Executing [s@macro-user-callerid:6] GotoIf("SIP/290-000000cd", "0?report") in new stack
[Mar 24 13:34:43] DEBUG[12172] app_macro.c: Executed application: GotoIf
[Mar 24 13:34:43] VERBOSE[12172] logger.c: -- Executing [s@macro-user-callerid:7] Set("SIP/290-000000cd", "AMPUSERCID=290") in new stack
[Mar 24 13:34:43] DEBUG[12172] app_macro.c: Executed application: Set
[Mar 24 13:34:43] VERBOSE[12172] logger.c: -- Executing [s@macro-user-callerid:8] Set("SIP/290-000000cd", "CALLERID(all)="Christian" <290>") in new stack
[Mar 24 13:34:43] DEBUG[12172] app_macro.c: Executed application: Set
[Mar 24 13:34:43] VERBOSE[12172] logger.c: -- Executing [s@macro-user-callerid:9] ExecIf("SIP/290-000000cd", "1|Set|CHANNEL(language)=de") in new stack
[Mar 24 13:34:43] DEBUG[12172] app_macro.c: Executed application: ExecIf
[Mar 24 13:34:43] DEBUG[12172] app_macro.c: Last app: Set|CHANNEL(language)=de
[Mar 24 13:34:43] VERBOSE[12172] logger.c: -- Executing [s@macro-user-callerid:10] GotoIf("SIP/290-000000cd", "0?continue") in new stack
[Mar 24 13:34:43] DEBUG[12172] app_macro.c: Executed application: GotoIf
[Mar 24 13:34:43] VERBOSE[12172] logger.c: -- Executing [s@macro-user-callerid:11] Set("SIP/290-000000cd", "__TTL=64") in new stack
[Mar 24 13:34:43] DEBUG[12172] app_macro.c: Executed application: Set
[Mar 24 13:34:43] VERBOSE[12172] logger.c: -- Executing [s@macro-user-callerid:12] GotoIf("SIP/290-000000cd", "1?continue") in new stack
[Mar 24 13:34:43] VERBOSE[12172] logger.c: -- Goto (macro-user-callerid,s,19)
[Mar 24 13:34:43] DEBUG[12172] app_macro.c: Executed application: GotoIf
[Mar 24 13:34:43] VERBOSE[12172] logger.c: -- Executing [s@macro-user-callerid:19] NoOp("SIP/290-000000cd", "Using CallerID "Christian" <290>") in new stack
[Mar 24 13:34:43] DEBUG[12172] app_macro.c: Executed application: Noop
[Mar 24 13:34:43] VERBOSE[12172] logger.c: -- Executing [pbdirectory@from-internal:2] AGI("SIP/290-000000cd", "pbdirectory") in new stack
[Mar 24 13:34:43] VERBOSE[12172] logger.c: -- Launched AGI Script /var/lib/asterisk/agi-bin/pbdirectory
[Mar 24 13:34:43] VERBOSE[12174] logger.c: == Parsing '/etc/asterisk/manager.conf': [Mar 24 13:34:43] VERBOSE[12174] logger.c: Found
[Mar 24 13:34:43] VERBOSE[12174] logger.c: == Parsing '/etc/asterisk/manager_additional.conf': [Mar 24 13:34:43] VERBOSE[12174] logger.c: Found
[Mar 24 13:34:43] VERBOSE[12174] logger.c: == Parsing '/etc/asterisk/manager_custom.conf': [Mar 24 13:34:43] VERBOSE[12174] logger.c: Found
[Mar 24 13:34:43] VERBOSE[12174] logger.c: == Manager 'admin' logged on from 127.0.0.1
[Mar 24 13:34:43] VERBOSE[12174] logger.c: == Manager 'admin' logged off from 127.0.0.1
[Mar 24 13:34:43] VERBOSE[12172] logger.c: pbdirectory: test
[Mar 24 13:34:43] VERBOSE[12172] logger.c: -- Playing 'pbdirectory/welcome-to-phonebook' (escape_digits=) (sample_offset 0)
[Mar 24 13:34:45] VERBOSE[12172] logger.c: pbdirectory: start loop
[Mar 24 13:34:45] VERBOSE[12172] logger.c: pbdirectory: loop = 0
[Mar 24 13:34:45] VERBOSE[12172] logger.c: -- <SIP/290-000000cd> Playing 'pbdirectory/first-three-letters-entry' (language 'de')
[Mar 24 13:34:51] VERBOSE[12172] logger.c: -- Playing 'dir-nomatch' (escape_digits=) (sample_offset 0)
[Mar 24 13:34:55] VERBOSE[12172] logger.c: pbdirectory: loop = 1
[Mar 24 13:34:55] VERBOSE[12172] logger.c: -- <SIP/290-000000cd> Playing 'pbdirectory/first-three-letters-entry' (language 'de')
[Mar 24 13:34:58] DEBUG[12172] res_agi.c: SIP/290-000000cd hungup
[Mar 24 13:34:58] VERBOSE[12172] logger.c: == Spawn extension (from-internal, pbdirectory, 2) exited non-zero on 'SIP/290-000000cd'
[Mar 24 13:34:58] VERBOSE[12172] logger.c: -- Executing [h@from-internal:1] Macro("SIP/290-000000cd", "hangupcall") in new stack
[Mar 24 13:34:58] VERBOSE[12172] logger.c: -- Executing [s@macro-hangupcall:1] GotoIf("SIP/290-000000cd", "1?skiprg") in new stack
[Mar 24 13:34:58] VERBOSE[12172] logger.c: -- Goto (macro-hangupcall,s,4)
[Mar 24 13:34:58] DEBUG[12172] app_macro.c: Executed application: GotoIf
[Mar 24 13:34:58] VERBOSE[12172] logger.c: -- Executing [s@macro-hangupcall:4] GotoIf("SIP/290-000000cd", "1?skipblkvm") in new stack
[Mar 24 13:34:58] VERBOSE[12172] logger.c: -- Goto (macro-hangupcall,s,7)
[Mar 24 13:34:58] DEBUG[12172] app_macro.c: Executed application: GotoIf
[Mar 24 13:34:58] VERBOSE[12172] logger.c: -- Executing [s@macro-hangupcall:7] GotoIf("SIP/290-000000cd", "1?theend") in new stack
[Mar 24 13:34:58] VERBOSE[12172] logger.c: -- Goto (macro-hangupcall,s,9)
[Mar 24 13:34:58] DEBUG[12172] app_macro.c: Executed application: GotoIf
[Mar 24 13:34:58] VERBOSE[12172] logger.c: -- Executing [s@macro-hangupcall:9] Hangup("SIP/290-000000cd", "") in new stack
[Mar 24 13:34:58] VERBOSE[12172] logger.c: == Spawn extension (macro-hangupcall, s, 9) exited non-zero on 'SIP/290-000000cd' in macro 'hangupcall'
[Mar 24 13:34:58] VERBOSE[12172] logger.c: == Spawn extension (from-internal, h, 1) exited non-zero on 'SIP/290-000000cd'
[Mar 24 13:35:01] VERBOSE[2518] logger.c: -- Remote UNIX connection
[Mar 24 13:35:01] VERBOSE[12178] logger.c: -- Remote UNIX connection disconnected