zfs crypto discuss - Jun 2008 - [Bug 2303] New: zvol_encrypt_001 hangs - zpool key -u

http://defect.opensolaris.org/bz/show_bug.cgi?id=2303

           Summary: zvol_encrypt_001 hangs - zpool key -u
    Classification: Development
           Product: zfs-crypto
           Version: unspecified
          Platform: Other
        OS/Version: Solaris
            Status: NEW
          Severity: major
          Priority: P2
         Component: other
        AssignedTo: darrenm at opensolaris.org
        ReportedBy: hua.tang at sun.com
         QAContact: hua.tang at sun.com
                CC: zfs-crypto-discuss at opensolaris.org
   Estimated Hours: 0.0


Test_Case_Start| 16744 tests/functional/crypto/encryption/zvol_encrypt_001 |
02:48:01 0 |
Msg| 16745 | ASSERTION:
Msg| 16745 |
/export/home/zfs-tests/proto/suites/zfs/tests/functional/crypto/encryption/zvol_encrypt_001
Msg| 16745 | DESCRIPTION:
Msg| 16745 | These tests verify data on an encrypted ZVOL is encrypted.
Encrypted data can be accessible with a key, while not without a key.
The encryption algorithms on, aes-128-cbc and aes-256-cbc are tested.
Msg| 16745 | INTERFACE:
Msg| 16745 | zpool,zfs
Msg| 16745 |  
stdout| 16745| 1: encryption=on
stdout| 16745| /usr/sbin/mkfile 1g /export/home/vdev_file_1
stdout| 16745| /usr/sbin/zpool create -f -o
keysource=hex,file:///export/home/zfs-tests/proto/suites/zfs/etc/hex_key_file
pool_16745_1 /export/home/vdev_file_1
stdout| 16745| /usr/sbin/zfs create -o encryption=on -V 200m pool_16745_1/vol_1
stdout| 16745| /usr/sbin/zpool create -f vol_pool_1
/dev/zvol/dsk/pool_16745_1/vol_1
stdout| 16745| cp /export/home/zfs-tests/proto/suites/zfs/etc/file1.txt
/vol_pool_1
stdout| 16745| cp /export/home/zfs-tests/proto/suites/zfs/etc/file2.txt
/vol_pool_1
stdout| 16745| cp /export/home/zfs-tests/proto/suites/zfs/etc/file3.txt
/vol_pool_1
stdout| 16745| cp /export/home/zfs-tests/proto/suites/zfs/etc/file4.txt
/vol_pool_1
stdout| 16745| cp /export/home/zfs-tests/proto/suites/zfs/etc/file5.txt
/vol_pool_1
stdout| 16745| cp /export/home/zfs-tests/proto/suites/zfs/etc/file6.txt
/vol_pool_1
stdout| 16745| cp /export/home/zfs-tests/proto/suites/zfs/etc/file7.txt
/vol_pool_1
stdout| 16745| cp /export/home/zfs-tests/proto/suites/zfs/etc/Hamlet.txt
/vol_pool_1
stdout| 16745| /usr/sbin/zpool export vol_pool_1
stdout| 16745| /usr/sbin/zpool export pool_16745_1
Msg| 16745 | [ - Progress ]
Msg| 16745 | Testing data on ZVOL is encrypted
Msg| 16745 |  
stdout| 16745| Checking data on the disk. It may take several minutes. Please
be patient.
Msg| 16745 | [ - Result ]
Msg| 16745 | RESULT:  PASS
Msg| 16745 |  
stdout| 16745| /usr/sbin/zpool import -d /export/home pool_16745_1
stdout| 16745| /usr/sbin/zpool import -d /dev/zvol/dsk/pool_16745_1 vol_pool_1
Msg| 16745 | [ - Progress ]
Msg| 16745 | Testing the file system on the encrypted ZVOL is accessible after
importing
Msg| 16745 |  
stdout| 16745| diff /export/home/zfs-tests/proto/suites/zfs/etc/file1.txt
/vol_pool_1/file1.txt
stdout| 16745| diff /export/home/zfs-tests/proto/suites/zfs/etc/file2.txt
/vol_pool_1/file2.txt
stdout| 16745| diff /export/home/zfs-tests/proto/suites/zfs/etc/file3.txt
/vol_pool_1/file3.txt
stdout| 16745| diff /export/home/zfs-tests/proto/suites/zfs/etc/file4.txt
/vol_pool_1/file4.txt
stdout| 16745| diff /export/home/zfs-tests/proto/suites/zfs/etc/file5.txt
/vol_pool_1/file5.txt
stdout| 16745| diff /export/home/zfs-tests/proto/suites/zfs/etc/file6.txt
/vol_pool_1/file6.txt
stdout| 16745| diff /export/home/zfs-tests/proto/suites/zfs/etc/file7.txt
/vol_pool_1/file7.txt
stdout| 16745| diff /export/home/zfs-tests/proto/suites/zfs/etc/Hamlet.txt
/vol_pool_1/Hamlet.txt
stdout| 16745| /usr/sbin/zpool key -u pool_16745_1

