90 replies to this topic

[doglover]

De HD2400 gaat niet in deep standby.  Heb die nu de master browser laten spelen.

 

Vanaf het moment dat ik een apparaat als master browser aangeduid heb, is het niet fout gegaan. 

De NAS heeft het een dag gedaan.  Staat nu terug af. (master browser)

Ook de HD2400 heeft 2 dagen als master browser gestaan, en toen ging het ook goed.  Staat nu terug.

 

Het begint mij nu langzaam te dagen wat er verkeerd kon gegaan zijn.  Ik heb 4 apparaten met Samba.

Een HD2400, een ET6500 (die regelmatig in deep standby gaat), een linuxPC die ook regelmatig in deep standby gaat en een Synology NAS.

En voordien was geen enkele gedefinieerd als master browser.  Blijkbaar was soms een van de apparaten die in deep standby gingen master browser geraakt (waarom?) en liep e.e.a in het honderd.

 

Willy

[WanWizard]

Als je niks definieert dan wordt er flink heen en weer gebroadcast, en is het afhankelijk wie wat op welk moment ziet, of het werkt of niet, vrij random dus. Definieer je een master browser, dan houdt die gewoon centraal alles bij.

[doglover]

Niet tegenstaande momenteel een master browser gedifinieerd is deze ochtend geen verbinding met de HD2400.

 

Ik wou samba op de HD2400 heropstarten en toen kreeg ik dit:

root@hd2400:~# /etc/init.d/samba.sh restart
Stopping Samba: smbdstart-stop-daemon: warning: killing process 476: No such process nmbd.
Waiting for samba processes to die off...
Starting Samba: smbd nmbd.
root@hd2400:~#

Blijkt dus dat er iets niet draait, of gecrasht is of niet geladen.

Trouwens na deze herstart van samba, waren de verbindingen terug OK.

 

Willy

[Bram55]

Voor mij was dit toch écht de oplossing. Nu een dag of vier in gebruik en sindsdien geen probleem meer gehad.

Je begrijpt dat ik van de samba.config zoals die nu is een kopie hebt gemaakt op de HDD vd NAS.

Ook heb ik een txt file waarin enkele tips/geheugensteuntjes staan voor bij een schone flash.

Ook daarin staan die drie regels.

[WanWizard]

Blijkt dus dat er iets niet draait, of gecrasht is of niet geladen.

 

Dat is inderdaad niet in de haak. Heeft de box sinds je aanpassing in deep standby (= uit) gestaan? Staan er foutmeldingen in de samba logfiles in /var/log... ?

[doglover]

Deze ochtend herstart.  En ndadien had ie het probleem.

Box is niet in deepstandby geweest.  Gewoon volledig herstart.  (rond 06h00)

Iets na 9h00 Samba herstart.

 

Log:

[1970/01/01 01:00:15.544603,  0] ../source3/lib/util.c:478(reinit_after_fork)
  messaging_reinit() failed: NT_STATUS_INVALID_PARAMETER
[1970/01/01 01:00:15.563754,  0] ../source3/lib/util.c:478(reinit_after_fork)
  messaging_reinit() failed: NT_STATUS_INVALID_PARAMETER
[1970/01/01 01:00:15.564175,  0] ../lib/util/become_daemon.c:111(exit_daemon)
  STATUS=daemon failed to start: Samba cannot init the cleanupd, error code 13
[2017/11/13 09:17:21.133888,  0] ../lib/util/become_daemon.c:124(daemon_ready)
  STATUS=daemon 'smbd' finished starting up and ready to serve connections
[2017/11/13 09:17:48.152121,  0] ../lib/util/charset/codepoints.c:16630(get_conv_handle)
  dos charset 'CP850' unavailable - using ASCII
[2017/11/13 10:06:01.936429,  0] ../lib/util/charset/codepoints.c:16630(get_conv_handle)
  dos charset 'CP850' unavailable - using ASCII
[2017/11/13 10:06:02.129052,  0] ../lib/util/charset/codepoints.c:16630(get_conv_handle)
  dos charset 'CP850' unavailable - using ASCII
[2017/11/13 10:12:09.194033,  0] ../lib/util/charset/codepoints.c:16630(get_conv_handle)
  dos charset 'CP850' unavailable - using ASCII
[2017/11/13 10:12:09.214037,  0] ../lib/util/charset/codepoints.c:16630(get_conv_handle)
  dos charset 'CP850' unavailable - using ASCII
