Autofs stopped working after Openmediavault 5 to 6 update

I’ve got smb shares loaded from my NAS running Openmediavault on my Vero4k+ using autofs.
This has been configured for some time and been running without issue.
Yesterday, I did a major update of Openmediavault (Version 5 to Version 6) and now autofs is not loading the shares… The shares are still working and the credentials also work as I have verified accessing them through Windows.

The contents of my /etc/auto.smb.shares is as follows

osmc@Vero4k:~$ cat /etc/auto.smb.shares
/mnt/helios4/media -fstype=cifs,rw,credentials=/home/osmc/.smbcredentials,iocharset=utf8,uid=osmc,gid=osmc ://192.168.1.25/Medina
/mnt/helios4/europa -fstype=cifs,rw,credentials=/home/osmc/.smbcredentials,iocharset=utf8,uid=osmc,gid=osmc ://192.168.1.25/Europa

When I run sudo automount -f -v -d I get the following

osmc@Vero4k:~$ sudo automount -f -v -d
Starting automounter version 5.1.2, master map /etc/auto.master
using kernel protocol version 5.02
lookup_nss_read_master: reading master file /etc/auto.master
do_init: parse(sun): init gathered global options: (null)
lookup_read_master: lookup(file): read entry +dir:/etc/auto.master.d
lookup_nss_read_master: reading master dir /etc/auto.master.d
lookup_read_master: lookup(dir): scandir: /etc/auto.master.d
lookup_read_master: lookup(file): read entry +auto.master
lookup_nss_read_master: reading master files auto.master
do_init: parse(sun): init gathered global options: (null)
lookup(file): failed to read included master map auto.master
lookup_read_master: lookup(file): read entry /-
master_do_mount: mounting /-
automount_path_to_fifo: fifo name /var/run/autofs.fifo--
lookup_nss_read_map: reading map file /etc/auto.smb.shares
do_init: parse(sun): init gathered global options: (null)
mounted direct on /mnt/helios4/europa with timeout 15, freq 4 seconds
do_mount_autofs_direct: mounted trigger /mnt/helios4/europa
mounted direct on /mnt/helios4/media with timeout 15, freq 4 seconds
do_mount_autofs_direct: mounted trigger /mnt/helios4/media
st_ready: st_ready(): state = 0 path /-
st_expire: state 1 path /-
expire_proc: exp_proc = 4094686272 path /-
expire_cleanup: got thid 4094686272 path /- stat 0
expire_cleanup: sigchld: exp 4094686272 finished, switching from 2 to 1
st_ready: st_ready(): state = 2 path /-
st_expire: state 1 path /-
expire_proc: exp_proc = 4094686272 path /-
expire_cleanup: got thid 4094686272 path /- stat 0
expire_cleanup: sigchld: exp 4094686272 finished, switching from 2 to 1
st_ready: st_ready(): state = 2 path /-
st_expire: state 1 path /-
expire_proc: exp_proc = 4094686272 path /-
expire_cleanup: got thid 4094686272 path /- stat 0
expire_cleanup: sigchld: exp 4094686272 finished, switching from 2 to 1
st_ready: st_ready(): state = 2 path /-
handle_packet: type = 5
handle_packet_missing_direct: token 100, name /mnt/helios4/media, request pid 2881
attempting to mount entry /mnt/helios4/media
lookup_mount: lookup(file): looking up /mnt/helios4/media
lookup_mount: lookup(file): /mnt/helios4/media -> -fstype=cifs,rw,credentials=/home/osmc/.smbcredentials,iocharset=utf8,uid=osmc,gid=osmc ://192.168.1.25/Medina
parse_mount: parse(sun): expanded entry: -fstype=cifs,rw,credentials=/home/osmc/.smbcredentials,iocharset=utf8,uid=osmc,gid=osmc ://192.168.1.25/Medina
parse_mount: parse(sun): gathered options: fstype=cifs,rw,credentials=/home/osmc/.smbcredentials,iocharset=utf8,uid=osmc,gid=osmc
parse_mount: parse(sun): dequote("://192.168.1.25/Medina") -> ://192.168.1.25/Medina
parse_mount: parse(sun): core of entry: options=fstype=cifs,rw,credentials=/home/osmc/.smbcredentials,iocharset=utf8,uid=osmc,gid=osmc, loc=://192.168.1.25/Medina
sun_mount: parse(sun): mounting root /mnt/helios4/media, mountpoint /mnt/helios4/media, what //192.168.1.25/Medina, fstype cifs, options rw,credentials=/home/osmc/.smbcredentials,iocharset=utf8,uid=osmc,gid=osmc
do_mount: //192.168.1.25/Medina /mnt/helios4/media type cifs options rw,credentials=/home/osmc/.smbcredentials,iocharset=utf8,uid=osmc,gid=osmc using module generic
mount_mount: mount(generic): calling mkdir_path /mnt/helios4/media
mount_mount: mount(generic): calling mount -t cifs -o rw,credentials=/home/osmc/.smbcredentials,iocharset=utf8,uid=osmc,gid=osmc //192.168.1.25/Medina /mnt/helios4/media
>> mount error(95): Operation not supported
>> Refer to the mount.cifs(8) manual page (e.g. man mount.cifs)
mount(generic): failed to mount //192.168.1.25/Medina (type cifs) on /mnt/helios4/media
dev_ioctl_send_fail: token = 100
failed to mount /mnt/helios4/media
st_expire: state 1 path /-
expire_proc: exp_proc = 4094686272 path /-
expire_cleanup: got thid 4094686272 path /- stat 0
expire_cleanup: sigchld: exp 4094686272 finished, switching from 2 to 1
st_ready: st_ready(): state = 2 path /-
st_expire: state 1 path /-
expire_proc: exp_proc = 4094686272 path /-
expire_cleanup: got thid 4094686272 path /- stat 0
expire_cleanup: sigchld: exp 4094686272 finished, switching from 2 to 1
st_ready: st_ready(): state = 2 path /-
^Cdo_notify_state: signal 2
master_notify_state_change: sig 2 switching /- from 1 to 5
st_prepare_shutdown: state 1 path /-
expire_proc: exp_proc = 4093633600 path /-
expire_cleanup: got thid 4093633600 path /- stat 0
expire_cleanup: sigchld: exp 4093633600 finished, switching from 5 to 7
st_shutdown: state 5 path /-
umount_multi: path /mnt/helios4/europa incl 0
set_direct_mount_catatonic: set /mnt/helios4/europa catatonic
umounted direct mount /mnt/helios4/europa
umount_multi: path /mnt/helios4/media incl 0
set_direct_mount_catatonic: set /mnt/helios4/media catatonic
umounted direct mount /mnt/helios4/media
automount_path_to_fifo: fifo name /var/run/autofs.fifo--
shut down path /-
autofs stopped

