[Duplicity-talk] Duplicity Timeout Error

duplicity-talk
[Date Prev][Date Next][Thread Prev][Thread Next][Date Index][Thread Index]
[Duplicity-talk] Duplicity Timeout Error

From:	Pascal Schaedeli
Subject:	[Duplicity-talk] Duplicity Timeout Error
Date:	Mon, 30 Jun 2008 06:59:17 -0700
I'm trying to use duplicity to backup some files from one computer (OS
X 10.5) to another remote computer (OS X 10.5) over a DSL connection
(70 KB/s upload). Duplicity seems to create some errors and ultimately
fails due to timeouts. The "scp" command it is waiting for are running
fine on their own, and it seems that they are always hanging even
though they seem to be fully uploaded.

Any idea how to mitigate this?

I tried reducing the --volsize to 1MB. More luck, but only a few
segments got uploaded successfully.

This is the result on the remote computer with the 5 and 1MB volsize
respectively:

On the remote computer:
In the case of the 5MB volume
pascal$ ls -l
total 10048
-rw-------  1 pascal  staff  5144576 Jun 30 05:41
duplicity-full.2008-06-29T20:29:17-07:00.vol1.difftar.gpg

In the case of the 5MB volume
pascal$ ls -l
total 5032
-rw-------  1 pascal  staff  1035528 Jun 30 05:59
duplicity-full.2008-06-29T20:57:09-07:00.vol1.difftar.gpg
-rw-------  1 pascal  staff  1033609 Jun 30 06:01
duplicity-full.2008-06-29T20:57:09-07:00.vol2.difftar.gpg
-rw-------  1 pascal  staff   503808 Jun 30 06:06
duplicity-full.2008-06-29T20:57:09-07:00.vol3.difftar.gpg

And then the full log (for the 5 and 1MB volsize respectively as well):