[2017/11/13 10:21:14.974097,  0] ../lib/util/charset/codepoints.c:16630(get_conv_handle)
  dos charset 'CP850' unavailable - using ASCII
[2017/11/13 10:21:14.991701,  0] ../lib/util/charset/codepoints.c:16630(get_conv_handle)
  dos charset 'CP850' unavailable - using ASCII
[2017/11/13 10:26:37.541887,  0] ../lib/util/charset/codepoints.c:16630(get_conv_handle)
  dos charset 'CP850' unavailable - using ASCII
[2017/11/13 10:26:37.559805,  0] ../lib/util/charset/codepoints.c:16630(get_conv_handle)
  dos charset 'CP850' unavailable - using ASCII

[WanWizard]

Dat zou deze kunnen zijn: https://bugzilla.sam...ug.cgi?id=12016, daar moet naar gekeken worden.

[doglover]

Ik heb nog af en toe een probleem dat samba niet correct opstart.

Meestal gaat het wel goed.

 

Deze ochtend was er een box missende onder windows.

In telnet samba herstart, en dit was het resultaat:

root@sh1:~# /etc/init.d/samba.sh restart                                      
Stopping Samba: smbdstart-stop-daemon: warning: killing process 432: No such process nmbd.                                                                        
Waiting for samba processes to die off...                                     
Starting Samba: smbd nmbd.                                                    
root@sh1:~#

BTW: dit is

Systeem OE:  PLi-OE
Firmware versie:  OpenPLi 6.1-rc (2017-12-15 rc)
Kernel versie / stuurprogramma datum:  4.10.12 / 4.10.12-20171108-r0.0

 

Willy

Edited by doglover, 2 February 2018 - 10:02.

[WanWizard]

Even in /var/log/log.nmbd kijken of er foutmeldingen in staan?

[doglover]

Te laat.

Box is deze middag afgezet.  Hoepelijk denk ik er volgende keer als het nog eens gebeurd.

 

Willy

[doglover]

Weer gebeurd.

 

log.smdb

[1970/01/01 01:00:15.376963,  0] ../source3/lib/util.c:478(reinit_after_fork)
  messaging_reinit() failed: NT_STATUS_INVALID_PARAMETER
[1970/01/01 01:00:15.380022,  0] ../lib/util/become_daemon.c:111(exit_daemon)
  STATUS=daemon failed to start: Samba cannot init the cleanupd, error code 13

log.nmdv:

[1970/01/01 01:00:16.022979,  0] ../lib/util/become_daemon.c:124(daemon_ready)
  STATUS=daemon 'nmbd' finished starting up and ready to serve connections
[1970/01/01 01:00:16.030102,  0] ../source3/nmbd/nmbd_become_dmb.c:294(become_domain_master_browser_bcast)
  become_domain_master_browser_bcast:
  Attempting to become domain master browser on workgroup WORKGROUP on subnet 192.168.178.19
[1970/01/01 01:00:16.031863,  0] ../source3/nmbd/nmbd_become_dmb.c:307(become_domain_master_browser_bcast)
  become_domain_master_browser_bcast: querying subnet 192.168.178.19 for domain master browser on workgroup WORKGROUP
[2018/02/09 05:53:44.528258,  0] ../source3/nmbd/nmbd_become_dmb.c:112(become_domain_master_stage2)
  *****
 
  Samba server HD2400 is now a domain master browser for workgroup WORKGROUP on subnet 192.168.178.19
 
  *****
[2018/02/09 05:53:57.618390,  0] ../source3/nmbd/nmbd_become_lmb.c:397(become_local_master_stage2)
  *****
 
  Samba name server HD2400 is now a local master browser for workgroup WORKGROUP on subnet 192.168.178.19
 
  *****

Als dit helpt.

 

Willy

[WanWizard]

Zou het te maken kunnen hebben met het feit dat de tijd op je box (nog) niet deugd?

 

Zet eens

log level = 3

er bij in de global sectie van je smb.conf, en post de log eens opnieuw als het weer gebeurd?

 

Er zijn namelijk 12 verschillende redenen waarom de cleanupd_init() zou kunnen mislukken, maar welke wordt alleen zichtbaar in de debug log.

[doglover]

Is op beide boxen erbij gezet.

Zal morgen na de opstart de log file eens terug opvragen (goed of niet).

 

Willy

 

