Bug: browsing for backup map

HvD · 26 September 2015 10:57

I had set my OSMC to make a scheduled backup through nfs on my Synology NAS. Was working fine, until I changed my router. A new set of IP addresses was set for all my devices in my home network. No problem I thought, just change the IP address in the OSMC update settings. After tring to change the adress of the map on my NAS through the browsing possibility OSMC freezes. Only thing to do then is to unplug the PI’s power adapter. Trying again gave the same result.

So I think OSMC is trying to search for a non existing old IP address. Anyhow I can’t change the old IP address that was set through browsing. What I can do is typing the location of the map and notify you guys about this bug.

Karnage · 27 September 2015 00:37

Are there any errors in the debug log?

HvD · 27 September 2015 05:49

Looked in the kodi.log and kodi.old.log. Both were telling that backup could not mount to nfs:

ERROR: NFS: Failed to mount nfs share

I think it’s easy to duplicate the failure for you guys by manipulating the settings.xml from script.xbmcbackup with a wrong ip address in nfs protocol and then in the UI trying to browse for another map.

DBMandrake · 27 September 2015 08:22

A full kodi log taken with debug mode enabled and the problem reproduced would be necessary here.

HvD · 27 September 2015 20:28

I’m so sorry. I fixed my installation and now I can’t make this undone to reproduce the problem. I thought the setting was stored in settings.xml in userdata/addon_data/script.xbmcbackup but changing this ip address is not changing the setting in the OSMC UI. Would like to help, but on this point I need a little help where to change my IP address.

HvD · 13 October 2015 16:35

OK,

problem reproduced. Put NFS in Synology behind firewall. Then try to alter the backup url by browsing. Notice: url was existing before browsing. When searching for the url is not successfull OSMC freezes. Kodi.old.log, I think it’s the last line were you can find the problem:

