Linux Device Mapper development
 help / color / mirror / Atom feed
* rdac path failure - Sun 6140
@ 2009-08-13 18:50 Stewart Smith
  2009-08-13 19:42 ` Moger, Babu
  0 siblings, 1 reply; 9+ messages in thread
From: Stewart Smith @ 2009-08-13 18:50 UTC (permalink / raw)
  To: dm-devel

Hello All,

I am seeing many of these messages when my Sun 6140 array is under heavy I/O
device-mapper: multipath: Failing path 8:208.
device-mapper: multipath: Failing path 8:208.
device-mapper: multipath: Failing path 8:208.
device-mapper: multipath: Failing path 8:208.
device-mapper: multipath: Failing path 8:208.


I am running a Fedora 10 server, with two fiber connections to two
different switches.  Both controllers on the 6140 have one connection
to each switch as well.  The end result is that I see four paths to
each LUN.

When the volume is mounted and under significant load I see the
messages above every few seconds.  They seem to appear every
"no_path_retry" seconds.

The 6140 controller firmware is up to date at version 07.50.08.10 and
I have installed the latest firmware for my Emulex LPe11002 cards.  I
have reproduced the problem using both Cisco MDS and Brocade fiber
channel switches as well.

Using CAM, I have set the initiator Host Type to "Linux" at the
moment.  I have tried other options as well without success.

I have NOT installed the RDAC drivers from either Sun or LSI -
primarily because they do not seem to build on my Fedora 10 kernel.

Any ideas would be greatly appreciated!!!

configs and debugging multipathd output is below.





Kernel: 2.6.27.24-170.2.68.fc10.x86_64

# multipath -lll
vol1 (3600a0b800048335200001e5d48b68a9b) dm-1 SUN,CSM200_R
[size=12T][features=1 queue_if_no_path][hwhandler=1 rdac][rw]
\_ round-robin 0 [prio=6][active]
 \_ 5:0:1:2 sdj 8:144 [active][ready]
 \_ 2:0:1:2 sdn 8:208 [active][ready]
\_ round-robin 0 [prio=0][enabled]
 \_ 2:0:0:2 sdb 8:16  [active][ghost]
 \_ 5:0:0:2 sdd 8:48  [active][ghost]


# cat /etc/multipath.conf

blacklist {
        devnode "^sd[a-z][[0-9]*]"
        devnode "^(ram|raw|loop|fd|md|dm-|sr|scd|st)[0-9]*"
        devnode "^hd[a-z][0-9]*"
        devnode "^cciss!c[0-9]d[0-9](p[0-9]*)*"
}

defaults {
        udev_dir                /dev
        polling_interval        10
        selector                "round-robin 0"
        path_grouping_policy    multibus
        getuid_callout          "/sbin/scsi_id --whitelisted /dev/%n"
        prio                    alua
        path_checker            readsector0
        rr_min_io               100
        max_fds                 8192
        rr_weight               priorities
        failback                immediate
        no_path_retry           fail
        user_friendly_names     yes
}
devices {
        device {
                vendor                  "SUN"
                product                 "CSM200_R"
                product_blacklist       "Universal Xport"
                getuid_callout          "/sbin/scsi_id --whitelisted /dev/%n"
                features                "0"
                hardware_handler        "1 rdac"
                path_selector           "round-robin 0"
                path_grouping_policy    group_by_prio
                failback                immediate
                rr_weight               uniform
                no_path_retry           queue
                rr_min_io               1000
                path_checker            rdac
                prio                    rdac
        }
}

multipaths {
        multipath {
                wwid                    3600a0b800048335200001e5d48b68a9b
                alias                   vol1
                rr_weight               priorities
                no_path_retry           5
                rr_min_io               100
        }
}



# multipathd -d v3


Aug 13 14:48:53 | sdb: ownership set to vol1
Aug 13 14:48:53 | sdb: not found in pathvec
Aug 13 14:48:53 | sdb: mask = 0xc
Aug 13 14:48:53 | sdb: path checker = rdac (controller setting)
Aug 13 14:48:53 | sdb: state = 4
Aug 13 14:48:53 | sdb: rdac prio = 0
Aug 13 14:48:53 | sdd: ownership set to vol1
Aug 13 14:48:53 | sdd: not found in pathvec
Aug 13 14:48:53 | sdd: mask = 0xc
Aug 13 14:48:53 | sdd: path checker = rdac (controller setting)
Aug 13 14:48:53 | sdd: state = 4
Aug 13 14:48:53 | sdd: rdac prio = 0
Aug 13 14:48:53 | sdj: ownership set to vol1
Aug 13 14:48:53 | sdj: not found in pathvec
Aug 13 14:48:53 | sdj: mask = 0xc
Aug 13 14:48:53 | sdj: path checker = rdac (controller setting)
Aug 13 14:48:53 | sdj: state = 2
Aug 13 14:48:53 | sdj: rdac prio = 3
Aug 13 14:48:53 | sdn: ownership set to vol1
Aug 13 14:48:53 | sdn: not found in pathvec
Aug 13 14:48:53 | sdn: mask = 0xc
Aug 13 14:48:53 | sdn: path checker = rdac (controller setting)
Aug 13 14:48:53 | sdn: state = 2
Aug 13 14:48:53 | sdn: rdac prio = 3
Aug 13 14:48:53 | vol1: pgfailback = -2 (controller setting)
Aug 13 14:48:53 | vol1: pgpolicy = group_by_prio (controller setting)
Aug 13 14:48:53 | vol1: selector = round-robin 0 (controller setting)
Aug 13 14:48:53 | vol1: features = 0 (controller setting)
Aug 13 14:48:53 | vol1: hwhandler = 1 rdac (controller setting)
Aug 13 14:48:53 | vol1: rr_weight = 2 (LUN setting)
Aug 13 14:48:53 | vol1: minio = 100 (LUN setting)
Aug 13 14:48:53 | vol1: no_path_retry = 5 (multipath setting)
Aug 13 14:48:53 | pg_timeout = NONE (internal default)
Aug 13 14:48:53 | vol1: set ACT_CREATE (map does not exist)
create: vol1 (3600a0b800048335200001e5d48b68a9b) n/a SUN,CSM200_R
[size=12T][features=0][hwhandler=1 rdac][n/a]
\_ round-robin 0 [prio=6][undef]
 \_ 5:0:1:2 sdj 8:144 [undef][ready]
 \_ 2:0:1:2 sdn 8:208 [undef][ready]
\_ round-robin 0 [prio=0][undef]
 \_ 2:0:0:2 sdb 8:16 [undef][ghost]
 \_ 5:0:0:2 sdd 8:48 [undef][ghost]

^ permalink raw reply	[flat|nested] 9+ messages in thread

* RE: rdac path failure - Sun 6140
  2009-08-13 18:50 rdac path failure - Sun 6140 Stewart Smith
@ 2009-08-13 19:42 ` Moger, Babu
  2009-08-13 20:27   ` Stewart Smith
  0 siblings, 1 reply; 9+ messages in thread
From: Moger, Babu @ 2009-08-13 19:42 UTC (permalink / raw)
  To: device-mapper development

Do you have /var/log/messages file for this problem?

Thanks
Babu Moger 

> -----Original Message-----
> From: dm-devel-bounces@redhat.com [mailto:dm-devel-bounces@redhat.com] On
> Behalf Of Stewart Smith
> Sent: Thursday, August 13, 2009 1:51 PM
> To: dm-devel@redhat.com
> Subject: [dm-devel] rdac path failure - Sun 6140
> 
> Hello All,
> 
> I am seeing many of these messages when my Sun 6140 array is under heavy
> I/O
> device-mapper: multipath: Failing path 8:208.
> device-mapper: multipath: Failing path 8:208.
> device-mapper: multipath: Failing path 8:208.
> device-mapper: multipath: Failing path 8:208.
> device-mapper: multipath: Failing path 8:208.
> 
> 
> I am running a Fedora 10 server, with two fiber connections to two
> different switches.  Both controllers on the 6140 have one connection
> to each switch as well.  The end result is that I see four paths to
> each LUN.
> 
> When the volume is mounted and under significant load I see the
> messages above every few seconds.  They seem to appear every
> "no_path_retry" seconds.
> 
> The 6140 controller firmware is up to date at version 07.50.08.10 and
> I have installed the latest firmware for my Emulex LPe11002 cards.  I
> have reproduced the problem using both Cisco MDS and Brocade fiber
> channel switches as well.
> 
> Using CAM, I have set the initiator Host Type to "Linux" at the
> moment.  I have tried other options as well without success.
> 
> I have NOT installed the RDAC drivers from either Sun or LSI -
> primarily because they do not seem to build on my Fedora 10 kernel.
> 
> Any ideas would be greatly appreciated!!!
> 
> configs and debugging multipathd output is below.
> 
> 
> 
> 
> 
> Kernel: 2.6.27.24-170.2.68.fc10.x86_64
> 
> # multipath -lll
> vol1 (3600a0b800048335200001e5d48b68a9b) dm-1 SUN,CSM200_R
> [size=12T][features=1 queue_if_no_path][hwhandler=1 rdac][rw]
> \_ round-robin 0 [prio=6][active]
>  \_ 5:0:1:2 sdj 8:144 [active][ready]
>  \_ 2:0:1:2 sdn 8:208 [active][ready]
> \_ round-robin 0 [prio=0][enabled]
>  \_ 2:0:0:2 sdb 8:16  [active][ghost]
>  \_ 5:0:0:2 sdd 8:48  [active][ghost]
> 
> 
> # cat /etc/multipath.conf
> 
> blacklist {
>         devnode "^sd[a-z][[0-9]*]"
>         devnode "^(ram|raw|loop|fd|md|dm-|sr|scd|st)[0-9]*"
>         devnode "^hd[a-z][0-9]*"
>         devnode "^cciss!c[0-9]d[0-9](p[0-9]*)*"
> }
> 
> defaults {
>         udev_dir                /dev
>         polling_interval        10
>         selector                "round-robin 0"
>         path_grouping_policy    multibus
>         getuid_callout          "/sbin/scsi_id --whitelisted /dev/%n"
>         prio                    alua
>         path_checker            readsector0
>         rr_min_io               100
>         max_fds                 8192
>         rr_weight               priorities
>         failback                immediate
>         no_path_retry           fail
>         user_friendly_names     yes
> }
> devices {
>         device {
>                 vendor                  "SUN"
>                 product                 "CSM200_R"
>                 product_blacklist       "Universal Xport"
>                 getuid_callout          "/sbin/scsi_id --whitelisted
> /dev/%n"
>                 features                "0"
>                 hardware_handler        "1 rdac"
>                 path_selector           "round-robin 0"
>                 path_grouping_policy    group_by_prio
>                 failback                immediate
>                 rr_weight               uniform
>                 no_path_retry           queue
>                 rr_min_io               1000
>                 path_checker            rdac
>                 prio                    rdac
>         }
> }
> 
> multipaths {
>         multipath {
>                 wwid                    3600a0b800048335200001e5d48b68a9b
>                 alias                   vol1
>                 rr_weight               priorities
>                 no_path_retry           5
>                 rr_min_io               100
>         }
> }
> 
> 
> 
> # multipathd -d v3
> 
> 
> Aug 13 14:48:53 | sdb: ownership set to vol1
> Aug 13 14:48:53 | sdb: not found in pathvec
> Aug 13 14:48:53 | sdb: mask = 0xc
> Aug 13 14:48:53 | sdb: path checker = rdac (controller setting)
> Aug 13 14:48:53 | sdb: state = 4
> Aug 13 14:48:53 | sdb: rdac prio = 0
> Aug 13 14:48:53 | sdd: ownership set to vol1
> Aug 13 14:48:53 | sdd: not found in pathvec
> Aug 13 14:48:53 | sdd: mask = 0xc
> Aug 13 14:48:53 | sdd: path checker = rdac (controller setting)
> Aug 13 14:48:53 | sdd: state = 4
> Aug 13 14:48:53 | sdd: rdac prio = 0
> Aug 13 14:48:53 | sdj: ownership set to vol1
> Aug 13 14:48:53 | sdj: not found in pathvec
> Aug 13 14:48:53 | sdj: mask = 0xc
> Aug 13 14:48:53 | sdj: path checker = rdac (controller setting)
> Aug 13 14:48:53 | sdj: state = 2
> Aug 13 14:48:53 | sdj: rdac prio = 3
> Aug 13 14:48:53 | sdn: ownership set to vol1
> Aug 13 14:48:53 | sdn: not found in pathvec
> Aug 13 14:48:53 | sdn: mask = 0xc
> Aug 13 14:48:53 | sdn: path checker = rdac (controller setting)
> Aug 13 14:48:53 | sdn: state = 2
> Aug 13 14:48:53 | sdn: rdac prio = 3
> Aug 13 14:48:53 | vol1: pgfailback = -2 (controller setting)
> Aug 13 14:48:53 | vol1: pgpolicy = group_by_prio (controller setting)
> Aug 13 14:48:53 | vol1: selector = round-robin 0 (controller setting)
> Aug 13 14:48:53 | vol1: features = 0 (controller setting)
> Aug 13 14:48:53 | vol1: hwhandler = 1 rdac (controller setting)
> Aug 13 14:48:53 | vol1: rr_weight = 2 (LUN setting)
> Aug 13 14:48:53 | vol1: minio = 100 (LUN setting)
> Aug 13 14:48:53 | vol1: no_path_retry = 5 (multipath setting)
> Aug 13 14:48:53 | pg_timeout = NONE (internal default)
> Aug 13 14:48:53 | vol1: set ACT_CREATE (map does not exist)
> create: vol1 (3600a0b800048335200001e5d48b68a9b) n/a SUN,CSM200_R
> [size=12T][features=0][hwhandler=1 rdac][n/a]
> \_ round-robin 0 [prio=6][undef]
>  \_ 5:0:1:2 sdj 8:144 [undef][ready]
>  \_ 2:0:1:2 sdn 8:208 [undef][ready]
> \_ round-robin 0 [prio=0][undef]
>  \_ 2:0:0:2 sdb 8:16 [undef][ghost]
>  \_ 5:0:0:2 sdd 8:48 [undef][ghost]
> 
> --
> dm-devel mailing list
> dm-devel@redhat.com
> https://www.redhat.com/mailman/listinfo/dm-devel

^ permalink raw reply	[flat|nested] 9+ messages in thread

* Re: rdac path failure - Sun 6140
  2009-08-13 19:42 ` Moger, Babu
@ 2009-08-13 20:27   ` Stewart Smith
  2009-08-13 20:34     ` Stewart Smith
  0 siblings, 1 reply; 9+ messages in thread
From: Stewart Smith @ 2009-08-13 20:27 UTC (permalink / raw)
  To: device-mapper development


