Hi,

I'm using obnam 1.0 and try to backup files / directories. obnam is installed on Debian Squeeze with the package frovided on http://liw.fi. No ~/.obnam.conf file is used. The obnam repository and the files to backup are stored on a partition that is mounted from an encrypted partition (cryptsetup, device-mapper). When trying to backup with

cd /mnt/crypt/obnam

obnam backup /mnt/crypt/myfiles/test.data

obnam complains, that /mnt/crypt/myfiles/test.data is not available (No such file or directory). But the file is definitely available (less -f /mnt/crypt/myfiles/test.data shows data). When I comment out

line 91: #raise OSError(err, os.strerror(err), self.cwd)

in the file obnamlib/vfs_local.py, the backup works fine. I don't understand what the purpose of this line is (I'm not a python programmer), but for me it produces errors. Maybe you can find a solution ;-)


Hi: there is at least one obvious bug here, which is that Obnam does not complain when you don't give an explicit backup repository (it uses the current working directory instead). I'll fix that. However, you seem to be working around that with the cd command. (Edit: --repository must now be set explicitly.)

The line you commented out is essential. It makes sure that the repository exists.

I'm not sure what the real error is that makes things not work for you. Could you e-mail me the log file, which has a lot extra information I could use for debugging. Thanks.

--liw


