Skip to content
New issue

Have a question about this project? Sign up for a free GitHub account to open an issue and contact its maintainers and the community.

Sign up for GitHub

By clicking “Sign up for GitHub”, you agree to our terms of service and privacy statement. We’ll occasionally send you account related emails.

Already on GitHub? Sign in to your account

Jump to bottom

[CRITICAL BUG] Triggering a backup chmods / to 700, causing immediate crash & unbootable PC #974

Closed
bentolor opened this issue Feb 5, 2019 · 4 comments · Fixed by #1058
Closed

[CRITICAL BUG] Triggering a backup chmods / to 700, causing immediate crash & unbootable PC #974

bentolor opened this issue Feb 5, 2019 · 4 comments · Fixed by #1058

Comments

@bentolor
Copy link

bentolor commented Feb 5, 2019 •
edited

Problem description

Starting a backup changes the permission of / from 755 to 700 which makes the PC immediately crash, (shells crash, windows closes) and makes the PC unbootable. I needed several hours to figure out the problem and then was finally able to pinpoint it down to BIT as problem source.

Due to the changes permission, any non-root user cannot access / execute any command, unless you boot a live CD and restore the original permissions of the root-directory of the root partition.

Debug

root@n223:~# ls -Fdl /
drwxr-xr-x 25 root root 4096 Feb  4 18:29 //

# Starting BIT-Backup. Then…

root@n223:~# ls -Fdl /
drwx------ 25 root root 4096 Feb  4 18:29 //

Here is the full terminal output:

 ben@n223 /u/l/systemd  $ pkexec backintime-qt --debug
DEBUG: [common/backintime.py:585 argParse] Arguments: {'debug': True} | unknownArgs: []

Back In Time
Version: 1.2.0~alpha17

Back In Time comes with ABSOLUTELY NO WARRANTY.
This is free software, and you are welcome to redistribute it
under certain conditions; type `backintime --license' for details.

DEBUG: [common/backintime.py:670 getConfig] config file: /root/.config/backintime/config
DEBUG: [common/backintime.py:671 getConfig] share path: /root/.local/share/backintime
DEBUG: [common/backintime.py:673 getConfig] profiles: 1=Hauptprofil
DEBUG: [common/pluginmanager.py:90 PluginManager.load] Register plugin path /usr/share/backintime/plugins
DEBUG: [common/pluginmanager.py:106 PluginManager.load] Add plugin notifyplugin.py
DEBUG: [common/pluginmanager.py:106 PluginManager.load] Add plugin userscriptsplugin.py
DEBUG: [common/pluginmanager.py:106 PluginManager.load] Add plugin qt4plugin.py
QStandardPaths: XDG_RUNTIME_DIR not set, defaulting to '/tmp/runtime-root'
DEBUG: [common/tools.py:795 keyringSupported] No keyring due to import error.
DEBUG: [common/tools.py:795 keyringSupported] No keyring due to import error.
DEBUG: [common/tools.py:795 keyringSupported] No keyring due to import error.
DEBUG: [common/sshtools.py:224 SSH.startSshAgent] ssh-agent started successful: SSH_AUTH_SOCK=/tmp/ssh-twT077A4DJlH/agent.14683 | SSH_AGENT_PID=14684
DEBUG: [common/sshtools.py:267 SSH.unlockSshAgent] Add private key /root/.ssh/id_rsa to ssh agent
DEBUG: [common/sshtools.py:272 SSH.unlockSshAgent] Password available: True
DEBUG: [common/sshtools.py:288 SSH.unlockSshAgent] Provide password through temp FIFO
DEBUG: [common/encfstools.py:222 EncFS_SSH.mount] Mount sshfs
DEBUG: [common/mount.py:678 SSH.mountProcessLockAcquire] Acquire mountprocess lock /root/.local/share/backintime/mnt/14676.lock
DEBUG: [common/sshtools.py:494 SSH.checkPingHost] Check ping host
DEBUG: [common/sshtools.py:503 SSH.checkPingHost] Host storage1.REDACTED is available
DEBUG: [common/mount.py:574 SSH.checkFuse] Check fuse
DEBUG: [common/sshtools.py:328 SSH.checkLogin] Check login
DEBUG: [common/sshtools.py:440 SSH.checkRemoteFolder] Check remote folder
DEBUG: [common/sshtools.py:457 SSH.checkRemoteFolder] Call command: ssh -o ServerAliveInterval=240 -o LogLevel=Error -o IdentityFile=/root/.ssh/id_rsa -p 22  bentolor@storage1.REDACTED d=0;test -e "/data/share/home/bentolor" || d=1;test $d -eq 1 && mkdir "/data/share/home/bentolor"; err=$?;test $d -eq 1 && exit $err;test -d "/data/share/home/bentolor" || exit 11;test -w "/data/share/home/bentolor" || exit 12;test -x "/data/share/home/bentolor" || exit 13;exit 20
DEBUG: [common/sshtools.py:463 SSH.checkRemoteFolder] Command returncode: 20
DEBUG: [common/sshtools.py:155 SSH._mount] Call mount command: sshfs -o ServerAliveInterval=240 -o LogLevel=Error -o IdentityFile=/root/.ssh/id_rsa -p 22 -o idmap=user -o cache_dir_timeout=2 -o cache_stat_timeout=2  bentolor@storage1.REDACTED:/data/share/home/bentolor /root/.local/share/backintime/mnt/81BBC763/mountpoint
INFO: [common/mount.py:424 SSH.mount] mount ssh_encfs:  bentolor@storage1.REDACTED:/data/share/home/bentolor on /root/.local/share/backintime/mnt/81BBC763/mountpoint
DEBUG: [common/mount.py:705 SSH.mountLockAquire] Set mount lock /root/.local/share/backintime/mnt/81BBC763/locks/14676.lock
DEBUG: [common/mount.py:690 SSH.mountProcessLockRelease] Release mountprocess lock /root/.local/share/backintime/mnt/14676.lock
DEBUG: [common/encfstools.py:246 EncFS_SSH.mount] Mount local filesystem root with encfs --reverse
DEBUG: [common/mount.py:678 EncFS_mount.mountProcessLockAcquire] Acquire mountprocess lock /root/.local/share/backintime/mnt/14676.lock
DEBUG: [common/mount.py:574 EncFS_mount.checkFuse] Check fuse
DEBUG: [common/encfstools.py:64 EncFS_mount._mount] Provide password through temp FIFO
DEBUG: [common/encfstools.py:127 EncFS_mount.isConfigured] Found encfs config in /root/.local/share/backintime/mnt/81BBC763/mountpoint/.encfs6.xml
DEBUG: [common/encfstools.py:77 EncFS_mount._mount] Call mount command: encfs --extpass=backintime-askpass --reverse / /root/.local/share/backintime/mnt/F55D11D7/mountpoint
DEBUG: [common/encfstools.py:183 EncFS_mount.backupConfig] Encfs config did not change. Skip backup
INFO: [common/mount.py:424 EncFS_mount.mount] mount ssh_encfs: / on /root/.local/share/backintime/mnt/F55D11D7/mountpoint
DEBUG: [common/mount.py:705 EncFS_mount.mountLockAquire] Set mount lock /root/.local/share/backintime/mnt/F55D11D7/locks/14676.lock
DEBUG: [common/mount.py:690 EncFS_mount.mountProcessLockRelease] Release mountprocess lock /root/.local/share/backintime/mnt/14676.lock
DEBUG: [common/encfstools.py:249 EncFS_SSH.mount] Mount encfs
DEBUG: [common/mount.py:678 EncFS_SSH.mountProcessLockAcquire] Acquire mountprocess lock /root/.local/share/backintime/mnt/14676.lock
DEBUG: [common/encfstools.py:64 EncFS_SSH._mount] Provide password through temp FIFO
DEBUG: [common/encfstools.py:127 EncFS_SSH.isConfigured] Found encfs config in /root/.local/share/backintime/mnt/81BBC763/mountpoint/.encfs6.xml
DEBUG: [common/encfstools.py:77 EncFS_SSH._mount] Call mount command: encfs --extpass=backintime-askpass /root/.local/share/backintime/mnt/81BBC763/mountpoint /root/.local/share/backintime/mnt/9B546949/mountpoint
DEBUG: [common/encfstools.py:183 EncFS_SSH.backupConfig] Encfs config did not change. Skip backup
INFO: [common/mount.py:424 EncFS_SSH.mount] mount ssh_encfs: /root/.local/share/backintime/mnt/81BBC763/mountpoint on /root/.local/share/backintime/mnt/9B546949/mountpoint
DEBUG: [common/mount.py:705 EncFS_SSH.mountLockAquire] Set mount lock /root/.local/share/backintime/mnt/9B546949/locks/14676.lock
DEBUG: [common/mount.py:690 EncFS_SSH.mountProcessLockRelease] Release mountprocess lock /root/.local/share/backintime/mnt/14676.lock
DEBUG: [common/tools.py:1215 readCrontab] Read 2 lines from users crontab
DEBUG: [common/config.py:1497 Config.removeOldCrontab] Clearing system Back In Time entries
DEBUG: [common/config.py:1533 Config.cronLine] Profile: Hauptprofil | Automatic backup: Jeden Tag
DEBUG: [common/config.py:1481 setupCron] Crontab didn't change. Skip writing.
DEBUG: [common/backintime.py:585 argParse] Arguments: {'debug': True, 'command': 'backup', 'func': <function backup at 0x7f2a2b60a840>} | unknownArgs: []

Back In Time
Version: 1.2.0~alpha17

Back In Time comes with ABSOLUTELY NO WARRANTY.
This is free software, and you are welcome to redistribute it
under certain conditions; type `backintime --license' for details.

