SMB Shares inaccesible after v4.5.4-0 upgrade

Mark93 · January 18, 2023, 10:48am

Hello,
after upgrading to v4.5.4-0 my SMB Shares (working perfectly fine since going to V4) stopped being accessible.
I tried to find the cause myself, but I’m not seeing a for me understandable “real” error message in the logs…
Also i tried it with another, newly created user. Stopped samba Service, deleted and added the samba-shares/exports and also tried it with different settings of Admin-Users for the share/export (none, Main User, Mark2 (new user)) and with different file owner settings in the share itself (owner root, group users; owner Mark2, group users).
Here is what I get

(Saying Access denied)

SMB-Log (/var/log/samba/log.myiclientpaddress (192.168.30.51):

[…]
[2023/01/18 11:32:02.722858, 3] …/…/auth/auth_log.c:665(log_authentication_event_human_readable)
Auth: [SMB2,(null)] user [MicrosoftAccount][Mark2] at [Mi, 18 Jan 2023 11:32:02.722819 CET] with [NTLMv2] status [NT_STATUS_OK] workstation [APPARAT] remote host [ipv4:192.168.30.51:51681] became [ROCKSTOR4][Mark2] [S-1-5-21-679555601-880528519-2831801044-1004]. local host [ipv4:192.168.30.75:445]
{“timestamp”: “2023-01-18T11:32:02.723068+0100”, “type”: “Authentication”, “Authentication”: {“version”: {“major”: 1, “minor”: 2}, “eventId”: 4624, “logonId”: “0”, “logonType”: 3, “status”: “NT_STATUS_OK”, “localAddress”: “ipv4:192.168.30.75:445”, “remoteAddress”: “ipv4:192.168.30.51:51681”, “serviceDescription”: “SMB2”, “authDescription”: null, “clientDomain”: “MicrosoftAccount”, “clientAccount”: “Mark2”, “workstation”: “APPARAT”, “becameAccount”: “Mark2”, “becameDomain”: “ROCKSTOR4”, “becameSid”: “S-1-5-21-679555601-880528519-2831801044-1004”, “mappedAccount”: “Mark2”, “mappedDomain”: “MicrosoftAccount”, “netlogonComputer”: null, “netlogonTrustAccount”: null, “netlogonNegotiateFlags”: “0x00000000”, “netlogonSecureChannelType”: 0, “netlogonTrustAccountSid”: null, “passwordType”: “NTLMv2”, “duration”: 10969}}
[2023/01/18 11:32:02.723225, 2] …/…/source3/auth/auth.c:330(auth_check_ntlm_password)
check_ntlm_password: authentication for user [Mark2] → [Mark2] → [Mark2] succeeded
[2023/01/18 11:32:02.723278, 3] …/…/source3/param/loadparm.c:3971(lp_load_ex)
lp_load_ex: refreshing parameters
[2023/01/18 11:32:02.723443, 3] …/…/source3/param/loadparm.c:557(init_globals)
Initialising global parameters
[2023/01/18 11:32:02.723907, 3] …/…/source3/param/loadparm.c:2873(lp_do_section)
Processing section “[global]”
[2023/01/18 11:32:02.724119, 2] …/…/source3/param/loadparm.c:2890(lp_do_section)
Processing section “[Scan]”
[2023/01/18 11:32:02.724322, 3] …/…/source3/param/loadparm.c:1674(lp_add_ipc)
adding IPC service
[2023/01/18 11:32:02.724739, 3] …/…/source3/auth/token_util.c:689(finalize_local_nt_token)
Failed to fetch domain sid for WORKGROUP
[2023/01/18 11:32:02.726087, 3] …/…/auth/ntlmssp/ntlmssp_sign.c:623(ntlmssp_sign_reset)
NTLMSSP Sign/Seal - Initialising with flags:
[2023/01/18 11:32:02.726167, 3] …/…/auth/ntlmssp/ntlmssp_util.c:72(debug_ntlmssp_flags)
Got NTLMSSP neg_flags=0xe2088215
[2023/01/18 11:32:02.726314, 3] …/…/auth/ntlmssp/ntlmssp_sign.c:623(ntlmssp_sign_reset)
NTLMSSP Sign/Seal - Initialising with flags:
[2023/01/18 11:32:02.726395, 3] …/…/auth/ntlmssp/ntlmssp_util.c:72(debug_ntlmssp_flags)
Got NTLMSSP neg_flags=0xe2088215
[2023/01/18 11:32:02.726739, 3] …/…/source3/auth/token_util.c:689(finalize_local_nt_token)
Failed to fetch domain sid for WORKGROUP
[2023/01/18 11:32:02.728089, 3] …/…/source3/smbd/password.c:85(register_homes_share)
Adding homes service for user ‘Mark2’ using home directory: ‘/home/Mark2’

This log is showing that I’m successfuly authenticated, right?

Here is the log.smdb

[2023/01/18 11:34:10.229650, 3] …/…/source3/smbd/server_exit.c:240(exit_server_common)
Server exit (termination signal)
[2023/01/18 11:34:10, 2] …/…/source3/lib/interface.c:346(add_interface)
added interface eth0 ip=2003:dd:71f:1100:c0c2:38f6:cd3e:a60 bcast= netmask=ffff:ffff:ffff:ffff::
[2023/01/18 11:34:10, 2] …/…/source3/lib/interface.c:346(add_interface)
added interface eth0 ip=2003:dd:71f:1100:ebb4:8eff:d268:621f bcast= netmask=ffff:ffff:ffff:ffff::
[2023/01/18 11:34:10, 2] …/…/source3/lib/interface.c:346(add_interface)
added interface eth0 ip=fd00::8cdb:df2:d824:c976 bcast= netmask=ffff:ffff:ffff:ffff::
[2023/01/18 11:34:10, 2] …/…/source3/lib/interface.c:346(add_interface)
added interface eth0 ip=fd00::cf2d:3c95:887b:ce4d bcast= netmask=ffff:ffff:ffff:ffff::
[2023/01/18 11:34:10, 2] …/…/source3/lib/interface.c:346(add_interface)
added interface eth0 ip=192.168.30.75 bcast=192.168.30.255 netmask=255.255.255.0
[2023/01/18 11:34:10.346944, 0] …/…/source3/smbd/server.c:1734(main)
smbd version 4.15.12-git.535.7750e5c95ef150300.3.43.1-SUSE-oS15.0-x86_64 started.
Copyright Andrew Tridgell and the Samba Team 1992-2021
[2023/01/18 11:34:10.346994, 2] …/…/source3/smbd/server.c:1738(main)
uid=0 gid=0 euid=0 egid=0
[2023/01/18 11:34:10.347196, 2] …/…/source3/lib/tallocmsg.c:84(register_msg_pool_usage)
Registered MSG_REQ_POOL_USAGE
[2023/01/18 11:34:10.347211, 2] …/…/source3/lib/dmallocmsg.c:78(register_dmalloc_msgs)
Registered MSG_REQ_DMALLOC_MARK and LOG_CHANGED
[2023/01/18 11:34:10.347292, 3] …/…/source3/param/loadparm.c:3971(lp_load_ex)
lp_load_ex: refreshing parameters
[2023/01/18 11:34:10.347338, 3] …/…/source3/param/loadparm.c:557(init_globals)
Initialising global parameters
[2023/01/18 11:34:10.347451, 3] …/…/source3/param/loadparm.c:2873(lp_do_section)
Processing section “[global]”
[2023/01/18 11:34:10.347618, 2] …/…/source3/param/loadparm.c:2890(lp_do_section)
Processing section “[Scan]”
[2023/01/18 11:34:10.347778, 3] …/…/source3/param/loadparm.c:1674(lp_add_ipc)
adding IPC service
[2023/01/18 11:34:10.348049, 2] …/…/source3/lib/interface.c:346(add_interface)
added interface eth0 ip=2003:dd:71f:1100:c0c2:38f6:cd3e:a60 bcast= netmask=ffff:ffff:ffff:ffff::
[2023/01/18 11:34:10.348068, 2] …/…/source3/lib/interface.c:346(add_interface)
added interface eth0 ip=2003:dd:71f:1100:ebb4:8eff:d268:621f bcast= netmask=ffff:ffff:ffff:ffff::
[2023/01/18 11:34:10.348079, 2] …/…/source3/lib/interface.c:346(add_interface)
added interface eth0 ip=fd00::8cdb:df2:d824:c976 bcast= netmask=ffff:ffff:ffff:ffff::
[2023/01/18 11:34:10.348089, 2] …/…/source3/lib/interface.c:346(add_interface)
added interface eth0 ip=fd00::cf2d:3c95:887b:ce4d bcast= netmask=ffff:ffff:ffff:ffff::
[2023/01/18 11:34:10.348099, 2] …/…/source3/lib/interface.c:346(add_interface)
added interface eth0 ip=192.168.30.75 bcast=192.168.30.255 netmask=255.255.255.0
[2023/01/18 11:34:10.348118, 3] …/…/source3/smbd/server.c:1806(main)
loaded services
[2023/01/18 11:34:10.349515, 1] …/…/source3/profile/profile.c:55(set_profile_level)
INFO: Profiling turned OFF from pid 6179
[2023/01/18 11:34:10.349542, 3] …/…/source3/smbd/server.c:1826(main)
Standard input is not a socket, assuming -D option
[2023/01/18 11:34:10.349553, 3] …/…/source3/smbd/server.c:1838(main)
Becoming a daemon.
[2023/01/18 11:34:10.349761, 2] …/…/source3/lib/tallocmsg.c:84(register_msg_pool_usage)
Registered MSG_REQ_POOL_USAGE
[2023/01/18 11:34:10.349812, 2] …/…/source3/passdb/pdb_interface.c:163(make_pdb_method_name)
No builtin backend found, trying to load plugin
[2023/01/18 11:34:10.351275, 3] …/…/lib/util/modules.c:167(load_module_absolute_path)
load_module_absolute_path: Module ‘/usr/lib64/samba/pdb/tdbsam.so’ loaded
[2023/01/18 11:34:10.353747, 3] …/…/source3/lib/util_procid.c:54(pid_to_procid)
pid_to_procid: messaging_dgm_get_unique failed: Datei oder Verzeichnis nicht gefunden
[2023/01/18 11:34:10.354118, 2] …/…/source3/lib/tallocmsg.c:84(register_msg_pool_usage)
Registered MSG_REQ_POOL_USAGE
[2023/01/18 11:34:10.354789, 2] …/…/source3/lib/tallocmsg.c:84(register_msg_pool_usage)
Registered MSG_REQ_POOL_USAGE
[2023/01/18 11:34:10.355986, 3] …/…/source3/auth/token_util.c:689(finalize_local_nt_token)
Failed to fetch domain sid for WORKGROUP
[2023/01/18 11:34:10.356536, 3] …/…/librpc/rpc/dcesrv_core.c:2601(dcerpc_register_ep_server)
DCERPC endpoint server ‘winreg’ registered
[2023/01/18 11:34:10.356558, 3] …/…/librpc/rpc/dcesrv_core.c:2601(dcerpc_register_ep_server)
DCERPC endpoint server ‘srvsvc’ registered
[2023/01/18 11:34:10.356572, 3] …/…/librpc/rpc/dcesrv_core.c:2601(dcerpc_register_ep_server)
DCERPC endpoint server ‘lsarpc’ registered
[2023/01/18 11:34:10.356596, 3] …/…/librpc/rpc/dcesrv_core.c:2601(dcerpc_register_ep_server)
DCERPC endpoint server ‘samr’ registered
[2023/01/18 11:34:10.356610, 3] …/…/librpc/rpc/dcesrv_core.c:2601(dcerpc_register_ep_server)
DCERPC endpoint server ‘netdfs’ registered
[2023/01/18 11:34:10.356620, 3] …/…/librpc/rpc/dcesrv_core.c:2601(dcerpc_register_ep_server)
DCERPC endpoint server ‘dssetup’ registered
[2023/01/18 11:34:10.356634, 3] …/…/librpc/rpc/dcesrv_core.c:2601(dcerpc_register_ep_server)
DCERPC endpoint server ‘wkssvc’ registered
[2023/01/18 11:34:10.356644, 3] …/…/librpc/rpc/dcesrv_core.c:2601(dcerpc_register_ep_server)
DCERPC endpoint server ‘spoolss’ registered
[2023/01/18 11:34:10.356654, 3] …/…/librpc/rpc/dcesrv_core.c:2601(dcerpc_register_ep_server)
DCERPC endpoint server ‘svcctl’ registered
[2023/01/18 11:34:10.356663, 3] …/…/librpc/rpc/dcesrv_core.c:2601(dcerpc_register_ep_server)
DCERPC endpoint server ‘ntsvcs’ registered
[2023/01/18 11:34:10.356678, 3] …/…/librpc/rpc/dcesrv_core.c:2601(dcerpc_register_ep_server)
DCERPC endpoint server ‘eventlog’ registered
[2023/01/18 11:34:10.356689, 3] …/…/librpc/rpc/dcesrv_core.c:2601(dcerpc_register_ep_server)
DCERPC endpoint server ‘initshutdown’ registered
[2023/01/18 11:34:10.356705, 3] …/…/source3/rpc_server/rpc_modules.c:64(register_rpc_module)
register_rpc_module: Successfully added RPC module ‘mdssvc’
[2023/01/18 11:34:10.356749, 3] …/…/librpc/rpc/dcesrv_core.c:2601(dcerpc_register_ep_server)
DCERPC endpoint server ‘mdssvc’ registered
[2023/01/18 11:34:10.356905, 3] …/…/source3/rpc_server/svcctl/srv_svcctl_reg.c:565(svcctl_init_winreg)
Initialise the svcctl registry keys if needed.
[2023/01/18 11:34:10.358063, 3] …/…/source3/rpc_server/eventlog/srv_eventlog_reg.c:59(eventlog_init_winreg)
Initialise the eventlog registry keys if needed.
[2023/01/18 11:34:10.358956, 3] …/…/source3/printing/queue_process.c:359(start_background_queue)
start_background_queue: Starting background LPQ thread
[2023/01/18 11:34:10.388994, 1] …/…/source3/printing/printer_list.c:255(printer_list_get_last_refresh)
Failed to fetch record!
[2023/01/18 11:34:10.389023, 2] …/…/source3/smbd/server.c:1364(smbd_parent_loop)
waiting for connections
[2023/01/18 11:34:16.455067, 2] …/…/source3/lib/tallocmsg.c:84(register_msg_pool_usage)
Registered MSG_REQ_POOL_USAGE
[2023/01/18 11:34:16.455465, 3] …/…/lib/util/access.c:372(allow_access)
Allowed connection from 192.168.30.51 (192.168.30.51)

nmdb.log

[2023/01/18 11:34:10.370722, 0] …/…/source3/nmbd/nmbd.c:59(terminate)
Got SIGTERM: going down…
[2023/01/18 11:34:10.370786, 3] …/…/source3/nmbd/nmbd_sendannounce.c:213(send_host_announcement)
send_host_announcement: type 0 for host ROCKSTOR4 on subnet 192.168.30.75 for workgroup WORKGROUP
[2023/01/18 11:34:10, 2] …/…/source3/lib/interface.c:346(add_interface)
added interface eth0 ip=2003:dd:71f:1100:c0c2:38f6:cd3e:a60 bcast= netmask=ffff:ffff:ffff:ffff::
[2023/01/18 11:34:10, 2] …/…/source3/lib/interface.c:346(add_interface)
added interface eth0 ip=2003:dd:71f:1100:ebb4:8eff:d268:621f bcast= netmask=ffff:ffff:ffff:ffff::
[2023/01/18 11:34:10, 2] …/…/source3/lib/interface.c:346(add_interface)
added interface eth0 ip=fd00::8cdb:df2:d824:c976 bcast= netmask=ffff:ffff:ffff:ffff::
[2023/01/18 11:34:10, 2] …/…/source3/lib/interface.c:346(add_interface)
added interface eth0 ip=fd00::cf2d:3c95:887b:ce4d bcast= netmask=ffff:ffff:ffff:ffff::
[2023/01/18 11:34:10, 2] …/…/source3/lib/interface.c:346(add_interface)
added interface eth0 ip=192.168.30.75 bcast=192.168.30.255 netmask=255.255.255.0
[2023/01/18 11:34:10.444411, 0] …/…/source3/nmbd/nmbd.c:901(main)
nmbd version 4.15.12-git.535.7750e5c95ef150300.3.43.1-SUSE-oS15.0-x86_64 started.
Copyright Andrew Tridgell and the Samba Team 1992-2021
[2023/01/18 11:34:10.444746, 2] …/…/source3/lib/tallocmsg.c:84(register_msg_pool_usage)
Registered MSG_REQ_POOL_USAGE
[2023/01/18 11:34:10.444771, 2] …/…/source3/lib/dmallocmsg.c:78(register_dmalloc_msgs)
Registered MSG_REQ_DMALLOC_MARK and LOG_CHANGED
[2023/01/18 11:34:10.444798, 3] …/…/source3/param/loadparm.c:3971(lp_load_ex)
lp_load_ex: refreshing parameters
[2023/01/18 11:34:10.444856, 3] …/…/source3/param/loadparm.c:557(init_globals)
Initialising global parameters
[2023/01/18 11:34:10.444878, 2] …/…/source3/param/loadparm.c:329(max_open_files)
rlimit_max: increasing rlimit_max (1024) to minimum Windows limit (16384)
[2023/01/18 11:34:10.445030, 3] …/…/source3/param/loadparm.c:2873(lp_do_section)
Processing section “[global]”
[2023/01/18 11:34:10.445296, 3] …/…/source3/nmbd/nmbd.c:414(reload_nmbd_services)
services not loaded
[2023/01/18 11:34:10.445429, 3] …/…/source3/nmbd/nmbd.c:941(main)
standard input is not a socket, assuming -D option
[2023/01/18 11:34:10.445461, 3] …/…/source3/nmbd/nmbd.c:946(main)
Becoming a daemon.
[2023/01/18 11:34:10.445740, 2] …/…/source3/lib/tallocmsg.c:84(register_msg_pool_usage)
Registered MSG_REQ_POOL_USAGE
[2023/01/18 11:34:10.445807, 3] …/…/source3/nmbd/nmbd.c:1029(main)
Opening sockets 137
[2023/01/18 11:34:10.445866, 3] …/…/source3/nmbd/nmbd.c:763(open_sockets)
open_sockets: Broadcast sockets opened.
[2023/01/18 11:34:10.446120, 2] …/…/source3/lib/interface.c:346(add_interface)
added interface eth0 ip=2003:dd:71f:1100:c0c2:38f6:cd3e:a60 bcast= netmask=ffff:ffff:ffff:ffff::
[2023/01/18 11:34:10.446147, 2] …/…/source3/lib/interface.c:346(add_interface)
added interface eth0 ip=2003:dd:71f:1100:ebb4:8eff:d268:621f bcast= netmask=ffff:ffff:ffff:ffff::
[2023/01/18 11:34:10.446165, 2] …/…/source3/lib/interface.c:346(add_interface)
added interface eth0 ip=fd00::8cdb:df2:d824:c976 bcast= netmask=ffff:ffff:ffff:ffff::
[2023/01/18 11:34:10.446184, 2] …/…/source3/lib/interface.c:346(add_interface)
added interface eth0 ip=fd00::cf2d:3c95:887b:ce4d bcast= netmask=ffff:ffff:ffff:ffff::
[2023/01/18 11:34:10.446214, 2] …/…/source3/lib/interface.c:346(add_interface)
added interface eth0 ip=192.168.30.75 bcast=192.168.30.255 netmask=255.255.255.0
[2023/01/18 11:34:10.446282, 2] …/…/source3/nmbd/nmbd_subnetdb.c:179(make_subnet)
making subnet name:192.168.30.75 Broadcast address:192.168.30.255 Subnet mask:255.255.255.0
[2023/01/18 11:34:10.446300, 2] …/…/source3/nmbd/nmbd_subnetdb.c:299(create_subnets)
create_subnets: ignoring non IPv4 interface.
[2023/01/18 11:34:10.446326, 2] …/…/source3/nmbd/nmbd_subnetdb.c:299(create_subnets)
create_subnets: ignoring non IPv4 interface.
[2023/01/18 11:34:10.446340, 2] …/…/source3/nmbd/nmbd_subnetdb.c:299(create_subnets)
create_subnets: ignoring non IPv4 interface.
[2023/01/18 11:34:10.446352, 2] …/…/source3/nmbd/nmbd_subnetdb.c:299(create_subnets)
create_subnets: ignoring non IPv4 interface.
[2023/01/18 11:34:10.446366, 2] …/…/source3/nmbd/nmbd_subnetdb.c:179(make_subnet)
making subnet name:UNICAST_SUBNET Broadcast address:0.0.0.0 Subnet mask:0.0.0.0
[2023/01/18 11:34:10.446381, 2] …/…/source3/nmbd/nmbd_subnetdb.c:179(make_subnet)
making subnet name:REMOTE_BROADCAST_SUBNET Broadcast address:0.0.0.0 Subnet mask:0.0.0.0
[2023/01/18 11:34:10.446430, 3] …/…/source3/nmbd/nmbd_namelistdb.c:263(add_name_to_subnet)
add_name_to_subnet: Added netbios name LOCALHOST<00> with first IP 127.0.0.1 ttl=0 nb_flags= 4 to subnet REMOTE_BROADCAST_SUBNET
[2023/01/18 11:34:10.446470, 3] …/…/source3/nmbd/nmbd_namelistdb.c:263(add_name_to_subnet)
add_name_to_subnet: Added netbios name LOCALHOST<20> with first IP 127.0.0.1 ttl=0 nb_flags= 4 to subnet REMOTE_BROADCAST_SUBNET
[2023/01/18 11:34:10.446488, 3] …/…/source3/nmbd/nmbd.c:1050(main)
Loaded hosts file /etc/samba/lmhosts
[2023/01/18 11:34:10.446505, 3] …/…/source3/nmbd/nmbd_namelistdb.c:263(add_name_to_subnet)
add_name_to_subnet: Added netbios name *<00> with first IP 192.168.30.75 ttl=0 nb_flags= 0 to subnet 192.168.30.75
[2023/01/18 11:34:10.446539, 3] …/…/source3/nmbd/nmbd_namelistdb.c:263(add_name_to_subnet)
add_name_to_subnet: Added netbios name *<20> with first IP 192.168.30.75 ttl=0 nb_flags= 0 to subnet 192.168.30.75
[2023/01/18 11:34:10.446557, 3] …/…/source3/nmbd/nmbd_namelistdb.c:263(add_name_to_subnet)
add_name_to_subnet: Added netbios name SAMBA<20> with first IP 192.168.30.75 ttl=0 nb_flags= 0 to subnet 192.168.30.75
[2023/01/18 11:34:10.446572, 3] …/…/source3/nmbd/nmbd_namelistdb.c:263(add_name_to_subnet)
add_name_to_subnet: Added netbios name SAMBA<00> with first IP 192.168.30.75 ttl=0 nb_flags= 0 to subnet 192.168.30.75
[2023/01/18 11:34:10.446651, 3] …/…/source3/nmbd/nmbd_serverlistdb.c:135(create_server_on_workgroup)
create_server_on_workgroup: Created server entry ROCKSTOR4 of type 40819a03 (Samba 4.15.12-git.535.7750e5c95ef150300.3.43.1-S) on workgroup WORKGROUP.
[2023/01/18 11:34:10.446669, 3] …/…/source3/nmbd/nmbd_workgroupdb.c:262(initiate_myworkgroup_startup)
initiate_myworkgroup_startup: Added server name entry ROCKSTOR4 on subnet 192.168.30.75
[2023/01/18 11:34:10.446687, 3] …/…/source3/nmbd/nmbd_namelistdb.c:263(add_name_to_subnet)
add_name_to_subnet: Added netbios name *<00> with first IP 192.168.30.75 ttl=0 nb_flags= 0 to subnet UNICAST_SUBNET
[2023/01/18 11:34:10.446703, 3] …/…/source3/nmbd/nmbd_namelistdb.c:263(add_name_to_subnet)
add_name_to_subnet: Added netbios name *<20> with first IP 192.168.30.75 ttl=0 nb_flags= 0 to subnet UNICAST_SUBNET
[2023/01/18 11:34:10.446728, 3] …/…/source3/nmbd/nmbd_namelistdb.c:263(add_name_to_subnet)
add_name_to_subnet: Added netbios name SAMBA<20> with first IP 192.168.30.75 ttl=0 nb_flags= 0 to subnet UNICAST_SUBNET
[2023/01/18 11:34:10.446745, 3] …/…/source3/nmbd/nmbd_namelistdb.c:263(add_name_to_subnet)
add_name_to_subnet: Added netbios name SAMBA<00> with first IP 192.168.30.75 ttl=0 nb_flags= 0 to subnet UNICAST_SUBNET
[2023/01/18 11:34:10.446762, 3] …/…/source3/nmbd/nmbd_namelistdb.c:263(add_name_to_subnet)
add_name_to_subnet: Added netbios name ROCKSTOR4<20> with first IP 192.168.30.75 ttl=0 nb_flags= 0 to subnet UNICAST_SUBNET
[2023/01/18 11:34:10.446779, 3] …/…/source3/nmbd/nmbd_namelistdb.c:263(add_name_to_subnet)
add_name_to_subnet: Added netbios name ROCKSTOR4<03> with first IP 192.168.30.75 ttl=0 nb_flags= 0 to subnet UNICAST_SUBNET
[2023/01/18 11:34:10.446796, 3] …/…/source3/nmbd/nmbd_namelistdb.c:263(add_name_to_subnet)
add_name_to_subnet: Added netbios name ROCKSTOR4<00> with first IP 192.168.30.75 ttl=0 nb_flags= 0 to subnet UNICAST_SUBNET
[2023/01/18 11:34:10.446822, 3] …/…/source3/nmbd/nmbd_namelistdb.c:263(add_name_to_subnet)
add_name_to_subnet: Added netbios name WORKGROUP<00> with first IP 192.168.30.75 ttl=0 nb_flags=80 to subnet UNICAST_SUBNET
[2023/01/18 11:34:10.446840, 3] …/…/source3/nmbd/nmbd_namelistdb.c:263(add_name_to_subnet)
add_name_to_subnet: Added netbios name WORKGROUP<1e> with first IP 192.168.30.75 ttl=0 nb_flags=80 to subnet UNICAST_SUBNET
[2023/01/18 11:34:10.446855, 3] …/…/source3/nmbd/nmbd_namelistdb.c:263(add_name_to_subnet)
add_name_to_subnet: Added netbios name *<00> with first IP 192.168.30.75 ttl=0 nb_flags= 0 to subnet REMOTE_BROADCAST_SUBNET
[2023/01/18 11:34:10.446870, 3] …/…/source3/nmbd/nmbd_namelistdb.c:263(add_name_to_subnet)
add_name_to_subnet: Added netbios name *<20> with first IP 192.168.30.75 ttl=0 nb_flags= 0 to subnet REMOTE_BROADCAST_SUBNET
[2023/01/18 11:34:10.446888, 3] …/…/source3/nmbd/nmbd_namelistdb.c:263(add_name_to_subnet)
add_name_to_subnet: Added netbios name SAMBA<20> with first IP 192.168.30.75 ttl=0 nb_flags= 0 to subnet REMOTE_BROADCAST_SUBNET
[2023/01/18 11:34:10.446904, 3] …/…/source3/nmbd/nmbd_namelistdb.c:263(add_name_to_subnet)
add_name_to_subnet: Added netbios name SAMBA<00> with first IP 192.168.30.75 ttl=0 nb_flags= 0 to subnet REMOTE_BROADCAST_SUBNET
[2023/01/18 11:34:10.447020, 3] …/…/source3/nmbd/nmbd_sendannounce.c:213(send_host_announcement)
send_host_announcement: type 819a03 for host ROCKSTOR4 on subnet 192.168.30.75 for workgroup WORKGROUP
[2023/01/18 11:34:10.447490, 3] …/…/source3/nmbd/nmbd_elections.c:80(check_for_master_browser_success)
check_for_master_browser_success: Local master browser for workgroup WORKGROUP exists at IP 192.168.30.51 (just checking).
[2023/01/18 11:34:14.453266, 3] …/…/source3/nmbd/nmbd_namelistdb.c:263(add_name_to_subnet)
add_name_to_subnet: Added netbios name ROCKSTOR4<20> with first IP 192.168.30.75 ttl=0 nb_flags= 0 to subnet 192.168.30.75
[2023/01/18 11:34:14.453402, 3] …/…/source3/nmbd/nmbd_namelistdb.c:263(add_name_to_subnet)
add_name_to_subnet: Added netbios name ROCKSTOR4<03> with first IP 192.168.30.75 ttl=0 nb_flags= 0 to subnet 192.168.30.75
[2023/01/18 11:34:14.453462, 3] …/…/source3/nmbd/nmbd_namelistdb.c:263(add_name_to_subnet)
add_name_to_subnet: Added netbios name ROCKSTOR4<00> with first IP 192.168.30.75 ttl=0 nb_flags= 0 to subnet 192.168.30.75
[2023/01/18 11:34:14.453535, 3] …/…/source3/nmbd/nmbd_namelistdb.c:263(add_name_to_subnet)
add_name_to_subnet: Added netbios name WORKGROUP<00> with first IP 192.168.30.75 ttl=0 nb_flags=80 to subnet 192.168.30.75
[2023/01/18 11:34:14.453589, 3] …/…/source3/nmbd/nmbd_namelistdb.c:263(add_name_to_subnet)
add_name_to_subnet: Added netbios name WORKGROUP<1e> with first IP 192.168.30.75 ttl=0 nb_flags=80 to subnet 192.168.30.75
[2023/01/18 11:34:34.471950, 3] …/…/source3/nmbd/nmbd_serverlistdb.c:414(write_browse_list)
write_browse_list: Wrote browse list into file /var/lib/samba/browse.dat
[2023/01/18 11:35:13.537940, 3] …/…/source3/nmbd/nmbd_incomingdgrams.c:270(process_local_master_announce)
process_local_master_announce: from APPARAT<00> IP 192.168.30.51 to WORKGROUP<1e> for server APPARAT.
[2023/01/18 11:35:13.537989, 3] …/…/source3/nmbd/nmbd_serverlistdb.c:135(create_server_on_workgroup)
create_server_on_workgroup: Created server entry APPARAT of type 40051003 () on workgroup WORKGROUP.
[2023/01/18 11:35:13.538187, 3] …/…/source3/nmbd/nmbd_serverlistdb.c:414(write_browse_list)
write_browse_list: Wrote browse list into file /var/lib/samba/browse.dat
[2023/01/18 11:35:13.538260, 3] …/…/source3/nmbd/nmbd_incomingdgrams.c:270(process_local_master_announce)
process_local_master_announce: from APPARAT<00> IP 192.168.30.51 to WORKGROUP<1e> for server APPARAT.
[2023/01/18 11:35:13.538297, 3] …/…/source3/nmbd/nmbd_sendannounce.c:213(send_host_announcement)

Processes are running:

rockstor4:/var/log # systemctl status smb.service
● smb.service - Samba SMB Daemon
Loaded: loaded (/etc/systemd/system/smb.service; enabled; vendor preset: disabled)
Active: active (running) since Wed 2023-01-18 11:34:10 CET; 8min ago
Docs: man:smbd(8)
man:samba(7)
man:smb.conf(5)
Process: 6178 ExecStartPre=/usr/share/samba/update-apparmor-samba-profile (code=exited, status=0/SUCCESS)
Main PID: 6179 (smbd)
Status: “smbd: ready to serve connections…”
Tasks: 4
CGroup: /system.slice/smb.service
├─6179 /usr/sbin/smbd --foreground --no-process-group
├─6181 /usr/sbin/smbd --foreground --no-process-group
├─6182 /usr/sbin/smbd --foreground --no-process-group
└─6183 /usr/lib64/samba/samba-bgqd --ready-signal-fd=47 --parent-watch-fd=13 --debuglevel=3 -F
Jan 18 11:34:10 rockstor4 systemd[1]: Starting Samba SMB Daemon…
Jan 18 11:34:10 rockstor4 smbd[6179]: [2023/01/18 11:34:10.346944, 0] …/…/source3/smbd/server.c:1734(main)
Jan 18 11:34:10 rockstor4 smbd[6179]: smbd version 4.15.12-git.535.7750e5c95ef150300.3.43.1-SUSE-oS15.0-x86_64 started.
Jan 18 11:34:10 rockstor4 smbd[6179]: Copyright Andrew Tridgell and the Samba Team 1992-2021
Jan 18 11:34:10 rockstor4 systemd[1]: Started Samba SMB Daemon.
rockstor4:/var/log # systemctl status nmb.service
● nmb.service - Samba NMB Daemon
Loaded: loaded (/usr/lib/systemd/system/nmb.service; enabled; vendor preset: disabled)
Active: active (running) since Wed 2023-01-18 11:34:10 CET; 8min ago
Docs: man:nmbd(8)
man:samba(7)
man:smb.conf(5)
Main PID: 6185 (nmbd)
Status: “nmbd: ready to serve connections…”
Tasks: 1
CGroup: /system.slice/nmb.service
└─6185 /usr/sbin/nmbd --foreground --no-process-group
Jan 18 11:34:10 rockstor4 systemd[1]: Starting Samba NMB Daemon…
Jan 18 11:34:10 rockstor4 nmbd[6185]: [2023/01/18 11:34:10.444411, 0] …/…/source3/nmbd/nmbd.c:901(main)
Jan 18 11:34:10 rockstor4 nmbd[6185]: nmbd version 4.15.12-git.535.7750e5c95ef150300.3.43.1-SUSE-oS15.0-x86_64 started.
Jan 18 11:34:10 rockstor4 nmbd[6185]: Copyright Andrew Tridgell and the Samba Team 1992-2021
Jan 18 11:34:10 rockstor4 systemd[1]: Started Samba NMB Daemon.

SMB Configuration:

I have to say, that I’m running stable kernel backports as described in the rockstor docs. So I’m not really sure if it’s related to the latest rockstor update or the latest kernel update.

Any help is appreciated

Mark93 · January 18, 2023, 1:41pm

After trying to downgrade samba package, kernel and rockstor, I can say that going back to Version 4.5.0-0 with Kernel Linux: 6.1.7-lp153.2.g872045c-default is working. So I would think it’s a problem specific to the new rockstor version (with my superficial knowledge )

Flox · January 18, 2023, 4:58pm

Hi @Mark93,

Thanks a lot for such a detailed report.
It’s a bit surprising to see it being related to Rockstor version as I don’t recall doing any work related to Samba between the two versions. I’m trying to reproduce that myself at the moment, but to verify something: how did you downgrade to Rockstor-4.5.0? Was it a whole-system snapshot or just the rpm? I just want to make sure Rockstor was the only thing downgraded when you did just that.

Mark93 · January 18, 2023, 5:08pm

Hey @Flox - I just downgraded the rpm.
Just to make sure it wasn’t a problem with my PC I also tried to access via iphone and another PC.
Possibly it was a interference between Rockstor and some of the samba-related packages?! I mean that they are at the latest version aside of the kernel itself. But I’m really far away of elaborating on this, due to lack of knowledge and understanding

Flox · January 18, 2023, 5:22pm

@Mark93,

Can you try to confirm something for me, please?
In you smb.conf, located at /etc/samba/smb.conf, could you replace any mention of /opt/rockstor/bin/mnt-share with /opt/rockstor/.venv/bin/mnt-share? There should be one for each of the Samba exports defined.
For instance, mine looks like that (the commented line is the before, and uncommented is the after the change):

$ cat /etc/samba/smb.conf 
[global]
    log level = 3
    map to guest = Bad User
    cups options = raw
    log file = /var/log/samba/log.%m
    printcap name = /dev/null
    load printers = no

####BEGIN: Rockstor SAMBA GLOBAL CUSTOM####
    workgroup = WORKGROUP
####END: Rockstor SAMBA GLOBAL CUSTOM####

####BEGIN: Rockstor SAMBA CONFIG####
[test_share01]
    root preexec = "/opt/rockstor/.venv/bin/mnt-share test_share01"
#    root preexec = "/opt/rockstor/bin/mnt-share test_share01"
    root preexec close = yes
    comment = Samba-Export
    path = /mnt2/test_share01
    browseable = yes
    read only = no
    guest ok = yes
####END: Rockstor SAMBA CONFIG####

Flox · January 18, 2023, 5:24pm

If you have many exports defined, you can also do all of them with:

sed -i 's:/opt/rockstor/bin:/opt/rockstor/.venv/bin:g' /etc/samba/smb.conf

Then, make sure to restart the relevant services:

systemctl restart smb nmb

phillxnet · January 18, 2023, 6:22pm

@Mark93 & @Flox This is my fault via:

github.com/rockstor/rockstor-core

Replace Buildout with Poetry #2432

rockstor:testing ← phillxnet:2432_Replace_Buildout_with_Poetry

opened 06:44PM - 04 Dec 22 UTC

phillxnet

+917 -7089

Our prior build system "Buildout" has now been superseded by more modern standar…ds based approaches. Here we remove our buildbot artifacts and replace them with an initial Poetry config. Fixes #2432 Supersedes #2433 @FroggyFlox & @Hooverdan96 Ready for review. ## Includes: - pyproject.toml - poetry.toml - to have poetry create/use .venv dir. Thanks to FroggyFlox for this gem. - use poetry created .venv/bin in initrock. - poetry.lock - via dependency constraints in pyproject.toml - move nginx service management: supervisord -> systemd and configure via a systemd override file instantiated/updated via initrock. Also required/includes some Web-UI log-manager modifications. - delete legacy manage.py, 64-btrfs.rules, smb.service, old db file, unused huey shell script file, and various bootstrap config files. - delete now legacy setup.py file. Poetry can generate this for us but we aim to go the more modern root of being entirely pyproject.toml based. - delete decade old selenium and bash tests. These tests have received zero attention in 10 years. - remove our prior django-hack.py (modified manage.py) This file is now redundant as it was associated with our prior buildout mechanism. As we have now moved to using a Poetry build/venv system we can simply use the vanilla django-admin from within the custom venv. - move nginx.conf, mime.types, gunicorn, & supervisord.conf to ./etc. - hard-wire rockstor service files - install dir. N.B. hard-coded directory paths in above 2 items. - update supervisord and gunicorn to latest Python 2.7 compat versions. - Pre-create top-level var/log dir with placeholder file. - remove long redundant docker conf file. - pg_dump notes from old buildbout file to initrock. - Use regular django-admin in initrock. - activate default static files FileSystemFinder to pick-up our jslibs top directory and incorporate into the generic static dir. - Simple script to prepare our source for a poetry build, includes the official poetry installer. - update supervisord.conf re upstream advice re user and dummpy pass. - Add note on moving gunicorn to systemd. - Move remaining systemd setup from rockstor-bootstrap rockstor-pre (initrock). We already to the vast majority of our initial systemd service config in initrock.py (rockstor-pre.service), so move the remaining duplicate firewalld and unique atd systemd commands from the 'bootstrap' command in command.py of storageadmin invoked by our scripts/bootstrap which in turn is started by our rockstor-bootstrap; to our rockstor-pre initrock.py setup. - modernise settings.py re dynamically establishing our run-time path and settings BASE_DIR accordingly. - configure pyproject.toml to have poetry dist tar include self build capability. - add comment on future build.py pre-build capability. Our current Python 2.7 tether prevents this capability. Co-authored-by: FroggyFlox <30297881+FroggyFlox@users.noreply.github.com>

I was sure I’d tested this function but alas not. I was thinking of the intended release before this rather forced (and large) change came upon us when we were unable to build rpms for 15.4. Alas.

We now have:

github.com/rockstor/rockstor-core

(t) 4.5.4-0 Samba shares fail

opened 06:15PM - 18 Jan 23 UTC

closed 09:56PM - 18 Jan 23 UTC

phillxnet

Thanks to forum member Mark93 for highlighting this issue and @FroggyFlox for th…e initial diagnosis. We have a path failure in our samba "root preexec = " entries where we inadvertently reference our now legacy build systems' script entry points: (See: Replace Buildout with Poetry #2432 #2434) ## before 4.5.4-0: > /opt/rockstor/bin ## 4.5.4-0 +: > /opt/rockstor/.venv/bin The following is an in-place work around post encountering this issue, provided by @FroggyFlox . ``` sed -i 's:/opt/rockstor/bin:/opt/rockstor/.venv/bin:g' /etc/samba/smb.conf systemctl restart smb nmb ``` Canonical forum reference: https://forum.rockstor.com/t/smb-shares-inaccesible-after-v4-5-4-0-upgrade/8627

Which I an now starting to look at.

@Mark93 Thanks from me also for an excellent report. I was unfortunately too distracted with our new build system and rpm build method and entirely missed this side-effect. Maybe this rpm should have been numbered 4.0.4 !

Thanks for the field test, much appreciated.

phillxnet · January 18, 2023, 6:48pm

@Mark93 & @Flox
Quick update:
It looks like we (miss)define this path here:

github.com

rockstor/rockstor-core/blob/28292f5b0bd1dc61673818d69164d3f471fe15e3/src/rockstor/system/samba.py#L52




def test_parm(config="/etc/samba/smb.conf"):
    cmd = [TESTPARM, "-s", config]
    o, e, rc = run_command(cmd, throw=False)
    if rc != 0:
        raise Exception("Syntax error while checking the temporary samba config file")
    return True




def rockstor_smb_config(fo, exports):
    mnt_helper = os.path.join(settings.ROOT_DIR, "bin/mnt-share")
    fo.write("{}\n".format(RS_SHARES_HEADER))
    for e in exports:
        admin_users = ""
        for au in e.admin_users.all():
            admin_users = "{}{} ".format(admin_users, au.username)
        fo.write("[{}]\n".format(e.share.name))
        fo.write('    root preexec = "{} {}"\n'.format(mnt_helper, e.share.name))
        fo.write("    root preexec close = yes\n")
        fo.write("    comment = {}\n".format(e.comment.encode("utf-8")))
        fo.write("    path = {}\n".format(e.path))

Just noting here in case folks are following along.

Mark93 · January 18, 2023, 8:30pm

@Flox @phillxnet
Works like a charm
Thank you guys!

phillxnet · January 18, 2023, 8:37pm

@Mark93 Thanks for the confirmation.

So just to be sure, have you tried the edit within the pull request referenced file so that a new samba share is setup and works as expected for you. I’m actually fairly rusty on samba, @Flox is our go-to on that (and many other) fronts I’m afraid. But I’m eager to get this fix settled given that there is engagement. And it’s a bad show of course .

I.e. the change to src/rockstor/system/samba.py so that it reads:

mnt_helper = os.path.join(settings.ROOT_DIR, “.venv/bin/mnt-share”)

Cheers.

Mark93 · January 18, 2023, 8:40pm

This fixed it for me

phillxnet · January 18, 2023, 8:45pm

@Mark93 Thanks, that helps.

Future share definitions will still have the old incorrect path unfortunately. But the referenced pull request has the proposed fix for those. But a rockstor.service restart will be required post the code change. We will try and get an updated rpm release our shortly.

Thanks again for the engagement here.

Jorma_Tuomainen · January 18, 2023, 9:37pm

fixing root preexec fixed it for me too.

Flox · January 18, 2023, 9:39pm

Thanks a lot for the confirmation, @Jorma_Tuomainen, that’s really helpful!

Kuro · January 20, 2023, 8:29am

This fixed after the recent updatemy issue! Thank for providing this solution.

(I’ll never auto-reboot after an update again)

KarstenV · January 21, 2023, 10:26am

This fixed the problem for me to.

Updated to 4.5.5.0 today and lost all my Samba shares.

Thankfully help was nearby in the forums

phillxnet · January 21, 2023, 2:35pm

@Flox @Mark93 @Jorma_Tuomainen @Kuro @KarstenV

Give that we have essentially fixed all new shares in 4.5.5-0 but existing definitions will need intervention as per @Flox sed above, and that most folks will just updated and move-on. Maybe what we need here is the same, or similar, sed to be run in our initrock script by way of migrating folks over. It can do no harm if they are on a fresh install and tends to what will now be a potentially years long issue as folks upgrade to what is now our new-norm file structure wise. I’m not keen on establishing redirect etc as it only leads to confusion obfoscation regarding the canonical location of such launchers. And our new .venv is a well understood default in the python world.

Anyway just a thought and wanted to see float the idea here before issue it.

In short I propose that we sed edit smb.conf to address the migration required. Or what-ever short cut will do the same during our future updates. We are on RC2 now so now is the time to get such a migration requirement into initrock if it is needed. It may be that as from 4.5.5-0 we have other migration options available. I’ve just not looking into what will reliable re-write the smb.conf with our new .venv launcher location for the mnt_helper.

Ideas and further experimentation welcome as always.

Mark93 · January 21, 2023, 4:13pm

Good idea to save people from the initial shock when their shares become inaccessible after the upgrade. To me it sounds like a reasonable way to do it this way

Flox · January 21, 2023, 8:06pm

I too like the idea, especially for those users who may not have realized such a change would have been needed. It’s also not too costly as it shouldn’t add too much to the Rockstor boot time; this is especially true if you consider a Rockstor as an appliance that is relatively not rebooted that often.

Currently, the only workaround/fix available to the user in the webUI is I believe, to edit a currently existing Samba export or add a new one, as this will then trigger the rewrite of smb.conf using the new path for mnt_helper. The user shouldn’t have to do that all things considered so having the Rockstor boot process ensuring that this sort of things is in order is valuable in my opinion, and the place to do that.

One has also to consider that the same applies for the snapshot, scrub, and shutdown scheduled tasks (all listed in /etc/cron.d/rockstortab), which would thus add even more burden to the user if they had to fix all of that from the webUI.