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:[email protected]'" "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: [email protected] 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 [email protected] from namespace imdb.entity" "2012-10-02T11:51:25.805953Z":1364:ODBC:DEBUG:sipx2.callidus.local:SipRedirectServer-10:7f01ab4f4700:SipRegistrar:"[email protected] 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 [email protected] from namespace imdb.entity" "2012-10-02T11:51:25.806084Z":1366:SIP:DEBUG:sipx2.callidus.local:SipRedirectServer-10:7f01ab4f4700:SipRegistrar:"UrlMapping::doTransform adding '<sip:[email protected]>;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 [email protected] from namespace imdb.entity" "2012-10-02T11:51:25.807215Z":1369:ODBC:DEBUG:sipx2.callidus.local:SipRedirectServer-10:7f01ab4f4700:SipRegistrar:"[email protected] 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 [email protected] 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:[email protected]'. 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:[email protected];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 '[email protected]' in request to 'sip:[email protected]'" "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:[email protected] @ location ''" "2012-10-02T11:51:25.808615Z":1379:ODBC:INFO:sipx2.callidus.local:SipRedirectServer-10:7f01ab4f4700:SipRegistrar:"EntityDB::findByIdentity - Finding entity record for [email protected] from namespace imdb.entity" "2012-10-02T11:51:25.809687Z":1380:ODBC:DEBUG:sipx2.callidus.local:SipRedirectServer-10:7f01ab4f4700:SipRegistrar:"[email protected] 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 [email protected] 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:[email protected]'" "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" : "[email protected]", "uid" : "superadmin", "cnt" : "sip:[email protected]", "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" : "[email protected]", "uid" : "200", "cnt" : "sip:[email protected]", "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" : "[email protected]", "uid" : "201", "cnt" : "sip:[email protected]", "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" : "[email protected]", "uid" : "~~id~acd", "ent" : "specialuser", "rlm" : "callidus.local", "pstk" : "j7ahQcJoH9", "authtp" : "DIGEST", "prm" : [ "InternationalDialing", "LocalDialing", "LongDistanceDialing", "Mobile", "TollFree" ] } { "_id" : "~~id~config", "ident" : "[email protected]", "uid" : "~~id~config", "ent" : "specialuser", "rlm" : "callidus.local", "pstk" : "xUKNFEoCmp", "authtp" : "DIGEST", "prm" : [ "InternationalDialing", "LocalDialing", "LongDistanceDialing", "Mobile", "TollFree" ] } { "_id" : "~~id~media", "ident" : "[email protected]", "uid" : "~~id~media", "ent" : "specialuser", "rlm" : "callidus.local", "pstk" : "ytnKCLXZi4", "authtp" : "DIGEST", "prm" : [ "InternationalDialing", "LocalDialing", "LongDistanceDialing", "Mobile", "TollFree" ] } { "_id" : "~~id~park", "ident" : "[email protected]", "uid" : "~~id~park", "ent" : "specialuser", "rlm" : "callidus.local", "pstk" : "cobgqpNP7E", "authtp" : "DIGEST", "prm" : [ "InternationalDialing", "LocalDialing", "LongDistanceDialing", "Mobile", "TollFree" ] } { "_id" : "~~id~registrar", "ident" : "[email protected]", "uid" : "~~id~registrar", "ent" : "specialuser", "rlm" : "callidus.local", "pstk" : "cPFVo6zTY2", "authtp" : "DIGEST", "prm" : [ "InternationalDialing", "LocalDialing", "LongDistanceDialing", "Mobile", "TollFree" ] } { "_id" : "~~id~sipXprovision", "ident" : "[email protected]", "uid" : "~~id~sipXprovision", "ent" : "specialuser", "rlm" : "callidus.local", "pstk" : "YOWT6JvHMd", "authtp" : "DIGEST" } { "_id" : "~~id~sipXrls", "ident" : "[email protected]", "uid" : "~~id~sipXrls", "ent" : "specialuser", "rlm" : "callidus.local", "pstk" : "I8OR59vQXH", "authtp" : "DIGEST", "prm" : [ "InternationalDialing", "LocalDialing", "LongDistanceDialing", "Mobile", "TollFree" ] } { "_id" : "~~id~sipXsaa", "ident" : "[email protected]", "uid" : "~~id~sipXsaa", "ent" : "specialuser", "rlm" : "callidus.local", "pstk" : "eT8C4ecUDR", "authtp" : "DIGEST", "prm" : [ "InternationalDialing", "LocalDialing", "LongDistanceDialing", "Mobile", "TollFree" ] } { "_id" : "~~id~xmpprlsclient", "ident" : "[email protected]", "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 <[email protected]> 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:"[email protected] > 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 [email protected] 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 [email protected] > > George > _______________________________________________ > sipx-users mailing list > [email protected] > List Archive: http://list.sipfoundry.org/archive/sipx-users/ > _______________________________________________ sipx-users mailing list [email protected] List Archive: http://list.sipfoundry.org/archive/sipx-users/