~$ duplicity -v9
/Users/pascal/Documents/MyDocuments/References/Business\ Analysis
ssh://address@hidden/backup/testb
Main action: inc
Running 'sftp  address@hidden' (attempt #1)
State = sftp, Before = 'Connecting to alice.dynalias.org...'
sftp command: 'mkdir backup/testb'
State = sftp, Before = 'mkdir backup/testb
Couldn't create directory: Failure'
sftp command: 'cd backup/testb'
State = sftp, Before = 'cd backup/testb'
sftp command: 'ls -1'
State = sftp, Before = 'ls -1'
State = sftp, Before = 'quit'
0 files exist on backend
Extracting backup chains from list of files: []
Collection Status
-----------------
Connecting with backend: sshBackend
Archive dir: None

Found 0 backup chains without signatures.
No backup chains with active signatures found
No orphaned or incomplete backup sets found.
Last full backup date: none
PASSPHRASE variable not set, asking user.
GnuPG passphrase:
Retype to confirm:
No signatures found, switching to full backup.
Using temporary directory
/var/folders/Gj/GjCTMUR8EViYUXcc8HBPR++++TY/-Tmp-/duplicity-xRXL5L-tempdir
Registering (mktemp) temporary file
/var/folders/Gj/GjCTMUR8EViYUXcc8HBPR++++TY/-Tmp-/duplicity-xRXL5L-tempdir/mktemp-FMaMGh-1
Registering (mktemp) temporary file
/var/folders/Gj/GjCTMUR8EViYUXcc8HBPR++++TY/-Tmp-/duplicity-xRXL5L-tempdir/mktemp-oJRSzd-2
Selecting /Users/pascal/Documents/MyDocuments/References/Business Analysis
Comparing () and None
Getting delta of (()
/Users/pascal/Documents/MyDocuments/References/Business Analysis dir)
and None
Generating delta - new file: .
Selecting /Users/pascal/Documents/MyDocuments/References/Business
Analysis/.DS_Store
Comparing ('.DS_Store',) and None
Getting delta of (('.DS_Store',)
/Users/pascal/Documents/MyDocuments/References/Business
Analysis/.DS_Store reg) and None
Generating delta - new file: .DS_Store
Selecting /Users/pascal/Documents/MyDocuments/References/Business
Analysis/BA Update Presentation May05.ppt
Comparing ('BA Update Presentation May05.ppt',) and None
Getting delta of (('BA Update Presentation May05.ppt',)
/Users/pascal/Documents/MyDocuments/References/Business Analysis/BA
Update Presentation May05.ppt reg) and None
Generating delta - new file: BA Update Presentation May05.ppt
Selecting /Users/pascal/Documents/MyDocuments/References/Business Analysis/BPMN
Comparing ('BPMN',) and None
Getting delta of (('BPMN',)
/Users/pascal/Documents/MyDocuments/References/Business Analysis/BPMN
dir) and None
Generating delta - new file: BPMN
Selecting /Users/pascal/Documents/MyDocuments/References/Business
Analysis/BPMN/BPMN 0-9-V2003.vss
Comparing ('BPMN', 'BPMN 0-9-V2003.vss') and None
Getting delta of (('BPMN', 'BPMN 0-9-V2003.vss')
/Users/pascal/Documents/MyDocuments/References/Business
Analysis/BPMN/BPMN 0-9-V2003.vss reg) and None
Generating delta - new file: BPMN/BPMN 0-9-V2003.vss
Selecting /Users/pascal/Documents/MyDocuments/References/Business
Analysis/BPMN/BPMN V1-0 May 3 2004.pdf
Comparing ('BPMN', 'BPMN V1-0 May 3 2004.pdf') and None
Getting delta of (('BPMN', 'BPMN V1-0 May 3 2004.pdf')
/Users/pascal/Documents/MyDocuments/References/Business
Analysis/BPMN/BPMN V1-0 May 3 2004.pdf reg) and None
Generating delta - new file: BPMN/BPMN V1-0 May 3 2004.pdf
Selecting /Users/pascal/Documents/MyDocuments/References/Business
Analysis/BPMN/Introduction to BPMN.pdf
Comparing ('BPMN', 'Introduction to BPMN.pdf') and None
Getting delta of (('BPMN', 'Introduction to BPMN.pdf')
/Users/pascal/Documents/MyDocuments/References/Business
Analysis/BPMN/Introduction to BPMN.pdf reg) and None
Generating delta - new file: BPMN/Introduction to BPMN.pdf
Selecting /Users/pascal/Documents/MyDocuments/References/Business
Analysis/BPMN/NWG-2001-09-01R4 Charter.pdf
Comparing ('BPMN', 'NWG-2001-09-01R4 Charter.pdf') and None
Getting delta of (('BPMN', 'NWG-2001-09-01R4 Charter.pdf')
/Users/pascal/Documents/MyDocuments/References/Business
Analysis/BPMN/NWG-2001-09-01R4 Charter.pdf reg) and None
Generating delta - new file: BPMN/NWG-2001-09-01R4 Charter.pdf
Selecting /Users/pascal/Documents/MyDocuments/References/Business
Analysis/BPMN/Notations and Workflow Patterns.pdf
Comparing ('BPMN', 'Notations and Workflow Patterns.pdf') and None
Getting delta of (('BPMN', 'Notations and Workflow Patterns.pdf')
/Users/pascal/Documents/MyDocuments/References/Business
Analysis/BPMN/Notations and Workflow Patterns.pdf reg) and None
Generating delta - new file: BPMN/Notations and Workflow Patterns.pdf
Selecting /Users/pascal/Documents/MyDocuments/References/Business
Analysis/BPMN/Product Catalog Process.doc
Comparing ('BPMN', 'Product Catalog Process.doc') and None
Getting delta of (('BPMN', 'Product Catalog Process.doc')
/Users/pascal/Documents/MyDocuments/References/Business
Analysis/BPMN/Product Catalog Process.doc reg) and None
Generating delta - new file: BPMN/Product Catalog Process.doc
Selecting /Users/pascal/Documents/MyDocuments/References/Business
Analysis/BPMN/Use Cases_1_&_2_Performing_Login_and_Logout.doc
Comparing ('BPMN', 'Use Cases_1_&_2_Performing_Login_and_Logout.doc') and None
Getting delta of (('BPMN', 'Use
Cases_1_&_2_Performing_Login_and_Logout.doc')
/Users/pascal/Documents/MyDocuments/References/Business
Analysis/BPMN/Use Cases_1_&_2_Performing_Login_and_Logout.doc reg) and
None
Generating delta - new file: BPMN/Use
Cases_1_&_2_Performing_Login_and_Logout.doc
Selecting /Users/pascal/Documents/MyDocuments/References/Business
Analysis/Business Case Example.doc
Comparing ('Business Case Example.doc',) and None
Getting delta of (('Business Case Example.doc',)
/Users/pascal/Documents/MyDocuments/References/Business
Analysis/Business Case Example.doc reg) and None
Generating delta - new file: Business Case Example.doc
Selecting /Users/pascal/Documents/MyDocuments/References/Business
Analysis/Business_Interaction_With_GCG-IT_DRAFT.ppt
Comparing ('Business_Interaction_With_GCG-IT_DRAFT.ppt',) and None
Getting delta of (('Business_Interaction_With_GCG-IT_DRAFT.ppt',)
/Users/pascal/Documents/MyDocuments/References/Business
Analysis/Business_Interaction_With_GCG-IT_DRAFT.ppt reg) and None
Generating delta - new file: Business_Interaction_With_GCG-IT_DRAFT.ppt
Running 'scp  
/var/folders/Gj/GjCTMUR8EViYUXcc8HBPR++++TY/-Tmp-/duplicity-xRXL5L-tempdir/mktemp-oJRSzd-2
address@hidden:backup/testb/duplicity-full.2008-06-29T20:29:17-07:00.vol1.difftar.gpg'
(attempt #1)
State = copying, Before = 'mktemp-oJRSzd-2
   0%    0     0.0KB/s   --:--'
State = copying, Before = 'mktemp-oJRSzd-2
  40% 2068KB   2.0MB/s   00:01'
State = copying, Before = 'mktemp-oJRSzd-2
  40% 2068KB   1.8MB/s   00:01'
State = copying, Before = 'mktemp-oJRSzd-2
  41% 2152KB   1.6MB/s   00:01'
State = copying, Before = 'mktemp-oJRSzd-2
  41% 2152KB   1.5MB/s   00:01'
State = copying, Before = 'mktemp-oJRSzd-2
  41% 2152KB   1.3MB/s   00:02'
State = copying, Before = 'mktemp-oJRSzd-2
  41% 2152KB   1.2MB/s   00:02'
State = copying, Before = 'mktemp-oJRSzd-2
  41% 2152KB   1.1MB/s   00:02'
State = copying, Before = 'mktemp-oJRSzd-2
  41% 2152KB 994.1KB/s -'
mktemp-oJRSzd-2                                43% 2256KB 905.1KB/s   00:03'
State = copying, Before = 'mktemp-oJRSzd-2
  43% 2256KB 814.6KB/s   00:03'
State = copying, Before = 'mktemp-oJRSzd-2
  45% 2336KB 741.1KB/s   00:03'
State = copying, Before = 'mktemp-oJRSzd-2
  45% 2336KB 667.0KB/s   00:04'
State = copying, Before = 'mktemp-oJRSzd-2
  47% 2432KB 609.9KB/s   00:04'
State = copying, Before = 'mktemp-oJRSzd-2
  49% 2532KB 558.9KB/s   00:04'
State = copying, Before = 'mktemp-oJRSzd-2
  49% 2532KB 503.0KB/s   00:05'
State = copying, Before = 'mktemp-oJRSzd-2
  51% 2624KB 461.9KB/s   00:05'
State = copying, Before = 'mktemp-oJRSzd-2
  53% 2720KB 425.3KB/s   00:05'
State = copying, Before = 'mktemp-oJRSzd-2
  53% 2720KB 382.8KB/s   00:06'
State = copying, Before = 'mktemp-oJRSzd-2
  54% 2816KB 354.1KB/s   00:06'
State = copying, Before = 'mktemp-oJRSzd-2
  54% 2816KB 318.7KB/s   00:07'
State = copying, Before = 'mktemp-oJRSzd-2
  56% 2912KB 296.4KB/s   00:07'
State = copying, Before = 'mktemp-oJRSzd-2
  58% 3008KB 276.4KB/s   00:07'
State = copying, Before = 'mktemp-oJRSzd-2
  58% 3008KB 248.8KB/s   00:08'
State = copying, Before = 'mktemp-oJRSzd-2
  58% 3008KB 223.9KB/s   00:09'
State = copying, Before = 'mktemp-oJRSzd-2
  58% 3008KB 201.5KB/s   00:10'
State = copying, Before = 'mktemp-oJRSzd-2
  60% 3096KB 190.1KB/s   00:10'
State = copying, Before = 'mktemp-oJRSzd-2
  60% 3096KB 171.1KB/s   00:11'
State = copying, Before = 'mktemp-oJRSzd-2
  60% 3096KB 154.0KB/s   00:13'
State = copying, Before = 'mktemp-oJRSzd-2
  62% 3192KB 148.2KB/s   00:13'
State = copying, Before = 'mktemp-oJRSzd-2
  62% 3192KB 133.4KB/s   00:14'
State = copying, Before = 'mktemp-oJRSzd-2
  62% 3192KB 120.1KB/s   00:16'
State = copying, Before = 'mktemp-oJRSzd-2
  62% 3192KB 108.0KB/s   00:17'
State = copying, Before = 'mktemp-oJRSzd-2
  64% 3292KB 107.2KB/s   00:17'
State = copying, Before = 'mktemp-oJRSzd-2
  64% 3292KB  96.5KB/s   00:19'
State = copying, Before = 'mktemp-oJRSzd-2
  64% 3292KB  86.9KB/s   00:21'
State = copying, Before = 'mktemp-oJRSzd-2
  64% 3292KB  78.2KB/s   00:23'
State = copying, Before = 'mktemp-oJRSzd-2
  64% 3292KB  70.4KB/s   00:26'
State = copying, Before = 'mktemp-oJRSzd-2
  66% 3388KB  72.9KB/s   00:23'
State = copying, Before = 'mktemp-oJRSzd-2
  66% 3388KB  65.6KB/s   00:26'
State = copying, Before = 'mktemp-oJRSzd-2
  68% 3488KB  69.1KB/s   00:23'
State = copying, Before = 'mktemp-oJRSzd-2
  68% 3488KB  62.2KB/s   00:26'
State = copying, Before = 'mktemp-oJRSzd-2
  68% 3488KB  55.9KB/s   00:29'
State = copying, Before = 'mktemp-oJRSzd-2
  69% 3576KB  59.2KB/s   00:26'
State = copying, Before = 'mktemp-oJRSzd-2
  69% 3576KB  53.2KB/s   00:29'
State = copying, Before = 'mktemp-oJRSzd-2
  71% 3672KB  57.5KB/s   00:25'
State = copying, Before = 'mktemp-oJRSzd-2
  71% 3672KB  51.8KB/s   00:28'
State = copying, Before = 'mktemp-oJRSzd-2
  71% 3672KB  46.6KB/s   00:31'
State = copying, Before = 'mktemp-oJRSzd-2
  73% 3768KB  51.5KB/s   00:26'
State = copying, Before = 'mktemp-oJRSzd-2
  75% 3868KB  56.4KB/s   00:22'
State = copying, Before = 'mktemp-oJRSzd-2
  75% 3868KB  50.7KB/s   00:24'
State = copying, Before = 'mktemp-oJRSzd-2
  77% 3964KB  55.3KB/s   00:21'
State = copying, Before = 'mktemp-oJRSzd-2
  77% 3964KB  49.7KB/s   00:23'
State = copying, Before = 'mktemp-oJRSzd-2
  79% 4060KB  54.4KB/s   00:19'
State = copying, Before = 'mktemp-oJRSzd-2
  79% 4060KB  48.9KB/s   00:21'
State = copying, Before = 'mktemp-oJRSzd-2
  79% 4060KB  44.0KB/s   00:24'
State = copying, Before = 'mktemp-oJRSzd-2
  80% 4152KB  48.8KB/s   00:19'
State = copying, Before = 'mktemp-oJRSzd-2
  80% 4152KB  43.9KB/s   00:22'
State = copying, Before = 'mktemp-oJRSzd-2
  82% 4248KB  49.2KB/s   00:17'
State = copying, Before = 'mktemp-oJRSzd-2
  82% 4248KB  44.2KB/s   00:19'
State = copying, Before = 'mktemp-oJRSzd-2
  84% 4344KB  49.4KB/s   00:15'
State = copying, Before = 'mktemp-oJRSzd-2
  86% 4440KB  54.1KB/s   00:12'
State = copying, Before = 'mktemp-oJRSzd-2
  86% 4440KB  48.7KB/s   00:14'
State = copying, Before = 'mktemp-oJRSzd-2
  86% 4440KB  43.8KB/s   00:15'
State = copying, Before = 'mktemp-oJRSzd-2
  88% 4536KB  49.0KB/s   00:12'
State = copying, Before = 'mktemp-oJRSzd-2
  90% 4632KB  53.7KB/s   00:09'
State = copying, Before = 'mktemp-oJRSzd-2
  90% 4632KB  48.3KB/s   00:10'
State = copying, Before = 'mktemp-oJRSzd-2
  92% 4728KB  53.1KB/s   00:07'
State = copying, Before = 'mktemp-oJRSzd-2
  92% 4728KB  47.8KB/s   00:08'
State = copying, Before = 'mktemp-oJRSzd-2
  94% 4824KB  52.6KB/s   00:05'
State = copying, Before = 'mktemp-oJRSzd-2
  94% 4824KB  47.4KB/s   00:06'
State = copying, Before = 'mktemp-oJRSzd-2
  95% 4920KB  52.2KB/s   00:03'
State = copying, Before = 'mktemp-oJRSzd-2
  95% 4920KB  47.0KB/s   00:04'
State = copying, Before = 'mktemp-oJRSzd-2
  97% 5016KB  51.9KB/s   00:02'
State = copying, Before = 'mktemp-oJRSzd-2
  99% 5116KB  56.7KB/s   00:00'
State = copying, Before = 'mktemp-oJRSzd-2
  99% 5116KB  51.0KB/s   00:00'
State = copying, Before = 'mktemp-oJRSzd-2
 100% 5127KB  68.4KB/s   01:15'
Timeout waiting for response
Running 'scp  
/var/folders/Gj/GjCTMUR8EViYUXcc8HBPR++++TY/-Tmp-/duplicity-xRXL5L-tempdir/mktemp-oJRSzd-2
address@hidden:backup/testb/duplicity-full.2008-06-29T20:29:17-07:00.vol1.difftar.gpg'
failed (attempt #1)
Running 'scp  
/var/folders/Gj/GjCTMUR8EViYUXcc8HBPR++++TY/-Tmp-/duplicity-xRXL5L-tempdir/mktemp-oJRSzd-2
address@hidden:backup/testb/duplicity-full.2008-06-29T20:29:17-07:00.vol1.difftar.gpg'
(attempt #2)
State = copying, Before = 'mktemp-oJRSzd-2
   0%    0     0.0KB/s   --:--'
State = copying, Before = 'mktemp-oJRSzd-2
  40% 2064KB   2.0MB/s   00:01'
State = copying, Before = 'mktemp-oJRSzd-2
  40% 2064KB   1.8MB/s   00:01'
State = copying, Before = 'mktemp-oJRSzd-2
  40% 2064KB   1.6MB/s   00:01'
State = copying, Before = 'mktemp-oJRSzd-2
  40% 2064KB   1.5MB/s   00:02'
State = copying, Before = 'mktemp-oJRSzd-2
  42% 2160KB   1.3MB/s   00:02'
State = copying, Before = 'mktemp-oJRSzd-2
  43% 2248KB   1.2MB/s   00:02'
State = copying, Before = 'mktemp-oJRSzd-2
  43% 2248KB   1.1MB/s   00:02'
State = copying, Before = 'mktemp-oJRSzd-2
  45% 2336KB   1.0MB/s   00:02'
State = copying, Before = 'mktemp-oJRSzd-2
  45% 2336KB 909.1KB/s   00:03'
State = copying, Before = 'mktemp-oJRSzd-2
  47% 2432KB 827.8KB/s   00:03'
State = copying, Before = 'mktemp-oJRSzd-2
  47% 2432KB 745.0KB/s   00:03'
State = copying, Before = 'mktemp-oJRSzd-2
  49% 2528KB 680.1KB/s   00:03'
State = copying, Before = 'mktemp-oJRSzd-2
  49% 2528KB 612.1KB/s   00:04'
State = copying, Before = 'mktemp-oJRSzd-2
  51% 2624KB 560.5KB/s   00:04'
State = copying, Before = 'mktemp-oJRSzd-2
  53% 2724KB 514.5KB/s   00:04'
State = copying, Before = 'mktemp-oJRSzd-2
  53% 2724KB 463.0KB/s   00:05'
State = copying, Before = 'mktemp-oJRSzd-2
  54% 2820KB 426.3KB/s   00:05'
State = copying, Before = 'mktemp-oJRSzd-2
  54% 2820KB 383.7KB/s   00:06'
State = copying, Before = 'mktemp-oJRSzd-2
  56% 2912KB 354.5KB/s   00:06'
State = copying, Before = 'mktemp-oJRSzd-2
  56% 2912KB 319.1KB/s   00:06'
State = copying, Before = 'mktemp-oJRSzd-2
  58% 3008KB 296.8KB/s   00:07'
State = copying, Before = 'mktemp-oJRSzd-2
  60% 3096KB 275.9KB/s   00:07'
State = copying, Before = 'mktemp-oJRSzd-2
  60% 3096KB 248.3KB/s   00:08'
State = copying, Before = 'mktemp-oJRSzd-2
  62% 3196KB 233.5KB/s   00:08'
State = copying, Before = 'mktemp-oJRSzd-2
  62% 3196KB 210.1KB/s   00:09'
State = copying, Before = 'mktemp-oJRSzd-2
  64% 3292KB 198.7KB/s   00:09'
State = copying, Before = 'mktemp-oJRSzd-2
  64% 3292KB 178.8KB/s   00:10'
State = copying, Before = 'mktemp-oJRSzd-2
  66% 3388KB 170.5KB/s   00:10'
State = copying, Before = 'mktemp-oJRSzd-2
  66% 3388KB 153.5KB/s   00:11'
State = copying, Before = 'mktemp-oJRSzd-2
  68% 3488KB 148.1KB/s   00:11'
State = copying, Before = 'mktemp-oJRSzd-2
  69% 3576KB 142.1KB/s   00:10'
State = copying, Before = 'mktemp-oJRSzd-2
  69% 3576KB 127.9KB/s   00:12'
State = copying, Before = 'mktemp-oJRSzd-2
  71% 3672KB 124.7KB/s   00:11'
State = copying, Before = 'mktemp-oJRSzd-2
  71% 3672KB 112.3KB/s   00:12'
State = copying, Before = 'mktemp-oJRSzd-2
  73% 3780KB 111.8KB/s   00:12'
State = copying, Before = 'mktemp-oJRSzd-2
  73% 3780KB 100.6KB/s   00:13'
State = copying, Before = 'mktemp-oJRSzd-2
  75% 3868KB  99.4KB/s   00:12'
State = copying, Before = 'mktemp-oJRSzd-2
  77% 3964KB  99.0KB/s   00:11'
State = copying, Before = 'mktemp-oJRSzd-2
  77% 3964KB  89.1KB/s   00:13'
State = copying, Before = 'mktemp-oJRSzd-2
  79% 4060KB  89.8KB/s   00:11'
State = copying, Before = 'mktemp-oJRSzd-2
  80% 4152KB  90.0KB/s   00:10'
State = copying, Before = 'mktemp-oJRSzd-2
  80% 4152KB  81.0KB/s   00:12'
State = copying, Before = 'mktemp-oJRSzd-2
  82% 4248KB  82.5KB/s   00:10'
State = copying, Before = 'mktemp-oJRSzd-2
  82% 4248KB  74.3KB/s   00:11'
State = copying, Before = 'mktemp-oJRSzd-2
  84% 4344KB  76.5KB/s   00:10'
State = copying, Before = 'mktemp-oJRSzd-2
  86% 4444KB  78.8KB/s   00:08'
State = copying, Before = 'mktemp-oJRSzd-2
  86% 4444KB  70.9KB/s   00:09'
State = copying, Before = 'mktemp-oJRSzd-2
  86% 4444KB  63.8KB/s   00:10'
State = copying, Before = 'mktemp-oJRSzd-2
  86% 4444KB  57.5KB/s   00:11'
State = copying, Before = 'mktemp-oJRSzd-2
  88% 4536KB  60.9KB/s   00:09'
State = copying, Before = 'mktemp-oJRSzd-2
  88% 4536KB  54.8KB/s   00:10'
State = copying, Before = 'mktemp-oJRSzd-2
  88% 4536KB  49.3KB/s   00:11'
State = copying, Before = 'mktemp-oJRSzd-2
  90% 4632KB  54.0KB/s   00:09'
State = copying, Before = 'mktemp-oJRSzd-2
  90% 4632KB  48.6KB/s   00:10'
State = copying, Before = 'mktemp-oJRSzd-2
  90% 4632KB  43.7KB/s   00:11'
State = copying, Before = 'mktemp-oJRSzd-2
  92% 4728KB  49.0KB/s   00:08'
State = copying, Before = 'mktemp-oJRSzd-2
  92% 4728KB  44.1KB/s   00:09'
State = copying, Before = 'mktemp-oJRSzd-2
  92% 4728KB  39.7KB/s   00:10'
State = copying, Before = 'mktemp-oJRSzd-2
  92% 4728KB  35.7KB/s   00:11'
State = copying, Before = 'mktemp-oJRSzd-2
  94% 4824KB  41.7KB/s   00:07'
State = copying, Before = 'mktemp-oJRSzd-2
  94% 4824KB  37.6KB/s   00:08'
State = copying, Before = 'mktemp-oJRSzd-2
  94% 4824KB  33.8KB/s   00:08'
State = copying, Before = 'mktemp-oJRSzd-2
  96% 4924KB  40.4KB/s   00:05'
State = copying, Before = 'mktemp-oJRSzd-2
  96% 4924KB  36.4KB/s   00:05'
State = copying, Before = 'mktemp-oJRSzd-2
  97% 5016KB  41.9KB/s   00:02'
State = copying, Before = 'mktemp-oJRSzd-2
  97% 5016KB  37.7KB/s   00:02'
State = copying, Before = 'mktemp-oJRSzd-2
  99% 5112KB  43.6KB/s   00:00'
State = copying, Before = 'mktemp-oJRSzd-2
  99% 5112KB  39.2KB/s   00:00'
State = copying, Before = 'mktemp-oJRSzd-2
  99% 5112KB  35.3KB/s   00:00'
State = copying, Before = 'mktemp-oJRSzd-2
 100% 5127KB  74.3KB/s   01:09'
Timeout waiting for response
Running 'scp  
/var/folders/Gj/GjCTMUR8EViYUXcc8HBPR++++TY/-Tmp-/duplicity-xRXL5L-tempdir/mktemp-oJRSzd-2
address@hidden:backup/testb/duplicity-full.2008-06-29T20:29:17-07:00.vol1.difftar.gpg'
failed (attempt #2)
Running 'scp  
/var/folders/Gj/GjCTMUR8EViYUXcc8HBPR++++TY/-Tmp-/duplicity-xRXL5L-tempdir/mktemp-oJRSzd-2
address@hidden:backup/testb/duplicity-full.2008-06-29T20:29:17-07:00.vol1.difftar.gpg'
(attempt #3)
State = copying, Before = 'mktemp-oJRSzd-2
   0%    0     0.0KB/s   --:--'
State = copying, Before = 'mktemp-oJRSzd-2
  40% 2068KB   2.0MB/s   00:01'
State = copying, Before = 'mktemp-oJRSzd-2
  40% 2068KB   1.8MB/s   00:01'
State = copying, Before = 'mktemp-oJRSzd-2
  40% 2068KB   1.6MB/s   00:01'
State = copying, Before = 'mktemp-oJRSzd-2
  40% 2068KB   1.5MB/s   00:02'
State = copying, Before = 'mktemp-oJRSzd-2
  42% 2160KB   1.3MB/s   00:02'
State = copying, Before = 'mktemp-oJRSzd-2
  42% 2160KB   1.2MB/s   00:02'
State = copying, Before = 'mktemp-oJRSzd-2
  44% 2260KB   1.1MB/s   00:02'
State = copying, Before = 'mktemp-oJRSzd-2
  44% 2260KB   1.0MB/s   00:02'
State = copying, Before = 'mktemp-oJRSzd-2
  45% 2340KB 912.3KB/s   00:03'
State = copying, Before = 'mktemp-oJRSzd-2
  45% 2340KB 821.1KB/s   00:03'
State = copying, Before = 'mktemp-oJRSzd-2
  47% 2432KB 748.2KB/s   00:03'
State = copying, Before = 'mktemp-oJRSzd-2
  47% 2432KB 673.4KB/s   00:04'
State = copying, Before = 'mktemp-oJRSzd-2
  49% 2532KB 616.0KB/s   00:04'
State = copying, Before = 'mktemp-oJRSzd-2
  49% 2532KB 554.4KB/s   00:04'
State = copying, Before = 'mktemp-oJRSzd-2
  51% 2624KB 508.2KB/s   00:04'
State = copying, Before = 'mktemp-oJRSzd-2
  51% 2624KB 457.4KB/s   00:05'
State = copying, Before = 'mktemp-oJRSzd-2
  53% 2724KB 421.6KB/s   00:05'
State = copying, Before = 'mktemp-oJRSzd-2
  53% 2724KB 379.5KB/s   00:06'
State = copying, Before = 'mktemp-oJRSzd-2
  54% 2812KB 350.3KB/s   00:06'
State = copying, Before = 'mktemp-oJRSzd-2
  54% 2812KB 315.3KB/s   00:07'
State = copying, Before = 'mktemp-oJRSzd-2
  56% 2916KB 294.2KB/s   00:07'
State = copying, Before = 'mktemp-oJRSzd-2
  56% 2916KB 264.7KB/s   00:08'
State = copying, Before = 'mktemp-oJRSzd-2
  58% 3008KB 247.5KB/s   00:08'
State = copying, Before = 'mktemp-oJRSzd-2
  60% 3104KB 232.3KB/s   00:08'
State = copying, Before = 'mktemp-oJRSzd-2
  60% 3104KB 209.1KB/s   00:09'
State = copying, Before = 'mktemp-oJRSzd-2
  62% 3192KB 197.0KB/s   00:09'
State = copying, Before = 'mktemp-oJRSzd-2
  62% 3192KB 177.3KB/s   00:10'
State = copying, Before = 'mktemp-oJRSzd-2
  64% 3296KB 170.0KB/s   00:10'
State = copying, Before = 'mktemp-oJRSzd-2
  64% 3296KB 153.0KB/s   00:11'
State = copying, Before = 'mktemp-oJRSzd-2
  66% 3392KB 147.3KB/s   00:11'
State = copying, Before = 'mktemp-oJRSzd-2
  66% 3392KB 132.5KB/s   00:13'
State = copying, Before = 'mktemp-oJRSzd-2
  67% 3484KB 128.5KB/s   00:12'
State = copying, Before = 'mktemp-oJRSzd-2
  69% 3576KB 124.8KB/s   00:12'
State = copying, Before = 'mktemp-oJRSzd-2
  69% 3576KB 112.4KB/s   00:13'
State = copying, Before = 'mktemp-oJRSzd-2
  71% 3672KB 110.7KB/s   00:13'
State = copying, Before = 'mktemp-oJRSzd-2
  71% 3672KB  99.6KB/s   00:14'
State = copying, Before = 'mktemp-oJRSzd-2
  73% 3768KB  99.3KB/s   00:13'
State = copying, Before = 'mktemp-oJRSzd-2
  73% 3768KB  89.4KB/s   00:15'
State = copying, Before = 'mktemp-oJRSzd-2
  75% 3864KB  90.0KB/s   00:14'
State = copying, Before = 'mktemp-oJRSzd-2
  77% 3960KB  90.6KB/s   00:12'
State = copying, Before = 'mktemp-oJRSzd-2
  77% 3960KB  81.6KB/s   00:14'
State = copying, Before = 'mktemp-oJRSzd-2
  79% 4056KB  83.0KB/s   00:12'
State = copying, Before = 'mktemp-oJRSzd-2
  80% 4152KB  84.3KB/s   00:11'
State = copying, Before = 'mktemp-oJRSzd-2
  80% 4152KB  75.9KB/s   00:12'
State = copying, Before = 'mktemp-oJRSzd-2
  82% 4248KB  77.9KB/s   00:11'
State = copying, Before = 'mktemp-oJRSzd-2
  82% 4248KB  70.1KB/s   00:12'
State = copying, Before = 'mktemp-oJRSzd-2
  84% 4348KB  73.1KB/s   00:10'
State = copying, Before = 'mktemp-oJRSzd-2
  86% 4444KB  75.4KB/s   00:09'
State = copying, Before = 'mktemp-oJRSzd-2
  86% 4444KB  67.8KB/s   00:10'
State = copying, Before = 'mktemp-oJRSzd-2
  88% 4540KB  70.7KB/s   00:08'
State = copying, Before = 'mktemp-oJRSzd-2
  88% 4540KB  63.6KB/s   00:09'
State = copying, Before = 'mktemp-oJRSzd-2
  90% 4636KB  66.8KB/s   00:07'
State = copying, Before = 'mktemp-oJRSzd-2
  92% 4728KB  69.3KB/s   00:05'
State = copying, Before = 'mktemp-oJRSzd-2
  92% 4728KB  62.4KB/s   00:06'
State = copying, Before = 'mktemp-oJRSzd-2
  94% 4836KB  67.0KB/s   00:04'
State = copying, Before = 'mktemp-oJRSzd-2
  94% 4836KB  60.3KB/s   00:04'
State = copying, Before = 'mktemp-oJRSzd-2
  95% 4920KB  62.6KB/s   00:03'
State = copying, Before = 'mktemp-oJRSzd-2
  98% 5028KB  67.2KB/s   00:01'
State = copying, Before = 'mktemp-oJRSzd-2
  98% 5028KB  60.5KB/s   00:01'
State = copying, Before = 'mktemp-oJRSzd-2
  99% 5116KB  63.2KB/s   00:00'
State = copying, Before = 'mktemp-oJRSzd-2
  99% 5116KB  56.9KB/s   00:00'
State = copying, Before = 'mktemp-oJRSzd-2
 100% 5127KB  84.1KB/s   01:01'
Timeout waiting for response
Running 'scp  
/var/folders/Gj/GjCTMUR8EViYUXcc8HBPR++++TY/-Tmp-/duplicity-xRXL5L-tempdir/mktemp-oJRSzd-2
address@hidden:backup/testb/duplicity-full.2008-06-29T20:29:17-07:00.vol1.difftar.gpg'
failed (attempt #3)
Running 'scp  
/var/folders/Gj/GjCTMUR8EViYUXcc8HBPR++++TY/-Tmp-/duplicity-xRXL5L-tempdir/mktemp-oJRSzd-2
address@hidden:backup/testb/duplicity-full.2008-06-29T20:29:17-07:00.vol1.difftar.gpg'
(attempt #4)
State = copying, Before = 'mktemp-oJRSzd-2
   0%    0     0.0KB/s   --:--'
State = copying, Before = 'mktemp-oJRSzd-2
  40% 2064KB   2.0MB/s   00:01'
State = copying, Before = 'mktemp-oJRSzd-2
  40% 2064KB   1.8MB/s   00:01'
State = copying, Before = 'mktemp-oJRSzd-2
  40% 2064KB   1.6MB/s   00:01'
State = copying, Before = 'mktemp-oJRSzd-2
  40% 2064KB   1.5MB/s   00:02'
State = copying, Before = 'mktemp-oJRSzd-2
  42% 2160KB   1.3MB/s   00:02'
State = copying, Before = 'mktemp-oJRSzd-2
  42% 2160KB   1.2MB/s   00:02'
State = copying, Before = 'mktemp-oJRSzd-2
  42% 2160KB   1.1MB/s   00:02'
State = copying, Before = 'mktemp-oJRSzd-2
  42% 2160KB 994.2KB/s   00:02'
State = copying, Before = 'mktemp-oJRSzd-2
  43% 2256KB 904.4KB/s   00:03'
State = copying, Before = 'mktemp-oJRSzd-2
  43% 2256KB 813.9KB/s   00:03'
State = copying, Before = 'mktemp-oJRSzd-2
  43% 2256KB 732.6KB/s   00:03'
State = copying, Before = 'mktemp-oJRSzd-2
  43% 2256KB 659.3KB/s   00:04'
State = copying, Before = 'mktemp-oJRSzd-2
  45% 2332KB 601.0KB/s   00:04'
State = copying, Before = 'mktemp-oJRSzd-2
  45% 2332KB 540.9KB/s   00:05'
State = copying, Before = 'mktemp-oJRSzd-2
  45% 2332KB 486.8KB/s   00:05'
State = copying, Before = 'mktemp-oJRSzd-2
  47% 2436KB 448.5KB/s   00:06'
State = copying, Before = 'mktemp-oJRSzd-2
  47% 2436KB 403.7KB/s   00:06'
State = copying, Before = 'mktemp-oJRSzd-2
  49% 2532KB 372.9KB/s   00:06'
State = copying, Before = 'mktemp-oJRSzd-2
  49% 2532KB 335.6KB/s   00:07'
State = copying, Before = 'mktemp-oJRSzd-2
  49% 2532KB 302.0KB/s   00:08'
State = copying, Before = 'mktemp-oJRSzd-2
  51% 2624KB 281.0KB/s   00:08'
State = copying, Before = 'mktemp-oJRSzd-2
  51% 2624KB 252.9KB/s   00:09'
State = copying, Before = 'mktemp-oJRSzd-2
  51% 2624KB 227.6KB/s   00:10'
State = copying, Before = 'mktemp-oJRSzd-2
  52% 2712KB 213.7KB/s   00:11'
State = copying, Before = 'mktemp-oJRSzd-2
  52% 2712KB 192.3KB/s   00:12'
State = copying, Before = 'mktemp-oJRSzd-2
  54% 2816KB 183.5KB/s   00:12'
State = copying, Before = 'mktemp-oJRSzd-2
  54% 2816KB 165.1KB/s   00:13'
State = copying, Before = 'mktemp-oJRSzd-2
  56% 2904KB 157.4KB/s   00:14'
State = copying, Before = 'mktemp-oJRSzd-2
  56% 2904KB 141.7KB/s   00:15'
State = copying, Before = 'mktemp-oJRSzd-2
  58% 3000KB 137.1KB/s   00:15'
State = copying, Before = 'mktemp-oJRSzd-2
  58% 3000KB 123.4KB/s   00:17'
State = copying, Before = 'mktemp-oJRSzd-2
  60% 3104KB 121.5KB/s   00:16'
State = copying, Before = 'mktemp-oJRSzd-2
  60% 3104KB 109.3KB/s   00:18'
State = copying, Before = 'mktemp-oJRSzd-2
  60% 3104KB  98.4KB/s   00:20'
State = copying, Before = 'mktemp-oJRSzd-2
  62% 3200KB  98.1KB/s   00:19'
State = copying, Before = 'mktemp-oJRSzd-2
  64% 3288KB  97.1KB/s   00:18'
State = copying, Before = 'mktemp-oJRSzd-2
  64% 3288KB  87.4KB/s   00:21'
State = copying, Before = 'mktemp-oJRSzd-2
  65% 3384KB  88.3KB/s   00:19'
State = copying, Before = 'mktemp-oJRSzd-2
  65% 3384KB  79.4KB/s   00:21'
State = copying, Before = 'mktemp-oJRSzd-2
  67% 3480KB  81.1KB/s   00:20'
State = copying, Before = 'mktemp-oJRSzd-2
  67% 3480KB  73.0KB/s   00:22'
State = copying, Before = 'mktemp-oJRSzd-2
  69% 3576KB  75.3KB/s   00:20'
State = copying, Before = 'mktemp-oJRSzd-2
  69% 3576KB  67.8KB/s   00:22'
State = copying, Before = 'mktemp-oJRSzd-2
  71% 3676KB  71.0KB/s   00:20'
State = copying, Before = 'mktemp-oJRSzd-2
  71% 3676KB  63.9KB/s   00:22'
State = copying, Before = 'mktemp-oJRSzd-2
  73% 3768KB  66.7KB/s   00:20'
State = copying, Before = 'mktemp-oJRSzd-2
  73% 3768KB  60.0KB/s   00:22'
State = copying, Before = 'mktemp-oJRSzd-2
  75% 3864KB  63.6KB/s   00:19'
State = copying, Before = 'mktemp-oJRSzd-2
  77% 3960KB  66.9KB/s   00:17'
State = copying, Before = 'mktemp-oJRSzd-2
  77% 3960KB  60.2KB/s   00:19'
State = copying, Before = 'mktemp-oJRSzd-2
  79% 4056KB  63.8KB/s   00:16'
State = copying, Before = 'mktemp-oJRSzd-2
  79% 4056KB  57.4KB/s   00:18'
State = copying, Before = 'mktemp-oJRSzd-2
  81% 4156KB  61.6KB/s   00:15'
State = copying, Before = 'mktemp-oJRSzd-2
  82% 4252KB  65.1KB/s   00:13'
State = copying, Before = 'mktemp-oJRSzd-2
  82% 4252KB  58.6KB/s   00:14'
State = copying, Before = 'mktemp-oJRSzd-2
  84% 4348KB  62.3KB/s   00:12'
State = copying, Before = 'mktemp-oJRSzd-2
  84% 4348KB  56.1KB/s   00:13'
State = copying, Before = 'mktemp-oJRSzd-2
  86% 4440KB  59.7KB/s   00:11'
State = copying, Before = 'mktemp-oJRSzd-2
  86% 4440KB  53.7KB/s   00:12'
State = copying, Before = 'mktemp-oJRSzd-2
  88% 4536KB  57.9KB/s   00:10'
State = copying, Before = 'mktemp-oJRSzd-2
  90% 4632KB  61.7KB/s   00:08'
State = copying, Before = 'mktemp-oJRSzd-2
  90% 4632KB  55.6KB/s   00:08'
State = copying, Before = 'mktemp-oJRSzd-2
  92% 4728KB  59.6KB/s   00:06'
State = copying, Before = 'mktemp-oJRSzd-2
  92% 4728KB  53.7KB/s   00:07'
State = copying, Before = 'mktemp-oJRSzd-2
  94% 4824KB  57.9KB/s   00:05'
State = copying, Before = 'mktemp-oJRSzd-2
  95% 4920KB  61.7KB/s   00:03'
State = copying, Before = 'mktemp-oJRSzd-2
  95% 4920KB  55.5KB/s   00:03'
State = copying, Before = 'mktemp-oJRSzd-2
  97% 5016KB  59.6KB/s   00:01'
State = copying, Before = 'mktemp-oJRSzd-2
  97% 5016KB  53.6KB/s   00:02'
State = copying, Before = 'mktemp-oJRSzd-2
  99% 5112KB  57.9KB/s   00:00'
State = copying, Before = 'mktemp-oJRSzd-2
 100% 5127KB  73.3KB/s   01:10'
Timeout waiting for response
Running 'scp  
/var/folders/Gj/GjCTMUR8EViYUXcc8HBPR++++TY/-Tmp-/duplicity-xRXL5L-tempdir/mktemp-oJRSzd-2
address@hidden:backup/testb/duplicity-full.2008-06-29T20:29:17-07:00.vol1.difftar.gpg'
failed (attempt #4)
Running 'scp  
/var/folders/Gj/GjCTMUR8EViYUXcc8HBPR++++TY/-Tmp-/duplicity-xRXL5L-tempdir/mktemp-oJRSzd-2
address@hidden:backup/testb/duplicity-full.2008-06-29T20:29:17-07:00.vol1.difftar.gpg'
(attempt #5)
State = copying, Before = 'mktemp-oJRSzd-2
   0%    0     0.0KB/s   --:--'
State = copying, Before = 'mktemp-oJRSzd-2
  40% 2068KB   2.0MB/s   00:01'
State = copying, Before = 'mktemp-oJRSzd-2
  40% 2068KB   1.8MB/s   00:01'
State = copying, Before = 'mktemp-oJRSzd-2
  40% 2068KB   1.6MB/s   00:01'
State = copying, Before = 'mktemp-oJRSzd-2
  40% 2068KB   1.5MB/s   00:02'
State = copying, Before = 'mktemp-oJRSzd-2
  40% 2068KB   1.3MB/s   00:02'
State = copying, Before = 'mktemp-oJRSzd-2
  40% 2068KB   1.2MB/s -'
mktemp-oJRSzd-2                                42% 2164KB 998.7KB/s   00:02'd -
State = copying, Before = 'mktemp-oJRSzd-2
  42% 2164KB 898.8KB/s   00:03'
State = copying, Before = 'mktemp-oJRSzd-2
  42% 2164KB 809.0KB/s   00:03'
State = copying, Before = 'mktemp-oJRSzd-2
  42% 2164KB 728.1KB/s   00:04'
State = copying, Before = 'mktemp-oJRSzd-2
  42% 2164KB 655.3KB/s   00:04'
State = copying, Before = 'mktemp-oJRSzd-2
  42% 2164KB 589.7KB/s -'
mktemp-oJRSzd-2                                44% 2260KB 540.4KB/s   00:05'
State = copying, Before = 'mktemp-oJRSzd-2
  44% 2260KB 486.3KB/s   00:05'
State = copying, Before = 'mktemp-oJRSzd-2
  44% 2260KB 437.7KB/s   00:06'
State = copying, Before = 'mktemp-oJRSzd-2
  44% 2260KB 393.9KB/s   00:07'
State = copying, Before = 'mktemp-oJRSzd-2
  44% 2260KB 354.5KB/s   00:08'
State = copying, Before = 'mktemp-oJRSzd-2
  45% 2336KB 326.7KB/s   00:08'
State = copying, Before = 'mktemp-oJRSzd-2
  45% 2336KB 294.0KB/s   00:09'
State = copying, Before = 'mktemp-oJRSzd-2
  45% 2336KB 264.6KB/s   00:10'
State = copying, Before = 'mktemp-oJRSzd-2
  45% 2336KB 238.1KB/s   00:11'
State = copying, Before = 'mktemp-oJRSzd-2
  45% 2336KB 214.3KB/s   00:13'
State = copying, Before = 'mktemp-oJRSzd-2
  45% 2336KB 192.9KB/s -'
mktemp-oJRSzd-2                                47% 2432KB 183.2KB/s   00:14'
State = copying, Before = 'mktemp-oJRSzd-2
  47% 2432KB 164.9KB/s   00:16'
State = copying, Before = 'mktemp-oJRSzd-2
  47% 2432KB 148.4KB/s   00:18'
State = copying, Before = 'mktemp-oJRSzd-2
  47% 2432KB 133.6KB/s   00:20'
State = copying, Before = 'mktemp-oJRSzd-2
  47% 2432KB 120.2KB/s   00:22'
State = copying, Before = 'mktemp-oJRSzd-2
  49% 2528KB 117.8KB/s   00:22'
State = copying, Before = 'mktemp-oJRSzd-2
  49% 2528KB 106.0KB/s   00:24'
State = copying, Before = 'mktemp-oJRSzd-2
  49% 2528KB  95.4KB/s   00:27'
State = copying, Before = 'mktemp-oJRSzd-2
  49% 2528KB  85.9KB/s   00:30'
State = copying, Before = 'mktemp-oJRSzd-2
  49% 2528KB  77.3KB/s   00:33'
State = copying, Before = 'mktemp-oJRSzd-2
  51% 2624KB  79.2KB/s   00:31'
State = copying, Before = 'mktemp-oJRSzd-2
  51% 2624KB  71.2KB/s   00:35'
State = copying, Before = 'mktemp-oJRSzd-2
  51% 2624KB  64.1KB/s   00:39'
State = copying, Before = 'mktemp-oJRSzd-2
  51% 2624KB  57.7KB/s   00:43'
State = copying, Before = 'mktemp-oJRSzd-2
  51% 2624KB  51.9KB/s   00:48'
State = copying, Before = 'mktemp-oJRSzd-2
  51% 2624KB  46.7KB/s -'
mktemp-oJRSzd-2                                53% 2724KB  52.1KB/s   00:46'
State = copying, Before = 'mktemp-oJRSzd-2
  53% 2724KB  46.9KB/s   00:51'
State = copying, Before = 'mktemp-oJRSzd-2
  53% 2724KB  42.2KB/s   00:56'
State = copying, Before = 'mktemp-oJRSzd-2
  54% 2816KB  47.2KB/s   00:49'
State = copying, Before = 'mktemp-oJRSzd-2
  54% 2816KB  42.4KB/s   00:54'
State = copying, Before = 'mktemp-oJRSzd-2
  54% 2816KB  38.2KB/s   01:00'
State = copying, Before = 'mktemp-oJRSzd-2
  56% 2912KB  44.0KB/s   00:50'
State = copying, Before = 'mktemp-oJRSzd-2
  56% 2912KB  39.6KB/s   00:55'
State = copying, Before = 'mktemp-oJRSzd-2
  56% 2912KB  35.6KB/s   01:02'
State = copying, Before = 'mktemp-oJRSzd-2
  56% 2912KB  32.1KB/s   01:09'
State = copying, Before = 'mktemp-oJRSzd-2
  58% 3008KB  38.5KB/s   00:55'
State = copying, Before = 'mktemp-oJRSzd-2
  58% 3008KB  34.6KB/s   01:01'
State = copying, Before = 'mktemp-oJRSzd-2
  58% 3008KB  31.1KB/s   01:08'
State = copying, Before = 'mktemp-oJRSzd-2
  58% 3008KB  28.0KB/s   01:15'
State = copying, Before = 'mktemp-oJRSzd-2
  60% 3096KB  34.0KB/s   00:59'
State = copying, Before = 'mktemp-oJRSzd-2
  60% 3096KB  30.6KB/s   01:06'
State = copying, Before = 'mktemp-oJRSzd-2
  62% 3196KB  37.6KB/s   00:51'
State = copying, Before = 'mktemp-oJRSzd-2
  62% 3196KB  33.8KB/s   00:57'
State = copying, Before = 'mktemp-oJRSzd-2
  64% 3292KB  40.0KB/s   00:45'
State = copying, Before = 'mktemp-oJRSzd-2
  64% 3292KB  36.0KB/s   00:50'
State = copying, Before = 'mktemp-oJRSzd-2
  66% 3388KB  42.0KB/s   00:41'
State = copying, Before = 'mktemp-oJRSzd-2
  66% 3388KB  37.8KB/s   00:45'
State = copying, Before = 'mktemp-oJRSzd-2
  67% 3480KB  43.2KB/s   00:38'
State = copying, Before = 'mktemp-oJRSzd-2
  67% 3480KB  38.9KB/s   00:42'
State = copying, Before = 'mktemp-oJRSzd-2
  69% 3584KB  45.4KB/s   00:33'
State = copying, Before = 'mktemp-oJRSzd-2
  71% 3672KB  49.7KB/s   00:29'
State = copying, Before = 'mktemp-oJRSzd-2
  71% 3672KB  44.7KB/s   00:32'
State = copying, Before = 'mktemp-oJRSzd-2
  73% 3768KB  49.8KB/s   00:27'
State = copying, Before = 'mktemp-oJRSzd-2
  73% 3768KB  44.9KB/s   00:30'
State = copying, Before = 'mktemp-oJRSzd-2
  73% 3768KB  40.4KB/s   00:33'
State = copying, Before = 'mktemp-oJRSzd-2
  75% 3864KB  45.9KB/s   00:27'
State = copying, Before = 'mktemp-oJRSzd-2
  77% 3960KB  50.9KB/s   00:22'
State = copying, Before = 'mktemp-oJRSzd-2
  77% 3960KB  45.8KB/s   00:25'
State = copying, Before = 'mktemp-oJRSzd-2
  79% 4056KB  50.9KB/s   00:21'
State = copying, Before = 'mktemp-oJRSzd-2
  79% 4056KB  45.8KB/s   00:23'
State = copying, Before = 'mktemp-oJRSzd-2
  80% 4152KB  50.8KB/s   00:19'
State = copying, Before = 'mktemp-oJRSzd-2
  80% 4152KB  45.7KB/s   00:21'
State = copying, Before = 'mktemp-oJRSzd-2
  82% 4248KB  50.7KB/s   00:17'
State = copying, Before = 'mktemp-oJRSzd-2
  82% 4248KB  45.7KB/s   00:19'
State = copying, Before = 'mktemp-oJRSzd-2
  84% 4344KB  50.7KB/s   00:15'
State = copying, Before = 'mktemp-oJRSzd-2
  84% 4344KB  45.6KB/s   00:17'
State = copying, Before = 'mktemp-oJRSzd-2
  86% 4440KB  50.7KB/s   00:13'
State = copying, Before = 'mktemp-oJRSzd-2
  88% 4548KB  56.4KB/s   00:10'
State = copying, Before = 'mktemp-oJRSzd-2
  88% 4548KB  50.8KB/s   00:11'
State = copying, Before = 'mktemp-oJRSzd-2
  90% 4640KB  54.9KB/s   00:08'
State = copying, Before = 'mktemp-oJRSzd-2
  90% 4640KB  49.4KB/s   00:09'
State = copying, Before = 'mktemp-oJRSzd-2
  92% 4728KB  53.3KB/s   00:07'
State = copying, Before = 'mktemp-oJRSzd-2
  92% 4728KB  47.9KB/s   00:08'
State = copying, Before = 'mktemp-oJRSzd-2
  94% 4824KB  52.7KB/s   00:05'
State = copying, Before = 'mktemp-oJRSzd-2
  95% 4920KB  57.1KB/s   00:03'
State = copying, Before = 'mktemp-oJRSzd-2
  95% 4920KB  51.4KB/s   00:04'
State = copying, Before = 'mktemp-oJRSzd-2
  97% 5016KB  55.8KB/s   00:01'
State = copying, Before = 'mktemp-oJRSzd-2
  97% 5016KB  50.2KB/s   00:02'
State = copying, Before = 'mktemp-oJRSzd-2
  99% 5112KB  54.8KB/s   00:00'
State = copying, Before = 'mktemp-oJRSzd-2
  99% 5112KB  49.3KB/s   00:00'
State = copying, Before = 'mktemp-oJRSzd-2
 100% 5127KB  54.0KB/s   01:35'
Timeout waiting for response
Running 'scp  
/var/folders/Gj/GjCTMUR8EViYUXcc8HBPR++++TY/-Tmp-/duplicity-xRXL5L-tempdir/mktemp-oJRSzd-2
address@hidden:backup/testb/duplicity-full.2008-06-29T20:29:17-07:00.vol1.difftar.gpg'
failed (attempt #5)
Giving up trying to execute 'scp
/var/folders/Gj/GjCTMUR8EViYUXcc8HBPR++++TY/-Tmp-/duplicity-xRXL5L-tempdir/mktemp-oJRSzd-2
address@hidden:backup/testb/duplicity-full.2008-06-29T20:29:17-07:00.vol1.difftar.gpg'
after 5 attempts
Traceback (most recent call last):
 File "/opt/local/bin/duplicity", line 463, in <module>
   with_tempdir(main)
 File "/opt/local/bin/duplicity", line 458, in with_tempdir
   fn()
 File "/opt/local/bin/duplicity", line 449, in main
   full_backup(col_stats)
 File "/opt/local/bin/duplicity", line 155, in full_backup
   bytes_written = write_multivol("full", tarblock_iter, globals.backend)
 File "/opt/local/bin/duplicity", line 99, in write_multivol
   backend.put(tdp, dest_filename)
 File "/opt/local/lib/python2.5/site-packages/duplicity/backends.py",
line 481, in put
   self.run_scp_command(commandline)
 File "/opt/local/lib/python2.5/site-packages/duplicity/backends.py",
line 424, in run_scp_command
   raise BackendException("Error running '%s'" % commandline)
duplicity.backends.BackendException: Error running 'scp
/var/folders/Gj/GjCTMUR8EViYUXcc8HBPR++++TY/-Tmp-/duplicity-xRXL5L-tempdir/mktemp-oJRSzd-2
address@hidden:backup/testb/duplicity-full.2008-06-29T20:29:17-07:00.vol1.difftar.gpg'

************
~$ duplicity --volsize 1 -v9
/Users/pascal/Documents/MyDocuments/References/Business\ Analysis
ssh://address@hidden/backup/testb
Main action: inc
Running 'sftp  address@hidden' (attempt #1)
State = sftp, Before = 'Connecting to alice.dynalias.org...'
sftp command: 'mkdir backup/testb'
State = sftp, Before = 'mkdir backup/testb
Couldn't create directory: Failure'
sftp command: 'cd backup/testb'
State = sftp, Before = 'cd backup/testb'
sftp command: 'ls -1'
State = sftp, Before = 'ls -1'
State = sftp, Before = 'quit'
0 files exist on backend
Extracting backup chains from list of files: []
Collection Status
-----------------
Connecting with backend: sshBackend
Archive dir: None

Found 0 backup chains without signatures.
No backup chains with active signatures found
No orphaned or incomplete backup sets found.
Last full backup date: none
PASSPHRASE variable not set, asking user.
GnuPG passphrase:
Retype to confirm:
No signatures found, switching to full backup.
Using temporary directory
/var/folders/Gj/GjCTMUR8EViYUXcc8HBPR++++TY/-Tmp-/duplicity-iy6VPW-tempdir
Registering (mktemp) temporary file
/var/folders/Gj/GjCTMUR8EViYUXcc8HBPR++++TY/-Tmp-/duplicity-iy6VPW-tempdir/mktemp-BrBLsj-1
Registering (mktemp) temporary file
/var/folders/Gj/GjCTMUR8EViYUXcc8HBPR++++TY/-Tmp-/duplicity-iy6VPW-tempdir/mktemp-_20M5d-2
Selecting /Users/pascal/Documents/MyDocuments/References/Business Analysis
Comparing () and None
Getting delta of (()
/Users/pascal/Documents/MyDocuments/References/Business Analysis dir)
and None
Generating delta - new file: .
Selecting /Users/pascal/Documents/MyDocuments/References/Business
Analysis/.DS_Store
Comparing ('.DS_Store',) and None
Getting delta of (('.DS_Store',)
/Users/pascal/Documents/MyDocuments/References/Business
Analysis/.DS_Store reg) and None
Generating delta - new file: .DS_Store
Selecting /Users/pascal/Documents/MyDocuments/References/Business
Analysis/BA Update Presentation May05.ppt
Comparing ('BA Update Presentation May05.ppt',) and None
Getting delta of (('BA Update Presentation May05.ppt',)
/Users/pascal/Documents/MyDocuments/References/Business Analysis/BA
Update Presentation May05.ppt reg) and None
Generating delta - new file: BA Update Presentation May05.ppt
Running 'scp  
/var/folders/Gj/GjCTMUR8EViYUXcc8HBPR++++TY/-Tmp-/duplicity-iy6VPW-tempdir/mktemp-_20M5d-2
address@hidden:backup/testb/duplicity-full.2008-06-29T20:57:09-07:00.vol1.difftar.gpg'
(attempt #1)
State = copying, Before = 'mktemp-_20M5d-2
   0%    0     0.0KB/s   --:--'
State = copying, Before = 'mktemp-_20M5d-2
 100% 1011KB   1.0MB/s   00:00'
Timeout waiting for response
Running 'scp  
/var/folders/Gj/GjCTMUR8EViYUXcc8HBPR++++TY/-Tmp-/duplicity-iy6VPW-tempdir/mktemp-_20M5d-2
address@hidden:backup/testb/duplicity-full.2008-06-29T20:57:09-07:00.vol1.difftar.gpg'
failed (attempt #1)
Running 'scp  
/var/folders/Gj/GjCTMUR8EViYUXcc8HBPR++++TY/-Tmp-/duplicity-iy6VPW-tempdir/mktemp-_20M5d-2
address@hidden:backup/testb/duplicity-full.2008-06-29T20:57:09-07:00.vol1.difftar.gpg'
(attempt #2)
State = copying, Before = 'mktemp-_20M5d-2
   0%    0     0.0KB/s   --:--'
State = copying, Before = 'mktemp-_20M5d-2
 100% 1011KB   1.0MB/s   00:00'
Deleting 
/var/folders/Gj/GjCTMUR8EViYUXcc8HBPR++++TY/-Tmp-/duplicity-iy6VPW-tempdir/mktemp-_20M5d-2
Forgetting temporary file
/var/folders/Gj/GjCTMUR8EViYUXcc8HBPR++++TY/-Tmp-/duplicity-iy6VPW-tempdir/mktemp-_20M5d-2
Registering (mktemp) temporary file
/var/folders/Gj/GjCTMUR8EViYUXcc8HBPR++++TY/-Tmp-/duplicity-iy6VPW-tempdir/mktemp-peIryP-3
Selecting /Users/pascal/Documents/MyDocuments/References/Business Analysis/BPMN
Comparing ('BPMN',) and None
Getting delta of (('BPMN',)
/Users/pascal/Documents/MyDocuments/References/Business Analysis/BPMN
dir) and None
Generating delta - new file: BPMN
Selecting /Users/pascal/Documents/MyDocuments/References/Business
Analysis/BPMN/BPMN 0-9-V2003.vss
Comparing ('BPMN', 'BPMN 0-9-V2003.vss') and None
Getting delta of (('BPMN', 'BPMN 0-9-V2003.vss')
/Users/pascal/Documents/MyDocuments/References/Business
Analysis/BPMN/BPMN 0-9-V2003.vss reg) and None
Generating delta - new file: BPMN/BPMN 0-9-V2003.vss
Selecting /Users/pascal/Documents/MyDocuments/References/Business
Analysis/BPMN/BPMN V1-0 May 3 2004.pdf
Comparing ('BPMN', 'BPMN V1-0 May 3 2004.pdf') and None
Getting delta of (('BPMN', 'BPMN V1-0 May 3 2004.pdf')
/Users/pascal/Documents/MyDocuments/References/Business
Analysis/BPMN/BPMN V1-0 May 3 2004.pdf reg) and None
Generating delta - new file: BPMN/BPMN V1-0 May 3 2004.pdf
Running 'scp  
/var/folders/Gj/GjCTMUR8EViYUXcc8HBPR++++TY/-Tmp-/duplicity-iy6VPW-tempdir/mktemp-peIryP-3
address@hidden:backup/testb/duplicity-full.2008-06-29T20:57:09-07:00.vol2.difftar.gpg'
(attempt #1)
State = copying, Before = 'mktemp-peIryP-3
   0%    0     0.0KB/s   --:--'
State = copying, Before = 'mktemp-peIryP-3
 100% 1009KB   1.0MB/s   00:00'
Timeout waiting for response
Running 'scp  
/var/folders/Gj/GjCTMUR8EViYUXcc8HBPR++++TY/-Tmp-/duplicity-iy6VPW-tempdir/mktemp-peIryP-3
address@hidden:backup/testb/duplicity-full.2008-06-29T20:57:09-07:00.vol2.difftar.gpg'
failed (attempt #1)
Running 'scp  
/var/folders/Gj/GjCTMUR8EViYUXcc8HBPR++++TY/-Tmp-/duplicity-iy6VPW-tempdir/mktemp-peIryP-3
address@hidden:backup/testb/duplicity-full.2008-06-29T20:57:09-07:00.vol2.difftar.gpg'
(attempt #2)
State = copying, Before = 'mktemp-peIryP-3
   0%    0     0.0KB/s   --:--'
State = copying, Before = 'mktemp-peIryP-3
 100% 1009KB   1.0MB/s   00:00'
Deleting 
/var/folders/Gj/GjCTMUR8EViYUXcc8HBPR++++TY/-Tmp-/duplicity-iy6VPW-tempdir/mktemp-peIryP-3
Forgetting temporary file
/var/folders/Gj/GjCTMUR8EViYUXcc8HBPR++++TY/-Tmp-/duplicity-iy6VPW-tempdir/mktemp-peIryP-3
Registering (mktemp) temporary file
/var/folders/Gj/GjCTMUR8EViYUXcc8HBPR++++TY/-Tmp-/duplicity-iy6VPW-tempdir/mktemp-i6pZQ--4
Running 'scp  
/var/folders/Gj/GjCTMUR8EViYUXcc8HBPR++++TY/-Tmp-/duplicity-iy6VPW-tempdir/mktemp-i6pZQ--4
address@hidden:backup/testb/duplicity-full.2008-06-29T20:57:09-07:00.vol3.difftar.gpg'
(attempt #1)
State = copying, Before = 'mktemp-i6pZQ--4
   0%    0     0.0KB/s   --:--'
State = copying, Before = 'mktemp-i6pZQ--4
 100% 1008KB   1.0MB/s   00:00'
Timeout waiting for response
Running 'scp  
/var/folders/Gj/GjCTMUR8EViYUXcc8HBPR++++TY/-Tmp-/duplicity-iy6VPW-tempdir/mktemp-i6pZQ--4
address@hidden:backup/testb/duplicity-full.2008-06-29T20:57:09-07:00.vol3.difftar.gpg'
failed (attempt #1)
Running 'scp  
/var/folders/Gj/GjCTMUR8EViYUXcc8HBPR++++TY/-Tmp-/duplicity-iy6VPW-tempdir/mktemp-i6pZQ--4
address@hidden:backup/testb/duplicity-full.2008-06-29T20:57:09-07:00.vol3.difftar.gpg'
(attempt #2)
State = copying, Before = 'mktemp-i6pZQ--4
   0%    0     0.0KB/s   --:--'
State = copying, Before = 'mktemp-i6pZQ--4
 100% 1008KB   1.0MB/s   00:00'
Timeout waiting for response
Running 'scp  
/var/folders/Gj/GjCTMUR8EViYUXcc8HBPR++++TY/-Tmp-/duplicity-iy6VPW-tempdir/mktemp-i6pZQ--4
address@hidden:backup/testb/duplicity-full.2008-06-29T20:57:09-07:00.vol3.difftar.gpg'
failed (attempt #2)
Running 'scp  
/var/folders/Gj/GjCTMUR8EViYUXcc8HBPR++++TY/-Tmp-/duplicity-iy6VPW-tempdir/mktemp-i6pZQ--4
address@hidden:backup/testb/duplicity-full.2008-06-29T20:57:09-07:00.vol3.difftar.gpg'
(attempt #3)
State = copying, Before = 'mktemp-i6pZQ--4
   0%    0     0.0KB/s   --:--'
State = copying, Before = 'mktemp-i6pZQ--4
 100% 1008KB   1.0MB/s   00:00'
Timeout waiting for response
Running 'scp  
/var/folders/Gj/GjCTMUR8EViYUXcc8HBPR++++TY/-Tmp-/duplicity-iy6VPW-tempdir/mktemp-i6pZQ--4
address@hidden:backup/testb/duplicity-full.2008-06-29T20:57:09-07:00.vol3.difftar.gpg'
failed (attempt #3)
Running 'scp  
/var/folders/Gj/GjCTMUR8EViYUXcc8HBPR++++TY/-Tmp-/duplicity-iy6VPW-tempdir/mktemp-i6pZQ--4
address@hidden:backup/testb/duplicity-full.2008-06-29T20:57:09-07:00.vol3.difftar.gpg'
(attempt #4)
State = copying, Before = 'mktemp-i6pZQ--4
   0%    0     0.0KB/s   --:--'
State = copying, Before = 'mktemp-i6pZQ--4
 100% 1008KB   1.0MB/s   00:00'
Timeout waiting for response
Running 'scp  
/var/folders/Gj/GjCTMUR8EViYUXcc8HBPR++++TY/-Tmp-/duplicity-iy6VPW-tempdir/mktemp-i6pZQ--4
address@hidden:backup/testb/duplicity-full.2008-06-29T20:57:09-07:00.vol3.difftar.gpg'
failed (attempt #4)
Running 'scp  
/var/folders/Gj/GjCTMUR8EViYUXcc8HBPR++++TY/-Tmp-/duplicity-iy6VPW-tempdir/mktemp-i6pZQ--4
address@hidden:backup/testb/duplicity-full.2008-06-29T20:57:09-07:00.vol3.difftar.gpg'
(attempt #5)
State = copying, Before = 'mktemp-i6pZQ--4
   0%    0     0.0KB/s   --:--'
State = copying, Before = 'mktemp-i6pZQ--4
 100% 1008KB   1.0MB/s   00:00'
Timeout waiting for response
Running 'scp  
/var/folders/Gj/GjCTMUR8EViYUXcc8HBPR++++TY/-Tmp-/duplicity-iy6VPW-tempdir/mktemp-i6pZQ--4
address@hidden:backup/testb/duplicity-full.2008-06-29T20:57:09-07:00.vol3.difftar.gpg'
failed (attempt #5)
Giving up trying to execute 'scp
/var/folders/Gj/GjCTMUR8EViYUXcc8HBPR++++TY/-Tmp-/duplicity-iy6VPW-tempdir/mktemp-i6pZQ--4
address@hidden:backup/testb/duplicity-full.2008-06-29T20:57:09-07:00.vol3.difftar.gpg'
after 5 attempts
Traceback (most recent call last):
 File "/opt/local/bin/duplicity", line 463, in <module>
   with_tempdir(main)
 File "/opt/local/bin/duplicity", line 458, in with_tempdir
   fn()
 File "/opt/local/bin/duplicity", line 449, in main
   full_backup(col_stats)
 File "/opt/local/bin/duplicity", line 155, in full_backup
   bytes_written = write_multivol("full", tarblock_iter, globals.backend)
 File "/opt/local/bin/duplicity", line 99, in write_multivol
   backend.put(tdp, dest_filename)
 File "/opt/local/lib/python2.5/site-packages/duplicity/backends.py",
line 481, in put
   self.run_scp_command(commandline)
 File "/opt/local/lib/python2.5/site-packages/duplicity/backends.py",
line 424, in run_scp_command
   raise BackendException("Error running '%s'" % commandline)
duplicity.backends.BackendException: Error running 'scp
/var/folders/Gj/GjCTMUR8EViYUXcc8HBPR++++TY/-Tmp-/duplicity-iy6VPW-tempdir/mktemp-i6pZQ--4
address@hidden:backup/testb/duplicity-full.2008-06-29T20:57:09-07:00.vol3.difftar.gpg'
[Prev in Thread]
Current Thread
[Next in Thread]
[Duplicity-talk] Duplicity Timeout Error, Pascal Schaedeli <=
Prev by Date: Re: [Duplicity-talk] how much metadata does duplicity store between runs
Previous by thread: [Duplicity-talk] how much metadata does duplicity store between runs
Index(es):
- Date
- Thread