Samba 4.0.4 member server on FreeBSD 9.1 panics

Gémes Géza geza at kzsdabas.hu
Sun Jun 30 23:24:46 MDT 2013


Hi,

This morning I've been asked about a fault in samba 4.0.4 running as a 
member server when connected from Windows.
The only non default setting (besides idmap ranges and stuff) is the 
usage of system keytab, which got successfully populated at net ads join.

The error log is:

[2013/07/01 07:11:58.182797,  1] 
../source3/librpc/crypto/gse_krb5.c:416(fill_mem_keytab_from_system_keytab)
   ../source3/librpc/crypto/gse_krb5.c:416: krb5_kt_start_seq_get failed 
(No such file or directory)
[2013/07/01 07:11:58.182882,  0] ../lib/util/fault.c:72(fault_report)
   ===============================================================
[2013/07/01 07:11:58.183185,  0] ../lib/util/fault.c:73(fault_report)
   INTERNAL ERROR: Signal 11 in pid 14885 (4.0.4)
   Please read the Trouble-Shooting section of the Samba HOWTO
[2013/07/01 07:11:58.183227,  0] ../lib/util/fault.c:75(fault_report)
   ===============================================================
[2013/07/01 07:11:58.183269,  0] ../source3/lib/util.c:810(smb_panic_s3)
   PANIC (pid 14885): internal error
[2013/07/01 07:11:58.183491,  0] ../source3/lib/util.c:921(log_stack_trace)
   BACKTRACE: 4 stack frames:
    #0 0x801d1d18d <smb_panic_s3+45> at /usr/local/lib/libsmbconf.so.0
    #1 0x80083e47c <smb_panic+44> at /usr/local/lib/libsamba-util.so.0
    #2 0x80083e691 <smb_panic+577> at /usr/local/lib/libsamba-util.so.0
    #3 0x80335d516 <_pthread_sigmask+918> at /lib/libthr.so.3
[2013/07/01 07:11:58.183637,  0] ../source3/lib/dumpcore.c:312(dump_core)
   unable to change to %N.core
   refusing to dump core
[2013/07/01 07:11:58.188231,  3] 
../source3/smbd/server.c:446(remove_child_pid)
   ../source3/smbd/server.c:446 Unclean shutdown of pid 14885
[2013/07/01 07:11:58.192093,  3] ../source3/lib/access.c:338(allow_access)
   Allowed connection from 10.1.3.30 (10.1.3.30)
[2013/07/01 07:11:58.192239,  3] ../source3/smbd/oplock.c:985(init_oplocks)
   init_oplocks: initializing messages.
[2013/07/01 07:11:58.192493,  3] ../source3/smbd/process.c:1789(process_smb)
   Transaction 0 of length 137 (0 toread)
[2013/07/01 07:11:58.192534,  3] 
../source3/smbd/process.c:1392(switch_message)
   switch message SMBnegprot (pid 14886) conn 0x0
[2013/07/01 07:11:58.192658,  3] 
../source3/smbd/negprot.c:563(reply_negprot)
   Requested protocol [PC NETWORK PROGRAM 1.0]
[2013/07/01 07:11:58.192687,  3] 
../source3/smbd/negprot.c:563(reply_negprot)
   Requested protocol [LANMAN1.0]
[2013/07/01 07:11:58.192707,  3] 
../source3/smbd/negprot.c:563(reply_negprot)
   Requested protocol [Windows for Workgroups 3.1a]
[2013/07/01 07:11:58.192744,  3] 
../source3/smbd/negprot.c:563(reply_negprot)
   Requested protocol [LM1.2X002]
[2013/07/01 07:11:58.192763,  3] 
../source3/smbd/negprot.c:563(reply_negprot)
   Requested protocol [LANMAN2.1]
[2013/07/01 07:11:58.192783,  3] 
../source3/smbd/negprot.c:563(reply_negprot)
   Requested protocol [NT LM 0.12]
[2013/07/01 07:11:58.193541,  5, pid=14886, effective(0, 0), real(0, 0), 
class=auth] ../source3/auth/auth.c:450(make_auth_context_subsystem)
   Making default auth method list for server role = 'domain member'
[2013/07/01 07:11:58.193590,  5, pid=14886, effective(0, 0), real(0, 0), 
class=auth] ../source3/auth/auth.c:48(smb_register_auth)
   Attempting to register auth backend sam
[2013/07/01 07:11:58.193615,  5, pid=14886, effective(0, 0), real(0, 0), 
class=auth] ../source3/auth/auth.c:60(smb_register_auth)
   Successfully added auth method 'sam'
