PDA

View Full Version : Log file for S03 error


pneumatic
11-12-2017, 02:42 PM
Hello

I am getting the S03 error during guided setup when using postcode 5000. Below is the relevant snippet of my log file during the error from var/log/tclient.

You can see that it gets up to 73% loading data (pct=73) at which point it fails. I was hoping an oztivo engineer might read this and advise on how I may be able to fix it, perhaps with a command through telnet or some other method.


Dec 10 12:36:10 (none) AvalPercentReporter[620]: pct=10 nSec=5 nSecLeft=48
Dec 10 12:36:14 (none) WatchdogChore[572]: SameCallActive, compare last UNKNOWN to now 1512909313
Dec 10 12:36:16 (none) AvalPercentReporter[620]: pct=20 nSec=11 nSecLeft=46
Dec 10 12:36:18 (none) AvalPercentReporter[620]: pct=30 nSec=13 nSecLeft=31
Dec 10 12:36:19 (none) AvalPercentReporter[620]: pct=40 nSec=14 nSecLeft=22
Dec 10 12:36:22 (none) AvalPercentReporter[620]: pct=50 nSec=17 nSecLeft=18
Dec 10 12:36:24 (none) AvalPercentReporter[620]: pct=60 nSec=19 nSecLeft=13
Dec 10 12:36:24 (none) AvalPercentReporter[620]: pct=73 nSec=19 nSecLeft=8
Dec 10 12:36:24 (none) db[620]: DbLoadGeneric TvStatus=0x30012 near GenBatch: Size=1 failed while nproc=790 item#=788 id=112699950 ty=50 nBadErr=1 lastBadErr=TvStatus=0x30012
Dec 10 12:36:24 (none) db[620]: DbLoadGeneric TvStatus=0x30012 near GenBatch: min=4 max=5 failed while nproc=790 item#=788 id=112699950 ty=50 nBadErr=2 lastBadErr=TvStatus=0x30012
Dec 10 12:36:24 (none) db[620]: DbLoadGeneric TvStatus=0x30012 near GenBatch: min=4 max=6 failed while nproc=790 item#=788 id=112699950 ty=50 nBadErr=3 lastBadErr=TvStatus=0x30012
Dec 10 12:36:24 (none) db[620]: DbLoadGeneric TvStatus=0x30012 near GenBatch: min=0 max=6 failed while nproc=790 item#=788 id=112699950 ty=50 nBadErr=4 lastBadErr=TvStatus=0x30012
Dec 10 12:36:24 (none) db[620]: DbLoadGeneric TvStatus=0x30012 near GenBatch: min=0 max=17 failed while nproc=790 item#=788 id=112699950 ty=50 nBadErr=5 lastBadErr=TvStatus=0x30012
Dec 10 12:36:24 (none) db[620]: DbLoadGeneric TvStatus=0x30012 near GenBatch: min=0 max=50 failed while nproc=790 item#=788 id=112699950 ty=50 nBadErr=6 lastBadErr=TvStatus=0x30012
Dec 10 12:36:24 (none) db[620]: DbLoadGeneric TvStatus=0x30012 near GenBatch: min=0 max=150 failed while nproc=790 item#=788 id=112699950 ty=50 nBadErr=7 lastBadErr=TvStatus=0x30012
Dec 10 12:36:24 (none) db[620]: DbLoadGeneric TvStatus=0x30012 near Gen:end while nproc=790 item#=788 id=112699950 ty=50 nBadErr=8 lastBadErr=TvStatus=0x30012
Dec 10 12:36:24 (none) db[620]: DbLoader ProcessOneGroupItem TvStatus=0x30012 near nproc=790 item#=788 id=112699950 ty=50 nBadErr=8 lastBadErr=TvStatus=0x30012
Dec 10 12:36:24 (none) db[620]: DbLoadGeneric TvStatus=0x30012 near Group ProcessOneGpItem while nproc=790 item#=788 id=112699950 ty=50 nBadErr=9 lastBadErr=TvStatus=0x30012
Dec 10 12:36:24 (none) db[620]: DbLoader Unpack=/var/packages/5000-p17375-tgroup-v236.snow.bnd: Processing TvStatus=0x30012
Dec 10 12:36:24 (none) db[620]: DbLoader FinishedLoading(Unpack=/var/packages/5000-p17375-tgroup-v236.snow.bnd): nAction=811/825 nBatch=790 nBatchTrans=790 nBadBatch=7 nproc=790 item#=788 id=112699950 ty=50 nBadErr=9 lastBadErr=TvStatus=0x30012
Dec 10 12:36:24 (none) db[620]: DbLoader Unpack=/var/packages/5000-p17375-tgroup-v236.snow.bnd: Error Processing TvStatus=0x30012
Dec 10 12:36:24 (none) db[620]: DbLoader DbLoad failed to process file=/var/packages/5000-p17375-tgroup-v236.snow.bnd err=x30012
Dec 10 12:36:24 (none) avalPP[620]: DBLoad Failed with errcode x30012!
Dec 10 12:36:24 (none) AvalDbLoader[620]: Enabling gc
Dec 10 12:36:24 (none) SoftwareLoader[620]: TvStatus=0x30012 SoftwareLoaderAvalTraits reportError
Dec 10 12:36:24 (none) AvalBlockIoUnpacker[620]: sFile=80898 sBlock=16368 nCallRead=14026 nByteRead=7165 curBlockHit=7160 prevBlockHit=0 blockRead=6
Dec 10 12:36:24 (none) avalPP[620]: file=5000-p17375-tgroup-v236.snow.bnd (3) PostProc returns FAILURE_00030012 (30012)
Dec 10 12:36:24 (none) avalPP[620]: StartDirectory failed, returned error <0x30012>
Dec 10 12:36:24 (none) avalPP[620]: CLEARING OUT ANY TROUBLED DIRECTORIES
Dec 10 12:36:24 (none) avalPP[620]: Removing dead directory <0x5ee47660>
Dec 10 12:36:24 (none) avalPP[620]: NukeFromDisk returns <0>
Dec 10 12:36:24 (none) avalPP[620]: DONE CLEARING OUT TROUBLED DIRECTORIES: bool retval=0
Dec 10 12:36:24 (none) comm[620]: There went Avalanche->Start! (err = 0x30012)
Dec 10 12:36:24 (none) comm[620]: RemovePackages dir=/var/packages, Deleted: SM-tivopvr_production-v143.slice.gz SM-tivoffm_production-v33.slice.gz 5000-p17375-tgroup-v236.snow.bnd
Dec 10 12:36:24 (none) aval_pp[620]: NukeOrphanedRecordings found 0 orphans
Dec 10 12:36:24 (none) Call[620]: Err: TvStatus=0x30012 ProcessQueue failed
Dec 10 12:36:24 (none) CallService[620]: Err: TvStatus=0x30012 Postprocessing failed
Dec 10 12:36:24 (none) NetAgent[620]: flushing all queues
Dec 10 12:36:24 (none) comm[620]: BackhaulStatus: type=1 hserver=1 tried=0 ok=1
Dec 10 12:36:24 (none) LogMgr[620]: Reverting private logs
Dec 10 12:36:24 (none) CallService[620]: Cleanup finished
Dec 10 12:36:24 (none) LogMgr[295]: Received the revert complete event
Dec 10 12:36:24 (none) PhoneHome[620]: TvStatus=0x30012 CallService done

The rest of the log file for that connection attempt can be found here (https://pastebin.com/cTRAPG1f).

Any help appreciated, thank you.
pneumatic
11-12-2017, 03:47 PM
According to this (http://www.boygenius.co.uk/tivo/BackupModuleFaq.aspx), 0x30012 error may indicate the guide data needs to finish indexing first. Perhaps there is a telnet command that can force indexing to take place?

edit: saw this http://www.oztivo.net/twiki/bin/view/Howto/ForceIndexing but it seems to be for series 1 and I can't find a force_index.tcl, if it even exists on TivoHD.