[-- Attachment #1.1: Type: text/plain, Size: 7913 bytes --]

after a fresh, multipath -F and start of multipathd with -v 2 I see the
following messages.

After starting multipathd I mounted /dev/mapper/vol1 and generated some
simple I/O to it using dd


Aug 13 16:23:14.888 localhost kernel: device-mapper: multipath: Failing path
8:208.
Aug 13 16:23:14.000 localhost multipathd: 8:208: mark as failed
Aug 13 16:23:16.000 localhost multipathd: 8:208: reinstated
Aug 13 16:23:30.462 localhost kernel: device-mapper: multipath: Failing path
8:208.
Aug 13 16:23:30.000 localhost multipathd: 8:208: mark as failed
Aug 13 16:23:39.000 localhost multipathd: 8:208: reinstated
Aug 13 16:23:46.430 localhost kernel: device-mapper: multipath: Failing path
8:208.
Aug 13 16:23:46.000 localhost multipathd: 8:208: mark as failed
Aug 13 16:23:51.041 localhost kernel: device-mapper: multipath: Failing path
8:208.
Aug 13 16:23:51.000 localhost multipathd: 8:208: mark as failed
Aug 13 16:23:59.000 localhost multipathd: 8:208: reinstated
Aug 13 16:24:06.465 localhost kernel: device-mapper: multipath: Failing path
8:208.
Aug 13 16:24:06.000 localhost multipathd: 8:208: mark as failed
Aug 13 16:24:09.000 localhost multipathd: 8:208: reinstated


Thanks,
--
Stew




On Thu, Aug 13, 2009 at 12:42 PM, Moger, Babu <Babu.Moger@lsi.com> wrote:

> Do you have /var/log/messages file for this problem?
>
> Thanks
> Babu Moger
>
> > -----Original Message-----
> > From: dm-devel-bounces@redhat.com [mailto:dm-devel-bounces@redhat.com]
> On
> > Behalf Of Stewart Smith
> > Sent: Thursday, August 13, 2009 1:51 PM
> > To: dm-devel@redhat.com
> > Subject: [dm-devel] rdac path failure - Sun 6140
> >
> > Hello All,
> >
> > I am seeing many of these messages when my Sun 6140 array is under heavy
> > I/O
> > device-mapper: multipath: Failing path 8:208.
> > device-mapper: multipath: Failing path 8:208.
> > device-mapper: multipath: Failing path 8:208.
> > device-mapper: multipath: Failing path 8:208.
> > device-mapper: multipath: Failing path 8:208.
> >
> >
> > I am running a Fedora 10 server, with two fiber connections to two
> > different switches.  Both controllers on the 6140 have one connection
> > to each switch as well.  The end result is that I see four paths to
> > each LUN.
> >
> > When the volume is mounted and under significant load I see the
> > messages above every few seconds.  They seem to appear every
> > "no_path_retry" seconds.
> >
> > The 6140 controller firmware is up to date at version 07.50.08.10 and
> > I have installed the latest firmware for my Emulex LPe11002 cards.  I
> > have reproduced the problem using both Cisco MDS and Brocade fiber
> > channel switches as well.
> >
> > Using CAM, I have set the initiator Host Type to "Linux" at the
> > moment.  I have tried other options as well without success.
> >
> > I have NOT installed the RDAC drivers from either Sun or LSI -
> > primarily because they do not seem to build on my Fedora 10 kernel.
> >
> > Any ideas would be greatly appreciated!!!
> >
> > configs and debugging multipathd output is below.
> >
> >
> >
> >
> >
> > Kernel: 2.6.27.24-170.2.68.fc10.x86_64
> >
> > # multipath -lll
> > vol1 (3600a0b800048335200001e5d48b68a9b) dm-1 SUN,CSM200_R
> > [size=12T][features=1 queue_if_no_path][hwhandler=1 rdac][rw]
> > \_ round-robin 0 [prio=6][active]
> >  \_ 5:0:1:2 sdj 8:144 [active][ready]
> >  \_ 2:0:1:2 sdn 8:208 [active][ready]
> > \_ round-robin 0 [prio=0][enabled]
> >  \_ 2:0:0:2 sdb 8:16  [active][ghost]
> >  \_ 5:0:0:2 sdd 8:48  [active][ghost]
> >
> >
> > # cat /etc/multipath.conf
> >
> > blacklist {
> >         devnode "^sd[a-z][[0-9]*]"
> >         devnode "^(ram|raw|loop|fd|md|dm-|sr|scd|st)[0-9]*"
> >         devnode "^hd[a-z][0-9]*"
> >         devnode "^cciss!c[0-9]d[0-9](p[0-9]*)*"
> > }
> >
> > defaults {
> >         udev_dir                /dev
> >         polling_interval        10
> >         selector                "round-robin 0"
> >         path_grouping_policy    multibus
> >         getuid_callout          "/sbin/scsi_id --whitelisted /dev/%n"
> >         prio                    alua
> >         path_checker            readsector0
> >         rr_min_io               100
> >         max_fds                 8192
> >         rr_weight               priorities
> >         failback                immediate
> >         no_path_retry           fail
> >         user_friendly_names     yes
> > }
> > devices {
> >         device {
> >                 vendor                  "SUN"
> >                 product                 "CSM200_R"
> >                 product_blacklist       "Universal Xport"
> >                 getuid_callout          "/sbin/scsi_id --whitelisted
> > /dev/%n"
> >                 features                "0"
> >                 hardware_handler        "1 rdac"
> >                 path_selector           "round-robin 0"
> >                 path_grouping_policy    group_by_prio
> >                 failback                immediate
> >                 rr_weight               uniform
> >                 no_path_retry           queue
> >                 rr_min_io               1000
> >                 path_checker            rdac
> >                 prio                    rdac
> >         }
> > }
> >
> > multipaths {
> >         multipath {
> >                 wwid                    3600a0b800048335200001e5d48b68a9b
> >                 alias                   vol1
> >                 rr_weight               priorities
> >                 no_path_retry           5
> >                 rr_min_io               100
> >         }
> > }
> >
> >
> >
> > # multipathd -d v3
> >
> >
> > Aug 13 14:48:53 | sdb: ownership set to vol1
> > Aug 13 14:48:53 | sdb: not found in pathvec
> > Aug 13 14:48:53 | sdb: mask = 0xc
> > Aug 13 14:48:53 | sdb: path checker = rdac (controller setting)
> > Aug 13 14:48:53 | sdb: state = 4
> > Aug 13 14:48:53 | sdb: rdac prio = 0
> > Aug 13 14:48:53 | sdd: ownership set to vol1
> > Aug 13 14:48:53 | sdd: not found in pathvec
> > Aug 13 14:48:53 | sdd: mask = 0xc
> > Aug 13 14:48:53 | sdd: path checker = rdac (controller setting)
> > Aug 13 14:48:53 | sdd: state = 4
> > Aug 13 14:48:53 | sdd: rdac prio = 0
> > Aug 13 14:48:53 | sdj: ownership set to vol1
> > Aug 13 14:48:53 | sdj: not found in pathvec
> > Aug 13 14:48:53 | sdj: mask = 0xc
> > Aug 13 14:48:53 | sdj: path checker = rdac (controller setting)
> > Aug 13 14:48:53 | sdj: state = 2
> > Aug 13 14:48:53 | sdj: rdac prio = 3
> > Aug 13 14:48:53 | sdn: ownership set to vol1
> > Aug 13 14:48:53 | sdn: not found in pathvec
> > Aug 13 14:48:53 | sdn: mask = 0xc
> > Aug 13 14:48:53 | sdn: path checker = rdac (controller setting)
> > Aug 13 14:48:53 | sdn: state = 2
> > Aug 13 14:48:53 | sdn: rdac prio = 3
> > Aug 13 14:48:53 | vol1: pgfailback = -2 (controller setting)
> > Aug 13 14:48:53 | vol1: pgpolicy = group_by_prio (controller setting)
> > Aug 13 14:48:53 | vol1: selector = round-robin 0 (controller setting)
> > Aug 13 14:48:53 | vol1: features = 0 (controller setting)
> > Aug 13 14:48:53 | vol1: hwhandler = 1 rdac (controller setting)
> > Aug 13 14:48:53 | vol1: rr_weight = 2 (LUN setting)
> > Aug 13 14:48:53 | vol1: minio = 100 (LUN setting)
> > Aug 13 14:48:53 | vol1: no_path_retry = 5 (multipath setting)
> > Aug 13 14:48:53 | pg_timeout = NONE (internal default)
> > Aug 13 14:48:53 | vol1: set ACT_CREATE (map does not exist)
> > create: vol1 (3600a0b800048335200001e5d48b68a9b) n/a SUN,CSM200_R
> > [size=12T][features=0][hwhandler=1 rdac][n/a]
> > \_ round-robin 0 [prio=6][undef]
> >  \_ 5:0:1:2 sdj 8:144 [undef][ready]
> >  \_ 2:0:1:2 sdn 8:208 [undef][ready]
> > \_ round-robin 0 [prio=0][undef]
> >  \_ 2:0:0:2 sdb 8:16 [undef][ghost]
> >  \_ 5:0:0:2 sdd 8:48 [undef][ghost]
> >
> > --
> > dm-devel mailing list
> > dm-devel@redhat.com
> > https://www.redhat.com/mailman/listinfo/dm-devel
>
> --
> dm-devel mailing list
> dm-devel@redhat.com
> https://www.redhat.com/mailman/listinfo/dm-devel
>

[-- Attachment #1.2: Type: text/html, Size: 10095 bytes --]

[-- Attachment #2: Type: text/plain, Size: 0 bytes --]



^ permalink raw reply	[flat|nested] 9+ messages in thread

* Re: rdac path failure - Sun 6140
  2009-08-13 20:27   ` Stewart Smith
@ 2009-08-13 20:34     ` Stewart Smith
  2009-08-14  0:05       ` Moger, Babu
  0 siblings, 1 reply; 9+ messages in thread
From: Stewart Smith @ 2009-08-13 20:34 UTC (permalink / raw)
  To: device-mapper development


[-- Attachment #1.1: Type: text/plain, Size: 16401 bytes --]

Same sequence of events, with multipathd -v3

Aug 13 16:28:48.627  kernel: device-mapper: multipath: Failing path 8:208.
Aug 13 16:28:48.000  multipathd: vol1: rr_weight = 2 (LUN setting)
Aug 13 16:28:48.000  multipathd: vol1: pgfailback = -2 (controller setting)
Aug 13 16:28:48.000  multipathd: pg_timeout = NONE (internal default)
Aug 13 16:28:48.000  multipathd: 8:208: mark as failed
Aug 13 16:28:48.000  multipathd: uevent 'change' from
'/devices/virtual/block/dm-1'
Aug 13 16:28:48.000  multipathd: UDEV_LOG=3
Aug 13 16:28:48.000  multipathd: ACTION=change
Aug 13 16:28:48.000  multipathd: DEVPATH=/devices/virtual/block/dm-1
Aug 13 16:28:48.000  multipathd: SUBSYSTEM=block
Aug 13 16:28:48.000  multipathd: DM_TARGET=multipath
Aug 13 16:28:48.000  multipathd: DM_ACTION=PATH_FAILED
Aug 13 16:28:48.000  multipathd: DM_SEQNUM=1
Aug 13 16:28:48.000  multipathd: DM_PATH=8:208
Aug 13 16:28:48.000  multipathd: DM_NR_VALID_PATHS=3
Aug 13 16:28:48.000  multipathd: DM_NAME=vol1
Aug 13 16:28:48.000  multipathd:
DM_UUID=mpath-3600a0b800048335200001e5d48b68a9b
Aug 13 16:28:48.000  multipathd: MAJOR=253
Aug 13 16:28:48.000  multipathd: MINOR=1
Aug 13 16:28:48.000  multipathd: DEVTYPE=disk
Aug 13 16:28:48.000  multipathd: SEQNUM=1738
Aug 13 16:28:48.000  multipathd: UDEVD_EVENT=1
Aug 13 16:28:48.000  multipathd: DEVNAME=/dev/dm-1
Aug 13 16:28:50.000  multipathd: 8:208: reinstated
Aug 13 16:28:50.000  multipathd: vol1: remaining active paths: 4
Aug 13 16:28:50.000  multipathd: sdj: rdac prio = 3
Aug 13 16:28:50.000  multipathd: sdn: rdac prio = 3
Aug 13 16:28:50.000  multipathd: sdb: rdac prio = 0
Aug 13 16:28:50.000  multipathd: sdd: rdac prio = 0
Aug 13 16:28:50.763  kernel: device-mapper: multipath: Failing path 8:208.
Aug 13 16:28:50.000  multipathd: uevent 'change' from
'/devices/virtual/block/dm-1'
Aug 13 16:28:50.000  multipathd: UDEV_LOG=3
Aug 13 16:28:50.000  multipathd: ACTION=change
Aug 13 16:28:50.000  multipathd: DEVPATH=/devices/virtual/block/dm-1
Aug 13 16:28:50.000  multipathd: SUBSYSTEM=block
Aug 13 16:28:50.000  multipathd: DM_TARGET=multipath
Aug 13 16:28:50.000  multipathd: DM_ACTION=PATH_REINSTATED
Aug 13 16:28:50.000  multipathd: DM_SEQNUM=2
Aug 13 16:28:50.000  multipathd: DM_PATH=8:208
Aug 13 16:28:50.000  multipathd: DM_NR_VALID_PATHS=4
Aug 13 16:28:50.000  multipathd: DM_NAME=vol1
Aug 13 16:28:50.000  multipathd:
DM_UUID=mpath-3600a0b800048335200001e5d48b68a9b
Aug 13 16:28:50.000  multipathd: MAJOR=253
Aug 13 16:28:50.000  multipathd: MINOR=1
Aug 13 16:28:50.000  multipathd: DEVTYPE=diskAug 13 16:28:50.000
 multipathd: SEQNUM=1739Aug 13 16:28:50.000  multipathd: UDEVD_EVENT=1
Aug 13 16:28:50.000  multipathd: vol1: rr_weight = 2 (LUN setting)
Aug 13 16:28:50.000  multipathd: vol1: pgfailback = -2 (controller setting)
Aug 13 16:28:50.000  multipathd: pg_timeout = NONE (internal default)
Aug 13 16:28:50.000  multipathd: 8:208: mark as failed
Aug 13 16:28:50.000  multipathd: vol1: remaining active paths: 3
Aug 13 16:28:50.000  multipathd: vol1: rr_weight = 2 (LUN setting)
Aug 13 16:28:50.000  multipathd: vol1: pgfailback = -2 (controller setting)
Aug 13 16:28:50.000  multipathd: uevent 'change' from
'/devices/virtual/block/dm-1'
Aug 13 16:28:50.000  multipathd: UDEV_LOG=3
Aug 13 16:28:50.000  multipathd: ACTION=change
Aug 13 16:28:50.000  multipathd: DEVPATH=/devices/virtual/block/dm-1
Aug 13 16:28:50.000  multipathd: SUBSYSTEM=block
Aug 13 16:28:50.000  multipathd: DM_TARGET=multipath
Aug 13 16:28:50.000  multipathd: DM_ACTION=PATH_FAILED
Aug 13 16:28:50.000  multipathd: DM_SEQNUM=3
Aug 13 16:28:50.000  multipathd: DM_PATH=8:208
Aug 13 16:28:50.000  multipathd: DM_NR_VALID_PATHS=3
Aug 13 16:28:50.000  multipathd: DM_NAME=vol1
Aug 13 16:28:50.000  multipathd:
DM_UUID=mpath-3600a0b800048335200001e5d48b68a9b
Aug 13 16:28:50.000  multipathd: MAJOR=253
Aug 13 16:28:50.000  multipathd: MINOR=1
Aug 13 16:28:50.000  multipathd: DEVTYPE=disk
Aug 13 16:28:50.000  multipathd: SEQNUM=1740
Aug 13 16:28:50.000  multipathd: UDEVD_EVENT=1
Aug 13 16:28:50.000  multipathd: DEVNAME=/dev/dm-1
Aug 13 16:29:00.000  multipathd: 8:208: reinstated
Aug 13 16:29:00.000  multipathd: vol1: remaining active paths: 4
Aug 13 16:29:00.000  multipathd: sdj: rdac prio = 3
Aug 13 16:29:00.000  multipathd: sdn: rdac prio = 3
Aug 13 16:29:00.000  multipathd: sdb: rdac prio = 0
Aug 13 16:29:00.000  multipathd: sdd: rdac prio = 0
Aug 13 16:29:00.000  multipathd: vol1: rr_weight = 2 (LUN setting)
Aug 13 16:29:00.000  multipathd: vol1: pgfailback = -2 (controller setting)
Aug 13 16:29:00.000  multipathd: uevent 'change' from
'/devices/virtual/block/dm-1'
Aug 13 16:29:00.000  multipathd: UDEV_LOG=3
Aug 13 16:29:00.000  multipathd: ACTION=change
Aug 13 16:29:00.000  multipathd: DEVPATH=/devices/virtual/block/dm-1
Aug 13 16:29:00.000  multipathd: SUBSYSTEM=block
Aug 13 16:29:00.000  multipathd: DM_TARGET=multipath
Aug 13 16:29:00.000  multipathd: DM_ACTION=PATH_REINSTATED
Aug 13 16:29:00.000  multipathd: DM_SEQNUM=4
Aug 13 16:29:00.000  multipathd: DM_PATH=8:208
Aug 13 16:29:00.000  multipathd: DM_NR_VALID_PATHS=4
Aug 13 16:29:00.000  multipathd: DM_NAME=vol1
Aug 13 16:29:00.000  multipathd:
DM_UUID=mpath-3600a0b800048335200001e5d48b68a9b
Aug 13 16:29:00.000  multipathd: MAJOR=253
Aug 13 16:29:00.000  multipathd: MINOR=1
Aug 13 16:29:00.000  multipathd: DEVTYPE=disk
Aug 13 16:29:00.000  multipathd: SEQNUM=1741
Aug 13 16:29:00.000  multipathd: UDEVD_EVENT=1
Aug 13 16:29:00.000  multipathd: DEVNAME=/dev/dm-1
Aug 13 16:29:02.753  kernel: device-mapper: multipath: Failing path 8:208.
Aug 13 16:29:02.000  multipathd: vol1: rr_weight = 2 (LUN setting)
Aug 13 16:29:02.000  multipathd: vol1: pgfailback = -2 (controller setting)
Aug 13 16:29:02.000  multipathd: pg_timeout = NONE (internal default)
Aug 13 16:29:02.000  multipathd: 8:208: mark as failed
Aug 13 16:29:02.000  multipathd: uevent 'change' from
'/devices/virtual/block/dm-1'
Aug 13 16:29:02.000  multipathd: UDEV_LOG=3
Aug 13 16:29:02.000  multipathd: ACTION=change
Aug 13 16:29:02.000  multipathd: DEVPATH=/devices/virtual/block/dm-1
Aug 13 16:29:02.000  multipathd: SUBSYSTEM=block
Aug 13 16:29:02.000  multipathd: DM_TARGET=multipath
Aug 13 16:29:02.000  multipathd: DM_ACTION=PATH_FAILED
Aug 13 16:29:02.000  multipathd: DM_SEQNUM=5
Aug 13 16:29:02.000  multipathd: DM_PATH=8:208
Aug 13 16:29:02.000  multipathd: DM_NR_VALID_PATHS=3
Aug 13 16:29:02.000  multipathd: DM_NAME=vol1
Aug 13 16:29:02.000  multipathd:
DM_UUID=mpath-3600a0b800048335200001e5d48b68a9b
Aug 13 16:29:02.000  multipathd: MAJOR=253
Aug 13 16:29:02.000  multipathd: MINOR=1
Aug 13 16:29:02.000  multipathd: DEVTYPE=disk
Aug 13 16:29:02.000  multipathd: SEQNUM=1742
Aug 13 16:29:02.000  multipathd: UDEVD_EVENT=1
Aug 13 16:29:02.000  multipathd: DEVNAME=/dev/dm-1
Aug 13 16:29:10.000  multipathd: 8:208: reinstated
Aug 13 16:29:10.000  multipathd: vol1: remaining active paths: 4
Aug 13 16:29:10.000  multipathd: sdj: rdac prio = 3
Aug 13 16:29:10.000  multipathd: sdn: rdac prio = 3
Aug 13 16:29:10.000  multipathd: sdb: rdac prio = 0
Aug 13 16:29:10.000  multipathd: sdd: rdac prio = 0
Aug 13 16:29:10.000  multipathd: vol1: rr_weight = 2 (LUN setting)
Aug 13 16:29:10.000  multipathd: vol1: pgfailback = -2 (controller setting)
Aug 13 16:29:10.000  multipathd: uevent 'change' from
'/devices/virtual/block/dm-1'
Aug 13 16:29:10.000  multipathd: UDEV_LOG=3
Aug 13 16:29:10.000  multipathd: ACTION=change
Aug 13 16:29:10.000  multipathd: DEVPATH=/devices/virtual/block/dm-1
Aug 13 16:29:10.000  multipathd: SUBSYSTEM=block
Aug 13 16:29:10.000  multipathd: DM_TARGET=multipath
Aug 13 16:29:10.000  multipathd: DM_ACTION=PATH_REINSTATED
Aug 13 16:29:10.000  multipathd: DM_SEQNUM=6
Aug 13 16:29:10.000  multipathd: DM_PATH=8:208
Aug 13 16:29:10.000  multipathd: DM_NR_VALID_PATHS=4
Aug 13 16:29:10.000  multipathd: DM_NAME=vol1
Aug 13 16:29:10.000  multipathd:
DM_UUID=mpath-3600a0b800048335200001e5d48b68a9b
Aug 13 16:29:10.000  multipathd: MAJOR=253
Aug 13 16:29:10.000  multipathd: MINOR=1
Aug 13 16:29:10.000  multipathd: DEVTYPE=disk
Aug 13 16:29:10.000  multipathd: SEQNUM=1743
Aug 13 16:29:10.000  multipathd: UDEVD_EVENT=1
Aug 13 16:29:10.000  multipathd: DEVNAME=/dev/dm-1





On Thu, Aug 13, 2009 at 1:27 PM, Stewart Smith <stew@cleepdar.com> wrote:

>
> after a fresh, multipath -F and start of multipathd with -v 2 I see the
> following messages.
>
> After starting multipathd I mounted /dev/mapper/vol1 and generated some
> simple I/O to it using dd
>
>
> Aug 13 16:23:14.888 localhost kernel: device-mapper: multipath: Failing
> path 8:208.
> Aug 13 16:23:14.000 localhost multipathd: 8:208: mark as failed
> Aug 13 16:23:16.000 localhost multipathd: 8:208: reinstated
> Aug 13 16:23:30.462 localhost kernel: device-mapper: multipath: Failing
> path 8:208.
> Aug 13 16:23:30.000 localhost multipathd: 8:208: mark as failed
> Aug 13 16:23:39.000 localhost multipathd: 8:208: reinstated
> Aug 13 16:23:46.430 localhost kernel: device-mapper: multipath: Failing
> path 8:208.
> Aug 13 16:23:46.000 localhost multipathd: 8:208: mark as failed
> Aug 13 16:23:51.041 localhost kernel: device-mapper: multipath: Failing
> path 8:208.
> Aug 13 16:23:51.000 localhost multipathd: 8:208: mark as failed
> Aug 13 16:23:59.000 localhost multipathd: 8:208: reinstated
> Aug 13 16:24:06.465 localhost kernel: device-mapper: multipath: Failing
> path 8:208.
> Aug 13 16:24:06.000 localhost multipathd: 8:208: mark as failed
> Aug 13 16:24:09.000 localhost multipathd: 8:208: reinstated
>
>
> Thanks,
> --
> Stew
>
>
>
>
> On Thu, Aug 13, 2009 at 12:42 PM, Moger, Babu <Babu.Moger@lsi.com> wrote:
>
>> Do you have /var/log/messages file for this problem?
>>
>> Thanks
>> Babu Moger
>>
>> > -----Original Message-----
>> > From: dm-devel-bounces@redhat.com [mailto:dm-devel-bounces@redhat.com]
>> On
>> > Behalf Of Stewart Smith
>> > Sent: Thursday, August 13, 2009 1:51 PM
>> > To: dm-devel@redhat.com
>> > Subject: [dm-devel] rdac path failure - Sun 6140
>> >
>> > Hello All,
>> >
>> > I am seeing many of these messages when my Sun 6140 array is under heavy
>> > I/O
>> > device-mapper: multipath: Failing path 8:208.
>> > device-mapper: multipath: Failing path 8:208.
>> > device-mapper: multipath: Failing path 8:208.
>> > device-mapper: multipath: Failing path 8:208.
>> > device-mapper: multipath: Failing path 8:208.
>> >
>> >
>> > I am running a Fedora 10 server, with two fiber connections to two
>> > different switches.  Both controllers on the 6140 have one connection
>> > to each switch as well.  The end result is that I see four paths to
>> > each LUN.
>> >
>> > When the volume is mounted and under significant load I see the
>> > messages above every few seconds.  They seem to appear every
>> > "no_path_retry" seconds.
>> >
>> > The 6140 controller firmware is up to date at version 07.50.08.10 and
>> > I have installed the latest firmware for my Emulex LPe11002 cards.  I
>> > have reproduced the problem using both Cisco MDS and Brocade fiber
>> > channel switches as well.
>> >
>> > Using CAM, I have set the initiator Host Type to "Linux" at the
>> > moment.  I have tried other options as well without success.
>> >
>> > I have NOT installed the RDAC drivers from either Sun or LSI -
>> > primarily because they do not seem to build on my Fedora 10 kernel.
>> >
>> > Any ideas would be greatly appreciated!!!
>> >
>> > configs and debugging multipathd output is below.
>> >
>> >
>> >
>> >
>> >
>> > Kernel: 2.6.27.24-170.2.68.fc10.x86_64
>> >
>> > # multipath -lll
>> > vol1 (3600a0b800048335200001e5d48b68a9b) dm-1 SUN,CSM200_R
>> > [size=12T][features=1 queue_if_no_path][hwhandler=1 rdac][rw]
>> > \_ round-robin 0 [prio=6][active]
>> >  \_ 5:0:1:2 sdj 8:144 [active][ready]
>> >  \_ 2:0:1:2 sdn 8:208 [active][ready]
>> > \_ round-robin 0 [prio=0][enabled]
>> >  \_ 2:0:0:2 sdb 8:16  [active][ghost]
>> >  \_ 5:0:0:2 sdd 8:48  [active][ghost]
>> >
>> >
>> > # cat /etc/multipath.conf
>> >
>> > blacklist {
>> >         devnode "^sd[a-z][[0-9]*]"
>> >         devnode "^(ram|raw|loop|fd|md|dm-|sr|scd|st)[0-9]*"
>> >         devnode "^hd[a-z][0-9]*"
>> >         devnode "^cciss!c[0-9]d[0-9](p[0-9]*)*"
>> > }
>> >
>> > defaults {
>> >         udev_dir                /dev
>> >         polling_interval        10
>> >         selector                "round-robin 0"
>> >         path_grouping_policy    multibus
>> >         getuid_callout          "/sbin/scsi_id --whitelisted /dev/%n"
>> >         prio                    alua
>> >         path_checker            readsector0
>> >         rr_min_io               100
>> >         max_fds                 8192
>> >         rr_weight               priorities
>> >         failback                immediate
>> >         no_path_retry           fail
>> >         user_friendly_names     yes
>> > }
>> > devices {
>> >         device {
>> >                 vendor                  "SUN"
>> >                 product                 "CSM200_R"
>> >                 product_blacklist       "Universal Xport"
>> >                 getuid_callout          "/sbin/scsi_id --whitelisted
>> > /dev/%n"
>> >                 features                "0"
>> >                 hardware_handler        "1 rdac"
>> >                 path_selector           "round-robin 0"
>> >                 path_grouping_policy    group_by_prio
>> >                 failback                immediate
>> >                 rr_weight               uniform
>> >                 no_path_retry           queue
>> >                 rr_min_io               1000
>> >                 path_checker            rdac
>> >                 prio                    rdac
>> >         }
>> > }
>> >
>> > multipaths {
>> >         multipath {
>> >                 wwid
>>  3600a0b800048335200001e5d48b68a9b
>> >                 alias                   vol1
>> >                 rr_weight               priorities
>> >                 no_path_retry           5
>> >                 rr_min_io               100
>> >         }
>> > }
>> >
>> >
>> >
>> > # multipathd -d v3
>> >
>> >
>> > Aug 13 14:48:53 | sdb: ownership set to vol1
>> > Aug 13 14:48:53 | sdb: not found in pathvec
>> > Aug 13 14:48:53 | sdb: mask = 0xc
>> > Aug 13 14:48:53 | sdb: path checker = rdac (controller setting)
>> > Aug 13 14:48:53 | sdb: state = 4
>> > Aug 13 14:48:53 | sdb: rdac prio = 0
>> > Aug 13 14:48:53 | sdd: ownership set to vol1
>> > Aug 13 14:48:53 | sdd: not found in pathvec
>> > Aug 13 14:48:53 | sdd: mask = 0xc
>> > Aug 13 14:48:53 | sdd: path checker = rdac (controller setting)
>> > Aug 13 14:48:53 | sdd: state = 4
>> > Aug 13 14:48:53 | sdd: rdac prio = 0
>> > Aug 13 14:48:53 | sdj: ownership set to vol1
>> > Aug 13 14:48:53 | sdj: not found in pathvec
>> > Aug 13 14:48:53 | sdj: mask = 0xc
>> > Aug 13 14:48:53 | sdj: path checker = rdac (controller setting)
>> > Aug 13 14:48:53 | sdj: state = 2
>> > Aug 13 14:48:53 | sdj: rdac prio = 3
>> > Aug 13 14:48:53 | sdn: ownership set to vol1
>> > Aug 13 14:48:53 | sdn: not found in pathvec
>> > Aug 13 14:48:53 | sdn: mask = 0xc
>> > Aug 13 14:48:53 | sdn: path checker = rdac (controller setting)
>> > Aug 13 14:48:53 | sdn: state = 2
>> > Aug 13 14:48:53 | sdn: rdac prio = 3
>> > Aug 13 14:48:53 | vol1: pgfailback = -2 (controller setting)
>> > Aug 13 14:48:53 | vol1: pgpolicy = group_by_prio (controller setting)
>> > Aug 13 14:48:53 | vol1: selector = round-robin 0 (controller setting)
>> > Aug 13 14:48:53 | vol1: features = 0 (controller setting)
>> > Aug 13 14:48:53 | vol1: hwhandler = 1 rdac (controller setting)
>> > Aug 13 14:48:53 | vol1: rr_weight = 2 (LUN setting)
>> > Aug 13 14:48:53 | vol1: minio = 100 (LUN setting)
>> > Aug 13 14:48:53 | vol1: no_path_retry = 5 (multipath setting)
>> > Aug 13 14:48:53 | pg_timeout = NONE (internal default)
>> > Aug 13 14:48:53 | vol1: set ACT_CREATE (map does not exist)
>> > create: vol1 (3600a0b800048335200001e5d48b68a9b) n/a SUN,CSM200_R
>> > [size=12T][features=0][hwhandler=1 rdac][n/a]
>> > \_ round-robin 0 [prio=6][undef]
>> >  \_ 5:0:1:2 sdj 8:144 [undef][ready]
>> >  \_ 2:0:1:2 sdn 8:208 [undef][ready]
>> > \_ round-robin 0 [prio=0][undef]
>> >  \_ 2:0:0:2 sdb 8:16 [undef][ghost]
>> >  \_ 5:0:0:2 sdd 8:48 [undef][ghost]
>> >
>> > --
>> > dm-devel mailing list
>> > dm-devel@redhat.com
>> > https://www.redhat.com/mailman/listinfo/dm-devel
>>
>> --
>> dm-devel mailing list
>> dm-devel@redhat.com
>> https://www.redhat.com/mailman/listinfo/dm-devel
>>
>
>

[-- Attachment #1.2: Type: text/html, Size: 20471 bytes --]

[-- Attachment #2: Type: text/plain, Size: 0 bytes --]



^ permalink raw reply	[flat|nested] 9+ messages in thread

* RE: rdac path failure - Sun 6140
  2009-08-13 20:34     ` Stewart Smith
@ 2009-08-14  0:05       ` Moger, Babu
  2009-08-14 15:58         ` Stewart Smith
  0 siblings, 1 reply; 9+ messages in thread
From: Moger, Babu @ 2009-08-14  0:05 UTC (permalink / raw)
  To: device-mapper development; +Cc: Stewart Smith


[-- Attachment #1.1: Type: text/plain, Size: 17359 bytes --]

Stew,
     I don't see much information about this failure in the logs. Right now device handlers don't provide much information on failures.  We are working on to add some more debug levels.  I am attaching my draft code (scsi_dh_rdac.c) here.  Please use this only for your testing. It is not been approved/reviewed yet. I still need to submit this one to community for approval. The code is attached.  Please replace this file with scsi_dh_rdac.c in the directory /driver/scsi/device_handlers and rebuild the kernel.  This should give more information from the target point of view. Please send me the /var/log/messages file after the failure. Let see if we can get more information..

Thanks
Babu Moger
________________________________
From: dm-devel-bounces@redhat.com [mailto:dm-devel-bounces@redhat.com] On Behalf Of Stewart Smith
Sent: Thursday, August 13, 2009 3:35 PM
To: device-mapper development
Subject: Re: [dm-devel] rdac path failure - Sun 6140


Same sequence of events, with multipathd -v3

Aug 13 16:28:48.627  kernel: device-mapper: multipath: Failing path 8:208.
Aug 13 16:28:48.000  multipathd: vol1: rr_weight = 2 (LUN setting)
Aug 13 16:28:48.000  multipathd: vol1: pgfailback = -2 (controller setting)
Aug 13 16:28:48.000  multipathd: pg_timeout = NONE (internal default)
Aug 13 16:28:48.000  multipathd: 8:208: mark as failed
Aug 13 16:28:48.000  multipathd: uevent 'change' from '/devices/virtual/block/dm-1'
Aug 13 16:28:48.000  multipathd: UDEV_LOG=3
Aug 13 16:28:48.000  multipathd: ACTION=change
Aug 13 16:28:48.000  multipathd: DEVPATH=/devices/virtual/block/dm-1
Aug 13 16:28:48.000  multipathd: SUBSYSTEM=block
Aug 13 16:28:48.000  multipathd: DM_TARGET=multipath
Aug 13 16:28:48.000  multipathd: DM_ACTION=PATH_FAILED
Aug 13 16:28:48.000  multipathd: DM_SEQNUM=1
Aug 13 16:28:48.000  multipathd: DM_PATH=8:208
Aug 13 16:28:48.000  multipathd: DM_NR_VALID_PATHS=3
Aug 13 16:28:48.000  multipathd: DM_NAME=vol1
Aug 13 16:28:48.000  multipathd: DM_UUID=mpath-3600a0b800048335200001e5d48b68a9b
Aug 13 16:28:48.000  multipathd: MAJOR=253
Aug 13 16:28:48.000  multipathd: MINOR=1
Aug 13 16:28:48.000  multipathd: DEVTYPE=disk
Aug 13 16:28:48.000  multipathd: SEQNUM=1738
Aug 13 16:28:48.000  multipathd: UDEVD_EVENT=1
Aug 13 16:28:48.000  multipathd: DEVNAME=/dev/dm-1
Aug 13 16:28:50.000  multipathd: 8:208: reinstated
Aug 13 16:28:50.000  multipathd: vol1: remaining active paths: 4
Aug 13 16:28:50.000  multipathd: sdj: rdac prio = 3
Aug 13 16:28:50.000  multipathd: sdn: rdac prio = 3
Aug 13 16:28:50.000  multipathd: sdb: rdac prio = 0
Aug 13 16:28:50.000  multipathd: sdd: rdac prio = 0
Aug 13 16:28:50.763  kernel: device-mapper: multipath: Failing path 8:208.
Aug 13 16:28:50.000  multipathd: uevent 'change' from '/devices/virtual/block/dm-1'
Aug 13 16:28:50.000  multipathd: UDEV_LOG=3
Aug 13 16:28:50.000  multipathd: ACTION=change
Aug 13 16:28:50.000  multipathd: DEVPATH=/devices/virtual/block/dm-1
Aug 13 16:28:50.000  multipathd: SUBSYSTEM=block
Aug 13 16:28:50.000  multipathd: DM_TARGET=multipath
Aug 13 16:28:50.000  multipathd: DM_ACTION=PATH_REINSTATED
Aug 13 16:28:50.000  multipathd: DM_SEQNUM=2
Aug 13 16:28:50.000  multipathd: DM_PATH=8:208
Aug 13 16:28:50.000  multipathd: DM_NR_VALID_PATHS=4
Aug 13 16:28:50.000  multipathd: DM_NAME=vol1
Aug 13 16:28:50.000  multipathd: DM_UUID=mpath-3600a0b800048335200001e5d48b68a9b
Aug 13 16:28:50.000  multipathd: MAJOR=253
Aug 13 16:28:50.000  multipathd: MINOR=1
Aug 13 16:28:50.000  multipathd: DEVTYPE=diskAug 13 16:28:50.000  multipathd: SEQNUM=1739Aug 13 16:28:50.000  multipathd: UDEVD_EVENT=1
Aug 13 16:28:50.000  multipathd: vol1: rr_weight = 2 (LUN setting)
Aug 13 16:28:50.000  multipathd: vol1: pgfailback = -2 (controller setting)
Aug 13 16:28:50.000  multipathd: pg_timeout = NONE (internal default)
Aug 13 16:28:50.000  multipathd: 8:208: mark as failed
Aug 13 16:28:50.000  multipathd: vol1: remaining active paths: 3
Aug 13 16:28:50.000  multipathd: vol1: rr_weight = 2 (LUN setting)
Aug 13 16:28:50.000  multipathd: vol1: pgfailback = -2 (controller setting)
Aug 13 16:28:50.000  multipathd: uevent 'change' from '/devices/virtual/block/dm-1'
Aug 13 16:28:50.000  multipathd: UDEV_LOG=3
Aug 13 16:28:50.000  multipathd: ACTION=change
Aug 13 16:28:50.000  multipathd: DEVPATH=/devices/virtual/block/dm-1
Aug 13 16:28:50.000  multipathd: SUBSYSTEM=block
Aug 13 16:28:50.000  multipathd: DM_TARGET=multipath
Aug 13 16:28:50.000  multipathd: DM_ACTION=PATH_FAILED
Aug 13 16:28:50.000  multipathd: DM_SEQNUM=3
Aug 13 16:28:50.000  multipathd: DM_PATH=8:208
Aug 13 16:28:50.000  multipathd: DM_NR_VALID_PATHS=3
Aug 13 16:28:50.000  multipathd: DM_NAME=vol1
Aug 13 16:28:50.000  multipathd: DM_UUID=mpath-3600a0b800048335200001e5d48b68a9b
Aug 13 16:28:50.000  multipathd: MAJOR=253
Aug 13 16:28:50.000  multipathd: MINOR=1
Aug 13 16:28:50.000  multipathd: DEVTYPE=disk
Aug 13 16:28:50.000  multipathd: SEQNUM=1740
Aug 13 16:28:50.000  multipathd: UDEVD_EVENT=1
Aug 13 16:28:50.000  multipathd: DEVNAME=/dev/dm-1
Aug 13 16:29:00.000  multipathd: 8:208: reinstated
Aug 13 16:29:00.000  multipathd: vol1: remaining active paths: 4
Aug 13 16:29:00.000  multipathd: sdj: rdac prio = 3
Aug 13 16:29:00.000  multipathd: sdn: rdac prio = 3
Aug 13 16:29:00.000  multipathd: sdb: rdac prio = 0
Aug 13 16:29:00.000  multipathd: sdd: rdac prio = 0
Aug 13 16:29:00.000  multipathd: vol1: rr_weight = 2 (LUN setting)
Aug 13 16:29:00.000  multipathd: vol1: pgfailback = -2 (controller setting)
Aug 13 16:29:00.000  multipathd: uevent 'change' from '/devices/virtual/block/dm-1'
Aug 13 16:29:00.000  multipathd: UDEV_LOG=3
Aug 13 16:29:00.000  multipathd: ACTION=change
Aug 13 16:29:00.000  multipathd: DEVPATH=/devices/virtual/block/dm-1
Aug 13 16:29:00.000  multipathd: SUBSYSTEM=block
Aug 13 16:29:00.000  multipathd: DM_TARGET=multipath
Aug 13 16:29:00.000  multipathd: DM_ACTION=PATH_REINSTATED
Aug 13 16:29:00.000  multipathd: DM_SEQNUM=4
Aug 13 16:29:00.000  multipathd: DM_PATH=8:208
Aug 13 16:29:00.000  multipathd: DM_NR_VALID_PATHS=4
Aug 13 16:29:00.000  multipathd: DM_NAME=vol1
Aug 13 16:29:00.000  multipathd: DM_UUID=mpath-3600a0b800048335200001e5d48b68a9b
Aug 13 16:29:00.000  multipathd: MAJOR=253
Aug 13 16:29:00.000  multipathd: MINOR=1
Aug 13 16:29:00.000  multipathd: DEVTYPE=disk
Aug 13 16:29:00.000  multipathd: SEQNUM=1741
Aug 13 16:29:00.000  multipathd: UDEVD_EVENT=1
Aug 13 16:29:00.000  multipathd: DEVNAME=/dev/dm-1
Aug 13 16:29:02.753  kernel: device-mapper: multipath: Failing path 8:208.
Aug 13 16:29:02.000  multipathd: vol1: rr_weight = 2 (LUN setting)
Aug 13 16:29:02.000  multipathd: vol1: pgfailback = -2 (controller setting)
Aug 13 16:29:02.000  multipathd: pg_timeout = NONE (internal default)
Aug 13 16:29:02.000  multipathd: 8:208: mark as failed
Aug 13 16:29:02.000  multipathd: uevent 'change' from '/devices/virtual/block/dm-1'
Aug 13 16:29:02.000  multipathd: UDEV_LOG=3
Aug 13 16:29:02.000  multipathd: ACTION=change
Aug 13 16:29:02.000  multipathd: DEVPATH=/devices/virtual/block/dm-1
Aug 13 16:29:02.000  multipathd: SUBSYSTEM=block
Aug 13 16:29:02.000  multipathd: DM_TARGET=multipath
Aug 13 16:29:02.000  multipathd: DM_ACTION=PATH_FAILED
Aug 13 16:29:02.000  multipathd: DM_SEQNUM=5
Aug 13 16:29:02.000  multipathd: DM_PATH=8:208
Aug 13 16:29:02.000  multipathd: DM_NR_VALID_PATHS=3
Aug 13 16:29:02.000  multipathd: DM_NAME=vol1
Aug 13 16:29:02.000  multipathd: DM_UUID=mpath-3600a0b800048335200001e5d48b68a9b
Aug 13 16:29:02.000  multipathd: MAJOR=253
Aug 13 16:29:02.000  multipathd: MINOR=1
Aug 13 16:29:02.000  multipathd: DEVTYPE=disk
Aug 13 16:29:02.000  multipathd: SEQNUM=1742
Aug 13 16:29:02.000  multipathd: UDEVD_EVENT=1
Aug 13 16:29:02.000  multipathd: DEVNAME=/dev/dm-1
Aug 13 16:29:10.000  multipathd: 8:208: reinstated
Aug 13 16:29:10.000  multipathd: vol1: remaining active paths: 4
Aug 13 16:29:10.000  multipathd: sdj: rdac prio = 3
Aug 13 16:29:10.000  multipathd: sdn: rdac prio = 3
Aug 13 16:29:10.000  multipathd: sdb: rdac prio = 0
Aug 13 16:29:10.000  multipathd: sdd: rdac prio = 0
Aug 13 16:29:10.000  multipathd: vol1: rr_weight = 2 (LUN setting)
Aug 13 16:29:10.000  multipathd: vol1: pgfailback = -2 (controller setting)
Aug 13 16:29:10.000  multipathd: uevent 'change' from '/devices/virtual/block/dm-1'
Aug 13 16:29:10.000  multipathd: UDEV_LOG=3
Aug 13 16:29:10.000  multipathd: ACTION=change
Aug 13 16:29:10.000  multipathd: DEVPATH=/devices/virtual/block/dm-1
Aug 13 16:29:10.000  multipathd: SUBSYSTEM=block
Aug 13 16:29:10.000  multipathd: DM_TARGET=multipath
Aug 13 16:29:10.000  multipathd: DM_ACTION=PATH_REINSTATED
Aug 13 16:29:10.000  multipathd: DM_SEQNUM=6
Aug 13 16:29:10.000  multipathd: DM_PATH=8:208
Aug 13 16:29:10.000  multipathd: DM_NR_VALID_PATHS=4
Aug 13 16:29:10.000  multipathd: DM_NAME=vol1
Aug 13 16:29:10.000  multipathd: DM_UUID=mpath-3600a0b800048335200001e5d48b68a9b
Aug 13 16:29:10.000  multipathd: MAJOR=253
Aug 13 16:29:10.000  multipathd: MINOR=1
Aug 13 16:29:10.000  multipathd: DEVTYPE=disk
Aug 13 16:29:10.000  multipathd: SEQNUM=1743
Aug 13 16:29:10.000  multipathd: UDEVD_EVENT=1
Aug 13 16:29:10.000  multipathd: DEVNAME=/dev/dm-1




On Thu, Aug 13, 2009 at 1:27 PM, Stewart Smith <stew@cleepdar.com<mailto:stew@cleepdar.com>> wrote:

after a fresh, multipath -F and start of multipathd with -v 2 I see the following messages.

After starting multipathd I mounted /dev/mapper/vol1 and generated some simple I/O to it using dd


Aug 13 16:23:14.888 localhost kernel: device-mapper: multipath: Failing path 8:208.
Aug 13 16:23:14.000 localhost multipathd: 8:208: mark as failed
Aug 13 16:23:16.000 localhost multipathd: 8:208: reinstated
Aug 13 16:23:30.462 localhost kernel: device-mapper: multipath: Failing path 8:208.
Aug 13 16:23:30.000 localhost multipathd: 8:208: mark as failed
Aug 13 16:23:39.000 localhost multipathd: 8:208: reinstated
Aug 13 16:23:46.430 localhost kernel: device-mapper: multipath: Failing path 8:208.
Aug 13 16:23:46.000 localhost multipathd: 8:208: mark as failed
Aug 13 16:23:51.041 localhost kernel: device-mapper: multipath: Failing path 8:208.
Aug 13 16:23:51.000 localhost multipathd: 8:208: mark as failed
Aug 13 16:23:59.000 localhost multipathd: 8:208: reinstated
Aug 13 16:24:06.465 localhost kernel: device-mapper: multipath: Failing path 8:208.
Aug 13 16:24:06.000 localhost multipathd: 8:208: mark as failed
Aug 13 16:24:09.000 localhost multipathd: 8:208: reinstated


Thanks,
--
Stew



On Thu, Aug 13, 2009 at 12:42 PM, Moger, Babu <Babu.Moger@lsi.com<mailto:Babu.Moger@lsi.com>> wrote:
Do you have /var/log/messages file for this problem?

Thanks
Babu Moger

> -----Original Message-----
> From: dm-devel-bounces@redhat.com<mailto:dm-devel-bounces@redhat.com> [mailto:dm-devel-bounces@redhat.com<mailto:dm-devel-bounces@redhat.com>] On
> Behalf Of Stewart Smith
> Sent: Thursday, August 13, 2009 1:51 PM
> To: dm-devel@redhat.com<mailto:dm-devel@redhat.com>
> Subject: [dm-devel] rdac path failure - Sun 6140
>
> Hello All,
>
> I am seeing many of these messages when my Sun 6140 array is under heavy
> I/O
> device-mapper: multipath: Failing path 8:208.
> device-mapper: multipath: Failing path 8:208.
> device-mapper: multipath: Failing path 8:208.
> device-mapper: multipath: Failing path 8:208.
> device-mapper: multipath: Failing path 8:208.
>
>
> I am running a Fedora 10 server, with two fiber connections to two
> different switches.  Both controllers on the 6140 have one connection
> to each switch as well.  The end result is that I see four paths to
> each LUN.
>
> When the volume is mounted and under significant load I see the
> messages above every few seconds.  They seem to appear every
> "no_path_retry" seconds.
>
> The 6140 controller firmware is up to date at version 07.50.08.10 and
> I have installed the latest firmware for my Emulex LPe11002 cards.  I
> have reproduced the problem using both Cisco MDS and Brocade fiber
> channel switches as well.
>
> Using CAM, I have set the initiator Host Type to "Linux" at the
> moment.  I have tried other options as well without success.
>
> I have NOT installed the RDAC drivers from either Sun or LSI -
> primarily because they do not seem to build on my Fedora 10 kernel.
>
> Any ideas would be greatly appreciated!!!
>
> configs and debugging multipathd output is below.
>
>
>
>
>
> Kernel: 2.6.27.24-170.2.68.fc10.x86_64
>
> # multipath -lll
> vol1 (3600a0b800048335200001e5d48b68a9b) dm-1 SUN,CSM200_R
> [size=12T][features=1 queue_if_no_path][hwhandler=1 rdac][rw]
> \_ round-robin 0 [prio=6][active]
>  \_ 5:0:1:2 sdj 8:144 [active][ready]
>  \_ 2:0:1:2 sdn 8:208 [active][ready]
> \_ round-robin 0 [prio=0][enabled]
>  \_ 2:0:0:2 sdb 8:16  [active][ghost]
>  \_ 5:0:0:2 sdd 8:48  [active][ghost]
>
>
> # cat /etc/multipath.conf
>
> blacklist {
>         devnode "^sd[a-z][[0-9]*]"
>         devnode "^(ram|raw|loop|fd|md|dm-|sr|scd|st)[0-9]*"
>         devnode "^hd[a-z][0-9]*"
>         devnode "^cciss!c[0-9]d[0-9](p[0-9]*)*"
> }
>
> defaults {
>         udev_dir                /dev
>         polling_interval        10
>         selector                "round-robin 0"
>         path_grouping_policy    multibus
>         getuid_callout          "/sbin/scsi_id --whitelisted /dev/%n"
>         prio                    alua
>         path_checker            readsector0
>         rr_min_io               100
>         max_fds                 8192
>         rr_weight               priorities
>         failback                immediate
>         no_path_retry           fail
>         user_friendly_names     yes
> }
> devices {
>         device {
>                 vendor                  "SUN"
>                 product                 "CSM200_R"
>                 product_blacklist       "Universal Xport"
>                 getuid_callout          "/sbin/scsi_id --whitelisted
> /dev/%n"
>                 features                "0"
>                 hardware_handler        "1 rdac"
>                 path_selector           "round-robin 0"
>                 path_grouping_policy    group_by_prio
>                 failback                immediate
>                 rr_weight               uniform
>                 no_path_retry           queue
>                 rr_min_io               1000
>                 path_checker            rdac
>                 prio                    rdac
>         }
> }
>
> multipaths {
>         multipath {
>                 wwid                    3600a0b800048335200001e5d48b68a9b
>                 alias                   vol1
>                 rr_weight               priorities
>                 no_path_retry           5
>                 rr_min_io               100
>         }
> }
>
>
>
> # multipathd -d v3
>
>
> Aug 13 14:48:53 | sdb: ownership set to vol1
> Aug 13 14:48:53 | sdb: not found in pathvec
> Aug 13 14:48:53 | sdb: mask = 0xc
> Aug 13 14:48:53 | sdb: path checker = rdac (controller setting)
> Aug 13 14:48:53 | sdb: state = 4
> Aug 13 14:48:53 | sdb: rdac prio = 0
> Aug 13 14:48:53 | sdd: ownership set to vol1
> Aug 13 14:48:53 | sdd: not found in pathvec
> Aug 13 14:48:53 | sdd: mask = 0xc
> Aug 13 14:48:53 | sdd: path checker = rdac (controller setting)
> Aug 13 14:48:53 | sdd: state = 4
> Aug 13 14:48:53 | sdd: rdac prio = 0
> Aug 13 14:48:53 | sdj: ownership set to vol1
> Aug 13 14:48:53 | sdj: not found in pathvec
> Aug 13 14:48:53 | sdj: mask = 0xc
> Aug 13 14:48:53 | sdj: path checker = rdac (controller setting)
> Aug 13 14:48:53 | sdj: state = 2
> Aug 13 14:48:53 | sdj: rdac prio = 3
> Aug 13 14:48:53 | sdn: ownership set to vol1
> Aug 13 14:48:53 | sdn: not found in pathvec
> Aug 13 14:48:53 | sdn: mask = 0xc
> Aug 13 14:48:53 | sdn: path checker = rdac (controller setting)
> Aug 13 14:48:53 | sdn: state = 2
> Aug 13 14:48:53 | sdn: rdac prio = 3
> Aug 13 14:48:53 | vol1: pgfailback = -2 (controller setting)
> Aug 13 14:48:53 | vol1: pgpolicy = group_by_prio (controller setting)
> Aug 13 14:48:53 | vol1: selector = round-robin 0 (controller setting)
> Aug 13 14:48:53 | vol1: features = 0 (controller setting)
> Aug 13 14:48:53 | vol1: hwhandler = 1 rdac (controller setting)
> Aug 13 14:48:53 | vol1: rr_weight = 2 (LUN setting)
> Aug 13 14:48:53 | vol1: minio = 100 (LUN setting)
> Aug 13 14:48:53 | vol1: no_path_retry = 5 (multipath setting)
> Aug 13 14:48:53 | pg_timeout = NONE (internal default)
> Aug 13 14:48:53 | vol1: set ACT_CREATE (map does not exist)
> create: vol1 (3600a0b800048335200001e5d48b68a9b) n/a SUN,CSM200_R
> [size=12T][features=0][hwhandler=1 rdac][n/a]
> \_ round-robin 0 [prio=6][undef]
>  \_ 5:0:1:2 sdj 8:144 [undef][ready]
>  \_ 2:0:1:2 sdn 8:208 [undef][ready]
> \_ round-robin 0 [prio=0][undef]
>  \_ 2:0:0:2 sdb 8:16 [undef][ghost]
>  \_ 5:0:0:2 sdd 8:48 [undef][ghost]
>
> --
> dm-devel mailing list
> dm-devel@redhat.com<mailto:dm-devel@redhat.com>
> https://www.redhat.com/mailman/listinfo/dm-devel

--
dm-devel mailing list
dm-devel@redhat.com<mailto:dm-devel@redhat.com>
https://www.redhat.com/mailman/listinfo/dm-devel



[-- Attachment #1.2: Type: text/html, Size: 53333 bytes --]

[-- Attachment #2: scsi_dh_rdac.c --]
[-- Type: text/plain, Size: 19308 bytes --]

/*
 * Engenio/LSI RDAC SCSI Device Handler
 *
 * Copyright (C) 2005 Mike Christie. All rights reserved.
 * Copyright (C) Chandra Seetharaman, IBM Corp. 2007
 *
 * This program is free software; you can redistribute it and/or modify
 * it under the terms of the GNU General Public License as published by
 * the Free Software Foundation; either version 2 of the License, or
 * (at your option) any later version.
 *
 * This program is distributed in the hope that it will be useful,
 * but WITHOUT ANY WARRANTY; without even the implied warranty of
 * MERCHANTABILITY or FITNESS FOR A PARTICULAR PURPOSE.  See the
 * GNU General Public License for more details.
 *
 * You should have received a copy of the GNU General Public License
 * along with this program; if not, write to the Free Software
 * Foundation, Inc., 59 Temple Place - Suite 330, Boston, MA 02111-1307, USA.
 *
 */
#include <scsi/scsi.h>
#include <scsi/scsi_eh.h>
#include <scsi/scsi_dh.h>

#define RDAC_NAME "rdac"
#define RDAC_RETRY_COUNT 5

/*
 * LSI mode page stuff
 *
 * These struct definitions and the forming of the
 * mode page were taken from the LSI RDAC 2.4 GPL'd
 * driver, and then converted to Linux conventions.
 */
#define RDAC_QUIESCENCE_TIME 20;
/*
 * Page Codes
 */
#define RDAC_PAGE_CODE_REDUNDANT_CONTROLLER 0x2c

/*
 * Controller modes definitions
 */
#define RDAC_MODE_TRANSFER_SPECIFIED_LUNS	0x02

/*
 * RDAC Options field
 */
#define RDAC_FORCED_QUIESENCE 0x02

#define RDAC_TIMEOUT	(60 * HZ)
#define RDAC_RETRIES	3

struct rdac_mode_6_hdr {
	u8	data_len;
	u8	medium_type;
	u8	device_params;
	u8	block_desc_len;
};

struct rdac_mode_10_hdr {
	u16	data_len;
	u8	medium_type;
	u8	device_params;
	u16	reserved;
	u16	block_desc_len;
};

struct rdac_mode_common {
	u8	controller_serial[16];
	u8	alt_controller_serial[16];
	u8	rdac_mode[2];
	u8	alt_rdac_mode[2];
	u8	quiescence_timeout;
	u8	rdac_options;
};

struct rdac_pg_legacy {
	struct rdac_mode_6_hdr hdr;
	u8	page_code;
	u8	page_len;
	struct rdac_mode_common common;
#define MODE6_MAX_LUN	32
	u8	lun_table[MODE6_MAX_LUN];
	u8	reserved2[32];
	u8	reserved3;
	u8	reserved4;
};

struct rdac_pg_expanded {
	struct rdac_mode_10_hdr hdr;
	u8	page_code;
	u8	subpage_code;
	u8	page_len[2];
	struct rdac_mode_common common;
	u8	lun_table[256];
	u8	reserved3;
	u8	reserved4;
};

struct c9_inquiry {
	u8	peripheral_info;
	u8	page_code;	/* 0xC9 */
	u8	reserved1;
	u8	page_len;
	u8	page_id[4];	/* "vace" */
	u8	avte_cvp;
	u8	path_prio;
	u8	reserved2[38];
};

#define SUBSYS_ID_LEN	16
#define SLOT_ID_LEN	2

struct c4_inquiry {
	u8	peripheral_info;
	u8	page_code;	/* 0xC4 */
	u8	reserved1;
	u8	page_len;
	u8	page_id[4];	/* "subs" */
	u8	subsys_id[SUBSYS_ID_LEN];
	u8	revision[4];
	u8	slot_id[SLOT_ID_LEN];
	u8	reserved[2];
};

struct rdac_controller {
	u8			subsys_id[SUBSYS_ID_LEN];
	u8			slot_id[SLOT_ID_LEN];
	int			use_ms10;
	struct kref		kref;
	struct list_head	node; /* list of all controllers */
	union			{
		struct rdac_pg_legacy legacy;
		struct rdac_pg_expanded expanded;
	} mode_select;
	u8			index;
	u8			array_name[31];
};
struct c8_inquiry {
	u8	peripheral_info;
	u8	page_code; /* 0xC8 */
	u8	reserved1;
	u8	page_len;
	u8	page_id[4]; /* "edid" */
	u8	reserved2[3];
	u8	vol_uniq_id_len;
	u8	vol_uniq_id[16];
	u8	vol_user_label_len;
	u8	vol_user_label[60];
	u8	array_uniq_id_len;
	u8	array_unique_id[16];
	u8	array_user_label_len;
	u8	array_user_label[60];
	u8	lun[8];
};

struct c2_inquiry {
	u8	peripheral_info;
	u8	page_code;	/* 0xC2 */
	u8	reserved1;
	u8	page_len;
	u8	page_id[4];	/* "swr4" */
	u8	sw_version[3];
	u8	sw_date[3];
	u8	features_enabled;
	u8	max_lun_supported;
	u8	partitions[239]; /* Total allocation length should be 0xFF */
};

struct rdac_dh_data {
	struct rdac_controller	*ctlr;
#define UNINITIALIZED_LUN	(1 << 8)
	unsigned		lun;
#define RDAC_STATE_ACTIVE	0
#define RDAC_STATE_PASSIVE	1
	unsigned char		state;

#define RDAC_LUN_UNOWNED	0
#define RDAC_LUN_OWNED		1
#define RDAC_LUN_AVT		2
	char			lun_state;
	unsigned char		sense[SCSI_SENSE_BUFFERSIZE];
	union			{
		struct c2_inquiry c2;
		struct c4_inquiry c4;
		struct c8_inquiry c8;
		struct c9_inquiry c9;
	} inq;
};

static const char *lun_state[] =
{
	"unowned",
	"owned",
	"owned (AVT mode)",
};

static LIST_HEAD(ctlr_list);
static DEFINE_SPINLOCK(list_lock);

/* 
 * module parameter to enable rdac debug logging.
 * 2 bits for each type of logging, only two types defined for now 
 * Can be enhanced if required at later point
 */
static int rdac_logging = 0xF;
module_param(rdac_logging, int, 0);
MODULE_PARM_DESC(rdac_logging, "A bit mask of rdac logging levels, "
		"Default is 1 - failover logging enabled, "
		"set it to 0xF to enable all the logs");

#define RDAC_LOG_FAILOVER	0
#define RDAC_LOG_SENSE		2

#define RDAC_LOG_BITS		2

#define RDAC_LOG_LEVEL(SHIFT)  \
        ((rdac_logging >> (SHIFT)) & ((1 << (RDAC_LOG_BITS)) - 1))

#define RDAC_DEBUG(SHIFT, sdev, f, arg...) \
do { \
	if (unlikely(RDAC_LOG_LEVEL(SHIFT))) \
		sdev_printk(KERN_INFO, sdev, RDAC_NAME ": " f "\n", ## arg); \
} while (0);

static inline struct rdac_dh_data *get_rdac_data(struct scsi_device *sdev)
{
	struct scsi_dh_data *scsi_dh_data = sdev->scsi_dh_data;
	BUG_ON(scsi_dh_data == NULL);
	return ((struct rdac_dh_data *) scsi_dh_data->buf);
}

static struct request *get_rdac_req(struct scsi_device *sdev,
			void *buffer, unsigned buflen, int rw)
{
	struct request *rq;
	struct request_queue *q = sdev->request_queue;

	rq = blk_get_request(q, rw, GFP_NOIO);

	if (!rq) {
		sdev_printk(KERN_INFO, sdev,
				"get_rdac_req: blk_get_request failed.\n");
		return NULL;
	}

	if (buflen && blk_rq_map_kern(q, rq, buffer, buflen, GFP_NOIO)) {
		blk_put_request(rq);
		sdev_printk(KERN_INFO, sdev,
				"get_rdac_req: blk_rq_map_kern failed.\n");
		return NULL;
	}

	rq->cmd_type = REQ_TYPE_BLOCK_PC;
	rq->cmd_flags |= REQ_FAILFAST_DEV | REQ_FAILFAST_TRANSPORT |
			 REQ_FAILFAST_DRIVER;
	rq->retries = RDAC_RETRIES;
	rq->timeout = RDAC_TIMEOUT;

	return rq;
}

static struct request *rdac_failover_get(struct scsi_device *sdev,
					 struct rdac_dh_data *h)
{
	struct request *rq;
	struct rdac_mode_common *common;
	unsigned data_size;

	if (h->ctlr->use_ms10) {
		struct rdac_pg_expanded *rdac_pg;

		data_size = sizeof(struct rdac_pg_expanded);
		rdac_pg = &h->ctlr->mode_select.expanded;
		memset(rdac_pg, 0, data_size);
		common = &rdac_pg->common;
		rdac_pg->page_code = RDAC_PAGE_CODE_REDUNDANT_CONTROLLER + 0x40;
		rdac_pg->subpage_code = 0x1;
		rdac_pg->page_len[0] = 0x01;
		rdac_pg->page_len[1] = 0x28;
		rdac_pg->lun_table[h->lun] = 0x81;
	} else {
		struct rdac_pg_legacy *rdac_pg;

		data_size = sizeof(struct rdac_pg_legacy);
		rdac_pg = &h->ctlr->mode_select.legacy;
		memset(rdac_pg, 0, data_size);
		common = &rdac_pg->common;
		rdac_pg->page_code = RDAC_PAGE_CODE_REDUNDANT_CONTROLLER;
		rdac_pg->page_len = 0x68;
		rdac_pg->lun_table[h->lun] = 0x81;
	}
	common->rdac_mode[1] = RDAC_MODE_TRANSFER_SPECIFIED_LUNS;
	common->quiescence_timeout = RDAC_QUIESCENCE_TIME;
	common->rdac_options = RDAC_FORCED_QUIESENCE;

	/* get request for block layer packet command */
	rq = get_rdac_req(sdev, &h->ctlr->mode_select, data_size, WRITE);
	if (!rq)
		return NULL;

	/* Prepare the command. */
	if (h->ctlr->use_ms10) {
		rq->cmd[0] = MODE_SELECT_10;
		rq->cmd[7] = data_size >> 8;
		rq->cmd[8] = data_size & 0xff;
	} else {
		rq->cmd[0] = MODE_SELECT;
		rq->cmd[4] = data_size;
	}
	rq->cmd_len = COMMAND_SIZE(rq->cmd[0]);

	rq->sense = h->sense;
	memset(rq->sense, 0, SCSI_SENSE_BUFFERSIZE);
	rq->sense_len = 0;

	return rq;
}

static void release_controller(struct kref *kref)
{
	struct rdac_controller *ctlr;
	ctlr = container_of(kref, struct rdac_controller, kref);

	spin_lock(&list_lock);
	list_del(&ctlr->node);
	spin_unlock(&list_lock);
	kfree(ctlr);
}

static struct rdac_controller *get_controller(u8 *subsys_id, u8 *slot_id)
{
	struct rdac_controller *ctlr, *tmp;

	spin_lock(&list_lock);

	list_for_each_entry(tmp, &ctlr_list, node) {
		if ((memcmp(tmp->subsys_id, subsys_id, SUBSYS_ID_LEN) == 0) &&
			  (memcmp(tmp->slot_id, slot_id, SLOT_ID_LEN) == 0)) {
			kref_get(&tmp->kref);
			spin_unlock(&list_lock);
			return tmp;
		}
	}
	ctlr = kmalloc(sizeof(*ctlr), GFP_ATOMIC);
	if (!ctlr)
		goto done;

	/* initialize fields of controller */
	memcpy(ctlr->subsys_id, subsys_id, SUBSYS_ID_LEN);
	memcpy(ctlr->slot_id, slot_id, SLOT_ID_LEN);

	/* update the controller index */
	if (slot_id[1] == 0x31)
		ctlr->index = 0;
	else
		ctlr->index = 1;

	kref_init(&ctlr->kref);
	ctlr->use_ms10 = -1;
	list_add(&ctlr->node, &ctlr_list);
done:
	spin_unlock(&list_lock);
	return ctlr;
}

static int submit_inquiry(struct scsi_device *sdev, int page_code,
			  unsigned int len, struct rdac_dh_data *h)
{
	struct request *rq;
	struct request_queue *q = sdev->request_queue;
	int err = SCSI_DH_RES_TEMP_UNAVAIL;

	rq = get_rdac_req(sdev, &h->inq, len, READ);
	if (!rq)
		goto done;

	/* Prepare the command. */
	rq->cmd[0] = INQUIRY;
	rq->cmd[1] = 1;
	rq->cmd[2] = page_code;
	rq->cmd[4] = len;
	rq->cmd_len = COMMAND_SIZE(INQUIRY);

	rq->sense = h->sense;
	memset(rq->sense, 0, SCSI_SENSE_BUFFERSIZE);
	rq->sense_len = 0;

	err = blk_execute_rq(q, NULL, rq, 1);
	if (err == -EIO)
		err = SCSI_DH_IO;

	blk_put_request(rq);
done:
	return err;
}

static int get_lun(struct scsi_device *sdev, struct rdac_dh_data *h)
{
	int err;
	struct c8_inquiry *inqp;

	err = submit_inquiry(sdev, 0xC8, sizeof(struct c8_inquiry), h);
	if (err == SCSI_DH_OK) {
		inqp = &h->inq.c8;
		if (inqp->page_code != 0xc8)
			return SCSI_DH_NOSYS;
		if (inqp->page_id[0] != 'e' || inqp->page_id[1] != 'd' ||
		    inqp->page_id[2] != 'i' || inqp->page_id[3] != 'd')
			return SCSI_DH_NOSYS;
		h->lun = inqp->lun[7]; /* Uses only the last byte */
	}
	return err;
}

static int get_array_name(struct scsi_device *sdev, struct rdac_dh_data *h)
{
	int err, i;
	struct c8_inquiry *inqp;

	err = submit_inquiry(sdev, 0xC8, sizeof(struct c8_inquiry), h);
	if (err == SCSI_DH_OK) {
		inqp = &h->inq.c8;
		if (inqp->page_code != 0xc8)
			return SCSI_DH_NOSYS;

		for(i=0; i<30; ++i){
			h->ctlr->array_name[i] = inqp->array_user_label[(2*i)+1];
		}
		h->ctlr->array_name[30] = '\0';
	}
			
	return err;
}

static int check_ownership(struct scsi_device *sdev, struct rdac_dh_data *h)
{
	int err;
	struct c9_inquiry *inqp;

	h->lun_state = RDAC_LUN_UNOWNED;
	h->state = RDAC_STATE_ACTIVE;
	err = submit_inquiry(sdev, 0xC9, sizeof(struct c9_inquiry), h);
	if (err == SCSI_DH_OK) {
		inqp = &h->inq.c9;
		if ((inqp->avte_cvp >> 7) == 0x1) {
			/* LUN in AVT mode */
			sdev_printk(KERN_NOTICE, sdev,
				    "%s: AVT mode detected\n",
				    RDAC_NAME);
			h->lun_state = RDAC_LUN_AVT;
		} else if ((inqp->avte_cvp & 0x1) != 0) {
			/* LUN was owned by the controller */
			h->lun_state = RDAC_LUN_OWNED;
		}
	}

	if (h->lun_state == RDAC_LUN_UNOWNED)
		h->state = RDAC_STATE_PASSIVE;

	return err;
}

static int initialize_controller(struct scsi_device *sdev,
				 struct rdac_dh_data *h)
{
	int err;
	struct c4_inquiry *inqp;

	err = submit_inquiry(sdev, 0xC4, sizeof(struct c4_inquiry), h);
	if (err == SCSI_DH_OK) {
		inqp = &h->inq.c4;
		h->ctlr = get_controller(inqp->subsys_id, inqp->slot_id);
		if (!h->ctlr)
			err = SCSI_DH_RES_TEMP_UNAVAIL;
	}
	return err;
}

static int set_mode_select(struct scsi_device *sdev, struct rdac_dh_data *h)
{
	int err;
	struct c2_inquiry *inqp;

	err = submit_inquiry(sdev, 0xC2, sizeof(struct c2_inquiry), h);
	if (err == SCSI_DH_OK) {
		inqp = &h->inq.c2;
		/*
		 * If more than MODE6_MAX_LUN luns are supported, use
		 * mode select 10
		 */
		if (inqp->max_lun_supported >= MODE6_MAX_LUN)
			h->ctlr->use_ms10 = 1;
		else
			h->ctlr->use_ms10 = 0;
	}
	return err;
}

static int mode_select_handle_sense(struct scsi_device *sdev,
				    unsigned char *sensebuf)
{
	struct scsi_sense_hdr sense_hdr;
	int err = SCSI_DH_IO, ret;
	struct rdac_dh_data *h = get_rdac_data(sdev);

	ret = scsi_normalize_sense(sensebuf, SCSI_SENSE_BUFFERSIZE, &sense_hdr);
	if (!ret)
		goto done;

	switch (sense_hdr.sense_key) {
	case NO_SENSE:
	case ABORTED_COMMAND:
	case UNIT_ATTENTION:
		err = SCSI_DH_RETRY;
		break;
	case NOT_READY:
		if (sense_hdr.asc == 0x04 && sense_hdr.ascq == 0x01)
			/* LUN Not Ready and is in the Process of Becoming
			 * Ready
			 */
			err = SCSI_DH_RETRY;
		break;
	case ILLEGAL_REQUEST:
		if (sense_hdr.asc == 0x91 && sense_hdr.ascq == 0x36)
			/*
			 * Command Lock contention
			 */
			err = SCSI_DH_RETRY;
		break;
	default:
		break;
	}

done:
	RDAC_DEBUG(RDAC_LOG_FAILOVER, sdev, "array %s, ctlr %d, "
		"MODE_SELECT returned with sense %02x/%02x/%02x",
		(char *) h->ctlr->array_name, h->ctlr->index,
		sense_hdr.sense_key, sense_hdr.asc, sense_hdr.ascq);
		
	return err;
}

static int send_mode_select(struct scsi_device *sdev, struct rdac_dh_data *h)
{
	struct request *rq;
	struct request_queue *q = sdev->request_queue;
	int err, retry_cnt = RDAC_RETRY_COUNT;

retry:
	err = SCSI_DH_RES_TEMP_UNAVAIL;
	rq = rdac_failover_get(sdev, h);
	if (!rq)
		goto done;

	RDAC_DEBUG(RDAC_LOG_FAILOVER, sdev, "array %s, ctlr %d, "
		"%s MODE_SELECT command",
		(char *) h->ctlr->array_name, h->ctlr->index,
		(retry_cnt == RDAC_RETRY_COUNT) ? "queueing" : "retrying");

	err = blk_execute_rq(q, NULL, rq, 1);
	blk_put_request(rq);
	if (err != SCSI_DH_OK) {
		err = mode_select_handle_sense(sdev, h->sense);
		if (err == SCSI_DH_RETRY && retry_cnt--)
			goto retry;
	}
	if (err == SCSI_DH_OK) {
		h->state = RDAC_STATE_ACTIVE;
		RDAC_DEBUG(RDAC_LOG_FAILOVER, sdev, "array %s, ctlr %d, "
				"MODE_SELECT completed",
				(char *) h->ctlr->array_name, h->ctlr->index);
	}

done:
	return err;
}

static int rdac_activate(struct scsi_device *sdev)
{
	struct rdac_dh_data *h = get_rdac_data(sdev);
	int err = SCSI_DH_OK;

	err = check_ownership(sdev, h);
	if (err != SCSI_DH_OK)
		goto done;

	if (h->ctlr->use_ms10 == -1) {
		err = set_mode_select(sdev, h);
		if (err != SCSI_DH_OK)
			goto done;
	}
	if (h->lun_state == RDAC_LUN_UNOWNED)
		err = send_mode_select(sdev, h);
done:
	return err;
}

static int rdac_prep_fn(struct scsi_device *sdev, struct request *req)
{
	struct rdac_dh_data *h = get_rdac_data(sdev);
	int ret = BLKPREP_OK;

	if (h->state != RDAC_STATE_ACTIVE) {
		ret = BLKPREP_KILL;
		req->cmd_flags |= REQ_QUIET;
	}
	return ret;

}

static int rdac_check_sense(struct scsi_device *sdev,
				struct scsi_sense_hdr *sense_hdr)
{
	struct rdac_dh_data *h = get_rdac_data(sdev);
		
	RDAC_DEBUG(RDAC_LOG_SENSE, sdev, "array %s, ctlr %d, "
			"command returned with sense %02x/%02x/%02x",
			(char *) h->ctlr->array_name, h->ctlr->index,
			sense_hdr->sense_key, sense_hdr->asc, sense_hdr->ascq);

	switch (sense_hdr->sense_key) {
	case NOT_READY:
		if (sense_hdr->asc == 0x04 && sense_hdr->ascq == 0x01)
			/* LUN Not Ready - Logical Unit Not Ready and is in
			* the process of becoming ready
			* Just retry.
			*/
			return ADD_TO_MLQUEUE;
		if (sense_hdr->asc == 0x04 && sense_hdr->ascq == 0x81)
			/* LUN Not Ready - Storage firmware incompatible
			 * Manual code synchonisation required.
			 *
			 * Nothing we can do here. Try to bypass the path.
			 */
			return SUCCESS;
		if (sense_hdr->asc == 0x04 && sense_hdr->ascq == 0xA1)
			/* LUN Not Ready - Quiescense in progress
			 *
			 * Just retry and wait.
			 */
			return ADD_TO_MLQUEUE;
		if (sense_hdr->asc == 0xA1  && sense_hdr->ascq == 0x02)
			/* LUN Not Ready - Quiescense in progress
			 * or has been achieved
			 * Just retry.
			 */
			return ADD_TO_MLQUEUE;
		break;
	case ILLEGAL_REQUEST:
		if (sense_hdr->asc == 0x94 && sense_hdr->ascq == 0x01) {
			/* Invalid Request - Current Logical Unit Ownership.
			 * Controller is not the current owner of the LUN,
			 * Fail the path, so that the other path be used.
			 */
			h->state = RDAC_STATE_PASSIVE;
			return SUCCESS;
		}
		break;
	case UNIT_ATTENTION:
		if (sense_hdr->asc == 0x29 && sense_hdr->ascq == 0x00)
			/*
			 * Power On, Reset, or Bus Device Reset, just retry.
			 */
			return ADD_TO_MLQUEUE;
		if (sense_hdr->asc == 0x8b && sense_hdr->ascq == 0x02)
			/*
			 * Quiescence in progress , just retry.
			 */
			return ADD_TO_MLQUEUE;
		break;
	}
	/* success just means we do not care what scsi-ml does */
	return SCSI_RETURN_NOT_HANDLED;
}

static const struct scsi_dh_devlist rdac_dev_list[] = {
	{"IBM", "1722"},
	{"IBM", "1724"},
	{"IBM", "1726"},
	{"IBM", "1742"},
	{"IBM", "1814"},
	{"IBM", "1815"},
	{"IBM", "1818"},
	{"IBM", "3526"},
	{"SGI", "TP9400"},
	{"SGI", "TP9500"},
	{"SGI", "IS"},
	{"STK", "OPENstorage D280"},
	{"SUN", "CSM200_R"},
	{"SUN", "LCSM100_F"},
	{"DELL", "MD3000"},
	{"DELL", "MD3000i"},
	{"LSI", "INF-01-00"},
	{"ENGENIO", "INF-01-00"},
	{NULL, NULL},
};

static int rdac_bus_attach(struct scsi_device *sdev);
static void rdac_bus_detach(struct scsi_device *sdev);

static struct scsi_device_handler rdac_dh = {
	.name = RDAC_NAME,
	.module = THIS_MODULE,
	.devlist = rdac_dev_list,
	.prep_fn = rdac_prep_fn,
	.check_sense = rdac_check_sense,
	.attach = rdac_bus_attach,
	.detach = rdac_bus_detach,
	.activate = rdac_activate,
};

static int rdac_bus_attach(struct scsi_device *sdev)
{
	struct scsi_dh_data *scsi_dh_data;
	struct rdac_dh_data *h;
	unsigned long flags;
	int err;

	scsi_dh_data = kzalloc(sizeof(struct scsi_device_handler *)
			       + sizeof(*h) , GFP_KERNEL);
	if (!scsi_dh_data) {
		sdev_printk(KERN_ERR, sdev, "%s: Attach failed\n",
			    RDAC_NAME);
		return 0;
	}

	scsi_dh_data->scsi_dh = &rdac_dh;
	h = (struct rdac_dh_data *) scsi_dh_data->buf;
	h->lun = UNINITIALIZED_LUN;
	h->state = RDAC_STATE_ACTIVE;

	err = get_lun(sdev, h);
	if (err != SCSI_DH_OK)
		goto failed;

	err = check_ownership(sdev, h);
	if (err != SCSI_DH_OK)
		goto failed;

	if (!h->ctlr) {
		err = initialize_controller(sdev, h);
		if (err != SCSI_DH_OK)
			goto failed;
		
		err = get_array_name(sdev, h);
		if (err != SCSI_DH_OK)
			goto failed;
	}

	if (!try_module_get(THIS_MODULE))
		goto failed;

	spin_lock_irqsave(sdev->request_queue->queue_lock, flags);
	sdev->scsi_dh_data = scsi_dh_data;
	spin_unlock_irqrestore(sdev->request_queue->queue_lock, flags);

	sdev_printk(KERN_NOTICE, sdev,
		    "%s: LUN %d (%s)\n",
		    RDAC_NAME, h->lun, lun_state[(int)h->lun_state]);

	return 0;

failed:
	kfree(scsi_dh_data);
	sdev_printk(KERN_ERR, sdev, "%s: not attached\n",
		    RDAC_NAME);
	return -EINVAL;
}

static void rdac_bus_detach( struct scsi_device *sdev )
{
	struct scsi_dh_data *scsi_dh_data;
	struct rdac_dh_data *h;
	unsigned long flags;

	spin_lock_irqsave(sdev->request_queue->queue_lock, flags);
	scsi_dh_data = sdev->scsi_dh_data;
	sdev->scsi_dh_data = NULL;
	spin_unlock_irqrestore(sdev->request_queue->queue_lock, flags);

	h = (struct rdac_dh_data *) scsi_dh_data->buf;
	if (h->ctlr)
		kref_put(&h->ctlr->kref, release_controller);
	kfree(scsi_dh_data);
	module_put(THIS_MODULE);
	sdev_printk(KERN_NOTICE, sdev, "%s: Detached\n", RDAC_NAME);
}



static int __init rdac_init(void)
{
	int r;

	r = scsi_register_device_handler(&rdac_dh);
	if (r != 0)
		printk(KERN_ERR "Failed to register scsi device handler.");
	return r;
}

static void __exit rdac_exit(void)
{
	scsi_unregister_device_handler(&rdac_dh);
}

module_init(rdac_init);
module_exit(rdac_exit);

MODULE_DESCRIPTION("Multipath LSI/Engenio RDAC driver");
MODULE_AUTHOR("Mike Christie, Chandra Seetharaman");
MODULE_LICENSE("GPL");

[-- Attachment #3: Type: text/plain, Size: 0 bytes --]



^ permalink raw reply	[flat|nested] 9+ messages in thread

* Re: rdac path failure - Sun 6140
  2009-08-14  0:05       ` Moger, Babu
@ 2009-08-14 15:58         ` Stewart Smith
  2009-08-14 16:21           ` Moger, Babu
  0 siblings, 1 reply; 9+ messages in thread
From: Stewart Smith @ 2009-08-14 15:58 UTC (permalink / raw)
  To: device-mapper development

I will test this today.

Does everything look OK from a configuration standpoint?  Should the
RDAC virtual HBA drivers from LSI be a requirement?  I am not
currently using them.

Thank you,
--
Stew




On Thu, Aug 13, 2009 at 5:05 PM, Moger, Babu<Babu.Moger@lsi.com> wrote:
> Stew,
>
>      I don’t see much information about this failure in the logs. Right now
> device handlers don’t provide much information on failures.  We are working
> on to add some more debug levels.  I am attaching my draft code
> (scsi_dh_rdac.c) here.  Please use this only for your testing. It is not
> been approved/reviewed yet. I still need to submit this one to community for
> approval. The code is attached.  Please replace this file with
> scsi_dh_rdac.c in the directory /driver/scsi/device_handlers and rebuild the
> kernel.  This should give more information from the target point of view.
> Please send me the /var/log/messages file after the failure. Let see if we
> can get more information..
>
>
>
> Thanks
>
> Babu Moger
>
> ________________________________
>
> From: dm-devel-bounces@redhat.com [mailto:dm-devel-bounces@redhat.com] On
> Behalf Of Stewart Smith
> Sent: Thursday, August 13, 2009 3:35 PM
> To: device-mapper development
> Subject: Re: [dm-devel] rdac path failure - Sun 6140
>
>
>
>
>
> Same sequence of events, with multipathd -v3
>
>
>
> Aug 13 16:28:48.627  kernel: device-mapper: multipath: Failing path 8:208.
>
> Aug 13 16:28:48.000  multipathd: vol1: rr_weight = 2 (LUN setting)
>
> Aug 13 16:28:48.000  multipathd: vol1: pgfailback = -2 (controller setting)
>
> Aug 13 16:28:48.000  multipathd: pg_timeout = NONE (internal default)
>
> Aug 13 16:28:48.000  multipathd: 8:208: mark as failed
>
> Aug 13 16:28:48.000  multipathd: uevent 'change' from
> '/devices/virtual/block/dm-1'
>
> Aug 13 16:28:48.000  multipathd: UDEV_LOG=3
>
> Aug 13 16:28:48.000  multipathd: ACTION=change
>
> Aug 13 16:28:48.000  multipathd: DEVPATH=/devices/virtual/block/dm-1
>
> Aug 13 16:28:48.000  multipathd: SUBSYSTEM=block
>
> Aug 13 16:28:48.000  multipathd: DM_TARGET=multipath
>
> Aug 13 16:28:48.000  multipathd: DM_ACTION=PATH_FAILED
>
> Aug 13 16:28:48.000  multipathd: DM_SEQNUM=1
>
> Aug 13 16:28:48.000  multipathd: DM_PATH=8:208
>
> Aug 13 16:28:48.000  multipathd: DM_NR_VALID_PATHS=3
>
> Aug 13 16:28:48.000  multipathd: DM_NAME=vol1
>
> Aug 13 16:28:48.000  multipathd:
> DM_UUID=mpath-3600a0b800048335200001e5d48b68a9b
>
> Aug 13 16:28:48.000  multipathd: MAJOR=253
>
> Aug 13 16:28:48.000  multipathd: MINOR=1
>
> Aug 13 16:28:48.000  multipathd: DEVTYPE=disk
>
> Aug 13 16:28:48.000  multipathd: SEQNUM=1738
>
> Aug 13 16:28:48.000  multipathd: UDEVD_EVENT=1
>
> Aug 13 16:28:48.000  multipathd: DEVNAME=/dev/dm-1
>
> Aug 13 16:28:50.000  multipathd: 8:208: reinstated
>
> Aug 13 16:28:50.000  multipathd: vol1: remaining active paths: 4
>
> Aug 13 16:28:50.000  multipathd: sdj: rdac prio = 3
>
> Aug 13 16:28:50.000  multipathd: sdn: rdac prio = 3
>
> Aug 13 16:28:50.000  multipathd: sdb: rdac prio = 0
>
> Aug 13 16:28:50.000  multipathd: sdd: rdac prio = 0
>
> Aug 13 16:28:50.763  kernel: device-mapper: multipath: Failing path 8:208.
>
> Aug 13 16:28:50.000  multipathd: uevent 'change' from
> '/devices/virtual/block/dm-1'
>
> Aug 13 16:28:50.000  multipathd: UDEV_LOG=3
>
> Aug 13 16:28:50.000  multipathd: ACTION=change
>
> Aug 13 16:28:50.000  multipathd: DEVPATH=/devices/virtual/block/dm-1
>
> Aug 13 16:28:50.000  multipathd: SUBSYSTEM=block
>
> Aug 13 16:28:50.000  multipathd: DM_TARGET=multipath
>
> Aug 13 16:28:50.000  multipathd: DM_ACTION=PATH_REINSTATED
>
> Aug 13 16:28:50.000  multipathd: DM_SEQNUM=2
>
> Aug 13 16:28:50.000  multipathd: DM_PATH=8:208
>
> Aug 13 16:28:50.000  multipathd: DM_NR_VALID_PATHS=4
>
> Aug 13 16:28:50.000  multipathd: DM_NAME=vol1
>
> Aug 13 16:28:50.000  multipathd:
> DM_UUID=mpath-3600a0b800048335200001e5d48b68a9b
>
> Aug 13 16:28:50.000  multipathd: MAJOR=253
>
> Aug 13 16:28:50.000  multipathd: MINOR=1
>
> Aug 13 16:28:50.000  multipathd: DEVTYPE=diskAug 13 16:28:50.000
>  multipathd: SEQNUM=1739Aug 13 16:28:50.000  multipathd: UDEVD_EVENT=1
>
> Aug 13 16:28:50.000  multipathd: vol1: rr_weight = 2 (LUN setting)
>
> Aug 13 16:28:50.000  multipathd: vol1: pgfailback = -2 (controller setting)
>
> Aug 13 16:28:50.000  multipathd: pg_timeout = NONE (internal default)
>
> Aug 13 16:28:50.000  multipathd: 8:208: mark as failed
>
> Aug 13 16:28:50.000  multipathd: vol1: remaining active paths: 3
>
> Aug 13 16:28:50.000  multipathd: vol1: rr_weight = 2 (LUN setting)
>
> Aug 13 16:28:50.000  multipathd: vol1: pgfailback = -2 (controller setting)
>
> Aug 13 16:28:50.000  multipathd: uevent 'change' from
> '/devices/virtual/block/dm-1'
>
> Aug 13 16:28:50.000  multipathd: UDEV_LOG=3
>
> Aug 13 16:28:50.000  multipathd: ACTION=change
>
> Aug 13 16:28:50.000  multipathd: DEVPATH=/devices/virtual/block/dm-1
>
> Aug 13 16:28:50.000  multipathd: SUBSYSTEM=block
>
> Aug 13 16:28:50.000  multipathd: DM_TARGET=multipath
>
> Aug 13 16:28:50.000  multipathd: DM_ACTION=PATH_FAILED
>
> Aug 13 16:28:50.000  multipathd: DM_SEQNUM=3
>
> Aug 13 16:28:50.000  multipathd: DM_PATH=8:208
>
> Aug 13 16:28:50.000  multipathd: DM_NR_VALID_PATHS=3
>
> Aug 13 16:28:50.000  multipathd: DM_NAME=vol1
>
> Aug 13 16:28:50.000  multipathd:
> DM_UUID=mpath-3600a0b800048335200001e5d48b68a9b
>
> Aug 13 16:28:50.000  multipathd: MAJOR=253
>
> Aug 13 16:28:50.000  multipathd: MINOR=1
>
> Aug 13 16:28:50.000  multipathd: DEVTYPE=disk
>
> Aug 13 16:28:50.000  multipathd: SEQNUM=1740
>
> Aug 13 16:28:50.000  multipathd: UDEVD_EVENT=1
>
> Aug 13 16:28:50.000  multipathd: DEVNAME=/dev/dm-1
>
> Aug 13 16:29:00.000  multipathd: 8:208: reinstated
>
> Aug 13 16:29:00.000  multipathd: vol1: remaining active paths: 4
>
> Aug 13 16:29:00.000  multipathd: sdj: rdac prio = 3
>
> Aug 13 16:29:00.000  multipathd: sdn: rdac prio = 3
>
> Aug 13 16:29:00.000  multipathd: sdb: rdac prio = 0
>
> Aug 13 16:29:00.000  multipathd: sdd: rdac prio = 0
>
> Aug 13 16:29:00.000  multipathd: vol1: rr_weight = 2 (LUN setting)
>
> Aug 13 16:29:00.000  multipathd: vol1: pgfailback = -2 (controller setting)
>
> Aug 13 16:29:00.000  multipathd: uevent 'change' from
> '/devices/virtual/block/dm-1'
>
> Aug 13 16:29:00.000  multipathd: UDEV_LOG=3
>
> Aug 13 16:29:00.000  multipathd: ACTION=change
>
> Aug 13 16:29:00.000  multipathd: DEVPATH=/devices/virtual/block/dm-1
>
> Aug 13 16:29:00.000  multipathd: SUBSYSTEM=block
>
> Aug 13 16:29:00.000  multipathd: DM_TARGET=multipath
>
> Aug 13 16:29:00.000  multipathd: DM_ACTION=PATH_REINSTATED
>
> Aug 13 16:29:00.000  multipathd: DM_SEQNUM=4
>
> Aug 13 16:29:00.000  multipathd: DM_PATH=8:208
>
> Aug 13 16:29:00.000  multipathd: DM_NR_VALID_PATHS=4
>
> Aug 13 16:29:00.000  multipathd: DM_NAME=vol1
>
> Aug 13 16:29:00.000  multipathd:
> DM_UUID=mpath-3600a0b800048335200001e5d48b68a9b
>
> Aug 13 16:29:00.000  multipathd: MAJOR=253
>
> Aug 13 16:29:00.000  multipathd: MINOR=1
>
> Aug 13 16:29:00.000  multipathd: DEVTYPE=disk
>
> Aug 13 16:29:00.000  multipathd: SEQNUM=1741
>
> Aug 13 16:29:00.000  multipathd: UDEVD_EVENT=1
>
> Aug 13 16:29:00.000  multipathd: DEVNAME=/dev/dm-1
>
> Aug 13 16:29:02.753  kernel: device-mapper: multipath: Failing path 8:208.
>
> Aug 13 16:29:02.000  multipathd: vol1: rr_weight = 2 (LUN setting)
>
> Aug 13 16:29:02.000  multipathd: vol1: pgfailback = -2 (controller setting)
>
> Aug 13 16:29:02.000  multipathd: pg_timeout = NONE (internal default)
>
> Aug 13 16:29:02.000  multipathd: 8:208: mark as failed
>
> Aug 13 16:29:02.000  multipathd: uevent 'change' from
> '/devices/virtual/block/dm-1'
>
> Aug 13 16:29:02.000  multipathd: UDEV_LOG=3
>
> Aug 13 16:29:02.000  multipathd: ACTION=change
>
> Aug 13 16:29:02.000  multipathd: DEVPATH=/devices/virtual/block/dm-1
>
> Aug 13 16:29:02.000  multipathd: SUBSYSTEM=block
>
> Aug 13 16:29:02.000  multipathd: DM_TARGET=multipath
>
> Aug 13 16:29:02.000  multipathd: DM_ACTION=PATH_FAILED
>
> Aug 13 16:29:02.000  multipathd: DM_SEQNUM=5
>
> Aug 13 16:29:02.000  multipathd: DM_PATH=8:208
>
> Aug 13 16:29:02.000  multipathd: DM_NR_VALID_PATHS=3
>
> Aug 13 16:29:02.000  multipathd: DM_NAME=vol1
>
> Aug 13 16:29:02.000  multipathd:
> DM_UUID=mpath-3600a0b800048335200001e5d48b68a9b
>
> Aug 13 16:29:02.000  multipathd: MAJOR=253
>
> Aug 13 16:29:02.000  multipathd: MINOR=1
>
> Aug 13 16:29:02.000  multipathd: DEVTYPE=disk
>
> Aug 13 16:29:02.000  multipathd: SEQNUM=1742
>
> Aug 13 16:29:02.000  multipathd: UDEVD_EVENT=1
>
> Aug 13 16:29:02.000  multipathd: DEVNAME=/dev/dm-1
>
> Aug 13 16:29:10.000  multipathd: 8:208: reinstated
>
> Aug 13 16:29:10.000  multipathd: vol1: remaining active paths: 4
>
> Aug 13 16:29:10.000  multipathd: sdj: rdac prio = 3
>
> Aug 13 16:29:10.000  multipathd: sdn: rdac prio = 3
>
> Aug 13 16:29:10.000  multipathd: sdb: rdac prio = 0
>
> Aug 13 16:29:10.000  multipathd: sdd: rdac prio = 0
>
> Aug 13 16:29:10.000  multipathd: vol1: rr_weight = 2 (LUN setting)
>
> Aug 13 16:29:10.000  multipathd: vol1: pgfailback = -2 (controller setting)
>
> Aug 13 16:29:10.000  multipathd: uevent 'change' from
> '/devices/virtual/block/dm-1'
>
> Aug 13 16:29:10.000  multipathd: UDEV_LOG=3
>
> Aug 13 16:29:10.000  multipathd: ACTION=change
>
> Aug 13 16:29:10.000  multipathd: DEVPATH=/devices/virtual/block/dm-1
>
> Aug 13 16:29:10.000  multipathd: SUBSYSTEM=block
>
> Aug 13 16:29:10.000  multipathd: DM_TARGET=multipath
>
> Aug 13 16:29:10.000  multipathd: DM_ACTION=PATH_REINSTATED
>
> Aug 13 16:29:10.000  multipathd: DM_SEQNUM=6
>
> Aug 13 16:29:10.000  multipathd: DM_PATH=8:208
>
> Aug 13 16:29:10.000  multipathd: DM_NR_VALID_PATHS=4
>
> Aug 13 16:29:10.000  multipathd: DM_NAME=vol1
>
> Aug 13 16:29:10.000  multipathd:
> DM_UUID=mpath-3600a0b800048335200001e5d48b68a9b
>
> Aug 13 16:29:10.000  multipathd: MAJOR=253
>
> Aug 13 16:29:10.000  multipathd: MINOR=1
>
> Aug 13 16:29:10.000  multipathd: DEVTYPE=disk
>
> Aug 13 16:29:10.000  multipathd: SEQNUM=1743
>
> Aug 13 16:29:10.000  multipathd: UDEVD_EVENT=1
>
> Aug 13 16:29:10.000  multipathd: DEVNAME=/dev/dm-1
>
>
>
>
>
>
>
>
>
> On Thu, Aug 13, 2009 at 1:27 PM, Stewart Smith <stew@cleepdar.com> wrote:
>
>
>
> after a fresh, multipath -F and start of multipathd with -v 2 I see the
> following messages.
>
>
>
> After starting multipathd I mounted /dev/mapper/vol1 and generated some
> simple I/O to it using dd
>
>
>
>
>
> Aug 13 16:23:14.888 localhost kernel: device-mapper: multipath: Failing path
> 8:208.
>
> Aug 13 16:23:14.000 localhost multipathd: 8:208: mark as failed
>
> Aug 13 16:23:16.000 localhost multipathd: 8:208: reinstated
>
> Aug 13 16:23:30.462 localhost kernel: device-mapper: multipath: Failing path
> 8:208.
>
> Aug 13 16:23:30.000 localhost multipathd: 8:208: mark as failed
>
> Aug 13 16:23:39.000 localhost multipathd: 8:208: reinstated
>
> Aug 13 16:23:46.430 localhost kernel: device-mapper: multipath: Failing path
> 8:208.
>
> Aug 13 16:23:46.000 localhost multipathd: 8:208: mark as failed
>
> Aug 13 16:23:51.041 localhost kernel: device-mapper: multipath: Failing path
> 8:208.
>
> Aug 13 16:23:51.000 localhost multipathd: 8:208: mark as failed
>
> Aug 13 16:23:59.000 localhost multipathd: 8:208: reinstated
>
> Aug 13 16:24:06.465 localhost kernel: device-mapper: multipath: Failing path
> 8:208.
>
> Aug 13 16:24:06.000 localhost multipathd: 8:208: mark as failed
>
> Aug 13 16:24:09.000 localhost multipathd: 8:208: reinstated
>
>
>
>
>
> Thanks,
>
> --
>
> Stew
>
>
>
>
>
>
>
> On Thu, Aug 13, 2009 at 12:42 PM, Moger, Babu <Babu.Moger@lsi.com> wrote:
>
> Do you have /var/log/messages file for this problem?
>
> Thanks
> Babu Moger
>
>> -----Original Message-----
>> From: dm-devel-bounces@redhat.com [mailto:dm-devel-bounces@redhat.com] On
>> Behalf Of Stewart Smith
>> Sent: Thursday, August 13, 2009 1:51 PM
>> To: dm-devel@redhat.com
>> Subject: [dm-devel] rdac path failure - Sun 6140
>>
>> Hello All,
>>
>> I am seeing many of these messages when my Sun 6140 array is under heavy
>> I/O
>> device-mapper: multipath: Failing path 8:208.
>> device-mapper: multipath: Failing path 8:208.
>> device-mapper: multipath: Failing path 8:208.
>> device-mapper: multipath: Failing path 8:208.
>> device-mapper: multipath: Failing path 8:208.
>>
>>
>> I am running a Fedora 10 server, with two fiber connections to two
>> different switches.  Both controllers on the 6140 have one connection
>> to each switch as well.  The end result is that I see four paths to
>> each LUN.
>>
>> When the volume is mounted and under significant load I see the
>> messages above every few seconds.  They seem to appear every
>> "no_path_retry" seconds.
>>
>> The 6140 controller firmware is up to date at version 07.50.08.10 and
>> I have installed the latest firmware for my Emulex LPe11002 cards.  I
>> have reproduced the problem using both Cisco MDS and Brocade fiber
>> channel switches as well.
>>
>> Using CAM, I have set the initiator Host Type to "Linux" at the
>> moment.  I have tried other options as well without success.
>>
>> I have NOT installed the RDAC drivers from either Sun or LSI -
>> primarily because they do not seem to build on my Fedora 10 kernel.
>>
>> Any ideas would be greatly appreciated!!!
>>
>> configs and debugging multipathd output is below.
>>
>>
>>
>>
>>
>> Kernel: 2.6.27.24-170.2.68.fc10.x86_64
>>
>> # multipath -lll
>> vol1 (3600a0b800048335200001e5d48b68a9b) dm-1 SUN,CSM200_R
>> [size=12T][features=1 queue_if_no_path][hwhandler=1 rdac][rw]
>> \_ round-robin 0 [prio=6][active]
>>  \_ 5:0:1:2 sdj 8:144 [active][ready]
>>  \_ 2:0:1:2 sdn 8:208 [active][ready]
>> \_ round-robin 0 [prio=0][enabled]
>>  \_ 2:0:0:2 sdb 8:16  [active][ghost]
>>  \_ 5:0:0:2 sdd 8:48  [active][ghost]
>>
>>
>> # cat /etc/multipath.conf
>>
>> blacklist {
>>         devnode "^sd[a-z][[0-9]*]"
>>         devnode "^(ram|raw|loop|fd|md|dm-|sr|scd|st)[0-9]*"
>>         devnode "^hd[a-z][0-9]*"
>>         devnode "^cciss!c[0-9]d[0-9](p[0-9]*)*"
>> }
>>
>> defaults {
>>         udev_dir                /dev
>>         polling_interval        10
>>         selector                "round-robin 0"
>>         path_grouping_policy    multibus
>>         getuid_callout          "/sbin/scsi_id --whitelisted /dev/%n"
>>         prio                    alua
>>         path_checker            readsector0
>>         rr_min_io               100
>>         max_fds                 8192
>>         rr_weight               priorities
>>         failback                immediate
>>         no_path_retry           fail
>>         user_friendly_names     yes
>> }
>> devices {
>>         device {
>>                 vendor                  "SUN"
>>                 product                 "CSM200_R"
>>                 product_blacklist       "Universal Xport"
>>                 getuid_callout          "/sbin/scsi_id --whitelisted
>> /dev/%n"
>>                 features                "0"
>>                 hardware_handler        "1 rdac"
>>                 path_selector           "round-robin 0"
>>                 path_grouping_policy    group_by_prio
>>                 failback                immediate
>>                 rr_weight               uniform
>>                 no_path_retry           queue
>>                 rr_min_io               1000
>>                 path_checker            rdac
>>                 prio                    rdac
>>         }
>> }
>>
>> multipaths {
>>         multipath {
>>                 wwid                    3600a0b800048335200001e5d48b68a9b
>>                 alias                   vol1
>>                 rr_weight               priorities
>>                 no_path_retry           5
>>                 rr_min_io               100
>>         }
>> }
>>
>>
>>
>> # multipathd -d v3
>>
>>
>> Aug 13 14:48:53 | sdb: ownership set to vol1
>> Aug 13 14:48:53 | sdb: not found in pathvec
>> Aug 13 14:48:53 | sdb: mask = 0xc
>> Aug 13 14:48:53 | sdb: path checker = rdac (controller setting)
>> Aug 13 14:48:53 | sdb: state = 4
>> Aug 13 14:48:53 | sdb: rdac prio = 0
>> Aug 13 14:48:53 | sdd: ownership set to vol1
>> Aug 13 14:48:53 | sdd: not found in pathvec
>> Aug 13 14:48:53 | sdd: mask = 0xc
>> Aug 13 14:48:53 | sdd: path checker = rdac (controller setting)
>> Aug 13 14:48:53 | sdd: state = 4
>> Aug 13 14:48:53 | sdd: rdac prio = 0
>> Aug 13 14:48:53 | sdj: ownership set to vol1
>> Aug 13 14:48:53 | sdj: not found in pathvec
>> Aug 13 14:48:53 | sdj: mask = 0xc
>> Aug 13 14:48:53 | sdj: path checker = rdac (controller setting)
>> Aug 13 14:48:53 | sdj: state = 2
>> Aug 13 14:48:53 | sdj: rdac prio = 3
>> Aug 13 14:48:53 | sdn: ownership set to vol1
>> Aug 13 14:48:53 | sdn: not found in pathvec
>> Aug 13 14:48:53 | sdn: mask = 0xc
>> Aug 13 14:48:53 | sdn: path checker = rdac (controller setting)
>> Aug 13 14:48:53 | sdn: state = 2
>> Aug 13 14:48:53 | sdn: rdac prio = 3
>> Aug 13 14:48:53 | vol1: pgfailback = -2 (controller setting)
>> Aug 13 14:48:53 | vol1: pgpolicy = group_by_prio (controller setting)
>> Aug 13 14:48:53 | vol1: selector = round-robin 0 (controller setting)
>> Aug 13 14:48:53 | vol1: features = 0 (controller setting)
>> Aug 13 14:48:53 | vol1: hwhandler = 1 rdac (controller setting)
>> Aug 13 14:48:53 | vol1: rr_weight = 2 (LUN setting)
>> Aug 13 14:48:53 | vol1: minio = 100 (LUN setting)
>> Aug 13 14:48:53 | vol1: no_path_retry = 5 (multipath setting)
>> Aug 13 14:48:53 | pg_timeout = NONE (internal default)
>> Aug 13 14:48:53 | vol1: set ACT_CREATE (map does not exist)
>> create: vol1 (3600a0b800048335200001e5d48b68a9b) n/a SUN,CSM200_R
>> [size=12T][features=0][hwhandler=1 rdac][n/a]
>> \_ round-robin 0 [prio=6][undef]
>>  \_ 5:0:1:2 sdj 8:144 [undef][ready]
>>  \_ 2:0:1:2 sdn 8:208 [undef][ready]
>> \_ round-robin 0 [prio=0][undef]
>>  \_ 2:0:0:2 sdb 8:16 [undef][ghost]
>>  \_ 5:0:0:2 sdd 8:48 [undef][ghost]
>>
>
>> --
>> dm-devel mailing list
>> dm-devel@redhat.com
>> https://www.redhat.com/mailman/listinfo/dm-devel
>
> --
> dm-devel mailing list
> dm-devel@redhat.com
> https://www.redhat.com/mailman/listinfo/dm-devel
>
>
>
>

^ permalink raw reply	[flat|nested] 9+ messages in thread

* RE: rdac path failure - Sun 6140
  2009-08-14 15:58         ` Stewart Smith
@ 2009-08-14 16:21           ` Moger, Babu
  2009-08-14 20:26             ` Stewart Smith
  0 siblings, 1 reply; 9+ messages in thread
From: Moger, Babu @ 2009-08-14 16:21 UTC (permalink / raw)
  To: device-mapper development

> -----Original Message-----
> From: dm-devel-bounces@redhat.com [mailto:dm-devel-bounces@redhat.com] On
> Behalf Of Stewart Smith
> Sent: Friday, August 14, 2009 10:58 AM
> To: device-mapper development
> Subject: Re: [dm-devel] rdac path failure - Sun 6140
>
> I will test this today.
>
> Does everything look OK from a configuration standpoint?  Should the

 I have verified your configuration file. It looks fine..

> RDAC virtual HBA drivers from LSI be a requirement?  I am not
> currently using them.

 You can't use both the solutions at once. You are fine..

> Thank you,
> --
> Stew
>
>
>
>
> On Thu, Aug 13, 2009 at 5:05 PM, Moger, Babu<Babu.Moger@lsi.com> wrote:
> > Stew,
> >
> >      I don’t see much information about this failure in the logs. Right
> now
> > device handlers don’t provide much information on failures.  We are
> working
> > on to add some more debug levels.  I am attaching my draft code
> > (scsi_dh_rdac.c) here.  Please use this only for your testing. It is not
> > been approved/reviewed yet. I still need to submit this one to community
> for
> > approval. The code is attached.  Please replace this file with
> > scsi_dh_rdac.c in the directory /driver/scsi/device_handlers and rebuild
> the
> > kernel.  This should give more information from the target point of
> view.
> > Please send me the /var/log/messages file after the failure. Let see if
> we
> > can get more information..
> >
> >
> >
> > Thanks
> >
> > Babu Moger
> >
> > ________________________________
> >
> > From: dm-devel-bounces@redhat.com [mailto:dm-devel-bounces@redhat.com]
> On
> > Behalf Of Stewart Smith
> > Sent: Thursday, August 13, 2009 3:35 PM
> > To: device-mapper development
> > Subject: Re: [dm-devel] rdac path failure - Sun 6140
> >
> >
> >
> >
> >
> > Same sequence of events, with multipathd -v3
> >
> >
> >
> > Aug 13 16:28:48.627  kernel: device-mapper: multipath: Failing path
> 8:208.
> >
> > Aug 13 16:28:48.000  multipathd: vol1: rr_weight = 2 (LUN setting)
> >
> > Aug 13 16:28:48.000  multipathd: vol1: pgfailback = -2 (controller
> setting)
> >
> > Aug 13 16:28:48.000  multipathd: pg_timeout = NONE (internal default)
> >
> > Aug 13 16:28:48.000  multipathd: 8:208: mark as failed
> >
> > Aug 13 16:28:48.000  multipathd: uevent 'change' from
> > '/devices/virtual/block/dm-1'
> >
> > Aug 13 16:28:48.000  multipathd: UDEV_LOG=3
> >
> > Aug 13 16:28:48.000  multipathd: ACTION=change
> >
> > Aug 13 16:28:48.000  multipathd: DEVPATH=/devices/virtual/block/dm-1
> >
> > Aug 13 16:28:48.000  multipathd: SUBSYSTEM=block
> >
> > Aug 13 16:28:48.000  multipathd: DM_TARGET=multipath
> >
> > Aug 13 16:28:48.000  multipathd: DM_ACTION=PATH_FAILED
> >
> > Aug 13 16:28:48.000  multipathd: DM_SEQNUM=1
> >
> > Aug 13 16:28:48.000  multipathd: DM_PATH=8:208
> >
> > Aug 13 16:28:48.000  multipathd: DM_NR_VALID_PATHS=3
> >
> > Aug 13 16:28:48.000  multipathd: DM_NAME=vol1
> >
> > Aug 13 16:28:48.000  multipathd:
> > DM_UUID=mpath-3600a0b800048335200001e5d48b68a9b
> >
> > Aug 13 16:28:48.000  multipathd: MAJOR=253
> >
> > Aug 13 16:28:48.000  multipathd: MINOR=1
> >
> > Aug 13 16:28:48.000  multipathd: DEVTYPE=disk
> >
> > Aug 13 16:28:48.000  multipathd: SEQNUM=1738
> >
> > Aug 13 16:28:48.000  multipathd: UDEVD_EVENT=1
> >
> > Aug 13 16:28:48.000  multipathd: DEVNAME=/dev/dm-1
> >
> > Aug 13 16:28:50.000  multipathd: 8:208: reinstated
> >
> > Aug 13 16:28:50.000  multipathd: vol1: remaining active paths: 4
> >
> > Aug 13 16:28:50.000  multipathd: sdj: rdac prio = 3
> >
> > Aug 13 16:28:50.000  multipathd: sdn: rdac prio = 3
> >
> > Aug 13 16:28:50.000  multipathd: sdb: rdac prio = 0
> >
> > Aug 13 16:28:50.000  multipathd: sdd: rdac prio = 0
> >
> > Aug 13 16:28:50.763  kernel: device-mapper: multipath: Failing path
> 8:208.
> >
> > Aug 13 16:28:50.000  multipathd: uevent 'change' from
> > '/devices/virtual/block/dm-1'
> >
> > Aug 13 16:28:50.000  multipathd: UDEV_LOG=3
> >
> > Aug 13 16:28:50.000  multipathd: ACTION=change
> >
> > Aug 13 16:28:50.000  multipathd: DEVPATH=/devices/virtual/block/dm-1
> >
> > Aug 13 16:28:50.000  multipathd: SUBSYSTEM=block
> >
> > Aug 13 16:28:50.000  multipathd: DM_TARGET=multipath
> >
> > Aug 13 16:28:50.000  multipathd: DM_ACTION=PATH_REINSTATED
> >
> > Aug 13 16:28:50.000  multipathd: DM_SEQNUM=2
> >
> > Aug 13 16:28:50.000  multipathd: DM_PATH=8:208
> >
> > Aug 13 16:28:50.000  multipathd: DM_NR_VALID_PATHS=4
> >
> > Aug 13 16:28:50.000  multipathd: DM_NAME=vol1
> >
> > Aug 13 16:28:50.000  multipathd:
> > DM_UUID=mpath-3600a0b800048335200001e5d48b68a9b
> >
> > Aug 13 16:28:50.000  multipathd: MAJOR=253
> >
> > Aug 13 16:28:50.000  multipathd: MINOR=1
> >
> > Aug 13 16:28:50.000  multipathd: DEVTYPE=diskAug 13 16:28:50.000
> >  multipathd: SEQNUM=1739Aug 13 16:28:50.000  multipathd: UDEVD_EVENT=1
> >
> > Aug 13 16:28:50.000  multipathd: vol1: rr_weight = 2 (LUN setting)
> >
> > Aug 13 16:28:50.000  multipathd: vol1: pgfailback = -2 (controller
> setting)
> >
> > Aug 13 16:28:50.000  multipathd: pg_timeout = NONE (internal default)
> >
> > Aug 13 16:28:50.000  multipathd: 8:208: mark as failed
> >
> > Aug 13 16:28:50.000  multipathd: vol1: remaining active paths: 3
> >
> > Aug 13 16:28:50.000  multipathd: vol1: rr_weight = 2 (LUN setting)
> >
> > Aug 13 16:28:50.000  multipathd: vol1: pgfailback = -2 (controller
> setting)
> >
> > Aug 13 16:28:50.000  multipathd: uevent 'change' from
> > '/devices/virtual/block/dm-1'
> >
> > Aug 13 16:28:50.000  multipathd: UDEV_LOG=3
> >
> > Aug 13 16:28:50.000  multipathd: ACTION=change
> >
> > Aug 13 16:28:50.000  multipathd: DEVPATH=/devices/virtual/block/dm-1
> >
> > Aug 13 16:28:50.000  multipathd: SUBSYSTEM=block
> >
> > Aug 13 16:28:50.000  multipathd: DM_TARGET=multipath
> >
> > Aug 13 16:28:50.000  multipathd: DM_ACTION=PATH_FAILED
> >
> > Aug 13 16:28:50.000  multipathd: DM_SEQNUM=3
> >
> > Aug 13 16:28:50.000  multipathd: DM_PATH=8:208
> >
> > Aug 13 16:28:50.000  multipathd: DM_NR_VALID_PATHS=3
> >
> > Aug 13 16:28:50.000  multipathd: DM_NAME=vol1
> >
> > Aug 13 16:28:50.000  multipathd:
> > DM_UUID=mpath-3600a0b800048335200001e5d48b68a9b
> >
> > Aug 13 16:28:50.000  multipathd: MAJOR=253
> >
> > Aug 13 16:28:50.000  multipathd: MINOR=1
> >
> > Aug 13 16:28:50.000  multipathd: DEVTYPE=disk
> >
> > Aug 13 16:28:50.000  multipathd: SEQNUM=1740
> >
> > Aug 13 16:28:50.000  multipathd: UDEVD_EVENT=1
> >
> > Aug 13 16:28:50.000  multipathd: DEVNAME=/dev/dm-1
> >
> > Aug 13 16:29:00.000  multipathd: 8:208: reinstated
> >
> > Aug 13 16:29:00.000  multipathd: vol1: remaining active paths: 4
> >
> > Aug 13 16:29:00.000  multipathd: sdj: rdac prio = 3
> >
> > Aug 13 16:29:00.000  multipathd: sdn: rdac prio = 3
> >
> > Aug 13 16:29:00.000  multipathd: sdb: rdac prio = 0
> >
> > Aug 13 16:29:00.000  multipathd: sdd: rdac prio = 0
> >
> > Aug 13 16:29:00.000  multipathd: vol1: rr_weight = 2 (LUN setting)
> >
> > Aug 13 16:29:00.000  multipathd: vol1: pgfailback = -2 (controller
> setting)
> >
> > Aug 13 16:29:00.000  multipathd: uevent 'change' from
> > '/devices/virtual/block/dm-1'
> >
> > Aug 13 16:29:00.000  multipathd: UDEV_LOG=3
> >
> > Aug 13 16:29:00.000  multipathd: ACTION=change
> >
> > Aug 13 16:29:00.000  multipathd: DEVPATH=/devices/virtual/block/dm-1
> >
> > Aug 13 16:29:00.000  multipathd: SUBSYSTEM=block
> >
> > Aug 13 16:29:00.000  multipathd: DM_TARGET=multipath
> >
> > Aug 13 16:29:00.000  multipathd: DM_ACTION=PATH_REINSTATED
> >
> > Aug 13 16:29:00.000  multipathd: DM_SEQNUM=4
> >
> > Aug 13 16:29:00.000  multipathd: DM_PATH=8:208
> >
> > Aug 13 16:29:00.000  multipathd: DM_NR_VALID_PATHS=4
> >
> > Aug 13 16:29:00.000  multipathd: DM_NAME=vol1
> >
> > Aug 13 16:29:00.000  multipathd:
> > DM_UUID=mpath-3600a0b800048335200001e5d48b68a9b
> >
> > Aug 13 16:29:00.000  multipathd: MAJOR=253
> >
> > Aug 13 16:29:00.000  multipathd: MINOR=1
> >
> > Aug 13 16:29:00.000  multipathd: DEVTYPE=disk
> >
> > Aug 13 16:29:00.000  multipathd: SEQNUM=1741
> >
> > Aug 13 16:29:00.000  multipathd: UDEVD_EVENT=1
> >
> > Aug 13 16:29:00.000  multipathd: DEVNAME=/dev/dm-1
> >
> > Aug 13 16:29:02.753  kernel: device-mapper: multipath: Failing path
> 8:208.
> >
> > Aug 13 16:29:02.000  multipathd: vol1: rr_weight = 2 (LUN setting)
> >
> > Aug 13 16:29:02.000  multipathd: vol1: pgfailback = -2 (controller
> setting)
> >
> > Aug 13 16:29:02.000  multipathd: pg_timeout = NONE (internal default)
> >
> > Aug 13 16:29:02.000  multipathd: 8:208: mark as failed
> >
> > Aug 13 16:29:02.000  multipathd: uevent 'change' from
> > '/devices/virtual/block/dm-1'
> >
> > Aug 13 16:29:02.000  multipathd: UDEV_LOG=3
> >
> > Aug 13 16:29:02.000  multipathd: ACTION=change
> >
> > Aug 13 16:29:02.000  multipathd: DEVPATH=/devices/virtual/block/dm-1
> >
> > Aug 13 16:29:02.000  multipathd: SUBSYSTEM=block
> >
> > Aug 13 16:29:02.000  multipathd: DM_TARGET=multipath
> >
> > Aug 13 16:29:02.000  multipathd: DM_ACTION=PATH_FAILED
> >
> > Aug 13 16:29:02.000  multipathd: DM_SEQNUM=5
> >
> > Aug 13 16:29:02.000  multipathd: DM_PATH=8:208
> >
> > Aug 13 16:29:02.000  multipathd: DM_NR_VALID_PATHS=3
> >
> > Aug 13 16:29:02.000  multipathd: DM_NAME=vol1
> >
> > Aug 13 16:29:02.000  multipathd:
> > DM_UUID=mpath-3600a0b800048335200001e5d48b68a9b
> >
> > Aug 13 16:29:02.000  multipathd: MAJOR=253
> >
> > Aug 13 16:29:02.000  multipathd: MINOR=1
> >
> > Aug 13 16:29:02.000  multipathd: DEVTYPE=disk
> >
> > Aug 13 16:29:02.000  multipathd: SEQNUM=1742
> >
> > Aug 13 16:29:02.000  multipathd: UDEVD_EVENT=1
> >
> > Aug 13 16:29:02.000  multipathd: DEVNAME=/dev/dm-1
> >
> > Aug 13 16:29:10.000  multipathd: 8:208: reinstated
> >
> > Aug 13 16:29:10.000  multipathd: vol1: remaining active paths: 4
> >
> > Aug 13 16:29:10.000  multipathd: sdj: rdac prio = 3
> >
> > Aug 13 16:29:10.000  multipathd: sdn: rdac prio = 3
> >
> > Aug 13 16:29:10.000  multipathd: sdb: rdac prio = 0
> >
> > Aug 13 16:29:10.000  multipathd: sdd: rdac prio = 0
> >
> > Aug 13 16:29:10.000  multipathd: vol1: rr_weight = 2 (LUN setting)
> >
> > Aug 13 16:29:10.000  multipathd: vol1: pgfailback = -2 (controller
> setting)
> >
> > Aug 13 16:29:10.000  multipathd: uevent 'change' from
> > '/devices/virtual/block/dm-1'
> >
> > Aug 13 16:29:10.000  multipathd: UDEV_LOG=3
> >
> > Aug 13 16:29:10.000  multipathd: ACTION=change
> >
> > Aug 13 16:29:10.000  multipathd: DEVPATH=/devices/virtual/block/dm-1
> >
> > Aug 13 16:29:10.000  multipathd: SUBSYSTEM=block
> >
> > Aug 13 16:29:10.000  multipathd: DM_TARGET=multipath
> >
> > Aug 13 16:29:10.000  multipathd: DM_ACTION=PATH_REINSTATED
> >
> > Aug 13 16:29:10.000  multipathd: DM_SEQNUM=6
> >
> > Aug 13 16:29:10.000  multipathd: DM_PATH=8:208
> >
> > Aug 13 16:29:10.000  multipathd: DM_NR_VALID_PATHS=4
> >
> > Aug 13 16:29:10.000  multipathd: DM_NAME=vol1
> >
> > Aug 13 16:29:10.000  multipathd:
> > DM_UUID=mpath-3600a0b800048335200001e5d48b68a9b
> >
> > Aug 13 16:29:10.000  multipathd: MAJOR=253
> >
> > Aug 13 16:29:10.000  multipathd: MINOR=1
> >
> > Aug 13 16:29:10.000  multipathd: DEVTYPE=disk
> >
> > Aug 13 16:29:10.000  multipathd: SEQNUM=1743
> >
> > Aug 13 16:29:10.000  multipathd: UDEVD_EVENT=1
> >
> > Aug 13 16:29:10.000  multipathd: DEVNAME=/dev/dm-1
> >
> >
> >
> >
> >
> >
> >
> >
> >
> > On Thu, Aug 13, 2009 at 1:27 PM, Stewart Smith <stew@cleepdar.com>
> wrote:
> >
> >
> >
> > after a fresh, multipath -F and start of multipathd with -v 2 I see the
> > following messages.
> >
> >
> >
> > After starting multipathd I mounted /dev/mapper/vol1 and generated some
> > simple I/O to it using dd
> >
> >
> >
> >
> >
> > Aug 13 16:23:14.888 localhost kernel: device-mapper: multipath: Failing
> path
> > 8:208.
> >
> > Aug 13 16:23:14.000 localhost multipathd: 8:208: mark as failed
> >
> > Aug 13 16:23:16.000 localhost multipathd: 8:208: reinstated
> >
> > Aug 13 16:23:30.462 localhost kernel: device-mapper: multipath: Failing
> path
> > 8:208.
> >
> > Aug 13 16:23:30.000 localhost multipathd: 8:208: mark as failed
> >
> > Aug 13 16:23:39.000 localhost multipathd: 8:208: reinstated
> >
> > Aug 13 16:23:46.430 localhost kernel: device-mapper: multipath: Failing
> path
> > 8:208.
> >
> > Aug 13 16:23:46.000 localhost multipathd: 8:208: mark as failed
> >
> > Aug 13 16:23:51.041 localhost kernel: device-mapper: multipath: Failing
> path
> > 8:208.
> >
> > Aug 13 16:23:51.000 localhost multipathd: 8:208: mark as failed
> >
> > Aug 13 16:23:59.000 localhost multipathd: 8:208: reinstated
> >
> > Aug 13 16:24:06.465 localhost kernel: device-mapper: multipath: Failing
> path
> > 8:208.
> >
> > Aug 13 16:24:06.000 localhost multipathd: 8:208: mark as failed
> >
> > Aug 13 16:24:09.000 localhost multipathd: 8:208: reinstated
> >
> >
> >
> >
> >
> > Thanks,
> >
> > --
> >
> > Stew
> >
> >
> >
> >
> >
> >
> >
> > On Thu, Aug 13, 2009 at 12:42 PM, Moger, Babu <Babu.Moger@lsi.com>
> wrote:
> >
> > Do you have /var/log/messages file for this problem?
> >
> > Thanks
> > Babu Moger
> >
> >> -----Original Message-----
> >> From: dm-devel-bounces@redhat.com [mailto:dm-devel-bounces@redhat.com]
> On
> >> Behalf Of Stewart Smith
> >> Sent: Thursday, August 13, 2009 1:51 PM
> >> To: dm-devel@redhat.com
> >> Subject: [dm-devel] rdac path failure - Sun 6140
> >>
> >> Hello All,
> >>
> >> I am seeing many of these messages when my Sun 6140 array is under
> heavy
> >> I/O
> >> device-mapper: multipath: Failing path 8:208.
> >> device-mapper: multipath: Failing path 8:208.
> >> device-mapper: multipath: Failing path 8:208.
> >> device-mapper: multipath: Failing path 8:208.
> >> device-mapper: multipath: Failing path 8:208.
> >>
> >>
> >> I am running a Fedora 10 server, with two fiber connections to two
> >> different switches.  Both controllers on the 6140 have one connection
> >> to each switch as well.  The end result is that I see four paths to
> >> each LUN.
> >>
> >> When the volume is mounted and under significant load I see the
> >> messages above every few seconds.  They seem to appear every
> >> "no_path_retry" seconds.
> >>
> >> The 6140 controller firmware is up to date at version 07.50.08.10 and
> >> I have installed the latest firmware for my Emulex LPe11002 cards.  I
> >> have reproduced the problem using both Cisco MDS and Brocade fiber
> >> channel switches as well.
> >>
> >> Using CAM, I have set the initiator Host Type to "Linux" at the
> >> moment.  I have tried other options as well without success.
> >>
> >> I have NOT installed the RDAC drivers from either Sun or LSI -
> >> primarily because they do not seem to build on my Fedora 10 kernel.
> >>
> >> Any ideas would be greatly appreciated!!!
> >>
> >> configs and debugging multipathd output is below.
> >>
> >>
> >>
> >>
> >>
> >> Kernel: 2.6.27.24-170.2.68.fc10.x86_64
> >>
> >> # multipath -lll
> >> vol1 (3600a0b800048335200001e5d48b68a9b) dm-1 SUN,CSM200_R
> >> [size=12T][features=1 queue_if_no_path][hwhandler=1 rdac][rw]
> >> \_ round-robin 0 [prio=6][active]
> >>  \_ 5:0:1:2 sdj 8:144 [active][ready]
> >>  \_ 2:0:1:2 sdn 8:208 [active][ready]
> >> \_ round-robin 0 [prio=0][enabled]
> >>  \_ 2:0:0:2 sdb 8:16  [active][ghost]
> >>  \_ 5:0:0:2 sdd 8:48  [active][ghost]
> >>
> >>
> >> # cat /etc/multipath.conf
> >>
> >> blacklist {
> >>         devnode "^sd[a-z][[0-9]*]"
> >>         devnode "^(ram|raw|loop|fd|md|dm-|sr|scd|st)[0-9]*"
> >>         devnode "^hd[a-z][0-9]*"
> >>         devnode "^cciss!c[0-9]d[0-9](p[0-9]*)*"
> >> }
> >>
> >> defaults {
> >>         udev_dir                /dev
> >>         polling_interval        10
> >>         selector                "round-robin 0"
> >>         path_grouping_policy    multibus
> >>         getuid_callout          "/sbin/scsi_id --whitelisted /dev/%n"
> >>         prio                    alua
> >>         path_checker            readsector0
> >>         rr_min_io               100
> >>         max_fds                 8192
> >>         rr_weight               priorities
> >>         failback                immediate
> >>         no_path_retry           fail
> >>         user_friendly_names     yes
> >> }
> >> devices {
> >>         device {
> >>                 vendor                  "SUN"
> >>                 product                 "CSM200_R"
> >>                 product_blacklist       "Universal Xport"
> >>                 getuid_callout          "/sbin/scsi_id --whitelisted
> >> /dev/%n"
> >>                 features                "0"
> >>                 hardware_handler        "1 rdac"
> >>                 path_selector           "round-robin 0"
> >>                 path_grouping_policy    group_by_prio
> >>                 failback                immediate
> >>                 rr_weight               uniform
> >>                 no_path_retry           queue
> >>                 rr_min_io               1000
> >>                 path_checker            rdac
> >>                 prio                    rdac
> >>         }
> >> }
> >>
> >> multipaths {
> >>         multipath {
> >>                 wwid
>  3600a0b800048335200001e5d48b68a9b
> >>                 alias                   vol1
> >>                 rr_weight               priorities
> >>                 no_path_retry           5
> >>                 rr_min_io               100
> >>         }
> >> }
> >>
> >>
> >>
> >> # multipathd -d v3
> >>
> >>
> >> Aug 13 14:48:53 | sdb: ownership set to vol1
> >> Aug 13 14:48:53 | sdb: not found in pathvec
> >> Aug 13 14:48:53 | sdb: mask = 0xc
> >> Aug 13 14:48:53 | sdb: path checker = rdac (controller setting)
> >> Aug 13 14:48:53 | sdb: state = 4
> >> Aug 13 14:48:53 | sdb: rdac prio = 0
> >> Aug 13 14:48:53 | sdd: ownership set to vol1
> >> Aug 13 14:48:53 | sdd: not found in pathvec
> >> Aug 13 14:48:53 | sdd: mask = 0xc
> >> Aug 13 14:48:53 | sdd: path checker = rdac (controller setting)
> >> Aug 13 14:48:53 | sdd: state = 4
> >> Aug 13 14:48:53 | sdd: rdac prio = 0
> >> Aug 13 14:48:53 | sdj: ownership set to vol1
> >> Aug 13 14:48:53 | sdj: not found in pathvec
> >> Aug 13 14:48:53 | sdj: mask = 0xc
> >> Aug 13 14:48:53 | sdj: path checker = rdac (controller setting)
> >> Aug 13 14:48:53 | sdj: state = 2
> >> Aug 13 14:48:53 | sdj: rdac prio = 3
> >> Aug 13 14:48:53 | sdn: ownership set to vol1
> >> Aug 13 14:48:53 | sdn: not found in pathvec
> >> Aug 13 14:48:53 | sdn: mask = 0xc
> >> Aug 13 14:48:53 | sdn: path checker = rdac (controller setting)
> >> Aug 13 14:48:53 | sdn: state = 2
> >> Aug 13 14:48:53 | sdn: rdac prio = 3
> >> Aug 13 14:48:53 | vol1: pgfailback = -2 (controller setting)
> >> Aug 13 14:48:53 | vol1: pgpolicy = group_by_prio (controller setting)
> >> Aug 13 14:48:53 | vol1: selector = round-robin 0 (controller setting)
> >> Aug 13 14:48:53 | vol1: features = 0 (controller setting)
> >> Aug 13 14:48:53 | vol1: hwhandler = 1 rdac (controller setting)
> >> Aug 13 14:48:53 | vol1: rr_weight = 2 (LUN setting)
> >> Aug 13 14:48:53 | vol1: minio = 100 (LUN setting)
> >> Aug 13 14:48:53 | vol1: no_path_retry = 5 (multipath setting)
> >> Aug 13 14:48:53 | pg_timeout = NONE (internal default)
> >> Aug 13 14:48:53 | vol1: set ACT_CREATE (map does not exist)
> >> create: vol1 (3600a0b800048335200001e5d48b68a9b) n/a SUN,CSM200_R
> >> [size=12T][features=0][hwhandler=1 rdac][n/a]
> >> \_ round-robin 0 [prio=6][undef]
> >>  \_ 5:0:1:2 sdj 8:144 [undef][ready]
> >>  \_ 2:0:1:2 sdn 8:208 [undef][ready]
> >> \_ round-robin 0 [prio=0][undef]
> >>  \_ 2:0:0:2 sdb 8:16 [undef][ghost]
> >>  \_ 5:0:0:2 sdd 8:48 [undef][ghost]
> >>
> >
> >> --
> >> dm-devel mailing list
> >> dm-devel@redhat.com
> >> https://www.redhat.com/mailman/listinfo/dm-devel
> >
> > --
> > dm-devel mailing list
> > dm-devel@redhat.com
> > https://www.redhat.com/mailman/listinfo/dm-devel
> >
> >
> >
> >
>
> --
> dm-devel mailing list
> dm-devel@redhat.com
> https://www.redhat.com/mailman/listinfo/dm-devel

^ permalink raw reply	[flat|nested] 9+ messages in thread

* Re: rdac path failure - Sun 6140
  2009-08-14 16:21           ` Moger, Babu
@ 2009-08-14 20:26             ` Stewart Smith
  2009-08-14 22:22               ` Chandra Seetharaman
  0 siblings, 1 reply; 9+ messages in thread
From: Stewart Smith @ 2009-08-14 20:26 UTC (permalink / raw)
  To: device-mapper development

Interesting.

I just grabbed 2.6.30.4 from kernel.org and I can no longer reproduce
the issue with that kernel.  I did not add in your debugging version
of scsi_dh_rdac.c yet.

Somewhere between vmlinuz-2.6.29.4-167.fc11 and the generic 2.6.30.4
(using the same kernel .config) this problem was fixed.

Its now running over 350 MB/s with 16 sequential writers using both
active paths.




# fio --filename=/san0/vol1/test --direct=1 --rw=write --bs=8m
--size=32G --numjobs=16 --runtime=60 --group_reporting --name=file1

Run status group 0 (all jobs):
  WRITE: io=21,416MiB, aggrb=355MiB/s, minb=355MiB/s, maxb=355MiB/s,
mint=60342msec, maxt=60342msec

Disk stats (read/write):
  dm-1: ios=3/85697, merge=0/0, ticks=11/21809639, in_queue=21810085,
util=99.94%, aggrios=0/11402, aggrmerge=0/10022, aggrticks=2/2805880,
aggrin_queue=2805875, aggrutil=97.09%
    sdf: ios=0/22732, merge=0/20168, ticks=0/6090166,
in_queue=6090145, util=97.09%
    sdn: ios=3/22876, merge=0/19921, ticks=11/5133355,
in_queue=5133356, util=96.16%
    sdb: ios=0/0, merge=0/0, ticks=0/0, in_queue=0, util=0.00%
    sdj: ios=0/0, merge=0/0, ticks=0/0, in_queue=0, util=0.00%


Thanks!
--
Stewart




On Fri, Aug 14, 2009 at 9:21 AM, Moger, Babu<Babu.Moger@lsi.com> wrote:
>> -----Original Message-----
>> From: dm-devel-bounces@redhat.com [mailto:dm-devel-bounces@redhat.com] On
>> Behalf Of Stewart Smith
>> Sent: Friday, August 14, 2009 10:58 AM
>> To: device-mapper development
>> Subject: Re: [dm-devel] rdac path failure - Sun 6140
>>
>> I will test this today.
>>
>> Does everything look OK from a configuration standpoint?  Should the
>
>  I have verified your configuration file. It looks fine..
>
>> RDAC virtual HBA drivers from LSI be a requirement?  I am not
>> currently using them.
>
>  You can't use both the solutions at once. You are fine..
>
>> Thank you,
>> --
>> Stew
>>
>>
>>
>>
>> On Thu, Aug 13, 2009 at 5:05 PM, Moger, Babu<Babu.Moger@lsi.com> wrote:
>> > Stew,
>> >
>> >      I don’t see much information about this failure in the logs. Right
>> now
>> > device handlers don’t provide much information on failures.  We are
>> working
>> > on to add some more debug levels.  I am attaching my draft code
>> > (scsi_dh_rdac.c) here.  Please use this only for your testing. It is not
>> > been approved/reviewed yet. I still need to submit this one to community
>> for
>> > approval. The code is attached.  Please replace this file with
>> > scsi_dh_rdac.c in the directory /driver/scsi/device_handlers and rebuild
>> the
>> > kernel.  This should give more information from the target point of
>> view.
>> > Please send me the /var/log/messages file after the failure. Let see if
>> we
>> > can get more information..
>> >
>> >
>> >
>> > Thanks
>> >
>> > Babu Moger
>> >
>> > ________________________________
>> >
>> > From: dm-devel-bounces@redhat.com [mailto:dm-devel-bounces@redhat.com]
>> On
>> > Behalf Of Stewart Smith
>> > Sent: Thursday, August 13, 2009 3:35 PM
>> > To: device-mapper development
>> > Subject: Re: [dm-devel] rdac path failure - Sun 6140
>> >
>> >
>> >
>> >
>> >
>> > Same sequence of events, with multipathd -v3
>> >
>> >
>> >
>> > Aug 13 16:28:48.627  kernel: device-mapper: multipath: Failing path
>> 8:208.
>> >
>> > Aug 13 16:28:48.000  multipathd: vol1: rr_weight = 2 (LUN setting)
>> >
>> > Aug 13 16:28:48.000  multipathd: vol1: pgfailback = -2 (controller
>> setting)
>> >
>> > Aug 13 16:28:48.000  multipathd: pg_timeout = NONE (internal default)
>> >
>> > Aug 13 16:28:48.000  multipathd: 8:208: mark as failed
>> >
>> > Aug 13 16:28:48.000  multipathd: uevent 'change' from
>> > '/devices/virtual/block/dm-1'
>> >
>> > Aug 13 16:28:48.000  multipathd: UDEV_LOG=3
>> >
>> > Aug 13 16:28:48.000  multipathd: ACTION=change
>> >
>> > Aug 13 16:28:48.000  multipathd: DEVPATH=/devices/virtual/block/dm-1
>> >
>> > Aug 13 16:28:48.000  multipathd: SUBSYSTEM=block
>> >
>> > Aug 13 16:28:48.000  multipathd: DM_TARGET=multipath
>> >
>> > Aug 13 16:28:48.000  multipathd: DM_ACTION=PATH_FAILED
>> >
>> > Aug 13 16:28:48.000  multipathd: DM_SEQNUM=1
>> >
>> > Aug 13 16:28:48.000  multipathd: DM_PATH=8:208
>> >
>> > Aug 13 16:28:48.000  multipathd: DM_NR_VALID_PATHS=3
>> >
>> > Aug 13 16:28:48.000  multipathd: DM_NAME=vol1
>> >
>> > Aug 13 16:28:48.000  multipathd:
>> > DM_UUID=mpath-3600a0b800048335200001e5d48b68a9b
>> >
>> > Aug 13 16:28:48.000  multipathd: MAJOR=253
>> >
>> > Aug 13 16:28:48.000  multipathd: MINOR=1
>> >
>> > Aug 13 16:28:48.000  multipathd: DEVTYPE=disk
>> >
>> > Aug 13 16:28:48.000  multipathd: SEQNUM=1738
>> >
>> > Aug 13 16:28:48.000  multipathd: UDEVD_EVENT=1
>> >
>> > Aug 13 16:28:48.000  multipathd: DEVNAME=/dev/dm-1
>> >
>> > Aug 13 16:28:50.000  multipathd: 8:208: reinstated
>> >
>> > Aug 13 16:28:50.000  multipathd: vol1: remaining active paths: 4
>> >
>> > Aug 13 16:28:50.000  multipathd: sdj: rdac prio = 3
>> >
>> > Aug 13 16:28:50.000  multipathd: sdn: rdac prio = 3
>> >
>> > Aug 13 16:28:50.000  multipathd: sdb: rdac prio = 0
>> >
>> > Aug 13 16:28:50.000  multipathd: sdd: rdac prio = 0
>> >
>> > Aug 13 16:28:50.763  kernel: device-mapper: multipath: Failing path
>> 8:208.
>> >
>> > Aug 13 16:28:50.000  multipathd: uevent 'change' from
>> > '/devices/virtual/block/dm-1'
>> >
>> > Aug 13 16:28:50.000  multipathd: UDEV_LOG=3
>> >
>> > Aug 13 16:28:50.000  multipathd: ACTION=change
>> >
>> > Aug 13 16:28:50.000  multipathd: DEVPATH=/devices/virtual/block/dm-1
>> >
>> > Aug 13 16:28:50.000  multipathd: SUBSYSTEM=block
>> >
>> > Aug 13 16:28:50.000  multipathd: DM_TARGET=multipath
>> >
>> > Aug 13 16:28:50.000  multipathd: DM_ACTION=PATH_REINSTATED
>> >
>> > Aug 13 16:28:50.000  multipathd: DM_SEQNUM=2
>> >
>> > Aug 13 16:28:50.000  multipathd: DM_PATH=8:208
>> >
>> > Aug 13 16:28:50.000  multipathd: DM_NR_VALID_PATHS=4
>> >
>> > Aug 13 16:28:50.000  multipathd: DM_NAME=vol1
>> >
>> > Aug 13 16:28:50.000  multipathd:
>> > DM_UUID=mpath-3600a0b800048335200001e5d48b68a9b
>> >
>> > Aug 13 16:28:50.000  multipathd: MAJOR=253
>> >
>> > Aug 13 16:28:50.000  multipathd: MINOR=1
>> >
>> > Aug 13 16:28:50.000  multipathd: DEVTYPE=diskAug 13 16:28:50.000
>> >  multipathd: SEQNUM=1739Aug 13 16:28:50.000  multipathd: UDEVD_EVENT=1
>> >
>> > Aug 13 16:28:50.000  multipathd: vol1: rr_weight = 2 (LUN setting)
>> >
>> > Aug 13 16:28:50.000  multipathd: vol1: pgfailback = -2 (controller
>> setting)
>> >
>> > Aug 13 16:28:50.000  multipathd: pg_timeout = NONE (internal default)
>> >
>> > Aug 13 16:28:50.000  multipathd: 8:208: mark as failed
>> >
>> > Aug 13 16:28:50.000  multipathd: vol1: remaining active paths: 3
>> >
>> > Aug 13 16:28:50.000  multipathd: vol1: rr_weight = 2 (LUN setting)
>> >
>> > Aug 13 16:28:50.000  multipathd: vol1: pgfailback = -2 (controller
>> setting)
>> >
>> > Aug 13 16:28:50.000  multipathd: uevent 'change' from
>> > '/devices/virtual/block/dm-1'
>> >
>> > Aug 13 16:28:50.000  multipathd: UDEV_LOG=3
>> >
>> > Aug 13 16:28:50.000  multipathd: ACTION=change
>> >
>> > Aug 13 16:28:50.000  multipathd: DEVPATH=/devices/virtual/block/dm-1
>> >
>> > Aug 13 16:28:50.000  multipathd: SUBSYSTEM=block
>> >
>> > Aug 13 16:28:50.000  multipathd: DM_TARGET=multipath
>> >
>> > Aug 13 16:28:50.000  multipathd: DM_ACTION=PATH_FAILED
>> >
>> > Aug 13 16:28:50.000  multipathd: DM_SEQNUM=3
>> >
>> > Aug 13 16:28:50.000  multipathd: DM_PATH=8:208
>> >
>> > Aug 13 16:28:50.000  multipathd: DM_NR_VALID_PATHS=3
>> >
>> > Aug 13 16:28:50.000  multipathd: DM_NAME=vol1
>> >
>> > Aug 13 16:28:50.000  multipathd:
>> > DM_UUID=mpath-3600a0b800048335200001e5d48b68a9b
>> >
>> > Aug 13 16:28:50.000  multipathd: MAJOR=253
>> >
>> > Aug 13 16:28:50.000  multipathd: MINOR=1
>> >
>> > Aug 13 16:28:50.000  multipathd: DEVTYPE=disk
>> >
>> > Aug 13 16:28:50.000  multipathd: SEQNUM=1740
>> >
>> > Aug 13 16:28:50.000  multipathd: UDEVD_EVENT=1
>> >
>> > Aug 13 16:28:50.000  multipathd: DEVNAME=/dev/dm-1
>> >
>> > Aug 13 16:29:00.000  multipathd: 8:208: reinstated
>> >
>> > Aug 13 16:29:00.000  multipathd: vol1: remaining active paths: 4
>> >
>> > Aug 13 16:29:00.000  multipathd: sdj: rdac prio = 3
>> >
>> > Aug 13 16:29:00.000  multipathd: sdn: rdac prio = 3
>> >
>> > Aug 13 16:29:00.000  multipathd: sdb: rdac prio = 0
>> >
>> > Aug 13 16:29:00.000  multipathd: sdd: rdac prio = 0
>> >
>> > Aug 13 16:29:00.000  multipathd: vol1: rr_weight = 2 (LUN setting)
>> >
>> > Aug 13 16:29:00.000  multipathd: vol1: pgfailback = -2 (controller
>> setting)
>> >
>> > Aug 13 16:29:00.000  multipathd: uevent 'change' from
>> > '/devices/virtual/block/dm-1'
>> >
>> > Aug 13 16:29:00.000  multipathd: UDEV_LOG=3
>> >
>> > Aug 13 16:29:00.000  multipathd: ACTION=change
>> >
>> > Aug 13 16:29:00.000  multipathd: DEVPATH=/devices/virtual/block/dm-1
>> >
>> > Aug 13 16:29:00.000  multipathd: SUBSYSTEM=block
>> >
>> > Aug 13 16:29:00.000  multipathd: DM_TARGET=multipath
>> >
>> > Aug 13 16:29:00.000  multipathd: DM_ACTION=PATH_REINSTATED
>> >
>> > Aug 13 16:29:00.000  multipathd: DM_SEQNUM=4
>> >
>> > Aug 13 16:29:00.000  multipathd: DM_PATH=8:208
>> >
>> > Aug 13 16:29:00.000  multipathd: DM_NR_VALID_PATHS=4
>> >
>> > Aug 13 16:29:00.000  multipathd: DM_NAME=vol1
>> >
>> > Aug 13 16:29:00.000  multipathd:
>> > DM_UUID=mpath-3600a0b800048335200001e5d48b68a9b
>> >
>> > Aug 13 16:29:00.000  multipathd: MAJOR=253
>> >
>> > Aug 13 16:29:00.000  multipathd: MINOR=1
>> >
>> > Aug 13 16:29:00.000  multipathd: DEVTYPE=disk
>> >
>> > Aug 13 16:29:00.000  multipathd: SEQNUM=1741
>> >
>> > Aug 13 16:29:00.000  multipathd: UDEVD_EVENT=1
>> >
>> > Aug 13 16:29:00.000  multipathd: DEVNAME=/dev/dm-1
>> >
>> > Aug 13 16:29:02.753  kernel: device-mapper: multipath: Failing path
>> 8:208.
>> >
>> > Aug 13 16:29:02.000  multipathd: vol1: rr_weight = 2 (LUN setting)
>> >
>> > Aug 13 16:29:02.000  multipathd: vol1: pgfailback = -2 (controller
>> setting)
>> >
>> > Aug 13 16:29:02.000  multipathd: pg_timeout = NONE (internal default)
>> >
>> > Aug 13 16:29:02.000  multipathd: 8:208: mark as failed
>> >
>> > Aug 13 16:29:02.000  multipathd: uevent 'change' from
>> > '/devices/virtual/block/dm-1'
>> >
>> > Aug 13 16:29:02.000  multipathd: UDEV_LOG=3
>> >
>> > Aug 13 16:29:02.000  multipathd: ACTION=change
>> >
>> > Aug 13 16:29:02.000  multipathd: DEVPATH=/devices/virtual/block/dm-1
>> >
>> > Aug 13 16:29:02.000  multipathd: SUBSYSTEM=block
>> >
>> > Aug 13 16:29:02.000  multipathd: DM_TARGET=multipath
>> >
>> > Aug 13 16:29:02.000  multipathd: DM_ACTION=PATH_FAILED
>> >
>> > Aug 13 16:29:02.000  multipathd: DM_SEQNUM=5
>> >
>> > Aug 13 16:29:02.000  multipathd: DM_PATH=8:208
>> >
>> > Aug 13 16:29:02.000  multipathd: DM_NR_VALID_PATHS=3
>> >
>> > Aug 13 16:29:02.000  multipathd: DM_NAME=vol1
>> >
>> > Aug 13 16:29:02.000  multipathd:
>> > DM_UUID=mpath-3600a0b800048335200001e5d48b68a9b
>> >
>> > Aug 13 16:29:02.000  multipathd: MAJOR=253
>> >
>> > Aug 13 16:29:02.000  multipathd: MINOR=1
>> >
>> > Aug 13 16:29:02.000  multipathd: DEVTYPE=disk
>> >
>> > Aug 13 16:29:02.000  multipathd: SEQNUM=1742
>> >
>> > Aug 13 16:29:02.000  multipathd: UDEVD_EVENT=1
>> >
>> > Aug 13 16:29:02.000  multipathd: DEVNAME=/dev/dm-1
>> >
>> > Aug 13 16:29:10.000  multipathd: 8:208: reinstated
>> >
>> > Aug 13 16:29:10.000  multipathd: vol1: remaining active paths: 4
>> >
>> > Aug 13 16:29:10.000  multipathd: sdj: rdac prio = 3
>> >
>> > Aug 13 16:29:10.000  multipathd: sdn: rdac prio = 3
>> >
>> > Aug 13 16:29:10.000  multipathd: sdb: rdac prio = 0
>> >
>> > Aug 13 16:29:10.000  multipathd: sdd: rdac prio = 0
>> >
>> > Aug 13 16:29:10.000  multipathd: vol1: rr_weight = 2 (LUN setting)
>> >
>> > Aug 13 16:29:10.000  multipathd: vol1: pgfailback = -2 (controller
>> setting)
>> >
>> > Aug 13 16:29:10.000  multipathd: uevent 'change' from
>> > '/devices/virtual/block/dm-1'
>> >
>> > Aug 13 16:29:10.000  multipathd: UDEV_LOG=3
>> >
>> > Aug 13 16:29:10.000  multipathd: ACTION=change
>> >
>> > Aug 13 16:29:10.000  multipathd: DEVPATH=/devices/virtual/block/dm-1
>> >
>> > Aug 13 16:29:10.000  multipathd: SUBSYSTEM=block
>> >
>> > Aug 13 16:29:10.000  multipathd: DM_TARGET=multipath
>> >
>> > Aug 13 16:29:10.000  multipathd: DM_ACTION=PATH_REINSTATED
>> >
>> > Aug 13 16:29:10.000  multipathd: DM_SEQNUM=6
>> >
>> > Aug 13 16:29:10.000  multipathd: DM_PATH=8:208
>> >
>> > Aug 13 16:29:10.000  multipathd: DM_NR_VALID_PATHS=4
>> >
>> > Aug 13 16:29:10.000  multipathd: DM_NAME=vol1
>> >
>> > Aug 13 16:29:10.000  multipathd:
>> > DM_UUID=mpath-3600a0b800048335200001e5d48b68a9b
>> >
>> > Aug 13 16:29:10.000  multipathd: MAJOR=253
>> >
>> > Aug 13 16:29:10.000  multipathd: MINOR=1
>> >
>> > Aug 13 16:29:10.000  multipathd: DEVTYPE=disk
>> >
>> > Aug 13 16:29:10.000  multipathd: SEQNUM=1743
>> >
>> > Aug 13 16:29:10.000  multipathd: UDEVD_EVENT=1
>> >
>> > Aug 13 16:29:10.000  multipathd: DEVNAME=/dev/dm-1
>> >
>> >
>> >
>> >
>> >
>> >
>> >
>> >
>> >
>> > On Thu, Aug 13, 2009 at 1:27 PM, Stewart Smith <stew@cleepdar.com>
>> wrote:
>> >
>> >
>> >
>> > after a fresh, multipath -F and start of multipathd with -v 2 I see the
>> > following messages.
>> >
>> >
>> >
>> > After starting multipathd I mounted /dev/mapper/vol1 and generated some
>> > simple I/O to it using dd
>> >
>> >
>> >
>> >
>> >
>> > Aug 13 16:23:14.888 localhost kernel: device-mapper: multipath: Failing
>> path
>> > 8:208.
>> >
>> > Aug 13 16:23:14.000 localhost multipathd: 8:208: mark as failed
>> >
>> > Aug 13 16:23:16.000 localhost multipathd: 8:208: reinstated
>> >
>> > Aug 13 16:23:30.462 localhost kernel: device-mapper: multipath: Failing
>> path
>> > 8:208.
>> >
>> > Aug 13 16:23:30.000 localhost multipathd: 8:208: mark as failed
>> >
>> > Aug 13 16:23:39.000 localhost multipathd: 8:208: reinstated
>> >
>> > Aug 13 16:23:46.430 localhost kernel: device-mapper: multipath: Failing
>> path
>> > 8:208.
>> >
>> > Aug 13 16:23:46.000 localhost multipathd: 8:208: mark as failed
>> >
>> > Aug 13 16:23:51.041 localhost kernel: device-mapper: multipath: Failing
>> path
>> > 8:208.
>> >
>> > Aug 13 16:23:51.000 localhost multipathd: 8:208: mark as failed
>> >
>> > Aug 13 16:23:59.000 localhost multipathd: 8:208: reinstated
>> >
>> > Aug 13 16:24:06.465 localhost kernel: device-mapper: multipath: Failing
>> path
>> > 8:208.
>> >
>> > Aug 13 16:24:06.000 localhost multipathd: 8:208: mark as failed
>> >
>> > Aug 13 16:24:09.000 localhost multipathd: 8:208: reinstated
>> >
>> >
>> >
>> >
>> >
>> > Thanks,
>> >
>> > --
>> >
>> > Stew
>> >
>> >
>> >
>> >
>> >
>> >
>> >
>> > On Thu, Aug 13, 2009 at 12:42 PM, Moger, Babu <Babu.Moger@lsi.com>
>> wrote:
>> >
>> > Do you have /var/log/messages file for this problem?
>> >
>> > Thanks
>> > Babu Moger
>> >
>> >> -----Original Message-----
>> >> From: dm-devel-bounces@redhat.com [mailto:dm-devel-bounces@redhat.com]
>> On
>> >> Behalf Of Stewart Smith
>> >> Sent: Thursday, August 13, 2009 1:51 PM
>> >> To: dm-devel@redhat.com
>> >> Subject: [dm-devel] rdac path failure - Sun 6140
>> >>
>> >> Hello All,
>> >>
>> >> I am seeing many of these messages when my Sun 6140 array is under
>> heavy
>> >> I/O
>> >> device-mapper: multipath: Failing path 8:208.
>> >> device-mapper: multipath: Failing path 8:208.
>> >> device-mapper: multipath: Failing path 8:208.
>> >> device-mapper: multipath: Failing path 8:208.
>> >> device-mapper: multipath: Failing path 8:208.
>> >>
>> >>
>> >> I am running a Fedora 10 server, with two fiber connections to two
>> >> different switches.  Both controllers on the 6140 have one connection
>> >> to each switch as well.  The end result is that I see four paths to
>> >> each LUN.
>> >>
>> >> When the volume is mounted and under significant load I see the
>> >> messages above every few seconds.  They seem to appear every
>> >> "no_path_retry" seconds.
>> >>
>> >> The 6140 controller firmware is up to date at version 07.50.08.10 and
>> >> I have installed the latest firmware for my Emulex LPe11002 cards.  I
>> >> have reproduced the problem using both Cisco MDS and Brocade fiber
>> >> channel switches as well.
>> >>
>> >> Using CAM, I have set the initiator Host Type to "Linux" at the
>> >> moment.  I have tried other options as well without success.
>> >>
>> >> I have NOT installed the RDAC drivers from either Sun or LSI -
>> >> primarily because they do not seem to build on my Fedora 10 kernel.
>> >>
>> >> Any ideas would be greatly appreciated!!!
>> >>
>> >> configs and debugging multipathd output is below.
>> >>
>> >>
>> >>
>> >>
>> >>
>> >> Kernel: 2.6.27.24-170.2.68.fc10.x86_64
>> >>
>> >> # multipath -lll
>> >> vol1 (3600a0b800048335200001e5d48b68a9b) dm-1 SUN,CSM200_R
>> >> [size=12T][features=1 queue_if_no_path][hwhandler=1 rdac][rw]
>> >> \_ round-robin 0 [prio=6][active]
>> >>  \_ 5:0:1:2 sdj 8:144 [active][ready]
>> >>  \_ 2:0:1:2 sdn 8:208 [active][ready]
>> >> \_ round-robin 0 [prio=0][enabled]
>> >>  \_ 2:0:0:2 sdb 8:16  [active][ghost]
>> >>  \_ 5:0:0:2 sdd 8:48  [active][ghost]
>> >>
>> >>
>> >> # cat /etc/multipath.conf
>> >>
>> >> blacklist {
>> >>         devnode "^sd[a-z][[0-9]*]"
>> >>         devnode "^(ram|raw|loop|fd|md|dm-|sr|scd|st)[0-9]*"
>> >>         devnode "^hd[a-z][0-9]*"
>> >>         devnode "^cciss!c[0-9]d[0-9](p[0-9]*)*"
>> >> }
>> >>
>> >> defaults {
>> >>         udev_dir                /dev
>> >>         polling_interval        10
>> >>         selector                "round-robin 0"
>> >>         path_grouping_policy    multibus
>> >>         getuid_callout          "/sbin/scsi_id --whitelisted /dev/%n"
>> >>         prio                    alua
>> >>         path_checker            readsector0
>> >>         rr_min_io               100
>> >>         max_fds                 8192
>> >>         rr_weight               priorities
>> >>         failback                immediate
>> >>         no_path_retry           fail
>> >>         user_friendly_names     yes
>> >> }
>> >> devices {
>> >>         device {
>> >>                 vendor                  "SUN"
>> >>                 product                 "CSM200_R"
>> >>                 product_blacklist       "Universal Xport"
>> >>                 getuid_callout          "/sbin/scsi_id --whitelisted
>> >> /dev/%n"
>> >>                 features                "0"
>> >>                 hardware_handler        "1 rdac"
>> >>                 path_selector           "round-robin 0"
>> >>                 path_grouping_policy    group_by_prio
>> >>                 failback                immediate
>> >>                 rr_weight               uniform
>> >>                 no_path_retry           queue
>> >>                 rr_min_io               1000
>> >>                 path_checker            rdac
>> >>                 prio                    rdac
>> >>         }
>> >> }
>> >>
>> >> multipaths {
>> >>         multipath {
>> >>                 wwid
>>  3600a0b800048335200001e5d48b68a9b
>> >>                 alias                   vol1
>> >>                 rr_weight               priorities
>> >>                 no_path_retry           5
>> >>                 rr_min_io               100
>> >>         }
>> >> }
>> >>
>> >>
>> >>
>> >> # multipathd -d v3
>> >>
>> >>
>> >> Aug 13 14:48:53 | sdb: ownership set to vol1
>> >> Aug 13 14:48:53 | sdb: not found in pathvec
>> >> Aug 13 14:48:53 | sdb: mask = 0xc
>> >> Aug 13 14:48:53 | sdb: path checker = rdac (controller setting)
>> >> Aug 13 14:48:53 | sdb: state = 4
>> >> Aug 13 14:48:53 | sdb: rdac prio = 0
>> >> Aug 13 14:48:53 | sdd: ownership set to vol1
>> >> Aug 13 14:48:53 | sdd: not found in pathvec
>> >> Aug 13 14:48:53 | sdd: mask = 0xc
>> >> Aug 13 14:48:53 | sdd: path checker = rdac (controller setting)
>> >> Aug 13 14:48:53 | sdd: state = 4
>> >> Aug 13 14:48:53 | sdd: rdac prio = 0
>> >> Aug 13 14:48:53 | sdj: ownership set to vol1
>> >> Aug 13 14:48:53 | sdj: not found in pathvec
>> >> Aug 13 14:48:53 | sdj: mask = 0xc
>> >> Aug 13 14:48:53 | sdj: path checker = rdac (controller setting)
>> >> Aug 13 14:48:53 | sdj: state = 2
>> >> Aug 13 14:48:53 | sdj: rdac prio = 3
>> >> Aug 13 14:48:53 | sdn: ownership set to vol1
>> >> Aug 13 14:48:53 | sdn: not found in pathvec
>> >> Aug 13 14:48:53 | sdn: mask = 0xc
>> >> Aug 13 14:48:53 | sdn: path checker = rdac (controller setting)
>> >> Aug 13 14:48:53 | sdn: state = 2
>> >> Aug 13 14:48:53 | sdn: rdac prio = 3
>> >> Aug 13 14:48:53 | vol1: pgfailback = -2 (controller setting)
>> >> Aug 13 14:48:53 | vol1: pgpolicy = group_by_prio (controller setting)
>> >> Aug 13 14:48:53 | vol1: selector = round-robin 0 (controller setting)
>> >> Aug 13 14:48:53 | vol1: features = 0 (controller setting)
>> >> Aug 13 14:48:53 | vol1: hwhandler = 1 rdac (controller setting)
>> >> Aug 13 14:48:53 | vol1: rr_weight = 2 (LUN setting)
>> >> Aug 13 14:48:53 | vol1: minio = 100 (LUN setting)
>> >> Aug 13 14:48:53 | vol1: no_path_retry = 5 (multipath setting)
>> >> Aug 13 14:48:53 | pg_timeout = NONE (internal default)
>> >> Aug 13 14:48:53 | vol1: set ACT_CREATE (map does not exist)
>> >> create: vol1 (3600a0b800048335200001e5d48b68a9b) n/a SUN,CSM200_R
>> >> [size=12T][features=0][hwhandler=1 rdac][n/a]
>> >> \_ round-robin 0 [prio=6][undef]
>> >>  \_ 5:0:1:2 sdj 8:144 [undef][ready]
>> >>  \_ 2:0:1:2 sdn 8:208 [undef][ready]
>> >> \_ round-robin 0 [prio=0][undef]
>> >>  \_ 2:0:0:2 sdb 8:16 [undef][ghost]
>> >>  \_ 5:0:0:2 sdd 8:48 [undef][ghost]
>> >>
>> >
>> >> --
>> >> dm-devel mailing list
>> >> dm-devel@redhat.com
>> >> https://www.redhat.com/mailman/listinfo/dm-devel
>> >
>> > --
>> > dm-devel mailing list
>> > dm-devel@redhat.com
>> > https://www.redhat.com/mailman/listinfo/dm-devel
>> >
>> >
>> >
>> >
>>
>> --
>> dm-devel mailing list
>> dm-devel@redhat.com
>> https://www.redhat.com/mailman/listinfo/dm-devel
>
> --
> dm-devel mailing list
> dm-devel@redhat.com
> https://www.redhat.com/mailman/listinfo/dm-devel
>

^ permalink raw reply	[flat|nested] 9+ messages in thread

* Re: rdac path failure - Sun 6140
  2009-08-14 20:26             ` Stewart Smith
@ 2009-08-14 22:22               ` Chandra Seetharaman
  0 siblings, 0 replies; 9+ messages in thread
From: Chandra Seetharaman @ 2009-08-14 22:22 UTC (permalink / raw)
  To: device-mapper development


On Fri, 2009-08-14 at 13:26 -0700, Stewart Smith wrote:
> Interesting.
> 
> I just grabbed 2.6.30.4 from kernel.org and I can no longer reproduce
> the issue with that kernel.  I did not add in your debugging version
> of scsi_dh_rdac.c yet.
> 
> Somewhere between vmlinuz-2.6.29.4-167.fc11 and the generic 2.6.30.4
> (using the same kernel .config) this problem was fixed.

That is good :)

I do not have a fc11 install.... If it is not a hassle, can you send  a
diff of scsi_dh_rdac.c and dm-mpath.c, we should understand what fixed
the problem.
> 
> Its now running over 350 MB/s with 16 sequential writers using both
> active paths.
> 
> 
> 
> 
> # fio --filename=/san0/vol1/test --direct=1 --rw=write --bs=8m
> --size=32G --numjobs=16 --runtime=60 --group_reporting --name=file1
> 
> Run status group 0 (all jobs):
>   WRITE: io=21,416MiB, aggrb=355MiB/s, minb=355MiB/s, maxb=355MiB/s,
> mint=60342msec, maxt=60342msec
> 
> Disk stats (read/write):
>   dm-1: ios=3/85697, merge=0/0, ticks=11/21809639, in_queue=21810085,
> util=99.94%, aggrios=0/11402, aggrmerge=0/10022, aggrticks=2/2805880,
> aggrin_queue=2805875, aggrutil=97.09%
>     sdf: ios=0/22732, merge=0/20168, ticks=0/6090166,
> in_queue=6090145, util=97.09%
>     sdn: ios=3/22876, merge=0/19921, ticks=11/5133355,
> in_queue=5133356, util=96.16%
>     sdb: ios=0/0, merge=0/0, ticks=0/0, in_queue=0, util=0.00%
>     sdj: ios=0/0, merge=0/0, ticks=0/0, in_queue=0, util=0.00%
> 
> 
> Thanks!
> --
> Stewart
> 
> 
> 
> 
> On Fri, Aug 14, 2009 at 9:21 AM, Moger, Babu<Babu.Moger@lsi.com> wrote:
> >> -----Original Message-----
> >> From: dm-devel-bounces@redhat.com [mailto:dm-devel-bounces@redhat.com] On
> >> Behalf Of Stewart Smith
> >> Sent: Friday, August 14, 2009 10:58 AM
> >> To: device-mapper development
> >> Subject: Re: [dm-devel] rdac path failure - Sun 6140
> >>
> >> I will test this today.
> >>
> >> Does everything look OK from a configuration standpoint?  Should the
> >
> >  I have verified your configuration file. It looks fine..
> >
> >> RDAC virtual HBA drivers from LSI be a requirement?  I am not
> >> currently using them.
> >
> >  You can't use both the solutions at once. You are fine..
> >
> >> Thank you,
> >> --
> >> Stew
> >>
> >>
> >>
> >>
> >> On Thu, Aug 13, 2009 at 5:05 PM, Moger, Babu<Babu.Moger@lsi.com> wrote:
> >> > Stew,
> >> >
> >> >      I don’t see much information about this failure in the logs. Right
> >> now
> >> > device handlers don’t provide much information on failures.  We are
> >> working
> >> > on to add some more debug levels.  I am attaching my draft code
> >> > (scsi_dh_rdac.c) here.  Please use this only for your testing. It is not
> >> > been approved/reviewed yet. I still need to submit this one to community
> >> for
> >> > approval. The code is attached.  Please replace this file with
> >> > scsi_dh_rdac.c in the directory /driver/scsi/device_handlers and rebuild
> >> the
> >> > kernel.  This should give more information from the target point of
> >> view.
> >> > Please send me the /var/log/messages file after the failure. Let see if
> >> we
> >> > can get more information..
> >> >
> >> >
> >> >
> >> > Thanks
> >> >
> >> > Babu Moger
> >> >
> >> > ________________________________
> >> >
> >> > From: dm-devel-bounces@redhat.com [mailto:dm-devel-bounces@redhat.com]
> >> On
> >> > Behalf Of Stewart Smith
> >> > Sent: Thursday, August 13, 2009 3:35 PM
> >> > To: device-mapper development
> >> > Subject: Re: [dm-devel] rdac path failure - Sun 6140
> >> >
> >> >
> >> >
> >> >
> >> >
> >> > Same sequence of events, with multipathd -v3
> >> >
> >> >
> >> >
> >> > Aug 13 16:28:48.627  kernel: device-mapper: multipath: Failing path
> >> 8:208.
> >> >
> >> > Aug 13 16:28:48.000  multipathd: vol1: rr_weight = 2 (LUN setting)
> >> >
> >> > Aug 13 16:28:48.000  multipathd: vol1: pgfailback = -2 (controller
> >> setting)
> >> >
> >> > Aug 13 16:28:48.000  multipathd: pg_timeout = NONE (internal default)
> >> >
> >> > Aug 13 16:28:48.000  multipathd: 8:208: mark as failed
> >> >
> >> > Aug 13 16:28:48.000  multipathd: uevent 'change' from
> >> > '/devices/virtual/block/dm-1'
> >> >
> >> > Aug 13 16:28:48.000  multipathd: UDEV_LOG=3
> >> >
> >> > Aug 13 16:28:48.000  multipathd: ACTION=change
> >> >
> >> > Aug 13 16:28:48.000  multipathd: DEVPATH=/devices/virtual/block/dm-1
> >> >
> >> > Aug 13 16:28:48.000  multipathd: SUBSYSTEM=block
> >> >
> >> > Aug 13 16:28:48.000  multipathd: DM_TARGET=multipath
> >> >
> >> > Aug 13 16:28:48.000  multipathd: DM_ACTION=PATH_FAILED
> >> >
> >> > Aug 13 16:28:48.000  multipathd: DM_SEQNUM=1
> >> >
> >> > Aug 13 16:28:48.000  multipathd: DM_PATH=8:208
> >> >
> >> > Aug 13 16:28:48.000  multipathd: DM_NR_VALID_PATHS=3
> >> >
> >> > Aug 13 16:28:48.000  multipathd: DM_NAME=vol1
> >> >
> >> > Aug 13 16:28:48.000  multipathd:
> >> > DM_UUID=mpath-3600a0b800048335200001e5d48b68a9b
> >> >
> >> > Aug 13 16:28:48.000  multipathd: MAJOR=253
> >> >
> >> > Aug 13 16:28:48.000  multipathd: MINOR=1
> >> >
> >> > Aug 13 16:28:48.000  multipathd: DEVTYPE=disk
> >> >
> >> > Aug 13 16:28:48.000  multipathd: SEQNUM=1738
> >> >
> >> > Aug 13 16:28:48.000  multipathd: UDEVD_EVENT=1
> >> >
> >> > Aug 13 16:28:48.000  multipathd: DEVNAME=/dev/dm-1
> >> >
> >> > Aug 13 16:28:50.000  multipathd: 8:208: reinstated
> >> >
> >> > Aug 13 16:28:50.000  multipathd: vol1: remaining active paths: 4
> >> >
> >> > Aug 13 16:28:50.000  multipathd: sdj: rdac prio = 3
> >> >
> >> > Aug 13 16:28:50.000  multipathd: sdn: rdac prio = 3
> >> >
> >> > Aug 13 16:28:50.000  multipathd: sdb: rdac prio = 0
> >> >
> >> > Aug 13 16:28:50.000  multipathd: sdd: rdac prio = 0
> >> >
> >> > Aug 13 16:28:50.763  kernel: device-mapper: multipath: Failing path
> >> 8:208.
> >> >
> >> > Aug 13 16:28:50.000  multipathd: uevent 'change' from
> >> > '/devices/virtual/block/dm-1'
> >> >
> >> > Aug 13 16:28:50.000  multipathd: UDEV_LOG=3
> >> >
> >> > Aug 13 16:28:50.000  multipathd: ACTION=change
> >> >
> >> > Aug 13 16:28:50.000  multipathd: DEVPATH=/devices/virtual/block/dm-1
> >> >
> >> > Aug 13 16:28:50.000  multipathd: SUBSYSTEM=block
> >> >
> >> > Aug 13 16:28:50.000  multipathd: DM_TARGET=multipath
> >> >
> >> > Aug 13 16:28:50.000  multipathd: DM_ACTION=PATH_REINSTATED
> >> >
> >> > Aug 13 16:28:50.000  multipathd: DM_SEQNUM=2
> >> >
> >> > Aug 13 16:28:50.000  multipathd: DM_PATH=8:208
> >> >
> >> > Aug 13 16:28:50.000  multipathd: DM_NR_VALID_PATHS=4
> >> >
> >> > Aug 13 16:28:50.000  multipathd: DM_NAME=vol1
> >> >
> >> > Aug 13 16:28:50.000  multipathd:
> >> > DM_UUID=mpath-3600a0b800048335200001e5d48b68a9b
> >> >
> >> > Aug 13 16:28:50.000  multipathd: MAJOR=253
> >> >
> >> > Aug 13 16:28:50.000  multipathd: MINOR=1
> >> >
> >> > Aug 13 16:28:50.000  multipathd: DEVTYPE=diskAug 13 16:28:50.000
> >> >  multipathd: SEQNUM=1739Aug 13 16:28:50.000  multipathd: UDEVD_EVENT=1
> >> >
> >> > Aug 13 16:28:50.000  multipathd: vol1: rr_weight = 2 (LUN setting)
> >> >
> >> > Aug 13 16:28:50.000  multipathd: vol1: pgfailback = -2 (controller
> >> setting)
> >> >
> >> > Aug 13 16:28:50.000  multipathd: pg_timeout = NONE (internal default)
> >> >
> >> > Aug 13 16:28:50.000  multipathd: 8:208: mark as failed
> >> >
> >> > Aug 13 16:28:50.000  multipathd: vol1: remaining active paths: 3
> >> >
> >> > Aug 13 16:28:50.000  multipathd: vol1: rr_weight = 2 (LUN setting)
> >> >
> >> > Aug 13 16:28:50.000  multipathd: vol1: pgfailback = -2 (controller
> >> setting)
> >> >
> >> > Aug 13 16:28:50.000  multipathd: uevent 'change' from
> >> > '/devices/virtual/block/dm-1'
> >> >
> >> > Aug 13 16:28:50.000  multipathd: UDEV_LOG=3
> >> >
> >> > Aug 13 16:28:50.000  multipathd: ACTION=change
> >> >
> >> > Aug 13 16:28:50.000  multipathd: DEVPATH=/devices/virtual/block/dm-1
> >> >
> >> > Aug 13 16:28:50.000  multipathd: SUBSYSTEM=block
> >> >
> >> > Aug 13 16:28:50.000  multipathd: DM_TARGET=multipath
> >> >
> >> > Aug 13 16:28:50.000  multipathd: DM_ACTION=PATH_FAILED
> >> >
> >> > Aug 13 16:28:50.000  multipathd: DM_SEQNUM=3
> >> >
> >> > Aug 13 16:28:50.000  multipathd: DM_PATH=8:208
> >> >
> >> > Aug 13 16:28:50.000  multipathd: DM_NR_VALID_PATHS=3
> >> >
> >> > Aug 13 16:28:50.000  multipathd: DM_NAME=vol1
> >> >
> >> > Aug 13 16:28:50.000  multipathd:
> >> > DM_UUID=mpath-3600a0b800048335200001e5d48b68a9b
> >> >
> >> > Aug 13 16:28:50.000  multipathd: MAJOR=253
> >> >
> >> > Aug 13 16:28:50.000  multipathd: MINOR=1
> >> >
> >> > Aug 13 16:28:50.000  multipathd: DEVTYPE=disk
> >> >
> >> > Aug 13 16:28:50.000  multipathd: SEQNUM=1740
> >> >
> >> > Aug 13 16:28:50.000  multipathd: UDEVD_EVENT=1
> >> >
> >> > Aug 13 16:28:50.000  multipathd: DEVNAME=/dev/dm-1
> >> >
> >> > Aug 13 16:29:00.000  multipathd: 8:208: reinstated
> >> >
> >> > Aug 13 16:29:00.000  multipathd: vol1: remaining active paths: 4
> >> >
> >> > Aug 13 16:29:00.000  multipathd: sdj: rdac prio = 3
> >> >
> >> > Aug 13 16:29:00.000  multipathd: sdn: rdac prio = 3
> >> >
> >> > Aug 13 16:29:00.000  multipathd: sdb: rdac prio = 0
> >> >
> >> > Aug 13 16:29:00.000  multipathd: sdd: rdac prio = 0
> >> >
> >> > Aug 13 16:29:00.000  multipathd: vol1: rr_weight = 2 (LUN setting)
> >> >
> >> > Aug 13 16:29:00.000  multipathd: vol1: pgfailback = -2 (controller
> >> setting)
> >> >
> >> > Aug 13 16:29:00.000  multipathd: uevent 'change' from
> >> > '/devices/virtual/block/dm-1'
> >> >
> >> > Aug 13 16:29:00.000  multipathd: UDEV_LOG=3
> >> >
> >> > Aug 13 16:29:00.000  multipathd: ACTION=change
> >> >
> >> > Aug 13 16:29:00.000  multipathd: DEVPATH=/devices/virtual/block/dm-1
> >> >
> >> > Aug 13 16:29:00.000  multipathd: SUBSYSTEM=block
> >> >
> >> > Aug 13 16:29:00.000  multipathd: DM_TARGET=multipath
> >> >
> >> > Aug 13 16:29:00.000  multipathd: DM_ACTION=PATH_REINSTATED
> >> >
> >> > Aug 13 16:29:00.000  multipathd: DM_SEQNUM=4
> >> >
> >> > Aug 13 16:29:00.000  multipathd: DM_PATH=8:208
> >> >
> >> > Aug 13 16:29:00.000  multipathd: DM_NR_VALID_PATHS=4
> >> >
> >> > Aug 13 16:29:00.000  multipathd: DM_NAME=vol1
> >> >
> >> > Aug 13 16:29:00.000  multipathd:
> >> > DM_UUID=mpath-3600a0b800048335200001e5d48b68a9b
> >> >
> >> > Aug 13 16:29:00.000  multipathd: MAJOR=253
> >> >
> >> > Aug 13 16:29:00.000  multipathd: MINOR=1
> >> >
> >> > Aug 13 16:29:00.000  multipathd: DEVTYPE=disk
> >> >
> >> > Aug 13 16:29:00.000  multipathd: SEQNUM=1741
> >> >
> >> > Aug 13 16:29:00.000  multipathd: UDEVD_EVENT=1
> >> >
> >> > Aug 13 16:29:00.000  multipathd: DEVNAME=/dev/dm-1
> >> >
> >> > Aug 13 16:29:02.753  kernel: device-mapper: multipath: Failing path
> >> 8:208.
> >> >
> >> > Aug 13 16:29:02.000  multipathd: vol1: rr_weight = 2 (LUN setting)
> >> >
> >> > Aug 13 16:29:02.000  multipathd: vol1: pgfailback = -2 (controller
> >> setting)
> >> >
> >> > Aug 13 16:29:02.000  multipathd: pg_timeout = NONE (internal default)
> >> >
> >> > Aug 13 16:29:02.000  multipathd: 8:208: mark as failed
> >> >
> >> > Aug 13 16:29:02.000  multipathd: uevent 'change' from
> >> > '/devices/virtual/block/dm-1'
> >> >
> >> > Aug 13 16:29:02.000  multipathd: UDEV_LOG=3
> >> >
> >> > Aug 13 16:29:02.000  multipathd: ACTION=change
> >> >
> >> > Aug 13 16:29:02.000  multipathd: DEVPATH=/devices/virtual/block/dm-1
> >> >
> >> > Aug 13 16:29:02.000  multipathd: SUBSYSTEM=block
> >> >
> >> > Aug 13 16:29:02.000  multipathd: DM_TARGET=multipath
> >> >
> >> > Aug 13 16:29:02.000  multipathd: DM_ACTION=PATH_FAILED
> >> >
> >> > Aug 13 16:29:02.000  multipathd: DM_SEQNUM=5
> >> >
> >> > Aug 13 16:29:02.000  multipathd: DM_PATH=8:208
> >> >
> >> > Aug 13 16:29:02.000  multipathd: DM_NR_VALID_PATHS=3
> >> >
> >> > Aug 13 16:29:02.000  multipathd: DM_NAME=vol1
> >> >
> >> > Aug 13 16:29:02.000  multipathd:
> >> > DM_UUID=mpath-3600a0b800048335200001e5d48b68a9b
> >> >
> >> > Aug 13 16:29:02.000  multipathd: MAJOR=253
> >> >
> >> > Aug 13 16:29:02.000  multipathd: MINOR=1
> >> >
> >> > Aug 13 16:29:02.000  multipathd: DEVTYPE=disk
> >> >
> >> > Aug 13 16:29:02.000  multipathd: SEQNUM=1742
> >> >
> >> > Aug 13 16:29:02.000  multipathd: UDEVD_EVENT=1
> >> >
> >> > Aug 13 16:29:02.000  multipathd: DEVNAME=/dev/dm-1
> >> >
> >> > Aug 13 16:29:10.000  multipathd: 8:208: reinstated
> >> >
> >> > Aug 13 16:29:10.000  multipathd: vol1: remaining active paths: 4
> >> >
> >> > Aug 13 16:29:10.000  multipathd: sdj: rdac prio = 3
> >> >
> >> > Aug 13 16:29:10.000  multipathd: sdn: rdac prio = 3
> >> >
> >> > Aug 13 16:29:10.000  multipathd: sdb: rdac prio = 0
> >> >
> >> > Aug 13 16:29:10.000  multipathd: sdd: rdac prio = 0
> >> >
> >> > Aug 13 16:29:10.000  multipathd: vol1: rr_weight = 2 (LUN setting)
> >> >
> >> > Aug 13 16:29:10.000  multipathd: vol1: pgfailback = -2 (controller
> >> setting)
> >> >
> >> > Aug 13 16:29:10.000  multipathd: uevent 'change' from
> >> > '/devices/virtual/block/dm-1'
> >> >
> >> > Aug 13 16:29:10.000  multipathd: UDEV_LOG=3
> >> >
> >> > Aug 13 16:29:10.000  multipathd: ACTION=change
> >> >
> >> > Aug 13 16:29:10.000  multipathd: DEVPATH=/devices/virtual/block/dm-1
> >> >
> >> > Aug 13 16:29:10.000  multipathd: SUBSYSTEM=block
> >> >
> >> > Aug 13 16:29:10.000  multipathd: DM_TARGET=multipath
> >> >
> >> > Aug 13 16:29:10.000  multipathd: DM_ACTION=PATH_REINSTATED
> >> >
> >> > Aug 13 16:29:10.000  multipathd: DM_SEQNUM=6
> >> >
> >> > Aug 13 16:29:10.000  multipathd: DM_PATH=8:208
> >> >
> >> > Aug 13 16:29:10.000  multipathd: DM_NR_VALID_PATHS=4
> >> >
> >> > Aug 13 16:29:10.000  multipathd: DM_NAME=vol1
> >> >
> >> > Aug 13 16:29:10.000  multipathd:
> >> > DM_UUID=mpath-3600a0b800048335200001e5d48b68a9b
> >> >
> >> > Aug 13 16:29:10.000  multipathd: MAJOR=253
> >> >
> >> > Aug 13 16:29:10.000  multipathd: MINOR=1
> >> >
> >> > Aug 13 16:29:10.000  multipathd: DEVTYPE=disk
> >> >
> >> > Aug 13 16:29:10.000  multipathd: SEQNUM=1743
> >> >
> >> > Aug 13 16:29:10.000  multipathd: UDEVD_EVENT=1
> >> >
> >> > Aug 13 16:29:10.000  multipathd: DEVNAME=/dev/dm-1
> >> >
> >> >
> >> >
> >> >
> >> >
> >> >
> >> >
> >> >
> >> >
> >> > On Thu, Aug 13, 2009 at 1:27 PM, Stewart Smith <stew@cleepdar.com>
> >> wrote:
> >> >
> >> >
> >> >
> >> > after a fresh, multipath -F and start of multipathd with -v 2 I see the
> >> > following messages.
> >> >
> >> >
> >> >
> >> > After starting multipathd I mounted /dev/mapper/vol1 and generated some
> >> > simple I/O to it using dd
> >> >
> >> >
> >> >
> >> >
> >> >
> >> > Aug 13 16:23:14.888 localhost kernel: device-mapper: multipath: Failing
> >> path
> >> > 8:208.
> >> >
> >> > Aug 13 16:23:14.000 localhost multipathd: 8:208: mark as failed
> >> >
> >> > Aug 13 16:23:16.000 localhost multipathd: 8:208: reinstated
> >> >
> >> > Aug 13 16:23:30.462 localhost kernel: device-mapper: multipath: Failing
> >> path
> >> > 8:208.
> >> >
> >> > Aug 13 16:23:30.000 localhost multipathd: 8:208: mark as failed
> >> >
> >> > Aug 13 16:23:39.000 localhost multipathd: 8:208: reinstated
> >> >
> >> > Aug 13 16:23:46.430 localhost kernel: device-mapper: multipath: Failing
> >> path
> >> > 8:208.
> >> >
> >> > Aug 13 16:23:46.000 localhost multipathd: 8:208: mark as failed
> >> >
> >> > Aug 13 16:23:51.041 localhost kernel: device-mapper: multipath: Failing
> >> path
> >> > 8:208.
> >> >
> >> > Aug 13 16:23:51.000 localhost multipathd: 8:208: mark as failed
> >> >
> >> > Aug 13 16:23:59.000 localhost multipathd: 8:208: reinstated
> >> >
> >> > Aug 13 16:24:06.465 localhost kernel: device-mapper: multipath: Failing
> >> path
> >> > 8:208.
> >> >
> >> > Aug 13 16:24:06.000 localhost multipathd: 8:208: mark as failed
> >> >
> >> > Aug 13 16:24:09.000 localhost multipathd: 8:208: reinstated
> >> >
> >> >
> >> >
> >> >
> >> >
> >> > Thanks,
> >> >
> >> > --
> >> >
> >> > Stew
> >> >
> >> >
> >> >
> >> >
> >> >
> >> >
> >> >
> >> > On Thu, Aug 13, 2009 at 12:42 PM, Moger, Babu <Babu.Moger@lsi.com>
> >> wrote:
> >> >
> >> > Do you have /var/log/messages file for this problem?
> >> >
> >> > Thanks
> >> > Babu Moger
> >> >
> >> >> -----Original Message-----
> >> >> From: dm-devel-bounces@redhat.com [mailto:dm-devel-bounces@redhat.com]
> >> On
> >> >> Behalf Of Stewart Smith
> >> >> Sent: Thursday, August 13, 2009 1:51 PM
> >> >> To: dm-devel@redhat.com
> >> >> Subject: [dm-devel] rdac path failure - Sun 6140
> >> >>
> >> >> Hello All,
> >> >>
> >> >> I am seeing many of these messages when my Sun 6140 array is under
> >> heavy
> >> >> I/O
> >> >> device-mapper: multipath: Failing path 8:208.
> >> >> device-mapper: multipath: Failing path 8:208.
> >> >> device-mapper: multipath: Failing path 8:208.
> >> >> device-mapper: multipath: Failing path 8:208.
> >> >> device-mapper: multipath: Failing path 8:208.
> >> >>
> >> >>
> >> >> I am running a Fedora 10 server, with two fiber connections to two
> >> >> different switches.  Both controllers on the 6140 have one connection
> >> >> to each switch as well.  The end result is that I see four paths to
> >> >> each LUN.
> >> >>
> >> >> When the volume is mounted and under significant load I see the
> >> >> messages above every few seconds.  They seem to appear every
> >> >> "no_path_retry" seconds.
> >> >>
> >> >> The 6140 controller firmware is up to date at version 07.50.08.10 and
> >> >> I have installed the latest firmware for my Emulex LPe11002 cards.  I
> >> >> have reproduced the problem using both Cisco MDS and Brocade fiber
> >> >> channel switches as well.
> >> >>
> >> >> Using CAM, I have set the initiator Host Type to "Linux" at the
> >> >> moment.  I have tried other options as well without success.
> >> >>
> >> >> I have NOT installed the RDAC drivers from either Sun or LSI -
> >> >> primarily because they do not seem to build on my Fedora 10 kernel.
> >> >>
> >> >> Any ideas would be greatly appreciated!!!
> >> >>
> >> >> configs and debugging multipathd output is below.
> >> >>
> >> >>
> >> >>
> >> >>
> >> >>
> >> >> Kernel: 2.6.27.24-170.2.68.fc10.x86_64
> >> >>
> >> >> # multipath -lll
> >> >> vol1 (3600a0b800048335200001e5d48b68a9b) dm-1 SUN,CSM200_R
> >> >> [size=12T][features=1 queue_if_no_path][hwhandler=1 rdac][rw]
> >> >> \_ round-robin 0 [prio=6][active]
> >> >>  \_ 5:0:1:2 sdj 8:144 [active][ready]
> >> >>  \_ 2:0:1:2 sdn 8:208 [active][ready]
> >> >> \_ round-robin 0 [prio=0][enabled]
> >> >>  \_ 2:0:0:2 sdb 8:16  [active][ghost]
> >> >>  \_ 5:0:0:2 sdd 8:48  [active][ghost]
> >> >>
> >> >>
> >> >> # cat /etc/multipath.conf
> >> >>
> >> >> blacklist {
> >> >>         devnode "^sd[a-z][[0-9]*]"
> >> >>         devnode "^(ram|raw|loop|fd|md|dm-|sr|scd|st)[0-9]*"
> >> >>         devnode "^hd[a-z][0-9]*"
> >> >>         devnode "^cciss!c[0-9]d[0-9](p[0-9]*)*"
> >> >> }
> >> >>
> >> >> defaults {
> >> >>         udev_dir                /dev
> >> >>         polling_interval        10
> >> >>         selector                "round-robin 0"
> >> >>         path_grouping_policy    multibus
> >> >>         getuid_callout          "/sbin/scsi_id --whitelisted /dev/%n"
> >> >>         prio                    alua
> >> >>         path_checker            readsector0
> >> >>         rr_min_io               100
> >> >>         max_fds                 8192
> >> >>         rr_weight               priorities
> >> >>         failback                immediate
> >> >>         no_path_retry           fail
> >> >>         user_friendly_names     yes
> >> >> }
> >> >> devices {
> >> >>         device {
> >> >>                 vendor                  "SUN"
> >> >>                 product                 "CSM200_R"
> >> >>                 product_blacklist       "Universal Xport"
> >> >>                 getuid_callout          "/sbin/scsi_id --whitelisted
> >> >> /dev/%n"
> >> >>                 features                "0"
> >> >>                 hardware_handler        "1 rdac"
> >> >>                 path_selector           "round-robin 0"
> >> >>                 path_grouping_policy    group_by_prio
> >> >>                 failback                immediate
> >> >>                 rr_weight               uniform
> >> >>                 no_path_retry           queue
> >> >>                 rr_min_io               1000
> >> >>                 path_checker            rdac
> >> >>                 prio                    rdac
> >> >>         }
> >> >> }
> >> >>
> >> >> multipaths {
> >> >>         multipath {
> >> >>                 wwid
> >>  3600a0b800048335200001e5d48b68a9b
> >> >>                 alias                   vol1
> >> >>                 rr_weight               priorities
> >> >>                 no_path_retry           5
> >> >>                 rr_min_io               100
> >> >>         }
> >> >> }
> >> >>
> >> >>
> >> >>
> >> >> # multipathd -d v3
> >> >>
> >> >>
> >> >> Aug 13 14:48:53 | sdb: ownership set to vol1
> >> >> Aug 13 14:48:53 | sdb: not found in pathvec
> >> >> Aug 13 14:48:53 | sdb: mask = 0xc
> >> >> Aug 13 14:48:53 | sdb: path checker = rdac (controller setting)
> >> >> Aug 13 14:48:53 | sdb: state = 4
> >> >> Aug 13 14:48:53 | sdb: rdac prio = 0
> >> >> Aug 13 14:48:53 | sdd: ownership set to vol1
> >> >> Aug 13 14:48:53 | sdd: not found in pathvec
> >> >> Aug 13 14:48:53 | sdd: mask = 0xc
> >> >> Aug 13 14:48:53 | sdd: path checker = rdac (controller setting)
> >> >> Aug 13 14:48:53 | sdd: state = 4
> >> >> Aug 13 14:48:53 | sdd: rdac prio = 0
> >> >> Aug 13 14:48:53 | sdj: ownership set to vol1
> >> >> Aug 13 14:48:53 | sdj: not found in pathvec
> >> >> Aug 13 14:48:53 | sdj: mask = 0xc
> >> >> Aug 13 14:48:53 | sdj: path checker = rdac (controller setting)
> >> >> Aug 13 14:48:53 | sdj: state = 2
> >> >> Aug 13 14:48:53 | sdj: rdac prio = 3
> >> >> Aug 13 14:48:53 | sdn: ownership set to vol1
> >> >> Aug 13 14:48:53 | sdn: not found in pathvec
> >> >> Aug 13 14:48:53 | sdn: mask = 0xc
> >> >> Aug 13 14:48:53 | sdn: path checker = rdac (controller setting)
> >> >> Aug 13 14:48:53 | sdn: state = 2
> >> >> Aug 13 14:48:53 | sdn: rdac prio = 3
> >> >> Aug 13 14:48:53 | vol1: pgfailback = -2 (controller setting)
> >> >> Aug 13 14:48:53 | vol1: pgpolicy = group_by_prio (controller setting)
> >> >> Aug 13 14:48:53 | vol1: selector = round-robin 0 (controller setting)
> >> >> Aug 13 14:48:53 | vol1: features = 0 (controller setting)
> >> >> Aug 13 14:48:53 | vol1: hwhandler = 1 rdac (controller setting)
> >> >> Aug 13 14:48:53 | vol1: rr_weight = 2 (LUN setting)
> >> >> Aug 13 14:48:53 | vol1: minio = 100 (LUN setting)
> >> >> Aug 13 14:48:53 | vol1: no_path_retry = 5 (multipath setting)
> >> >> Aug 13 14:48:53 | pg_timeout = NONE (internal default)
> >> >> Aug 13 14:48:53 | vol1: set ACT_CREATE (map does not exist)
> >> >> create: vol1 (3600a0b800048335200001e5d48b68a9b) n/a SUN,CSM200_R
> >> >> [size=12T][features=0][hwhandler=1 rdac][n/a]
> >> >> \_ round-robin 0 [prio=6][undef]
> >> >>  \_ 5:0:1:2 sdj 8:144 [undef][ready]
> >> >>  \_ 2:0:1:2 sdn 8:208 [undef][ready]
> >> >> \_ round-robin 0 [prio=0][undef]
> >> >>  \_ 2:0:0:2 sdb 8:16 [undef][ghost]
> >> >>  \_ 5:0:0:2 sdd 8:48 [undef][ghost]
> >> >>
> >> >
> >> >> --
> >> >> dm-devel mailing list
> >> >> dm-devel@redhat.com
> >> >> https://www.redhat.com/mailman/listinfo/dm-devel
> >> >
> >> > --
> >> > dm-devel mailing list
> >> > dm-devel@redhat.com
> >> > https://www.redhat.com/mailman/listinfo/dm-devel
> >> >
> >> >
> >> >
> >> >
> >>
> >> --
> >> dm-devel mailing list
> >> dm-devel@redhat.com
> >> https://www.redhat.com/mailman/listinfo/dm-devel
> >
> > --
> > dm-devel mailing list
> > dm-devel@redhat.com
> > https://www.redhat.com/mailman/listinfo/dm-devel
> >
> 
> --
> dm-devel mailing list
> dm-devel@redhat.com
> https://www.redhat.com/mailman/listinfo/dm-devel

^ permalink raw reply	[flat|nested] 9+ messages in thread

end of thread, other threads:[~2009-08-14 22:22 UTC | newest]

Thread overview: 9+ messages (download: mbox.gz follow: Atom feed
-- links below jump to the message on this page --
2009-08-13 18:50 rdac path failure - Sun 6140 Stewart Smith
2009-08-13 19:42 ` Moger, Babu
2009-08-13 20:27   ` Stewart Smith
2009-08-13 20:34     ` Stewart Smith
2009-08-14  0:05       ` Moger, Babu
2009-08-14 15:58         ` Stewart Smith
2009-08-14 16:21           ` Moger, Babu
2009-08-14 20:26             ` Stewart Smith
2009-08-14 22:22               ` Chandra Seetharaman

This is a public inbox, see mirroring instructions
for how to clone and mirror all data and code used for this inbox