No subject

Thu Feb 23 20:31:07 UTC 2006

2006-03-25 19:00:02.883 Started recording "Dateline NBC" on channel:
1004 on cardid: 1, sourceid 1
2006-03-25 19:00:02.944 scheduler: Schedule Change
2006-03-25 19:00:02.971 Started recording "Signs" on channel: 1003 on
cardid: 2, sourceid 1
2006-03-25 19:00:03.562 Changing from None to RecordingOnly
2006-03-25 19:00:03.612 New DB connection, total: 6
2006-03-25 19:00:13.499 Starting Commercial Flagging for "Dateline
NBC" recorded from channel 1004 at Sat Mar 25 19:00:00 2006.
2006-03-25 19:00:13.507 commflag: Commercial Flagging Starting
2006-03-25 19:00:15.499 New DB connection, total: 1
2006-03-25 19:00:15.583 New DB connection, total: 2
2006-03-25 19:00:15.639 Connecting to backend server:
192.168.1.246:6543 (try 1 of 5)
2006-03-25 19:00:15.647 Using protocol version 15
2006-03-25 19:00:15.654 MainServer::HandleAnnounce Playback
2006-03-25 19:00:15.656 adding: localhost.localdomain as a client (events: =
0)
2006-03-25 19:00:23.964 Changing from None to RecordingOnly
2006-03-25 19:00:54.479 MainServer::HandleAnnounce Playback
2006-03-25 19:00:54.485 adding: localhost.localdomain as a client (events: =
1)
2006-03-25 19:01:13.507 Starting Commercial Flagging for "Signs"
recorded from channel 1003 at Sat Mar 25 19:00:00 2006.
2006-03-25 19:01:13.762 New DB connection, total: 1
2006-03-25 19:01:13.792 New DB connection, total: 2
2006-03-25 19:01:13.798 Invalid file handle when opening
/video/recordings//1003_20060325190000_20060325210000.nuv.  4 retries
remaining.
2006-03-25 19:01:14.306 Invalid file handle when opening
/video/recordings//1003_20060325190000_20060325210000.nuv.  3 retries
remaining.
2006-03-25 19:01:14.810 Invalid file handle when opening
/video/recordings//1003_20060325190000_20060325210000.nuv.  2 retries
remaining.
2006-03-25 19:01:15.314 Invalid file handle when opening
/video/recordings//1003_20060325190000_20060325210000.nuv.  1 retries
remaining.
2006-03-25 19:01:15.825 Invalid file handle when opening
/video/recordings//1003_20060325190000_20060325210000.nuv.  0 retries
remaining.
2006-03-25 19:01:16.341 Connecting to backend server:
192.168.1.246:6543 (try 1 of 5)
2006-03-25 19:01:16.388 Using protocol version 15
2006-03-25 19:01:16.395 MainServer::HandleAnnounce Playback
2006-03-25 19:01:16.396 adding: localhost.localdomain as a client (events: =
0)
2006-03-25 19:01:16.415 unknown socket
2006-03-25 19:51:05.200 MainServer::HandleAnnounce Playback
2006-03-25 19:51:05.254 adding: localhost.localdomain as a client (events: =
0)
2006-03-25 20:02:00.004 Finished recording Dateline NBC on channel: 1004
2006-03-25 20:02:00.082 scheduler: Last message repeated 1 times
2006-03-25 20:02:00.090 scheduler: Finished recording
2006-03-25 20:02:00.157 Changing from RecordingOnly to None
2006-03-25 20:02:00.157 Reschedule requested for id 0.
2006-03-25 20:02:02.978 Scheduled 315 items in 2.8 =3D 0.01 match + 2.81 pl=
ace
2006-03-25 20:02:03.002 scheduler: Scheduled items

2006-03-25 20:03:22.862 commflag: Last message repeated 1 times
2006-03-25 20:03:22.878 commflag: Commercial Flagging Finished
2006-03-25 20:03:22.906 Finished, 6 break(s) found.
2006-03-25 20:03:22.913 commflag: Commercial Flagging ERRORED
2006-03-25 20:03:22.930 ERROR in Commercial Flagging for "Signs"
recorded from channel 1003 at Sat Mar 25 19:00:00 2006, problem
opening file or inittin
g decoder, check backend log.

