OpenELEC / OpenELEC.tv

OpenELEC - The living room PC for everyone
http://openelec.tv
1.61k stars 882 forks source link

Playing Ogg Vorbis audio causes XBMC restart #483

Closed shantikulkarni closed 12 years ago

shantikulkarni commented 12 years ago

On 1.95.2, attempting to play an ogg vorbis file either directly or through a UPnP server causes XBMC to restart. I didn't notice an error in the logs. Here they are from when I open the window until XBMC restarts (and logging ends). The file in question is readable from the OE box, and other ogg files give the same result.

20:01:41 T:140369199396672   DEBUG: ------ Window Init (MyMusicSongs.xml) ------
20:01:41 T:140369199396672    INFO: Loading skin file: MyMusicSongs.xml
20:01:41 T:140369199396672   DEBUG: CGUIMediaWindow::GetDirectory ()
20:01:41 T:140369199396672   DEBUG:   ParentPath = []
20:01:41 T:140369199396672   DEBUG: RetrieveMusicInfo() took 0 msec
20:01:41 T:140368691574528  NOTICE: Thread Background Loader start, auto delete: false
20:01:41 T:140368691574528   DEBUG: Thread Background Loader 140368691574528 terminating
20:01:41 T:140369199396672   DEBUG: LIRC: Update - NEW at 29608:160 0 KEY_OK_UP devinput (KEY_OK_UP)
20:01:43 T:140369199396672   DEBUG: LIRC: Update - NEW at 31196:6c 0 KEY_DOWN devinput (KEY_DOWN)
20:01:43 T:140369199396672   DEBUG: OnKey: 167 (a7) pressed, action is Down
20:01:43 T:140369199396672   DEBUG: LIRC: Update - NEW at 31580:6c 0 KEY_DOWN_UP devinput (KEY_DOWN_UP)
20:01:43 T:140369199396672   DEBUG: LIRC: Update - NEW at 31763:160 0 KEY_OK devinput (KEY_OK)
20:01:43 T:140369199396672   DEBUG: OnKey: 11 (0b) pressed, action is Select
20:01:43 T:140369199396672   DEBUG: CGUIMediaWindow::GetDirectory (/media/music/)
20:01:43 T:140369199396672   DEBUG:   ParentPath = []
20:01:43 T:140369199396672   DEBUG: RetrieveMusicInfo() took 0 msec
20:01:43 T:140368691574528  NOTICE: Thread Background Loader start, auto delete: false
20:01:43 T:140368236164864  NOTICE: Previous line repeats 3 times.
20:01:43 T:140368236164864   DEBUG: Thread Background Loader 140368236164864 terminating
20:01:43 T:140368227772160   DEBUG: Thread Background Loader 140368227772160 terminating
20:01:43 T:140368969234176   DEBUG: Thread Background Loader 140368969234176 terminating
20:01:43 T:140368691574528   DEBUG: Thread Background Loader 140368691574528 terminating
20:01:43 T:140368219379456  NOTICE: Thread Background Loader start, auto delete: false
20:01:43 T:140368219379456   DEBUG: Thread Background Loader 140368219379456 terminating
20:01:44 T:140369199396672   DEBUG: LIRC: Update - NEW at 32263:160 0 KEY_OK_UP devinput (KEY_OK_UP)
20:01:44 T:140369199396672   DEBUG: LIRC: Update - NEW at 32697:6c 0 KEY_DOWN devinput (KEY_DOWN)
20:01:44 T:140369199396672   DEBUG: OnKey: 167 (a7) pressed, action is Down
20:01:45 T:140369199396672   DEBUG: LIRC: Update - NEW at 33081:6c 0 KEY_DOWN_UP devinput (KEY_DOWN_UP)
20:01:45 T:140369199396672   DEBUG: LIRC: Update - NEW at 33330:160 0 KEY_OK devinput (KEY_OK)
20:01:45 T:140369199396672   DEBUG: OnKey: 11 (0b) pressed, action is Select
20:01:45 T:140369199396672   DEBUG: CGUIMediaWindow::GetDirectory (/media/music/Alt_Country/)
20:01:45 T:140369199396672   DEBUG:   ParentPath = [/media/music/]
20:01:45 T:140369199396672   DEBUG: RetrieveMusicInfo() took 0 msec
20:01:45 T:140368219379456  NOTICE: Thread Background Loader start, auto delete: false
20:01:45 T:140368219379456   DEBUG: Thread Background Loader 140368219379456 terminating
20:01:45 T:140368691574528  NOTICE: Thread Background Loader start, auto delete: false
20:01:45 T:140368691574528   DEBUG: Thread Background Loader 140368691574528 terminating
20:01:45 T:140369199396672   DEBUG: LIRC: Update - NEW at 33813:160 0 KEY_OK_UP devinput (KEY_OK_UP)
20:01:46 T:140369199396672   DEBUG: LIRC: Update - NEW at 34063:6c 0 KEY_DOWN devinput (KEY_DOWN)
20:01:46 T:140369199396672   DEBUG: OnKey: 167 (a7) pressed, action is Down
20:01:46 T:140369199396672   DEBUG: LIRC: Update - NEW at 34447:6c 0 KEY_DOWN_UP devinput (KEY_DOWN_UP)
20:01:46 T:140369199396672   DEBUG: LIRC: Update - NEW at 34530:160 0 KEY_OK devinput (KEY_OK)
20:01:46 T:140369199396672   DEBUG: OnKey: 11 (0b) pressed, action is Select
20:01:46 T:140369199396672   DEBUG: CGUIMediaWindow::GetDirectory (/media/music/Alt_Country/Adams_Ryan/)
20:01:46 T:140369199396672   DEBUG:   ParentPath = [/media/music/Alt_Country/]
20:01:46 T:140369199396672   DEBUG: RetrieveMusicInfo() took 0 msec
20:01:46 T:140368691574528  NOTICE: Thread Background Loader start, auto delete: false
20:01:46 T:140368691574528  NOTICE: Previous line repeats 1 times.
20:01:46 T:140368691574528   DEBUG: Thread Background Loader 140368691574528 terminating
20:01:46 T:140368969234176   DEBUG: Thread Background Loader 140368969234176 terminating
20:01:46 T:140368219379456  NOTICE: Thread Background Loader start, auto delete: false
20:01:46 T:140368219379456   DEBUG: Thread Background Loader 140368219379456 terminating
20:01:46 T:140369199396672   DEBUG: LIRC: Update - NEW at 34914:160 0 KEY_OK_UP devinput (KEY_OK_UP)
20:01:48 T:140369199396672   DEBUG: LIRC: Update - NEW at 35947:6c 0 KEY_DOWN devinput (KEY_DOWN)
20:01:48 T:140369199396672   DEBUG: OnKey: 167 (a7) pressed, action is Down
20:01:48 T:140369199396672   DEBUG: LIRC: Update - NEW at 36164:6c 0 KEY_DOWN_UP devinput (KEY_DOWN_UP)
20:01:48 T:140369199396672   DEBUG: LIRC: Update - NEW at 36181:6c 0 KEY_DOWN devinput (KEY_DOWN)
20:01:48 T:140369199396672   DEBUG: OnKey: 167 (a7) pressed, action is Down
20:01:48 T:140369199396672   DEBUG: LIRC: Update - NEW at 36331:6c 0 KEY_DOWN_UP devinput (KEY_DOWN_UP)
20:01:48 T:140369199396672   DEBUG: LIRC: Update - NEW at 36348:6c 0 KEY_DOWN devinput (KEY_DOWN)
20:01:48 T:140369199396672   DEBUG: OnKey: 167 (a7) pressed, action is Down
20:01:48 T:140369199396672   DEBUG: LIRC: Update - NEW at 36713:6c 0 KEY_DOWN_UP devinput (KEY_DOWN_UP)
20:01:49 T:140369199396672   DEBUG: LIRC: Update - NEW at 37013:160 0 KEY_OK devinput (KEY_OK)
20:01:49 T:140369199396672   DEBUG: OnKey: 11 (0b) pressed, action is Select
20:01:49 T:140369199396672   DEBUG: CGUIMediaWindow::GetDirectory (/media/music/Alt_Country/Adams_Ryan/Cold_Roses_(with_The_Cardinals)/)
20:01:49 T:140369199396672   DEBUG:   ParentPath = [/media/music/Alt_Country/Adams_Ryan/]
20:01:49 T:140369199396672   DEBUG: SECTION:LoadDLL(libvorbisfile.so.3)
20:01:49 T:140369199396672   DEBUG: Loading: libvorbisfile.so.3
20:01:49 T:140368219379456  NOTICE: Thread Background Loader start, auto delete: false
20:01:49 T:140368219379456   DEBUG: Saving fileitems [/media/music/Alt_Country/Adams_Ryan/Cold_Roses_(with_The_Cardinals)/]
20:01:49 T:140368219379456   DEBUG:   -- items: 20, sort method: 0, ascending: false
20:01:49 T:140368219379456   DEBUG: Thread Background Loader 140368219379456 terminating
20:01:49 T:140369199396672   DEBUG: RetrieveMusicInfo() took 85 msec
20:01:49 T:140368219379456  NOTICE: Thread Background Loader start, auto delete: false
20:01:49 T:140368969234176  NOTICE: Previous line repeats 3 times.
20:01:49 T:140368969234176   DEBUG: Thread Background Loader 140368969234176 terminating
20:01:49 T:140368227772160   DEBUG: Thread Background Loader 140368227772160 terminating
20:01:49 T:140368219379456   DEBUG: Thread Background Loader 140368219379456 terminating
20:01:49 T:140368691574528   DEBUG: Thread Background Loader 140368691574528 terminating
20:01:49 T:140369199396672   DEBUG: LIRC: Update - NEW at 37397:160 0 KEY_OK_UP devinput (KEY_OK_UP)
20:01:49 T:140369199396672   DEBUG: LIRC: Update - NEW at 37930:6c 0 KEY_DOWN devinput (KEY_DOWN)
20:01:49 T:140369199396672   DEBUG: OnKey: 167 (a7) pressed, action is Down
20:01:50 T:140369199396672   DEBUG: LIRC: Update - NEW at 38314:6c 0 KEY_DOWN_UP devinput (KEY_DOWN_UP)
20:01:51 T:140369199396672   DEBUG: LIRC: Update - NEW at 38947:160 0 KEY_OK devinput (KEY_OK)
20:01:51 T:140369199396672   DEBUG: OnKey: 11 (0b) pressed, action is Select
20:01:51 T:140369199396672   DEBUG: CPlayerCoreFactory::GetPlayers(/media/music/Alt_Country/Adams_Ryan/Cold_Roses_(with_The_Cardinals)/01-Magnolia Mountain.ogg)
20:01:51 T:140369199396672   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: system rules
20:01:51 T:140369199396672   DEBUG: CPlayerSelectionRule::GetPlayers: matches rule: system rules
20:01:51 T:140369199396672   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtv
20:01:51 T:140369199396672   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: hdhomerun/myth/rtmp/mms/udp
20:01:51 T:140369199396672   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: lastfm/shout
20:01:51 T:140369199396672   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: rtsp
20:01:51 T:140369199396672   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: streams
20:01:51 T:140369199396672   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvd
20:01:51 T:140369199396672   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvdfile
20:01:51 T:140369199396672   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: dvdimage
20:01:51 T:140369199396672   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: sdp/asf
20:01:51 T:140369199396672   DEBUG: CPlayerSelectionRule::GetPlayers: considering rule: nsv
20:01:51 T:140369199396672   DEBUG: CPlayerCoreFactory::GetPlayers: matched 0 rules with players
20:01:51 T:140369199396672   DEBUG: CPlayerCoreFactory::GetPlayers: adding audiodefaultplayer (3)
20:01:51 T:140369199396672   DEBUG: CPlayerCoreFactory::GetPlayers: for video=0, audio=1
20:01:51 T:140369199396672   DEBUG: CPlayerCoreFactory::GetPlayers: adding player: PAPlayer (3)
20:01:51 T:140369199396672   DEBUG: CPlayerCoreFactory::GetPlayers: for video=1, audio=1
20:01:51 T:140369199396672   DEBUG: CPlayerCoreFactory::GetPlayers: adding player: DVDPlayer (1)
20:01:51 T:140369199396672   DEBUG: CPlayerCoreFactory::GetPlayers: added 2 players
20:01:51 T:140369199396672   DEBUG: CFileCache::Open - opening </media/music/Alt_Country/Adams_Ryan/Cold_Roses_(with_The_Cardinals)/01-Magnolia Mountain.ogg> using cache
20:01:51 T:140368691574528  NOTICE: Thread CFileCache start, auto delete: false
20:01:51 T:140368691574528   DEBUG: Process, request seek on source to 9147668
20:01:51 T:140368691574528    INFO: CFileCache::Process - Hit eof.
20:01:51 T:140368691574528   DEBUG: Process, request seek on source to 9082132
20:01:51 T:140368691574528    INFO: CFileCache::Process - Hit eof.
20:01:51 T:140368691574528   DEBUG: Process, request seek on source to 4070
20:01:51 T:140369199396672   DEBUG: CFileCache::Open - opening </media/music/Alt_Country/Adams_Ryan/Cold_Roses_(with_The_Cardinals)/01-Magnolia Mountain.ogg> using cache
20:01:51 T:140368219379456  NOTICE: Thread CFileCache start, auto delete: false
20:01:51 T:140368219379456   DEBUG: Process, request seek on source to 9147668
20:01:51 T:140368219379456    INFO: CFileCache::Process - Hit eof.
20:01:51 T:140368219379456   DEBUG: Process, request seek on source to 9082132
20:01:51 T:140368219379456    INFO: CFileCache::Process - Hit eof.
20:01:51 T:140368219379456   DEBUG: Process, request seek on source to 4070
20:01:51 T:140369199396672    INFO: PAPlayer: Playing /media/music/Alt_Country/Adams_Ryan/Cold_Roses_(with_The_Cardinals)/01-Magnolia Mountain.ogg
20:01:51 T:140369199396672   DEBUG: PAPlayer: Creating new audio renderer
20:01:51 T:140369199396672    INFO: CAudioRendererFactory: no input channel map specified assume windows
20:01:51 T:140369199396672    INFO: AudioRendererFactory:  not a explicit device, trying to autodetect.
20:01:51 T:140369199396672    INFO: CPCMRemap: Configured speaker layout: 5.1
20:01:51 T:140369199396672    INFO: CPCMRemap: I channel map: FL,FR
20:01:51 T:140369199396672    INFO: CPCMRemap: O channel map: FL,FR
20:01:51 T:140369199396672   DEBUG: CPCMRemap: Downmix normalization is disabled
20:01:51 T:140369199396672   DEBUG: CPCMRemap: FL = FL(1.000000*)
20:01:51 T:140369199396672   DEBUG: CPCMRemap: FR = FR(1.000000*)
20:01:51 T:140369199396672   DEBUG: RemoveActiveDevice - Removing device 1
20:01:51 T:140369199396672   DEBUG: SetActiveDevice - SetActiveDevice from 0 to 2
20:01:51 T:140369199396672   DEBUG: RemoveActiveDevice - Removing device 0
20:01:51 T:140369199396672   DEBUG: Initialize - using alsa device default
20:01:51 T:140369199396672   DEBUG: CALSADirectSound::Initialize - frame count:940, packet count:8, buffer size:7526
20:01:51 T:140369199396672   DEBUG: CALSADirectSound::Initialize - Channels: 2 - SampleRate: 44100 - SampleBit: 16 - Resample false - IsMusic true - IsPassthrough 0 - audioDevice: default
20:01:51 T:140368227772160  NOTICE: Thread PAPlayer start, auto delete: false
20:01:51 T:140368227772160   DEBUG: PAPlayer: Thread started
sraue commented 12 years ago

