I have a physical FreeNAS 9.3 box with 24GB of ecc RAM, and dual L5630 CPU's that is having some weird issues joining a windows 2012 r2 level domain. When I first joined the domain, everything worked perfectly. I mapped some permissions out and was happy. I rebooted the server and now my issue is that I see no active directory users in the change permissions list. Domain Groups show up as normal. Browsing the SMB share doesn't work now due to the box being unable to resolve the users properly.
My box successfully joins the domain, "wbinfo -u" and "wbinfo -g" and "wbinfo -t" all return users, groups, and success respectfully. I went through the common troubleshooting tips listed in the manual
http://doc.freenas.org/9.3/freenas_directoryservice.html
with no fix including clearing the active directory cache and running the various commands. They all return an expected '0' code.
This is a nearly fresh reinstall of freenas where I basically configured networking on the box (dns, default gateway, etc) and then joined the domain. I can both forward and reverse lookup my domain controllers, and ping them fine. I went through and double checked that all relevant DNS SRV records were present on both my DNS servers.
Let me know which logs I should pull from and I will gladly upload them. Otherwise here is my console output:
My box successfully joins the domain, "wbinfo -u" and "wbinfo -g" and "wbinfo -t" all return users, groups, and success respectfully. I went through the common troubleshooting tips listed in the manual
http://doc.freenas.org/9.3/freenas_directoryservice.html
with no fix including clearing the active directory cache and running the various commands. They all return an expected '0' code.
This is a nearly fresh reinstall of freenas where I basically configured networking on the box (dns, default gateway, etc) and then joined the domain. I can both forward and reverse lookup my domain controllers, and ping them fine. I went through and double checked that all relevant DNS SRV records were present on both my DNS servers.
Let me know which logs I should pull from and I will gladly upload them. Otherwise here is my console output:
May 2 01:05:06 freenas GEOM_ELI: Device da2p1.eli created.
May 2 01:05:06 freenas GEOM_ELI: Encryption: AES-XTS 256
May 2 01:05:06 freenas GEOM_ELI: Crypto: hardware
May 2 01:05:06 freenas GEOM_ELI: Device da1p1.eli created.
May 2 01:05:06 freenas GEOM_ELI: Encryption: AES-XTS 256
May 2 01:05:06 freenas GEOM_ELI: Crypto: hardware
May 2 01:05:06 freenas GEOM_ELI: Device da0p1.eli created.
May 2 01:05:06 freenas GEOM_ELI: Encryption: AES-XTS 256
May 2 01:05:06 freenas GEOM_ELI: Crypto: hardware
May 2 01:05:06 freenas GEOM_ELI: Device da4p1.eli created.
May 2 01:05:06 freenas GEOM_ELI: Encryption: AES-XTS 256
May 2 01:05:06 freenas GEOM_ELI: Crypto: hardware
May 2 01:05:06 freenas GEOM_ELI: Device da9p1.eli created.
May 2 01:05:06 freenas GEOM_ELI: Encryption: AES-XTS 256
May 2 01:05:06 freenas GEOM_ELI: Crypto: hardware
May 2 01:05:06 freenas GEOM_ELI: Device da8p1.eli created.
May 2 01:05:06 freenas GEOM_ELI: Encryption: AES-XTS 256
May 2 01:05:06 freenas GEOM_ELI: Crypto: hardware
May 2 01:05:06 freenas GEOM_ELI: Device da7p1.eli created.
May 2 01:05:06 freenas GEOM_ELI: Encryption: AES-XTS 256
May 2 01:05:06 freenas GEOM_ELI: Crypto: hardware
May 2 01:05:06 freenas GEOM_ELI: Device da5p1.eli created.
May 2 01:05:06 freenas GEOM_ELI: Encryption: AES-XTS 256
May 2 01:05:06 freenas GEOM_ELI: Crypto: hardware
May 2 01:05:06 freenas GEOM_ELI: Device da6p1.eli created.
May 2 01:05:07 freenas GEOM_ELI: Encryption: AES-XTS 256
May 2 01:05:07 freenas GEOM_ELI: Crypto: hardware
May 2 01:05:07 freenas GEOM_ELI: Device da3p1.eli created.
May 2 01:05:07 freenas GEOM_ELI: Encryption: AES-XTS 256
May 2 01:05:07 freenas GEOM_ELI: Crypto: hardware
May 2 01:05:07 freenas notifier: geli: Cannot access da2p1 (error=1).
May 2 01:05:07 freenas notifier: Stopping collectd.
May 2 01:05:10 freenas notifier: Waiting for PIDS: 6310.
May 2 01:05:10 freenas notifier: Starting collectd.
May 2 01:06:12 freenas manage.py: [common.pipesubr:59] Popen()ing: klist
May 2 01:06:12 freenas manage.py: [common.pipesubr:59] Popen()ing: klist
May 2 01:06:13 freenas manage.py: [common.pipesubr:59] Popen()ing: klist
May 2 01:06:13 freenas manage.py: [common.pipesubr:59] Popen()ing: klist
May 2 01:06:28 freenas manage.py: [common.pipesubr:59] Popen()ing: klist
May 2 01:06:28 freenas manage.py: [common.pipesubr:59] Popen()ing: klist
May 2 01:06:28 freenas manage.py: [common.pipesubr:59] Popen()ing: klist
May 2 01:06:28 freenas manage.py: [common.pipesubr:59] Popen()ing: klist
May 2 01:06:39 freenas cachetool.py: [common.pipesubr:59] Popen()ing: klist
May 2 01:06:40 freenas cachetool.py: [common.pipesubr:59] Popen()ing: klist
May 2 01:13:12 freenas manage.py: [common.pipesubr:59] Popen()ing: klist
May 2 01:13:12 freenas manage.py: [common.pipesubr:59] Popen()ing: klist
May 2 01:13:12 freenas manage.py: [common.pipesubr:59] Popen()ing: klist
May 2 01:13:12 freenas manage.py: [common.pipesubr:59] Popen()ing: klist
May 2 01:13:38 freenas manage.py: [common.pipesubr:59] Popen()ing: klist
May 2 01:13:39 freenas ActiveDirectory: /usr/local/bin/python /usr/local/www/freenasUI/middleware/notifier.py stop cifs
May 2 01:13:41 freenas notifier: Stopping winbindd.
May 2 01:13:41 freenas winbindd[7722]: [2015/05/02 01:13:41.412498, 0] ../source3/winbindd/winbindd.c:234(winbindd_sig_term_handler)
May 2 01:13:41 freenas winbindd[7722]: Got sig[15] terminate (is_parent=1)
May 2 01:13:41 freenas notifier: Waiting for PIDS: 7722.
May 2 01:13:41 freenas notifier: Stopping smbd.
May 2 01:13:41 freenas notifier: Waiting for PIDS: 7718.
May 2 01:13:41 freenas notifier: Stopping nmbd.
May 2 01:13:41 freenas nmbd[7714]: [2015/05/02 01:13:41.425438, 0] ../source3/nmbd/nmbd.c:57(terminate)
May 2 01:13:41 freenas nmbd[7714]: Got SIGTERM: going down...
May 2 01:13:41 freenas notifier: Waiting for PIDS: 7714.
May 2 01:13:42 freenas ActiveDirectory: /usr/sbin/service ix-kerberos quietstop
May 2 01:13:42 freenas ActiveDirectory: /usr/sbin/service ix-nsswitch quietstop
May 2 01:13:44 freenas ActiveDirectory: /usr/sbin/service ix-pam quietstop
May 2 01:13:44 freenas ActiveDirectory: /usr/sbin/service ix-activedirectory forcestop
May 2 01:13:49 freenas ActiveDirectory: /usr/sbin/service ix-cache quietstop &
May 2 01:13:51 freenas ActiveDirectory: /usr/sbin/service samba_server forcestop
May 2 01:13:52 freenas ActiveDirectory: /usr/sbin/service ix-pre-samba start
May 2 01:13:54 freenas generate_smb4_conf.py: [common.pipesubr:59] Popen()ing: /sbin/sysctl -n 'kern.maxfilesperproc'
May 2 01:13:54 freenas generate_smb4_conf.py: [common.pipesubr:59] Popen()ing: zfs list -H -o mountpoint
May 2 01:13:55 freenas generate_smb4_conf.py: [common.pipesubr:59] Popen()ing: zfs list -H -o mountpoint
May 2 01:13:55 freenas generate_smb4_conf.py: [common.pipesubr:59] Popen()ing: zfs list -H -o mountpoint
May 2 01:13:55 freenas generate_smb4_conf.py: [common.pipesubr:59] Popen()ing: zfs list -H -o mountpoint
May 2 01:13:55 freenas generate_smb4_conf.py: [common.pipesubr:59] Popen()ing: zfs list -H -o mountpoint
May 2 01:13:55 freenas generate_smb4_conf.py: [common.pipesubr:59] Popen()ing: zfs list -H -o mountpoint
May 2 01:13:55 freenas generate_smb4_conf.py: [common.pipesubr:59] Popen()ing: /usr/local/bin/pdbedit -d 0 -i smbpasswd:/tmp/tmpqvd9Pd -s /usr/local/etc/smb4.conf -e tdbsam:/var/etc/private/passdb.tdb
May 2 01:13:56 freenas generate_smb4_conf.py: [common.pipesubr:59] Popen()ing: /usr/bin/getent passwd 'ESXi'
May 2 01:13:56 freenas generate_smb4_conf.py: [common.pipesubr:59] Popen()ing: /usr/local/bin/pdbedit -L
May 2 01:13:56 freenas generate_smb4_conf.py: [common.pipesubr:59] Popen()ing: /usr/local/bin/net sam rights grant ESXi SeTakeOwnershipPrivilege SeBackupPrivilege SeRestorePrivilege
May 2 01:13:56 freenas ActiveDirectory: /usr/sbin/service ix-kinit forcestop
May 2 01:13:56 freenas ActiveDirectory: /usr/sbin/service ix-hostname quietstart
May 2 01:13:59 freenas adtool: [common.pipesubr:59] Popen()ing: klist
May 2 01:13:59 freenas adtool: [common.pipesubr:59] Popen()ing: /usr/bin/kinit --renewable --password-file=/tmp/tmpbGN7Pq freenasadmin@CAMDOGHOME.LOCAL
May 2 01:14:03 freenas ActiveDirectory: /usr/sbin/service ix-hostname quietstart
May 2 01:14:04 freenas ActiveDirectory: /usr/sbin/service ix-kerberos quietstart
May 2 01:14:06 freenas ActiveDirectory: /usr/sbin/service ix-nsswitch quietstart
May 2 01:14:08 freenas ActiveDirectory: /usr/sbin/service ix-kinit quietstart
May 2 01:14:10 freenas ActiveDirectory: /usr/sbin/service ix-kinit status
May 2 01:14:12 freenas ActiveDirectory: /usr/local/bin/python /usr/local/www/freenasUI/middleware/notifier.py start cifs
May 2 01:14:16 freenas generate_smb4_conf.py: [common.pipesubr:59] Popen()ing: /sbin/sysctl -n 'kern.maxfilesperproc'
May 2 01:14:16 freenas generate_smb4_conf.py: [common.pipesubr:59] Popen()ing: klist
May 2 01:14:16 freenas generate_smb4_conf.py: [common.pipesubr:59] Popen()ing: zfs list -H -o mountpoint
May 2 01:14:17 freenas generate_smb4_conf.py: [common.pipesubr:59] Popen()ing: zfs list -H -o mountpoint
May 2 01:14:17 freenas generate_smb4_conf.py: [common.pipesubr:59] Popen()ing: zfs list -H -o mountpoint
May 2 01:14:17 freenas generate_smb4_conf.py: [common.pipesubr:59] Popen()ing: zfs list -H -o mountpoint
May 2 01:14:17 freenas generate_smb4_conf.py: [common.pipesubr:59] Popen()ing: zfs list -H -o mountpoint
May 2 01:14:17 freenas generate_smb4_conf.py: [common.pipesubr:59] Popen()ing: zfs list -H -o mountpoint
May 2 01:14:17 freenas generate_smb4_conf.py: [common.pipesubr:59] Popen()ing: /usr/local/bin/pdbedit -d 0 -i smbpasswd:/tmp/tmp7MGUt0 -s /usr/local/etc/smb4.conf -e tdbsam:/var/etc/private/passdb.tdb
May 2 01:14:18 freenas generate_smb4_conf.py: [common.pipesubr:59] Popen()ing: /usr/bin/getent passwd 'ESXi'
May 2 01:14:18 freenas generate_smb4_conf.py: [common.pipesubr:59] Popen()ing: /usr/local/bin/pdbedit -L
May 2 01:14:18 freenas generate_smb4_conf.py: [common.pipesubr:59] Popen()ing: /usr/local/bin/net sam rights grant ESXi SeTakeOwnershipPrivilege SeBackupPrivilege SeRestorePrivilege
May 2 01:14:18 freenas notifier: Importing account for ESXi...ok
May 2 01:14:18 freenas notifier:
May 2 01:14:18 freenas notifier: Granted SeTakeOwnershipPrivilege to FREENAS\ESXi
May 2 01:14:18 freenas notifier: Granted SeBackupPrivilege to FREENAS\ESXi
May 2 01:14:18 freenas notifier: Granted SeRestorePrivilege to FREENAS\ESXi
May 2 01:14:18 freenas notifier:
May 2 01:14:18 freenas notifier: Performing sanity check on Samba configuration: OK
May 2 01:14:18 freenas notifier: Starting nmbd.
May 2 01:14:18 freenas notifier: Starting smbd.
May 2 01:14:18 freenas nmbd[13311]: [2015/05/02 01:14:18.858008, 0] ../lib/util/become_daemon.c:136(daemon_ready)
May 2 01:14:18 freenas nmbd[13311]: STATUS=daemon 'nmbd' finished starting up and ready to serve connectionssend_host_announcement: type 809b03 for host FREENAS on subnet 10.0.13.8 for workgroup CAMDOGHOME
May 2 01:14:18 freenas notifier: Starting winbindd.
May 2 01:14:18 freenas smbd[13315]: [2015/05/02 01:14:18.923118, 0] ../lib/util/become_daemon.c:136(daemon_ready)
May 2 01:14:18 freenas smbd[13315]: STATUS=daemon 'smbd' finished starting up and ready to serve connectionswaiting for connections
May 2 01:14:18 freenas winbindd[13319]: [2015/05/02 01:14:18.995832, 0] ../source3/winbindd/winbindd_util.c:634(init_domain_list)
May 2 01:14:18 freenas winbindd[13319]: Could not fetch our SID - did we join?
May 2 01:14:18 freenas winbindd[13319]: [2015/05/02 01:14:18.996180, 0] ../source3/winbindd/winbindd.c:1240(winbindd_register_handlers)
May 2 01:14:18 freenas winbindd[13319]: unable to initialize domain list
May 2 01:14:19 freenas ActiveDirectory: /usr/sbin/service ix-activedirectory quietstart
May 2 01:14:23 freenas generate_ldap_conf.py: [common.pipesubr:59] Popen()ing: klist
May 2 01:14:25 freenas ActiveDirectory: /usr/sbin/service ix-activedirectory status
May 2 01:14:28 freenas ActiveDirectory: /usr/local/bin/python /usr/local/www/freenasUI/middleware/notifier.py stop cifs
May 2 01:14:30 freenas notifier: winbindd not running? (check /var/run/samba/winbindd.pid).
May 2 01:14:30 freenas notifier: Stopping smbd.
May 2 01:14:30 freenas notifier: Waiting for PIDS: 13315.
May 2 01:14:30 freenas notifier: Stopping nmbd.
May 2 01:14:30 freenas nmbd[13311]: [2015/05/02 01:14:30.378628, 0] ../source3/nmbd/nmbd.c:57(terminate)
May 2 01:14:30 freenas nmbd[13311]: Got SIGTERM: going down...
May 2 01:14:30 freenas notifier: Waiting for PIDS: 13311.
May 2 01:14:31 freenas ActiveDirectory: /usr/local/bin/python /usr/local/www/freenasUI/middleware/notifier.py start cifs
May 2 01:14:35 freenas generate_smb4_conf.py: [common.pipesubr:59] Popen()ing: /sbin/sysctl -n 'kern.maxfilesperproc'
May 2 01:14:35 freenas generate_smb4_conf.py: [common.pipesubr:59] Popen()ing: klist
May 2 01:14:35 freenas generate_smb4_conf.py: [common.pipesubr:59] Popen()ing: zfs list -H -o mountpoint
May 2 01:14:35 freenas generate_smb4_conf.py: [common.pipesubr:59] Popen()ing: zfs list -H -o mountpoint
May 2 01:14:35 freenas generate_smb4_conf.py: [common.pipesubr:59] Popen()ing: zfs list -H -o mountpoint
May 2 01:14:36 freenas generate_smb4_conf.py: [common.pipesubr:59] Popen()ing: zfs list -H -o mountpoint
May 2 01:14:36 freenas generate_smb4_conf.py: [common.pipesubr:59] Popen()ing: zfs list -H -o mountpoint
May 2 01:14:36 freenas generate_smb4_conf.py: [common.pipesubr:59] Popen()ing: zfs list -H -o mountpoint
May 2 01:14:36 freenas generate_smb4_conf.py: [common.pipesubr:59] Popen()ing: /usr/local/bin/pdbedit -d 0 -i smbpasswd:/tmp/tmpPm7zKY -s /usr/local/etc/smb4.conf -e tdbsam:/var/etc/private/passdb.tdb
May 2 01:14:36 freenas generate_smb4_conf.py: [common.pipesubr:59] Popen()ing: /usr/bin/getent passwd 'ESXi'
May 2 01:14:36 freenas generate_smb4_conf.py: [common.pipesubr:59] Popen()ing: /usr/local/bin/pdbedit -L
May 2 01:14:37 freenas generate_smb4_conf.py: [common.pipesubr:59] Popen()ing: /usr/local/bin/net sam rights grant ESXi SeTakeOwnershipPrivilege SeBackupPrivilege SeRestorePrivilege
May 2 01:14:37 freenas notifier: Importing account for ESXi...ok
May 2 01:14:37 freenas notifier:
May 2 01:14:37 freenas notifier: Granted SeTakeOwnershipPrivilege to FREENAS\ESXi
May 2 01:14:37 freenas notifier: Granted SeBackupPrivilege to FREENAS\ESXi
May 2 01:14:37 freenas notifier: Granted SeRestorePrivilege to FREENAS\ESXi
May 2 01:14:37 freenas notifier:
May 2 01:14:37 freenas notifier: Performing sanity check on Samba configuration: OK
May 2 01:14:37 freenas notifier: Starting nmbd.
May 2 01:14:37 freenas notifier: Starting smbd.
May 2 01:14:37 freenas nmbd[14501]: [2015/05/02 01:14:37.541310, 0] ../lib/util/become_daemon.c:136(daemon_ready)
May 2 01:14:37 freenas nmbd[14501]: STATUS=daemon 'nmbd' finished starting up and ready to serve connectionssend_host_announcement: type 809b03 for host FREENAS on subnet 10.0.13.8 for workgroup CAMDOGHOME
May 2 01:14:37 freenas notifier: Starting winbindd.
May 2 01:14:37 freenas smbd[14505]: [2015/05/02 01:14:37.605909, 0] ../lib/util/become_daemon.c:136(daemon_ready)
May 2 01:14:37 freenas smbd[14505]: STATUS=daemon 'smbd' finished starting up and ready to serve connectionswaiting for connections
May 2 01:14:37 freenas winbindd[14511]: [2015/05/02 01:14:37.701323, 0] ../lib/util/become_daemon.c:136(daemon_ready)
May 2 01:14:38 freenas ActiveDirectory: /usr/sbin/service ix-pam quietstart
May 2 01:14:40 freenas ActiveDirectory: /usr/sbin/service ix-cache quietstart &
May 2 01:14:42 freenas cachetool.py: [common.pipesubr:59] Popen()ing: klist
May 2 01:14:42 freenas winbindd[15047]: STATUS=daemon 'winbindd' finished starting up and ready to serve connectionsget_dc_list: preferred server list: "winsrv1.camdoghome.local, *"
May 2 01:14:42 freenas winbindd[14511]: STATUS=daemon 'winbindd' finished starting up and ready to serve connectionsconnection_ok: Connection to (null) for domain CAMDOGHOME is not connected
May 2 01:14:43 freenas cachetool.py: [common.pipesubr:59] Popen()ing: klist
May 2 01:14:48 freenas manage.py: [common.pipesubr:59] Popen()ing: klist
May 2 01:15:42 freenas manage.py: [common.pipesubr:59] Popen()ing: klist
May 2 01:15:43 freenas manage.py: [common.pipesubr:59] Popen()ing: klist
May 2 01:15:43 freenas manage.py: [common.pipesubr:59] Popen()ing: klist
May 2 01:15:43 freenas manage.py: [common.pipesubr:59] Popen()ing: klist
May 2 01:18:40 freenas generate_smb4_conf.py: [common.pipesubr:59] Popen()ing: /sbin/sysctl -n 'kern.maxfilesperproc'
May 2 01:18:40 freenas generate_smb4_conf.py: [common.pipesubr:59] Popen()ing: klist
May 2 01:18:40 freenas generate_smb4_conf.py: [common.pipesubr:59] Popen()ing: zfs list -H -o mountpoint
May 2 01:18:40 freenas generate_smb4_conf.py: [common.pipesubr:59] Popen()ing: zfs list -H -o mountpoint
May 2 01:18:41 freenas generate_smb4_conf.py: [common.pipesubr:59] Popen()ing: zfs list -H -o mountpoint
May 2 01:18:41 freenas generate_smb4_conf.py: [common.pipesubr:59] Popen()ing: zfs list -H -o mountpoint
May 2 01:18:41 freenas generate_smb4_conf.py: [common.pipesubr:59] Popen()ing: zfs list -H -o mountpoint
May 2 01:18:41 freenas generate_smb4_conf.py: [common.pipesubr:59] Popen()ing: zfs list -H -o mountpoint
May 2 01:18:41 freenas generate_smb4_conf.py: [common.pipesubr:59] Popen()ing: /usr/local/bin/pdbedit -d 0 -i smbpasswd:/tmp/tmpQvOEMF -s /usr/local/etc/smb4.conf -e tdbsam:/var/etc/private/passdb.tdb
May 2 01:18:42 freenas generate_smb4_conf.py: [common.pipesubr:59] Popen()ing: /usr/bin/getent passwd 'ESXi'
May 2 01:18:42 freenas generate_smb4_conf.py: [common.pipesubr:59] Popen()ing: /usr/local/bin/pdbedit -L
May 2 01:18:42 freenas generate_smb4_conf.py: [common.pipesubr:59] Popen()ing: /usr/local/bin/net sam rights grant ESXi SeTakeOwnershipPrivilege SeBackupPrivilege SeRestorePrivilege
May 2 01:18:42 freenas notifier: Importing account for ESXi...ok
May 2 01:18:42 freenas notifier:
May 2 01:18:42 freenas notifier: Granted SeTakeOwnershipPrivilege to FREENAS\ESXi
May 2 01:18:42 freenas notifier: Granted SeBackupPrivilege to FREENAS\ESXi
May 2 01:18:42 freenas notifier: Granted SeRestorePrivilege to FREENAS\ESXi
May 2 01:18:42 freenas notifier:
May 2 01:18:42 freenas notifier: Performing sanity check on Samba configuration: OK
May 2 01:18:49 freenas generate_ldap_conf.py: [common.pipesubr:59] Popen()ing: klist
May 2 01:19:09 freenas generate_smb4_conf.py: [common.pipesubr:59] Popen()ing: /sbin/sysctl -n 'kern.maxfilesperproc'
May 2 01:19:09 freenas generate_smb4_conf.py: [common.pipesubr:59] Popen()ing: klist
May 2 01:19:09 freenas generate_smb4_conf.py: [common.pipesubr:59] Popen()ing: zfs list -H -o mountpoint
May 2 01:19:09 freenas generate_smb4_conf.py: [common.pipesubr:59] Popen()ing: zfs list -H -o mountpoint
May 2 01:19:09 freenas generate_smb4_conf.py: [common.pipesubr:59] Popen()ing: zfs list -H -o mountpoint
May 2 01:19:09 freenas generate_smb4_conf.py: [common.pipesubr:59] Popen()ing: zfs list -H -o mountpoint
May 2 01:19:10 freenas generate_smb4_conf.py: [common.pipesubr:59] Popen()ing: zfs list -H -o mountpoint
May 2 01:19:10 freenas generate_smb4_conf.py: [common.pipesubr:59] Popen()ing: zfs list -H -o mountpoint
May 2 01:19:10 freenas generate_smb4_conf.py: [common.pipesubr:59] Popen()ing: /usr/local/bin/pdbedit -d 0 -i smbpasswd:/tmp/tmpg_iI93 -s /usr/local/etc/smb4.conf -e tdbsam:/var/etc/private/passdb.tdb
May 2 01:19:10 freenas generate_smb4_conf.py: [common.pipesubr:59] Popen()ing: /usr/bin/getent passwd 'ESXi'
May 2 01:19:10 freenas generate_smb4_conf.py: [common.pipesubr:59] Popen()ing: /usr/local/bin/pdbedit -L
May 2 01:19:10 freenas generate_smb4_conf.py: [common.pipesubr:59] Popen()ing: /usr/local/bin/net sam rights grant ESXi SeTakeOwnershipPrivilege SeBackupPrivilege SeRestorePrivilege
May 2 01:19:11 freenas notifier: Importing account for ESXi...ok
May 2 01:19:11 freenas notifier:
May 2 01:19:11 freenas notifier: Granted SeTakeOwnershipPrivilege to FREENAS\ESXi
May 2 01:19:11 freenas notifier: Granted SeBackupPrivilege to FREENAS\ESXi
May 2 01:19:11 freenas notifier: Granted SeRestorePrivilege to FREENAS\ESXi
May 2 01:19:11 freenas notifier:
May 2 01:19:11 freenas notifier: Stopping winbindd.
May 2 01:19:11 freenas winbindd[14511]: [2015/05/02 01:19:11.258793, 0] ../source3/winbindd/winbindd.c:234(winbindd_sig_term_handler)
May 2 01:19:11 freenas winbindd[14511]: Got sig[15] terminate (is_parent=1)
May 2 01:19:11 freenas winbindd[17424]: [2015/05/02 01:19:11.261593, 0] ../source3/winbindd/winbindd.c:234(winbindd_sig_term_handler)
May 2 01:19:11 freenas winbindd[15979]: [2015/05/02 01:19:11.261631, 0] ../source3/winbindd/winbindd.c:234(winbindd_sig_term_handler)
May 2 01:19:11 freenas winbindd[15980]: [2015/05/02 01:19:11.261631, 0] ../source3/winbindd/winbindd.c:234(winbindd_sig_term_handler)
May 2 01:19:11 freenas winbindd[17424]: Got sig[15] terminate (is_parent=0)
May 2 01:19:11 freenas winbindd[15048]: [2015/05/02 01:19:11.261659, 0] ../source3/winbindd/winbindd.c:234(winbindd_sig_term_handler)
May 2 01:19:11 freenas winbindd[15979]: Got sig[15] terminate (is_parent=0)
May 2 01:19:11 freenas winbindd[15980]: Got sig[15] terminate (is_parent=0)
May 2 01:19:11 freenas winbindd[15048]: Got sig[15] terminate (is_parent=0)
May 2 01:19:11 freenas notifier: Waiting for PIDS: 14511.
May 2 01:19:11 freenas notifier: Stopping smbd.
May 2 01:19:11 freenas notifier: Waiting for PIDS: 14505.
May 2 01:19:11 freenas notifier: Stopping nmbd.
May 2 01:19:11 freenas nmbd[14501]: [2015/05/02 01:19:11.271937, 0] ../source3/nmbd/nmbd.c:57(terminate)
May 2 01:19:11 freenas nmbd[14501]: Got SIGTERM: going down...
May 2 01:19:11 freenas notifier: Waiting for PIDS: 14501.
May 2 01:19:11 freenas notifier: Performing sanity check on Samba configuration: OK
May 2 01:19:11 freenas notifier: winbindd not running? (check /var/run/samba/winbindd.pid).
May 2 01:19:11 freenas notifier: smbd not running? (check /var/run/samba/smbd.pid).
May 2 01:19:11 freenas notifier: nmbd not running? (check /var/run/samba/nmbd.pid).
May 2 01:19:11 freenas notifier: Performing sanity check on Samba configuration: OK
May 2 01:19:11 freenas notifier: Starting nmbd.
May 2 01:19:11 freenas notifier: Starting smbd.
May 2 01:19:11 freenas nmbd[18636]: [2015/05/02 01:19:11.544963, 0] ../lib/util/become_daemon.c:136(daemon_ready)
May 2 01:19:11 freenas nmbd[18636]: STATUS=daemon 'nmbd' finished starting up and ready to serve connectionssend_host_announcement: type 809b03 for host FREENAS on subnet 10.0.13.8 for workgroup CAMDOGHOME
May 2 01:19:11 freenas notifier: Starting winbindd.
May 2 01:19:11 freenas smbd[18640]: [2015/05/02 01:19:11.609529, 0] ../lib/util/become_daemon.c:136(daemon_ready)
May 2 01:19:11 freenas smbd[18640]: STATUS=daemon 'smbd' finished starting up and ready to serve connectionswaiting for connections
May 2 01:19:11 freenas winbindd[18644]: [2015/05/02 01:19:11.698040, 0] ../lib/util/become_daemon.c:136(daemon_ready)
May 2 01:19:11 freenas notifier: Stopping mdnsd.
May 2 01:19:11 freenas smbd[18640]: dnssd_clientstub DNSServiceProcessResult called with DNSServiceRef with no ProcessReply function
May 2 01:19:11 freenas notifier: Waiting for PIDS: 7767.
May 2 01:19:11 freenas notifier: Starting mdnsd.
May 2 01:19:16 freenas winbindd[19118]: STATUS=daemon 'winbindd' finished starting up and ready to serve connectionsget_dc_list: preferred server list: "winsrv1.camdoghome.local, *"
May 2 01:19:16 freenas winbindd[18644]: STATUS=daemon 'winbindd' finished starting up and ready to serve connectionsconnection_ok: Connection to (null) for domain CAMDOGHOME is not connected
May 2 01:19:22 freenas cachetool.py: [common.pipesubr:59] Popen()ing: klist
May 2 01:19:22 freenas cachetool.py: [common.pipesubr:59] Popen()ing: klist
May 2 01:19:30 freenas manage.py: [common.pipesubr:59] Popen()ing: klist
May 2 01:19:30 freenas manage.py: [common.pipesubr:59] Popen()ing: klist
May 2 01:19:30 freenas manage.py: [common.pipesubr:59] Popen()ing: klist
May 2 01:19:31 freenas manage.py: [common.pipesubr:59] Popen()ing: klist
May 2 01:23:21 freenas manage.py: [common.pipesubr:59] Popen()ing: klist
May 2 01:23:21 freenas manage.py: [common.pipesubr:59] Popen()ing: klist
May 2 01:23:21 freenas manage.py: [common.pipesubr:59] Popen()ing: klist
May 2 01:23:21 freenas manage.py: [common.pipesubr:59] Popen()ing: klist
May 2 01:05:06 freenas GEOM_ELI: Encryption: AES-XTS 256
May 2 01:05:06 freenas GEOM_ELI: Crypto: hardware
May 2 01:05:06 freenas GEOM_ELI: Device da1p1.eli created.
May 2 01:05:06 freenas GEOM_ELI: Encryption: AES-XTS 256
May 2 01:05:06 freenas GEOM_ELI: Crypto: hardware
May 2 01:05:06 freenas GEOM_ELI: Device da0p1.eli created.
May 2 01:05:06 freenas GEOM_ELI: Encryption: AES-XTS 256
May 2 01:05:06 freenas GEOM_ELI: Crypto: hardware
May 2 01:05:06 freenas GEOM_ELI: Device da4p1.eli created.
May 2 01:05:06 freenas GEOM_ELI: Encryption: AES-XTS 256
May 2 01:05:06 freenas GEOM_ELI: Crypto: hardware
May 2 01:05:06 freenas GEOM_ELI: Device da9p1.eli created.
May 2 01:05:06 freenas GEOM_ELI: Encryption: AES-XTS 256
May 2 01:05:06 freenas GEOM_ELI: Crypto: hardware
May 2 01:05:06 freenas GEOM_ELI: Device da8p1.eli created.
May 2 01:05:06 freenas GEOM_ELI: Encryption: AES-XTS 256
May 2 01:05:06 freenas GEOM_ELI: Crypto: hardware
May 2 01:05:06 freenas GEOM_ELI: Device da7p1.eli created.
May 2 01:05:06 freenas GEOM_ELI: Encryption: AES-XTS 256
May 2 01:05:06 freenas GEOM_ELI: Crypto: hardware
May 2 01:05:06 freenas GEOM_ELI: Device da5p1.eli created.
May 2 01:05:06 freenas GEOM_ELI: Encryption: AES-XTS 256
May 2 01:05:06 freenas GEOM_ELI: Crypto: hardware
May 2 01:05:06 freenas GEOM_ELI: Device da6p1.eli created.
May 2 01:05:07 freenas GEOM_ELI: Encryption: AES-XTS 256
May 2 01:05:07 freenas GEOM_ELI: Crypto: hardware
May 2 01:05:07 freenas GEOM_ELI: Device da3p1.eli created.
May 2 01:05:07 freenas GEOM_ELI: Encryption: AES-XTS 256
May 2 01:05:07 freenas GEOM_ELI: Crypto: hardware
May 2 01:05:07 freenas notifier: geli: Cannot access da2p1 (error=1).
May 2 01:05:07 freenas notifier: Stopping collectd.
May 2 01:05:10 freenas notifier: Waiting for PIDS: 6310.
May 2 01:05:10 freenas notifier: Starting collectd.
May 2 01:06:12 freenas manage.py: [common.pipesubr:59] Popen()ing: klist
May 2 01:06:12 freenas manage.py: [common.pipesubr:59] Popen()ing: klist
May 2 01:06:13 freenas manage.py: [common.pipesubr:59] Popen()ing: klist
May 2 01:06:13 freenas manage.py: [common.pipesubr:59] Popen()ing: klist
May 2 01:06:28 freenas manage.py: [common.pipesubr:59] Popen()ing: klist
May 2 01:06:28 freenas manage.py: [common.pipesubr:59] Popen()ing: klist
May 2 01:06:28 freenas manage.py: [common.pipesubr:59] Popen()ing: klist
May 2 01:06:28 freenas manage.py: [common.pipesubr:59] Popen()ing: klist
May 2 01:06:39 freenas cachetool.py: [common.pipesubr:59] Popen()ing: klist
May 2 01:06:40 freenas cachetool.py: [common.pipesubr:59] Popen()ing: klist
May 2 01:13:12 freenas manage.py: [common.pipesubr:59] Popen()ing: klist
May 2 01:13:12 freenas manage.py: [common.pipesubr:59] Popen()ing: klist
May 2 01:13:12 freenas manage.py: [common.pipesubr:59] Popen()ing: klist
May 2 01:13:12 freenas manage.py: [common.pipesubr:59] Popen()ing: klist
May 2 01:13:38 freenas manage.py: [common.pipesubr:59] Popen()ing: klist
May 2 01:13:39 freenas ActiveDirectory: /usr/local/bin/python /usr/local/www/freenasUI/middleware/notifier.py stop cifs
May 2 01:13:41 freenas notifier: Stopping winbindd.
May 2 01:13:41 freenas winbindd[7722]: [2015/05/02 01:13:41.412498, 0] ../source3/winbindd/winbindd.c:234(winbindd_sig_term_handler)
May 2 01:13:41 freenas winbindd[7722]: Got sig[15] terminate (is_parent=1)
May 2 01:13:41 freenas notifier: Waiting for PIDS: 7722.
May 2 01:13:41 freenas notifier: Stopping smbd.
May 2 01:13:41 freenas notifier: Waiting for PIDS: 7718.
May 2 01:13:41 freenas notifier: Stopping nmbd.
May 2 01:13:41 freenas nmbd[7714]: [2015/05/02 01:13:41.425438, 0] ../source3/nmbd/nmbd.c:57(terminate)
May 2 01:13:41 freenas nmbd[7714]: Got SIGTERM: going down...
May 2 01:13:41 freenas notifier: Waiting for PIDS: 7714.
May 2 01:13:42 freenas ActiveDirectory: /usr/sbin/service ix-kerberos quietstop
May 2 01:13:42 freenas ActiveDirectory: /usr/sbin/service ix-nsswitch quietstop
May 2 01:13:44 freenas ActiveDirectory: /usr/sbin/service ix-pam quietstop
May 2 01:13:44 freenas ActiveDirectory: /usr/sbin/service ix-activedirectory forcestop
May 2 01:13:49 freenas ActiveDirectory: /usr/sbin/service ix-cache quietstop &
May 2 01:13:51 freenas ActiveDirectory: /usr/sbin/service samba_server forcestop
May 2 01:13:52 freenas ActiveDirectory: /usr/sbin/service ix-pre-samba start
May 2 01:13:54 freenas generate_smb4_conf.py: [common.pipesubr:59] Popen()ing: /sbin/sysctl -n 'kern.maxfilesperproc'
May 2 01:13:54 freenas generate_smb4_conf.py: [common.pipesubr:59] Popen()ing: zfs list -H -o mountpoint
May 2 01:13:55 freenas generate_smb4_conf.py: [common.pipesubr:59] Popen()ing: zfs list -H -o mountpoint
May 2 01:13:55 freenas generate_smb4_conf.py: [common.pipesubr:59] Popen()ing: zfs list -H -o mountpoint
May 2 01:13:55 freenas generate_smb4_conf.py: [common.pipesubr:59] Popen()ing: zfs list -H -o mountpoint
May 2 01:13:55 freenas generate_smb4_conf.py: [common.pipesubr:59] Popen()ing: zfs list -H -o mountpoint
May 2 01:13:55 freenas generate_smb4_conf.py: [common.pipesubr:59] Popen()ing: zfs list -H -o mountpoint
May 2 01:13:55 freenas generate_smb4_conf.py: [common.pipesubr:59] Popen()ing: /usr/local/bin/pdbedit -d 0 -i smbpasswd:/tmp/tmpqvd9Pd -s /usr/local/etc/smb4.conf -e tdbsam:/var/etc/private/passdb.tdb
May 2 01:13:56 freenas generate_smb4_conf.py: [common.pipesubr:59] Popen()ing: /usr/bin/getent passwd 'ESXi'
May 2 01:13:56 freenas generate_smb4_conf.py: [common.pipesubr:59] Popen()ing: /usr/local/bin/pdbedit -L
May 2 01:13:56 freenas generate_smb4_conf.py: [common.pipesubr:59] Popen()ing: /usr/local/bin/net sam rights grant ESXi SeTakeOwnershipPrivilege SeBackupPrivilege SeRestorePrivilege
May 2 01:13:56 freenas ActiveDirectory: /usr/sbin/service ix-kinit forcestop
May 2 01:13:56 freenas ActiveDirectory: /usr/sbin/service ix-hostname quietstart
May 2 01:13:59 freenas adtool: [common.pipesubr:59] Popen()ing: klist
May 2 01:13:59 freenas adtool: [common.pipesubr:59] Popen()ing: /usr/bin/kinit --renewable --password-file=/tmp/tmpbGN7Pq freenasadmin@CAMDOGHOME.LOCAL
May 2 01:14:03 freenas ActiveDirectory: /usr/sbin/service ix-hostname quietstart
May 2 01:14:04 freenas ActiveDirectory: /usr/sbin/service ix-kerberos quietstart
May 2 01:14:06 freenas ActiveDirectory: /usr/sbin/service ix-nsswitch quietstart
May 2 01:14:08 freenas ActiveDirectory: /usr/sbin/service ix-kinit quietstart
May 2 01:14:10 freenas ActiveDirectory: /usr/sbin/service ix-kinit status
May 2 01:14:12 freenas ActiveDirectory: /usr/local/bin/python /usr/local/www/freenasUI/middleware/notifier.py start cifs
May 2 01:14:16 freenas generate_smb4_conf.py: [common.pipesubr:59] Popen()ing: /sbin/sysctl -n 'kern.maxfilesperproc'
May 2 01:14:16 freenas generate_smb4_conf.py: [common.pipesubr:59] Popen()ing: klist
May 2 01:14:16 freenas generate_smb4_conf.py: [common.pipesubr:59] Popen()ing: zfs list -H -o mountpoint
May 2 01:14:17 freenas generate_smb4_conf.py: [common.pipesubr:59] Popen()ing: zfs list -H -o mountpoint
May 2 01:14:17 freenas generate_smb4_conf.py: [common.pipesubr:59] Popen()ing: zfs list -H -o mountpoint
May 2 01:14:17 freenas generate_smb4_conf.py: [common.pipesubr:59] Popen()ing: zfs list -H -o mountpoint
May 2 01:14:17 freenas generate_smb4_conf.py: [common.pipesubr:59] Popen()ing: zfs list -H -o mountpoint
May 2 01:14:17 freenas generate_smb4_conf.py: [common.pipesubr:59] Popen()ing: zfs list -H -o mountpoint
May 2 01:14:17 freenas generate_smb4_conf.py: [common.pipesubr:59] Popen()ing: /usr/local/bin/pdbedit -d 0 -i smbpasswd:/tmp/tmp7MGUt0 -s /usr/local/etc/smb4.conf -e tdbsam:/var/etc/private/passdb.tdb
May 2 01:14:18 freenas generate_smb4_conf.py: [common.pipesubr:59] Popen()ing: /usr/bin/getent passwd 'ESXi'
May 2 01:14:18 freenas generate_smb4_conf.py: [common.pipesubr:59] Popen()ing: /usr/local/bin/pdbedit -L
May 2 01:14:18 freenas generate_smb4_conf.py: [common.pipesubr:59] Popen()ing: /usr/local/bin/net sam rights grant ESXi SeTakeOwnershipPrivilege SeBackupPrivilege SeRestorePrivilege
May 2 01:14:18 freenas notifier: Importing account for ESXi...ok
May 2 01:14:18 freenas notifier:
May 2 01:14:18 freenas notifier: Granted SeTakeOwnershipPrivilege to FREENAS\ESXi
May 2 01:14:18 freenas notifier: Granted SeBackupPrivilege to FREENAS\ESXi
May 2 01:14:18 freenas notifier: Granted SeRestorePrivilege to FREENAS\ESXi
May 2 01:14:18 freenas notifier:
May 2 01:14:18 freenas notifier: Performing sanity check on Samba configuration: OK
May 2 01:14:18 freenas notifier: Starting nmbd.
May 2 01:14:18 freenas notifier: Starting smbd.
May 2 01:14:18 freenas nmbd[13311]: [2015/05/02 01:14:18.858008, 0] ../lib/util/become_daemon.c:136(daemon_ready)
May 2 01:14:18 freenas nmbd[13311]: STATUS=daemon 'nmbd' finished starting up and ready to serve connectionssend_host_announcement: type 809b03 for host FREENAS on subnet 10.0.13.8 for workgroup CAMDOGHOME
May 2 01:14:18 freenas notifier: Starting winbindd.
May 2 01:14:18 freenas smbd[13315]: [2015/05/02 01:14:18.923118, 0] ../lib/util/become_daemon.c:136(daemon_ready)
May 2 01:14:18 freenas smbd[13315]: STATUS=daemon 'smbd' finished starting up and ready to serve connectionswaiting for connections
May 2 01:14:18 freenas winbindd[13319]: [2015/05/02 01:14:18.995832, 0] ../source3/winbindd/winbindd_util.c:634(init_domain_list)
May 2 01:14:18 freenas winbindd[13319]: Could not fetch our SID - did we join?
May 2 01:14:18 freenas winbindd[13319]: [2015/05/02 01:14:18.996180, 0] ../source3/winbindd/winbindd.c:1240(winbindd_register_handlers)
May 2 01:14:18 freenas winbindd[13319]: unable to initialize domain list
May 2 01:14:19 freenas ActiveDirectory: /usr/sbin/service ix-activedirectory quietstart
May 2 01:14:23 freenas generate_ldap_conf.py: [common.pipesubr:59] Popen()ing: klist
May 2 01:14:25 freenas ActiveDirectory: /usr/sbin/service ix-activedirectory status
May 2 01:14:28 freenas ActiveDirectory: /usr/local/bin/python /usr/local/www/freenasUI/middleware/notifier.py stop cifs
May 2 01:14:30 freenas notifier: winbindd not running? (check /var/run/samba/winbindd.pid).
May 2 01:14:30 freenas notifier: Stopping smbd.
May 2 01:14:30 freenas notifier: Waiting for PIDS: 13315.
May 2 01:14:30 freenas notifier: Stopping nmbd.
May 2 01:14:30 freenas nmbd[13311]: [2015/05/02 01:14:30.378628, 0] ../source3/nmbd/nmbd.c:57(terminate)
May 2 01:14:30 freenas nmbd[13311]: Got SIGTERM: going down...
May 2 01:14:30 freenas notifier: Waiting for PIDS: 13311.
May 2 01:14:31 freenas ActiveDirectory: /usr/local/bin/python /usr/local/www/freenasUI/middleware/notifier.py start cifs
May 2 01:14:35 freenas generate_smb4_conf.py: [common.pipesubr:59] Popen()ing: /sbin/sysctl -n 'kern.maxfilesperproc'
May 2 01:14:35 freenas generate_smb4_conf.py: [common.pipesubr:59] Popen()ing: klist
May 2 01:14:35 freenas generate_smb4_conf.py: [common.pipesubr:59] Popen()ing: zfs list -H -o mountpoint
May 2 01:14:35 freenas generate_smb4_conf.py: [common.pipesubr:59] Popen()ing: zfs list -H -o mountpoint
May 2 01:14:35 freenas generate_smb4_conf.py: [common.pipesubr:59] Popen()ing: zfs list -H -o mountpoint
May 2 01:14:36 freenas generate_smb4_conf.py: [common.pipesubr:59] Popen()ing: zfs list -H -o mountpoint
May 2 01:14:36 freenas generate_smb4_conf.py: [common.pipesubr:59] Popen()ing: zfs list -H -o mountpoint
May 2 01:14:36 freenas generate_smb4_conf.py: [common.pipesubr:59] Popen()ing: zfs list -H -o mountpoint
May 2 01:14:36 freenas generate_smb4_conf.py: [common.pipesubr:59] Popen()ing: /usr/local/bin/pdbedit -d 0 -i smbpasswd:/tmp/tmpPm7zKY -s /usr/local/etc/smb4.conf -e tdbsam:/var/etc/private/passdb.tdb
May 2 01:14:36 freenas generate_smb4_conf.py: [common.pipesubr:59] Popen()ing: /usr/bin/getent passwd 'ESXi'
May 2 01:14:36 freenas generate_smb4_conf.py: [common.pipesubr:59] Popen()ing: /usr/local/bin/pdbedit -L
May 2 01:14:37 freenas generate_smb4_conf.py: [common.pipesubr:59] Popen()ing: /usr/local/bin/net sam rights grant ESXi SeTakeOwnershipPrivilege SeBackupPrivilege SeRestorePrivilege
May 2 01:14:37 freenas notifier: Importing account for ESXi...ok
May 2 01:14:37 freenas notifier:
May 2 01:14:37 freenas notifier: Granted SeTakeOwnershipPrivilege to FREENAS\ESXi
May 2 01:14:37 freenas notifier: Granted SeBackupPrivilege to FREENAS\ESXi
May 2 01:14:37 freenas notifier: Granted SeRestorePrivilege to FREENAS\ESXi
May 2 01:14:37 freenas notifier:
May 2 01:14:37 freenas notifier: Performing sanity check on Samba configuration: OK
May 2 01:14:37 freenas notifier: Starting nmbd.
May 2 01:14:37 freenas notifier: Starting smbd.
May 2 01:14:37 freenas nmbd[14501]: [2015/05/02 01:14:37.541310, 0] ../lib/util/become_daemon.c:136(daemon_ready)
May 2 01:14:37 freenas nmbd[14501]: STATUS=daemon 'nmbd' finished starting up and ready to serve connectionssend_host_announcement: type 809b03 for host FREENAS on subnet 10.0.13.8 for workgroup CAMDOGHOME
May 2 01:14:37 freenas notifier: Starting winbindd.
May 2 01:14:37 freenas smbd[14505]: [2015/05/02 01:14:37.605909, 0] ../lib/util/become_daemon.c:136(daemon_ready)
May 2 01:14:37 freenas smbd[14505]: STATUS=daemon 'smbd' finished starting up and ready to serve connectionswaiting for connections
May 2 01:14:37 freenas winbindd[14511]: [2015/05/02 01:14:37.701323, 0] ../lib/util/become_daemon.c:136(daemon_ready)
May 2 01:14:38 freenas ActiveDirectory: /usr/sbin/service ix-pam quietstart
May 2 01:14:40 freenas ActiveDirectory: /usr/sbin/service ix-cache quietstart &
May 2 01:14:42 freenas cachetool.py: [common.pipesubr:59] Popen()ing: klist
May 2 01:14:42 freenas winbindd[15047]: STATUS=daemon 'winbindd' finished starting up and ready to serve connectionsget_dc_list: preferred server list: "winsrv1.camdoghome.local, *"
May 2 01:14:42 freenas winbindd[14511]: STATUS=daemon 'winbindd' finished starting up and ready to serve connectionsconnection_ok: Connection to (null) for domain CAMDOGHOME is not connected
May 2 01:14:43 freenas cachetool.py: [common.pipesubr:59] Popen()ing: klist
May 2 01:14:48 freenas manage.py: [common.pipesubr:59] Popen()ing: klist
May 2 01:15:42 freenas manage.py: [common.pipesubr:59] Popen()ing: klist
May 2 01:15:43 freenas manage.py: [common.pipesubr:59] Popen()ing: klist
May 2 01:15:43 freenas manage.py: [common.pipesubr:59] Popen()ing: klist
May 2 01:15:43 freenas manage.py: [common.pipesubr:59] Popen()ing: klist
May 2 01:18:40 freenas generate_smb4_conf.py: [common.pipesubr:59] Popen()ing: /sbin/sysctl -n 'kern.maxfilesperproc'
May 2 01:18:40 freenas generate_smb4_conf.py: [common.pipesubr:59] Popen()ing: klist
May 2 01:18:40 freenas generate_smb4_conf.py: [common.pipesubr:59] Popen()ing: zfs list -H -o mountpoint
May 2 01:18:40 freenas generate_smb4_conf.py: [common.pipesubr:59] Popen()ing: zfs list -H -o mountpoint
May 2 01:18:41 freenas generate_smb4_conf.py: [common.pipesubr:59] Popen()ing: zfs list -H -o mountpoint
May 2 01:18:41 freenas generate_smb4_conf.py: [common.pipesubr:59] Popen()ing: zfs list -H -o mountpoint
May 2 01:18:41 freenas generate_smb4_conf.py: [common.pipesubr:59] Popen()ing: zfs list -H -o mountpoint
May 2 01:18:41 freenas generate_smb4_conf.py: [common.pipesubr:59] Popen()ing: zfs list -H -o mountpoint
May 2 01:18:41 freenas generate_smb4_conf.py: [common.pipesubr:59] Popen()ing: /usr/local/bin/pdbedit -d 0 -i smbpasswd:/tmp/tmpQvOEMF -s /usr/local/etc/smb4.conf -e tdbsam:/var/etc/private/passdb.tdb
May 2 01:18:42 freenas generate_smb4_conf.py: [common.pipesubr:59] Popen()ing: /usr/bin/getent passwd 'ESXi'
May 2 01:18:42 freenas generate_smb4_conf.py: [common.pipesubr:59] Popen()ing: /usr/local/bin/pdbedit -L
May 2 01:18:42 freenas generate_smb4_conf.py: [common.pipesubr:59] Popen()ing: /usr/local/bin/net sam rights grant ESXi SeTakeOwnershipPrivilege SeBackupPrivilege SeRestorePrivilege
May 2 01:18:42 freenas notifier: Importing account for ESXi...ok
May 2 01:18:42 freenas notifier:
May 2 01:18:42 freenas notifier: Granted SeTakeOwnershipPrivilege to FREENAS\ESXi
May 2 01:18:42 freenas notifier: Granted SeBackupPrivilege to FREENAS\ESXi
May 2 01:18:42 freenas notifier: Granted SeRestorePrivilege to FREENAS\ESXi
May 2 01:18:42 freenas notifier:
May 2 01:18:42 freenas notifier: Performing sanity check on Samba configuration: OK
May 2 01:18:49 freenas generate_ldap_conf.py: [common.pipesubr:59] Popen()ing: klist
May 2 01:19:09 freenas generate_smb4_conf.py: [common.pipesubr:59] Popen()ing: /sbin/sysctl -n 'kern.maxfilesperproc'
May 2 01:19:09 freenas generate_smb4_conf.py: [common.pipesubr:59] Popen()ing: klist
May 2 01:19:09 freenas generate_smb4_conf.py: [common.pipesubr:59] Popen()ing: zfs list -H -o mountpoint
May 2 01:19:09 freenas generate_smb4_conf.py: [common.pipesubr:59] Popen()ing: zfs list -H -o mountpoint
May 2 01:19:09 freenas generate_smb4_conf.py: [common.pipesubr:59] Popen()ing: zfs list -H -o mountpoint
May 2 01:19:09 freenas generate_smb4_conf.py: [common.pipesubr:59] Popen()ing: zfs list -H -o mountpoint
May 2 01:19:10 freenas generate_smb4_conf.py: [common.pipesubr:59] Popen()ing: zfs list -H -o mountpoint
May 2 01:19:10 freenas generate_smb4_conf.py: [common.pipesubr:59] Popen()ing: zfs list -H -o mountpoint
May 2 01:19:10 freenas generate_smb4_conf.py: [common.pipesubr:59] Popen()ing: /usr/local/bin/pdbedit -d 0 -i smbpasswd:/tmp/tmpg_iI93 -s /usr/local/etc/smb4.conf -e tdbsam:/var/etc/private/passdb.tdb
May 2 01:19:10 freenas generate_smb4_conf.py: [common.pipesubr:59] Popen()ing: /usr/bin/getent passwd 'ESXi'
May 2 01:19:10 freenas generate_smb4_conf.py: [common.pipesubr:59] Popen()ing: /usr/local/bin/pdbedit -L
May 2 01:19:10 freenas generate_smb4_conf.py: [common.pipesubr:59] Popen()ing: /usr/local/bin/net sam rights grant ESXi SeTakeOwnershipPrivilege SeBackupPrivilege SeRestorePrivilege
May 2 01:19:11 freenas notifier: Importing account for ESXi...ok
May 2 01:19:11 freenas notifier:
May 2 01:19:11 freenas notifier: Granted SeTakeOwnershipPrivilege to FREENAS\ESXi
May 2 01:19:11 freenas notifier: Granted SeBackupPrivilege to FREENAS\ESXi
May 2 01:19:11 freenas notifier: Granted SeRestorePrivilege to FREENAS\ESXi
May 2 01:19:11 freenas notifier:
May 2 01:19:11 freenas notifier: Stopping winbindd.
May 2 01:19:11 freenas winbindd[14511]: [2015/05/02 01:19:11.258793, 0] ../source3/winbindd/winbindd.c:234(winbindd_sig_term_handler)
May 2 01:19:11 freenas winbindd[14511]: Got sig[15] terminate (is_parent=1)
May 2 01:19:11 freenas winbindd[17424]: [2015/05/02 01:19:11.261593, 0] ../source3/winbindd/winbindd.c:234(winbindd_sig_term_handler)
May 2 01:19:11 freenas winbindd[15979]: [2015/05/02 01:19:11.261631, 0] ../source3/winbindd/winbindd.c:234(winbindd_sig_term_handler)
May 2 01:19:11 freenas winbindd[15980]: [2015/05/02 01:19:11.261631, 0] ../source3/winbindd/winbindd.c:234(winbindd_sig_term_handler)
May 2 01:19:11 freenas winbindd[17424]: Got sig[15] terminate (is_parent=0)
May 2 01:19:11 freenas winbindd[15048]: [2015/05/02 01:19:11.261659, 0] ../source3/winbindd/winbindd.c:234(winbindd_sig_term_handler)
May 2 01:19:11 freenas winbindd[15979]: Got sig[15] terminate (is_parent=0)
May 2 01:19:11 freenas winbindd[15980]: Got sig[15] terminate (is_parent=0)
May 2 01:19:11 freenas winbindd[15048]: Got sig[15] terminate (is_parent=0)
May 2 01:19:11 freenas notifier: Waiting for PIDS: 14511.
May 2 01:19:11 freenas notifier: Stopping smbd.
May 2 01:19:11 freenas notifier: Waiting for PIDS: 14505.
May 2 01:19:11 freenas notifier: Stopping nmbd.
May 2 01:19:11 freenas nmbd[14501]: [2015/05/02 01:19:11.271937, 0] ../source3/nmbd/nmbd.c:57(terminate)
May 2 01:19:11 freenas nmbd[14501]: Got SIGTERM: going down...
May 2 01:19:11 freenas notifier: Waiting for PIDS: 14501.
May 2 01:19:11 freenas notifier: Performing sanity check on Samba configuration: OK
May 2 01:19:11 freenas notifier: winbindd not running? (check /var/run/samba/winbindd.pid).
May 2 01:19:11 freenas notifier: smbd not running? (check /var/run/samba/smbd.pid).
May 2 01:19:11 freenas notifier: nmbd not running? (check /var/run/samba/nmbd.pid).
May 2 01:19:11 freenas notifier: Performing sanity check on Samba configuration: OK
May 2 01:19:11 freenas notifier: Starting nmbd.
May 2 01:19:11 freenas notifier: Starting smbd.
May 2 01:19:11 freenas nmbd[18636]: [2015/05/02 01:19:11.544963, 0] ../lib/util/become_daemon.c:136(daemon_ready)
May 2 01:19:11 freenas nmbd[18636]: STATUS=daemon 'nmbd' finished starting up and ready to serve connectionssend_host_announcement: type 809b03 for host FREENAS on subnet 10.0.13.8 for workgroup CAMDOGHOME
May 2 01:19:11 freenas notifier: Starting winbindd.
May 2 01:19:11 freenas smbd[18640]: [2015/05/02 01:19:11.609529, 0] ../lib/util/become_daemon.c:136(daemon_ready)
May 2 01:19:11 freenas smbd[18640]: STATUS=daemon 'smbd' finished starting up and ready to serve connectionswaiting for connections
May 2 01:19:11 freenas winbindd[18644]: [2015/05/02 01:19:11.698040, 0] ../lib/util/become_daemon.c:136(daemon_ready)
May 2 01:19:11 freenas notifier: Stopping mdnsd.
May 2 01:19:11 freenas smbd[18640]: dnssd_clientstub DNSServiceProcessResult called with DNSServiceRef with no ProcessReply function
May 2 01:19:11 freenas notifier: Waiting for PIDS: 7767.
May 2 01:19:11 freenas notifier: Starting mdnsd.
May 2 01:19:16 freenas winbindd[19118]: STATUS=daemon 'winbindd' finished starting up and ready to serve connectionsget_dc_list: preferred server list: "winsrv1.camdoghome.local, *"
May 2 01:19:16 freenas winbindd[18644]: STATUS=daemon 'winbindd' finished starting up and ready to serve connectionsconnection_ok: Connection to (null) for domain CAMDOGHOME is not connected
May 2 01:19:22 freenas cachetool.py: [common.pipesubr:59] Popen()ing: klist
May 2 01:19:22 freenas cachetool.py: [common.pipesubr:59] Popen()ing: klist
May 2 01:19:30 freenas manage.py: [common.pipesubr:59] Popen()ing: klist
May 2 01:19:30 freenas manage.py: [common.pipesubr:59] Popen()ing: klist
May 2 01:19:30 freenas manage.py: [common.pipesubr:59] Popen()ing: klist
May 2 01:19:31 freenas manage.py: [common.pipesubr:59] Popen()ing: klist
May 2 01:23:21 freenas manage.py: [common.pipesubr:59] Popen()ing: klist
May 2 01:23:21 freenas manage.py: [common.pipesubr:59] Popen()ing: klist
May 2 01:23:21 freenas manage.py: [common.pipesubr:59] Popen()ing: klist
May 2 01:23:21 freenas manage.py: [common.pipesubr:59] Popen()ing: klist