Ultimo 4k restarts upon recording on IPTV stream

cojie

Newbie
Hi all,

Vix latest.

Box restarting instantly when selecting recording on IPTV, recording on normal sat channels work perfectly. Up to last week it worked perfectly. I have IPTV and free sat channels populating the same channel list, epg info was attached to the IPTV channels using EChannelizer. This is driving me mad as I cannot record anything, supplier says there is no reason recording shouldnt work plus it worked for a few weeks up until this error appeared.

Log below.

Many thanks :)

"
OpenViX Enigma2 Crashlog

Crashdate = Mon Jul 30 19:44:27 2018

Creator = OpenViX
Version = 5.1
Build = 032
Dev = 005
Compiled = Jul 24 2018
Skin = slyk-1-hd/skin.xml
Component = Enigma2

Kernel CMDline = root=/dev/mmcblk0p4 rootfstype=ext4 rootflags=data=journal rootwait rw coherent_pool=2M vmalloc=622m bmem=630m@394m bmem=383m@1665m bmem=443m@2625m

ffer usage histogram (40 buffers of 188 kB)
< 99648.684> [eDVBRecordFileThread] 1: 23
< 99648.684> [eDVBRecordFileThread] 2: 22
< 99648.691> [eFilePushThreadRecorder] THREAD STOP
< 99648.693> [eDVBServicePlay] remove timeshift files
< 99648.693> [eDVBCAService] free slot 0 demux 1 for service xxxxxxxxxxxxxxxxxxxx
< 99648.693> [eDVBCAService] free service xxxxxxxxxxxxxxxx:
< 99648.694> [eBackgroundFileEraser] deleting '/media/hdd/timeshift/timeshift.6HjloU.del'
< 99648.696> [eDVBServicePlay] timeshift
< 99648.697> [eDVBServicePlay] timeshift
< 99648.697> [eTSMPEGDecoder] decoder state: play, vpid=ffffffff, apid=ffffffff
< 99648.697> [eDVBPCR0] DEMUX_STOP ok
< 99648.697> [eDVBPCR0] destroy
< 99648.697> [eDVBVideo0] DEMUX_STOP ok
< 99648.698> [eDVBVideo0] VIDEO_STOP ok
< 99648.702> [eDVBVideo0] destroy
< 99648.702> [eDVBAudio0] AUDIO_STOP ok
< 99648.731> [eDVBAudio0] DEMUX_STOP ok
< 99648.731> [eDVBAudio0] AUDIO_CONTINUE ok
< 99648.739> [eDVBAudio0] destroy
< 99648.741> [eDVBResourceManager] start release channel timer
< 99648.745> [eBackgroundFileEraser] deleting '/media/hdd/timeshift/pts_livebuffer_1.eit.del'
< 99648.745> [eBackgroundFileEraser] deleting '/media/hdd/timeshift/pts_livebuffer_1.sc.del'
< 99648.745> [eBackgroundFileEraser] deleting '/media/hdd/timeshift/pts_livebuffer_1.meta.del'
< 99648.745> [eDVBServicePlay] timeshift
< 99648.746> [eDVBServicePlay] timeshift
< 99648.747> [eDVBServicePlay] timeshift
< 99648.747> [Notifications] RemovePopup, id = ZapError
< 99648.748> [eHttpStream] Start thread
< 99648.748> [eDVBServicePMTHandler] alloc PVR
< 99648.748> [eDVBLocalTimerHandler] remove channel 0x12400f8
< 99648.748> [eEPGCache] remove channel 0x12400f8
< 99648.748> [eEPGCache] abort caching events !!
< 99648.750> [eDVBChannel] getDemux cap=00
< 99648.750> [eDVBResourceManager] allocate demux cap=00
< 99648.750> [eDVBResourceManager] allocating demux adapter=0, demux=22, source=-1 fesource=-1
< 99648.750> [eDVBDemux] open demux /dev/dvb/adapter0/demux22
< 99648.750> [eDVBTSTools] setSource loading streaminfo for http://xxxxxxxxxxxxxxxxxxxxxx.ts
< 99648.750> [eDVBDemux] open dvr /dev/dvb/adapter0/dvr22
< 99648.750> [eDVBServicePlay] cutfile not found!
< 99648.750> [eDVBServicePlay] no cue sheet
< 99648.751> [setIoPrio] best-effort level 0 ok
< 99648.751> [eDVBLocalTimerHandler] channel 0x12400f8 running
< 99648.751> [eFilePushThread] START thread
< 99648.751> [eDVBChannel] getDemux cap=00
< 99648.751> [eDVBChannel] no cue sheet. forcing normal play
< 99648.751> [eDVBDemux] open demux /dev/dvb/adapter0/demux22
< 99648.751> [eDVBSectionReader] DMX_SET_FILTER pid=20
< 99648.752> [eEPGCache] channel 0x12400f8 running
< 99648.752> [eDVBChannel] getDemux cap=00
< 99648.752> [eDVBDemux] open demux /dev/dvb/adapter0/demux22
< 99648.752> [eDVBDemux] open demux /dev/dvb/adapter0/demux22
< 99648.752> [eDVBDemux] open demux /dev/dvb/adapter0/demux22
< 99648.752> [eDVBDemux] open demux /dev/dvb/adapter0/demux22
< 99648.752> [eDVBDemux] open demux /dev/dvb/adapter0/demux22
< 99648.752> [eDVBDemux] open demux /dev/dvb/adapter0/demux22
< 99648.752> [eDVBDemux] open demux /dev/dvb/adapter0/demux22
< 99648.753> [eDVBDemux] open demux /dev/dvb/adapter0/demux22
< 99648.753> [eDVBDemux] open demux /dev/dvb/adapter0/demux22
< 99648.753> [eDVBDemux] open demux /dev/dvb/adapter0/demux22
< 99648.753> [eDVBDemux] open demux /dev/dvb/adapter0/demux22
< 99648.753> [eDVBDemux] open demux /dev/dvb/adapter0/demux22
< 99648.753> [eDVBDemux] open demux /dev/dvb/adapter0/demux22
< 99648.753> [eDVBServicePMTHandler] ok ... now we start!!
< 99648.753> [eEPGCache] next update in 2 sec
< 99648.753> [eDVBDemux] open demux /dev/dvb/adapter0/demux22
< 99648.754> [eDVBSectionReader] DMX_SET_FILTER pid=0
< 99648.762> [eDVBDemux] open demux /dev/dvb/adapter0/demux22
< 99648.762> [eDVBSectionReader] DMX_SET_FILTER pid=18
< 99648.763> [Notifications] RemovePopup, id = ZapError
< 99648.763> [Notifications] RemovePopup, id = Parental control
< 99649.001> [eFilePushThread] wait for driver eof timeout
< 99649.252> [eFilePushThread] wait for driver eof timeout
< 99649.407> [eHttpStream] openUrl: redirecting to: http://xxxxxxxxxxxxxxxxxxxxxxxxxxxx...HWkFaVldAGl4VBhVJGwxZWl8WV0ptRQhUQAtBCQADAUBE
< 99649.502> [eFilePushThread] wait for driver eof timeout
< 99649.518> [eHttpStream] Thread end connection
< 99649.752> [eFilePushThread] wait for driver eof timeout
< 99649.753> [eDVBServicePMTHandler] PATready
< 99649.753> [eDVBServicePMTHandler] use single pat entry!
< 99649.753> [eDVBServicePMTHandler] use pmtpid 1000 for service_id 0001
< 99649.753> [eDVBDemux] open demux /dev/dvb/adapter0/demux22
< 99649.754> [eDVBSectionReader] DMX_SET_FILTER pid=4096
< 99649.754> [eDVBDemux] open demux /dev/dvb/adapter0/demux22
< 99649.754> [eDVBSectionReader] DMX_SET_FILTER pid=0
< 99649.755> [eDVBServicePlay] eventNewProgramInfo timeshift_enabled=0 timeshift_active=0
< 99649.755> [eDVBServicePlay] have 1 video stream(s) (0100), and 1 audio stream(s) (0101), and the pcr pid is 0100, and the text pid is ffffffff
< 99649.758> [eTSMPEGDecoder] decoder state: play, vpid=0100, apid=0101
< 99649.762> [eDVBAudio0] DMX_SET_PES_FILTER pid=0x0101 ok
< 99649.762> [eDVBAudio0] DEMUX_START ok
< 99649.762> [eDVBAudio0] AUDIO_SET_BYPASS bypass=8 ok
< 99649.771> [eDVBAudio0] AUDIO_PAUSE ok
< 99649.774> [eDVBAudio0] AUDIO_PLAY ok
< 99649.780> [eDVBVideo] Video Device: /dev/dvb/adapter0/video0
< 99649.781> [eDVBVideo] demux device: /dev/dvb/adapter0/demux22
< 99649.785> [eDVBVideo0] VIDEO_SET_STREAMTYPE 1 - ok
< 99649.789> [eDVBVideo0] DMX_SET_PES_FILTER pid=0x0100 ok
< 99649.789> [eDVBVideo0] DEMUX_START ok
< 99649.789> [eDVBVideo0] VIDEO_FREEZE ok
< 99649.793> [eDVBVideo0] VIDEO_PLAY ok
< 99649.802> [eDVBVideo0] VIDEO_SLOWMOTION 0 ok
< 99649.806> [eDVBVideo0] VIDEO_FAST_FORWARD 0 ok
< 99649.811> [eDVBVideo0] VIDEO_CONTINUE ok
< 99649.815> [eDVBAudio0] AUDIO_CONTINUE ok
< 99649.823> [eDVBTeletextParser] Starting!
< 99649.823> [eDVBTeletextParser] disable teletext subtitles page ffffffffffffffff (und)
< 99649.823> [eDVBPESReader] Created. Opening demux
< 99649.823> [eDVBDemux] open demux /dev/dvb/adapter0/demux22
< 99649.824> [eDVBTeletextParser] created teletext subtitle PES reader!
< 99649.824> [eDVBPESReader] Created. Opening demux
< 99649.824> [eDVBDemux] open demux /dev/dvb/adapter0/demux22
< 99649.824> [eDVBTeletextParser] starting PES reader on pid=ffffffff
< 99649.824> [eDVBServicePlay] timeshift
< 99649.825> [eDVBServicePlay] timeshift
< 99649.825> [eDVBServicePlay] timeshift
< 99649.839> [eDVBDemux] open demux /dev/dvb/adapter0/demux22
< 99649.839> [eDVBSectionReader] DMX_SET_FILTER pid=4096
< 99650.138> [eDVBVideo0] VIDEO_GET_EVENT FRAME_RATE_CHANGED 50000 fps
< 99650.481> [eInputDeviceInit] 1 160 1
< 99650.483> [InfoBarGenerics] KEY: 352 OK
< 99650.483> [ActionMap] Keymap 'OkCancelActions' -> Unknown action 'ok'! (Typo in keymap?)
< 99650.606> [eInputDeviceInit] 0 160 1
< 99650.608> [InfoBarGenerics] KEY: 352 OK
< 99650.608> [ActionMap] Keymap 'OkCancelActions' -> Action = 'OK'
< 99650.621> [eDVBServicePlay] timeshift
< 99650.640> [VideoHardware] setting aspect: 16:9
< 99650.640> [VideoHardware] setting wss: auto
< 99650.640> [VideoHardware] setting policy: panscan
< 99650.640> [VideoHardware] setting policy2: letterbox
< 99650.753> [Timeshift] unable to activate, due being on a stream.
< 99650.754> [eEPGCache] start caching events(1532976264)
< 99650.754> [eDVBSectionReader] DMX_SET_FILTER pid=211
< 99650.754> [eDVBSectionReader] DMX_SET_FILTER pid=561
< 99650.754> [eDVBSectionReader] DMX_SET_FILTER pid=3842
< 99650.755> [eDVBSectionReader] DMX_SET_FILTER pid=3003
< 99650.755> [eDVBSectionReader] DMX_SET_FILTER pid=18
< 99650.756> [eDVBSectionReader] DMX_SET_FILTER pid=18
< 99650.756> [eDVBSectionReader] DMX_SET_FILTER pid=18
< 99650.757> [eDVBSectionReader] DMX_SET_FILTER pid=700
< 99650.758> [eDVBSectionReader] DMX_SET_FILTER pid=700
< 99650.758> [eDVBSectionReader] DMX_SET_FILTER pid=5000
< 99650.759> [eDVBSectionReader] DMX_SET_FILTER pid=5000
< 99651.196> [eInputDeviceInit] 1 ae 1
< 99651.198> [InfoBarGenerics] KEY: 174 EXIT
< 99651.198> [ActionMap] Keymap 'InfobarShowHideActions' -> Action = 'hide'
< 99651.200> [eDVBVideo0] VIDEO_GET_EVENT FRAME_RATE_CHANGED 25000 fps
< 99651.321> [eInputDeviceInit] 0 ae 1
< 99651.322> [InfoBarGenerics] KEY: 174 EXIT
< 99651.641> [eInputDeviceInit] 1 166 1
< 99651.642> [InfoBarGenerics] KEY: 358 INFO
< 99651.701> [VideoHardware] setting aspect: 16:9
< 99651.702> [VideoHardware] setting wss: auto
< 99651.702> [VideoHardware] setting policy: panscan
< 99651.702> [VideoHardware] setting policy2: letterbox
< 99651.750> [eDVBFrontend] close frontend 9
< 99651.873> [eInputDeviceInit] 0 166 1
< 99651.874> [InfoBarGenerics] KEY: 358 INFO
< 99651.882> [ActionMap] Keymap 'InfobarEPGActions' -> Action = 'InfoPressed'
< 99651.898> [Skin] processing screen GraphicalEPGPIG:
< 99651.913> [GUISkin] warning, skin is missing element number in <class 'Screens.EpgSelection.EPGSelection'>
< 99651.913> [GUISkin] warning, skin is missing element jump in <class 'Screens.EpgSelection.EPGSelection'>
< 99651.914> [GUISkin] warning, skin is missing element lab1 in <class 'Screens.EpgSelection.EPGSelection'>
< 99651.915> [GUISkin] warning, skin is missing element primetime in <class 'Screens.EpgSelection.EPGSelection'>
< 99651.915> [GUISkin] warning, skin is missing element timeline2 in <class 'Screens.EpgSelection.EPGSelection'>
< 99651.915> [GUISkin] warning, skin is missing element timeline3 in <class 'Screens.EpgSelection.EPGSelection'>
< 99651.915> [GUISkin] warning, skin is missing element timeline0 in <class 'Screens.EpgSelection.EPGSelection'>
< 99651.915> [GUISkin] warning, skin is missing element timeline1 in <class 'Screens.EpgSelection.EPGSelection'>
< 99651.915> [GUISkin] warning, skin is missing element timeline4 in <class 'Screens.EpgSelection.EPGSelection'>
< 99651.915> [GUISkin] warning, skin is missing element timeline5 in <class 'Screens.EpgSelection.EPGSelection'>
< 99651.917> [GUISkin] warning, skin is missing element change_bouquet in <class 'Screens.EpgSelection.EPGSelection'>
< 99651.918> [Skin] Attribute not implemented: backgroundColour value: skytitlebackground
< 99651.920> [Skin] Attribute not implemented: EntryFontWrap value: no
< 99651.920> [GUISkin] warning, skin is missing element page in <class 'Screens.EpgSelection.EPGSelection'>
< 99651.924> [gAccel] alloc failed
< 99651.924> [gSurface] ERROR: accelAlloc failed
< 99652.004> [Skin] processing screen GraphicalEPGPIG_summary:
< 99652.905> [eInputDeviceInit] 1 18f 1
< 99652.906> [InfoBarGenerics] KEY: 399 GREEN
< 99653.029> [eInputDeviceInit] 0 18f 1
< 99653.030> [InfoBarGenerics] KEY: 399 GREEN
< 99653.030> [ActionMap] Keymap 'EPGSelectActions' -> Unknown action 'timerAdd'! (Typo in keymap?)
< 99653.030> [ActionMap] Keymap 'ColorActions' -> Action = 'green'
< 99653.033> menu_path: Timer entry
< 99653.037> [Skin] processing screen TimerEntry:
< 99653.053> [GUISkin] warning, skin is missing element ok in <class 'Screens.TimerEntry.TimerEntry'>
< 99653.054> [Skin] processing screen NumericalTextInputHelpDialog:
< 99653.067> [GUISkin] warning, skin is missing element cancel in <class 'Screens.TimerEntry.TimerEntry'>
< 99653.083> [Skin] processing screen SimpleSummary:
< 99653.744> [eInputDeviceInit] 1 18f 1
< 99653.746> [InfoBarGenerics] KEY: 399 GREEN
< 99653.746> [ActionMap] Keymap 'SetupActions' -> Action = 'save'
< 99653.813> [TimerSanityCheck] Exception - timer does not have to be checked!
< 99653.813> [Timer] Record RecordTimerEntry(name=Inside the Tour, begin=Mon Jul 30 19:30:00 2018, serviceref=xxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxts:MUTV, justplay=False, isAutoTimer=False)
< 99653.813> [RecordTimer] activating state 1
< 99653.814> [RecordTimer] Found enough free space to record
< 99653.815> [RecordTimer] Filename calculated as: '/media/hdd/movie/20180730 1930 - MUTV - Inside the Tour'
< 99653.815> [Navigation] recording service: xxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxx.ts:MUTV
< 99653.816> [eHttpStream] Start thread
< 99653.816> [eDVBServicePMTHandler] alloc PVR
< 99653.816> [eDVBChannel] getDemux cap=00
< 99653.816> [eDVBResourceManager] allocate demux cap=00
< 99653.816> [eDVBResourceManager] allocating demux adapter=0, demux=21, source=-1 fesource=-1
< 99653.816> [eDVBDemux] open demux /dev/dvb/adapter0/demux21
< 99653.816> [eDVBTSTools] setSource loading streaminfo for http://xxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxxx.ts
< 99653.816> [eDVBDemux] open dvr /dev/dvb/adapter0/dvr21
< 99653.816> [eDVBServiceRecord] RECORD service event 7
< 99653.816> [setIoPrio] best-effort level 0 ok
< 99653.816> [eDVBLocalTimerHandler] channel 0x13b1b78 running
< 99653.816> [eFilePushThread] START thread
< 99653.816> [eDVBChannel] getDemux cap=00
< 99653.817> [eDVBChannel] no cue sheet. forcing normal play
< 99653.817> [eDVBDemux] open demux /dev/dvb/adapter0/demux21
< 99653.817> [eDVBSectionReader] DMX_SET_FILTER pid=20
< 99653.817> [eEPGCache] channel 0x13b1b78 running
< 99653.817> [eDVBChannel] getDemux cap=00
< 99653.817> [eDVBDemux] open demux /dev/dvb/adapter0/demux21
< 99653.817> [eDVBDemux] open demux /dev/dvb/adapter0/demux21
< 99653.817> [eDVBDemux] open demux /dev/dvb/adapter0/demux21
< 99653.818> [eDVBDemux] open demux /dev/dvb/adapter0/demux21
< 99653.818> [eDVBDemux] open demux /dev/dvb/adapter0/demux21
< 99653.818> [eDVBDemux] open demux /dev/dvb/adapter0/demux21
< 99653.818> [eDVBDemux] open demux /dev/dvb/adapter0/demux21
< 99653.818> [eDVBDemux] open demux /dev/dvb/adapter0/demux21
< 99653.818> [eDVBDemux] open demux /dev/dvb/adapter0/demux21
< 99653.818> [eDVBDemux] open demux /dev/dvb/adapter0/demux21
< 99653.819> [eDVBDemux] open demux /dev/dvb/adapter0/demux21
< 99653.819> [eDVBDemux] open demux /dev/dvb/adapter0/demux21
< 99653.819> [eDVBDemux] open demux /dev/dvb/adapter0/demux21
< 99653.819> [eDVBServicePMTHandler] ok ... now we start!!
< 99653.819> [eDVBDemux] open demux /dev/dvb/adapter0/demux21
< 99653.819> [eEPGCache] next update in 2 sec
< 99653.819> [eDVBSectionReader] DMX_SET_FILTER pid=0
< 99653.819> [eDVBServiceRecord] RECORD service event 6
< 99653.820> [eDVBServiceRecord] tuned..
< 99653.820> [eDVBDemux] open demux /dev/dvb/adapter0/demux21
< 99653.820> [eDVBSectionReader] DMX_SET_FILTER pid=18
< 99653.820> [eEPGCache] saveEventToFile epg event id 5928
< 99653.821> [RecordTimer] prepare ok, waiting for begin
< 99653.821> [Trashcan] Recording(s) in progress: 1
< 99653.821> [RecordTimer] activating state 2
< 99653.822> [eDVBServiceRecord] Recording to /media/hdd/movie/20180730 1930 - MUTV - Inside the Tour.ts...
< 99653.822> [eDVBServiceRecord] start recording...
< 99653.822> [eDVBServiceRecord] getting program info failed.
< 99653.823> Traceback (most recent call last):
< 99653.823> File "/usr/lib/enigma2/python/mytest.py", line 235, in processDelay
< 99653.824> callback(*retval)
< 99653.824> File "/usr/lib/enigma2/python/Screens/EpgSelection.py", line 1082, in finishedAdd
< 99653.824> File "/usr/lib/enigma2/python/RecordTimer.py", line 1178, in record
< 99653.824> File "/usr/lib/enigma2/python/timer.py", line 200, in addTimerEntry
< 99653.825> File "/usr/lib/enigma2/python/timer.py", line 239, in calcNextActivation
< 99653.825> File "/usr/lib/enigma2/python/timer.py", line 314, in processActivation
< 99653.825> File "/usr/lib/enigma2/python/RecordTimer.py", line 938, in doActivate
< 99653.825> File "/usr/lib/enigma2/python/RecordTimer.py", line 613, in activate
< 99653.825> File "/usr/lib/enigma2/python/RecordTimer.py", line 440, in log_tuner
< 99653.825> TypeError: unsupported operand type(s) for +: 'int' and 'dict'
< 99653.825> [ePyObject] (CallObject(<bound method Session.processDelay of <__main__.Session instance at 0x90bbbc10>>,()) failed)
 
Last edited:
Back
Top