DEBUG: [common/backintime.py:670 getConfig] config file: /root/.config/backintime/config
DEBUG: [common/backintime.py:671 getConfig] share path: /root/.local/share/backintime
DEBUG: [common/backintime.py:673 getConfig] profiles: 1=Hauptprofil
DEBUG: [common/pluginmanager.py:90 PluginManager.load] Register plugin path /usr/share/backintime/plugins
DEBUG: [common/pluginmanager.py:106 PluginManager.load] Add plugin notifyplugin.py
DEBUG: [common/pluginmanager.py:106 PluginManager.load] Add plugin userscriptsplugin.py
DEBUG: [common/pluginmanager.py:106 PluginManager.load] Add plugin qt4plugin.py
INFO: [common/snapshots.py:632 Snapshots.backup] Lock
DEBUG: [common/tools.py:1170 inhibitSuspend] Inhibit Suspend failed because BIT was started as root.
DEBUG: [common/tools.py:795 keyringSupported] No keyring due to import error.
DEBUG: [common/tools.py:795 keyringSupported] No keyring due to import error.
DEBUG: [common/tools.py:795 keyringSupported] No keyring due to import error.
DEBUG: [common/sshtools.py:224 SSH.startSshAgent] ssh-agent started successful: SSH_AUTH_SOCK=/tmp/ssh-dWe9pUAot3aZ/agent.14752 | SSH_AGENT_PID=14753
DEBUG: [common/sshtools.py:267 SSH.unlockSshAgent] Add private key /root/.ssh/id_rsa to ssh agent
DEBUG: [common/sshtools.py:272 SSH.unlockSshAgent] Password available: True
DEBUG: [common/sshtools.py:288 SSH.unlockSshAgent] Provide password through temp FIFO
DEBUG: [common/encfstools.py:222 EncFS_SSH.mount] Mount sshfs
DEBUG: [common/mount.py:678 SSH.mountProcessLockAcquire] Acquire mountprocess lock /root/.local/share/backintime/mnt/14748.lock
INFO: [common/mount.py:416 SSH.mount] Mountpoint /root/.local/share/backintime/mnt/81BBC763/mountpoint is already mounted
DEBUG: [common/mount.py:705 SSH.mountLockAquire] Set mount lock /root/.local/share/backintime/mnt/81BBC763/locks/14748.lock
DEBUG: [common/mount.py:690 SSH.mountProcessLockRelease] Release mountprocess lock /root/.local/share/backintime/mnt/14748.lock
DEBUG: [common/encfstools.py:246 EncFS_SSH.mount] Mount local filesystem root with encfs --reverse
DEBUG: [common/mount.py:678 EncFS_mount.mountProcessLockAcquire] Acquire mountprocess lock /root/.local/share/backintime/mnt/14748.lock
INFO: [common/mount.py:416 EncFS_mount.mount] Mountpoint /root/.local/share/backintime/mnt/F55D11D7/mountpoint is already mounted
DEBUG: [common/mount.py:705 EncFS_mount.mountLockAquire] Set mount lock /root/.local/share/backintime/mnt/F55D11D7/locks/14748.lock
DEBUG: [common/mount.py:690 EncFS_mount.mountProcessLockRelease] Release mountprocess lock /root/.local/share/backintime/mnt/14748.lock
DEBUG: [common/encfstools.py:249 EncFS_SSH.mount] Mount encfs
DEBUG: [common/mount.py:678 EncFS_SSH.mountProcessLockAcquire] Acquire mountprocess lock /root/.local/share/backintime/mnt/14748.lock
INFO: [common/mount.py:416 EncFS_SSH.mount] Mountpoint /root/.local/share/backintime/mnt/9B546949/mountpoint is already mounted
DEBUG: [common/mount.py:705 EncFS_SSH.mountLockAquire] Set mount lock /root/.local/share/backintime/mnt/9B546949/locks/14748.lock
DEBUG: [common/mount.py:690 EncFS_SSH.mountProcessLockRelease] Release mountprocess lock /root/.local/share/backintime/mnt/14748.lock
INFO: [common/snapshots.py:664 Snapshots.backup] Take a new snapshot. Profile: 1 Hauptprofil
DEBUG: [common/encfstools.py:356 Encode.startProcess] start 'encfsctl encode' process
DEBUG: [common/encfstools.py:360 Encode.startProcess] Call command: encfsctl encode --extpass=backintime-askpass /
QStandardPaths: XDG_RUNTIME_DIR not set, defaulting to '/tmp/runtime-root'
INFO: [common/snapshots.py:1010 Snapshots.takeSnapshot] Call rsync to take the snapshot
DEBUG: [common/snapshots.py:690 Snapshots.backup] Call command "rsync --recursive --times --devices --specials --hard-links --human-readable --links --perms --executability --group --owner --info=progress2 --no-inc-recursive --rsh=ssh -o ServerAliveInterval=240 -o LogLevel=Error -o IdentityFile=/root/.ssh/id_rsa -p 22 --delete --delete-excluded -v -i --out-format=BACKINTIME: %i %n%L --chmod=Du+wx --exclude=/Z0LJF7lWepJAdbKcfeeolz0B/4NGX5kDq6V3r8p18ABEzCaMd/sgBs-gK03KMWNBOhjWkRyOJ3/YZ-dv7qHc-LhAfTOKzIFrf2B/-38SF7s4DO2cpGRHVKlJd-o7/-6uzvu6yuX3PVOZdCE4Mo4Te --exclude=/Z0LJF7lWepJAdbKcfeeolz0B/4NGX5kDq6V3r8p18ABEzCaMd/sgBs-gK03KMWNBOhjWkRyOJ3/YZ-dv7qHc-LhAfTOKzIFrf2B --exclude=4NGX5kDq6V3r8p18ABEzCaMd/sgBs-gK03KMWNBOhjWkRyOJ3/YZ-dv7qHc-LhAfTOKzIFrf2B/-38SF7s4DO2cpGRHVKlJd-o7 --exclude=wdfrDILDE19dxQSY2obZ5kDQ --exclude=/aNtvPJU3G5hOW8U71adYp2dW --exclude=/rQ3FSy7igTCyMdgHSQ2MLuc5 --exclude=/2TUeZZIAwkNtF-,9aQmk6xDR --exclude=/qPmmQGCx3fc3qFpC1gFKj-yo --exclude=/s,,xD85cz7DyMpZe9gUWyt-y --exclude=/-38SF7s4DO2cpGRHVKlJd-o7 --exclude=/wP9HfQFb-p4gxN02NWDfj08e --exclude=/Z0LJF7lWepJAdbKcfeeolz0B/mZZvxzLlZnRiXDcPy0Okrin5 --exclude=/Z0LJF7lWepJAdbKcfeeolz0B/SXrIYWIl-4n4w0I6p9npX65N --exclude=/Z0LJF7lWepJAdbKcfeeolz0B/udSIdZg,v8IqGx3TFJJNDyIB --exclude=/Z0LJF7lWepJAdbKcfeeolz0B/CbOH3pvVrtIEpdmbM6pE0Pxj --exclude=UF3Oov1ZGF7OuVaarg63aD1Y --exclude=KU4cICNGXPg3pRz,U1ZOpaVE/* --exclude=8aKUKvBdIIEEZz7oxvBTbhYz --exclude=5623bz9uUKiCyRh4DG2jgcKl --exclude=T8FSbrAm--g0fMoXoXi89vXlYO2U,QcsJT0f0q-tEQ6JX1 --exclude=nkCznLr1OIsZA6pj2yokqra4 --exclude=VZb8otSF8J6-jCXD0zaiWN-S --exclude=lQK,nuzczudG8TACSYryA3BI1C2,iRlIc4rhdqq-KDF2e- --exclude=Isjpuz303cdDk7IPNRqnmsGU --exclude=UE3TTC-dInhxVDwjkuf,If-y --exclude=Mg0dmD8xJB2,NChh2sijC2Gu --exclude=v8K8kr4uKnZbzGoWWopbXPLO --exclude=LPkGtWCKaEwj69Ql0hzZygno --exclude=3v7BqS5aeMjj,PcDpozcByo4 --exclude=ssD4ebePaIQBf5z98BTYcMJR --exclude=CuVJk,EmOzvmiWa2w7W-B,72 --exclude=oitfc0lwcILhVuGetl2XxGgU --exclude=eHu1aMgYQIzD3S1ch0SWLdMa --exclude=SXrIYWIl-4n4w0I6p9npX65N --exclude=P9GYO6IcuI1RurO17hcVwb85 --exclude=JmLmJ626HVkSklfQPkTwUGhQ --exclude=raObgo7oFrNVIBCRgT7EphTA --exclude=IxxStee9,hBzx6lsEqTuEpjq --exclude=udSIdZg,v8IqGx3TFJJNDyIB --exclude=3xCzUNjJx98GYEMcgixhYDx8 --exclude=/h0iHN8CK2AlVmjd3U79yPSzN/3TfDTCeD2bWDS2GOog0F2D4-/6OopT-PgT6Rl-9JBUVegBrO5/wRCoq7pBpWNVQ79wawkJAxF1 --exclude=lN27ZXRouE2ODGUAwjzDpT3F --exclude=HOniE1M6qtvs-zF6mZuw8JPn --exclude=Hyfpbj0yOJrk87M0KxYiz-Ou --exclude=UE3TTC-dInhxVDwjkuf,If-y/* --exclude=/aNtvPJU3G5hOW8U71adYp2dW/* --exclude=/rQ3FSy7igTCyMdgHSQ2MLuc5/* --exclude=/2TUeZZIAwkNtF-,9aQmk6xDR/* --exclude=/wP9HfQFb-p4gxN02NWDfj08e/* --exclude=/Rxv3j5y5Buvx46jb8Ne-,cYQ/8F2c8bJ57PgfC4,NICX8AGsL --exclude=qPmmQGCx3fc3qFpC1gFKj-yo/* --exclude=/ssD4ebePaIQBf5z98BTYcMJR/* --exclude=/qRypDi9cndEtFmml-9UxaRuA/ssD4ebePaIQBf5z98BTYcMJR/* --exclude=/qRypDi9cndEtFmml-9UxaRuA/CwoYRNxy-VO7IvKpAr8ISsoZ/* --exclude=QSLYL6ak8E2gDJHp4lYHjWkf --exclude=/h0iHN8CK2AlVmjd3U79yPSzN/3TfDTCeD2bWDS2GOog0F2D4- --exclude=/qRypDi9cndEtFmml-9UxaRuA/rtgyK0Fe58iT2Y4jD3PK6LNt --exclude=/qRypDi9cndEtFmml-9UxaRuA/Mg0dmD8xJB2,NChh2sijC2Gu/* --exclude=/qRypDi9cndEtFmml-9UxaRuA/4F4cRMX4CVgz9adC3fJ48be4/* --exclude=/qRypDi9cndEtFmml-9UxaRuA/2dXEOXPs68nG5o25sxMPRbbj/* --exclude=/qRypDi9cndEtFmml-9UxaRuA/ax9ZnhOtCUShagk39qws9bPf/* --exclude=/qRypDi9cndEtFmml-9UxaRuA/-qIjIH,6FsvjWCBwdOcNgGrT --exclude=/qRypDi9cndEtFmml-9UxaRuA/wP9HfQFb-p4gxN02NWDfj08e --exclude=/qRypDi9cndEtFmml-9UxaRuA/9S1VaTF6anMRKQN1jRndm8qD/* --exclude=/qRypDi9cndEtFmml-9UxaRuA/x77GXQY0tuMJXC0qbwoX1c9A/0topJLPPx6UlxNkjo0t2WVwQ/* --exclude=/qRypDi9cndEtFmml-9UxaRuA/x77GXQY0tuMJXC0qbwoX1c9A/oy2uQoTcbd6SiLy1srtQVHml --exclude=/qRypDi9cndEtFmml-9UxaRuA/x77GXQY0tuMJXC0qbwoX1c9A/2rBUW0gcsCLiioeF9H15Lw4K/* --exclude=/Rxv3j5y5Buvx46jb8Ne-,cYQ/rqFiOqOy5BikzJclwpiDV6dw/-j2fNMaqdEKyFehO7gzJD1aHWLVaPtgQIbG1mDz2Jcg7J0 --exclude=/Rxv3j5y5Buvx46jb8Ne-,cYQ/rqFiOqOy5BikzJclwpiDV6dw/otTN12fY8NedC0MKMr4WTPAhrGR7veePhjcHH1fZKDbSO, --exclude=/qRypDi9cndEtFmml-9UxaRuA/x77GXQY0tuMJXC0qbwoX1c9A/x-y-KqvtbxagOIYgwzcthC8H/KzqnbM5auN6rO9x63brgYdD-/* --include=/ --include=/** --exclude=* /root/.local/share/backintime/mnt/F55D11D7/mountpoint/  bentolor@storage1.REDACTED:"/data/share/home/bentolor/YZ-dv7qHc-LhAfTOKzIFrf2B/TG5hAow5ZCSB4LlkfugUNPYX/Z0LJF7lWepJAdbKcfeeolz0B/TA7x88VZ1UxLaX1nzTlnDbFU/jw1o4qfrsSgopckAbsxlC50r/FPXoR-qewxXInvPh3AYDCq13""
WARNING: [common/snapshots.py:690 Snapshots.backup] Command "rsync --recursive --times --devices --specials --hard-links --human-readable --links --perms --executability --group --owner --info=progress2 --no-inc-recursive --rsh=ssh -o ServerAliveInterval=240 -o LogLevel=Error -o IdentityFile=/root/.ssh/id_rsa -p 22 --delete --delete-excluded -v -i --out-format=BACKINTIME: %i %n%L --chmod=Du+wx --exclude=/Z0LJF7lWepJAdbKcfeeolz0B/4NGX5kDq6V3r8p18ABEzCaMd/sgBs-gK03KMWNBOhjWkRyOJ3/YZ-dv7qHc-LhAfTOKzIFrf2B/-38SF7s4DO2cpGRHVKlJd-o7/-6uzvu6yuX3PVOZdCE4Mo4Te --exclude=/Z0LJF7lWepJAdbKcfeeolz0B/4NGX5kDq6V3r8p18ABEzCaMd/sgBs-gK03KMWNBOhjWkRyOJ3/YZ-dv7qHc-LhAfTOKzIFrf2B --exclude=4NGX5kDq6V3r8p18ABEzCaMd/sgBs-gK03KMWNBOhjWkRyOJ3/YZ-dv7qHc-LhAfTOKzIFrf2B/-38SF7s4DO2cpGRHVKlJd-o7 --exclude=wdfrDILDE19dxQSY2obZ5kDQ --exclude=/aNtvPJU3G5hOW8U71adYp2dW --exclude=/rQ3FSy7igTCyMdgHSQ2MLuc5 --exclude=/2TUeZZIAwkNtF-,9aQmk6xDR --exclude=/qPmmQGCx3fc3qFpC1gFKj-yo --exclude=/s,,xD85cz7DyMpZe9gUWyt-y --exclude=/-38SF7s4DO2cpGRHVKlJd-o7 --exclude=/wP9HfQFb-p4gxN02NWDfj08e --exclude=/Z0LJF7lWepJAdbKcfeeolz0B/mZZvxzLlZnRiXDcPy0Okrin5 --exclude=/Z0LJF7lWepJAdbKcfeeolz0B/SXrIYWIl-4n4w0I6p9npX65N --exclude=/Z0LJF7lWepJAdbKcfeeolz0B/udSIdZg,v8IqGx3TFJJNDyIB --exclude=/Z0LJF7lWepJAdbKcfeeolz0B/CbOH3pvVrtIEpdmbM6pE0Pxj --exclude=UF3Oov1ZGF7OuVaarg63aD1Y --exclude=KU4cICNGXPg3pRz,U1ZOpaVE/* --exclude=8aKUKvBdIIEEZz7oxvBTbhYz --exclude=5623bz9uUKiCyRh4DG2jgcKl --exclude=T8FSbrAm--g0fMoXoXi89vXlYO2U,QcsJT0f0q-tEQ6JX1 --exclude=nkCznLr1OIsZA6pj2yokqra4 --exclude=VZb8otSF8J6-jCXD0zaiWN-S --exclude=lQK,nuzczudG8TACSYryA3BI1C2,iRlIc4rhdqq-KDF2e- --exclude=Isjpuz303cdDk7IPNRqnmsGU --exclude=UE3TTC-dInhxVDwjkuf,If-y --exclude=Mg0dmD8xJB2,NChh2sijC2Gu --exclude=v8K8kr4uKnZbzGoWWopbXPLO --exclude=LPkGtWCKaEwj69Ql0hzZygno --exclude=3v7BqS5aeMjj,PcDpozcByo4 --exclude=ssD4ebePaIQBf5z98BTYcMJR --exclude=CuVJk,EmOzvmiWa2w7W-B,72 --exclude=oitfc0lwcILhVuGetl2XxGgU --exclude=eHu1aMgYQIzD3S1ch0SWLdMa --exclude=SXrIYWIl-4n4w0I6p9npX65N --exclude=P9GYO6IcuI1RurO17hcVwb85 --exclude=JmLmJ626HVkSklfQPkTwUGhQ --exclude=raObgo7oFrNVIBCRgT7EphTA --exclude=IxxStee9,hBzx6lsEqTuEpjq --exclude=udSIdZg,v8IqGx3TFJJNDyIB --exclude=3xCzUNjJx98GYEMcgixhYDx8 --exclude=/h0iHN8CK2AlVmjd3U79yPSzN/3TfDTCeD2bWDS2GOog0F2D4-/6OopT-PgT6Rl-9JBUVegBrO5/wRCoq7pBpWNVQ79wawkJAxF1 --exclude=lN27ZXRouE2ODGUAwjzDpT3F --exclude=HOniE1M6qtvs-zF6mZuw8JPn --exclude=Hyfpbj0yOJrk87M0KxYiz-Ou --exclude=UE3TTC-dInhxVDwjkuf,If-y/* --exclude=/aNtvPJU3G5hOW8U71adYp2dW/* --exclude=/rQ3FSy7igTCyMdgHSQ2MLuc5/* --exclude=/2TUeZZIAwkNtF-,9aQmk6xDR/* --exclude=/wP9HfQFb-p4gxN02NWDfj08e/* --exclude=/Rxv3j5y5Buvx46jb8Ne-,cYQ/8F2c8bJ57PgfC4,NICX8AGsL --exclude=qPmmQGCx3fc3qFpC1gFKj-yo/* --exclude=/ssD4ebePaIQBf5z98BTYcMJR/* --exclude=/qRypDi9cndEtFmml-9UxaRuA/ssD4ebePaIQBf5z98BTYcMJR/* --exclude=/qRypDi9cndEtFmml-9UxaRuA/CwoYRNxy-VO7IvKpAr8ISsoZ/* --exclude=QSLYL6ak8E2gDJHp4lYHjWkf --exclude=/h0iHN8CK2AlVmjd3U79yPSzN/3TfDTCeD2bWDS2GOog0F2D4- --exclude=/qRypDi9cndEtFmml-9UxaRuA/rtgyK0Fe58iT2Y4jD3PK6LNt --exclude=/qRypDi9cndEtFmml-9UxaRuA/Mg0dmD8xJB2,NChh2sijC2Gu/* --exclude=/qRypDi9cndEtFmml-9UxaRuA/4F4cRMX4CVgz9adC3fJ48be4/* --exclude=/qRypDi9cndEtFmml-9UxaRuA/2dXEOXPs68nG5o25sxMPRbbj/* --exclude=/qRypDi9cndEtFmml-9UxaRuA/ax9ZnhOtCUShagk39qws9bPf/* --exclude=/qRypDi9cndEtFmml-9UxaRuA/-qIjIH,6FsvjWCBwdOcNgGrT --exclude=/qRypDi9cndEtFmml-9UxaRuA/wP9HfQFb-p4gxN02NWDfj08e --exclude=/qRypDi9cndEtFmml-9UxaRuA/9S1VaTF6anMRKQN1jRndm8qD/* --exclude=/qRypDi9cndEtFmml-9UxaRuA/x77GXQY0tuMJXC0qbwoX1c9A/0topJLPPx6UlxNkjo0t2WVwQ/* --exclude=/qRypDi9cndEtFmml-9UxaRuA/x77GXQY0tuMJXC0qbwoX1c9A/oy2uQoTcbd6SiLy1srtQVHml --exclude=/qRypDi9cndEtFmml-9UxaRuA/x77GXQY0tuMJXC0qbwoX1c9A/2rBUW0gcsCLiioeF9H15Lw4K/* --exclude=/Rxv3j5y5Buvx46jb8Ne-,cYQ/rqFiOqOy5BikzJclwpiDV6dw/-j2fNMaqdEKyFehO7gzJD1aHWLVaPtgQIbG1mDz2Jcg7J0 --exclude=/Rxv3j5y5Buvx46jb8Ne-,cYQ/rqFiOqOy5BikzJclwpiDV6dw/otTN12fY8NedC0MKMr4WTPAhrGR7veePhjcHH1fZKDbSO, --exclude=/qRypDi9cndEtFmml-9UxaRuA/x77GXQY0tuMJXC0qbwoX1c9A/x-y-KqvtbxagOIYgwzcthC8H/KzqnbM5auN6rO9x63brgYdD-/* --include=/ --include=/** --exclude=* /root/.local/share/backintime/mnt/F55D11D7/mountpoint/  bentolor@storage1.REDACTED:"/data/share/home/bentolor/YZ-dv7qHc-LhAfTOKzIFrf2B/TG5hAow5ZCSB4LlkfugUNPYX/Z0LJF7lWepJAdbKcfeeolz0B/TA7x88VZ1UxLaX1nzTlnDbFU/jw1o4qfrsSgopckAbsxlC50r/FPXoR-qewxXInvPh3AYDCq13"" returns 255
DEBUG: [common/snapshots.py:1032 Snapshots.takeSnapshot] Failed to remove snapshot progress file /root/.local/share/backintime/worker.progress: [Errno 2] No such file or directory: '/root/.local/share/backintime/worker.progress'
INFO: [common/snapshots.py:835 Snapshots.backupConfig] Save config file
INFO: [common/snapshots.py:872 Snapshots.backupPermissions] Save permissions
DEBUG: [common/sshtools.py:206 SSH.startSshAgent] ssh-agent already running. Skip starting a new one.
DEBUG: [common/sshtools.py:319 SSH.unlockSshAgent] Private key /root/.ssh/id_rsa is already unlocked in ssh agent
DEBUG: [common/encfstools.py:579 Decode.startProcess] start 'encfsctl decode' process
DEBUG: [common/encfstools.py:583 Decode.startProcess] Call command: encfsctl decode --extpass=backintime-askpass /root/.local/share/backintime/mnt/81BBC763/mountpoint
DEBUG: [common/snapshots.py:1057 Snapshots.takeSnapshot] Call command "rsync --dry-run -r --out-format=%n --rsh=ssh -o ServerAliveInterval=240 -o LogLevel=Error -o IdentityFile=/root/.ssh/id_rsa -p 22  bentolor@storage1.REDACTED:"/data/share/home/bentolor/YZ-dv7qHc-LhAfTOKzIFrf2B/TG5hAow5ZCSB4LlkfugUNPYX/Z0LJF7lWepJAdbKcfeeolz0B/TA7x88VZ1UxLaX1nzTlnDbFU/jw1o4qfrsSgopckAbsxlC50r/FPXoR-qewxXInvPh3AYDCq13"/ /tmp/tmp79om86cs/"
DEBUG: [common/snapshots.py:1057 Snapshots.takeSnapshot] Command "rsync --dry-run ..." returns 0
DEBUG: [common/encfstools.py:693 Decode.close] stop 'encfsctl decode' process
INFO: [common/snapshots.py:848 Snapshots.backupInfo] Create info file
DEBUG: [common/tools.py:1101 writeTimeStamp] write timestamp '20190205 1325' into file '/root/.local/share/backintime/anacron/1_Hauptprofil'
DEBUG: [common/snapshots.py:1726 Snapshots.createLastSnapshotSymlink] Create symlink /root/.local/share/backintime/mnt/1_14748/backintime/n223/root/1/last_snapshot => 20190205-132512-506
DEBUG: [common/snapshots.py:1396 Snapshots.freeSpace] Remove snapshots older than: 20180201-000000
DEBUG: [common/snapshots.py:1218 Snapshots.smartRemoveList] Considered: [20190205-132512-506]
DEBUG: [common/snapshots.py:1220 Snapshots.smartRemoveList] There is only one snapshots, so keep it
DEBUG: [common/tools.py:795 keyringSupported] No keyring due to import error.
DEBUG: [common/sshtools.py:206 SSH.startSshAgent] ssh-agent already running. Skip starting a new one.
DEBUG: [common/sshtools.py:319 SSH.unlockSshAgent] Private key /root/.ssh/id_rsa is already unlocked in ssh agent
DEBUG: [common/encfstools.py:445 Encode.close] stop 'encfsctl encode' process
DEBUG: [common/encfstools.py:262 EncFS_SSH.umount] Unmount encfs
DEBUG: [common/mount.py:678 EncFS_SSH.mountProcessLockAcquire] Acquire mountprocess lock /root/.local/share/backintime/mnt/14748.lock
INFO: [common/mount.py:453 EncFS_SSH.umount] Mountpoint /root/.local/share/backintime/mnt/9B546949/mountpoint still in use. Keep mounted
DEBUG: [common/mount.py:730 EncFS_SSH.mountLockRelease] Remove mount lock /root/.local/share/backintime/mnt/9B546949/locks/14748.lock
DEBUG: [common/mount.py:690 EncFS_SSH.mountProcessLockRelease] Release mountprocess lock /root/.local/share/backintime/mnt/14748.lock
DEBUG: [common/encfstools.py:264 EncFS_SSH.umount] Unmount local filesystem root mount encfs --reverse
DEBUG: [common/mount.py:678 EncFS_mount.mountProcessLockAcquire] Acquire mountprocess lock /root/.local/share/backintime/mnt/14748.lock
INFO: [common/mount.py:453 EncFS_mount.umount] Mountpoint /root/.local/share/backintime/mnt/F55D11D7/mountpoint still in use. Keep mounted
DEBUG: [common/mount.py:730 EncFS_mount.mountLockRelease] Remove mount lock /root/.local/share/backintime/mnt/F55D11D7/locks/14748.lock
DEBUG: [common/mount.py:690 EncFS_mount.mountProcessLockRelease] Release mountprocess lock /root/.local/share/backintime/mnt/14748.lock
DEBUG: [common/encfstools.py:266 EncFS_SSH.umount] Unmount sshfs
DEBUG: [common/mount.py:678 SSH.mountProcessLockAcquire] Acquire mountprocess lock /root/.local/share/backintime/mnt/14748.lock
INFO: [common/mount.py:453 SSH.umount] Mountpoint /root/.local/share/backintime/mnt/81BBC763/mountpoint still in use. Keep mounted
DEBUG: [common/mount.py:730 SSH.mountLockRelease] Remove mount lock /root/.local/share/backintime/mnt/81BBC763/locks/14748.lock
DEBUG: [common/mount.py:690 SSH.mountProcessLockRelease] Release mountprocess lock /root/.local/share/backintime/mnt/14748.lock
INFO: [common/snapshots.py:737 Snapshots.backup] Unlock
@bentolor
Copy link
Author

