decryption problem after upgrade

Status
Not open for further replies.

tsf0x13

Dabbler
Joined
May 22, 2016
Messages
10
after upgrade from 11.0-U4 to 11.1-U1 I can't decrypt volume.
I get next errors

1. At Web console

Code:
Environment:

Software Version: FreeNAS-11.1-U1 (f7e246b8f)
Request Method: POST
Request URL: http://192.168.13.55/storage/volume/1/unlock/?X-Progress-ID=c6cdfc77-e383-40dd-85a8-00c33f410822


Traceback:
File "/usr/local/lib/python3.6/site-packages/django/core/handlers/exception.py" in inner
  42.			 response = get_response(request)
File "/usr/local/lib/python3.6/site-packages/django/core/handlers/base.py" in _legacy_get_response
  249.			 response = self._get_response(request)
File "/usr/local/lib/python3.6/site-packages/django/core/handlers/base.py" in _get_response
  178.			 response = middleware_method(request, callback, callback_args, callback_kwargs)
File "./freenasUI/freeadmin/middleware.py" in process_view
  162.		 return login_required(view_func)(request, *view_args, **view_kwargs)
File "/usr/local/lib/python3.6/site-packages/django/contrib/auth/decorators.py" in _wrapped_view
  23.				 return view_func(request, *args, **kwargs)
File "./freenasUI/storage/views.py" in volume_unlock
  1005.			 form.done(volume=volume)
File "./freenasUI/storage/forms.py" in done
  2792.			 raise MiddlewareError(msg)

Exception Type: MiddlewareError at /storage/volume/1/unlock/
Exception Value: [MiddlewareError: Volume could not be imported: 1 devices failed to decrypt]


at /var/log/message

Code:
root@freenas:~ # tail -n 50 /var/log/messages

Feb 17 17:18:45 freenas GEOM_ELI: Encryption: AES-XTS 256

Feb 17 17:18:45 freenas GEOM_ELI:	 Crypto: hardware

Feb 17 17:18:47 freenas GEOM_ELI: Device gptid/27e31ee3-55f5-11e7-9e8b-0cc47a89f7ec.eli created.

Feb 17 17:18:47 freenas GEOM_ELI: Encryption: AES-XTS 256

Feb 17 17:18:47 freenas GEOM_ELI:	 Crypto: hardware

Feb 17 17:18:50 freenas GEOM_ELI: Device gptid/28a1c985-55f5-11e7-9e8b-0cc47a89f7ec.eli created.

Feb 17 17:18:50 freenas GEOM_ELI: Encryption: AES-XTS 256

Feb 17 17:18:50 freenas GEOM_ELI:	 Crypto: hardware

Feb 17 17:18:52 freenas GEOM_ELI: Device gptid/6bb6abc4-5668-11e7-8649-0cc47a89f7ec.eli created.

Feb 17 17:18:52 freenas GEOM_ELI: Encryption: AES-XTS 256

Feb 17 17:18:52 freenas GEOM_ELI:	 Crypto: hardware

Feb 17 17:18:54 freenas GEOM_ELI: Device gptid/8b911d6b-68bf-11e7-b1d8-0cc47a89f7ec.eli created.

Feb 17 17:18:54 freenas GEOM_ELI: Encryption: AES-XTS 256

Feb 17 17:18:54 freenas GEOM_ELI:	 Crypto: hardware

Feb 17 17:18:56 freenas uwsgi: [middleware.exceptions:36] [MiddlewareError: Unable to geli attach gptid/ce2a3d8c-f927-11e7-a01a-0cc47a89f7ec: geli: Missing -p flag.

]

Feb 17 17:18:56 freenas uwsgi: [middleware.notifier:603] [MiddlewareError: Unable to geli attach gptid/ce2a3d8c-f927-11e7-a01a-0cc47a89f7ec: geli: Missing -p flag.

]

Feb 17 17:18:56 freenas GEOM_ELI: Device gptid/12d3f682-9cb1-11e7-b802-0cc47a89f7ec.eli created.

Feb 17 17:18:56 freenas GEOM_ELI: Encryption: AES-XTS 256

Feb 17 17:18:56 freenas GEOM_ELI:	 Crypto: hardware

Feb 17 17:18:57 freenas ZFS: vdev state changed, pool_guid=16192510302262910621 vdev_guid=6815957274998268511

