[Freedombox-discuss] Backups stopped working. Where are the logs? How do I debug this?
A. F. Cano
afc54 at comcast.net
Fri Oct 13 22:52:26 BST 2023
On Thu, Oct 12, 2023 at 04:31:51PM -0700, Sunil Mohan Adapa wrote:
> ...
>
> If you are facing an error during automated backups, you will likely face the
> same error during backup to the same repository. Run a manual backup and
Correct. Ran a manual backup and got this error:
500
This is an internal error and not something you caused or can fix. Please report the error on the bug tracker so we can fix it. Also, please attach the status log to the bug report.
The Status log, as provided by the web interfae, is included in full
below. The user name, password, local IP address and domain (all blanked)
are correct. It looks like there is some problem mounting the partition
where the backups are kept on the remote/internal machine (/home is in
/dev/sdb1)
Oct 13 16:09:48 fbx /usr/bin/plinth[521]: Error running action backups..mount(*('/media/054e54ca-da9c-11ec-abca-000db93f92a8', '<user>@192.168.x.x:~/backups/fbx'), **{'user_known_hosts_file': '/var/lib/plinth/.ssh/known_hosts', 'password': '*******'}): [Errno 17] File exists: b'' (17, 'File exists') [' File "/usr/share/plinth/actions/actions", line 93, in _call\n return_values = func(*arguments[\'args\'], **arguments[\'kwargs\'])\n
Looking a bit further I see:
Oct 13 16:09:47 fbx /usr/share/plinth/actions/actions[244281]: Error executing action: [Errno 17] File exists: '/media/054e54ca-da9c-11ec-abca-000db93f92a8'
$ cd /media
$ sudo ls -lR
.:
ls: cannot access '054e54ca-da9c-11ec-abca-000db93f92a8': Transport endpoint is not connected
total 0
d????????? ? ? ? ? ? 054e54ca-da9c-11ec-abca-000db93f92a8
drwxr-xr-x 1 root root 0 Nov 16 2021 root
ls: cannot open directory './054e54ca-da9c-11ec-abca-000db93f92a8': Transport endpoint is not connected
./root: This one was easy to remove.
total 0
Thinking that maybe this is a leftover that shouldn't be there, tried to
delete it:
$ sudo rmdir 054e54ca-da9c-11ec-abca-000db93f92a8
rmdir: failed to remove '054e54ca-da9c-11ec-abca-000db93f92a8': Device
or resource busy
$ sudo lsof | grep 92a8
lsof: WARNING: can't stat() fuse.sshfs file system /media/054e54ca-da9c-11ec-abca-000db93f92a8
Output information may be incomplete.
So can't remove it, can't find what process is using it.
Note that this used to work. What else can I try?
> collect the logs using 'journalctl -u plinth'. Post them and we can try to
> analyze the problem.
This command returns the same info.
Thanks.
Augustine
Complete Status log:
Oct 13 14:43:57 fbx /usr/bin/plinth[521]: Dynamic domain <domain>.freedombox.rocks is up-to-date: 69.141.241.189
Oct 13 14:48:57 fbx /usr/bin/plinth[521]: Dynamic domain <domain>.freedombox.rocks is up-to-date: 69.141.241.189
Oct 13 14:53:57 fbx /usr/bin/plinth[521]: Dynamic domain <domain>.freedombox.rocks is up-to-date: 69.141.241.189
Oct 13 14:58:57 fbx /usr/bin/plinth[521]: Dynamic domain <domain>.freedombox.rocks is up-to-date: 69.141.241.189
Oct 13 15:02:13 fbx /usr/bin/plinth[521]: # storage..usage_info(…)
Oct 13 15:02:13 fbx sudo[242316]: plinth : PWD=/ ; USER=root ; COMMAND=/usr/share/plinth/actions/actions storage usage_info --write-fd 30
Oct 13 15:02:13 fbx sudo[242316]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=115)
Oct 13 15:02:14 fbx /usr/bin/plinth[521]: # backups..is_mounted(…)
Oct 13 15:02:14 fbx sudo[242320]: plinth : PWD=/ ; USER=root ; COMMAND=/usr/share/plinth/actions/actions backups is_mounted --write-fd 23
Oct 13 15:02:14 fbx sudo[242320]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=115)
Oct 13 15:02:16 fbx /usr/share/plinth/actions/actions[242319]: Error executing action: Command '['df', '--exclude-type=tmpfs', '--exclude-type=devtmpfs', '--block-size=1', '--output=source,fstype,size,used,avail,pcent,target']' returned non-zero exit status 1.
Traceback (most recent call last):
File "/usr/share/plinth/actions/actions", line 93, in _call
return_values = func(*arguments['args'], **arguments['kwargs'])
^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
File "/usr/lib/python3/dist-packages/plinth/modules/storage/privileged.py", line 328, in usage_info
return subprocess.check_output(command).decode()
^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
File "/usr/lib/python3.11/subprocess.py", line 466, in check_output
return run(*popenargs, stdout=PIPE, timeout=timeout, check=True,
^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
File "/usr/lib/python3.11/subprocess.py", line 571, in run
raise CalledProcessError(retcode, process.args,
subprocess.CalledProcessError: Command '['df', '--exclude-type=tmpfs', '--exclude-type=devtmpfs', '--block-size=1', '--output=source,fstype,size,used,avail,pcent,target']' returned non-zero exit status 1.
Oct 13 15:02:16 fbx sudo[242316]: pam_unix(sudo:session): session closed for user root
Oct 13 15:02:16 fbx /usr/bin/plinth[521]: Error running action storage..usage_info(*(), **{}): Command '['df', '--exclude-type=tmpfs', '--exclude-type=devtmpfs', '--block-size=1', '--output=source,fstype,size,used,avail,pcent,target']' returned non-zero exit status 1. (1, ['df', '--exclude-type=tmpfs', '--exclude-type=devtmpfs', '--block-size=1', '--output=source,fstype,size,used,avail,pcent,target'], b'', b'df: /media/054e54ca-da9c-11ec-abca-000db93f92a8: Transport endpoint is not connected\n\x1b[31m ERROR\x1b[0m \x1b[94m__main__ \x1b[0m Error executing action: Command \'[\'df\', \'--exclude-type=tmpfs\', \'--exclude-type=devtmpfs\', \'--block-size=1\', \'--output=source,fstype,size,used,avail,pcent,target\']\' returned non-zero exit status 1.\nTraceback (most recent call last):\n File "/usr/share/plinth/actions/actions", line 93, in _call\n return_values = func(*arguments[\'args\'], **arguments[\'kwargs\'])\n ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^\n File "/usr/lib/python3/dist-packages/plinth/modules/storage/privileged.py", line 328, in usage_info\n return subprocess.check_output(command).decode()\n ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^\n File "/usr/lib/python3.11/subprocess.py", line 466, in check_output\n return run(*popenargs, stdout=PIPE, timeout=timeout, check=True,\n ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^\n File "/usr/lib/python3.11/subprocess.py", line 571, in run\n raise CalledProcessError(retcode, process.args,\nsubprocess.CalledProcessError: Command \'[\'df\', \'--exclude-type=tmpfs\', \'--exclude-type=devtmpfs\', \'--block-size=1\', \'--output=source,fstype,size,used,avail,pcent,target\']\' returned non-zero exit status 1.\n') [' File "/usr/share/plinth/actions/actions", line 93, in _call\n return_values = func(*arguments[\'args\'], **arguments[\'kwargs\'])\n ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^\n', ' File "/usr/lib/python3/dist-packages/plinth/modules/storage/privileged.py", line 328, in usage_info\n return subprocess.check_output(command).decode()\n ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^\n', ' File "/usr/lib/python3.11/subprocess.py", line 466, in check_output\n return run(*popenargs, stdout=PIPE, timeout=timeout, check=True,\n ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^\n', ' File "/usr/lib/python3.11/subprocess.py", line 571, in run\n raise CalledProcessError(retcode, process.args,\n']
Oct 13 15:02:16 fbx /usr/bin/plinth[521]: Error getting disk information: Command '['df', '--exclude-type=tmpfs', '--exclude-type=devtmpfs', '--block-size=1', '--output=source,fstype,size,used,avail,pcent,target']' returned non-zero exit status 1.
Traceback (most recent call last):
File "/usr/lib/python3/dist-packages/plinth/modules/storage/__init__.py", line 134, in _get_disks_from_df
output = privileged.usage_info()
^^^^^^^^^^^^^^^^^^^^^^^
File "/usr/lib/python3/dist-packages/plinth/actions.py", line 57, in wrapper
return _run_privileged_method_as_process(module_name, action_name,
^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
File "/usr/lib/python3/dist-packages/plinth/actions.py", line 116, in _run_privileged_method_as_process
return _wait_for_return(*wait_args)
^^^^^^^^^^^^^^^^^^^^^^^^^^^^
File "/usr/lib/python3/dist-packages/plinth/actions.py", line 154, in _wait_for_return
raise exception
subprocess.CalledProcessError: Command '['df', '--exclude-type=tmpfs', '--exclude-type=devtmpfs', '--block-size=1', '--output=source,fstype,size,used,avail,pcent,target']' returned non-zero exit status 1.
Oct 13 15:02:17 fbx sudo[242320]: pam_unix(sudo:session): session closed for user root
Oct 13 15:02:17 fbx /usr/bin/plinth[521]: # backups..is_mounted(…)
Oct 13 15:02:17 fbx sudo[242327]: plinth : PWD=/ ; USER=root ; COMMAND=/usr/share/plinth/actions/actions backups is_mounted --write-fd 23
Oct 13 15:02:17 fbx sudo[242327]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=115)
Oct 13 15:02:20 fbx sudo[242327]: pam_unix(sudo:session): session closed for user root
Oct 13 15:02:20 fbx /usr/bin/plinth[521]: # backups..mount(…)
Oct 13 15:02:20 fbx sudo[242332]: plinth : PWD=/ ; USER=root ; COMMAND=/usr/share/plinth/actions/actions backups mount --write-fd 23
Oct 13 15:02:20 fbx sudo[242332]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=115)
Oct 13 15:02:22 fbx /usr/share/plinth/actions/actions[242334]: Error executing action: [Errno 17] File exists: '/media/054e54ca-da9c-11ec-abca-000db93f92a8'
Traceback (most recent call last):
File "/usr/share/plinth/actions/actions", line 93, in _call
return_values = func(*arguments['args'], **arguments['kwargs'])
^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
File "/usr/lib/python3/dist-packages/plinth/modules/backups/privileged.py", line 29, in mount
_validate_mountpoint(mountpoint)
File "/usr/lib/python3/dist-packages/plinth/modules/backups/privileged.py", line 78, in _validate_mountpoint
os.makedirs(mountpoint)
File "<frozen os>", line 225, in makedirs
FileExistsError: [Errno 17] File exists: '/media/054e54ca-da9c-11ec-abca-000db93f92a8'
Oct 13 15:02:23 fbx sudo[242332]: pam_unix(sudo:session): session closed for user root
Oct 13 15:02:23 fbx /usr/bin/plinth[521]: Error running action backups..mount(*('/media/054e54ca-da9c-11ec-abca-000db93f92a8', '<user>@192.168.x.x:~/backups/fbx'), **{'user_known_hosts_file': '/var/lib/plinth/.ssh/known_hosts', 'password': '*******'}): [Errno 17] File exists: b'' (17, 'File exists') [' File "/usr/share/plinth/actions/actions", line 93, in _call\n return_values = func(*arguments[\'args\'], **arguments[\'kwargs\'])\n ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^\n', ' File "/usr/lib/python3/dist-packages/plinth/modules/backups/privileged.py", line 29, in mount\n _validate_mountpoint(mountpoint)\n', ' File "/usr/lib/python3/dist-packages/plinth/modules/backups/privileged.py", line 78, in _validate_mountpoint\n os.makedirs(mountpoint)\n', ' File "<frozen os>", line 225, in makedirs\n']
Oct 13 15:02:23 fbx /usr/bin/plinth[521]: Error running scheduled backup: [Errno 17] File exists: b''
Traceback (most recent call last):
File "/usr/lib/python3/dist-packages/plinth/modules/backups/__init__.py", line 106, in backup_by_schedule
repository.schedule.run_schedule()
File "/usr/lib/python3/dist-packages/plinth/modules/backups/schedule.py", line 190, in run_schedule
repository.prepare()
File "/usr/lib/python3/dist-packages/plinth/modules/backups/repository.py", line 405, in prepare
self.mount()
File "/usr/lib/python3/dist-packages/plinth/modules/backups/repository.py", line 450, in mount
privileged.mount(self._mountpoint, self._path, **kwargs)
File "/usr/lib/python3/dist-packages/plinth/actions.py", line 57, in wrapper
return _run_privileged_method_as_process(module_name, action_name,
^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
File "/usr/lib/python3/dist-packages/plinth/actions.py", line 116, in _run_privileged_method_as_process
return _wait_for_return(*wait_args)
^^^^^^^^^^^^^^^^^^^^^^^^^^^^
File "/usr/lib/python3/dist-packages/plinth/actions.py", line 154, in _wait_for_return
raise exception
FileExistsError: [Errno 17] File exists: b''
Oct 13 15:03:57 fbx /usr/bin/plinth[521]: Dynamic domain <domain>.freedombox.rocks is up-to-date: 69.141.241.189
Oct 13 15:08:58 fbx /usr/bin/plinth[521]: Dynamic domain <domain>.freedombox.rocks is up-to-date: 69.141.241.189
Oct 13 15:13:58 fbx /usr/bin/plinth[521]: Dynamic domain <domain>.freedombox.rocks is up-to-date: 69.141.241.189
Oct 13 15:18:58 fbx /usr/bin/plinth[521]: Dynamic domain <domain>.freedombox.rocks is up-to-date: 69.141.241.189
Oct 13 15:23:58 fbx /usr/bin/plinth[521]: Dynamic domain <domain>.freedombox.rocks is up-to-date: 69.141.241.189
Oct 13 15:28:58 fbx /usr/bin/plinth[521]: Dynamic domain <domain>.freedombox.rocks is up-to-date: 69.141.241.189
Oct 13 15:33:58 fbx /usr/bin/plinth[521]: Dynamic domain <domain>.freedombox.rocks is up-to-date: 69.141.241.189
Oct 13 15:38:58 fbx /usr/bin/plinth[521]: Dynamic domain <domain>.freedombox.rocks is up-to-date: 69.141.241.189
Oct 13 15:43:58 fbx /usr/bin/plinth[521]: Dynamic domain <domain>.freedombox.rocks is up-to-date: 69.141.241.189
Oct 13 15:48:58 fbx /usr/bin/plinth[521]: Dynamic domain <domain>.freedombox.rocks is up-to-date: 69.141.241.189
Oct 13 15:53:58 fbx /usr/bin/plinth[521]: Dynamic domain <domain>.freedombox.rocks is up-to-date: 69.141.241.189
Oct 13 15:58:58 fbx /usr/bin/plinth[521]: Dynamic domain <domain>.freedombox.rocks is up-to-date: 69.141.241.189
Oct 13 16:02:13 fbx /usr/bin/plinth[521]: # storage..usage_info(…)
Oct 13 16:02:14 fbx sudo[244107]: plinth : PWD=/ ; USER=root ; COMMAND=/usr/share/plinth/actions/actions storage usage_info --write-fd 16
Oct 13 16:02:14 fbx sudo[244107]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=115)
Oct 13 16:02:14 fbx /usr/bin/plinth[521]: # backups..is_mounted(…)
Oct 13 16:02:14 fbx sudo[244111]: plinth : PWD=/ ; USER=root ; COMMAND=/usr/share/plinth/actions/actions backups is_mounted --write-fd 14
Oct 13 16:02:14 fbx sudo[244111]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=115)
Oct 13 16:02:16 fbx /usr/share/plinth/actions/actions[244110]: Error executing action: Command '['df', '--exclude-type=tmpfs', '--exclude-type=devtmpfs', '--block-size=1', '--output=source,fstype,size,used,avail,pcent,target']' returned non-zero exit status 1.
Traceback (most recent call last):
File "/usr/share/plinth/actions/actions", line 93, in _call
return_values = func(*arguments['args'], **arguments['kwargs'])
^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
File "/usr/lib/python3/dist-packages/plinth/modules/storage/privileged.py", line 328, in usage_info
return subprocess.check_output(command).decode()
^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
File "/usr/lib/python3.11/subprocess.py", line 466, in check_output
return run(*popenargs, stdout=PIPE, timeout=timeout, check=True,
^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
File "/usr/lib/python3.11/subprocess.py", line 571, in run
raise CalledProcessError(retcode, process.args,
subprocess.CalledProcessError: Command '['df', '--exclude-type=tmpfs', '--exclude-type=devtmpfs', '--block-size=1', '--output=source,fstype,size,used,avail,pcent,target']' returned non-zero exit status 1.
Oct 13 16:02:17 fbx sudo[244107]: pam_unix(sudo:session): session closed for user root
Oct 13 16:02:17 fbx /usr/bin/plinth[521]: Error running action storage..usage_info(*(), **{}): Command '['df', '--exclude-type=tmpfs', '--exclude-type=devtmpfs', '--block-size=1', '--output=source,fstype,size,used,avail,pcent,target']' returned non-zero exit status 1. (1, ['df', '--exclude-type=tmpfs', '--exclude-type=devtmpfs', '--block-size=1', '--output=source,fstype,size,used,avail,pcent,target'], b'', b'df: /media/054e54ca-da9c-11ec-abca-000db93f92a8: Transport endpoint is not connected\n\x1b[31m ERROR\x1b[0m \x1b[94m__main__ \x1b[0m Error executing action: Command \'[\'df\', \'--exclude-type=tmpfs\', \'--exclude-type=devtmpfs\', \'--block-size=1\', \'--output=source,fstype,size,used,avail,pcent,target\']\' returned non-zero exit status 1.\nTraceback (most recent call last):\n File "/usr/share/plinth/actions/actions", line 93, in _call\n return_values = func(*arguments[\'args\'], **arguments[\'kwargs\'])\n ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^\n File "/usr/lib/python3/dist-packages/plinth/modules/storage/privileged.py", line 328, in usage_info\n return subprocess.check_output(command).decode()\n ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^\n File "/usr/lib/python3.11/subprocess.py", line 466, in check_output\n return run(*popenargs, stdout=PIPE, timeout=timeout, check=True,\n ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^\n File "/usr/lib/python3.11/subprocess.py", line 571, in run\n raise CalledProcessError(retcode, process.args,\nsubprocess.CalledProcessError: Command \'[\'df\', \'--exclude-type=tmpfs\', \'--exclude-type=devtmpfs\', \'--block-size=1\', \'--output=source,fstype,size,used,avail,pcent,target\']\' returned non-zero exit status 1.\n') [' File "/usr/share/plinth/actions/actions", line 93, in _call\n return_values = func(*arguments[\'args\'], **arguments[\'kwargs\'])\n ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^\n', ' File "/usr/lib/python3/dist-packages/plinth/modules/storage/privileged.py", line 328, in usage_info\n return subprocess.check_output(command).decode()\n ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^\n', ' File "/usr/lib/python3.11/subprocess.py", line 466, in check_output\n return run(*popenargs, stdout=PIPE, timeout=timeout, check=True,\n ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^\n', ' File "/usr/lib/python3.11/subprocess.py", line 571, in run\n raise CalledProcessError(retcode, process.args,\n']
Oct 13 16:02:17 fbx /usr/bin/plinth[521]: Error getting disk information: Command '['df', '--exclude-type=tmpfs', '--exclude-type=devtmpfs', '--block-size=1', '--output=source,fstype,size,used,avail,pcent,target']' returned non-zero exit status 1.
Traceback (most recent call last):
File "/usr/lib/python3/dist-packages/plinth/modules/storage/__init__.py", line 134, in _get_disks_from_df
output = privileged.usage_info()
^^^^^^^^^^^^^^^^^^^^^^^
File "/usr/lib/python3/dist-packages/plinth/actions.py", line 57, in wrapper
return _run_privileged_method_as_process(module_name, action_name,
^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
File "/usr/lib/python3/dist-packages/plinth/actions.py", line 116, in _run_privileged_method_as_process
return _wait_for_return(*wait_args)
^^^^^^^^^^^^^^^^^^^^^^^^^^^^
File "/usr/lib/python3/dist-packages/plinth/actions.py", line 154, in _wait_for_return
raise exception
subprocess.CalledProcessError: Command '['df', '--exclude-type=tmpfs', '--exclude-type=devtmpfs', '--block-size=1', '--output=source,fstype,size,used,avail,pcent,target']' returned non-zero exit status 1.
Oct 13 16:02:17 fbx sudo[244111]: pam_unix(sudo:session): session closed for user root
Oct 13 16:02:17 fbx /usr/bin/plinth[521]: # backups..is_mounted(…)
Oct 13 16:02:17 fbx sudo[244118]: plinth : PWD=/ ; USER=root ; COMMAND=/usr/share/plinth/actions/actions backups is_mounted --write-fd 15
Oct 13 16:02:17 fbx sudo[244118]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=115)
Oct 13 16:02:20 fbx sudo[244118]: pam_unix(sudo:session): session closed for user root
Oct 13 16:02:20 fbx /usr/bin/plinth[521]: # backups..mount(…)
Oct 13 16:02:20 fbx sudo[244124]: plinth : PWD=/ ; USER=root ; COMMAND=/usr/share/plinth/actions/actions backups mount --write-fd 14
Oct 13 16:02:20 fbx sudo[244124]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=115)
Oct 13 16:02:22 fbx /usr/share/plinth/actions/actions[244126]: Error executing action: [Errno 17] File exists: '/media/054e54ca-da9c-11ec-abca-000db93f92a8'
Traceback (most recent call last):
File "/usr/share/plinth/actions/actions", line 93, in _call
return_values = func(*arguments['args'], **arguments['kwargs'])
^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
File "/usr/lib/python3/dist-packages/plinth/modules/backups/privileged.py", line 29, in mount
_validate_mountpoint(mountpoint)
File "/usr/lib/python3/dist-packages/plinth/modules/backups/privileged.py", line 78, in _validate_mountpoint
os.makedirs(mountpoint)
File "<frozen os>", line 225, in makedirs
FileExistsError: [Errno 17] File exists: '/media/054e54ca-da9c-11ec-abca-000db93f92a8'
Oct 13 16:02:23 fbx sudo[244124]: pam_unix(sudo:session): session closed for user root
Oct 13 16:02:23 fbx /usr/bin/plinth[521]: Error running action backups..mount(*('/media/054e54ca-da9c-11ec-abca-000db93f92a8', '<user>@192.168.x.x:~/backups/fbx'), **{'user_known_hosts_file': '/var/lib/plinth/.ssh/known_hosts', 'password': '********'}): [Errno 17] File exists: b'' (17, 'File exists') [' File "/usr/share/plinth/actions/actions", line 93, in _call\n return_values = func(*arguments[\'args\'], **arguments[\'kwargs\'])\n ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^\n', ' File "/usr/lib/python3/dist-packages/plinth/modules/backups/privileged.py", line 29, in mount\n _validate_mountpoint(mountpoint)\n', ' File "/usr/lib/python3/dist-packages/plinth/modules/backups/privileged.py", line 78, in _validate_mountpoint\n os.makedirs(mountpoint)\n', ' File "<frozen os>", line 225, in makedirs\n']
Oct 13 16:02:23 fbx /usr/bin/plinth[521]: Error running scheduled backup: [Errno 17] File exists: b''
Traceback (most recent call last):
File "/usr/lib/python3/dist-packages/plinth/modules/backups/__init__.py", line 106, in backup_by_schedule
repository.schedule.run_schedule()
File "/usr/lib/python3/dist-packages/plinth/modules/backups/schedule.py", line 190, in run_schedule
repository.prepare()
File "/usr/lib/python3/dist-packages/plinth/modules/backups/repository.py", line 405, in prepare
self.mount()
File "/usr/lib/python3/dist-packages/plinth/modules/backups/repository.py", line 450, in mount
privileged.mount(self._mountpoint, self._path, **kwargs)
File "/usr/lib/python3/dist-packages/plinth/actions.py", line 57, in wrapper
return _run_privileged_method_as_process(module_name, action_name,
^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
File "/usr/lib/python3/dist-packages/plinth/actions.py", line 116, in _run_privileged_method_as_process
return _wait_for_return(*wait_args)
^^^^^^^^^^^^^^^^^^^^^^^^^^^^
File "/usr/lib/python3/dist-packages/plinth/actions.py", line 154, in _wait_for_return
raise exception
FileExistsError: [Errno 17] File exists: b''
Oct 13 16:03:58 fbx /usr/bin/plinth[521]: Dynamic domain <domain>.freedombox.rocks is up-to-date: 69.141.241.189
Oct 13 16:05:34 fbx /usr/bin/plinth[521]: # snapshot..get_config(…)
Oct 13 16:05:34 fbx sudo[244161]: plinth : PWD=/ ; USER=root ; COMMAND=/usr/share/plinth/actions/actions snapshot get_config --write-fd 20
Oct 13 16:05:34 fbx sudo[244161]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=115)
Oct 13 16:05:37 fbx sudo[244161]: pam_unix(sudo:session): session closed for user root
Oct 13 16:05:42 fbx /usr/bin/plinth[521]: # snapshot..list_(…)
Oct 13 16:05:42 fbx sudo[244169]: plinth : PWD=/ ; USER=root ; COMMAND=/usr/share/plinth/actions/actions snapshot list_ --write-fd 18
Oct 13 16:05:42 fbx sudo[244169]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=115)
Oct 13 16:05:45 fbx sudo[244169]: pam_unix(sudo:session): session closed for user root
Oct 13 16:07:24 fbx /usr/bin/plinth[521]: # backups..list_repo(…)
Oct 13 16:07:24 fbx sudo[244182]: plinth : PWD=/ ; USER=root ; COMMAND=/usr/share/plinth/actions/actions backups list_repo --write-fd 18
Oct 13 16:07:24 fbx sudo[244182]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=115)
Oct 13 16:07:29 fbx sudo[244182]: pam_unix(sudo:session): session closed for user root
Oct 13 16:07:29 fbx /usr/bin/plinth[521]: # backups..is_mounted(…)
Oct 13 16:07:29 fbx sudo[244187]: plinth : PWD=/ ; USER=root ; COMMAND=/usr/share/plinth/actions/actions backups is_mounted --write-fd 18
Oct 13 16:07:29 fbx sudo[244187]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=115)
Oct 13 16:07:32 fbx sudo[244187]: pam_unix(sudo:session): session closed for user root
Oct 13 16:08:45 fbx /usr/bin/plinth[521]: # backups..list_repo(…)
Oct 13 16:08:45 fbx sudo[244192]: plinth : PWD=/ ; USER=root ; COMMAND=/usr/share/plinth/actions/actions backups list_repo --write-fd 18
Oct 13 16:08:45 fbx sudo[244192]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=115)
Oct 13 16:08:50 fbx sudo[244192]: pam_unix(sudo:session): session closed for user root
Oct 13 16:08:50 fbx /usr/bin/plinth[521]: # backups..is_mounted(…)
Oct 13 16:08:50 fbx sudo[244197]: plinth : PWD=/ ; USER=root ; COMMAND=/usr/share/plinth/actions/actions backups is_mounted --write-fd 18
Oct 13 16:08:50 fbx sudo[244197]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=115)
Oct 13 16:08:53 fbx sudo[244197]: pam_unix(sudo:session): session closed for user root
Oct 13 16:08:59 fbx /usr/bin/plinth[521]: Dynamic domain <domain>.freedombox.rocks is up-to-date: 69.141.241.189
Oct 13 16:09:42 fbx /usr/bin/plinth[521]: # backups..is_mounted(…)
Oct 13 16:09:42 fbx sudo[244274]: plinth : PWD=/ ; USER=root ; COMMAND=/usr/share/plinth/actions/actions backups is_mounted --write-fd 18
Oct 13 16:09:42 fbx sudo[244274]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=115)
Oct 13 16:09:45 fbx sudo[244274]: pam_unix(sudo:session): session closed for user root
Oct 13 16:09:45 fbx /usr/bin/plinth[521]: # backups..mount(…)
Oct 13 16:09:45 fbx sudo[244279]: plinth : PWD=/ ; USER=root ; COMMAND=/usr/share/plinth/actions/actions backups mount --write-fd 18
Oct 13 16:09:45 fbx sudo[244279]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=115)
Oct 13 16:09:47 fbx /usr/share/plinth/actions/actions[244281]: Error executing action: [Errno 17] File exists: '/media/054e54ca-da9c-11ec-abca-000db93f92a8'
Traceback (most recent call last):
File "/usr/share/plinth/actions/actions", line 93, in _call
return_values = func(*arguments['args'], **arguments['kwargs'])
^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
File "/usr/lib/python3/dist-packages/plinth/modules/backups/privileged.py", line 29, in mount
_validate_mountpoint(mountpoint)
File "/usr/lib/python3/dist-packages/plinth/modules/backups/privileged.py", line 78, in _validate_mountpoint
os.makedirs(mountpoint)
File "<frozen os>", line 225, in makedirs
FileExistsError: [Errno 17] File exists: '/media/054e54ca-da9c-11ec-abca-000db93f92a8'
Oct 13 16:09:48 fbx sudo[244279]: pam_unix(sudo:session): session closed for user root
Oct 13 16:09:48 fbx /usr/bin/plinth[521]: Error running action backups..mount(*('/media/054e54ca-da9c-11ec-abca-000db93f92a8', '<user>@192.168.x.x:~/backups/fbx'), **{'user_known_hosts_file': '/var/lib/plinth/.ssh/known_hosts', 'password': '*******'}): [Errno 17] File exists: b'' (17, 'File exists') [' File "/usr/share/plinth/actions/actions", line 93, in _call\n return_values = func(*arguments[\'args\'], **arguments[\'kwargs\'])\n ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^\n', ' File "/usr/lib/python3/dist-packages/plinth/modules/backups/privileged.py", line 29, in mount\n _validate_mountpoint(mountpoint)\n', ' File "/usr/lib/python3/dist-packages/plinth/modules/backups/privileged.py", line 78, in _validate_mountpoint\n os.makedirs(mountpoint)\n', ' File "<frozen os>", line 225, in makedirs\n']
Oct 13 16:09:48 fbx /usr/bin/plinth[521]: Internal Server Error: /plinth/sys/backups/create/
Traceback (most recent call last):
File "/usr/lib/python3/dist-packages/django/core/handlers/exception.py", line 47, in inner
response = get_response(request)
^^^^^^^^^^^^^^^^^^^^^
File "/usr/lib/python3/dist-packages/django/core/handlers/base.py", line 181, in _get_response
response = wrapped_callback(request, *callback_args, **callback_kwargs)
^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
File "/usr/lib/python3/dist-packages/django/views/generic/base.py", line 70, in view
return self.dispatch(request, *args, **kwargs)
^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
File "/usr/lib/python3/dist-packages/django/views/generic/base.py", line 98, in dispatch
return handler(request, *args, **kwargs)
^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
File "/usr/lib/python3/dist-packages/django/views/generic/edit.py", line 142, in post
return self.form_valid(form)
^^^^^^^^^^^^^^^^^^^^^
File "/usr/lib/python3/dist-packages/plinth/modules/backups/views.py", line 131, in form_valid
repository.mount()
File "/usr/lib/python3/dist-packages/plinth/modules/backups/repository.py", line 450, in mount
privileged.mount(self._mountpoint, self._path, **kwargs)
File "/usr/lib/python3/dist-packages/plinth/actions.py", line 57, in wrapper
return _run_privileged_method_as_process(module_name, action_name,
^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
File "/usr/lib/python3/dist-packages/plinth/actions.py", line 116, in _run_privileged_method_as_process
return _wait_for_return(*wait_args)
^^^^^^^^^^^^^^^^^^^^^^^^^^^^
File "/usr/lib/python3/dist-packages/plinth/actions.py", line 154, in _wait_for_return
raise exception
FileExistsError: [Errno 17] File exists: b''
Oct 13 16:10:15 fbx /usr/bin/plinth[521]: # help..get_logs(…)
Oct 13 16:10:15 fbx sudo[244289]: plinth : PWD=/ ; USER=root ; COMMAND=/usr/share/plinth/actions/actions help get_logs --write-fd 18
Oct 13 16:10:15 fbx sudo[244289]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=115)
More information about the Freedombox-discuss
mailing list