Kodi Community Forum

Hi all,

Recently installed a new HTPC using Fedora 19 and RPMfusion repos. Previous HTPC had Fedora 17 installed with same repos running XBMC eden. XBMC Frodo seems to have real issues playing WMV files, with files causing XBMC to crash, or play jerkily, hang XBMC, or play with bad audio, and seeking just seems to make things worse. This was never an issue with Eden, so I've created a test build of ffmpeg 1.2.3 to see if ffmpeg was the culprit with no luck. Either XBMC was compiled with static ffmpeg support, or there's something else at play. Frodo works flawlessly with all other filetypes, it's just WMV files it has issues with. I can consistently break XBMC playing any types of WMV files.

From /var/log/messages:
-----------------------------------
Sep 8 20:15:39 brownbox /etc/gdm/Xsession[702]: *** Error in `/usr/lib64/xbmc/xbmc.bin': corrupted double-linked list: 0x00007f97c808c360 ***
Sep 8 20:15:39 brownbox /etc/gdm/Xsession[702]: ======= Backtrace: =========
Sep 8 20:15:39 brownbox /etc/gdm/Xsession[702]: /lib64/libc.so.6[0x3f0a07c72c]
Sep 8 20:15:39 brownbox /etc/gdm/Xsession[702]: /lib64/libc.so.6[0x3f0a07cfd6]
Sep 8 20:15:39 brownbox /etc/gdm/Xsession[702]: /usr/lib64/nvidia-304xx/tls/libnvidia-tls.so.304.88[0x3f15801cc1]
Sep 8 20:15:39 brownbox /etc/gdm/Xsession[702]: ======= Memory map: ========
Sep 8 20:15:39 brownbox /etc/gdm/Xsession[702]: 00400000-013aa000 r-xp 00000000 08:01 2097503 /usr/lib64/xbmc/xbmc.bin
Sep 8 20:15:39 brownbox /etc/gdm/Xsession[702]: 015a9000-01607000 r--p 00fa9000 08:01 2097503 /usr/lib64/xbmc/xbmc.bin
Sep 8 20:15:39 brownbox /etc/gdm/Xsession[702]: 01607000-0162a000 rw-p 01007000 08:01 2097503 /usr/lib64/xbmc/xbmc.bin
Sep 8 20:15:39 brownbox /etc/gdm/Xsession[702]: 0162a000-01657000 rw-p 00000000 00:00 0
Sep 8 20:15:39 brownbox /etc/gdm/Xsession[702]: 01829000-0197b000 rw-p 01029000 08:01 2097503 /usr/lib64/xbmc/xbmc.bin
Sep 8 20:15:39 brownbox /etc/gdm/Xsession[702]: 032d7000-06ac4000 rw-p 00000000 00:00 0 [heap]
Sep 8 20:15:39 brownbox /etc/gdm/Xsession[702]: 41027000-410a5000 rw-p 00000000 00:00 0
Sep 8 20:15:39 brownbox /etc/gdm/Xsession[702]: 410ec000-4116a000 rw-p 00000000 00:00 0
Sep 8 20:15:39 brownbox /etc/gdm/Xsession[702]: 41b09000-41b0b000 r-xs 00000000 00:1e 18129 /tmp/gl8BxYK5 (deleted)
Sep 8 20:15:39 brownbox /etc/gdm/Xsession[702]: 354c200000-354c203000 r-xp 00000000 08:01 1574638 /usr/lib64/libpulse-simple.so.0.0.3
Sep 8 20:15:39 brownbox /etc/gdm/Xsession[702]: 354c203000-354c403000 ---p 00003000 08:01 1574638 /usr/lib64/libpulse-simple.so.0.0.3
Sep 8 20:15:39 brownbox /etc/gdm/Xsession[702]: 354c403000-354c404000 r--p 00003000 08:01 1574638 /usr/lib64/libpulse-simple.so.0.0.3
Sep 8 20:15:39 brownbox /etc/gdm/Xsession[702]: 354c404000-354c405000 rw-p 00004000 08:01 1574638 /usr/lib64/libpulse-simple.so.0.0.3
Sep 8 20:15:39 brownbox /etc/gdm/Xsession[702]: 354ce00000-354ce09000 r-xp 00000000 08:01 1574010 /usr/lib64/libjson-c.so.2.0.1
Sep 8 20:15:39 brownbox /etc/gdm/Xsession[702]: 354ce09000-354d009000 ---p 00009000 08:01 1574010 /usr/lib64/libjson-c.so.2.0.1
Sep 8 20:15:39 brownbox /etc/gdm/Xsession[702]: 354d009000-354d00a000 r--p 00009000 08:01 1574010 /usr/lib64/libjson-c.so.2.0.1
Sep 8 20:15:39 brownbox /etc/gdm/Xsession[702]: 354d00a000-354d00b000 rw-p 0000a000 08:01 1574010 /usr/lib64/libjson-c.so.2.0.1
Sep 8 20:15:39 brownbox /etc/gdm/Xsession[702]: 354d200000-354d248000 r-xp 00000000 08:01 1574014 /usr/lib64/libpulse.so.0.15.3
Sep 8 20:15:39 brownbox /etc/gdm/Xsession[702]: 354d248000-354d448000 ---p 00048000 08:01 1574014 /usr/lib64/libpulse.so.0.15.3
Sep 8 20:15:39 brownbox /etc/gdm/Xsession[702]: 354d448000-354d449000 r--p 00048000 08:01 1574014 /usr/lib64/libpulse.so.0.15.3
Sep 8 20:15:39 brownbox /etc/gdm/Xsession[702]: Running DIL (3.22.0) Version
Sep 8 20:15:39 brownbox /etc/gdm/Xsession[702]: DtsDeviceOpen: Opening HW in mode 0
Sep 8 20:15:39 brownbox /etc/gdm/Xsession[702]: DtsDeviceOpen: Create File Failed
Sep 8 20:15:39 brownbox /etc/gdm/Xsession[702]: 354d449000-354d44a000 rw-p 00049000 08:01 1574014 /usr/lib64/libpulse.so.0.15.3
Sep 8 20:15:39 brownbox /etc/gdm/Xsession[702]: 354d600000-354d601000 r-xp 00000000 08:01 1574013 /usr/lib64/libjson.so.0.1.0
Sep 8 20:15:39 brownbox /etc/gdm/Xsession[702]: 354d601000-354d800000 ---p 00001000 08:01 1574013 /usr/lib64/libjson.so.0.1.0
Sep 8 20:15:39 brownbox /etc/gdm/Xsession[702]: 354d800000-354d801000 r--p 00000000 08:01 1574013 /usr/lib64/libjson.so.0.1.0
Sep 8 20:15:39 brownbox /etc/gdm/Xsession[702]: 354d801000-354d802000 rw-p 00001000 08:01 1574013 /usr/lib64/libjson.so.0.1.0
Sep 8 20:15:39 brownbox /etc/gdm/Xsession[702]: 3c71e00000-3c71e26000 r-xp 00000000 08:01 1968848 /usr/lib64/samba/libgse.so
Sep 8 20:15:39 brownbox /etc/gdm/Xsession[702]: 3c71e26000-3c72026000 ---p 00026000 08:01 1968848 /usr/lib64/samba/libgse.so
Sep 8 20:15:39 brownbox /etc/gdm/Xsession[702]: 3c72026000-3c72027000 r--p 00026000 08:01 1968848 /usr/lib64/samba/libgse.so
Sep 8 20:15:39 brownbox /etc/gdm/Xsession[702]: 3c72027000-3c72028000 rw-p 00027000 08:01 1968848 /usr/lib64/samba/libgse.so
Sep 8 20:15:39 brownbox /etc/gdm/Xsession[702]: 3c72200000-3c72222000 r-xp 00000000 08:01 1574009 /usr/lib64/libsmbclient.so.0.2.0
Sep 8 20:15:39 brownbox /etc/gdm/Xsession[702]: 3c72222000-3c72422000 ---p 00022000 08:01 1574009 /usr/lib64/libsmbclient.so.0.2.0
Sep 8 20:15:39 brownbox /etc/gdm/Xsession[702]: 3c72422000-3c72423000 r--p 00022000 08:01 1574009 /usr/lib64/libsmbclient.so.0.2.0
Sep 8 20:15:39 brownbox /etc/gdm/Xsession[702]: 3c72423000-3c72424000 rw-p 00000000 00:00 0
Sep 8 20:15:39 brownbox /etc/gdm/Xsession[702]: 3c72600000-3c72602000 r-xp 00000000 08:01 1969258 /usr/lib64/samba/libutil_cmdline.so
Sep 8 20:15:39 brownbox /etc/gdm/Xsession[702]: 3c72602000-3c72802000 ---p 00002000 08:01 1969258 /usr/lib64/samba/libutil_cmdline.so
Sep 8 20:15:39 brownbox /etc/gdm/Xsession[702]: 3c72802000-3c72803000 r--p 00002000 08:01 1969258 /usr/lib64/samba/libutil_cmdline.so
Sep 8 20:15:39 brownbox /etc/gdm/Xsession[702]: 3c72803000-3c72804000 rw-p 00000000 00:00 0
Sep 8 20:15:39 brownbox /etc/gdm/Xsession[702]: 3c72a00000-3c72a0a000 r-xp 00000000 08:01 1968159 /usr/lib64/samba/libsecrets3.so
Sep 8 20:15:39 brownbox /etc/gdm/Xsession[702]: 3c72a0a000-3c72c09000 ---p 0000a000 08:01 1968159 /usr/lib64/samba/libsecrets3.so
Sep 8 20:15:39 brownbox /etc/gdm/Xsession[702]: 3c72c09000-3c72c0a000 r--p 00009000 08:01 1968159 /usr/lib64/samba/libsecrets3.so
Sep 8 20:15:39 brownbox /etc/gdm/Xsession[702]: 3c72c0a000-3c72c0b000 rw-p 00000000 00:00 0

etc....
-----------------------------------

From xbmc.log when file hangs xbmc (black screen):
-----------------------------------
20:22:02 T:139660438599872 NOTICE: DVDPlayer: Opening: smb://MEDIABOX/TEST/test.wmv
20:22:02 T:139660438599872 WARNING: CDVDMessageQueue(player):ut MSGQ_NOT_INITIALIZED
20:22:02 T:139660384802560 NOTICE: Thread CDVDPlayer start, auto delete: false
20:22:02 T:139660384802560 NOTICE: Creating InputStream
20:22:02 T:139660384802560 NOTICE: Creating Demuxer
20:22:02 T:139660384802560 NOTICE: Opening video stream: 1 source: 256
20:22:02 T:139660384802560 NOTICE: Creating video codec with codec id: 73
20:22:02 T:139660384802560 NOTICE: CDVDVideoCodecFFmpeg::Open() Creating VDPAU(500x278, 73)
20:22:02 T:139660384802560 NOTICE: vdp_device = 0x00000001 vdp_st = 0x00000000
20:22:02 T:139660384802560 NOTICE: VDPAU Decoder capabilities:
20:22:02 T:139660384802560 NOTICE: name level macbs width height
20:22:02 T:139660384802560 NOTICE: ------------------------------------
20:22:02 T:139660384802560 NOTICE: MPEG1 0 8192 2048 2048
20:22:02 T:139660384802560 NOTICE: MPEG2_SIMPLE 3 8192 2048 2048
20:22:02 T:139660384802560 NOTICE: MPEG2_MAIN 3 8192 2048 2048
20:22:02 T:139660384802560 NOTICE: H264_MAIN 41 8192 2048 2048
20:22:02 T:139660384802560 NOTICE: H264_HIGH 41 8192 2048 2048
20:22:02 T:139660384802560 NOTICE: VC1_SIMPLE 1 8190 2048 2048
20:22:02 T:139660384802560 NOTICE: VC1_MAIN 2 8190 2048 2048
20:22:02 T:139660384802560 NOTICE: VC1_ADVANCED 4 8190 2048 2048
20:22:02 T:139660384802560 NOTICE: MPEG4_PART2_ASP 5 8192 2048 2048
20:22:02 T:139660384802560 NOTICE: ------------------------------------
20:22:02 T:139660384802560 NOTICE: Mixer feature: VDP_VIDEO_MIXER_FEATURE_NOISE_REDUCTION
20:22:02 T:139660384802560 NOTICE: Mixer feature: VDP_VIDEO_MIXER_FEATURE_SHARPNESS
20:22:02 T:139660384802560 NOTICE: Mixer feature: VDP_VIDEO_MIXER_FEATURE_DEINTERLACE_TEMPORAL
20:22:02 T:139660384802560 NOTICE: Mixer feature: VDP_VIDEO_MIXER_FEATURE_DEINTERLACE_TEMPORAL_SPATIAL
20:22:02 T:139660384802560 NOTICE: Mixer feature: VDP_VIDEO_MIXER_FEATURE_INVERSE_TELECINE
20:22:02 T:139660384802560 NOTICE: Mixer feature: VDP_VIDEO_MIXER_FEATURE_HIGH_QUALITY_SCALING_L1
20:22:02 T:139660384802560 NOTICE: CDVDVideoCodecFFmpeg::Open() Using codec: Windows Media Video 9 VDPAU
20:22:02 T:139660384802560 NOTICE: Creating video thread
20:22:02 T:139660349990656 NOTICE: Thread CDVDPlayerVideo start, auto delete: false
20:22:02 T:139660349990656 NOTICE: running thread: video_thread
20:22:02 T:139660384802560 NOTICE: Opening audio stream: 0 source: 256
20:22:02 T:139660384802560 NOTICE: Finding audio codec for: 86024
20:22:02 T:139660384802560 NOTICE: Creating audio thread
20:22:02 T:139659162146560 NOTICE: Thread CDVDPlayerAudio start, auto delete: false
20:22:02 T:139659162146560 NOTICE: running thread: CDVDPlayerAudio:rocess()
20:22:02 T:139660349990656 NOTICE: (VDPAU) screenWidth:0 vidWidth:500 surfaceWidth:500
20:22:02 T:139660349990656 NOTICE: (VDPAU) screenHeight:0 vidHeight:278 surfaceHeight:278
20:22:02 T:139659162146560 NOTICE: Creating audio stream (codec id: 86024, channels: 2, sample rate: 48000, no pass-through)
20:22:02 T:139660349990656 NOTICE: Creating 500x278 pixmap
20:22:02 T:139660349990656 NOTICE: (VDPAU) Total Output Surfaces Available: 4 of a max (tmp: 4 const: 4)
20:22:02 T:139660349990656 NOTICE: (VDPAU) Creating the video mixer
20:22:02 T:139660349990656 NOTICE: fps: 29.970030, pwidth: 500, pheight: 278, dwidth: 500, dheight: 278
20:22:02 T:139660349990656 NOTICE: Display resolution DESKTOP : 1920x1080 @ 60.00 - Full Screen (16)
20:22:02 T:139660438599872 NOTICE: Using GL_TEXTURE_2D
20:22:02 T:139660438599872 NOTICE: GL: Using VDPAU render method
20:22:02 T:139660438599872 NOTICE: GL: NPOT texture support detected
20:22:02 T:139660438599872 NOTICE: GL: Using GL_ARB_pixel_buffer_object

---------------------------------
From crash log:
---------------------------------
0:21:34 T:140302354478848 NOTICE: Thread CDVDPlayerAudio start, auto delete: false
20:21:34 T:140302354478848 NOTICE: running thread: CDVDPlayerAudio:rocess()
20:21:34 T:140302712956672 NOTICE: (VDPAU) screenWidth:0 vidWidth:500 surfaceWidth:500
20:21:34 T:140302712956672 NOTICE: (VDPAU) screenHeight:0 vidHeight:278 surfaceHeight:278
20:21:34 T:140302354478848 NOTICE: Creating audio stream (codec id: 86024, channels: 2, sample rate: 48000, no pass-through)
20:21:34 T:140302712956672 NOTICE: Creating 500x278 pixmap
20:21:34 T:140302712956672 NOTICE: (VDPAU) Total Output Surfaces Available: 4 of a max (tmp: 4 const: 4)
20:21:34 T:140302712956672 NOTICE: (VDPAU) Creating the video mixer
20:21:34 T:140302712956672 NOTICE: fps: 29.970030, pwidth: 500, pheight: 278, dwidth: 500, dheight: 278
20:21:34 T:140302712956672 NOTICE: Display resolution DESKTOP : 1920x1080 @ 60.00 - Full Screen (16)
20:21:34 T:140303772412096 NOTICE: Using GL_TEXTURE_2D
20:21:34 T:140303772412096 NOTICE: GL: Using VDPAU render method
20:21:34 T:140303772412096 NOTICE: GL: NPOT texture support detected
20:21:34 T:140303772412096 NOTICE: GL: Using GL_ARB_pixel_buffer_object
20:21:35 T:140302354478848 ERROR: CDVDPlayerAudio:ecodeFrame - Decode Error. Skipping audio packet
20:21:35 T:140302354478848 ERROR: Previous line repeats 7 times.
20:21:35 T:140302354478848 WARNING: CDVDMessageQueue(audio)::Get - asked for new data packet, with nothing available
20:21:35 T:140303700588288 WARNING: PulseAudio: Stream underflow
20:21:36 T:140302354478848 ERROR: CDVDPlayerAudio:ecodeFrame - Decode Error. Skipping audio packet
------------------------------------

Version/build of XBMC from rpmfusion:

xbmc-12.2-3.fc19.x86_64


Any suggestions? I was going to roll Frodo out to a couple of friend's HTPCs using the disk image from my Fedora HTPC, but it doesn't look like it's quite ready for production. I thought I might be able to change the sound settings to use ALSA in XBMC, but that option appears to be disabled in Frodo, so I'm stuck with PulseAudio. I've turned off DTS and any digitial sound toggles in XBMC, and have made recommended settings for VDPAU so I don't think it's an NVIdia driver issue, as all patches have been applied before getting to this stage.

Try removing Pulseaudio completely. I wouldn't use Fedora on a HTPC either, though I guess that's a matter of personal preference.

Tried that just now. Some WMV files play with no audio, but jerkily. Others play jerkily and bomb XBMC when you hit STOP.

Error in /var/log/messages starts out slightly different though:

--------------
Sep 8 23:08:57 brownbox abrt[1079]: Saved core dump of pid 1003 (/usr/lib64/xbmc/xbmc.bin) to /var/tmp/abrt/ccpp-2013-09-08-23:08:54-1003 (230158336 bytes)
Sep 8 23:08:57 brownbox abrtd: Directory 'ccpp-2013-09-08-23:08:54-1003' creation detected
Sep 8 23:08:57 brownbox abrtd: Can't load public GPG key /etc/pki/rpm-gpg/RPM-GPG-KEY-fedora
Sep 8 23:08:57 brownbox /etc/gdm/Xsession[694]: /usr/bin/xbmc: line 137: 1003 Aborted (core dumped) "$LIBDIR/xbmc/xbmc.bin" $SAVED_ARGS
Sep 8 23:08:57 brownbox /etc/gdm/Xsession[694]: which: no lsb_release in (/usr/lib64/ccache:/usr/local/bin:/usr/bin:/bin:/usr/local/sbin:/usr/sbin:/home/mediauser/.local/bin:/home/mediauser/bin)
Sep 8 23:08:57 brownbox abrtd: Generating core_backtrace
Sep 8 23:08:57 brownbox abrtd: Generating backtrace
Sep 8 23:08:58 brownbox abrt: detected unhandled Python exception
Sep 8 23:08:58 brownbox abrt: detected unhandled Python exception
Sep 8 23:08:58 brownbox /etc/gdm/Xsession[694]: Crash report available at /home/mediauser/xbmc_crashlog-20130908_230857.log
Sep 8 23:09:50 brownbox abrtd: Duplicate: core backtrace
Sep 8 23:09:50 brownbox abrtd: DUP_OF_DIR: /var/tmp/abrt/ccpp-2013-09-06-23:03:31-781
Sep 8 23:09:50 brownbox abrtd: Deleting problem directory ccpp-2013-09-08-23:08:54-1003 (dup of ccpp-2013-09-06-23:03:31-781)
Sep 8 23:11:00 brownbox /etc/gdm/Xsession[694]: *** Error in `/usr/lib64/xbmc/xbmc.bin': free(): invalid pointer: 0x00007f8d384d4340 ***
Sep 8 23:11:00 brownbox /etc/gdm/Xsession[694]: ======= Backtrace: =========
Sep 8 23:11:00 brownbox /etc/gdm/Xsession[694]: /lib64/libc.so.6[0x3f0a07d0e8]
Sep 8 23:11:00 brownbox /etc/gdm/Xsession[694]: /usr/lib64/nvidia-304xx/tls/libnvidia-tls.so.304.88[0x3f15801cc1]
etc...
----------------------------------
Other log files are pretty much identical to previous post.