I am having this same problem. I had to wipe my obnam repo from March--32 GB, uploaded slowly :(--since the repo format changed. So before starting a whole, new, full backup, I decided to do a few little tests. I first backed up a small directory to a local directory and tried a few operations. Then I rsynced the repo to a remote server and ran fsck (obnam's, of course) on it. It came out fine. Listing clients and generations and keys and "ls" all worked fine.

So then I tried to make a new backup of the same, small, local directory. It failed with:

ERROR: sftp://me@host/~/obnam: No such file

This was quite strange, since all the other ops worked. Finally I made a full log and here's what I see:

2012-06-21 03:05:51 INFO obnam version 1.0 starts
2012-06-21 03:05:51 DEBUG Current configuration:
[config]
output = 
log = /tmp/obnam.log
log-level = debug
log-max = 0
log-keep = 10
log-mode = 0600
dump-memory-profile = simple
repository = sftp://me@host/~/obnam
client-name = mysystem
node-size = 262144
chunk-size = 1048576
upload-queue-size = 1024
lru-size = 500
trace = 
idpath-depth = 3
idpath-bits = 12
idpath-skip = 13
quiet = False
pretend = False
pretend-time = 
lock-timeout = 60
crash-limit = 0
compress-with = none
root = 
exclude = 
exclude-caches = False
one-file-system = False
checkpoint = 1073741824
chunkids-per-group = 1024
deduplicate = fatalist
leave-checkpoints = False
small-files-in-btree = False
warn-age = 27h
critical-age = 27h
sftp-delay = 0
ssh-key = 
strict-ssh-host-keys = False
ssh-known-hosts = /home/me/.ssh/known_hosts
pure-paramiko = False
to = 
generation = latest
keep = 
fsck-fix = False
verify-randomly = 0
encrypt-with = mykeyid
keyid = 
weak-random = False
symmetric-key-bits = 


2012-06-21 03:05:51 INFO Backup starts
2012-06-21 03:05:51 INFO Checkpoints every 1073741824 bytes
2012-06-21 03:05:51 DEBUG Exclude pattern: /tmp/obnam.log
2012-06-21 03:05:51 DEBUG opening repository (create=True)
2012-06-21 03:05:51 INFO VFS: __init__: baseurl=sftp://me@host/~/obnam
2012-06-21 03:05:51 DEBUG executing openssh: ['ssh', '-oForwardX11=no', '-oForwardAgent=no', '-oClearAllForwardings=yes', '-oProtocol=2', '-p', '22', '-l', 'b122569', '-s', '-o', 'UserKnownHostsFile=/home/me/.ssh/known_hosts', 'host', 'sftp']
2012-06-21 03:05:52 INFO [chan obnam SSHChannelAdapter] Opened sftp connection (server version 3)
2012-06-21 03:05:52 DEBUG [chan obnam SSHChannelAdapter] mkdir('obnam', 511)
2012-06-21 03:05:53 DEBUG [chan obnam SSHChannelAdapter] stat('obnam')
2012-06-21 03:05:53 DEBUG [chan obnam SSHChannelAdapter] normalize('obnam')
2012-06-21 03:05:53 DEBUG [chan obnam SSHChannelAdapter] open('/path/to/my/user/obnam/./lock', 'wx')
2012-06-21 03:05:53 DEBUG [chan obnam SSHChannelAdapter] open('/path/to/my/user/obnam/./lock', 'wx') -> 00000000
2012-06-21 03:05:53 DEBUG [chan obnam SSHChannelAdapter] close(00000000)
2012-06-21 03:05:53 DEBUG [chan obnam SSHChannelAdapter] lstat('/path/to/my/user/obnam/metadata/format')
2012-06-21 03:05:53 DEBUG [chan obnam SSHChannelAdapter] open('/path/to/my/user/obnam/metadata/format', 'r')
2012-06-21 03:05:53 DEBUG [chan obnam SSHChannelAdapter] open('/path/to/my/user/obnam/metadata/format', 'r') -> 00000000
2012-06-21 03:05:53 DEBUG [chan obnam SSHChannelAdapter] close(00000000)
2012-06-21 03:05:53 DEBUG [chan obnam SSHChannelAdapter] lstat('/path/to/my/user/obnam/metadata')
2012-06-21 03:05:53 DEBUG [chan obnam SSHChannelAdapter] mkdir('/path/to/my/user/obnam/metadata', 511)
2012-06-21 03:05:53 DEBUG [chan obnam SSHChannelAdapter] open('/path/to/my/user/obnam/metadata/tmp.5e2ae5d86f54786c', 'wx')
2012-06-21 03:05:53 DEBUG [chan obnam SSHChannelAdapter] open('/path/to/my/user/obnam/metadata/tmp.5e2ae5d86f54786c', 'wx') -> 00000000
2012-06-21 03:05:53 DEBUG [chan obnam SSHChannelAdapter] close(00000000)
2012-06-21 03:05:54 DEBUG [chan obnam SSHChannelAdapter] remove('/path/to/my/user/obnam/metadata/format')
2012-06-21 03:05:54 DEBUG [chan obnam SSHChannelAdapter] rename('/path/to/my/user/obnam/metadata/tmp.5e2ae5d86f54786c', '/path/to/my/user/obnam/metadata/format')
2012-06-21 03:05:54 DEBUG [chan obnam SSHChannelAdapter] lstat('/path/to/my/user/obnam/clientlist')
2012-06-21 03:05:54 DEBUG [chan obnam SSHChannelAdapter] listdir('/path/to/my/user/obnam/clientlist')
2012-06-21 03:05:54 DEBUG [chan obnam SSHChannelAdapter] lstat('/path/to/my/user/obnam/clientlist')
2012-06-21 03:05:54 DEBUG Initializing Journal for clientlist
2012-06-21 03:05:54 DEBUG [chan obnam SSHChannelAdapter] lstat('/path/to/my/user/obnam/clientlist/new/metadata')
2012-06-21 03:05:54 DEBUG Automatically rolling back remaining changes
2012-06-21 03:05:54 DEBUG [chan obnam SSHChannelAdapter] lstat('/path/to/my/user/obnam/clientlist/new/')
2012-06-21 03:05:54 DEBUG [chan obnam SSHChannelAdapter] listdir('/path/to/my/user/obnam/clientlist/new/')
2012-06-21 03:05:54 DEBUG [chan obnam SSHChannelAdapter] lstat('/path/to/my/user/obnam/clientlist/new/nodes')
2012-06-21 03:05:55 DEBUG [chan obnam SSHChannelAdapter] listdir('/path/to/my/user/obnam/clientlist/new/nodes')
2012-06-21 03:05:55 DEBUG [chan obnam SSHChannelAdapter] lstat('/path/to/my/user/obnam/clientlist/new/nodes/0')
2012-06-21 03:05:55 DEBUG [chan obnam SSHChannelAdapter] listdir('/path/to/my/user/obnam/clientlist/new/nodes/0')
2012-06-21 03:05:55 DEBUG [chan obnam SSHChannelAdapter] lstat('/path/to/my/user/obnam/clientlist/new/nodes/0/0')
2012-06-21 03:05:55 DEBUG [chan obnam SSHChannelAdapter] listdir('/path/to/my/user/obnam/clientlist/new/nodes/0/0')
2012-06-21 03:05:55 DEBUG [chan obnam SSHChannelAdapter] lstat('/path/to/my/user/obnam/clientlist/new/nodes/0/0/0')
2012-06-21 03:05:55 DEBUG [chan obnam SSHChannelAdapter] listdir('/path/to/my/user/obnam/clientlist/new/nodes/0/0/0')
2012-06-21 03:05:56 DEBUG [chan obnam SSHChannelAdapter] lstat('/path/to/my/user/obnam/clientlist/new/nodes/0/0/0')
2012-06-21 03:05:56 DEBUG [chan obnam SSHChannelAdapter] rmdir('/path/to/my/user/obnam/clientlist/new/nodes/0/0/0')
2012-06-21 03:05:56 DEBUG [chan obnam SSHChannelAdapter] lstat('/path/to/my/user/obnam/clientlist/new/nodes/0/0')
2012-06-21 03:05:56 DEBUG [chan obnam SSHChannelAdapter] rmdir('/path/to/my/user/obnam/clientlist/new/nodes/0/0')
2012-06-21 03:05:56 DEBUG [chan obnam SSHChannelAdapter] lstat('/path/to/my/user/obnam/clientlist/new/nodes/0')
2012-06-21 03:05:56 DEBUG [chan obnam SSHChannelAdapter] rmdir('/path/to/my/user/obnam/clientlist/new/nodes/0')
2012-06-21 03:05:56 DEBUG [chan obnam SSHChannelAdapter] lstat('/path/to/my/user/obnam/clientlist/new/nodes')
2012-06-21 03:05:56 DEBUG [chan obnam SSHChannelAdapter] rmdir('/path/to/my/user/obnam/clientlist/new/nodes')
2012-06-21 03:05:56 DEBUG [chan obnam SSHChannelAdapter] lstat('/path/to/my/user/obnam/clientlist/new/refcounts')
2012-06-21 03:05:56 DEBUG [chan obnam SSHChannelAdapter] listdir('/path/to/my/user/obnam/clientlist/new/refcounts')
2012-06-21 03:05:57 DEBUG [chan obnam SSHChannelAdapter] lstat('/path/to/my/user/obnam/clientlist/new/refcounts')
2012-06-21 03:05:57 DEBUG [chan obnam SSHChannelAdapter] rmdir('/path/to/my/user/obnam/clientlist/new/refcounts')
2012-06-21 03:05:57 DEBUG [chan obnam SSHChannelAdapter] lstat('/path/to/my/user/obnam/clientlist/delete/')
2012-06-21 03:05:57 DEBUG [chan obnam SSHChannelAdapter] listdir('/path/to/my/user/obnam/clientlist/delete/')
2012-06-21 03:05:57 DEBUG [chan obnam SSHChannelAdapter] lstat('/path/to/my/user/obnam/clientlist/delete/nodes')
2012-06-21 03:05:57 DEBUG [chan obnam SSHChannelAdapter] listdir('/path/to/my/user/obnam/clientlist/delete/nodes')
2012-06-21 03:05:57 DEBUG [chan obnam SSHChannelAdapter] lstat('/path/to/my/user/obnam/clientlist/delete/nodes/0')
2012-06-21 03:05:57 DEBUG [chan obnam SSHChannelAdapter] listdir('/path/to/my/user/obnam/clientlist/delete/nodes/0')
2012-06-21 03:05:58 DEBUG [chan obnam SSHChannelAdapter] lstat('/path/to/my/user/obnam/clientlist/delete/nodes/0/0')
2012-06-21 03:05:58 DEBUG [chan obnam SSHChannelAdapter] listdir('/path/to/my/user/obnam/clientlist/delete/nodes/0/0')
2012-06-21 03:05:58 DEBUG [chan obnam SSHChannelAdapter] lstat('/path/to/my/user/obnam/clientlist/delete/nodes/0/0/0')
2012-06-21 03:05:58 DEBUG [chan obnam SSHChannelAdapter] listdir('/path/to/my/user/obnam/clientlist/delete/nodes/0/0/0')
2012-06-21 03:05:58 DEBUG [chan obnam SSHChannelAdapter] lstat('/path/to/my/user/obnam/clientlist/delete/nodes/0/0/0')
2012-06-21 03:05:58 DEBUG [chan obnam SSHChannelAdapter] rmdir('/path/to/my/user/obnam/clientlist/delete/nodes/0/0/0')
2012-06-21 03:05:58 DEBUG [chan obnam SSHChannelAdapter] lstat('/path/to/my/user/obnam/clientlist/delete/nodes/0/0')
2012-06-21 03:05:58 DEBUG [chan obnam SSHChannelAdapter] rmdir('/path/to/my/user/obnam/clientlist/delete/nodes/0/0')
2012-06-21 03:05:58 DEBUG [chan obnam SSHChannelAdapter] lstat('/path/to/my/user/obnam/clientlist/delete/nodes/0')
2012-06-21 03:05:58 DEBUG [chan obnam SSHChannelAdapter] rmdir('/path/to/my/user/obnam/clientlist/delete/nodes/0')
2012-06-21 03:05:59 DEBUG [chan obnam SSHChannelAdapter] lstat('/path/to/my/user/obnam/clientlist/delete/nodes')
2012-06-21 03:05:59 DEBUG [chan obnam SSHChannelAdapter] rmdir('/path/to/my/user/obnam/clientlist/delete/nodes')
2012-06-21 03:05:59 DEBUG [chan obnam SSHChannelAdapter] lstat('/path/to/my/user/obnam/clientlist/metadata')
2012-06-21 03:05:59 DEBUG [chan obnam SSHChannelAdapter] open('/path/to/my/user/obnam/clientlist/metadata', 'r')
2012-06-21 03:05:59 DEBUG [chan obnam SSHChannelAdapter] open('/path/to/my/user/obnam/clientlist/metadata', 'r') -> 00000000
2012-06-21 03:05:59 DEBUG [chan obnam SSHChannelAdapter] close(00000000)
2012-06-21 03:05:59 DEBUG [chan obnam SSHChannelAdapter] open('/path/to/my/user/obnam/clientlist/key', 'r')
2012-06-21 03:05:59 DEBUG [chan obnam SSHChannelAdapter] open('/path/to/my/user/obnam/clientlist/key', 'r') -> 00000000
2012-06-21 03:05:59 DEBUG [chan obnam SSHChannelAdapter] close(00000000)
2012-06-21 03:06:00 DEBUG [chan obnam SSHChannelAdapter] open('/path/to/my/user/obnam/clientlist/nodes/0/0/0/5', 'r')
2012-06-21 03:06:00 DEBUG [chan obnam SSHChannelAdapter] open('/path/to/my/user/obnam/clientlist/nodes/0/0/0/5', 'r') -> 00000000
2012-06-21 03:06:00 DEBUG [chan obnam SSHChannelAdapter] close(00000000)
2012-06-21 03:06:00 DEBUG [chan obnam SSHChannelAdapter] lstat('/path/to/my/user/obnam/clientlist/refcounts/refcounts-0')
2012-06-21 03:06:00 DEBUG [chan obnam SSHChannelAdapter] open('/path/to/my/user/obnam/clientlist/refcounts/refcounts-0', 'r')
2012-06-21 03:06:00 DEBUG [chan obnam SSHChannelAdapter] open('/path/to/my/user/obnam/clientlist/refcounts/refcounts-0', 'r') -> 00000000
2012-06-21 03:06:00 DEBUG [chan obnam SSHChannelAdapter] close(00000000)
2012-06-21 03:06:00 DEBUG [chan obnam SSHChannelAdapter] lstat('/path/to/my/user/obnam/metadata/format')
2012-06-21 03:06:00 DEBUG [chan obnam SSHChannelAdapter] open('/path/to/my/user/obnam/metadata/format', 'r')
2012-06-21 03:06:00 DEBUG [chan obnam SSHChannelAdapter] open('/path/to/my/user/obnam/metadata/format', 'r') -> 00000000
2012-06-21 03:06:01 DEBUG [chan obnam SSHChannelAdapter] close(00000000)
2012-06-21 03:06:01 DEBUG [chan obnam SSHChannelAdapter] open('/path/to/my/user/obnam/clientlist/nodes/0/0/0/2', 'r')
2012-06-21 03:06:01 DEBUG [chan obnam SSHChannelAdapter] open('/path/to/my/user/obnam/clientlist/nodes/0/0/0/2', 'r') -> 00000000
2012-06-21 03:06:01 DEBUG [chan obnam SSHChannelAdapter] close(00000000)
2012-06-21 03:06:01 DEBUG [chan obnam SSHChannelAdapter] lstat('/path/to/my/user/obnam/clientlist/nodes/0/0/0/5')
2012-06-21 03:06:01 DEBUG [chan obnam SSHChannelAdapter] lstat('/path/to/my/user/obnam/clientlist/delete/nodes/0/0')
2012-06-21 03:06:01 DEBUG [chan obnam SSHChannelAdapter] lstat('/path/to/my/user/obnam/clientlist/delete/nodes/0')
2012-06-21 03:06:01 DEBUG [chan obnam SSHChannelAdapter] lstat('/path/to/my/user/obnam/clientlist/delete/nodes')
2012-06-21 03:06:01 DEBUG [chan obnam SSHChannelAdapter] lstat('/path/to/my/user/obnam/clientlist/delete')
2012-06-21 03:06:01 DEBUG [chan obnam SSHChannelAdapter] mkdir('/path/to/my/user/obnam/clientlist/delete/nodes', 511)
2012-06-21 03:06:02 DEBUG [chan obnam SSHChannelAdapter] mkdir('/path/to/my/user/obnam/clientlist/delete/nodes/0', 511)
2012-06-21 03:06:02 DEBUG [chan obnam SSHChannelAdapter] mkdir('/path/to/my/user/obnam/clientlist/delete/nodes/0/0', 511)
2012-06-21 03:06:02 DEBUG [chan obnam SSHChannelAdapter] mkdir('/path/to/my/user/obnam/clientlist/delete/nodes/0/0/0', 511)
2012-06-21 03:06:02 DEBUG [chan obnam SSHChannelAdapter] open('/path/to/my/user/obnam/clientlist/delete/nodes/0/0/0/tmp.a6cb1927c96d46d9', 'wx')
2012-06-21 03:06:02 DEBUG [chan obnam SSHChannelAdapter] open('/path/to/my/user/obnam/clientlist/delete/nodes/0/0/0/tmp.a6cb1927c96d46d9', 'wx') -> 00000000
2012-06-21 03:06:02 DEBUG [chan obnam SSHChannelAdapter] close(00000000)
2012-06-21 03:06:02 DEBUG [chan obnam SSHChannelAdapter] remove('/path/to/my/user/obnam/clientlist/delete/nodes/0/0/0/5')
2012-06-21 03:06:02 DEBUG [chan obnam SSHChannelAdapter] rename('/path/to/my/user/obnam/clientlist/delete/nodes/0/0/0/tmp.a6cb1927c96d46d9', '/path/to/my/user/obnam/clientlist/delete/nodes/0/0/0/5')
2012-06-21 03:06:02 DEBUG [chan obnam SSHChannelAdapter] lstat('/path/to/my/user/obnam/clientlist/refcounts')
2012-06-21 03:06:02 DEBUG [chan obnam SSHChannelAdapter] lstat('/path/to/my/user/obnam/clientlist/new')
2012-06-21 03:06:02 DEBUG [chan obnam SSHChannelAdapter] mkdir('/path/to/my/user/obnam/clientlist/new/refcounts', 511)
2012-06-21 03:06:02 DEBUG [chan obnam SSHChannelAdapter] open('/path/to/my/user/obnam/clientlist/new/refcounts/tmp.f0f0e1113a89e450', 'wx')
2012-06-21 03:06:02 DEBUG [chan obnam SSHChannelAdapter] open('/path/to/my/user/obnam/clientlist/new/refcounts/tmp.f0f0e1113a89e450', 'wx') -> 00000000
2012-06-21 03:06:02 DEBUG [chan obnam SSHChannelAdapter] close(00000000)
2012-06-21 03:06:03 DEBUG [chan obnam SSHChannelAdapter] remove('/path/to/my/user/obnam/clientlist/new/refcounts/refcounts-0')
2012-06-21 03:06:03 DEBUG [chan obnam SSHChannelAdapter] rename('/path/to/my/user/obnam/clientlist/new/refcounts/tmp.f0f0e1113a89e450', '/path/to/my/user/obnam/clientlist/new/refcounts/refcounts-0')
2012-06-21 03:06:03 DEBUG [chan obnam SSHChannelAdapter] lstat('/path/to/my/user/obnam/clientlist/new/nodes/0/0')
2012-06-21 03:06:03 DEBUG [chan obnam SSHChannelAdapter] lstat('/path/to/my/user/obnam/clientlist/new/nodes/0')
2012-06-21 03:06:03 DEBUG [chan obnam SSHChannelAdapter] lstat('/path/to/my/user/obnam/clientlist/new/nodes')
2012-06-21 03:06:03 DEBUG [chan obnam SSHChannelAdapter] lstat('/path/to/my/user/obnam/clientlist/new')
2012-06-21 03:06:03 DEBUG [chan obnam SSHChannelAdapter] mkdir('/path/to/my/user/obnam/clientlist/new/nodes', 511)
2012-06-21 03:06:03 DEBUG [chan obnam SSHChannelAdapter] mkdir('/path/to/my/user/obnam/clientlist/new/nodes/0', 511)
2012-06-21 03:06:03 DEBUG [chan obnam SSHChannelAdapter] mkdir('/path/to/my/user/obnam/clientlist/new/nodes/0/0', 511)
2012-06-21 03:06:03 DEBUG [chan obnam SSHChannelAdapter] mkdir('/path/to/my/user/obnam/clientlist/new/nodes/0/0/0', 511)
2012-06-21 03:06:03 DEBUG [chan obnam SSHChannelAdapter] open('/path/to/my/user/obnam/clientlist/new/nodes/0/0/0/tmp.5e84ba749fa001e6', 'wx')
2012-06-21 03:06:03 DEBUG [chan obnam SSHChannelAdapter] open('/path/to/my/user/obnam/clientlist/new/nodes/0/0/0/tmp.5e84ba749fa001e6', 'wx') -> 00000000
2012-06-21 03:06:03 DEBUG [chan obnam SSHChannelAdapter] close(00000000)
2012-06-21 03:06:03 DEBUG [chan obnam SSHChannelAdapter] remove('/path/to/my/user/obnam/clientlist/new/nodes/0/0/0/6')
2012-06-21 03:06:04 DEBUG [chan obnam SSHChannelAdapter] rename('/path/to/my/user/obnam/clientlist/new/nodes/0/0/0/tmp.5e84ba749fa001e6', '/path/to/my/user/obnam/clientlist/new/nodes/0/0/0/6')
2012-06-21 03:06:04 DEBUG LRUCache : hits=0 misses=2
2012-06-21 03:06:04 DEBUG LRUCache : hits=3 misses=2
2012-06-21 03:06:04 DEBUG [chan obnam SSHChannelAdapter] lstat('/path/to/my/user/obnam/clientlist')
2012-06-21 03:06:04 DEBUG [chan obnam SSHChannelAdapter] mkdir('/path/to/my/user/obnam/clientlist/new', 511)
2012-06-21 03:06:04 DEBUG [chan obnam SSHChannelAdapter] open('/path/to/my/user/obnam/clientlist/new/tmp.46022d631cdb89f7', 'wx')
2012-06-21 03:06:04 DEBUG [chan obnam SSHChannelAdapter] open('/path/to/my/user/obnam/clientlist/new/tmp.46022d631cdb89f7', 'wx') -> 00000000
2012-06-21 03:06:04 DEBUG [chan obnam SSHChannelAdapter] close(00000000)
2012-06-21 03:06:04 DEBUG [chan obnam SSHChannelAdapter] remove('/path/to/my/user/obnam/clientlist/new/metadata')
2012-06-21 03:06:04 DEBUG [chan obnam SSHChannelAdapter] rename('/path/to/my/user/obnam/clientlist/new/tmp.46022d631cdb89f7', '/path/to/my/user/obnam/clientlist/new/metadata')
2012-06-21 03:06:04 DEBUG [chan obnam SSHChannelAdapter] lstat('/path/to/my/user/obnam/clientlist/delete/')
2012-06-21 03:06:04 DEBUG [chan obnam SSHChannelAdapter] listdir('/path/to/my/user/obnam/clientlist/delete/')
2012-06-21 03:06:04 DEBUG [chan obnam SSHChannelAdapter] lstat('/path/to/my/user/obnam/clientlist/delete/nodes')
2012-06-21 03:06:04 DEBUG [chan obnam SSHChannelAdapter] listdir('/path/to/my/user/obnam/clientlist/delete/nodes')
2012-06-21 03:06:05 DEBUG [chan obnam SSHChannelAdapter] lstat('/path/to/my/user/obnam/clientlist/delete/nodes/0')
2012-06-21 03:06:05 DEBUG [chan obnam SSHChannelAdapter] listdir('/path/to/my/user/obnam/clientlist/delete/nodes/0')
2012-06-21 03:06:05 DEBUG [chan obnam SSHChannelAdapter] lstat('/path/to/my/user/obnam/clientlist/delete/nodes/0/0')
2012-06-21 03:06:05 DEBUG [chan obnam SSHChannelAdapter] listdir('/path/to/my/user/obnam/clientlist/delete/nodes/0/0')
2012-06-21 03:06:05 DEBUG [chan obnam SSHChannelAdapter] lstat('/path/to/my/user/obnam/clientlist/delete/nodes/0/0/0')
2012-06-21 03:06:05 DEBUG [chan obnam SSHChannelAdapter] listdir('/path/to/my/user/obnam/clientlist/delete/nodes/0/0/0')
2012-06-21 03:06:06 DEBUG [chan obnam SSHChannelAdapter] lstat('/path/to/my/user/obnam/clientlist/delete/nodes/0/0/0/5')
2012-06-21 03:06:06 DEBUG [chan obnam SSHChannelAdapter] remove('/path/to/my/user/obnam/clientlist/nodes/0/0/0/5')
2012-06-21 03:06:06 DEBUG [chan obnam SSHChannelAdapter] remove('/path/to/my/user/obnam/clientlist/delete/nodes/0/0/0/5')
2012-06-21 03:06:06 DEBUG [chan obnam SSHChannelAdapter] lstat('/path/to/my/user/obnam/clientlist/new/')
2012-06-21 03:06:06 DEBUG [chan obnam SSHChannelAdapter] listdir('/path/to/my/user/obnam/clientlist/new/')
2012-06-21 03:06:06 DEBUG [chan obnam SSHChannelAdapter] lstat('/path/to/my/user/obnam/clientlist/new/metadata')
2012-06-21 03:06:06 DEBUG [chan obnam SSHChannelAdapter] lstat('/path/to/my/user/obnam/clientlist/new/nodes')
2012-06-21 03:06:06 DEBUG [chan obnam SSHChannelAdapter] listdir('/path/to/my/user/obnam/clientlist/new/nodes')
2012-06-21 03:06:07 DEBUG [chan obnam SSHChannelAdapter] lstat('/path/to/my/user/obnam/clientlist/new/nodes/0')
2012-06-21 03:06:07 DEBUG [chan obnam SSHChannelAdapter] listdir('/path/to/my/user/obnam/clientlist/new/nodes/0')
2012-06-21 03:06:07 DEBUG [chan obnam SSHChannelAdapter] lstat('/path/to/my/user/obnam/clientlist/new/nodes/0/0')
2012-06-21 03:06:07 DEBUG [chan obnam SSHChannelAdapter] listdir('/path/to/my/user/obnam/clientlist/new/nodes/0/0')
2012-06-21 03:06:07 DEBUG [chan obnam SSHChannelAdapter] lstat('/path/to/my/user/obnam/clientlist/new/nodes/0/0/0')
2012-06-21 03:06:07 DEBUG [chan obnam SSHChannelAdapter] listdir('/path/to/my/user/obnam/clientlist/new/nodes/0/0/0')
2012-06-21 03:06:08 DEBUG [chan obnam SSHChannelAdapter] lstat('/path/to/my/user/obnam/clientlist/new/nodes/0/0/0/6')
2012-06-21 03:06:08 DEBUG [chan obnam SSHChannelAdapter] lstat('/path/to/my/user/obnam/clientlist/new/nodes/0/0/0/6')
2012-06-21 03:06:08 DEBUG [chan obnam SSHChannelAdapter] lstat('/path/to/my/user/obnam/clientlist/nodes/0/0/0')
2012-06-21 03:06:08 DEBUG [chan obnam SSHChannelAdapter] remove('/path/to/my/user/obnam/clientlist/nodes/0/0/0/6')
2012-06-21 03:06:08 DEBUG [chan obnam SSHChannelAdapter] rename('/path/to/my/user/obnam/clientlist/new/nodes/0/0/0/6', '/path/to/my/user/obnam/clientlist/nodes/0/0/0/6')
2012-06-21 03:06:08 DEBUG [chan obnam SSHChannelAdapter] lstat('/path/to/my/user/obnam/clientlist/new/nodes/0/0/0')
2012-06-21 03:06:08 DEBUG [chan obnam SSHChannelAdapter] lstat('/path/to/my/user/obnam/clientlist/nodes/0/0/0')
2012-06-21 03:06:08 DEBUG [chan obnam SSHChannelAdapter] lstat('/path/to/my/user/obnam/clientlist/new/nodes/0/0')
2012-06-21 03:06:08 DEBUG [chan obnam SSHChannelAdapter] lstat('/path/to/my/user/obnam/clientlist/nodes/0/0')
2012-06-21 03:06:08 DEBUG [chan obnam SSHChannelAdapter] lstat('/path/to/my/user/obnam/clientlist/new/nodes/0')
2012-06-21 03:06:08 DEBUG [chan obnam SSHChannelAdapter] lstat('/path/to/my/user/obnam/clientlist/nodes/0')
2012-06-21 03:06:08 DEBUG [chan obnam SSHChannelAdapter] lstat('/path/to/my/user/obnam/clientlist/new/nodes')
2012-06-21 03:06:08 DEBUG [chan obnam SSHChannelAdapter] lstat('/path/to/my/user/obnam/clientlist/nodes')
2012-06-21 03:06:08 DEBUG [chan obnam SSHChannelAdapter] lstat('/path/to/my/user/obnam/clientlist/new/refcounts')
2012-06-21 03:06:08 DEBUG [chan obnam SSHChannelAdapter] listdir('/path/to/my/user/obnam/clientlist/new/refcounts')
2012-06-21 03:06:09 DEBUG [chan obnam SSHChannelAdapter] lstat('/path/to/my/user/obnam/clientlist/new/refcounts/refcounts-0')
2012-06-21 03:06:09 DEBUG [chan obnam SSHChannelAdapter] lstat('/path/to/my/user/obnam/clientlist/new/refcounts/refcounts-0')
2012-06-21 03:06:09 DEBUG [chan obnam SSHChannelAdapter] lstat('/path/to/my/user/obnam/clientlist/refcounts')
2012-06-21 03:06:09 DEBUG [chan obnam SSHChannelAdapter] remove('/path/to/my/user/obnam/clientlist/refcounts/refcounts-0')
2012-06-21 03:06:09 DEBUG [chan obnam SSHChannelAdapter] rename('/path/to/my/user/obnam/clientlist/new/refcounts/refcounts-0', '/path/to/my/user/obnam/clientlist/refcounts/refcounts-0')
2012-06-21 03:06:09 DEBUG [chan obnam SSHChannelAdapter] lstat('/path/to/my/user/obnam/clientlist/new/refcounts')
2012-06-21 03:06:09 DEBUG [chan obnam SSHChannelAdapter] lstat('/path/to/my/user/obnam/clientlist/refcounts')
2012-06-21 03:06:09 DEBUG [chan obnam SSHChannelAdapter] lstat('/path/to/my/user/obnam/clientlist/new/metadata')
2012-06-21 03:06:09 DEBUG [chan obnam SSHChannelAdapter] remove('/path/to/my/user/obnam/clientlist/metadata')
2012-06-21 03:06:09 DEBUG [chan obnam SSHChannelAdapter] rename('/path/to/my/user/obnam/clientlist/new/metadata', '/path/to/my/user/obnam/clientlist/metadata')
2012-06-21 03:06:09 DEBUG [chan obnam SSHChannelAdapter] remove('/path/to/my/user/obnam/./lock')
2012-06-21 03:06:09 DEBUG opening repository (create=False)
2012-06-21 03:06:09 DEBUG [chan obnam SSHChannelAdapter] stat('/path/to/my/user/obnam/obnam')
2012-06-21 03:06:09 CRITICAL Traceback (most recent call last):
  File "/usr/lib/python2.7/dist-packages/cliapp/app.py", line 172, in _run
    self.process_args(args)
  File "/usr/lib/python2.7/dist-packages/obnamlib/app.py", line 158, in process_args
    cliapp.Application.process_args(self, args)
  File "/usr/lib/python2.7/dist-packages/cliapp/app.py", line 407, in process_args
    method(args[1:])
  File "/usr/lib/python2.7/dist-packages/obnamlib/plugins/backup_plugin.py", line 226, in backup
    self.add_client(client_name)
  File "/usr/lib/python2.7/dist-packages/obnamlib/plugins/backup_plugin.py", line 293, in add_client
    self.repo = self.app.open_repository(repofs=self.repo.fs.fs)
  File "/usr/lib/python2.7/dist-packages/obnamlib/app.py", line 187, in open_repository
    repofs.reinit(repopath)
  File "/usr/lib/python2.7/dist-packages/obnamlib/plugins/sftp_plugin.py", line 58, in helper
    raise OSError(e.errno, e.strerror or str(e), filename)
OSError: [Errno 2] No such file: 'sftp://me@host/~/obnam'

Near the end of the log, it tries to stat('/path/to/my/user/obnam/obnam'), which doesn't exist. Where did the extra "/obnam" come from?

Also, from my cursory look at the log, it seems like the backup succeeded before it failed, yet when I run "generations" I don't see any new ones. Will I need to run "fsck" to remove orphaned nodes or files?

Thanks for obnam! Looking forward to using it full-time.

--AP


AP, what was your command line? I wasn't able to reproduce this myself, so I need your help to do so. --liw


That happened to me yesterday when setting up a my new offsite repository. When obnam is asked to create a new repository (notice the "opening repository (create=True)" in the log above) but the repository directory already exists, then it fails with the file not found error. I rmdir'd my empty directory on the server (and I also replaced the "~" with a fully expanded path, not sure if that's related to the error) and it started working.

--nemoinis


Ok, let me try this again. Hopefully this will make it clear. :) --AP