[2013/07/01 07:11:58.193632,  5, pid=14886, effective(0, 0), real(0, 0), 
class=auth] ../source3/auth/auth.c:48(smb_register_auth)
   Attempting to register auth backend sam_ignoredomain
[2013/07/01 07:11:58.193651,  5, pid=14886, effective(0, 0), real(0, 0), 
class=auth] ../source3/auth/auth.c:60(smb_register_auth)
   Successfully added auth method 'sam_ignoredomain'
[2013/07/01 07:11:58.193674,  5, pid=14886, effective(0, 0), real(0, 0), 
class=auth] ../source3/auth/auth.c:48(smb_register_auth)
   Attempting to register auth backend unix
[2013/07/01 07:11:58.193691,  5, pid=14886, effective(0, 0), real(0, 0), 
class=auth] ../source3/auth/auth.c:60(smb_register_auth)
   Successfully added auth method 'unix'
[2013/07/01 07:11:58.193711,  5, pid=14886, effective(0, 0), real(0, 0), 
class=auth] ../source3/auth/auth.c:48(smb_register_auth)
   Attempting to register auth backend winbind
[2013/07/01 07:11:58.193730,  5, pid=14886, effective(0, 0), real(0, 0), 
class=auth] ../source3/auth/auth.c:60(smb_register_auth)
   Successfully added auth method 'winbind'
[2013/07/01 07:11:58.193747,  5, pid=14886, effective(0, 0), real(0, 0), 
class=auth] ../source3/auth/auth.c:48(smb_register_auth)
   Attempting to register auth backend wbc
[2013/07/01 07:11:58.193763,  5, pid=14886, effective(0, 0), real(0, 0), 
class=auth] ../source3/auth/auth.c:60(smb_register_auth)
   Successfully added auth method 'wbc'
[2013/07/01 07:11:58.193781,  5, pid=14886, effective(0, 0), real(0, 0), 
class=auth] ../source3/auth/auth.c:48(smb_register_auth)
   Attempting to register auth backend trustdomain
[2013/07/01 07:11:58.193799,  5, pid=14886, effective(0, 0), real(0, 0), 
class=auth] ../source3/auth/auth.c:60(smb_register_auth)
   Successfully added auth method 'trustdomain'
[2013/07/01 07:11:58.193818,  5, pid=14886, effective(0, 0), real(0, 0), 
class=auth] ../source3/auth/auth.c:48(smb_register_auth)
   Attempting to register auth backend ntdomain
[2013/07/01 07:11:58.193835,  5, pid=14886, effective(0, 0), real(0, 0), 
class=auth] ../source3/auth/auth.c:60(smb_register_auth)
   Successfully added auth method 'ntdomain'
[2013/07/01 07:11:58.193862,  5, pid=14886, effective(0, 0), real(0, 0), 
class=auth] ../source3/auth/auth.c:48(smb_register_auth)
   Attempting to register auth backend guest
[2013/07/01 07:11:58.193883,  5, pid=14886, effective(0, 0), real(0, 0), 
class=auth] ../source3/auth/auth.c:60(smb_register_auth)
   Successfully added auth method 'guest'
[2013/07/01 07:11:58.193903,  5, pid=14886, effective(0, 0), real(0, 0), 
class=auth] ../source3/auth/auth.c:48(smb_register_auth)
   Attempting to register auth backend samba4
[2013/07/01 07:11:58.193919,  5, pid=14886, effective(0, 0), real(0, 0), 
class=auth] ../source3/auth/auth.c:60(smb_register_auth)
   Successfully added auth method 'samba4'
[2013/07/01 07:11:58.193934,  5, pid=14886, effective(0, 0), real(0, 0), 
class=auth] ../source3/auth/auth.c:351(load_auth_module)
   load_auth_module: Attempting to find an auth method to match guest
[2013/07/01 07:11:58.193956,  5, pid=14886, effective(0, 0), real(0, 0), 
class=auth] ../source3/auth/auth.c:376(load_auth_module)
   load_auth_module: auth method guest has a valid init
[2013/07/01 07:11:58.193989,  5, pid=14886, effective(0, 0), real(0, 0), 
class=auth] ../source3/auth/auth.c:351(load_auth_module)
   load_auth_module: Attempting to find an auth method to match sam
[2013/07/01 07:11:58.194007,  5, pid=14886, effective(0, 0), real(0, 0), 
class=auth] ../source3/auth/auth.c:376(load_auth_module)
   load_auth_module: auth method sam has a valid init
