Login at Kodi Home

AuditeMarlow · (This post was last modified: 2017-02-06, 23:27 by AuditeMarlow.)

I'm running Arch Linux on my Raspberry Pi 3 and updated Kodi to version 17 this morning. I must say, I'm pretty comfortable with the new layout design. Although, when I try to playback any video, Kodi freezes instantly, then exits minutes later to give me a crash report. Below is an output of my most recent Kodi crash log:

Code:

marlow@ArchMarlow ~                                                               [15:42:34] 

> $ cat kodi_crashlog-20170206_124933.log                                                   

############## Kodi CRASH LOG ###############



################ SYSTEM INFO ################

Date: Mon Feb  6 12:49:33 CET 2017

Kodi Options: 

Arch: armv7l

Kernel: Linux 4.4.46-1-ARCH #1 SMP Fri Feb 3 19:02:01 MST 2017

Release: Arch Linux ARM

############## END SYSTEM INFO ##############



############### STACK TRACE #################

gdb not installed, can't get stack trace.

############# END STACK TRACE ###############



################# LOG FILE ##################



12:46:35.749 T:1942933504  NOTICE: special://profile/ is mapped to: special://masterprofile/

12:46:35.749 T:1942933504  NOTICE: -----------------------------------------------------------------------

12:46:35.749 T:1942933504  NOTICE: Starting Kodi (17.0 Git:20170205-nogitfound). Platform: Linux ARM 32-bit

12:46:35.749 T:1942933504  NOTICE: Using Release Kodi x32 build (version for Raspberry Pi)

12:46:35.749 T:1942933504  NOTICE: Kodi compiled Feb  4 2017 by GCC 6.3.1 for Linux ARM 32-bit version 4.7.0 (263936)

12:46:35.750 T:1942933504  NOTICE: Running on Arch Linux ARM rolling, kernel: Linux ARM 32-bit version 4.4.46-1-ARCH

12:46:35.759 T:1942933504  NOTICE: FFmpeg version/source: ffmpeg-3.1-kodi

12:46:35.759 T:1942933504  NOTICE: Host CPU: ARMv7 Processor rev 4 (v7l), 4 cores available

12:46:35.759 T:1942933504  NOTICE: ARM Features: Neon enabled

12:46:35.760 T:1942933504  NOTICE: special://xbmc/ is mapped to: /usr/share/kodi

12:46:35.760 T:1942933504  NOTICE: special://xbmcbin/ is mapped to: /usr/lib/kodi

12:46:35.760 T:1942933504  NOTICE: special://xbmcbinaddons/ is mapped to: /usr/lib/kodi/addons

12:46:35.760 T:1942933504  NOTICE: special://masterprofile/ is mapped to: /home/alarm/.kodi/userdata

12:46:35.760 T:1942933504  NOTICE: special://envhome/ is mapped to: /home/alarm

12:46:35.760 T:1942933504  NOTICE: special://home/ is mapped to: /home/alarm/.kodi

12:46:35.760 T:1942933504  NOTICE: special://temp/ is mapped to: /home/alarm/.kodi/temp

12:46:35.760 T:1942933504  NOTICE: special://logpath/ is mapped to: /home/alarm/.kodi/temp

12:46:35.760 T:1942933504  NOTICE: The executable running is: /usr/lib/kodi/kodi.bin

12:46:35.760 T:1942933504  NOTICE: Local hostname: RPi3

12:46:35.760 T:1942933504  NOTICE: Log File is located: /home/alarm/.kodi/temp//kodi.log

12:46:35.760 T:1942933504  NOTICE: -----------------------------------------------------------------------

12:46:35.882 T:1942933504   ERROR: DBus: Error org.freedesktop.DBus.Error.ServiceUnknown - The name org.freedesktop.UPower was not provided by any .service files

12:46:35.886 T:1942933504   ERROR: DBus: Error org.freedesktop.DBus.Error.AccessDenied - Permission denied

12:46:35.904 T:1942933504   ERROR: Previous line repeats 1 times.

12:46:35.904 T:1942933504   ERROR: DBus: Error org.freedesktop.DBus.Error.ServiceUnknown - The name org.freedesktop.PolicyKit1 was not provided by any .service files

12:46:35.904 T:1942933504 WARNING: LogindUPowerSyscall - failed to inhibit sleep delay lock

12:46:35.918 T:1942933504  NOTICE: load settings...

12:46:36.083 T:1942933504  NOTICE: Found 1 Lists of Devices

12:46:36.083 T:1942933504  NOTICE: Enumerated PI devices:

12:46:36.083 T:1942933504  NOTICE:     Device 1

12:46:36.083 T:1942933504  NOTICE:         m_deviceName      : HDMI

12:46:36.083 T:1942933504  NOTICE:         m_displayName     : HDMI

12:46:36.083 T:1942933504  NOTICE:         m_displayNameExtra:

12:46:36.083 T:1942933504  NOTICE:         m_deviceType      : AE_DEVTYPE_HDMI

12:46:36.083 T:1942933504  NOTICE:         m_channels        : FL,FR

12:46:36.083 T:1942933504  NOTICE:         m_sampleRates     : 8000,11025,16000,22050,24000,32000,44100,48000,88200,96000,176400,192000

