XBMC 12.2 crash when selecting a channel
#1
Hello all,

I use XBMC 12.2 on Windows 7 x64.

1) I installed the MediaPortal TV Server 1.5.0 and imported my IPTV channels in it and tested them (preview): it works like a charm
2) I installed the PVR MediaPortal addon in XBMC and enabled the Live TV.

The problem is that XBMC immediately crashes each time I select a channel to watch.

Is there anything I can do to fix this issue ?

Thank you in advance for your help Smile
Reply
#2
No debug xbmc.log = no way for us to figure out why it is crashing.
Please enable debug logging and post your xbmc.log file on http://xbmclogs.com/ and the link here.
I would like to know if it is the PVR addon itself that causes the crash or whether it crashes lateron when XBMC tries to play the actual stream.

I must say that I don't have IPTV here, so I've never had the chance to test the addon with IPTV channels.

What kind of IPTV channels are you using? UDP urls, http, rtsp?
Can you play the IPTV streams directly in XBMC or the IPTVSimple pvr addon?
Developer of the MediaPortal PVR addon and retired developer of the Argus-TV PVR-addon.
http://www.scintilla.utwente.nl/~marcelg/xbmc
Reply
#3
Another report of this issue my side Sad

After happily using MP with XBMC for quite some time (massive fan of all your hard work, margro), I've just done a fresh install of both server and clients (they're all now OpenELEC with the only Windows machine being the server), and am now experiencing this same issue. (In my case, I use Analog channels)

I'm using MP 1.5 (with the 1.4 addon) but have also tried with previous versions (including MP 1.4 and 1.23, with their applicable server addons.).

Timers work great, recordings play perfectly and I can play a recording whilst it's recording. (The XBMC machine can also access the Samba TS share fine in the XBMC File Manager).

But if I start a channel on the Channels list, I almost always get an XBMC crash-then-restart.
If it does work, then a reboot of the XBMC client box will yield the crashes from then on; until (it appears) the server is rebooted.

The full XBMC log is here

