[tvmanbrt]

Hi guys,

I am using atv2 with Eden and am experiencing a rather odd issue. Some files are playing fine from the video library while other force atv box to restart after 2 seconds of playout. I debugged the issue and it seems to be following :

File playing fine has properties - video size 640x480, aspect ratio 4:3, audio codec WMA 9.2, video codec vc-1 simple/main profile

File crashing the system has properties - video size 700x400, aspect ratio 9:5 (1.81:1 displayed), audio codec WMA 9.2, video codec vc-1 simple/main profile

XBMC log shows following:

01:41:01 T:114872320 WARNING: Previous line repeats 10 times.
01:41:01 T:114872320 NOTICE: -->Python Interpreter Initialized<--
01:41:04 T:75141120 ERROR: Unable to load /private/var/stash/Applications/XBMC.frappliance/XBMCData/XBMCHome/system/players/paplayer/libsidplay2-arm-osx.so, reason: dlopen(/private/var/stash/Applications/XBMC.frappliance/XBMCData/XBMCHome/system/players/paplayer/libsidplay2-arm-osx.so, 1): image not found
01:41:04 T:75141120 ERROR: Previous line repeats 3 times.
01:41:04 T:75141120 NOTICE: DVDPlayer: Opening: mms://xxx.xxx.xxx.xxx/vod7/7407.50.wmv?sid=E4A6AD428C5EED9D8B3E809393E1A645146CDC0FF5C79BBCEFADDDF4F1B9088
01:41:04 T:75141120 WARNING: CDVDMessageQueue(player):ut MSGQ_NOT_INITIALIZED
01:41:04 T:125861888 NOTICE: Creating InputStream
01:41:04 T:125861888 NOTICE: Creating Demuxer
01:41:11 T:125861888 NOTICE: Opening video stream: 1 source: 256
01:41:11 T:125861888 NOTICE: Creating video codec with codec id: 74
01:41:11 T:125861888 NOTICE: CDVDVideoCodecFFmpeg::Open() Using codec: Windows Media Video 9
01:41:11 T:125861888 NOTICE: Creating video thread
01:41:11 T:126713856 NOTICE: running thread: video_thread
01:41:11 T:125861888 NOTICE: Opening audio stream: 0 source: 256
01:41:11 T:125861888 NOTICE: Finding audio codec for: 86024
01:41:11 T:125861888 NOTICE: Creating audio thread
01:41:11 T:127647744 NOTICE: running thread: CDVDPlayerAudio:rocess()
01:41:11 T:126713856 NOTICE: fps: 25.000000, pwidth: 640, pheight: 480, dwidth: 640, dheight: 480
01:41:11 T:127647744 NOTICE: Creating audio device with codec id: 86024, channels: 2, sample rate: 32000, no pass-through
01:41:11 T:126713856 WARNING: CRenderManager::Configure - timeout waiting for previous frame
01:41:11 T:126713856 NOTICE: Display resolution DESKTOP : 1280x720 (12)
01:41:12 T:75141120 NOTICE: Using GL_TEXTURE_2D
01:41:12 T:75141120 NOTICE: GL: Using software color conversion/RGBA render method
01:41:12 T:75141120 NOTICE: GL: NPOT texture support detected
01:41:38 T:75141120 NOTICE: CDVDPlayer::CloseFile()
01:41:38 T:75141120 NOTICE: DVDPlayer: waiting for threads to exit
01:41:38 T:125861888 NOTICE: CDVDPlayer::OnExit()
01:41:38 T:125861888 NOTICE: DVDPlayer: closing audio stream
01:41:38 T:125861888 NOTICE: Closing audio stream
01:41:38 T:125861888 NOTICE: Waiting for audio thread to exit
01:41:38 T:127647744 NOTICE: thread end: CDVDPlayerAudio::OnExit()
01:41:38 T:125861888 NOTICE: Closing audio device
01:41:38 T:125861888 NOTICE: Deleting audio codec
01:41:38 T:125861888 NOTICE: DVDPlayer: closing video stream
01:41:38 T:125861888 NOTICE: Closing video stream
01:41:38 T:125861888 NOTICE: waiting for video thread to exit
01:41:38 T:126713856 NOTICE: thread end: video_thread
01:41:38 T:125861888 NOTICE: deleting video codec
01:41:38 T:125861888 NOTICE: CDVDPlayer::OnExit() deleting demuxer
01:41:38 T:125861888 NOTICE: CDVDPlayer::OnExit() deleting input stream
01:41:38 T:75141120 NOTICE: DVDPlayer: finished waiting
01:41:40 T:75141120 NOTICE: CDVDPlayer::CloseFile()
01:41:40 T:75141120 WARNING: CDVDMessageQueue(player):ut MSGQ_NOT_INITIALIZED
01:41:40 T:75141120 NOTICE: DVDPlayer: waiting for threads to exit
01:41:40 T:75141120 NOTICE: DVDPlayer: finished waiting
01:41:40 T:111865856 WARNING: JpegIO: Error 55: Not a JPEG file: starts with 0x%02x 0x%02x
01:41:41 T:103018496 NOTICE: -->Python Interpreter Initialized<--
01:41:47 T:124088320 NOTICE: -->Python Interpreter Initialized<--
01:41:51 T:111865856 WARNING: JpegIO: Error 55: Not a JPEG file: starts with 0x%02x 0x%02x
01:42:00 T:126713856 WARNING: Previous line repeats 12 times.
01:42:00 T:126713856 NOTICE: -->Python Interpreter Initialized<--
01:42:03 T:75141120 ERROR: Unable to load /private/var/stash/Applications/XBMC.frappliance/XBMCData/XBMCHome/system/players/paplayer/libsidplay2-arm-osx.so, reason: dlopen(/private/var/stash/Applications/XBMC.frappliance/XBMCData/XBMCHome/system/players/paplayer/libsidplay2-arm-osx.so, 1): image not found
01:42:03 T:75141120 ERROR: Previous line repeats 3 times.
01:42:03 T:75141120 NOTICE: DVDPlayer: Opening: mms://xxx.xxx.xxx.xxx/vod7/4618.64.wmv?sid=002A298240FAB9099F3E6457370DB2F578A8006BD95F4FC863C9191CF581SDS9
01:42:03 T:75141120 WARNING: CDVDMessageQueue(player):ut MSGQ_NOT_INITIALIZED
01:42:03 T:124088320 NOTICE: Creating InputStream
01:42:03 T:124088320 NOTICE: Creating Demuxer
01:42:12 T:124088320 NOTICE: Opening video stream: 1 source: 256
01:42:12 T:124088320 NOTICE: Creating video codec with codec id: 74
01:42:12 T:124088320 NOTICE: CDVDVideoCodecFFmpeg::Open() Using codec: Windows Media Video 9
01:42:12 T:124088320 NOTICE: Creating video thread
01:42:12 T:125251584 NOTICE: running thread: video_thread
01:42:12 T:124088320 NOTICE: Opening audio stream: 0 source: 256
01:42:12 T:124088320 NOTICE: Finding audio codec for: 86024
01:42:12 T:124088320 NOTICE: Creating audio thread
01:42:12 T:128487424 NOTICE: running thread: CDVDPlayerAudio:rocess()
--------------

