ICal-server Archive

List Statistics

  • Total Threads: 53
  • Total Posts: 33
  #1  
31-05-2011 08:00 PM
ICal-server member admin is online now
User
 

So, this may just have been an example of coincidence (or just bad timing), but I had this problem today with my 10.6.7 iCal server:



Around 10:00 a.m., I did an archive of my OD database (with Server Admin). Nothing was amiss with the archive (though it took longer than usual):

2011-05-31 10:09:15 -0400 - slapconfig -backupdb
2011-05-31 10:09:15 -0400 - command: /usr/sbin/sso_util info -r /LDAPv3/127.0.0.1 -p
2011-05-31 10:09:15 -0400 - 1 Backing up LDAP database
2011-05-31 10:09:15 -0400 - Stopping LDAP server (slapd)
2011-05-31 10:09:16 -0400 - command: /usr/bin/db_recover -h /var/db/openldap/openldap-data
2011-05-31 10:09:17 -0400 - popen: /usr/sbin/slapcat -l /tmp/slapconfig_backup_stage43919vK92MQ/backup.ldif, "r"
2011-05-31 10:09:29 -0400 - Starting LDAP server (slapd)
2011-05-31 10:09:29 -0400 - popen: /bin/cp /var/db/openldap/openldap-data/DB_CONFIG /tmp/slapconfig_backup_stage43919vK92MQ/DB_CONFIG, "r"
2011-05-31 10:09:29 -0400 - popen: /bin/cp -r /etc/openldap /tmp/slapconfig_backup_stage43919vK92MQ/, "r"
2011-05-31 10:09:31 -0400 - 2 Backing up password server database
2011-05-31 10:09:31 -0400 - popen: /usr/sbin/mkpassdb -backupdb /tmp/slapconfig_backup_stage43919vK92MQ/passwordserver_backup/ > /dev/null, "r"
2011-05-31 10:09:31 -0400 - popen: /bin/cp -r /Library/Preferences/com.apple.passwordserver.plist /tmp/slapconfig_backup_stage43919vK92MQ/, "r"
2011-05-31 10:09:31 -0400 - popen: /usr/sbin/mkpassdb -list > /tmp/slapconfig_backup_stage43919vK92MQ/sasl-plugin-list, "r"
2011-05-31 10:09:31 -0400 - popen: /bin/hostname > /tmp/slapconfig_backup_stage43919vK92MQ/hostname, "r"
2011-05-31 10:09:31 -0400 - 3 Backing up Kerberos database
2011-05-31 10:09:31 -0400 - popen: /usr/sbin/kdb5_util -r FS.TECHTRANSFER.UMICH.EDU dump > /tmp/slapconfig_backup_stage43919vK92MQ/kdb5dump.FS.TECHTRANSFER.UMICH.EDU.bak, "r"
2011-05-31 10:09:31 -0400 - popen: /usr/sbin/sso_util info -pr /LDAPv3/127.0.0.1 > /tmp/slapconfig_backup_stage43919vK92MQ/local_odkrb5realm, "r"
2011-05-31 10:09:37 -0400 - Error: Command failed with exit code 512: /usr/sbin/sso_util info -pr /LDAPv3/127.0.0.1 > /tmp/slapconfig_backup_stage43919vK92MQ/local_odkrb5realm
2011-05-31 10:09:37 -0400 - popen: /usr/bin/tar czpf /tmp/slapconfig_backup_stage43919vK92MQ/krb5backup.tar.gz /var/db/krb5kdc/kdc.conf /var/db/krb5kdc/kadm5.acl /var/db/krb5kdc/kadm5.keytab /var/db/krb5kdc/.k5.* /Library/Preferences/edu.mit.Kerberos /etc/krb5.keytab , "r"
2011-05-31 10:09:37 -0400 - popen: /bin/cp /var/db/dslocal/nodes/Default/config/KerberosKDC.plist /tmp/slapconfig_backup_stage43919vK92MQ/KerberosKDC.plist, "r"
2011-05-31 10:09:37 -0400 - popen: /bin/cp /System/Library/LaunchDaemons/com.apple.PasswordService.plist /tmp/slapconfig_backup_stage43919vK92MQ/LaunchDaemons/, "r"
2011-05-31 10:09:37 -0400 - 4 Backing up configuration files
2011-05-31 10:09:37 -0400 - popen: /bin/cp /System/Library/LaunchDaemons/org.openldap.slapd.plist /tmp/slapconfig_backup_stage43919vK92MQ/LaunchDaemons/, "r"
2011-05-31 10:09:37 -0400 - popen: /bin/cp -r /Library/Preferences/DirectoryService /tmp/slapconfig_backup_stage43919vK92MQ/, "r"
2011-05-31 10:09:37 -0400 - popen: /bin/cp /Library/Preferences/com.apple.openldap.plist /tmp/slapconfig_backup_stage43919vK92MQ/, "r"
2011-05-31 10:09:37 -0400 - popen: /bin/cp /Library/Preferences/SystemConfiguration/com.apple.smb.server.plist /tmp/slapconfig_backup_stage43919vK92MQ/, "r"
2011-05-31 10:09:37 -0400 - popen: /bin/cp /Library/Preferences/com.apple.samba.plist /tmp/slapconfig_backup_stage43919vK92MQ/, "r"
2011-05-31 10:09:37 -0400 - popen: /usr/bin/sw_vers > /tmp/slapconfig_backup_stage43919vK92MQ/version.txt, "r"
2011-05-31 10:09:37 -0400 - popen: /bin/cp -r /var/db/dslocal /tmp/slapconfig_backup_stage43919vK92MQ/, "r"
2011-05-31 10:09:40 -0400 - 5 Backing up local directory database
2011-05-31 10:09:40 -0400 - popen: /usr/bin/tar czpf /tmp/slapconfig_backup_stage43919vK92MQ/shadowbackup.tar.gz /var/db/shadow, "r"
2011-05-31 10:09:40 -0400 - popen: /usr/bin/gnutar cpf /tmp/slapconfig_backup_stage43919vK92MQ/sambabackup.tar /var/db/samba /etc/smb.conf, "r"
2011-05-31 10:09:40 -0400 - command: /usr/bin/gnutar --delete -f /tmp/slapconfig_backup_stage43919vK92MQ/sambabackup.tar var/db/samba/secrets.tdb
2011-05-31 10:09:40 -0400 - command: /usr/bin/gzip -f4 /tmp/slapconfig_backup_stage43919vK92MQ/sambabackup.tar
2011-05-31 10:09:41 -0400 - Backed Up Keychain
2011-05-31 10:09:41 -0400 - 6 Creating archive
2011-05-31 10:09:41 -0400 - command: /usr/bin/hdiutil create -ov -plist -puppetstrings -layout UNIVERSAL CD -fs HFS+ -volname ldap_bk -srcfolder /tmp/slapconfig_backup_stage43919vK92MQ -format SPARSE -encryption AES-256 -stdinpass /OD Database Backups/5-31
2011-05-31 10:10:29 -0400 - Removed directory at path /tmp/slapconfig_backup_stage43919vK92MQ.
2011-05-31 10:10:29 -0400 - Removed file at path /var/run/slapconfig.lock.


