DRBD will not start the sync process

SUSE Product Topics SLES Configure-Administer
1

Hi,

We are trying to use DRBD to sync up to LVM logical volumes on PowerPC
720 VMs. We can get the initial connection messages but as soon as we
tell it to sync the primary to secondary it goes to WFConnection.
drbdsetup /dev/drbd0 events -u
2 ST 0 { cs:WFConnection ro:Secondary/Unknown ds:Inconsistent/DUnknown
r— }
20813 ST 0 { cs:WFReportParams ro:Secondary/Unknown
ds:Inconsistent/DUnknown r— }
20814 ST 0 { cs:WFBitMapT ro:Secondary/Primary ds:Inconsistent/UpToDate
r— }
20815 ST 0 { cs:WFSyncUUID ro:Secondary/Primary
ds:Inconsistent/UpToDate r— }
20816 UH 0 before-resync-target
1 ST 0 { cs:WFSyncUUID ro:Secondary/Primary ds:Inconsistent/UpToDate
r— }
20817 ST 0 { cs:SyncTarget ro:Secondary/Primary
ds:Inconsistent/UpToDate r— }
20818 ST 0 { cs:NetworkFailure ro:Secondary/Unknown
ds:Inconsistent/DUnknown r— }
20819 ST 0 { cs:Unconnected ro:Secondary/Unknown
ds:Inconsistent/DUnknown r— }
20820 ST 0 { cs:WFConnection ro:Secondary/Unknown
ds:Inconsistent/DUnknown r— }
20821 ST 0 { cs:WFReportParams ro:Secondary/Unknown
ds:Inconsistent/DUnknown r— }
20822 ST 0 { cs:WFBitMapT ro:Secondary/Primary ds:Inconsistent/UpToDate
r— }
20823 ST 0 { cs:WFSyncUUID ro:Secondary/Primary
ds:Inconsistent/UpToDate r— }
20824 UH 0 before-resync-target

/var/log/messages:
Nov 30 19:20:37 info1 kernel: klogd 1.4.1, ---------- state change

Nov 30 19:20:37 info1 kernel: blk_queue_max_segment_size: set to
minimum 65536
Nov 30 19:20:37 info1 kernel: block drbd0: Starting worker thread (from
cqueue [3618])
Nov 30 19:20:37 info1 kernel: block drbd0: disk( Diskless → Attaching
)
Nov 30 19:20:37 info1 kernel: block drbd0: Found 1 transactions (1
active extents) in activity log.
Nov 30 19:20:37 info1 kernel: block drbd0: Method to ensure write
ordering: barrier
Nov 30 19:20:37 info1 kernel: block drbd0: Backing device’s
merge_bvec_fn() = d0000000029839f0
Nov 30 19:20:37 info1 kernel: block drbd0: max_segment_size ( = BIO
size ) = 65536
Nov 30 19:20:37 info1 kernel: block drbd0: drbd_bm_resize called with
capacity == 10485368
Nov 30 19:20:37 info1 kernel: block drbd0: resync bitmap: bits=1310671
words=20480
Nov 30 19:20:37 info1 kernel: block drbd0: size = 5120 MB (5242684 KB)
Nov 30 19:20:37 info1 kernel: block drbd0: recounting of set bits took
additional 0 jiffies
Nov 30 19:20:37 info1 kernel: block drbd0: 19 MB (4887 bits) marked
out-of-sync by on disk bit-map.
Nov 30 19:20:37 info1 kernel: block drbd0: disk( Attaching → UpToDate
) pdsk( DUnknown → Outdated )
Nov 30 19:20:37 info1 kernel: block drbd0: conn( StandAlone →
Unconnected )
Nov 30 19:20:37 info1 kernel: block drbd0: Starting receiver thread
(from drbd0_worker [20704])
Nov 30 19:20:37 info1 kernel: block drbd0: receiver (re)started
Nov 30 19:20:37 info1 kernel: block drbd0: conn( Unconnected →
WFConnection )
Nov 30 19:20:48 info1 kernel: block drbd0: Handshake successful: Agreed
network protocol version 91
Nov 30 19:20:48 info1 kernel: block drbd0: conn( WFConnection →
WFReportParams )
Nov 30 19:20:48 info1 kernel: block drbd0: Starting asender thread
(from drbd0_receiver [20718])
Nov 30 19:20:48 info1 kernel: block drbd0: data-integrity-alg:

