NETGEAR is aware of a growing number of phone and online scams. To learn how to stay safe click here.
Forum Discussion
roadfun
Aug 16, 2009Aspirant
Periodic (daily) Time Machine failures
I am running TM on an iMac with 10.5.8 to a Duo running 4.1.6. However I am getting a failure about once a day where TM pops up a dialog saying the network volume could not be mounted because of a problem with the username or password. It is very odd because it will do its hourly backup just fine for some period of time (a day or maybe a bit longer) before giving me this error. If I go to the TM Preferences I have to re-enter the username and password, then all is fine again for a day or so. This happened again just now and I snagged the Duo logs and also took a look at the Mac log. On there I see this series of possibly related messages:
Aug 16 17:07:40 Kobe kernel[0]: AFP_VFS afpfs_mount: /Volumes/ReadyNAS, pid 4993
Aug 16 17:07:40 Kobe Bonjour Mounter[267]: DiskAppearedCallback diskDescription = {\n DAVolumeKind = afpfs;\n DAVolumeMountable = 1;\n DAVolumeName = ReadyNAS;\n DAVolumeNetwork = 1;\n DAVolumePath = file://localhost/Volumes/ReadyNAS/;\n}
Aug 16 17:07:42 Kobe [0x0-0x14c14c].com.apple.systempreferences[4987]: chown: /Volumes/ReadyNAS/.001ec20ffc9e: Operation not permitted
Aug 16 17:07:43: --- last message repeated 1 time ---
Aug 16 17:07:43 Kobe kernel[0]: AFP_VFS afpfs_unmount: /Volumes/ReadyNAS, flags 0, pid 4998
Aug 16 17:07:43 Kobe Finder[161]: StatusMonitor::volumesChangedCallBack returned -47
Aug 16 17:07:43 Kobe kernel[0]: ASP_TCP do_thread_read: no reqInfo found for reqID 1
Aug 16 17:07:43 Kobe Bonjour Mounter[267]: DiskDisappearedCallback diskDescription = {\n DAVolumeKind = afpfs;\n DAVolumeMountable = 1;\n DAVolumeName = ReadyNAS;\n DAVolumeNetwork = 1;\n DAVolumePath = file://localhost/Volumes/ReadyNAS/;\n}
Aug 16 17:07:43 Kobe kernel[0]: ASP_TCP CancelOneRequest: cancelling slot 29 error 89 reqID 30 flags 0x9 afpCmd 0x14 so 0x7e7a330
In Duo afp.log
Aug 16 17:07:42 cnid_dbd[29190][logger.c:255]: I:Logger: doing log_setup, type 0, level 50, filename "/var/log/netatalk.log"
Aug 16 17:07:42 cnid_dbd[29190][logger.c:395]: D7:Logger: log_file_arr[0] now contains: {log_filename:/var/log/netatalk.log, log_file:(nil), log_level: 50}
Aug 16 17:07:42 cnid_dbd[29190][logger.c:398]: D5:Logger: log_setup[0] done
Aug 16 17:07:42 cnid_dbd[29190][main.c:210]: I:CNID: Setting uid/gid to 0/0
Aug 16 17:07:42 cnid_dbd[29190][main.c:309]: I:CNID: Startup, DB dir /c/.timemachine/.AppleDB
Any idea how I prevent this from happening? It means if I'm not in front of the Mac for awhile the TM backups stop.
Aug 16 17:07:40 Kobe kernel[0]: AFP_VFS afpfs_mount: /Volumes/ReadyNAS, pid 4993
Aug 16 17:07:40 Kobe Bonjour Mounter[267]: DiskAppearedCallback diskDescription = {\n DAVolumeKind = afpfs;\n DAVolumeMountable = 1;\n DAVolumeName = ReadyNAS;\n DAVolumeNetwork = 1;\n DAVolumePath = file://localhost/Volumes/ReadyNAS/;\n}
Aug 16 17:07:42 Kobe [0x0-0x14c14c].com.apple.systempreferences[4987]: chown: /Volumes/ReadyNAS/.001ec20ffc9e: Operation not permitted
Aug 16 17:07:43: --- last message repeated 1 time ---
Aug 16 17:07:43 Kobe kernel[0]: AFP_VFS afpfs_unmount: /Volumes/ReadyNAS, flags 0, pid 4998
Aug 16 17:07:43 Kobe Finder[161]: StatusMonitor::volumesChangedCallBack returned -47
Aug 16 17:07:43 Kobe kernel[0]: ASP_TCP do_thread_read: no reqInfo found for reqID 1
Aug 16 17:07:43 Kobe Bonjour Mounter[267]: DiskDisappearedCallback diskDescription = {\n DAVolumeKind = afpfs;\n DAVolumeMountable = 1;\n DAVolumeName = ReadyNAS;\n DAVolumeNetwork = 1;\n DAVolumePath = file://localhost/Volumes/ReadyNAS/;\n}
Aug 16 17:07:43 Kobe kernel[0]: ASP_TCP CancelOneRequest: cancelling slot 29 error 89 reqID 30 flags 0x9 afpCmd 0x14 so 0x7e7a330
In Duo afp.log
Aug 16 17:07:42 cnid_dbd[29190][logger.c:255]: I:Logger: doing log_setup, type 0, level 50, filename "/var/log/netatalk.log"
Aug 16 17:07:42 cnid_dbd[29190][logger.c:395]: D7:Logger: log_file_arr[0] now contains: {log_filename:/var/log/netatalk.log, log_file:(nil), log_level: 50}
Aug 16 17:07:42 cnid_dbd[29190][logger.c:398]: D5:Logger: log_setup[0] done
Aug 16 17:07:42 cnid_dbd[29190][main.c:210]: I:CNID: Setting uid/gid to 0/0
Aug 16 17:07:42 cnid_dbd[29190][main.c:309]: I:CNID: Startup, DB dir /c/.timemachine/.AppleDB
Any idea how I prevent this from happening? It means if I'm not in front of the Mac for awhile the TM backups stop.
82 Replies
Replies have been turned off for this discussion
- roadfunAspirantJust happened to me again today. So after a few weeks of not happening it has back to happening regularly. I sent in another log file just now.
- rezonat0rAspirantJust had the error again. Hadn't had it in several weeks (since clean installing Snow Leopard, really). Wasn't doing anything unusual. Safari, Firefox, Adium, Apache2 are the only apps running.
System: Macbook (Late 2008 Unibody), OS X 10.6.1
Network topology: NAS to Airport Extreme (Dual Band) via CAT6; Macbook to AE via 802.11n (5Ghz)
TCP Retransmits: 811
Unrecovered TCP Retransmits: 38
(This is after the NAS has been up for several weeks and done many TM backups; don't have numbers from before the error unfortunately)
Shares: AFP only (no CIFS). Guest access on AFP enabled. Pretty much all other services are OFF.
Logs sent. - BoarderBlueAspirant
rezonat0r wrote: Just had the error again. Hadn't had it in several weeks (since clean installing Snow Leopard, really). Wasn't doing anything unusual. Safari, Firefox, Adium, Apache2 are the only apps running.
System: Macbook (Late 2008 Unibody), OS X 10.6.1
Network topology: NAS to Airport Extreme (Dual Band) via CAT6; Macbook to AE via 802.11n (5Ghz)
TCP Retransmits: 811
Unrecovered TCP Retransmits: 38
(This is after the NAS has been up for several weeks and done many TM backups; don't have numbers from before the error unfortunately)
Shares: AFP only (no CIFS). Guest access on AFP enabled. Pretty much all other services are OFF.
Logs sent.
Hi there
I have been having the same problem (since I upgraded to a dual band AE) - TM fails with an error message "The backup was not performed because an error occurred while copying files to the backup disk" I haven't been able to complete a back up since a day after I installed the new AE.
Thanks in advance for any help or advice. - mdgm-ntgrNETGEAR Employee Retired
mnc042 wrote:
The original layout of my home network was thus:
Mac -> 5-port 10/100 Switch -> 16-port 10/100 Switch -> 24-port 10/100 Switch -> NAS
Wow you must have a lot of devices.BoarderBlue wrote:
I have been having the same problem (since I upgraded to a dual band AE) - TM fails with an error message "The backup was not performed because an error occurred while copying files to the backup disk" I haven't been able to complete a back up since a day after I installed the new AE.
I have dual band AE and TM on the ReadyNas is working fine on my Macs running 10.5.8 - rezonat0rAspirantSo Netgear, have you been able to reproduce this issue in-house yet?
9 users reporting the same exact problem across multiple OS's (Leopard+Snow Leopard), multiple network topologies, and multiple types of Macs. Only common thread: the ReadyNAS. - roadfunAspirantI'm one of the 9. I see see this happen regularly on multiple Macs. Since it seems to just cause a miss of a single backup I don't worry much about it. At least in my case the backups always seem to be successful the next time.
- rezonat0rAspirantNetgear is officially advertising Time Machine functionality. This functionality is not 100% working.
Therefore, I would like to see some attempt to address this problem other than blaming the network. If they cannot or will not address a problem with the feature, then they should not be advertising it.
Any response, Netgear? - mnc042AspirantJust a follow-up from a long time ago..
This *still* happens to me. And I've since replaced every switch and router in the house with gigabit capability.
Same problems.
Every other Mac backing up to Time Capsules "Just Work" -- it's the ReadyNAS for sure.
Wonder if Netgear has made any headway into figuring this out?
\marc - dmoffittAspirantHaving some Time Machine of my own here, was also getting this "Error (-36)" that I noticed in Console when trying to copy files over yesterday to a different share on the device. Details below:
Jan 28 01:54:29 macpro com.apple.backupd[48207]: Starting standard backup
Jan 28 01:54:29 macpro com.apple.backupd[48207]: Attempting to mount network destination using URL: afp://[email protected]/ReadyNAS
Jan 28 01:54:29 macpro com.apple.backupd[48207]: Mounted network destination using URL: afp://[email protected]/ReadyNAS
Jan 28 01:54:29 macpro com.apple.backupd[48207]: Warning: Destination /Volumes/ReadyNAS does not support TM Lock Stealing
Jan 28 01:54:29 macpro com.apple.backupd[48207]: Warning: Destination /Volumes/ReadyNAS does not support Server Reply Cache
Jan 28 01:54:31 macpro com.apple.backupd[48207]: Disk image /Volumes/ReadyNAS/macpro.sparsebundle mounted at: /Volumes/Time Machine Backups
Jan 28 01:59:00 macpro com.apple.backupd[48258]: Starting standard backup
Jan 28 01:59:01 macpro com.apple.backupd[48258]: Network destination already mounted at: /Volumes/ReadyNAS
Jan 28 01:59:01 macpro com.apple.backupd[48258]: Warning: Destination /Volumes/ReadyNAS does not support TM Lock Stealing
Jan 28 01:59:01 macpro com.apple.backupd[48258]: Warning: Destination /Volumes/ReadyNAS does not support Server Reply Cache
Jan 28 01:59:02 macpro com.apple.backupd[48258]: Disk image /Volumes/ReadyNAS/macpro.sparsebundle mounted at: /Volumes/Time Machine Backups
Jan 28 01:59:02 macpro com.apple.backupd[48258]: Backing up to: /Volumes/Time Machine Backups/Backups.backupdb
Jan 28 01:59:26 macpro com.apple.backupd[48258]: No pre-backup thinning needed: 387.24 GB requested (including padding), 817.85 GB available
Jan 28 01:59:38 macpro diskmanagementd[48225]: APICALLBACK_dmAsyncFinishedForDisk_FSCK_result dmErr=-9957 detailErr=8
Jan 28 01:59:41 macpro com.apple.backupd[48258]: Copied 111 files (2.0 MB) from volume Mac Pro.
Jan 28 02:00:10 macpro com.apple.backupd[48258]: Error: (-36) SrcErr:NO Copying /Volumes/MacPro/Users/davidmoffitt/Music/iTunes/iTunes Library to /Volumes/Time Machine Backups/Backups.backupdb/##REDACTED##/Music/iTunes
Jan 28 02:00:10 macpro com.apple.backupd[48258]: Error: (-36) SrcErr:NO Copying /Volumes/MacPro/Users/davidmoffitt/Music/iTunes/iTunes Library Extras.itdb to /Volumes/Time Machine Backups/Backups.backupdb/##REDACTED##/Music/iTunes
Jan 28 02:00:10 macpro com.apple.backupd[48258]: Error: (-36) SrcErr:NO Copying /Volumes/MacPro/Users/davidmoffitt/Music/iTunes/iTunes Media/.iTunes Preferences.plist to /Volumes/Time Machine Backups/Backups.backupdb/##REDACTED##/Music/iTunes/iTunes Media
Jan 28 02:00:10 macpro com.apple.backupd[48258]: Error: (-36) SrcErr:NO Copying /Volumes/MacPro/Users/davidmoffitt/Music/iTunes/iTunes Media/Downloads/Podcasts/Tiësto`s club life podcast 99 _ Radio 538_ Tiësto`s club life podcast.tmp/download.m4a to /Volumes/Time Machine Backups/Backups.backupdb/##REDACTED##/Music/iTunes/iTunes Media/Downloads/Podcasts/Tiësto`s club life podcast 99 _ Radio 538_ Tiësto`s club life podcast.tmp
Jan 28 02:01:17 macpro com.apple.backupd[48258]: Error: (-36) SrcErr:NO Copying /Volumes/MacPro/Users/davidmoffitt/Music/iTunes/iTunes Media/Music/.DS_Store to /Volumes/Time Machine Backups/Backups.backupdb/##REDACTED##/Music/iTunes/iTunes Media/Music
Jan 28 02:04:07 macpro com.apple.backupd[48258]: Error: (-36) SrcErr:NO Copying /Volumes/MacPro/Users/davidmoffitt/Music/iTunes/iTunes Media/Music/Basil Poledouris/.DS_Store to /Volumes/Time Machine Backups/Backups.backupdb/##REDACTED##/Music/iTunes/iTunes Media/Music/Basil Poledouris
Jan 28 02:04:07 macpro com.apple.backupd[48258]: Error: (-36) SrcErr:NO Copying /Volumes/MacPro/Users/davidmoffitt/Music/iTunes/iTunes Media/Music/Basil Poledouris/Robocop/01 Main Title.m4a to /Volumes/Time Machine Backups/Backups.backupdb/##REDACTED##/Music/iTunes/iTunes Media/Music/Basil Poledouris/Robocop
Jan 28 02:04:07 macpro com.apple.backupd[48258]: Error: (-36) SrcErr:NO Copying /Volumes/MacPro/Users/davidmoffitt/Music/iTunes/iTunes Media/Music/Basil Poledouris/Robocop/02 Van Chase.m4a to /Volumes/Time Machine Backups/Backups.backupdb/##REDACTED##/Music/iTunes/iTunes Media/Music/Basil Poledouris/Robocop
Jan 28 02:04:07 macpro com.apple.backupd[48258]: Error: (-36) SrcErr:NO Copying /Volumes/MacPro/Users/davidmoffitt/Music/iTunes/iTunes Media/Music/Basil Poledouris/Robocop/03 Murphy's Death.m4a to /Volumes/Time Machine Backups/Backups.backupdb/##REDACTED##/Music/iTunes/iTunes Media/Music/Basil Poledouris/Robocop
Jan 28 02:04:07 macpro com.apple.backupd[48258]: Error: (-36) SrcErr:NO Copying /Volumes/MacPro/Users/davidmoffitt/Music/iTunes/iTunes Media/Music/Basil Poledouris/Robocop/04 Rock Shop.m4a to /Volumes/Time Machine Backups/Backups.backupdb/##REDACTED##/Music/iTunes/iTunes Media/Music/Basil Poledouris/Robocop
Jan 28 02:04:07 macpro com.apple.backupd[48258]: Error: (-36) SrcErr:NO Copying /Volumes/MacPro/Users/davidmoffitt/Music/iTunes/iTunes Media/Music/Basil Poledouris/Robocop/05 Home.m4a to /Volumes/Time Machine Backups/Backups.backupdb/##REDACTED##/Music/iTunes/iTunes Media/Music/Basil Poledouris/Robocop
Jan 28 02:04:07 macpro com.apple.backupd[48258]: Error: (-36) SrcErr:NO Copying /Volumes/MacPro/Users/davidmoffitt/Music/iTunes/iTunes Media/Music/Basil Poledouris/Robocop/06 Robo vs. ED-209.m4a to /Volumes/Time Machine Backups/Backups.backupdb/##REDACTED##/Music/iTunes/iTunes Media/Music/Basil Poledouris/Robocop
Jan 28 02:04:07 macpro com.apple.backupd[48258]: Error: (-36) SrcErr:NO Copying /Volumes/MacPro/Users/davidmoffitt/Music/iTunes/iTunes Media/Music/Basil Poledouris/Robocop/07 The Dream.m4a to /Volumes/Time Machine Backups/Backups.backupdb/##REDACTED##/Music/iTunes/iTunes Media/Music/Basil Poledouris/Robocop
Jan 28 02:04:07 macpro com.apple.backupd[48258]: Error: (-36) SrcErr:NO Copying /Volumes/MacPro/Users/davidmoffitt/Music/iTunes/iTunes Media/Music/Basil Poledouris/Robocop/08 Across the Board.m4a to /Volumes/Time Machine Backups/Backups.backupdb/##REDACTED##/Music/iTunes/iTunes Media/Music/Basil Poledouris/Robocop
Jan 28 02:04:07 macpro com.apple.backupd[48258]: Error: (-36) SrcErr:NO Copying /Volumes/MacPro/Users/davidmoffitt/Music/iTunes/iTunes Media/Music/Basil Poledouris/Robocop/09 Betrayal.m4a to /Volumes/Time Machine Backups/Backups.backupdb/##REDACTED##/Music/iTunes/iTunes Media/Music/Basil Poledouris/Robocop
Jan 28 02:04:07 macpro com.apple.backupd[48258]: Error: (-36) SrcErr:NO Copying /Volumes/MacPro/Users/davidmoffitt/Music/iTunes/iTunes Media/Music/Basil Poledouris/Robocop/10 Clarence Frags Bob.m4a to /Volumes/Time Machine Backups/Backups.backupdb/##REDACTED##/Music/iTunes/iTunes Media/Music/Basil Poledouris/Robocop
Jan 28 02:04:07 macpro com.apple.backupd[48258]: Error: (-36) SrcErr:NO Copying /Volumes/MacPro/Users/davidmoffitt/Music/iTunes/iTunes Media/Music/Basil Poledouris/Robocop/11 Care Package.m4a to /Volumes/Time Machine Backups/Backups.backupdb/##REDACTED##/Music/iTunes/iTunes Media/Music/Basil Poledouris/Robocop
Jan 28 02:04:07 macpro com.apple.backupd[48258]: Error: (-36) SrcErr:NO Copying /Volumes/MacPro/Users/davidmoffitt/Music/iTunes/iTunes Media/Music/Basil Poledouris/Robocop/12 Robo Drives to Jones.m4a to /Volumes/Time Machine Backups/Backups.backupdb/##REDACTED##/Music/iTunes/iTunes Media/Music/Basil Poledouris/Robocop
Jan 28 02:04:07 macpro com.apple.backupd[48258]: Error: (-36) SrcErr:NO Copying /Volumes/MacPro/Users/davidmoffitt/Music/iTunes/iTunes Media/Music/Basil Poledouris/Robocop/13 We Killed You.m4a to /Volumes/Time Machine Backups/Backups.backupdb/##REDACTED##/Music/iTunes/iTunes Media/Music/Basil Poledouris/Robocop
Jan 28 02:04:07 macpro com.apple.backupd[48258]: Error: (-36) SrcErr:NO Copying /Volumes/MacPro/Users/davidmoffitt/Music/iTunes/iTunes Media/Music/Basil Poledouris/Robocop/14 Directive IV.m4a to /Volumes/Time Machine Backups/Backups.backupdb/##REDACTED##/Music/iTunes/iTunes Media/Music/Basil Poledouris/Robocop
Jan 28 02:04:07 macpro com.apple.backupd[48258]: Stopping backup.
Jan 28 02:04:07 macpro com.apple.backupd[48258]: Error: (-36) SrcErr:NO Copying /Volumes/MacPro/Users/davidmoffitt/Music/iTunes/iTunes Media/Music/Basil Poledouris/Robocop/15 Showdown.m4a to /Volumes/Time Machine Backups/Backups.backupdb//davidmoffitt/Music/iTunes/iTunes Media/Music/Basil Poledouris/Robocop
Jan 28 02:04:08 macpro com.apple.backupd[48258]: Copied 31623 files (9.0 GB) from volume MacPro/Users.
Jan 28 02:04:08 macpro com.apple.backupd[48258]: Copy stage failed with error:11
Jan 28 02:04:14 macpro com.apple.backupd[48258]: Backup failed with error: 11
Jan 28 02:04:18 macpro com.apple.backupd[48258]: Ejected Time Machine disk image.
Jan 28 02:04:20 macpro com.apple.backupd[48258]: Ejected Time Machine network volume.
Jan 28 02:04:28 macpro hdiejectd[48215]: quitCheck: calling exit(0) - rezonat0rAspirantdmoffitt, you have a different issue. This thread is about intermittent Time Machine failures to the ReadyNAS where the error reported is
The network backup disk could not be accessed because there was a problem with the network username or password.
and the backup fails to even begin.
Related Content
- Oct 20, 2020Retired_Member
NETGEAR Academy
Boost your skills with the Netgear Academy - Get trained, certified and stay ahead with the latest Netgear technology!
Join Us!