Feb 17 17:18:57 freenas ZFS: vdev state changed, pool_guid=16192510302262910621 vdev_guid=9176704266986961701

Feb 17 17:18:57 freenas ZFS: vdev state changed, pool_guid=16192510302262910621 vdev_guid=3830063813981185436

Feb 17 17:18:57 freenas ZFS: vdev state changed, pool_guid=16192510302262910621 vdev_guid=7671228637717603417

Feb 17 17:18:57 freenas ZFS: vdev state changed, pool_guid=16192510302262910621 vdev_guid=3608714621435591507

Feb 17 17:18:57 freenas ZFS: vdev state changed, pool_guid=16192510302262910621 vdev_guid=4125778472356756426

Feb 17 17:18:57 freenas ZFS: vdev state changed, pool_guid=16192510302262910621 vdev_guid=7832945164792938758

Feb 17 17:18:57 freenas ZFS: vdev state changed, pool_guid=16192510302262910621 vdev_guid=10989567438496859891

Feb 17 17:18:57 freenas ZFS: vdev state changed, pool_guid=16192510302262910621 vdev_guid=206505426856901859

Feb 17 17:18:57 freenas ZFS: vdev state changed, pool_guid=16192510302262910621 vdev_guid=12025238781512328955

Feb 17 17:18:57 freenas ZFS: vdev state changed, pool_guid=16192510302262910621 vdev_guid=1413155218131044867

Feb 17 17:18:59 freenas ZFS: vdev state changed, pool_guid=16192510302262910621 vdev_guid=13379403156962506339

Feb 17 17:19:00 freenas ZFS: vdev state changed, pool_guid=16192510302262910621 vdev_guid=1413155218131044867

Feb 17 17:19:00 freenas ZFS: vdev state changed, pool_guid=16192510302262910621 vdev_guid=6815957274998268511

Feb 17 17:19:00 freenas ZFS: vdev state changed, pool_guid=16192510302262910621 vdev_guid=9176704266986961701

Feb 17 17:19:00 freenas ZFS: vdev state changed, pool_guid=16192510302262910621 vdev_guid=3830063813981185436

Feb 17 17:19:00 freenas ZFS: vdev state changed, pool_guid=16192510302262910621 vdev_guid=7671228637717603417

Feb 17 17:19:00 freenas ZFS: vdev state changed, pool_guid=16192510302262910621 vdev_guid=3608714621435591507

Feb 17 17:19:00 freenas ZFS: vdev state changed, pool_guid=16192510302262910621 vdev_guid=4125778472356756426

Feb 17 17:19:00 freenas ZFS: vdev state changed, pool_guid=16192510302262910621 vdev_guid=7832945164792938758

Feb 17 17:19:00 freenas ZFS: vdev state changed, pool_guid=16192510302262910621 vdev_guid=10989567438496859891

Feb 17 17:19:00 freenas ZFS: vdev state changed, pool_guid=16192510302262910621 vdev_guid=206505426856901859

Feb 17 17:19:00 freenas ZFS: vdev state changed, pool_guid=16192510302262910621 vdev_guid=12025238781512328955

Feb 17 17:19:00 freenas ZFS: vdev state changed, pool_guid=16192510302262910621 vdev_guid=1413155218131044867

Feb 17 17:19:03 freenas ZFS: vdev state changed, pool_guid=16192510302262910621 vdev_guid=13379403156962506339

Feb 17 17:19:03 freenas ZFS: vdev state changed, pool_guid=16192510302262910621 vdev_guid=1413155218131044867

Feb 17 17:19:03 freenas uwsgi: [middleware.notifier:2524] Importing vol1 [16192510302262910621] failed with: cannot import 'vol1': one or more devices is currently unavailable

Feb 17 17:19:03 freenas uwsgi: [middleware.exceptions:36] [MiddlewareError: Volume could not be imported: 1 devices failed to decrypt]

Feb 17 17:19:40 freenas daemon[3444]:	 2018/02/17 17:19:40 [WARN] agent: Check 'freenas_health' is now warning

root@freenas:~ #
 
Last edited:

tsf0x13

Dabbler
Joined
May 22, 2016
Messages
10
root@freenas:~ # camcontrol devlist

<
Code:
ATA ST8000AS0002-1NA RT17>		at scbus0 target 17 lun 0 (pass0,da0)

<ATA ST8000AS0002-1NA AR15>		at scbus0 target 18 lun 0 (pass1,da1)

