[Duplicity-talk] duplicity 0.7.02, freebsd and sftp backend -- how to further debug.

[Dirk-Willem van Gulik]

------------ ------------ ------------ ------------ ------------ ——————

On a (new) 0.7.02 upgrade/install; which works fine with a file:/// backend to 
/tmp as a test — we’re finding that it hangs ‘forever’ on ‘sftp’.

sftp itself works fine; and when we place a few files there - we can see in the 
output that they are nicely seen; and ignored (as is the .ssh directory with 
the right authorized_keys magic).

Below is the command used and the output. Any suggestion as to where/how to 
start debugging this ?

The main change with prior version/use is a sharply increased volume and going 
to version 0.7.02 (as python needed to be upgraded).

Thanks,

Dw.

# duplicity --version
duplicity 0.7.02

# cat backup.sh

#!/bin/sh
unset SSH_AUTH_SOCK
export GNUPGHOME=/XXXXXXX
export PASSPHRASE=""
export SIGN_PASSPHRASE=“”

# Removed: --gpg-options "--yes --lock-never --no-random-seed-file  
--no-greeting --no-secmem-warning --no-auto-check-trustd -q " 

/usr/local/bin/duplicity \
        --ssh-options "-oIdentityFile=XXXXX  \
        --archive-dir /var/db/duplicity \
        --hidden-encrypt-key XXX \
        --hidden-encrypt-key XXX \
        --hidden-encrypt-key XXX \
        --sign-key XXX \
        --include /XXX \
        ..snipped directories XXXXX ...
        --exclude '**' \
        / sftp://address@hidden