$ sftp me@server
Connected to server.
sftp> ls
Maildir                   logs                      obnam                     
sftp> ^D

$ time obnam --log=/tmp/obnam.log --log-level=debug backup ~/Dropbox/Zim
ERROR: sftp://me@server/~/obnam/: No such file

$ cat .obnam.conf 
[config]
repository = sftp://me@server/~/obnam/
encrypt-with = MYKEY

$ cat /tmp/obnam.log 
2012-07-07 13:47:40 INFO obnam version 1.0 starts
2012-07-07 13:47:40 DEBUG Current configuration:
[config]
output = 
log = /tmp/obnam.log
log-level = debug
log-max = 0
log-keep = 10
log-mode = 0600
dump-memory-profile = simple
repository = sftp://me@server/~/obnam/
client-name = laptop
node-size = 262144
chunk-size = 1048576
upload-queue-size = 1024
lru-size = 500
trace = 
idpath-depth = 3
idpath-bits = 12
idpath-skip = 13
quiet = False
pretend = False
pretend-time = 
lock-timeout = 60
crash-limit = 0
compress-with = none
root = 
exclude = 
exclude-caches = False
one-file-system = False
checkpoint = 1073741824
chunkids-per-group = 1024
deduplicate = fatalist
leave-checkpoints = False
small-files-in-btree = False
warn-age = 27h
critical-age = 27h
sftp-delay = 0
ssh-key = 
strict-ssh-host-keys = False
ssh-known-hosts = /home/me/.ssh/known_hosts
pure-paramiko = False
to = 
generation = latest
keep = 
fsck-fix = False
verify-randomly = 0
encrypt-with = MYKEY
keyid = 
weak-random = False
symmetric-key-bits = 