The last few lines of the log are:
Code:
21:55:06 T:2773791840   DEBUG: AddOnLog: MediaPortal PVR Client: CVTPTransceiver::ReadResponse - timeout waiting for response, retrying... (5)
21:55:06 T:2773791840    INFO: AddOnLog: MediaPortal PVR Client: Channel stream URL: rtsp://192.168.2.5/stream3.0, timeshift buffer: F:\Contents\Videos\Recorded TV\TS\live3-0.ts.tsbuffer
21:55:06 T:2773791840    INFO: AddOnLog: MediaPortal PVR Client: Creating a new TsReader...
21:55:06 T:2773791840  NOTICE: AddOnLog: MediaPortal PVR Client: CTsReader::Open(F:\Contents\Videos\Recorded TV\TS\live3-0.ts.tsbuffer)
21:55:06 T:2773791840   DEBUG: AddOnLog: MediaPortal PVR Client: Multiseat mode; need to translate 'F:\Contents\Videos\Recorded TV\TS\live3-0.ts.tsbuffer' to UNC filename.
21:55:06 T:2773791840    INFO: AddOnLog: MediaPortal PVR Client: CTsReader:TranslatePath F:\Contents\Videos\Recorded TV\TS\live3-0.ts.tsbuffer -> smb://Guest@HPPROLIANT/RecordedTV/TS/live3-0.ts.tsbuffer
21:55:06 T:2773791840   DEBUG: AddOnLog: MediaPortal PVR Client: FileReader::OpenFile() Trying to open smb://Guest@HPPROLIANT/RecordedTV/TS/live3-0.ts.tsbuffer
21:55:06 T:2773791840    INFO: AddOnLog: MediaPortal PVR Client: FileReader::OpenFile() smb://Guest@HPPROLIANT/RecordedTV/TS/live3-0.ts.tsbuffer.
21:55:06 T:2773791840   DEBUG: CSmbFile::Open - opened RecordedTV/TS/live3-0.ts.tsbuffer, fd=10000
21:55:06 T:2773791840   DEBUG: AddOnLog: MediaPortal PVR Client: OpenFile: OpenFile(smb://Guest@HPPROLIANT/RecordedTV/TS/live3-0.ts.tsbuffer) succeeded.
21:55:06 T:2773791840   DEBUG: AddOnLog: MediaPortal PVR Client: MultiFileReader: buffer file opened return code 0.
21:55:06 T:2773791840   DEBUG: CSmbFile::Open - opened RecordedTV/TS/live3-0.ts.tsbuffer1.ts, fd=10001
21:55:06 T:2773791840   DEBUG: CSmbFile::Close closing fd 10001
21:55:07 T:2773791840   DEBUG: PVRFile - Open - playback has started on filename pvr://channels/tv/All TV channels/4.pvr
21:55:07 T:2773791840   DEBUG: CDVDInputStreamPVRManager::Open - stream opened: pvr://channels/tv/All TV channels/4.pvr
21:55:07 T:2773791840  NOTICE: Creating Demuxer
21:55:07 T:2773791840   DEBUG: DllAvUtilBase: Using libavutil system library
21:55:07 T:2773791840   DEBUG: DllAvCodec: Using libavcodec system library
21:55:07 T:2773791840   DEBUG: DllAvFormat: Using libavformat system library
21:55:07 T:2773791840   DEBUG: AddOnLog: MediaPortal PVR Client: FileReader::OpenFile() Trying to open smb://Guest@HPPROLIANT/RecordedTV/TS/live3-0.ts.tsbuffer1.ts
21:55:07 T:2773791840    INFO: AddOnLog: MediaPortal PVR Client: FileReader::OpenFile() smb://Guest@HPPROLIANT/RecordedTV/TS/live3-0.ts.tsbuffer1.ts.
21:55:07 T:2773791840   DEBUG: CSmbFile::Open - opened RecordedTV/TS/live3-0.ts.tsbuffer1.ts, fd=10001
21:55:07 T:2773791840   DEBUG: AddOnLog: MediaPortal PVR Client: OpenFile: OpenFile(smb://Guest@HPPROLIANT/RecordedTV/TS/live3-0.ts.tsbuffer1.ts) succeeded.

...not very helpful, I'm afraid Confused

After this happens, Previewing channels within MP SetupTV still work fine; and in fact whilst previewing, I can browse from the freshly-crashed XBMC box to the TS folder and play the TS file of the channel being previewed!

This particular log is from a Pi; but OpenELEC (version 3.2.3 Official) on my 2 other HTPC's (one an ION_64 build of OpenELEC; the other a GENERIC build) produce the same behavior.

Looks like a similar issue as to that reported here.

So there's a possibility it's related to the Server. Or interaction between XBMC on Linux-based builds (such as OE) and the server.

The server logs don't yield much: "streaming server.Log" contains:
Code:
03-11-2013 22:17:42.893 Stream server: add timeshift  mpeg-2 transport stream stream3.0 filename:F:\Contents\Videos\Recorded TV\TS\live3-0.ts.tsbuffer
03-11-2013 22:17:42.893 Stream server: url for stream is rtsp://192.168.2.5/stream3.0
03-11-2013 22:17:43.876 Stream server:Stream server: remove stream stream3.0

My "MPFileWriter.Log" after a crash is here.

My "TVService.Log" after a crash is here. It ends like this:
Code:
[2013-11-03 22:17:40,694] [Log    ] [3        ] [DEBUG] - TVServerXBMC: OnTvServerEvent: StartTimeShifting
[2013-11-03 22:17:40,694] [Log    ] [3        ] [INFO ] - Controller: epg stop
[2013-11-03 22:17:40,694] [Log    ] [3        ] [INFO ] - card: StartTimeShifting 3 F:\Contents\Videos\Recorded TV\TS\live3-0.ts
[2013-11-03 22:17:40,694] [Log    ] [3        ] [INFO ] - card: CAM enabled : False
[2013-11-03 22:17:40,694] [Log    ] [3        ] [INFO ] - analog:SetTimeShiftFileName:F:\Contents\Videos\Recorded TV\TS\live3-0.ts
[2013-11-03 22:17:40,694] [Log    ] [3        ] [INFO ] - analog:SetTimeShiftFileName: uses .ts
[2013-11-03 22:17:40,694] [Log    ] [3        ] [INFO ] - card: WaitForFile - waiting _eventAudio & _eventVideo
[2013-11-03 22:17:42,878] [Log    ] [5        ] [INFO ] - PID seen - type = Audio
[2013-11-03 22:17:42,878] [Log    ] [5        ] [INFO ] - audioVideoEventHandler Audio
[2013-11-03 22:17:42,878] [Log    ] [5        ] [INFO ] - PID seen - type = Video
[2013-11-03 22:17:42,878] [Log    ] [5        ] [INFO ] - audioVideoEventHandler Video
[2013-11-03 22:17:42,878] [Log    ] [3        ] [INFO ] - card: WaitForFile - video and audio are seen after 2.1840038 seconds
[2013-11-03 22:17:42,893] [Log    ] [3        ] [INFO ] - user:XBMCpvrclient15 card:3 sub:0 add stream:F:\Contents\Videos\Recorded TV\TS\live3-0.ts.tsbuffer
[2013-11-03 22:17:42,893] [Log    ] [3        ] [INFO ] - RTSP: add stream stream3.0 file:F:\Contents\Videos\Recorded TV\TS\live3-0.ts.tsbuffer
[2013-11-03 22:17:42,893] [Log    ] [3        ] [INFO ] - Controller: StartTimeShifting started on card:3 to F:\Contents\Videos\Recorded TV\TS\live3-0.ts.tsbuffer
[2013-11-03 22:17:42,893] [Log    ] [3        ] [DEBUG] - CardReservation.RemoveTuneTicket: removed reservation with id=36, tuningdetails=tv:CHAN3 Freq:247259994 Channel:70 Tuner:Antenna Video:Tuner Audio:Automatic
[2013-11-03 22:17:42,893] [Log    ] [3        ] [INFO ] - Controller: XBMCpvrclient15 3 0
[2013-11-03 22:17:42,893] [Log    ] [3        ] [DEBUG] - TVServerXBMC: OnTvServerEvent: EndZapChannel
[2013-11-03 22:17:42,893] [Log    ] [3        ] [INFO ] - control2:XBMCpvrclient15 3 0
[2013-11-03 22:17:43,003] [Log    ] [3        ] [DEBUG] - TVServerXBMC: Timeshift started for channel: 'CHAN3' on device 'Hauppauge Cx23100 Tuner'
[2013-11-03 22:17:43,003] [Log    ] [3        ] [DEBUG] - TVServerXBMC: TV Server returned 'rtsp://HPProliant:554/stream3.0' as timeshift URL and F:\Contents\Videos\Recorded TV\TS\live3-0.ts.tsbuffer as timeshift file
[2013-11-03 22:17:43,003] [Log    ] [3        ] [DEBUG] - TVServerXBMC: Remote server='HPProliant'
[2013-11-03 22:17:43,018] [Log    ] [3        ] [DEBUG] - TVServerXBMC: StartTimeShifting took 19825 ms
[2013-11-03 22:17:43,018] [Log    ] [3        ] [DEBUG] - TVServerXBMC: PlayChannel 11 => URL=rtsp://192.168.2.5/stream3.0
[2013-11-03 22:17:43,143] [Log    ] [3        ] [DEBUG] - TVServerXBMC: Handling command: GetSignalQuality
[2013-11-03 22:17:43,221] [Log    ] [3        ] [DEBUG] - TVServerXBMC: Connection closed
[2013-11-03 22:17:43,221] [Log    ] [3        ] [DEBUG] - TVServerXBMC: OnTvServerEvent: EndTimeShifting
[2013-11-03 22:17:43,221] [Log    ] [3        ] [INFO ] - Controller: StopTimeShifting 3
[2013-11-03 22:17:43,221] [Log    ] [3        ] [DEBUG] - CardTuner.RequestCardStopReservation: placed reservation with id=37, user=XBMCpvrclient15
[2013-11-03 22:17:43,330] [Log    ] [3        ] [DEBUG] - CardTuner.Stop: ticket id=37, found=True
[2013-11-03 22:17:43,330] [Log    ] [3        ] [INFO ] - Stop cardid=3, ticket=37, tunestate=Idle, stopstate=Stopping
[2013-11-03 22:17:43,330] [Log    ] [3        ] [INFO ] - card Hauppauge Cx23100 Tuner: StopTimeShifting user:XBMCpvrclient15 sub:0
[2013-11-03 22:17:43,330] [Log    ] [3        ] [DEBUG] - card not IDLE - removing user: XBMCpvrclient15
[2013-11-03 22:17:43,330] [Log    ] [3        ] [DEBUG] - usermanagement.RemoveUser: XBMCpvrclient15, subch: 0 of 1, card: 3
[2013-11-03 22:17:43,330] [Log    ] [3        ] [INFO ] - user:XBMCpvrclient15 remove
[2013-11-03 22:17:43,330] [Log    ] [3        ] [INFO ] - analog: StopTimeShifting()
[2013-11-03 22:17:43,346] [Log    ] [3        ] [INFO ] - tvcard:FreeSubChannel: subchannels count 1 subch#0
[2013-11-03 22:17:43,346] [Log    ] [3        ] [INFO ] - analog subch:0 Decompose()
[2013-11-03 22:17:43,346] [Log    ] [3        ] [INFO ] - tvcard:FreeSubChannel : no subchannels present, pausing graph
[2013-11-03 22:17:43,346] [Log    ] [3        ] [INFO ] - tvcard:FreeAllSubChannels
[2013-11-03 22:17:43,346] [Log    ] [3        ] [INFO ] - analog: StopGraph state:Running
[2013-11-03 22:17:43,876] [Log    ] [3        ] [INFO ] - analog: Graph stopped
[2013-11-03 22:17:43,876] [Log    ] [3        ] [INFO ] - tvcard:FreeAllSubChannels
[2013-11-03 22:17:43,876] [Log    ] [3        ] [INFO ] - analog: StopGraph state:Stopped
[2013-11-03 22:17:43,876] [Log    ] [3        ] [INFO ] - user:XBMCpvrclient15 remove
[2013-11-03 22:17:43,876] [Log    ] [3        ] [DEBUG] - CardReservation.RemoveStopTicket: removed STOP reservation with id=37
[2013-11-03 22:17:43,876] [Log    ] [3        ] [INFO ] - Controller:Timeshifting stopped on card:3
[2013-11-03 22:17:43,876] [Log    ] [TS_File_Cleanup] [INFO ] - card: delete timeshift files F:\Contents\Videos\Recorded TV\TS\live3-0.ts
[2013-11-03 22:17:43,876] [Log    ] [3        ] [INFO ] - RTSP: remove stream stream3.0
[2013-11-03 22:17:43,876] [Log    ] [3        ] [INFO ] - Controller: epg start

I've spent most of the last two days trying to figure out what's happening, but I concede - even after previously running MP + XBMC for 6 months without incident - I'm stumped! Any help would be appreciated :-)

EDIT: So in summary: the server appears to be creating the TS buffer fine. The XBMC client has access to this file. The client can play it fine manually. Just when played from the Channels list is it failing.
Shot in the dark: How much time does the PVR client addon wait for before attempting to play this buffer file? Perhaps newer versions of XBMC (used in OE) are having a problem with the file if it's too new? Too little video data to play? Samba file-share link not fully established? (I've adjusted the 'time between channel changes' addon setting to no avail)? Or am I grasping at straws... :-)
Reply
#4
I've set up XBMC on a Windows box for further testing: under Windows (XBMC 12.2), it seems to work in order.