# sh backup.sh 
Using archive dir: /var/db/duplicity/be3234cf4cbafbdf41099030093b6bbe
Using backup name: be3234cf4cbafbdf41099030093b6bbe
Import of duplicity.backends.azurebackend Succeeded
Import of duplicity.backends.botobackend Succeeded
Import of duplicity.backends.cfbackend Succeeded
Import of duplicity.backends.copycombackend Succeeded
Import of duplicity.backends.dpbxbackend Succeeded
Import of duplicity.backends.ftpbackend Succeeded
Import of duplicity.backends.ftpsbackend Succeeded
Import of duplicity.backends.gdocsbackend Succeeded
Import of duplicity.backends.giobackend Succeeded
Import of duplicity.backends.hsibackend Succeeded
Import of duplicity.backends.hubicbackend Succeeded
Import of duplicity.backends.imapbackend Succeeded
Import of duplicity.backends.lftpbackend Failed: the scheme ftp already has a 
backend associated with it
Import of duplicity.backends.localbackend Succeeded
Import of duplicity.backends.megabackend Succeeded
Import of duplicity.backends.ncftpbackend Succeeded
Import of duplicity.backends.onedrivebackend Failed: No module named requests
Import of duplicity.backends.par2backend Succeeded
Import of duplicity.backends.pydrivebackend Succeeded
Import of duplicity.backends.rsyncbackend Succeeded
Import of duplicity.backends.ssh_paramiko_backend Succeeded
Import of duplicity.backends.ssh_pexpect_backend Succeeded
Import of duplicity.backends.sshbackend Failed: 'module' object has no 
attribute 'ssh_backend'
Import of duplicity.backends.swiftbackend Succeeded
Import of duplicity.backends.sxbackend Succeeded
Import of duplicity.backends.tahoebackend Succeeded
Import of duplicity.backends.webdavbackend Succeeded
Import of duplicity.backends.~par2wrapperbackend Succeeded
ssh: starting thread (client mode): 0x816c750L
ssh: Connected (version 2.0, client mod_sftp/0.9.9)
ssh: kex algos:[u'ecdh-sha2-nistp256', u'ecdh-sha2-nistp384', 
u'ecdh-sha2-nistp521', u'diffie-hellman-group-exchange-sha256', 
u'diffie-hellman-group-exchange-sha1', u'diffie-hellman-group14-sha1', 
u'diffie-hellman-group1-sha1', u'rsa1024-sha1'] server key:[u'ssh-rsa', 
u'ssh-dss'] client encrypt:[u'aes256-ctr', u'aes192-ctr', u'aes128-ctr', 
u'aes256-cbc', u'aes192-cbc', u'aes128-cbc', u'blowfish-ctr', u'blowfish-cbc', 
u'cast128-cbc', u'arcfour256', u'arcfour128', u'3des-ctr', u'3des-cbc'] server 
encrypt:[u'aes256-ctr', u'aes192-ctr', u'aes128-ctr', u'aes256-cbc', 
u'aes192-cbc', u'aes128-cbc', u'blowfish-ctr', u'blowfish-cbc', u'cast128-cbc', 
u'arcfour256', u'arcfour128', u'3des-ctr', u'3des-cbc'] client 
mac:[u'hmac-sha2-256', u'hmac-sha2-512', u'hmac-sha1', u'hmac-sha1-96', 
u'hmac-md5', u'hmac-md5-96', u'hmac-ripemd160', u'address@hidden'] server 
mac:[u'hmac-sha2-256', u'hmac-sha2-512', u'hmac-sha1', u'hmac-sha1-96', 
u'hmac-md5', u'hmac-md5-96', u'hmac-ripemd160', u'address@hidden'] client 
compress:[u'none'] server compress:[u'none'] client lang:[u''] server 
lang:[u''] kex follows?False
ssh: Ciphers agreed: local=aes128-ctr, remote=aes128-ctr
ssh: using kex diffie-hellman-group1-sha1; server key type ssh-rsa; cipher: 
local aes128-ctr, remote aes128-ctr; mac: local hmac-sha1, remote hmac-sha1; 
compression: local none, remote none
ssh: Switch to new keys ...
ssh: Trying key ef4214c5fdba6d3c519c737ed1bf6358 from XXXXX
ssh: userauth is OK
ssh: Authentication (publickey) successful!
ssh: [chan 1] Max packet in: 34816 bytes
ssh: [chan 1] Max packet out: 0 bytes
ssh: Secsh channel 1 opened.
ssh: [chan 1] Sesch channel 1 request ok
ssh: [chan 1] Opened sftp connection (server version 3)
ssh: [chan 1] stat('.')
ssh: [chan 1] stat('.')
ssh: [chan 1] normalize('.')
Main action: inc
================================================================================
duplicity 0.7.02 (March 11, 2015)
Args: /usr/local/bin/duplicity --verbosity debug --ssh-options 
-oIdentityFile=XXXXX --archive-dir /var/db/duplicity --hidden-encrypt-key XXX 
--hidden-encrypt-key XXX --hidden-encrypt-key XXXX --sign-key XXX --include 
/XXX XXXXXX  --exclude ** / sftp://address@hidden
FreeBSD XXXXXXX 10.1-RELEASE-p9 FreeBSD 10.1-RELEASE-p9 #0: Tue Apr  7 01:09:46 
UTC 2015     address@hidden:/usr/obj/usr/src/sys/GENERIC amd64 amd64
/usr/local/bin/python 2.7.9 (default, Apr  8 2015, 15:12:41) 
[GCC 4.2.1 Compatible FreeBSD Clang 3.4.1 (tags/RELEASE_34/dot1-final 208032)]
================================================================================
Using temporary directory /tmp/duplicity-MSIr4U-tempdir
Registering (mkstemp) temporary file 
/tmp/duplicity-MSIr4U-tempdir/mkstemp-xUwUpW-1
Temp has 13190230286848 available, backup will use approx 34078720.
ssh: [chan 1] listdir('/.')
Local and Remote metadata are synchronized, no sync needed.
ssh: [chan 1] listdir('/.')
1 file exists on backend
4 files exist in cache
Extracting backup chains from list of files: 
[u'duplicity-full-signatures.20150502T140646Z.sigtar.part', 
u'duplicity-full.20150502T140646Z.manifest.part', u'.ssh']
File duplicity-full-signatures.20150502T140646Z.sigtar.part is not part of a 
known set; creating new set
Ignoring file (rejected by backup set) 
'duplicity-full-signatures.20150502T140646Z.sigtar.part'
File duplicity-full.20150502T140646Z.manifest.part is not part of a known set; 
creating new set
File .ssh is not part of a known set; creating new set
Ignoring file (rejected by backup set) '.ssh'
Found backup chain [Sat May  2 16:06:46 2015]-[Sat May  2 16:06:46 2015]
Last full backup left a partial set, restarting.
Last full backup date: Sat May  2 16:06:46 2015
Collection Status
-----------------
Connecting with backend: BackendWrapper
Archive dir: /var/db/duplicity/be3234cf4cbafbdf41099030093b6bbe