2012-07-07 13:47:40 INFO Backup starts
2012-07-07 13:47:40 INFO Checkpoints every 1073741824 bytes
2012-07-07 13:47:40 DEBUG Exclude pattern: /tmp/obnam.log
2012-07-07 13:47:40 DEBUG opening repository (create=True)
2012-07-07 13:47:40 INFO VFS: __init__: baseurl=sftp://me@server/~/obnam/
2012-07-07 13:47:40 DEBUG executing openssh: ['ssh', '-oForwardX11=no', '-oForwardAgent=no', '-oClearAllForwardings=yes', '-oProtocol=2', '-p', '22', '-l', 'me', '-s', '-o', 'UserKnownHostsFile=/home/me/.ssh/known_hosts', 'server', 'sftp']
2012-07-07 13:47:42 INFO [chan obnam SSHChannelAdapter] Opened sftp connection (server version 3)
2012-07-07 13:47:42 DEBUG [chan obnam SSHChannelAdapter] mkdir('obnam/', 511)
2012-07-07 13:47:42 DEBUG [chan obnam SSHChannelAdapter] stat('obnam/')
2012-07-07 13:47:42 DEBUG [chan obnam SSHChannelAdapter] normalize('obnam/')
2012-07-07 13:47:42 DEBUG [chan obnam SSHChannelAdapter] open('/path/to/me/obnam/./lock', 'wx')
2012-07-07 13:47:42 DEBUG [chan obnam SSHChannelAdapter] open('/path/to/me/obnam/./lock', 'wx') -> 00000000
2012-07-07 13:47:42 DEBUG [chan obnam SSHChannelAdapter] close(00000000)
2012-07-07 13:47:42 DEBUG [chan obnam SSHChannelAdapter] lstat('/path/to/me/obnam/metadata/format')
2012-07-07 13:47:42 DEBUG [chan obnam SSHChannelAdapter] open('/path/to/me/obnam/metadata/format', 'r')
2012-07-07 13:47:42 DEBUG [chan obnam SSHChannelAdapter] open('/path/to/me/obnam/metadata/format', 'r') -> 00000000
2012-07-07 13:47:43 DEBUG [chan obnam SSHChannelAdapter] close(00000000)
2012-07-07 13:47:43 DEBUG [chan obnam SSHChannelAdapter] lstat('/path/to/me/obnam/metadata')
2012-07-07 13:47:43 DEBUG [chan obnam SSHChannelAdapter] mkdir('/path/to/me/obnam/metadata', 511)
2012-07-07 13:47:43 DEBUG [chan obnam SSHChannelAdapter] open('/path/to/me/obnam/metadata/tmp.a8866c9f96aef3c3', 'wx')
2012-07-07 13:47:43 DEBUG [chan obnam SSHChannelAdapter] open('/path/to/me/obnam/metadata/tmp.a8866c9f96aef3c3', 'wx') -> 00000000
2012-07-07 13:47:43 DEBUG [chan obnam SSHChannelAdapter] close(00000000)
2012-07-07 13:47:43 DEBUG [chan obnam SSHChannelAdapter] remove('/path/to/me/obnam/metadata/format')
2012-07-07 13:47:43 DEBUG [chan obnam SSHChannelAdapter] rename('/path/to/me/obnam/metadata/tmp.a8866c9f96aef3c3', '/path/to/me/obnam/metadata/format')
2012-07-07 13:47:43 DEBUG [chan obnam SSHChannelAdapter] lstat('/path/to/me/obnam/clientlist')
2012-07-07 13:47:43 DEBUG [chan obnam SSHChannelAdapter] listdir('/path/to/me/obnam/clientlist')
2012-07-07 13:47:44 DEBUG [chan obnam SSHChannelAdapter] lstat('/path/to/me/obnam/clientlist')
2012-07-07 13:47:44 DEBUG Initializing Journal for clientlist
2012-07-07 13:47:44 DEBUG [chan obnam SSHChannelAdapter] lstat('/path/to/me/obnam/clientlist/new/metadata')
2012-07-07 13:47:44 DEBUG Automatically rolling back remaining changes
2012-07-07 13:47:44 DEBUG [chan obnam SSHChannelAdapter] lstat('/path/to/me/obnam/clientlist/new/')
2012-07-07 13:47:44 DEBUG [chan obnam SSHChannelAdapter] listdir('/path/to/me/obnam/clientlist/new/')
2012-07-07 13:47:44 DEBUG [chan obnam SSHChannelAdapter] lstat('/path/to/me/obnam/clientlist/new/nodes')
2012-07-07 13:47:44 DEBUG [chan obnam SSHChannelAdapter] listdir('/path/to/me/obnam/clientlist/new/nodes')
2012-07-07 13:47:45 DEBUG [chan obnam SSHChannelAdapter] lstat('/path/to/me/obnam/clientlist/new/nodes/0')
2012-07-07 13:47:45 DEBUG [chan obnam SSHChannelAdapter] listdir('/path/to/me/obnam/clientlist/new/nodes/0')
2012-07-07 13:47:45 DEBUG [chan obnam SSHChannelAdapter] lstat('/path/to/me/obnam/clientlist/new/nodes/0/0')
2012-07-07 13:47:45 DEBUG [chan obnam SSHChannelAdapter] listdir('/path/to/me/obnam/clientlist/new/nodes/0/0')
2012-07-07 13:47:45 DEBUG [chan obnam SSHChannelAdapter] lstat('/path/to/me/obnam/clientlist/new/nodes/0/0/0')
2012-07-07 13:47:45 DEBUG [chan obnam SSHChannelAdapter] listdir('/path/to/me/obnam/clientlist/new/nodes/0/0/0')
2012-07-07 13:47:46 DEBUG [chan obnam SSHChannelAdapter] lstat('/path/to/me/obnam/clientlist/new/nodes/0/0/0')
2012-07-07 13:47:46 DEBUG [chan obnam SSHChannelAdapter] rmdir('/path/to/me/obnam/clientlist/new/nodes/0/0/0')
2012-07-07 13:47:46 DEBUG [chan obnam SSHChannelAdapter] lstat('/path/to/me/obnam/clientlist/new/nodes/0/0')
2012-07-07 13:47:46 DEBUG [chan obnam SSHChannelAdapter] rmdir('/path/to/me/obnam/clientlist/new/nodes/0/0')
2012-07-07 13:47:46 DEBUG [chan obnam SSHChannelAdapter] lstat('/path/to/me/obnam/clientlist/new/nodes/0')
2012-07-07 13:47:46 DEBUG [chan obnam SSHChannelAdapter] rmdir('/path/to/me/obnam/clientlist/new/nodes/0')
2012-07-07 13:47:46 DEBUG [chan obnam SSHChannelAdapter] lstat('/path/to/me/obnam/clientlist/new/nodes')
2012-07-07 13:47:46 DEBUG [chan obnam SSHChannelAdapter] rmdir('/path/to/me/obnam/clientlist/new/nodes')
2012-07-07 13:47:46 DEBUG [chan obnam SSHChannelAdapter] lstat('/path/to/me/obnam/clientlist/new/refcounts')
2012-07-07 13:47:46 DEBUG [chan obnam SSHChannelAdapter] listdir('/path/to/me/obnam/clientlist/new/refcounts')
2012-07-07 13:47:47 DEBUG [chan obnam SSHChannelAdapter] lstat('/path/to/me/obnam/clientlist/new/refcounts')
2012-07-07 13:47:47 DEBUG [chan obnam SSHChannelAdapter] rmdir('/path/to/me/obnam/clientlist/new/refcounts')
2012-07-07 13:47:47 DEBUG [chan obnam SSHChannelAdapter] lstat('/path/to/me/obnam/clientlist/delete/')
2012-07-07 13:47:47 DEBUG [chan obnam SSHChannelAdapter] listdir('/path/to/me/obnam/clientlist/delete/')
2012-07-07 13:47:47 DEBUG [chan obnam SSHChannelAdapter] lstat('/path/to/me/obnam/clientlist/delete/nodes')
2012-07-07 13:47:47 DEBUG [chan obnam SSHChannelAdapter] listdir('/path/to/me/obnam/clientlist/delete/nodes')
2012-07-07 13:47:48 DEBUG [chan obnam SSHChannelAdapter] lstat('/path/to/me/obnam/clientlist/delete/nodes/0')
2012-07-07 13:47:48 DEBUG [chan obnam SSHChannelAdapter] listdir('/path/to/me/obnam/clientlist/delete/nodes/0')
2012-07-07 13:47:48 DEBUG [chan obnam SSHChannelAdapter] lstat('/path/to/me/obnam/clientlist/delete/nodes/0/0')
2012-07-07 13:47:48 DEBUG [chan obnam SSHChannelAdapter] listdir('/path/to/me/obnam/clientlist/delete/nodes/0/0')
2012-07-07 13:47:49 DEBUG [chan obnam SSHChannelAdapter] lstat('/path/to/me/obnam/clientlist/delete/nodes/0/0/0')
2012-07-07 13:47:49 DEBUG [chan obnam SSHChannelAdapter] listdir('/path/to/me/obnam/clientlist/delete/nodes/0/0/0')
2012-07-07 13:47:49 DEBUG [chan obnam SSHChannelAdapter] lstat('/path/to/me/obnam/clientlist/delete/nodes/0/0/0')
2012-07-07 13:47:49 DEBUG [chan obnam SSHChannelAdapter] rmdir('/path/to/me/obnam/clientlist/delete/nodes/0/0/0')
2012-07-07 13:47:49 DEBUG [chan obnam SSHChannelAdapter] lstat('/path/to/me/obnam/clientlist/delete/nodes/0/0')
2012-07-07 13:47:49 DEBUG [chan obnam SSHChannelAdapter] rmdir('/path/to/me/obnam/clientlist/delete/nodes/0/0')
2012-07-07 13:47:49 DEBUG [chan obnam SSHChannelAdapter] lstat('/path/to/me/obnam/clientlist/delete/nodes/0')
2012-07-07 13:47:49 DEBUG [chan obnam SSHChannelAdapter] rmdir('/path/to/me/obnam/clientlist/delete/nodes/0')
2012-07-07 13:47:49 DEBUG [chan obnam SSHChannelAdapter] lstat('/path/to/me/obnam/clientlist/delete/nodes')
2012-07-07 13:47:49 DEBUG [chan obnam SSHChannelAdapter] rmdir('/path/to/me/obnam/clientlist/delete/nodes')
2012-07-07 13:47:50 DEBUG [chan obnam SSHChannelAdapter] lstat('/path/to/me/obnam/clientlist/metadata')
2012-07-07 13:47:50 DEBUG [chan obnam SSHChannelAdapter] open('/path/to/me/obnam/clientlist/metadata', 'r')
2012-07-07 13:47:50 DEBUG [chan obnam SSHChannelAdapter] open('/path/to/me/obnam/clientlist/metadata', 'r') -> 00000000
2012-07-07 13:47:50 DEBUG [chan obnam SSHChannelAdapter] close(00000000)
2012-07-07 13:47:50 DEBUG [chan obnam SSHChannelAdapter] open('/path/to/me/obnam/clientlist/key', 'r')
2012-07-07 13:47:50 DEBUG [chan obnam SSHChannelAdapter] open('/path/to/me/obnam/clientlist/key', 'r') -> 00000000
2012-07-07 13:47:50 DEBUG [chan obnam SSHChannelAdapter] close(00000000)
2012-07-07 13:47:51 DEBUG [chan obnam SSHChannelAdapter] open('/path/to/me/obnam/clientlist/nodes/0/0/0/6', 'r')
2012-07-07 13:47:51 DEBUG [chan obnam SSHChannelAdapter] open('/path/to/me/obnam/clientlist/nodes/0/0/0/6', 'r') -> 00000000
2012-07-07 13:47:51 DEBUG [chan obnam SSHChannelAdapter] close(00000000)
2012-07-07 13:47:51 DEBUG [chan obnam SSHChannelAdapter] lstat('/path/to/me/obnam/clientlist/refcounts/refcounts-0')
2012-07-07 13:47:51 DEBUG [chan obnam SSHChannelAdapter] open('/path/to/me/obnam/clientlist/refcounts/refcounts-0', 'r')
2012-07-07 13:47:51 DEBUG [chan obnam SSHChannelAdapter] open('/path/to/me/obnam/clientlist/refcounts/refcounts-0', 'r') -> 00000000
2012-07-07 13:47:52 DEBUG [chan obnam SSHChannelAdapter] close(00000000)
2012-07-07 13:47:52 DEBUG [chan obnam SSHChannelAdapter] lstat('/path/to/me/obnam/metadata/format')
2012-07-07 13:47:52 DEBUG [chan obnam SSHChannelAdapter] open('/path/to/me/obnam/metadata/format', 'r')
2012-07-07 13:47:52 DEBUG [chan obnam SSHChannelAdapter] open('/path/to/me/obnam/metadata/format', 'r') -> 00000000
2012-07-07 13:47:52 DEBUG [chan obnam SSHChannelAdapter] close(00000000)
2012-07-07 13:47:52 DEBUG [chan obnam SSHChannelAdapter] open('/path/to/me/obnam/clientlist/nodes/0/0/0/2', 'r')
2012-07-07 13:47:52 DEBUG [chan obnam SSHChannelAdapter] open('/path/to/me/obnam/clientlist/nodes/0/0/0/2', 'r') -> 00000000
2012-07-07 13:47:53 DEBUG [chan obnam SSHChannelAdapter] close(00000000)
2012-07-07 13:47:53 DEBUG [chan obnam SSHChannelAdapter] lstat('/path/to/me/obnam/clientlist/nodes/0/0/0/6')
2012-07-07 13:47:53 DEBUG [chan obnam SSHChannelAdapter] lstat('/path/to/me/obnam/clientlist/delete/nodes/0/0')
2012-07-07 13:47:53 DEBUG [chan obnam SSHChannelAdapter] lstat('/path/to/me/obnam/clientlist/delete/nodes/0')
2012-07-07 13:47:53 DEBUG [chan obnam SSHChannelAdapter] lstat('/path/to/me/obnam/clientlist/delete/nodes')
2012-07-07 13:47:53 DEBUG [chan obnam SSHChannelAdapter] lstat('/path/to/me/obnam/clientlist/delete')
2012-07-07 13:47:53 DEBUG [chan obnam SSHChannelAdapter] mkdir('/path/to/me/obnam/clientlist/delete/nodes', 511)
2012-07-07 13:47:53 DEBUG [chan obnam SSHChannelAdapter] mkdir('/path/to/me/obnam/clientlist/delete/nodes/0', 511)
2012-07-07 13:47:53 DEBUG [chan obnam SSHChannelAdapter] mkdir('/path/to/me/obnam/clientlist/delete/nodes/0/0', 511)
2012-07-07 13:47:53 DEBUG [chan obnam SSHChannelAdapter] mkdir('/path/to/me/obnam/clientlist/delete/nodes/0/0/0', 511)
2012-07-07 13:47:53 DEBUG [chan obnam SSHChannelAdapter] open('/path/to/me/obnam/clientlist/delete/nodes/0/0/0/tmp.e1f00e0fb571930c', 'wx')
2012-07-07 13:47:54 DEBUG [chan obnam SSHChannelAdapter] open('/path/to/me/obnam/clientlist/delete/nodes/0/0/0/tmp.e1f00e0fb571930c', 'wx') -> 00000000
2012-07-07 13:47:54 DEBUG [chan obnam SSHChannelAdapter] close(00000000)
2012-07-07 13:47:54 DEBUG [chan obnam SSHChannelAdapter] remove('/path/to/me/obnam/clientlist/delete/nodes/0/0/0/6')
2012-07-07 13:47:54 DEBUG [chan obnam SSHChannelAdapter] rename('/path/to/me/obnam/clientlist/delete/nodes/0/0/0/tmp.e1f00e0fb571930c', '/path/to/me/obnam/clientlist/delete/nodes/0/0/0/6')
2012-07-07 13:47:54 DEBUG [chan obnam SSHChannelAdapter] lstat('/path/to/me/obnam/clientlist/refcounts')
2012-07-07 13:47:54 DEBUG [chan obnam SSHChannelAdapter] lstat('/path/to/me/obnam/clientlist/new')
2012-07-07 13:47:54 DEBUG [chan obnam SSHChannelAdapter] mkdir('/path/to/me/obnam/clientlist/new/refcounts', 511)
2012-07-07 13:47:54 DEBUG [chan obnam SSHChannelAdapter] open('/path/to/me/obnam/clientlist/new/refcounts/tmp.c4b90ce174b14a09', 'wx')
2012-07-07 13:47:54 DEBUG [chan obnam SSHChannelAdapter] open('/path/to/me/obnam/clientlist/new/refcounts/tmp.c4b90ce174b14a09', 'wx') -> 00000000
2012-07-07 13:47:54 DEBUG [chan obnam SSHChannelAdapter] close(00000000)
2012-07-07 13:47:54 DEBUG [chan obnam SSHChannelAdapter] remove('/path/to/me/obnam/clientlist/new/refcounts/refcounts-0')
2012-07-07 13:47:54 DEBUG [chan obnam SSHChannelAdapter] rename('/path/to/me/obnam/clientlist/new/refcounts/tmp.c4b90ce174b14a09', '/path/to/me/obnam/clientlist/new/refcounts/refcounts-0')
2012-07-07 13:47:55 DEBUG [chan obnam SSHChannelAdapter] lstat('/path/to/me/obnam/clientlist/new/nodes/0/0')
2012-07-07 13:47:55 DEBUG [chan obnam SSHChannelAdapter] lstat('/path/to/me/obnam/clientlist/new/nodes/0')
2012-07-07 13:47:55 DEBUG [chan obnam SSHChannelAdapter] lstat('/path/to/me/obnam/clientlist/new/nodes')
2012-07-07 13:47:55 DEBUG [chan obnam SSHChannelAdapter] lstat('/path/to/me/obnam/clientlist/new')
2012-07-07 13:47:55 DEBUG [chan obnam SSHChannelAdapter] mkdir('/path/to/me/obnam/clientlist/new/nodes', 511)
2012-07-07 13:47:55 DEBUG [chan obnam SSHChannelAdapter] mkdir('/path/to/me/obnam/clientlist/new/nodes/0', 511)
2012-07-07 13:47:55 DEBUG [chan obnam SSHChannelAdapter] mkdir('/path/to/me/obnam/clientlist/new/nodes/0/0', 511)
2012-07-07 13:47:55 DEBUG [chan obnam SSHChannelAdapter] mkdir('/path/to/me/obnam/clientlist/new/nodes/0/0/0', 511)
2012-07-07 13:47:55 DEBUG [chan obnam SSHChannelAdapter] open('/path/to/me/obnam/clientlist/new/nodes/0/0/0/tmp.1f371a581e20dd5b', 'wx')
2012-07-07 13:47:55 DEBUG [chan obnam SSHChannelAdapter] open('/path/to/me/obnam/clientlist/new/nodes/0/0/0/tmp.1f371a581e20dd5b', 'wx') -> 00000000
2012-07-07 13:47:55 DEBUG [chan obnam SSHChannelAdapter] close(00000000)
2012-07-07 13:47:56 DEBUG [chan obnam SSHChannelAdapter] remove('/path/to/me/obnam/clientlist/new/nodes/0/0/0/7')
2012-07-07 13:47:56 DEBUG [chan obnam SSHChannelAdapter] rename('/path/to/me/obnam/clientlist/new/nodes/0/0/0/tmp.1f371a581e20dd5b', '/path/to/me/obnam/clientlist/new/nodes/0/0/0/7')
2012-07-07 13:47:56 DEBUG LRUCache : hits=0 misses=2
2012-07-07 13:47:56 DEBUG LRUCache : hits=3 misses=2
2012-07-07 13:47:56 DEBUG [chan obnam SSHChannelAdapter] lstat('/path/to/me/obnam/clientlist')
2012-07-07 13:47:56 DEBUG [chan obnam SSHChannelAdapter] mkdir('/path/to/me/obnam/clientlist/new', 511)
2012-07-07 13:47:56 DEBUG [chan obnam SSHChannelAdapter] open('/path/to/me/obnam/clientlist/new/tmp.334690ba416a3225', 'wx')
2012-07-07 13:47:56 DEBUG [chan obnam SSHChannelAdapter] open('/path/to/me/obnam/clientlist/new/tmp.334690ba416a3225', 'wx') -> 00000000
2012-07-07 13:47:56 DEBUG [chan obnam SSHChannelAdapter] close(00000000)
2012-07-07 13:47:56 DEBUG [chan obnam SSHChannelAdapter] remove('/path/to/me/obnam/clientlist/new/metadata')
2012-07-07 13:47:56 DEBUG [chan obnam SSHChannelAdapter] rename('/path/to/me/obnam/clientlist/new/tmp.334690ba416a3225', '/path/to/me/obnam/clientlist/new/metadata')
2012-07-07 13:47:56 DEBUG [chan obnam SSHChannelAdapter] lstat('/path/to/me/obnam/clientlist/delete/')
2012-07-07 13:47:56 DEBUG [chan obnam SSHChannelAdapter] listdir('/path/to/me/obnam/clientlist/delete/')
2012-07-07 13:47:57 DEBUG [chan obnam SSHChannelAdapter] lstat('/path/to/me/obnam/clientlist/delete/nodes')
2012-07-07 13:47:57 DEBUG [chan obnam SSHChannelAdapter] listdir('/path/to/me/obnam/clientlist/delete/nodes')
2012-07-07 13:47:57 DEBUG [chan obnam SSHChannelAdapter] lstat('/path/to/me/obnam/clientlist/delete/nodes/0')
2012-07-07 13:47:57 DEBUG [chan obnam SSHChannelAdapter] listdir('/path/to/me/obnam/clientlist/delete/nodes/0')
2012-07-07 13:47:57 DEBUG [chan obnam SSHChannelAdapter] lstat('/path/to/me/obnam/clientlist/delete/nodes/0/0')
2012-07-07 13:47:58 DEBUG [chan obnam SSHChannelAdapter] listdir('/path/to/me/obnam/clientlist/delete/nodes/0/0')
2012-07-07 13:47:58 DEBUG [chan obnam SSHChannelAdapter] lstat('/path/to/me/obnam/clientlist/delete/nodes/0/0/0')
2012-07-07 13:47:58 DEBUG [chan obnam SSHChannelAdapter] listdir('/path/to/me/obnam/clientlist/delete/nodes/0/0/0')
2012-07-07 13:47:58 DEBUG [chan obnam SSHChannelAdapter] lstat('/path/to/me/obnam/clientlist/delete/nodes/0/0/0/6')
2012-07-07 13:47:58 DEBUG [chan obnam SSHChannelAdapter] remove('/path/to/me/obnam/clientlist/nodes/0/0/0/6')
2012-07-07 13:47:58 DEBUG [chan obnam SSHChannelAdapter] remove('/path/to/me/obnam/clientlist/delete/nodes/0/0/0/6')
2012-07-07 13:47:58 DEBUG [chan obnam SSHChannelAdapter] lstat('/path/to/me/obnam/clientlist/new/')
2012-07-07 13:47:59 DEBUG [chan obnam SSHChannelAdapter] listdir('/path/to/me/obnam/clientlist/new/')
2012-07-07 13:47:59 DEBUG [chan obnam SSHChannelAdapter] lstat('/path/to/me/obnam/clientlist/new/metadata')
2012-07-07 13:47:59 DEBUG [chan obnam SSHChannelAdapter] lstat('/path/to/me/obnam/clientlist/new/nodes')
2012-07-07 13:47:59 DEBUG [chan obnam SSHChannelAdapter] listdir('/path/to/me/obnam/clientlist/new/nodes')
2012-07-07 13:47:59 DEBUG [chan obnam SSHChannelAdapter] lstat('/path/to/me/obnam/clientlist/new/nodes/0')
2012-07-07 13:47:59 DEBUG [chan obnam SSHChannelAdapter] listdir('/path/to/me/obnam/clientlist/new/nodes/0')
2012-07-07 13:48:00 DEBUG [chan obnam SSHChannelAdapter] lstat('/path/to/me/obnam/clientlist/new/nodes/0/0')
2012-07-07 13:48:00 DEBUG [chan obnam SSHChannelAdapter] listdir('/path/to/me/obnam/clientlist/new/nodes/0/0')
2012-07-07 13:48:00 DEBUG [chan obnam SSHChannelAdapter] lstat('/path/to/me/obnam/clientlist/new/nodes/0/0/0')
2012-07-07 13:48:00 DEBUG [chan obnam SSHChannelAdapter] listdir('/path/to/me/obnam/clientlist/new/nodes/0/0/0')
2012-07-07 13:48:01 DEBUG [chan obnam SSHChannelAdapter] lstat('/path/to/me/obnam/clientlist/new/nodes/0/0/0/7')
2012-07-07 13:48:01 DEBUG [chan obnam SSHChannelAdapter] lstat('/path/to/me/obnam/clientlist/new/nodes/0/0/0/7')
2012-07-07 13:48:01 DEBUG [chan obnam SSHChannelAdapter] lstat('/path/to/me/obnam/clientlist/nodes/0/0/0')
2012-07-07 13:48:01 DEBUG [chan obnam SSHChannelAdapter] remove('/path/to/me/obnam/clientlist/nodes/0/0/0/7')
2012-07-07 13:48:01 DEBUG [chan obnam SSHChannelAdapter] rename('/path/to/me/obnam/clientlist/new/nodes/0/0/0/7', '/path/to/me/obnam/clientlist/nodes/0/0/0/7')
2012-07-07 13:48:01 DEBUG [chan obnam SSHChannelAdapter] lstat('/path/to/me/obnam/clientlist/new/nodes/0/0/0')
2012-07-07 13:48:01 DEBUG [chan obnam SSHChannelAdapter] lstat('/path/to/me/obnam/clientlist/nodes/0/0/0')
2012-07-07 13:48:01 DEBUG [chan obnam SSHChannelAdapter] lstat('/path/to/me/obnam/clientlist/new/nodes/0/0')
2012-07-07 13:48:01 DEBUG [chan obnam SSHChannelAdapter] lstat('/path/to/me/obnam/clientlist/nodes/0/0')
2012-07-07 13:48:01 DEBUG [chan obnam SSHChannelAdapter] lstat('/path/to/me/obnam/clientlist/new/nodes/0')
2012-07-07 13:48:01 DEBUG [chan obnam SSHChannelAdapter] lstat('/path/to/me/obnam/clientlist/nodes/0')
2012-07-07 13:48:01 DEBUG [chan obnam SSHChannelAdapter] lstat('/path/to/me/obnam/clientlist/new/nodes')
2012-07-07 13:48:01 DEBUG [chan obnam SSHChannelAdapter] lstat('/path/to/me/obnam/clientlist/nodes')
2012-07-07 13:48:02 DEBUG [chan obnam SSHChannelAdapter] lstat('/path/to/me/obnam/clientlist/new/refcounts')
2012-07-07 13:48:02 DEBUG [chan obnam SSHChannelAdapter] listdir('/path/to/me/obnam/clientlist/new/refcounts')
2012-07-07 13:48:02 DEBUG [chan obnam SSHChannelAdapter] lstat('/path/to/me/obnam/clientlist/new/refcounts/refcounts-0')
2012-07-07 13:48:02 DEBUG [chan obnam SSHChannelAdapter] lstat('/path/to/me/obnam/clientlist/new/refcounts/refcounts-0')
2012-07-07 13:48:02 DEBUG [chan obnam SSHChannelAdapter] lstat('/path/to/me/obnam/clientlist/refcounts')
2012-07-07 13:48:02 DEBUG [chan obnam SSHChannelAdapter] remove('/path/to/me/obnam/clientlist/refcounts/refcounts-0')
2012-07-07 13:48:02 DEBUG [chan obnam SSHChannelAdapter] rename('/path/to/me/obnam/clientlist/new/refcounts/refcounts-0', '/path/to/me/obnam/clientlist/refcounts/refcounts-0')
2012-07-07 13:48:02 DEBUG [chan obnam SSHChannelAdapter] lstat('/path/to/me/obnam/clientlist/new/refcounts')
2012-07-07 13:48:02 DEBUG [chan obnam SSHChannelAdapter] lstat('/path/to/me/obnam/clientlist/refcounts')
2012-07-07 13:48:02 DEBUG [chan obnam SSHChannelAdapter] lstat('/path/to/me/obnam/clientlist/new/metadata')
2012-07-07 13:48:03 DEBUG [chan obnam SSHChannelAdapter] remove('/path/to/me/obnam/clientlist/metadata')
2012-07-07 13:48:03 DEBUG [chan obnam SSHChannelAdapter] rename('/path/to/me/obnam/clientlist/new/metadata', '/path/to/me/obnam/clientlist/metadata')
2012-07-07 13:48:03 DEBUG [chan obnam SSHChannelAdapter] remove('/path/to/me/obnam/./lock')
2012-07-07 13:48:03 DEBUG opening repository (create=False)
2012-07-07 13:48:03 DEBUG [chan obnam SSHChannelAdapter] stat('/path/to/me/obnam/obnam/')
2012-07-07 13:48:03 CRITICAL Traceback (most recent call last):
  File "/usr/lib/python2.7/dist-packages/cliapp/app.py", line 172, in _run
    self.process_args(args)
  File "/usr/lib/python2.7/dist-packages/obnamlib/app.py", line 158, in process_args
    cliapp.Application.process_args(self, args)
  File "/usr/lib/python2.7/dist-packages/cliapp/app.py", line 407, in process_args
    method(args[1:])
  File "/usr/lib/python2.7/dist-packages/obnamlib/plugins/backup_plugin.py", line 226, in backup
    self.add_client(client_name)
  File "/usr/lib/python2.7/dist-packages/obnamlib/plugins/backup_plugin.py", line 293, in add_client
    self.repo = self.app.open_repository(repofs=self.repo.fs.fs)
  File "/usr/lib/python2.7/dist-packages/obnamlib/app.py", line 187, in open_repository
    repofs.reinit(repopath)
  File "/usr/lib/python2.7/dist-packages/obnamlib/plugins/sftp_plugin.py", line 58, in helper
    raise OSError(e.errno, e.strerror or str(e), filename)
OSError: [Errno 2] No such file: 'sftp://me@server/~/obnam/'

I've fixed this now. It turns out that the SFTP plugin did not handle re-initialization repository paths that start with /~/. This will be included in the next release. --liw

done