Alexander Sinev
2018-Oct-29 16:50 UTC
[Samba] smb.service fails to start after openSUSE Tumbleweed update
Hello! I had working Samba installation on openSUSE Tumbleweed server. I made my previous OS update a month ago, and everything worked fine after it. But today I updated the OS again, and smb.service failed to start. Version 4.9.1-git.96.c3bff26bf16SUSE-oS15.5-x86_64 I tried many things: - minimal config - removed Samba package with all the dependencies and installed it again and so on. I also tried to set up Samba on another openSUSE Tumbleweed server with newly updated OS, and it works fine there with the same minimal config. I cannot find the cause of the problem. The difference in the logs of working and non-working instances is in the following log entries of non-working instance: [2018/10/29 18:58:48.292061, 3] ../source3/groupdb/mapping.c:834(pdb_create_builtin_alias) pdb_create_builtin_alias: Could not get a gid out of winbind [2018/10/29 18:58:48.292134, 2] ../source3/auth/token_util.c:713(finalize_local_nt_token) WARNING: Failed to create BUILTIN\Administrators group! Can Winbind allocate gids? and so on. My full log is: [2018/10/29 18:58:48.254096, 3] ../source3/param/loadparm.c:3873(lp_load_ex) lp_load_ex: refreshing parameters [2018/10/29 18:58:48.254201, 3] ../source3/param/loadparm.c:548(init_globals) Initialising global parameters [2018/10/29 18:58:48.254407, 3] ../source3/param/loadparm.c:2786(lp_do_section) Processing section "[global]" doing parameter workgroup = HOME doing parameter case sensitive = no doing parameter interfaces = lo enp1s0 doing parameter bind interfaces only = yes doing parameter restrict anonymous = 0 doing parameter dns proxy = no doing parameter log file = /var/log/samba/log.%m doing parameter log level = 4 [2018/10/29 18:58:48.254660, 2] ../source3/param/loadparm.c:2803(lp_do_section) Processing section "[Video]" doing parameter comment = "Video share" doing parameter path = /mnt/hdd1/Multimedia/Video doing parameter browseable = yes doing parameter writeable = yes doing parameter guest ok = yes [2018/10/29 18:58:48.254814, 4] ../source3/param/loadparm.c:3915(lp_load_ex) pm_process() returned Yes [2018/10/29 18:58:48.254868, 3] ../source3/param/loadparm.c:1621(lp_add_ipc) adding IPC service [2018/10/29 18:58:48.256292, 2] ../source3/lib/interface.c:345(add_interface) added interface lo ip=::1 bcast= netmask=ffff:ffff:ffff:ffff:ffff:ffff:ffff:ffff [2018/10/29 18:58:48.256369, 2] ../source3/lib/interface.c:345(add_interface) added interface lo ip=127.0.0.1 bcast=127.255.255.255 netmask=255.0.0.0 [2018/10/29 18:58:48.256408, 2] ../source3/lib/interface.c:345(add_interface) added interface enp1s0 ip=192.168.1.10 bcast=192.168.1.255 netmask=255.255.255.0 [2018/10/29 18:58:48.256468, 3] ../source3/smbd/server.c:1810(main) loaded services [2018/10/29 18:58:48.269106, 1] ../source3/profile/profile.c:51(set_profile_level) INFO: Profiling turned OFF from pid 20958 [2018/10/29 18:58:48.269192, 3] ../source3/smbd/server.c:1830(main) Standard input is not a socket, assuming -D option [2018/10/29 18:58:48.269224, 3] ../source3/smbd/server.c:1842(main) Becoming a daemon. [2018/10/29 18:58:48.270070, 2] ../source3/passdb/pdb_interface.c:161(make_pdb_method_name) No builtin backend found, trying to load plugin [2018/10/29 18:58:48.274731, 3] ../lib/util/modules.c:167(load_module_absolute_path) load_module_absolute_path: Module '/usr/lib64/samba/pdb/tdbsam.so' loaded [2018/10/29 18:58:48.279952, 3] ../source3/lib/util_procid.c:54(pid_to_procid) pid_to_procid: messaging_dgm_get_unique failed: No such file or directory [2018/10/29 18:58:48.291476, 4] ../source3/smbd/sec_ctx.c:216(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1 [2018/10/29 18:58:48.291580, 4] ../source3/smbd/uid.c:527(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 0 [2018/10/29 18:58:48.291620, 4] ../source3/smbd/sec_ctx.c:320(set_sec_ctx_internal) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1 [2018/10/29 18:58:48.291689, 3] ../source3/auth/token_util.c:681(finalize_local_nt_token) Failed to fetch domain sid for HOME [2018/10/29 18:58:48.291729, 4] ../source3/smbd/sec_ctx.c:438(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0 [2018/10/29 18:58:48.291928, 4] ../source3/smbd/sec_ctx.c:216(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1 [2018/10/29 18:58:48.291963, 4] ../source3/smbd/uid.c:527(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 0 [2018/10/29 18:58:48.291993, 4] ../source3/smbd/sec_ctx.c:320(set_sec_ctx_internal) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1 [2018/10/29 18:58:48.292061, 3] ../source3/groupdb/mapping.c:834(pdb_create_builtin_alias) pdb_create_builtin_alias: Could not get a gid out of winbind [2018/10/29 18:58:48.292101, 4] ../source3/smbd/sec_ctx.c:438(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0 [2018/10/29 18:58:48.292134, 2] ../source3/auth/token_util.c:713(finalize_local_nt_token) WARNING: Failed to create BUILTIN\Administrators group! Can Winbind allocate gids? [2018/10/29 18:58:48.292175, 4] ../source3/smbd/sec_ctx.c:216(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1 [2018/10/29 18:58:48.292226, 4] ../source3/smbd/uid.c:527(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 0 [2018/10/29 18:58:48.292259, 4] ../source3/smbd/sec_ctx.c:320(set_sec_ctx_internal) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1 [2018/10/29 18:58:48.292311, 3] ../source3/groupdb/mapping.c:834(pdb_create_builtin_alias) pdb_create_builtin_alias: Could not get a gid out of winbind [2018/10/29 18:58:48.292351, 4] ../source3/smbd/sec_ctx.c:438(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0 [2018/10/29 18:58:48.292383, 2] ../source3/auth/token_util.c:732(finalize_local_nt_token) WARNING: Failed to create BUILTIN\Users group! Can Winbind allocate gids? [2018/10/29 18:58:48.292423, 4] ../source3/smbd/sec_ctx.c:216(push_sec_ctx) push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1 [2018/10/29 18:58:48.292455, 4] ../source3/smbd/uid.c:527(push_conn_ctx) push_conn_ctx(0) : conn_ctx_stack_ndx = 0 [2018/10/29 18:58:48.292486, 4] ../source3/smbd/sec_ctx.c:320(set_sec_ctx_internal) setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1 [2018/10/29 18:58:48.292545, 3] ../source3/groupdb/mapping.c:834(pdb_create_builtin_alias) pdb_create_builtin_alias: Could not get a gid out of winbind [2018/10/29 18:58:48.292584, 4] ../source3/smbd/sec_ctx.c:438(pop_sec_ctx) pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0 [2018/10/29 18:58:48.292617, 2] ../source3/auth/token_util.c:774(finalize_local_nt_token) Failed to create BUILTIN\Guests group NT_STATUS_ACCESS_DENIED! Can Winbind allocate gids? [2018/10/29 18:58:48.292659, 3] ../source3/auth/token_util.c:412(create_local_nt_token_from_info3) Failed to finalize nt token [2018/10/29 18:58:48.292691, 0] ../source3/auth/auth_util.c:1382(make_new_session_info_guest) create_local_token failed: NT_STATUS_ACCESS_DENIED [2018/10/29 18:58:48.292823, 0] ../source3/smbd/server.c:2000(main) ERROR: failed to setup guest info.
L.P.H. van Belle
2018-Oct-29 17:12 UTC
[Samba] smb.service fails to start after openSUSE Tumbleweed update
Hai, Yes that is know. Enable and change the range to a, for you usable range, outside the current ranges. Example: idmap config * : backend = tdb idmap config * : range = 3000-7999 Now start samba and winbind. And posting you smb.conf really helps of analyze things like this. Greetz, Louis> -----Oorspronkelijk bericht----- > Van: samba [mailto:samba-bounces at lists.samba.org] Namens > Alexander Sinev via samba > Verzonden: maandag 29 oktober 2018 17:51 > Aan: samba at lists.samba.org > Onderwerp: [Samba] smb.service fails to start after openSUSE > Tumbleweed update > > Hello! I had working Samba installation on openSUSE > Tumbleweed server. > I made my previous OS update a month ago, and everything worked fine > after it. But today I updated the OS again, and smb.service > failed to > start. > > Version 4.9.1-git.96.c3bff26bf16SUSE-oS15.5-x86_64 > > I tried many things: > > - minimal config > > - removed Samba package with all the dependencies and > installed it again > > and so on. I also tried to set up Samba on another openSUSE > Tumbleweed > server with newly updated OS, and it works fine there with the same > minimal config. I cannot find the cause of the problem. > > The difference in the logs of working and non-working instances is in > the following log entries of non-working instance: > > [2018/10/29 18:58:48.292061, 3] > ../source3/groupdb/mapping.c:834(pdb_create_builtin_alias) > pdb_create_builtin_alias: Could not get a gid out of winbind > > [2018/10/29 18:58:48.292134, 2] > ../source3/auth/token_util.c:713(finalize_local_nt_token) > WARNING: Failed to create BUILTIN\Administrators group! > Can Winbind > allocate gids? > > and so on. > > > My full log is: > > [2018/10/29 18:58:48.254096, 3] > ../source3/param/loadparm.c:3873(lp_load_ex) > lp_load_ex: refreshing parameters > [2018/10/29 18:58:48.254201, 3] > ../source3/param/loadparm.c:548(init_globals) > Initialising global parameters > [2018/10/29 18:58:48.254407, 3] > ../source3/param/loadparm.c:2786(lp_do_section) > Processing section "[global]" > doing parameter workgroup = HOME > doing parameter case sensitive = no > doing parameter interfaces = lo enp1s0 > doing parameter bind interfaces only = yes > doing parameter restrict anonymous = 0 > doing parameter dns proxy = no > doing parameter log file = /var/log/samba/log.%m > doing parameter log level = 4 > [2018/10/29 18:58:48.254660, 2] > ../source3/param/loadparm.c:2803(lp_do_section) > Processing section "[Video]" > doing parameter comment = "Video share" > doing parameter path = /mnt/hdd1/Multimedia/Video > doing parameter browseable = yes > doing parameter writeable = yes > doing parameter guest ok = yes > [2018/10/29 18:58:48.254814, 4] > ../source3/param/loadparm.c:3915(lp_load_ex) > pm_process() returned Yes > [2018/10/29 18:58:48.254868, 3] > ../source3/param/loadparm.c:1621(lp_add_ipc) > adding IPC service > [2018/10/29 18:58:48.256292, 2] > ../source3/lib/interface.c:345(add_interface) > added interface lo ip=::1 bcast= > netmask=ffff:ffff:ffff:ffff:ffff:ffff:ffff:ffff > [2018/10/29 18:58:48.256369, 2] > ../source3/lib/interface.c:345(add_interface) > added interface lo ip=127.0.0.1 bcast=127.255.255.255 > netmask=255.0.0.0 > [2018/10/29 18:58:48.256408, 2] > ../source3/lib/interface.c:345(add_interface) > added interface enp1s0 ip=192.168.1.10 bcast=192.168.1.255 > netmask=255.255.255.0 > [2018/10/29 18:58:48.256468, 3] ../source3/smbd/server.c:1810(main) > loaded services > [2018/10/29 18:58:48.269106, 1] > ../source3/profile/profile.c:51(set_profile_level) > INFO: Profiling turned OFF from pid 20958 > [2018/10/29 18:58:48.269192, 3] ../source3/smbd/server.c:1830(main) > Standard input is not a socket, assuming -D option > [2018/10/29 18:58:48.269224, 3] ../source3/smbd/server.c:1842(main) > Becoming a daemon. > [2018/10/29 18:58:48.270070, 2] > ../source3/passdb/pdb_interface.c:161(make_pdb_method_name) > No builtin backend found, trying to load plugin > [2018/10/29 18:58:48.274731, 3] > ../lib/util/modules.c:167(load_module_absolute_path) > load_module_absolute_path: Module > '/usr/lib64/samba/pdb/tdbsam.so' loaded > [2018/10/29 18:58:48.279952, 3] > ../source3/lib/util_procid.c:54(pid_to_procid) > pid_to_procid: messaging_dgm_get_unique failed: No such > file or directory > [2018/10/29 18:58:48.291476, 4] > ../source3/smbd/sec_ctx.c:216(push_sec_ctx) > push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1 > [2018/10/29 18:58:48.291580, 4] > ../source3/smbd/uid.c:527(push_conn_ctx) > push_conn_ctx(0) : conn_ctx_stack_ndx = 0 > [2018/10/29 18:58:48.291620, 4] > ../source3/smbd/sec_ctx.c:320(set_sec_ctx_internal) > setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1 > [2018/10/29 18:58:48.291689, 3] > ../source3/auth/token_util.c:681(finalize_local_nt_token) > Failed to fetch domain sid for HOME > [2018/10/29 18:58:48.291729, 4] > ../source3/smbd/sec_ctx.c:438(pop_sec_ctx) > pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0 > [2018/10/29 18:58:48.291928, 4] > ../source3/smbd/sec_ctx.c:216(push_sec_ctx) > push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1 > [2018/10/29 18:58:48.291963, 4] > ../source3/smbd/uid.c:527(push_conn_ctx) > push_conn_ctx(0) : conn_ctx_stack_ndx = 0 > [2018/10/29 18:58:48.291993, 4] > ../source3/smbd/sec_ctx.c:320(set_sec_ctx_internal) > setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1 > [2018/10/29 18:58:48.292061, 3] > ../source3/groupdb/mapping.c:834(pdb_create_builtin_alias) > pdb_create_builtin_alias: Could not get a gid out of winbind > [2018/10/29 18:58:48.292101, 4] > ../source3/smbd/sec_ctx.c:438(pop_sec_ctx) > pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0 > [2018/10/29 18:58:48.292134, 2] > ../source3/auth/token_util.c:713(finalize_local_nt_token) > WARNING: Failed to create BUILTIN\Administrators group! > Can Winbind > allocate gids? > [2018/10/29 18:58:48.292175, 4] > ../source3/smbd/sec_ctx.c:216(push_sec_ctx) > push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1 > [2018/10/29 18:58:48.292226, 4] > ../source3/smbd/uid.c:527(push_conn_ctx) > push_conn_ctx(0) : conn_ctx_stack_ndx = 0 > [2018/10/29 18:58:48.292259, 4] > ../source3/smbd/sec_ctx.c:320(set_sec_ctx_internal) > setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1 > [2018/10/29 18:58:48.292311, 3] > ../source3/groupdb/mapping.c:834(pdb_create_builtin_alias) > pdb_create_builtin_alias: Could not get a gid out of winbind > [2018/10/29 18:58:48.292351, 4] > ../source3/smbd/sec_ctx.c:438(pop_sec_ctx) > pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0 > [2018/10/29 18:58:48.292383, 2] > ../source3/auth/token_util.c:732(finalize_local_nt_token) > WARNING: Failed to create BUILTIN\Users group! Can Winbind > allocate gids? > [2018/10/29 18:58:48.292423, 4] > ../source3/smbd/sec_ctx.c:216(push_sec_ctx) > push_sec_ctx(0, 0) : sec_ctx_stack_ndx = 1 > [2018/10/29 18:58:48.292455, 4] > ../source3/smbd/uid.c:527(push_conn_ctx) > push_conn_ctx(0) : conn_ctx_stack_ndx = 0 > [2018/10/29 18:58:48.292486, 4] > ../source3/smbd/sec_ctx.c:320(set_sec_ctx_internal) > setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1 > [2018/10/29 18:58:48.292545, 3] > ../source3/groupdb/mapping.c:834(pdb_create_builtin_alias) > pdb_create_builtin_alias: Could not get a gid out of winbind > [2018/10/29 18:58:48.292584, 4] > ../source3/smbd/sec_ctx.c:438(pop_sec_ctx) > pop_sec_ctx (0, 0) - sec_ctx_stack_ndx = 0 > [2018/10/29 18:58:48.292617, 2] > ../source3/auth/token_util.c:774(finalize_local_nt_token) > Failed to create BUILTIN\Guests group > NT_STATUS_ACCESS_DENIED! Can > Winbind allocate gids? > [2018/10/29 18:58:48.292659, 3] > ../source3/auth/token_util.c:412(create_local_nt_token_from_info3) > Failed to finalize nt token > [2018/10/29 18:58:48.292691, 0] > ../source3/auth/auth_util.c:1382(make_new_session_info_guest) > create_local_token failed: NT_STATUS_ACCESS_DENIED > [2018/10/29 18:58:48.292823, 0] ../source3/smbd/server.c:2000(main) > ERROR: failed to setup guest info. > > -- > To unsubscribe from this list go to the following URL and read the > instructions: https://lists.samba.org/mailman/options/samba > >
Rowland Penny
2018-Oct-29 17:37 UTC
[Samba] smb.service fails to start after openSUSE Tumbleweed update
On Mon, 29 Oct 2018 18:12:04 +0100 "L.P.H. van Belle via samba" <samba at lists.samba.org> wrote:> Hai, > > Yes that is know. > > Enable and change the range to a, for you usable range, outside the > current ranges. Example: > idmap config * : backend = tdb > idmap config * : range = 3000-7999 > > Now start samba and winbind. > > And posting you smb.conf really helps of analyze things like this. >In a way he did ;-) [global] workgroup = HOME case sensitive = no interfaces = lo enp1s0 bind interfaces only = yes restrict anonymous = 0 dns proxy = no log file = /var/log/samba/log.%m log level = 4 [Video] comment = "Video share" path = /mnt/hdd1/Multimedia/Video guest ok = yes It is a 'standalone server', but I don't know why he has 'guest ok yes', he doesn't have 'map to guest = Bad User', so the guest user will never get near the share. I think we need to know more about the OP's set up. Rowland
Alexander Sinev
2018-Oct-31 06:10 UTC
[Samba] smb.service fails to start after openSUSE Tumbleweed update
On 29.10.2018 20:12, L.P.H. van Belle via samba wrote:> Hai, > > Yes that is know. > > Enable and change the range to a, for you usable range, outside the current ranges. > Example: > idmap config * : backend = tdb > idmap config * : range = 3000-7999 > > Now start samba and winbind. > > And posting you smb.conf really helps of analyze things like this. > > Greetz, > > LouisHi, thank you for your reply, Louis. It did not help, unfortunately. I think the problem was in some broken dependencies, I couldn't find the real cause. Bearing in mind that another similar server did not have such issues, I decided to reinstall everything from scratch, from OS intstallation. Now everything is working fine with my old Samba configs, without any dances with tambourine (no winbind, nmb, etc., just my router's Unbound). Thanks anyway for your precious help! Best regards, Alex