Found 0 secondary backup chains.

Found primary backup chain with matching signature chain:
-------------------------
Chain start time: Sat May  2 16:06:46 2015
Chain end time: Sat May  2 16:06:46 2015
Number of contained backup sets: 1
Total number of contained volumes: 0
 Type of backup set:                            Time:      Num volumes:
-------------------------
No orphaned or incomplete backup sets found.
RESTART: The first volume failed to upload before termination.
         Restart is impossible...starting backup from beginning.
Deleting 
/var/db/duplicity/be3234cf4cbafbdf41099030093b6bbe/duplicity-full-signatures.20150502T140646Z.sigtar.part
Deleting 
/var/db/duplicity/be3234cf4cbafbdf41099030093b6bbe/duplicity-full.20150502T140646Z.manifest.part
Releasing lockfile <LinkLockFile: 
'/var/db/duplicity/be3234cf4cbafbdf41099030093b6bbe/XXXXXX.650626177224228893873130'
 -- '/var/db/duplicity/be3234cf4cbafbdf41099030093b6bbe/lockfile'>
Using archive dir: /var/db/duplicity/be3234cf4cbafbdf41099030093b6bbe
Using backup name: be3234cf4cbafbdf41099030093b6bbe
Import of duplicity.backends.azurebackend Succeeded
Import of duplicity.backends.botobackend Succeeded
Import of duplicity.backends.cfbackend Succeeded
Import of duplicity.backends.copycombackend Succeeded
Import of duplicity.backends.dpbxbackend Succeeded
Import of duplicity.backends.ftpbackend Succeeded
Import of duplicity.backends.ftpsbackend Succeeded
Import of duplicity.backends.gdocsbackend Succeeded
Import of duplicity.backends.giobackend Succeeded
Import of duplicity.backends.hsibackend Succeeded
Import of duplicity.backends.hubicbackend Succeeded
Import of duplicity.backends.imapbackend Succeeded
Import of duplicity.backends.lftpbackend Failed: the scheme ftp already has a 
backend associated with it
Import of duplicity.backends.localbackend Succeeded
Import of duplicity.backends.megabackend Succeeded
Import of duplicity.backends.ncftpbackend Succeeded
Import of duplicity.backends.onedrivebackend Failed: No module named requests
Import of duplicity.backends.par2backend Succeeded
Import of duplicity.backends.pydrivebackend Succeeded
Import of duplicity.backends.rsyncbackend Succeeded
Import of duplicity.backends.ssh_paramiko_backend Succeeded
Import of duplicity.backends.ssh_pexpect_backend Succeeded
Import of duplicity.backends.sshbackend Failed: 'module' object has no 
attribute 'ssh_backend'
Import of duplicity.backends.swiftbackend Succeeded
Import of duplicity.backends.sxbackend Succeeded
Import of duplicity.backends.tahoebackend Succeeded
Import of duplicity.backends.webdavbackend Succeeded
Import of duplicity.backends.~par2wrapperbackend Succeeded
ssh: starting thread (client mode): 0x816c750L
ssh: Connected (version 2.0, client mod_sftp/0.9.9)
ssh: kex algos:[u'ecdh-sha2-nistp256', u'ecdh-sha2-nistp384', 
u'ecdh-sha2-nistp521', u'diffie-hellman-group-exchange-sha256', 
u'diffie-hellman-group-exchange-sha1', u'diffie-hellman-group14-sha1', 
u'diffie-hellman-group1-sha1', u'rsa1024-sha1'] server key:[u'ssh-rsa', 
u'ssh-dss'] client encrypt:[u'aes256-ctr', u'aes192-ctr', u'aes128-ctr', 
u'aes256-cbc', u'aes192-cbc', u'aes128-cbc', u'blowfish-ctr', u'blowfish-cbc', 
u'cast128-cbc', u'arcfour256', u'arcfour128', u'3des-ctr', u'3des-cbc'] server 
encrypt:[u'aes256-ctr', u'aes192-ctr', u'aes128-ctr', u'aes256-cbc', 
u'aes192-cbc', u'aes128-cbc', u'blowfish-ctr', u'blowfish-cbc', u'cast128-cbc', 
u'arcfour256', u'arcfour128', u'3des-ctr', u'3des-cbc'] client 
mac:[u'hmac-sha2-256', u'hmac-sha2-512', u'hmac-sha1', u'hmac-sha1-96', 
u'hmac-md5', u'hmac-md5-96', u'hmac-ripemd160', u'address@hidden'] server 
mac:[u'hmac-sha2-256', u'hmac-sha2-512', u'hmac-sha1', u'hmac-sha1-96', 
u'hmac-md5', u'hmac-md5-96', u'hmac-ripemd160', u'address@hidden'] client 
compress:[u'none'] server compress:[u'none'] client lang:[u''] server 
lang:[u''] kex follows?False
ssh: Ciphers agreed: local=aes128-ctr, remote=aes128-ctr
ssh: using kex diffie-hellman-group1-sha1; server key type ssh-rsa; cipher: 
local aes128-ctr, remote aes128-ctr; mac: local hmac-sha1, remote hmac-sha1; 
compression: local none, remote none
ssh: Switch to new keys ...
ssh: Trying key ef4214c5fdba6d3c519c737ed1bf6358 from /XXXXX
ssh: userauth is OK
ssh: Authentication (publickey) successful!
ssh: [chan 1] Max packet in: 34816 bytes
ssh: [chan 1] Max packet out: 0 bytes
ssh: Secsh channel 1 opened.
ssh: [chan 1] Sesch channel 1 request ok
ssh: [chan 1] Opened sftp connection (server version 3)
ssh: [chan 1] stat('.')
ssh: [chan 1] stat('.')
ssh: [chan 1] normalize('.')
Main action: inc
================================================================================
duplicity 0.7.02 (March 11, 2015)
Args: /usr/local/bin/duplicity --verbosity debug --ssh-options 
-oIdentityFile=//XXXX --archive-dir /var/db/duplicity --hidden-encrypt-key XXXX 
--hidden-encrypt-key XXX --hidden-encrypt-key XXX --sign-key XXXX --include 
/XXX XXXXXX-exclude ** / sftp://address@hidden
FreeBSD XXXXXX 10.1-RELEASE-p9 FreeBSD 10.1-RELEASE-p9 #0: Tue Apr  7 01:09:46 
UTC 2015     address@hidden:/usr/obj/usr/src/sys/GENERIC amd64 amd64
/usr/local/bin/python 2.7.9 (default, Apr  8 2015, 15:12:41) 
[GCC 4.2.1 Compatible FreeBSD Clang 3.4.1 (tags/RELEASE_34/dot1-final 208032)]
================================================================================
Using temporary directory /tmp/duplicity-ny_w0E-tempdir
Registering (mkstemp) temporary file 
/tmp/duplicity-ny_w0E-tempdir/mkstemp-hiD03y-1
Temp has 13190230286848 available, backup will use approx 34078720.
ssh: [chan 1] listdir('/.')
Local and Remote metadata are synchronized, no sync needed.
ssh: [chan 1] listdir('/.')
1 file exists on backend
2 files exist in cache
Extracting backup chains from list of files: [u'.ssh']
File .ssh is not part of a known set; creating new set
Ignoring file (rejected by backup set) '.ssh'
Last full backup date: none
Collection Status
-----------------
Connecting with backend: BackendWrapper
Archive dir: /var/db/duplicity/be3234cf4cbafbdf41099030093b6bbe