12:46:36.083 T:1942933504  NOTICE:         m_dataFormats     : AE_FMT_FLOAT,AE_FMT_S32NE,AE_FMT_S16NE,AE_FMT_S32LE,AE_FMT_S16LE,AE_FMT_FLOATP,AE_FMT_S32NEP,AE_FMT_S16NEP,AE_FMT_RAW

12:46:36.084 T:1942933504  NOTICE:         m_streamTypes     : STREAM_TYPE_AC3,STREAM_TYPE_EAC3,STREAM_TYPE_DTSHD_CORE,STREAM_TYPE_DTS_2048,STREAM_TYPE_DTS_1024,STREAM_TYPE_DTS_512

12:46:36.084 T:1942933504  NOTICE:     Device 2

12:46:36.084 T:1942933504  NOTICE:         m_deviceName      : Analogue

12:46:36.084 T:1942933504  NOTICE:         m_displayName     : Analogue

12:46:36.084 T:1942933504  NOTICE:         m_displayNameExtra:

12:46:36.084 T:1942933504  NOTICE:         m_deviceType      : AE_DEVTYPE_PCM

12:46:36.084 T:1942933504  NOTICE:         m_channels        : FL,FR

12:46:36.084 T:1942933504  NOTICE:         m_sampleRates     : 48000

12:46:36.084 T:1942933504  NOTICE:         m_dataFormats     : AE_FMT_FLOAT,AE_FMT_S32LE,AE_FMT_S16LE,AE_FMT_FLOATP,AE_FMT_S32NEP,AE_FMT_S16NEP

12:46:36.084 T:1942933504  NOTICE:         m_streamTypes     : No passthrough capabilities

12:46:36.084 T:1942933504  NOTICE:     Device 3

12:46:36.084 T:1942933504  NOTICE:         m_deviceName      : Both

12:46:36.084 T:1942933504  NOTICE:         m_displayName     : HDMI and Analogue

12:46:36.084 T:1942933504  NOTICE:         m_displayNameExtra:

12:46:36.084 T:1942933504  NOTICE:         m_deviceType      : AE_DEVTYPE_PCM

12:46:36.084 T:1942933504  NOTICE:         m_channels        : FL,FR

12:46:36.084 T:1942933504  NOTICE:         m_sampleRates     : 48000

12:46:36.085 T:1942933504  NOTICE:         m_dataFormats     : AE_FMT_FLOAT,AE_FMT_S32LE,AE_FMT_S16LE,AE_FMT_FLOATP,AE_FMT_S32NEP,AE_FMT_S16NEP

12:46:36.085 T:1942933504  NOTICE:         m_streamTypes     : No passthrough capabilities

