[10.10 Yosemite] TM Backup sehr langsam

[FritzS]

Seit zwei Tagen ist das TM Backups sehr langsam und das auf meinen beiden ext. TM HDs. Begonnen hat es vor Tagen, als es auf der einen TM Platte einiges an Dateien (rund 30GB) nachzusichern galt - ich das Backup aber abbrechen musste.

In diese Zeit viel auch ein der Ausfall des UppStores mitten im Update Zyklus von Xcode, das später nochmals durchlief.
Und auch die Installation der MS Office 2016 Pre Version inkl. des Outlook 2016 Import der OL 2011 Mails.
Kann dies das TM Backup derart ausbremsen?

„Backup vorbereiten“ dauert schon elends langsam, wenn das Backup doch einmal beginnt geht nahezu nichts weiter, die Bytes tröpfeln anscheinend einzeln. Auch ein Reboot des Rechners und keine offenen Apps helfen da nichts.
Am USB Port kann es nicht liegen, denn ich hatte da eine andere USB Platte angesteckt und ca. 200GB ohne Probleme per Drag and Drop weggesichert.

EtreCheck version: 2.1.8 (121)
Report generated 13. März 2015 19:40:56 MEZ
Download EtreCheck from http://etresoft.com/etrecheck

Click the [Click for support] links for help with non-Apple products.
Click the [Click for details] links for more information about that line.

Hardware Information: ??
    MacBook Pro (15-inch, Late 2008) (Technical Specifications)
    MacBook Pro - model: MacBookPro5,1
    1 2.4 GHz Intel Core 2 Duo CPU: 2-core
    8 GB RAM Upgradeable
        BANK 0/DIMM0
            4 GB DDR3 1067 MHz ok
        BANK 0/DIMM1
            4 GB DDR3 1067 MHz ok
    Bluetooth: Old - Handoff/Airdrop2 not supported
    Wireless:  en1: 802.11 a/b/g/n
    Battery Health: Normal - Cycle count 122

Video Information: ??
    NVIDIA GeForce 9600M GT - VRAM: 256 MB
        Color LCD 1440 x 900
    NVIDIA GeForce 9400M - VRAM: 256 MB

System Software: ??
    OS X 10.10.2 (14C1510) - Time since boot: 0:32:41

Disk Information: ??
    WDC WD10JPVX-22JC3T0 disk0 : (1 TB)
        EFI (disk0s1) <not mounted> : 210 MB
        MBP ARIES (disk0s2) / : 999.35 GB (353.43 GB free)
        Recovery HD (disk0s3) <not mounted>  [Recovery]: 650 MB

    MATSHITADVD-R   UJ-868 

USB Information: ??
    Western Digital My Passport 0820 2 TB
        EFI (disk1s1) <not mounted> : 210 MB
        WD 2TB My Passport (disk1s2) /Volumes/WD 2TB My Passport : 2.00 TB (631.00 GB free)
    Apple Inc. Built-in iSight
    Apple, Inc. Apple Internal Keyboard / Trackpad
    Apple Computer, Inc. IR Receiver
    Apple Inc. BRCM2046 Hub
        Apple Inc. Bluetooth USB Host Controller

Gatekeeper: ??
    Mac App Store and identified developers

Kernel Extensions: ??
        /Applications/HardwareMonitor.app
    [not loaded]    com.bresink.driver.BRESINKx86Monitoring (9.0) [Click for support]

        /Applications/VMware Fusion.app
    [not loaded]    com.vmware.kext.vmci (90.6.3) [Click for support]
    [not loaded]    com.vmware.kext.vmioplug.14.1.3 (14.1.3) [Click for support]
    [not loaded]    com.vmware.kext.vmnet (0231.47.74) [Click for support]
    [not loaded]    com.vmware.kext.vmx86 (0231.47.74) [Click for support]
    [not loaded]    com.vmware.kext.vsockets (90.6.0) [Click for support]

        /Library/Extensions
    [loaded]    at.obdev.nke.LittleSnitch (4234 - SDK 10.8) [Click for support]

        /System/Library/Extensions
    [loaded]    org.dungeon.driver.SATSMARTDriver (0.8 - SDK 10.6) [Click for support]

Launch Agents: ??
    [running]    at.obdev.LittleSnitchUIAgent.plist [Click for support]
    [loaded]    org.macosforge.xquartz.startx.plist [Click for support]
    [running]    org.macports.gpg-agent.plist [Click for support]

Launch Daemons: ??
    [running]    at.obdev.littlesnitchd.plist [Click for support]
    [loaded]    com.cocoatech.pathfinder.SMFHelper7.plist [Click for support]
    [loaded]    com.microsoft.office.licensing.helper.plist [Click for support]
    [loaded]    com.skype.skypeinstaller.plist [Click for support]
    [not loaded]    hdapm.plist [Click for support]
    [not loaded]    hdapm.plist~ [Click for support]
    [loaded]    org.macosforge.xquartz.privileged_startx.plist [Click for support]
    [not loaded]    org.macports.slapd.plist [Click for support]
    [running]    org.macports.unbound.plist [Click for support]

