Missed Create Events

We use Idenity Manager for automated account managament within EDirectory,
and NSM works OK in conjunction with IM most of the time, but a small
percentage of our create events are being dropped by NSM. It appears to be
incorrectly identifuing some create events as move events.

We are running the latest version of Storage Manager according to the Check
for Updates feature and we have been running two event servers for a couple
of months (I believe that was one of tech support's suggestions the last
time we reported this problem), but we are still seeing a few events get
missed in the shuffle. Below is the section of the event log pertaining to
one of the creates that got skipped last week
(122759.G2.Students.HomeConnect.Roam.VSD). The event servers appear to have
detected the create as a move and then skipped over the event after the move
tests failed. There were no additional entries in the log about this user.

Thanks,
Steve Bratt

Event Server Information for Server1:
Netware 6.5 SP5
Edirectory version 8.7.3.7
Storage Manager Event Monitor version 2.00.08 Oct 31 2006 09:35:35

Nemo Event Log Entries:
03/02/2007 09:02:53 4: TestForMove start
<122759.G2.Students.HomeConnect.Roam.VSD>
03/02/2007 09:02:53 4: GetReservedServerConnEvironment astnum=339
03/02/2007 09:02:53 0: got specific AST: 339
03/02/2007 09:02:53 4: TestForMove: connected to the replica server.
rconn=2129451360
03/02/2007 09:02:53 2: Error reading object info:
<122759.G2.Students.HomeConnect.Roam.VSD> -601
03/02/2007 09:02:53 4: TestForMove: create event honored due to no local
GUID
03/02/2007 09:02:53 4: TestForMove start
<122759.G2.Students.HomeConnect.Roam.VSD>
03/02/2007 09:02:53 4: GetReservedServerConnEvironment astnum=339
03/02/2007 09:02:53 0: got specific AST: 339
03/02/2007 09:02:53 4: TestForMove: connected to the replica server.
rconn=2129451360
03/02/2007 09:02:53 2: Error reading object info:
<122759.G2.Students.HomeConnect.Roam.VSD> -601
03/02/2007 09:02:53 4: TestForMove: create event honored due to no local
GUID
03/02/2007 09:02:55 4:
MU,1172596797,1172854970,NEMO,69515.G10.STUDENTS.BAY.HS.VSD..CN=69515.OU=STU
DENTS.OU=USERS.OU=DELETED.O=VSD
03/02/2007 09:02:55 4: AM,1172854956,1172854956,NEMO,INTERNET
USERS.INTERNET.APPS.ROAM.VSD..122759.G2.STUDENTS.HOMECONNECT.ROAM.VSD
03/02/2007 09:02:55 4:
AM,1172854956,1172854956,NEMO,STUDENTGRP.STUDENTS.ROAM.VSD..122759.G2.STUDEN
TS.HOMECONNECT.ROAM.VSD

Event Server Information for Server2:
Netware 6.5 SP5
Edirectory version 8.7.3.7
Storage Manager Event Monitor version 2.00.08 Oct 31 2006 09:35:35