12:46:36.110 T:1942933504  NOTICE: No settings file to load (special://xbmc/system/advancedsettings.xml)

12:46:36.111 T:1942933504  NOTICE: No settings file to load (special://masterprofile/advancedsettings.xml)

12:46:36.111 T:1942933504  NOTICE: Default Video Player: VideoPlayer

12:46:36.111 T:1942933504  NOTICE: Default Audio Player: paplayer

12:46:36.111 T:1942933504  NOTICE: Disabled debug logging due to GUI setting. Level 0.

12:46:36.111 T:1942933504  NOTICE: Log level changed to "LOG_LEVEL_NORMAL"

12:46:36.111 T:1942933504  NOTICE: CMediaSourceSettings: loading media sources from special://masterprofile/sources.xml

12:46:36.114 T:1942933504  NOTICE: Loading player core factory settings from special://xbmc/system/playercorefactory.xml.

12:46:36.125 T:1942933504  NOTICE: Loaded playercorefactory configuration

12:46:36.125 T:1942933504  NOTICE: Loading player core factory settings from special://masterprofile/playercorefactory.xml.

12:46:36.126 T:1942933504  NOTICE: special://masterprofile/playercorefactory.xml does not exist. Skipping.

11:46:36.222 T:1942933504  NOTICE: Running database version Addons27

11:46:36.751 T:1942933504  NOTICE: ADDONS: Using repository repository.xbmc.org

11:46:36.980 T:1942933504  NOTICE: Raspberry PI firmware version: Jan 31 2017 17:40:14 

                                            Copyright (c) 2012 Broadcom

                                            version 8d94fbc3bbdde25c29b18a2572a5c60ee75c56f3 (clean) (release)

11:46:36.980 T:1942933504  NOTICE: ARM mem: 752MB GPU mem: 256MB MPG2:0 WVC1:0

11:46:36.980 T:1942933504  NOTICE: Config:

                                            arm_freq=1200

                                            audio_pwm_mode=1

                                            config_hdmi_boost=5

                                            core_freq=400

                                            desired_osc_freq=0x36ee80

                                            disable_commandline_tags=2

                                            disable_l2cache=1

                                            force_eeprom_read=1

                                            force_pwm_open=1

                                            framebuffer_depth=32

                                            framebuffer_ignore_alpha=1

                                            framebuffer_swap=1

                                            gpu_freq=300

                                            hdmi_channel_map=8

                                            hdmi_force_cec_address=65535

                                            init_uart_clock=0x2dc6c00

                                            lcd_framerate=60

                                            over_voltage_avs=0x19f0a

                                            over_voltage_avs_boost=0x19f0a

                                            pause_burst_frames=1

                                            program_serial_random=1

                                            sdram_freq=450

                                            temp_limit=85

11:46:36.981 T:1942933504  NOTICE: Config:

                                            device_tree=-

11:46:36.981 T:1942933504  NOTICE: InitWindowSystem: Using EGL Implementation: raspberrypi

11:46:36.983 T:1942933504  NOTICE: Found resolution 640 x 480 for display 0 with 640 x 480 @ 60.000000 Hz

11:46:36.984 T:1942933504  NOTICE: Found resolution 640 x 480 for display 0 with 640 x 480 @ 59.940063 Hz

11:46:36.984 T:1942933504  NOTICE: Found resolution 800 x 600 for display 0 with 800 x 600 @ 60.000000 Hz

11:46:36.984 T:1942933504  NOTICE: Found resolution 800 x 600 for display 0 with 800 x 600 @ 59.940063 Hz

11:46:36.984 T:1942933504  NOTICE: Found resolution 1024 x 768 for display 0 with 1024 x 768 @ 60.000000 Hz

11:46:36.984 T:1942933504  NOTICE: Found resolution 1024 x 768 for display 0 with 1024 x 768 @ 59.940063 Hz

11:46:36.984 T:1942933504  NOTICE: Found resolution 1280 x 1024 for display 0 with 1280 x 1024 @ 60.000000 Hz

11:46:36.984 T:1942933504  NOTICE: Found resolution 1280 x 1024 for display 0 with 1280 x 1024 @ 59.940063 Hz

11:46:36.984 T:1942933504  NOTICE: Found resolution 1360 x 768 for display 0 with 1360 x 768 @ 60.000000 Hz

11:46:36.984 T:1942933504  NOTICE: Found resolution 1360 x 768 for display 0 with 1360 x 768 @ 59.940063 Hz

11:46:36.984 T:1942933504  NOTICE: Found resolution 720 x 480 for display 0 with 720 x 480 @ 60.000000 Hz

11:46:36.984 T:1942933504  NOTICE: Found resolution 720 x 480 for display 0 with 720 x 480 @ 59.940063 Hz

11:46:36.984 T:1942933504  NOTICE: Found resolution 1280 x 720 for display 0 with 1280 x 720 @ 60.000000 Hz

11:46:36.984 T:1942933504  NOTICE: Found resolution 1280 x 720 for display 0 with 1280 x 720 @ 59.940063 Hz

11:46:36.984 T:1942933504  NOTICE: Found resolution 1920 x 1080 for display 0 with 1920 x 1080 @ 60.000000 Hz

11:46:36.984 T:1942933504  NOTICE: Found resolution 1920 x 1080 for display 0 with 1920 x 1080 @ 59.940063 Hz

11:46:36.984 T:1942933504  NOTICE: Found resolution 720 x 576 for display 0 with 720 x 576 @ 50.000000 Hz

11:46:36.984 T:1942933504  NOTICE: Found resolution 1280 x 720 for display 0 with 1280 x 720 @ 50.000000 Hz

11:46:36.985 T:1942933504  NOTICE: Found resolution 1920 x 1080 for display 0 with 1920 x 1080 @ 50.000000 Hz

11:46:36.985 T:1942933504  NOTICE: Found resolution 1920 x 1080 for display 0 with 1920 x 1080 @ 24.000000 Hz

11:46:36.985 T:1942933504  NOTICE: Found resolution 1920 x 1080 for display 0 with 1920 x 1080 @ 23.976025 Hz

11:46:36.985 T:1942933504  NOTICE: Found resolution 1920 x 1080 for display 0 with 1920 x 1080 @ 25.000000 Hz

11:46:36.985 T:1942933504  NOTICE: Found resolution 1920 x 1080 for display 0 with 1920 x 1080 @ 30.000000 Hz

11:46:36.985 T:1942933504  NOTICE: Found resolution 1920 x 1080 for display 0 with 1920 x 1080 @ 29.970032 Hz

11:46:36.985 T:1942933504  NOTICE: Found ([email protected]) at 30, setting to RES_DESKTOP at 16

11:46:36.985 T:1942933504  NOTICE: Checking resolution 16

11:46:37.275 T:1942933504  NOTICE: GL_VENDOR = Broadcom

11:46:37.275 T:1942933504  NOTICE: GL_RENDERER = VideoCore IV HW

11:46:37.275 T:1942933504  NOTICE: GL_VERSION = OpenGL ES 2.0

11:46:37.275 T:1942933504  NOTICE: GL_SHADING_LANGUAGE_VERSION = OpenGL ES GLSL ES 1.00

11:46:37.275 T:1942933504  NOTICE: GL_EXTENSIONS = GL_OES_compressed_ETC1_RGB8_texture GL_OES_compressed_paletted_texture GL_OES_texture_npot GL_OES_depth24 GL_OES_vertex_half_float GL_OES_EGL_image GL_OES_EGL_image_external GL_EXT_discard_framebuffer GL_OES_rgb8_rgba8 GL_OES_depth32 GL_OES_mapbuffer GL_EXT_texture_format_BGRA8888 GL_APPLE_rgb_422 GL_EXT_debug_marker

11:46:38.809 T:1922036624  NOTICE: Running database version Addons27

11:46:38.815 T:1922036624  NOTICE: Running database version ViewModes6

11:46:38.826 T:1922036624  NOTICE: Running database version Textures13

11:46:38.849 T:1922036624  NOTICE: Running database version MyMusic60

11:46:38.881 T:1922036624  NOTICE: Running database version MyVideos107

11:46:38.889 T:1922036624  NOTICE: Running database version TV29

11:46:38.896 T:1922036624  NOTICE: Running database version Epg11

11:46:38.904 T:1942933504  NOTICE: start dvd mediatype detection

11:46:38.984 T:1805882256  NOTICE: Register - new cec device registered on cec->RPI: CEC Adapter (2708:1001)

11:46:39.024 T:1942933504 WARNING: CSkinInfo: failed to load skin settings

11:46:39.819 T:1942933504 WARNING: JSONRPC: Could not parse type "Setting.Details.SettingList"

11:46:40.263 T:1942933504  NOTICE: initialize done

11:46:40.264 T:1942933504  NOTICE: Running the application...

11:46:40.281 T:1942933504  NOTICE: starting zeroconf publishing

11:46:40.281 T:1942933504  NOTICE: starting upnp client

11:46:40.375 T:1579922320  NOTICE: ES: Starting UDP Event server on port 9777

11:46:40.375 T:1579922320  NOTICE: UDP: Listening on port 9777 (ipv6 : false)

11:46:42.175 T:1692644240  NOTICE: Skin Helper Service --> skin helper service version 1.0.100 started

11:46:42.218 T:1692644240  NOTICE: Skin Helper Service --> WebService - start helper webservice on port 52307

11:46:51.711 T:1666167696   ERROR: GetDirectory - Error getting

11:46:57.307 T:1922036624   ERROR: Previous line repeats 6 times.

11:46:57.307 T:1922036624  NOTICE: CDVDVideoCodecFFmpeg::Open() Using codec: H.264 / AVC / MPEG-4 AVC / MPEG-4 part 10

11:46:58.115 T:1942933504  NOTICE: VideoPlayer: Opening: /mnt/media/videos/Movies/The 5th Wave [2016]/5 W 2016 WEBDL 1080P.mkv

11:46:58.116 T:1942933504 WARNING: CDVDMessageQueue(player)::Put MSGQ_NOT_INITIALIZED

11:46:58.121 T:1473246096  NOTICE: Creating InputStream

11:46:58.124 T:1473246096  NOTICE: Creating Demuxer

11:46:58.163 T:1473246096  NOTICE: Opening stream: 0 source: 256

11:46:58.163 T:1473246096  NOTICE: Creating video codec with codec id: 28

11:46:58.173 T:1473246096   ERROR: CMMALVideo::Open Failed to create pool for decoder input port (status=0 SUCCESS)

11:46:58.181 T:1473246096  NOTICE: CDVDVideoCodecFFmpeg::Open() Using codec: H.264 / AVC / MPEG-4 AVC / MPEG-4 part 10

11:46:58.182 T:1473246096  NOTICE: Creating video thread

11:46:58.182 T:1473246096  NOTICE: Opening stream: 1 source: 256

11:46:58.182 T:1481634704  NOTICE: running thread: video_thread

11:46:58.182 T:1473246096  NOTICE: Finding audio codec for: 86019

11:46:58.183 T:1473246096  NOTICE: Creating audio thread

11:46:58.183 T:1588310928  NOTICE: running thread: CVideoPlayerAudio::Process()

11:46:58.183 T:1473246096  NOTICE: Opening stream: 0 source: 1024

11:46:58.310 T:1481634704  NOTICE: CDecoder::Open - fmt:0

11:46:58.316 T:1481634704   ERROR: mbox_property: ioctl_set_msg failed:-1





############### END LOG FILE ################



############ END Kodi CRASH LOG #############

Now I'm not really a video professional so I can't personally make out anything of this. What I did notice is that this Kodi version was compiled for Linux kernel 4.7, and I'm still running 4.4. This may be a problem from my point of view.

**popcornmix** · 2017-02-06, 17:27

You should really ask in an arch forum as this looks to be an environment issue.

Code:
11:46:58.316 T:1481634704 ERROR: mbox_property: ioctl_set_msg failed:-1

is probably the cause. Hardware video decode requires access to certain device nodes:

Code:
$ ls -l /dev/vcio /dev/vcsm /dev/vchiq 

crw-rw---- 1 root video 248, 0 Feb  5 23:17 /dev/vchiq

crw-rw---- 1 root video 249, 0 Feb  5 23:17 /dev/vcio

crw-rw---- 1 root video 246, 0 Feb  5 23:17 /dev/vcsm

$ groups pi

pi : pi adm dialout cdrom sudo audio video plugdev games users input netdev spi i2c gpio

i.e. the user running kodi should be in group "video" and video should have rw access to devices vcio, vcsm and vchiq.
I suspect you do not have that.

AuditeMarlow · 2017-02-06, 17:40

I've just added the user I run Kodi with to the group "video", without any improvements. Below is an output of the devices you've listed before, and my most recent Kodi crash report.

Code:
RPi3# ls -l /dev/vcio /dev/vcsm /dev/vchiq

crwxrwxrwx 1 root video 248, 0 Feb  1 02:10 /dev/vchiq

crw-rw---- 1 root video 249, 0 Feb  1 02:10 /dev/vcio

crw-rw---- 1 root video 246, 0 Feb  1 02:10 /dev/vcsm

RPi3# groups alarm 

video alarm

Code:

############## Kodi CRASH LOG ###############



################ SYSTEM INFO ################

Date: Mon Feb  6 16:35:56 CET 2017

Kodi Options: 

Arch: armv7l

Kernel: Linux 4.4.46-1-ARCH #1 SMP Fri Feb 3 19:02:01 MST 2017

Release: Arch Linux ARM

############## END SYSTEM INFO ##############



############### STACK TRACE #################

gdb not installed, can't get stack trace.

############# END STACK TRACE ###############



################# LOG FILE ##################



16:32:14.352 T:1943613440  NOTICE: special://profile/ is mapped to: special://masterprofile/

16:32:14.352 T:1943613440  NOTICE: -----------------------------------------------------------------------

16:32:14.352 T:1943613440  NOTICE: Starting Kodi (17.0 Git:20170205-nogitfound). Platform: Linux ARM 32-bit

16:32:14.352 T:1943613440  NOTICE: Using Release Kodi x32 build (version for Raspberry Pi)

16:32:14.352 T:1943613440  NOTICE: Kodi compiled Feb  4 2017 by GCC 6.3.1 for Linux ARM 32-bit version 4.7.0 (263936)

16:32:14.352 T:1943613440  NOTICE: Running on Arch Linux ARM rolling, kernel: Linux ARM 32-bit version 4.4.46-1-ARCH

16:32:14.352 T:1943613440  NOTICE: FFmpeg version/source: ffmpeg-3.1-kodi

16:32:14.352 T:1943613440  NOTICE: Host CPU: ARMv7 Processor rev 4 (v7l), 4 cores available

16:32:14.352 T:1943613440  NOTICE: ARM Features: Neon enabled

16:32:14.352 T:1943613440  NOTICE: special://xbmc/ is mapped to: /usr/share/kodi

16:32:14.352 T:1943613440  NOTICE: special://xbmcbin/ is mapped to: /usr/lib/kodi

16:32:14.352 T:1943613440  NOTICE: special://xbmcbinaddons/ is mapped to: /usr/lib/kodi/addons

16:32:14.352 T:1943613440  NOTICE: special://masterprofile/ is mapped to: /home/alarm/.kodi/userdata

16:32:14.352 T:1943613440  NOTICE: special://envhome/ is mapped to: /home/alarm

16:32:14.352 T:1943613440  NOTICE: special://home/ is mapped to: /home/alarm/.kodi

16:32:14.353 T:1943613440  NOTICE: special://temp/ is mapped to: /home/alarm/.kodi/temp

16:32:14.353 T:1943613440  NOTICE: special://logpath/ is mapped to: /home/alarm/.kodi/temp

16:32:14.353 T:1943613440  NOTICE: The executable running is: /usr/lib/kodi/kodi.bin

16:32:14.353 T:1943613440  NOTICE: Local hostname: RPi3

16:32:14.353 T:1943613440  NOTICE: Log File is located: /home/alarm/.kodi/temp//kodi.log

16:32:14.353 T:1943613440  NOTICE: -----------------------------------------------------------------------

16:32:14.359 T:1943613440   ERROR: DBus: Error org.freedesktop.DBus.Error.ServiceUnknown - The name org.freedesktop.UPower was not provided by any .service files

16:32:14.360 T:1943613440   ERROR: DBus: Error org.freedesktop.DBus.Error.AccessDenied - Permission denied

16:32:14.365 T:1943613440   ERROR: Previous line repeats 1 times.

16:32:14.365 T:1943613440   ERROR: DBus: Error org.freedesktop.DBus.Error.ServiceUnknown - The name org.freedesktop.PolicyKit1 was not provided by any .service files

16:32:14.365 T:1943613440 WARNING: LogindUPowerSyscall - failed to inhibit sleep delay lock

16:32:14.367 T:1943613440  NOTICE: load settings...

16:32:14.421 T:1943613440  NOTICE: Found 1 Lists of Devices

16:32:14.421 T:1943613440  NOTICE: Enumerated PI devices:

16:32:14.421 T:1943613440  NOTICE:     Device 1

16:32:14.421 T:1943613440  NOTICE:         m_deviceName      : HDMI

16:32:14.421 T:1943613440  NOTICE:         m_displayName     : HDMI

16:32:14.421 T:1943613440  NOTICE:         m_displayNameExtra:

16:32:14.422 T:1943613440  NOTICE:         m_deviceType      : AE_DEVTYPE_HDMI

16:32:14.422 T:1943613440  NOTICE:         m_channels        : FL,FR

16:32:14.422 T:1943613440  NOTICE:         m_sampleRates     : 8000,11025,16000,22050,24000,32000,44100,48000,88200,96000,176400,192000

16:32:14.422 T:1943613440  NOTICE:         m_dataFormats     : AE_FMT_FLOAT,AE_FMT_S32NE,AE_FMT_S16NE,AE_FMT_S32LE,AE_FMT_S16LE,AE_FMT_FLOATP,AE_FMT_S32NEP,AE_FMT_S16NEP,AE_FMT_RAW

16:32:14.422 T:1943613440  NOTICE:         m_streamTypes     : STREAM_TYPE_AC3,STREAM_TYPE_EAC3,STREAM_TYPE_DTSHD_CORE,STREAM_TYPE_DTS_2048,STREAM_TYPE_DTS_1024,STREAM_TYPE_DTS_512

16:32:14.422 T:1943613440  NOTICE:     Device 2

16:32:14.422 T:1943613440  NOTICE:         m_deviceName      : Analogue

16:32:14.422 T:1943613440  NOTICE:         m_displayName     : Analogue

16:32:14.422 T:1943613440  NOTICE:         m_displayNameExtra:

16:32:14.422 T:1943613440  NOTICE:         m_deviceType      : AE_DEVTYPE_PCM

16:32:14.422 T:1943613440  NOTICE:         m_channels        : FL,FR

16:32:14.422 T:1943613440  NOTICE:         m_sampleRates     : 48000

16:32:14.422 T:1943613440  NOTICE:         m_dataFormats     : AE_FMT_FLOAT,AE_FMT_S32LE,AE_FMT_S16LE,AE_FMT_FLOATP,AE_FMT_S32NEP,AE_FMT_S16NEP

16:32:14.422 T:1943613440  NOTICE:         m_streamTypes     : No passthrough capabilities

16:32:14.422 T:1943613440  NOTICE:     Device 3

16:32:14.422 T:1943613440  NOTICE:         m_deviceName      : Both

16:32:14.422 T:1943613440  NOTICE:         m_displayName     : HDMI and Analogue

16:32:14.422 T:1943613440  NOTICE:         m_displayNameExtra:

16:32:14.422 T:1943613440  NOTICE:         m_deviceType      : AE_DEVTYPE_PCM

16:32:14.422 T:1943613440  NOTICE:         m_channels        : FL,FR

16:32:14.422 T:1943613440  NOTICE:         m_sampleRates     : 48000

16:32:14.422 T:1943613440  NOTICE:         m_dataFormats     : AE_FMT_FLOAT,AE_FMT_S32LE,AE_FMT_S16LE,AE_FMT_FLOATP,AE_FMT_S32NEP,AE_FMT_S16NEP

16:32:14.422 T:1943613440  NOTICE:         m_streamTypes     : No passthrough capabilities

16:32:14.431 T:1943613440  NOTICE: No settings file to load (special://xbmc/system/advancedsettings.xml)

16:32:14.431 T:1943613440  NOTICE: No settings file to load (special://masterprofile/advancedsettings.xml)

16:32:14.431 T:1943613440  NOTICE: Default Video Player: VideoPlayer

16:32:14.431 T:1943613440  NOTICE: Default Audio Player: paplayer

16:32:14.431 T:1943613440  NOTICE: Disabled debug logging due to GUI setting. Level 0.

16:32:14.431 T:1943613440  NOTICE: Log level changed to "LOG_LEVEL_NORMAL"

16:32:14.431 T:1943613440  NOTICE: CMediaSourceSettings: loading media sources from special://masterprofile/sources.xml

16:32:14.432 T:1943613440  NOTICE: Loading player core factory settings from special://xbmc/system/playercorefactory.xml.

16:32:14.433 T:1943613440  NOTICE: Loaded playercorefactory configuration

16:32:14.433 T:1943613440  NOTICE: Loading player core factory settings from special://masterprofile/playercorefactory.xml.

16:32:14.433 T:1943613440  NOTICE: special://masterprofile/playercorefactory.xml does not exist. Skipping.

15:32:14.453 T:1943613440  NOTICE: Running database version Addons27

15:32:14.556 T:1943613440  NOTICE: ADDONS: Using repository repository.xbmc.org

15:32:14.614 T:1943613440  NOTICE: Raspberry PI firmware version: Jan 31 2017 17:40:14 

                                            Copyright (c) 2012 Broadcom

                                            version 8d94fbc3bbdde25c29b18a2572a5c60ee75c56f3 (clean) (release)

15:32:14.614 T:1943613440  NOTICE: ARM mem: 752MB GPU mem: 256MB MPG2:0 WVC1:0

15:32:14.614 T:1943613440  NOTICE: Config:

                                            arm_freq=1200

                                            audio_pwm_mode=1

                                            config_hdmi_boost=5

                                            core_freq=400

                                            desired_osc_freq=0x36ee80

                                            disable_commandline_tags=2

                                            disable_l2cache=1

                                            force_eeprom_read=1

                                            force_pwm_open=1

                                            framebuffer_depth=32

                                            framebuffer_ignore_alpha=1

                                            framebuffer_swap=1

                                            gpu_freq=300

                                            hdmi_channel_map=8

                                            hdmi_force_cec_address=65535

                                            init_uart_clock=0x2dc6c00

                                            lcd_framerate=60

                                            over_voltage_avs=0x19f0a

                                            over_voltage_avs_boost=0x19f0a

                                            pause_burst_frames=1

                                            program_serial_random=1

                                            sdram_freq=450

                                            temp_limit=85

15:32:14.614 T:1943613440  NOTICE: Config:

                                            device_tree=-

15:32:14.614 T:1943613440  NOTICE: InitWindowSystem: Using EGL Implementation: raspberrypi

15:32:14.616 T:1943613440  NOTICE: Found resolution 640 x 480 for display 0 with 640 x 480 @ 60.000000 Hz

15:32:14.616 T:1943613440  NOTICE: Found resolution 640 x 480 for display 0 with 640 x 480 @ 59.940063 Hz

15:32:14.616 T:1943613440  NOTICE: Found resolution 800 x 600 for display 0 with 800 x 600 @ 60.000000 Hz

15:32:14.616 T:1943613440  NOTICE: Found resolution 800 x 600 for display 0 with 800 x 600 @ 59.940063 Hz

15:32:14.616 T:1943613440  NOTICE: Found resolution 1024 x 768 for display 0 with 1024 x 768 @ 60.000000 Hz

15:32:14.616 T:1943613440  NOTICE: Found resolution 1024 x 768 for display 0 with 1024 x 768 @ 59.940063 Hz

15:32:14.616 T:1943613440  NOTICE: Found resolution 1280 x 1024 for display 0 with 1280 x 1024 @ 60.000000 Hz

15:32:14.616 T:1943613440  NOTICE: Found resolution 1280 x 1024 for display 0 with 1280 x 1024 @ 59.940063 Hz

15:32:14.616 T:1943613440  NOTICE: Found resolution 1360 x 768 for display 0 with 1360 x 768 @ 60.000000 Hz

15:32:14.616 T:1943613440  NOTICE: Found resolution 1360 x 768 for display 0 with 1360 x 768 @ 59.940063 Hz

15:32:14.616 T:1943613440  NOTICE: Found resolution 720 x 480 for display 0 with 720 x 480 @ 60.000000 Hz

15:32:14.616 T:1943613440  NOTICE: Found resolution 720 x 480 for display 0 with 720 x 480 @ 59.940063 Hz

15:32:14.616 T:1943613440  NOTICE: Found resolution 1280 x 720 for display 0 with 1280 x 720 @ 60.000000 Hz

15:32:14.616 T:1943613440  NOTICE: Found resolution 1280 x 720 for display 0 with 1280 x 720 @ 59.940063 Hz

15:32:14.616 T:1943613440  NOTICE: Found resolution 1920 x 1080 for display 0 with 1920 x 1080 @ 60.000000 Hz

15:32:14.616 T:1943613440  NOTICE: Found resolution 1920 x 1080 for display 0 with 1920 x 1080 @ 59.940063 Hz

15:32:14.616 T:1943613440  NOTICE: Found resolution 720 x 576 for display 0 with 720 x 576 @ 50.000000 Hz

15:32:14.616 T:1943613440  NOTICE: Found resolution 1280 x 720 for display 0 with 1280 x 720 @ 50.000000 Hz

15:32:14.616 T:1943613440  NOTICE: Found resolution 1920 x 1080 for display 0 with 1920 x 1080 @ 50.000000 Hz

15:32:14.616 T:1943613440  NOTICE: Found resolution 1920 x 1080 for display 0 with 1920 x 1080 @ 24.000000 Hz

15:32:14.617 T:1943613440  NOTICE: Found resolution 1920 x 1080 for display 0 with 1920 x 1080 @ 23.976025 Hz

15:32:14.617 T:1943613440  NOTICE: Found resolution 1920 x 1080 for display 0 with 1920 x 1080 @ 25.000000 Hz

15:32:14.617 T:1943613440  NOTICE: Found resolution 1920 x 1080 for display 0 with 1920 x 1080 @ 30.000000 Hz

15:32:14.617 T:1943613440  NOTICE: Found resolution 1920 x 1080 for display 0 with 1920 x 1080 @ 29.970032 Hz

15:32:14.617 T:1943613440  NOTICE: Found ([email protected]) at 30, setting to RES_DESKTOP at 16

15:32:14.617 T:1943613440  NOTICE: Checking resolution 16

15:32:14.899 T:1943613440  NOTICE: GL_VENDOR = Broadcom

15:32:14.899 T:1943613440  NOTICE: GL_RENDERER = VideoCore IV HW

15:32:14.899 T:1943613440  NOTICE: GL_VERSION = OpenGL ES 2.0

15:32:14.899 T:1943613440  NOTICE: GL_SHADING_LANGUAGE_VERSION = OpenGL ES GLSL ES 1.00

15:32:14.899 T:1943613440  NOTICE: GL_EXTENSIONS = GL_OES_compressed_ETC1_RGB8_texture GL_OES_compressed_paletted_texture GL_OES_texture_npot GL_OES_depth24 GL_OES_vertex_half_float GL_OES_EGL_image GL_OES_EGL_image_external GL_EXT_discard_framebuffer GL_OES_rgb8_rgba8 GL_OES_depth32 GL_OES_mapbuffer GL_EXT_texture_format_BGRA8888 GL_APPLE_rgb_422 GL_EXT_debug_marker

15:32:15.809 T:1923085200  NOTICE: Running database version Addons27

15:32:15.810 T:1923085200  NOTICE: Running database version ViewModes6

15:32:15.812 T:1923085200  NOTICE: Running database version Textures13

15:32:15.818 T:1923085200  NOTICE: Running database version MyMusic60

15:32:15.828 T:1923085200  NOTICE: Running database version MyVideos107

15:32:15.830 T:1923085200  NOTICE: Running database version TV29

15:32:15.832 T:1923085200  NOTICE: Running database version Epg11

15:32:15.835 T:1943613440  NOTICE: start dvd mediatype detection

15:32:15.888 T:1943613440 WARNING: CSkinInfo: failed to load skin settings

15:32:15.905 T:1806611344  NOTICE: Register - new cec device registered on cec->RPI: CEC Adapter (2708:1001)

15:32:16.428 T:1943613440 WARNING: JSONRPC: Could not parse type "Setting.Details.SettingList"

15:32:16.685 T:1943613440  NOTICE: initialize done

15:32:16.685 T:1943613440  NOTICE: Running the application...

15:32:16.695 T:1943613440  NOTICE: starting zeroconf publishing

15:32:16.695 T:1943613440  NOTICE: starting upnp client

15:32:16.699 T:1614803856  NOTICE: ES: Starting UDP Event server on port 9777

15:32:16.700 T:1614803856  NOTICE: UDP: Listening on port 9777 (ipv6 : false)

15:32:17.742 T:1693385616  NOTICE: Skin Helper Service --> skin helper service version 1.0.100 started

15:32:17.746 T:1693385616  NOTICE: Skin Helper Service --> WebService - start helper webservice on port 52307

15:32:20.620 T:1683686288   ERROR: GetDirectory - Error getting

15:32:30.502 T:1943613440   ERROR: Previous line repeats 6 times.

15:32:30.502 T:1943613440  NOTICE: VideoPlayer: Opening: /mnt/media/videos/TV Series/Steven Universe/Season 1/[AliQ] S00E00 - Pilot.mp4

15:32:30.502 T:1943613440 WARNING: CDVDMessageQueue(player)::Put MSGQ_NOT_INITIALIZED

15:32:30.503 T:1598026640  NOTICE: Creating InputStream

15:32:30.512 T:1598026640  NOTICE: Creating Demuxer

15:32:30.612 T:1598026640  NOTICE: Opening stream: 0 source: 256

15:32:30.613 T:1598026640  NOTICE: Creating video codec with codec id: 28

15:32:30.623 T:1598026640   ERROR: CMMALVideo::Open Failed to create pool for decoder input port (status=0 SUCCESS)

15:32:30.627 T:1598026640  NOTICE: CDVDVideoCodecFFmpeg::Open() Using codec: H.264 / AVC / MPEG-4 AVC / MPEG-4 part 10

15:32:30.628 T:1598026640  NOTICE: Creating video thread

15:32:30.628 T:1598026640  NOTICE: Opening stream: 1 source: 256

15:32:30.628 T:1598026640  NOTICE: Finding audio codec for: 86018

15:32:30.628 T:1497363344  NOTICE: running thread: video_thread

15:32:30.630 T:1598026640  NOTICE: Creating audio thread

15:32:30.630 T:1488974736  NOTICE: running thread: CVideoPlayerAudio::Process()

15:32:30.632 T:1497363344  NOTICE: CDecoder::Open - fmt:0

15:32:30.637 T:1497363344   ERROR: mbox_property: ioctl_set_msg failed:-1





############### END LOG FILE ################



############ END Kodi CRASH LOG #############

**popcornmix** · 2017-02-06, 18:55

How are you launching kodi? Are you sure it runs as user alarm (some packages run it as user "kodi").
It doesn't look like you have permission to access /dev/vcio

**DarrenHill** · 2017-02-06, 19:54

Please use PasteBin.com for logs - do not post them directly here.

AuditeMarlow · 2017-02-06, 20:38

(2017-02-06, 18:55)popcornmix Wrote: How are you launching kodi? Are you sure it runs as user alarm (some packages run it as user "kodi").
It doesn't look like you have permission to access /dev/vcio

I am launching Kodi directly from the command line, logged in as user alarm.

**popcornmix** · 2017-02-06, 20:47

(2017-02-06, 20:38)AuditeMarlow Wrote: I am launching Kodi directly from the command line, logged in as user alarm.

Can you run strace on it and check for a failed open of device (probably /dev/vcio).

AuditeMarlow · 2017-02-06, 21:44

Here is a pastebin of the strace output: http://pastebin.com/yC1f4TqY It looks like something related to vcio fails?

**popcornmix** · 2017-02-06, 22:15

(2017-02-06, 21:44)AuditeMarlow Wrote: Here is a pastebin of the strace output: http://pastebin.com/yC1f4TqY It looks like something related to vcio fails?

/usr/bin/kodi is just a script which launches kodi. You need to run it on kodi.bin.

maksverver · 2017-02-06, 22:17

I had the same problem, and for me, adding myself to the video group helped.

Note that there are some subtleties when it comes to group permissions:

Make sure you use vigr to edit the groups file, and make sure that you add your username to the video group in /etc/group and /etc/gshadow. If these files are inconsistent, you're going to have a bad time.
You will have to log out of your current session, and log back in again, for group changes to take effect.
The command groups $USER will show you the settings from /etc/group, not the ones that apply to your current session. Run groups (without the user argument) for that. If the output of that command doesn't contain the video group, you'll have to log out and back in again.

(I was quite surprised to see that this was a permissions problem, considering that Kodi 16 worked just fine, and also considering that Kodi 17 with OMX Player did work flawlessly.)

ivanhoe1024 · 2017-02-06, 23:02

Same exact situation here, with Kodi 17 on a Raspberry Pi 2 with ArchLinux ARM... Solved as suggested by popcornmix and maksverver!

Very strange behaviour, indeed... Kodi 16 was working like a charme! Anyway, thank you very much for your help! Nod

AuditeMarlow · 2017-02-06, 23:26

(2017-02-06, 22:17)maksverver Wrote:
You will have to log out of your current session, and log back in again, for group changes to take effect.

The command groups $USER will show you the settings from /etc/group, not the ones that apply to your current session. Run groups (without the user argument) for that. If the output of that command doesn't contain the video group, you'll have to log out and back in again.

This was actually all I had to do. I had added my user to the video group, but didn't log out and back in. I just tried this and videos play back like a charm again.

Thanks a lot for the help, guys!

lpt2007 · (This post was last modified: 2020-01-20, 00:22 by lpt2007.)

sorry wrong post