17:05:46 506286.281250 T:3025584688 NOTICE: special://profile/ is mapped to: special://masterprofile/
17:05:46 506286.281250 T:3025584688 NOTICE: -----------------------------------------------------------------------
17:05:46 506286.281250 T:3025584688 NOTICE: Starting Kodi (15.2-RC2). Platform: Linux ARM 32-bit
17:05:46 506286.281250 T:3025584688 NOTICE: Using Release Kodi x32 build (version for Raspberry Pi)
17:05:46 506286.281250 T:3025584688 NOTICE: Kodi compiled Sep 28 2015 by GCC 4.9.2 for Linux ARM 32-bit version 3.16.7 (200711)
17:05:46 506286.281250 T:3025584688 NOTICE: Running on Open Source Media Center 2015.09-2, kernel: Linux ARM 32-bit version 4.2.1-1-osmc
17:05:46 506286.281250 T:3025584688 NOTICE: FFmpeg statically linked, version: 2.6.4-kodi-2.6.4-Isengard
17:05:46 506286.281250 T:3025584688 NOTICE: Host CPU: ARMv6-compatible processor rev 7 (v6l), 1 core available
17:05:46 506286.281250 T:3025584688 NOTICE: ARM Features: Neon disabled
17:05:46 506286.281250 T:3025584688 NOTICE: special://xbmc/ is mapped to: /usr/share/kodi
17:05:46 506286.281250 T:3025584688 NOTICE: special://xbmcbin/ is mapped to: /usr/lib/kodi
17:05:46 506286.281250 T:3025584688 NOTICE: special://masterprofile/ is mapped to: /home/osmc/.kodi/userdata
17:05:46 506286.281250 T:3025584688 NOTICE: special://home/ is mapped to: /home/osmc/.kodi
17:05:46 506286.281250 T:3025584688 NOTICE: special://temp/ is mapped to: /home/osmc/.kodi/temp
17:05:46 506286.281250 T:3025584688 NOTICE: The executable running is: /usr/lib/kodi/kodi.bin
17:05:46 506286.281250 T:3025584688 NOTICE: Local hostname: osmc
17:05:46 506286.281250 T:3025584688 NOTICE: Log File is located: /home/osmc/.kodi/temp/kodi.log
17:05:46 506286.281250 T:3025584688 NOTICE: -----------------------------------------------------------------------
17:05:46 506286.531250 T:3025584688 ERROR: DBus: Error org.freedesktop.DBus.Error.ServiceUnknown - The name org.freedesktop.UPower was not provided by any .service files
17:05:46 506286.656250 T:3025584688 NOTICE: load settings…
17:05:46 506286.906250 T:3025576992 NOTICE: Thread FDEventMonitor start, auto delete: false
17:05:46 506286.968750 T:3025584688 NOTICE: Found 1 Lists of Devices
17:05:46 506286.968750 T:3025584688 NOTICE: Enumerated PI devices:
17:05:46 506286.968750 T:3025584688 NOTICE: Device 1
17:05:46 506286.968750 T:3025584688 NOTICE: m_deviceName : HDMI
17:05:46 506286.968750 T:3025584688 NOTICE: m_displayName : HDMI
17:05:46 506286.968750 T:3025584688 NOTICE: m_displayNameExtra:
17:05:46 506286.968750 T:3025584688 NOTICE: m_deviceType : AE_DEVTYPE_HDMI
17:05:46 506286.968750 T:3025584688 NOTICE: m_channels : FL,FR
17:05:46 506286.968750 T:3025584688 NOTICE: m_sampleRates : 8000,11025,16000,22050,24000,32000,44100,48000,88200,96000,176400,192000
17:05:46 506286.968750 T:3025584688 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_AC3,AE_FMT_DTS,AE_FMT_EAC3
17:05:46 506286.968750 T:3025584688 NOTICE: Device 2
17:05:46 506286.968750 T:3025584688 NOTICE: m_deviceName : Analogue
17:05:46 506286.968750 T:3025584688 NOTICE: m_displayName : Analogue
17:05:46 506286.968750 T:3025584688 NOTICE: m_displayNameExtra:
17:05:46 506286.968750 T:3025584688 NOTICE: m_deviceType : AE_DEVTYPE_PCM
17:05:46 506286.968750 T:3025584688 NOTICE: m_channels : FL,FR
17:05:46 506286.968750 T:3025584688 NOTICE: m_sampleRates : 48000
17:05:46 506286.968750 T:3025584688 NOTICE: m_dataFormats : AE_FMT_FLOAT,AE_FMT_S32LE,AE_FMT_S16LE,AE_FMT_FLOATP,AE_FMT_S32NEP,AE_FMT_S16NEP
17:05:46 506286.968750 T:3025584688 NOTICE: Device 3
17:05:47 506286.968750 T:3025584688 NOTICE: m_deviceName : Both
17:05:47 506286.968750 T:3025584688 NOTICE: m_displayName : HDMI and Analogue
17:05:47 506286.968750 T:3025584688 NOTICE: m_displayNameExtra:
17:05:47 506286.968750 T:3025584688 NOTICE: m_deviceType : AE_DEVTYPE_PCM
17:05:47 506286.968750 T:3025584688 NOTICE: m_channels : FL,FR
17:05:47 506286.968750 T:3025584688 NOTICE: m_sampleRates : 48000
17:05:47 506286.968750 T:3025584688 NOTICE: m_dataFormats : AE_FMT_FLOAT,AE_FMT_S32LE,AE_FMT_S16LE,AE_FMT_FLOATP,AE_FMT_S32NEP,AE_FMT_S16NEP
17:05:47 506287.000000 T:3025584688 NOTICE: Loaded settings file from special://xbmc/system/advancedsettings.xml
17:05:47 506287.031250 T:3025584688 NOTICE: Contents of special://xbmc/system/advancedsettings.xml are…
<?xml version="1.0" encoding="UTF-8" ?>

4.0

540
720
false
0

30

17:05:47 506287.062500 T:3025584688 NOTICE: Loaded settings file from special://profile/advancedsettings.xml
17:05:47 506287.062500 T:3025584688 NOTICE: Contents of special://profile/advancedsettings.xml are…