Does anybody have any ideas what’s happening?
Thanks :slightly_smiling_face:

Reading online that a mount error(95) could be due to a smb version issue. That kinda makes sense to me as nothing else should have changed and I can still access the shares as per normal through Windows and Mac after the update to my NAS.

A suggestion is to add SMB version 3.0 to the mount options… Any thoughts on that?

OK. Adding vers=3.0 to /etc/auto.smb.shares seems to have fixed that particular issue :smiley:

However, now I get errors when attempting to refresh/scrape items into my movie library :confounded: (playing the movie itself works without issue). NOTE: I’ve also tried removing the movie from my library and re-scan it in; I get the same error.

Here’s an excerpt from the log. The full log (not debug, I can get that if required) is here.

2022-08-02 09:15:03.188 T:3109     INFO <general>: [metadata.themoviedb.org.python]: Find movie with title 'The-Age-of-Adaline' from year '2015'
2022-08-02 09:15:03.735 T:3109     INFO <general>: CPythonInvoker(8, /home/osmc/.kodi/addons/metadata.themoviedb.org.python/python/scraper.py): script successfully run
2022-08-02 09:15:03.750 T:2726     INFO <general>: Loading skin file: DialogSelect.xml, load type: KEEP_IN_MEMORY
2022-08-02 09:15:03.795 T:2726  WARNING <general>: Trying to add unsupported control type 17
2022-08-02 09:15:06.055 T:3109     INFO <general>: Skipped 1 duplicate messages..
2022-08-02 09:15:06.055 T:3109     INFO <general>: initializing python engine.
2022-08-02 09:15:06.775 T:3109    ERROR <general>: EXCEPTION Thrown (PythonToCppException) : -->Python callback/script returned the following error<--
                                                    - NOTE: IGNORING THIS CAN LEAD TO MEMORY LEAKS!
                                                   Error Type: <class 'KeyError'>
                                                   Error Contents: 'images'
                                                   Traceback (most recent call last):
                                                     File "/home/osmc/.kodi/addons/metadata.themoviedb.org.python/python/scraper.py", line 189, in <module>
                                                       run()
                                                     File "/home/osmc/.kodi/addons/metadata.themoviedb.org.python/python/scraper.py", line 178, in run
                                                       enddir = not get_details(parse_lookup_string(params["url"]), params['handle'], settings)
                                                     File "/home/osmc/.kodi/addons/metadata.themoviedb.org.python/python/scraper.py", line 101, in get_details
                                                       details = get_tmdb_scraper(settings).get_details(input_uniqueids)
                                                     File "/home/osmc/.kodi/addons/metadata.themoviedb.org.python/python/lib/tmdbscraper/tmdb.py", line 58, in get_details
                                                       details = self._gather_details(media_id)
                                                     File "/home/osmc/.kodi/addons/metadata.themoviedb.org.python/python/lib/tmdbscraper/tmdb.py", line 72, in _gather_details
                                                       movie['images'] = movie_fallback['images']
                                                   KeyError: 'images'
                                                   -->End of Python script error report<--
                                                   
2022-08-02 09:15:07.388 T:3109  WARNING <general>: CPythonInvoker(8, /home/osmc/.kodi/addons/metadata.themoviedb.org.python/python/scraper.py): the python script "/home/osmc/.kodi/addons/metadata.themoviedb.org.python/python/scraper.py" has left several classes in memory that we couldn't clean up. The classes include: N9XBMCAddon9xbmcaddon5AddonE
2022-08-02 09:15:07.388 T:3109     INFO <general>: Python interpreter stopped
2022-08-02 09:15:07.402 T:3126    ERROR <general>: Skipped 1 duplicate messages..
2022-08-02 09:15:07.402 T:3126    ERROR <general>: Process: Error getting details from {"tmdb": "293863"}

Do I need to completely delete my Movie and TV libraries and re-scan/re-scrape them?

I completely deleted my Movie and TV sources and re-scraped them.
Decided to go this route as I wanted to take the opportunity to improve my library setup as well.

Everything has scraped properly now and my library is back up and running.

This was the solution to the problem I raised in my original/initial post :smiley:

1 Like