Connected to Asterisk 16.8.0 currently running on pebo (pid = 1239)
  == Setting global variable 'SIPDOMAIN' to '100.96.214.184'
  == Using SIP RTP Audio TOS bits 184
  == Using SIP RTP Audio CoS mark 5
    -- Executing [s@mdc_incoming-1:1] Verbose("PJSIP/mdc_trunk_conf-1-000001db", "1,Inbound call on trunk: Telekom SIP-Trunk, getting number by: to-header") in new stack
 Inbound call on trunk: Telekom SIP-Trunk, getting number by: to-header
    -- Executing [s@mdc_incoming-1:2] Set("PJSIP/mdc_trunk_conf-1-000001db", "MDC_CALLER_NUM_TRUNK=+492286896297") in new stack
    -- Executing [s@mdc_incoming-1:3] Set("PJSIP/mdc_trunk_conf-1-000001db", "MDC_CALLEE_NUM_TRUNK=02285595216") in new stack
    -- Executing [s@mdc_incoming-1:4] Verbose("PJSIP/mdc_trunk_conf-1-000001db", "1,destination 02285595216 is extracted") in new stack
 destination 02285595216 is extracted
    -- Executing [s@mdc_incoming-1:5] Goto("PJSIP/mdc_trunk_conf-1-000001db", "mdc_trunk-2,s,1") in new stack
    -- Goto (mdc_trunk-2,s,1)
    -- Executing [s@mdc_trunk-2:1] Verbose("PJSIP/mdc_trunk_conf-1-000001db", "1,callee number: 02285595216 caller number: +492286896297") in new stack
 callee number: 02285595216 caller number: +492286896297
    -- Executing [s@mdc_trunk-2:2] ExecIf("PJSIP/mdc_trunk_conf-1-000001db", "0?Set(CALLERID(num)=anonymous)") in new stack
    -- Executing [s@mdc_trunk-2:3] ExecIf("PJSIP/mdc_trunk_conf-1-000001db", "0?Set(CALLERID(num)=anonymous)") in new stack
    -- Executing [s@mdc_trunk-2:4] ExecIf("PJSIP/mdc_trunk_conf-1-000001db", "0?Set(CALLERID(num)=anonymous)") in new stack
    -- Executing [s@mdc_trunk-2:5] Ringing("PJSIP/mdc_trunk_conf-1-000001db", "") in new stack
    -- Executing [s@mdc_trunk-2:6] Set("PJSIP/mdc_trunk_conf-1-000001db", "MDC_FALLBACK_TRUNK=10") in new stack
    -- Executing [s@mdc_trunk-2:7] Gosub("PJSIP/mdc_trunk_conf-1-000001db", "sub_nat2int,s,1(MDC_CALLER_NUM_INTERNAT,+492286896297,00,49,0,228,1)") in new stack
    -- Executing [s@sub_nat2int:1] Verbose("PJSIP/mdc_trunk_conf-1-000001db", "1,sub_nat2int:: variable: MDC_CALLER_NUM_INTERNAT - number: +492286896297 - intVAZ: 00 - lkz: 49 - natVAZ: 0 - onKz: 228 - incoming: 1") in new stack
 sub_nat2int:: variable: MDC_CALLER_NUM_INTERNAT - number: +492286896297 - intVAZ: 00 - lkz: 49 - natVAZ: 0 - onKz: 228 - incoming: 1
    -- Executing [s@sub_nat2int:2] GotoIf("PJSIP/mdc_trunk_conf-1-000001db", "0?s-emergency,1") in new stack
    -- Executing [s@sub_nat2int:3] GotoIf("PJSIP/mdc_trunk_conf-1-000001db", "0?s-int,1") in new stack
    -- Executing [s@sub_nat2int:4] GotoIf("PJSIP/mdc_trunk_conf-1-000001db", "0?s-int,1") in new stack
    -- Executing [s@sub_nat2int:5] GotoIf("PJSIP/mdc_trunk_conf-1-000001db", "1?s-convert,1") in new stack
    -- Goto (sub_nat2int,s-convert,1)
    -- Executing [s-convert@sub_nat2int:1] Set("PJSIP/mdc_trunk_conf-1-000001db", "ARG2=00492286896297") in new stack
    -- Executing [s-convert@sub_nat2int:2] Goto("PJSIP/mdc_trunk_conf-1-000001db", "s,check") in new stack
    -- Goto (sub_nat2int,s,6)
    -- Executing [s@sub_nat2int:6] GotoIf("PJSIP/mdc_trunk_conf-1-000001db", "1?s-int,1") in new stack
    -- Goto (sub_nat2int,s-int,1)
    -- Executing [s-int@sub_nat2int:1] Verbose("PJSIP/mdc_trunk_conf-1-000001db", "1,international") in new stack
 international
    -- Executing [s-int@sub_nat2int:2] Set("PJSIP/mdc_trunk_conf-1-000001db", "MDC_CALLER_NUM_INTERNAT=00492286896297") in new stack
    -- Executing [s-int@sub_nat2int:3] Return("PJSIP/mdc_trunk_conf-1-000001db", "") in new stack
    -- Executing [s@mdc_trunk-2:8] Set("PJSIP/mdc_trunk_conf-1-000001db", "CALLERID(num)=00492286896297") in new stack
    -- Executing [s@mdc_trunk-2:9] Gosub("PJSIP/mdc_trunk_conf-1-000001db", "sub_int2nat,s,1(MDC_CALLER_NUM_NAT,00492286896297,00,49,0,228,1)") in new stack
    -- Executing [s@sub_int2nat:1] Verbose("PJSIP/mdc_trunk_conf-1-000001db", "1,sub_int2nat:: variable: MDC_CALLER_NUM_NAT - exten: 00492286896297 - intVAZ: 00 - lkz: 49 - natVAZ: 0 - onKz: 228 - incoming: 1") in new stack
 sub_int2nat:: variable: MDC_CALLER_NUM_NAT - exten: 00492286896297 - intVAZ: 00 - lkz: 49 - natVAZ: 0 - onKz: 228 - incoming: 1
    -- Executing [s@sub_int2nat:2] GotoIf("PJSIP/mdc_trunk_conf-1-000001db", "0?s-emergency,1") in new stack
    -- Executing [s@sub_int2nat:3] GotoIf("PJSIP/mdc_trunk_conf-1-000001db", "0?nat") in new stack
    -- Executing [s@sub_int2nat:4] GotoIf("PJSIP/mdc_trunk_conf-1-000001db", "1?s-internat,1") in new stack
    -- Goto (sub_int2nat,s-internat,1)
    -- Executing [s-internat@sub_int2nat:1] Set("PJSIP/mdc_trunk_conf-1-000001db", "MDC_CALLER_NUM_NAT=02286896297") in new stack
    -- Executing [s-internat@sub_int2nat:2] Return("PJSIP/mdc_trunk_conf-1-000001db", "") in new stack
    -- Executing [s@mdc_trunk-2:10] Set("PJSIP/mdc_trunk_conf-1-000001db", "CALLERID(num)=02286896297") in new stack
    -- Executing [s@mdc_trunk-2:11] Set("PJSIP/mdc_trunk_conf-1-000001db", "MDC_NUMPREFIX_TRUNK=") in new stack
    -- Executing [s@mdc_trunk-2:12] UserEvent("PJSIP/mdc_trunk_conf-1-000001db", "ResolveCallerName,Strategy: system,Outbound: 0") in new stack
    -- Executing [s@mdc_trunk-2:13] Wait("PJSIP/mdc_trunk_conf-1-000001db", "0.25") in new stack
    -- Executing [s@mdc_trunk-2:14] Verbose("PJSIP/mdc_trunk_conf-1-000001db", "1,MDC_RESOLVENAME_HITS = 1") in new stack
 MDC_RESOLVENAME_HITS = 1
    -- Executing [s@mdc_trunk-2:15] Verbose("PJSIP/mdc_trunk_conf-1-000001db", "1,CALLERID(name) = Ulf Kosack") in new stack
 CALLERID(name) = Ulf Kosack
    -- Executing [s@mdc_trunk-2:16] Goto("PJSIP/mdc_trunk_conf-1-000001db", "mdc_mapping-2,02285595216,1") in new stack
    -- Goto (mdc_mapping-2,02285595216,1)
    -- Executing [02285595216@mdc_mapping-2:1] Set("PJSIP/mdc_trunk_conf-1-000001db", "CHANNEL(language)=de") in new stack
    -- Executing [02285595216@mdc_mapping-2:2] Verbose("PJSIP/mdc_trunk_conf-1-000001db", "1,mapping from _022855952XX to 16") in new stack
 mapping from _022855952XX to 16
    -- Executing [02285595216@mdc_mapping-2:3] Goto("PJSIP/mdc_trunk_conf-1-000001db", "mdc_external,16,1") in new stack
    -- Goto (mdc_external,16,1)
    -- Executing [16@mdc_external:1] Set("PJSIP/mdc_trunk_conf-1-000001db", "HASH(__SIPHEADERS,Alert-info)=<http://www.notused.de>;info=alert-external;x-line-id=0") in new stack
    -- Executing [16@mdc_external:2] GosubIf("PJSIP/mdc_trunk_conf-1-000001db", "1?sub_initcall,s,1(ext,16)") in new stack
    -- Executing [s@sub_initcall:1] Verbose("PJSIP/mdc_trunk_conf-1-000001db", "1,sub_initcall descent: ext exten: 16") in new stack
 sub_initcall descent: ext exten: 16
    -- Executing [s@sub_initcall:2] GosubIf("PJSIP/mdc_trunk_conf-1-000001db", "1?sub_initloop,s,1") in new stack
    -- Executing [s@sub_initloop:1] Verbose("PJSIP/mdc_trunk_conf-1-000001db", "1,initial loop") in new stack
 initial loop
    -- Executing [s@sub_initloop:2] Set("PJSIP/mdc_trunk_conf-1-000001db", "MDC_ALIAS_HOP=0") in new stack
    -- Executing [s@sub_initloop:3] Set("PJSIP/mdc_trunk_conf-1-000001db", "MDC_MAIN_HOP=0") in new stack
    -- Executing [s@sub_initloop:4] Return("PJSIP/mdc_trunk_conf-1-000001db", "") in new stack
    -- Executing [s@sub_initcall:3] Set("PJSIP/mdc_trunk_conf-1-000001db", "__MDC_TRANSFERBACK_HOP=0") in new stack
    -- Executing [s@sub_initcall:4] Set("PJSIP/mdc_trunk_conf-1-000001db", "__MDC_DIALDESCENT=ext") in new stack
    -- Executing [s@sub_initcall:5] Goto("PJSIP/mdc_trunk_conf-1-000001db", "ext,1") in new stack
    -- Goto (sub_initcall,ext,1)
    -- Executing [ext@sub_initcall:1] Set("PJSIP/mdc_trunk_conf-1-000001db", "__MDC_DIALCALLERNUMINIT=+492286896297") in new stack
    -- Executing [ext@sub_initcall:2] Set("PJSIP/mdc_trunk_conf-1-000001db", "__MDC_DIALCALLEENUMINIT=02285595216") in new stack
    -- Executing [ext@sub_initcall:3] Set("PJSIP/mdc_trunk_conf-1-000001db", "__MDC_DIALCALLEENUMMAP=16") in new stack
    -- Executing [ext@sub_initcall:4] Return("PJSIP/mdc_trunk_conf-1-000001db", "") in new stack
    -- Executing [16@mdc_external:3] Goto("PJSIP/mdc_trunk_conf-1-000001db", "main,16,1") in new stack
    -- Goto (main,16,1)
    -- Executing [16@main:1] ExecIf("PJSIP/mdc_trunk_conf-1-000001db", "0?Set(MDC_MAIN_HOP=0)") in new stack
    -- Executing [16@main:2] Set("PJSIP/mdc_trunk_conf-1-000001db", "MDC_MAIN_HOP=1") in new stack
    -- Executing [16@main:3] GotoIf("PJSIP/mdc_trunk_conf-1-000001db", "0?mdc_loop,s,1") in new stack
    -- Executing [16@main:4] Gosub("PJSIP/mdc_trunk_conf-1-000001db", "sub_defcall,s,1(16)") in new stack
    -- Executing [s@sub_defcall:1] Set("PJSIP/mdc_trunk_conf-1-000001db", "__MDC_ALIAS_HOP=1") in new stack
    -- Executing [s@sub_defcall:2] Set("PJSIP/mdc_trunk_conf-1-000001db", "__MDC_DIALCALLEENUM=16") in new stack
    -- Executing [s@sub_defcall:3] Set("PJSIP/mdc_trunk_conf-1-000001db", "__MDC_DIALCALLERNUM=02286896297") in new stack
    -- Executing [s@sub_defcall:4] Set("PJSIP/mdc_trunk_conf-1-000001db", "__MDC_DIALCALLERLANGUAGE=de") in new stack
    -- Executing [s@sub_defcall:5] Set("PJSIP/mdc_trunk_conf-1-000001db", "__MDC_DIALCALLERNAME=Ulf Kosack") in new stack
    -- Executing [s@sub_defcall:6] Set("PJSIP/mdc_trunk_conf-1-000001db", "__MDC_DIALCHANNELNAME=mdc_trunk_conf-1") in new stack
    -- Executing [s@sub_defcall:7] Return("PJSIP/mdc_trunk_conf-1-000001db", "") in new stack
    -- Executing [16@main:5] GosubIf("PJSIP/mdc_trunk_conf-1-000001db", "1?sub_homer,s,1") in new stack
    -- Executing [s@sub_homer:1] Set("PJSIP/mdc_trunk_conf-1-000001db", "PJSIP_HEADER(remove,P-cs-cid)=") in new stack
    -- Executing [s@sub_homer:2] ExecIf("PJSIP/mdc_trunk_conf-1-000001db", "1?Set(PJSIP_HEADER(add,P-cs-cid)=28d69bab7fcade67@87.137.173.114)") in new stack
    -- Executing [s@sub_homer:3] Return("PJSIP/mdc_trunk_conf-1-000001db", "") in new stack
    -- Executing [16@main:6] Goto("PJSIP/mdc_trunk_conf-1-000001db", "mdc_distribute,16,1") in new stack
    -- Goto (mdc_distribute,16,1)
    -- Executing [16@mdc_distribute:1] Gosub("PJSIP/mdc_trunk_conf-1-000001db", "sub_user,s,1(callee,4,weberm,Michael Weber,16,16)") in new stack
    -- Executing [s@sub_user:1] Verbose("PJSIP/mdc_trunk_conf-1-000001db", "1,sub_user mode callee") in new stack
 sub_user mode callee
    -- Executing [s@sub_user:2] Goto("PJSIP/mdc_trunk_conf-1-000001db", "s-callee,1") in new stack
    -- Goto (sub_user,s-callee,1)
    -- Executing [s-callee@sub_user:1] Verbose("PJSIP/mdc_trunk_conf-1-000001db", "1,sub_user user id: 4 - user: weberm - realname: Michael Weber - own mailbox: 16 - watched mailbox: 16") in new stack
 sub_user user id: 4 - user: weberm - realname: Michael Weber - own mailbox: 16 - watched mailbox: 16
    -- Executing [s-callee@sub_user:2] Set("PJSIP/mdc_trunk_conf-1-000001db", "_MDC_CALLEE_USER_ID=4") in new stack
    -- Executing [s-callee@sub_user:3] Set("PJSIP/mdc_trunk_conf-1-000001db", "_MDC_CALLEE_ACC_NAME=weberm") in new stack
    -- Executing [s-callee@sub_user:4] Set("PJSIP/mdc_trunk_conf-1-000001db", "_MDC_CALLEE_ACC_REALNAME=Michael Weber") in new stack
    -- Executing [s-callee@sub_user:5] Set("PJSIP/mdc_trunk_conf-1-000001db", "_MDC_CALLEE_VM_OWN=16") in new stack
    -- Executing [s-callee@sub_user:6] Set("PJSIP/mdc_trunk_conf-1-000001db", "_MDC_CALLEE_VM_WATCHED=16") in new stack
    -- Executing [s-callee@sub_user:7] Return("PJSIP/mdc_trunk_conf-1-000001db", "") in new stack
    -- Executing [16@mdc_distribute:2] Goto("PJSIP/mdc_trunk_conf-1-000001db", "mdc_ident-4,16,1") in new stack
    -- Goto (mdc_ident-4,16,1)
    -- Executing [16@mdc_ident-4:1] GotoIf("PJSIP/mdc_trunk_conf-1-000001db", "0?mdc_loop,s,1") in new stack
    -- Executing [16@mdc_ident-4:2] Set("PJSIP/mdc_trunk_conf-1-000001db", "MDC_MAIN_HOP=2") in new stack
    -- Executing [16@mdc_ident-4:3] NoOp("PJSIP/mdc_trunk_conf-1-000001db", "alias-check:: call forwarding from 16 - 0") in new stack
    -- Executing [16@mdc_ident-4:4] GotoIf("PJSIP/mdc_trunk_conf-1-000001db", "0?16-uml,1:16-dial,1") in new stack
    -- Goto (mdc_ident-4,16-dial,1)
    -- Executing [16-dial@mdc_ident-4:1] Set("PJSIP/mdc_trunk_conf-1-000001db", "__MDC_EXTEN=16") in new stack
    -- Executing [16-dial@mdc_ident-4:2] Gosub("PJSIP/mdc_trunk_conf-1-000001db", "sub_prefix-16,ext,1") in new stack
    -- Executing [ext@sub_prefix-16:1] GotoIf("PJSIP/mdc_trunk_conf-1-000001db", "1?next_33") in new stack
    -- Goto (sub_prefix-16,ext,4)
    -- Executing [ext@sub_prefix-16:4] Return("PJSIP/mdc_trunk_conf-1-000001db", "") in new stack
    -- Executing [16-dial@mdc_ident-4:3] GotoIf("PJSIP/mdc_trunk_conf-1-000001db", "1?16-unavail,1") in new stack
    -- Goto (mdc_ident-4,16-unavail,1)
    -- Executing [16-unavail@mdc_ident-4:1] Set("PJSIP/mdc_trunk_conf-1-000001db", "__MDC_EXTEN=16") in new stack
    -- Executing [16-unavail@mdc_ident-4:2] Set("PJSIP/mdc_trunk_conf-1-000001db", "DIALSTATUS=CHANUNAVAIL") in new stack
    -- Executing [16-unavail@mdc_ident-4:3] Goto("PJSIP/mdc_trunk_conf-1-000001db", "16-dial,suffix") in new stack
    -- Goto (mdc_ident-4,16-dial,7)
    -- Executing [16-dial@mdc_ident-4:7] Gosub("PJSIP/mdc_trunk_conf-1-000001db", "sub_suffix-16,ext,1") in new stack
    -- Executing [ext@sub_suffix-16:1] GotoIf("PJSIP/mdc_trunk_conf-1-000001db", "1?back") in new stack
    -- Goto (sub_suffix-16,ext,4)
    -- Executing [ext@sub_suffix-16:4] Return("PJSIP/mdc_trunk_conf-1-000001db", "") in new stack
    -- Executing [16-dial@mdc_ident-4:8] ExecIf("PJSIP/mdc_trunk_conf-1-000001db", "0?HangUp(21)") in new stack
    -- Executing [16-dial@mdc_ident-4:9] ExecIf("PJSIP/mdc_trunk_conf-1-000001db", "0?HangUp(19)") in new stack
    -- Executing [16-dial@mdc_ident-4:10] ExecIf("PJSIP/mdc_trunk_conf-1-000001db", "0?HangUp(17):HangUp(20)") in new stack
  == Spawn extension (mdc_ident-4, 16-dial, 10) exited non-zero on 'PJSIP/mdc_trunk_conf-1-000001db'