PS:  Het gebeurt niet zo vaak, maar als het gebeurt is het het vervelend.  (weet nu wel hoe het op te lossen)

[WanWizard]

Merci. Hopelijk komt er wat uit en kunnen we verder zoeken.

[doglover]

Weer eens geen Samba verbinding na een opstart.

Logs (log level =3 is actief)

 

log.nmbd

[1970/01/01 01:00:34.090738,  2] ../source3/lib/tallocmsg.c:56(register_msg_pool_usage)
  Registered MSG_REQ_POOL_USAGE
[1970/01/01 01:00:34.091255,  2] ../source3/lib/dmallocmsg.c:78(register_dmalloc_msgs)
  Registered MSG_REQ_DMALLOC_MARK and LOG_CHANGED
[1970/01/01 01:00:34.093218,  3] ../source3/param/loadparm.c:3742(lp_load_ex)
  lp_load_ex: refreshing parameters
[1970/01/01 01:00:34.094215,  3] ../source3/param/loadparm.c:544(init_globals)
  Initialising global parameters
[1970/01/01 01:00:34.094931,  2] ../source3/param/loadparm.c:316(max_open_files)
  rlimit_max: increasing rlimit_max (1024) to minimum Windows limit (16384)
[1970/01/01 01:00:34.096556,  3] ../source3/param/loadparm.c:2671(lp_do_section)
  Processing section "[global]"
[1970/01/01 01:00:34.101696,  3] ../source3/nmbd/nmbd.c:414(reload_nmbd_services)
  services not loaded
[1970/01/01 01:00:34.105811,  3] ../source3/nmbd/nmbd.c:953(main)
  standard input is not a socket, assuming -D option
[1970/01/01 01:00:34.106197,  3] ../source3/nmbd/nmbd.c:958(main)
  Becoming a daemon.
[1970/01/01 01:00:34.138289,  1] ../source3/lib/messages_dgm.c:157(messaging_dgm_lockfile_create)
  messaging_dgm_lockfile_create: write failed: Invalid argument
[1970/01/01 01:00:34.140900,  1] ../source3/lib/messages_dgm.c:228(messaging_dgm_init)
  messaging_dgm_init: messaging_dgm_create_lockfile failed: Invalid argument
[1970/01/01 01:00:34.141349,  2] ../source3/lib/messages.c:409(messaging_reinit)
  messaging_dgm_ref failed: Invalid argument
[1970/01/01 01:00:34.141988,  0] ../source3/lib/util.c:478(reinit_after_fork)
  messaging_reinit() failed: NT_STATUS_INVALID_PARAMETER
[1970/01/01 01:00:34.142398,  0] ../lib/util/become_daemon.c:111(exit_daemon)
  STATUS=daemon failed to start: reinit_after_fork() failed, error code 22

log.smdb

[1970/01/01 01:00:30.579711,  3] ../source3/param/loadparm.c:3742(lp_load_ex)
  lp_load_ex: refreshing parameters
[1970/01/01 01:00:30.581040,  3] ../source3/param/loadparm.c:544(init_globals)
  Initialising global parameters
[1970/01/01 01:00:30.581741,  2] ../source3/param/loadparm.c:316(max_open_files)
  rlimit_max: increasing rlimit_max (1024) to minimum Windows limit (16384)
[1970/01/01 01:00:30.583666,  3] ../source3/param/loadparm.c:2671(lp_do_section)
  Processing section "[global]"
[1970/01/01 01:00:30.587655,  2] ../source3/param/loadparm.c:2688(lp_do_section)
  Processing section "[root]"
[1970/01/01 01:00:30.598099,  2] ../source3/param/loadparm.c:2688(lp_do_section)
  Processing section "[Media]"
[1970/01/01 01:00:30.602402,  2] ../source3/param/loadparm.c:2688(lp_do_section)
  Processing section "[Harddisk]"
[1970/01/01 01:00:30.608921,  3] ../source3/param/loadparm.c:1588(lp_add_ipc)
  adding IPC service
[1970/01/01 01:00:30.617541,  2] ../source3/lib/interface.c:345(add_interface)
  added interface eth0 ip=192.168.178.15 bcast=192.168.178.255 netmask=255.255.255.0
[1970/01/01 01:00:30.628822,  3] ../source3/smbd/server.c:1448(main)
  loaded services