User Launch Agents: ??
    [loaded]    com.google.keystone.agent.plist [Click for support]

User Login Items: ??
    iTunesHelper    Programm  (/Applications/iTunes.app/Contents/MacOS/iTunesHelper.app)
    VMware Fusion Start Menu    Programm  (/Applications/VMware Fusion.app/Contents/Library/VMware Fusion Start Menu.app)
    CrossOver CD Helper    Programm  (/Applications/CrossOver.app/Contents/Resources/CrossOver CD Helper.app)

Internet Plug-ins: ??
    Default Browser: Version: 600 - SDK 10.10
    QuickTime Plugin: Version: 7.7.3
    SharePointBrowserPlugin: Version: 14.4.8 - SDK 10.6 [Click for support]

Safari Extensions: ??
    AdBlock
    ClickToFlash
    SafariRestore
    JavaScript Blocker

3rd Party Preference Panes: ??
    None

Time Machine: ??
    Skip System Files: NO
    Mobile backups: ON
    Auto backup: YES
    Volumes being backed up:
        MBP ARIES: Disk size: 999.35 GB Disk used: 645.91 GB
    Destinations:
        Seagate 2TB [Local]
        Total size: 2.00 TB
        Total number of backups: 39
        Oldest backup: 2014-10-28 17:34:20 +0000
        Last backup: 2015-03-07 17:40:40 +0000
        Size of backup disk: Adequate
            Backup size 2.00 TB > (Disk used 645.91 GB X 3)
        WD 2TB My Passport [Local]
        Total size: 2.00 TB
        Total number of backups: 36
        Oldest backup: 2014-08-12 14:13:51 +0000
        Last backup: 2015-03-06 17:30:03 +0000
        Size of backup disk: Adequate
            Backup size 2.00 TB > (Disk used 645.91 GB X 3)

Top Processes by CPU: ??
        29%    WindowServer
         8%    iCab
         4%    Little Snitch Network Monitor
         3%    backupd
         2%    com.apple.prefs.backup.remoteservice

Top Processes by Memory: ??
    704 MB    mds_stores
    326 MB    iCab
    249 MB    Smultron 6
    180 MB    WindowServer
    155 MB    backupd

Virtual Memory Information: ??
    3.07 GB    Free RAM
    3.50 GB    Active RAM
    768 MB    Inactive RAM
    983 MB    Wired RAM
    6.52 GB    Page-ins
    25 KB    Page-outs

Diagnostics Information: ??
    Mar 13, 2015, 07:05:28 PM    Self test - passed
    Mar 13, 2015, 05:36:58 PM    /Users/[redacted]/Library/Logs/DiagnosticReports/com.apple.WebKit.WebContent_2015-03-13-173658_[redacted].crash

    Standard users cannot read /Library/Logs/DiagnosticReports.
    Run as an administrator account to see more information.

 

[Macbeatnik]

Hier gibt es einiges zum hängenden Backup nachzulesen, ist übrigens bei Timemachine Problemen eine gute Anlaufstelle:
http://pondini.org/TM/Troubleshooting.html


Ich würde in einem solchen fall zuerst das "in progress" file löschen, Timemachine sollte dabei deaktiviert sein und dann Timemachine neu starten. Wäre aber vermutlich eine harte tour.

 

[FritzS]

Danke! Werde mir den Tip genau ansehen.

Ich lösche (direkt ohne Umweg über Papierkorb) gerade das MS OL 2016 Profil
~/Library/Group Containers/UBF8T346G9.Office/Outlook/Outlook 15 Profiles/Main Profile
mit nahezu 200.000 Objekten im PathFinder - geht auch sehr, sehr langsam.
Ich lösche es auch deshalb, da OL 2016 jedes mal und „zuverlässig“ beim Start abstürzt, muss vorerst mal ein leeres OL 2016 Profil erstellen und nachher erst zu importieren versuchen.

Meine 1TB HD ist nun zu 2/3 belegt und ich habe den Eindruck, dass dadurch auch die Zugriffsgeschwindigkeit (gerade bei vielen kleinen Dateien) etwas darunter leidet. Eine Abhilfe wäre eine zweite HD anstelle des teilweise kaputten CD/DVD Laufwerks ein zu bauen. Leider ist der Umstieg auf eine SSD, für das OS selbst, unter Mavericks mangels funktionierenden TRIM (ohne die Sicherheit herabzusetzen) nicht mehr möglich.

PS: Wie kann man unter Yosemite den Finder umstellen so dass er in Infos unter Ort wieder den Unix like Pfad anzeigt?
Unter Yosemite sieht das nun so aus:
... ~/Library ▸ Group Containers ▸ UBF8T346G9.Office

 

[FritzS]

Ich habe nun auf meinen beiden USB TM HDs die Files „in progress“ gelöscht.
Bei der ersten TM BU HD ist das TM-Backup nun doch nach langer Zeit fertig geworden, jetzt läuft das TM-Backup auf der zweiten HD.