Nov 30 19:20:48 info1 kernel: block drbd0: drbd_sync_handshake:
Nov 30 19:20:48 info1 kernel: block drbd0: self
806E043A51EDBC2A:1305C57E68297622:9D8BE51EF668C301:7102FBD0F223
38D0 bits:4887 flags:0
Nov 30 19:20:48 info1 kernel: block drbd0: peer
1305C57E68297622:0000000000000000:CB814415AC44771E:B201464AD6E9
1765 bits:0 flags:0
Nov 30 19:20:48 info1 kernel: block drbd0: uuid_compare()=1 by rule 70
Nov 30 19:20:48 info1 kernel: block drbd0: Becoming sync source due to
disk states.
Nov 30 19:20:48 info1 kernel: block drbd0: peer( Unknown → Secondary )
conn( WFReportParams → WFBitMapS ) pds
k( Outdated → Inconsistent )
Nov 30 19:20:48 info1 kernel: block drbd0: conn( WFBitMapS →
SyncSource )
Nov 30 19:20:48 info1 kernel: block drbd0: Began resync as SyncSource
(will sync 19548 KB [4887 bits set]).
Nov 30 19:20:48 info1 kernel: block drbd0:
/usr/src/packages/BUILD/drbd-8.3.7/obj/ppc64/drbd_receiver.c:1995: s
ector: 16384s, size: 65536
Nov 30 19:20:48 info1 kernel: block drbd0: error receiving
RSDataRequest, l: 24!
Nov 30 19:20:48 info1 kernel: block drbd0: peer( Secondary → Unknown )
conn( SyncSource → ProtocolError )
Nov 30 19:20:48 info1 kernel: block drbd0: asender terminated
Nov 30 19:20:48 info1 kernel: block drbd0: Terminating asender thread
Nov 30 19:20:48 info1 kernel: block drbd0: Connection closed
Nov 30 19:20:48 info1 kernel: block drbd0: conn( ProtocolError →
Unconnected )
Nov 30 19:20:48 info1 kernel: block drbd0: receiver terminated
Nov 30 19:20:48 info1 kernel: block drbd0: Restarting receiver thread
Nov 30 19:20:48 info1 kernel: block drbd0: receiver (re)started
Nov 30 19:20:48 info1 kernel: block drbd0: conn( Unconnected →
WFConnection )
Nov 30 19:20:48 info1 kernel: block drbd0: Handshake successful: Agreed
network protocol version 91
Nov 30 19:20:48 info1 kernel: block drbd0: conn( WFConnection →
WFReportParams )
Nov 30 19:20:48 info1 kernel: block drbd0: Starting asender thread
(from drbd0_receiver [20718])
Nov 30 19:20:48 info1 kernel: block drbd0: data-integrity-alg:

Nov 30 19:20:48 info1 kernel: block drbd0: drbd_sync_handshake:
Nov 30 19:20:48 info1 kernel: block drbd0: self
806E043A51EDBC2A:EEF11BDAD7BF92A1:1305C57E68297622:9D8BE51EF668
C301 bits:4887 flags:0
Nov 30 19:20:48 info1 kernel: block drbd0: peer
EEF11BDAD7BF92A0:0000000000000000:CB814415AC44771E:B201464AD6E9
1765 bits:4887 flags:0
Nov 30 19:20:48 info1 kernel: block drbd0: uuid_compare()=1 by rule 70
Nov 30 19:20:48 info1 kernel: block drbd0: Becoming sync source due to
disk states.
Nov 30 19:20:48 info1 kernel: block drbd0: peer( Unknown → Secondary )
conn( WFReportParams → WFBitMapS )
Nov 30 19:20:48 info1 kernel: block drbd0: conn( WFBitMapS →
SyncSource )
Nov 30 19:20:48 info1 kernel: block drbd0: Began resync as SyncSource
(will sync 19548 KB [4887 bits set]).
Nov 30 19:20:48 info1 kernel: block drbd0:
/usr/src/packages/BUILD/drbd-8.3.7/obj/ppc64/drbd_receiver.c:1995: s
ector: 16384s, size: 65536
Nov 30 19:20:48 info1 kernel: block drbd0: error receiving
RSDataRequest, l: 24!
Nov 30 19:20:48 info1 kernel: block drbd0: peer( Secondary → Unknown )
conn( SyncSource → ProtocolError )
Nov 30 19:20:48 info1 kernel: block drbd0: asender terminated
Nov 30 19:20:48 info1 kernel: block drbd0: Terminating asender thread

This goes on and on with no end to it. We have drbd 8.3.7 installed on
suse11 SP1
I’m suspecting either a configuration issue or a patch.

–
amadera

amadera’s Profile: http://forums.novell.com/member.php?userid=120594
View this thread: http://forums.novell.com/showthread.php?t=448989

2

amadera,

It appears that in the past few days you have not received a response to your
posting. That concerns us, and has triggered this automated reply.

Has your problem been resolved? If not, you might try one of the following options:

  • Visit http://support.novell.com and search the knowledgebase and/or check all
    the other self support options and support programs available.
  • You could also try posting your message again. Make sure it is posted in the
    correct newsgroup. (http://forums.novell.com)

Be sure to read the forum FAQ about what to expect in the way of responses:
http://forums.novell.com/faq.php

If this is a reply to a duplicate posting, please ignore and accept our apologies
and rest assured we will issue a stern reprimand to our posting bot.

Good luck!

Your Novell Product Support Forums Team
http://forums.novell.com/

3

your problem shows: “Nov 30 19:20:48 info1 kernel: block drbd0: error
receiving RSDataRequest, l: 24!”
you can deep into drbd source code.d

–
todaygood123

todaygood123’s Profile: http://forums.novell.com/member.php?userid=120505
View this thread: http://forums.novell.com/showthread.php?t=448989