Found 0 secondary backup chains.
No backup chains with active signatures found
No orphaned or incomplete backup sets found.
No signatures found, switching to full backup.
Using temporary directory 
/var/db/duplicity/be3234cf4cbafbdf41099030093b6bbe/duplicity-uGRFgC-tempdir
Registering (mktemp) temporary file 
/var/db/duplicity/be3234cf4cbafbdf41099030093b6bbe/duplicity-uGRFgC-tempdir/mktemp-v8RrI4-1
Using temporary directory 
/var/db/duplicity/be3234cf4cbafbdf41099030093b6bbe/duplicity-Ek5eEY-tempdir
Registering (mktemp) temporary file 
/var/db/duplicity/be3234cf4cbafbdf41099030093b6bbe/duplicity-Ek5eEY-tempdir/mktemp-gWTVYe-1
AsyncScheduler: instantiating at concurrency 0
Registering (mktemp) temporary file 
/tmp/duplicity-ny_w0E-tempdir/mktemp-cOWPt7-2
Selecting /
Comparing . and None
Getting delta of (. dir) and None
A .
Selecting /XXXX
Comparing XXXX and None
Getting delta of (XXX dir) and None
A XXX

…. some 350k lines snipped ….

Removing still remembered temporary file 
/var/db/duplicity/be3234cf4cbafbdf41099030093b6bbe/duplicity-uGRFgC-tempdir/mktemp-v8RrI4-1
Removing still remembered temporary file 
/var/db/duplicity/be3234cf4cbafbdf41099030093b6bbe/duplicity-Ek5eEY-tempdir/mktemp-gWTVYe-1
AsyncScheduler: running task synchronously (asynchronicity disabled)
Writing duplicity-full.20150503T112752Z.vol1.difftar.gpg
ssh: [chan 1] open('/duplicity-full.20150503T112752Z.vol1.difftar.gpg', 'wb')
ssh: [chan 1] open('/duplicity-full.20150503T112752Z.vol1.difftar.gpg', 'wb') 
-> 61623031376465316137393162356235
ssh: Sending global request "address@hidden"
ssh: Sending global request "address@hidden"
ssh: Sending global request "address@hidden"
ssh: Sending global request "address@hidden
… repeated few 100 times ...
ssh: Sending global request "address@hidden"
ssh: Sending global request "address@hidden"
ssh: Sending global request "address@hidden"
ssh: Disconnect (code 11): data stalled timeout reached
ssh: [chan 1] close(61623031376465316137393162356235)
Backtrace of previous error: Traceback (innermost last):
  File "/usr/local/lib/python2.7/site-packages/duplicity/backend.py", line 365, 