Vor dieser Aktion hatte ich schon das MS OL 2016 Profil komplett gelöscht - OL 2016 mit meinen ganzen Mailbestand (über 161.000 Objekte - 8,4 GB) zum Laufen zu bringen ist eine andere Geschichte.

 

[FritzS]

Auch bei der zweiten TM Backup HD hat es nun geklappt.

Nur dauert es derzeit jedes mal sehr lange bis die eigentliche Kopieraktion beginnt - „Backup vorbereiten“ kommt mir derzeit, gegenüber vorher, sehr lange vor.

Gestern hatte ich während des TM Backups einen seltsamen „caught burning CPU!“ Eintrag im system.log - iStat Pro Widget zeigte knapp danach dies an: CPU 70° CPU Heatsink 60°

Mar 14 18:36:35 aries kernel[0]: SATSMARTDriver v0.8: disk serial 'WD-WXM......', revision '01.01A01', model 'WDC WD20NMVW-11AV3S2'
Mar 14 18:36:37 aries kernel[0]: hfs: mounted WD 2TB My Passport on device disk1s2
Mar 14 18:37:07 aries.local com.apple.backupd[1722]: Starting manual backup
Mar 14 18:37:07 aries.local com.apple.backupd[1722]: Backing up to /dev/disk1s2: /Volumes/WD 2TB My Passport/Backups.backupdb
Mar 14 18:39:43 aries.local lsregister[1733]: LaunchServices: Begin database seeding
Mar 14 18:39:43 aries.local lsregister[1733]: LaunchServices: Completed database seeding
Mar 14 18:39:43 aries.local lsregister[1734]: LaunchServices: Begin database seeding
Mar 14 18:39:43 aries.local lsregister[1734]: LaunchServices: Completed database seeding
Mar 14 18:41:47 aries.local lsregister[1751]: LaunchServices: Begin database seeding
Mar 14 18:41:47 aries.local lsregister[1751]: LaunchServices: Completed database seeding
Mar 14 18:41:47 aries.local lsregister[1752]: LaunchServices: Begin database seeding
Mar 14 18:41:47 aries.local lsregister[1752]: LaunchServices: Completed database seeding
Mar 14 18:45:51 aries.local lsregister[1782]: LaunchServices: Begin database seeding
Mar 14 18:45:51 aries.local lsregister[1782]: LaunchServices: Completed database seeding
Mar 14 18:45:51 aries.local lsregister[1783]: LaunchServices: Begin database seeding
Mar 14 18:45:51 aries.local lsregister[1783]: LaunchServices: Completed database seeding
Mar 14 18:48:50 aries kernel[0]: process backupd[1722] thread 732285 caught burning CPU! It used more than 50% CPU (Actual recent usage: 55%) over 180 seconds. thread lifetime cpu usage 139.243419 seconds, (49.505768 user, 89.737651 system) ledger info: balance: 90027399741 credit: 139166638144 debit: 49139238403 limit: 90000000000 (50%) period: 180000000000 time since last refill (ns): 161794336760
Mar 14 18:48:50 aries com.apple.xpc.launchd[1] (com.apple.ReportCrash.Root[1788]): Endpoint has been activated through legacy launch(3) APIs. Please switch to XPC or bootstrap_check_in(): com.apple.ReportCrash.DirectoryService
Mar 14 18:48:51 aries.local ReportCrash[1788]: Invoking spindump for pid=1722 thread=732285 percent_cpu=55 duration=164 because of excessive cpu utilization
Mar 14 18:48:53 aries.local spindump[400]: Saved cpu_resource.diag report for backupd version ??? (???) to /Library/Logs/DiagnosticReports/backupd_2015-03-14-184853_aries.cpu_resource.diag
Mar 14 18:49:54 aries.local lsregister[1799]: LaunchServices: Begin database seeding
Mar 14 18:49:54 aries.local lsregister[1799]: LaunchServices: Completed database seeding
Mar 14 18:49:54 aries.local lsregister[1798]: LaunchServices: Begin database seeding
Mar 14 18:49:54 aries.local lsregister[1798]: LaunchServices: Completed database seeding
Mar 14 18:51:57 aries.local lsregister[1817]: LaunchServices: Begin database seeding
Mar 14 18:51:57 aries.local lsregister[1816]: LaunchServices: Begin database seeding
Mar 14 18:51:57 aries.local lsregister[1817]: LaunchServices: Completed database seeding
Mar 14 18:51:57 aries.local lsregister[1816]: LaunchServices: Completed database seeding
Mar 14 18:53:54 aries com.apple.xpc.launchd[1] (com.apple.imfoundation.IMRemoteURLConnectionAgent): The _DirtyJetsamMemoryLimit key is not available on this platform.
Mar 14 18:54:14 aries kernel[0]: nspace-handler-set-snapshot-time: 1426355656
Mar 14 18:54:14 aries.local com.apple.mtmd[495]: Set snapshot time: 2015-03-14 18:54:16 +0100 (current time: 2015-03-14 18:54:14 +0100)