Upload the full logs to xbmclogs.com so that someone can take a proper look at them. Snippets are usually not enough.

Sorry for the delay - haven't had a chance to sit down again and take a look. Here are the relevant log files. Hope this helps. Unfortunately can't upload attachments - so posting multipart reply.

(edited after worked out how to use xbmclogs)

crashlog

/var/log/messages:
=============
Sep 13 20:25:11 brownbox abrt[1060]: Saved core dump of pid 757 (/usr/lib64/xbmc/xbmc.bin) to /var/tmp/abrt/ccpp-2013-09-13-20:25:06-757 (340873216 bytes)
Sep 13 20:25:11 brownbox abrtd: Directory 'ccpp-2013-09-13-20:25:06-757' creation detected
Sep 13 20:25:11 brownbox /etc/gdm/Xsession[693]: /usr/bin/xbmc: line 137: 757 Segmentation fault (core dumped) "$LIBDIR/xbmc/xbmc.bin" $SAVED_ARGS
Sep 13 20:25:11 brownbox /etc/gdm/Xsession[693]: which: no lsb_release in (/usr/lib64/ccache:/usr/local/bin:/usr/bin:/bin:/usr/local/sbin:/usr/sbin:/home/mediauser/.local/bin:/home/mediauser/bin)
Sep 13 20:25:11 brownbox abrtd: Can't load public GPG key /etc/pki/rpm-gpg/RPM-GPG-KEY-fedora
Sep 13 20:25:11 brownbox abrtd: Generating core_backtrace
Sep 13 20:25:11 brownbox abrtd: Generating backtrace
Sep 13 20:25:12 brownbox abrt: detected unhandled Python exception
Sep 13 20:25:12 brownbox abrt: detected unhandled Python exception
Sep 13 20:25:13 brownbox abrt: detected unhandled Python exception
Sep 13 20:25:14 brownbox abrt: detected unhandled Python exception
Sep 13 20:25:14 brownbox /etc/gdm/Xsession[693]: Crash report available at /home/mediauser/xbmc_crashlog-20130913_202511.log
Sep 13 20:26:11 brownbox kernel: [ 2794.400352] abrt-handle-eve[1062]: segfault at 0 ip 00007ffdfece8248 sp 00007fff28c6cb58 error 4 in libsatyr.so.1.0.0[7ffdfec90000+13e000]
Sep 13 20:26:11 brownbox abrt[1213]: Saved core dump of pid 1062 (/usr/libexec/abrt-handle-event) to /var/tmp/abrt/abrt-handle-event-coredump (2142208 bytes)
Sep 13 20:26:11 brownbox abrtd: 'post-create' on '/var/tmp/abrt/ccpp-2013-09-13-20:25:06-757' killed by signal 11
Sep 13 20:26:11 brownbox abrtd: Deleting problem directory '/var/tmp/abrt/ccpp-2013-09-13-20:25:06-757'
=============

(2013-09-13, 13:19)MattH7 Wrote: [ -> ]Sorry for the delay - haven't had a chance to sit down again and take a look. Here are the relevant log files. Hope this helps. Unfortunately can't upload attachments - so posting multipart reply.

(edited after worked out how to use xbmclogs)
<SNIP>

Confirmed this affects XBMC when playing via DVI with sound card, not just audio/video over HDMI.

Same files play perfectly fine with XBMC from rpmfusion under Fedora 17 (Eden) on same hardware and with same configuration (ALSA only).
I've gone back to Fedora 17 now on the media center, but have upgraded my dev workstation to Fedora 19 and captured disk image from my HTPC so I can come back to it later.
This also seems to be an issue even with ffmpeg 1.2.3 installed, so I think it's XBMC and not ffmpeg that's the issue (until someone can take a look and show otherwise).