-- 
Configure bugmail: http://defect.opensolaris.org/bz/userprefs.cgi?tab=email
------- You are receiving this mail because: -------
You are on the CC list for the bug.

http://defect.opensolaris.org/bz/show_bug.cgi?id=2303


Darren J Moffat <darrenm at opensolaris.org> changed:

           What    |Removed                     |Added
----------------------------------------------------------------------------
             Status|NEW                         |INCOMPLETE




--- Comment #1 from Darren J Moffat <darrenm at opensolaris.org> 
2008-06-23 01:49:41 ---
The information in the bug doesn''t show any evidence of a hang.

How do you know it is hung ?  How is the test detecting a hang verses slowness
?

If we get a hang we MUST get a forced crash dump - in another window
"reboot
-d", if a "reboot -d" fails then force a crash dump using
"Stop-A sync" on
SPARC.

-- 
Configure bugmail: http://defect.opensolaris.org/bz/userprefs.cgi?tab=email
------- You are receiving this mail because: -------
You are on the CC list for the bug.

http://defect.opensolaris.org/bz/show_bug.cgi?id=2303


Grace <hua.tang at sun.com> changed:

           What    |Removed                     |Added
----------------------------------------------------------------------------
             Status|INCOMPLETE                  |NEW




--- Comment #2 from Grace <hua.tang at sun.com>  2008-06-24 01:26:16 ---
Running root test case:  tests/encryption/fs_encrypt_001 | PASS
Running root test case:  tests/encryption/zvol_encrypt_001 | 
process 101310 - timed out
poll failed
: Interrupted system call
errno=4
TIMED_OUT
Running root test case:  tests/encryption/snapshot_encrypt_001 |


This test case timed out. ''zpool key -u'' was the last command
and it was a long
period between ''zpool key -u'' and timeout, obviously it
wasn''t a slowness.