After playing first file fine I stopped the video and chose a second file that crashed the box.

Please help me to resolve this issue. It only happens on ATV/ATV2, XBMC on Win7 runs all files without any problem.

[Memphiz]

first link in my sig ... syslog, crashreporter and full xbmc.log - with debugging turned on - paste the logs to pastebin.com and put the link in here

[tvmanbrt]

XBMC, Platform: Darwin iOS (11.0.0 AppleTV2,1, Version 4.3 (Build 8F305)). Built on Dec 24 2011 (Git:20111222-22ad8e4)

Syslog - http://pastebin.com/Lwh3ZVGA
Crashreporter - http://pastebin.com/7EDM3wyv
Xbmc.log - http://pastebin.com/Mm7B0BHv

Please let me know if you need more info. Greatly appreciate your help

[g-off]

Did you do anything like try and play the file when you made that logfile?
All that happens is xbmc starts and loads almost every add-on in existence then is shut down.

[Memphiz]

Crash happend on 2012-01-15 17:10:25.918 -0500
syslog starts Jan 15 17:10:26 <- we need some mins before too ...

xbmc.log is useless - you didn't even try to play a file in there (as g-off already mentioned)

[tvmanbrt]

Sorry about that. XBMC created a new log file after the crash. The old one was named xbmc.log.old.
Here is more info - http://pastebin.com/J4kpv8CG

[tvmanbrt]

More info from syslog before crash - http://pastebin.com/n6Qk3JVf

[Memphiz]

Sorry about that. XBMC created a new log file after the crash. The old one was named xbmc.log.old.
Here is more info - http://pastebin.com/J4kpv8CG

You cut that log ... we devs hate that! Stop trying to think for us. We filter the information by ourselfs...

Are these streams you try to play? (some addon or so?)

[tvmanbrt]

You cut that log ... we devs hate that! Stop trying to think for us. We filter the information by ourselfs...

Are these streams you try to play? (some addon or so?)

That log was just huge! I cut from the place I started, all info before that was loading plugins, nothing interesting, really. We have a plugin for our service that works beautifully, but there is one issue that we noticed - it crashes the box and forces to restart on trying to play specific files - those having size 700x400 with aspect ratio 9:5 (VC-1 format). Other video files worked fine, just see the log from the first post where one file launched from mms://xxx.xxx.xxx.xxx/vod7/7407.50.wmv?sid=E4A6AD428C5EED9D8B3E809393E1A64514 6CDC0FF5C79BBCEFADDDF4F1B9088 (640x480) worked fine and the other one mms://xxx.xxx.xxx.xxx/vod7/4618.64.wmv?sid=002A298240FAB9099F3E6457370DB2F578 A8006BD95F4FC863C9191CF581SDS9 (700x400) crashed the box.

There are plenty of other files with similar properties behaving exactly the same way, so the issue is reproducible. Please let me know if I can provide more details.

[Memphiz]

where can i get that addon...

[tvmanbrt]

HERE

One thing though, it is in Russian. I will send you a login/password from the service into your private box.

[tvmanbrt]

Here are the steps to reproduce:

[tvmanbrt]

Guys,

The error is still in XBMC Eden. Please see a picture below. Two files - 1 on the left plays fine, no problem, 1 on the right causes ATV2 to reboot. Please look into it. Issue is reproducible on ATV2 with XBMC Eden

[lyulyok]

Hello, was there any resolution to this problem? I have encoutered a similar but using a different site...

Thanks!

[tvmanbrt]

Guys, the issue is pretty severe and no one seems to be able to help. It has been confirmed and reproduced. All logs and screenshots are shown above. Issue exists only on AppleTV2. Any ideas or suggestions are welcome.