[1970/01/01 01:00:30.645172,  1] ../source3/profile/profile_dummy.c:30(set_profile_level)
  INFO: Profiling support unavailable in this build.
[1970/01/01 01:00:30.647346,  3] ../source3/smbd/server.c:1467(main)
  Standard input is not a socket, assuming -D option
[1970/01/01 01:00:30.647824,  3] ../source3/smbd/server.c:1479(main)
  Becoming a daemon.
[1970/01/01 01:00:30.689683,  2] ../source3/passdb/pdb_interface.c:160(make_pdb_method_name)
  No builtin backend found, trying to load plugin
[1970/01/01 01:00:30.823143,  2] ../lib/util/modules.c:196(do_smb_load_module)
  Module 'tdbsam' loaded
[1970/01/01 01:00:31.010030,  1] ../source3/lib/messages_dgm.c:157(messaging_dgm_lockfile_create)
  messaging_dgm_lockfile_create: write failed: Invalid argument
[1970/01/01 01:00:31.015013,  1] ../source3/lib/messages_dgm.c:228(messaging_dgm_init)
  messaging_dgm_init: messaging_dgm_create_lockfile failed: Invalid argument
[1970/01/01 01:00:31.015589,  2] ../source3/lib/messages.c:409(messaging_reinit)
  messaging_dgm_ref failed: Invalid argument
[1970/01/01 01:00:31.020271,  0] ../source3/lib/util.c:478(reinit_after_fork)
  messaging_reinit() failed: NT_STATUS_INVALID_PARAMETER
[1970/01/01 01:00:31.047382,  1] ../source3/smbd/server.c:402(smbd_notifyd_init)
  smbd_notifyd_init: reinit_after_fork failed: NT_STATUS_INVALID_PARAMETER
[1970/01/01 01:00:31.432610,  3] ../source3/auth/token_util.c:547(finalize_local_nt_token)
  Failed to fetch domain sid for WORKGROUP
[1970/01/01 01:00:31.437112,  3] ../source3/auth/token_util.c:579(finalize_local_nt_token)
  Failed to fetch domain sid for WORKGROUP
[1970/01/01 01:00:31.617724,  3] ../source3/rpc_server/svcctl/srv_svcctl_reg.c:565(svcctl_init_winreg)
  Initialise the svcctl registry keys if needed.
[1970/01/01 01:00:31.923746,  3] ../source3/rpc_server/eventlog/srv_eventlog_reg.c:59(eventlog_init_winreg)
  Initialise the eventlog registry keys if needed.
[1970/01/01 01:00:31.952769,  0] ../lib/util/become_daemon.c:124(daemon_ready)
  STATUS=daemon 'smbd' finished starting up and ready to serve connections
[1970/01/01 01:00:32.119625,  2] ../source3/smbd/server.c:1125(smbd_parent_loop)
  waiting for connections
[2018/04/09 13:35:54.131575,  2] ../source3/smbd/server.c:576(remove_child_pid)
  Could not find child 477 -- ignoring
[2018/04/09 13:50:54.249604,  2] ../source3/smbd/server.c:576(remove_child_pid)
  Could not find child 512 -- ignoring

Dit zijn de logs van mijn Zgemma - OpenPLI 6.1

 

Willy

Edited by doglover, 9 April 2018 - 13:00.

[doglover]

Samba opnieuw gestart:

 

 

log.nmdb

[2018/04/09 13:57:54.777461,  3] ../source3/nmbd/nmbd_incomingrequests.c:459(process_name_query_request)
  process_name_query_request: Name query from 192.168.178.17 on subnet 192.168.178.15 for name BRW34238763B77E<00>
[2018/04/09 13:57:55.637107,  3] ../source3/nmbd/nmbd_incomingrequests.c:459(process_name_query_request)
  process_name_query_request: Name query from 192.168.178.17 on subnet 192.168.178.15 for name BRW34238763B77E<00>
[2018/04/09 13:57:56.386677,  3] ../source3/nmbd/nmbd_incomingrequests.c:459(process_name_query_request)
  process_name_query_request: Name query from 192.168.178.17 on subnet 192.168.178.15 for name BRW34238763B77E<00>
[2018/04/09 13:57:57.137032,  3] ../source3/nmbd/nmbd_incomingrequests.c:459(process_name_query_request)
  process_name_query_request: Name query from 192.168.178.17 on subnet 192.168.178.15 for name BRW34238763B77E<00>

log.smdb

