[mythtv-users] Firewire modules do not load

Fri Aug 21 23:42:09 UTC 2009

I have been trying to get my Motorola DCH3200 working for two weeks now with
only about a 50% success rate.  I am running Ubuntu 9.04 and MythTV trunk
v21133.  When I schedule a program to record, sometimes it works
flawlessly.  Other times I get this in my BE log:

2009-08-21 18:23:22.166 scheduler: Scheduled items: Scheduled 1110 items in
4.6 = 0.01 match + 4.61 place
2009-08-21 18:23:22.195 TVRec(8): ASK_RECORDING 8 0 0 0
2009-08-21 18:23:22.268 TVRec(8): Changing from None to Watching
RecordingOnly
2009-08-21 18:23:22.276 TVRec(8): HW Tuner: 8->8
2009-08-21 18:23:22.281 LAVCInfo(), Error: Unable to get handle for port: -1
                        eno: Invalid argument (22)
2009-08-21 18:23:23.294 ret_pid(0) child(3200) status(0x0)
2009-08-21 18:23:24.295 ret_pid(0) child(3200) status(0x0)
2009-08-21 18:23:24.571 ret_pid(3200) child(3200) status(0x0)
2009-08-21 18:23:24.572 External Tuning program exited with no error
2009-08-21 18:23:24.576 LAVCInfo(), Error: Unable to get handle for port: -1
                        eno: Invalid argument (22)
2009-08-21 18:23:24.583 LAVCInfo(), Error: Unable to get handle for port: -1
                        eno: Invalid argument (22)
2009-08-21 18:23:24.591 AutoExpire: CalcParams(): Max required Free Space:
3.0 GB w/freq: 15 min
2009-08-21 18:23:24.602 TVRec(8): Changing from Watching RecordingOnly to
None
2009-08-21 18:23:24.610 Started recording: Star Trek: Enterprise "The
Shipment": channel 7739 on cardid 8, sourceid 7
2009-08-21 18:23:24.622 Unknown type, recording width was 0
2009-08-21 18:23:24.634 scheduler: Started recording: Star Trek: Enterprise
"The Shipment": channel 7739 on cardid 8, sourceid 7
2009-08-21 18:23:24.736 mythbackend version: trunk [21133] www.mythtv.org
2009-08-21 18:23:24.893 ProgramInfo, Error: GetPlaybackURL:
'7763_20090821174800.mpg' should be local, but it can not be found.
2009-08-21 18:23:25.188 Using runtime prefix = /usr/local
2009-08-21 18:23:25.199 Empty LocalHostName.
2009-08-21 18:23:25.199 Using localhost value of mythtv
2009-08-21 18:23:25.717 Reschedule requested for id 0.
2009-08-21 18:23:26.152 New DB connection, total: 1
2009-08-21 18:23:26.162 Connected to database 'mythconverg' at host:
localhost
2009-08-21 18:23:26.165 Closing DB connection named 'DBManager0'
2009-08-21 18:23:26.166 Deleting UPnP client...
2009-08-21 18:23:26.621 ProgramInfo, Error: GetPlaybackURL:
'7763_20090821174800.mpg' should be local, but it can not be found.
2009-08-21 18:23:27.053 Connected to database 'mythconverg' at host:
localhost
2009-08-21 18:23:27.061 Current Schema Version: 1239
2009-08-21 18:23:27.065 New DB connection, total: 2
2009-08-21 18:23:27.067 Connected to database 'mythconverg' at host:
localhost
2009-08-21 18:23:27.083 Preview Error: Previewer file
'/mythtv/data/7739_20090821182300.mpg' is not valid.
2009-08-21 18:23:27.084 Preview Error: Run() file not local:
'/mythtv/data/7739_20090821182300.mpg'
2009-08-21 18:23:27.098 Preview Error: Preview process not ok.
                        fileinfo(/mythtv/data/7739_20090821182300.mpg.png)
exists: 0 readable: 0 size: 0
2009-08-21 18:23:29.695 Scheduled 1110 items in 3.9 = 0.00 match + 3.95
place
2009-08-21 18:23:29.701 scheduler: Scheduled items: Scheduled 1110 items in
3.9 = 0.00 match + 3.95 place

and sometimes:

