Hi All, Suddenly our phone Registration failed and its not registering back......Please check the attached register and proxy logs
Regards, Kumaran T
"2012-04-04T09:46:55.367267Z":25331:SIP:DEBUG:sipx-test.ttplservices.com:SipUserAgent-13:7f517fcfc700:SipRegistrar:"SipUserAgent[SipUserAgent-13]::handleMessage calling garbageCollection()" "2012-04-04T09:46:55.370019Z":25332:HTTP:DEBUG:sipx-test.ttplservices.com:OsTimer-10:7f518f9db700:SipRegistrar:"HttpConnectionMap::getPersistentConnection - Found ConnectionMapEntry-0 for http::80, socket 0x7f516c001460" "2012-04-04T09:46:55.370134Z":25333:HTTP:DEBUG:sipx-test.ttplservices.com:OsTimer-10:7f518f9db700:SipRegistrar:"HttpMessage::get[4] sent request" "2012-04-04T09:46:55.370179Z":25334:HTTP:DEBUG:sipx-test.ttplservices.com:OsTimer-10:7f518f9db700:SipRegistrar:"HttpMessage::get[4] read returned 0 bytes" "2012-04-04T09:46:55.370205Z":25335:HTTP:DEBUG:sipx-test.ttplservices.com:OsTimer-10:7f518f9db700:SipRegistrar:"HttpMessage::get[4] Receiving failed on persistent connection on try 0" "2012-04-04T09:46:55.370232Z":25336:KERNEL:INFO:sipx-test.ttplservices.com:OsTimer-10:7f518f9db700:SipRegistrar:"OsConnectionSocket::~" "2012-04-04T09:46:55.370291Z":25337:KERNEL:DEBUG:sipx-test.ttplservices.com:OsTimer-10:7f518f9db700:SipRegistrar:"OsSocket::~ close socket 21" "2012-04-04T09:46:55.370327Z":25338:KERNEL:DEBUG:sipx-test.ttplservices.com:OsTimer-10:7f518f9db700:SipRegistrar:"OsConnectionSocket::_ attempt :80 BLOCKING timeout 4000" "2012-04-04T09:46:55.370361Z":25339:KERNEL:DEBUG:sipx-test.ttplservices.com:OsTimer-10:7f518f9db700:SipRegistrar:"OsSocket::makeNonblocking 21" "2012-04-04T09:46:55.370451Z":25340:KERNEL:DEBUG:sipx-test.ttplservices.com:OsTimer-10:7f518f9db700:SipRegistrar:"OsConnectionSocket::_: connecting to host at: 127.0.0.1:80" "2012-04-04T09:46:55.370484Z":25341:KERNEL:DEBUG:sipx-test.ttplservices.com:OsTimer-10:7f518f9db700:SipRegistrar:"OsConnectionSocket::_ connect 21" "2012-04-04T09:46:55.370579Z":25342:KERNEL:DEBUG:sipx-test.ttplservices.com:OsTimer-10:7f518f9db700:SipRegistrar:"OsConnectionSocket::_ poll 21 timeout 4000 msec" "2012-04-04T09:46:55.370612Z":25343:KERNEL:DEBUG:sipx-test.ttplservices.com:OsTimer-10:7f518f9db700:SipRegistrar:"OsConnectionSocket::_ after poll(), error = 0" "2012-04-04T09:46:55.370636Z":25344:KERNEL:DEBUG:sipx-test.ttplservices.com:OsTimer-10:7f518f9db700:SipRegistrar:"OsSocket::makeBlocking 21" "2012-04-04T09:46:55.370661Z":25345:KERNEL:INFO:sipx-test.ttplservices.com:OsTimer-10:7f518f9db700:SipRegistrar:"OsConnectionSocket::_[5] connected 21 to localhost:80" "2012-04-04T09:46:55.370770Z":25346:HTTP:DEBUG:sipx-test.ttplservices.com:OsTimer-10:7f518f9db700:SipRegistrar:"HttpMessage::get[4] sent request" "2012-04-04T09:46:55.371050Z":25347:HTTP:DEBUG:sipx-test.ttplservices.com:OsTimer-10:7f518f9db700:SipRegistrar:"HttpMessage::read contentLength 295, contentTypeSet 1, contentType 'text/html; charset=iso-8859-1'" "2012-04-04T09:46:55.371092Z":25348:HTTP:DEBUG:sipx-test.ttplservices.com:OsTimer-10:7f518f9db700:SipRegistrar:"HttpMessage::read full msg rcvd bytes 477: header: 182 content: 295" "2012-04-04T09:46:55.371135Z":25349:HTTP:DEBUG:sipx-test.ttplservices.com:OsTimer-10:7f518f9db700:SipRegistrar:"HttpMessage::get[4] read returned 477 bytes" "2012-04-04T09:46:55.371168Z":25350:HTTP:DEBUG:sipx-test.ttplservices.com:OsTimer-10:7f518f9db700:SipRegistrar:"HttpMessage::get[4] returning 400 response" "2012-04-04T09:46:55.371202Z":25351:XMLRPC:DEBUG:sipx-test.ttplservices.com:OsTimer-10:7f518f9db700:SipRegistrar:"mpResponseBody::setFault -7 Bad Request" "2012-04-04T09:46:55.371227Z":25352:XMLRPC:INFO:sipx-test.ttplservices.com:OsTimer-10:7f518f9db700:SipRegistrar:"XmlRpcRequest::execute http request failed; status = 400 Bad Request" "2012-04-04T09:46:55.371263Z":25353:NAT:ERR:sipx-test.ttplservices.com:OsTimer-10:7f518f9db700:SipRegistrar:"SipRedirectorPresenceRouting::registerPresenceMonitorRequestWithOpenfire failed to execute() request: -7 : Bad Request" "2012-04-04T09:46:55.371300Z":25354:NAT:ERR:sipx-test.ttplservices.com:OsTimer-10:7f518f9db700:SipRegistrar:"[900-PRESENCE] SipRedirectorPresenceRouting::signal: failed to reconnect with openfire - retrying later" "2012-04-04T09:46:55.373946Z":25355:SIP:DEBUG:sipx-test.ttplservices.com:SipUserAgent-25:7f517f4f4700:SipRegistrar:"SipUserAgent[SipUserAgent-25]::handleMessage calling garbageCollection()" "2012-04-04T09:47:03.356043Z":25356:SIP:DEBUG:sipx-test.ttplservices.com:SipUserAgent-3:7f518f8da700:SipRegistrar:"SipUserAgent[SipUserAgent-3]::handleMessage calling garbageCollection()" "2012-04-04T09:47:03.367229Z":25357:SIP:DEBUG:sipx-test.ttplservices.com:SipUserAgent-13:7f517fcfc700:SipRegistrar:"SipUserAgent[SipUserAgent-13]::handleMessage calling garbageCollection()" "2012-04-04T09:47:03.372537Z":25358:SIP:DEBUG:sipx-test.ttplservices.com:SipUserAgent-25:7f517f4f4700:SipRegistrar:"SipUserAgent[SipUserAgent-25]::handleMessage calling garbageCollection()" "2012-04-04T09:47:11.356065Z":25359:SIP:DEBUG:sipx-test.ttplservices.com:SipUserAgent-3:7f518f8da700:SipRegistrar:"SipUserAgent[SipUserAgent-3]::handleMessage calling garbageCollection()" "2012-04-04T09:47:11.367209Z":25360:SIP:DEBUG:sipx-test.ttplservices.com:SipUserAgent-13:7f517fcfc700:SipRegistrar:"SipUserAgent[SipUserAgent-13]::handleMessage calling garbageCollection()" "2012-04-04T09:47:11.372560Z":25361:SIP:DEBUG:sipx-test.ttplservices.com:SipUserAgent-25:7f517f4f4700:SipRegistrar:"SipUserAgent[SipUserAgent-25]::handleMessage calling garbageCollection()" "2012-04-04T09:47:15.370029Z":25362:HTTP:DEBUG:sipx-test.ttplservices.com:OsTimer-10:7f518f9db700:SipRegistrar:"HttpConnectionMap::getPersistentConnection - Found ConnectionMapEntry-0 for http::80, socket 0x7f516c001460" "2012-04-04T09:47:15.370149Z":25363:HTTP:DEBUG:sipx-test.ttplservices.com:OsTimer-10:7f518f9db700:SipRegistrar:"HttpMessage::get[4] sent request" "2012-04-04T09:47:15.370188Z":25364:HTTP:DEBUG:sipx-test.ttplservices.com:OsTimer-10:7f518f9db700:SipRegistrar:"HttpMessage::get[4] read returned 0 bytes" "2012-04-04T09:47:15.370209Z":25365:HTTP:DEBUG:sipx-test.ttplservices.com:OsTimer-10:7f518f9db700:SipRegistrar:"HttpMessage::get[4] Receiving failed on persistent connection on try 0" "2012-04-04T09:47:15.370231Z":25366:KERNEL:INFO:sipx-test.ttplservices.com:OsTimer-10:7f518f9db700:SipRegistrar:"OsConnectionSocket::~" "2012-04-04T09:47:15.370265Z":25367:KERNEL:DEBUG:sipx-test.ttplservices.com:OsTimer-10:7f518f9db700:SipRegistrar:"OsSocket::~ close socket 21" "2012-04-04T09:47:15.370289Z":25368:KERNEL:DEBUG:sipx-test.ttplservices.com:OsTimer-10:7f518f9db700:SipRegistrar:"OsConnectionSocket::_ attempt :80 BLOCKING timeout 4000" "2012-04-04T09:47:15.370316Z":25369:KERNEL:DEBUG:sipx-test.ttplservices.com:OsTimer-10:7f518f9db700:SipRegistrar:"OsSocket::makeNonblocking 21" "2012-04-04T09:47:15.370396Z":25370:KERNEL:DEBUG:sipx-test.ttplservices.com:OsTimer-10:7f518f9db700:SipRegistrar:"OsConnectionSocket::_: connecting to host at: 127.0.0.1:80" "2012-04-04T09:47:15.370423Z":25371:KERNEL:DEBUG:sipx-test.ttplservices.com:OsTimer-10:7f518f9db700:SipRegistrar:"OsConnectionSocket::_ connect 21" "2012-04-04T09:47:15.370505Z":25372:KERNEL:DEBUG:sipx-test.ttplservices.com:OsTimer-10:7f518f9db700:SipRegistrar:"OsConnectionSocket::_ poll 21 timeout 4000 msec" "2012-04-04T09:47:15.370532Z":25373:KERNEL:DEBUG:sipx-test.ttplservices.com:OsTimer-10:7f518f9db700:SipRegistrar:"OsConnectionSocket::_ after poll(), error = 0" "2012-04-04T09:47:15.370552Z":25374:KERNEL:DEBUG:sipx-test.ttplservices.com:OsTimer-10:7f518f9db700:SipRegistrar:"OsSocket::makeBlocking 21" "2012-04-04T09:47:15.370573Z":25375:KERNEL:INFO:sipx-test.ttplservices.com:OsTimer-10:7f518f9db700:SipRegistrar:"OsConnectionSocket::_[5] connected 21 to localhost:80" "2012-04-04T09:47:15.370666Z":25376:HTTP:DEBUG:sipx-test.ttplservices.com:OsTimer-10:7f518f9db700:SipRegistrar:"HttpMessage::get[4] sent request" "2012-04-04T09:47:15.370908Z":25377:HTTP:DEBUG:sipx-test.ttplservices.com:OsTimer-10:7f518f9db700:SipRegistrar:"HttpMessage::read contentLength 295, contentTypeSet 1, contentType 'text/html; charset=iso-8859-1'" "2012-04-04T09:47:15.370943Z":25378:HTTP:DEBUG:sipx-test.ttplservices.com:OsTimer-10:7f518f9db700:SipRegistrar:"HttpMessage::read full msg rcvd bytes 477: header: 182 content: 295" "2012-04-04T09:47:15.371000Z":25379:HTTP:DEBUG:sipx-test.ttplservices.com:OsTimer-10:7f518f9db700:SipRegistrar:"HttpMessage::get[4] read returned 477 bytes" "2012-04-04T09:47:15.371031Z":25380:HTTP:DEBUG:sipx-test.ttplservices.com:OsTimer-10:7f518f9db700:SipRegistrar:"HttpMessage::get[4] returning 400 response" "2012-04-04T09:47:15.371059Z":25381:XMLRPC:DEBUG:sipx-test.ttplservices.com:OsTimer-10:7f518f9db700:SipRegistrar:"mpResponseBody::setFault -7 Bad Request" "2012-04-04T09:47:15.371080Z":25382:XMLRPC:INFO:sipx-test.ttplservices.com:OsTimer-10:7f518f9db700:SipRegistrar:"XmlRpcRequest::execute http request failed; status = 400 Bad Request" "2012-04-04T09:47:15.371109Z":25383:NAT:ERR:sipx-test.ttplservices.com:OsTimer-10:7f518f9db700:SipRegistrar:"SipRedirectorPresenceRouting::registerPresenceMonitorRequestWithOpenfire failed to execute() request: -7 : Bad Request" "2012-04-04T09:47:15.371140Z":25384:NAT:ERR:sipx-test.ttplservices.com:OsTimer-10:7f518f9db700:SipRegistrar:"[900-PRESENCE] SipRedirectorPresenceRouting::signal: failed to reconnect with openfire - retrying later" "2012-04-04T09:47:19.356056Z":25385:SIP:DEBUG:sipx-test.ttplservices.com:SipUserAgent-3:7f518f8da700:SipRegistrar:"SipUserAgent[SipUserAgent-3]::handleMessage calling garbageCollection()" "2012-04-04T09:47:19.367258Z":25386:SIP:DEBUG:sipx-test.ttplservices.com:SipUserAgent-13:7f517fcfc700:SipRegistrar:"SipUserAgent[SipUserAgent-13]::handleMessage calling garbageCollection()" "2012-04-04T09:47:19.372522Z":25387:SIP:DEBUG:sipx-test.ttplservices.com:SipUserAgent-25:7f517f4f4700:SipRegistrar:"SipUserAgent[SipUserAgent-25]::handleMessage calling garbageCollection()" "2012-04-04T09:47:27.355999Z":25388:SIP:DEBUG:sipx-test.ttplservices.com:SipUserAgent-3:7f518f8da700:SipRegistrar:"SipUserAgent[SipUserAgent-3]::handleMessage calling garbageCollection()" "2012-04-04T09:47:27.367200Z":25389:SIP:DEBUG:sipx-test.ttplservices.com:SipUserAgent-13:7f517fcfc700:SipRegistrar:"SipUserAgent[SipUserAgent-13]::handleMessage calling garbageCollection()" "2012-04-04T09:47:27.372466Z":25390:SIP:DEBUG:sipx-test.ttplservices.com:SipUserAgent-25:7f517f4f4700:SipRegistrar:"SipUserAgent[SipUserAgent-25]::handleMessage calling garbageCollection()" "2012-04-04T09:47:35.356039Z":25391:SIP:DEBUG:sipx-test.ttplservices.com:SipUserAgent-3:7f518f8da700:SipRegistrar:"SipUserAgent[SipUserAgent-3]::handleMessage calling garbageCollection()" "2012-04-04T09:47:35.367249Z":25392:SIP:DEBUG:sipx-test.ttplservices.com:SipUserAgent-13:7f517fcfc700:SipRegistrar:"SipUserAgent[SipUserAgent-13]::handleMessage calling garbageCollection()" "2012-04-04T09:47:35.370008Z":25393:HTTP:DEBUG:sipx-test.ttplservices.com:OsTimer-10:7f518f9db700:SipRegistrar:"HttpConnectionMap::getPersistentConnection - Found ConnectionMapEntry-0 for http::80, socket 0x7f516c001460" "2012-04-04T09:47:35.370136Z":25394:HTTP:DEBUG:sipx-test.ttplservices.com:OsTimer-10:7f518f9db700:SipRegistrar:"HttpMessage::get[4] sent request" "2012-04-04T09:47:35.370183Z":25395:HTTP:DEBUG:sipx-test.ttplservices.com:OsTimer-10:7f518f9db700:SipRegistrar:"HttpMessage::get[4] read returned 0 bytes" "2012-04-04T09:47:35.370209Z":25396:HTTP:DEBUG:sipx-test.ttplservices.com:OsTimer-10:7f518f9db700:SipRegistrar:"HttpMessage::get[4] Receiving failed on persistent connection on try 0" "2012-04-04T09:47:35.370237Z":25397:KERNEL:INFO:sipx-test.ttplservices.com:OsTimer-10:7f518f9db700:SipRegistrar:"OsConnectionSocket::~" "2012-04-04T09:47:35.370280Z":25398:KERNEL:DEBUG:sipx-test.ttplservices.com:OsTimer-10:7f518f9db700:SipRegistrar:"OsSocket::~ close socket 21" "2012-04-04T09:47:35.370310Z":25399:KERNEL:DEBUG:sipx-test.ttplservices.com:OsTimer-10:7f518f9db700:SipRegistrar:"OsConnectionSocket::_ attempt :80 BLOCKING timeout 4000" "2012-04-04T09:47:35.370345Z":25400:KERNEL:DEBUG:sipx-test.ttplservices.com:OsTimer-10:7f518f9db700:SipRegistrar:"OsSocket::makeNonblocking 21" "2012-04-04T09:47:35.370480Z":25401:KERNEL:DEBUG:sipx-test.ttplservices.com:OsTimer-10:7f518f9db700:SipRegistrar:"OsConnectionSocket::_: connecting to host at: 127.0.0.1:80" "2012-04-04T09:47:35.370514Z":25402:KERNEL:DEBUG:sipx-test.ttplservices.com:OsTimer-10:7f518f9db700:SipRegistrar:"OsConnectionSocket::_ connect 21" "2012-04-04T09:47:35.370622Z":25403:KERNEL:DEBUG:sipx-test.ttplservices.com:OsTimer-10:7f518f9db700:SipRegistrar:"OsConnectionSocket::_ poll 21 timeout 4000 msec" "2012-04-04T09:47:35.370655Z":25404:KERNEL:DEBUG:sipx-test.ttplservices.com:OsTimer-10:7f518f9db700:SipRegistrar:"OsConnectionSocket::_ after poll(), error = 0" "2012-04-04T09:47:35.370679Z":25405:KERNEL:DEBUG:sipx-test.ttplservices.com:OsTimer-10:7f518f9db700:SipRegistrar:"OsSocket::makeBlocking 21" "2012-04-04T09:47:35.370704Z":25406:KERNEL:INFO:sipx-test.ttplservices.com:OsTimer-10:7f518f9db700:SipRegistrar:"OsConnectionSocket::_[5] connected 21 to localhost:80" "2012-04-04T09:47:35.370815Z":25407:HTTP:DEBUG:sipx-test.ttplservices.com:OsTimer-10:7f518f9db700:SipRegistrar:"HttpMessage::get[4] sent request" "2012-04-04T09:47:35.371097Z":25408:HTTP:DEBUG:sipx-test.ttplservices.com:OsTimer-10:7f518f9db700:SipRegistrar:"HttpMessage::read contentLength 295, contentTypeSet 1, contentType 'text/html; charset=iso-8859-1'" "2012-04-04T09:47:35.371155Z":25409:HTTP:DEBUG:sipx-test.ttplservices.com:OsTimer-10:7f518f9db700:SipRegistrar:"HttpMessage::read full msg rcvd bytes 477: header: 182 content: 295" "2012-04-04T09:47:35.371203Z":25410:HTTP:DEBUG:sipx-test.ttplservices.com:OsTimer-10:7f518f9db700:SipRegistrar:"HttpMessage::get[4] read returned 477 bytes" "2012-04-04T09:47:35.371236Z":25411:HTTP:DEBUG:sipx-test.ttplservices.com:OsTimer-10:7f518f9db700:SipRegistrar:"HttpMessage::get[4] returning 400 response" "2012-04-04T09:47:35.371269Z":25412:XMLRPC:DEBUG:sipx-test.ttplservices.com:OsTimer-10:7f518f9db700:SipRegistrar:"mpResponseBody::setFault -7 Bad Request" "2012-04-04T09:47:35.371295Z":25413:XMLRPC:INFO:sipx-test.ttplservices.com:OsTimer-10:7f518f9db700:SipRegistrar:"XmlRpcRequest::execute http request failed; status = 400 Bad Request" "2012-04-04T09:47:35.371330Z":25414:NAT:ERR:sipx-test.ttplservices.com:OsTimer-10:7f518f9db700:SipRegistrar:"SipRedirectorPresenceRouting::registerPresenceMonitorRequestWithOpenfire failed to execute() request: -7 : Bad Request" "2012-04-04T09:47:35.371367Z":25415:NAT:ERR:sipx-test.ttplservices.com:OsTimer-10:7f518f9db700:SipRegistrar:"[900-PRESENCE] SipRedirectorPresenceRouting::signal: failed to reconnect with openfire - retrying later" "2012-04-04T09:47:35.374028Z":25416:SIP:DEBUG:sipx-test.ttplservices.com:SipUserAgent-25:7f517f4f4700:SipRegistrar:"SipUserAgent[SipUserAgent-25]::handleMessage calling garbageCollection()" "2012-04-04T09:47:43.356041Z":25417:SIP:DEBUG:sipx-test.ttplservices.com:SipUserAgent-3:7f518f8da700:SipRegistrar:"SipUserAgent[SipUserAgent-3]::handleMessage calling garbageCollection()" "2012-04-04T09:47:43.367212Z":25418:SIP:DEBUG:sipx-test.ttplservices.com:SipUserAgent-13:7f517fcfc700:SipRegistrar:"SipUserAgent[SipUserAgent-13]::handleMessage calling garbageCollection()" "2012-04-04T09:47:43.372510Z":25419:SIP:DEBUG:sipx-test.ttplservices.com:SipUserAgent-25:7f517f4f4700:SipRegistrar:"SipUserAgent[SipUserAgent-25]::handleMessage calling garbageCollection()" "2012-04-04T09:47:51.356076Z":25420:SIP:DEBUG:sipx-test.ttplservices.com:SipUserAgent-3:7f518f8da700:SipRegistrar:"SipUserAgent[SipUserAgent-3]::handleMessage calling garbageCollection()" "2012-04-04T09:47:51.367236Z":25421:SIP:DEBUG:sipx-test.ttplservices.com:SipUserAgent-13:7f517fcfc700:SipRegistrar:"SipUserAgent[SipUserAgent-13]::handleMessage calling garbageCollection()" "2012-04-04T09:47:51.372524Z":25422:SIP:DEBUG:sipx-test.ttplservices.com:SipUserAgent-25:7f517f4f4700:SipRegistrar:"SipUserAgent[SipUserAgent-25]::handleMessage calling garbageCollection()" "2012-04-04T09:47:55.370044Z":25423:HTTP:DEBUG:sipx-test.ttplservices.com:OsTimer-10:7f518f9db700:SipRegistrar:"HttpConnectionMap::getPersistentConnection - Found ConnectionMapEntry-0 for http::80, socket 0x7f516c001460" "2012-04-04T09:47:55.370167Z":25424:HTTP:DEBUG:sipx-test.ttplservices.com:OsTimer-10:7f518f9db700:SipRegistrar:"HttpMessage::get[4] sent request" "2012-04-04T09:47:55.370215Z":25425:HTTP:DEBUG:sipx-test.ttplservices.com:OsTimer-10:7f518f9db700:SipRegistrar:"HttpMessage::get[4] read returned 0 bytes" "2012-04-04T09:47:55.370237Z":25426:HTTP:DEBUG:sipx-test.ttplservices.com:OsTimer-10:7f518f9db700:SipRegistrar:"HttpMessage::get[4] Receiving failed on persistent connection on try 0" "2012-04-04T09:47:55.370259Z":25427:KERNEL:INFO:sipx-test.ttplservices.com:OsTimer-10:7f518f9db700:SipRegistrar:"OsConnectionSocket::~" "2012-04-04T09:47:55.370295Z":25428:KERNEL:DEBUG:sipx-test.ttplservices.com:OsTimer-10:7f518f9db700:SipRegistrar:"OsSocket::~ close socket 21" "2012-04-04T09:47:55.370319Z":25429:KERNEL:DEBUG:sipx-test.ttplservices.com:OsTimer-10:7f518f9db700:SipRegistrar:"OsConnectionSocket::_ attempt :80 BLOCKING timeout 4000" "2012-04-04T09:47:55.370348Z":25430:KERNEL:DEBUG:sipx-test.ttplservices.com:OsTimer-10:7f518f9db700:SipRegistrar:"OsSocket::makeNonblocking 21" "2012-04-04T09:47:55.370425Z":25431:KERNEL:DEBUG:sipx-test.ttplservices.com:OsTimer-10:7f518f9db700:SipRegistrar:"OsConnectionSocket::_: connecting to host at: 127.0.0.1:80" "2012-04-04T09:47:55.370452Z":25432:KERNEL:DEBUG:sipx-test.ttplservices.com:OsTimer-10:7f518f9db700:SipRegistrar:"OsConnectionSocket::_ connect 21" "2012-04-04T09:47:55.370533Z":25433:KERNEL:DEBUG:sipx-test.ttplservices.com:OsTimer-10:7f518f9db700:SipRegistrar:"OsConnectionSocket::_ poll 21 timeout 4000 msec" "2012-04-04T09:47:55.370561Z":25434:KERNEL:DEBUG:sipx-test.ttplservices.com:OsTimer-10:7f518f9db700:SipRegistrar:"OsConnectionSocket::_ after poll(), error = 0" "2012-04-04T09:47:55.370580Z":25435:KERNEL:DEBUG:sipx-test.ttplservices.com:OsTimer-10:7f518f9db700:SipRegistrar:"OsSocket::makeBlocking 21" "2012-04-04T09:47:55.370600Z":25436:KERNEL:INFO:sipx-test.ttplservices.com:OsTimer-10:7f518f9db700:SipRegistrar:"OsConnectionSocket::_[5] connected 21 to localhost:80" "2012-04-04T09:47:55.370695Z":25437:HTTP:DEBUG:sipx-test.ttplservices.com:OsTimer-10:7f518f9db700:SipRegistrar:"HttpMessage::get[4] sent request" "2012-04-04T09:47:55.370937Z":25438:HTTP:DEBUG:sipx-test.ttplservices.com:OsTimer-10:7f518f9db700:SipRegistrar:"HttpMessage::read contentLength 295, contentTypeSet 1, contentType 'text/html; charset=iso-8859-1'" "2012-04-04T09:47:55.370984Z":25439:HTTP:DEBUG:sipx-test.ttplservices.com:OsTimer-10:7f518f9db700:SipRegistrar:"HttpMessage::read full msg rcvd bytes 477: header: 182 content: 295" "2012-04-04T09:47:55.371022Z":25440:HTTP:DEBUG:sipx-test.ttplservices.com:OsTimer-10:7f518f9db700:SipRegistrar:"HttpMessage::get[4] read returned 477 bytes" "2012-04-04T09:47:55.371049Z":25441:HTTP:DEBUG:sipx-test.ttplservices.com:OsTimer-10:7f518f9db700:SipRegistrar:"HttpMessage::get[4] returning 400 response" "2012-04-04T09:47:55.371077Z":25442:XMLRPC:DEBUG:sipx-test.ttplservices.com:OsTimer-10:7f518f9db700:SipRegistrar:"mpResponseBody::setFault -7 Bad Request" "2012-04-04T09:47:55.371098Z":25443:XMLRPC:INFO:sipx-test.ttplservices.com:OsTimer-10:7f518f9db700:SipRegistrar:"XmlRpcRequest::execute http request failed; status = 400 Bad Request" "2012-04-04T09:47:55.371128Z":25444:NAT:ERR:sipx-test.ttplservices.com:OsTimer-10:7f518f9db700:SipRegistrar:"SipRedirectorPresenceRouting::registerPresenceMonitorRequestWithOpenfire failed to execute() request: -7 : Bad Request" "2012-04-04T09:47:55.371159Z":25445:NAT:ERR:sipx-test.ttplservices.com:OsTimer-10:7f518f9db700:SipRegistrar:"[900-PRESENCE] SipRedirectorPresenceRouting::signal: failed to reconnect with openfire - retrying later" "2012-04-04T09:47:59.356008Z":25446:SIP:DEBUG:sipx-test.ttplservices.com:SipUserAgent-3:7f518f8da700:SipRegistrar:"SipUserAgent[SipUserAgent-3]::handleMessage calling garbageCollection()" "2012-04-04T09:47:59.367252Z":25447:SIP:DEBUG:sipx-test.ttplservices.com:SipUserAgent-13:7f517fcfc700:SipRegistrar:"SipUserAgent[SipUserAgent-13]::handleMessage calling garbageCollection()" "2012-04-04T09:47:59.372503Z":25448:SIP:DEBUG:sipx-test.ttplservices.com:SipUserAgent-25:7f517f4f4700:SipRegistrar:"SipUserAgent[SipUserAgent-25]::handleMessage calling garbageCollection()" "2012-04-04T09:48:07.355989Z":25449:SIP:DEBUG:sipx-test.ttplservices.com:SipUserAgent-3:7f518f8da700:SipRegistrar:"SipUserAgent[SipUserAgent-3]::handleMessage calling garbageCollection()" "2012-04-04T09:48:07.367221Z":25450:SIP:DEBUG:sipx-test.ttplservices.com:SipUserAgent-13:7f517fcfc700:SipRegistrar:"SipUserAgent[SipUserAgent-13]::handleMessage calling garbageCollection()" "2012-04-04T09:48:07.372539Z":25451:SIP:DEBUG:sipx-test.ttplservices.com:SipUserAgent-25:7f517f4f4700:SipRegistrar:"SipUserAgent[SipUserAgent-25]::handleMessage calling garbageCollection()" "2012-04-04T09:48:15.356037Z":25452:SIP:DEBUG:sipx-test.ttplservices.com:SipUserAgent-3:7f518f8da700:SipRegistrar:"SipUserAgent[SipUserAgent-3]::handleMessage calling garbageCollection()" "2012-04-04T09:48:15.367220Z":25453:SIP:DEBUG:sipx-test.ttplservices.com:SipUserAgent-13:7f517fcfc700:SipRegistrar:"SipUserAgent[SipUserAgent-13]::handleMessage calling garbageCollection()" "2012-04-04T09:48:15.369986Z":25454:HTTP:DEBUG:sipx-test.ttplservices.com:OsTimer-10:7f518f9db700:SipRegistrar:"HttpConnectionMap::getPersistentConnection - Found ConnectionMapEntry-0 for http::80, socket 0x7f516c001460" "2012-04-04T09:48:15.370139Z":25455:HTTP:DEBUG:sipx-test.ttplservices.com:OsTimer-10:7f518f9db700:SipRegistrar:"HttpMessage::get[4] sent request" "2012-04-04T09:48:15.370188Z":25456:HTTP:DEBUG:sipx-test.ttplservices.com:OsTimer-10:7f518f9db700:SipRegistrar:"HttpMessage::get[4] read returned 0 bytes" "2012-04-04T09:48:15.370213Z":25457:HTTP:DEBUG:sipx-test.ttplservices.com:OsTimer-10:7f518f9db700:SipRegistrar:"HttpMessage::get[4] Receiving failed on persistent connection on try 0" "2012-04-04T09:48:15.370240Z":25458:KERNEL:INFO:sipx-test.ttplservices.com:OsTimer-10:7f518f9db700:SipRegistrar:"OsConnectionSocket::~" "2012-04-04T09:48:15.370282Z":25459:KERNEL:DEBUG:sipx-test.ttplservices.com:OsTimer-10:7f518f9db700:SipRegistrar:"OsSocket::~ close socket 21" "2012-04-04T09:48:15.370311Z":25460:KERNEL:DEBUG:sipx-test.ttplservices.com:OsTimer-10:7f518f9db700:SipRegistrar:"OsConnectionSocket::_ attempt :80 BLOCKING timeout 4000" "2012-04-04T09:48:15.370343Z":25461:KERNEL:DEBUG:sipx-test.ttplservices.com:OsTimer-10:7f518f9db700:SipRegistrar:"OsSocket::makeNonblocking 21" "2012-04-04T09:48:15.370478Z":25462:KERNEL:DEBUG:sipx-test.ttplservices.com:OsTimer-10:7f518f9db700:SipRegistrar:"OsConnectionSocket::_: connecting to host at: 127.0.0.1:80" "2012-04-04T09:48:15.370511Z":25463:KERNEL:DEBUG:sipx-test.ttplservices.com:OsTimer-10:7f518f9db700:SipRegistrar:"OsConnectionSocket::_ connect 21" "2012-04-04T09:48:15.370606Z":25464:KERNEL:DEBUG:sipx-test.ttplservices.com:OsTimer-10:7f518f9db700:SipRegistrar:"OsConnectionSocket::_ poll 21 timeout 4000 msec" "2012-04-04T09:48:15.370638Z":25465:KERNEL:DEBUG:sipx-test.ttplservices.com:OsTimer-10:7f518f9db700:SipRegistrar:"OsConnectionSocket::_ after poll(), error = 0" "2012-04-04T09:48:15.370662Z":25466:KERNEL:DEBUG:sipx-test.ttplservices.com:OsTimer-10:7f518f9db700:SipRegistrar:"OsSocket::makeBlocking 21" "2012-04-04T09:48:15.370687Z":25467:KERNEL:INFO:sipx-test.ttplservices.com:OsTimer-10:7f518f9db700:SipRegistrar:"OsConnectionSocket::_[5] connected 21 to localhost:80" "2012-04-04T09:48:15.370797Z":25468:HTTP:DEBUG:sipx-test.ttplservices.com:OsTimer-10:7f518f9db700:SipRegistrar:"HttpMessage::get[4] sent request" "2012-04-04T09:48:15.371098Z":25469:HTTP:DEBUG:sipx-test.ttplservices.com:OsTimer-10:7f518f9db700:SipRegistrar:"HttpMessage::read contentLength 295, contentTypeSet 1, contentType 'text/html; charset=iso-8859-1'" "2012-04-04T09:48:15.371145Z":25470:HTTP:DEBUG:sipx-test.ttplservices.com:OsTimer-10:7f518f9db700:SipRegistrar:"HttpMessage::read full msg rcvd bytes 477: header: 182 content: 295" "2012-04-04T09:48:15.371209Z":25471:HTTP:DEBUG:sipx-test.ttplservices.com:OsTimer-10:7f518f9db700:SipRegistrar:"HttpMessage::get[4] read returned 477 bytes" "2012-04-04T09:48:15.371246Z":25472:HTTP:DEBUG:sipx-test.ttplservices.com:OsTimer-10:7f518f9db700:SipRegistrar:"HttpMessage::get[4] returning 400 response" "2012-04-04T09:48:15.371280Z":25473:XMLRPC:DEBUG:sipx-test.ttplservices.com:OsTimer-10:7f518f9db700:SipRegistrar:"mpResponseBody::setFault -7 Bad Request" "2012-04-04T09:48:15.371318Z":25474:XMLRPC:INFO:sipx-test.ttplservices.com:OsTimer-10:7f518f9db700:SipRegistrar:"XmlRpcRequest::execute http request failed; status = 400 Bad Request" "2012-04-04T09:48:15.371354Z":25475:NAT:ERR:sipx-test.ttplservices.com:OsTimer-10:7f518f9db700:SipRegistrar:"SipRedirectorPresenceRouting::registerPresenceMonitorRequestWithOpenfire failed to execute() request: -7 : Bad Request" "2012-04-04T09:48:15.371392Z":25476:NAT:ERR:sipx-test.ttplservices.com:OsTimer-10:7f518f9db700:SipRegistrar:"[900-PRESENCE] SipRedirectorPresenceRouting::signal: failed to reconnect with openfire - retrying later" "2012-04-04T09:48:15.374035Z":25477:SIP:DEBUG:sipx-test.ttplservices.com:SipUserAgent-25:7f517f4f4700:SipRegistrar:"SipUserAgent[SipUserAgent-25]::handleMessage calling garbageCollection()" "2012-04-04T09:48:23.355975Z":25478:SIP:DEBUG:sipx-test.ttplservices.com:SipUserAgent-3:7f518f8da700:SipRegistrar:"SipUserAgent[SipUserAgent-3]::handleMessage calling garbageCollection()" "2012-04-04T09:48:23.367193Z":25479:SIP:DEBUG:sipx-test.ttplservices.com:SipUserAgent-13:7f517fcfc700:SipRegistrar:"SipUserAgent[SipUserAgent-13]::handleMessage calling garbageCollection()" "2012-04-04T09:48:23.372456Z":25480:SIP:DEBUG:sipx-test.ttplservices.com:SipUserAgent-25:7f517f4f4700:SipRegistrar:"SipUserAgent[SipUserAgent-25]::handleMessage calling garbageCollection()" "2012-04-04T09:48:31.356003Z":25481:SIP:DEBUG:sipx-test.ttplservices.com:SipUserAgent-3:7f518f8da700:SipRegistrar:"SipUserAgent[SipUserAgent-3]::handleMessage calling garbageCollection()" "2012-04-04T09:48:31.367213Z":25482:SIP:DEBUG:sipx-test.ttplservices.com:SipUserAgent-13:7f517fcfc700:SipRegistrar:"SipUserAgent[SipUserAgent-13]::handleMessage calling garbageCollection()" "2012-04-04T09:48:31.372499Z":25483:SIP:DEBUG:sipx-test.ttplservices.com:SipUserAgent-25:7f517f4f4700:SipRegistrar:"SipUserAgent[SipUserAgent-25]::handleMessage calling garbageCollection()" "2012-04-04T09:48:35.369907Z":25484:HTTP:DEBUG:sipx-test.ttplservices.com:OsTimer-10:7f518f9db700:SipRegistrar:"HttpConnectionMap::getPersistentConnection - Found ConnectionMapEntry-0 for http::80, socket 0x7f516c001460" "2012-04-04T09:48:35.369984Z":25485:HTTP:DEBUG:sipx-test.ttplservices.com:OsTimer-10:7f518f9db700:SipRegistrar:"HttpMessage::get[4] sent request" "2012-04-04T09:48:35.370014Z":25486:HTTP:DEBUG:sipx-test.ttplservices.com:OsTimer-10:7f518f9db700:SipRegistrar:"HttpMessage::get[4] read returned 0 bytes" "2012-04-04T09:48:35.370044Z":25487:HTTP:DEBUG:sipx-test.ttplservices.com:OsTimer-10:7f518f9db700:SipRegistrar:"HttpMessage::get[4] Receiving failed on persistent connection on try 0" "2012-04-04T09:48:35.370067Z":25488:KERNEL:INFO:sipx-test.ttplservices.com:OsTimer-10:7f518f9db700:SipRegistrar:"OsConnectionSocket::~" "2012-04-04T09:48:35.370109Z":25489:KERNEL:DEBUG:sipx-test.ttplservices.com:OsTimer-10:7f518f9db700:SipRegistrar:"OsSocket::~ close socket 21" "2012-04-04T09:48:35.370130Z":25490:KERNEL:DEBUG:sipx-test.ttplservices.com:OsTimer-10:7f518f9db700:SipRegistrar:"OsConnectionSocket::_ attempt :80 BLOCKING timeout 4000" "2012-04-04T09:48:35.370145Z":25491:KERNEL:DEBUG:sipx-test.ttplservices.com:OsTimer-10:7f518f9db700:SipRegistrar:"OsSocket::makeNonblocking 21" "2012-04-04T09:48:35.370190Z":25492:KERNEL:DEBUG:sipx-test.ttplservices.com:OsTimer-10:7f518f9db700:SipRegistrar:"OsConnectionSocket::_: connecting to host at: 127.0.0.1:80" "2012-04-04T09:48:35.370204Z":25493:KERNEL:DEBUG:sipx-test.ttplservices.com:OsTimer-10:7f518f9db700:SipRegistrar:"OsConnectionSocket::_ connect 21" "2012-04-04T09:48:35.370250Z":25494:KERNEL:DEBUG:sipx-test.ttplservices.com:OsTimer-10:7f518f9db700:SipRegistrar:"OsConnectionSocket::_ poll 21 timeout 4000 msec" "2012-04-04T09:48:35.370265Z":25495:KERNEL:DEBUG:sipx-test.ttplservices.com:OsTimer-10:7f518f9db700:SipRegistrar:"OsConnectionSocket::_ after poll(), error = 0" "2012-04-04T09:48:35.370275Z":25496:KERNEL:DEBUG:sipx-test.ttplservices.com:OsTimer-10:7f518f9db700:SipRegistrar:"OsSocket::makeBlocking 21" "2012-04-04T09:48:35.370292Z":25497:KERNEL:INFO:sipx-test.ttplservices.com:OsTimer-10:7f518f9db700:SipRegistrar:"OsConnectionSocket::_[5] connected 21 to localhost:80" "2012-04-04T09:48:35.370345Z":25498:HTTP:DEBUG:sipx-test.ttplservices.com:OsTimer-10:7f518f9db700:SipRegistrar:"HttpMessage::get[4] sent request" "2012-04-04T09:48:35.370568Z":25499:HTTP:DEBUG:sipx-test.ttplservices.com:OsTimer-10:7f518f9db700:SipRegistrar:"HttpMessage::read contentLength 295, contentTypeSet 1, contentType 'text/html; charset=iso-8859-1'" "2012-04-04T09:48:35.370592Z":25500:HTTP:DEBUG:sipx-test.ttplservices.com:OsTimer-10:7f518f9db700:SipRegistrar:"HttpMessage::read full msg rcvd bytes 477: header: 182 content: 295" "2012-04-04T09:48:35.370621Z":25501:HTTP:DEBUG:sipx-test.ttplservices.com:OsTimer-10:7f518f9db700:SipRegistrar:"HttpMessage::get[4] read returned 477 bytes" "2012-04-04T09:48:35.370645Z":25502:HTTP:DEBUG:sipx-test.ttplservices.com:OsTimer-10:7f518f9db700:SipRegistrar:"HttpMessage::get[4] returning 400 response" "2012-04-04T09:48:35.370663Z":25503:XMLRPC:DEBUG:sipx-test.ttplservices.com:OsTimer-10:7f518f9db700:SipRegistrar:"mpResponseBody::setFault -7 Bad Request" "2012-04-04T09:48:35.370674Z":25504:XMLRPC:INFO:sipx-test.ttplservices.com:OsTimer-10:7f518f9db700:SipRegistrar:"XmlRpcRequest::execute http request failed; status = 400 Bad Request" "2012-04-04T09:48:35.370690Z":25505:NAT:ERR:sipx-test.ttplservices.com:OsTimer-10:7f518f9db700:SipRegistrar:"SipRedirectorPresenceRouting::registerPresenceMonitorRequestWithOpenfire failed to execute() request: -7 : Bad Request" "2012-04-04T09:48:35.370705Z":25506:NAT:ERR:sipx-test.ttplservices.com:OsTimer-10:7f518f9db700:SipRegistrar:"[900-PRESENCE] SipRedirectorPresenceRouting::signal: failed to reconnect with openfire - retrying later" "2012-04-04T09:48:39.355966Z":25507:SIP:DEBUG:sipx-test.ttplservices.com:SipUserAgent-3:7f518f8da700:SipRegistrar:"SipUserAgent[SipUserAgent-3]::handleMessage calling garbageCollection()" "2012-04-04T09:48:39.367214Z":25508:SIP:DEBUG:sipx-test.ttplservices.com:SipUserAgent-13:7f517fcfc700:SipRegistrar:"SipUserAgent[SipUserAgent-13]::handleMessage calling garbageCollection()" "2012-04-04T09:48:39.372506Z":25509:SIP:DEBUG:sipx-test.ttplservices.com:SipUserAgent-25:7f517f4f4700:SipRegistrar:"SipUserAgent[SipUserAgent-25]::handleMessage calling garbageCollection()" "2012-04-04T09:48:47.356030Z":25510:SIP:DEBUG:sipx-test.ttplservices.com:SipUserAgent-3:7f518f8da700:SipRegistrar:"SipUserAgent[SipUserAgent-3]::handleMessage calling garbageCollection()" "2012-04-04T09:48:47.367206Z":25511:SIP:DEBUG:sipx-test.ttplservices.com:SipUserAgent-13:7f517fcfc700:SipRegistrar:"SipUserAgent[SipUserAgent-13]::handleMessage calling garbageCollection()" "2012-04-04T09:48:47.372543Z":25512:SIP:DEBUG:sipx-test.ttplservices.com:SipUserAgent-25:7f517f4f4700:SipRegistrar:"SipUserAgent[SipUserAgent-25]::handleMessage calling garbageCollection()" "2012-04-04T09:48:55.355969Z":25513:SIP:DEBUG:sipx-test.ttplservices.com:SipUserAgent-3:7f518f8da700:SipRegistrar:"SipUserAgent[SipUserAgent-3]::handleMessage calling garbageCollection()" "2012-04-04T09:48:55.367185Z":25514:SIP:DEBUG:sipx-test.ttplservices.com:SipUserAgent-13:7f517fcfc700:SipRegistrar:"SipUserAgent[SipUserAgent-13]::handleMessage calling garbageCollection()" "2012-04-04T09:48:55.369919Z":25515:HTTP:DEBUG:sipx-test.ttplservices.com:OsTimer-10:7f518f9db700:SipRegistrar:"HttpConnectionMap::getPersistentConnection - Found ConnectionMapEntry-0 for http::80, socket 0x7f516c001460" "2012-04-04T09:48:55.370000Z":25516:HTTP:DEBUG:sipx-test.ttplservices.com:OsTimer-10:7f518f9db700:SipRegistrar:"HttpMessage::get[4] sent request" "2012-04-04T09:48:55.370021Z":25517:HTTP:DEBUG:sipx-test.ttplservices.com:OsTimer-10:7f518f9db700:SipRegistrar:"HttpMessage::get[4] read returned 0 bytes" "2012-04-04T09:48:55.370032Z":25518:HTTP:DEBUG:sipx-test.ttplservices.com:OsTimer-10:7f518f9db700:SipRegistrar:"HttpMessage::get[4] Receiving failed on persistent connection on try 0" "2012-04-04T09:48:55.370043Z":25519:KERNEL:INFO:sipx-test.ttplservices.com:OsTimer-10:7f518f9db700:SipRegistrar:"OsConnectionSocket::~" "2012-04-04T09:48:55.370071Z":25520:KERNEL:DEBUG:sipx-test.ttplservices.com:OsTimer-10:7f518f9db700:SipRegistrar:"OsSocket::~ close socket 21" "2012-04-04T09:48:55.370085Z":25521:KERNEL:DEBUG:sipx-test.ttplservices.com:OsTimer-10:7f518f9db700:SipRegistrar:"OsConnectionSocket::_ attempt :80 BLOCKING timeout 4000" "2012-04-04T09:48:55.370102Z":25522:KERNEL:DEBUG:sipx-test.ttplservices.com:OsTimer-10:7f518f9db700:SipRegistrar:"OsSocket::makeNonblocking 21" "2012-04-04T09:48:55.370156Z":25523:KERNEL:DEBUG:sipx-test.ttplservices.com:OsTimer-10:7f518f9db700:SipRegistrar:"OsConnectionSocket::_: connecting to host at: 127.0.0.1:80" "2012-04-04T09:48:55.370172Z":25524:KERNEL:DEBUG:sipx-test.ttplservices.com:OsTimer-10:7f518f9db700:SipRegistrar:"OsConnectionSocket::_ connect 21" "2012-04-04T09:48:55.370222Z":25525:KERNEL:DEBUG:sipx-test.ttplservices.com:OsTimer-10:7f518f9db700:SipRegistrar:"OsConnectionSocket::_ poll 21 timeout 4000 msec" "2012-04-04T09:48:55.370237Z":25526:KERNEL:DEBUG:sipx-test.ttplservices.com:OsTimer-10:7f518f9db700:SipRegistrar:"OsConnectionSocket::_ after poll(), error = 0" "2012-04-04T09:48:55.370246Z":25527:KERNEL:DEBUG:sipx-test.ttplservices.com:OsTimer-10:7f518f9db700:SipRegistrar:"OsSocket::makeBlocking 21" "2012-04-04T09:48:55.370256Z":25528:KERNEL:INFO:sipx-test.ttplservices.com:OsTimer-10:7f518f9db700:SipRegistrar:"OsConnectionSocket::_[5] connected 21 to localhost:80" "2012-04-04T09:48:55.370309Z":25529:HTTP:DEBUG:sipx-test.ttplservices.com:OsTimer-10:7f518f9db700:SipRegistrar:"HttpMessage::get[4] sent request" "2012-04-04T09:48:55.370473Z":25530:HTTP:DEBUG:sipx-test.ttplservices.com:OsTimer-10:7f518f9db700:SipRegistrar:"HttpMessage::read contentLength 295, contentTypeSet 1, contentType 'text/html; charset=iso-8859-1'" "2012-04-04T09:48:55.370495Z":25531:HTTP:DEBUG:sipx-test.ttplservices.com:OsTimer-10:7f518f9db700:SipRegistrar:"HttpMessage::read full msg rcvd bytes 477: header: 182 content: 295" "2012-04-04T09:48:55.370514Z":25532:HTTP:DEBUG:sipx-test.ttplservices.com:OsTimer-10:7f518f9db700:SipRegistrar:"HttpMessage::get[4] read returned 477 bytes" "2012-04-04T09:48:55.370528Z":25533:HTTP:DEBUG:sipx-test.ttplservices.com:OsTimer-10:7f518f9db700:SipRegistrar:"HttpMessage::get[4] returning 400 response" "2012-04-04T09:48:55.370542Z":25534:XMLRPC:DEBUG:sipx-test.ttplservices.com:OsTimer-10:7f518f9db700:SipRegistrar:"mpResponseBody::setFault -7 Bad Request" "2012-04-04T09:48:55.370553Z":25535:XMLRPC:INFO:sipx-test.ttplservices.com:OsTimer-10:7f518f9db700:SipRegistrar:"XmlRpcRequest::execute http request failed; status = 400 Bad Request" "2012-04-04T09:48:55.370568Z":25536:NAT:ERR:sipx-test.ttplservices.com:OsTimer-10:7f518f9db700:SipRegistrar:"SipRedirectorPresenceRouting::registerPresenceMonitorRequestWithOpenfire failed to execute() request: -7 : Bad Request" "2012-04-04T09:48:55.370584Z":25537:NAT:ERR:sipx-test.ttplservices.com:OsTimer-10:7f518f9db700:SipRegistrar:"[900-PRESENCE] SipRedirectorPresenceRouting::signal: failed to reconnect with openfire - retrying later" "2012-04-04T09:48:55.373201Z":25538:SIP:DEBUG:sipx-test.ttplservices.com:SipUserAgent-25:7f517f4f4700:SipRegistrar:"SipUserAgent[SipUserAgent-25]::handleMessage calling garbageCollection()" "2012-04-04T09:49:03.355995Z":25539:SIP:DEBUG:sipx-test.ttplservices.com:SipUserAgent-3:7f518f8da700:SipRegistrar:"SipUserAgent[SipUserAgent-3]::handleMessage calling garbageCollection()" "2012-04-04T09:49:03.367253Z":25540:SIP:DEBUG:sipx-test.ttplservices.com:SipUserAgent-13:7f517fcfc700:SipRegistrar:"SipUserAgent[SipUserAgent-13]::handleMessage calling garbageCollection()" "2012-04-04T09:49:03.372558Z":25541:SIP:DEBUG:sipx-test.ttplservices.com:SipUserAgent-25:7f517f4f4700:SipRegistrar:"SipUserAgent[SipUserAgent-25]::handleMessage calling garbageCollection()" "2012-04-04T09:49:11.356017Z":25542:SIP:DEBUG:sipx-test.ttplservices.com:SipUserAgent-3:7f518f8da700:SipRegistrar:"SipUserAgent[SipUserAgent-3]::handleMessage calling garbageCollection()" "2012-04-04T09:49:11.367219Z":25543:SIP:DEBUG:sipx-test.ttplservices.com:SipUserAgent-13:7f517fcfc700:SipRegistrar:"SipUserAgent[SipUserAgent-13]::handleMessage calling garbageCollection()" "2012-04-04T09:49:11.372555Z":25544:SIP:DEBUG:sipx-test.ttplservices.com:SipUserAgent-25:7f517f4f4700:SipRegistrar:"SipUserAgent[SipUserAgent-25]::handleMessage calling garbageCollection()" "2012-04-04T09:49:15.370021Z":25545:HTTP:DEBUG:sipx-test.ttplservices.com:OsTimer-10:7f518f9db700:SipRegistrar:"HttpConnectionMap::getPersistentConnection - Found ConnectionMapEntry-0 for http::80, socket 0x7f516c001460" "2012-04-04T09:49:15.370175Z":25546:HTTP:DEBUG:sipx-test.ttplservices.com:OsTimer-10:7f518f9db700:SipRegistrar:"HttpMessage::get[4] sent request" "2012-04-04T09:49:15.370222Z":25547:HTTP:DEBUG:sipx-test.ttplservices.com:OsTimer-10:7f518f9db700:SipRegistrar:"HttpMessage::get[4] read returned 0 bytes" "2012-04-04T09:49:15.370248Z":25548:HTTP:DEBUG:sipx-test.ttplservices.com:OsTimer-10:7f518f9db700:SipRegistrar:"HttpMessage::get[4] Receiving failed on persistent connection on try 0" "2012-04-04T09:49:15.370275Z":25549:KERNEL:INFO:sipx-test.ttplservices.com:OsTimer-10:7f518f9db700:SipRegistrar:"OsConnectionSocket::~" "2012-04-04T09:49:15.370315Z":25550:KERNEL:DEBUG:sipx-test.ttplservices.com:OsTimer-10:7f518f9db700:SipRegistrar:"OsSocket::~ close socket 21" "2012-04-04T09:49:15.370345Z":25551:KERNEL:DEBUG:sipx-test.ttplservices.com:OsTimer-10:7f518f9db700:SipRegistrar:"OsConnectionSocket::_ attempt :80 BLOCKING timeout 4000" "2012-04-04T09:49:15.370378Z":25552:KERNEL:DEBUG:sipx-test.ttplservices.com:OsTimer-10:7f518f9db700:SipRegistrar:"OsSocket::makeNonblocking 21" "2012-04-04T09:49:15.370467Z":25553:KERNEL:DEBUG:sipx-test.ttplservices.com:OsTimer-10:7f518f9db700:SipRegistrar:"OsConnectionSocket::_: connecting to host at: 127.0.0.1:80" "2012-04-04T09:49:15.370499Z":25554:KERNEL:DEBUG:sipx-test.ttplservices.com:OsTimer-10:7f518f9db700:SipRegistrar:"OsConnectionSocket::_ connect 21" "2012-04-04T09:49:15.370594Z":25555:KERNEL:DEBUG:sipx-test.ttplservices.com:OsTimer-10:7f518f9db700:SipRegistrar:"OsConnectionSocket::_ poll 21 timeout 4000 msec" "2012-04-04T09:49:15.370627Z":25556:KERNEL:DEBUG:sipx-test.ttplservices.com:OsTimer-10:7f518f9db700:SipRegistrar:"OsConnectionSocket::_ after poll(), error = 0" "2012-04-04T09:49:15.370651Z":25557:KERNEL:DEBUG:sipx-test.ttplservices.com:OsTimer-10:7f518f9db700:SipRegistrar:"OsSocket::makeBlocking 21" "2012-04-04T09:49:15.370676Z":25558:KERNEL:INFO:sipx-test.ttplservices.com:OsTimer-10:7f518f9db700:SipRegistrar:"OsConnectionSocket::_[5] connected 21 to localhost:80" "2012-04-04T09:49:15.370787Z":25559:HTTP:DEBUG:sipx-test.ttplservices.com:OsTimer-10:7f518f9db700:SipRegistrar:"HttpMessage::get[4] sent request" "2012-04-04T09:49:15.371061Z":25560:HTTP:DEBUG:sipx-test.ttplservices.com:OsTimer-10:7f518f9db700:SipRegistrar:"HttpMessage::read contentLength 295, contentTypeSet 1, contentType 'text/html; charset=iso-8859-1'" "2012-04-04T09:49:15.371120Z":25561:HTTP:DEBUG:sipx-test.ttplservices.com:OsTimer-10:7f518f9db700:SipRegistrar:"HttpMessage::read full msg rcvd bytes 477: header: 182 content: 295" "2012-04-04T09:49:15.371165Z":25562:HTTP:DEBUG:sipx-test.ttplservices.com:OsTimer-10:7f518f9db700:SipRegistrar:"HttpMessage::get[4] read returned 477 bytes" "2012-04-04T09:49:15.371198Z":25563:HTTP:DEBUG:sipx-test.ttplservices.com:OsTimer-10:7f518f9db700:SipRegistrar:"HttpMessage::get[4] returning 400 response" "2012-04-04T09:49:15.371232Z":25564:XMLRPC:DEBUG:sipx-test.ttplservices.com:OsTimer-10:7f518f9db700:SipRegistrar:"mpResponseBody::setFault -7 Bad Request" "2012-04-04T09:49:15.371258Z":25565:XMLRPC:INFO:sipx-test.ttplservices.com:OsTimer-10:7f518f9db700:SipRegistrar:"XmlRpcRequest::execute http request failed; status = 400 Bad Request" "2012-04-04T09:49:15.371293Z":25566:NAT:ERR:sipx-test.ttplservices.com:OsTimer-10:7f518f9db700:SipRegistrar:"SipRedirectorPresenceRouting::registerPresenceMonitorRequestWithOpenfire failed to execute() request: -7 : Bad Request" "2012-04-04T09:49:15.371331Z":25567:NAT:ERR:sipx-test.ttplservices.com:OsTimer-10:7f518f9db700:SipRegistrar:"[900-PRESENCE] SipRedirectorPresenceRouting::signal: failed to reconnect with openfire - retrying later"
_______________________________________________ sipx-dev mailing list [email protected] List Archive: http://list.sipfoundry.org/archive/sipx-dev/