smbd_dirptr_get_entry mask=[*] found var/cache fname=cache (cache)
[2018/04/09 13:58:51.904510,  3] ../source3/smbd/dir.c:1188(smbd_dirptr_get_entry)
  smbd_dirptr_get_entry mask=[*] found var/volatile fname=volatile (volatile)
[2018/04/09 13:58:51.908018,  3] ../source3/smbd/dir.c:1188(smbd_dirptr_get_entry)
  smbd_dirptr_get_entry mask=[*] found var/local fname=local (local)
[2018/04/09 13:58:51.912652,  3] ../source3/smbd/dir.c:1188(smbd_dirptr_get_entry)
  smbd_dirptr_get_entry mask=[*] found var/share fname=share (share)
[2018/04/09 13:58:51.915789,  3] ../source3/smbd/dir.c:1188(smbd_dirptr_get_entry)
  smbd_dirptr_get_entry mask=[*] found var/spool fname=spool (spool)
[2018/04/09 13:58:51.918638,  3] ../source3/smbd/dir.c:1188(smbd_dirptr_get_entry)
  smbd_dirptr_get_entry mask=[*] found var/openldap fname=openldap (openldap)
[2018/04/09 13:58:51.933107,  3] ../source3/smbd/dir.c:1188(smbd_dirptr_get_entry)
  smbd_dirptr_get_entry mask=[*] found var/backups fname=backups (backups)
[2018/04/09 13:58:51.944044,  3] ../source3/smbd/dir.c:1188(smbd_dirptr_get_entry)
  smbd_dirptr_get_entry mask=[*] found var/krb5kdc fname=krb5kdc (krb5kdc)
[2018/04/09 13:58:51.949679,  3] ../source3/smbd/smb2_server.c:3098(smbd_smb2_request_error_ex)
  smbd_smb2_request_error_ex: smbd_smb2_request_error_ex: idx[5] status[STATUS_NO_MORE_FILES] || at ../source3/smbd/smb2_query_directory.c:154
[2018/04/09 13:58:55.422587,  2] ../source3/smbd/open.c:1006(open_file)
  root opened file var/log/log.smbd read=No write=No (numopen=3)
[2018/04/09 13:58:55.434996,  3] ../source3/smbd/nttrans.c:2033(smbd_do_query_security_desc)
  smbd_do_query_security_desc: sd_size = 20.
[2018/04/09 13:58:55.439068,  3] ../source3/smbd/smb2_server.c:3098(smbd_smb2_request_error_ex)
  smbd_smb2_request_error_ex: smbd_smb2_request_error_ex: idx[1] status[NT_STATUS_BUFFER_TOO_SMALL] | +info| at ../source3/smbd/smb2_getinfo.c:171
[2018/04/09 13:58:55.445954,  3] ../source3/smbd/nttrans.c:2033(smbd_do_query_security_desc)
  smbd_do_query_security_desc: sd_size = 20.
[2018/04/09 13:58:55.451616,  2] ../source3/smbd/close.c:783(close_normal_file)
  root closed file var/log/log.smbd (numopen=2) NT_STATUS_OK
[2018/04/09 13:58:55.460388,  3] ../source3/smbd/smb2_server.c:3098(smbd_smb2_request_error_ex)
  smbd_smb2_request_error_ex: smbd_smb2_request_error_ex: idx[1] status[NT_STATUS_OBJECT_NAME_NOT_FOUND] || at ../source3/smbd/smb2_create.c:293
[2018/04/09 13:58:57.592687,  2] ../source3/smbd/open.c:1006(open_file)
  root opened file var/log/log.nmbd read=Yes write=No (numopen=3)
[2018/04/09 13:58:57.601175,  3] ../source3/smbd/smb2_read.c:413(smb2_read_complete)
  smbd_smb2_read: fnum 3594893296, file var/log/log.nmbd, length=880 offset=0 read=880

[WanWizard]

En hierna loopt hij wel?

 

Ik denk dat hier wel zaken in staan waar we wat mee kunnen. Ik zet het even op de todo list.

[doglover]

Na een herstart van samba loopt ie wel.

 

Willy

[WanWizard]

Ok. Ik ga tijd proberen te vinden...

 

Kun je mij je smb.conf even prive sturen (email of PM), dan heb ik een gelijke omgeving als ik wil testen.

[WanWizard]

Kun je ook de log posten na een reboot en een direct correct startende samba?