2009-08-20 18:29:30.424 TVRec(8): ASK_RECORDING 8 29 0 0
2009-08-20 18:30:02.393 TVRec(8): Changing from None to Watching
RecordingOnly
2009-08-20 18:30:02.412 TVRec(8): HW Tuner: 8->8
2009-08-20 18:30:03.478 ret_pid(0) child(7274) status(0x0)
2009-08-20 18:30:04.008 ret_pid(7274) child(7274) status(0x0)
2009-08-20 18:30:04.009 External Tuning program exited with no error
2009-08-20 18:30:04.061 LFireDev(0023A2FFFE93B690): Buffered packets 2000
(8000 KB)
2009-08-20 18:30:04.062 AutoExpire: CalcParams(): Max required Free Space:
3.0 GB w/freq: 15 min
2009-08-20 18:30:04.072 Started recording: How It's Made: channel 7763 on
cardid 8, sourceid 7
2009-08-20 18:30:04.077 scheduler: Started recording: How It's Made: channel
7763 on cardid 8, sourceid 7
2009-08-20 18:30:04.599 LFireDev(0023A2FFFE93B690), Warning: No Input in 50
msec...
2009-08-20 18:30:04.654 LFireDev(0023A2FFFE93B690), Warning: No Input in 100
msec...
2009-08-20 18:30:04.705 LFireDev(0023A2FFFE93B690), Warning: No Input in 150
msec...
2009-08-20 18:30:04.756 LFireDev(0023A2FFFE93B690), Warning: No Input in 200
msec...
2009-08-20 18:30:04.806 LFireDev(0023A2FFFE93B690), Warning: No Input in 250
msec...
2009-08-20 18:30:04.857 LFireDev(0023A2FFFE93B690), Warning: No Input in 300
msec...
2009-08-20 18:30:04.908 LFireDev(0023A2FFFE93B690), Warning: No Input in 350
msec...
2009-08-20 18:30:04.959 LFireDev(0023A2FFFE93B690), Warning: No Input in 400
msec...
2009-08-20 18:30:05.009 LFireDev(0023A2FFFE93B690), Warning: No Input in 450
msec...
2009-08-20 18:30:05.060 LFireDev(0023A2FFFE93B690), Warning: No Input in 500
msec...
2009-08-20 18:30:05.111 LFireDev(0023A2FFFE93B690), Warning: No Input in 550
msec...
2009-08-20 18:30:05.161 LFireDev(0023A2FFFE93B690), Warning: No Input in 600
msec...
2009-08-20 18:30:05.212 LFireDev(0023A2FFFE93B690), Warning: No Input in 650
msec...
2009-08-20 18:30:05.263 LFireDev(0023A2FFFE93B690), Warning: No Input in 700
msec...
2009-08-20 18:30:05.314 LFireDev(0023A2FFFE93B690), Warning: No Input in 750
msec...
2009-08-20 18:30:05.364 LFireDev(0023A2FFFE93B690), Warning: No Input in 800
msec...
2009-08-20 18:30:05.415 LFireDev(0023A2FFFE93B690), Warning: No Input in 850
msec...
2009-08-20 18:30:05.466 LFireDev(0023A2FFFE93B690), Warning: No Input in 900
msec...
2009-08-20 18:30:05.517 LFireDev(0023A2FFFE93B690), Warning: No Input in 950
msec...
2009-08-20 18:30:05.567 LFireDev(0023A2FFFE93B690), Warning: No Input in
1000 msec...
2009-08-20 18:30:05.618 LFireDev(0023A2FFFE93B690), Warning: No Input in
1050 msec...
2009-08-20 18:30:05.619 LFireDev(0023A2FFFE93B690): ResetBus() -- begin
2009-08-20 18:30:05.621 LFireDev(0023A2FFFE93B690): ResetBus() -- end
2009-08-20 18:30:05.622 LFireDev(0023A2FFFE93B690): SignalReset(6634->6635)
2009-08-20 18:30:05.630 LFireDev(0023A2FFFE93B690): SignalReset(6634->6635):
Updating device list -- begin
2009-08-20 18:30:05.937 LFireDev(0023A2FFFE93B690): SignalReset(6634->6635):
Updating device list -- end

The modules installed are:

ken at mythtv:~$ lsmod | grep 1394
dv1394                 25948  0
raw1394                32732  0
ohci1394               38576  1 dv1394
ieee1394               94660  3 dv1394,raw1394,ohci1394

Running test-mpeg2 works only about half the time.  It has been very
frustrating.

Is this indicative of a bad firewire port or cable?  My firewire port is
integrated on the (ASUS) motherboard: Agere FW322.

Any clues or suggestions much appreciated.

-- Ken

>
> _______________________________________________
> mythtv-users mailing list
> mythtv-users at mythtv.org
> http://mythtv.org/cgi-bin/mailman/listinfo/mythtv-users
>
-------------- next part --------------
An HTML attachment was scrubbed...
URL: <http://mythtv.org/pipermail/mythtv-users/attachments/20090821/46c0c942/attachment.htm>