Periodic snapshots in 9.3.1 not happening

Status
Not open for further replies.
S

saurav

Contributor
Joined
Jul 29, 2012
Messages
139
I recently upgraded my FreeNAS Mini from 9.2.1.8 to 9.3.1 by installing the latter on a new SATA dom,\ and uploading the config db. It seems with 9.3 my periodic snapshot tasks are not creating any snapshots. I don't see anything in the logs either. There's not a single snapshot since I upgraded.

I haven't upgraded the pool yet. I wanted to see if things are working all right before I go all in. Do I have to upgrade the pool for snapshots to work?

Thanks,
Saurav.
 
D

dlavigne

Guest
DO NOT upgrade your pool unless you need a new ZFS feature and have no intention of ever using that pool in another OS or older version of FreeNAS.

There were some snapshot/replication bugs in the 9.3.1 series which are being fixed. If you are running 201509160044 (from System -> Information) and still have issues, please create a bug report at bugs.freenas.org and post the issue number here.
 
S

saurav

Contributor
Joined
Jul 29, 2012
Messages
139
I'm on 201509022158.

That's the other weird thing. I also updated my backup HP N36L (without upgrading pool) with the same ISO, and it has some pending updates, but the mini didn't get them. I wonder why. In fact, the N36L got the first update the very next day, but I didn't install any of them yet.

Should I update the mini *manually*?
 
S

saurav

Contributor
Joined
Jul 29, 2012
Messages
139
Well, clicking on the "Check Now" button in the Update screen on the mini seems to get a list of the upgrades. So as far as updates go, the mini only has a problem with getting the updates automatically.

I'm going to install the updates and see if any of them fix snapshots. changelogs mention some fixes related to snapshot but they don't seem to be directly related to my issue.

Code:
#10418    Bug    Important    CIFS "Local Master" always in effect.
#11227    Bug    Important    Fixed a bug that prevents snapshots being deleted at the sending side.
#11262    Bug    Important    Active Directory won't re-start if krb5 ticket expires
#11331    Bug    Important    Can't destroy a zvol in GUI when iSCSI is enabled and system is possessed by evil spirits
#11335    Bug    Important    Make self-signed certificates and CAs work proper with Windows
#11361    Bug    Critical    Windows Previous Versions "Can't Read" error
#11409    Bug    Important    grub configuration generation issue
#11420    Feature    Nice to have    Replication: Recursive replicate vs Remove stale snapshots
#11421    Bug    Important    Fix DomainController migration failure for upgrade from 9.2.X
 
S

saurav

Contributor
Joined
Jul 29, 2012
Messages
139
It's not just snapshots, but it seems anything that is run by cron is not running. Like my cronjob to run Cyberjock's script to backup the config db.

I tried to restart all enabled services (sudo service -R), and it output this. There are some warnings in there, but they might not be the problem. Still looking...