[2013/07/01 07:11:58.194023,  5, pid=14886, effective(0, 0), real(0, 0), 
class=auth] ../source3/auth/auth.c:351(load_auth_module)
   load_auth_module: Attempting to find an auth method to match 
winbind:ntdomain
[2013/07/01 07:11:58.194040,  5, pid=14886, effective(0, 0), real(0, 0), 
class=auth] ../source3/auth/auth.c:351(load_auth_module)
   load_auth_module: Attempting to find an auth method to match ntdomain
[2013/07/01 07:11:58.194056,  5, pid=14886, effective(0, 0), real(0, 0), 
class=auth] ../source3/auth/auth.c:376(load_auth_module)
   load_auth_module: auth method ntdomain has a valid init
[2013/07/01 07:11:58.194071,  5, pid=14886, effective(0, 0), real(0, 0), 
class=auth] ../source3/auth/auth.c:376(load_auth_module)
   load_auth_module: auth method winbind has a valid init
[2013/07/01 07:11:58.195742,  3] 
../auth/gensec/gensec_start.c:868(gensec_register)
   GENSEC backend 'gssapi_spnego' registered
[2013/07/01 07:11:58.195778,  3] 
../auth/gensec/gensec_start.c:868(gensec_register)
   GENSEC backend 'gssapi_krb5' registered
[2013/07/01 07:11:58.195804,  3] 
../auth/gensec/gensec_start.c:868(gensec_register)
   GENSEC backend 'gssapi_krb5_sasl' registered
[2013/07/01 07:11:58.245252,  3] 
../auth/gensec/gensec_start.c:868(gensec_register)
   GENSEC backend 'sasl-DIGEST-MD5' registered
[2013/07/01 07:11:58.245307,  3] 
../auth/gensec/gensec_start.c:868(gensec_register)
   GENSEC backend 'schannel' registered
[2013/07/01 07:11:58.245321,  3] 
../auth/gensec/gensec_start.c:868(gensec_register)
   GENSEC backend 'spnego' registered
[2013/07/01 07:11:58.245337,  3] 
../auth/gensec/gensec_start.c:868(gensec_register)
   GENSEC backend 'ntlmssp' registered
[2013/07/01 07:11:58.245357,  3] 
../auth/gensec/gensec_start.c:868(gensec_register)
   GENSEC backend 'krb5' registered
[2013/07/01 07:11:58.245376,  3] 
../auth/gensec/gensec_start.c:868(gensec_register)
   GENSEC backend 'fake_gssapi_krb5' registered
[2013/07/01 07:11:58.245990,  1] 
../source3/librpc/crypto/gse_krb5.c:416(fill_mem_keytab_from_system_keytab)
   ../source3/librpc/crypto/gse_krb5.c:416: krb5_kt_start_seq_get failed 
(No such file or directory)
[2013/07/01 07:11:58.246071,  0] ../lib/util/fault.c:72(fault_report)
   ===============================================================
[2013/07/01 07:11:58.246366,  0] ../lib/util/fault.c:73(fault_report)
   INTERNAL ERROR: Signal 11 in pid 14886 (4.0.4)
   Please read the Trouble-Shooting section of the Samba HOWTO
[2013/07/01 07:11:58.246408,  0] ../lib/util/fault.c:75(fault_report)
   ===============================================================
[2013/07/01 07:11:58.246441,  0] ../source3/lib/util.c:810(smb_panic_s3)
   PANIC (pid 14886): internal error
[2013/07/01 07:11:58.246662,  0] ../source3/lib/util.c:921(log_stack_trace)
   BACKTRACE: 4 stack frames:
    #0 0x801d1d18d <smb_panic_s3+45> at /usr/local/lib/libsmbconf.so.0
    #1 0x80083e47c <smb_panic+44> at /usr/local/lib/libsamba-util.so.0
    #2 0x80083e691 <smb_panic+577> at /usr/local/lib/libsamba-util.so.0
    #3 0x80335d516 <_pthread_sigmask+918> at /lib/libthr.so.3
[2013/07/01 07:11:58.246818,  0] ../source3/lib/dumpcore.c:312(dump_core)
   unable to change to %N.core
   refusing to dump core
[2013/07/01 07:11:58.251427,  3] 
../source3/smbd/server.c:446(remove_child_pid)
   ../source3/smbd/server.c:446 Unclean shutdown of pid 14886
[2013/07/01 07:12:11.740788,  1] 
../source3/smbd/server.c:408(cleanup_timeout_fn)
   Cleaning up brl and lock database after unclean shutdown

Cheers

Geza Gemes


More information about the samba-technical mailing list