can you please test this build: ION: http://sources.openelec.tv/tmp/image/test/OpenELEC-ION.x86_64-devel-20120514163330-r10959.tar.bz2 Fusion: http://sources.openelec.tv/tmp/image/test/OpenELEC-Fusion.x86_64-devel-20120514162819-r10959.tar.bz2 and report back? please test all kind of videos you have. thanks much

shantikulkarni commented 12 years ago

To be clear, the files in question are ogg vorbis audio, not video files.

I tested the ION build from the link in your email. I installed the ION build linked to in your email tried playing two of them, but via a UPNP server and a directly-mounted share. The result is that XBMC restarts. MP3 audio files play just fine from either source.

Here's what ogginfo returns for the ogg files I tested. Let me know if you want me to send you one of them.

Shanti

$ ogginfo 01_inaudible_melodies.ogg Processing file "01_inaudible_melodies.ogg"...

New logical stream (#1, serial: 4687b3dd): type vorbis Vorbis headers parsed for stream 1, information follows... Version: 0 Vendor: Xiphophorus libVorbis I 20011231 (1.0 rc3) Channels: 2 Rate: 44100

Nominal bitrate: 128.031000 kb/s Upper bitrate: 4294967.295000 kb/s Lower bitrate: 4294967.295000 kb/s User comments section follows... TITLE=inaudible melodies ARTIST=Johnson, Jack ALBUM=Brushfire Fairytales DATE=2000 TRACKNUMBER=01/13 GENRE=Blues MUSICIP_PUID=c161e469-311f-acf7-5aae-05d9fbd77cbf Vorbis stream 1: Total data length: 3409475 bytes Playback length: 3m:35.360s Average bitrate: 126.652117 kb/s Logical stream 1 ended

$ ogginfo 01-Magnolia\ Mountain.ogg Processing file "01-Magnolia Mountain.ogg"...

New logical stream (#1, serial: 000006cc): type vorbis Vorbis headers parsed for stream 1, information follows... Version: 0 Vendor: Xiph.Org libVorbis I 20050304 (1.1.1) Channels: 2 Rate: 44100

Nominal bitrate: 192.000000 kb/s Upper bitrate not set Lower bitrate not set User comments section follows... TITLE=Magnolia Mountain ARTIST=Adams, Ryan ALBUM=Cold Roses (with the Cardinals) DATE=2005 TRACKNUMBER=01/19 GENRE=Alt. Country TRACKTOTAL=19 TRACK=1 YEAR=2005 MUSICIP_PUID=892c0fdd-050e-e4ff-8475-7538c95ce3fc Vorbis stream 1: Total data length: 9143598 bytes Playback length: 5m:52.533s Average bitrate: 207.494660 kb/s Logical stream 1 ended

On May 14, 2012, at 10:37 AM, Stephan Raue wrote:

can you please test this build: ION: http://sources.openelec.tv/tmp/image/test/OpenELEC-ION.x86_64-devel-20120514163330-r10959.tar.bz2 Fusion: http://sources.openelec.tv/tmp/image/test/OpenELEC-Fusion.x86_64-devel-20120514162819-r10959.tar.bz2 and report back? please test all kind of videos you have. thanks much


Reply to this email directly or view it on GitHub: https://github.com/OpenELEC/OpenELEC.tv/issues/483#issuecomment-5693354

mrdominuzq commented 12 years ago

just tried beta 3 and it works fine with usb and samba share. no crash.

shantikulkarni commented 12 years ago

Finally thought to check /var/log/messages and see errors such as the following when I attempt to play an ogg file:

May 22 21:48:00 dhcppc260 user.info kernel: [90136.831076] xbmc.bin[1717] trap invalid opcode ip:7f82923109a0 sp:7f82627b29c0 error:0 in libvorbis.so.0.4.6[7f82922f0000+33000]

I should have thought of that before. This is using the ION build of r10959 which Stephan sent me.

mrdominuzq commented 12 years ago

can you try and convert a cd to ogg and then try using beta4 :)

shantikulkarni commented 12 years ago

I think this bug is a duplicate of #687. Like the poster of in issue I'm using a Zotac ND-22, an ION/Celeron platform. I belatedly realized that with the ION build, now videos cause XBMC to restart as well as ogg vorbis files. Generic builds don't crash.

Should the ION build be used only systems with an Atom CPU?