in inner_retry
    return fn(self, *args)
  File "/usr/local/lib/python2.7/site-packages/duplicity/backend.py", line 515, 
in put
    self.__do_put(source_path, remote_filename)
  File "/usr/local/lib/python2.7/site-packages/duplicity/backend.py", line 501, 
in __do_put
    self.backend._put(source_path, remote_filename)
  File 
"/usr/local/lib/python2.7/site-packages/duplicity/backends/ssh_paramiko_backend.py",
 line 288, in _put
    self.sftp.put(source_path.name, remote_filename)
  File "/usr/local/lib/python2.7/site-packages/paramiko/sftp_client.py", line 
587, in put
    return self.putfo(fl, remotepath, os.stat(localpath).st_size, callback, 
confirm)
  File "/usr/local/lib/python2.7/site-packages/paramiko/sftp_client.py", line 
546, in putfo
    fr.write(data)
  File "/usr/local/lib/python2.7/site-packages/paramiko/file.py", line 330, in 
write
    self._write_all(data)
  File "/usr/local/lib/python2.7/site-packages/paramiko/file.py", line 447, in 
_write_all
    count = self._write(data)
  File "/usr/local/lib/python2.7/site-packages/paramiko/sftp_file.py", line 
176, in _write
    self._reqs.append(self.sftp._async_request(type(None), CMD_WRITE, 
self.handle, long(self._realpos), data[:chunk]))
  File "/usr/local/lib/python2.7/site-packages/paramiko/sftp_client.py", line 
670, in _async_request
    self._send_packet(t, msg)
  File "/usr/local/lib/python2.7/site-packages/paramiko/sftp.py", line 170, in 
_send_packet
    self._write_all(out)
  File "/usr/local/lib/python2.7/site-packages/paramiko/sftp.py", line 135, in 
_write_all
    raise EOFError()
 EOFError

Attempt 1 failed. EOFError: 
Writing duplicity-full.20150503T112752Z.vol1.difftar.gpg
ssh: [chan 1] open('/duplicity-full.20150503T112752Z.vol1.difftar.gpg', 'wb')
Backtrace of previous error: Traceback (innermost last):
  File "/usr/local/lib/python2.7/site-packages/duplicity/backend.py", line 365, 
in inner_retry
    return fn(self, *args)
  File "/usr/local/lib/python2.7/site-packages/duplicity/backend.py", line 515, 