<ATA ST8000AS0002-1NA AR17>		at scbus0 target 19 lun 0 (pass2,da2)

<ATA ST8000AS0002-1NA AR15>		at scbus0 target 20 lun 0 (pass3,da3)

<ATA ST8000AS0002-1NA AR17>		at scbus0 target 21 lun 0 (pass4,da4)

<ATA ST8000AS0002-1NA AR17>		at scbus0 target 22 lun 0 (pass5,da5)

<ATA ST8000AS0002-1NA AR17>		at scbus0 target 23 lun 0 (pass6,da6)

<ATA ST8000AS0002-1NA AR17>		at scbus0 target 24 lun 0 (pass7,da7)

<ATA ST8000AS0002-1NA AR13>		at scbus0 target 25 lun 0 (pass8,da8)

<ATA ST8000AS0002-1NA AR17>		at scbus0 target 26 lun 0 (pass9,da9)

<SATA SSD S9FM02.1>				at scbus1 target 0 lun 0 (ada0,pass10)

<TS128GSSD370S O0918B>			 at scbus5 target 0 lun 0 (ada1,pass11)

<INTEL SSDSC2BB080G4 D2010370>	 at scbus6 target 0 lun 0 (ada2,pass12)
 

tsf0x13

Dabbler
Joined
May 22, 2016
Messages
10
root@freenas:~ # /usr/local/bin/sqlite3 /data/freenas-v1.db "select * from storage_encrypteddisk;"

Code:
3|1|{serial_lunid}Z840GMVF_5000c50090e0d153|gptid/239cab3d-55f5-11e7-9e8b-0cc47a89f7ec

4|1|{serial_lunid}Z840AZJP_5000c50090eb2c48|gptid/244dab2d-55f5-11e7-9e8b-0cc47a89f7ec

5|1|{serial_lunid}Z840GMRW_5000c50090e0cd51|gptid/2516134a-55f5-11e7-9e8b-0cc47a89f7ec

6|1|{serial_lunid}Z840H8G0_5000c50090ef59ab|gptid/25c59603-55f5-11e7-9e8b-0cc47a89f7ec

7|1|{serial_lunid}Z840GTX9_5000c50090eb86ab|gptid/267f3cc6-55f5-11e7-9e8b-0cc47a89f7ec

8|1|{serial_lunid}Z840G731_5000c50090e22cc2|gptid/273440e5-55f5-11e7-9e8b-0cc47a89f7ec

9|1|{serial_lunid}Z840H15F_5000c50090ee8655|gptid/27e31ee3-55f5-11e7-9e8b-0cc47a89f7ec

10|1|{serial_lunid}Z8405P54_5000c5007b41f93a|gptid/28a1c985-55f5-11e7-9e8b-0cc47a89f7ec

12|1|{serial_lunid}Z840YA04_5000c500a1f4b208|gptid/6bb6abc4-5668-11e7-8649-0cc47a89f7ec

13|1|{serial}D333640007|gptid/8b911d6b-68bf-11e7-b1d8-0cc47a89f7ec

14|1|{serial_lunid}Z840XK5D_5000c5009397c2e9|gptid/12d3f682-9cb1-11e7-b802-0cc47a89f7ec

15|1||gptid/ce2a3d8c-f927-11e7-a01a-0cc47a89f7ec
 

tsf0x13

Dabbler
Joined
May 22, 2016
Messages
10
partially solved

at web GUI
detach [volume]
Import [volume] (choose case Yes, encrypted)
pause at step 3, switch to console

at console
zpool status
(see volume is okay but zil is error)
zpool import -m [volume]
zpool remove [volume] [guid broken zil]

now i can see my data, inside console but still don't see at webGUI
 

tsf0x13

Dabbler
Joined
May 22, 2016
Messages
10
Sorry, but not completely.
I decided to migrate to Oracle Solaris 11.3, because I don't want store data on the system, which destroy my RAID just after upgrade

My long and happy life with FreeNAS ended on upgrade from 11.0-U4 to 11.1-U1

At this moment I just won't do any reboot, just migrate data to temp datastore.
 
Last edited by a moderator:

Ericloewe

Server Wrangler
Moderator
Joined
Feb 15, 2014
Messages
20,194
I find the notion that any Oracle product will be reliable absolutely laughable, even if it is derived from the same codebase as OpenZFS.
 
Status
Not open for further replies.
Top