Code:
Sep 17 16:15:42 freenas-primary saurav: /usr/sbin/service: WARNING: $vmware_guest__enable is not set properly - see rc.conf(5).
Sep 17 16:15:42 freenas-primary saurav: /usr/sbin/service: WARNING: $stunnel_enable is not set properly - see rc.conf(5).
Sep 17 16:15:42 freenas-primary saurav: /usr/sbin/service: WARNING: $snmptrapd_enable is not set properly - see rc.conf(5).
Sep 17 16:15:42 freenas-primary saurav: /usr/sbin/service: WARNING: $rrdcached_enable is not set properly - see rc.conf(5).
Sep 17 16:15:42 freenas-primary saurav: /usr/sbin/service: WARNING: $mdnsresponderposix_enable is not set properly - see rc.conf(5).
Sep 17 16:15:42 freenas-primary saurav: /usr/sbin/service: WARNING: $kpropd_enable is not set properly - see rc.conf(5).
Sep 17 16:15:42 freenas-primary saurav: /usr/sbin/service: WARNING: $htcacheclean_enable is not set properly - see rc.conf(5).
Sep 17 16:15:42 freenas-primary saurav: /usr/sbin/service: WARNING: $git_daemon_enable is not set properly - see rc.conf(5).
Sep 17 16:15:42 freenas-primary saurav: /usr/sbin/service: WARNING: $django_enable is not set properly - see rc.conf(5).
Sep 17 16:15:42 freenas-primary saurav: /usr/sbin/service: WARNING: $collectdmon_enable is not set properly - see rc.conf(5).
Sep 17 16:16:41 freenas-primary saurav: /usr/sbin/service: WARNING: $collectdmon_enable is not set properly - see rc.conf(5).
Sep 17 16:16:41 freenas-primary saurav: /usr/sbin/service: WARNING: $django_enable is not set properly - see rc.conf(5).
Sep 17 16:16:41 freenas-primary saurav: /usr/sbin/service: WARNING: $git_daemon_enable is not set properly - see rc.conf(5).
Sep 17 16:16:41 freenas-primary saurav: /usr/sbin/service: WARNING: $htcacheclean_enable is not set properly - see rc.conf(5).
Sep 17 16:16:41 freenas-primary saurav: /usr/sbin/service: WARNING: $kpropd_enable is not set properly - see rc.conf(5).
Sep 17 16:16:41 freenas-primary saurav: /usr/sbin/service: WARNING: $mdnsresponderposix_enable is not set properly - see rc.conf(5).
Sep 17 16:16:41 freenas-primary afpd[3246]: AFP Server shutting down
Sep 17 16:16:41 freenas-primary cnid_metad[3247]: shutting down on SIGTERM
Sep 17 16:16:41 freenas-primary netatalk[3231]: Netatalk AFP server exiting
Sep 17 16:16:41 freenas-primary smbd[2934]: dnssd_clientstub DNSServiceProcessResult called with DNSServiceRef with no ProcessReply function
Sep 17 16:16:41 freenas-primary upsmon[2736]: upsmon parent: read
Sep 17 16:16:41 freenas-primary upsd[2730]: mainloop: Interrupted system call
Sep 17 16:16:41 freenas-primary saurav: /usr/sbin/service: WARNING: $_enable is not set properly - see rc.conf(5).
Sep 17 16:16:41 freenas-primary saurav: /usr/sbin/service: WARNING: $rrdcached_enable is not set properly - see rc.conf(5).
Sep 17 16:16:42 freenas-primary winbindd[2937]:   STATUS=daemon 'winbindd' finished starting up and ready to serve connectionsGot sig[15] terminate (is_parent=1)
Sep 17 16:16:42 freenas-primary winbindd[2941]:   STATUS=daemon 'winbindd' finished starting up and ready to serve connectionsGot sig[15] terminate (is_parent=0)
Sep 17 16:16:42 freenas-primary winbindd[2942]:   STATUS=daemon 'winbindd' finished starting up and ready to serve connectionsGot sig[15] terminate (is_parent=0)
Sep 17 16:16:42 freenas-primary winbindd[2943]:   STATUS=daemon 'winbindd' finished starting up and ready to serve connectionsGot sig[15] terminate (is_parent=0)
Sep 17 16:16:43 freenas-primary nmbd[2931]: [2015/09/17 16:16:43.301201,  0] ../source3/nmbd/nmbd.c:57(terminate)
Sep 17 16:16:43 freenas-primary nmbd[2931]:   Got SIGTERM: going down...
Sep 17 16:16:43 freenas-primary saurav: /usr/sbin/service: WARNING: $snmptrapd_enable is not set properly - see rc.conf(5).
Sep 17 16:16:43 freenas-primary saurav: /usr/sbin/service: WARNING: $stunnel_enable is not set properly - see rc.conf(5).
Sep 17 16:16:43 freenas-primary syslog-ng[1994]: syslog-ng shutting down; version='3.5.6'
Sep 17 16:16:43 freenas-primary syslog-ng[45465]: syslog-ng starting up; version='3.5.6'
Sep 17 16:16:43 freenas-primary vboxdrv: fAsync=0 offMin=0x630 offMax=0x15f0
Sep 17 16:16:43 freenas-primary saurav: /usr/sbin/service: WARNING: $stunnel_enable is not set properly - see rc.conf(5).
Sep 17 16:16:43 freenas-primary saurav: /usr/sbin/service: WARNING: $snmptrapd_enable is not set properly - see rc.conf(5).
Sep 17 16:16:46 freenas-primary nmbd[45516]: [2015/09/17 16:16:46.102554,  0] ../lib/util/become_daemon.c:136(daemon_ready)
Sep 17 16:16:46 freenas-primary smbd[45523]: [2015/09/17 16:16:46.190022,  0] ../lib/util/become_daemon.c:136(daemon_ready)
Sep 17 16:16:46 freenas-primary smbd[45523]: dnssd_clientstub ConnectToServer: connect()-> No of tries: 1
Sep 17 16:16:46 freenas-primary winbindd[45527]: [2015/09/17 16:16:46.236824,  0] ../source3/winbindd/winbindd_cache.c:3196(initialize_winbindd_cache)
Sep 17 16:16:46 freenas-primary winbindd[45527]:   initialize_winbindd_cache: clearing cache and re-creating with version number 2
Sep 17 16:16:46 freenas-primary winbindd[45527]: [2015/09/17 16:16:46.242194,  0] ../lib/util/become_daemon.c:136(daemon_ready)
Sep 17 16:16:46 freenas-primary saurav: /usr/sbin/service: WARNING: $rrdcached_enable is not set properly - see rc.conf(5).
Sep 17 16:16:46 freenas-primary saurav: /usr/sbin/service: WARNING: $_enable is not set properly - see rc.conf(5).
Sep 17 16:16:46 freenas-primary python: dnssd_clientstub ConnectToServer: connect()-> No of tries: 1
Sep 17 16:16:46 freenas-primary python: dnssd_clientstub ConnectToServer: connect()-> No of tries: 1
Sep 17 16:16:46 freenas-primary python: dnssd_clientstub ConnectToServer: connect()-> No of tries: 1
Sep 17 16:16:47 freenas-primary smbd[45523]: dnssd_clientstub ConnectToServer: connect()-> No of tries: 2
Sep 17 16:16:47 freenas-primary python: dnssd_clientstub ConnectToServer: connect()-> No of tries: 2
Sep 17 16:16:47 freenas-primary python: dnssd_clientstub ConnectToServer: connect()-> No of tries: 2
Sep 17 16:16:47 freenas-primary python: dnssd_clientstub ConnectToServer: connect()-> No of tries: 2
Sep 17 16:16:48 freenas-primary smbd[45523]: dnssd_clientstub ConnectToServer: connect()-> No of tries: 3
Sep 17 16:16:48 freenas-primary python: dnssd_clientstub ConnectToServer: connect()-> No of tries: 3
Sep 17 16:16:48 freenas-primary python: dnssd_clientstub ConnectToServer: connect()-> No of tries: 3
Sep 17 16:16:48 freenas-primary python: dnssd_clientstub ConnectToServer: connect()-> No of tries: 3
Sep 17 16:16:49 freenas-primary smbd[45523]: dnssd_clientstub ConnectToServer: connect() failed Socket:32 Err:-1 Errno:61 Connection refused
Sep 17 16:16:49 freenas-primary python: dnssd_clientstub ConnectToServer: connect() failed Socket:4 Err:-1 Errno:61 Connection refused
Sep 17 16:16:49 freenas-primary python: dnssd_clientstub ConnectToServer: connect() failed Socket:7 Err:-1 Errno:61 Connection refused
Sep 17 16:16:49 freenas-primary python: dnssd_clientstub ConnectToServer: connect() failed Socket:8 Err:-1 Errno:61 Connection refused
Sep 17 16:16:50 freenas-primary saurav: /usr/sbin/service: WARNING: $mdnsresponderposix_enable is not set properly - see rc.conf(5).
Sep 17 16:16:50 freenas-primary saurav: /usr/sbin/service: WARNING: $kpropd_enable is not set properly - see rc.conf(5).
Sep 17 16:16:50 freenas-primary INADYN[45713]: Thu Sep 17 16:16:50 2015: W:INADYN: Address, alias pairs read from cache file (/tmp/inadyn_ip.cache):
Sep 17 16:16:50 freenas-primary INADYN[45713]: Thu Sep 17 16:16:50 2015: W:INADYN: xxx.yyy.zz.w xxxxxx.xxxxx.xxx:auto xxxxxxxxxx...
Sep 17 16:16:50 freenas-primary saurav: /usr/sbin/service: WARNING: $htcacheclean_enable is not set properly - see rc.conf(5).
Sep 17 16:16:50 freenas-primary saurav: /usr/sbin/service: WARNING: $git_daemon_enable is not set properly - see rc.conf(5).
Sep 17 16:16:50 freenas-primary saurav: /usr/sbin/service: WARNING: $django_enable is not set properly - see rc.conf(5).
Sep 17 16:16:50 freenas-primary saurav: /usr/sbin/service: WARNING: $collectdmon_enable is not set properly - see rc.conf(5).
Sep 17 16:16:50 freenas-primary netatalk[45690]: Netatalk AFP server starting
Sep 17 16:16:50 freenas-primary netatalk[45690]: Registered with Zeroconf
Sep 17 16:16:50 freenas-primary cnid_metad[45817]: CNID Server listening on localhost:4700
Sep 17 16:16:50 freenas-primary afpd[45816]: Netatalk AFP/TCP listening on xxx.xxx.xxx.xxx:548
Sep 17 16:17:09 freenas-primary nmbd[45516]:   STATUS=daemon 'nmbd' finished starting up and ready to serve connections*****
Sep 17 16:17:09 freenas-primary nmbd[45516]: 
Sep 17 16:17:09 freenas-primary nmbd[45516]:   Samba name server FREENAS-PRIMARY is now a local master browser for workgroup WORKGROUP on subnet 192.168.1.50
Sep 17 16:17:09 freenas-primary nmbd[45516]: 
Sep 17 16:17:09 freenas-primary nmbd[45516]:   *****
 