in put
    self.__do_put(source_path, remote_filename)
  File "/usr/local/lib/python2.7/site-packages/duplicity/backend.py", line 501, 
in __do_put
    self.backend._put(source_path, remote_filename)
  File 
"/usr/local/lib/python2.7/site-packages/duplicity/backends/ssh_paramiko_backend.py",
 line 288, in _put
    self.sftp.put(source_path.name, remote_filename)
  File "/usr/local/lib/python2.7/site-packages/paramiko/sftp_client.py", line 
587, in put
    return self.putfo(fl, remotepath, os.stat(localpath).st_size, callback, 
confirm)
  File "/usr/local/lib/python2.7/site-packages/paramiko/sftp_client.py", line 
541, in putfo
    with self.file(remotepath, 'wb') as fr:
  File "/usr/local/lib/python2.7/site-packages/paramiko/sftp_client.py", line 
245, in open
    t, msg = self._request(CMD_OPEN, filename, imode, attrblock)
  File "/usr/local/lib/python2.7/site-packages/paramiko/sftp_client.py", line 
648, in _request
    num = self._async_request(type(None), t, *arg)
  File "/usr/local/lib/python2.7/site-packages/paramiko/sftp_client.py", line 
670, in _async_request
    self._send_packet(t, msg)
  File "/usr/local/lib/python2.7/site-packages/paramiko/sftp.py", line 170, in 
_send_packet
    self._write_all(out)
  File "/usr/local/lib/python2.7/site-packages/paramiko/sftp.py", line 135, in 
_write_all
    raise EOFError()
 EOFError

Attempt 2 failed. EOFError: 
Writing duplicity-full.20150503T112752Z.vol1.difftar.gpg
ssh: [chan 1] open('/duplicity-full.20150503T112752Z.vol1.difftar.gpg', 'wb')
Backtrace of previous error: Traceback (innermost last):
  File "/usr/local/lib/python2.7/site-packages/duplicity/backend.py", line 365, 
in inner_retry
    return fn(self, *args)
  File "/usr/local/lib/python2.7/site-packages/duplicity/backend.py", line 515, 
in put
    self.__do_put(source_path, remote_filename)
  File "/usr/local/lib/python2.7/site-packages/duplicity/backend.py", line 501, 
in __do_put
    self.backend._put(source_path, remote_filename)
  File 
"/usr/local/lib/python2.7/site-packages/duplicity/backends/ssh_paramiko_backend.py",
 line 288, in _put
    self.sftp.put(source_path.name, remote_filename)
  File "/usr/local/lib/python2.7/site-packages/paramiko/sftp_client.py", line 
587, in put
    return self.putfo(fl, remotepath, os.stat(localpath).st_size, callback, 
confirm)
  File "/usr/local/lib/python2.7/site-packages/paramiko/sftp_client.py", line 
541, in putfo
    with self.file(remotepath, 'wb') as fr:
  File "/usr/local/lib/python2.7/site-packages/paramiko/sftp_client.py", line 
245, in open
    t, msg = self._request(CMD_OPEN, filename, imode, attrblock)
  File "/usr/local/lib/python2.7/site-packages/paramiko/sftp_client.py", line 
648, in _request
    num = self._async_request(type(None), t, *arg)
  File "/usr/local/lib/python2.7/site-packages/paramiko/sftp_client.py", line 
670, in _async_request
    self._send_packet(t, msg)
  File "/usr/local/lib/python2.7/site-packages/paramiko/sftp.py", line 170, in 
_send_packet
    self._write_all(out)
  File "/usr/local/lib/python2.7/site-packages/paramiko/sftp.py", line 135, in 
_write_all
    raise EOFError()
 EOFError

Attempt 3 failed. EOFError: 
Writing duplicity-full.20150503T112752Z.vol1.difftar.gpg
ssh: [chan 1] open('/duplicity-full.20150503T112752Z.vol1.difftar.gpg', 'wb')
Backtrace of previous error: Traceback (innermost last):
  File "/usr/local/lib/python2.7/site-packages/duplicity/backend.py", line 365, 
in inner_retry
    return fn(self, *args)
  File "/usr/local/lib/python2.7/site-packages/duplicity/backend.py", line 515, 
