gojets
03-21-2008, 04:46 PM
It appears the last call home before daylight saving change my Tivo got messed up. I am not sure if that is the cause or not. I connect through the network and my network connection is fine. I can telnet into the Tivo fine and I can ping out to Internet sites like yahoo and google. But when I look in the tcdebuglog it appears that the IP address and port settings for the call home (204.176.49.2 port=80) are not being set.
Does any one know how I can fix this.
My Tivo is a standalone series 1 with a TurboNet card. Worked for years with out issues
Here are the logs before my issue and after
*****************************************************************
BEFORE
*****************************************************************
Mar 6 18:13:12 (none) comm[122]: commglobals resource mgr initialized
Mar 6 18:13:12 (none) comm[122]: commglobals testResource: (BakPhone=18778771756) (DefHost=204.176.49.2) (DefPhone=18772823740) (DefPort=80) (DefPppPasswd=MtDubois) (DefPppUser=ppptcd) (EmgHost=192.168.50.1) (EmgPhone=18778771756) (EmgPort=3911) (EmgPppPasswd=goTivoGo) (EmgPppUser=ppptcd)
Mar 6 18:13:12 (none) comm[122]: commglobals create all done
Mar 6 18:13:13 (none) comm[122]: Call: MakeCall, subtype 6
Mar 6 18:13:13 (none) comm[122]: Call: prep logs for backhaul
Mar 6 18:13:29 (none) comm[122]: Call: make query file
Mar 6 18:13:39 (none) comm[122]: Call: prep headend id list
Mar 6 18:13:56 (none) comm[122]: XferRqst XferRqstQ(post) adding (#1 type=1 ipaddr=204.176.49.2 port=80 name=modLog dataname=/var/log/svclog infile=/var/log/svclog.upload outfile=)
Mar 6 18:13:56 (none) comm[122]: XferRqst XferRqstQ(post) adding (#3 type=1 ipaddr=204.176.49.2 port=80 name=Performance Log dataname= infile=/var/log/perflog.now outfile=)
Mar 6 18:13:56 (none) comm[122]: Call: create 411 rqst
Mar 6 18:13:56 (none) comm[122]: XferRqst XferRqstQ(post) adding (#4 type=1 ipaddr=204.176.49.2 port=80 name=FourOneOneRqst dataname=FourOneOneResp infile=/var/tmp/TCD411.send outfile=/var/tmp/TCD411.recv)
Mar 6 18:13:56 (none) comm[122]: Call: create ident block
Mar 6 18:13:58 (none) comm[122]: Call: Enqueue Ident
Mar 6 18:13:58 (none) comm[122]: XferRqst XferRqstQ(post) adding (#5 type=1 ipaddr=204.176.49.2 port=80 name=HServerRqst dataname=HServerResp infile=/var/tmp/HServer.send outfile=/var/tmp/HServer.recv)
Mar 6 18:13:58 (none) comm[122]: commglobals Rqst Summary Start
Mar 6 18:13:58 (none) comm[122]: commglobals DESC: #1 type=1 ipaddr=204.176.49.2 port=80 name=modLog dataname=/var/log/svclog infile=/var/log/svclog.upload outfile=
Mar 6 18:13:58 (none) comm[122]: commglobals STATUS: #1 fopen=F fclose=F fverify=F feval=F fopenstatus=F verifystatus=F evalstatus=0x0 nread=0 nwrite=0 nreaderr=0 nwriteerr=0
Mar 6 18:13:58 (none) comm[122]: commglobals DESC: #2 type=1 ipaddr=204.176.49.2 port=80 name=commerceLog dataname=/var/log/commlog infile=/var/log/commlog.upload outfile=
Mar 6 18:13:58 (none) comm[122]: commglobals STATUS: #2 fopen=F fclose=F fverify=F feval=F fopenstatus=F verifystatus=F evalstatus=0x0 nread=0 nwrite=0 nreaderr=0 nwriteerr=0
Mar 6 18:13:58 (none) comm[122]: commglobals DESC: #3 type=1 ipaddr=204.176.49.2 port=80 name=Performance Log dataname= infile=/var/log/perflog.now outfile=
Mar 6 18:13:58 (none) comm[122]: commglobals STATUS: #3 fopen=F fclose=F fverify=F feval=F fopenstatus=F verifystatus=F evalstatus=0x0 nread=0 nwrite=0 nreaderr=0 nwriteerr=0
Mar 6 18:13:58 (none) comm[122]: commglobals DESC: #4 type=1 ipaddr=204.176.49.2 port=80 name=FourOneOneRqst dataname=FourOneOneResp infile=/var/tmp/TCD411.send outfile=/var/tmp/TCD411.recv
Mar 6 18:13:58 (none) comm[122]: commglobals STATUS: #4 fopen=F fclose=F fverify=F feval=F fopenstatus=F verifystatus=F evalstatus=0x0 nread=0 nwrite=0 nreaderr=0 nwriteerr=0
Mar 6 18:13:58 (none) comm[122]: commglobals DESC: #5 type=1 ipaddr=204.176.49.2 port=80 name=HServerRqst dataname=HServerResp infile=/var/tmp/HServer.send outfile=/var/tmp/HServer.recv
Mar 6 18:13:58 (none) comm[122]: commglobals STATUS: #5 fopen=F fclose=F fverify=F feval=F fopenstatus=F verifystatus=F evalstatus=0x0 nread=0 nwrite=0 nreaderr=0 nwriteerr=0
Mar 6 18:13:58 (none) comm[122]: commglobals Rqst Summary End
Mar 6 18:13:58 (none) comm[122]: CallService: PreCall: err 0
Mar 6 18:13:58 (none) comm[122]: CallService: StartCall: err 0
Mar 6 18:13:58 (none) comm[122]: CallService: InCall start
Mar 6 18:13:59 (none) comm[122]: CallService: InCall updatesubphase SP_START_AUTH err 0
Mar 6 18:13:59 (none) comm[122]: NetAgent: drainGetPostQ: starting doXfer(#1 type=1 ipaddr=204.176.49.2 port=80 name=modLog dataname=/var/log/svclog infile=/var/log/svclog.upload outfile=)
Mar 6 18:13:59 (none) comm[122]: FileRqst opened input file /var/log/svclog.upload
Mar 6 18:13:59 (none) comm[122]: XferRqst Open() done: (#1 fopen=T fclose=F fverify=F feval=F fopenstatus=F verifystatus=F evalstatus=0x0 nread=0 nwrite=0 nreaderr=0 nwriteerr=0)
Mar 6 18:13:59 (none) comm[122]: NetAgent: doXfer: select-ing for download data for modLog
Mar 6 18:13:59 (none) comm[122]: NetAgent: doXfer: data ready on socket 32 for modLog
Mar 6 18:13:59 (none) comm[122]: NetAgent: doXfer: read 123 bytes from socket: HTTP/1.1 200 OK^M Date: Thu, 06 Mar 2008 18:14:00 GMT^M Server: Apache^M Connection: close^M Content-Type: text/plain^M ^M Done.
Mar 6 18:13:59 (none) comm[122]: NetAgent: doXfer: select-ing for download data for modLog
Mar 6 18:13:59 (none) comm[122]: NetAgent: doXfer: data ready on socket 32 for modLog
Mar 6 18:13:59 (none) comm[122]: NetAgent: doXfer: EOF read on connection 32
Mar 6 18:13:59 (none) comm[122]: XferRqst Close() done: (#1 fopen=T fclose=T fverify=F feval=F fopenstatus=F verifystatus=F evalstatus=0x0 nread=1412 nwrite=123 nreaderr=0 nwriteerr=0)
Mar 6 18:13:59 (none) comm[122]: XferRqst Verify() done: (#1 fopen=T fclose=T fverify=T feval=F fopenstatus=F verifystatus=F evalstatus=0x0 nread=1412 nwrite=123 nreaderr=0 nwriteerr=0)
Mar 6 18:13:59 (none) comm[122]: NetAgent: drainGetPostQ: doXfer ok (enqueuing evalQ: modLog)
Mar 6 18:13:59 (none) comm[122]: XferRqst XferRqstQ(eval) adding (#1 type=1 ipaddr=204.176.49.2 port=80 name=modLog dataname=/var/log/svclog infile=/var/log/svclog.upload outfile=)
Mar 6 18:13:59 (none) comm[122]: NetAgent: drainGetPostQ: starting doXfer(#3 type=1 ipaddr=204.176.49.2 port=80 name=Performance Log dataname= infile=/var/log/perflog.now outfile=)
Mar 6 18:13:59 (none) comm[122]: HttpPostRqst: open could not stat file /var/log/perflog.now
***************************************************************************************************
AFTER
***************************************************************************************************
Mar 21 09:47:57 (none) comm[122]: commglobals resource mgr initialized
Mar 21 09:47:57 (none) comm[122]: commglobals testResource: (BakPhone=18778771756) (DefHost=204.176.49.2) (DefPhone=18772823740) (DefPort=80) (DefPppPasswd=MtDubois) (DefPppUser=ppptcd) (EmgHost=192.168.50.1) (EmgPhone=18778771756) (EmgPort=3911) (EmgPppPasswd=goTivoGo) (EmgPppUser=ppptcd)
Mar 21 09:47:57 (none) comm[122]: commglobals create all done
Mar 21 09:47:58 (none) comm[122]: Call: MakeCall, subtype 6
Mar 21 09:47:58 (none) comm[122]: Call: prep logs for backhaul
Mar 21 09:48:20 (none) comm[122]: Call: make query file
Mar 21 09:48:32 (none) comm[122]: Call: prep headend id list
Mar 21 09:49:00 (none) comm[122]: XferRqst XferRqstQ(post) adding (#1 type=1 ipaddr=127.0.0.1 port=8000 name=modLog dataname=/var/log/svclog infile=/var/log/svclog.upload outfile=)
Mar 21 09:49:00 (none) comm[122]: XferRqst XferRqstQ(post) adding (#3 type=1 ipaddr=127.0.0.1 port=8000 name=Performance Log dataname= infile=/var/log/perflog.now outfile=)
Mar 21 09:49:00 (none) comm[122]: Call: create 411 rqst
Mar 21 09:49:00 (none) comm[122]: XferRqst XferRqstQ(post) adding (#4 type=1 ipaddr=127.0.0.1 port=8000 name=FourOneOneRqst dataname=FourOneOneResp infile=/var/tmp/TCD411.send outfile=/var/tmp/TCD411.recv)
Mar 21 09:49:00 (none) comm[122]: Call: create ident block
Mar 21 09:49:02 (none) comm[122]: Call: Enqueue Ident
Mar 21 09:49:07 (none) comm[122]: XferRqst XferRqstQ(post) adding (#5 type=1 ipaddr=127.0.0.1 port=8000 name=HServerRqst dataname=HServerResp infile=/var/tmp/HServer.send outfile=/var/tmp/HServer.recv)
Mar 21 09:49:07 (none) comm[122]: commglobals Rqst Summary Start
Mar 21 09:49:07 (none) comm[122]: commglobals DESC: #1 type=1 ipaddr=127.0.0.1 port=8000 name=modLog dataname=/var/log/svclog infile=/var/log/svclog.upload outfile=
Mar 21 09:49:07 (none) comm[122]: commglobals STATUS: #1 fopen=F fclose=F fverify=F feval=F fopenstatus=F verifystatus=F evalstatus=0x0 nread=0 nwrite=0 nreaderr=0 nwriteerr=0
Mar 21 09:49:07 (none) comm[122]: commglobals DESC: #2 type=1 ipaddr=127.0.0.1 port=8000 name=commerceLog dataname=/var/log/commlog infile=/var/log/commlog.upload outfile=
Mar 21 09:49:07 (none) comm[122]: commglobals STATUS: #2 fopen=F fclose=F fverify=F feval=F fopenstatus=F verifystatus=F evalstatus=0x0 nread=0 nwrite=0 nreaderr=0 nwriteerr=0
Mar 21 09:49:07 (none) comm[122]: commglobals DESC: #3 type=1 ipaddr=127.0.0.1 port=8000 name=Performance Log dataname= infile=/var/log/perflog.now outfile=
Mar 21 09:49:07 (none) comm[122]: commglobals STATUS: #3 fopen=F fclose=F fverify=F feval=F fopenstatus=F verifystatus=F evalstatus=0x0 nread=0 nwrite=0 nreaderr=0 nwriteerr=0
Mar 21 09:49:07 (none) comm[122]: commglobals DESC: #4 type=1 ipaddr=127.0.0.1 port=8000 name=FourOneOneRqst dataname=FourOneOneResp infile=/var/tmp/TCD411.send outfile=/var/tmp/TCD411.recv
Mar 21 09:49:07 (none) comm[122]: commglobals STATUS: #4 fopen=F fclose=F fverify=F feval=F fopenstatus=F verifystatus=F evalstatus=0x0 nread=0 nwrite=0 nreaderr=0 nwriteerr=0
Mar 21 09:49:07 (none) comm[122]: commglobals DESC: #5 type=1 ipaddr=127.0.0.1 port=8000 name=HServerRqst dataname=HServerResp infile=/var/tmp/HServer.send outfile=/var/tmp/HServer.recv
Mar 21 09:49:07 (none) comm[122]: commglobals STATUS: #5 fopen=F fclose=F fverify=F feval=F fopenstatus=F verifystatus=F evalstatus=0x0 nread=0 nwrite=0 nreaderr=0 nwriteerr=0
Mar 21 09:49:07 (none) comm[122]: commglobals Rqst Summary End
Mar 21 09:49:07 (none) comm[122]: CallService: PreCall: err 0
Mar 21 09:49:07 (none) comm[122]: CallService: StartCall: err 0
Mar 21 09:49:07 (none) comm[122]: CallService: InCall start
Mar 21 09:49:07 (none) comm[122]: CallService: InCall updatesubphase SP_START_AUTH err 0
Mar 21 09:49:07 (none) comm[122]: NetAgent: drainGetPostQ: starting doXfer(#1 type=1 ipaddr=127.0.0.1 port=8000 name=modLog dataname=/var/log/svclog infile=/var/log/svclog.upload outfile=)
Mar 21 09:49:07 (none) comm[122]: FileRqst opened input file /var/log/svclog.upload
Mar 21 09:49:07 (none) comm[122]: XferRqst Open() done: (#1 fopen=T fclose=F fverify=F feval=F fopenstatus=F verifystatus=F evalstatus=0x0 nread=0 nwrite=0 nreaderr=0 nwriteerr=0)
Mar 21 09:52:07 (none) comm[122]: NetAgent: doXfer: tmk tcp socket failed 327685
Mar 21 09:52:07 (none) comm[122]: NetAgent: Process: drainPostQ err 327685
Mar 21 09:52:07 (none) comm[122]: NetAgent: flushing all queues
Mar 21 09:52:07 (none) comm[122]: CallService: InCall: err 327685
Mar 21 09:52:09 (none) comm[122]: CallService: EndCall returns 327685
Mar 21 09:52:09 (none) comm[122]: CallService: EndCall: err 327685
Mar 21 09:52:09 (none) comm[122]: commglobals fBackhaulCallM = 0, evalOK = 1
Mar 21 09:52:09 (none) comm[122]: commglobals FBackhaulDone=F
Mar 21 09:52:10 (none) aval_pp[122]: NukeOrphanedRecordings found 0 orphans
Mar 21 09:52:10 (none) comm[122]: CallService: CleanupCall: Cleanup err 0
Does any one know how I can fix this.
My Tivo is a standalone series 1 with a TurboNet card. Worked for years with out issues
Here are the logs before my issue and after
*****************************************************************
BEFORE
*****************************************************************
Mar 6 18:13:12 (none) comm[122]: commglobals resource mgr initialized
Mar 6 18:13:12 (none) comm[122]: commglobals testResource: (BakPhone=18778771756) (DefHost=204.176.49.2) (DefPhone=18772823740) (DefPort=80) (DefPppPasswd=MtDubois) (DefPppUser=ppptcd) (EmgHost=192.168.50.1) (EmgPhone=18778771756) (EmgPort=3911) (EmgPppPasswd=goTivoGo) (EmgPppUser=ppptcd)
Mar 6 18:13:12 (none) comm[122]: commglobals create all done
Mar 6 18:13:13 (none) comm[122]: Call: MakeCall, subtype 6
Mar 6 18:13:13 (none) comm[122]: Call: prep logs for backhaul
Mar 6 18:13:29 (none) comm[122]: Call: make query file
Mar 6 18:13:39 (none) comm[122]: Call: prep headend id list
Mar 6 18:13:56 (none) comm[122]: XferRqst XferRqstQ(post) adding (#1 type=1 ipaddr=204.176.49.2 port=80 name=modLog dataname=/var/log/svclog infile=/var/log/svclog.upload outfile=)
Mar 6 18:13:56 (none) comm[122]: XferRqst XferRqstQ(post) adding (#3 type=1 ipaddr=204.176.49.2 port=80 name=Performance Log dataname= infile=/var/log/perflog.now outfile=)
Mar 6 18:13:56 (none) comm[122]: Call: create 411 rqst
Mar 6 18:13:56 (none) comm[122]: XferRqst XferRqstQ(post) adding (#4 type=1 ipaddr=204.176.49.2 port=80 name=FourOneOneRqst dataname=FourOneOneResp infile=/var/tmp/TCD411.send outfile=/var/tmp/TCD411.recv)
Mar 6 18:13:56 (none) comm[122]: Call: create ident block
Mar 6 18:13:58 (none) comm[122]: Call: Enqueue Ident
Mar 6 18:13:58 (none) comm[122]: XferRqst XferRqstQ(post) adding (#5 type=1 ipaddr=204.176.49.2 port=80 name=HServerRqst dataname=HServerResp infile=/var/tmp/HServer.send outfile=/var/tmp/HServer.recv)
Mar 6 18:13:58 (none) comm[122]: commglobals Rqst Summary Start
Mar 6 18:13:58 (none) comm[122]: commglobals DESC: #1 type=1 ipaddr=204.176.49.2 port=80 name=modLog dataname=/var/log/svclog infile=/var/log/svclog.upload outfile=
Mar 6 18:13:58 (none) comm[122]: commglobals STATUS: #1 fopen=F fclose=F fverify=F feval=F fopenstatus=F verifystatus=F evalstatus=0x0 nread=0 nwrite=0 nreaderr=0 nwriteerr=0
Mar 6 18:13:58 (none) comm[122]: commglobals DESC: #2 type=1 ipaddr=204.176.49.2 port=80 name=commerceLog dataname=/var/log/commlog infile=/var/log/commlog.upload outfile=
Mar 6 18:13:58 (none) comm[122]: commglobals STATUS: #2 fopen=F fclose=F fverify=F feval=F fopenstatus=F verifystatus=F evalstatus=0x0 nread=0 nwrite=0 nreaderr=0 nwriteerr=0
Mar 6 18:13:58 (none) comm[122]: commglobals DESC: #3 type=1 ipaddr=204.176.49.2 port=80 name=Performance Log dataname= infile=/var/log/perflog.now outfile=
Mar 6 18:13:58 (none) comm[122]: commglobals STATUS: #3 fopen=F fclose=F fverify=F feval=F fopenstatus=F verifystatus=F evalstatus=0x0 nread=0 nwrite=0 nreaderr=0 nwriteerr=0
Mar 6 18:13:58 (none) comm[122]: commglobals DESC: #4 type=1 ipaddr=204.176.49.2 port=80 name=FourOneOneRqst dataname=FourOneOneResp infile=/var/tmp/TCD411.send outfile=/var/tmp/TCD411.recv
Mar 6 18:13:58 (none) comm[122]: commglobals STATUS: #4 fopen=F fclose=F fverify=F feval=F fopenstatus=F verifystatus=F evalstatus=0x0 nread=0 nwrite=0 nreaderr=0 nwriteerr=0
Mar 6 18:13:58 (none) comm[122]: commglobals DESC: #5 type=1 ipaddr=204.176.49.2 port=80 name=HServerRqst dataname=HServerResp infile=/var/tmp/HServer.send outfile=/var/tmp/HServer.recv
Mar 6 18:13:58 (none) comm[122]: commglobals STATUS: #5 fopen=F fclose=F fverify=F feval=F fopenstatus=F verifystatus=F evalstatus=0x0 nread=0 nwrite=0 nreaderr=0 nwriteerr=0
Mar 6 18:13:58 (none) comm[122]: commglobals Rqst Summary End
Mar 6 18:13:58 (none) comm[122]: CallService: PreCall: err 0
Mar 6 18:13:58 (none) comm[122]: CallService: StartCall: err 0
Mar 6 18:13:58 (none) comm[122]: CallService: InCall start
Mar 6 18:13:59 (none) comm[122]: CallService: InCall updatesubphase SP_START_AUTH err 0
Mar 6 18:13:59 (none) comm[122]: NetAgent: drainGetPostQ: starting doXfer(#1 type=1 ipaddr=204.176.49.2 port=80 name=modLog dataname=/var/log/svclog infile=/var/log/svclog.upload outfile=)
Mar 6 18:13:59 (none) comm[122]: FileRqst opened input file /var/log/svclog.upload
Mar 6 18:13:59 (none) comm[122]: XferRqst Open() done: (#1 fopen=T fclose=F fverify=F feval=F fopenstatus=F verifystatus=F evalstatus=0x0 nread=0 nwrite=0 nreaderr=0 nwriteerr=0)
Mar 6 18:13:59 (none) comm[122]: NetAgent: doXfer: select-ing for download data for modLog
Mar 6 18:13:59 (none) comm[122]: NetAgent: doXfer: data ready on socket 32 for modLog
Mar 6 18:13:59 (none) comm[122]: NetAgent: doXfer: read 123 bytes from socket: HTTP/1.1 200 OK^M Date: Thu, 06 Mar 2008 18:14:00 GMT^M Server: Apache^M Connection: close^M Content-Type: text/plain^M ^M Done.
Mar 6 18:13:59 (none) comm[122]: NetAgent: doXfer: select-ing for download data for modLog
Mar 6 18:13:59 (none) comm[122]: NetAgent: doXfer: data ready on socket 32 for modLog
Mar 6 18:13:59 (none) comm[122]: NetAgent: doXfer: EOF read on connection 32
Mar 6 18:13:59 (none) comm[122]: XferRqst Close() done: (#1 fopen=T fclose=T fverify=F feval=F fopenstatus=F verifystatus=F evalstatus=0x0 nread=1412 nwrite=123 nreaderr=0 nwriteerr=0)
Mar 6 18:13:59 (none) comm[122]: XferRqst Verify() done: (#1 fopen=T fclose=T fverify=T feval=F fopenstatus=F verifystatus=F evalstatus=0x0 nread=1412 nwrite=123 nreaderr=0 nwriteerr=0)
Mar 6 18:13:59 (none) comm[122]: NetAgent: drainGetPostQ: doXfer ok (enqueuing evalQ: modLog)
Mar 6 18:13:59 (none) comm[122]: XferRqst XferRqstQ(eval) adding (#1 type=1 ipaddr=204.176.49.2 port=80 name=modLog dataname=/var/log/svclog infile=/var/log/svclog.upload outfile=)
Mar 6 18:13:59 (none) comm[122]: NetAgent: drainGetPostQ: starting doXfer(#3 type=1 ipaddr=204.176.49.2 port=80 name=Performance Log dataname= infile=/var/log/perflog.now outfile=)
Mar 6 18:13:59 (none) comm[122]: HttpPostRqst: open could not stat file /var/log/perflog.now
***************************************************************************************************
AFTER
***************************************************************************************************
Mar 21 09:47:57 (none) comm[122]: commglobals resource mgr initialized
Mar 21 09:47:57 (none) comm[122]: commglobals testResource: (BakPhone=18778771756) (DefHost=204.176.49.2) (DefPhone=18772823740) (DefPort=80) (DefPppPasswd=MtDubois) (DefPppUser=ppptcd) (EmgHost=192.168.50.1) (EmgPhone=18778771756) (EmgPort=3911) (EmgPppPasswd=goTivoGo) (EmgPppUser=ppptcd)
Mar 21 09:47:57 (none) comm[122]: commglobals create all done
Mar 21 09:47:58 (none) comm[122]: Call: MakeCall, subtype 6
Mar 21 09:47:58 (none) comm[122]: Call: prep logs for backhaul
Mar 21 09:48:20 (none) comm[122]: Call: make query file
Mar 21 09:48:32 (none) comm[122]: Call: prep headend id list
Mar 21 09:49:00 (none) comm[122]: XferRqst XferRqstQ(post) adding (#1 type=1 ipaddr=127.0.0.1 port=8000 name=modLog dataname=/var/log/svclog infile=/var/log/svclog.upload outfile=)
Mar 21 09:49:00 (none) comm[122]: XferRqst XferRqstQ(post) adding (#3 type=1 ipaddr=127.0.0.1 port=8000 name=Performance Log dataname= infile=/var/log/perflog.now outfile=)
Mar 21 09:49:00 (none) comm[122]: Call: create 411 rqst
Mar 21 09:49:00 (none) comm[122]: XferRqst XferRqstQ(post) adding (#4 type=1 ipaddr=127.0.0.1 port=8000 name=FourOneOneRqst dataname=FourOneOneResp infile=/var/tmp/TCD411.send outfile=/var/tmp/TCD411.recv)
Mar 21 09:49:00 (none) comm[122]: Call: create ident block
Mar 21 09:49:02 (none) comm[122]: Call: Enqueue Ident
Mar 21 09:49:07 (none) comm[122]: XferRqst XferRqstQ(post) adding (#5 type=1 ipaddr=127.0.0.1 port=8000 name=HServerRqst dataname=HServerResp infile=/var/tmp/HServer.send outfile=/var/tmp/HServer.recv)
Mar 21 09:49:07 (none) comm[122]: commglobals Rqst Summary Start
Mar 21 09:49:07 (none) comm[122]: commglobals DESC: #1 type=1 ipaddr=127.0.0.1 port=8000 name=modLog dataname=/var/log/svclog infile=/var/log/svclog.upload outfile=
Mar 21 09:49:07 (none) comm[122]: commglobals STATUS: #1 fopen=F fclose=F fverify=F feval=F fopenstatus=F verifystatus=F evalstatus=0x0 nread=0 nwrite=0 nreaderr=0 nwriteerr=0
Mar 21 09:49:07 (none) comm[122]: commglobals DESC: #2 type=1 ipaddr=127.0.0.1 port=8000 name=commerceLog dataname=/var/log/commlog infile=/var/log/commlog.upload outfile=
Mar 21 09:49:07 (none) comm[122]: commglobals STATUS: #2 fopen=F fclose=F fverify=F feval=F fopenstatus=F verifystatus=F evalstatus=0x0 nread=0 nwrite=0 nreaderr=0 nwriteerr=0
Mar 21 09:49:07 (none) comm[122]: commglobals DESC: #3 type=1 ipaddr=127.0.0.1 port=8000 name=Performance Log dataname= infile=/var/log/perflog.now outfile=
Mar 21 09:49:07 (none) comm[122]: commglobals STATUS: #3 fopen=F fclose=F fverify=F feval=F fopenstatus=F verifystatus=F evalstatus=0x0 nread=0 nwrite=0 nreaderr=0 nwriteerr=0
Mar 21 09:49:07 (none) comm[122]: commglobals DESC: #4 type=1 ipaddr=127.0.0.1 port=8000 name=FourOneOneRqst dataname=FourOneOneResp infile=/var/tmp/TCD411.send outfile=/var/tmp/TCD411.recv
Mar 21 09:49:07 (none) comm[122]: commglobals STATUS: #4 fopen=F fclose=F fverify=F feval=F fopenstatus=F verifystatus=F evalstatus=0x0 nread=0 nwrite=0 nreaderr=0 nwriteerr=0
Mar 21 09:49:07 (none) comm[122]: commglobals DESC: #5 type=1 ipaddr=127.0.0.1 port=8000 name=HServerRqst dataname=HServerResp infile=/var/tmp/HServer.send outfile=/var/tmp/HServer.recv
Mar 21 09:49:07 (none) comm[122]: commglobals STATUS: #5 fopen=F fclose=F fverify=F feval=F fopenstatus=F verifystatus=F evalstatus=0x0 nread=0 nwrite=0 nreaderr=0 nwriteerr=0
Mar 21 09:49:07 (none) comm[122]: commglobals Rqst Summary End
Mar 21 09:49:07 (none) comm[122]: CallService: PreCall: err 0
Mar 21 09:49:07 (none) comm[122]: CallService: StartCall: err 0
Mar 21 09:49:07 (none) comm[122]: CallService: InCall start
Mar 21 09:49:07 (none) comm[122]: CallService: InCall updatesubphase SP_START_AUTH err 0
Mar 21 09:49:07 (none) comm[122]: NetAgent: drainGetPostQ: starting doXfer(#1 type=1 ipaddr=127.0.0.1 port=8000 name=modLog dataname=/var/log/svclog infile=/var/log/svclog.upload outfile=)
Mar 21 09:49:07 (none) comm[122]: FileRqst opened input file /var/log/svclog.upload
Mar 21 09:49:07 (none) comm[122]: XferRqst Open() done: (#1 fopen=T fclose=F fverify=F feval=F fopenstatus=F verifystatus=F evalstatus=0x0 nread=0 nwrite=0 nreaderr=0 nwriteerr=0)
Mar 21 09:52:07 (none) comm[122]: NetAgent: doXfer: tmk tcp socket failed 327685
Mar 21 09:52:07 (none) comm[122]: NetAgent: Process: drainPostQ err 327685
Mar 21 09:52:07 (none) comm[122]: NetAgent: flushing all queues
Mar 21 09:52:07 (none) comm[122]: CallService: InCall: err 327685
Mar 21 09:52:09 (none) comm[122]: CallService: EndCall returns 327685
Mar 21 09:52:09 (none) comm[122]: CallService: EndCall: err 327685
Mar 21 09:52:09 (none) comm[122]: commglobals fBackhaulCallM = 0, evalOK = 1
Mar 21 09:52:09 (none) comm[122]: commglobals FBackhaulDone=F
Mar 21 09:52:10 (none) aval_pp[122]: NukeOrphanedRecordings found 0 orphans
Mar 21 09:52:10 (none) comm[122]: CallService: CleanupCall: Cleanup err 0