PDA

View Full Version : Old series 1, trouble on broadband daily call


ggpipe
07-05-2006, 04:25 PM
I posted this on the silicondust forum, but didn't get too far there, so I thought I would try here.

I have had a S1 Sony SA Tivo for quite a while, on dial up. Recently I switched to a new VOIP provider (Packet8) and the Tivo dialup no longer works. It worked on Vonage.

Anyhow I have the following setup:

- S1 SA Sony TiVo (v3.01 software)
- 9thtee.com ISA adapter, with 3com ISA ethernet card
- Verizon FIOS internet
- dlink router
- dlink 4 port hub

I setup tivoweb, telnet and ftp some time ago with a static ip and that all works fine. It is using a ISA ethernet adapter board I got from 9thtee.com. I gathered that I need to enter ,#401 for the dialup prefix code to enable the dialup over broadband. Tried that and it doesn't work. I have verified that outbound access works as I can do a traceroute to IPs on the internet.

What should I do to fix it?

Here is a excerpt from the tclient log

Jun 28 03:33:47 (none) tcphonehome[119]: Setting MCP PhoneHome action: RUNNING
Jun 28 03:33:47 (none) tcphonehome[119]: pCommMempool empty
Jun 28 03:33:47 (none) tcphonehome[119]: useBackupTollFree is 1
Jun 28 03:33:47 (none) tcphonehome[119]: phonehome: received message. type = 30 subtype = 3
Jun 28 03:33:47 (none) tcphonehome[119]: creating CommGlobals
Jun 28 03:33:55 (none) tcphonehome[119]: created CommGlobals
Jun 28 03:33:55 (none) tcphonehome[119]: PerformCall, subtype=3 forceTollFree=0 automated=0
Jun 28 03:33:55 (none) tcphonehome[119]: setCallStatus called with: In Progress state 1
Jun 28 03:33:55 (none) tcphonehome[119]: LastCallAttempt at 1151464825
Jun 28 03:33:55 (none) tcphonehome[119]: setting call status to: In Progress
Jun 28 03:33:55 (none) tcphonehome[119]: setting call in progress to 1 (second successCount)
Jun 28 03:33:55 (none) tcphonehome[119]: Setting callActive to 1
Jun 28 03:33:55 (none) tcphonehome[119]: setting call attempt
Jun 28 03:33:55 (none) tcphonehome[119]: Error statting file /var/log/http: No such file or directory (errno=2)
Jun 28 03:33:55 (none) tcphonehome[119]: Error statting file /var/log/Ohttp: No such file or directory (errno=2)
Jun 28 03:33:55 (none) tcphonehome[119]: Calling TClient
Jun 28 03:33:55 (none) comm[119]: CallStatusReporter: Phase: Select_Phone, Status In Progress
Jun 28 03:33:55 (none) comm[119]: CallStatusReporter: sending message "EX|29"
Jun 28 03:33:55 (none) comm[119]: CallService: preprocessing call.
Jun 28 03:33:55 (none) comm[119]: CallStatusReporter: Phase: Prepare_Call, Status In Progress
Jun 28 03:33:55 (none) comm[119]: CallStatusReporter: sending message "EX|29"
Jun 28 03:33:55 (none) comm[119]: SvcLogRqst: open(/var/log/svclog.tmp)ed (tmpfd = 20)
Jun 28 03:33:55 (none) comm[119]: SvcLogRqst: open(/var/log/svclog.upload)ed (uploadfd = 21)
Jun 28 03:33:55 (none) comm[119]: SvcLogRqst: final (469 bytes)::read() (status = 0)
Jun 28 03:33:55 (none) comm[119]: SvcLogRqst: unlink(/var/log/svclog.tmp)ed (status = 0)
Jun 28 03:33:55 (none) comm[119]: Start Ident ==================
Jun 28 03:33:55 (none) comm[119]: version: 3
Jun 28 03:33:55 (none) comm[119]: centerID: 01000001123CC55
Jun 28 03:33:55 (none) comm[119]: reasonCode: 4
Jun 28 03:33:55 (none) comm[119]: softwareDesc: NONE
Jun 28 03:33:55 (none) comm[119]: locationID: NONE
Jun 28 03:33:55 (none) comm[119]: sequenceCookie: NONE
Jun 28 03:33:55 (none) comm[119]: headendID: NONE
Jun 28 03:33:55 (none) comm[119]: headendHisto:
Jun 28 03:33:55 (none) comm[119]: headendWorst:
Jun 28 03:33:55 (none) comm[119]: showcaseDesc: NONE
Jun 28 03:33:55 (none) comm[119]: inventoryFile:
Jun 28 03:33:55 (none) comm[119]: waitingCount:
Jun 28 03:33:55 (none) comm[119]: confInfo:
Jun 28 03:33:55 (none) comm[119]: dialConfig:
Jun 28 03:33:55 (none) comm[119]: messageDesc:
Jun 28 03:33:55 (none) comm[119]: irdbVersion:
Jun 28 03:33:55 (none) comm[119]: genreVersion:
Jun 28 03:33:55 (none) comm[119]: logoVersion:
Jun 28 03:33:55 (none) comm[119]: affiliationVersion:
Jun 28 03:33:55 (none) comm[119]: showcaseVersion:
Jun 28 03:33:55 (none) comm[119]: demoMode:
Jun 28 03:33:55 (none) comm[119]: swVerName: 3.0-01-1-010
Jun 28 03:33:55 (none) comm[119]: apgOnly:
Jun 28 03:33:55 (none) comm[119]: useChksums: TRUE
Jun 28 03:33:55 (none) comm[119]: premiumShowcases:
Jun 28 03:33:55 (none) comm[119]: captureRequests:
Jun 28 03:33:55 (none) comm[119]: menuItems:
Jun 28 03:33:55 (none) comm[119]: collabData:
Jun 28 03:33:55 (none) comm[119]: signedFiles:
Jun 28 03:33:55 (none) comm[119]: otherDatasets:
Jun 28 03:33:55 (none) comm[119]: rbBackgrounds:
Jun 28 03:33:55 (none) comm[119]: dataGroupList:
Jun 28 03:33:55 (none) comm[119]: lastAvalDownload:
Jun 28 03:33:55 (none) comm[119]: userInitiated:
Jun 28 03:33:56 (none) comm[119]: mfsTotalApp:
Jun 28 03:33:56 (none) comm[119]: mfsAvailApp:
Jun 28 03:33:56 (none) comm[119]: mfsTotalMedia:
Jun 28 03:33:56 (none) comm[119]: mfsAvailMedia:
Jun 28 03:33:56 (none) comm[119]: clipsTotalSize:
Jun 28 03:33:56 (none) comm[119]: clipsAvailSize:
Jun 28 03:33:56 (none) comm[119]: rbTotalSize:
Jun 28 03:33:56 (none) comm[119]: rbAvailSize:
Jun 28 03:33:56 (none) comm[119]: tcdId: 01000001123CC55
Jun 28 03:33:56 (none) comm[119]: callId: 1151465635
Jun 28 03:33:56 (none) comm[119]: sourceParameterList:
Jun 28 03:33:56 (none) comm[119]: configParameterList:
Jun 28 03:33:56 (none) comm[119]: iceboxinfo:
Jun 28 03:33:56 (none) comm[119]: timeStamp: ...
Jun 28 03:33:56 (none) comm[119]: End Ident ==================
Jun 28 03:33:56 (none) comm[119]: CallService: Start err 0
Jun 28 03:33:56 (none) comm[119]: CAM_ID not found.
Jun 28 03:33:56 (none) comm[119]: CallStatusReporter: Phase: Dial, Status In Progress
Jun 28 03:33:56 (none) comm[119]: CallStatusReporter: sending message "CL|30"
Jun 28 03:33:56 (none) comm[119]: Backdoor code 4, enable calls via broadband
Jun 28 03:33:56 (none) comm[119]: CallStatusReporter: Turning off-hook LED on
Jun 28 03:33:56 (none) comm[119]: Opening device
Jun 28 03:33:56 (none) comm[119]: Initializing modem
Jun 28 03:33:56 (none) comm[119]: ATZ
Jun 28 03:33:56 (none) comm[119]: OK
Jun 28 03:33:56 (none) comm[119]: Determining modem type
Jun 28 03:33:56 (none) comm[119]: ATI3
Jun 28 03:33:56 (none) comm[119]: V2.210K1-V34_DLP
Jun 28 03:33:56 (none) comm[119]: OK
Jun 28 03:33:56 (none) comm[119]: Modem is OLD
Jun 28 03:33:56 (none) comm[119]: Set up modem and check for availability
Jun 28 03:33:56 (none) comm[119]: Setting up old modem
Jun 28 03:33:56 (none) comm[119]: 0007: BB
Jun 28 03:33:56 (none) comm[119]: 02
Jun 28 03:33:56 (none) comm[119]: 0008: E0
Jun 28 03:33:56 (none) comm[119]: OK
Jun 28 03:33:56 (none) comm[119]: ATQ0
Jun 28 03:33:56 (none) comm[119]: OK
Jun 28 03:33:56 (none) comm[119]: ATS0=0
Jun 28 03:33:56 (none) comm[119]: OK
Jun 28 03:33:56 (none) comm[119]: ATW2S6=8S7=50S11=100%C0&D2+MS=11,1,300,33600,0,0
Jun 28 03:33:56 (none) comm[119]: OK
Jun 28 03:33:56 (none) comm[119]: Modem set up and onhook.
Jun 28 03:33:56 (none) comm[119]: Turning off dial tone detection
Jun 28 03:33:56 (none) comm[119]: ATX3
Jun 28 03:33:56 (none) comm[119]: OK
Jun 28 03:33:56 (none) comm[119]: Trying to connect
Jun 28 03:35:01 (none) comm[119]: ATDT9723720000
Jun 28 03:35:01 (none) comm[119]: NO CARRIER
Jun 28 03:35:01 (none) comm[119]: Failed to get a connection. No Carrier.
Jun 28 03:35:03 (none) comm[119]: Modem dialcode is 12
Jun 28 03:35:03 (none) comm[119]: CallStatusReporter: Turning off-hook LED off
Jun 28 03:35:06 (none) tcphonehome[119]: CallService return status 0xffff
Jun 28 03:35:06 (none) comm[119]: AT&V1&V2
Jun 28 03:35:06 (none) comm[119]: TERMINATION REASON.......... NONE
Jun 28 03:35:06 (none) comm[119]: LAST TX rate................ N/A
Jun 28 03:35:06 (none) comm[119]: HIGHEST TX rate............. 300 BPS
Jun 28 03:35:06 (none) comm[119]: LAST RX rate................ N/A
Jun 28 03:35:06 (none) comm[119]: HIGHEST RX rate............. 300 BPS
Jun 28 03:35:06 (none) comm[119]: PROTOCOL.................... N/A
Jun 28 03:35:06 (none) comm[119]: COMPRESSION................. N/A
Jun 28 03:35:06 (none) comm[119]: Line QUALITY................ 255
Jun 28 03:35:06 (none) comm[119]: Rx LEVEL.................... 215
Jun 28 03:35:06 (none) comm[119]: Highest Rx State............ 00
Jun 28 03:35:06 (none) comm[119]: Highest TX State............ 00
Jun 28 03:35:06 (none) comm[119]: EQM Sum..................... FFFF
Jun 28 03:35:06 (none) comm[119]: RBS Pattern................. FF
Jun 28 03:35:06 (none) comm[119]: Rate Drop................... FF
Jun 28 03:35:06 (none) comm[119]: Digital Loss................ None
Jun 28 03:35:06 (none) comm[119]: Local Rtrn Count............ 00
Jun 28 03:35:06 (none) comm[119]: Remote Rtrn Count........... 00
Jun 28 03:35:06 (none) comm[119]: BEGINaa255ab255ac0ad255ba255bb255bc0bd255ca255cb255cc255da255ea255eb255fa255fb255fc0ga10gb255ha255hb 255hc0hd0he255hf255hg255hh255hi255hj255hk255hl255hm255hn255ho255hp255hq255hr255hs255ia255ib255ic0ja0 jb0jc0jd0je0ka255kb255kc255kd255ke255kf255kg255kh255ki255kj255kk255kl255km255kn255la0lb0lc255ld255ma 0mb0mc0na255nb255oa255ob255oc255od255oe255of255og255pa255pb0qa21qb0qc255ra255rb255rc255END
Jun 28 03:35:06 (none) comm[119]: OK
Jun 28 03:35:06 (none) comm[119]: ATZ
Jun 28 03:35:06 (none) comm[119]: OK
Jun 28 03:35:06 (none) comm[119]: CallStatusReporter: Phase: Dial, Status Failed
Jun 28 03:35:06 (none) comm[119]: CallStatusReporter: sending message "EX|12"
Jun 28 03:35:06 (none) tcphonehome[119]: TClient failed: EX|12
Jun 28 03:35:06 (none) tcphonehome[119]: Sending dialup event, subtype 8, msg EX|12
Jun 28 03:35:06 (none) tcphonehome[119]: setCallStatus called with: Failed state 0
Jun 28 03:35:19 (none) tcphonehome[119]: LastCallAttempt at 1151465635
Jun 28 03:35:19 (none) tcphonehome[119]: setting call status to: Failed
Jun 28 03:35:19 (none) tcphonehome[119]: setting call in progress to 0 (second successCount)
Jun 28 03:35:19 (none) tcphonehome[119]: Setting callActive to 0
Jun 28 03:35:19 (none) comm[119]: CallStatusReporter: sending data changed event 20
Jun 28 03:35:19 (none) tcphonehome[119]: destroying CommGlobals!
Jun 28 03:35:19 (none) tcphonehome[119]: pCommMempool empty
Jun 28 03:35:19 (none) tcphonehome[119]: Setting MCP PhoneHome action: ENABLED

ggpipe
07-07-2006, 02:24 PM
Noone have any suggestions?