So only the OpenELEC boxes are having this issue... specific perhaps to the MP PVR Client addon under Linux/OE? (OE 3.2.3)?
Reply
#5
I have posted in another thread regarding this issue as well. I have 2 tuners, an older hdhomerun which tunes ota ATSC channels in the us, and an hdhomerun prime cablecard tuner. I am using mediaportal 1.5 as my backend. When watching live tv in windows on latest xbmc frodo stable, both tuners work fine. On any Linux based xbmc install(tested on ipad 3, Linux mint, and xbian), I get a crash like above poster when trying to tune the cablecard adapter. The last thing the xbmc Log file shows is starting demuxer. I've tried setting wait time in xbmc plugin to 3 seconds, setting don't stop timeshift and starting a working stream first, all to no avail. If I start the mediaportal stream on windows and attemp to tune the same channel( which i think should use the already created timeshift buffer) it also crashes. If I play the cablecard timeshift.ts file directly I don't get a crash. If I start a recording on cablecard tuner and play that it also works fine. Any ideas? Not even sure at this point whether its an xbmc or mediaportal issue.
Reply
#6
I've really no idea... I don't see anything strange in the log files, so without a crash trace I can't do much...
Developer of the MediaPortal PVR addon and retired developer of the Argus-TV PVR-addon.
http://www.scintilla.utwente.nl/~marcelg/xbmc
Reply
#7
Thanks for looking!

