Attachment 12190 Details for Bug 11980 – smbd log

smbd log

touch-zupa.txt (text/plain), 60.99 KB, created by Arkadiusz Miskiewicz on 2016-06-20 19:36:41 UTC

(hide)

Description:

Filename:

MIME Type:

Creator: Arkadiusz Miskiewicz

Created: 2016-06-20 19:36:41 UTC

Size: 60.99 KB

patch

obsolete

>[2016/06/20 21:28:43.862420, 10, pid=23196, effective(0, 0), real(0, 0)] ../source3/lib/util_sock.c:369(read_smb_length_return_keepalive)                                   
>  got smb length of 104                                                                                                                                                     
>[2016/06/20 21:28:43.862655,  6, pid=23196, effective(0, 0), real(0, 0)] ../source3/smbd/process.c:1877(process_smb)                                                        
>  got message type 0x0 of len 0x68                                                                                                                                          
>[2016/06/20 21:28:43.862720,  3, pid=23196, effective(0, 0), real(0, 0)] ../source3/smbd/process.c:1879(process_smb)                                                        
>  Transaction 32 of length 108 (0 toread)                                                                                                                                   
>[2016/06/20 21:28:43.862965,  5, pid=23196, effective(0, 0), real(0, 0)] ../source3/lib/util.c:168(show_msg)                                                                
>[2016/06/20 21:28:43.863080,  5, pid=23196, effective(0, 0), real(0, 0)] ../source3/lib/util.c:178(show_msg)                                                                
>  size=104                                                                                                                                                                  
>  smb_com=0x32                                                                                                                                                              
>  smb_rcls=0                                                                                                                                                                
>  smb_reh=0                                                                                                                                                                 
>  smb_err=0                                                                                                                                                                 
>  smb_flg=0                                                                                                                                                                 
>  smb_flg2=49153                                                                                                                                                            
>  smb_tid=15566                                                                                                                                                             
>  smb_pid=12667                                                                                                                                                             
>  smb_uid=59966                                                                                                                                                             
>  smb_mid=147                                                                                                                                                               
>  smt_wct=15                                                                                                                                                                
>  smb_vwv[ 0]=   18 (0x12)                                                                                                                                                  
>  smb_vwv[ 1]=   18 (0x12)                                                                                                                                                  
>  smb_vwv[ 2]=    2 (0x2)                                                                                                                                                   
>  smb_vwv[ 3]= 1000 (0x3E8)                                                                                                                                                 
>  smb_vwv[ 4]=    0 (0x0)                                                                                                                                                   
>  smb_vwv[ 5]=    0 (0x0)                                                                                                                                                   
>  smb_vwv[ 6]=    0 (0x0)                                                                                                                                                   
>  smb_vwv[ 7]=    0 (0x0)                                                                                                                                                   
>  smb_vwv[ 8]=    0 (0x0)                                                                                                                                                   
>  smb_vwv[ 9]=   18 (0x12)                                                                                                                                                  
>  smb_vwv[10]=   68 (0x44)                                                                                                                                                  
>  smb_vwv[11]=   18 (0x12)                                                                                                                                                  
>  smb_vwv[12]=   86 (0x56)                                                                                                                                                  
>  smb_vwv[13]=    1 (0x1)                                                                                                                                                   
>  smb_vwv[14]=    6 (0x6)                                                                                                                                                   
>  smb_bcc=39                                                                                                                                                                
>[2016/06/20 21:28:43.866204, 10, pid=23196, effective(0, 0), real(0, 0)] ../lib/util/util.c:559(dump_data)                                                                  
>  [0000] 00 00 00 09 02 00 00 00   00 2F 00 7A 00 75 00 70   ........ ./.z.u.p                                                                                              
>  [0010] 00 61 00 00 00 02 00 00   00 12 00 00 00 A4 81 00   .a...... ........                                                                                              
>  [0020] 00 00 00 00 00 00 02                               .......                                                                                                         
>[2016/06/20 21:28:43.867014,  3, pid=23196, effective(0, 0), real(0, 0)] ../source3/smbd/process.c:1489(switch_message)                                                     
>  switch message SMBtrans2 (pid 23196) conn 0x559ceeae5d90                                                                                                                  
>[2016/06/20 21:28:43.867182,  4, pid=23196, effective(0, 0), real(0, 0)] ../source3/smbd/sec_ctx.c:316(set_sec_ctx)                                                         
>  setting sec ctx (1000, 1000) - sec_ctx_stack_ndx = 0                                                                                                                      
>[2016/06/20 21:28:43.867267,  5, pid=23196, effective(0, 0), real(0, 0)] ../libcli/security/security_token.c:63(security_token_debug)                                       
>  Security token SIDs (18):                                                                                                                                                 
>    SID[  0]: S-1-22-1-1000                                                                                                                                                 
>    SID[  1]: S-1-22-2-1000                                                                                                                                                 
>    SID[  2]: S-1-22-2-3                                                                                                                                                    
>    SID[  3]: S-1-22-2-4                                                                                                                                                    
>    SID[  4]: S-1-22-2-7                                                                                                                                                    
>    SID[  5]: S-1-22-2-10                                                                                                                                                   
>    SID[  6]: S-1-22-2-11                                                                                                                                                   
>    SID[  7]: S-1-22-2-17                                                                                                                                                   
>    SID[  8]: S-1-22-2-23                                                                                                                                                   
>    SID[  9]: S-1-22-2-24                                                                                                                                                   
>    SID[ 10]: S-1-22-2-27                                                                                                                                                   
>    SID[ 11]: S-1-22-2-28                                                                                                                                                   
>    SID[ 12]: S-1-22-2-78                                                                                                                                                   
>    SID[ 13]: S-1-22-2-84                                                                                                                                                   
>    SID[ 14]: S-1-22-2-99                                                                                                                                                   
>    SID[ 15]: S-1-1-0                                                                                                                                                       
>    SID[ 16]: S-1-5-2                                                                                                                                                       
>    SID[ 17]: S-1-5-32-546                                                                                                                                                  
>   Privileges (0x               0):                                                                                                                                         
>   Rights (0x               0):                                                                                                                                             
>[2016/06/20 21:28:43.868710,  5, pid=23196, effective(0, 0), real(0, 0)] ../source3/auth/token_util.c:639(debug_unix_user_token)                                            
>  UNIX token of user 1000                                                                                                                                                   
>  Primary group is 1000 and contains 14 supplementary groups                                                                                                                
>  Group[  0]: 1000                                                                                                                                                          
>  Group[  1]: 3                                                                                                                                                             
>  Group[  2]: 4                                                                                                                                                             
>  Group[  3]: 7                                                                                                                                                             
>  Group[  4]: 10                                                                                                                                                            
>  Group[  5]: 11                                                                                                                                                            
>  Group[  6]: 17                                                                                                                                                            
>  Group[  7]: 23                                                                                                                                                            
>  Group[  8]: 24                                                                                                                                                            
>  Group[  9]: 27                                                                                                                                                            
>  Group[ 10]: 28                                                                                                                                                            
>  Group[ 11]: 78                                                                                                                                                            
>  Group[ 12]: 84                                                                                                                                                            
>  Group[ 13]: 99                                                                                                                                                            
>[2016/06/20 21:28:43.870120,  5, pid=23196, effective(1000, 1000), real(1000, 0)] ../source3/smbd/uid.c:363(change_to_user_internal)                                        
>  Impersonated user: uid=(1000,1000), gid=(0,1000)                                                                                                                          
>[2016/06/20 21:28:43.870282,  5, pid=23196, effective(1000, 1000), real(1000, 0)] ../source3/smbd/filename.c:257(unix_convert)                                              
>  unix_convert called on file "zupa"                                                                                                                                        
>[2016/06/20 21:28:43.870350,  5, pid=23196, effective(1000, 1000), real(1000, 0)] ../source3/smbd/filename.c:449(unix_convert)                                              
>  unix_convert begin: name = zupa, dirpath = , start = zupa                                                                                                                 
>[2016/06/20 21:28:43.870445,  3, pid=23196, effective(1000, 1000), real(1000, 0), class=vfs] ../source3/smbd/vfs.c:1174(check_reduced_name)                                 
>  check_reduced_name [zupa] [/mnt/storage-sdd-noraid/public]                                                                                                                
>[2016/06/20 21:28:43.870535, 10, pid=23196, effective(1000, 1000), real(1000, 0), class=vfs] ../source3/smbd/vfs.c:1234(check_reduced_name)                                 
>  check_reduced_name realpath [zupa] -> [/mnt/storage-sdd-noraid/public/zupa]                                                                                               
>[2016/06/20 21:28:43.870597,  3, pid=23196, effective(1000, 1000), real(1000, 0), class=vfs] ../source3/smbd/vfs.c:1322(check_reduced_name)                                 
>  check_reduced_name: zupa reduced to /mnt/storage-sdd-noraid/public/zupa                                                                                                   
>[2016/06/20 21:28:43.870658,  3, pid=23196, effective(1000, 1000), real(1000, 0)] ../source3/smbd/trans2.c:8503(call_trans2setfilepathinfo)                                 
>  call_trans2setfilepathinfo(6) zupa (fnum [fsp is NULL]) info_level=521 totdata=18                                                                                         
>[2016/06/20 21:28:43.870720,  3, pid=23196, effective(1000, 1000), real(1000, 0)] ../source3/smbd/trans2.c:8080(smbd_do_setfilepathinfo)                                    
>  smbd_do_setfilepathinfo: zupa (fnum [fsp is NULL]) info_level=521 totdata=18                                                                                              
>[2016/06/20 21:28:43.870783, 10, pid=23196, effective(1000, 1000), real(1000, 0)] ../source3/smbd/trans2.c:7839(smb_posix_open)                                             
>  smb_posix_open: file zupa, smb_posix_flags = 0, mode 0644                                                                                                                 
>[2016/06/20 21:28:43.870842, 10, pid=23196, effective(1000, 1000), real(1000, 0)] ../source3/smbd/open.c:4982(create_file_default)                                          
>  create_file: access_mask = 0x112 file_attributes = 0x10001a4, share_access = 0x7, create_disposition = 0x3 create_options = 0x40 oplock_request = 0x1 private_flags = 0x0 root_dir_fid = 0x0, ea_list = 0x(nil), sd = 0x(nil), fname = zupa                                                                                                           
>[2016/06/20 21:28:43.870912, 10, pid=23196, effective(1000, 1000), real(1000, 0)] ../source3/smbd/open.c:4459(create_file_unixpath)                                         
>  create_file_unixpath: access_mask = 0x112 file_attributes = 0x10001a4, share_access = 0x7, create_disposition = 0x3 create_options = 0x40 oplock_request = 0x1 private_flags = 0x0 ea_list = 0x(nil), sd = 0x(nil), fname = zupa                                                                                                                      
>[2016/06/20 21:28:43.871016,  5, pid=23196, effective(1000, 1000), real(1000, 0)] ../lib/dbwrap/dbwrap.c:178(dbwrap_check_lock_order)                                       
>  check lock order 1 for /var/lib/samba/smbXsrv_open_global.tdb                                                                                                             
>[2016/06/20 21:28:43.871079, 10, pid=23196, effective(1000, 1000), real(1000, 0)] ../lib/dbwrap/dbwrap.c:133(debug_lock_order)                                              
>  lock order:  1:/var/lib/samba/smbXsrv_open_global.tdb 2:<none> 3:<none>                                                                                                   
>[2016/06/20 21:28:43.871151, 10, pid=23196, effective(1000, 1000), real(1000, 0)] ../lib/dbwrap/dbwrap_tdb.c:60(db_tdb_log_key)                                             
>  Locking key 83FF04D5                                                                                                                                                      
>[2016/06/20 21:28:43.871241, 10, pid=23196, effective(1000, 1000), real(1000, 0)] ../lib/dbwrap/dbwrap_tdb.c:144(db_tdb_fetch_locked_internal)                              
>  Allocated locked data 0x0x559ceeaeadf0                                                                                                                                    
>[2016/06/20 21:28:43.871409, 10, pid=23196, effective(1000, 1000), real(1000, 0)] ../source3/smbd/smbXsrv_open.c:584(smbXsrv_open_global_verify_record)                     
>  smbXsrv_open_global_verify_record: empty value                                                                                                                            
>[2016/06/20 21:28:43.871635, 10, pid=23196, effective(1000, 1000), real(1000, 0)] ../source3/smbd/smbXsrv_open.c:702(smbXsrv_open_global_store)                             
>  smbXsrv_open_global_store: key '83FF04D5' stored                                                                                                                          
>[2016/06/20 21:28:43.871718,  1, pid=23196, effective(1000, 1000), real(1000, 0)] ../librpc/ndr/ndr.c:402(ndr_print_debug)                                                  
>       &global_blob: struct smbXsrv_open_globalB                                                                                                                            
>          version                  : SMBXSRV_VERSION_0 (0)                                                                                                                  
>          seqnum                   : 0x00000001 (1)                                                                                                                         
>          info                     : union smbXsrv_open_globalU(case 0)                                                                                                     
>          info0                    : *                                                                                                                                      
>              info0: struct smbXsrv_open_global0                                                                                                                            
>                  db_rec                   : *                                                                                                                              
>                  server_id: struct server_id                                                                                                                               
>                      pid                      : 0x0000000000005a9c (23196)                                                                                                 
>                      task_id                  : 0x00000000 (0)                                                                                                             
>                      vnn                      : 0xffffffff (4294967295)                                                                                                    
>                      unique_id                : 0x9628c959b8733413 (-7626624581768104941)                                                                                  
>                  open_global_id           : 0x83ff04d5 (2214528213)                                                                                                        
>                  open_persistent_id       : 0x0000000083ff04d5 (2214528213)                                                                                                
>                  open_volatile_id         : 0x00000000000070ff (28927)                                                                                                     
>                  open_owner               : S-1-22-1-1000                                                                                                                  
>                  open_time                : pon cze 20 21:28:44 2016 CEST                                                                                                  
>                  create_guid              : 00000000-0000-0000-0000-000000000000                                                                                           
>                  client_guid              : 00000000-0000-0000-0000-000000000000                                                                                           
>                  app_instance_id          : 00000000-0000-0000-0000-000000000000                                                                                           
>                  disconnect_time          : NTTIME(0)                                                                                                                      
>                  durable_timeout_msec     : 0x00000000 (0)                                                                                                                 
>                  durable                  : 0x00 (0)                                                                                                                       
>                  backend_cookie           : DATA_BLOB length=0                                                                                                             
>[2016/06/20 21:28:43.872860, 10, pid=23196, effective(1000, 1000), real(1000, 0)] ../lib/dbwrap/dbwrap_tdb.c:60(db_tdb_log_key)                                             
>  Unlocking key 83FF04D5                                                                                                                                                    
>[2016/06/20 21:28:43.872943,  5, pid=23196, effective(1000, 1000), real(1000, 0)] ../lib/dbwrap/dbwrap.c:146(dbwrap_lock_order_state_destructor)                            
>  release lock order 1 for /var/lib/samba/smbXsrv_open_global.tdb                                                                                                           
>[2016/06/20 21:28:43.873012, 10, pid=23196, effective(1000, 1000), real(1000, 0)] ../lib/dbwrap/dbwrap.c:133(debug_lock_order)                                              
>  lock order:  1:<none> 2:<none> 3:<none>                                                                                                                                   
>[2016/06/20 21:28:43.873089, 10, pid=23196, effective(1000, 1000), real(1000, 0)] ../source3/smbd/smbXsrv_open.c:876(smbXsrv_open_create)                                   
>  smbXsrv_open_create: global_id (0x83ff04d5) stored                                                                                                                        
>[2016/06/20 21:28:43.873293,  1, pid=23196, effective(1000, 1000), real(1000, 0)] ../librpc/ndr/ndr.c:402(ndr_print_debug)                                                  
>       &open_blob: struct smbXsrv_openB                                                                                                                                     
>          version                  : SMBXSRV_VERSION_0 (0)                                                                                                                  
>          reserved                 : 0x00000000 (0)                                                                                                                         
>          info                     : union smbXsrv_openU(case 0)                                                                                                            
>          info0                    : *                                                                                                                                      
>              info0: struct smbXsrv_open                                                                                                                                    
>                  table                    : *                                                                                                                              
>                  db_rec                   : NULL                                                                                                                           
>                  local_id                 : 0x000070ff (28927)                                                                                                             
>                  global                   : *                                                                                                                              
>                      global: struct smbXsrv_open_global0                                                                                                                   
>                          db_rec                   : NULL                                                                                                                   
>                          server_id: struct server_id                                                                                                                       
>                              pid                      : 0x0000000000005a9c (23196)                                                                                         
>                              task_id                  : 0x00000000 (0)                                                                                                     
>                              vnn                      : 0xffffffff (4294967295)                                                                                            
>                              unique_id                : 0x9628c959b8733413 (-7626624581768104941)                                                                          
>                          open_global_id           : 0x83ff04d5 (2214528213)                                                                                                
>                          open_persistent_id       : 0x0000000083ff04d5 (2214528213)                                                                                        
>                          open_volatile_id         : 0x00000000000070ff (28927)                                                                                             
>                          open_owner               : S-1-22-1-1000                                                                                                          
>                          open_time                : pon cze 20 21:28:44 2016 CEST                                                                                          
>                          create_guid              : 00000000-0000-0000-0000-000000000000                                                                                   
>                          client_guid              : 00000000-0000-0000-0000-000000000000                                                                                   
>                          app_instance_id          : 00000000-0000-0000-0000-000000000000                                                                                   
>                          disconnect_time          : NTTIME(0)                                                                                                              
>                          durable_timeout_msec     : 0x00000000 (0)                                                                                                         
>                          durable                  : 0x00 (0)                                                                                                               
>                          backend_cookie           : DATA_BLOB length=0                                                                                                     
>                  status                   : NT_STATUS_OK                                                                                                                   
>                  idle_time                : pon cze 20 21:28:44 2016 CEST                                                                                                  
>                  compat                   : NULL                                                                                                                           
>[2016/06/20 21:28:43.874939,  5, pid=23196, effective(1000, 1000), real(1000, 0)] ../source3/smbd/files.c:129(file_new)                                                     
>  allocated file structure fnum 28927 (1 used)                                                                                                                              
>[2016/06/20 21:28:43.874998, 10, pid=23196, effective(1000, 1000), real(1000, 0)] ../source3/smbd/files.c:744(file_name_hash)                                               
>  file_name_hash: /mnt/storage-sdd-noraid/public/zupa hash 0xb107e9ed                                                                                                       
>[2016/06/20 21:28:43.875039, 10, pid=23196, effective(1000, 1000), real(1000, 0)] ../source3/smbd/open.c:2478(open_file_ntcreate)                                           
>  open_file_ntcreate: fname=zupa, dos_attrs=0x0 access_mask=0x112 share_access=0x7 create_disposition = 0x3 create_options=0x40 unix mode=0644 oplock_request=1 private_flags = 0x0                                                                                                                                                                     
>[2016/06/20 21:28:43.875085, 10, pid=23196, effective(1000, 1000), real(1000, 0)] ../source3/smbd/open.c:2636(open_file_ntcreate)                                           
>  open_file_ntcreate: fname=zupa, after mapping access_mask=0x112                                                                                                           
>[2016/06/20 21:28:43.875127,  4, pid=23196, effective(1000, 1000), real(1000, 0)] ../source3/smbd/open.c:2726(open_file_ntcreate)                                           
>  calling open_file with flags=0x1 flags2=0x40 mode=0644, access_mask = 0x112, open_access_mask = 0x112                                                                     
>[2016/06/20 21:28:43.875180, 10, pid=23196, effective(1000, 1000), real(1000, 0), class=acls] ../source3/smbd/posix_acls.c:3558(posix_get_nt_acl)                           
>  posix_get_nt_acl: called for file .                                                                                                                                       
>[2016/06/20 21:28:43.875287, 10, pid=23196, effective(1000, 1000), real(1000, 0)] ../source3/passdb/lookup_sid.c:1237(uid_to_sid)                                           
>  uid 1000 -> sid S-1-5-21-4285455791-229362118-3877793692-1000                                                                                                             
>[2016/06/20 21:28:43.875398,  5, pid=23196, effective(1000, 1000), real(1000, 0)] ../source3/passdb/lookup_sid.c:1278(gid_to_sid)                                           
>  gid_to_sid: winbind failed to find a sid for gid 1000                                                                                                                     
>[2016/06/20 21:28:43.875439,  4, pid=23196, effective(1000, 1000), real(1000, 0)] ../source3/smbd/sec_ctx.c:216(push_sec_ctx)                                               
>  push_sec_ctx(1000, 1000) : sec_ctx_stack_ndx = 1                                                                                                                          
>[2016/06/20 21:28:43.875479,  4, pid=23196, effective(1000, 1000), real(1000, 0)] ../source3/smbd/uid.c:491(push_conn_ctx)                                                  
>  push_conn_ctx(59966) : conn_ctx_stack_ndx = 0                                                                                                                             
>[2016/06/20 21:28:43.875517,  4, pid=23196, effective(1000, 1000), real(1000, 0)] ../source3/smbd/sec_ctx.c:316(set_sec_ctx)                                                
>  setting sec ctx (0, 0) - sec_ctx_stack_ndx = 1                                                                                                                            
>[2016/06/20 21:28:43.875546,  5, pid=23196, effective(1000, 1000), real(1000, 0)] ../libcli/security/security_token.c:53(security_token_debug)                              
>  Security token: (NULL)                                                                                                                                                    
>[2016/06/20 21:28:43.875573,  5, pid=23196, effective(1000, 1000), real(1000, 0)] ../source3/auth/token_util.c:639(debug_unix_user_token)                                   
>  UNIX token of user 0                                                                                                                                                      
>  Primary group is 0 and contains 0 supplementary groups                                                                                                                    
>[2016/06/20 21:28:43.875700,  4, pid=23196, effective(1000, 1000), real(1000, 0)] ../source3/smbd/sec_ctx.c:421(pop_sec_ctx)                                                
>  pop_sec_ctx (1000, 1000) - sec_ctx_stack_ndx = 0                                                                                                                          
>[2016/06/20 21:28:43.875735, 10, pid=23196, effective(1000, 1000), real(1000, 0)] ../source3/passdb/lookup_sid.c:1141(legacy_gid_to_sid)                                    
>  LEGACY: gid 1000 -> sid S-1-22-2-1000                                                                                                                                     
>[2016/06/20 21:28:43.875773, 10, pid=23196, effective(1000, 1000), real(1000, 0), class=acls] ../source3/smbd/posix_acls.c:2724(canonicalise_acl)                           
>  canonicalise_acl: Access ace entries before arrange :                                                                                                                     
>[2016/06/20 21:28:43.875802, 10, pid=23196, effective(1000, 1000), real(1000, 0), class=acls] ../source3/smbd/posix_acls.c:2737(canonicalise_acl)                           
>  canon_ace index 0. Type = allow SID = S-1-1-0 other SMB_ACL_OTHER ace_flags = 0x0 perms r-x                                                                               
>[2016/06/20 21:28:43.875839, 10, pid=23196, effective(1000, 1000), real(1000, 0), class=acls] ../source3/smbd/posix_acls.c:2737(canonicalise_acl)                           
>  canon_ace index 1. Type = allow SID = S-1-22-2-1000 gid 1000 (users) SMB_ACL_GROUP_OBJ ace_flags = 0x0 perms r-x                                                          
>[2016/06/20 21:28:43.875954, 10, pid=23196, effective(1000, 1000), real(1000, 0), class=acls] ../source3/smbd/posix_acls.c:2737(canonicalise_acl)                           
>  canon_ace index 2. Type = allow SID = S-1-5-21-4285455791-229362118-3877793692-1000 uid 1000 (arekm) SMB_ACL_USER_OBJ ace_flags = 0x0 perms rwx                           
>[2016/06/20 21:28:43.876066, 10, pid=23196, effective(1000, 1000), real(1000, 0), class=acls] ../source3/smbd/posix_acls.c:848(print_canon_ace_list)                        
>  print_canon_ace_list: canonicalise_acl: ace entries after arrange                                                                                                         
>  canon_ace index 0. Type = allow SID = S-1-5-21-4285455791-229362118-3877793692-1000 uid 1000 (arekm) SMB_ACL_USER_OBJ ace_flags = 0x0 perms rwx                           
>  canon_ace index 1. Type = allow SID = S-1-22-2-1000 gid 1000 (users) SMB_ACL_GROUP_OBJ ace_flags = 0x0 perms r-x                                                          
>  canon_ace index 2. Type = allow SID = S-1-1-0 other SMB_ACL_OTHER ace_flags = 0x0 perms r-x                                                                               
>[2016/06/20 21:28:43.876212, 10, pid=23196, effective(1000, 1000), real(1000, 0), class=acls] ../source3/smbd/posix_acls.c:1110(map_canon_ace_perms)                        
>  map_canon_ace_perms: Mapped (UNIX) 1c0 to (NT) 1f01ff                                                                                                                     
>[2016/06/20 21:28:43.876244, 10, pid=23196, effective(1000, 1000), real(1000, 0), class=acls] ../source3/smbd/posix_acls.c:1110(map_canon_ace_perms)                        
>  map_canon_ace_perms: Mapped (UNIX) 140 to (NT) 1200a9                                                                                                                     
>[2016/06/20 21:28:43.876272, 10, pid=23196, effective(1000, 1000), real(1000, 0), class=acls] ../source3/smbd/posix_acls.c:1110(map_canon_ace_perms)                        
>  map_canon_ace_perms: Mapped (UNIX) 140 to (NT) 1200a9                                                                                                                     
>[2016/06/20 21:28:43.876319,  5, pid=23196, effective(1000, 1000), real(1000, 0)] ../source3/smbd/open.c:300(check_parent_access)                                           
>  check_parent_access: access check on directory . for path zupa for mask 0x2 returned (0x2) NT_STATUS_ACCESS_DENIED                                                        
>[2016/06/20 21:28:43.876353, 10, pid=23196, effective(1000, 1000), real(1000, 0)] ../source3/smbd/open.c:866(open_file)                                                     
>  open_file: check_parent_access on file zupa returned NT_STATUS_ACCESS_DENIED                                                                                              
>[2016/06/20 21:28:43.876386,  5, pid=23196, effective(1000, 1000), real(1000, 0)] ../lib/dbwrap/dbwrap.c:178(dbwrap_check_lock_order)                                       
>  check lock order 1 for /var/lib/samba/smbXsrv_open_global.tdb                                                                                                             
>[2016/06/20 21:28:43.876426, 10, pid=23196, effective(1000, 1000), real(1000, 0)] ../lib/dbwrap/dbwrap.c:133(debug_lock_order)                                              
>  lock order:  1:/var/lib/samba/smbXsrv_open_global.tdb 2:<none> 3:<none>                                                                                                   
>[2016/06/20 21:28:43.876462, 10, pid=23196, effective(1000, 1000), real(1000, 0)] ../lib/dbwrap/dbwrap_tdb.c:60(db_tdb_log_key)                                             
>  Locking key 83FF04D5                                                                                                                                                      
>[2016/06/20 21:28:43.876502, 10, pid=23196, effective(1000, 1000), real(1000, 0)] ../lib/dbwrap/dbwrap_tdb.c:144(db_tdb_fetch_locked_internal)                              
>  Allocated locked data 0x0x559ceeaea140                                                                                                                                    
>[2016/06/20 21:28:43.876550, 10, pid=23196, effective(1000, 1000), real(1000, 0)] ../lib/dbwrap/dbwrap_tdb.c:60(db_tdb_log_key)                                             
>  Unlocking key 83FF04D5                                                                                                                                                    
>[2016/06/20 21:28:43.876583,  5, pid=23196, effective(1000, 1000), real(1000, 0)] ../lib/dbwrap/dbwrap.c:146(dbwrap_lock_order_state_destructor)                            
>  release lock order 1 for /var/lib/samba/smbXsrv_open_global.tdb                                                                                                           
>[2016/06/20 21:28:43.876611, 10, pid=23196, effective(1000, 1000), real(1000, 0)] ../lib/dbwrap/dbwrap.c:133(debug_lock_order)                                              
>  lock order:  1:<none> 2:<none> 3:<none>                                                                                                                                   
>[2016/06/20 21:28:43.876651,  5, pid=23196, effective(1000, 1000), real(1000, 0)] ../source3/smbd/files.c:555(file_free)                                                    
>  freed files structure 28927 (0 used)                                                                                                                                      
>[2016/06/20 21:28:43.876679, 10, pid=23196, effective(1000, 1000), real(1000, 0)] ../source3/smbd/open.c:4803(create_file_unixpath)                                         
>  create_file_unixpath: NT_STATUS_ACCESS_DENIED                                                                                                                             
>[2016/06/20 21:28:43.876706, 10, pid=23196, effective(1000, 1000), real(1000, 0)] ../source3/smbd/open.c:5079(create_file_default)                                          
>  create_file: NT_STATUS_ACCESS_DENIED                                                                                                                                      
>[2016/06/20 21:28:43.876740,  3, pid=23196, effective(1000, 1000), real(1000, 0)] ../source3/smbd/error.c:82(error_packet_set)                                              
>  NT error packet at ../source3/smbd/error.c(165) cmd=50 (SMBtrans2) NT_STATUS_ACCESS_DENIED                                                                                
>[2016/06/20 21:28:43.876844,  5, pid=23196, effective(1000, 1000), real(1000, 0)] ../source3/lib/util.c:168(show_msg)                                                       
>[2016/06/20 21:28:43.876870,  5, pid=23196, effective(1000, 1000), real(1000, 0)] ../source3/lib/util.c:178(show_msg)                                                       
>  size=35                                                                                                                                                                   
>  smb_com=0x32                                                                                                                                                              
>  smb_rcls=34                                                                                                                                                               
>  smb_reh=0                                                                                                                                                                 
>  smb_err=49152                                                                                                                                                             
>  smb_flg=128                                                                                                                                                               
>  smb_flg2=51203                                                                                                                                                            
>  smb_tid=15566                                                                                                                                                             
>  smb_pid=12667                                                                                                                                                             
>  smb_uid=59966                                                                                                                                                             
>  smb_mid=147                                                                                                                                                               
>  smt_wct=0                                                                                                                                                                 
>  smb_bcc=0                                                                                                                                                                 
>[2016/06/20 21:28:43.876965, 10, pid=23196, effective(1000, 1000), real(1000, 0)] ../lib/util/util.c:559(dump_data)                                                         
>[2016/06/20 21:28:43.879142, 10, pid=23196, effective(1000, 1000), real(1000, 0)] ../source3/lib/util_sock.c:369(read_smb_length_return_keepalive)                          
>  got smb length of 84                                                                                                                                                      
>[2016/06/20 21:28:43.879309,  6, pid=23196, effective(1000, 1000), real(1000, 0)] ../source3/smbd/process.c:1877(process_smb)                                               
>  got message type 0x0 of len 0x54                                                                                                                                          
>[2016/06/20 21:28:43.879343,  3, pid=23196, effective(1000, 1000), real(1000, 0)] ../source3/smbd/process.c:1879(process_smb)                                               
>  Transaction 33 of length 88 (0 toread)                                                                                                                                    
>[2016/06/20 21:28:43.879373,  5, pid=23196, effective(1000, 1000), real(1000, 0)] ../source3/lib/util.c:168(show_msg)                                                       
>[2016/06/20 21:28:43.879396,  5, pid=23196, effective(1000, 1000), real(1000, 0)] ../source3/lib/util.c:178(show_msg)                                                       
>  size=84                                                                                                                                                                   
>  smb_com=0x32                                                                                                                                                              
>  smb_rcls=0                                                                                                                                                                
>  smb_reh=0                                                                                                                                                                 
>  smb_err=0                                                                                                                                                                 
>  smb_flg=0                                                                                                                                                                 
>  smb_flg2=49153                                                                                                                                                            
>  smb_tid=15566                                                                                                                                                             
>  smb_pid=12667                                                                                                                                                             
>  smb_uid=59966                                                                                                                                                             
>  smb_mid=148                                                                                                                                                               
>  smt_wct=15                                                                                                                                                                
>  smb_vwv[ 0]=   18 (0x12)                                                                                                                                                  
>  smb_vwv[ 1]=    0 (0x0)                                                                                                                                                   
>  smb_vwv[ 2]=    2 (0x2)                                                                                                                                                   
>  smb_vwv[ 3]= 4000 (0xFA0)                                                                                                                                                 
>  smb_vwv[ 4]=    0 (0x0)                                                                                                                                                   
>  smb_vwv[ 5]=    0 (0x0)                                                                                                                                                   
>  smb_vwv[ 6]=    0 (0x0)                                                                                                                                                   
>  smb_vwv[ 7]=    0 (0x0)                                                                                                                                                   
>  smb_vwv[ 8]=    0 (0x0)                                                                                                                                                   
>  smb_vwv[ 9]=   18 (0x12)                                                                                                                                                  
>  smb_vwv[10]=   66 (0x42)                                                                                                                                                  
>  smb_vwv[11]=    0 (0x0)                                                                                                                                                   
>  smb_vwv[12]=    0 (0x0)                                                                                                                                                   
>  smb_vwv[13]=    1 (0x1)                                                                                                                                                   
>  smb_vwv[14]=    5 (0x5)                                                                                                                                                   
>  smb_bcc=19                                                                                                                                                                
>[2016/06/20 21:28:43.880344, 10, pid=23196, effective(1000, 1000), real(1000, 0)] ../lib/util/util.c:559(dump_data)                                                         
>  [0000] 00 00 02 00 00 00 00 2F   00 7A 00 75 00 70 00 61   ......./ .z.u.p.a                                                                                              
>  [0010] 00 00 00                                           ...                                                                                                             
>[2016/06/20 21:28:43.880570,  3, pid=23196, effective(1000, 1000), real(1000, 0)] ../source3/smbd/process.c:1489(switch_message)                                            
>  switch message SMBtrans2 (pid 23196) conn 0x559ceeae5d90                                                                                                                  
>[2016/06/20 21:28:43.880693,  4, pid=23196, effective(1000, 1000), real(1000, 0)] ../source3/smbd/sec_ctx.c:316(set_sec_ctx)                                                
>  setting sec ctx (1000, 1000) - sec_ctx_stack_ndx = 0                                                                                                                      
>[2016/06/20 21:28:43.880741,  5, pid=23196, effective(1000, 1000), real(1000, 0)] ../libcli/security/security_token.c:63(security_token_debug)                              
>  Security token SIDs (18):                                                                                                                                                 
>    SID[  0]: S-1-22-1-1000                                                                                                                                                 
>    SID[  1]: S-1-22-2-1000                                                                                                                                                 
>    SID[  2]: S-1-22-2-3                                                                                                                                                    
>    SID[  3]: S-1-22-2-4                                                                                                                                                    
>    SID[  4]: S-1-22-2-7                                                                                                                                                    
>    SID[  5]: S-1-22-2-10                                                                                                                                                   
>    SID[  6]: S-1-22-2-11                                                                                                                                                   
>    SID[  7]: S-1-22-2-17                                                                                                                                                   
>    SID[  8]: S-1-22-2-23                                                                                                                                                   
>    SID[  9]: S-1-22-2-24                                                                                                                                                   
>    SID[ 10]: S-1-22-2-27                                                                                                                                                   
>    SID[ 11]: S-1-22-2-28                                                                                                                                                   
>    SID[ 12]: S-1-22-2-78                                                                                                                                                   
>    SID[ 13]: S-1-22-2-84                                                                                                                                                   
>    SID[ 14]: S-1-22-2-99                                                                                                                                                   
>    SID[ 15]: S-1-1-0                                                                                                                                                       
>    SID[ 16]: S-1-5-2                                                                                                                                                       
>    SID[ 17]: S-1-5-32-546                                                                                                                                                  
>   Privileges (0x               0):                                                                                                                                         
>   Rights (0x               0):                                                                                                                                             
>[2016/06/20 21:28:43.881512,  5, pid=23196, effective(1000, 1000), real(1000, 0)] ../source3/auth/token_util.c:639(debug_unix_user_token)                                   
>  UNIX token of user 1000                                                                                                                                                   
>  Primary group is 1000 and contains 14 supplementary groups                                                                                                                
>  Group[  0]: 1000
>  Group[  1]: 3
>  Group[  2]: 4
>  Group[  3]: 7
>  Group[  4]: 10
>  Group[  5]: 11
>  Group[  6]: 17
>  Group[  7]: 23
>  Group[  8]: 24
>  Group[  9]: 27
>  Group[ 10]: 28
>  Group[ 11]: 78
>  Group[ 12]: 84
>  Group[ 13]: 99
>[2016/06/20 21:28:43.882029,  5, pid=23196, effective(1000, 1000), real(1000, 0)] ../source3/smbd/uid.c:363(change_to_user_internal)
>  Impersonated user: uid=(1000,1000), gid=(0,1000)
>[2016/06/20 21:28:43.882108,  3, pid=23196, effective(1000, 1000), real(1000, 0)] ../source3/smbd/trans2.c:5564(call_trans2qfilepathinfo)
>  call_trans2qfilepathinfo: TRANSACT2_QPATHINFO: level = 512
>[2016/06/20 21:28:43.882154,  5, pid=23196, effective(1000, 1000), real(1000, 0)] ../source3/smbd/filename.c:257(unix_convert)
>  unix_convert called on file "zupa"
>[2016/06/20 21:28:43.882186,  5, pid=23196, effective(1000, 1000), real(1000, 0)] ../source3/smbd/filename.c:449(unix_convert)
>  unix_convert begin: name = zupa, dirpath = , start = zupa
>[2016/06/20 21:28:43.882269,  3, pid=23196, effective(1000, 1000), real(1000, 0), class=vfs] ../source3/smbd/vfs.c:1174(check_reduced_name)
>  check_reduced_name [zupa] [/mnt/storage-sdd-noraid/public]
>[2016/06/20 21:28:43.882321, 10, pid=23196, effective(1000, 1000), real(1000, 0), class=vfs] ../source3/smbd/vfs.c:1234(check_reduced_name)
>  check_reduced_name realpath [zupa] -> [/mnt/storage-sdd-noraid/public/zupa]
>[2016/06/20 21:28:43.882353,  3, pid=23196, effective(1000, 1000), real(1000, 0), class=vfs] ../source3/smbd/vfs.c:1322(check_reduced_name)
>  check_reduced_name: zupa reduced to /mnt/storage-sdd-noraid/public/zupa
>[2016/06/20 21:28:43.882384,  3, pid=23196, effective(1000, 1000), real(1000, 0)] ../source3/smbd/trans2.c:5670(call_trans2qfilepathinfo)
>  call_trans2qfilepathinfo: SMB_VFS_LSTAT of zupa failed (Nie ma takiego pliku ani katalogu)
>[2016/06/20 21:28:43.882428,  3, pid=23196, effective(1000, 1000), real(1000, 0)] ../source3/smbd/error.c:82(error_packet_set)
>  NT error packet at ../source3/smbd/trans2.c(5672) cmd=50 (SMBtrans2) NT_STATUS_OBJECT_NAME_NOT_FOUND
>[2016/06/20 21:28:43.882463,  5, pid=23196, effective(1000, 1000), real(1000, 0)] ../source3/lib/util.c:168(show_msg)
>[2016/06/20 21:28:43.882484,  5, pid=23196, effective(1000, 1000), real(1000, 0)] ../source3/lib/util.c:178(show_msg)
>  size=35
>  smb_com=0x32
>  smb_rcls=52
>  smb_reh=0
>  smb_err=49152
>  smb_flg=128
>  smb_flg2=51203
>  smb_tid=15566
>  smb_pid=12667
>  smb_uid=59966
>  smb_mid=148
>  smt_wct=0
>  smb_bcc=0
>[2016/06/20 21:28:43.882562, 10, pid=23196, effective(1000, 1000), real(1000, 0)] ../lib/util/util.c:559(dump_data)
>

Actions: View

Attachments on bug 11980: 12190