Asm Diskgroup Write Hang (Doc ID 2778839.1)

Last updated on APRIL 17, 2023

Applies to:

Symptoms

There was no response for a long time during copying file from filesystem to ASM diskgroup.

For Example:

Copy from the diskgroup to the file system will be successful.
[grid@nodeXvm01 ~]$ asmcmd cp
<diskgroup_name>/<db_unique_name>/datafile/<datafileXXXX>.506.1072871763 /tmp/t1
copying +<diskgroup_name>/<db_unique_name>/datafile/<datafileXXXX>.506.1072871763 -> /tmp/t1
[grid@nodeXvm01 ~]$

Copy from the file system to the diskgroup will be hung.
[grid@nodeXvm01 ~]$ asmcmd cp  /tmp/t1  +<diskgroup_name>/<db_unique_name>/datafile/t1
copying /tmp/t1 -> +<diskgroup_name>/<db_unique_name>/datafile/t1   <<<<<<<<<<< Hung


From hunganalyze trace of ASM instance.

Chain 3:
-------------------------------------------------------------------------------
    Oracle session identified by:
    {
                instance: 1 (+asm.+asm1)
                   os id: 172759
              process id: 42, oracle@nodeXvm01 (TNS V1-V3)
              session id: 791
        session serial #: 61476
             module name: 0 (oracle@nodeXvm01.xx.XXXX.oraclecloudat)
    }
    is waiting for 'kfk: async disk IO' with wait info:
    {
                      p1: 'count'=0xc
                      p2: 'where'=0x6
                      p3: 'timeout'=0xffffffff
                     px1: 'disk number'=0xe
                     px2: 'au'=0x6
                     px3: 'offset'=0x300000
            time in wait: 876 min 46 sec    <<<<<           timeout after: never
                 wait id: 59
                blocking: 0 sessions
          current sql_id: 0
             current sql: <none>
             short stack: ksedsts()+426<-ksdxfstk()+58<-ksdxcb()+872<-sspuser()+223<-__sighandler()<-__nanosleep()+16<-ossnet_execute_deferred_connect()+2367<-ossnet_connect_to_box()+591<-ossnet_reconnect_box_handle_int()+1736<-ossnet_vrpc_completion()+1800<-ossnet_process_netmsg_completion()+240<-ossnet_wait_all()+582<-ossnet_unified_wait()+346<-ossnet_wait_internal()+537<-ossnet_wait()+176<-ossnet_reopen_wait()+402<-ossnet_execute_deferred_connect()+1132<-ossnet_connect_to_box()+591<-ossnet_reconnect_box_handle_int()+1736<-ossnet_vrpc_co
            wait history:
              * time between current wait and wait #1: 0.000000 sec
              1.       event: 'ASM file metadata operation'
                 time waited: 0.000007 sec (last interval)
                 time waited: 0.056518 sec (total)
                     wait id: 31               p1: 'msgop'=0xb
                                               p2: 'locn'=0x1
              * time between wait #1 and #2: 0.000000 sec
              2.       event: 'CSS operation: action'
                 time waited: 0.000409 sec
                     wait id: 58               p1: 'function_id'=0x41
              * time between wait #2 and #3: 0.000000 sec
              3.       event: 'ASM file metadata operation'
                 time waited: 0.000003 sec (last interval)
                 time waited: 0.056102 sec (total)
                     wait id: 31               p1: 'msgop'=0xb
                                               p2: 'locn'=0x1
    }
 
Chain 3 Signature: 'kfk: async disk IO'
Chain 3 Signature Hash: 0x5069352

Changes

 N/A

Cause

My Oracle Support provides customers with access to over a million knowledge articles and a vibrant support community of peers and Oracle experts.