And then from the messages log:
Mar 25 19:00:13 localhost kernel: ivtv: 1000 ms time out waiting for firmwa=
re
Mar 25 19:00:13 localhost kernel: ivtv: Failed api call 0x000000d2
with result 0xfffffff0
Mar 25 19:00:13 localhost kernel: saa7115: decoder disable output
Mar 25 19:00:13 localhost kernel: saa7115: decoder enable output
Mar 25 19:00:23 localhost kernel: ivtv: 1000 ms time out waiting for firmwa=
re
Mar 25 19:00:23 localhost kernel: ivtv: Failed api call 0x000000d2
with result 0xfffffff0
Mar 25 19:00:23 localhost kernel: saa7115: decoder set picture
bright=3D127 contrast=3D63 saturation=3D63 hue=3D0
Mar 25 19:00:24 localhost last message repeated 3 times
Mar 25 19:00:24 localhost kernel: saa7115: decoder set size
Mar 25 19:00:28 localhost kernel: ivtv: No Free Mailbox for cmd
0x000000c7 after 100 tries!
Mar 25 19:00:28 localhost kernel: ivtv: Mailbox[0] 0x000000d3 flags 0x00000=
003
Mar 25 19:00:28 localhost kernel: ivtv: Mailbox[1] 0x000000c9 flags 0x00000=
003
Mar 25 19:00:28 localhost kernel: ivtv: Mailbox[2] 0x000000d6 flags 0x00000=
003
Mar 25 19:00:28 localhost kernel: ivtv: Firmware UNRESPONSIVE when
trying cmd 0x000000c7!!!
Mar 25 19:00:32 localhost kernel: ivtv: No Free Mailbox for cmd
0x00000091 after 100 tries!
Mar 25 19:00:32 localhost kernel: ivtv: Mailbox[0] 0x000000b9 flags 0x00000=
003
Mar 25 19:00:32 localhost kernel: ivtv: Mailbox[1] 0x000000bb flags 0x00000=
003
Mar 25 19:00:32 localhost kernel: ivtv: Mailbox[2] 0x0000008f flags 0x00000=
003
Mar 25 19:00:32 localhost kernel: ivtv: Firmware UNRESPONSIVE when
trying cmd 0x00000091!!!
Mar 25 19:00:36 localhost kernel: ivtv: No Free Mailbox for cmd
0x000000b1 after 100 tries!
Mar 25 19:00:36 localhost kernel: ivtv: Mailbox[0] 0x00000099 flags 0x00000=
003
Mar 25 19:00:36 localhost kernel: ivtv: Mailbox[1] 0x00000095 flags 0x00000=
003
Mar 25 19:00:36 localhost kernel: ivtv: Mailbox[2] 0x00000097 flags 0x00000=
003
Mar 25 19:00:36 localhost kernel: ivtv: Firmware UNRESPONSIVE when
trying cmd 0x000000b1!!!
Mar 25 19:00:40 localhost kernel: ivtv: No Free Mailbox for cmd
0x0000009d after 100 tries!
Mar 25 19:00:40 localhost kernel: ivtv: Mailbox[0] 0x000000c5 flags 0x00000=
003
Mar 25 19:00:40 localhost kernel: ivtv: Mailbox[1] 0x000000bd flags 0x00000=
003
Mar 25 19:00:40 localhost kernel: ivtv: Mailbox[2] 0x0000009b flags 0x00000=
003
Mar 25 19:00:40 localhost kernel: ivtv: Firmware UNRESPONSIVE when
trying cmd 0x0000009d!!!
Mar 25 19:00:44 localhost kernel: ivtv: No Free Mailbox for cmd
0x000000d8 after 100 tries!
Mar 25 19:00:44 localhost kernel: ivtv: Mailbox[0] 0x0000009f flags 0x00000=
003
Mar 25 19:00:44 localhost kernel: ivtv: Mailbox[1] 0x000000a1 flags 0x00000=
003
Mar 25 19:00:44 localhost kernel: ivtv: Mailbox[2] 0x000000d0 flags 0x00000=
003
Mar 25 19:00:44 localhost kernel: ivtv: Firmware UNRESPONSIVE when
trying cmd 0x000000d8!!!
Mar 25 19:00:54 localhost kernel: ivtv: 1000 ms time out waiting for firmwa=
re
Mar 25 19:00:54 localhost kernel: ivtv: Failed api call 0x000000c8
with result 0xfffffff0
Mar 25 19:00:54 localhost kernel: ivtv: init error 21. Code -16
Mar 25 19:01:04 localhost kernel: ivtv: 1000 ms time out waiting for firmwa=
re
Mar 25 19:01:04 localhost kernel: ivtv: Failed api call 0x000000b7
with result 0xfffffff0
Mar 25 19:01:14 localhost kernel: ivtv: 1000 ms time out waiting for firmwa=
re
Mar 25 19:01:14 localhost kernel: ivtv: Failed api call 0x000000b7
with result 0xfffffff0
Mar 25 19:01:25 localhost kernel: ivtv: 1000 ms time out waiting for firmwa=
re
Mar 25 19:01:25 localhost kernel: ivtv: Failed api call 0x000000b7
with result 0xfffffff0
Mar 25 19:01:35 localhost kernel: ivtv: 1000 ms time out waiting for firmwa=
re
Mar 25 19:01:35 localhost kernel: ivtv: Failed api call 0x000000b7
with result 0xfffffff0
Mar 25 19:01:45 localhost kernel: ivtv: 1000 ms time out waiting for firmwa=
re
Mar 25 19:01:45 localhost kernel: ivtv: Failed api call 0x000000b7
with result 0xfffffff0
Mar 25 19:01:55 localhost kernel: ivtv: 1000 ms time out waiting for firmwa=
re
Mar 25 19:01:55 localhost kernel: ivtv: Failed api call 0x000000b7
with result 0xfffffff0
Mar 25 19:02:05 localhost kernel: ivtv: 1000 ms time out waiting for firmwa=
re
Mar 25 19:02:05 localhost kernel: ivtv: Failed api call 0x000000b7
with result 0xfffffff0
Mar 25 19:09:00 localhost kernel: ivtv: ENC: Error starting, retrying (1)..=
.
Mar 25 19:09:10 localhost kernel: ivtv: 1000 ms time out waiting for firmwa=
re
Mar 25 19:09:10 localhost kernel: ivtv: Failed api call 0x00000081
with result 0xfffffff0
Mar 25 19:09:10 localhost kernel: ivtv: ENC: Error starting, retrying (0)..=
.