1
0
30

17:05:47 506287.062500 T:3025584688 NOTICE: Default DVD Player: dvdplayer
17:05:47 506287.062500 T:3025584688 NOTICE: Default Video Player: dvdplayer
17:05:47 506287.062500 T:3025584688 NOTICE: Default Audio Player: paplayer
17:05:47 506287.062500 T:3025584688 NOTICE: Disabled debug logging due to GUI setting. Level 0.
17:05:47 506287.062500 T:3025584688 NOTICE: Log level changed to “LOG_LEVEL_NORMAL”
17:05:47 506287.062500 T:3025584688 NOTICE: CMediaSourceSettings: loading media sources from special://masterprofile/sources.xml
17:05:47 506287.062500 T:3025584688 NOTICE: Loading player core factory settings from special://xbmc/system/playercorefactory.xml.
17:05:47 506287.062500 T:3025584688 NOTICE: Loaded playercorefactory configuration
17:05:47 506287.062500 T:3025584688 NOTICE: Loading player core factory settings from special://masterprofile/playercorefactory.xml.
17:05:47 506287.062500 T:3025584688 NOTICE: special://masterprofile/playercorefactory.xml does not exist. Skipping.
17:05:47 506287.468750 T:3015701536 NOTICE: Thread ActiveAE start, auto delete: false
17:05:47 506287.468750 T:3005215776 NOTICE: Thread AESink start, auto delete: false
17:05:47 506287.500000 T:2946495520 NOTICE: Thread CRBPWorker start, auto delete: false
17:05:47 506287.531250 T:3025584688 NOTICE: Running database version Addons19
17:05:48 506288.031250 T:3025584688 NOTICE: ADDONS: Using repository repository.superrepo.org.helix.repositories
17:05:48 506288.031250 T:3025584688 NOTICE: ADDONS: Using repository net.rieter.xot.repository
17:05:48 506288.031250 T:3025584688 NOTICE: ADDONS: Using repository repository.superrepo.org.helix.video
17:05:48 506288.031250 T:3025584688 NOTICE: ADDONS: Using repository repository.xbmc.org
17:05:48 506288.031250 T:3025584688 NOTICE: ADDONS: Using repository repository.superrepo.org.helix.album_information
17:05:48 506288.031250 T:3025584688 NOTICE: ADDONS: Using repository repository.superrepo.org.helix.regional.europe.netherlands
17:05:48 506288.031250 T:2936546336 NOTICE: Thread RemoteControl start, auto delete: false
17:05:48 506288.312500 T:3025584688 NOTICE: Raspberry PI firmware version: Sep 23 2015 12:21:14
Copyright (c) 2012 Broadcom
version c156d00b148c30a3ba28ec376c9c01e95a77d6d5 (clean) (release)
17:05:48 506288.312500 T:3025584688 NOTICE: ARM mem: 368MB GPU mem: 144MB MPG2:1 WVC1:0
17:05:48 506288.312500 T:3025584688 NOTICE: cacheMemBufferSize: 0MB
17:05:48 506288.312500 T:3025584688 NOTICE: Config:
arm_freq=850
config_hdmi_boost=2
core_freq=375
disable_auto_turbo=1
disable_commandline_tags=2
disable_overscan=1
emmc_pll_core=1
force_pwm_open=1
framebuffer_ignore_alpha=1
framebuffer_swap=1
hdmi_channel_map=8
hdmi_force_cec_address=65535
hdmi_force_hotplug=1
hdmi_ignore_cec_init=1
pause_burst_frames=1
program_serial_random=1
sdram_freq=400
sdtv_aspect=1
temp_limit=85
17:05:48 506288.312500 T:3025584688 NOTICE: Config:
decode_MPG2=0x9f02cab2
device_tree=-
17:05:48 506288.343750 T:3025584688 NOTICE: InitWindowSystem: Using EGL Implementation: raspberrypi
17:05:48 506288.343750 T:3025584688 NOTICE: Found resolution 640 x 480 for display 0 with 640 x 480 @ 60.000000 Hz
17:05:48 506288.343750 T:3025584688 NOTICE: Found resolution 640 x 480 for display 0 with 640 x 480 @ 59.940063 Hz
17:05:48 506288.343750 T:3025584688 NOTICE: Found resolution 720 x 480 for display 0 with 720 x 480 @ 60.000000 Hz
17:05:48 506288.343750 T:3025584688 NOTICE: Found resolution 720 x 480 for display 0 with 720 x 480 @ 59.940063 Hz
17:05:48 506288.343750 T:3025584688 NOTICE: Found resolution 1280 x 720 for display 0 with 1280 x 720 @ 60.000000 Hz
17:05:48 506288.343750 T:3025584688 NOTICE: Found resolution 1280 x 720 for display 0 with 1280 x 720 @ 59.940063 Hz
17:05:48 506288.343750 T:3025584688 NOTICE: Found resolution 720 x 576 for display 0 with 720 x 576 @ 50.000000 Hz
17:05:48 506288.343750 T:3025584688 NOTICE: Found resolution 1280 x 720 for display 0 with 1280 x 720 @ 50.000000 Hz
17:05:48 506288.343750 T:3025584688 NOTICE: Found resolution 800 x 600 for display 0 with 800 x 600 @ 60.000000 Hz
17:05:48 506288.343750 T:3025584688 NOTICE: Found resolution 800 x 600 for display 0 with 800 x 600 @ 59.940063 Hz
17:05:48 506288.343750 T:3025584688 NOTICE: Found resolution 1024 x 768 for display 0 with 1024 x 768 @ 60.000000 Hz
17:05:48 506288.343750 T:3025584688 NOTICE: Found resolution 1024 x 768 for display 0 with 1024 x 768 @ 59.940063 Hz
17:05:48 506288.343750 T:3025584688 NOTICE: Found resolution 1360 x 768 for display 0 with 1360 x 768 @ 60.000000 Hz
17:05:48 506288.343750 T:3025584688 NOTICE: Found resolution 1360 x 768 for display 0 with 1360 x 768 @ 59.940063 Hz
17:05:48 506288.343750 T:3025584688 NOTICE: Found (1360x768@60.000000) at 28, setting to RES_DESKTOP at 16
17:05:48 506288.343750 T:3025584688 NOTICE: Checking resolution 16
17:05:48 506288.468750 T:3025584688 NOTICE: GL_VENDOR = Broadcom
17:05:48 506288.500000 T:3025584688 NOTICE: GL_RENDERER = VideoCore IV HW
17:05:48 506288.500000 T:3025584688 NOTICE: GL_VERSION = OpenGL ES 2.0
17:05:48 506288.500000 T:3025584688 NOTICE: GL_SHADING_LANGUAGE_VERSION = OpenGL ES GLSL ES 1.00
17:05:48 506288.500000 T:3025584688 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
17:05:50 506290.000000 T:3025584688 NOTICE: Register - new cec device registered on cec->RPI: CEC Adapter (2708:1001)
17:05:50 506290.031250 T:2919769120 NOTICE: Thread CECAdapter start, auto delete: false
17:05:50 506290.125000 T:2894603296 NOTICE: Thread PeripBusUSBUdev start, auto delete: false
17:05:50 506290.312500 T:3025584688 NOTICE: Running database version Addons19
17:05:50 506290.312500 T:3025584688 NOTICE: Running database version ViewModes6
17:05:50 506290.312500 T:3025584688 NOTICE: Running database version Textures13
17:05:50 506290.343750 T:3025584688 NOTICE: Running database version MyMusic52
17:05:50 506290.375000 T:3025584688 NOTICE: Running database version MyVideos93
17:05:50 506290.375000 T:3025584688 NOTICE: Running database version TV29
17:05:50 506290.406250 T:3025584688 NOTICE: Running database version Epg10
17:05:50 506290.406250 T:3025584688 NOTICE: start dvd mediatype detection
17:05:50 506290.437500 T:2885215264 NOTICE: Thread DetectDVDMedia start, auto delete: false
17:05:52 506292.531250 T:3025584688 WARNING: JSONRPC: Could not parse type “PVR.Details.Channel”
17:05:52 506292.531250 T:3025584688 WARNING: JSONRPC: Could not parse type “PVR.Details.ChannelGroup.Extended”
17:05:52 506292.562500 T:3025584688 WARNING: JSONRPC: Could not parse type “GUI.Property.Value”
17:05:52 506292.593750 T:3025584688 WARNING: JSONRPC: Could not parse type “Setting.Details.SettingList”
17:05:52 506292.906250 T:2868864032 NOTICE: Thread LanguageInvoker start, auto delete: false
17:05:54 506294.218750 T:2860475424 NOTICE: Previous line repeats 2 times.
17:05:54 506294.218750 T:2860475424 NOTICE: -->Python Interpreter Initialized<–
17:05:55 506294.968750 T:2840028192 NOTICE: Previous line repeats 1 times.
17:05:55 506294.968750 T:2840028192 NOTICE: Thread JobWorker start, auto delete: true
17:05:55 506294.968750 T:2831639584 NOTICE: Thread LanguageInvoker start, auto delete: false
17:05:55 506295.031250 T:3025584688 NOTICE: Previous line repeats 4 times.
17:05:55 506295.031250 T:3025584688 NOTICE: initialize done
17:05:55 506295.031250 T:3025584688 NOTICE: Running the application…
17:05:55 506295.093750 T:3025584688 NOTICE: starting zeroconf publishing
17:05:55 506295.093750 T:3025584688 NOTICE: Webserver: Starting…
17:05:55 506295.093750 T:3025584688 NOTICE: WebServer: Started the webserver
17:05:55 506295.093750 T:3025584688 NOTICE: starting upnp client
17:05:55 506295.093750 T:2781307936 NOTICE: Thread JobWorker start, auto delete: true
17:05:55 506295.156250 T:3025584688 NOTICE: starting upnp server
17:05:55 506295.187500 T:3025584688 NOTICE: starting upnp controller
17:05:55 506295.187500 T:3025584688 NOTICE: starting upnp renderer
17:05:55 506295.250000 T:3025584688 NOTICE: ES: Starting event server
17:05:55 506295.281250 T:2660234272 NOTICE: Thread TCPServer start, auto delete: false
17:05:55 506295.281250 T:2668622880 NOTICE: Thread EventServer start, auto delete: false
17:05:55 506295.281250 T:2668622880 NOTICE: ES: Starting UDP Event server on 0.0.0.0:9777
17:05:55 506295.281250 T:2668622880 NOTICE: UDP: Listening on port 9777
17:05:55 506295.281250 T:2651845664 NOTICE: Thread JobWorker start, auto delete: true
17:05:55 506295.343750 T:2643457056 NOTICE: Thread CECAdapterUpdate start, auto delete: false
17:05:55 506295.468750 T:2625004576 NOTICE: Thread AirPlayServer start, auto delete: false
17:05:56 506296.437500 T:2697421856 NOTICE: Thread LanguageInvoker start, auto delete: false
17:06:04 506304.687500 T:2868864032 NOTICE: -->Python Interpreter Initialized<–
17:06:06 506306.375000 T:2599838752 NOTICE: Thread FileCache start, auto delete: false
17:06:06 506306.906250 T:2814862368 NOTICE: -->Python Interpreter Initialized<–
17:06:07 506307.343750 T:2599838752 NOTICE: Thread FileCache start, auto delete: false
17:06:07 506307.375000 T:2599838752 NOTICE: Thread LanguageInvoker start, auto delete: false
17:06:07 506307.875000 T:2651845664 ERROR: CCurlFile::FillBuffer - Failed: HTTP returned error 416
17:06:07 506307.875000 T:2651845664 NOTICE: CCurlFile::FillBuffer - Reconnect, (re)try 1
17:06:08 506308.093750 T:2714199072 NOTICE: Thread FileCache start, auto delete: false
17:06:08 506308.093750 T:2651845664 ERROR: Failed to fetch checksum for directory listing http://xml.superrepo.org/v5/.xml/helix/video/addons.xml for repository repository.superrepo.org.helix.video.
17:06:08 506308.437500 T:2714199072 NOTICE: Thread FileCache start, auto delete: false
17:06:17 506316.968750 T:2651845664 NOTICE: Previous line repeats 2 times.
17:06:17 506316.968750 T:2651845664 ERROR: CCurlFile::FillBuffer - Failed: HTTP returned error 416
17:06:17 506316.968750 T:2651845664 NOTICE: CCurlFile::FillBuffer - Reconnect, (re)try 1
17:06:17 506317.031250 T:2697421856 NOTICE: -->Python Interpreter Initialized<–
17:06:17 506317.218750 T:2714199072 NOTICE: Previous line repeats 1 times.
17:06:17 506317.218750 T:2714199072 NOTICE: Thread FileCache start, auto delete: false
17:06:17 506317.218750 T:2651845664 ERROR: Failed to fetch checksum for directory listing http://xml.superrepo.org/v5/.xml/helix/album_information/addons.xml for repository repository.superrepo.org.helix.album_information.
17:06:17 506317.406250 T:2651845664 ERROR: CCurlFile::FillBuffer - Failed: HTTP returned error 416
17:06:17 506317.406250 T:2651845664 NOTICE: CCurlFile::FillBuffer - Reconnect, (re)try 1
17:06:17 506317.656250 T:2714199072 NOTICE: Thread FileCache start, auto delete: false
17:06:17 506317.656250 T:2651845664 ERROR: Failed to fetch checksum for directory listing http://xml.superrepo.org/v5/.xml/helix/regional/europe/netherlands/addons.xml for repository repository.superrepo.org.helix.regional.europe.netherlands.
17:06:19 506319.531250 T:2806473760 NOTICE: -->Python Interpreter Initialized<–
17:06:24 506323.968750 T:2814862368 NOTICE: Previous line repeats 2 times.
17:06:24 506323.968750 T:2814862368 NOTICE: StorageServer Module loaded RUN
17:06:24 506323.968750 T:2814862368 NOTICE: StorageClient-2.5.4 Starting server
17:06:28 506328.812500 T:2599838752 NOTICE: -->Python Interpreter Initialized<–
17:06:34 506334.875000 T:2806473760 NOTICE: 1Channel: Service: Installed Version: 2.5.64
17:06:36 506336.750000 T:2806473760 NOTICE: 1Channel: Loading sqlite3 as DB engine
17:06:37 506337.500000 T:2806473760 NOTICE: 1Channel: Service: Resetting…
17:06:37 506337.500000 T:2806473760 NOTICE: 1Channel: Service: starting…
17:06:40 506340.750000 T:2840028192 NOTICE: AxelProxy Downloader Starting - 127.0.0.1:45550
17:06:40 506340.750000 T:2840028192 NOTICE: Press CTL break to stop…
17:06:45 506345.750000 T:2697421856 NOTICE: Thread LanguageInvoker start, auto delete: false
17:06:46 506346.406250 T:2697421856 NOTICE: -->Python Interpreter Initialized<–
17:06:52 506352.875000 T:2553279520 NOTICE: Thread JobWorker start, auto delete: true
17:06:53 506353.906250 T:2697421856 NOTICE: Previous line repeats 1 times.
17:06:53 506353.906250 T:2697421856 NOTICE: CommonFunctions-2.5.1
17:06:54 506354.062500 T:2697421856 ERROR: GetDirectory - Error getting /home/osmc/.kodi/userdata/addon_data/plugin.video.genesis/TVShows/
17:06:56 506356.406250 T:2851824672 ERROR: EXCEPTION: Non-Existent Control 300
17:07:08 506368.406250 T:2668622880 NOTICE: ES: Client from 192.168.178.22 timed out