I'm going to try it out with today's OpenELEC 3.2.4 release and see if it's any different.

Thanks for all your hard work on this integration, margro!
Reply
#8
Getting same issue here. I have two channels that work and the rest crash XBMC. Using Openelec 3.2.4 and tried Raspbmc (same problem there too).

------------------

Update: I updated to latest nightly w/ Raspbmc and the broken channels started working, but encountered constant stuttering / buffering (even on the channels that work perfectly in 12.2).
Reply
#9
Ok, I feel compelled to let you know how it fixed this... 2 things.

1. In the PVR Add-on configuration page... change the IP address of your PC from 127.0.0.1 to the actual IP address of the PC. (this assumes you're running XBMC and mediaportal on the same PC).
2. For the SMB share... it defaults to GUEST. Windows 7 by default disables the guest account. So either enable the guest account (which I don't recommend), or make another account on the machine that has access to the shares created for the files.

This worked for me on my Windows 7 Ultimate machine (x64).

Good Luck!
Reply
#10
Thanks NonExcited. The logs weren't super useful, but your mention of the SMB share made me go look at that. In my case, somehow my configuration had reverted back to what I had originally used when I had XBMC and TV Server on the same machine. My recording and timeshift folders were set to local drives. I set them back to SMB shares and the channels started working. Very odd that I had a couple working channels.
Reply
#11
(2013-12-08, 17:28)NonExcited Wrote: For the SMB share... it defaults to GUEST. Windows 7 by default disables the guest account. So either enable the guest account (which I don't recommend), or make another account on the machine that has access to the shares created for the files.

This worked for me on my Windows 7 Ultimate machine (x64).

Good Luck!

Another Thank You! This sorted me out as well!

The kicker is that it appears whatever account you use needs Read AND WRITE permissions to the share!

So under Windows, I opened up the folder being shared (containing TS and Recordings; as specified by the TVServerXBMC Mediaportal plugin), explicitly assigned a user account to the share (I removed 'Everyone'); and provided full control (read and write) to the assigned account.

Then to make sure XBMC knew about that path and it's credentials, I opened up XBMC's 'File Manager', added this share as a source ('Add Source') by browsing to it, entered the new credentials when prompted: and boom, worked immediately thereafter.

So we're definitely dealing with an SMB Sharing issue; and it appears write access may be needed along with read.

Thank you, NonExcited!


Side-note:

@margro: after a bit of defecting to other PVR back-ends, I have to say that upon returning to MediaBrowser and your plugin, this is easily the most stable of the lot, and has the fewest 'gotchas' in my case. So thank you for the excellent job you've done in making this happen.
Reply
#12
Hi all,

I'm having no luck with one particular usb tuner (I also have a TBS6280) and only under openelec.
Once I restart the MP tv service then it'll work for a while, then the openelec computers will reset when trying to watch a live tv show,
The windows computers will continue to work though.

I disabled the usb tuner but still had a crash on the openelec box first time, then ok second time..

This is the last thing in the log before the reset:

07:36:42 T:140326169732864 NOTICE: AddOnLog: MediaPortal PVR Client: CTsReader::Open(\\APPSERVER\Timeshift\live4-1.ts.tsbuffer)
07:36:43 T:140326169732864 NOTICE: Creating Demuxer
07:36:43 T:140327541937984 ERROR: CWinSystemX11::XErrorHandler: BadDrawable (invalid Pixmap or Window parameter), type:0, serial:7311553, error_code:9, request_code:134 minor_code:4

Also had this error, but then worked ok?

07:46:18 T:140111387719424 ERROR: AddOnLog: MediaPortal PVR Client: MultiFileReader has error 0x80 in Loop 0. Try to clear SMB Cache.

I'm going to try and grab more logs - but they don't seem to show much - just something about the multiplexer not working. But, I also had that message when it did work?!

Would permission problems cause openelec to reset I wonder...
Reply
#13
(2013-12-19, 12:06)Thebluevoice Wrote: Would permission problems cause openelec to reset I wonder...

Yes, this is what was happening to us. Likewise, Windows machines were fine with only OE crashing.

Try following our suggestions above for deleting the share and re-creating it above (with permissions) and hopefully you should be sorted!
Reply
#14
(2013-12-19, 14:17)kreeturez Wrote:
(2013-12-19, 12:06)Thebluevoice Wrote: Would permission problems cause openelec to reset I wonder...

Yes, this is what was happening to us. Likewise, Windows machines were fine with only OE crashing.

Try following our suggestions above for deleting the share and re-creating it above (with permissions) and hopefully you should be sorted!

Thanks, I'll give it a go tonight, quick question though, did you find the openelec boxes would work for awhile first then start crashing? Blush
Reply
#15
(2013-12-19, 14:59)Thebluevoice Wrote:
(2013-12-19, 14:17)kreeturez Wrote:
(2013-12-19, 12:06)Thebluevoice Wrote: Would permission problems cause openelec to reset I wonder...

Yes, this is what was happening to us. Likewise, Windows machines were fine with only OE crashing.

Try following our suggestions above for deleting the share and re-creating it above (with permissions) and hopefully you should be sorted!

Thanks, I'll give it a go tonight, quick question though, did you find the openelec boxes would work for awhile first then start crashing? Blush

Yup!
Reply

Logout Mark Read Team Forum Stats Members Help
XBMC 12.2 crash when selecting a channel0