nr_read 142150 nr_write 94329 sum 236479 prev_sum 236060 hdd was accessed since previous check! [IDLE] 0 600 False It's now Sat Jul 3 08:02:27 2010 next real activation is Sun Jul 4 02:00:01 2010 [timer.py] next activation: 1278137047 (in 99992 ms) [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 3626018 bytes for cache used It's now Sat Jul 3 08:02:59 2010 next real activation is Sat Jul 3 11:54:40 2010 [timer.py] next activation: 1278137079 (in 99991 ms) It's now Sat Jul 3 08:03:03 2010 [timer.py] next activation: 1278137083 (in 99994 ms) nr_read 142450 nr_write 94430 sum 236880 prev_sum 236479 hdd was accessed since previous check! [IDLE] 0 600 False [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 3626000 bytes for cache used It's now Sat Jul 3 08:04:07 2010 next real activation is Sun Jul 4 02:00:01 2010 [timer.py] next activation: 1278137147 (in 99990 ms) nr_read 142758 nr_write 94536 sum 237294 prev_sum 236880 hdd was accessed since previous check! [IDLE] 0 600 False [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 3626000 bytes for cache used It's now Sat Jul 3 08:04:39 2010 next real activation is Sat Jul 3 11:54:40 2010 [timer.py] next activation: 1278137179 (in 99991 ms) It's now Sat Jul 3 08:04:43 2010 [timer.py] next activation: 1278137183 (in 99995 ms) nr_read 143061 nr_write 94627 sum 237688 prev_sum 237294 hdd was accessed since previous check! [IDLE] 0 600 False [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 3624708 bytes for cache used It's now Sat Jul 3 08:05:47 2010 next real activation is Sun Jul 4 02:00:01 2010 [timer.py] next activation: 1278137247 (in 99990 ms) nr_read 143372 nr_write 94737 sum 238109 prev_sum 237688 hdd was accessed since previous check! [IDLE] 0 600 False It's now Sat Jul 3 08:06:19 2010 next real activation is Sat Jul 3 11:54:40 2010 [timer.py] next activation: 1278137279 (in 99989 ms) It's now Sat Jul 3 08:06:23 2010 [timer.py] next activation: 1278137283 (in 99994 ms) [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 3624690 bytes for cache used nr_read 143681 nr_write 94872 sum 238553 prev_sum 238109 hdd was accessed since previous check! [IDLE] 0 600 False It's now Sat Jul 3 08:07:27 2010 next real activation is Sun Jul 4 02:00:01 2010 [timer.py] next activation: 1278137347 (in 99989 ms) [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 3624134 bytes for cache used It's now Sat Jul 3 08:07:59 2010 next real activation is Sat Jul 3 11:54:40 2010 [timer.py] next activation: 1278137379 (in 99989 ms) It's now Sat Jul 3 08:08:03 2010 [timer.py] next activation: 1278137383 (in 99992 ms) nr_read 143986 nr_write 95004 sum 238990 prev_sum 238553 hdd was accessed since previous check! [IDLE] 0 600 False [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 3624134 bytes for cache used It's now Sat Jul 3 08:09:07 2010 next real activation is Sun Jul 4 02:00:01 2010 [timer.py] next activation: 1278137447 (in 99989 ms) nr_read 144288 nr_write 95106 sum 239394 prev_sum 238990 hdd was accessed since previous check! [IDLE] 0 600 False [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 3624104 bytes for cache used It's now Sat Jul 3 08:09:39 2010 next real activation is Sat Jul 3 11:54:40 2010 [timer.py] next activation: 1278137479 (in 99990 ms) It's now Sat Jul 3 08:09:43 2010 [timer.py] next activation: 1278137483 (in 99994 ms) nr_read 144593 nr_write 95256 sum 239849 prev_sum 239394 hdd was accessed since previous check! [IDLE] 0 600 False [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 3618703 bytes for cache used It's now Sat Jul 3 08:10:47 2010 next real activation is Sun Jul 4 02:00:01 2010 [timer.py] next activation: 1278137547 (in 99991 ms) nr_read 144887 nr_write 95365 sum 240252 prev_sum 239849 hdd was accessed since previous check! [IDLE] 0 600 False It's now Sat Jul 3 08:11:19 2010 next real activation is Sat Jul 3 11:54:40 2010 [timer.py] next activation: 1278137579 (in 99991 ms) It's now Sat Jul 3 08:11:23 2010 [timer.py] next activation: 1278137583 (in 99994 ms) [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 3618230 bytes for cache used nr_read 145183 nr_write 95456 sum 240639 prev_sum 240252 hdd was accessed since previous check! [IDLE] 0 600 False It's now Sat Jul 3 08:12:27 2010 next real activation is Sun Jul 4 02:00:01 2010 [timer.py] next activation: 1278137647 (in 99991 ms) [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 3617978 bytes for cache used It's now Sat Jul 3 08:12:59 2010 next real activation is Sat Jul 3 11:54:40 2010 [timer.py] next activation: 1278137679 (in 99990 ms) It's now Sat Jul 3 08:13:03 2010 [timer.py] next activation: 1278137683 (in 99994 ms) nr_read 145486 nr_write 95588 sum 241074 prev_sum 240639 hdd was accessed since previous check! [IDLE] 0 600 False [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 3617978 bytes for cache used It's now Sat Jul 3 08:14:07 2010 next real activation is Sun Jul 4 02:00:01 2010 [timer.py] next activation: 1278137747 (in 99992 ms) nr_read 145793 nr_write 95699 sum 241492 prev_sum 241074 hdd was accessed since previous check! [IDLE] 0 600 False [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 3617942 bytes for cache used It's now Sat Jul 3 08:14:39 2010 next real activation is Sat Jul 3 11:54:40 2010 [timer.py] next activation: 1278137779 (in 99991 ms) It's now Sat Jul 3 08:14:43 2010 [timer.py] next activation: 1278137783 (in 99994 ms) nr_read 146096 nr_write 95810 sum 241906 prev_sum 241492 hdd was accessed since previous check! [IDLE] 0 600 False [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 3616621 bytes for cache used It's now Sat Jul 3 08:15:47 2010 next real activation is Sun Jul 4 02:00:01 2010 [timer.py] next activation: 1278137847 (in 99991 ms) nr_read 146396 nr_write 95975 sum 242371 prev_sum 241906 hdd was accessed since previous check! [IDLE] 0 600 False It's now Sat Jul 3 08:16:19 2010 next real activation is Sat Jul 3 11:54:40 2010 [timer.py] next activation: 1278137879 (in 99989 ms) It's now Sat Jul 3 08:16:23 2010 [timer.py] next activation: 1278137883 (in 99994 ms) [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 3616233 bytes for cache used nr_read 146697 nr_write 96102 sum 242799 prev_sum 242371 hdd was accessed since previous check! [IDLE] 0 600 False It's now Sat Jul 3 08:17:27 2010 next real activation is Sun Jul 4 02:00:01 2010 [timer.py] next activation: 1278137947 (in 99988 ms) [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 3616233 bytes for cache used It's now Sat Jul 3 08:17:59 2010 next real activation is Sat Jul 3 11:54:40 2010 [timer.py] next activation: 1278137979 (in 99990 ms) It's now Sat Jul 3 08:18:03 2010 [timer.py] next activation: 1278137983 (in 99994 ms) nr_read 146997 nr_write 96239 sum 243236 prev_sum 242799 hdd was accessed since previous check! [IDLE] 0 600 False [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 3616233 bytes for cache used It's now Sat Jul 3 08:19:07 2010 next real activation is Sun Jul 4 02:00:01 2010 [timer.py] next activation: 1278138047 (in 99990 ms) nr_read 147290 nr_write 96338 sum 243628 prev_sum 243236 hdd was accessed since previous check! [IDLE] 0 600 False [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 3616233 bytes for cache used It's now Sat Jul 3 08:19:39 2010 next real activation is Sat Jul 3 11:54:40 2010 [timer.py] next activation: 1278138079 (in 99990 ms) It's now Sat Jul 3 08:19:43 2010 [timer.py] next activation: 1278138083 (in 99992 ms) nr_read 147597 nr_write 96467 sum 244064 prev_sum 243628 hdd was accessed since previous check! [IDLE] 0 600 False [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 3615186 bytes for cache used It's now Sat Jul 3 08:20:47 2010 next real activation is Sun Jul 4 02:00:01 2010 [timer.py] next activation: 1278138147 (in 99991 ms) nr_read 147898 nr_write 96607 sum 244505 prev_sum 244064 hdd was accessed since previous check! [IDLE] 0 600 False It's now Sat Jul 3 08:21:19 2010 next real activation is Sat Jul 3 11:54:40 2010 [timer.py] next activation: 1278138179 (in 99991 ms) It's now Sat Jul 3 08:21:23 2010 [timer.py] next activation: 1278138183 (in 99993 ms) [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 3615186 bytes for cache used nr_read 148202 nr_write 96711 sum 244913 prev_sum 244505 hdd was accessed since previous check! [IDLE] 0 600 False It's now Sat Jul 3 08:22:27 2010 next real activation is Sun Jul 4 02:00:01 2010 [timer.py] next activation: 1278138247 (in 99992 ms) [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 3615186 bytes for cache used It's now Sat Jul 3 08:22:59 2010 next real activation is Sat Jul 3 11:54:40 2010 [timer.py] next activation: 1278138279 (in 99991 ms) It's now Sat Jul 3 08:23:03 2010 [timer.py] next activation: 1278138283 (in 99994 ms) nr_read 148504 nr_write 96812 sum 245316 prev_sum 244913 hdd was accessed since previous check! [IDLE] 0 600 False [eDVBLocalTimerHandler] no transponder tuned... or no TDT/TOT avail .. try to use RTC :) [eDVBLocalTimerHandler] shit RTC not ready :( [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 3615186 bytes for cache used It's now Sat Jul 3 08:24:07 2010 next real activation is Sun Jul 4 02:00:01 2010 [timer.py] next activation: 1278138347 (in 99991 ms) nr_read 148814 nr_write 96957 sum 245771 prev_sum 245316 hdd was accessed since previous check! [IDLE] 0 600 False [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 3615186 bytes for cache used It's now Sat Jul 3 08:24:39 2010 next real activation is Sat Jul 3 11:54:40 2010 [timer.py] next activation: 1278138379 (in 99991 ms) It's now Sat Jul 3 08:24:43 2010 [timer.py] next activation: 1278138383 (in 99994 ms) nr_read 149110 nr_write 97071 sum 246181 prev_sum 245771 hdd was accessed since previous check! [IDLE] 0 600 False [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 3613008 bytes for cache used It's now Sat Jul 3 08:25:47 2010 next real activation is Sun Jul 4 02:00:01 2010 [timer.py] next activation: 1278138447 (in 99992 ms) nr_read 149394 nr_write 97177 sum 246571 prev_sum 246181 hdd was accessed since previous check! [IDLE] 0 600 False It's now Sat Jul 3 08:26:19 2010 next real activation is Sat Jul 3 11:54:40 2010 [timer.py] next activation: 1278138479 (in 99991 ms) It's now Sat Jul 3 08:26:23 2010 [timer.py] next activation: 1278138483 (in 99994 ms) [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 3612990 bytes for cache used nr_read 149695 nr_write 97306 sum 247001 prev_sum 246571 hdd was accessed since previous check! [IDLE] 0 600 False It's now Sat Jul 3 08:27:27 2010 next real activation is Sun Jul 4 02:00:01 2010 [timer.py] next activation: 1278138547 (in 99989 ms) [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 3612990 bytes for cache used It's now Sat Jul 3 08:27:59 2010 next real activation is Sat Jul 3 11:54:40 2010 [timer.py] next activation: 1278138579 (in 99989 ms) It's now Sat Jul 3 08:28:03 2010 [timer.py] next activation: 1278138583 (in 99992 ms) nr_read 149999 nr_write 97404 sum 247403 prev_sum 247001 hdd was accessed since previous check! [IDLE] 0 600 False [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 3612990 bytes for cache used It's now Sat Jul 3 08:29:07 2010 next real activation is Sun Jul 4 02:00:01 2010 [timer.py] next activation: 1278138647 (in 99990 ms) nr_read 150290 nr_write 97510 sum 247800 prev_sum 247403 hdd was accessed since previous check! [IDLE] 0 600 False [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 3612968 bytes for cache used It's now Sat Jul 3 08:29:39 2010 next real activation is Sat Jul 3 11:54:40 2010 [timer.py] next activation: 1278138679 (in 99990 ms) It's now Sat Jul 3 08:29:43 2010 [timer.py] next activation: 1278138683 (in 99993 ms) nr_read 150592 nr_write 97620 sum 248212 prev_sum 247800 hdd was accessed since previous check! [IDLE] 0 600 False [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 3607508 bytes for cache used It's now Sat Jul 3 08:30:47 2010 next real activation is Sun Jul 4 02:00:01 2010 [timer.py] next activation: 1278138747 (in 99990 ms) nr_read 150903 nr_write 97756 sum 248659 prev_sum 248212 hdd was accessed since previous check! [IDLE] 0 600 False It's now Sat Jul 3 08:31:19 2010 next real activation is Sat Jul 3 11:54:40 2010 [timer.py] next activation: 1278138779 (in 99991 ms) It's now Sat Jul 3 08:31:23 2010 [timer.py] next activation: 1278138783 (in 99993 ms) [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 3606957 bytes for cache used nr_read 151206 nr_write 97866 sum 249072 prev_sum 248659 hdd was accessed since previous check! [IDLE] 0 600 False It's now Sat Jul 3 08:32:27 2010 next real activation is Sun Jul 4 02:00:01 2010 [timer.py] next activation: 1278138847 (in 99991 ms) [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 3606957 bytes for cache used It's now Sat Jul 3 08:32:59 2010 next real activation is Sat Jul 3 11:54:40 2010 [timer.py] next activation: 1278138879 (in 99991 ms) It's now Sat Jul 3 08:33:03 2010 [timer.py] next activation: 1278138883 (in 99994 ms) nr_read 151510 nr_write 97969 sum 249479 prev_sum 249072 hdd was accessed since previous check! [IDLE] 0 600 False [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 3606939 bytes for cache used It's now Sat Jul 3 08:34:07 2010 next real activation is Sun Jul 4 02:00:01 2010 [timer.py] next activation: 1278138947 (in 99990 ms) nr_read 151809 nr_write 98153 sum 249962 prev_sum 249479 hdd was accessed since previous check! [IDLE] 0 600 False [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 3606939 bytes for cache used It's now Sat Jul 3 08:34:39 2010 next real activation is Sat Jul 3 11:54:40 2010 [timer.py] next activation: 1278138979 (in 99990 ms) It's now Sat Jul 3 08:34:43 2010 [timer.py] next activation: 1278138983 (in 99993 ms) nr_read 152123 nr_write 98242 sum 250365 prev_sum 249962 hdd was accessed since previous check! [IDLE] 0 600 False [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 3604785 bytes for cache used It's now Sat Jul 3 08:35:47 2010 next real activation is Sun Jul 4 02:00:01 2010 [timer.py] next activation: 1278139047 (in 99992 ms) nr_read 152437 nr_write 98362 sum 250799 prev_sum 250365 hdd was accessed since previous check! [IDLE] 0 600 False It's now Sat Jul 3 08:36:19 2010 next real activation is Sat Jul 3 11:54:40 2010 [timer.py] next activation: 1278139079 (in 99991 ms) It's now Sat Jul 3 08:36:23 2010 [timer.py] next activation: 1278139083 (in 99994 ms) [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 3604785 bytes for cache used nr_read 152753 nr_write 98511 sum 251264 prev_sum 250799 hdd was accessed since previous check! [IDLE] 0 600 False It's now Sat Jul 3 08:37:27 2010 next real activation is Sun Jul 4 02:00:01 2010 [timer.py] next activation: 1278139147 (in 99990 ms) [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 3604785 bytes for cache used It's now Sat Jul 3 08:37:59 2010 next real activation is Sat Jul 3 11:54:40 2010 [timer.py] next activation: 1278139179 (in 99990 ms) It's now Sat Jul 3 08:38:03 2010 [timer.py] next activation: 1278139183 (in 99994 ms) nr_read 153069 nr_write 98657 sum 251726 prev_sum 251264 hdd was accessed since previous check! [IDLE] 0 600 False [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 3604785 bytes for cache used It's now Sat Jul 3 08:39:07 2010 next real activation is Sun Jul 4 02:00:01 2010 [timer.py] next activation: 1278139247 (in 99989 ms) nr_read 153401 nr_write 98860 sum 252261 prev_sum 251726 hdd was accessed since previous check! [IDLE] 0 600 False [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 3604785 bytes for cache used It's now Sat Jul 3 08:39:39 2010 next real activation is Sat Jul 3 11:54:40 2010 [timer.py] next activation: 1278139279 (in 99989 ms) It's now Sat Jul 3 08:39:43 2010 [timer.py] next activation: 1278139283 (in 99994 ms) nr_read 153726 nr_write 99086 sum 252812 prev_sum 252261 hdd was accessed since previous check! [IDLE] 0 600 False [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 3601769 bytes for cache used It's now Sat Jul 3 08:40:47 2010 next real activation is Sun Jul 4 02:00:01 2010 [timer.py] next activation: 1278139347 (in 99991 ms) nr_read 154037 nr_write 99294 sum 253331 prev_sum 252812 hdd was accessed since previous check! [IDLE] 0 600 False It's now Sat Jul 3 08:41:19 2010 next real activation is Sat Jul 3 11:54:40 2010 [timer.py] next activation: 1278139379 (in 99991 ms) It's now Sat Jul 3 08:41:23 2010 [timer.py] next activation: 1278139383 (in 99993 ms) [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 3601769 bytes for cache used nr_read 154349 nr_write 99487 sum 253836 prev_sum 253331 hdd was accessed since previous check! [IDLE] 0 600 False It's now Sat Jul 3 08:42:27 2010 next real activation is Sun Jul 4 02:00:01 2010 [timer.py] next activation: 1278139447 (in 99990 ms) [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 3601769 bytes for cache used It's now Sat Jul 3 08:42:59 2010 next real activation is Sat Jul 3 11:54:40 2010 [timer.py] next activation: 1278139479 (in 99991 ms) It's now Sat Jul 3 08:43:03 2010 [timer.py] next activation: 1278139483 (in 99995 ms) nr_read 154666 nr_write 99729 sum 254395 prev_sum 253836 hdd was accessed since previous check! [IDLE] 0 600 False [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 3601769 bytes for cache used It's now Sat Jul 3 08:44:07 2010 next real activation is Sun Jul 4 02:00:01 2010 [timer.py] next activation: 1278139547 (in 99991 ms) nr_read 154970 nr_write 99938 sum 254908 prev_sum 254395 hdd was accessed since previous check! [IDLE] 0 600 False [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 3601769 bytes for cache used It's now Sat Jul 3 08:44:39 2010 next real activation is Sat Jul 3 11:54:40 2010 [timer.py] next activation: 1278139579 (in 99990 ms) It's now Sat Jul 3 08:44:43 2010 [timer.py] next activation: 1278139583 (in 99994 ms) nr_read 155281 nr_write 100083 sum 255364 prev_sum 254908 hdd was accessed since previous check! [IDLE] 0 600 False [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 3600636 bytes for cache used It's now Sat Jul 3 08:45:47 2010 next real activation is Sun Jul 4 02:00:01 2010 [timer.py] next activation: 1278139647 (in 99991 ms) nr_read 155572 nr_write 100257 sum 255829 prev_sum 255364 hdd was accessed since previous check! [IDLE] 0 600 False It's now Sat Jul 3 08:46:19 2010 next real activation is Sat Jul 3 11:54:40 2010 [timer.py] next activation: 1278139679 (in 99989 ms) It's now Sat Jul 3 08:46:23 2010 [timer.py] next activation: 1278139683 (in 99994 ms) [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 3600618 bytes for cache used nr_read 155875 nr_write 100403 sum 256278 prev_sum 255829 hdd was accessed since previous check! [IDLE] 0 600 False It's now Sat Jul 3 08:47:27 2010 next real activation is Sun Jul 4 02:00:01 2010 [timer.py] next activation: 1278139747 (in 99990 ms) [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 3600618 bytes for cache used It's now Sat Jul 3 08:47:59 2010 next real activation is Sat Jul 3 11:54:40 2010 [timer.py] next activation: 1278139779 (in 99990 ms) It's now Sat Jul 3 08:48:03 2010 [timer.py] next activation: 1278139783 (in 99992 ms) nr_read 156182 nr_write 100519 sum 256701 prev_sum 256278 hdd was accessed since previous check! [IDLE] 0 600 False [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 3600375 bytes for cache used It's now Sat Jul 3 08:49:07 2010 next real activation is Sun Jul 4 02:00:01 2010 [timer.py] next activation: 1278139847 (in 99991 ms) nr_read 156481 nr_write 100651 sum 257132 prev_sum 256701 hdd was accessed since previous check! [IDLE] 0 600 False [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 3600345 bytes for cache used It's now Sat Jul 3 08:49:39 2010 next real activation is Sat Jul 3 11:54:40 2010 [timer.py] next activation: 1278139879 (in 99990 ms) It's now Sat Jul 3 08:49:43 2010 [timer.py] next activation: 1278139883 (in 99994 ms) nr_read 156785 nr_write 100890 sum 257675 prev_sum 257132 hdd was accessed since previous check! [IDLE] 0 600 False [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 3595828 bytes for cache used It's now Sat Jul 3 08:50:47 2010 next real activation is Sun Jul 4 02:00:01 2010 [timer.py] next activation: 1278139947 (in 99990 ms) nr_read 157088 nr_write 101047 sum 258135 prev_sum 257675 hdd was accessed since previous check! [IDLE] 0 600 False It's now Sat Jul 3 08:51:19 2010 next real activation is Sat Jul 3 11:54:40 2010 [timer.py] next activation: 1278139979 (in 99790 ms) It's now Sat Jul 3 08:51:23 2010 [timer.py] next activation: 1278139983 (in 99993 ms) [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 3595828 bytes for cache used nr_read 157397 nr_write 101215 sum 258612 prev_sum 258135 hdd was accessed since previous check! [IDLE] 0 600 False It's now Sat Jul 3 08:52:27 2010 next real activation is Sun Jul 4 02:00:01 2010 [timer.py] next activation: 1278140047 (in 99991 ms) [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 3595828 bytes for cache used It's now Sat Jul 3 08:52:59 2010 next real activation is Sat Jul 3 11:54:40 2010 [timer.py] next activation: 1278140079 (in 99991 ms) It's now Sat Jul 3 08:53:03 2010 [timer.py] next activation: 1278140083 (in 99994 ms) nr_read 157707 nr_write 101461 sum 259168 prev_sum 258612 hdd was accessed since previous check! [IDLE] 0 600 False [eDVBLocalTimerHandler] no transponder tuned... or no TDT/TOT avail .. try to use RTC :) [eDVBLocalTimerHandler] shit RTC not ready :( [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 3595810 bytes for cache used It's now Sat Jul 3 08:54:07 2010 next real activation is Sun Jul 4 02:00:01 2010 [timer.py] next activation: 1278140147 (in 99991 ms) nr_read 158008 nr_write 101641 sum 259649 prev_sum 259168 hdd was accessed since previous check! [IDLE] 0 600 False [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 3595810 bytes for cache used It's now Sat Jul 3 08:54:39 2010 next real activation is Sat Jul 3 11:54:40 2010 [timer.py] next activation: 1278140179 (in 99991 ms) It's now Sat Jul 3 08:54:43 2010 [timer.py] next activation: 1278140183 (in 99995 ms) [AutoTimer] No changes in configuration, won't parse lookup for events with 'Landpartie' in title(ignore case) [AutoTimer] Won't modify existing timer because either no modification allowed or repeated timer lookup for events with 'ttenwarder' in title(ignore case) [AutoTimer] Won't modify existing timer because either no modification allowed or repeated timer [AutoTimer] Won't modify existing timer because either no modification allowed or repeated timer lookup for events with '24' as title(case sensitive) lookup for events with 'SOKO Leipzig' in title(case sensitive) [AutoTimer] Won't modify existing timer because either no modification allowed or repeated timer lookup for events with 'Quarks' in title(case sensitive) [AutoTimer] Won't modify existing timer because either no modification allowed or repeated timer lookup for events with 'stadtrevier' in title(case sensitive) main thread is non-idle! display spinner! [AutoTimer] Won't modify existing timer because either no modification allowed or repeated timer lookup for events with '24' as title(case sensitive) lookup for events with 'Pellet' in title(ignore case) lookup for events with 'Die Herren mit der weißen Weste' in title(ignore case) lookup for events with 'Knockin' in title(ignore case) lookup for events with 'ARD-Ratgeber' in title(case sensitive) [AutoTimer] Won't modify existing timer because either no modification allowed or repeated timer [AutoTimer] Won't modify existing timer because either no modification allowed or repeated timer nr_read 158296 nr_write 101767 sum 260063 prev_sum 259649 hdd was accessed since previous check! [IDLE] 0 600 False [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 3591655 bytes for cache used It's now Sat Jul 3 08:55:47 2010 next real activation is Sun Jul 4 02:00:01 2010 [timer.py] next activation: 1278140247 (in 99991 ms) nr_read 158596 nr_write 101958 sum 260554 prev_sum 260063 hdd was accessed since previous check! [IDLE] 0 600 False It's now Sat Jul 3 08:56:19 2010 next real activation is Sat Jul 3 11:54:40 2010 [timer.py] next activation: 1278140279 (in 99991 ms) It's now Sat Jul 3 08:56:23 2010 [timer.py] next activation: 1278140283 (in 99993 ms) [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 3591655 bytes for cache used nr_read 158893 nr_write 102090 sum 260983 prev_sum 260554 hdd was accessed since previous check! [IDLE] 0 600 False It's now Sat Jul 3 08:57:27 2010 next real activation is Sun Jul 4 02:00:01 2010 [timer.py] next activation: 1278140347 (in 99991 ms) [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 3590575 bytes for cache used It's now Sat Jul 3 08:57:59 2010 next real activation is Sat Jul 3 11:54:40 2010 [timer.py] next activation: 1278140379 (in 99988 ms) It's now Sat Jul 3 08:58:03 2010 [timer.py] next activation: 1278140383 (in 99995 ms) nr_read 159203 nr_write 102236 sum 261439 prev_sum 260983 hdd was accessed since previous check! [IDLE] 0 600 False [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 3590412 bytes for cache used It's now Sat Jul 3 08:59:07 2010 next real activation is Sun Jul 4 02:00:01 2010 [timer.py] next activation: 1278140447 (in 99990 ms) nr_read 159511 nr_write 102358 sum 261869 prev_sum 261439 hdd was accessed since previous check! [IDLE] 0 600 False [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 3590364 bytes for cache used It's now Sat Jul 3 08:59:39 2010 next real activation is Sat Jul 3 11:54:40 2010 [timer.py] next activation: 1278140479 (in 99989 ms) It's now Sat Jul 3 08:59:43 2010 [timer.py] next activation: 1278140483 (in 99994 ms) nr_read 159818 nr_write 102526 sum 262344 prev_sum 261869 hdd was accessed since previous check! [IDLE] 0 600 False [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 3573339 bytes for cache used It's now Sat Jul 3 09:00:47 2010 next real activation is Sun Jul 4 02:00:01 2010 [timer.py] next activation: 1278140547 (in 99989 ms) nr_read 160121 nr_write 102654 sum 262775 prev_sum 262344 hdd was accessed since previous check! [IDLE] 0 600 False It's now Sat Jul 3 09:01:19 2010 next real activation is Sat Jul 3 11:54:40 2010 [timer.py] next activation: 1278140579 (in 99990 ms) It's now Sat Jul 3 09:01:23 2010 [timer.py] next activation: 1278140583 (in 99994 ms) [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 3573339 bytes for cache used nr_read 160426 nr_write 102764 sum 263190 prev_sum 262775 hdd was accessed since previous check! [IDLE] 0 600 False It's now Sat Jul 3 09:02:27 2010 next real activation is Sun Jul 4 02:00:01 2010 [timer.py] next activation: 1278140647 (in 99991 ms) [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 3573291 bytes for cache used It's now Sat Jul 3 09:02:59 2010 next real activation is Sat Jul 3 11:54:40 2010 [timer.py] next activation: 1278140679 (in 99988 ms) It's now Sat Jul 3 09:03:03 2010 [timer.py] next activation: 1278140683 (in 99993 ms) nr_read 160738 nr_write 102991 sum 263729 prev_sum 263190 hdd was accessed since previous check! [IDLE] 0 600 False [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 3573273 bytes for cache used It's now Sat Jul 3 09:04:07 2010 next real activation is Sun Jul 4 02:00:01 2010 [timer.py] next activation: 1278140747 (in 99991 ms) nr_read 161053 nr_write 103143 sum 264196 prev_sum 263729 hdd was accessed since previous check! [IDLE] 0 600 False [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 3573273 bytes for cache used It's now Sat Jul 3 09:04:39 2010 next real activation is Sat Jul 3 11:54:40 2010 [timer.py] next activation: 1278140779 (in 99991 ms) It's now Sat Jul 3 09:04:43 2010 [timer.py] next activation: 1278140783 (in 99995 ms) nr_read 161361 nr_write 103256 sum 264617 prev_sum 264196 hdd was accessed since previous check! [IDLE] 0 600 False [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 3570697 bytes for cache used It's now Sat Jul 3 09:05:47 2010 next real activation is Sun Jul 4 02:00:01 2010 [timer.py] next activation: 1278140847 (in 99991 ms) [DemuxTask] produced file: /hdd/movie/tmp/20100703075226/source_title_1.m2v None nr_read 161660 nr_write 103346 sum 265006 prev_sum 264617 hdd was accessed since previous check! [IDLE] 0 600 False It's now Sat Jul 3 09:06:19 2010 next real activation is Sat Jul 3 11:54:40 2010 [timer.py] next activation: 1278140879 (in 99990 ms) It's now Sat Jul 3 09:06:23 2010 [timer.py] next activation: 1278140883 (in 99993 ms) [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 3570679 bytes for cache used nr_read 161826 nr_write 103484 sum 265310 prev_sum 265006 hdd was accessed since previous check! [IDLE] 0 600 False It's now Sat Jul 3 09:07:27 2010 next real activation is Sun Jul 4 02:00:01 2010 [timer.py] next activation: 1278140947 (in 99992 ms) [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 3570389 bytes for cache used It's now Sat Jul 3 09:07:59 2010 next real activation is Sat Jul 3 11:54:40 2010 [timer.py] next activation: 1278140979 (in 99991 ms) It's now Sat Jul 3 09:08:03 2010 [timer.py] next activation: 1278140983 (in 99994 ms) nr_read 161999 nr_write 103589 sum 265588 prev_sum 265310 hdd was accessed since previous check! [IDLE] 0 600 False [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 3570371 bytes for cache used It's now Sat Jul 3 09:09:07 2010 next real activation is Sun Jul 4 02:00:01 2010 [timer.py] next activation: 1278141047 (in 99991 ms) [DemuxTask] produced file: /hdd/movie/tmp/20100703075226/source_title_1.mp2 2603 nr_read 162213 nr_write 103706 sum 265919 prev_sum 265588 hdd was accessed since previous check! [IDLE] 0 600 False [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 3569411 bytes for cache used It's now Sat Jul 3 09:09:39 2010 next real activation is Sat Jul 3 11:54:40 2010 [timer.py] next activation: 1278141079 (in 99991 ms) It's now Sat Jul 3 09:09:43 2010 [timer.py] next activation: 1278141083 (in 99994 ms) nr_read 162380 nr_write 103834 sum 266214 prev_sum 265919 hdd was accessed since previous check! [IDLE] 0 600 False [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 3569063 bytes for cache used It's now Sat Jul 3 09:10:47 2010 next real activation is Sun Jul 4 02:00:01 2010 [timer.py] next activation: 1278141147 (in 99991 ms) nr_read 162553 nr_write 103935 sum 266488 prev_sum 266214 hdd was accessed since previous check! [IDLE] 0 600 False It's now Sat Jul 3 09:11:19 2010 next real activation is Sat Jul 3 11:54:40 2010 [timer.py] next activation: 1278141179 (in 99991 ms) It's now Sat Jul 3 09:11:23 2010 [timer.py] next activation: 1278141183 (in 99994 ms) [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 3569063 bytes for cache used nr_read 162720 nr_write 104097 sum 266817 prev_sum 266488 hdd was accessed since previous check! [IDLE] 0 600 False [DemuxTask] produced file: /hdd/movie/tmp/20100703075226/source_title_1-02.mp2 2602 child has terminated pipes closed execute: 0 mplex -f8 -o /hdd/movie/tmp/20100703075226/dvd_title_1.mpg -v1 /hdd/movie/tmp/20100703075226/source_title_1.m2v /hdd/movie/tmp/20100703075226/source_title_1.mp2 /hdd/movie/tmp/20100703075226/source_title_1-02.mp2 poll: unhandled POLLERR/HUP/NVAL for fd 69(16) [MplexTask] INFO: [mplex] mplex version 1.9.0 (2.2.7 $Date: 2006/02/01 22:23:01 $) [MplexTask] INFO: [mplex] File /hdd/movie/tmp/20100703075226/source_title_1.m2v looks like an MPEG Video stream. [MplexTask] INFO: [mplex] File /hdd/movie/tmp/20100703075226/source_title_1.mp2 looks like an MPEG Audio stream. [MplexTask] INFO: [mplex] File /hdd/movie/tmp/20100703075226/source_title_1-02.mp2 looks like an MPEG Audio stream. [MplexTask] INFO: [mplex] Video stream 0: profile 8 selected - ignoring non-standard options! [MplexTask] INFO: [mplex] Found 2 audio streams and 1 video streams [MplexTask] INFO: [mplex] Selecting dvdauthor DVD output profile [MplexTask] INFO: [mplex] Multiplexing video program stream! [MplexTask] INFO: [mplex] Scanning for header info: Video stream e0 (/hdd/movie/tmp/20100703075226/source_title_1.m2v) [MplexTask] INFO: [mplex] VIDEO STREAM: e0 [MplexTask] INFO: [mplex] Frame width : 720 [MplexTask] INFO: [mplex] Frame height : 576 [MplexTask] INFO: [mplex] Aspect ratio : 16:9 display [MplexTask] INFO: [mplex] Picture rate : 25.000 frames/sec [MplexTask] INFO: [mplex] Bit rate : 9000000 bits/sec [MplexTask] INFO: [mplex] Vbv buffer size : 229376 bytes [MplexTask] INFO: [mplex] CSPF : 0 [MplexTask] INFO: [mplex] Scanning for header info: Audio stream c0 (/hdd/movie/tmp/20100703075226/source_title_1.mp2) [MplexTask] INFO: [mplex] MPEG AUDIO STREAM: c0 [MplexTask] INFO: [mplex] Audio version : 1.0 [MplexTask] INFO: [mplex] Layer : 2 [MplexTask] INFO: [mplex] CRC checksums : no [MplexTask] INFO: [mplex] Bit rate : 24576 bytes/sec (192 kbit/sec) [MplexTask] INFO: [mplex] Frequency : 48000 Hz [MplexTask] INFO: [mplex] Mode : 0 stereo [MplexTask] INFO: [mplex] Mode extension : 0 [MplexTask] INFO: [mplex] Copyright bit : 1 copyright protected [MplexTask] INFO: [mplex] Original/Copy : 1 original [MplexTask] INFO: [mplex] Emphasis : 0 none [MplexTask] INFO: [mplex] Scanning for header info: Audio stream c1 (/hdd/movie/tmp/20100703075226/source_title_1-02.mp2) [MplexTask] INFO: [mplex] MPEG AUDIO STREAM: c1 [MplexTask] INFO: [mplex] Audio version : 1.0 [MplexTask] INFO: [mplex] Layer : 2 [MplexTask] INFO: [mplex] CRC checksums : no [MplexTask] INFO: [mplex] Bit rate : 24576 bytes/sec (192 kbit/sec) [MplexTask] INFO: [mplex] Frequency : 48000 Hz [MplexTask] INFO: [mplex] Mode : 0 stereo [MplexTask] INFO: [mplex] Mode extension : 0 [MplexTask] INFO: [mplex] Copyright bit : 1 copyright protected [MplexTask] INFO: [mplex] Original/Copy : 1 original [MplexTask] INFO: [mplex] Emphasis : 0 none [MplexTask] INFO: [mplex] SYSTEMS/PROGRAM stream: [MplexTask] INFO: [mplex] rough-guess multiplexed stream data rate : 9587000 [MplexTask] INFO: [mplex] target data-rate specified : 10080000 [MplexTask] INFO: [mplex] Setting specified specified data rate: 10080000 [MplexTask] INFO: [mplex] Run-in delay = 7200 Video delay = 7200 Audio delay = 10800 [MplexTask] INFO: [mplex] New sequence commences... [MplexTask] INFO: [mplex] Video e0: buf= 0 frame=000000 sector=00000000 [MplexTask] INFO: [mplex] Audio c0: buf= 0 frame=000000 sector=00000000 [MplexTask] INFO: [mplex] Audio c1: buf= 0 frame=000000 sector=00000000 It's now Sat Jul 3 09:12:27 2010 next real activation is Sun Jul 4 02:00:01 2010 [timer.py] next activation: 1278141247 (in 99992 ms) [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 3569033 bytes for cache used [DVDAuthorTask] STAT: VOBU 16 at 6MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 6 of 2397 [DVDAuthorTask] STAT: VOBU 32 at 13MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 13 of 2397 [DVDAuthorTask] STAT: VOBU 48 at 20MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 20 of 2397 [DVDAuthorTask] STAT: VOBU 64 at 27MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 27 of 2397 It's now Sat Jul 3 09:12:59 2010 next real activation is Sat Jul 3 11:54:40 2010 [timer.py] next activation: 1278141279 (in 99991 ms) [DVDAuthorTask] STAT: VOBU 80 at 33MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 33 of 2397 It's now Sat Jul 3 09:13:03 2010 [timer.py] next activation: 1278141283 (in 99994 ms) [DVDAuthorTask] STAT: VOBU 96 at 40MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 40 of 2397 [DVDAuthorTask] STAT: VOBU 112 at 48MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 48 of 2397 nr_read 163192 nr_write 104244 sum 267436 prev_sum 266817 hdd was accessed since previous check! [IDLE] 0 600 False [DVDAuthorTask] STAT: VOBU 128 at 53MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 53 of 2397 [DVDAuthorTask] STAT: VOBU 144 at 60MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 60 of 2397 [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 3569033 bytes for cache used [DVDAuthorTask] STAT: VOBU 160 at 68MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 68 of 2397 [DVDAuthorTask] STAT: VOBU 176 at 75MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 75 of 2397 [DVDAuthorTask] STAT: VOBU 192 at 83MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 83 of 2397 [DVDAuthorTask] STAT: VOBU 208 at 90MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 90 of 2397 It's now Sat Jul 3 09:14:07 2010 next real activation is Sun Jul 4 02:00:01 2010 [timer.py] next activation: 1278141347 (in 99990 ms) [DVDAuthorTask] STAT: VOBU 224 at 97MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 97 of 2397 [DVDAuthorTask] STAT: VOBU 240 at 104MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 104 of 2397 nr_read 163652 nr_write 104362 sum 268014 prev_sum 267436 hdd was accessed since previous check! [IDLE] 0 600 False [DVDAuthorTask] STAT: VOBU 256 at 112MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 112 of 2397 [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 3568809 bytes for cache used [DVDAuthorTask] STAT: VOBU 272 at 119MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 119 of 2397 It's now Sat Jul 3 09:14:39 2010 next real activation is Sat Jul 3 11:54:40 2010 [timer.py] next activation: 1278141379 (in 99989 ms) [DVDAuthorTask] STAT: VOBU 288 at 126MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 126 of 2397 It's now Sat Jul 3 09:14:43 2010 [timer.py] next activation: 1278141383 (in 99994 ms) [DVDAuthorTask] STAT: VOBU 304 at 133MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 133 of 2397 [DVDAuthorTask] STAT: VOBU 320 at 141MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 141 of 2397 [DVDAuthorTask] STAT: VOBU 336 at 148MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 148 of 2397 [DVDAuthorTask] STAT: VOBU 352 at 155MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 155 of 2397 nr_read 164115 nr_write 104468 sum 268583 prev_sum 268014 hdd was accessed since previous check! [IDLE] 0 600 False [DVDAuthorTask] STAT: VOBU 368 at 163MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 163 of 2397 [DVDAuthorTask] STAT: VOBU 384 at 170MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 170 of 2397 [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 3565632 bytes for cache used [DVDAuthorTask] STAT: VOBU 400 at 177MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 177 of 2397 [DVDAuthorTask] STAT: VOBU 416 at 185MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 185 of 2397 It's now Sat Jul 3 09:15:47 2010 next real activation is Sun Jul 4 02:00:01 2010 [timer.py] next activation: 1278141447 (in 99992 ms) [DVDAuthorTask] STAT: VOBU 432 at 192MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 192 of 2397 [DVDAuthorTask] STAT: VOBU 448 at 200MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 200 of 2397 [DVDAuthorTask] STAT: VOBU 464 at 206MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 206 of 2397 [DVDAuthorTask] STAT: VOBU 480 at 212MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 212 of 2397 nr_read 164561 nr_write 104584 sum 269145 prev_sum 268583 hdd was accessed since previous check! [IDLE] 0 600 False It's now Sat Jul 3 09:16:19 2010 next real activation is Sat Jul 3 11:54:40 2010 [timer.py] next activation: 1278141479 (in 99991 ms) [DVDAuthorTask] STAT: VOBU 496 at 219MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 219 of 2397 It's now Sat Jul 3 09:16:23 2010 [timer.py] next activation: 1278141483 (in 99993 ms) [DVDAuthorTask] STAT: VOBU 512 at 225MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 225 of 2397 [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 3565632 bytes for cache used [DVDAuthorTask] STAT: VOBU 528 at 232MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 232 of 2397 [DVDAuthorTask] STAT: VOBU 544 at 239MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 239 of 2397 [DVDAuthorTask] STAT: VOBU 560 at 247MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 247 of 2397 [DVDAuthorTask] STAT: VOBU 576 at 254MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 254 of 2397 [DVDAuthorTask] STAT: VOBU 592 at 261MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 261 of 2397 [DVDAuthorTask] STAT: VOBU 608 at 268MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 268 of 2397 nr_read 165005 nr_write 104689 sum 269694 prev_sum 269145 hdd was accessed since previous check! [IDLE] 0 600 False [DVDAuthorTask] STAT: VOBU 624 at 274MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 274 of 2397 It's now Sat Jul 3 09:17:27 2010 next real activation is Sun Jul 4 02:00:01 2010 [timer.py] next activation: 1278141547 (in 99990 ms) [DVDAuthorTask] STAT: VOBU 640 at 281MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 281 of 2397 [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 3565632 bytes for cache used [DVDAuthorTask] STAT: VOBU 656 at 288MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 288 of 2397 [DVDAuthorTask] STAT: VOBU 672 at 295MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 295 of 2397 [DVDAuthorTask] STAT: VOBU 688 at 301MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 301 of 2397 [DVDAuthorTask] STAT: VOBU 704 at 307MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 307 of 2397 It's now Sat Jul 3 09:17:59 2010 next real activation is Sat Jul 3 11:54:40 2010 [timer.py] next activation: 1278141579 (in 99991 ms) It's now Sat Jul 3 09:18:03 2010 [timer.py] next activation: 1278141583 (in 99994 ms) [DVDAuthorTask] STAT: VOBU 720 at 313MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 313 of 2397 [DVDAuthorTask] STAT: VOBU 736 at 319MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 319 of 2397 nr_read 165451 nr_write 104804 sum 270255 prev_sum 269694 hdd was accessed since previous check! [IDLE] 0 600 False [DVDAuthorTask] STAT: VOBU 752 at 326MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 326 of 2397 [DVDAuthorTask] STAT: VOBU 768 at 333MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 333 of 2397 [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 3565632 bytes for cache used [DVDAuthorTask] STAT: VOBU 784 at 341MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 341 of 2397 [DVDAuthorTask] STAT: VOBU 800 at 349MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 349 of 2397 [DVDAuthorTask] STAT: VOBU 816 at 357MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 357 of 2397 [DVDAuthorTask] STAT: VOBU 832 at 364MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 364 of 2397 It's now Sat Jul 3 09:19:07 2010 next real activation is Sun Jul 4 02:00:01 2010 [timer.py] next activation: 1278141647 (in 99992 ms) [DVDAuthorTask] STAT: VOBU 848 at 372MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 372 of 2397 [DVDAuthorTask] STAT: VOBU 864 at 379MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 379 of 2397 nr_read 165906 nr_write 104908 sum 270814 prev_sum 270255 hdd was accessed since previous check! [IDLE] 0 600 False [DVDAuthorTask] STAT: VOBU 880 at 387MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 387 of 2397 [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 3565632 bytes for cache used [DVDAuthorTask] STAT: VOBU 896 at 395MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 395 of 2397 It's now Sat Jul 3 09:19:39 2010 next real activation is Sat Jul 3 11:54:40 2010 [timer.py] next activation: 1278141679 (in 99990 ms) [DVDAuthorTask] STAT: VOBU 912 at 402MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 402 of 2397 It's now Sat Jul 3 09:19:43 2010 [timer.py] next activation: 1278141683 (in 99995 ms) [DVDAuthorTask] STAT: VOBU 928 at 409MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 409 of 2397 [DVDAuthorTask] STAT: VOBU 944 at 416MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 416 of 2397 [DVDAuthorTask] STAT: VOBU 960 at 423MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 423 of 2397 [DVDAuthorTask] STAT: VOBU 976 at 431MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 431 of 2397 nr_read 166348 nr_write 105025 sum 271373 prev_sum 270814 hdd was accessed since previous check! [IDLE] 0 600 False [DVDAuthorTask] STAT: VOBU 992 at 438MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 438 of 2397 [DVDAuthorTask] STAT: VOBU 1008 at 445MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 445 of 2397 [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 3562710 bytes for cache used [DVDAuthorTask] STAT: VOBU 1024 at 453MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 453 of 2397 [DVDAuthorTask] STAT: VOBU 1040 at 460MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 460 of 2397 It's now Sat Jul 3 09:20:47 2010 next real activation is Sun Jul 4 02:00:01 2010 [timer.py] next activation: 1278141747 (in 99988 ms) [DVDAuthorTask] STAT: VOBU 1056 at 467MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 467 of 2397 [DVDAuthorTask] STAT: VOBU 1072 at 473MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 473 of 2397 [DVDAuthorTask] STAT: VOBU 1088 at 479MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 479 of 2397 [DVDAuthorTask] STAT: VOBU 1104 at 487MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 487 of 2397 nr_read 166800 nr_write 105124 sum 271924 prev_sum 271373 hdd was accessed since previous check! [IDLE] 0 600 False It's now Sat Jul 3 09:21:19 2010 next real activation is Sat Jul 3 11:54:40 2010 [timer.py] next activation: 1278141779 (in 99990 ms) [DVDAuthorTask] STAT: VOBU 1120 at 493MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 493 of 2397 It's now Sat Jul 3 09:21:23 2010 [timer.py] next activation: 1278141783 (in 99994 ms) [DVDAuthorTask] STAT: VOBU 1136 at 499MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 499 of 2397 [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 3562169 bytes for cache used [DVDAuthorTask] STAT: VOBU 1152 at 506MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 506 of 2397 [DVDAuthorTask] STAT: VOBU 1168 at 513MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 513 of 2397 [DVDAuthorTask] STAT: VOBU 1184 at 519MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 519 of 2397 [DVDAuthorTask] STAT: VOBU 1200 at 525MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 525 of 2397 [DVDAuthorTask] STAT: VOBU 1216 at 531MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 531 of 2397 [DVDAuthorTask] STAT: VOBU 1232 at 538MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 538 of 2397 nr_read 167237 nr_write 105234 sum 272471 prev_sum 271924 hdd was accessed since previous check! [IDLE] 0 600 False [DVDAuthorTask] STAT: VOBU 1248 at 545MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 545 of 2397 [DVDAuthorTask] STAT: VOBU 1264 at 552MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 552 of 2397 It's now Sat Jul 3 09:22:27 2010 next real activation is Sun Jul 4 02:00:01 2010 [timer.py] next activation: 1278141847 (in 99991 ms) [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 3562169 bytes for cache used [DVDAuthorTask] STAT: VOBU 1280 at 559MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 559 of 2397 [DVDAuthorTask] STAT: VOBU 1296 at 564MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 564 of 2397 [DVDAuthorTask] STAT: VOBU 1312 at 570MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 570 of 2397 [DVDAuthorTask] STAT: VOBU 1328 at 577MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 577 of 2397 It's now Sat Jul 3 09:22:59 2010 next real activation is Sat Jul 3 11:54:40 2010 [timer.py] next activation: 1278141879 (in 99991 ms) [DVDAuthorTask] STAT: VOBU 1344 at 584MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 584 of 2397 It's now Sat Jul 3 09:23:03 2010 [timer.py] next activation: 1278141883 (in 99992 ms) [DVDAuthorTask] STAT: VOBU 1360 at 590MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 590 of 2397 [DVDAuthorTask] STAT: VOBU 1376 at 597MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 597 of 2397 nr_read 167675 nr_write 105345 sum 273020 prev_sum 272471 hdd was accessed since previous check! [IDLE] 0 600 False [eDVBLocalTimerHandler] no transponder tuned... or no TDT/TOT avail .. try to use RTC :) [eDVBLocalTimerHandler] shit RTC not ready :( [DVDAuthorTask] STAT: VOBU 1392 at 603MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 603 of 2397 [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 3561232 bytes for cache used [DVDAuthorTask] STAT: VOBU 1408 at 610MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 610 of 2397 [DVDAuthorTask] STAT: VOBU 1424 at 618MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 618 of 2397 [DVDAuthorTask] STAT: VOBU 1440 at 624MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 624 of 2397 [DVDAuthorTask] STAT: VOBU 1456 at 630MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 630 of 2397 [DVDAuthorTask] STAT: VOBU 1472 at 637MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 637 of 2397 [DVDAuthorTask] STAT: VOBU 1488 at 642MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 642 of 2397 It's now Sat Jul 3 09:24:07 2010 next real activation is Sun Jul 4 02:00:01 2010 [timer.py] next activation: 1278141947 (in 99991 ms) [DVDAuthorTask] STAT: VOBU 1504 at 648MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 648 of 2397 nr_read 168120 nr_write 105453 sum 273573 prev_sum 273020 hdd was accessed since previous check! [IDLE] 0 600 False [DVDAuthorTask] STAT: VOBU 1520 at 654MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 654 of 2397 [DVDAuthorTask] STAT: VOBU 1536 at 660MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 660 of 2397 [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 3561232 bytes for cache used [DVDAuthorTask] STAT: VOBU 1552 at 666MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 666 of 2397 It's now Sat Jul 3 09:24:39 2010 next real activation is Sat Jul 3 11:54:40 2010 [timer.py] next activation: 1278141979 (in 99990 ms) [DVDAuthorTask] STAT: VOBU 1568 at 672MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 672 of 2397 It's now Sat Jul 3 09:24:43 2010 [timer.py] next activation: 1278141983 (in 99994 ms) [DVDAuthorTask] STAT: VOBU 1584 at 679MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 679 of 2397 [DVDAuthorTask] STAT: VOBU 1600 at 685MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 685 of 2397 [DVDAuthorTask] STAT: VOBU 1616 at 692MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 692 of 2397 [DVDAuthorTask] STAT: VOBU 1632 at 698MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 698 of 2397 [DVDAuthorTask] STAT: VOBU 1648 at 704MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 704 of 2397 nr_read 168557 nr_write 105567 sum 274124 prev_sum 273573 hdd was accessed since previous check! [IDLE] 0 600 False [DVDAuthorTask] STAT: VOBU 1664 at 710MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 710 of 2397 [DVDAuthorTask] STAT: VOBU 1680 at 715MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 715 of 2397 [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 3558896 bytes for cache used [DVDAuthorTask] STAT: VOBU 1696 at 721MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 721 of 2397 [DVDAuthorTask] STAT: VOBU 1712 at 728MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 728 of 2397 It's now Sat Jul 3 09:25:47 2010 next real activation is Sun Jul 4 02:00:01 2010 [timer.py] next activation: 1278142047 (in 99990 ms) [DVDAuthorTask] STAT: VOBU 1728 at 734MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 734 of 2397 [DVDAuthorTask] STAT: VOBU 1744 at 741MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 741 of 2397 [DVDAuthorTask] STAT: VOBU 1760 at 748MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 748 of 2397 [DVDAuthorTask] STAT: VOBU 1776 at 756MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 756 of 2397 nr_read 168995 nr_write 105671 sum 274666 prev_sum 274124 hdd was accessed since previous check! [IDLE] 0 600 False It's now Sat Jul 3 09:26:19 2010 next real activation is Sat Jul 3 11:54:40 2010 [timer.py] next activation: 1278142079 (in 99990 ms) [DVDAuthorTask] STAT: VOBU 1792 at 763MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 763 of 2397 It's now Sat Jul 3 09:26:23 2010 [timer.py] next activation: 1278142083 (in 99990 ms) [DVDAuthorTask] STAT: VOBU 1808 at 770MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 770 of 2397 [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 3558878 bytes for cache used [DVDAuthorTask] STAT: VOBU 1824 at 777MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 777 of 2397 [DVDAuthorTask] STAT: VOBU 1840 at 785MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 785 of 2397 [DVDAuthorTask] STAT: VOBU 1856 at 792MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 792 of 2397 [DVDAuthorTask] STAT: VOBU 1872 at 799MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 799 of 2397 [DVDAuthorTask] STAT: VOBU 1888 at 805MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 805 of 2397 [DVDAuthorTask] STAT: VOBU 1904 at 812MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 812 of 2397 nr_read 169446 nr_write 105782 sum 275228 prev_sum 274666 hdd was accessed since previous check! [IDLE] 0 600 False [DVDAuthorTask] STAT: VOBU 1920 at 818MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 818 of 2397 It's now Sat Jul 3 09:27:27 2010 next real activation is Sun Jul 4 02:00:01 2010 [timer.py] next activation: 1278142147 (in 99991 ms) [DVDAuthorTask] STAT: VOBU 1936 at 826MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 826 of 2397 [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 3558878 bytes for cache used [DVDAuthorTask] STAT: VOBU 1952 at 833MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 833 of 2397 [DVDAuthorTask] STAT: VOBU 1968 at 841MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 841 of 2397 [DVDAuthorTask] STAT: VOBU 1984 at 848MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 848 of 2397 It's now Sat Jul 3 09:27:59 2010 next real activation is Sat Jul 3 11:54:40 2010 [timer.py] next activation: 1278142179 (in 99990 ms) [DVDAuthorTask] STAT: VOBU 2000 at 855MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 855 of 2397 It's now Sat Jul 3 09:28:03 2010 [timer.py] next activation: 1278142183 (in 99993 ms) [DVDAuthorTask] STAT: VOBU 2016 at 861MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 861 of 2397 [DVDAuthorTask] STAT: VOBU 2032 at 868MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 868 of 2397 nr_read 169890 nr_write 105892 sum 275782 prev_sum 275228 hdd was accessed since previous check! [IDLE] 0 600 False [DVDAuthorTask] STAT: VOBU 2048 at 876MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 876 of 2397 [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 3558878 bytes for cache used [DVDAuthorTask] STAT: VOBU 2064 at 883MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 883 of 2397 [DVDAuthorTask] STAT: VOBU 2080 at 889MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 889 of 2397 [DVDAuthorTask] STAT: VOBU 2096 at 896MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 896 of 2397 [DVDAuthorTask] STAT: VOBU 2112 at 903MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 903 of 2397 [DVDAuthorTask] STAT: VOBU 2128 at 910MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 910 of 2397 It's now Sat Jul 3 09:29:07 2010 next real activation is Sun Jul 4 02:00:01 2010 [timer.py] next activation: 1278142247 (in 99991 ms) [DVDAuthorTask] STAT: VOBU 2144 at 918MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 918 of 2397 nr_read 170341 nr_write 105998 sum 276339 prev_sum 275782 hdd was accessed since previous check! [IDLE] 0 600 False [DVDAuthorTask] STAT: VOBU 2160 at 924MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 924 of 2397 [DVDAuthorTask] STAT: VOBU 2176 at 930MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 930 of 2397 [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 3558878 bytes for cache used [DVDAuthorTask] STAT: VOBU 2192 at 936MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 936 of 2397 [DVDAuthorTask] STAT: VOBU 2208 at 942MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 942 of 2397 It's now Sat Jul 3 09:29:39 2010 next real activation is Sat Jul 3 11:54:40 2010 [timer.py] next activation: 1278142279 (in 99989 ms) It's now Sat Jul 3 09:29:43 2010 [timer.py] next activation: 1278142283 (in 99994 ms) [DVDAuthorTask] STAT: VOBU 2224 at 948MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 948 of 2397 [DVDAuthorTask] STAT: VOBU 2240 at 955MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 955 of 2397 [DVDAuthorTask] STAT: VOBU 2256 at 962MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 962 of 2397 [DVDAuthorTask] STAT: VOBU 2272 at 969MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 969 of 2397 [DVDAuthorTask] STAT: VOBU 2288 at 976MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 976 of 2397 nr_read 170784 nr_write 106106 sum 276890 prev_sum 276339 hdd was accessed since previous check! [IDLE] 0 600 False [DVDAuthorTask] STAT: VOBU 2304 at 983MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 983 of 2397 [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 3552534 bytes for cache used [DVDAuthorTask] STAT: VOBU 2320 at 990MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 990 of 2397 [DVDAuthorTask] STAT: VOBU 2336 at 995MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 995 of 2397 [DVDAuthorTask] STAT: VOBU 2352 at 1001MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 1001 of 2397 It's now Sat Jul 3 09:30:47 2010 next real activation is Sun Jul 4 02:00:01 2010 [timer.py] next activation: 1278142347 (in 99991 ms) [DVDAuthorTask] STAT: VOBU 2368 at 1007MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 1007 of 2397 [DVDAuthorTask] STAT: VOBU 2384 at 1014MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 1014 of 2397 [DVDAuthorTask] STAT: VOBU 2400 at 1021MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 1021 of 2397 [DVDAuthorTask] STAT: VOBU 2416 at 1028MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 1028 of 2397 nr_read 171228 nr_write 106215 sum 277443 prev_sum 276890 hdd was accessed since previous check! [IDLE] 0 600 False It's now Sat Jul 3 09:31:19 2010 next real activation is Sat Jul 3 11:54:40 2010 [timer.py] next activation: 1278142379 (in 99990 ms) [DVDAuthorTask] STAT: VOBU 2432 at 1034MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 1034 of 2397 It's now Sat Jul 3 09:31:23 2010 [timer.py] next activation: 1278142383 (in 99994 ms) [DVDAuthorTask] STAT: VOBU 2448 at 1042MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 1042 of 2397 [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 3552534 bytes for cache used [DVDAuthorTask] STAT: VOBU 2464 at 1048MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 1048 of 2397 [DVDAuthorTask] STAT: VOBU 2480 at 1053MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 1053 of 2397 [DVDAuthorTask] STAT: VOBU 2496 at 1060MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 1060 of 2397 [DVDAuthorTask] STAT: VOBU 2512 at 1066MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 1066 of 2397 [DVDAuthorTask] STAT: VOBU 2528 at 1072MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 1072 of 2397 [DVDAuthorTask] STAT: VOBU 2544 at 1079MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 1079 of 2397 nr_read 171684 nr_write 106354 sum 278038 prev_sum 277443 hdd was accessed since previous check! [IDLE] 0 600 False [DVDAuthorTask] STAT: VOBU 2560 at 1086MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 1086 of 2397 [DVDAuthorTask] STAT: VOBU 2576 at 1093MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 1093 of 2397 It's now Sat Jul 3 09:32:27 2010 next real activation is Sun Jul 4 02:00:01 2010 [timer.py] next activation: 1278142447 (in 99990 ms) [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 3552534 bytes for cache used [DVDAuthorTask] STAT: VOBU 2592 at 1101MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 1101 of 2397 [DVDAuthorTask] STAT: VOBU 2608 at 1108MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 1108 of 2397 [DVDAuthorTask] STAT: VOBU 2624 at 1114MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 1114 of 2397 [DVDAuthorTask] STAT: VOBU 2640 at 1122MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 1122 of 2397 It's now Sat Jul 3 09:32:59 2010 next real activation is Sat Jul 3 11:54:40 2010 [timer.py] next activation: 1278142479 (in 99989 ms) [DVDAuthorTask] STAT: VOBU 2656 at 1128MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 1128 of 2397 It's now Sat Jul 3 09:33:03 2010 [timer.py] next activation: 1278142483 (in 99994 ms) [DVDAuthorTask] STAT: VOBU 2672 at 1134MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 1134 of 2397 [DVDAuthorTask] STAT: VOBU 2688 at 1140MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 1140 of 2397 nr_read 172132 nr_write 106479 sum 278611 prev_sum 278038 hdd was accessed since previous check! [IDLE] 0 600 False [DVDAuthorTask] STAT: VOBU 2704 at 1146MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 1146 of 2397 [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 3552033 bytes for cache used [DVDAuthorTask] STAT: VOBU 2720 at 1152MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 1152 of 2397 [DVDAuthorTask] STAT: VOBU 2736 at 1160MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 1160 of 2397 [DVDAuthorTask] STAT: VOBU 2752 at 1166MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 1166 of 2397 [DVDAuthorTask] STAT: VOBU 2768 at 1174MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 1174 of 2397 [DVDAuthorTask] STAT: VOBU 2784 at 1181MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 1181 of 2397 It's now Sat Jul 3 09:34:07 2010 next real activation is Sun Jul 4 02:00:01 2010 [timer.py] next activation: 1278142547 (in 99992 ms) [DVDAuthorTask] STAT: VOBU 2800 at 1187MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 1187 of 2397 [DVDAuthorTask] STAT: VOBU 2816 at 1194MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 1194 of 2397 nr_read 172577 nr_write 106590 sum 279167 prev_sum 278611 hdd was accessed since previous check! [IDLE] 0 600 False [DVDAuthorTask] STAT: VOBU 2832 at 1201MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 1201 of 2397 [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 3552033 bytes for cache used [DVDAuthorTask] STAT: VOBU 2848 at 1208MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 1208 of 2397 It's now Sat Jul 3 09:34:39 2010 next real activation is Sat Jul 3 11:54:40 2010 [timer.py] next activation: 1278142579 (in 99990 ms) [DVDAuthorTask] STAT: VOBU 2864 at 1216MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 1216 of 2397 It's now Sat Jul 3 09:34:43 2010 [timer.py] next activation: 1278142583 (in 99993 ms) [DVDAuthorTask] STAT: VOBU 2880 at 1223MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 1223 of 2397 [DVDAuthorTask] STAT: VOBU 2896 at 1228MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 1228 of 2397 [DVDAuthorTask] STAT: VOBU 2912 at 1235MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 1235 of 2397 [DVDAuthorTask] STAT: VOBU 2928 at 1241MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 1241 of 2397 [DVDAuthorTask] STAT: VOBU 2944 at 1247MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 1247 of 2397 nr_read 173027 nr_write 106696 sum 279723 prev_sum 279167 hdd was accessed since previous check! [IDLE] 0 600 False [DVDAuthorTask] STAT: VOBU 2960 at 1254MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 1254 of 2397 [DVDAuthorTask] STAT: VOBU 2976 at 1260MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 1260 of 2397 [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 3550795 bytes for cache used [DVDAuthorTask] STAT: VOBU 2992 at 1266MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 1266 of 2397 [DVDAuthorTask] STAT: VOBU 3008 at 1273MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 1273 of 2397 It's now Sat Jul 3 09:35:47 2010 next real activation is Sun Jul 4 02:00:01 2010 [timer.py] next activation: 1278142647 (in 99991 ms) [DVDAuthorTask] STAT: VOBU 3024 at 1279MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 1279 of 2397 [DVDAuthorTask] STAT: VOBU 3040 at 1285MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 1285 of 2397 [DVDAuthorTask] STAT: VOBU 3056 at 1291MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 1291 of 2397 [DVDAuthorTask] STAT: VOBU 3072 at 1297MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 1297 of 2397 [DVDAuthorTask] STAT: VOBU 3088 at 1303MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 1303 of 2397 nr_read 173465 nr_write 106795 sum 280260 prev_sum 279723 hdd was accessed since previous check! [IDLE] 0 600 False It's now Sat Jul 3 09:36:19 2010 next real activation is Sat Jul 3 11:54:40 2010 [timer.py] next activation: 1278142679 (in 99989 ms) It's now Sat Jul 3 09:36:23 2010 [timer.py] next activation: 1278142683 (in 99993 ms) [DVDAuthorTask] STAT: VOBU 3104 at 1309MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 1309 of 2397 [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 3550705 bytes for cache used [DVDAuthorTask] STAT: VOBU 3120 at 1316MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 1316 of 2397 [DVDAuthorTask] STAT: VOBU 3136 at 1323MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 1323 of 2397 [DVDAuthorTask] STAT: VOBU 3152 at 1330MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 1330 of 2397 [DVDAuthorTask] STAT: VOBU 3168 at 1336MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 1336 of 2397 [DVDAuthorTask] STAT: VOBU 3184 at 1342MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 1342 of 2397 [DVDAuthorTask] STAT: VOBU 3200 at 1348MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 1348 of 2397 [DVDAuthorTask] STAT: VOBU 3216 at 1353MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 1353 of 2397 nr_read 173904 nr_write 106904 sum 280808 prev_sum 280260 hdd was accessed since previous check! [IDLE] 0 600 False [DVDAuthorTask] STAT: VOBU 3232 at 1360MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 1360 of 2397 [DVDAuthorTask] STAT: VOBU 3248 at 1365MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 1365 of 2397 It's now Sat Jul 3 09:37:27 2010 next real activation is Sun Jul 4 02:00:01 2010 [timer.py] next activation: 1278142747 (in 99990 ms) [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 3550705 bytes for cache used [DVDAuthorTask] STAT: VOBU 3264 at 1372MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 1372 of 2397 [DVDAuthorTask] STAT: VOBU 3280 at 1378MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 1378 of 2397 [DVDAuthorTask] STAT: VOBU 3296 at 1385MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 1385 of 2397 [DVDAuthorTask] STAT: VOBU 3312 at 1391MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 1391 of 2397 It's now Sat Jul 3 09:37:59 2010 next real activation is Sat Jul 3 11:54:40 2010 [timer.py] next activation: 1278142779 (in 99991 ms) [DVDAuthorTask] STAT: VOBU 3328 at 1398MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 1398 of 2397 It's now Sat Jul 3 09:38:03 2010 [timer.py] next activation: 1278142783 (in 99995 ms) [DVDAuthorTask] STAT: VOBU 3344 at 1404MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 1404 of 2397 [DVDAuthorTask] STAT: VOBU 3360 at 1410MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 1410 of 2397 nr_read 174347 nr_write 107015 sum 281362 prev_sum 280808 hdd was accessed since previous check! [IDLE] 0 600 False [DVDAuthorTask] STAT: VOBU 3376 at 1415MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 1415 of 2397 [DVDAuthorTask] STAT: VOBU 3392 at 1421MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 1421 of 2397 [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 3550705 bytes for cache used [DVDAuthorTask] STAT: VOBU 3408 at 1427MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 1427 of 2397 [DVDAuthorTask] STAT: VOBU 3424 at 1432MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 1432 of 2397 [DVDAuthorTask] STAT: VOBU 3440 at 1437MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 1437 of 2397 [DVDAuthorTask] STAT: VOBU 3456 at 1443MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 1443 of 2397 [DVDAuthorTask] STAT: VOBU 3472 at 1449MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 1449 of 2397 [DVDAuthorTask] STAT: VOBU 3488 at 1455MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 1455 of 2397 It's now Sat Jul 3 09:39:07 2010 next real activation is Sun Jul 4 02:00:01 2010 [timer.py] next activation: 1278142847 (in 99990 ms) [DVDAuthorTask] STAT: VOBU 3504 at 1460MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 1460 of 2397 nr_read 174780 nr_write 107130 sum 281910 prev_sum 281362 hdd was accessed since previous check! [IDLE] 0 600 False [DVDAuthorTask] STAT: VOBU 3520 at 1465MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 1465 of 2397 [DVDAuthorTask] STAT: VOBU 3536 at 1471MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 1471 of 2397 [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 3550705 bytes for cache used [DVDAuthorTask] STAT: VOBU 3552 at 1477MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 1477 of 2397 It's now Sat Jul 3 09:39:39 2010 next real activation is Sat Jul 3 11:54:40 2010 [timer.py] next activation: 1278142879 (in 99989 ms) [DVDAuthorTask] STAT: VOBU 3568 at 1485MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 1485 of 2397 It's now Sat Jul 3 09:39:43 2010 [timer.py] next activation: 1278142883 (in 99993 ms) [DVDAuthorTask] STAT: VOBU 3584 at 1492MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 1492 of 2397 [DVDAuthorTask] STAT: VOBU 3600 at 1499MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 1499 of 2397 [DVDAuthorTask] STAT: VOBU 3616 at 1505MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 1505 of 2397 [DVDAuthorTask] STAT: VOBU 3632 at 1512MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 1512 of 2397 nr_read 175228 nr_write 107237 sum 282465 prev_sum 281910 hdd was accessed since previous check! [IDLE] 0 600 False [DVDAuthorTask] STAT: VOBU 3648 at 1519MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 1519 of 2397 [DVDAuthorTask] STAT: VOBU 3664 at 1527MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 1527 of 2397 [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 3549264 bytes for cache used [DVDAuthorTask] STAT: VOBU 3680 at 1533MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 1533 of 2397 [DVDAuthorTask] STAT: VOBU 3696 at 1539MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 1539 of 2397 [DVDAuthorTask] STAT: VOBU 3712 at 1544MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 1544 of 2397 It's now Sat Jul 3 09:40:47 2010 next real activation is Sun Jul 4 02:00:01 2010 [timer.py] next activation: 1278142947 (in 99990 ms) [DVDAuthorTask] STAT: VOBU 3728 at 1551MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 1551 of 2397 [DVDAuthorTask] STAT: VOBU 3744 at 1556MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 1556 of 2397 [DVDAuthorTask] STAT: VOBU 3760 at 1562MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 1562 of 2397 [DVDAuthorTask] STAT: VOBU 3776 at 1569MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 1569 of 2397 nr_read 175668 nr_write 107350 sum 283018 prev_sum 282465 hdd was accessed since previous check! [IDLE] 0 600 False [DVDAuthorTask] STAT: VOBU 3792 at 1574MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 1574 of 2397 It's now Sat Jul 3 09:41:19 2010 next real activation is Sat Jul 3 11:54:40 2010 [timer.py] next activation: 1278142979 (in 99989 ms) It's now Sat Jul 3 09:41:23 2010 [timer.py] next activation: 1278142983 (in 99993 ms) [DVDAuthorTask] STAT: VOBU 3808 at 1580MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 1580 of 2397 [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 3549264 bytes for cache used [DVDAuthorTask] STAT: VOBU 3824 at 1586MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 1586 of 2397 [DVDAuthorTask] STAT: VOBU 3840 at 1592MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 1592 of 2397 [DVDAuthorTask] STAT: VOBU 3856 at 1598MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 1598 of 2397 [DVDAuthorTask] STAT: VOBU 3872 at 1604MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 1604 of 2397 [DVDAuthorTask] STAT: VOBU 3888 at 1610MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 1610 of 2397 [DVDAuthorTask] STAT: VOBU 3904 at 1616MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 1616 of 2397 [DVDAuthorTask] STAT: VOBU 3920 at 1624MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 1624 of 2397 nr_read 176109 nr_write 107458 sum 283567 prev_sum 283018 hdd was accessed since previous check! [IDLE] 0 600 False [DVDAuthorTask] STAT: VOBU 3936 at 1630MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 1630 of 2397 [DVDAuthorTask] STAT: VOBU 3952 at 1635MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 1635 of 2397 It's now Sat Jul 3 09:42:27 2010 next real activation is Sun Jul 4 02:00:01 2010 [timer.py] next activation: 1278143047 (in 99992 ms) [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 3549238 bytes for cache used [DVDAuthorTask] STAT: VOBU 3968 at 1641MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 1641 of 2397 [DVDAuthorTask] STAT: VOBU 3984 at 1646MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 1646 of 2397 [DVDAuthorTask] STAT: VOBU 4000 at 1652MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 1652 of 2397 [DVDAuthorTask] STAT: VOBU 4016 at 1658MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 1658 of 2397 [DVDAuthorTask] STAT: VOBU 4032 at 1664MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 1664 of 2397 It's now Sat Jul 3 09:42:59 2010 next real activation is Sat Jul 3 11:54:40 2010 [timer.py] next activation: 1278143079 (in 99990 ms) It's now Sat Jul 3 09:43:03 2010 [timer.py] next activation: 1278143083 (in 99993 ms) [DVDAuthorTask] STAT: VOBU 4048 at 1669MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 1669 of 2397 [DVDAuthorTask] STAT: VOBU 4064 at 1677MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 1677 of 2397 nr_read 176550 nr_write 107570 sum 284120 prev_sum 283567 hdd was accessed since previous check! [IDLE] 0 600 False [DVDAuthorTask] STAT: VOBU 4080 at 1685MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 1685 of 2397 [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 3549238 bytes for cache used [DVDAuthorTask] STAT: VOBU 4096 at 1693MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 1693 of 2397 [DVDAuthorTask] STAT: VOBU 4112 at 1700MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 1700 of 2397 [DVDAuthorTask] STAT: VOBU 4128 at 1708MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 1708 of 2397 [DVDAuthorTask] STAT: VOBU 4144 at 1716MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 1716 of 2397 [DVDAuthorTask] STAT: VOBU 4160 at 1724MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 1724 of 2397 It's now Sat Jul 3 09:44:07 2010 next real activation is Sun Jul 4 02:00:01 2010 [timer.py] next activation: 1278143147 (in 99987 ms) [DVDAuthorTask] STAT: VOBU 4176 at 1731MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 1731 of 2397 nr_read 177005 nr_write 107671 sum 284676 prev_sum 284120 hdd was accessed since previous check! [IDLE] 0 600 False [DVDAuthorTask] STAT: VOBU 4192 at 1739MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 1739 of 2397 [DVDAuthorTask] STAT: VOBU 4208 at 1746MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 1746 of 2397 [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 3549238 bytes for cache used [DVDAuthorTask] STAT: VOBU 4224 at 1754MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 1754 of 2397 It's now Sat Jul 3 09:44:39 2010 next real activation is Sat Jul 3 11:54:40 2010 [timer.py] next activation: 1278143179 (in 99990 ms) It's now Sat Jul 3 09:44:43 2010 [timer.py] next activation: 1278143183 (in 99993 ms) [DVDAuthorTask] STAT: VOBU 4240 at 1760MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 1760 of 2397 [DVDAuthorTask] STAT: VOBU 4256 at 1767MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 1767 of 2397 [DVDAuthorTask] STAT: VOBU 4272 at 1774MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 1774 of 2397 [DVDAuthorTask] STAT: VOBU 4288 at 1781MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 1781 of 2397 [DVDAuthorTask] STAT: VOBU 4304 at 1788MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 1788 of 2397 nr_read 177453 nr_write 107778 sum 285231 prev_sum 284676 hdd was accessed since previous check! [IDLE] 0 600 False [DVDAuthorTask] STAT: VOBU 4320 at 1796MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 1796 of 2397 [DVDAuthorTask] STAT: VOBU 4336 at 1802MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 1802 of 2397 [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 3544283 bytes for cache used [DVDAuthorTask] STAT: VOBU 4352 at 1810MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 1810 of 2397 [DVDAuthorTask] STAT: VOBU 4368 at 1815MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 1815 of 2397 It's now Sat Jul 3 09:45:47 2010 next real activation is Sun Jul 4 02:00:01 2010 [timer.py] next activation: 1278143247 (in 99990 ms) [DVDAuthorTask] STAT: VOBU 4384 at 1822MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 1822 of 2397 [DVDAuthorTask] STAT: VOBU 4400 at 1828MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 1828 of 2397 [DVDAuthorTask] STAT: VOBU 4416 at 1834MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 1834 of 2397 [DVDAuthorTask] STAT: VOBU 4432 at 1841MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 1841 of 2397 nr_read 177909 nr_write 107893 sum 285802 prev_sum 285231 hdd was accessed since previous check! [IDLE] 0 600 False It's now Sat Jul 3 09:46:19 2010 next real activation is Sat Jul 3 11:54:40 2010 [timer.py] next activation: 1278143279 (in 99989 ms) [DVDAuthorTask] STAT: VOBU 4448 at 1847MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 1847 of 2397 It's now Sat Jul 3 09:46:23 2010 [timer.py] next activation: 1278143283 (in 99994 ms) [DVDAuthorTask] STAT: VOBU 4464 at 1853MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 1853 of 2397 [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 3544265 bytes for cache used [DVDAuthorTask] STAT: VOBU 4480 at 1859MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 1859 of 2397 [DVDAuthorTask] STAT: VOBU 4496 at 1866MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 1866 of 2397 [DVDAuthorTask] STAT: VOBU 4512 at 1872MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 1872 of 2397 [DVDAuthorTask] STAT: VOBU 4528 at 1878MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 1878 of 2397 [DVDAuthorTask] STAT: VOBU 4544 at 1885MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 1885 of 2397 [DVDAuthorTask] STAT: VOBU 4560 at 1892MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 1892 of 2397 [DVDAuthorTask] STAT: VOBU 4576 at 1898MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 1898 of 2397 nr_read 178347 nr_write 108007 sum 286354 prev_sum 285802 hdd was accessed since previous check! [IDLE] 0 600 False [DVDAuthorTask] STAT: VOBU 4592 at 1904MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 1904 of 2397 It's now Sat Jul 3 09:47:27 2010 next real activation is Sun Jul 4 02:00:01 2010 [timer.py] next activation: 1278143347 (in 99991 ms) [DVDAuthorTask] STAT: VOBU 4608 at 1910MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 1910 of 2397 [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 3543697 bytes for cache used [DVDAuthorTask] STAT: VOBU 4624 at 1916MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 1916 of 2397 [DVDAuthorTask] STAT: VOBU 4640 at 1922MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 1922 of 2397 [DVDAuthorTask] STAT: VOBU 4656 at 1927MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 1927 of 2397 [DVDAuthorTask] STAT: VOBU 4672 at 1932MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 1932 of 2397 It's now Sat Jul 3 09:47:59 2010 next real activation is Sat Jul 3 11:54:40 2010 [timer.py] next activation: 1278143379 (in 99990 ms) [DVDAuthorTask] STAT: VOBU 4688 at 1939MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 1939 of 2397 It's now Sat Jul 3 09:48:03 2010 [timer.py] next activation: 1278143383 (in 99994 ms) [DVDAuthorTask] STAT: VOBU 4704 at 1947MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 1947 of 2397 nr_read 178782 nr_write 108114 sum 286896 prev_sum 286354 hdd was accessed since previous check! [IDLE] 0 600 False [DVDAuthorTask] STAT: VOBU 4720 at 1953MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 1953 of 2397 [DVDAuthorTask] STAT: VOBU 4736 at 1960MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 1960 of 2397 [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 3543697 bytes for cache used [DVDAuthorTask] STAT: VOBU 4752 at 1967MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 1967 of 2397 [DVDAuthorTask] STAT: VOBU 4768 at 1975MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 1975 of 2397 [DVDAuthorTask] STAT: VOBU 4784 at 1982MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 1982 of 2397 [DVDAuthorTask] STAT: VOBU 4800 at 1990MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 1990 of 2397 [DVDAuthorTask] STAT: VOBU 4816 at 1996MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 1996 of 2397 It's now Sat Jul 3 09:49:07 2010 next real activation is Sun Jul 4 02:00:01 2010 [timer.py] next activation: 1278143447 (in 99990 ms) [DVDAuthorTask] STAT: VOBU 4832 at 2002MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 2002 of 2397 nr_read 179233 nr_write 108226 sum 287459 prev_sum 286896 hdd was accessed since previous check! [IDLE] 0 600 False [DVDAuthorTask] STAT: VOBU 4848 at 2008MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 2008 of 2397 [DVDAuthorTask] STAT: VOBU 4864 at 2016MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 2016 of 2397 [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 3543235 bytes for cache used [DVDAuthorTask] STAT: VOBU 4880 at 2022MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 2022 of 2397 It's now Sat Jul 3 09:49:39 2010 next real activation is Sat Jul 3 11:54:40 2010 [timer.py] next activation: 1278143479 (in 99990 ms) [DVDAuthorTask] STAT: VOBU 4896 at 2029MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 2029 of 2397 It's now Sat Jul 3 09:49:43 2010 [timer.py] next activation: 1278143483 (in 99994 ms) [DVDAuthorTask] STAT: VOBU 4912 at 2035MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 2035 of 2397 [DVDAuthorTask] STAT: VOBU 4928 at 2042MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 2042 of 2397 [DVDAuthorTask] STAT: VOBU 4944 at 2047MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 2047 of 2397 [DVDAuthorTask] STAT: VOBU 4960 at 2054MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 2054 of 2397 nr_read 179678 nr_write 108351 sum 288029 prev_sum 287459 hdd was accessed since previous check! [IDLE] 0 600 False [DVDAuthorTask] STAT: VOBU 4976 at 2061MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 2061 of 2397 [DVDAuthorTask] STAT: VOBU 4992 at 2068MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 2068 of 2397 [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 3542348 bytes for cache used [DVDAuthorTask] STAT: VOBU 5008 at 2076MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 2076 of 2397 [DVDAuthorTask] STAT: VOBU 5024 at 2084MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 2084 of 2397 It's now Sat Jul 3 09:50:47 2010 next real activation is Sun Jul 4 02:00:01 2010 [timer.py] next activation: 1278143547 (in 99989 ms) [DVDAuthorTask] STAT: VOBU 5040 at 2090MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 2090 of 2397 [DVDAuthorTask] STAT: VOBU 5056 at 2097MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 2097 of 2397 [DVDAuthorTask] STAT: VOBU 5072 at 2105MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 2105 of 2397 [DVDAuthorTask] STAT: VOBU 5088 at 2111MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 2111 of 2397 nr_read 180137 nr_write 108461 sum 288598 prev_sum 288029 hdd was accessed since previous check! [IDLE] 0 600 False It's now Sat Jul 3 09:51:19 2010 next real activation is Sat Jul 3 11:54:40 2010 [timer.py] next activation: 1278143579 (in 99990 ms) [DVDAuthorTask] STAT: VOBU 5104 at 2118MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 2118 of 2397 It's now Sat Jul 3 09:51:23 2010 [timer.py] next activation: 1278143583 (in 99994 ms) [DVDAuthorTask] STAT: VOBU 5120 at 2124MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 2124 of 2397 [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 3541982 bytes for cache used [DVDAuthorTask] STAT: VOBU 5136 at 2131MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 2131 of 2397 [DVDAuthorTask] STAT: VOBU 5152 at 2139MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 2139 of 2397 [DVDAuthorTask] STAT: VOBU 5168 at 2145MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 2145 of 2397 [DVDAuthorTask] STAT: VOBU 5184 at 2152MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 2152 of 2397 [DVDAuthorTask] STAT: VOBU 5200 at 2160MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 2160 of 2397 [DVDAuthorTask] STAT: VOBU 5216 at 2166MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 2166 of 2397 nr_read 180583 nr_write 108561 sum 289144 prev_sum 288598 hdd was accessed since previous check! [IDLE] 0 600 False [DVDAuthorTask] STAT: VOBU 5232 at 2173MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 2173 of 2397 It's now Sat Jul 3 09:52:27 2010 next real activation is Sun Jul 4 02:00:01 2010 [timer.py] next activation: 1278143647 (in 99991 ms) [DVDAuthorTask] STAT: VOBU 5248 at 2180MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 2180 of 2397 [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 3541982 bytes for cache used [DVDAuthorTask] STAT: VOBU 5264 at 2188MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 2188 of 2397 [DVDAuthorTask] STAT: VOBU 5280 at 2196MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 2196 of 2397 [DVDAuthorTask] STAT: VOBU 5296 at 2202MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 2202 of 2397 [DVDAuthorTask] STAT: VOBU 5312 at 2208MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 2208 of 2397 It's now Sat Jul 3 09:52:59 2010 next real activation is Sat Jul 3 11:54:40 2010 [timer.py] next activation: 1278143679 (in 99991 ms) It's now Sat Jul 3 09:53:03 2010 [timer.py] next activation: 1278143683 (in 99993 ms) [DVDAuthorTask] STAT: VOBU 5328 at 2214MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 2214 of 2397 [DVDAuthorTask] STAT: VOBU 5344 at 2221MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 2221 of 2397 nr_read 181025 nr_write 108674 sum 289699 prev_sum 289144 hdd was accessed since previous check! [IDLE] 0 600 False [eDVBLocalTimerHandler] no transponder tuned... or no TDT/TOT avail .. try to use RTC :) [eDVBLocalTimerHandler] shit RTC not ready :( [DVDAuthorTask] STAT: VOBU 5360 at 2228MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 2228 of 2397 [DVDAuthorTask] STAT: VOBU 5376 at 2235MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 2235 of 2397 [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 3541964 bytes for cache used [DVDAuthorTask] STAT: VOBU 5392 at 2242MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 2242 of 2397 [DVDAuthorTask] STAT: VOBU 5408 at 2248MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 2248 of 2397 [DVDAuthorTask] STAT: VOBU 5424 at 2255MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 2255 of 2397 [DVDAuthorTask] STAT: VOBU 5440 at 2263MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 2263 of 2397 It's now Sat Jul 3 09:54:07 2010 next real activation is Sun Jul 4 02:00:01 2010 [timer.py] next activation: 1278143747 (in 99990 ms) [DVDAuthorTask] STAT: VOBU 5456 at 2270MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 2270 of 2397 [DVDAuthorTask] STAT: VOBU 5472 at 2277MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 2277 of 2397 nr_read 181474 nr_write 108780 sum 290254 prev_sum 289699 hdd was accessed since previous check! [IDLE] 0 600 False [DVDAuthorTask] STAT: VOBU 5488 at 2283MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 2283 of 2397 [DVDAuthorTask] STAT: VOBU 5504 at 2290MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 2290 of 2397 [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 3541964 bytes for cache used [DVDAuthorTask] STAT: VOBU 5520 at 2296MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 2296 of 2397 [MplexTask] INFO: [mplex] Scanned to end AU 66300 [MplexTask] INFO: [mplex] STREAM e0 completed [MplexTask] INFO: [mplex] STREAM c0 completed [MplexTask] INFO: [mplex] STREAM c1 completed [DVDAuthorTask] [DVDAuthorTask] INFO: Video pts = 0.120 .. 2652.160 [DVDAuthorTask] INFO: Audio[8] pts = 0.120 .. 2652.168 [DVDAuthorTask] INFO: Audio[9] pts = 0.120 .. 2652.168 [DVDAuthorTask] STAT: VOBU 5525 at 2299MB, 1 PGCS [DVDAuthorTask] update mplextask progress: 2299 of 2397 [DVDAuthorTask] [DVDAuthorTask] INFO: Generating VTS with the following video attributes: [DVDAuthorTask] INFO: MPEG version: mpeg2 [DVDAuthorTask] INFO: TV standard: pal [DVDAuthorTask] INFO: Aspect ratio: 16:9 [DVDAuthorTask] INFO: Resolution: 720x576 [DVDAuthorTask] INFO: Audio ch 0 format: mp2/2ch, 48khz 20bps [DVDAuthorTask] INFO: Audio ch 1 format: mp2/2ch, 48khz 20bps [DVDAuthorTask] [MplexTask] INFO: [mplex] Multiplex completion at SCR=238682550. [MplexTask] INFO: [mplex] Video e0: completed [MplexTask] INFO: [mplex] Audio c0: completed [MplexTask] INFO: [mplex] Audio c1: completed [MplexTask] INFO: [mplex] VIDEO_STATISTICS: e0 [MplexTask] INFO: [mplex] Video Stream length: 2239624012 bytes [MplexTask] INFO: [mplex] Sequence headers: 5525 [MplexTask] INFO: [mplex] Sequence ends : 1 [MplexTask] INFO: [mplex] No. Pictures : 66301 [MplexTask] INFO: [mplex] No. Groups : 5525 [MplexTask] INFO: [mplex] No. I Frames : 5525 avg. size 99958 bytes [MplexTask] INFO: [mplex] No. P Frames : 16576 avg. size 42140 bytes [MplexTask] INFO: [mplex] No. B Frames : 44200 avg. size 22371 bytes It's now Sat Jul 3 09:54:39 2010 next real activation is Sat Jul 3 11:54:40 2010 [timer.py] next activation: 1278143779 (in 99980 ms) [MplexTask] INFO: [mplex] Average bit-rate : 6755600 bits/sec [MplexTask] INFO: [mplex] Peak bit-rate : 10714400 bits/sec [MplexTask] INFO: [mplex] BUFFERING min 15 Buf max 189067 [MplexTask] INFO: [mplex] AUDIO_STATISTICS: c0 [MplexTask] INFO: [mplex] Audio stream length 63649152 bytes. [MplexTask] INFO: [mplex] Syncwords : 110502 [MplexTask] INFO: [mplex] Frames : 110502 padded [MplexTask] INFO: [mplex] Frames : 0 unpadded [DVDAuthorTask] STAT: fixed 1 VOBUS [MplexTask] INFO: [mplex] BUFFERING min 15 Buf max 587 [MplexTask] INFO: [mplex] AUDIO_STATISTICS: c1 [MplexTask] INFO: [mplex] Audio stream length 63649152 bytes. [MplexTask] INFO: [mplex] Syncwords : 110502 [MplexTask] INFO: [mplex] Frames : 110502 padded [MplexTask] INFO: [mplex] Frames : 0 unpadded [MplexTask] INFO: [mplex] BUFFERING min 15 Buf max 587 [MplexTask] INFO: [mplex] MUX STATUS: no under-runs detected. child has terminated pipes closed execute: 0 rm -f /hdd/movie/tmp/20100703075226/source_title_1.m2v /hdd/movie/tmp/20100703075226/source_title_1.mp2 /hdd/movie/tmp/20100703075226/source_title_1-02.mp2 /hdd/movie/tmp/20100703075226/cut_1.Xcl poll: unhandled POLLERR/HUP/NVAL for fd 31(16) It's now Sat Jul 3 09:54:43 2010 [timer.py] next activation: 1278143783 (in 99995 ms) child has terminated pipes closed waiting for 1 resident task(s) [8] to finish... poll: unhandled POLLERR/HUP/NVAL for fd 31(16) nr_read 187337 nr_write 111398 sum 298735 prev_sum 290254 hdd was accessed since previous check! [IDLE] 0 600 False [DVDAuthorTask] STAT: fixing VOBU at 6MB (17/5525, 0%) STAT: fixing VOBU at 13MB (33/5525, 0%) STAT: fixing VOBU at 20MB (49/5525, 0%) STAT: fixing VOBU at 27MB (65/5525, 1%) STAT: fixing VOBU at 33MB (81/5525, 1%) STAT: fixing VOBU at 40MB (97/5525, 1%) STAT: fixing VOBU at 48MB (113/5525, 2%) STAT: fixing VOBU at 53MB (129/5525, 2%) STAT: fixing VOBU at 60MB (145/5525, 2%) STAT: fixing VOBU at 68MB (161/5525, 2%) STAT: fixing VOBU at 75MB (177/5525, 3%) STAT: fixing VOBU at 83MB (193/5525, 3%) STAT: fixing VOBU at 90MB (209/5525, 3%) STAT: fixing VOBU at 97MB (225/5525, 4%) STAT: fixing VOBU at 104MB (241/5525, 4%) STAT: fixing VOBU at 112MB (257/5525, 4%) STAT: fixing VOBU at 119MB (273/5525, 4%) STAT: fixing VOBU at 126MB (289/5525, 5%) STAT: fixing VOBU at 133MB (305/5525, 5%) STAT: fixing VOBU at 141MB (321/5525, 5%) STAT: fixing VOBU at 148MB (337/5525, 6%) STAT: fixing VOBU at 155MB (353/5525, 6%) STAT: fixing VOBU at 163MB (369/5525, 6%) STAT: fixing VOBU at 170MB (385/5525, 6%) STAT: fixing VOBU at 177MB (401/5525, 7%) STAT: fixing VOBU at 185MB (417/5525, 7%) STAT: fixing VOBU at 192MB (433/5525, 7%) STAT: fixing VOBU at 200MB (449/5525, 8%) STAT: fixing VOBU at 206MB (465/5525, 8%) STAT: fixing VOBU at 212MB (481/5525, 8%) STAT: fixing VOBU at 219MB (497/5525, 8%) STAT: fixing VOBU at 225MB (513/5525, 9%) STAT: fixing VOBU at 232MB (529/5525, 9%) STAT: fixing VOBU at 239MB (545/5525, 9%) STAT: fixing VOBU at 247MB (561/5525, 10%) STAT: fixing VOBU at 254MB (577/5525, 10%) STAT: fixing VOBU at 261MB (593/5525, 10%) STAT: fixing VOBU at 268MB (609/5525, 11%) STAT: fixing VOBU at 274MB (625/5525, 11%) STAT: fixing VOBU at 281MB (641/5525, 11%) STAT: fixing VOBU at 288MB (657/5525, 11%) STAT: fixing VOBU at 295MB (673/5525, 12%) STAT: fixing VOBU at 301MB (689/5525, 12%) STAT: fixing VOBU at 307MB (705/5525, 12%) STAT: fixing VOBU at 313MB (721/5525, 13%) STAT: fixing VOBU at 319MB (737/5525, 13%) STAT: fixing VOBU at 326MB (753/5525, 13%) STAT: fixing VOBU at 333MB (769/5525, 13%) STAT: fixing VOBU at 341MB (785/5525, 14%) STAT: fixing VOBU at 349MB (801/5525, 14%) STAT: fixing VOBU at 357MB (817/5525, 14%) STAT: fixing VOBU at 364MB (833/5525, 15%) STAT: fixing VOBU at 372MB (849/5525, 15%) STAT: fixing VOBU at 379MB (865/5525, 15%) STAT: fixing VOBU at 387MB (881/5525, 15%) STAT: fixing VOBU at 395MB (897/5525, 16%) STAT: fixing VOBU at 402MB (913/5525, 16%) STAT: fixing VOBU at 409MB (929/5525, 16%) STAT: fixing VOBU at 416MB (945/5525, 17%) STAT: fixing VOBU at 423MB (961/5525, 17%) STAT: fixing VOBU at 431MB (977/5525, 17%) STAT: fixing VOBU at 438MB (993/5525, 17%) STAT: fixing VOBU at 445MB (1009/5525, 18%) STAT: fixing VOBU at 453MB (1025/5525, 18%) STAT: fixing VOBU at 460MB (1041/5525, 18%) STAT: fixing VOBU at 467MB (1057/5525, 19%) STAT: fixing VOBU at 473MB (1073/5525, 19%) STAT: fixing VOBU at 479MB (1089/5525, 19%) STAT: fixing VOBU at 487MB (1105/5525, 19%) STAT: fixing VOBU at 493MB (1121/5525, 20%) STAT: fixing VOBU at 499MB (1137/5525, 20%) STAT: fixing VOBU at 506MB (1153/5525, 20%) STAT: fixing VOBU at 513MB (1169/5525, 21%) STAT: fixing VOBU at 519MB (1185/5525, 21%) STAT: fixing VOBU at 525MB (1201/5525, 21%) STAT: fixing VOBU at 531MB (1217/5525, 22%) STAT: fixing VOBU at 538MB (1233/5525, 22%) STAT: fixing VOBU at 545MB (1249/5525, 22%) STAT: fixing VOBU at 552MB (1265/5525, 22%) STAT: fixing VOBU at 559MB (1281/5525, 23%) STAT: fixing VOBU at 564MB (1297/5525, 23%) STAT: fixing VOBU at 570MB (1313/5525, 23%) STAT: fixing VOBU at 577MB (1329/5525, 24%) STAT: fixing VOBU at 584MB (1345/5525, 24%) STAT: fixing VOBU at 590MB (1361/5525, 24%) STAT: fixing VOBU at 597MB (1377/5525, 24%) STAT: fixing VOBU at 603MB (1393/5525, 25%) STAT: fixing VOBU at 610MB (1409/5525, 25%) STAT: fixing VOBU at 618MB (1425/5525, 25%) STAT: fixing VOBU at 624MB (1441/5525, 26%) STAT: fixing VOBU at 630MB (1457/5525, 26%) STAT: fixing VOBU at 637MB (1473/5525, 26%) STAT: fixing VOBU at 642MB (1489/5525, 26%) STAT: fixing VOBU at 648MB (1505/5525, 27%) STAT: fixing VOBU at 654MB (1521/5525, 27%) STAT: fixing VOBU at 660MB (1537/5525, 27%) STAT: fixing VOBU at 666MB (1553/5525, 28%) STAT: fixing VOBU at 672MB (1569/5525, 28%) STAT: fixing VOBU at 679MB (1585/5525, 28%) STAT: fixing VOBU at 685MB (1601/5525, 28%) STAT: fixing VOBU at 692MB (1617/5525, 29%) STAT: fixing VOBU at 698MB (1633/5525, 29%) STAT: fixing VOBU at 704MB (1649/5525, 29%) STAT: fixing VOBU at 710MB (1665/5525, 30%) STAT: fixing VOBU at 715MB (1681/5525, 30%) STAT: fixing VOBU at 721MB (1697/5525, 30%) STAT: fixing VOBU at 728MB (1713/5525, 30%) STAT: fixing VOBU at 734MB (1729/5525, 31%) STAT: fixing VOBU at 741MB (1745/5525, 31%) STAT: fixing VOBU at 748MB (1761/5525, 31%) STAT: fixing VOBU at 756MB (1777/5525, 32%) STAT: fixing VOBU at 763MB (1793/5525, 32%) STAT: fixing VOBU at 770MB (1809/5525, 32%) STAT: fixing VOBU at 777MB (1825/5525, 33%) STAT: fixing VOBU at 785MB (1841/5525, 33%) STAT: fixing VOBU at 792MB (1857/5525, 33%) STAT: fixing VOBU at 799MB (1873/5525, 33%) STAT: fixing VOBU at 805MB (1889/5525, 34%) STAT: fixing VOBU at 812MB (1905/5525, 34%) STAT: fixing VOBU at 818MB (1921/5525, 34%) STAT: fixing VOBU at 826MB (1937/5525, 35%) STAT: fixing VOBU at 833MB (1953/5525, 35%) STAT: fixing VOBU at 841MB (1969/5525, 35%) STAT: fixing VOBU at 848MB (1985/5525, 35%) STAT: fixing VOBU at 855MB (2001/5525, 36%) STAT: fixing VOBU at 861MB (2017/5525, 36%) STAT: fixing VOBU at 868MB (2033/5525, 36%) STAT: fixing VOBU at 876MB (2049/5525, 37%) STAT: fixing VOBU at 883MB (2065/5525, 37%) STAT: fixing VOBU at 889MB (2081/5525, 37%) STAT: fixing VOBU at 896MB (2097/5525, 37%) STAT: fixing VOBU at 903MB (2113/5525, 38%) STAT: fixing VOBU at 910MB (2129/5525, 38%) STAT: fixing VOBU at 918MB (2145/5525, 38%) STAT: fixing VOBU at 924MB (2161/5525, 39%) STAT: fixing VOBU at 930MB (2177/5525, 39%) STAT: fixing VOBU at 936MB (2193/5525, 39%) STAT: fixing VOBU at 942MB (2209/5525, 39%) STAT: fixing VOBU at 948MB (2225/5525, 40%) STAT: fixing VOBU at 955MB (2241/5525, 40%) STAT: fixing VOBU at 962MB (2257/5525, 40%) STAT: fixing VOBU at 969MB (2273/5525, 41%) STAT: fixing VOBU at 976MB (2289/5525, 41%) STAT: fixing VOBU at 983MB (2305/5525, 41%) STAT: fixing VOBU at 990MB (2321/5525, 41%) STAT: fixing VOBU at 995MB (2337/5525, 42%) STAT: fixing VOBU at 1001MB (2353/5525, 42%) STAT: fixing VOBU at 1007MB (2369/5525, 42%) STAT: fixing VOBU at 1014MB (2385/5525, 43%) STAT: fixing VOBU at 1021MB (2401/5525, 43%) STAT: fixing VOBU at 1028MB (2417/5525, 43%) STAT: fixing VOBU at 1034MB (2433/5525, 44%) STAT: fixing VOBU at 1042MB (2449/5525, 44%) STAT: fixing VOBU at 1048MB (2465/5525, 44%) STAT: fixing VOBU at 1053MB (2481/5525, 44%) STAT: fixing VOBU at 1060MB (2497/5525, 45%) STAT: fixing VOBU at 1066MB (2513/5525, 45%) STAT: fixing VOBU at 1072MB (2529/5525, 45%) STAT: fixing VOBU at 1079MB (2545/5525, 46%) STAT: fixing VOBU at 1086MB (2561/5525, 46%) STAT: fixing VOBU at 1093MB (2577/5525, 46%) STAT: fixing VOBU at 1101MB (2593/5525, 46%) STAT: fixing VOBU at 1108MB (2609/5525, 47%) STAT: fixing VOBU at 1114MB (2625/5525, 47%) STAT: fixing VOBU at 1122MB (2641/5525, 47%) STAT: fixing VOBU at 1128MB (2657/5525, 48%) STAT: fixing VOBU at 1134MB (2673/5525, 48%) STAT: fixing VOBU at 1140MB (2689/5525, 48%) STAT: fixing VOBU at 1146MB (2705/5525, 48%) STAT: fixing VOBU at 1152MB (2721/5525, 49%) STAT: fixing VOBU at 1160MB (2737/5525, 49%) STAT: fixing VOBU at 1166MB (2753/5525, 49%) STAT: fixing VOBU at 1174MB (2769/5525, 50%) STAT: fixing VOBU at 1181MB (2785/5525, 50%) STAT: fixing VOBU at 1187MB (2801/5525, 50%) STAT: fixing VOBU at 1194MB (2817/5525, 50%) STAT: fixing VOBU at 1201MB (2833/5525, 51%) STAT: fixing VOBU at 1208MB (2849/5525, 51%) STAT: fixing VOBU at 1216MB (2865/5525, 51%) STAT: fixing VOBU at 1223MB (2881/5525, 52%) STAT: fixing VOBU at 1228MB (2897/5525, 52%) STAT: fixing VOBU at 1235MB (2913/5525, 52%) STAT: fixing VOBU at 1241MB (2929/5525, 52%) STAT: fixing VOBU at 1247MB (2945/5525, 53%) STAT: fixing VOBU at 1254MB (2961/5525, 53%) STAT: fixing VOBU at 1260MB (2977/5525, 53%) STAT: fixing VOBU at 1266MB (2993/5525, 54%) STAT: fixing VOBU at 1273MB (3009/5525, 54%) STAT: fixing VOBU at 1279MB (3025/5525, 54%) STAT: fixing VOBU at 1285MB (3041/5525, 55%) STAT: fixing VOBU at 1291MB (3057/5525, 55%) STAT: fixing VOBU at 1297MB (3073/5525, 55%) STAT: fixing VOBU at 1303MB (3089/5525, 55%) STAT: fixing VOBU at 1309MB (3105/5525, 56%) STAT: fixing VOBU at 1316MB (3121/5525, 56%) STAT: fixing VOBU at 1323MB (3137/5525, 56%) STAT: fixing VOBU at 1330MB (3153/5525, 57%) STAT: fixing VOBU at 1336MB (3169/5525, 57%) STAT: fixing VOBU at 1342MB (3185/5525, 57%) STAT: fixing VOBU at 1348MB (3201/5525, 57%) STAT: fixing VOBU at 1353MB (3217/5525, 58%) STAT: fixing VOBU at 1360MB (3233/5525, 58%) STAT: fixing VOBU at 1365MB (3249/5525, 58%) STAT: fixing VOBU at 1372MB (3265/5525, 59%) STAT: fixing VOBU at 1378MB (3281/5525, 59%) STAT: fixing VOBU at 1385MB (3297/5525, 59%) STAT: fixing VOBU at 1391MB (3313/5525, 59%) STAT: fixing VOBU at 1398MB (3329/5525, 60%) STAT: fixing VOBU at 1404MB (3345/5525, 60%) STAT: fixing VOBU at 1410MB (3361/5525, 60%) STAT: fixing VOBU at 1415MB (3377/5525, 61%) STAT: fixing VOBU at 1421MB (3393/5525, 61%) STAT: fixing VOBU at 1427MB (3409/5525, 61%) STAT: fixing VOBU at 1432MB (3425/5525, 61%) STAT: fixing VOBU at 1437MB (3441/5525, 62%) STAT: fixing VOBU at 1443MB (3457/5525, 62%) STAT: fixing VOBU at 1449MB (3473/5525, 62%) STAT: fixing VOBU at 1455MB (3489/5525, 63%) STAT: fixing VOBU at 1460MB (3505/5525, 63%) STAT: fixing VOBU at 1465MB (3521/5525, 63%) STAT: fixing VOBU at 1471MB (3537/5525, 64%) STAT: fixing VOBU at 1477MB (3553/5525, 64%) STAT: fixing VOBU at 1485MB (3569/5525, 64%) STAT: fixing VOBU at 1492MB (3585/5525, 64%) STAT: fixing VOBU at 1499MB (3601/5525, 65%) STAT: fixing VOBU at 1505MB (3617/5525, 65%) STAT: fixing VOBU at 1512MB (3633/5525, 65%) STAT: fixing VOBU at 1519MB (3649/5525, 66%) STAT: fixing VOBU at 1527MB (3665/5525, 66%) STAT: fixing VOBU at 1533MB (3681/5525, 66%) STAT: fixing VOBU at 1539MB (3697/5525, 66%) STAT: fixing VOBU at 1544MB (3713/5525, 67%) STAT: fixing VOBU at 1551MB (3729/5525, 67%) STAT: fixing VOBU at 1556MB (3745/5525, 67%) STAT: fixing VOBU at 1562MB (3761/5525, 68%) STAT: fixing VOBU at 1569MB (3777/5525, 68%) STAT: fixing VOBU at 1574MB (3793/5525, 68%) STAT: fixing VOBU at 1580MB (3809/5525, 68%) STAT: fixing VOBU at 1586MB (3825/5525, 69%) STAT: fixing VOBU at 1592MB (3841/5525, 69%) STAT: fixing VOBU at 1598MB (3857/5525, 69%) STAT: fixing VOBU at 1604MB (3873/5525, 70%) STAT: fixing VOBU at 1610MB (3889/5525, 70%) STAT: fixing VOBU at 1616MB (3905/5525, 70%) STAT: fixing VOBU at 1624MB (3921/5525, 70%) STAT: fixing VOBU at 1630MB (3937/5525, 71%) STAT: fixing VOBU at 1635MB (3953/5525, 71%) STAT: fixing VOBU at 1641MB (3969/5525, 71%) STAT: fixing VOBU at 1646MB (3985/5525, 72%) STAT: fixing VOBU at 1652MB (4001/5525, 72%) STAT: fixing VOBU at 1658MB (4017/5525, 72%) STAT: fixing VOBU at 1664MB (4033/5525, 72%) STAT: fixing VOBU at 1669MB (4049/5525, 73%) STAT: fixing VOBU at 1677MB (4065/5525, 73%) STAT: fixing VOBU at 1685MB (4081/5525, 73%) STAT: fixing VOBU at 1693MB (4097/5525, 74%) STAT: fixing VOBU at 1700MB (4113/5525, 74%) STAT: fixing VOBU at 1708MB (4129/5525, 74%) STAT: fixing VOBU at 1716MB (4145/5525, 75%) STAT: fixing VOBU at 1724MB (4161/5525, 75%) STAT: fixing VOBU at 1731MB (4177/5525, 75%) STAT: fixing VOBU at 1739MB (4193/5525, 75%) STAT: fixing VOBU at 1746MB (4209/5525, 76%) STAT: fixing VOBU at 1754MB (4225/5525, 76%) STAT: fixing VOBU at 1760MB (4241/5525, 76%) STAT: fixing VOBU at 1767MB (4257/5525, 77%) STAT: fixing VOBU at 1774MB (4273/5525, 77%) STAT: fixing VOBU at 1781MB (4289/5525, 77%) STAT: fixing VOBU at 1788MB (4305/5525, 77%) STAT: fixing VOBU at 1796MB (4321/5525, 78%) STAT: fixing VOBU at 1802MB (4337/5525, 78%) STAT: fixing VOBU at 1810MB (4353/5525, 78%) STAT: fixing VOBU at 1815MB (4369/5525, 79%) STAT: fixing VOBU at 1822MB (4385/5525, 79%) STAT: fixing VOBU at 1828MB (4401/5525, 79%) STAT: fixing VOBU at 1834MB (4417/5525, 79%) STAT: fixing VOBU at 1841MB (4433/5525, 80%) STAT: fixing VOBU at 1847MB (4449/5525, 80%) STAT: fixing VOBU at 1853MB (4465/5525, 80%) STAT: fixing VOBU at 1859MB (4481/5525, 81%) STAT: fixing VOBU at 1866MB (4497/5525, 81%) STAT: fixing VOBU at 1872MB (4513/5525, 81%) STAT: fixing VOBU at 1878MB (4529/5525, 81%) STAT: fixing VOBU at 1885MB (4545/5525, 82%) STAT: fixing VOBU at 1892MB (4561/5525, 82%) STAT: fixing VOBU at 1898MB (4577/5525, 82%) STAT: fixing VOBU at 1904MB (4593/5525, 83%) STAT: fixing VOBU at 1910MB (4609/5525, 83%) STAT: fixing VOBU at 1916MB (4625/5525, 83%) STAT: fixing VOBU at 1922MB (4641/5525, 83%) STAT: fixing VOBU at 1927MB (4657/5525, 84%) STAT: fixing VOBU at 1932MB (4673/5525, 84%) STAT: fixing VOBU at 1939MB (4689/5525, 84%) STAT: fixing VOBU at 1947MB (4705/5525, 85%) STAT: fixing VOBU at 1953MB (4721/5525, 85%) STAT: fixing VOBU at 1960MB (4737/5525, 85%) STAT: fixing VOBU at 1967MB (4753/5525, 86%) STAT: fixing VOBU at 1975MB (4769/5525, 86%) STAT: fixing VOBU at 1982MB (4785/5525, 86%) STAT: fixing VOBU at 1990MB (4801/5525, 86%) STAT: fixing VOBU at 1996MB (4817/5525, 87%) STAT: fixing VOBU at 2002MB (4833/5525, 87%) STAT: fixing VOBU at 2008MB (4849/5525, 87%) STAT: fixing VOBU at 2016MB (4865/5525, 88%) STAT: fixing VOBU at 2022MB (4881/5525, 88%) STAT: fixing VOBU at 2029MB (4897/5525, 88%) STAT: fixing VOBU at 2035MB (4913/5525, 88%) STAT: fixing VOBU at 2042MB (4929/5525, 89%) STAT: fixing VOBU at 2047MB (4945/5525, 89%) STAT: fixing VOBU at 2054MB (4961/5525, 89%) STAT: fixing VOBU at 2061MB (4977/5525, 90%) STAT: fixing VOBU at 2068MB (4993/5525, 90%) STAT: fixing VOBU at 2076MB (5009/5525, 90%) STAT: fixing VOBU at 2084MB (5025/5525, 90%) STAT: fixing VOBU at 2090MB (5041/5525, 91%) STAT: fixing VOBU at 2097MB (5057/5525, 91%) STAT: fixing VOBU at 2105MB (5073/5525, 91%) STAT: fixing VOBU at 2111MB (5089/5525, 92%) STAT: fixing VOBU at 2118MB (5105/5525, 92%) STAT: fixing VOBU at 2124MB (5121/5525, 92%) STAT: fixing VOBU at 2131MB (5137/5525, 92%) STAT: fixing VOBU at 2139MB (5153/5525, 93%) STAT: fixing VOBU at 2145MB (5169/5525, 93%) STAT: fixing VOBU at 2152MB (5185/5525, 93%) STAT: fixing VOBU at 2160MB (5201/5525, 94%) STAT: fixing VOBU at 2166MB (5217/5525, 94%) STAT: fixing VOBU at 2173MB (5233/5525, 94%) STAT: fixing VOBU at 2180MB (5249/5525, 94%) STAT: fixing VOBU at 2188MB (5265/5525, 95%) STAT: fixing VOBU at 2196MB (5281/5525, 95%) STAT: fixing VOBU at 2202MB (5297/5525, 95%) STAT: fixing VOBU at 2208MB (5313/5525, 96%) STAT: fixing VOBU at 2214MB (5329/5525, 96%) STAT: fixing VOBU at 2221MB (5345/5525, 96%) STAT: fixing VOBU at 2228MB (5361/5525, 97%) STAT: fixing VOBU at 2235MB (5377/5525, 97%) STAT: fixing VOBU at 2242MB (5393/5525, 97%) STAT: fixing VOBU at 2248MB (5409/5525, 97%) STAT: fixing VOBU at 2255MB (5425/5525, 98%) STAT: fixing VOBU at 2263MB (5441/5525, 98%) STAT: fixing VOBU at 2270MB (5457/5525, 98%) STAT: fixing VOBU at 2277MB (5473/5525, 99%) STAT: fixing VOBU at 2283MB (5489/5525, 99%) STAT: fixing VOBU at 2290MB (5505/5525, 99%) STAT: fixing VOBU at 2296MB (5521/5525, 99%) STAT: fixed 5525 VOBUS [DVDAuthorTask] INFO: dvdauthor creating table of contents [DVDAuthorTask] INFO: Scanning /hdd/movie/tmp/20100703075226/dvd/VIDEO_TS/VTS_01_0.IFO [DVDAuthorTask] INFO: Creating menu for TOC [DVDAuthorTask] [DVDAuthorTask] STAT: Processing /usr/lib/enigma2/python/Plugins/Extensions/DVDBurn/vmgmdream.mpg... task keeps staying resident: [DVDAuthorTask] WARN: Discontinuity of 11755 in audio channel 8; please remultiplex input. [DVDAuthorTask] WARN: Previous sector: 0.120 - 0.120 [DVDAuthorTask] WARN: Current sector: 0.250 - 0.250 [DVDAuthorTask] WARN: Discontinuity of 11755 in audio channel 8; please remultiplex input. [DVDAuthorTask] WARN: Previous sector: 0.250 - 0.250 [DVDAuthorTask] WARN: Current sector: 0.381 - 0.381 [DVDAuthorTask] WARN: Discontinuity of 11755 in audio channel 8; please remultiplex input. [DVDAuthorTask] WARN: Previous sector: 0.381 - 0.381 [DVDAuthorTask] WARN: Current sector: 0.511 - 0.511 [DVDAuthorTask] WARN: Discontinuity of 11755 in audio channel 8; please remultiplex input. [DVDAuthorTask] WARN: Previous sector: 0.511 - 0.511 [DVDAuthorTask] WARN: Current sector: 0.642 - 0.642 [DVDAuthorTask] WARN: Discontinuity of 11755 in audio channel 8; please remultiplex input. [DVDAuthorTask] WARN: Previous sector: 0.642 - 0.642 [DVDAuthorTask] WARN: Current sector: 0.773 - 0.773 [DVDAuthorTask] WARN: Discontinuity of 11755 in audio channel 8; please remultiplex input. [DVDAuthorTask] WARN: Previous sector: 0.773 - 0.773 [DVDAuthorTask] WARN: Current sector: 0.903 - 0.903 [DVDAuthorTask] WARN: Discontinuity of 9404 in audio channel 8; please remultiplex input. [DVDAuthorTask] WARN: Previous sector: 0.903 - 0.903 [DVDAuthorTask] WARN: Current sector: 1.008 - 1.008 [DVDAuthorTask] WARN: Discontinuity of 11755 in audio channel 8; please remultiplex input. [DVDAuthorTask] WARN: Previous sector: 1.008 - 1.008 [DVDAuthorTask] WARN: Current sector: 1.138 - 1.138 [DVDAuthorTask] WARN: Discontinuity of 11755 in audio channel 8; please remultiplex input. [DVDAuthorTask] WARN: Previous sector: 1.138 - 1.138 [DVDAuthorTask] WARN: Current sector: 1.269 - 1.269 [DVDAuthorTask] WARN: Discontinuity of 11756 in audio channel 8; please remultiplex input. [DVDAuthorTask] WARN: Previous sector: 1.269 - 1.269 [DVDAuthorTask] WARN: Current sector: 1.400 - 1.400 [DVDAuthorTask] WARN: Discontinuity of 11755 in audio channel 8; please remultiplex input. [DVDAuthorTask] WARN: Previous sector: 1.400 - 1.400 [DVDAuthorTask] WARN: Current sector: 1.530 - 1.530 [DVDAuthorTask] WARN: Discontinuity of 11755 in audio channel 8; please remultiplex input. [DVDAuthorTask] WARN: Previous sector: 1.530 - 1.530 [DVDAuthorTask] WARN: Current sector: 1.661 - 1.661 [DVDAuthorTask] WARN: Discontinuity of 9404 in audio channel 8; please remultiplex input. [DVDAuthorTask] WARN: Previous sector: 1.661 - 1.661 [DVDAuthorTask] WARN: Current sector: 1.765 - 1.765 [DVDAuthorTask] WARN: Discontinuity of 11755 in audio channel 8; please remultiplex input. [DVDAuthorTask] WARN: Previous sector: 1.765 - 1.765 [DVDAuthorTask] WARN: Current sector: 1.896 - 1.896 [DVDAuthorTask] WARN: Discontinuity of 11755 in audio channel 8; please remultiplex input. [DVDAuthorTask] WARN: Previous sector: 1.896 - 1.896 [DVDAuthorTask] WARN: Current sector: 2.026 - 2.026 [DVDAuthorTask] WARN: Discontinuity of 11755 in audio channel 8; please remultiplex input. [DVDAuthorTask] WARN: Previous sector: 2.026 - 2.026 [DVDAuthorTask] WARN: Current sector: 2.157 - 2.157 [DVDAuthorTask] WARN: Discontinuity of 11755 in audio channel 8; please remultiplex input. [DVDAuthorTask] WARN: Previous sector: 2.157 - 2.157 [DVDAuthorTask] WARN: Current sector: 2.288 - 2.288 [DVDAuthorTask] WARN: Discontinuity of 11755 in audio channel 8; please remultiplex input. [DVDAuthorTask] WARN: Previous sector: 2.288 - 2.288 [DVDAuthorTask] WARN: Current sector: 2.418 - 2.418 [DVDAuthorTask] WARN: Discontinuity of 11755 in audio channel 8; please remultiplex input. [DVDAuthorTask] WARN: Previous sector: 2.418 - 2.418 [DVDAuthorTask] WARN: Current sector: 2.549 - 2.549 [DVDAuthorTask] WARN: Discontinuity of 9404 in audio channel 8; please remultiplex input. [DVDAuthorTask] WARN: Previous sector: 2.549 - 2.549 [DVDAuthorTask] WARN: Current sector: 2.653 - 2.653 [DVDAuthorTask] WARN: Discontinuity of 11756 in audio channel 8; please remultiplex input. [DVDAuthorTask] WARN: Previous sector: 2.653 - 2.653 [DVDAuthorTask] WARN: Current sector: 2.784 - 2.784 [DVDAuthorTask] WARN: Discontinuity of 11755 in audio channel 8; please remultiplex input. [DVDAuthorTask] WARN: Previous sector: 2.784 - 2.784 [DVDAuthorTask] WARN: Current sector: 2.915 - 2.915 [DVDAuthorTask] WARN: Discontinuity of 11755 in audio channel 8; please remultiplex input. [DVDAuthorTask] WARN: Previous sector: 2.915 - 2.915 [DVDAuthorTask] WARN: Current sector: 3.045 - 3.045 [DVDAuthorTask] WARN: Discontinuity of 11755 in audio channel 8; please remultiplex input. [DVDAuthorTask] WARN: Previous sector: 3.045 - 3.045 [DVDAuthorTask] WARN: Current sector: 3.176 - 3.176 [DVDAuthorTask] WARN: Discontinuity of 11755 in audio channel 8; please remultiplex input. [DVDAuthorTask] WARN: Previous sector: 3.176 - 3.176 [DVDAuthorTask] WARN: Current sector: 3.306 - 3.306 [DVDAuthorTask] WARN: Discontinuity of 9404 in audio channel 8; please remultiplex input. [DVDAuthorTask] WARN: Previous sector: 3.306 - 3.306 [DVDAuthorTask] WARN: Current sector: 3.411 - 3.411 [DVDAuthorTask] WARN: Discontinuity of 11755 in audio channel 8; please remultiplex input. [DVDAuthorTask] WARN: Previous sector: 3.411 - 3.411 [DVDAuthorTask] WARN: Current sector: 3.542 - 3.542 [DVDAuthorTask] WARN: Discontinuity of 11755 in audio channel 8; please remultiplex input. [DVDAuthorTask] WARN: Previous sector: 3.542 - 3.542 [DVDAuthorTask] WARN: Current sector: 3.672 - 3.672 [DVDAuthorTask] WARN: Discontinuity of 11755 in audio channel 8; please remultiplex input. [DVDAuthorTask] WARN: Previous sector: 3.672 - 3.672 [DVDAuthorTask] WARN: Current sector: 3.803 - 3.803 [DVDAuthorTask] WARN: Discontinuity of 11755 in audio channel 8; please remultiplex input. [DVDAuthorTask] WARN: Previous sector: 3.803 - 3.803 [DVDAuthorTask] WARN: Current sector: 3.933 - 3.933 [DVDAuthorTask] WARN: Discontinuity of 11756 in audio channel 8; please remultiplex input. [DVDAuthorTask] WARN: Previous sector: 3.933 - 3.933 [DVDAuthorTask] WARN: Current sector: 4.064 - 4.064 [DVDAuthorTask] WARN: Discontinuity of 11755 in audio channel 8; please remultiplex input. [DVDAuthorTask] WARN: Previous sector: 4.064 - 4.064 [DVDAuthorTask] WARN: Current sector: 4.195 - 4.195 [DVDAuthorTask] WARN: Discontinuity of 9404 in audio channel 8; please remultiplex input. [DVDAuthorTask] WARN: Previous sector: 4.195 - 4.195 [DVDAuthorTask] WARN: Current sector: 4.299 - 4.299 [DVDAuthorTask] WARN: Discontinuity of 11755 in audio channel 8; please remultiplex input. [DVDAuthorTask] WARN: Previous sector: 4.299 - 4.299 [DVDAuthorTask] WARN: Current sector: 4.430 - 4.430 [DVDAuthorTask] WARN: Discontinuity of 11755 in audio channel 8; please remultiplex input. [DVDAuthorTask] WARN: Previous sector: 4.430 - 4.430 [DVDAuthorTask] WARN: Current sector: 4.560 - 4.560 [DVDAuthorTask] WARN: Discontinuity of 11755 in audio channel 8; please remultiplex input. [DVDAuthorTask] WARN: Previous sector: 4.560 - 4.560 [DVDAuthorTask] WARN: Current sector: 4.691 - 4.691 [DVDAuthorTask] WARN: Discontinuity of 11755 in audio channel 8; please remultiplex input. [DVDAuthorTask] WARN: Previous sector: 4.691 - 4.691 [DVDAuthorTask] WARN: Current sector: 4.822 - 4.822 [DVDAuthorTask] WARN: Discontinuity of 11755 in audio channel 8; please remultiplex input. [DVDAuthorTask] WARN: Previous sector: 4.822 - 4.822 [DVDAuthorTask] WARN: Current sector: 4.952 - 4.952 [DVDAuthorTask] WARN: Discontinuity of 9404 in audio channel 8; please remultiplex input. [DVDAuthorTask] WARN: Previous sector: 4.952 - 4.952 [DVDAuthorTask] WARN: Current sector: 5.057 - 5.057 [DVDAuthorTask] [DVDAuthorTask] INFO: Video pts = 0.120 .. 0.880 [DVDAuthorTask] INFO: Audio[8] pts = 0.120 .. 5.057 [DVDAuthorTask] STAT: VOBU 2 at 0MB, 1 PGCS [DVDAuthorTask] [DVDAuthorTask] INFO: Generating VMGM with the following video attributes: [DVDAuthorTask] INFO: MPEG version: mpeg2 [DVDAuthorTask] INFO: TV standard: pal [DVDAuthorTask] INFO: Aspect ratio: 4:3 [DVDAuthorTask] INFO: Resolution: 720x576 [DVDAuthorTask] INFO: Audio ch 0 format: mp2/2ch, 48khz 20bps [DVDAuthorTask] [DVDAuthorTask] STAT: fixed 2 VOBUS child has terminated pipes closed resident task finished: execute: 0 growisofs -Z /dev/sr0 -dvd-compat -dvd-video -publisher Dreambox -V Dreambox DVD record /hdd/movie/tmp/20100703075226/dvd poll: unhandled POLLERR/HUP/NVAL for fd 66(16) [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 3540193 bytes for cache used It's now Sat Jul 3 09:55:47 2010 next real activation is Sun Jul 4 02:00:01 2010 [timer.py] next activation: 1278143847 (in 99992 ms) nr_read 188263 nr_write 114408 sum 302671 prev_sum 298735 hdd was accessed since previous check! [IDLE] 0 600 False It's now Sat Jul 3 09:56:19 2010 next real activation is Sat Jul 3 11:54:40 2010 [timer.py] next activation: 1278143879 (in 99990 ms) It's now Sat Jul 3 09:56:23 2010 [timer.py] next activation: 1278143883 (in 99993 ms) [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 3540193 bytes for cache used nr_read 188263 nr_write 114408 sum 302671 prev_sum 302671 hdd IDLE! [IDLE] 59.9999940395 600 False It's now Sat Jul 3 09:57:27 2010 next real activation is Sun Jul 4 02:00:01 2010 [timer.py] next activation: 1278143947 (in 99991 ms) [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 3540193 bytes for cache used It's now Sat Jul 3 09:57:59 2010 next real activation is Sat Jul 3 11:54:40 2010 [timer.py] next activation: 1278143979 (in 99991 ms) It's now Sat Jul 3 09:58:03 2010 [timer.py] next activation: 1278143983 (in 99994 ms) nr_read 188263 nr_write 114408 sum 302671 prev_sum 302671 hdd IDLE! [IDLE] 119.99998498 600 False [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 3540193 bytes for cache used It's now Sat Jul 3 09:59:07 2010 next real activation is Sun Jul 4 02:00:01 2010 [timer.py] next activation: 1278144047 (in 99991 ms) nr_read 188263 nr_write 114408 sum 302671 prev_sum 302671 hdd IDLE! [IDLE] 179.999973059 600 False [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 3539332 bytes for cache used It's now Sat Jul 3 09:59:39 2010 next real activation is Sat Jul 3 11:54:40 2010 [timer.py] next activation: 1278144079 (in 99991 ms) It's now Sat Jul 3 09:59:43 2010 [timer.py] next activation: 1278144083 (in 99994 ms) nr_read 188263 nr_write 114408 sum 302671 prev_sum 302671 hdd IDLE! [IDLE] 240.000098944 600 False [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 3524335 bytes for cache used It's now Sat Jul 3 10:00:47 2010 next real activation is Sun Jul 4 02:00:01 2010 [timer.py] next activation: 1278144147 (in 99991 ms) nr_read 188263 nr_write 114408 sum 302671 prev_sum 302671 hdd IDLE! [IDLE] 299.99998188 600 False It's now Sat Jul 3 10:01:19 2010 next real activation is Sat Jul 3 11:54:40 2010 [timer.py] next activation: 1278144179 (in 99991 ms) It's now Sat Jul 3 10:01:23 2010 [timer.py] next activation: 1278144183 (in 99994 ms) [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 3524335 bytes for cache used HDMI: hotplug handler! HDMI: no device attached HDMI: hotplug handler! set sb to 3(0) action -> StandbyActions power leave standby set input to 0 set fb to 2(0) using 50.00Hz as MonitorRefreshRate SET FORMAT: display[0], format=18 HDMI detected HDMI mode use EDID to detect colorspace using colorspace: 1 bcm_video_analog_port_setup (fmt=6) SET FORMAT: display[1], format=6 set current avs auto aspect to 16:9 disable wss on display 0 set wss 7 on display 1 set sb to 3(1) set mute 0 (001) 0 cannot open /proc/stb/audio/j1_mute(No such file or directory) playing 1:0:1:2EE3:441:1:C00000:0:0:0: not pauseable. RemovePopup, id = ZapError allocate channel.. 0441:0001 opening frontend 0 alps_bsbe2 is in normal mode now [eDVBCAService] new channel 0x11097a18! (0)tune RotorCmd ffffffff, lastRotorCmd ffffffff prepare_sat System 0 Freq 12187500 Pol 0 SR 27500000 INV 2 FEC 3 orbpos 192 system 0 modulation 1 pilot 2, rolloff 0 tuning to 1587 mhz OURSTATE: tuning allocate Channel: res 0 [eDVBCIInterfaces] addPMTHandler 1:0:1:2EE3:441:1:C00000:0:0:0: allocate demux setLCDBrightness 25 [SEC] set static current limiting set sequence pos 3 set sequence pos 4 [SEC] setVoltage 2 [SEC] sleep 200ms [SEC] invalidate current switch params [SEC] sendDiseqc: e00000(DiSEqC reset) [SEC] sleep 50ms [SEC] sendDiseqc: e00003(DiSEqC peripherial power on) [SEC] sleep 150ms [SEC] sendDiseqc: e01038f3 [SEC] sleep 50ms set sequence pos 3 [SEC] setTone 1 [SEC] sleep 10ms [SEC] update current switch params [SEC] startTuneTimeout 5000 [SEC] setFrontend 1 setting frontend 0 [SEC] sleep 500ms (0)fe event: status 0, inversion off, m_tuning 1 (0)fe event: status 1, inversion off, m_tuning 2 (0)fe event: status 3, inversion off, m_tuning 3 (0)fe event: status 1f, inversion off, m_tuning 4 OURSTATE: ok [eDVBCAService] channel 0x11097a18 running [eDVBLocalTimerHandler] channel 0x11097a18 running no version filtering 0014: 70 00 00 00 00 00 mask: fc 00 00 00 00 00 mode: 00 00 00 00 00 00 [eEPGCache] channel 0x11097a18 running stop release channel timer no version filtering 0012: 4e 2e e3 00 00 00 mask: ff ff ff 00 00 00 mode: 00 00 00 00 00 00 ok ... now we start!! no version filtering 0000: 00 00 00 00 00 00 mask: ff 00 00 00 00 00 mode: 00 00 00 00 00 00 eventNewProgramInfo 0 0 have 1 video stream(s) (00a3), and 1 audio stream(s) (006a), and the pcr pistart pcr0 on dmx 0 pid:a3 index 5 d is 00a3, and the text pid is 0069 alstart audio on dmx 0 pid:6a laudio xpt start ocsync is off so we enable it atedemux-index 0 pcr0pid a3 using 5 as pcr0 pidchannel demux disable teletext subAC3 titles daudio: decoder start 0 ecoder state: play, vpid=163, apid=106 DMX_SET_PES_FILTER(0xa3) - pcr - ok DEMUX_START - pcr - ok DMX_SET_PES_Fvideo delay 0 (0 ms) Itotal video delay: 0 (0 ms) LTER(0x6a) - audio - ok DEMUX_START - audio - ok Astart video0 on dmx 0 pid:a3 UDIOtotal video delay: 0 (0 ms) _SET_BYPASS(0) - ok AUDIO_PAUSE - ok AUDIO_PLAY - [EPGC] next update in 2 sec ok Video DevVIDEO0: start decode ice: /dev/dvb/adapter0/video0 demux device: /dev/dvb/adapter0/demux0 VIDEO_SET_STREAMTYPE 0 - ok DMX_SET_PES_FILTER(0xa3) - video - ok DEMUX_START - video - ok VIDEO_FREEZE - ok VIDEO_PLAY - ok DMX_SET_PES_FILTER(0x69) - ttx - ok DEMUX_START - ttx - ok VIDEO_SLOWMOTION(0) - ok VIDEO_FAST_FORWARD(0) - ok VIDEO_CONTINUE - ok AUDIO_CONTINUE - ok not pauseable. ch0: lock -+ 1/2 TID 4e RAP first pts 0x109377b3a, stc 0x109377886, pcr valid RAP sampling rate info isr + 1/1 TID 00 done! no version filtering 002c: 02 2e e3 00 00 00 mask: ff ff ff 00 00 00 mode: 00 00 00 00 00 00 doing version filtering 0000: 00 00 00 09 00 00 mask: ff 00 00 3f VIDEO0: first pts 0x1093838a6 00 00 mode: 00 00 00 3e 00 00 [SEC] set dynamic current limiting enable tsm0 + 1/1 TID 02 done! eventNewProgramInfo 0 0 have 1 video stream(s) (00a3), and 2 audio stream(s) (0068, 006a), and the pcr pid is 00a3, and the text pid is 0069 decoder state: play, vpid=163, apid=106 [eDVBCAService] new service 1:0:1:2EE3:441:1:C00000:0:0:0: [eDVBCAService] add demux 0 to slot 0 service 1:0:1:2EE3:441:1:C00000:0:0:0: [eDVBCIInterfaces] gotPMT demux 0 mask 01 prevhash 00000000 [eDVBCAService] send 59 bytes 9f 80 32 37 03 2e e3 13 00 13 01 81 08 00 c0 00 00 04 41 00 01 82 02 01 00 84 02 00 2c 02 00 a3 00 00 03 00 68 00 00 05 00 6c 00 00 06 00 69 00 00 06 00 6a 00 00 86 00 6d 00 00 doing version filtering 002c: 02 2e e3 13 00 00 mask: ff ff ff 3f 00 00 mode: 00 00 00 3e 00 00 ++ 2/2 TID 4e done! doing version filtering 0012: 4e 2e e3 2b 00 00 mask: ff ff ff 3f 00 00 mode: 00 00 00 3e 00 00 sdt update done! [EPGC] start caching events(1278144116) action -> InfobarMenuActions mainMenu loading mainmenu XML... TimerEdit TimerEditList PluginBrowser PluginBrowser reused converter! reused converter! allocating new converter! allocating new converter! ERROR reading section - Value too large for defined data type poll: unhandled POLLERR/HUP/NVAL for fd 32(8) action -> OkCancelActions ok okbuttonClick reused converter! reused converter! [eDVBLocalTimerHandler] diff is 20 [eDVBLocalTimerHandler] diff < 120 .. use Transponder Time [eDVBLocalTimerHandler] update RTC [eDVBLocalTimerHandler] time update to 10:02:20 [eDVBLocalTimerHandler] m_time_difference is 20 [eDVBLocalTimerHandler] set Linux Time [EPGC] start cleanloop [EPGC] stop cleanloop [EPGC] 3524309 bytes for cache used ERROR reading section - Value too large for defined data type poll: unhandled POLLERR/HUP/NVAL for fd 32(8) [EPGC] abort non avail schedule other reading [EPGC] abort non avail viasat reading [EPGC] nownext finished(1278144143) action -> WizardActions ok node: node: config[titlesetmode].setValue(multi) config[name].setValue(Dreambox DVD record) config[menutemplate].setValue(/usr/lib/enigma2/python/Plugins/Extensions/DVDBurn/Thumbs_menu_clouds.ddvdm.xml) config[authormode].setValue(menu_linked) config[dataformat].setValue(iso9660_4) config[vmgm].setValue(/usr/lib/enigma2/python/Plugins/Extensions/DVDBurn/vmgmdream.mpg) config[output].setValue(dvd) config[isopath].setValue(/media/hdd/movie/) node: node: [xmlGetTitleNodeRecursive] -1 [] xmlGetTitleNodeRecursive subnode: node: node: node: config[offset_thumb].setValue((-1, 0)) config[fontface_title].setValue(/usr/share/fonts/nmsbd.ttf) config[next_page_text].setValue(»»») config[offset_headline].setValue((-1, 40)) config[titleformat].setValue($t) config[cols].setValue(2) config[fontface_headline].setValue(/usr/share/fonts/nmsbd.ttf) config[color_highlight].setValue([128, 0, 0]) config[rows].setValue(2) config[dimensions].setValue((720, 576)) config[space_rows].setValue(24) config[margin_right].setValue(48) config[subtitleformat].setValue($d) config[offset_title].setValue((-1, 144)) config[fontsize_subtitle].setValue(12) config[fontsize_title].setValue(18) config[thumb_size].setValue((180, 144)) config[menuaudio].setValue(/usr/lib/enigma2/python/Plugins/Extensions/DVDBurn/silence.mp2) config[thumb_border].setValue(2) config[menubg].setValue(/usr/lib/enigma2/python/Plugins/Extensions/DVDBurn/dreamdvd_clouds.jpg) config[fontsize_headline].setValue(46) config[space_cols].setValue(24) config[color_button].setValue([8, 0, 0]) config[prev_page_text].setValue(«««) config[margin_top].setValue(100) config[margin_left].setValue(48) config[color_headline].setValue([128, 0, 0]) config[margin_bottom].setValue(48) config[fontface_subtitle].setValue(/usr/share/fonts/nmsbd.ttf) config[offset_subtitle].setValue((-1, 164)) node: updateSize: 0 MAX_DL: 8050 MAX_SL: 4380 reused converter! reused converter! allocating new converter! ERROR reading section - Value too large for defined data type poll: unhandled POLLERR/HUP/NVAL for fd 32(8) action -> MovieSelectionActions contextMenu type(job): Process.DVDJob: VIDEO0: dst_left, dst_top, dst_width and dst_height is 0.. reset to defaults! set current avs auto aspect to 16:9 disable wss on display 0 set wss 7 on display 1 set sb to 3(1) action -> WizardActions ok allocating new converter! allocating new converter! reused converter! allocating new converter! reused converter! allocating new converter! reused converter! allocating new converter! VIDEO0: dst_left, dst_top, dst_width and dst_height is 0.. reset to defaults! set current avs auto aspect to 16:9 disable wss on display 0 set wss 7 on display 1 set sb to 3(1) [EPGC] schedule finished(1278144153) [EPGC] stop caching events(1278144153) [EPGC] next update in 60 min no ancillary data in audio stream... abort radiotext pes parser nr_read 188263 nr_write 114408 sum 302671 prev_sum 302671 hdd IDLE! [IDLE] 380.009041071 600 False action -> ColorActions red user kill(SIGKILL) console App pipes closed >>> Error: [] job completed with [] in not retrying job. action -> MsgBoxActions ok action -> SetupActions cancel action -> OkCancelActions cancel It's now Sat Jul 3 10:02:47 2010 next real activation is Sun Jul 4 02:00:01 2010 [timer.py] next activation: 1278144267 (in 99982 ms) action -> WizardActions back action -> OkCancelActions cancel VIDEO0: dst_left, dst_top, dst_width and dst_height is 0.. reset to defaults! set current avs auto aspect to 16:9 disable wss on display 0 set wss 7 on display 1 set sb to 3(1) action -> InfobarShowHideActions hide action -> InfobarShowHideActions hide action -> GlobalActions power_down action -> GlobalActions power_up enter standby set mute 1 (001) 1 cannot open /proc/stb/audio/j1_mute(No such file or directory) stopService [eDVBCAService] free slot 0 demux 0 for service 1:0:1:2EE3:441:1:C00000:0:0:0: [eDVBCAService] free service 1:0:1:2EE3:441:1:C00000:0:0:0: decodestop pcr0 on dmx 0 pid:a3 r state: play, vpid=-1, apistop video0 on dmx 0 pid:a3 d=-1 DEMUX_STOP - pcr - ok DEMUXVIDEO0: stop decode _STOP - vVIDEO0: set blank to 1 ideo - ok VIDEO_STOaudio: decoder stop P - ok AUDIO_STOP - ok DEstop audio on dmx 0 pid:6a Maudio: xpt stop(3) Uno decoder left in sync handling so disable xpt_sync X_bcm_audio_channel_stop(3) done STOP - audio - ok AUDIO_CONTINUE - ok DEMUX_STOP - ttx - ok start release chset input to 1 aset fb to 2(0) nnel timer set sb to 3(0) reused converter! reused converter! reused converter! reused converter! setLCDBrightness 25 release cached channel (timer timeout) [eDVBCAService] remove channel 0x11097a18 [eDVBLocalTimerHandler] remove channel 0x11097a18 [eEPGCache] remove channel 0x11097a18 stop release channel timer close frontend 0 alps_bsbe2 is in powersave mode now