S

saurav

Contributor
Joined
Jul 29, 2012
Messages
139
"Verify Install" button in Update screen says everything is ok.
 
S

saurav

Contributor
Joined
Jul 29, 2012
Messages
139
Wow, after installing the upgrades 9.3.1 degraded my pool status because it couldn't find two of the HDs!

And I couldn't go back to the 9.2.1.8 install either! It hangs right after displaying all the messages starting with GEOM_ELI and "igb0: link status changed to UP". I have to reset the server to reboot. I just can't understand why this would happen.

I'm now trying to install 9.2.1.8 afresh on a usb drive to see if the mini would boot up from that. I hope my pool is alright, though!
 
S

saurav

Contributor
Joined
Jul 29, 2012
Messages
139
Ok, so I have installed 9.2.1.8 on a usb drive, which booted up fine. Then I uploaded my saved config from 9.2.1.8 and things are good now. Whether periodic snapshots and other crons are working can only be verified (without excessive effort) tomorrow.

Now I need to see what's wrong with the SATA dom that had 9.2.1.8 installed. I can run badblocks on it, but I don't know how to check if the 9.3.1 install corrupted it somehow.

But now I have my primary on 9.2.1.8 and my backup on 9.3.1 (pool not upgraded). I wonder how safe that is. May be I should revert to 9.2.1.8 on that as well.

Btw, why do I see 9.2.1.7 everywhere? I'm pretty sure I installed 9.2.1.8. Here's where I downloaded it from
https://download.freenas.org/9.2.1.8/RELEASE/x64/

And this is from the terminal log where I created the USB
Code:
$ pv FreeNAS-9.2.1.8-RELEASE-x64.img | sudo dd of=/dev/disk1
1.86GiB 0:24:53 [1.28MiB/s] [===================================>] 100%          
3906250+0 records in
3906250+0 records out
2000000000 bytes transferred in 1493.683383 secs (1338972 bytes/sec)
 
Status
Not open for further replies.

Similar threads

J
  • Locked
Periodic Snapshots Not Happening
Replies
4
Views
936
Jason Hamilton
J
coulix
  • Locked
Snapshots not happening anymore
Replies
2
Views
831
coulix
coulix
J
Periodic Snapshot stuck in "Pending" status
Replies
2
Views
3K
jerryjharrison
J
A
  • Locked
Periodic Snapshots don't work after 9.3 upgrade
Replies
2
Views
921
Alan99
A
F
  • Locked
Help verifying periodic snapshots
2 3
Replies
40
Views
7K
FreeNASBob
F
Top