in put
    self.__do_put(source_path, remote_filename)
  File "/usr/local/lib/python2.7/site-packages/duplicity/backend.py", line 501, 
in __do_put
    self.backend._put(source_path, remote_filename)
  File 
"/usr/local/lib/python2.7/site-packages/duplicity/backends/ssh_paramiko_backend.py",
 line 288, in _put
    self.sftp.put(source_path.name, remote_filename)
  File "/usr/local/lib/python2.7/site-packages/paramiko/sftp_client.py", line 
587, in put
    return self.putfo(fl, remotepath, os.stat(localpath).st_size, callback, 
confirm)
  File "/usr/local/lib/python2.7/site-packages/paramiko/sftp_client.py", line 
541, in putfo
    with self.file(remotepath, 'wb') as fr:
  File "/usr/local/lib/python2.7/site-packages/paramiko/sftp_client.py", line 
245, in open
    t, msg = self._request(CMD_OPEN, filename, imode, attrblock)
  File "/usr/local/lib/python2.7/site-packages/paramiko/sftp_client.py", line 
648, in _request
    num = self._async_request(type(None), t, *arg)
  File "/usr/local/lib/python2.7/site-packages/paramiko/sftp_client.py", line 
670, in _async_request
    self._send_packet(t, msg)
  File "/usr/local/lib/python2.7/site-packages/paramiko/sftp.py", line 170, in 
_send_packet
    self._write_all(out)
  File "/usr/local/lib/python2.7/site-packages/paramiko/sftp.py", line 135, in 
_write_all
    raise EOFError()
 EOFError

Attempt 4 failed. EOFError: 
Writing duplicity-full.20150503T112752Z.vol1.difftar.gpg
ssh: [chan 1] open('/duplicity-full.20150503T112752Z.vol1.difftar.gpg', 'wb')
Backtrace of previous error: Traceback (innermost last):
  File "/usr/local/lib/python2.7/site-packages/duplicity/backend.py", line 365, 
in inner_retry
    return fn(self, *args)
  File "/usr/local/lib/python2.7/site-packages/duplicity/backend.py", line 515, 
in put
    self.__do_put(source_path, remote_filename)
  File "/usr/local/lib/python2.7/site-packages/duplicity/backend.py", line 501, 
in __do_put
    self.backend._put(source_path, remote_filename)
  File 
"/usr/local/lib/python2.7/site-packages/duplicity/backends/ssh_paramiko_backend.py",
 line 288, in _put
    self.sftp.put(source_path.name, remote_filename)
  File "/usr/local/lib/python2.7/site-packages/paramiko/sftp_client.py", line 
587, in put
    return self.putfo(fl, remotepath, os.stat(localpath).st_size, callback, 
confirm)
  File "/usr/local/lib/python2.7/site-packages/paramiko/sftp_client.py", line 
541, in putfo
    with self.file(remotepath, 'wb') as fr:
  File "/usr/local/lib/python2.7/site-packages/paramiko/sftp_client.py", line 
245, in open
    t, msg = self._request(CMD_OPEN, filename, imode, attrblock)
  File "/usr/local/lib/python2.7/site-packages/paramiko/sftp_client.py", line 
648, in _request
    num = self._async_request(type(None), t, *arg)
  File "/usr/local/lib/python2.7/site-packages/paramiko/sftp_client.py", line 
670, in _async_request
    self._send_packet(t, msg)
  File "/usr/local/lib/python2.7/site-packages/paramiko/sftp.py", line 170, in 
_send_packet
    self._write_all(out)
  File "/usr/local/lib/python2.7/site-packages/paramiko/sftp.py", line 135, in 
_write_all
    raise EOFError()
 EOFError

Giving up after 5 attempts. EOFError: 
Releasing lockfile <LinkLockFile: 
'/var/db/duplicity/be3234cf4cbafbdf41099030093b6bbe/XXXXXXg.650626177224228893873130'
 -- '/var/db/duplicity/be3234cf4cbafbdf41099030093b6bbe/lockfile'>
Removing still remembered temporary file 
/tmp/duplicity-ny_w0E-tempdir/mktemp-cOWPt7-2
Removing still remembered temporary file 
/tmp/duplicity-ny_w0E-tempdir/mkstemp-hiD03y-1