Hi,
I have encountered a new problem which I have not seen before: I have missed timers without any obvious reason. All these timers were set to the same channel and this partivular channel differs from others in the sense that I have set the xmltv2vdr to update its epg. But I have also had successful timers on that channels so xmltv2vdr shoould not cause this problem.
As I said, I have not found any obvious reason, but will still attach a bit of the log showing how the timer for the 15th episode of "Heroes" was set but never started to record. But in the mean time recordings on other channels started just fine.
I am using vdr 1.5.2 patched with liemikuutio-, MainMenuHooks-, subtitles- and ttxtsub-patches. The version of the epgsearch-plugin is 0.9.21.
Hopefully someone could help me out with this one...
-Petri
May 16 19:57:00 ... timer 23 (4 1957-2210 'Ep�miellytt�v� totuus') start May 16 19:57:00 ... record /video/Ep�miellytt�v�_totuus/2007-05-16.19.57.50.99.rec May 16 19:57:04 ... recording to '/video/Ep�miellytt�v�_totuus/2007-05-16.19.57.50.99.rec/001.vdr' May 16 19:57:04 ... recording thread started (pid=4767, tid=5034) ... May 16 21:27:01 ... timer 22 (2 2127-0030 'Jalkapallon UEFA-cup') start May 16 21:27:01 ... record /video/Jalkapallon_UEFA-cup/2007-05-16.21.27.50.99.rec May 16 21:27:01 ... recording to '/video/Jalkapallon_UEFA-cup/2007-05-16.21.27.50.99.rec/001.vdr' May 16 21:27:01 ... recording thread started (pid=4767, tid=6077) ... May 16 21:28:24 ... timer 1 (12 2257-2355 'Heroes: 15. jakso: Run!~Ke 16.05.2007-23:00') set to no event ... May 16 21:28:28 ... timer 1 (12 2257-2355 'Heroes: 15. jakso: Run!~Ke 16.05.2007-23:00') set to event Ke 16.05.2007 23:00-23:45 'Heroes: 15. jakso: Run!' ... May 16 21:30:24 ... stopping recording due to modification of channel 2 May 16 21:30:24 ... recording thread ended (pid=4767, tid=6077) May 16 21:30:24 ... timer 22 (2 2127-0030 'Jalkapallon UEFA-cup') stop May 16 21:30:25 ... timer 22 (2 2127-0030 'Jalkapallon UEFA-cup') start May 16 21:30:25 ... record /video/Jalkapallon_UEFA-cup/2007-05-16.21.27.50.99.rec May 16 21:30:25 ... ttxtsubs: Selected language not found, just recording first teletext pid found. May 16 21:30:25 ... recording to '/video/Jalkapallon_UEFA-cup/2007-05-16.21.27.50.99.rec/002.vdr' May 16 21:30:25 ... recording thread started (pid=4767, tid=6125) May 16 21:46:34 ... recording to '/video/Ep�miellytt�v�_totuus/2007-05-16.19.57.50.99.rec/002.vdr' ... May 16 22:10:00 ... recording thread ended (pid=4767, tid=5034) May 16 22:10:00 ... timer 23 (4 1957-2210 'Ep�miellytt�v� totuus') stop May 16 22:11:29 ... deleting timer 23 (4 1957-2210 'Ep�miellytt�v� totuus') ... May 16 22:31:43 ... stopping recording due to modification of channel 2 May 16 22:31:43 ... recording thread ended (pid=4767, tid=6125) May 16 22:31:43 ... timer 22 (2 2127-0030 'Jalkapallon UEFA-cup') stop May 16 22:31:43 ... timer 22 (2 2127-0030 'Jalkapallon UEFA-cup') start May 16 22:31:43 ... record /video/Jalkapallon_UEFA-cup/2007-05-16.21.27.50.99.rec May 16 22:31:44 ... recording to '/video/Jalkapallon_UEFA-cup/2007-05-16.21.27.50.99.rec/003.vdr' May 16 22:31:44 ... recording thread started (pid=4767, tid=6745) May 16 22:40:24 ... stopping recording due to modification of channel 2 May 16 22:40:24 ... recording thread ended (pid=4767, tid=6745) May 16 22:40:24 ... timer 22 (2 2127-0030 'Jalkapallon UEFA-cup') stop May 16 22:40:24 ... timer 22 (2 2127-0030 'Jalkapallon UEFA-cup') start May 16 22:40:24 ... record /video/Jalkapallon_UEFA-cup/2007-05-16.21.27.50.99.rec May 16 22:40:24 ... recording to '/video/Jalkapallon_UEFA-cup/2007-05-16.21.27.50.99.rec/004.vdr' May 16 22:40:24 ... recording thread started (pid=4767, tid=6842) ... May 16 23:39:28 ... recording to '/video/Jalkapallon_UEFA-cup/2007-05-16.21.27.50.99.rec/005.vdr' May 16 23:53:00 ... EPGSearch: search timer update started May 16 23:53:00 ... EPGSearch: search timer update finished May 16 23:56:04 ... deleting timer 1 (12 2257-2355 'Heroes: 15. jakso: Run!~Ke 16.05.2007-23:00')
On 05/17/07 22:55, Petri Helin wrote:
Hi,
I have encountered a new problem which I have not seen before: I have missed timers without any obvious reason. All these timers were set to the same channel and this partivular channel differs from others in the sense that I have set the xmltv2vdr to update its epg. But I have also had successful timers on that channels so xmltv2vdr shoould not cause this problem.
As I said, I have not found any obvious reason, but will still attach a bit of the log showing how the timer for the 15th episode of "Heroes" was set but never started to record. But in the mean time recordings on other channels started just fine.
I am using vdr 1.5.2 patched with liemikuutio-, MainMenuHooks-, subtitles- and ttxtsub-patches. The version of the epgsearch-plugin is 0.9.21.
Hopefully someone could help me out with this one...
-Petri
May 16 19:57:00 ... timer 23 (4 1957-2210 'Ep�miellytt�v� totuus') start May 16 19:57:00 ... record /video/Ep�miellytt�v�_totuus/2007-05-16.19.57.50.99.rec May 16 19:57:04 ... recording to '/video/Ep�miellytt�v�_totuus/2007-05-16.19.57.50.99.rec/001.vdr' May 16 19:57:04 ... recording thread started (pid=4767, tid=5034) ... May 16 21:27:01 ... timer 22 (2 2127-0030 'Jalkapallon UEFA-cup') start May 16 21:27:01 ... record /video/Jalkapallon_UEFA-cup/2007-05-16.21.27.50.99.rec May 16 21:27:01 ... recording to '/video/Jalkapallon_UEFA-cup/2007-05-16.21.27.50.99.rec/001.vdr' May 16 21:27:01 ... recording thread started (pid=4767, tid=6077) ... May 16 21:28:24 ... timer 1 (12 2257-2355 'Heroes: 15. jakso: Run!~Ke 16.05.2007-23:00') set to no event ... May 16 21:28:28 ... timer 1 (12 2257-2355 'Heroes: 15. jakso: Run!~Ke 16.05.2007-23:00') set to event Ke 16.05.2007 23:00-23:45 'Heroes: 15. jakso: Run!' ... May 16 21:30:24 ... stopping recording due to modification of channel 2 May 16 21:30:24 ... recording thread ended (pid=4767, tid=6077) May 16 21:30:24 ... timer 22 (2 2127-0030 'Jalkapallon UEFA-cup') stop May 16 21:30:25 ... timer 22 (2 2127-0030 'Jalkapallon UEFA-cup') start May 16 21:30:25 ... record /video/Jalkapallon_UEFA-cup/2007-05-16.21.27.50.99.rec May 16 21:30:25 ... ttxtsubs: Selected language not found, just recording first teletext pid found. May 16 21:30:25 ... recording to '/video/Jalkapallon_UEFA-cup/2007-05-16.21.27.50.99.rec/002.vdr' May 16 21:30:25 ... recording thread started (pid=4767, tid=6125) May 16 21:46:34 ... recording to '/video/Ep�miellytt�v�_totuus/2007-05-16.19.57.50.99.rec/002.vdr' ... May 16 22:10:00 ... recording thread ended (pid=4767, tid=5034) May 16 22:10:00 ... timer 23 (4 1957-2210 'Ep�miellytt�v� totuus') stop May 16 22:11:29 ... deleting timer 23 (4 1957-2210 'Ep�miellytt�v� totuus') ... May 16 22:31:43 ... stopping recording due to modification of channel 2 May 16 22:31:43 ... recording thread ended (pid=4767, tid=6125) May 16 22:31:43 ... timer 22 (2 2127-0030 'Jalkapallon UEFA-cup') stop May 16 22:31:43 ... timer 22 (2 2127-0030 'Jalkapallon UEFA-cup') start May 16 22:31:43 ... record /video/Jalkapallon_UEFA-cup/2007-05-16.21.27.50.99.rec May 16 22:31:44 ... recording to '/video/Jalkapallon_UEFA-cup/2007-05-16.21.27.50.99.rec/003.vdr' May 16 22:31:44 ... recording thread started (pid=4767, tid=6745) May 16 22:40:24 ... stopping recording due to modification of channel 2 May 16 22:40:24 ... recording thread ended (pid=4767, tid=6745) May 16 22:40:24 ... timer 22 (2 2127-0030 'Jalkapallon UEFA-cup') stop May 16 22:40:24 ... timer 22 (2 2127-0030 'Jalkapallon UEFA-cup') start May 16 22:40:24 ... record /video/Jalkapallon_UEFA-cup/2007-05-16.21.27.50.99.rec May 16 22:40:24 ... recording to '/video/Jalkapallon_UEFA-cup/2007-05-16.21.27.50.99.rec/004.vdr' May 16 22:40:24 ... recording thread started (pid=4767, tid=6842) ... May 16 23:39:28 ... recording to '/video/Jalkapallon_UEFA-cup/2007-05-16.21.27.50.99.rec/005.vdr' May 16 23:53:00 ... EPGSearch: search timer update started May 16 23:53:00 ... EPGSearch: search timer update finished May 16 23:56:04 ... deleting timer 1 (12 2257-2355 'Heroes: 15. jakso: Run!~Ke 16.05.2007-23:00')
How many DVB devices does your system have? Are you sure there was one free when that timer should have been recorded? What was the priority of that timer? I'm afraid you've shortened your log a little too much, so I can't see the information on which device the individual timers did record.
Klaus
Klaus Schmidinger wrote:
How many DVB devices does your system have? Are you sure there was one free when that timer should have been recorded? What was the priority of that timer? I'm afraid you've shortened your log a little too much, so I can't see the information on which device the individual timers did record.
I have two budget cards. One of them was recording, but the other one should have been available. I use always the default priority (50). I have now attached a longer log, hope that will provide more info.
-Petri
May 16 19:52:52 x vdr: [4865] receiver on device 1 thread started (pid=4767, tid=4865) May 16 19:52:52 x vdr: [4868] TS buffer on device 1 thread started (pid=4767, tid=4868) May 16 19:52:52 x vdr: [4767] timer 1 (12 2257-2355 'Heroes: 15. jakso: Run!~Ke 16.05.2007-23:00') set to event Ke 16.05.2007 23:00-23:45 'Heroes: 15. jakso: Run!' May 16 19:52:52 x vdr: [4767] timer 2 (12 2057-2310 'Merijalkaväen mies') set to event Pe 18.05.2007 21:00-23:00 'Merijalkaväen mies' May 16 19:52:52 x vdr: [4767] timer 3 (12 2257-2355 'Heroes: 16. jakso: Unexpected~Ke 23.05.2007-23:00') set to event Ke 23.05.2007 23:00-23:45 'Heroes: 16. jakso: Unexpected' May 16 19:52:52 x vdr: [4767] timer 4 (2 1032-1133 'Meren salaisuudet~To 17.05.2007-10:35') set to event To 17.05.2007 10:35-11:24 'Meren salaisuudet' May 16 19:52:53 x vdr: [4774] changing pids of channel 1 from 512+512:650=fin:2321 to 512+512:650=fin,652=dut:2321 May 16 19:52:53 x vdr: [4807] ttxtsubs: Service Information read: timeout! May 16 19:52:53 x vdr: [4864] setting audio track to 1 (0) May 16 19:52:53 x vdr: [4767] timer 5 (7 1958-2036 'Monty Pythonin lentävä sirkus~Pe 18.05.2007-20:01') set to event Pe 18.05.2007 20:01-20:26 'Monty Pythonin lentävä sirkus' May 16 19:52:53 x vdr: [4767] timer 6 (1 1843-1944 'Avara luonto: Haikaran matkassa') set to event La 19.05.2007 18:45-19:34 'Avara luonto: Haikaran matkassa' May 16 19:52:53 x vdr: [4807] ttxtsubs: Wanted subtitle language(s) not found on channel, available languages: May 16 19:52:53 x vdr: [4807] ttxtsubs: 100: fin (Initial Page (The teletext start page, not a subtitles page!)) May 16 19:52:53 x vdr: [4770] video directory scanner thread ended (pid=4767, tid=4770) May 16 19:52:53 x vdr: [4769] video directory scanner thread ended (pid=4767, tid=4769) May 16 19:52:53 x vdr: [4767] timer 7 (5 2252-0000 'Twin Peaks~La 19.05.2007-22:55') set to event La 19.05.2007 22:55-23:50 'Twin Peaks' May 16 19:52:53 x vdr: [4767] timer 8 (12 2057-2350 'München') set to event Pe 25.05.2007 21:00-23:40 'München' May 16 19:52:53 x vdr: [4767] timer 9 (12 2337-0250 'King Kong') set to event Pe 25.05.2007 23:40-02:40 'King Kong' May 16 19:52:53 x vdr: [4767] timer 10 (12 2057-2320 'Brokeback Mountain') set to event La 26.05.2007 21:00-23:10 'Brokeback Mountain' May 16 19:52:53 x vdr: [4767] timer 11 (10 0238-0320 'Entourage: 3. kausi, 1. jakso: Aquamom~Ma 21.05.2007-02:40') set to event Ma 21.05.2007 02:40-03:10 'Entourage: 3. kausi, 1. jakso: Aquamom' May 16 19:52:53 x vdr: [4767] timer 12 (10 0238-0320 'Entourage: 3. kausi, 2. jakso: One Day in the Valley~Ti 22.05.2007-02:40') set to event Ti 22.05.2007 02:40-03:10 'Entourage: 3. kausi, 2. jakso: One Day in the Valley' May 16 19:52:53 x vdr: [4774] changing pids of channel 2 from 513+513:660=fin:2321 to 513+513:660=eng:2321 May 16 19:52:53 x vdr: [4807] ttxtsubs: Wanted subtitle language(s) not found on channel, available languages: May 16 19:52:53 x vdr: [4767] timer 13 (10 0253-0335 'Entourage: 3. kausi, 3. jakso: Dominated~Ke 23.05.2007-02:55') set to event Ke 23.05.2007 02:55-03:25 'Entourage: 3. kausi, 3. jakso: Dominated' May 16 19:52:53 x vdr: [4807] ttxtsubs: 100: fin (Initial Page (The teletext start page, not a subtitles page!)) May 16 19:52:53 x vdr: [4767] timer 14 (10 0238-0320 'Entourage: 3. kausi, 4. jakso: Guys and Doll~To 24.05.2007-02:40') set to event To 24.05.2007 02:40-03:10 'Entourage: 3. kausi, 4. jakso: Guys and Doll' May 16 19:52:53 x vdr: [4767] timer 15 (10 0238-0320 'Entourage: 5. jakso: Crash and Burn~Pe 25.05.2007-02:40') set to event Pe 25.05.2007 02:40-03:10 'Entourage: 5. jakso: Crash and Burn' May 16 19:52:53 x vdr: [4807] ttxtsubs: Wanted subtitle language(s) not found on channel, available languages: May 16 19:52:53 x vdr: [4767] timer 16 (10 0233-0315 'Entourage: 6. jakso: Three's Company~La 26.05.2007-02:35') set to event La 26.05.2007 02:35-03:05 'Entourage: 6. jakso: Three's Company' May 16 19:52:53 x vdr: [4807] ttxtsubs: 100: fin (Initial Page (The teletext start page, not a subtitles page!)) May 16 19:52:53 x vdr: [4767] timer 17 (10 0258-0345 'Entourage: 7. jakso: Strange Days~Su 27.05.2007-03:00') set to event Su 27.05.2007 03:00-03:35 'Entourage: 7. jakso: Strange Days' May 16 19:52:53 x vdr: [4767] timer 19 (10 0228-0310 'Entourage: 8. jakso: The Release~Ma 28.05.2007-02:30') set to event Ma 28.05.2007 02:30-03:00 'Entourage: 8. jakso: The Release' May 16 19:52:53 x vdr: [4767] timer 20 (10 0253-0340 'Entourage: 9. jakso: Vegas Baby, Vegas!~Ti 29.05.2007-02:55') set to event Ti 29.05.2007 02:55-03:30 'Entourage: 9. jakso: Vegas Baby, Vegas!' May 16 19:52:53 x vdr: [4767] timer 21 (10 0243-0325 'Entourage: 10. jakso: I Wanna Be Sedated~Ke 30.05.2007-02:45') set to event Ke 30.05.2007 02:45-03:15 'Entourage: 10. jakso: I Wanna Be Sedated' May 16 19:52:53 x vdr: [4767] timer 22 (2 2127-0030 'Jalkapallon UEFA-cup') set to event Ke 16.05.2007 22:40-23:45 'Jalkapallon UEFA-cup' May 16 19:52:53 x vdr: [4767] timer 23 (4 1957-2210 'Epämiellyttävä totuus') set to event Ke 16.05.2007 20:00-22:00 'Epämiellyttävä totuus' May 16 19:52:53 x vdr: [4774] channel 1 (TV1) event Ke 16.05.2007 19:05-19:56 'Historiaa: Kirottu siirtokunta' status 4 May 16 19:52:53 x vdr: [4767] max. latency time 6 seconds May 16 19:52:53 x vdr: [4767] retuning due to modification of channel 1 May 16 19:52:53 x vdr: [4767] switching to channel 1 May 16 19:52:53 x vdr: [4774] channel 2 (TV2) event Ke 16.05.2007 19:20-20:02 'Enkelin kosketus' status 4 May 16 19:52:53 x vdr: [4864] transfer thread ended (pid=4767, tid=4864) May 16 19:52:53 x vdr: [4767] buffer stats: 1116156 (53%) used May 16 19:52:53 x vdr: [4767] buffer stats: 0 (0%) used May 16 19:52:53 x vdr: [4910] transfer thread started (pid=4767, tid=4910) May 16 19:52:53 x vdr: [4767] buffer stats: 0 (0%) used May 16 19:52:53 x vdr: [4774] channel 7 (YLE Teema) event Ke 16.05.2007 19:51-19:54 'Lapset puhuvat' status 4 May 16 19:52:55 x vdr: [4910] setting audio track to 1 (0) May 16 19:53:02 x vdr: [4778] EPGSearch: search timer update started May 16 19:53:02 x vdr: [4778] EPGSearch: search timer update finished May 16 19:55:16 x vdr: [4774] channel 7 (YLE Teema) event Ke 16.05.2007 19:55-19:58 'Pyrähdyksiä: Pyrähdys Espanjaan' status 4 May 16 19:56:00 x vdr: [4767] switching device 3 to channel 4 May 16 19:56:02 x vdr: [4777] channel 5 (subtv) event Ke 16.05.2007 19:30-20:00 'Kolmas kivi auringosta' status 4 May 16 19:56:03 x vdr: [4777] channel 4 (Nelonen D) event Ke 16.05.2007 19:50-20:00 'IS Urheilu-uutiset' status 4 May 16 19:56:32 x vdr: [4767] timer 1 (12 2257-2355 'Heroes: 15. jakso: Run!~Ke 16.05.2007-23:00') set to no event May 16 19:56:32 x vdr: [4767] timer 2 (12 2057-2310 'Merijalkaväen mies') set to no event May 16 19:56:32 x vdr: [4767] timer 3 (12 2257-2355 'Heroes: 16. jakso: Unexpected~Ke 23.05.2007-23:00') set to no event May 16 19:56:32 x vdr: [4767] timer 4 (2 1032-1133 'Meren salaisuudet~To 17.05.2007-10:35') set to no event May 16 19:56:32 x vdr: [4767] timer 5 (7 1958-2036 'Monty Pythonin lentävä sirkus~Pe 18.05.2007-20:01') set to no event May 16 19:56:32 x vdr: [4767] timer 6 (1 1843-1944 'Avara luonto: Haikaran matkassa') set to no event May 16 19:56:32 x vdr: [4767] timer 7 (5 2252-0000 'Twin Peaks~La 19.05.2007-22:55') set to no event May 16 19:56:32 x vdr: [4767] timer 8 (12 2057-2350 'München') set to no event May 16 19:56:32 x vdr: [4767] timer 9 (12 2337-0250 'King Kong') set to no event May 16 19:56:32 x vdr: [4767] timer 10 (12 2057-2320 'Brokeback Mountain') set to no event May 16 19:56:32 x vdr: [4767] timer 11 (10 0238-0320 'Entourage: 3. kausi, 1. jakso: Aquamom~Ma 21.05.2007-02:40') set to no event May 16 19:56:32 x vdr: [4767] timer 12 (10 0238-0320 'Entourage: 3. kausi, 2. jakso: One Day in the Valley~Ti 22.05.2007-02:40') set to no event May 16 19:56:32 x vdr: [4767] timer 13 (10 0253-0335 'Entourage: 3. kausi, 3. jakso: Dominated~Ke 23.05.2007-02:55') set to no event May 16 19:56:32 x vdr: [4767] timer 14 (10 0238-0320 'Entourage: 3. kausi, 4. jakso: Guys and Doll~To 24.05.2007-02:40') set to no event May 16 19:56:32 x vdr: [4767] timer 15 (10 0238-0320 'Entourage: 5. jakso: Crash and Burn~Pe 25.05.2007-02:40') set to no event May 16 19:56:32 x vdr: [4767] timer 16 (10 0233-0315 'Entourage: 6. jakso: Three's Company~La 26.05.2007-02:35') set to no event May 16 19:56:32 x vdr: [4767] timer 17 (10 0258-0345 'Entourage: 7. jakso: Strange Days~Su 27.05.2007-03:00') set to no event May 16 19:56:32 x vdr: [4767] timer 19 (10 0228-0310 'Entourage: 8. jakso: The Release~Ma 28.05.2007-02:30') set to no event May 16 19:56:32 x vdr: [4767] timer 20 (10 0253-0340 'Entourage: 9. jakso: Vegas Baby, Vegas!~Ti 29.05.2007-02:55') set to no event May 16 19:56:32 x vdr: [4767] timer 21 (10 0243-0325 'Entourage: 10. jakso: I Wanna Be Sedated~Ke 30.05.2007-02:45') set to no event May 16 19:56:32 x vdr: [4767] timer 22 (2 2127-0030 'Jalkapallon UEFA-cup') set to no event May 16 19:56:32 x vdr: [4767] timer 23 (4 1957-2210 'Epämiellyttävä totuus') set to no event May 16 19:56:33 x vdr: [4774] channel 7 (YLE Teema) event Ke 16.05.2007 19:55-19:58 '(null)' status 4 May 16 19:56:33 x vdr: [4777] channel 4 (Nelonen D) event Ke 16.05.2007 19:50-20:00 '(null)' status 4 May 16 19:56:34 x vdr: [4774] channel 1 (TV1) event Ke 16.05.2007 19:05-19:56 '(null)' status 4 May 16 19:56:34 x vdr: [4774] channel 2 (TV2) event Ke 16.05.2007 19:20-20:02 'Enkelin kosketus' status 4 May 16 19:56:34 x vdr: [4777] channel 5 (subtv) event Ke 16.05.2007 19:30-20:00 'Kolmas kivi auringosta' status 4 May 16 19:56:38 x vdr: [4767] timer 1 (12 2257-2355 'Heroes: 15. jakso: Run!~Ke 16.05.2007-23:00') set to event Ke 16.05.2007 23:00-23:45 'Heroes: 15. jakso: Run!' May 16 19:56:38 x vdr: [4767] timer 2 (12 2057-2310 'Merijalkaväen mies') set to event Pe 18.05.2007 21:00-23:00 'Merijalkaväen mies' May 16 19:56:38 x vdr: [4767] timer 3 (12 2257-2355 'Heroes: 16. jakso: Unexpected~Ke 23.05.2007-23:00') set to event Ke 23.05.2007 23:00-23:45 'Heroes: 16. jakso: Unexpected' May 16 19:56:38 x vdr: [4767] timer 4 (2 1032-1133 'Meren salaisuudet~To 17.05.2007-10:35') set to event To 17.05.2007 10:35-11:24 'Meren salaisuudet' May 16 19:56:38 x vdr: [4767] timer 5 (7 1958-2036 'Monty Pythonin lentävä sirkus~Pe 18.05.2007-20:01') set to event Pe 18.05.2007 20:01-20:26 'Monty Pythonin lentävä sirkus' May 16 19:56:38 x vdr: [4767] timer 6 (1 1843-1944 'Avara luonto: Haikaran matkassa') set to event La 19.05.2007 18:45-19:34 'Avara luonto: Haikaran matkassa' May 16 19:56:38 x vdr: [4767] timer 7 (5 2252-0000 'Twin Peaks~La 19.05.2007-22:55') set to event La 19.05.2007 22:55-23:50 'Twin Peaks' May 16 19:56:38 x vdr: [4767] timer 8 (12 2057-2350 'München') set to event Pe 25.05.2007 21:00-23:40 'München' May 16 19:56:38 x vdr: [4767] timer 9 (12 2337-0250 'King Kong') set to event Pe 25.05.2007 23:40-02:40 'King Kong' May 16 19:56:38 x vdr: [4767] timer 10 (12 2057-2320 'Brokeback Mountain') set to event La 26.05.2007 21:00-23:10 'Brokeback Mountain' May 16 19:56:38 x vdr: [4767] timer 11 (10 0238-0320 'Entourage: 3. kausi, 1. jakso: Aquamom~Ma 21.05.2007-02:40') set to event Ma 21.05.2007 02:40-03:10 'Entourage: 3. kausi, 1. jakso: Aquamom' May 16 19:56:38 x vdr: [4767] timer 12 (10 0238-0320 'Entourage: 3. kausi, 2. jakso: One Day in the Valley~Ti 22.05.2007-02:40') set to event Ti 22.05.2007 02:40-03:10 'Entourage: 3. kausi, 2. jakso: One Day in the Valley' May 16 19:56:38 x vdr: [4767] timer 13 (10 0253-0335 'Entourage: 3. kausi, 3. jakso: Dominated~Ke 23.05.2007-02:55') set to event Ke 23.05.2007 02:55-03:25 'Entourage: 3. kausi, 3. jakso: Dominated' May 16 19:56:38 x vdr: [4767] timer 14 (10 0238-0320 'Entourage: 3. kausi, 4. jakso: Guys and Doll~To 24.05.2007-02:40') set to event To 24.05.2007 02:40-03:10 'Entourage: 3. kausi, 4. jakso: Guys and Doll' May 16 19:56:38 x vdr: [4767] timer 15 (10 0238-0320 'Entourage: 5. jakso: Crash and Burn~Pe 25.05.2007-02:40') set to event Pe 25.05.2007 02:40-03:10 'Entourage: 5. jakso: Crash and Burn' May 16 19:56:38 x vdr: [4767] timer 16 (10 0233-0315 'Entourage: 6. jakso: Three's Company~La 26.05.2007-02:35') set to event La 26.05.2007 02:35-03:05 'Entourage: 6. jakso: Three's Company' May 16 19:56:38 x vdr: [4767] timer 17 (10 0258-0345 'Entourage: 7. jakso: Strange Days~Su 27.05.2007-03:00') set to event Su 27.05.2007 03:00-03:35 'Entourage: 7. jakso: Strange Days' May 16 19:56:38 x vdr: [4767] timer 19 (10 0228-0310 'Entourage: 8. jakso: The Release~Ma 28.05.2007-02:30') set to event Ma 28.05.2007 02:30-03:00 'Entourage: 8. jakso: The Release' May 16 19:56:38 x vdr: [4767] timer 20 (10 0253-0340 'Entourage: 9. jakso: Vegas Baby, Vegas!~Ti 29.05.2007-02:55') set to event Ti 29.05.2007 02:55-03:30 'Entourage: 9. jakso: Vegas Baby, Vegas!' May 16 19:56:38 x vdr: [4767] timer 21 (10 0243-0325 'Entourage: 10. jakso: I Wanna Be Sedated~Ke 30.05.2007-02:45') set to event Ke 30.05.2007 02:45-03:15 'Entourage: 10. jakso: I Wanna Be Sedated' May 16 19:56:38 x vdr: [4767] timer 23 (4 1957-2210 'Epämiellyttävä totuus') set to event Ke 16.05.2007 20:00-22:00 'Epämiellyttävä totuus' May 16 19:56:43 x vdr: [4767] timer 22 (2 2127-0030 'Jalkapallon UEFA-cup') set to event Ke 16.05.2007 22:40-23:45 'Jalkapallon UEFA-cup' May 16 19:57:00 x vdr: [4767] switching device 3 to channel 4 May 16 19:57:00 x vdr: [4767] timer 23 (4 1957-2210 'Epämiellyttävä totuus') start May 16 19:57:00 x vdr: [4767] Title: 'Epämiellyttävä totuus' Subtitle: '(null)' May 16 19:57:00 x vdr: [4767] record /video/Epämiellyttävä_totuus/2007-05-16.19.57.50.99.rec May 16 19:57:00 x vdr: [4767] creating directory /video/Epämiellyttävä_totuus May 16 19:57:00 x vdr: [4767] creating directory /video/Epämiellyttävä_totuus/2007-05-16.19.57.50.99.rec May 16 19:57:00 x vdr: [4767] ttxtsubs: Wanted subtitle language(s) not found on channel, available languages: May 16 19:57:00 x vdr: [4767] ttxtsubs: 100: fin (Initial Page (The teletext start page, not a subtitles page!)) May 16 19:57:00 x vdr: [4767] ttxtsubs: Selected language not found, just recording first teletext pid found. May 16 19:57:04 x vdr: [4767] recording to '/video/Epämiellyttävä_totuus/2007-05-16.19.57.50.99.rec/001.vdr' May 16 19:57:04 x vdr: [5033] file writer thread started (pid=4767, tid=5033) May 16 19:57:04 x vdr: [5034] recording thread started (pid=4767, tid=5034) May 16 19:57:04 x vdr: [5035] receiver on device 2 thread started (pid=4767, tid=5035) May 16 19:57:04 x vdr: [5036] TS buffer on device 2 thread started (pid=4767, tid=5036) May 16 20:00:01 x vdr: [4777] channel 5 (subtv) event Ke 16.05.2007 20:00-20:30 'Frendit' status 4 May 16 20:00:02 x vdr: [4777] channel 4 (Nelonen D) event Ke 16.05.2007 20:00-22:00 'Epämiellyttävä totuus' status 4 May 16 20:00:04 x vdr: [4774] channel 7 (YLE Teema) event Ke 16.05.2007 20:00-20:38 'T-Klubi' status 4 May 16 20:00:21 x vdr: [4774] channel 1 (TV1) event Ke 16.05.2007 20:00-20:27 'Sukupuu' status 4 May 16 20:00:27 x vdr: [4774] changing pids of channel 1 from 512+512:650=fin,652=dut:2321 to 512+512:650=fin:2321 May 16 20:00:27 x vdr: [4767] retuning due to modification of channel 1 May 16 20:00:27 x vdr: [4767] switching to channel 1 May 16 20:00:27 x vdr: [4910] transfer thread ended (pid=4767, tid=4910) May 16 20:00:27 x vdr: [4767] buffer stats: 144384 (6%) used May 16 20:00:27 x vdr: [4767] buffer stats: 0 (0%) used May 16 20:00:27 x vdr: [5067] transfer thread started (pid=4767, tid=5067) May 16 20:00:27 x vdr: [4767] buffer stats: 12220 (6%) used May 16 20:00:29 x vdr: [5067] setting audio track to 1 (0) May 16 20:05:18 x vdr: [4774] channel 2 (TV2) event Ke 16.05.2007 20:05-20:35 'Äiti ja Seija' status 4 May 16 20:05:21 x vdr: [4774] changing pids of channel 2 from 513+513:660=eng:2321 to 513+513:660=fin:2321 May 16 20:07:27 x vdr: [4767] switching to channel 5 May 16 20:07:27 x vdr: [5067] transfer thread ended (pid=4767, tid=5067) May 16 20:07:27 x vdr: [4767] buffer stats: 105280 (5%) used May 16 20:07:27 x vdr: [4767] buffer stats: 0 (0%) used May 16 20:07:27 x vdr: [5140] transfer thread started (pid=4767, tid=5140) May 16 20:07:27 x vdr: [4767] buffer stats: 376 (0%) used May 16 20:07:27 x vdr: [4767] creating directory /vtx/C-0-2-97 May 16 20:07:27 x vdr: [4868] TS buffer on device 1 thread ended (pid=4767, tid=4868) May 16 20:07:27 x vdr: [4865] buffer stats: 93812 (4%) used May 16 20:07:27 x vdr: [4865] receiver on device 1 thread ended (pid=4767, tid=4865) May 16 20:07:27 x vdr: [5140] setting audio track to 1 (0) May 16 20:23:00 x vdr: [4778] EPGSearch: search timer update started May 16 20:23:00 x vdr: [4778] EPGSearch: search timer update finished May 16 20:30:01 x vdr: [4777] channel 5 (subtv) event Ke 16.05.2007 20:30-21:00 'Simpsonit' status 4 May 16 20:30:05 x vdr: [4774] changing pids of channel 15 from 515+515:680=fin:2321 to 515+515:680=eng:2321 May 16 20:30:11 x vdr: [4774] channel 1 (TV1) event Ke 16.05.2007 20:30-20:54 'Tv-uutiset ja sää' status 4 May 16 20:40:03 x vdr: [4774] channel 7 (YLE Teema) event Ke 16.05.2007 20:40-20:59 'Elävä arkisto: Mustahuulet' status 4 May 16 20:40:19 x vdr: [4774] channel 2 (TV2) event Ke 16.05.2007 20:40-21:27 'Hovimäki' status 4 May 16 20:53:00 x vdr: [4778] EPGSearch: search timer update started May 16 20:53:00 x vdr: [4778] EPGSearch: search timer update finished May 16 20:55:23 x vdr: [4774] channel 1 (TV1) event Ke 16.05.2007 20:55-21:04 'Urheiluruutu ja V5-ravipeli' status 4 May 16 21:00:01 x vdr: [4777] channel 5 (subtv) event Ke 16.05.2007 21:00-23:10 'SubLeffa: Kalifornia (K15)' status 4 May 16 21:00:04 x vdr: [4774] channel 7 (YLE Teema) event Ke 16.05.2007 21:00-21:58 'Berlin Alexanderplatz (K15)' status 4 May 16 21:00:06 x vdr: [4774] changing pids of channel 15 from 515+515:680=eng:2321 to 515+515:680=fin:2321 May 16 21:00:15 x vdr: [4774] changing pids of channel 7 from 516+516:690=fin:2321 to 516+516:690=deu:2321 May 16 21:05:21 x vdr: [4774] channel 1 (TV1) event Ke 16.05.2007 21:05-21:09 'Vikinglotto' status 4 May 16 21:11:07 x vdr: [4774] channel 1 (TV1) event Ke 16.05.2007 21:11-21:40 'A-studio' status 4 May 16 21:23:00 x vdr: [4778] EPGSearch: search timer update started May 16 21:23:00 x vdr: [4778] EPGSearch: search timer update finished May 16 21:24:30 x vdr: [4767] confirm: - Käytä tykki (HDMI)? May 16 21:24:30 x vdr: [4767] warning: - Käytä tykki (HDMI)? May 16 21:24:31 x vdr: [4767] confirmed May 16 21:24:31 x vdr: [4767] executing command '/data/vdr/scripts/restart_X.sh HDMI_Z4' May 16 21:24:35 x vdr: [5034] cAudioRepacker(0xC0): skipped 24 bytes while syncing on next audio frame May 16 21:24:35 x vdr: [5034] PES packet shortened to 1534 bytes (expected: 3374 bytes) May 16 21:24:35 x vdr: [5140] cAudioRepacker(0xC0): skipped 24 bytes while syncing on next audio frame May 16 21:24:35 x vdr: [5140] PES packet shortened to 1718 bytes (expected: 3374 bytes) May 16 21:24:59 x vdr: [4767] switching to channel 2 May 16 21:24:59 x vdr: [5140] transfer thread ended (pid=4767, tid=5140) May 16 21:24:59 x vdr: [4767] cTS2PES got 0 TS errors, 1 TS continuity errors May 16 21:24:59 x vdr: [4767] buffer stats: 134232 (6%) used May 16 21:24:59 x vdr: [4767] buffer stats: 0 (0%) used May 16 21:24:59 x vdr: [4767] creating directory /vtx/C-0-1-33 May 16 21:24:59 x vdr: [4807] buffer stats: 0 (0%) used May 16 21:24:59 x vdr: [6052] receiver on device 1 thread started (pid=4767, tid=6052) May 16 21:24:59 x vdr: [6051] transfer thread started (pid=4767, tid=6051) May 16 21:24:59 x vdr: [6055] TS buffer on device 1 thread started (pid=4767, tid=6055) May 16 21:24:59 x vdr: [4807] ttxtsubs: Wanted subtitle language(s) not found on channel, available languages: May 16 21:24:59 x vdr: [4807] ttxtsubs: 100: fin (Initial Page (The teletext start page, not a subtitles page!)) May 16 21:24:59 x vdr: [4807] ttxtsubs: Wanted subtitle language(s) not found on channel, available languages: May 16 21:24:59 x vdr: [4807] ttxtsubs: 100: fin (Initial Page (The teletext start page, not a subtitles page!)) May 16 21:24:59 x vdr: [6051] setting audio track to 1 (0) May 16 21:25:00 x vdr: [4807] ttxtsubs: Wanted subtitle language(s) not found on channel, available languages: May 16 21:25:00 x vdr: [4807] ttxtsubs: 100: fin (Initial Page (The teletext start page, not a subtitles page!)) May 16 21:27:00 x vdr: [4767] switching device 2 to channel 2 May 16 21:27:01 x vdr: [4767] timer 22 (2 2127-0030 'Jalkapallon UEFA-cup') start May 16 21:27:01 x vdr: [4767] Title: 'Jalkapallon UEFA-cup' Subtitle: '(null)' May 16 21:27:01 x vdr: [4767] record /video/Jalkapallon_UEFA-cup/2007-05-16.21.27.50.99.rec May 16 21:27:01 x vdr: [4767] creating directory /video/Jalkapallon_UEFA-cup May 16 21:27:01 x vdr: [4767] creating directory /video/Jalkapallon_UEFA-cup/2007-05-16.21.27.50.99.rec May 16 21:27:01 x vdr: [4767] ttxtsubs: Wanted subtitle language(s) not found on channel, available languages: May 16 21:27:01 x vdr: [4767] ttxtsubs: 100: fin (Initial Page (The teletext start page, not a subtitles page!)) May 16 21:27:01 x vdr: [4767] ttxtsubs: Selected language not found, just recording first teletext pid found. May 16 21:27:01 x vdr: [4767] recording to '/video/Jalkapallon_UEFA-cup/2007-05-16.21.27.50.99.rec/001.vdr' May 16 21:27:01 x vdr: [6076] file writer thread started (pid=4767, tid=6076) May 16 21:27:01 x vdr: [6077] recording thread started (pid=4767, tid=6077) May 16 21:28:24 x vdr: [4767] timer 1 (12 2257-2355 'Heroes: 15. jakso: Run!~Ke 16.05.2007-23:00') set to no event May 16 21:28:24 x vdr: [4767] timer 2 (12 2057-2310 'Merijalkaväen mies') set to no event May 16 21:28:24 x vdr: [4767] timer 3 (12 2257-2355 'Heroes: 16. jakso: Unexpected~Ke 23.05.2007-23:00') set to no event May 16 21:28:24 x vdr: [4767] timer 4 (2 1032-1133 'Meren salaisuudet~To 17.05.2007-10:35') set to no event May 16 21:28:24 x vdr: [4767] timer 5 (7 1958-2036 'Monty Pythonin lentävä sirkus~Pe 18.05.2007-20:01') set to no event May 16 21:28:24 x vdr: [4767] timer 6 (1 1843-1944 'Avara luonto: Haikaran matkassa') set to no event May 16 21:28:24 x vdr: [4767] timer 7 (5 2252-0000 'Twin Peaks~La 19.05.2007-22:55') set to no event May 16 21:28:24 x vdr: [4767] timer 8 (12 2057-2350 'München') set to no event May 16 21:28:24 x vdr: [4767] timer 9 (12 2337-0250 'King Kong') set to no event May 16 21:28:24 x vdr: [4767] timer 10 (12 2057-2320 'Brokeback Mountain') set to no event May 16 21:28:24 x vdr: [4767] timer 11 (10 0238-0320 'Entourage: 3. kausi, 1. jakso: Aquamom~Ma 21.05.2007-02:40') set to no event May 16 21:28:24 x vdr: [4767] timer 12 (10 0238-0320 'Entourage: 3. kausi, 2. jakso: One Day in the Valley~Ti 22.05.2007-02:40') set to no event May 16 21:28:24 x vdr: [4767] timer 13 (10 0253-0335 'Entourage: 3. kausi, 3. jakso: Dominated~Ke 23.05.2007-02:55') set to no event May 16 21:28:24 x vdr: [4767] timer 14 (10 0238-0320 'Entourage: 3. kausi, 4. jakso: Guys and Doll~To 24.05.2007-02:40') set to no event May 16 21:28:24 x vdr: [4767] timer 15 (10 0238-0320 'Entourage: 5. jakso: Crash and Burn~Pe 25.05.2007-02:40') set to no event May 16 21:28:24 x vdr: [4767] timer 16 (10 0233-0315 'Entourage: 6. jakso: Three's Company~La 26.05.2007-02:35') set to no event May 16 21:28:24 x vdr: [4767] timer 17 (10 0258-0345 'Entourage: 7. jakso: Strange Days~Su 27.05.2007-03:00') set to no event May 16 21:28:24 x vdr: [4767] timer 19 (10 0228-0310 'Entourage: 8. jakso: The Release~Ma 28.05.2007-02:30') set to no event May 16 21:28:24 x vdr: [4767] timer 20 (10 0253-0340 'Entourage: 9. jakso: Vegas Baby, Vegas!~Ti 29.05.2007-02:55') set to no event May 16 21:28:24 x vdr: [4767] timer 21 (10 0243-0325 'Entourage: 10. jakso: I Wanna Be Sedated~Ke 30.05.2007-02:45') set to no event May 16 21:28:24 x vdr: [4767] timer 22 (2 2127-0030 'Jalkapallon UEFA-cup') set to no event May 16 21:28:24 x vdr: [4767] timer 23 (4 1957-2210 'Epämiellyttävä totuus') set to no event May 16 21:28:25 x vdr: [4767] cleaning up schedules data May 16 21:28:25 x vdr: [4774] channel 1 (TV1) event Ke 16.05.2007 21:11-21:40 '(null)' status 4 May 16 21:28:25 x vdr: [4777] channel 5 (subtv) event Ke 16.05.2007 21:00-23:10 'SubLeffa: Kalifornia (K15)' status 4 May 16 21:28:25 x vdr: [4777] channel 4 (Nelonen D) event Ke 16.05.2007 20:00-22:00 'Epämiellyttävä totuus' status 4 May 16 21:28:26 x vdr: [4774] channel 2 (TV2) event Ke 16.05.2007 20:40-21:27 '(null)' status 4 May 16 21:28:26 x vdr: [4774] channel 7 (YLE Teema) event Ke 16.05.2007 21:00-21:58 'Berlin Alexanderplatz (K15)' status 4 May 16 21:28:28 x vdr: [4767] timer 1 (12 2257-2355 'Heroes: 15. jakso: Run!~Ke 16.05.2007-23:00') set to event Ke 16.05.2007 23:00-23:45 'Heroes: 15. jakso: Run!' May 16 21:28:28 x vdr: [4767] timer 2 (12 2057-2310 'Merijalkaväen mies') set to event Pe 18.05.2007 21:00-23:00 'Merijalkaväen mies' May 16 21:28:28 x vdr: [4767] timer 3 (12 2257-2355 'Heroes: 16. jakso: Unexpected~Ke 23.05.2007-23:00') set to event Ke 23.05.2007 23:00-23:45 'Heroes: 16. jakso: Unexpected' May 16 21:28:28 x vdr: [4767] timer 4 (2 1032-1133 'Meren salaisuudet~To 17.05.2007-10:35') set to event To 17.05.2007 10:35-11:24 'Meren salaisuudet' May 16 21:28:28 x vdr: [4767] timer 8 (12 2057-2350 'München') set to event Pe 25.05.2007 21:00-23:40 'München' May 16 21:28:28 x vdr: [4767] timer 9 (12 2337-0250 'King Kong') set to event Pe 25.05.2007 23:40-02:40 'King Kong' May 16 21:28:28 x vdr: [4767] timer 10 (12 2057-2320 'Brokeback Mountain') set to event La 26.05.2007 21:00-23:10 'Brokeback Mountain' May 16 21:28:28 x vdr: [4767] timer 11 (10 0238-0320 'Entourage: 3. kausi, 1. jakso: Aquamom~Ma 21.05.2007-02:40') set to event Ma 21.05.2007 02:40-03:10 'Entourage: 3. kausi, 1. jakso: Aquamom' May 16 21:28:28 x vdr: [4767] timer 12 (10 0238-0320 'Entourage: 3. kausi, 2. jakso: One Day in the Valley~Ti 22.05.2007-02:40') set to event Ti 22.05.2007 02:40-03:10 'Entourage: 3. kausi, 2. jakso: One Day in the Valley' May 16 21:28:28 x vdr: [4767] timer 13 (10 0253-0335 'Entourage: 3. kausi, 3. jakso: Dominated~Ke 23.05.2007-02:55') set to event Ke 23.05.2007 02:55-03:25 'Entourage: 3. kausi, 3. jakso: Dominated' May 16 21:28:28 x vdr: [4767] timer 14 (10 0238-0320 'Entourage: 3. kausi, 4. jakso: Guys and Doll~To 24.05.2007-02:40') set to event To 24.05.2007 02:40-03:10 'Entourage: 3. kausi, 4. jakso: Guys and Doll' May 16 21:28:28 x vdr: [4767] timer 15 (10 0238-0320 'Entourage: 5. jakso: Crash and Burn~Pe 25.05.2007-02:40') set to event Pe 25.05.2007 02:40-03:10 'Entourage: 5. jakso: Crash and Burn' May 16 21:28:28 x vdr: [4767] timer 16 (10 0233-0315 'Entourage: 6. jakso: Three's Company~La 26.05.2007-02:35') set to event La 26.05.2007 02:35-03:05 'Entourage: 6. jakso: Three's Company' May 16 21:28:28 x vdr: [4767] timer 17 (10 0258-0345 'Entourage: 7. jakso: Strange Days~Su 27.05.2007-03:00') set to event Su 27.05.2007 03:00-03:35 'Entourage: 7. jakso: Strange Days' May 16 21:28:28 x vdr: [4767] timer 19 (10 0228-0310 'Entourage: 8. jakso: The Release~Ma 28.05.2007-02:30') set to event Ma 28.05.2007 02:30-03:00 'Entourage: 8. jakso: The Release' May 16 21:28:28 x vdr: [4767] timer 20 (10 0253-0340 'Entourage: 9. jakso: Vegas Baby, Vegas!~Ti 29.05.2007-02:55') set to event Ti 29.05.2007 02:55-03:30 'Entourage: 9. jakso: Vegas Baby, Vegas!' May 16 21:28:28 x vdr: [4767] timer 21 (10 0243-0325 'Entourage: 10. jakso: I Wanna Be Sedated~Ke 30.05.2007-02:45') set to event Ke 30.05.2007 02:45-03:15 'Entourage: 10. jakso: I Wanna Be Sedated' May 16 21:28:28 x vdr: [4767] timer 22 (2 2127-0030 'Jalkapallon UEFA-cup') set to event Ke 16.05.2007 21:30-22:30 'Jalkapallon UEFA-cup' May 16 21:28:28 x vdr: [4767] timer 23 (4 1957-2210 'Epämiellyttävä totuus') set to event Ke 16.05.2007 20:00-22:00 'Epämiellyttävä totuus' May 16 21:28:33 x vdr: [4767] timer 5 (7 1958-2036 'Monty Pythonin lentävä sirkus~Pe 18.05.2007-20:01') set to event Pe 18.05.2007 20:01-20:26 'Monty Pythonin lentävä sirkus' May 16 21:28:33 x vdr: [4767] timer 22 (2 2127-0030 'Jalkapallon UEFA-cup') set to event Ke 16.05.2007 22:40-23:45 'Jalkapallon UEFA-cup' May 16 21:28:38 x vdr: [4767] timer 6 (1 1843-1944 'Avara luonto: Haikaran matkassa') set to event La 19.05.2007 18:45-19:34 'Avara luonto: Haikaran matkassa' May 16 21:28:38 x vdr: [4767] timer 7 (5 2252-0000 'Twin Peaks~La 19.05.2007-22:55') set to event La 19.05.2007 22:55-23:50 'Twin Peaks' May 16 21:30:11 x vdr: [4774] changing pids of channel 17 from 514+514:670=sve:2321 to 514+514:670=eng:2321 May 16 21:30:17 x vdr: [4774] channel 2 (TV2) event Ke 16.05.2007 21:30-22:30 'Jalkapallon UEFA-cup' status 4 May 16 21:30:24 x vdr: [4774] changing pids of channel 2 from 513+513:660=fin:2321 to 513+513:660=fin,661=sve:2321 May 16 21:30:24 x vdr: [4767] stopping recording due to modification of channel 2 May 16 21:30:24 x vdr: [6077] recording thread ended (pid=4767, tid=6077) May 16 21:30:24 x vdr: [6076] file writer thread ended (pid=4767, tid=6076) May 16 21:30:24 x vdr: [4767] buffer stats: 0 (0%) used May 16 21:30:24 x vdr: [4767] buffer stats: 84788 (1%) used May 16 21:30:24 x vdr: [4767] timer 22 (2 2127-0030 'Jalkapallon UEFA-cup') stop May 16 21:30:24 x vdr: [4767] retuning due to modification of channel 2 May 16 21:30:24 x vdr: [4767] switching to channel 2 May 16 21:30:25 x vdr: [6051] transfer thread ended (pid=4767, tid=6051) May 16 21:30:25 x vdr: [4767] buffer stats: 91932 (4%) used May 16 21:30:25 x vdr: [4767] buffer stats: 0 (0%) used May 16 21:30:25 x vdr: [6121] transfer thread started (pid=4767, tid=6121) May 16 21:30:25 x vdr: [4767] buffer stats: 6392 (3%) used May 16 21:30:25 x vdr: [4767] switching device 2 to channel 2 May 16 21:30:25 x vdr: [4767] timer 22 (2 2127-0030 'Jalkapallon UEFA-cup') start May 16 21:30:25 x vdr: [4767] Title: 'Jalkapallon UEFA-cup' Subtitle: '(null)' May 16 21:30:25 x vdr: [4767] record /video/Jalkapallon_UEFA-cup/2007-05-16.21.27.50.99.rec May 16 21:30:25 x vdr: [4767] ttxtsubs: Wanted subtitle language(s) not found on channel, available languages: May 16 21:30:25 x vdr: [4767] ttxtsubs: 100: fin (Initial Page (The teletext start page, not a subtitles page!)) May 16 21:30:25 x vdr: [4767] ttxtsubs: Selected language not found, just recording first teletext pid found. May 16 21:30:25 x vdr: [4767] recording to '/video/Jalkapallon_UEFA-cup/2007-05-16.21.27.50.99.rec/002.vdr' May 16 21:30:25 x vdr: [6124] file writer thread started (pid=4767, tid=6124) May 16 21:30:25 x vdr: [6125] recording thread started (pid=4767, tid=6125) May 16 21:30:26 x vdr: [6121] setting audio track to 1 (0) May 16 21:34:10 x vdr: [4767] saved setup to /data/vdr/configs/current/setup.conf May 16 21:34:42 x vdr: [6166] femon receiver thread started (pid=4767, tid=6166) May 16 21:34:42 x vdr: [6167] femon osd thread started (pid=4767, tid=6167) May 16 21:35:00 x vdr: [6167] femon osd thread ended (pid=4767, tid=6167) May 16 21:35:03 x vdr: [4767] ERROR: femon receiver thread 6166 won't end (waited 3 seconds) - canceling it... May 16 21:41:34 x vdr: [4774] channel 1 (TV1) event Ke 16.05.2007 21:40-21:59 'A-plus' status 4 May 16 21:46:34 x vdr: [5033] recording to '/video/Epämiellyttävä_totuus/2007-05-16.19.57.50.99.rec/002.vdr' May 16 21:49:13 x vdr: [4767] saved setup to /data/vdr/configs/current/setup.conf May 16 21:49:23 x vdr: [4767] saved setup to /data/vdr/configs/current/setup.conf May 16 21:49:48 x last message repeated 2 times May 16 21:49:59 x vdr: [4767] saved setup to /data/vdr/configs/current/setup.conf May 16 21:50:05 x vdr: [4767] saved setup to /data/vdr/configs/current/setup.conf May 16 21:51:43 x vdr: [4767] epgsearchonly: no translation found for 'EpgSearch-Search in main menu' in language 8 (suomi) May 16 21:51:50 x vdr: [4767] saved setup to /data/vdr/configs/current/setup.conf May 16 21:52:15 x vdr: [4767] saved setup to /data/vdr/configs/current/setup.conf May 16 21:53:00 x vdr: [4778] EPGSearch: search timer update started May 16 21:53:00 x vdr: [4778] EPGSearch: search timer update finished May 16 22:00:02 x vdr: [4777] channel 4 (Nelonen D) event Ke 16.05.2007 22:00-23:10 'Irtiottoja' status 4 May 16 22:00:07 x vdr: [4774] channel 7 (YLE Teema) event Ke 16.05.2007 22:00-22:04 'Kulttuuriuutiset' status 4 May 16 22:00:08 x vdr: [4774] changing pids of channel 7 from 516+516:690=deu:2321 to 516+516:690=fin:2321 May 16 22:02:20 x vdr: [4774] channel 1 (TV1) event Ke 16.05.2007 22:00-22:44 'Ulkolinja: Taistelu taivaasta' status 4 May 16 22:02:25 x vdr: [4774] changing pids of channel 1 from 512+512:650=fin:2321 to 512+512:650=eng:2321 May 16 22:05:21 x vdr: [4774] channel 7 (YLE Teema) event Ke 16.05.2007 22:05-23:46 'Kino Kauko: Kello 5 iltapäivällä' status 4 May 16 22:10:00 x vdr: [5034] recording thread ended (pid=4767, tid=5034) May 16 22:10:00 x vdr: [5033] file writer thread ended (pid=4767, tid=5033) May 16 22:10:00 x vdr: [4767] buffer stats: 0 (0%) used May 16 22:10:00 x vdr: [4767] cTS2PES got 0 TS errors, 1 TS continuity errors May 16 22:10:00 x vdr: [4767] buffer stats: 136488 (2%) used May 16 22:10:00 x vdr: [4767] timer 23 (4 1957-2210 'Epämiellyttävä totuus') stop May 16 22:10:00 x vdr: [5036] TS buffer on device 2 thread ended (pid=4767, tid=5036) May 16 22:10:00 x vdr: [5035] buffer stats: 215636 (10%) used May 16 22:10:00 x vdr: [5035] receiver on device 2 thread ended (pid=4767, tid=5035) May 16 22:11:29 x vdr: [4767] deleting timer 23 (4 1957-2210 'Epämiellyttävä totuus') May 16 22:17:05 x vdr: [4774] changing pids of channel 17 from 514+514:670=eng:2321 to 514+514:670=sve:2321 May 16 22:23:00 x vdr: [4778] EPGSearch: search timer update started May 16 22:23:00 x vdr: [4778] EPGSearch: search timer update finished May 16 22:31:40 x vdr: [4774] channel 2 (TV2) event Ke 16.05.2007 22:30-22:40 'Tv-uutiset' status 4 May 16 22:31:43 x vdr: [4774] changing pids of channel 2 from 513+513:660=fin,661=sve:2321 to 513+513:660=fin:2321 May 16 22:31:43 x vdr: [4767] stopping recording due to modification of channel 2 May 16 22:31:43 x vdr: [6125] recording thread ended (pid=4767, tid=6125) May 16 22:31:43 x vdr: [6124] file writer thread ended (pid=4767, tid=6124) May 16 22:31:43 x vdr: [4767] buffer stats: 0 (0%) used May 16 22:31:43 x vdr: [4767] buffer stats: 140812 (2%) used May 16 22:31:43 x vdr: [4767] timer 22 (2 2127-0030 'Jalkapallon UEFA-cup') stop May 16 22:31:43 x vdr: [4767] retuning due to modification of channel 2 May 16 22:31:43 x vdr: [4767] switching to channel 2 May 16 22:31:43 x vdr: [6121] transfer thread ended (pid=4767, tid=6121) May 16 22:31:43 x vdr: [4767] buffer stats: 156040 (7%) used May 16 22:31:43 x vdr: [4767] buffer stats: 0 (0%) used May 16 22:31:43 x vdr: [6741] transfer thread started (pid=4767, tid=6741) May 16 22:31:43 x vdr: [4767] buffer stats: 0 (0%) used May 16 22:31:43 x vdr: [4767] switching device 3 to channel 2 May 16 22:31:43 x vdr: [4767] timer 22 (2 2127-0030 'Jalkapallon UEFA-cup') start May 16 22:31:43 x vdr: [4767] Title: 'Jalkapallon UEFA-cup' Subtitle: '(null)' May 16 22:31:43 x vdr: [4767] record /video/Jalkapallon_UEFA-cup/2007-05-16.21.27.50.99.rec May 16 22:31:44 x vdr: [4767] ttxtsubs: Wanted subtitle language(s) not found on channel, available languages: May 16 22:31:44 x vdr: [4767] ttxtsubs: 100: fin (Initial Page (The teletext start page, not a subtitles page!)) May 16 22:31:44 x vdr: [4767] ttxtsubs: Selected language not found, just recording first teletext pid found. May 16 22:31:44 x vdr: [4767] recording to '/video/Jalkapallon_UEFA-cup/2007-05-16.21.27.50.99.rec/003.vdr' May 16 22:31:44 x vdr: [6744] file writer thread started (pid=4767, tid=6744) May 16 22:31:44 x vdr: [6745] recording thread started (pid=4767, tid=6745) May 16 22:31:44 x vdr: [6746] receiver on device 2 thread started (pid=4767, tid=6746) May 16 22:31:44 x vdr: [6747] TS buffer on device 2 thread started (pid=4767, tid=6747) May 16 22:31:46 x vdr: [6741] setting audio track to 1 (0) May 16 22:40:20 x vdr: [4774] channel 2 (TV2) event Ke 16.05.2007 22:40-23:45 'Jalkapallon UEFA-cup' status 4 May 16 22:40:23 x vdr: [4777] changing pids of channel 2 from 513+513:660=fin:2321 to 513+513:660=fin,661=sve:2321 May 16 22:40:24 x vdr: [4767] stopping recording due to modification of channel 2 May 16 22:40:24 x vdr: [6745] recording thread ended (pid=4767, tid=6745) May 16 22:40:24 x vdr: [6744] file writer thread ended (pid=4767, tid=6744) May 16 22:40:24 x vdr: [4767] buffer stats: 0 (0%) used May 16 22:40:24 x vdr: [4767] buffer stats: 91180 (1%) used May 16 22:40:24 x vdr: [4767] timer 22 (2 2127-0030 'Jalkapallon UEFA-cup') stop May 16 22:40:24 x vdr: [4767] retuning due to modification of channel 2 May 16 22:40:24 x vdr: [4767] switching to channel 2 May 16 22:40:24 x vdr: [6741] transfer thread ended (pid=4767, tid=6741) May 16 22:40:24 x vdr: [4767] buffer stats: 113928 (5%) used May 16 22:40:24 x vdr: [4767] buffer stats: 0 (0%) used May 16 22:40:24 x vdr: [6838] transfer thread started (pid=4767, tid=6838) May 16 22:40:24 x vdr: [4767] buffer stats: 0 (0%) used May 16 22:40:24 x vdr: [4767] switching device 3 to channel 2 May 16 22:40:24 x vdr: [4767] timer 22 (2 2127-0030 'Jalkapallon UEFA-cup') start May 16 22:40:24 x vdr: [4767] Title: 'Jalkapallon UEFA-cup' Subtitle: '(null)' May 16 22:40:24 x vdr: [4767] record /video/Jalkapallon_UEFA-cup/2007-05-16.21.27.50.99.rec May 16 22:40:24 x vdr: [6747] TS buffer on device 2 thread ended (pid=4767, tid=6747) May 16 22:40:24 x vdr: [6746] buffer stats: 94752 (4%) used May 16 22:40:24 x vdr: [6746] receiver on device 2 thread ended (pid=4767, tid=6746) May 16 22:40:24 x vdr: [4767] ttxtsubs: Wanted subtitle language(s) not found on channel, available languages: May 16 22:40:24 x vdr: [4767] ttxtsubs: 100: fin (Initial Page (The teletext start page, not a subtitles page!)) May 16 22:40:24 x vdr: [4767] ttxtsubs: Selected language not found, just recording first teletext pid found. May 16 22:40:24 x vdr: [4767] recording to '/video/Jalkapallon_UEFA-cup/2007-05-16.21.27.50.99.rec/004.vdr' May 16 22:40:24 x vdr: [6841] file writer thread started (pid=4767, tid=6841) May 16 22:40:24 x vdr: [6842] recording thread started (pid=4767, tid=6842) May 16 22:40:24 x vdr: [6843] receiver on device 2 thread started (pid=4767, tid=6843) May 16 22:40:24 x vdr: [6844] TS buffer on device 2 thread started (pid=4767, tid=6844) May 16 22:40:26 x vdr: [6838] setting audio track to 1 (0) May 16 22:46:43 x vdr: [4777] channel 1 (TV1) event Ke 16.05.2007 22:45-22:49 'Kulttuuriuutiset' status 4 May 16 22:46:46 x vdr: [4777] changing pids of channel 1 from 512+512:650=eng:2321 to 512+512:650=fin:2321 May 16 22:47:05 x vdr: [4774] changing pids of channel 17 from 514+514:670=sve:2321 to 514+514:670=fin:2321 May 16 22:51:57 x vdr: [4777] channel 1 (TV1) event Ke 16.05.2007 22:50-23:39 'K-trappan' status 4 May 16 22:53:00 x vdr: [4778] EPGSearch: search timer update started May 16 22:53:00 x vdr: [4778] EPGSearch: search timer update finished May 16 23:01:19 x vdr: [4777] changing pids of channel 17 from 514+514:670=fin:2321 to 514+514:670=sve:2321 May 16 23:13:55 x vdr: [4767] EPGSearch: timer 23 (3 2327-0200 'Rockyn uusintaottelu (K15)') added (active) May 16 23:14:16 x vdr: [4767] timer 23 (3 2327-0200 'Rockyn uusintaottelu (K15)') set to event Pe 18.05.2007 23:30-01:50 'Rockyn uusintaottelu (K15)' May 16 23:23:00 x vdr: [4778] EPGSearch: search timer update started May 16 23:23:00 x vdr: [4778] EPGSearch: search timer update finished May 16 23:39:28 x vdr: [6841] recording to '/video/Jalkapallon_UEFA-cup/2007-05-16.21.27.50.99.rec/005.vdr' May 16 23:41:52 x vdr: [4774] channel 1 (TV1) event Ke 16.05.2007 23:40-23:49 'Euronews' status 4 May 16 23:41:55 x vdr: [4774] changing pids of channel 1 from 512+512:650=fin:2321 to 512+512:650=eng,651=deu:2321 May 16 23:50:20 x vdr: [4774] channel 7 (YLE Teema) event Ke 16.05.2007 23:50-00:33 'Sohvaperunat maratonille' status 4 May 16 23:50:22 x vdr: [4777] changing pids of channel 7 from 516+516:690=fin:2321 to 516+516:690=fin,691=deu:2321 May 16 23:53:00 x vdr: [4778] EPGSearch: search timer update started May 16 23:53:00 x vdr: [4778] EPGSearch: search timer update finished May 16 23:55:06 x vdr: [4774] channel 1 (TV1) event Ke 16.05.2007 23:51-04:00 'Ei esitystä' status 4 May 16 23:55:10 x vdr: [4777] changing pids of channel 1 from 512+512:650=eng,651=deu:2321 to 512+512:650=fin:2321 May 16 23:56:04 x vdr: [4767] deleting timer 1 (12 2257-2355 'Heroes: 15. jakso: Run!~Ke 16.05.2007-23:00') May 17 00:23:00 x vdr: [4778] EPGSearch: search timer update started May 17 00:23:00 x vdr: [4778] EPGSearch: search timer update finished May 17 00:23:53 x vdr: [4767] editing timer 21 (2 2127-0030 'Jalkapallon UEFA-cup') May 17 00:24:13 x vdr: [4767] timer 21 (2 2127-0055 'Jalkapallon UEFA-cup') set to event Ke 16.05.2007 22:40-23:45 'Jalkapallon UEFA-cup' May 17 00:24:13 x vdr: [4767] timer 21 (2 2127-0055 'Jalkapallon UEFA-cup') modified (active) May 17 00:34:47 x vdr: [4774] channel 7 (YLE Teema) event To 17.05.2007 00:34-04:00 'Ei esitystä' status 4 May 17 00:34:49 x vdr: [4777] changing pids of channel 7 from 516+516:690=fin,691=deu:2321 to 516+516:690=fin:2321 May 17 00:39:20 x vdr: [6841] recording to '/video/Jalkapallon_UEFA-cup/2007-05-16.21.27.50.99.rec/006.vdr' May 17 00:39:43 x vdr: [6838] transfer thread ended (pid=4767, tid=6838) May 17 00:39:43 x vdr: [4767] buffer stats: 166004 (7%) used May 17 00:39:43 x vdr: [4767] replay /video/Jalkapallon_UEFA-cup/2007-05-16.21.27.50.99.rec May 17 00:39:43 x vdr: [4767] playing '/video/Jalkapallon_UEFA-cup/2007-05-16.21.27.50.99.rec/001.vdr' May 17 00:39:43 x vdr: [4767] buffer stats: 0 (0%) used May 17 00:39:43 x vdr: [4767] ttxtsubs: teletext subtitles replayer started with initial page 452 May 17 00:39:43 x vdr: [8044] dvbplayer thread started (pid=4767, tid=8044) May 17 00:39:43 x vdr: [8045] non blocking file reader thread started (pid=4767, tid=8045) May 17 00:39:43 x vdr: [8044] setting audio track to 1 (0) May 17 00:39:56 x vdr: [4767] playing '/video/Jalkapallon_UEFA-cup/2007-05-16.21.27.50.99.rec/005.vdr' May 17 00:39:58 x vdr: [8044] SetBrokenLink: no GOP header found in video packet May 17 00:42:47 x vdr: [4777] channel 2 (TV2) event Ke 16.05.2007 23:45-00:11 'Yle Live: Audioslave' status 4 May 17 00:42:51 x vdr: [4774] changing pids of channel 2 from 513+513:660=fin,661=sve:2321 to 513+513:660=eng:2321 May 17 00:42:51 x vdr: [4767] stopping recording due to modification of channel 2 May 17 00:42:51 x vdr: [6842] recording thread ended (pid=4767, tid=6842) May 17 00:42:52 x vdr: [6841] file writer thread ended (pid=4767, tid=6841) May 17 00:42:52 x vdr: [4767] buffer stats: 0 (0%) used May 17 00:42:52 x vdr: [4767] buffer stats: 150212 (2%) used May 17 00:42:52 x vdr: [4767] timer 21 (2 2127-0055 'Jalkapallon UEFA-cup') stop May 17 00:42:52 x vdr: [4767] switching device 2 to channel 2 May 17 00:42:52 x vdr: [4767] timer 21 (2 2127-0055 'Jalkapallon UEFA-cup') start May 17 00:42:52 x vdr: [4767] Title: 'Jalkapallon UEFA-cup' Subtitle: '(null)' May 17 00:42:52 x vdr: [4767] record /video/Jalkapallon_UEFA-cup/2007-05-16.21.27.50.99.rec May 17 00:42:52 x vdr: [6844] TS buffer on device 2 thread ended (pid=4767, tid=6844) May 17 00:42:52 x vdr: [6843] buffer stats: 114304 (5%) used May 17 00:42:52 x vdr: [6843] receiver on device 2 thread ended (pid=4767, tid=6843) May 17 00:42:52 x vdr: [4767] ttxtsubs: Wanted subtitle language(s) not found on channel, available languages: May 17 00:42:52 x vdr: [4767] ttxtsubs: 100: fin (Initial Page (The teletext start page, not a subtitles page!)) May 17 00:42:52 x vdr: [4767] ttxtsubs: Selected language not found, just recording first teletext pid found. May 17 00:42:52 x vdr: [4767] recording to '/video/Jalkapallon_UEFA-cup/2007-05-16.21.27.50.99.rec/007.vdr' May 17 00:42:52 x vdr: [8076] file writer thread started (pid=4767, tid=8076) May 17 00:42:52 x vdr: [8077] recording thread started (pid=4767, tid=8077) May 17 00:51:36 x vdr: [4767] buffer stats: 0 (0%) used May 17 00:51:36 x vdr: [8045] non blocking file reader thread ended (pid=4767, tid=8045) May 17 00:51:36 x vdr: [8044] dvbplayer thread ended (pid=4767, tid=8044) May 17 00:51:36 x vdr: [4767] switching to channel 2 May 17 00:51:36 x vdr: [4767] buffer stats: 0 (0%) used May 17 00:51:36 x vdr: [8168] transfer thread started (pid=4767, tid=8168) May 17 00:51:37 x vdr: [8168] setting audio track to 1 (0) May 17 00:52:00 x vdr: [4767] editing timer 21 (2 2127-0055 'Jalkapallon UEFA-cup') May 17 00:53:57 x vdr: [4767] timer 21 (2 2127-0127 'Jalkapallon UEFA-cup') set to event Ke 16.05.2007 22:40-23:45 'Jalkapallon UEFA-cup' May 17 00:53:57 x vdr: [4767] timer 21 (2 2127-0127 'Jalkapallon UEFA-cup') modified (active) May 17 00:54:03 x vdr: [4778] EPGSearch: search timer update started May 17 00:54:03 x vdr: [4778] EPGSearch: search timer update finished
Klaus Schmidinger wrote:
How many DVB devices does your system have? Are you sure there was one free when that timer should have been recorded? What was the priority of that timer?
I tried to recreate the situation by disabling the decrypting for the subscription channels. The channel the recording was supposed the take place on is encrypted and I though that maybe the decrypting didn't work for some reason and therefore the channel was unavailable. I just tested this and got the following log entries:
May 18 02:02:56 x vdr: [32337] EPGSearch: timer thread started (pid=32258, tid=32337) May 18 02:02:57 x vdr: [32258] connect from 127.0.0.1, port 39440 - accepted May 18 02:02:57 x vdr: [32258] timer 25 (11 0205-0215 'Magnum .44') added May 18 02:02:57 x vdr: [32258] closing SVDRP connection May 18 02:02:57 x vdr: [32337] EPGSearch: timer thread ended (pid=32258, tid=32337) May 18 02:03:02 x vdr: [32258] timer 25 (11 0205-0215 'Magnum .44') set to event Pe 18.05.2007 01:20-03:20 'Magnum .44' May 18 02:04:03 x vdr: [32258] switching device 3 to channel 11
So vdr tried to change to the channel, but couldn't, and therefore the recording could be started. Shouldn't this create some entries in the log? Like "unable to start recording" or something?
After that I tried to manually wswitch to the channel and got these log entries (these entries follow immediately the ones above):
May 18 02:06:52 x vdr: [32258] switching to channel 11 May 18 02:06:52 x vdr: [32334] transfer thread ended (pid=32258, tid=32334) May 18 02:06:52 x vdr: [32258] buffer stats: 87608 (4%) used May 18 02:06:52 x vdr: [32258] info: Kanava ei ole käytettävissä! May 18 02:06:57 x vdr: [32258] info: Kanavan vaihtaminen ei mahdollista! May 18 02:07:02 x vdr: [32258] switching to channel 1 May 18 02:07:02 x vdr: [32258] buffer stats: 0 (0%) used May 18 02:07:02 x vdr: [32397] transfer thread started (pid=32258, tid=32397) May 18 02:07:02 x vdr: [32258] buffer stats: 0 (0%) used May 18 02:07:02 x vdr: [32258] max. latency time 10 seconds May 18 02:07:02 x vdr: [32258] switching to channel 11 May 18 02:07:02 x vdr: [32397] transfer thread ended (pid=32258, tid=32397) May 18 02:07:02 x vdr: [32258] buffer stats: 0 (0%) used May 18 02:07:02 x vdr: [32258] info: Kanava ei ole käytettävissä! May 18 02:07:02 x vdr: [32258] connect from 127.0.0.1, port 60450 - accepted May 18 02:07:02 x vdr: [32258] closing SVDRP connection May 18 02:07:06 x vdr: [32258] info: VPS-tallennus on alkamassa! May 18 02:07:13 x vdr: [32258] switching to channel 1 May 18 02:07:13 x vdr: [32258] buffer stats: 0 (0%) used May 18 02:07:13 x vdr: [32400] transfer thread started (pid=32258, tid=32400) May 18 02:07:13 x vdr: [32258] buffer stats: 0 (0%) used May 18 02:07:15 x vdr: [32400] setting audio track to 1 (0)
So now there is additional entries telling that the channel is not available ("Kanava ei ole käytettävissä!"). But what is that strange entry about VPS recording staring ("VPS-tallennus on alkamassa!")? I didn't create a VPS timer...
-Petri
On 05/18/07 01:24, Petri Helin wrote:
Klaus Schmidinger wrote:
How many DVB devices does your system have? Are you sure there was one free when that timer should have been recorded? What was the priority of that timer?
I tried to recreate the situation by disabling the decrypting for the subscription channels. The channel the recording was supposed the take place on is encrypted and I though that maybe the decrypting didn't work for some reason and therefore the channel was unavailable. I just tested this and got the following log entries:
May 18 02:02:56 x vdr: [32337] EPGSearch: timer thread started (pid=32258, tid=32337) May 18 02:02:57 x vdr: [32258] connect from 127.0.0.1, port 39440 - accepted May 18 02:02:57 x vdr: [32258] timer 25 (11 0205-0215 'Magnum .44') added May 18 02:02:57 x vdr: [32258] closing SVDRP connection May 18 02:02:57 x vdr: [32337] EPGSearch: timer thread ended (pid=32258, tid=32337) May 18 02:03:02 x vdr: [32258] timer 25 (11 0205-0215 'Magnum .44') set to event Pe 18.05.2007 01:20-03:20 'Magnum .44' May 18 02:04:03 x vdr: [32258] switching device 3 to channel 11
So vdr tried to change to the channel, but couldn't, and therefore the recording could be started. Shouldn't this create some entries in the log? Like "unable to start recording" or something?
After that I tried to manually wswitch to the channel and got these log entries (these entries follow immediately the ones above):
May 18 02:06:52 x vdr: [32258] switching to channel 11 May 18 02:06:52 x vdr: [32334] transfer thread ended (pid=32258, tid=32334) May 18 02:06:52 x vdr: [32258] buffer stats: 87608 (4%) used May 18 02:06:52 x vdr: [32258] info: Kanava ei ole käytettävissä! May 18 02:06:57 x vdr: [32258] info: Kanavan vaihtaminen ei mahdollista! May 18 02:07:02 x vdr: [32258] switching to channel 1 May 18 02:07:02 x vdr: [32258] buffer stats: 0 (0%) used May 18 02:07:02 x vdr: [32397] transfer thread started (pid=32258, tid=32397) May 18 02:07:02 x vdr: [32258] buffer stats: 0 (0%) used May 18 02:07:02 x vdr: [32258] max. latency time 10 seconds May 18 02:07:02 x vdr: [32258] switching to channel 11 May 18 02:07:02 x vdr: [32397] transfer thread ended (pid=32258, tid=32397) May 18 02:07:02 x vdr: [32258] buffer stats: 0 (0%) used May 18 02:07:02 x vdr: [32258] info: Kanava ei ole käytettävissä! May 18 02:07:02 x vdr: [32258] connect from 127.0.0.1, port 60450 - accepted May 18 02:07:02 x vdr: [32258] closing SVDRP connection May 18 02:07:06 x vdr: [32258] info: VPS-tallennus on alkamassa! May 18 02:07:13 x vdr: [32258] switching to channel 1 May 18 02:07:13 x vdr: [32258] buffer stats: 0 (0%) used May 18 02:07:13 x vdr: [32400] transfer thread started (pid=32258, tid=32400) May 18 02:07:13 x vdr: [32258] buffer stats: 0 (0%) used May 18 02:07:15 x vdr: [32400] setting audio track to 1 (0)
So now there is additional entries telling that the channel is not available ("Kanava ei ole käytettävissä!"). But what is that strange entry about VPS recording staring ("VPS-tallennus on alkamassa!")? I didn't create a VPS timer...
The "Upcoming VPS recording!" message is probably actually wrong, since your timer doesn't use VPS. Originally switching to the transponder early was only done for VPS recordings, but beginning with version 1.4.0-3 this is also done for non-VPS timers, so that the EPG data is up-to-date when the timer actually starts. I'll change the message accordingly, so in your case it should just say "Upcoming recording".
As for the actual problem: I assume you're using a heavily patched version of VDR. Can you try to recreate the situation with an unpatched VDR? And please switch the OSD language to English while doing so, so that I can understand the log messages ;-)
Klaus
Hello
Just in case it might help: I had this problem some months ago. It turned out that cron died from time to time. the system restarted syslogd and cron - but too late for the recording.
Reason for this: A weak powersupply.
Regards Wolfgang
On 05/18/07 01:24, Petri Helin wrote:
Klaus Schmidinger wrote:
How many DVB devices does your system have? Are you sure there was one free when that timer should have been recorded? What was the priority of that timer?
I tried to recreate the situation by disabling the decrypting for the subscription channels. The channel the recording was supposed the take place on is encrypted and I though that maybe the decrypting didn't work for some reason and therefore the channel was unavailable. I just tested this and got the following log entries:
May 18 02:02:56 x vdr: [32337] EPGSearch: timer thread started (pid=32258, tid=32337) May 18 02:02:57 x vdr: [32258] connect from 127.0.0.1, port 39440 - accepted May 18 02:02:57 x vdr: [32258] timer 25 (11 0205-0215 'Magnum .44') added May 18 02:02:57 x vdr: [32258] closing SVDRP connection May 18 02:02:57 x vdr: [32337] EPGSearch: timer thread ended (pid=32258, tid=32337) May 18 02:03:02 x vdr: [32258] timer 25 (11 0205-0215 'Magnum .44') set to event Pe 18.05.2007 01:20-03:20 'Magnum .44' May 18 02:04:03 x vdr: [32258] switching device 3 to channel 11
So vdr tried to change to the channel, but couldn't, and therefore the recording could be started. Shouldn't this create some entries in the log? Like "unable to start recording" or something?
After that I tried to manually wswitch to the channel and got these log entries (these entries follow immediately the ones above):
May 18 02:06:52 x vdr: [32258] switching to channel 11 May 18 02:06:52 x vdr: [32334] transfer thread ended (pid=32258, tid=32334) May 18 02:06:52 x vdr: [32258] buffer stats: 87608 (4%) used May 18 02:06:52 x vdr: [32258] info: Kanava ei ole käytettävissä! May 18 02:06:57 x vdr: [32258] info: Kanavan vaihtaminen ei mahdollista! May 18 02:07:02 x vdr: [32258] switching to channel 1 May 18 02:07:02 x vdr: [32258] buffer stats: 0 (0%) used May 18 02:07:02 x vdr: [32397] transfer thread started (pid=32258, tid=32397) May 18 02:07:02 x vdr: [32258] buffer stats: 0 (0%) used May 18 02:07:02 x vdr: [32258] max. latency time 10 seconds May 18 02:07:02 x vdr: [32258] switching to channel 11 May 18 02:07:02 x vdr: [32397] transfer thread ended (pid=32258, tid=32397) May 18 02:07:02 x vdr: [32258] buffer stats: 0 (0%) used May 18 02:07:02 x vdr: [32258] info: Kanava ei ole käytettävissä! May 18 02:07:02 x vdr: [32258] connect from 127.0.0.1, port 60450 - accepted May 18 02:07:02 x vdr: [32258] closing SVDRP connection May 18 02:07:06 x vdr: [32258] info: VPS-tallennus on alkamassa! May 18 02:07:13 x vdr: [32258] switching to channel 1 May 18 02:07:13 x vdr: [32258] buffer stats: 0 (0%) used May 18 02:07:13 x vdr: [32400] transfer thread started (pid=32258, tid=32400) May 18 02:07:13 x vdr: [32258] buffer stats: 0 (0%) used May 18 02:07:15 x vdr: [32400] setting audio track to 1 (0)
So now there is additional entries telling that the channel is not available ("Kanava ei ole käytettävissä!"). But what is that strange entry about VPS recording staring ("VPS-tallennus on alkamassa!")? I didn't create a VPS timer...
The "Upcoming VPS recording!" message is probably actually wrong, since your timer doesn't use VPS. Originally switching to the transponder early was only done for VPS recordings, but beginning with version 1.4.0-3 this is also done for non-VPS timers, so that the EPG data is up-to-date when the timer actually starts. I'll change the message accordingly, so in your case it should just say "Upcoming recording".
As for the actual problem: I assume you're using a heavily patched version of VDR. Can you try to recreate the situation with an unpatched VDR? And please switch the OSD language to English while doing so, so that I can understand the log messages ;-)
Klaus
vdr mailing list vdr@linuxtv.org http://www.linuxtv.org/cgi-bin/mailman/listinfo/vdr
Klaus Schmidinger wrote:
On 05/18/07 01:24, Petri Helin wrote:
So now there is additional entries telling that the channel is not available ("Kanava ei ole käytettävissä!"). But what is that strange entry about VPS recording staring ("VPS-tallennus on alkamassa!")? I didn't create a VPS timer...
The "Upcoming VPS recording!" message is probably actually wrong, since your timer doesn't use VPS. Originally switching to the transponder early was only done for VPS recordings, but beginning with version 1.4.0-3 this is also done for non-VPS timers, so that the EPG data is up-to-date when the timer actually starts. I'll change the message accordingly, so in your case it should just say "Upcoming recording".
As for the actual problem: I assume you're using a heavily patched version of VDR. Can you try to recreate the situation with an unpatched VDR? And please switch the OSD language to English while doing so, so that I can understand the log messages ;-)
Sorry about the OSD language, should have known better...
Anyways, I am fairly confident that the problem is not with VDR per se, but with the decryption failing (there seems to be something wrong with my smartcard or my subscription). But an improvement I'd like to see in VDR would be some sort of loud and clear alert about "Unable to start recording xxx" or something like that to the OSD so that the user could try to fix the problem manually. And maybe an option to do something in case a recording cannot be started because VDR cannot tune to the channel.
-Petri
-
Klaus Schmidinger -
Petri Helin -
Wolfgang Goeller