-- Executing [int@origination:1] Verbose("SIP/lmadsen#lmentinc-082ed288", "1|--> Handling call to internal extension 102") in new stack
 --> Handling call to internal extension 102
    -- Executing [int@origination:2] Verbose("SIP/lmadsen#lmentinc-082ed288", "1|...finding out who 102 is") in new stack
 ...finding out who 102 is
    -- Executing [int@origination:3] Set("SIP/lmadsen#lmentinc-082ed288", "HASH(EXT_INFO)=lmadsen2") in new stack
[Mar  8 10:21:22] DEBUG[8597]: func_odbc.c:133 array: array (user_name=lmadsen2)
[Mar  8 10:21:22] DEBUG[8597]: func_odbc.c:145 array: array set value (user_name=lmadsen2)
    -- Executing [int@origination:4] Set("SIP/lmadsen#lmentinc-082ed288", "HASH(EXT_STATUS)=1") in new stack
[Mar  8 10:21:22] DEBUG[8597]: func_odbc.c:133 array: array (status=1)
[Mar  8 10:21:22] DEBUG[8597]: func_odbc.c:145 array: array set value (status=1)
    -- Executing [int@origination:5] GotoIf("SIP/lmadsen#lmentinc-082ed288", "0?not_assigned|1") in new stack
    -- Executing [int@origination:6] GotoIf("SIP/lmadsen#lmentinc-082ed288", "0?disconnected|1") in new stack
    -- Executing [int@origination:7] Gosub("SIP/lmadsen#lmentinc-082ed288", "sub-feature_status|s|1()") in new stack
[Mar  8 10:21:22] DEBUG[8597]: app_stack.c:179 gosub_exec: Setting gosub return address to '0:origination|int|8'
    -- Executing [s@sub-feature_status:1] NoOp("SIP/lmadsen#lmentinc-082ed288", "") in new stack
    -- Executing [s@sub-feature_status:2] Exec("SIP/lmadsen#lmentinc-082ed288", "NoOp()") in new stack
    -- Executing [s@sub-feature_status:3] Verbose("SIP/lmadsen#lmentinc-082ed288", "1|Setting HASH(feature_status) for lmadsen@lmentinc(6)") in new stack
 Setting HASH(feature_status) for lmadsen@lmentinc(6)
[Mar  8 10:21:22] WARNING[8597]: res_odbc.c:101 ast_odbc_prepare_and_execute: SQL Execute returned an error -1: 01000: [unixODBC]Error while executing the query (non-fatal);
ERROR:  function user_features_bad(integer) does not exist (113)