(The one "Error" in step 3 seems to come and go depending on when I run this...)

Anyway...

I have always done the Archive of OD while things were live.

However, today, for some unknown reason at 10:09:38 (according to the caldavd error.log), I got a bunch of these:

2011-05-31 10:09:38-0400 [-] [caldav-8010] [PooledMemCacheProtocol,client] [twistedcaldav.directory.appleopendirectory.OpenDirectoryRecord#error] OpenDirectory (node=/Search) error while performing digest authentication for user : ('DirectoryServices Error: Exception raised in file src/CDirectoryService.cpp at line 1078', -14002)

Not so much a big issue, but then I got a bunch of these as the reset of the OD archive process occurred -- and beyond!

2011-05-31 10:09:45-0400 [-] [caldav-8009] [PooledMemCacheProtocol,client] [twistedcaldav.directory.principal#error] No principal found for UID: F9E59BCC-BDC3-494D-A5BF-67370EAE00D9
2011-05-31 10:09:45-0400 [-] [caldav-8009] [PooledMemCacheProtocol,client] [twistedcaldav.directory.principal#error] No principal found for UID: CC525553-2323-468F-ABFF-A7159D2893B2
2011-05-31 10:09:45-0400 [-] [caldav-8009] [PooledMemCacheProtocol,client] [twistedcaldav.directory.principal#error] No principal found for UID: 9C522938-833C-4AEC-9F57-02BCECCE1021
2011-05-31 10:10:18-0400 [-] [caldav-8009] [PooledMemCacheProtocol,client] [twistedcaldav.directory.principal#error] No principal found for UID: 9C522938-833C-4AEC-9F57-02BCECCE1021
2011-05-31 10:10:18-0400 [-] [caldav-8009] [PooledMemCacheProtocol,client] [twistedcaldav.directory.principal#error] No principal found for UID: F9E59BCC-BDC3-494D-A5BF-67370EAE00D9
2011-05-31 10:10:18-0400 [-] [caldav-8009] [PooledMemCacheProtocol,client] [twistedcaldav.directory.principal#error] No principal found for UID: F95201BC-45AD-4CCA-95CA-05DB91733713
2011-05-31 10:10:19-0400 [-] [caldav-8009] [PooledMemCacheProtocol,client] [twistedcaldav.directory.principal#error] No principal found for UID: F9E59BCC-BDC3-494D-A5BF-67370EAE00D9
2011-05-31 10:10:19-0400 [-] [caldav-8009] [PooledMemCacheProtocol,client] [twistedcaldav.directory.principal#error] No principal found for UID: CC525553-2323-468F-ABFF-A7159D2893B2
2011-05-31 10:10:19-0400 [-] [caldav-8009] [PooledMemCacheProtocol,client] [twistedcaldav.directory.principal#error] No principal found for UID: 9C522938-833C-4AEC-9F57-02BCECCE1021
2011-05-31 10:10:20-0400 [-] [caldav-8009] [PooledMemCacheProtocol,client] [twistedcaldav.directory.principal#error] No principal found for UID: F95201BC-45AD-4CCA-95CA-05DB91733713#calendar-proxy-write
2011-05-31 10:10:20-0400 [-] [caldav-8009] [PooledMemCacheProtocol,client] [twistedcaldav.directory.principal#error] No principal found for UID: F9E59BCC-BDC3-494D-A5BF-67370EAE00D9#calendar-proxy-read
2011-05-31 10:10:20-0400 [-] [caldav-8009] [PooledMemCacheProtocol,client] [twistedcaldav.directory.principal#error] No principal found for UID: 9C522938-833C-4AEC-9F57-02BCECCE1021#calendar-proxy-read
2011-05-31 10:10:28-0400 [-] [caldav-8009] [PooledMemCacheProtocol,client] [twistedcaldav.directory.principal#error] No principal found for UID: 9C522938-833C-4AEC-9F57-02BCECCE1021
2011-05-31 10:10:28-0400 [-] [caldav-8009] [PooledMemCacheProtocol,client] [twistedcaldav.directory.principal#error] No principal found for UID: F9E59BCC-BDC3-494D-A5BF-67370EAE00D9
2011-05-31 10:10:28-0400 [-] [caldav-8009] [PooledMemCacheProtocol,client] [twistedcaldav.directory.principal#error] No principal found for UID: CC525553-2323-468F-ABFF-A7159D2893B2
2011-05-31 10:10:36-0400 [-] [caldav-8009] [PooledMemCacheProtocol,client] [twistedcaldav.directory.principal#error] No principal found for UID: CC525553-2323-468F-ABFF-A7159D2893B2
2011-05-31 10:10:36-0400 [-] [caldav-8009] [PooledMemCacheProtocol,client] [twistedcaldav.directory.principal#error] No principal found for UID: 9C522938-833C-4AEC-9F57-02BCECCE1021
2011-05-31 10:10:36-0400 [-] [caldav-8009] [PooledMemCacheProtocol,client] [twistedcaldav.directory.principal#error] No principal found for UID: F9E59BCC-BDC3-494D-A5BF-67370EAE00D9
2011-05-31 10:10:36-0400 [-] [caldav-8009] [PooledMemCacheProtocol,client] [twistedcaldav.directory.principal#error] No principal found for UID: F9E59BCC-BDC3-494D-A5BF-67370EAE00D9
2011-05-31 10:10:36-0400 [-] [caldav-8009] [PooledMemCacheProtocol,client] [twistedcaldav.directory.principal#error] No principal found for UID: CC525553-2323-468F-ABFF-A7159D2893B2
2011-05-31 10:10:36-0400 [-] [caldav-8009] [PooledMemCacheProtocol,client] [twistedcaldav.directory.principal#error] No principal found for UID: 9C522938-833C-4AEC-9F57-02BCECCE1021
2011-05-31 10:10:36-0400 [-] [caldav-8009] [PooledMemCacheProtocol,client] [twistedcaldav.directory.principal#error] No principal found for UID: CC525553-2323-468F-ABFF-A7159D2893B2
2011-05-31 10:10:37-0400 [-] [caldav-8009] [PooledMemCacheProtocol,client] [twistedcaldav.directory.principal#error] No principal found for UID: 9C522938-833C-4AEC-9F57-02BCECCE1021
2011-05-31 10:10:38-0400 [-] [caldav-8009] [PooledMemCacheProtocol,client] [twistedcaldav.directory.principal#error] No principal found for UID: CC525553-2323-468F-ABFF-A7159D2893B2
2011-05-31 10:10:38-0400 [-] [caldav-8009] [PooledMemCacheProtocol,client] [twistedcaldav.directory.principal#error] No principal found for UID: 9C522938-833C-4AEC-9F57-02BCECCE1021
2011-05-31 10:10:38-0400 [-] [caldav-8009] [PooledMemCacheProtocol,client] [twistedcaldav.directory.principal#error] No principal found for UID: F9E59BCC-BDC3-494D-A5BF-67370EAE00D9
2011-05-31 10:10:38-0400 [-] [caldav-8009] [PooledMemCacheProtocol,client] [twistedcaldav.directory.principal#error] No principal found for UID: F9E59BCC-BDC3-494D-A5BF-67370EAE00D9
2011-05-31 10:10:38-0400 [-] [caldav-8009] [PooledMemCacheProtocol,client] [twistedcaldav.directory.principal#error] No principal found for UID: CC525553-2323-468F-ABFF-A7159D2893B2
2011-05-31 10:10:38-0400 [-] [caldav-8009] [PooledMemCacheProtocol,client] [twistedcaldav.directory.principal#error] No principal found for UID: 9C522938-833C-4AEC-9F57-02BCECCE1021

(etc)


This had the adverse effect of hurting 3 user calendars and one resource calendar.

The resource calendar lost the write-proxy to the group that had access to it -- it just vanished from user's iCals -- (I had to use "calendarserver_manage-principals" to add it back)

And the 3 user calendars lost their list of accounts that could see *their* calendars.


None of this was overly critical -- the 3 users just had to reset who could see their calendar and everybody had to readd the resource calendar.


But my overall question: Nothing specifically in the archiving of the OD database with Server Admin was different from the myriad other times I've done this.


Any idea why archiving the OD database *this time* would have whacked some of the iCal Server settings? (And what, if anything, can I do to protect this from happening again -- short of stopping the service before I do the archive, I guess...)

- Steve


Steve Maser ()
Sr. Systems Administrator
Office of Technology Transfer

_______________________________________________
Do not post admin requests to the list. They will be ignored.
iCal-server mailing list (iCal-)
Help/Unsubscribe/Update your Subscription:
http://lists.apple.com/mailman/options/ical-server/shu.mcknight%40zeusmail.org

This email sent to
)

  #2  
01-06-2011 06:42 PM
ICal-server member admin is online now
User
 

So, this may just have been an example of coincidence (or just bad timing), but I had this problem today with my 10.6.7 iCal server:



Around 10:00 a.m., I did an archive of my OD database (with Server Admin). Nothing was amiss with the archive (though it took longer than usual):

2011-05-31 10:09:15 -0400 - slapconfig -backupdb
2011-05-31 10:09:15 -0400 - command: /usr/sbin/sso_util info -r /LDAPv3/127.0.0.1 -p
2011-05-31 10:09:15 -0400 - 1 Backing up LDAP database
2011-05-31 10:09:15 -0400 - Stopping LDAP server (slapd)
2011-05-31 10:09:16 -0400 - command: /usr/bin/db_recover -h /var/db/openldap/openldap-data
2011-05-31 10:09:17 -0400 - popen: /usr/sbin/slapcat -l /tmp/slapconfig_backup_stage43919vK92MQ/backup.ldif, "r"
2011-05-31 10:09:29 -0400 - Starting LDAP server (slapd)
2011-05-31 10:09:29 -0400 - popen: /bin/cp /var/db/openldap/openldap-data/DB_CONFIG /tmp/slapconfig_backup_stage43919vK92MQ/DB_CONFIG, "r"
2011-05-31 10:09:29 -0400 - popen: /bin/cp -r /etc/openldap /tmp/slapconfig_backup_stage43919vK92MQ/, "r"
2011-05-31 10:09:31 -0400 - 2 Backing up password server database
2011-05-31 10:09:31 -0400 - popen: /usr/sbin/mkpassdb -backupdb /tmp/slapconfig_backup_stage43919vK92MQ/passwordserver_backup/ > /dev/null, "r"
2011-05-31 10:09:31 -0400 - popen: /bin/cp -r /Library/Preferences/com.apple.passwordserver.plist /tmp/slapconfig_backup_stage43919vK92MQ/, "r"
2011-05-31 10:09:31 -0400 - popen: /usr/sbin/mkpassdb -list > /tmp/slapconfig_backup_stage43919vK92MQ/sasl-plugin-list, "r"
2011-05-31 10:09:31 -0400 - popen: /bin/hostname > /tmp/slapconfig_backup_stage43919vK92MQ/hostname, "r"
2011-05-31 10:09:31 -0400 - 3 Backing up Kerberos database
2011-05-31 10:09:31 -0400 - popen: /usr/sbin/kdb5_util -r FS.TECHTRANSFER.UMICH.EDU dump > /tmp/slapconfig_backup_stage43919vK92MQ/kdb5dump.FS.TECHTRANSFER.UMICH.EDU.bak, "r"
2011-05-31 10:09:31 -0400 - popen: /usr/sbin/sso_util info -pr /LDAPv3/127.0.0.1 > /tmp/slapconfig_backup_stage43919vK92MQ/local_odkrb5realm, "r"
2011-05-31 10:09:37 -0400 - Error: Command failed with exit code 512: /usr/sbin/sso_util info -pr /LDAPv3/127.0.0.1 > /tmp/slapconfig_backup_stage43919vK92MQ/local_odkrb5realm
2011-05-31 10:09:37 -0400 - popen: /usr/bin/tar czpf /tmp/slapconfig_backup_stage43919vK92MQ/krb5backup.tar.gz /var/db/krb5kdc/kdc.conf /var/db/krb5kdc/kadm5.acl /var/db/krb5kdc/kadm5.keytab /var/db/krb5kdc/.k5.* /Library/Preferences/edu.mit.Kerberos /etc/krb5.keytab , "r"
2011-05-31 10:09:37 -0400 - popen: /bin/cp /var/db/dslocal/nodes/Default/config/KerberosKDC.plist /tmp/slapconfig_backup_stage43919vK92MQ/KerberosKDC.plist, "r"
2011-05-31 10:09:37 -0400 - popen: /bin/cp /System/Library/LaunchDaemons/com.apple.PasswordService.plist /tmp/slapconfig_backup_stage43919vK92MQ/LaunchDaemons/, "r"
2011-05-31 10:09:37 -0400 - 4 Backing up configuration files
2011-05-31 10:09:37 -0400 - popen: /bin/cp /System/Library/LaunchDaemons/org.openldap.slapd.plist /tmp/slapconfig_backup_stage43919vK92MQ/LaunchDaemons/, "r"
2011-05-31 10:09:37 -0400 - popen: /bin/cp -r /Library/Preferences/DirectoryService /tmp/slapconfig_backup_stage43919vK92MQ/, "r"
2011-05-31 10:09:37 -0400 - popen: /bin/cp /Library/Preferences/com.apple.openldap.plist /tmp/slapconfig_backup_stage43919vK92MQ/, "r"
2011-05-31 10:09:37 -0400 - popen: /bin/cp /Library/Preferences/SystemConfiguration/com.apple.smb.server.plist /tmp/slapconfig_backup_stage43919vK92MQ/, "r"
2011-05-31 10:09:37 -0400 - popen: /bin/cp /Library/Preferences/com.apple.samba.plist /tmp/slapconfig_backup_stage43919vK92MQ/, "r"
2011-05-31 10:09:37 -0400 - popen: /usr/bin/sw_vers > /tmp/slapconfig_backup_stage43919vK92MQ/version.txt, "r"
2011-05-31 10:09:37 -0400 - popen: /bin/cp -r /var/db/dslocal /tmp/slapconfig_backup_stage43919vK92MQ/, "r"
2011-05-31 10:09:40 -0400 - 5 Backing up local directory database
2011-05-31 10:09:40 -0400 - popen: /usr/bin/tar czpf /tmp/slapconfig_backup_stage43919vK92MQ/shadowbackup.tar.gz /var/db/shadow, "r"
2011-05-31 10:09:40 -0400 - popen: /usr/bin/gnutar cpf /tmp/slapconfig_backup_stage43919vK92MQ/sambabackup.tar /var/db/samba /etc/smb.conf, "r"
2011-05-31 10:09:40 -0400 - command: /usr/bin/gnutar --delete -f /tmp/slapconfig_backup_stage43919vK92MQ/sambabackup.tar var/db/samba/secrets.tdb
2011-05-31 10:09:40 -0400 - command: /usr/bin/gzip -f4 /tmp/slapconfig_backup_stage43919vK92MQ/sambabackup.tar
2011-05-31 10:09:41 -0400 - Backed Up Keychain
2011-05-31 10:09:41 -0400 - 6 Creating archive
2011-05-31 10:09:41 -0400 - command: /usr/bin/hdiutil create -ov -plist -puppetstrings -layout UNIVERSAL CD -fs HFS+ -volname ldap_bk -srcfolder /tmp/slapconfig_backup_stage43919vK92MQ -format SPARSE -encryption AES-256 -stdinpass /OD Database Backups/5-31
2011-05-31 10:10:29 -0400 - Removed directory at path /tmp/slapconfig_backup_stage43919vK92MQ.
2011-05-31 10:10:29 -0400 - Removed file at path /var/run/slapconfig.lock.


(The one "Error" in step 3 seems to come and go depending on when I run this...)

Anyway...

I have always done the Archive of OD while things were live.

However, today, for some unknown reason at 10:09:38 (according to the caldavd error.log), I got a bunch of these:

2011-05-31 10:09:38-0400 [-] [caldav-8010] [PooledMemCacheProtocol,client] [twistedcaldav.directory.appleopendirectory.OpenDirectoryRecord#error] OpenDirectory (node=/Search) error while performing digest authentication for user : ('DirectoryServices Error: Exception raised in file src/CDirectoryService.cpp at line 1078', -14002)

Not so much a big issue, but then I got a bunch of these as the reset of the OD archive process occurred -- and beyond!

2011-05-31 10:09:45-0400 [-] [caldav-8009] [PooledMemCacheProtocol,client] [twistedcaldav.directory.principal#error] No principal found for UID: F9E59BCC-BDC3-494D-A5BF-67370EAE00D9
2011-05-31 10:09:45-0400 [-] [caldav-8009] [PooledMemCacheProtocol,client] [twistedcaldav.directory.principal#error] No principal found for UID: CC525553-2323-468F-ABFF-A7159D2893B2
2011-05-31 10:09:45-0400 [-] [caldav-8009] [PooledMemCacheProtocol,client] [twistedcaldav.directory.principal#error] No principal found for UID: 9C522938-833C-4AEC-9F57-02BCECCE1021
2011-05-31 10:10:18-0400 [-] [caldav-8009] [PooledMemCacheProtocol,client] [twistedcaldav.directory.principal#error] No principal found for UID: 9C522938-833C-4AEC-9F57-02BCECCE1021
2011-05-31 10:10:18-0400 [-] [caldav-8009] [PooledMemCacheProtocol,client] [twistedcaldav.directory.principal#error] No principal found for UID: F9E59BCC-BDC3-494D-A5BF-67370EAE00D9
2011-05-31 10:10:18-0400 [-] [caldav-8009] [PooledMemCacheProtocol,client] [twistedcaldav.directory.principal#error] No principal found for UID: F95201BC-45AD-4CCA-95CA-05DB91733713
2011-05-31 10:10:19-0400 [-] [caldav-8009] [PooledMemCacheProtocol,client] [twistedcaldav.directory.principal#error] No principal found for UID: F9E59BCC-BDC3-494D-A5BF-67370EAE00D9
2011-05-31 10:10:19-0400 [-] [caldav-8009] [PooledMemCacheProtocol,client] [twistedcaldav.directory.principal#error] No principal found for UID: CC525553-2323-468F-ABFF-A7159D2893B2
2011-05-31 10:10:19-0400 [-] [caldav-8009] [PooledMemCacheProtocol,client] [twistedcaldav.directory.principal#error] No principal found for UID: 9C522938-833C-4AEC-9F57-02BCECCE1021
2011-05-31 10:10:20-0400 [-] [caldav-8009] [PooledMemCacheProtocol,client] [twistedcaldav.directory.principal#error] No principal found for UID: F95201BC-45AD-4CCA-95CA-05DB91733713#calendar-proxy-write
2011-05-31 10:10:20-0400 [-] [caldav-8009] [PooledMemCacheProtocol,client] [twistedcaldav.directory.principal#error] No principal found for UID: F9E59BCC-BDC3-494D-A5BF-67370EAE00D9#calendar-proxy-read
2011-05-31 10:10:20-0400 [-] [caldav-8009] [PooledMemCacheProtocol,client] [twistedcaldav.directory.principal#error] No principal found for UID: 9C522938-833C-4AEC-9F57-02BCECCE1021#calendar-proxy-read
2011-05-31 10:10:28-0400 [-] [caldav-8009] [PooledMemCacheProtocol,client] [twistedcaldav.directory.principal#error] No principal found for UID: 9C522938-833C-4AEC-9F57-02BCECCE1021
2011-05-31 10:10:28-0400 [-] [caldav-8009] [PooledMemCacheProtocol,client] [twistedcaldav.directory.principal#error] No principal found for UID: F9E59BCC-BDC3-494D-A5BF-67370EAE00D9
2011-05-31 10:10:28-0400 [-] [caldav-8009] [PooledMemCacheProtocol,client] [twistedcaldav.directory.principal#error] No principal found for UID: CC525553-2323-468F-ABFF-A7159D2893B2
2011-05-31 10:10:36-0400 [-] [caldav-8009] [PooledMemCacheProtocol,client] [twistedcaldav.directory.principal#error] No principal found for UID: CC525553-2323-468F-ABFF-A7159D2893B2
2011-05-31 10:10:36-0400 [-] [caldav-8009] [PooledMemCacheProtocol,client] [twistedcaldav.directory.principal#error] No principal found for UID: 9C522938-833C-4AEC-9F57-02BCECCE1021
2011-05-31 10:10:36-0400 [-] [caldav-8009] [PooledMemCacheProtocol,client] [twistedcaldav.directory.principal#error] No principal found for UID: F9E59BCC-BDC3-494D-A5BF-67370EAE00D9
2011-05-31 10:10:36-0400 [-] [caldav-8009] [PooledMemCacheProtocol,client] [twistedcaldav.directory.principal#error] No principal found for UID: F9E59BCC-BDC3-494D-A5BF-67370EAE00D9
2011-05-31 10:10:36-0400 [-] [caldav-8009] [PooledMemCacheProtocol,client] [twistedcaldav.directory.principal#error] No principal found for UID: CC525553-2323-468F-ABFF-A7159D2893B2
2011-05-31 10:10:36-0400 [-] [caldav-8009] [PooledMemCacheProtocol,client] [twistedcaldav.directory.principal#error] No principal found for UID: 9C522938-833C-4AEC-9F57-02BCECCE1021
2011-05-31 10:10:36-0400 [-] [caldav-8009] [PooledMemCacheProtocol,client] [twistedcaldav.directory.principal#error] No principal found for UID: CC525553-2323-468F-ABFF-A7159D2893B2
2011-05-31 10:10:37-0400 [-] [caldav-8009] [PooledMemCacheProtocol,client] [twistedcaldav.directory.principal#error] No principal found for UID: 9C522938-833C-4AEC-9F57-02BCECCE1021
2011-05-31 10:10:38-0400 [-] [caldav-8009] [PooledMemCacheProtocol,client] [twistedcaldav.directory.principal#error] No principal found for UID: CC525553-2323-468F-ABFF-A7159D2893B2
2011-05-31 10:10:38-0400 [-] [caldav-8009] [PooledMemCacheProtocol,client] [twistedcaldav.directory.principal#error] No principal found for UID: 9C522938-833C-4AEC-9F57-02BCECCE1021
2011-05-31 10:10:38-0400 [-] [caldav-8009] [PooledMemCacheProtocol,client] [twistedcaldav.directory.principal#error] No principal found for UID: F9E59BCC-BDC3-494D-A5BF-67370EAE00D9
2011-05-31 10:10:38-0400 [-] [caldav-8009] [PooledMemCacheProtocol,client] [twistedcaldav.directory.principal#error] No principal found for UID: F9E59BCC-BDC3-494D-A5BF-67370EAE00D9
2011-05-31 10:10:38-0400 [-] [caldav-8009] [PooledMemCacheProtocol,client] [twistedcaldav.directory.principal#error] No principal found for UID: CC525553-2323-468F-ABFF-A7159D2893B2
2011-05-31 10:10:38-0400 [-] [caldav-8009] [PooledMemCacheProtocol,client] [twistedcaldav.directory.principal#error] No principal found for UID: 9C522938-833C-4AEC-9F57-02BCECCE1021

(etc)


This had the adverse effect of hurting 3 user calendars and one resource calendar.

The resource calendar lost the write-proxy to the group that had access to it -- it just vanished from user's iCals -- (I had to use "calendarserver_manage-principals" to add it back)

And the 3 user calendars lost their list of accounts that could see *their* calendars.


None of this was overly critical -- the 3 users just had to reset who could see their calendar and everybody had to readd the resource calendar.


But my overall question: Nothing specifically in the archiving of the OD database with Server Admin was different from the myriad other times I've done this.


Any idea why archiving the OD database *this time* would have whacked some of the iCal Server settings? (And what, if anything, can I do to protect this from happening again -- short of stopping the service before I do the archive, I guess...)

- Steve


Steve Maser ()
Sr. Systems Administrator
Office of Technology Transfer

_______________________________________________
Do not post admin requests to the list. They will be ignored.
iCal-server mailing list (iCal-)
Help/Unsubscribe/Update your Subscription:
http://lists.apple.com/mailman/options/ical-server/shu.mcknight%40zeusmail.org

This email sent to
)

On May 31, 2011, at 12:00 PM, Steve Maser wrote:

> So, this may just have been an example of coincidence (or just bad timing), but I had this problem today with my 10.6.7 iCal server:
>
>
>
> Around 10:00 a.m., I did an archive of my OD database (with Server Admin). Nothing was amiss with the archive (though it took longer than usual):
>
> 2011-05-31 10:09:15 -0400 - slapconfig -backupdb
> 2011-05-31 10:09:15 -0400 - command: /usr/sbin/sso_util info -r /LDAPv3/127.0.0.1 -p
> 2011-05-31 10:09:15 -0400 - 1 Backing up LDAP database
> 2011-05-31 10:09:15 -0400 - Stopping LDAP server (slapd)
> ...
> But my overall question: Nothing specifically in the archiving of the OD database with Server Admin was different from the myriad other times I've done this.
>
>
> Any idea why archiving the OD database *this time* would have whacked some of the iCal Server settings? (And what, if anything, can I do to protect this from happening again -- short of stopping the service before I do the archive, I guess...)

Step 1 of the backup involves stopping LDAP service, as seen in the log. Whether or not this is 'painful' really depends on the precise state of things at that instant. Mac OS X directory services clients (the most important of which in this case is your own server, which is also a client of its own OD master) will not necessarily maintain persistent LDAP connections; they are idled out after a couple minutes of inactivity. In that scenario, having LDAP services bounce quickly may go unnoticed, especially considering that iCal Server makes some effort to cache things on its own. If on the other hand there were queries in flight at the time of the backup, OD would return errors, which bubble upstream until they hit the requesting application (e.g. iCal Server), which appears to be what you are seeing.

In short, it's a roll of the dice. Personally I've always been a little less than fond of taking services offline while they being used (see also: Time Machine, which will do this hourly if you let it). In this case, the impact could probably be mitigated through the use of an OD replica (just don't archive both OD servers at the same instant :)

HTH,
-dre
_______________________________________________
Do not post admin requests to the list. They will be ignored.
iCal-server mailing list (iCal-)
Help/Unsubscribe/Update your Subscription:
http://lists.apple.com/mailman/options/ical-server/shu.mcknight%40zeusmail.org

This email sent to
)

  #3  
01-06-2011 08:30 PM
ICal-server member admin is online now
User
 

So, this may just have been an example of coincidence (or just bad timing), but I had this problem today with my 10.6.7 iCal server:



Around 10:00 a.m., I did an archive of my OD database (with Server Admin). Nothing was amiss with the archive (though it took longer than usual):

2011-05-31 10:09:15 -0400 - slapconfig -backupdb
2011-05-31 10:09:15 -0400 - command: /usr/sbin/sso_util info -r /LDAPv3/127.0.0.1 -p
2011-05-31 10:09:15 -0400 - 1 Backing up LDAP database
2011-05-31 10:09:15 -0400 - Stopping LDAP server (slapd)
2011-05-31 10:09:16 -0400 - command: /usr/bin/db_recover -h /var/db/openldap/openldap-data
2011-05-31 10:09:17 -0400 - popen: /usr/sbin/slapcat -l /tmp/slapconfig_backup_stage43919vK92MQ/backup.ldif, "r"
2011-05-31 10:09:29 -0400 - Starting LDAP server (slapd)
2011-05-31 10:09:29 -0400 - popen: /bin/cp /var/db/openldap/openldap-data/DB_CONFIG /tmp/slapconfig_backup_stage43919vK92MQ/DB_CONFIG, "r"
2011-05-31 10:09:29 -0400 - popen: /bin/cp -r /etc/openldap /tmp/slapconfig_backup_stage43919vK92MQ/, "r"
2011-05-31 10:09:31 -0400 - 2 Backing up password server database
2011-05-31 10:09:31 -0400 - popen: /usr/sbin/mkpassdb -backupdb /tmp/slapconfig_backup_stage43919vK92MQ/passwordserver_backup/ > /dev/null, "r"
2011-05-31 10:09:31 -0400 - popen: /bin/cp -r /Library/Preferences/com.apple.passwordserver.plist /tmp/slapconfig_backup_stage43919vK92MQ/, "r"
2011-05-31 10:09:31 -0400 - popen: /usr/sbin/mkpassdb -list > /tmp/slapconfig_backup_stage43919vK92MQ/sasl-plugin-list, "r"
2011-05-31 10:09:31 -0400 - popen: /bin/hostname > /tmp/slapconfig_backup_stage43919vK92MQ/hostname, "r"
2011-05-31 10:09:31 -0400 - 3 Backing up Kerberos database
2011-05-31 10:09:31 -0400 - popen: /usr/sbin/kdb5_util -r FS.TECHTRANSFER.UMICH.EDU dump > /tmp/slapconfig_backup_stage43919vK92MQ/kdb5dump.FS.TECHTRANSFER.UMICH.EDU.bak, "r"
2011-05-31 10:09:31 -0400 - popen: /usr/sbin/sso_util info -pr /LDAPv3/127.0.0.1 > /tmp/slapconfig_backup_stage43919vK92MQ/local_odkrb5realm, "r"
2011-05-31 10:09:37 -0400 - Error: Command failed with exit code 512: /usr/sbin/sso_util info -pr /LDAPv3/127.0.0.1 > /tmp/slapconfig_backup_stage43919vK92MQ/local_odkrb5realm
2011-05-31 10:09:37 -0400 - popen: /usr/bin/tar czpf /tmp/slapconfig_backup_stage43919vK92MQ/krb5backup.tar.gz /var/db/krb5kdc/kdc.conf /var/db/krb5kdc/kadm5.acl /var/db/krb5kdc/kadm5.keytab /var/db/krb5kdc/.k5.* /Library/Preferences/edu.mit.Kerberos /etc/krb5.keytab , "r"
2011-05-31 10:09:37 -0400 - popen: /bin/cp /var/db/dslocal/nodes/Default/config/KerberosKDC.plist /tmp/slapconfig_backup_stage43919vK92MQ/KerberosKDC.plist, "r"
2011-05-31 10:09:37 -0400 - popen: /bin/cp /System/Library/LaunchDaemons/com.apple.PasswordService.plist /tmp/slapconfig_backup_stage43919vK92MQ/LaunchDaemons/, "r"
2011-05-31 10:09:37 -0400 - 4 Backing up configuration files
2011-05-31 10:09:37 -0400 - popen: /bin/cp /System/Library/LaunchDaemons/org.openldap.slapd.plist /tmp/slapconfig_backup_stage43919vK92MQ/LaunchDaemons/, "r"
2011-05-31 10:09:37 -0400 - popen: /bin/cp -r /Library/Preferences/DirectoryService /tmp/slapconfig_backup_stage43919vK92MQ/, "r"
2011-05-31 10:09:37 -0400 - popen: /bin/cp /Library/Preferences/com.apple.openldap.plist /tmp/slapconfig_backup_stage43919vK92MQ/, "r"
2011-05-31 10:09:37 -0400 - popen: /bin/cp /Library/Preferences/SystemConfiguration/com.apple.smb.server.plist /tmp/slapconfig_backup_stage43919vK92MQ/, "r"
2011-05-31 10:09:37 -0400 - popen: /bin/cp /Library/Preferences/com.apple.samba.plist /tmp/slapconfig_backup_stage43919vK92MQ/, "r"
2011-05-31 10:09:37 -0400 - popen: /usr/bin/sw_vers > /tmp/slapconfig_backup_stage43919vK92MQ/version.txt, "r"
2011-05-31 10:09:37 -0400 - popen: /bin/cp -r /var/db/dslocal /tmp/slapconfig_backup_stage43919vK92MQ/, "r"
2011-05-31 10:09:40 -0400 - 5 Backing up local directory database
2011-05-31 10:09:40 -0400 - popen: /usr/bin/tar czpf /tmp/slapconfig_backup_stage43919vK92MQ/shadowbackup.tar.gz /var/db/shadow, "r"
2011-05-31 10:09:40 -0400 - popen: /usr/bin/gnutar cpf /tmp/slapconfig_backup_stage43919vK92MQ/sambabackup.tar /var/db/samba /etc/smb.conf, "r"
2011-05-31 10:09:40 -0400 - command: /usr/bin/gnutar --delete -f /tmp/slapconfig_backup_stage43919vK92MQ/sambabackup.tar var/db/samba/secrets.tdb
2011-05-31 10:09:40 -0400 - command: /usr/bin/gzip -f4 /tmp/slapconfig_backup_stage43919vK92MQ/sambabackup.tar
2011-05-31 10:09:41 -0400 - Backed Up Keychain
2011-05-31 10:09:41 -0400 - 6 Creating archive
2011-05-31 10:09:41 -0400 - command: /usr/bin/hdiutil create -ov -plist -puppetstrings -layout UNIVERSAL CD -fs HFS+ -volname ldap_bk -srcfolder /tmp/slapconfig_backup_stage43919vK92MQ -format SPARSE -encryption AES-256 -stdinpass /OD Database Backups/5-31
2011-05-31 10:10:29 -0400 - Removed directory at path /tmp/slapconfig_backup_stage43919vK92MQ.
2011-05-31 10:10:29 -0400 - Removed file at path /var/run/slapconfig.lock.


(The one "Error" in step 3 seems to come and go depending on when I run this...)

Anyway...

I have always done the Archive of OD while things were live.

However, today, for some unknown reason at 10:09:38 (according to the caldavd error.log), I got a bunch of these:

2011-05-31 10:09:38-0400 [-] [caldav-8010] [PooledMemCacheProtocol,client] [twistedcaldav.directory.appleopendirectory.OpenDirectoryRecord#error] OpenDirectory (node=/Search) error while performing digest authentication for user : ('DirectoryServices Error: Exception raised in file src/CDirectoryService.cpp at line 1078', -14002)

Not so much a big issue, but then I got a bunch of these as the reset of the OD archive process occurred -- and beyond!

2011-05-31 10:09:45-0400 [-] [caldav-8009] [PooledMemCacheProtocol,client] [twistedcaldav.directory.principal#error] No principal found for UID: F9E59BCC-BDC3-494D-A5BF-67370EAE00D9
2011-05-31 10:09:45-0400 [-] [caldav-8009] [PooledMemCacheProtocol,client] [twistedcaldav.directory.principal#error] No principal found for UID: CC525553-2323-468F-ABFF-A7159D2893B2
2011-05-31 10:09:45-0400 [-] [caldav-8009] [PooledMemCacheProtocol,client] [twistedcaldav.directory.principal#error] No principal found for UID: 9C522938-833C-4AEC-9F57-02BCECCE1021
2011-05-31 10:10:18-0400 [-] [caldav-8009] [PooledMemCacheProtocol,client] [twistedcaldav.directory.principal#error] No principal found for UID: 9C522938-833C-4AEC-9F57-02BCECCE1021
2011-05-31 10:10:18-0400 [-] [caldav-8009] [PooledMemCacheProtocol,client] [twistedcaldav.directory.principal#error] No principal found for UID: F9E59BCC-BDC3-494D-A5BF-67370EAE00D9
2011-05-31 10:10:18-0400 [-] [caldav-8009] [PooledMemCacheProtocol,client] [twistedcaldav.directory.principal#error] No principal found for UID: F95201BC-45AD-4CCA-95CA-05DB91733713
2011-05-31 10:10:19-0400 [-] [caldav-8009] [PooledMemCacheProtocol,client] [twistedcaldav.directory.principal#error] No principal found for UID: F9E59BCC-BDC3-494D-A5BF-67370EAE00D9
2011-05-31 10:10:19-0400 [-] [caldav-8009] [PooledMemCacheProtocol,client] [twistedcaldav.directory.principal#error] No principal found for UID: CC525553-2323-468F-ABFF-A7159D2893B2
2011-05-31 10:10:19-0400 [-] [caldav-8009] [PooledMemCacheProtocol,client] [twistedcaldav.directory.principal#error] No principal found for UID: 9C522938-833C-4AEC-9F57-02BCECCE1021
2011-05-31 10:10:20-0400 [-] [caldav-8009] [PooledMemCacheProtocol,client] [twistedcaldav.directory.principal#error] No principal found for UID: F95201BC-45AD-4CCA-95CA-05DB91733713#calendar-proxy-write
2011-05-31 10:10:20-0400 [-] [caldav-8009] [PooledMemCacheProtocol,client] [twistedcaldav.directory.principal#error] No principal found for UID: F9E59BCC-BDC3-494D-A5BF-67370EAE00D9#calendar-proxy-read
2011-05-31 10:10:20-0400 [-] [caldav-8009] [PooledMemCacheProtocol,client] [twistedcaldav.directory.principal#error] No principal found for UID: 9C522938-833C-4AEC-9F57-02BCECCE1021#calendar-proxy-read
2011-05-31 10:10:28-0400 [-] [caldav-8009] [PooledMemCacheProtocol,client] [twistedcaldav.directory.principal#error] No principal found for UID: 9C522938-833C-4AEC-9F57-02BCECCE1021
2011-05-31 10:10:28-0400 [-] [caldav-8009] [PooledMemCacheProtocol,client] [twistedcaldav.directory.principal#error] No principal found for UID: F9E59BCC-BDC3-494D-A5BF-67370EAE00D9
2011-05-31 10:10:28-0400 [-] [caldav-8009] [PooledMemCacheProtocol,client] [twistedcaldav.directory.principal#error] No principal found for UID: CC525553-2323-468F-ABFF-A7159D2893B2
2011-05-31 10:10:36-0400 [-] [caldav-8009] [PooledMemCacheProtocol,client] [twistedcaldav.directory.principal#error] No principal found for UID: CC525553-2323-468F-ABFF-A7159D2893B2
2011-05-31 10:10:36-0400 [-] [caldav-8009] [PooledMemCacheProtocol,client] [twistedcaldav.directory.principal#error] No principal found for UID: 9C522938-833C-4AEC-9F57-02BCECCE1021
2011-05-31 10:10:36-0400 [-] [caldav-8009] [PooledMemCacheProtocol,client] [twistedcaldav.directory.principal#error] No principal found for UID: F9E59BCC-BDC3-494D-A5BF-67370EAE00D9
2011-05-31 10:10:36-0400 [-] [caldav-8009] [PooledMemCacheProtocol,client] [twistedcaldav.directory.principal#error] No principal found for UID: F9E59BCC-BDC3-494D-A5BF-67370EAE00D9
2011-05-31 10:10:36-0400 [-] [caldav-8009] [PooledMemCacheProtocol,client] [twistedcaldav.directory.principal#error] No principal found for UID: CC525553-2323-468F-ABFF-A7159D2893B2
2011-05-31 10:10:36-0400 [-] [caldav-8009] [PooledMemCacheProtocol,client] [twistedcaldav.directory.principal#error] No principal found for UID: 9C522938-833C-4AEC-9F57-02BCECCE1021
2011-05-31 10:10:36-0400 [-] [caldav-8009] [PooledMemCacheProtocol,client] [twistedcaldav.directory.principal#error] No principal found for UID: CC525553-2323-468F-ABFF-A7159D2893B2
2011-05-31 10:10:37-0400 [-] [caldav-8009] [PooledMemCacheProtocol,client] [twistedcaldav.directory.principal#error] No principal found for UID: 9C522938-833C-4AEC-9F57-02BCECCE1021
2011-05-31 10:10:38-0400 [-] [caldav-8009] [PooledMemCacheProtocol,client] [twistedcaldav.directory.principal#error] No principal found for UID: CC525553-2323-468F-ABFF-A7159D2893B2
2011-05-31 10:10:38-0400 [-] [caldav-8009] [PooledMemCacheProtocol,client] [twistedcaldav.directory.principal#error] No principal found for UID: 9C522938-833C-4AEC-9F57-02BCECCE1021
2011-05-31 10:10:38-0400 [-] [caldav-8009] [PooledMemCacheProtocol,client] [twistedcaldav.directory.principal#error] No principal found for UID: F9E59BCC-BDC3-494D-A5BF-67370EAE00D9
2011-05-31 10:10:38-0400 [-] [caldav-8009] [PooledMemCacheProtocol,client] [twistedcaldav.directory.principal#error] No principal found for UID: F9E59BCC-BDC3-494D-A5BF-67370EAE00D9
2011-05-31 10:10:38-0400 [-] [caldav-8009] [PooledMemCacheProtocol,client] [twistedcaldav.directory.principal#error] No principal found for UID: CC525553-2323-468F-ABFF-A7159D2893B2
2011-05-31 10:10:38-0400 [-] [caldav-8009] [PooledMemCacheProtocol,client] [twistedcaldav.directory.principal#error] No principal found for UID: 9C522938-833C-4AEC-9F57-02BCECCE1021

(etc)


This had the adverse effect of hurting 3 user calendars and one resource calendar.

The resource calendar lost the write-proxy to the group that had access to it -- it just vanished from user's iCals -- (I had to use "calendarserver_manage-principals" to add it back)

And the 3 user calendars lost their list of accounts that could see *their* calendars.


None of this was overly critical -- the 3 users just had to reset who could see their calendar and everybody had to readd the resource calendar.


But my overall question: Nothing specifically in the archiving of the OD database with Server Admin was different from the myriad other times I've done this.


Any idea why archiving the OD database *this time* would have whacked some of the iCal Server settings? (And what, if anything, can I do to protect this from happening again -- short of stopping the service before I do the archive, I guess...)

- Steve


Steve Maser ()
Sr. Systems Administrator
Office of Technology Transfer

_______________________________________________
Do not post admin requests to the list. They will be ignored.
iCal-server mailing list (iCal-)
Help/Unsubscribe/Update your Subscription:
http://lists.apple.com/mailman/options/ical-server/shu.mcknight%40zeusmail.org

This email sent to
)

On May 31, 2011, at 12:00 PM, Steve Maser wrote:

> So, this may just have been an example of coincidence (or just bad timing), but I had this problem today with my 10.6.7 iCal server:
>
>
>
> Around 10:00 a.m., I did an archive of my OD database (with Server Admin). Nothing was amiss with the archive (though it took longer than usual):
>
> 2011-05-31 10:09:15 -0400 - slapconfig -backupdb
> 2011-05-31 10:09:15 -0400 - command: /usr/sbin/sso_util info -r /LDAPv3/127.0.0.1 -p
> 2011-05-31 10:09:15 -0400 - 1 Backing up LDAP database
> 2011-05-31 10:09:15 -0400 - Stopping LDAP server (slapd)
> ...
> But my overall question: Nothing specifically in the archiving of the OD database with Server Admin was different from the myriad other times I've done this.
>
>
> Any idea why archiving the OD database *this time* would have whacked some of the iCal Server settings? (And what, if anything, can I do to protect this from happening again -- short of stopping the service before I do the archive, I guess...)

Step 1 of the backup involves stopping LDAP service, as seen in the log. Whether or not this is 'painful' really depends on the precise state of things at that instant. Mac OS X directory services clients (the most important of which in this case is your own server, which is also a client of its own OD master) will not necessarily maintain persistent LDAP connections; they are idled out after a couple minutes of inactivity. In that scenario, having LDAP services bounce quickly may go unnoticed, especially considering that iCal Server makes some effort to cache things on its own. If on the other hand there were queries in flight at the time of the backup, OD would return errors, which bubble upstream until they hit the requesting application (e.g. iCal Server), which appears to be what you are seeing.

In short, it's a roll of the dice. Personally I've always been a little less than fond of taking services offline while they being used (see also: Time Machine, which will do this hourly if you let it). In this case, the impact could probably be mitigated through the use of an OD replica (just don't archive both OD servers at the same instant :)

HTH,
-dre
_______________________________________________
Do not post admin requests to the list. They will be ignored.
iCal-server mailing list (iCal-)
Help/Unsubscribe/Update your Subscription:
http://lists.apple.com/mailman/options/ical-server/shu.mcknight%40zeusmail.org

This email sent to
)

On Jun 1, 2011, at 1:46 PM, Morgen Sagen wrote:

>
> On May 31, 2011, at 12:00 PM, Steve Maser wrote:
>> The resource calendar lost the write-proxy to the group that had access to it -- it just vanished from user's iCals -- (I had to use "calendarserver_manage-principals" to add it back)
>>
>> And the 3 user calendars lost their list of accounts that could see *their* calendars.
>
> Do you see any /var/log/caldavd/error.log entries containing "Removing missing proxy principal for"?
>
> If so, then what has happened is the records were missing from the directory server long enough for calendar server to decide they no longer exist and removed them as delegates.
>
> ~morgen


Nope. The first thing in the error log during the time of the OD Archiving was:

2011-05-31 10:09:37-0400 [-] [caldav-8009] [PooledMemCacheProtocol,client] [twistedcaldav.directory.appleopendirectory.OpenDirectoryRecord#error] OpenDirectory (node=/Search) error while performing digest authentication for user : ('DirectoryServices Error: Exception raised in file src/CDirectoryService.cpp at line 1078', -14002)


(There were a bunch of these lines for two users -- so I guess it's entirely possible that one of those two users were trying to set up meetings in the resource or with one (or more) of the 3 affected users...)


Then a swath of these lines:

2011-05-31 10:09:45-0400 [-] [caldav-8009] [PooledMemCacheProtocol,client] [twistedcaldav.directory.principal#error] No principal found for UID: F9E59BCC-BDC3-494D-A5BF-67370EAE00D9

with different UIDs (but only the 4 UIDs that ended up having problems...)


with a smattering of these lines in between -- but by this point, the OD archiving had been *well finished* for a couple of minutes (2011-05-31 10:10:29 -0400 - Removed file at path /var/run/slapconfig.lock.):

2011-05-31 10:12:10-0400 [-] [caldav-8009] [PooledMemCacheProtocol,client] [twistedcaldav.scheduling.scheduler#error] Unknown calendar user address: urn:uuid:CC525553-2323-468F-ABFF-A7159D2893B2
2011-05-31 10:12:10-0400 [-] [caldav-8009] [PooledMemCacheProtocol,client] [twistedcaldav.scheduling.scheduler.ScheduleResponseQueue#error] Error during POST for urn:uuid:CC525553-2323-468F-ABFF-A7159D2893B2: None

ending with:

2011-05-31 10:41:54-0400 [-] [caldav-8013] [PooledMemCacheProtocol,client] [twistedcaldav.directory.principal#error] No principal found for UID: CC525553-2323-468F-ABFF-A7159D2893B2

when I noticed this problem and started stopping/restaring iCal to see if that would fix.


But nothing like "Removing missing proxy principal for" in the error.log file during any of this.

- Steve


_______________________________________________
Do not post admin requests to the list. They will be ignored.
iCal-server mailing list (iCal-)
Help/Unsubscribe/Update your Subscription:
http://lists.apple.com/mailman/options/ical-server/shu.mcknight%40zeusmail.org

This email sent to
)





NewsArc Lists  |  Culture Pages   |  Computing Archive  |  Media-Pages
Link to this page on your blog or website by copying the HTML code below and pasting it into your site: