[Freedombox-discuss] Backups stopped working. Where are the logs? How do I debug this?
A. F. Cano
afc54 at comcast.net
Sat Oct 14 20:03:33 BST 2023
On Fri, Oct 13, 2023 at 04:18:26PM -0700, Sunil Mohan Adapa wrote:
>
>...
> It appears that sshfs has left the mount point in a stale state. Please try
> 'sudo umount /media/054e54ca-da9c-11ec-abca-000db93f92a8' and then run backup
> again. I reboot should also work.
Ok, did the umount and then /media/054e54ca-da9c-11ec-abca-000db93f92a8
looks reasonable. But I still get an error, a different one this time:
Did a reboot too for good measure but it didn't change anything.
Backups
Error During Backup
A scheduled backup failed. Past 127 attempts for backup did not succeed. The latest error is: Command '['borg', 'list', '--json', '--format="{comment}"', '/media/054e54ca-da9c-11ec-abca-000db93f92a8']' returned non-zero exit status 2.
Did a manual backup and I got this:
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.
After seemingly working at it for a while.
The first error is this:
Oct 14 07:55:32 fbx /usr/share/plinth/actions/actions[276429]: Error executing action: Command '['borg', 'list', '--json', '--format="{comment}"', '/media/054e54ca-da9c-11ec-abca-000db93f92a8']' returned non-zero exit status 2.
The target directory seems to be mounted properly. From the FreedomBox:
$ cd /media
$ sudo ls -l 054e54ca-da9c-11ec-abca-000db93f92a8/data
total 60
drwx------ 1 fbx fbx 12288 Sep 29 2022 0
drwx------ 1 fbx fbx 12288 Feb 1 2023 1
drwx------ 1 fbx fbx 12288 Jun 8 02:17 2
drwx------ 1 fbx fbx 20480 Oct 8 03:02 3
drwx------ 1 fbx fbx 4096 Oct 12 13:07 4
The complete status log is appended below: (for the manual backup).
What else can I test? How?
Thanks.
Augustine
Oct 14 07:54:58 fbx /usr/bin/plinth[521]: # snapshot..list_(…)
Oct 14 07:54:58 fbx sudo[275963]: plinth : PWD=/ ; USER=root ; COMMAND=/usr/share/plinth/actions/actions snapshot list_ --write-fd 39
Oct 14 07:54:58 fbx sudo[275963]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=115)
Oct 14 07:55:01 fbx sudo[275963]: pam_unix(sudo:session): session closed for user root
Oct 14 07:55:19 fbx /usr/bin/plinth[521]: # backups..list_repo(…)
Oct 14 07:55:19 fbx sudo[276417]: plinth : PWD=/ ; USER=root ; COMMAND=/usr/share/plinth/actions/actions backups list_repo --write-fd 39
Oct 14 07:55:19 fbx sudo[276417]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=115)
Oct 14 07:55:24 fbx sudo[276417]: pam_unix(sudo:session): session closed for user root
Oct 14 07:55:24 fbx /usr/bin/plinth[521]: # backups..is_mounted(…)
Oct 14 07:55:24 fbx sudo[276422]: plinth : PWD=/ ; USER=root ; COMMAND=/usr/share/plinth/actions/actions backups is_mounted --write-fd 16
Oct 14 07:55:24 fbx sudo[276422]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=115)
Oct 14 07:55:27 fbx sudo[276422]: pam_unix(sudo:session): session closed for user root
Oct 14 07:55:27 fbx /usr/bin/plinth[521]: # backups..list_repo(…)
Oct 14 07:55:27 fbx sudo[276427]: plinth : PWD=/ ; USER=root ; COMMAND=/usr/share/plinth/actions/actions backups list_repo --write-fd 16
Oct 14 07:55:27 fbx sudo[276427]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=115)
Oct 14 07:55:32 fbx /usr/share/plinth/actions/actions[276429]: Error executing action: Command '['borg', 'list', '--json', '--format="{comment}"', '/media/054e54ca-da9c-11ec-abca-000db93f92a8']' returned non-zero exit status 2.
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 139, in list_repo
process = _run(['borg', 'list', '--json', '--format="{comment}"', path],
^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
File "/usr/lib/python3/dist-packages/plinth/modules/backups/privileged.py", line 352, in _run
return subprocess.run(cmd, check=check, env=env, **kwargs)
^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
File "/usr/lib/python3.11/subprocess.py", line 571, in run
raise CalledProcessError(retcode, process.args,
subprocess.CalledProcessError: Command '['borg', 'list', '--json', '--format="{comment}"', '/media/054e54ca-da9c-11ec-abca-000db93f92a8']' returned non-zero exit status 2.
Oct 14 07:55:32 fbx sudo[276427]: pam_unix(sudo:session): session closed for user root
Oct 14 07:55:32 fbx /usr/bin/plinth[521]: Error running action backups..list_repo(*('/media/054e54ca-da9c-11ec-abca-000db93f92a8', None), **{}): Command '['borg', 'list', '--json', '--format="{comment}"', '/media/054e54ca-da9c-11ec-abca-000db93f92a8']' returned non-zero exit status 2. (2, ['borg', 'list', '--json', '--format="{comment}"', '/media/054e54ca-da9c-11ec-abca-000db93f92a8'], b'', b'Cache is newer than repository - do you have multiple, independently updated repos with same ID?\n\x1b[31m ERROR\x1b[0m \x1b[94m__main__ \x1b[0m Error executing action: Command \'[\'borg\', \'list\', \'--json\', \'--format="{comment}"\', \'/media/054e54ca-da9c-11ec-abca-000db93f92a8\']\' returned non-zero exit status 2.\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/backups/privileged.py", line 139, in list_repo\n process = _run([\'borg\', \'list\', \'--json\', \'--format="{comment}"\', path],\n ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^\n File "/usr/lib/python3/dist-packages/plinth/modules/backups/privileged.py", line 352, in _run\n return subprocess.run(cmd, check=check, env=env, **kwargs)\n ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^\n File "/usr/lib/python3.11/subprocess.py", line 571, in run\n raise CalledProcessError(retcode, process.args,\nsubprocess.CalledProcessError: Command \'[\'borg\', \'list\', \'--json\', \'--format="{comment}"\', \'/media/054e54ca-da9c-11ec-abca-000db93f92a8\']\' returned non-zero exit status 2.\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/backups/privileged.py", line 139, in list_repo\n process = _run([\'borg\', \'list\', \'--json\', \'--format="{comment}"\', path],\n ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^\n', ' File "/usr/lib/python3/dist-packages/plinth/modules/backups/privileged.py", line 352, in _run\n return subprocess.run(cmd, check=check, env=env, **kwargs)\n ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^\n', ' File "/usr/lib/python3.11/subprocess.py", line 571, in run\n raise CalledProcessError(retcode, process.args,\n']
Oct 14 07:56:35 fbx /usr/bin/plinth[521]: # backups..is_mounted(…)
Oct 14 07:56:36 fbx sudo[276436]: plinth : PWD=/ ; USER=root ; COMMAND=/usr/share/plinth/actions/actions backups is_mounted --write-fd 16
Oct 14 07:56:36 fbx sudo[276436]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=115)
Oct 14 07:56:38 fbx sudo[276436]: pam_unix(sudo:session): session closed for user root
Oct 14 07:56:38 fbx /usr/bin/plinth[521]: # plinth..stop(…)
Oct 14 07:56:38 fbx sudo[276442]: plinth : PWD=/ ; USER=root ; COMMAND=/usr/share/plinth/actions/actions plinth stop --write-fd 16
Oct 14 07:56:38 fbx sudo[276442]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=115)
Oct 14 07:56:43 fbx /usr/share/plinth/actions/actions[276444]: Initialized apps - apache, api, names, avahi, storage, backups, cockpit, firewall, config, datetime, diagnostics, dynamicdns, first_boot, help, letsencrypt, networks, power, privacy, security, snapshot, ssh, sso, upgrades, users, bepasty, bind, calibre, coturn, deluge, ejabberd, email, gitweb, i2p, ikiwiki, infinoted, janus, jsxc, matrixsynapse, mediawiki, minetest, minidlna, mumble, openvpn, pagekite, performance, privoxy, quassel, radicale, roundcube, rssbridge, samba, searx, shaarli, shadowsocks, shadowsocksserver, sharing, syncthing, tor, torproxy, transmission, ttrss, wireguard, wordpress, zoph
Oct 14 07:56:45 fbx /usr/bin/plinth[521]: # apache..disable(…)
Oct 14 07:56:45 fbx sudo[276455]: plinth : PWD=/ ; USER=root ; COMMAND=/usr/share/plinth/actions/actions apache disable --write-fd 16
Oct 14 07:56:45 fbx sudo[276455]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=115)
Oct 14 07:56:49 fbx sudo[276455]: pam_unix(sudo:session): session closed for user root
Oct 14 07:56:49 fbx /usr/bin/plinth[521]: # plinth..stop(…)
Oct 14 07:56:49 fbx sudo[276534]: plinth : PWD=/ ; USER=root ; COMMAND=/usr/share/plinth/actions/actions plinth stop --write-fd 16
Oct 14 07:56:49 fbx sudo[276534]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=115)
Oct 14 07:56:53 fbx /usr/share/plinth/actions/actions[276536]: Initialized apps - apache, api, names, avahi, storage, backups, cockpit, firewall, config, datetime, diagnostics, dynamicdns, first_boot, help, letsencrypt, networks, power, privacy, security, snapshot, ssh, sso, upgrades, users, bepasty, bind, calibre, coturn, deluge, ejabberd, email, gitweb, i2p, ikiwiki, infinoted, janus, jsxc, matrixsynapse, mediawiki, minetest, minidlna, mumble, openvpn, pagekite, performance, privoxy, quassel, radicale, roundcube, rssbridge, samba, searx, shaarli, shadowsocks, shadowsocksserver, sharing, syncthing, tor, torproxy, transmission, ttrss, wireguard, wordpress, zoph
Oct 14 07:56:59 fbx sudo[276534]: pam_unix(sudo:session): session closed for user root
Oct 14 07:56:59 fbx /usr/bin/plinth[521]: # plinth..stop(…)
Oct 14 07:56:59 fbx sudo[276644]: plinth : PWD=/ ; USER=root ; COMMAND=/usr/share/plinth/actions/actions plinth stop --write-fd 16
Oct 14 07:56:59 fbx sudo[276644]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=115)
Oct 14 07:57:03 fbx /usr/share/plinth/actions/actions[276646]: Initialized apps - apache, api, names, avahi, storage, backups, cockpit, firewall, config, datetime, diagnostics, dynamicdns, first_boot, help, letsencrypt, networks, power, privacy, security, snapshot, ssh, sso, upgrades, users, bepasty, bind, calibre, coturn, deluge, ejabberd, email, gitweb, i2p, ikiwiki, infinoted, janus, jsxc, matrixsynapse, mediawiki, minetest, minidlna, mumble, openvpn, pagekite, performance, privoxy, quassel, radicale, roundcube, rssbridge, samba, searx, shaarli, shadowsocks, shadowsocksserver, sharing, syncthing, tor, torproxy, transmission, ttrss, wireguard, wordpress, zoph
Oct 14 07:57:04 fbx sudo[276644]: pam_unix(sudo:session): session closed for user root
Oct 14 07:57:04 fbx /usr/bin/plinth[521]: # plinth..stop(…)
Oct 14 07:57:05 fbx sudo[276657]: plinth : PWD=/ ; USER=root ; COMMAND=/usr/share/plinth/actions/actions plinth stop --write-fd 16
Oct 14 07:57:05 fbx sudo[276657]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=115)
Oct 14 07:57:09 fbx /usr/share/plinth/actions/actions[276659]: Initialized apps - apache, api, names, avahi, storage, backups, cockpit, firewall, config, datetime, diagnostics, dynamicdns, first_boot, help, letsencrypt, networks, power, privacy, security, snapshot, ssh, sso, upgrades, users, bepasty, bind, calibre, coturn, deluge, ejabberd, email, gitweb, i2p, ikiwiki, infinoted, janus, jsxc, matrixsynapse, mediawiki, minetest, minidlna, mumble, openvpn, pagekite, performance, privoxy, quassel, radicale, roundcube, rssbridge, samba, searx, shaarli, shadowsocks, shadowsocksserver, sharing, syncthing, tor, torproxy, transmission, ttrss, wireguard, wordpress, zoph
Oct 14 07:57:10 fbx sudo[276657]: pam_unix(sudo:session): session closed for user root
Oct 14 07:57:10 fbx /usr/bin/plinth[521]: # plinth..stop(…)
Oct 14 07:57:10 fbx sudo[276666]: plinth : PWD=/ ; USER=root ; COMMAND=/usr/share/plinth/actions/actions plinth stop --write-fd 16
Oct 14 07:57:10 fbx sudo[276666]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=115)
Oct 14 07:57:14 fbx /usr/share/plinth/actions/actions[276668]: Initialized apps - apache, api, names, avahi, storage, backups, cockpit, firewall, config, datetime, diagnostics, dynamicdns, first_boot, help, letsencrypt, networks, power, privacy, security, snapshot, ssh, sso, upgrades, users, bepasty, bind, calibre, coturn, deluge, ejabberd, email, gitweb, i2p, ikiwiki, infinoted, janus, jsxc, matrixsynapse, mediawiki, minetest, minidlna, mumble, openvpn, pagekite, performance, privoxy, quassel, radicale, roundcube, rssbridge, samba, searx, shaarli, shadowsocks, shadowsocksserver, sharing, syncthing, tor, torproxy, transmission, ttrss, wireguard, wordpress, zoph
Oct 14 07:57:15 fbx sudo[276666]: pam_unix(sudo:session): session closed for user root
Oct 14 07:57:15 fbx /usr/bin/plinth[521]: # plinth..stop(…)
Oct 14 07:57:15 fbx sudo[276675]: plinth : PWD=/ ; USER=root ; COMMAND=/usr/share/plinth/actions/actions plinth stop --write-fd 16
Oct 14 07:57:15 fbx sudo[276675]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=115)
Oct 14 07:57:19 fbx /usr/share/plinth/actions/actions[276677]: Initialized apps - apache, api, names, avahi, storage, backups, cockpit, firewall, config, datetime, diagnostics, dynamicdns, first_boot, help, letsencrypt, networks, power, privacy, security, snapshot, ssh, sso, upgrades, users, bepasty, bind, calibre, coturn, deluge, ejabberd, email, gitweb, i2p, ikiwiki, infinoted, janus, jsxc, matrixsynapse, mediawiki, minetest, minidlna, mumble, openvpn, pagekite, performance, privoxy, quassel, radicale, roundcube, rssbridge, samba, searx, shaarli, shadowsocks, shadowsocksserver, sharing, syncthing, tor, torproxy, transmission, ttrss, wireguard, wordpress, zoph
Oct 14 07:57:28 fbx sudo[276675]: pam_unix(sudo:session): session closed for user root
Oct 14 07:57:28 fbx /usr/bin/plinth[521]: # plinth..stop(…)
Oct 14 07:57:28 fbx sudo[276781]: plinth : PWD=/ ; USER=root ; COMMAND=/usr/share/plinth/actions/actions plinth stop --write-fd 16
Oct 14 07:57:28 fbx sudo[276781]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=115)
Oct 14 07:57:33 fbx /usr/share/plinth/actions/actions[276783]: Initialized apps - apache, api, names, avahi, storage, backups, cockpit, firewall, config, datetime, diagnostics, dynamicdns, first_boot, help, letsencrypt, networks, power, privacy, security, snapshot, ssh, sso, upgrades, users, bepasty, bind, calibre, coturn, deluge, ejabberd, email, gitweb, i2p, ikiwiki, infinoted, janus, jsxc, matrixsynapse, mediawiki, minetest, minidlna, mumble, openvpn, pagekite, performance, privoxy, quassel, radicale, roundcube, rssbridge, samba, searx, shaarli, shadowsocks, shadowsocksserver, sharing, syncthing, tor, torproxy, transmission, ttrss, wireguard, wordpress, zoph
Oct 14 07:57:33 fbx sudo[276781]: pam_unix(sudo:session): session closed for user root
Oct 14 07:57:33 fbx /usr/bin/plinth[521]: Running backup_pre hooks
Oct 14 07:57:33 fbx /usr/bin/plinth[521]: # backups..dump_settings(…)
Oct 14 07:57:34 fbx sudo[276790]: plinth : PWD=/ ; USER=root ; COMMAND=/usr/share/plinth/actions/actions backups dump_settings --write-fd 16
Oct 14 07:57:34 fbx sudo[276790]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=115)
Oct 14 07:57:36 fbx sudo[276790]: pam_unix(sudo:session): session closed for user root
Oct 14 07:57:36 fbx /usr/bin/plinth[521]: # zoph..dump_database(…)
Oct 14 07:57:36 fbx sudo[276794]: plinth : PWD=/ ; USER=root ; COMMAND=/usr/share/plinth/actions/actions zoph dump_database --write-fd 16
Oct 14 07:57:36 fbx sudo[276794]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=115)
Oct 14 07:57:41 fbx sudo[276794]: pam_unix(sudo:session): session closed for user root
Oct 14 07:57:41 fbx /usr/bin/plinth[521]: # backups..create_archive(…)
Oct 14 07:57:41 fbx sudo[276800]: plinth : PWD=/ ; USER=root ; COMMAND=/usr/share/plinth/actions/actions backups create_archive --write-fd 16
Oct 14 07:57:41 fbx sudo[276800]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=115)
Oct 14 07:57:45 fbx /usr/share/plinth/actions/actions[276802]: Error executing action: Command '['borg', 'create', '--json', '/media/054e54ca-da9c-11ec-abca-000db93f92a8::manual backup to track down error 2', '/etc/ez-ipupdate/', '/etc/letsencrypt/', '/etc/coturn', '/var/lib/ejabberd/', '/etc/ejabberd/letsencrypt/', '/var/lib/ikiwiki/', '/var/www/ikiwiki/', '/var/lib/infinoted/', '/etc/matrix-synapse/conf.d/', '/var/lib/matrix-synapse/media/', '/var/lib/mumble-server', '/etc/radicale/', '/var/lib/radicale/', '/var/lib/shaarli/data', '/var/lib/syncthing/.config', '/var/lib/zoph/', '/etc/localtime', '/var/lib/plinth/backups-data/dynamicdns-settings.json', '/etc/popularity-contest.d/freedombox.conf', '/etc/snapper/configs/root', '/etc/default/snapper', '/etc/ssh/sshd_config.d/freedombox.conf', '/etc/ssh/ssh_host_ecdsa_key', '/etc/ssh/ssh_host_ecdsa_key.pub', '/etc/ssh/ssh_host_ed25519_key', '/etc/ssh/ssh_host_ed25519_key.pub', '/etc/ssh/ssh_host_rsa_key', '/etc/ssh/ssh_host_rsa_key.pub', '/etc/apt/apt.conf.d/20auto-upgrades', '/etc/ejabberd/ejabberd.yml', '/etc/ejabberd/ejabberd.pem', '/etc/infinoted/infinoted-cert.pem', '/etc/infinoted/infinoted-key.pem', '/etc/matrix-synapse/homeserver.yaml', '/etc/matrix-synapse/log.yaml', '/var/lib/matrix-synapse/homeserver.db', '/etc/matrix-synapse/homeserver.signing.key', '/etc/matrix-synapse/homeserver.tls.crt', '/etc/matrix-synapse/homeserver.tls.key', '/etc/mumble-server.ini', '/etc/roundcube/freedombox-config.php', '/var/lib/dbconfig-common/sqlite3/roundcube/roundcube', '/etc/apache2/conf-available/sharing-freedombox.conf', '/var/lib/plinth/backups-data/zoph-database.sql', '/etc/zoph.ini', '/var/lib/plinth/backups-manifests/media054e54ca-da9c-11ec-abca-000db93f92a8manual_backup_to_track_down_error_2.json']' returned non-zero exit status 2.
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 166, in create_archive
_run(command, encryption_passphrase)
File "/usr/lib/python3/dist-packages/plinth/modules/backups/privileged.py", line 352, in _run
return subprocess.run(cmd, check=check, env=env, **kwargs)
^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
File "/usr/lib/python3.11/subprocess.py", line 571, in run
raise CalledProcessError(retcode, process.args,
subprocess.CalledProcessError: Command '['borg', 'create', '--json', '/media/054e54ca-da9c-11ec-abca-000db93f92a8::manual backup to track down error 2', '/etc/ez-ipupdate/', '/etc/letsencrypt/', '/etc/coturn', '/var/lib/ejabberd/', '/etc/ejabberd/letsencrypt/', '/var/lib/ikiwiki/', '/var/www/ikiwiki/', '/var/lib/infinoted/', '/etc/matrix-synapse/conf.d/', '/var/lib/matrix-synapse/media/', '/var/lib/mumble-server', '/etc/radicale/', '/var/lib/radicale/', '/var/lib/shaarli/data', '/var/lib/syncthing/.config', '/var/lib/zoph/', '/etc/localtime', '/var/lib/plinth/backups-data/dynamicdns-settings.json', '/etc/popularity-contest.d/freedombox.conf', '/etc/snapper/configs/root', '/etc/default/snapper', '/etc/ssh/sshd_config.d/freedombox.conf', '/etc/ssh/ssh_host_ecdsa_key', '/etc/ssh/ssh_host_ecdsa_key.pub', '/etc/ssh/ssh_host_ed25519_key', '/etc/ssh/ssh_host_ed25519_key.pub', '/etc/ssh/ssh_host_rsa_key', '/etc/ssh/ssh_host_rsa_key.pub', '/etc/apt/apt.conf.d/20auto-upgrades', '/etc/ejabberd/ejabberd.yml', '/etc/ejabberd/ejabberd.pem', '/etc/infinoted/infinoted-cert.pem', '/etc/infinoted/infinoted-key.pem', '/etc/matrix-synapse/homeserver.yaml', '/etc/matrix-synapse/log.yaml', '/var/lib/matrix-synapse/homeserver.db', '/etc/matrix-synapse/homeserver.signing.key', '/etc/matrix-synapse/homeserver.tls.crt', '/etc/matrix-synapse/homeserver.tls.key', '/etc/mumble-server.ini', '/etc/roundcube/freedombox-config.php', '/var/lib/dbconfig-common/sqlite3/roundcube/roundcube', '/etc/apache2/conf-available/sharing-freedombox.conf', '/var/lib/plinth/backups-data/zoph-database.sql', '/etc/zoph.ini', '/var/lib/plinth/backups-manifests/media054e54ca-da9c-11ec-abca-000db93f92a8manual_backup_to_track_down_error_2.json']' returned non-zero exit status 2.
Oct 14 07:57:46 fbx sudo[276800]: pam_unix(sudo:session): session closed for user root
Oct 14 07:57:46 fbx /usr/bin/plinth[521]: Error running action backups..create_archive(*('/media/054e54ca-da9c-11ec-abca-000db93f92a8::manual backup to track down error 2', ['/etc/ez-ipupdate/', '/etc/letsencrypt/', '/etc/coturn', '/var/lib/ejabberd/', '/etc/ejabberd/letsencrypt/', '/var/lib/ikiwiki/', '/var/www/ikiwiki/', '/var/lib/infinoted/', '/etc/matrix-synapse/conf.d/', '/var/lib/matrix-synapse/media/', '/var/lib/matrix-synapse/uploads/', '/var/lib/mumble-server', '/etc/radicale/', '/var/lib/radicale/', '/var/lib/shaarli/data', '/var/lib/syncthing/.config', '/var/lib/zoph/', '/etc/localtime', '/var/lib/plinth/backups-data/dynamicdns-settings.json', '/etc/popularity-contest.d/freedombox.conf', '/etc/security/access.d/50freedombox.conf', '/etc/snapper/configs/root', '/etc/default/snapper', '/etc/ssh/sshd_config.d/freedombox.conf', '/etc/ssh/ssh_host_ecdsa_key', '/etc/ssh/ssh_host_ecdsa_key.pub', '/etc/ssh/ssh_host_ed25519_key', '/etc/ssh/ssh_host_ed25519_key.pub', '/etc/ssh/ssh_host_rsa_key', '/etc/ssh/ssh_host_rsa_key.pub', '/etc/apt/apt.conf.d/20auto-upgrades', '/etc/ejabberd/ejabberd.yml', '/etc/ejabberd/ejabberd.pem', '/etc/infinoted/infinoted-cert.pem', '/etc/infinoted/infinoted-key.pem', '/etc/matrix-synapse/homeserver.yaml', '/etc/matrix-synapse/log.yaml', '/var/lib/matrix-synapse/homeserver.db', '/etc/matrix-synapse/homeserver.signing.key', '/etc/matrix-synapse/homeserver.tls.crt', '/etc/matrix-synapse/homeserver.tls.dh', '/etc/matrix-synapse/homeserver.tls.key', '/etc/mumble-server.ini', '/etc/roundcube/freedombox-config.php', '/var/lib/dbconfig-common/sqlite3/roundcube/roundcube', '/etc/searx/allow_public_access', '/etc/apache2/conf-available/sharing-freedombox.conf', '/var/lib/plinth/backups-data/zoph-database.sql', '/etc/zoph.ini', '/var/lib/plinth/backups-manifests/media054e54ca-da9c-11ec-abca-000db93f92a8manual_backup_to_track_down_error_2.json']), **{'comment': None, 'encryption_passphrase': None}): Command '['borg', 'create', '--json', '/media/054e54ca-da9c-11ec-abca-000db93f92a8::manual backup to track down error 2', '/etc/ez-ipupdate/', '/etc/letsencrypt/', '/etc/coturn', '/var/lib/ejabberd/', '/etc/ejabberd/letsencrypt/', '/var/lib/ikiwiki/', '/var/www/ikiwiki/', '/var/lib/infinoted/', '/etc/matrix-synapse/conf.d/', '/var/lib/matrix-synapse/media/', '/var/lib/mumble-server', '/etc/radicale/', '/var/lib/radicale/', '/var/lib/shaarli/data', '/var/lib/syncthing/.config', '/var/lib/zoph/', '/etc/localtime', '/var/lib/plinth/backups-data/dynamicdns-settings.json', '/etc/popularity-contest.d/freedombox.conf', '/etc/snapper/configs/root', '/etc/default/snapper', '/etc/ssh/sshd_config.d/freedombox.conf', '/etc/ssh/ssh_host_ecdsa_key', '/etc/ssh/ssh_host_ecdsa_key.pub', '/etc/ssh/ssh_host_ed25519_key', '/etc/ssh/ssh_host_ed25519_key.pub', '/etc/ssh/ssh_host_rsa_key', '/etc/ssh/ssh_host_rsa_key.pub', '/etc/apt/apt.conf.d/20auto-upgrades', '/etc/ejabberd/ejabberd.yml', '/etc/ejabberd/ejabberd.pem', '/etc/infinoted/infinoted-cert.pem', '/etc/infinoted/infinoted-key.pem', '/etc/matrix-synapse/homeserver.yaml', '/etc/matrix-synapse/log.yaml', '/var/lib/matrix-synapse/homeserver.db', '/etc/matrix-synapse/homeserver.signing.key', '/etc/matrix-synapse/homeserver.tls.crt', '/etc/matrix-synapse/homeserver.tls.key', '/etc/mumble-server.ini', '/etc/roundcube/freedombox-config.php', '/var/lib/dbconfig-common/sqlite3/roundcube/roundcube', '/etc/apache2/conf-available/sharing-freedombox.conf', '/var/lib/plinth/backups-data/zoph-database.sql', '/etc/zoph.ini', '/var/lib/plinth/backups-manifests/media054e54ca-da9c-11ec-abca-000db93f92a8manual_backup_to_track_down_error_2.json']' returned non-zero exit status 2. (2, ['borg', 'create', '--json', '/media/054e54ca-da9c-11ec-abca-000db93f92a8::manual backup to track down error 2', '/etc/ez-ipupdate/', '/etc/letsencrypt/', '/etc/coturn', '/var/lib/ejabberd/', '/etc/ejabberd/letsencrypt/', '/var/lib/ikiwiki/', '/var/www/ikiwiki/', '/var/lib/infinoted/', '/etc/matrix-synapse/conf.d/', '/var/lib/matrix-synapse/media/', '/var/lib/mumble-server', '/etc/radicale/', '/var/lib/radicale/', '/var/lib/shaarli/data', '/var/lib/syncthing/.config', '/var/lib/zoph/', '/etc/localtime', '/var/lib/plinth/backups-data/dynamicdns-settings.json', '/etc/popularity-contest.d/freedombox.conf', '/etc/snapper/configs/root', '/etc/default/snapper', '/etc/ssh/sshd_config.d/freedombox.conf', '/etc/ssh/ssh_host_ecdsa_key', '/etc/ssh/ssh_host_ecdsa_key.pub', '/etc/ssh/ssh_host_ed25519_key', '/etc/ssh/ssh_host_ed25519_key.pub', '/etc/ssh/ssh_host_rsa_key', '/etc/ssh/ssh_host_rsa_key.pub', '/etc/apt/apt.conf.d/20auto-upgrades', '/etc/ejabberd/ejabberd.yml', '/etc/ejabberd/ejabberd.pem', '/etc/infinoted/infinoted-cert.pem', '/etc/infinoted/infinoted-key.pem', '/etc/matrix-synapse/homeserver.yaml', '/etc/matrix-synapse/log.yaml', '/var/lib/matrix-synapse/homeserver.db', '/etc/matrix-synapse/homeserver.signing.key', '/etc/matrix-synapse/homeserver.tls.crt', '/etc/matrix-synapse/homeserver.tls.key', '/etc/mumble-server.ini', '/etc/roundcube/freedombox-config.php', '/var/lib/dbconfig-common/sqlite3/roundcube/roundcube', '/etc/apache2/conf-available/sharing-freedombox.conf', '/var/lib/plinth/backups-data/zoph-database.sql', '/etc/zoph.ini', '/var/lib/plinth/backups-manifests/media054e54ca-da9c-11ec-abca-000db93f92a8manual_backup_to_track_down_error_2.json'], b'', b'Cache is newer than repository - do you have multiple, independently updated repos with same ID?\n\x1b[31m ERROR\x1b[0m \x1b[94m__main__ \x1b[0m Error executing action: Command \'[\'borg\', \'create\', \'--json\', \'/media/054e54ca-da9c-11ec-abca-000db93f92a8::manual backup to track down error 2\', \'/etc/ez-ipupdate/\', \'/etc/letsencrypt/\', \'/etc/coturn\', \'/var/lib/ejabberd/\', \'/etc/ejabberd/letsencrypt/\', \'/var/lib/ikiwiki/\', \'/var/www/ikiwiki/\', \'/var/lib/infinoted/\', \'/etc/matrix-synapse/conf.d/\', \'/var/lib/matrix-synapse/media/\', \'/var/lib/mumble-server\', \'/etc/radicale/\', \'/var/lib/radicale/\', \'/var/lib/shaarli/data\', \'/var/lib/syncthing/.config\', \'/var/lib/zoph/\', \'/etc/localtime\', \'/var/lib/plinth/backups-data/dynamicdns-settings.json\', \'/etc/popularity-contest.d/freedombox.conf\', \'/etc/snapper/configs/root\', \'/etc/default/snapper\', \'/etc/ssh/sshd_config.d/freedombox.conf\', \'/etc/ssh/ssh_host_ecdsa_key\', \'/etc/ssh/ssh_host_ecdsa_key.pub\', \'/etc/ssh/ssh_host_ed25519_key\', \'/etc/ssh/ssh_host_ed25519_key.pub\', \'/etc/ssh/ssh_host_rsa_key\', \'/etc/ssh/ssh_host_rsa_key.pub\', \'/etc/apt/apt.conf.d/20auto-upgrades\', \'/etc/ejabberd/ejabberd.yml\', \'/etc/ejabberd/ejabberd.pem\', \'/etc/infinoted/infinoted-cert.pem\', \'/etc/infinoted/infinoted-key.pem\', \'/etc/matrix-synapse/homeserver.yaml\', \'/etc/matrix-synapse/log.yaml\', \'/var/lib/matrix-synapse/homeserver.db\', \'/etc/matrix-synapse/homeserver.signing.key\', \'/etc/matrix-synapse/homeserver.tls.crt\', \'/etc/matrix-synapse/homeserver.tls.key\', \'/etc/mumble-server.ini\', \'/etc/roundcube/freedombox-config.php\', \'/var/lib/dbconfig-common/sqlite3/roundcube/roundcube\', \'/etc/apache2/conf-available/sharing-freedombox.conf\', \'/var/lib/plinth/backups-data/zoph-database.sql\', \'/etc/zoph.ini\', \'/var/lib/plinth/backups-manifests/media054e54ca-da9c-11ec-abca-000db93f92a8manual_backup_to_track_down_error_2.json\']\' returned non-zero exit status 2.\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/backups/privileged.py", line 166, in create_archive\n _run(command, encryption_passphrase)\n File "/usr/lib/python3/dist-packages/plinth/modules/backups/privileged.py", line 352, in _run\n return subprocess.run(cmd, check=check, env=env, **kwargs)\n ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^\n File "/usr/lib/python3.11/subprocess.py", line 571, in run\n raise CalledProcessError(retcode, process.args,\nsubprocess.CalledProcessError: Command \'[\'borg\', \'create\', \'--json\', \'/media/054e54ca-da9c-11ec-abca-000db93f92a8::manual backup to track down error 2\', \'/etc/ez-ipupdate/\', \'/etc/letsencrypt/\', \'/etc/coturn\', \'/var/lib/ejabberd/\', \'/etc/ejabberd/letsencrypt/\', \'/var/lib/ikiwiki/\', \'/var/www/ikiwiki/\', \'/var/lib/infinoted/\', \'/etc/matrix-synapse/conf.d/\', \'/var/lib/matrix-synapse/media/\', \'/var/lib/mumble-server\', \'/etc/radicale/\', \'/var/lib/radicale/\', \'/var/lib/shaarli/data\', \'/var/lib/syncthing/.config\', \'/var/lib/zoph/\', \'/etc/localtime\', \'/var/lib/plinth/backups-data/dynamicdns-settings.json\', \'/etc/popularity-contest.d/freedombox.conf\', \'/etc/snapper/configs/root\', \'/etc/default/snapper\', \'/etc/ssh/sshd_config.d/freedombox.conf\', \'/etc/ssh/ssh_host_ecdsa_key\', \'/etc/ssh/ssh_host_ecdsa_key.pub\', \'/etc/ssh/ssh_host_ed25519_key\', \'/etc/ssh/ssh_host_ed25519_key.pub\', \'/etc/ssh/ssh_host_rsa_key\', \'/etc/ssh/ssh_host_rsa_key.pub\', \'/etc/apt/apt.conf.d/20auto-upgrades\', \'/etc/ejabberd/ejabberd.yml\', \'/etc/ejabberd/ejabberd.pem\', \'/etc/infinoted/infinoted-cert.pem\', \'/etc/infinoted/infinoted-key.pem\', \'/etc/matrix-synapse/homeserver.yaml\', \'/etc/matrix-synapse/log.yaml\', \'/var/lib/matrix-synapse/homeserver.db\', \'/etc/matrix-synapse/homeserver.signing.key\', \'/etc/matrix-synapse/homeserver.tls.crt\', \'/etc/matrix-synapse/homeserver.tls.key\', \'/etc/mumble-server.ini\', \'/etc/roundcube/freedombox-config.php\', \'/var/lib/dbconfig-common/sqlite3/roundcube/roundcube\', \'/etc/apache2/conf-available/sharing-freedombox.conf\', \'/var/lib/plinth/backups-data/zoph-database.sql\', \'/etc/zoph.ini\', \'/var/lib/plinth/backups-manifests/media054e54ca-da9c-11ec-abca-000db93f92a8manual_backup_to_track_down_error_2.json\']\' returned non-zero exit status 2.\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/backups/privileged.py", line 166, in create_archive\n _run(command, encryption_passphrase)\n', ' File "/usr/lib/python3/dist-packages/plinth/modules/backups/privileged.py", line 352, in _run\n return subprocess.run(cmd, check=check, env=env, **kwargs)\n ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^\n', ' File "/usr/lib/python3.11/subprocess.py", line 571, in run\n raise CalledProcessError(retcode, process.args,\n']
Oct 14 07:57:46 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 136, in form_valid
repository.create_archive(name, selected_apps)
File "/usr/lib/python3/dist-packages/plinth/modules/backups/repository.py", line 183, in create_archive
api.backup_apps(_backup_handler, path=archive_path, app_ids=app_ids,
File "/usr/lib/python3/dist-packages/plinth/modules/backups/api.py", line 131, in backup_apps
_run_operation(backup_handler, packet,
File "/usr/lib/python3/dist-packages/plinth/modules/backups/api.py", line 423, in _run_operation
handler(packet, encryption_passphrase=encryption_passphrase)
File "/usr/lib/python3/dist-packages/plinth/modules/backups/__init__.py", line 96, in _backup_handler
privileged.create_archive(packet.path, paths,
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 '['borg', 'create', '--json', '/media/054e54ca-da9c-11ec-abca-000db93f92a8::manual backup to track down error 2', '/etc/ez-ipupdate/', '/etc/letsencrypt/', '/etc/coturn', '/var/lib/ejabberd/', '/etc/ejabberd/letsencrypt/', '/var/lib/ikiwiki/', '/var/www/ikiwiki/', '/var/lib/infinoted/', '/etc/matrix-synapse/conf.d/', '/var/lib/matrix-synapse/media/', '/var/lib/mumble-server', '/etc/radicale/', '/var/lib/radicale/', '/var/lib/shaarli/data', '/var/lib/syncthing/.config', '/var/lib/zoph/', '/etc/localtime', '/var/lib/plinth/backups-data/dynamicdns-settings.json', '/etc/popularity-contest.d/freedombox.conf', '/etc/snapper/configs/root', '/etc/default/snapper', '/etc/ssh/sshd_config.d/freedombox.conf', '/etc/ssh/ssh_host_ecdsa_key', '/etc/ssh/ssh_host_ecdsa_key.pub', '/etc/ssh/ssh_host_ed25519_key', '/etc/ssh/ssh_host_ed25519_key.pub', '/etc/ssh/ssh_host_rsa_key', '/etc/ssh/ssh_host_rsa_key.pub', '/etc/apt/apt.conf.d/20auto-upgrades', '/etc/ejabberd/ejabberd.yml', '/etc/ejabberd/ejabberd.pem', '/etc/infinoted/infinoted-cert.pem', '/etc/infinoted/infinoted-key.pem', '/etc/matrix-synapse/homeserver.yaml', '/etc/matrix-synapse/log.yaml', '/var/lib/matrix-synapse/homeserver.db', '/etc/matrix-synapse/homeserver.signing.key', '/etc/matrix-synapse/homeserver.tls.crt', '/etc/matrix-synapse/homeserver.tls.key', '/etc/mumble-server.ini', '/etc/roundcube/freedombox-config.php', '/var/lib/dbconfig-common/sqlite3/roundcube/roundcube', '/etc/apache2/conf-available/sharing-freedombox.conf', '/var/lib/plinth/backups-data/zoph-database.sql', '/etc/zoph.ini', '/var/lib/plinth/backups-manifests/media054e54ca-da9c-11ec-abca-000db93f92a8manual_backup_to_track_down_error_2.json']' returned non-zero exit status 2.
Oct 14 07:58:19 fbx /usr/bin/plinth[521]: # help..get_logs(…)
Oct 14 07:58:19 fbx sudo[276996]: plinth : PWD=/ ; USER=root ; COMMAND=/usr/share/plinth/actions/actions help get_logs --write-fd 16
Oct 14 07:58:19 fbx sudo[276996]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=115)
More information about the Freedombox-discuss
mailing list