bentolor commented Feb 5, 2019

Here a takesnapshot.log I found. Noteworthy seems to be the following line:

)I] Schnappschuss erstellen (rsync: ssh: Could not resolve hostname storage1.REDACTED: Name or service not known

But I confirmed: The hostname is clearly resolvable?!?

root@n223 ~/.l/s/backintime# cat takesnapshot_.log 
========== Take snapshot (profile 1): Tue Feb  5 13:25:12 2019 ==========

[I] …
[I] Schnappschuss wird erstellt
[I] rsync --recursive --times --devices --specials --hard-links --human-readable --links --perms --executability --group --owner --info=progress2 --no-inc-recursive --rsh=ssh -o ServerAliveInterval=240 -o LogLevel=Error -o IdentityFile=/root/.ssh/id_rsa -p 22 --delete --delete-excluded -v -i --out-format=BACKINTIME: %i %n%L --chmod=Du+wx --exclude=/Z0LJF7lWepJAdbKcfeeolz0B/4NGX5kDq6V3r8p18ABEzCaMd/sgBs-gK03KMWNBOhjWkRyOJ3/YZ-dv7qHc-LhAfTOKzIFrf2B/-38SF7s4DO2cpGRHVKlJd-o7/-6uzvu6yuX3PVOZdCE4Mo4Te --exclude=/Z0LJF7lWepJAdbKcfeeolz0B/4NGX5kDq6V3r8p18ABEzCaMd/sgBs-gK03KMWNBOhjWkRyOJ3/YZ-dv7qHc-LhAfTOKzIFrf2B --exclude=4NGX5kDq6V3r8p18ABEzCaMd/sgBs-gK03KMWNBOhjWkRyOJ3/YZ-dv7qHc-LhAfTOKzIFrf2B/-38SF7s4DO2cpGRHVKlJd-o7 --exclude=wdfrDILDE19dxQSY2obZ5kDQ --exclude=/aNtvPJU3G5hOW8U71adYp2dW --exclude=/rQ3FSy7igTCyMdgHSQ2MLuc5 --exclude=/2TUeZZIAwkNtF-,9aQmk6xDR --exclude=/qPmmQGCx3fc3qFpC1gFKj-yo --exclude=/s,,xD85cz7DyMpZe9gUWyt-y --exclude=/-38SF7s4DO2cpGRHVKlJd-o7 --exclude=/wP9HfQFb-p4gxN02NWDfj08e --exclude=/Z0LJF7lWepJAdbKcfeeolz0B/mZZvxzLlZnRiXDcPy0Okrin5 --exclude=/Z0LJF7lWepJAdbKcfeeolz0B/SXrIYWIl-4n4w0I6p9npX65N --exclude=/Z0LJF7lWepJAdbKcfeeolz0B/udSIdZg,v8IqGx3TFJJNDyIB --exclude=/Z0LJF7lWepJAdbKcfeeolz0B/CbOH3pvVrtIEpdmbM6pE0Pxj --exclude=UF3Oov1ZGF7OuVaarg63aD1Y --exclude=KU4cICNGXPg3pRz,U1ZOpaVE/* --exclude=8aKUKvBdIIEEZz7oxvBTbhYz --exclude=5623bz9uUKiCyRh4DG2jgcKl --exclude=T8FSbrAm--g0fMoXoXi89vXlYO2U,QcsJT0f0q-tEQ6JX1 --exclude=nkCznLr1OIsZA6pj2yokqra4 --exclude=VZb8otSF8J6-jCXD0zaiWN-S --exclude=lQK,nuzczudG8TACSYryA3BI1C2,iRlIc4rhdqq-KDF2e- --exclude=Isjpuz303cdDk7IPNRqnmsGU --exclude=UE3TTC-dInhxVDwjkuf,If-y --exclude=Mg0dmD8xJB2,NChh2sijC2Gu --exclude=v8K8kr4uKnZbzGoWWopbXPLO --exclude=LPkGtWCKaEwj69Ql0hzZygno --exclude=3v7BqS5aeMjj,PcDpozcByo4 --exclude=ssD4ebePaIQBf5z98BTYcMJR --exclude=CuVJk,EmOzvmiWa2w7W-B,72 --exclude=oitfc0lwcILhVuGetl2XxGgU --exclude=eHu1aMgYQIzD3S1ch0SWLdMa --exclude=SXrIYWIl-4n4w0I6p9npX65N --exclude=P9GYO6IcuI1RurO17hcVwb85 --exclude=JmLmJ626HVkSklfQPkTwUGhQ --exclude=raObgo7oFrNVIBCRgT7EphTA --exclude=IxxStee9,hBzx6lsEqTuEpjq --exclude=udSIdZg,v8IqGx3TFJJNDyIB --exclude=3xCzUNjJx98GYEMcgixhYDx8 --exclude=/h0iHN8CK2AlVmjd3U79yPSzN/3TfDTCeD2bWDS2GOog0F2D4-/6OopT-PgT6Rl-9JBUVegBrO5/wRCoq7pBpWNVQ79wawkJAxF1 --exclude=lN27ZXRouE2ODGUAwjzDpT3F --exclude=HOniE1M6qtvs-zF6mZuw8JPn --exclude=Hyfpbj0yOJrk87M0KxYiz-Ou --exclude=UE3TTC-dInhxVDwjkuf,If-y/* --exclude=/aNtvPJU3G5hOW8U71adYp2dW/* --exclude=/rQ3FSy7igTCyMdgHSQ2MLuc5/* --exclude=/2TUeZZIAwkNtF-,9aQmk6xDR/* --exclude=/wP9HfQFb-p4gxN02NWDfj08e/* --exclude=/Rxv3j5y5Buvx46jb8Ne-,cYQ/8F2c8bJ57PgfC4,NICX8AGsL --exclude=qPmmQGCx3fc3qFpC1gFKj-yo/* --exclude=/ssD4ebePaIQBf5z98BTYcMJR/* --exclude=/qRypDi9cndEtFmml-9UxaRuA/ssD4ebePaIQBf5z98BTYcMJR/* --exclude=/qRypDi9cndEtFmml-9UxaRuA/CwoYRNxy-VO7IvKpAr8ISsoZ/* --exclude=QSLYL6ak8E2gDJHp4lYHjWkf --exclude=/h0iHN8CK2AlVmjd3U79yPSzN/3TfDTCeD2bWDS2GOog0F2D4- --exclude=/qRypDi9cndEtFmml-9UxaRuA/rtgyK0Fe58iT2Y4jD3PK6LNt --exclude=/qRypDi9cndEtFmml-9UxaRuA/Mg0dmD8xJB2,NChh2sijC2Gu/* --exclude=/qRypDi9cndEtFmml-9UxaRuA/4F4cRMX4CVgz9adC3fJ48be4/* --exclude=/qRypDi9cndEtFmml-9UxaRuA/2dXEOXPs68nG5o25sxMPRbbj/* --exclude=/qRypDi9cndEtFmml-9UxaRuA/ax9ZnhOtCUShagk39qws9bPf/* --exclude=/qRypDi9cndEtFmml-9UxaRuA/-qIjIH,6FsvjWCBwdOcNgGrT --exclude=/qRypDi9cndEtFmml-9UxaRuA/wP9HfQFb-p4gxN02NWDfj08e --exclude=/qRypDi9cndEtFmml-9UxaRuA/9S1VaTF6anMRKQN1jRndm8qD/* --exclude=/qRypDi9cndEtFmml-9UxaRuA/x77GXQY0tuMJXC0qbwoX1c9A/0topJLPPx6UlxNkjo0t2WVwQ/* --exclude=/qRypDi9cndEtFmml-9UxaRuA/x77GXQY0tuMJXC0qbwoX1c9A/oy2uQoTcbd6SiLy1srtQVHml --exclude=/qRypDi9cndEtFmml-9UxaRuA/x77GXQY0tuMJXC0qbwoX1c9A/2rBUW0gcsCLiioeF9H15Lw4K/* --exclude=/Rxv3j5y5Buvx46jb8Ne-,cYQ/rqFiOqOy5BikzJclwpiDV6dw/-j2fNMaqdEKyFehO7gzJD1aHWLVaPtgQIbG1mDz2Jcg7J0 --exclude=/Rxv3j5y5Buvx46jb8Ne-,cYQ/rqFiOqOy5BikzJclwpiDV6dw/otTN12fY8NedC0MKMr4WTPAhrGR7veePhjcHH1fZKDbSO, --exclude=/qRypDi9cndEtFmml-9UxaRuA/x77GXQY0tuMJXC0qbwoX1c9A/x-y-KqvtbxagOIYgwzcthC8H/KzqnbM5auN6rO9x63brgYdD-/* --include=/ --include=/** --exclude=* /root/.local/share/backintime/mnt/F55D11D7/mountpoint/  bentolor@storage1.REDACTED:"/data/share/home/bentolor/YZ-dv7qHc-LhAfTOKzIFrf2B/TG5hAow5ZCSB4LlkfugUNPYX/Z0LJF7lWepJAdbKcfeeolz0B/TA7x88VZ1UxLaX1nzTlnDbFU/jw1o4qfrsSgopckAbsxlC50r/FPXoR-qewxXInvPh3AYDCq13"
)I] Schnappschuss erstellen (rsync: ssh: Could not resolve hostname storage1.REDACTED: Name or service not known
[I] Schnappschuss erstellen (rsync: rsync: connection unexpectedly closed (0 bytes received so far) [sender])
[I] Schnappschuss erstellen (rsync: rsync error: unexplained error (code 255) at io.c(235) [sender=3.1.2])
[I] Konfigurationsdatei wird gespeichert …
[I] Zugriffsrechte werden gespeichert …
[I] Alte Schnappschüsse werden entfernt
[I] Intelligentes Löschen
[I] Finalisierung läuft

@bentolor bentolor changed the title [CRITICAL BUG] Triggering a backup chmods / to 700, causing immediate crashes & unbootable PC [CRITICAL BUG] Triggering a backup chmods / to 700, causing immediate crash & unbootable PC Feb 5, 2019
@bentolor
Copy link
Author

3 weeks with a disabled backup. Issue occurred after updating distribution and maybe the rsync update is the culprit (3.1.1 → 3.1.2)?

@68420948
Copy link

68420948 commented Jan 27, 2020 •
edited

I discovered the same issue recently after having updated to backintime 1.2.1 under Debian Bullseye. In bug #946349 I've described how to reproduce the issue and what I believe is its root cause.

You will find a patch attached to #946349 fixing things for me. Please consider integrating it in the upcoming release.

P.S.: It seems to me #954 is about the same flaw.

Cheers,
Sven

bentolor pushed a commit to bentolor/backintime that referenced this issue Jan 28, 2020
@bentolor
Keep permissions of an existing mountpoint from being overridden
7f6f570 
 This measure especially protects the root of a already mounted file system
 (ssh or encfs) from getting its access permissions altered.

Should fix bit-team#974 and bit-team#954
@bentolor bentolor mentioned this issue Jan 28, 2020
Merged
@bentolor
Copy link
Author

Awesome, @68420948 – i created a Github merge request to ease things for the maintainer.

Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment
Assignees
No one assigned
Labels
None yet
Projects
None yet
Milestone
No milestone
Development

Successfully merging a pull request may close this issue.

Keep permissions of an existing mountpoint from being overridden bentolor/backintime
2 participants
@bentolor @68420948