George, the log below is for determining caller-id and has nothing to do
with user or domain alias. For the meantime, can you make something out
of this log. Registrar is unable to route to the user mailbox.
"2012-10-02T11:51:25.801279Z":1352:SIP:DEBUG:sipx2.callidus.local:SipClientTcp-31:7f01aaded700:SipRegistrar:"SipTransaction::handleChildIncoming
0x7f01b000e4d0 relationship REQUEST parent (nil)"
"2012-10-02T11:51:25.801426Z":1353:SIP:DEBUG:sipx2.callidus.local:SipClientTcp-32:7f01aacec700:SipRegistrar:"SipClient[SipClientTcp-32]::run
resPoll= 1 revents: fd[0]= 1 fd[1]= 0"
"2012-10-02T11:51:25.801446Z":1354:SIP:DEBUG:sipx2.callidus.local:SipClientTcp-32:7f01aacec700:SipRegistrar:"SipClient[SipClientTcp-32]::run
got pipe-select Number of Messages waiting: 1"
"2012-10-02T11:51:25.801462Z":1355:SIP:DEBUG:sipx2.callidus.local:SipClientTcp-32:7f01aacec700:SipRegistrar:"SipClient[SipClientTcp-32]::run
got pipe-select mbTcpOnErrWaitForSend-0 waitingToReportErr-0
mbTcpOnErrWaitForSend-0 repeatedEOFs-0"
"2012-10-02T11:51:25.801543Z":1356:SIP:DEBUG:sipx2.callidus.local:SipRegistrar:7f01caa74700:SipRegistrar:"SipRegistrar::handleMessage()
Start processing SIP message"
"2012-10-02T11:51:25.801925Z":1357:SIP:DEBUG:sipx2.callidus.local:SipRedirectServer-10:7f01ab4f4700:SipRegistrar:"SipRedirectServer::processRedirect
Starting to process request URI 'sip:~~vm~***@callidus.local'"
"2012-10-02T11:51:25.801948Z":1358:SIP:DEBUG:sipx2.callidus.local:SipRedirectServer-10:7f01ab4f4700:SipRegistrar:"[090-USERPARAM]
SipRedirectorUserParam::lookUp disabled by configuration"
"2012-10-02T11:51:25.801978Z":1359:SIP:DEBUG:sipx2.callidus.local:SipRedirectServer-10:7f01ab4f4700:SipRegistrar:"[110-ALIAS]
SipRedirectorAliasDB::lookUp identity: ~~vm~***@callidus.local domain:
callidus.local local-domain: callidus.local isHostAlias: 0"
"2012-10-02T11:51:25.803212Z":1360:ODBC:INFO:sipx2.callidus.local:SipRedirectServer-10:7f01ab4f4700:SipRegistrar:"EntityDB::findByAliasUserId
- Finding entity record for alias ~~vm~201 from namespace imdb.entity"
"2012-10-02T11:51:25.803459Z":1361:ODBC:INFO:sipx2.callidus.local:SipRedirectServer-10:7f01ab4f4700:SipRegistrar:"EntityDB::findByAliasUserId
- Unable to find entity record for alias ~~vm~201 from namespace
imdb.entity"
"2012-10-02T11:51:25.804692Z":1362:SIP:DEBUG:sipx2.callidus.local:SipRedirectServer-10:7f01ab4f4700:SipRegistrar:"[120-REG]
SipRedirectorRegDB::lookUp got 0 unexpired contacts"
"2012-10-02T11:51:25.804732Z":1363:ODBC:INFO:sipx2.callidus.local:SipRedirectServer-10:7f01ab4f4700:SipRegistrar:"EntityDB::findByIdentity
- Finding entity record for ~~vm~***@callidus.local from namespace
imdb.entity"
"2012-10-02T11:51:25.805953Z":1364:ODBC:DEBUG:sipx2.callidus.local:SipRedirectServer-10:7f01ab4f4700:SipRegistrar:"~~vm~***@callidus.local
is NOT present in namespace imdb.entity"
"2012-10-02T11:51:25.805975Z":1365:ODBC:INFO:sipx2.callidus.local:SipRedirectServer-10:7f01ab4f4700:SipRegistrar:"EntityDB::findByIdentity
- Unable to find entity record for ~~vm~***@callidus.local from
namespace imdb.entity"
"2012-10-02T11:51:25.806084Z":1366:SIP:DEBUG:sipx2.callidus.local:SipRedirectServer-10:7f01ab4f4700:SipRegistrar:"UrlMapping::doTransform
adding '<sip:~~vm~~~vm~***@callidus.local>;q=0.1'"
"2012-10-02T11:51:25.806114Z":1367:SIP:DEBUG:sipx2.callidus.local:SipRedirectServer-10:7f01ab4f4700:SipRegistrar:"[130-MAPPING]
SipRedirectorMapping::lookUp got 1 UrlMapping Permission requirements
for 1 contacts"
"2012-10-02T11:51:25.806135Z":1368:ODBC:INFO:sipx2.callidus.local:SipRedirectServer-10:7f01ab4f4700:SipRegistrar:"EntityDB::findByIdentity
- Finding entity record for ~~vm~***@callidus.local from namespace
imdb.entity"
"2012-10-02T11:51:25.807215Z":1369:ODBC:DEBUG:sipx2.callidus.local:SipRedirectServer-10:7f01ab4f4700:SipRegistrar:"~~vm~***@callidus.local
is NOT present in namespace imdb.entity"
"2012-10-02T11:51:25.807242Z":1370:ODBC:INFO:sipx2.callidus.local:SipRedirectServer-10:7f01ab4f4700:SipRegistrar:"EntityDB::findByIdentity
- Unable to find entity record for ~~vm~***@callidus.local from
namespace imdb.entity"
"2012-10-02T11:51:25.808309Z":1371:ODBC:INFO:sipx2.callidus.local:SipRedirectServer-10:7f01ab4f4700:SipRegistrar:"EntityDB::findByAliasUserId
- Finding entity record for alias ~~vm~201 from namespace imdb.entity"
"2012-10-02T11:51:25.808335Z":1372:ODBC:INFO:sipx2.callidus.local:SipRedirectServer-10:7f01ab4f4700:SipRegistrar:"EntityDB::findByAliasUserId
- Unable to find entity record for alias ~~vm~201 from namespace
imdb.entity"
"2012-10-02T11:51:25.808364Z":1373:SIP:DEBUG:sipx2.callidus.local:SipRedirectServer-10:7f01ab4f4700:SipRegistrar:"[130-MAPPING]
SipRedirectorMapping::lookUp checking permissions DB for
urlMappingPermissions[0] = 'Voicemail'"
"2012-10-02T11:51:25.808404Z":1374:SIP:DEBUG:sipx2.callidus.local:SipRedirectServer-10:7f01ab4f4700:SipRegistrar:"[130-MAPPING]
SipRedirectorMapping::lookUp 0 permissions configured for request URI
'sip:~~vm~***@callidus.local'. Checking: "
"2012-10-02T11:51:25.808430Z":1375:SIP:DEBUG:sipx2.callidus.local:SipRedirectServer-10:7f01ab4f4700:SipRegistrar:"SipRedirectorFallback::
unbound entities allowing: FALSE"
"2012-10-02T11:51:25.808483Z":1376:SIP:DEBUG:sipx2.callidus.local:SipRedirectServer-10:7f01ab4f4700:SipRegistrar:"SipXauthIdentity::decode
parse
'\"200\"<sip:***@callidus.local;signature=506AD53C%3A7d6e8fa3dc3cfcc6a62df203b12d9d35>'"
"2012-10-02T11:51:25.808540Z":1377:SIP:DEBUG:sipx2.callidus.local:SipRedirectServer-10:7f01ab4f4700:SipRegistrar:"SipXauthIdentity::decode:
found P-Asserted-Identity '***@callidus.local' in request to
'sip:~~vm~***@callidus.local'"
"2012-10-02T11:51:25.808592Z":1378:SIP:DEBUG:sipx2.callidus.local:SipRedirectServer-10:7f01ab4f4700:SipRegistrar:"[140-FALLBACK]
SipRedirectorFallback::lookUp got 0 UrlMapping Contacts for
sip:~~vm~***@callidus.local @ location ''"
"2012-10-02T11:51:25.808615Z":1379:ODBC:INFO:sipx2.callidus.local:SipRedirectServer-10:7f01ab4f4700:SipRegistrar:"EntityDB::findByIdentity
- Finding entity record for ~~vm~***@callidus.local from namespace
imdb.entity"
"2012-10-02T11:51:25.809687Z":1380:ODBC:DEBUG:sipx2.callidus.local:SipRedirectServer-10:7f01ab4f4700:SipRegistrar:"~~vm~***@callidus.local
is NOT present in namespace imdb.entity"
"2012-10-02T11:51:25.809714Z":1381:ODBC:INFO:sipx2.callidus.local:SipRedirectServer-10:7f01ab4f4700:SipRegistrar:"EntityDB::findByIdentity
- Unable to find entity record for ~~vm~***@callidus.local from
namespace imdb.entity"
"2012-10-02T11:51:25.809741Z":1382:SIP:DEBUG:sipx2.callidus.local:SipRedirectServer-10:7f01ab4f4700:SipRegistrar:"[997-SUBSCRIBE]
SipRedirectorSubscribe::lookUp uri 'sip:~~vm~***@callidus.local'"
"2012-10-02T11:51:25.809766Z":1383:SIP:DEBUG:sipx2.callidus.local:SipRedirectServer-10:7f01ab4f4700:SipRegistrar:"[998-TIMEOFDAY]
SipRedirectorTimeOfDay::processContactList 0 contacts found"
"2012-10-02T11:51:25.809783Z":1384:SIP:DEBUG:sipx2.callidus.local:SipRedirectServer-10:7f01ab4f4700:SipRegistrar:"[999-AUTHROUTER]
SipRedirectorAuthRouter::lookUp 'INVITE' request is neither an INVITE or
SUBSCRIBE or ContactList has no contacts (0) - ignored."
"2012-10-02T11:51:25.809802Z":1385:SIP:DEBUG:sipx2.callidus.local:SipRedirectServer-10:7f01ab4f4700:SipRegistrar:"SipRedirectServer::processRedirect
No contacts added, sending 404 response"
"2012-10-02T11:51:25.809900Z":1386:SIP:DEBUG:sipx2.callidus.local:SipRedirectServer-10:7f01ab4f4700:SipRegistrar:"BranchId::equals(UtlString
'z9hG4bK-XX-0030tMqwaKbhff4odHjumUtstA')
'z9hG4bK-XX-0030tMqwaKbhff4odHjumUtstA'"
This is the content of indetity db
{ "_id" : "Group4", "uid" : "administrators", "dscr" : "Users with
superadmin privileges", "grprsc" : "user", "ent" : "group" }
{ "_id" : "User10", "ident" : "***@callidus.local", "uid" :
"superadmin", "cnt" : "sip:***@callidus.local", "lastUpdated" :
1349178254857, "gr" : [ "administrators" ], "vld" : true, "ent" :
"user", "moh" : "FILES_SRC", "bsyprmpt" : "true", "vcmltui" : "stdui",
"hshpstk" : "6a1f826e099d46d49a0c09192eb52460", "pntk" : "callidus_2",
"imenbld" : false, "imid" : "superadmin", "imdn" : "superadmin",
"cnfentry" : "1", "cnfexit" : "1", "lvmsgbeg" : "0", "lvmsgend" : "0",
"call" : "0", "callfrAny" : "0", "vmondnd" : false, "onphnmsg" : "On the
phone", "advcllsts" : true, "clldttls" : false, "defvmopt" : true, "pa"
: { "lng" : "en" }, "actvgr" : "standard", "rlm" : "callidus.local",
"pstk" : "hZyiVEnKkpJ1", "authtp" : "DIGEST", "als" : [], "prm" : [
"FreeswitchVoicemailServer", "InternationalDialing", "LocalDialing",
"LongDistanceDialing", "Mobile", "TollFree", "Voicemail",
"music-on-hold", "personal-auto-attendant", "subscribe-to-presence",
"superadmin" ], "cfwdtm" : 20 }
{ "_id" : "User11", "ident" : "***@callidus.local", "uid" : "200", "cnt"
: "sip:***@callidus.local", "lastUpdated" : 1349178255004, "gr" : [ ""
], "vld" : true, "ent" : "user", "moh" : "FILES_SRC", "bsyprmpt" :
"true", "vcmltui" : "stdui", "hshpstk" :
"80859c6eb77b573088770c69207f2cce", "pntk" : "password", "imenbld" :
false, "imid" : "200", "imdn" : "200", "cnfentry" : "1", "cnfexit" :
"1", "lvmsgbeg" : "0", "lvmsgend" : "0", "call" : "0", "callfrAny" :
"0", "vmondnd" : false, "onphnmsg" : "On the phone", "advcllsts" : true,
"clldttls" : false, "defvmopt" : true, "pa" : { "lng" : "en" }, "actvgr"
: "standard", "rlm" : "callidus.local", "pstk" : "password", "authtp" :
"DIGEST", "vpntk" : "731ecf0bf2df8034c756e49a255f7651", "als" : [],
"prm" : [ "FreeswitchVoicemailServer", "InternationalDialing",
"LocalDialing", "LongDistanceDialing", "Mobile", "TollFree",
"Voicemail", "music-on-hold", "personal-auto-attendant",
"subscribe-to-presence", "tui-change-pin" ], "cfwdtm" : 20 }
{ "_id" : "User12", "ident" : "***@callidus.local", "uid" : "201", "cnt"
: "sip:***@callidus.local", "lastUpdated" : 1349178255087, "gr" : [ ""
], "vld" : true, "ent" : "user", "moh" : "FILES_SRC", "bsyprmpt" :
"true", "vcmltui" : "stdui", "hshpstk" :
"910cb8a6ea2797c30bc0282278024720", "pntk" : "password", "imenbld" :
false, "imid" : "201", "imdn" : "201", "cnfentry" : "1", "cnfexit" :
"1", "lvmsgbeg" : "0", "lvmsgend" : "0", "call" : "0", "callfrAny" :
"0", "vmondnd" : false, "onphnmsg" : "On the phone", "advcllsts" : true,
"clldttls" : false, "defvmopt" : true, "pa" : { "lng" : "en" }, "actvgr"
: "standard", "rlm" : "callidus.local", "pstk" : "password", "authtp" :
"DIGEST", "vpntk" : "fa62938caba8d89e34814838e77c6655", "als" : [],
"prm" : [ "FreeswitchVoicemailServer", "InternationalDialing",
"LocalDialing", "LongDistanceDialing", "Mobile", "TollFree",
"Voicemail", "music-on-hold", "personal-auto-attendant",
"subscribe-to-presence", "tui-change-pin" ], "cfwdtm" : 20 }
{ "_id" : "extAls", "vld" : true, "ent" : "externalalias", "als" : [] }
{ "_id" : "~~id~acd", "ident" : "~~id~***@callidus.local", "uid" :
"~~id~acd", "ent" : "specialuser", "rlm" : "callidus.local", "pstk" :
"j7ahQcJoH9", "authtp" : "DIGEST", "prm" : [ "InternationalDialing",
"LocalDialing", "LongDistanceDialing", "Mobile", "TollFree" ] }
{ "_id" : "~~id~config", "ident" : "~~id~***@callidus.local", "uid" :
"~~id~config", "ent" : "specialuser", "rlm" : "callidus.local", "pstk" :
"xUKNFEoCmp", "authtp" : "DIGEST", "prm" : [ "InternationalDialing",
"LocalDialing", "LongDistanceDialing", "Mobile", "TollFree" ] }
{ "_id" : "~~id~media", "ident" : "~~id~***@callidus.local", "uid" :
"~~id~media", "ent" : "specialuser", "rlm" : "callidus.local", "pstk" :
"ytnKCLXZi4", "authtp" : "DIGEST", "prm" : [ "InternationalDialing",
"LocalDialing", "LongDistanceDialing", "Mobile", "TollFree" ] }
{ "_id" : "~~id~park", "ident" : "~~id~***@callidus.local", "uid" :
"~~id~park", "ent" : "specialuser", "rlm" : "callidus.local", "pstk" :
"cobgqpNP7E", "authtp" : "DIGEST", "prm" : [ "InternationalDialing",
"LocalDialing", "LongDistanceDialing", "Mobile", "TollFree" ] }
{ "_id" : "~~id~registrar", "ident" : "~~id~***@callidus.local",
"uid" : "~~id~registrar", "ent" : "specialuser", "rlm" :
"callidus.local", "pstk" : "cPFVo6zTY2", "authtp" : "DIGEST", "prm" : [
"InternationalDialing", "LocalDialing", "LongDistanceDialing", "Mobile",
"TollFree" ] }
{ "_id" : "~~id~sipXprovision", "ident" :
"~~id~***@callidus.local", "uid" : "~~id~sipXprovision", "ent"
: "specialuser", "rlm" : "callidus.local", "pstk" : "YOWT6JvHMd",
"authtp" : "DIGEST" }
{ "_id" : "~~id~sipXrls", "ident" : "~~id~***@callidus.local", "uid"
: "~~id~sipXrls", "ent" : "specialuser", "rlm" : "callidus.local",
"pstk" : "I8OR59vQXH", "authtp" : "DIGEST", "prm" : [
"InternationalDialing", "LocalDialing", "LongDistanceDialing", "Mobile",
"TollFree" ] }
{ "_id" : "~~id~sipXsaa", "ident" : "~~id~***@callidus.local", "uid"
: "~~id~sipXsaa", "ent" : "specialuser", "rlm" : "callidus.local",
"pstk" : "eT8C4ecUDR", "authtp" : "DIGEST", "prm" : [
"InternationalDialing", "LocalDialing", "LongDistanceDialing", "Mobile",
"TollFree" ] }
{ "_id" : "~~id~xmpprlsclient", "ident" :
"~~id~***@callidus.local", "uid" : "~~id~xmpprlsclient", "ent"
: "specialuser", "rlm" : "callidus.local", "pstk" : "tk2Li2iAYh",
"authtp" : "DIGEST", "prm" : [ "InternationalDialing", "LocalDialing",
"LongDistanceDialing", "Mobile", "TollFree" ] }
On 10/02/2012 08:41 PM, George Niculae wrote:
> On Tue, Oct 2, 2012 at 3:16 PM, darthzejdr <***@gmail.com> wrote:
>> Changed to ip address, everything is still the same
>>
> IMO it really looks like the domain alias issue we seen in latest 4.4
> build, will need Joegen's call to be sure
>
> 2012-10-02T11:51:25.797451Z":11702:SIP:DEBUG:sipx2.callidus.local:SipClientUdp-10:7fb0afa0b700:SipXProxy:"SipTransaction::handleChildIncoming
> 0x7fb0a801af80 relationship PROVISIONAL parent (nil)"
> "2012-10-02T11:51:25.797655Z":11703:ODBC:DEBUG:sipx2.callidus.local:SipRouter-12:7fb0ad9c0700:SipXProxy:"***@192.168.0.47
> is NOT present in namespace imdb.entity"
> "2012-10-02T11:51:25.797678Z":11704:ODBC:INFO:sipx2.callidus.local:SipRouter-12:7fb0ad9c0700:SipXProxy:"EntityDB::findByIdentity
> - Unable to find entity record for ***@192.168.0.47 from namespace
> imdb.entity"
> "2012-10-02T11:51:25.797702Z":11705:ODBC:INFO:sipx2.callidus.local:SipRouter-12:7fb0ad9c0700:SipXProxy:"EntityDB::findByIdentity
> - Finding entity record for callidus.local from namespace imdb.entity"
> "2012-10-02T11:51:25.797808Z":11706:SIP:DEBUG:sipx2.callidus.local:SipClientUdp-10:7fb0afa0b700:SipXProxy:"SipUserAgent::dispatch
> resentWithAuth 0"
> "2012-10-02T11:51:25.798772Z":11707:ODBC:DEBUG:sipx2.callidus.local:SipRouter-12:7fb0ad9c0700:SipXProxy:"callidus.local
> is NOT present in namespace imdb.entity"
> "2012-10-02T11:51:25.798799Z":11708:ODBC:INFO:sipx2.callidus.local:SipRouter-12:7fb0ad9c0700:SipXProxy:"EntityDB::findByIdentity
> - Unable to find entity record for callidus.local from namespace
> imdb.entity"
> "2012-10-02T11:51:25.798823Z":11709:SIP:WARNING:sipx2.callidus.local:SipRouter-12:7fb0ad9c0700:SipXProxy:"CallerAlias::getCallerAlias
> - No caller alias configured for identity=***@192.168.0.47
>
> George
> _______________________________________________
> sipx-users mailing list
> sipx-***@list.sipfoundry.org
> List Archive: http://list.sipfoundry.org/archive/sipx-users/
>