Sockeye Event Log Entries:
03/02/2007 09:03:02 4: TestForMove start
<122759.G2.Students.HomeConnect.Roam.VSD>
03/02/2007 09:03:02 4: GetReservedServerConnEvironment astnum=103
03/02/2007 09:03:02 0: got specific AST: 103
03/02/2007 09:03:02 4: TestForMove: connected to the replica server.
rconn=1283672896
03/02/2007 09:03:02 2: Error reading object info:
<122759.G2.Students.HomeConnect.Roam.VSD> 35082
03/02/2007 09:03:02 0: GetNDSObjectAttr: Error from NWDSRead err:
35082.03/02/2007 09:03:02 4: TestForMove: create event honored due to no
local GUID
03/02/2007 09:03:02 4: TestForMove start
<122759.G2.Students.HomeConnect.Roam.VSD>
03/02/2007 09:03:02 4: GetReservedServerConnEvironment astnum=103
03/02/2007 09:03:02 0: got specific AST: 103
03/02/2007 09:03:02 4: TestForMove: connected to the replica server.
rconn=1283672896
03/02/2007 09:03:02 2: Error reading object info:
<122759.G2.Students.HomeConnect.Roam.VSD> 35082
03/02/2007 09:03:02 0: GetNDSObjectAttr: Error from NWDSRead err:
35082.03/02/2007 09:03:02 4: TestForMove: create event honored due to no
local GUID
03/02/2007 09:03:04 4:
MU,1172596797,1172854980,SOCKEYE,69515.G10.STUDENTS.BAY.HS.VSD..CN=69515.OU=
STUDENTS.OU=USERS.OU=DELETED.O=VSD
03/02/2007 09:03:04 4: AM,1172854956,1172854956,SOCKEYE,INTERNET
USERS.INTERNET.APPS.ROAM.VSD..122759.G2.STUDENTS.HOMECONNECT.ROAM.VSD
03/02/2007 09:03:04 4:
AM,1172854956,1172854956,SOCKEYE,STUDENTGRP.STUDENTS.ROAM.VSD..122759.G2.STU
DENTS.HOMECONNECT.ROAM.VSD

  • Steve,
    We have seen this in another installation. We are working on a fix, and
    would appreciate some configuration information from you - sent to
    storagemanager -at- novell.com. A dump configuration file would be good,
    along with your fsfevent.txt

    Thanks
    NSM Development

    >>> On 3/5/2007 at 12:27 PM, in message <45EBE276.3525.00BD.0@vansd.org>,

    STEVE
    Bratt<Steve.Bratt@vansd.org> wrote:
    > We use Idenity Manager for automated account managament within
    > EDirectory,
    > and NSM works OK in conjunction with IM most of the time, but a small
    > percentage of our create events are being dropped by NSM. It appears to
    > be
    > incorrectly identifuing some create events as move events.
    >
    > We are running the latest version of Storage Manager according to the
    > Check
    > for Updates feature and we have been running two event servers for a
    > couple
    > of months (I believe that was one of tech support's suggestions the last
    > time we reported this problem), but we are still seeing a few events get
    > missed in the shuffle. Below is the section of the event log pertaining
    > to
    > one of the creates that got skipped last week
    > (122759.G2.Students.HomeConnect.Roam.VSD). The event servers appear to
    > have
    > detected the create as a move and then skipped over the event after the
    > move
    > tests failed. There were no additional entries in the log about this
    > user.
    >
    > Thanks,
    > Steve Bratt
    >
    > Event Server Information for Server1:
    > Netware 6.5 SP5
    > Edirectory version 8.7.3.7
    > Storage Manager Event Monitor version 2.00.08 Oct 31 2006 09:35:35
    >
    > Nemo Event Log Entries:
    > 03/02/2007 09:02:53 4: TestForMove start
    > <122759.G2.Students.HomeConnect.Roam.VSD>
    > 03/02/2007 09:02:53 4: GetReservedServerConnEvironment astnum=339
    > 03/02/2007 09:02:53 0: got specific AST: 339
    > 03/02/2007 09:02:53 4: TestForMove: connected to the replica server.
    > rconn=2129451360
    > 03/02/2007 09:02:53 2: Error reading object info:
    > <122759.G2.Students.HomeConnect.Roam.VSD> -601
    > 03/02/2007 09:02:53 4: TestForMove: create event honored due to no local
    > GUID
    > 03/02/2007 09:02:53 4: TestForMove start
    > <122759.G2.Students.HomeConnect.Roam.VSD>
    > 03/02/2007 09:02:53 4: GetReservedServerConnEvironment astnum=339
    > 03/02/2007 09:02:53 0: got specific AST: 339
    > 03/02/2007 09:02:53 4: TestForMove: connected to the replica server.
    > rconn=2129451360
    > 03/02/2007 09:02:53 2: Error reading object info:
    > <122759.G2.Students.HomeConnect.Roam.VSD> -601
    > 03/02/2007 09:02:53 4: TestForMove: create event honored due to no local
    > GUID
    > 03/02/2007 09:02:55 4:
    > MU,1172596797,1172854970,NEMO,69515.G10.STUDENTS.BAY.HS.VSD..CN=69515.OU
    > =STU
    > DENTS.OU=USERS.OU=DELETED.O=VSD
    > 03/02/2007 09:02:55 4: AM,1172854956,1172854956,NEMO,INTERNET
    > USERS.INTERNET.APPS.ROAM.VSD..122759.G2.STUDENTS.HOMECONNECT.ROAM.VSD
    > 03/02/2007 09:02:55 4:
    > AM,1172854956,1172854956,NEMO,STUDENTGRP.STUDENTS.ROAM.VSD..122759.G2.ST
    > UDEN
    > TS.HOMECONNECT.ROAM.VSD
    >
    > Event Server Information for Server2:
    > Netware 6.5 SP5
    > Edirectory version 8.7.3.7
    > Storage Manager Event Monitor version 2.00.08 Oct 31 2006 09:35:35
    >
    > Sockeye Event Log Entries:
    > 03/02/2007 09:03:02 4: TestForMove start
    > <122759.G2.Students.HomeConnect.Roam.VSD>
    > 03/02/2007 09:03:02 4: GetReservedServerConnEvironment astnum=103
    > 03/02/2007 09:03:02 0: got specific AST: 103
    > 03/02/2007 09:03:02 4: TestForMove: connected to the replica server.
    > rconn=1283672896
    > 03/02/2007 09:03:02 2: Error reading object info:
    > <122759.G2.Students.HomeConnect.Roam.VSD> 35082
    > 03/02/2007 09:03:02 0: GetNDSObjectAttr: Error from NWDSRead err:
    > 35082.03/02/2007 09:03:02 4: TestForMove: create event honored due to no
    > local GUID
    > 03/02/2007 09:03:02 4: TestForMove start
    > <122759.G2.Students.HomeConnect.Roam.VSD>
    > 03/02/2007 09:03:02 4: GetReservedServerConnEvironment astnum=103
    > 03/02/2007 09:03:02 0: got specific AST: 103
    > 03/02/2007 09:03:02 4: TestForMove: connected to the replica server.
    > rconn=1283672896
    > 03/02/2007 09:03:02 2: Error reading object info:
    > <122759.G2.Students.HomeConnect.Roam.VSD> 35082
    > 03/02/2007 09:03:02 0: GetNDSObjectAttr: Error from NWDSRead err:
    > 35082.03/02/2007 09:03:02 4: TestForMove: create event honored due to no
    > local GUID
    > 03/02/2007 09:03:04 4:
    > MU,1172596797,1172854980,SOCKEYE,69515.G10.STUDENTS.BAY.HS.VSD..CN=69515
    > .OU=
    > STUDENTS.OU=USERS.OU=DELETED.O=VSD
    > 03/02/2007 09:03:04 4: AM,1172854956,1172854956,SOCKEYE,INTERNET
    > USERS.INTERNET.APPS.ROAM.VSD..122759.G2.STUDENTS.HOMECONNECT.ROAM.VSD
    > 03/02/2007 09:03:04 4:
    > AM,1172854956,1172854956,SOCKEYE,STUDENTGRP.STUDENTS.ROAM.VSD..122759.G2
    > .STU
    > DENTS.HOMECONNECT.ROAM.VSD