1.0d locking out / crashing / freezing in general use
Posted: Tue May 22, 2012 1:20 pm
I've an old and venerable Tivo that I've just re-imaged with AltEPG 1.0d.
I'm now finding that I get intermittent daily lockups of the unit which I can't recover without power off (telnet / TivoWeb don't work and the picture freezes). My situation is unusual compared to others on the forum as this definitely doesn't happen during dial-ins but during normal usage.
Here's a log extract from tvlog:
May 22 13:27:00 (none) Recorder[331]: Adding check schedule task
May 22 13:27:10 (none) Recorder[331]: CheckSchedule: creating action for: rec 490009
May 22 13:27:10 (none) Recorder[331]: Creating normal action
May 22 13:27:10 (none) Recorder[331]: Creating normal action
May 22 13:27:10 (none) Recorder[331]: CheckSchedule: next creation at 15482 47646: rec 490010
May 22 13:27:10 (none) Recorder[331]: InitialAction rec 490009
May 22 13:27:10 (none) Recorder[331]: InitialAction RecId 490009
May 22 13:27:10 (none) Recorder[331]: Item 490009: estimate kb per second: 1247
May 22 13:27:10 (none) Deadline[331]: Task RequestTuner started late by 3609ms
May 22 13:27:10 (none) Recorder[331]: RequestTuner rec 490009
May 22 13:27:10 (none) TvVideoPolicy[331]: RecordingTunerRequest on 9
May 22 13:27:10 (none) VideoGuts[331]: RecordingTunerResult DENIED 9
May 22 13:27:10 (none) Deadline[331]: Task RequestTuner ran late by 2615ms
May 22 13:27:10 (none) Recorder[331]: Got EVT_VIDEO_SESSION 5
May 22 13:27:10 (none) Recorder[331]: DeniedTunerLock event received
May 22 13:27:10 (none) Recorder[331]: DeniedTunerLock event received
May 22 13:27:10 (none) Recorder[331]: Abr-- recording 490009 reason DeniedTunerLock event in recording engine
May 22 13:27:10 (none) Recorder[331]: Adding check schedule task
May 22 13:27:19 (none) mempool[324]: MyWorld block: 601kB/723kB chunk: 129kB/140kB unused: 2778kB search: 1 (size=3731424)
May 22 13:27:19 (none) mempool[324]: Osd block: 36kB/42kB chunk: 940kB/940kB unused: 1994kB search: 0 (size=3051488)
May 22 13:27:33 (none) TmkMediaswitch::Trace[330]: Drift = 1
May 22 13:31:22 (none) TmkMediaswitch::Trace[330]: Lost VBI lock
May 22 13:31:23 (none) last message repeated 5 times
May 22 13:34:56 (none) Recorder[331]: Adding check schedule task
May 22 13:40:43 (none) TmkTransform::Trace[330]: ClipCache 0x3000fc28 Secondary Reset
May 22 13:40:43 (none) ClipCache[326]: 0x3000fc28 in Entry(), thread 326
May 22 13:44:40 (none) TmkMediaswitch::Trace[330]: Lost VBI lock
May 22 13:45:05 (none) last message repeated 194 times
May 22 13:45:39 (none) mempool[324]: MyWorld block: 584kB/723kB chunk: 129kB/140kB unused: 2778kB search: 1 (size=3731424)
May 22 13:45:39 (none) mempool[324]: Osd block: 36kB/42kB chunk: 940kB/940kB unused: 1994kB search: 0 (size=3051488)
May 22 13:46:27 (none) TmkMediaswitch::Trace[330]: Lost VBI lock
May 22 13:48:03 (none) last message repeate
May 22 13:48:03 (none) last message repeated 259 times
May 22 13:49:04 (none) last message repeated 547 times
May 22 13:50:14 (none) last message repeated 163 times
May 22 13:51:15 (none) last message repeated 548 times
May 22 13:52:16 (none) last message repeated 551 times
May 22 13:53:44 (none) last message repeated 101 times
.
(I admit the 13:46:27 TmkMediaswitch message worries me). I've redone Delete All / Guided Setup a couple of time to ensure the AltEPG program data is clean.
Has anyone any ideas that I can try next?
Cheers
Martin
I'm now finding that I get intermittent daily lockups of the unit which I can't recover without power off (telnet / TivoWeb don't work and the picture freezes). My situation is unusual compared to others on the forum as this definitely doesn't happen during dial-ins but during normal usage.
Here's a log extract from tvlog:
May 22 13:27:00 (none) Recorder[331]: Adding check schedule task
May 22 13:27:10 (none) Recorder[331]: CheckSchedule: creating action for: rec 490009
May 22 13:27:10 (none) Recorder[331]: Creating normal action
May 22 13:27:10 (none) Recorder[331]: Creating normal action
May 22 13:27:10 (none) Recorder[331]: CheckSchedule: next creation at 15482 47646: rec 490010
May 22 13:27:10 (none) Recorder[331]: InitialAction rec 490009
May 22 13:27:10 (none) Recorder[331]: InitialAction RecId 490009
May 22 13:27:10 (none) Recorder[331]: Item 490009: estimate kb per second: 1247
May 22 13:27:10 (none) Deadline[331]: Task RequestTuner started late by 3609ms
May 22 13:27:10 (none) Recorder[331]: RequestTuner rec 490009
May 22 13:27:10 (none) TvVideoPolicy[331]: RecordingTunerRequest on 9
May 22 13:27:10 (none) VideoGuts[331]: RecordingTunerResult DENIED 9
May 22 13:27:10 (none) Deadline[331]: Task RequestTuner ran late by 2615ms
May 22 13:27:10 (none) Recorder[331]: Got EVT_VIDEO_SESSION 5
May 22 13:27:10 (none) Recorder[331]: DeniedTunerLock event received
May 22 13:27:10 (none) Recorder[331]: DeniedTunerLock event received
May 22 13:27:10 (none) Recorder[331]: Abr-- recording 490009 reason DeniedTunerLock event in recording engine
May 22 13:27:10 (none) Recorder[331]: Adding check schedule task
May 22 13:27:19 (none) mempool[324]: MyWorld block: 601kB/723kB chunk: 129kB/140kB unused: 2778kB search: 1 (size=3731424)
May 22 13:27:19 (none) mempool[324]: Osd block: 36kB/42kB chunk: 940kB/940kB unused: 1994kB search: 0 (size=3051488)
May 22 13:27:33 (none) TmkMediaswitch::Trace[330]: Drift = 1
May 22 13:31:22 (none) TmkMediaswitch::Trace[330]: Lost VBI lock
May 22 13:31:23 (none) last message repeated 5 times
May 22 13:34:56 (none) Recorder[331]: Adding check schedule task
May 22 13:40:43 (none) TmkTransform::Trace[330]: ClipCache 0x3000fc28 Secondary Reset
May 22 13:40:43 (none) ClipCache[326]: 0x3000fc28 in Entry(), thread 326
May 22 13:44:40 (none) TmkMediaswitch::Trace[330]: Lost VBI lock
May 22 13:45:05 (none) last message repeated 194 times
May 22 13:45:39 (none) mempool[324]: MyWorld block: 584kB/723kB chunk: 129kB/140kB unused: 2778kB search: 1 (size=3731424)
May 22 13:45:39 (none) mempool[324]: Osd block: 36kB/42kB chunk: 940kB/940kB unused: 1994kB search: 0 (size=3051488)
May 22 13:46:27 (none) TmkMediaswitch::Trace[330]: Lost VBI lock
May 22 13:48:03 (none) last message repeate
May 22 13:48:03 (none) last message repeated 259 times
May 22 13:49:04 (none) last message repeated 547 times
May 22 13:50:14 (none) last message repeated 163 times
May 22 13:51:15 (none) last message repeated 548 times
May 22 13:52:16 (none) last message repeated 551 times
May 22 13:53:44 (none) last message repeated 101 times
.
(I admit the 13:46:27 TmkMediaswitch message worries me). I've redone Delete All / Guided Setup a couple of time to ensure the AltEPG program data is clean.
Has anyone any ideas that I can try next?
Cheers
Martin