The forced core dumps are at:
/net/borg.sfbay/cube/builds/zfs-crypto-crash/2303/*.20.

# mdb -k *.20
Loading modules: [ unix genunix specfs dtrace ufs scsi_vhci sd pcisch ip hook
neti sctp arp usba fctl nca lofs zfs cpc random nfs fcip logindmux ptm sppp
]
> ::ptree
000000000184bdc0  sched
     0000060010165868  fsflush
     0000060010166498  pageout
     00000600101670c8  init
          0000030007d1c050  nfs4cbd
          0000030007d1cc80  nfsmapid
          0000060010590028  lockd
          00000600105a30f0  statd
          0000030007d18c88  java
          0000030007d198b8  devfsadm
          0000030007d164f0  fpsd
               00000300072ce068  fptest
          0000030007d17120  fmd
          0000030007d1e4e0  dtlogin
          00000600105a24c0  intrd
          0000030007d1b118  sendmail
          0000030007d318a0  sendmail
          0000030007d298a8  sshd
               0000030007d18058  sshd
                    0000030007d158c0  sshd
                         0000030007d33100  bash
                              0000030007d1f110  stf_execute
                                   0000030007d34c68  stf_execute
                                        00000300072cf8c8  stf_execute
                                             0000030007d14060  stf_execute
                                                  00000300072cec98  stf_timeout
                                                       0000030007d28048  
                                                       stf_jnl_context
                                                            00000300072d04f8  
                                                            zvol_encrypt_001

                                                                
0000030007d1a4e
                                                                 8  zpool
               0000030007d324d0  sshd
                    0000030007d2a4d8  sshd
                         0000030007d1d8b0  bash
                              000006001095f138  tail
          0000030007d28c78  syslogd
          00000600102070d0  automountd
               0000060010290018  automountd
          0000060010205870  cron
          0000030007d35898  inetd
          0000030007d30c70  smcboot
               0000030007d2b108  smcboot
               0000030007d30040  smcboot
          0000060010204010  utmpd
          0000060010590c58  ypbind    
          00000600103d8020  keyserv
          0000060010291878  in.routed
          00000600105a0030  in.ndpd
          0000030007d370f8  rpcbind
          00000600102930d8  rmvolmgr
          00000600105a0c60  hald
               00000600102924a8  hald-runner
                    00000600105924b8  hald-addon-cpufr
                    0000060010290c48  hald-addon-netwo
          00000600103d8c50  avahi-daemon-bri
          0000060010591888  dbus-daemon
          00000600105a1890  powerd
          00000600103db0e0  picld
          00000600103d9880  syseventd
          00000600105930e8  nscd
          00000600102064a0  kcfd
          0000060010204c40  dlmgmtd
          0000060010164c38  svc.configd
          0000060010164008  svc.startd
               0000030007d364c8  sh
               00000600103da4b0  sac
                    0000030007d34038  ttymon
> 0000030007d1a4e8::walk thread
30024115220
> 30024115220::threadlist -v
            ADDR             PROC              LWP CLS PRI            WCHAN
0000030024115220      30007d1a4e8      30008f040d8   1  59      3002772b3a2
  PC: cv_wait+0x5c    CMD: /usr/sbin/zpool key -u pool_102019_1
  stack pointer for thread 30024115220: 2a1008247d1
  [ 000002a1008247d1 cv_wait+0x5c() ]
    txg_wait_synced+0xf8()
    dsl_sync_task_group_wait+0x12c()
    dsl_sync_task_do+0x28()
    spa_history_log+0x5c()
    zfs_log_history+0x50()
    zfsdev_ioctl+0x1fc()
    fop_ioctl+0x58()
    ioctl+0x16c()
    syscall_trap32+0x1e8()
> $c
0xf00481e4(fff5e280, fff5e000, f0000000, fff78000, 3, 1)
client_handler+0x70(fff5e280, fff5e000, f0000000, fff78000, 3, 1)
client_handler+0x70(fff5e280, fff5e000, f0000000, fff78000, 3, 1)
client_handler+0x70(fff5e280, fff5e000, f0000000, fff78000, 3, 1)
client_handler+0x70(fff5e280, fff5e000, f0000000, fff78000, 3, 1)
client_handler+0x70(fff5e280, fff5e000, f0000000, fff78000, 3, 1)
client_handler+0x70(fff5e280, fff5e000, f0000000, fff78000, 3, 1)
client_handler+0x70(fff5e280, fff5e000, f0000000, fff78000, 3, 1)
client_handler+0x70(fff5e280, fff5e000, f0000000, fff78000, 3, 1)
client_handler+0x70(fff5e280, fff5e000, f0000000, fff78000, 3, 1)
client_handler+0x70(fff5e280, fff5e000, f0000000, fff78000, 3, 1)
client_handler+0x70(fff5e280, fff5e000, f0000000, fff78000, 3, 1)
client_handler+0x70(fff5e280, fff5e000, f0000000, fff78000, 3, 1)
client_handler+0x70(fff5e280, fff5e000, f0000000, fff78000, 3, 1)
client_handler+0x70(fff5e280, fff5e000, f0000000, fff78000, 3, 1)
client_handler+0x70(fff5e280, fff5e000, f0000000, fff78000, 3, 1)
client_handler+0x70(fff5e280, fff5e000, f0000000, fff78000, 3, 1)
client_handler+0x70(fff5e280, fff5e000, f0000000, fff78000, 3, 1)
client_handler+0x70(fff5e280, fff5e000, f0000000, fff78000, 3, 1)
client_handler+0x70(fff5e280, fff5e000, f0000000, fff78000, 3, 1)
client_handler+0x70(fff5e280, fff5e000, f0000000, fff78000, 3, 1)
client_handler+0x70(fff5e280, fff5e000, f0000000, fff78000, 3, 1)
client_handler+0x70(fff5e280, fff5e000, f0000000, fff78000, 3,
1)
>> More [<space>, <cr>, q, n, c, a] ?
-- 
Configure bugmail: http://defect.opensolaris.org/bz/userprefs.cgi?tab=email
------- You are receiving this mail because: -------
You are on the CC list for the bug.

http://defect.opensolaris.org/bz/show_bug.cgi?id=2303


Darren J Moffat <darrenm at opensolaris.org> changed:

           What    |Removed                     |Added
----------------------------------------------------------------------------
              Alias|                            |BUGSTER:6719747
             Status|NEW                         |CLOSED
         Resolution|                            |TRACKEDINBUGSTER




--- Comment #3 from Darren J Moffat <darrenm at opensolaris.org> 
2008-06-26 11:15:48 ---
BUGSTER:6719747

-- 
Configure bugmail: http://defect.opensolaris.org/bz/userprefs.cgi?tab=email
------- You are receiving this mail because: -------
You are on the CC list for the bug.

http://defect.opensolaris.org/bz/show_bug.cgi?id=2303


David Comay <David.Comay at Sun.COM> changed:

           What    |Removed                     |Added
----------------------------------------------------------------------------
  Status Whiteboard|                            |BugsterCR=6719747
                 CC|                            |David.Comay at Sun.COM




-- 
Configure bugmail: http://defect.opensolaris.org/bz/userprefs.cgi?tab=email
------- You are receiving this mail because: -------
You are on the CC list for the bug.