Dear fellow enthousiasts!
I thought I would update my packages after like two months of not logging into my Yunohost instance. But then my apps got removed automatically in the process and I cannot restore any archive.
Description of my issue
So I logged into it via the webportal. And updated my packages. The update went well except for one package that could not be updated, which was a first time (I can’t remember which one and accidentally clicked away the error messages ). Then I clicked to update my apps: Nextcloud and ttrss. After that whole operation I clicked away the messages as well, because I thought they werent important (stupid, I know). But then later I found out that both apps had just been removed in that process!
I still had an archive of both of their contents pre-update and a full archive dating back six months. I tried to restore the full archive but got the error message. Then I tried to to restore the pre-update app archives, without success either. See the full error message flow down below. And below that a detailed debug for the Nextcloud restoration.
This incident gravely lowered my ability to trust my Yunohost instance with any data. When something as innocent as upgrades can remove all apps irrestorably then this is a serious issue. 
I hope that somebody could help me find out what the problem is 
and make sure this kind of thing doesn’t happen to me and others in the future!
My YunoHost server
Hardware: Raspberry Pi 3B at home
YunoHost version: [see system information below]
I have access to my server : through the webadmin screen
Are you in a special context or did you perform some particular tweaking on your YunoHost instance ? : not recently. A few months ago I tried to install Collabora online and Docker, which didn’t work out well. My tinyrss app has been working fine though since.
System info:
{
"host": "Debian 9.9",
"kernel": "4.14.79-v7+",
"packages": {
"yunohost": {
"repo": "stable",
"version": "3.6.4.6"
},
"yunohost-admin": {
"repo": "stable",
"version": "3.6.4"
},
"moulinette": {
"repo": "stable",
"version": "3.6.4.1"
},
"ssowat": {
"repo": "stable",
"version": "3.6.4"
}
},
"backports": [],
"system": {
"disks": {
"root": "Mounted on /, 29.2GiB (25.8GiB free)",
"mmcblk0p1": "Mounted on /boot, 43.1MiB (20.8MiB free)"
},
"memory": {
"ram": "927.2MiB (469.4MiB free)",
"swap": "100.0MiB (0B free)"
}
},
"nginx": [
"nginx: the configuration file /etc/nginx/nginx.conf syntax is ok",
"nginx: configuration file /etc/nginx/nginx.conf test is successful"
],
"services": {
"glances": "running (enabled)",
"nslcd": "running (enabled)",
"metronome": "running (enabled)",
"postfix": "exited (enabled)",
"rspamd": "running (enabled)",
"yunohost-firewall": "exited (enabled)",
"nginx": "running (enabled)",
"php7.0-fpm": "running (enabled)",
"dnsmasq": "running (enabled)",
"fail2ban": "running (enabled)",
"yunohost-api": "running (enabled)",
"mysql": "running (enabled)",
"avahi-daemon": "running (enabled)",
"dovecot": "running (enabled)",
"redis-server": "running (enabled)",
"slapd": "running (enabled)",
"ssh": "running (enabled)"
},
"applications": {},
"security": {
"CVE-2017-5754": {
"name": "meltdown",
"vulnerable": false
}
}
}
Error messages for restoration attempts
Nothing has been restored
/etc/php/7.0/fpm/conf.d/20-ttrss.ini wasn't deleted because it doesn't exist.
E: Sub-process /usr/bin/dpkg returned an error code (1)
The operation 'Restore 'ttrss' from a backup archive' has failed! To get help, please provide the full log of this operation by clicking here
Unable to restore the app 'ttrss'
!!
ttrss's script has encountered an error. Its execution was cancelled.
e[91me[1m[ERR]e[0m !!
Unable to install dependencies
E: Sub-process /usr/bin/dpkg returned an error code (1)
Restoring application ttrss…
Preparing archive for restoration…
Nothing has been restored
Removal of nextcloud completed
Removing the dedicated system user
/etc/cron.d/nextcloud wasn't deleted because it doesn't exist.
/etc/fail2ban/filter.d/nextcloud.conf wasn't deleted because it doesn't exist.
/etc/fail2ban/jail.d/nextcloud.conf wasn't deleted because it doesn't exist.
Remove fail2ban configuration
Removing logrotate configuration
/etc/php/7.0/fpm/conf.d/20-nextcloud.ini wasn't deleted because it doesn't exist.
Removing php-fpm configuration
Removing nginx web server configuration
Removing app main directory
Removing the MySQL database
E: Sub-process /usr/bin/dpkg returned an error code (1)
Removing dependencies
Loading installation settings...
The operation 'Restore 'nextcloud' from a backup archive' has failed! To get help, please provide the full log of this operation by clicking here
Unable to restore the app 'nextcloud'
!!
nextcloud's script has encountered an error. Its execution was cancelled.
e[91me[1m[ERR]e[0m !!
Unable to install dependencies
E: Sub-process /usr/bin/dpkg returned an error code (1)
Validating restoration parameters...
Loading settings...
Restoring application nextcloud…
Preparing archive for restoration…
Yunohost encountered an internal error:/
Really sorry about that.
You should look for help on the forum or the chat to fix the situation, or report the bug on the bugtracker.
The following information might be useful for the person helping you:
Action
GET /backup/archives/
{"locale":"en","with_details":"","name":"20190125-154445"}
Traceback
Traceback (most recent call last):
File "/usr/lib/python2.7/dist-packages/moulinette/interfaces/api.py", line 439, in process
ret = self.actionsmap.process(arguments, timeout=30, route=_route)
File "/usr/lib/python2.7/dist-packages/moulinette/actionsmap.py", line 523, in process
return func(**arguments)
File "/usr/lib/moulinette/yunohost/backup.py", line 2292, in backup_info
key_info["size"] = info["size_details"][category][name]
TypeError: list indices must be integers, not str
Error message for Nextcloud restore
ended_at: 2019-08-06 18:55:44.920673
env:
YNH_APP_BACKUP_DIR: /home/yunohost.backup/tmp/nextcloud-pre-upgrade2/apps/nextcloud/backup
YNH_APP_ID: nextcloud
YNH_APP_INSTANCE_NAME: nextcloud
YNH_APP_INSTANCE_NUMBER: '1'
YNH_BACKUP_CSV: /home/yunohost.backup/tmp/nextcloud-pre-upgrade2/backup.csv
YNH_BACKUP_DIR: /home/yunohost.backup/tmp/nextcloud-pre-upgrade2
YNH_CWD: /home/yunohost.backup/tmp/nextcloud-pre-upgrade2/apps/nextcloud/backup
YNH_INTERFACE: api
YNH_STDINFO: /tmp/tmp1ct4Qh/stdinfo
YNH_STDRETURN: /tmp/tmpDn8Ltk/stdreturn
error: Unable to restore the app 'nextcloud'
operation: backup_restore_app
related_to:
- - app
- nextcloud
started_at: 2019-08-06 18:54:26.680589
success: false
============
2019-08-06 18:54:26,698: INFO - Restoring application nextcloud…
2019-08-06 18:54:27,131: DEBUG - Running restore script of app 'nextcloud'…
2019-08-06 18:54:27,225: DEBUG - Executing command 'sh -c YNH_APP_INSTANCE_NUMBER=1 YNH_CWD=/home/yunohost.backup/tmp/nextcloud-pre-upgrade2/apps/nextcloud/backup YNH_STDINFO=/tmp/tmp1ct4Qh/stdinfo YNH_BACKUP_CSV=/home/yunohost.backup/tmp/nextcloud-pre-upgrade2/backup.csv YNH_BACKUP_DIR=/home/yunohost.backup/tmp/nextcloud-pre-upgrade2 YNH_APP_INSTANCE_NAME=nextcloud YNH_INTERFACE=api YNH_APP_ID=nextcloud YNH_STDRETURN=/tmp/tmpDn8Ltk/stdreturn YNH_APP_BACKUP_DIR=/home/yunohost.backup/tmp/nextcloud-pre-upgrade2/apps/nextcloud/backup BASH_XTRACEFD=7 /bin/bash -x "/tmp/restoreRcMn1N/restore" /home/yunohost.backup/tmp/nextcloud-pre-upgrade2/apps/nextcloud/backup nextcloud 7>&1'…
2019-08-06 18:54:27,226: DEBUG - About to run the command '['sh', '-c', 'YNH_APP_INSTANCE_NUMBER=1 YNH_CWD=/home/yunohost.backup/tmp/nextcloud-pre-upgrade2/apps/nextcloud/backup YNH_STDINFO=/tmp/tmp1ct4Qh/stdinfo YNH_BACKUP_CSV=/home/yunohost.backup/tmp/nextcloud-pre-upgrade2/backup.csv YNH_BACKUP_DIR=/home/yunohost.backup/tmp/nextcloud-pre-upgrade2 YNH_APP_INSTANCE_NAME=nextcloud YNH_INTERFACE=api YNH_APP_ID=nextcloud YNH_STDRETURN=/tmp/tmpDn8Ltk/stdreturn YNH_APP_BACKUP_DIR=/home/yunohost.backup/tmp/nextcloud-pre-upgrade2/apps/nextcloud/backup BASH_XTRACEFD=7 /bin/bash -x "/tmp/restoreRcMn1N/restore" /home/yunohost.backup/tmp/nextcloud-pre-upgrade2/apps/nextcloud/backup nextcloud 7>&1']'
2019-08-06 18:54:27,372: DEBUG - + source ../settings/scripts/_common.sh
2019-08-06 18:54:27,374: DEBUG - ++ pkg_dependencies='php-gd php-json php-intl php-mcrypt php-curl php-apcu php-redis php-ldap php-imagick php-zip php-mbstring php-xml imagemagick acl tar smbclient at'
2019-08-06 18:54:27,375: DEBUG - + source /usr/share/yunohost/helpers
2019-08-06 18:54:27,376: DEBUG - +++ run-parts --list /usr/share/yunohost/helpers.d
2019-08-06 18:54:27,376: DEBUG - ++ for helper in $(run-parts --list /usr/share/yunohost/helpers.d 2>/dev/null)
2019-08-06 18:54:27,377: DEBUG - ++ '[' -r /usr/share/yunohost/helpers.d/apt ']'
2019-08-06 18:54:27,378: DEBUG - ++ . /usr/share/yunohost/helpers.d/apt
2019-08-06 18:54:27,378: DEBUG - ++ for helper in $(run-parts --list /usr/share/yunohost/helpers.d 2>/dev/null)
2019-08-06 18:54:27,379: DEBUG - ++ '[' -r /usr/share/yunohost/helpers.d/backup ']'
2019-08-06 18:54:27,380: DEBUG - ++ . /usr/share/yunohost/helpers.d/backup
2019-08-06 18:54:27,381: DEBUG - +++ CAN_BIND=1
2019-08-06 18:54:27,381: DEBUG - ++ for helper in $(run-parts --list /usr/share/yunohost/helpers.d 2>/dev/null)
2019-08-06 18:54:27,382: DEBUG - ++ '[' -r /usr/share/yunohost/helpers.d/fail2ban ']'
2019-08-06 18:54:27,383: DEBUG - ++ . /usr/share/yunohost/helpers.d/fail2ban
2019-08-06 18:54:27,384: DEBUG - ++ for helper in $(run-parts --list /usr/share/yunohost/helpers.d 2>/dev/null)
2019-08-06 18:54:27,384: DEBUG - ++ '[' -r /usr/share/yunohost/helpers.d/getopts ']'
2019-08-06 18:54:27,385: DEBUG - ++ . /usr/share/yunohost/helpers.d/getopts
2019-08-06 18:54:27,386: DEBUG - ++ for helper in $(run-parts --list /usr/share/yunohost/helpers.d 2>/dev/null)
2019-08-06 18:54:27,387: DEBUG - ++ '[' -r /usr/share/yunohost/helpers.d/logging ']'
2019-08-06 18:54:27,387: DEBUG - ++ . /usr/share/yunohost/helpers.d/logging
2019-08-06 18:54:27,388: DEBUG - +++ increment_progression=0
2019-08-06 18:54:27,388: DEBUG - +++ previous_weight=0
2019-08-06 18:54:27,389: DEBUG - +++ max_progression=-1
2019-08-06 18:54:27,390: DEBUG - +++ progress_scale=20
2019-08-06 18:54:27,391: DEBUG - +++ progress_string2='####################'
2019-08-06 18:54:27,391: DEBUG - +++ progress_string1=++++++++++++++++++++
2019-08-06 18:54:27,392: DEBUG - +++ progress_string0=....................
2019-08-06 18:54:27,393: DEBUG - ++++ date +%s
2019-08-06 18:54:27,393: DEBUG - +++ base_time=1565117667
2019-08-06 18:54:27,394: DEBUG - ++ for helper in $(run-parts --list /usr/share/yunohost/helpers.d 2>/dev/null)
2019-08-06 18:54:27,395: DEBUG - ++ '[' -r /usr/share/yunohost/helpers.d/logrotate ']'
2019-08-06 18:54:27,395: DEBUG - ++ . /usr/share/yunohost/helpers.d/logrotate
2019-08-06 18:54:27,396: DEBUG - ++ for helper in $(run-parts --list /usr/share/yunohost/helpers.d 2>/dev/null)
2019-08-06 18:54:27,397: DEBUG - ++ '[' -r /usr/share/yunohost/helpers.d/mysql ']'
2019-08-06 18:54:27,397: DEBUG - ++ . /usr/share/yunohost/helpers.d/mysql
2019-08-06 18:54:27,398: DEBUG - +++ MYSQL_ROOT_PWD_FILE=/etc/yunohost/mysql
2019-08-06 18:54:27,399: DEBUG - ++ for helper in $(run-parts --list /usr/share/yunohost/helpers.d 2>/dev/null)
2019-08-06 18:54:27,399: DEBUG - ++ '[' -r /usr/share/yunohost/helpers.d/network ']'
2019-08-06 18:54:27,400: DEBUG - ++ . /usr/share/yunohost/helpers.d/network
2019-08-06 18:54:27,401: DEBUG - ++ for helper in $(run-parts --list /usr/share/yunohost/helpers.d 2>/dev/null)
2019-08-06 18:54:27,402: DEBUG - ++ '[' -r /usr/share/yunohost/helpers.d/nginx ']'
2019-08-06 18:54:27,402: DEBUG - ++ . /usr/share/yunohost/helpers.d/nginx
2019-08-06 18:54:27,403: DEBUG - ++ for helper in $(run-parts --list /usr/share/yunohost/helpers.d 2>/dev/null)
2019-08-06 18:54:27,404: DEBUG - ++ '[' -r /usr/share/yunohost/helpers.d/nodejs ']'
2019-08-06 18:54:27,404: DEBUG - ++ . /usr/share/yunohost/helpers.d/nodejs
2019-08-06 18:54:27,405: DEBUG - +++ n_install_dir=/opt/node_n
2019-08-06 18:54:27,406: DEBUG - +++ node_version_path=/opt/node_n/n/versions/node
2019-08-06 18:54:27,406: DEBUG - +++ export N_PREFIX=/opt/node_n
2019-08-06 18:54:27,407: DEBUG - +++ N_PREFIX=/opt/node_n
2019-08-06 18:54:27,408: DEBUG - ++ for helper in $(run-parts --list /usr/share/yunohost/helpers.d 2>/dev/null)
2019-08-06 18:54:27,408: DEBUG - ++ '[' -r /usr/share/yunohost/helpers.d/php ']'
2019-08-06 18:54:27,409: DEBUG - ++ . /usr/share/yunohost/helpers.d/php
2019-08-06 18:54:27,410: DEBUG - ++ for helper in $(run-parts --list /usr/share/yunohost/helpers.d 2>/dev/null)
2019-08-06 18:54:27,410: DEBUG - ++ '[' -r /usr/share/yunohost/helpers.d/postgresql ']'
2019-08-06 18:54:27,411: DEBUG - ++ . /usr/share/yunohost/helpers.d/postgresql
2019-08-06 18:54:27,412: DEBUG - +++ PSQL_ROOT_PWD_FILE=/etc/yunohost/psql
2019-08-06 18:54:27,412: DEBUG - ++ for helper in $(run-parts --list /usr/share/yunohost/helpers.d 2>/dev/null)
2019-08-06 18:54:27,413: DEBUG - ++ '[' -r /usr/share/yunohost/helpers.d/setting ']'
2019-08-06 18:54:27,414: DEBUG - ++ . /usr/share/yunohost/helpers.d/setting
2019-08-06 18:54:27,415: DEBUG - ++ for helper in $(run-parts --list /usr/share/yunohost/helpers.d 2>/dev/null)
2019-08-06 18:54:27,415: DEBUG - ++ '[' -r /usr/share/yunohost/helpers.d/string ']'
2019-08-06 18:54:27,416: DEBUG - ++ . /usr/share/yunohost/helpers.d/string
2019-08-06 18:54:27,417: DEBUG - ++ for helper in $(run-parts --list /usr/share/yunohost/helpers.d 2>/dev/null)
2019-08-06 18:54:27,417: DEBUG - ++ '[' -r /usr/share/yunohost/helpers.d/systemd ']'
2019-08-06 18:54:27,418: DEBUG - ++ . /usr/share/yunohost/helpers.d/systemd
2019-08-06 18:54:27,419: DEBUG - ++ for helper in $(run-parts --list /usr/share/yunohost/helpers.d 2>/dev/null)
2019-08-06 18:54:27,420: DEBUG - ++ '[' -r /usr/share/yunohost/helpers.d/user ']'
2019-08-06 18:54:27,421: DEBUG - ++ . /usr/share/yunohost/helpers.d/user
2019-08-06 18:54:27,421: DEBUG - ++ for helper in $(run-parts --list /usr/share/yunohost/helpers.d 2>/dev/null)
2019-08-06 18:54:27,422: DEBUG - ++ '[' -r /usr/share/yunohost/helpers.d/utils ']'
2019-08-06 18:54:27,422: DEBUG - ++ . /usr/share/yunohost/helpers.d/utils
2019-08-06 18:54:27,524: DEBUG - + ynh_abort_if_errors
2019-08-06 18:54:27,525: INFO - Loading settings...
2019-08-06 18:54:27,530: DEBUG - + set -eu
2019-08-06 18:54:27,532: DEBUG - + trap ynh_exit_properly EXIT
2019-08-06 18:54:27,534: DEBUG - + ynh_print_info 'Loading settings...'
2019-08-06 18:54:27,535: DEBUG - + local legacy_args=m
2019-08-06 18:54:27,537: DEBUG - + args_array=([m]=message=)
2019-08-06 18:54:27,539: DEBUG - + declare -Ar args_array
2019-08-06 18:54:27,541: DEBUG - + local message
2019-08-06 18:54:27,542: DEBUG - + ynh_handle_getopts_args 'Loading settings...'
2019-08-06 18:54:27,544: DEBUG - + set +x
2019-08-06 18:54:27,545: DEBUG - + echo '! Helper used in legacy mode !'
2019-08-06 18:54:27,547: DEBUG - + set +x
2019-08-06 18:54:27,548: DEBUG - + echo 'Loading settings...'
2019-08-06 18:54:27,550: DEBUG - + app=nextcloud
2019-08-06 18:54:27,552: DEBUG - ++ ynh_app_setting_get nextcloud domain
2019-08-06 18:54:27,557: DEBUG - ++ local legacy_args=ak
2019-08-06 18:54:27,558: DEBUG - ++ args_array=([a]=app= [k]=key=)
2019-08-06 18:54:27,560: DEBUG - ++ declare -Ar args_array
2019-08-06 18:54:27,561: DEBUG - ++ local app
2019-08-06 18:54:27,563: DEBUG - ++ local key
2019-08-06 18:54:27,565: DEBUG - ++ ynh_handle_getopts_args nextcloud domain
2019-08-06 18:54:27,566: DEBUG - ++ set +x
2019-08-06 18:54:27,568: DEBUG - ++ echo '! Helper used in legacy mode !'
2019-08-06 18:54:27,570: DEBUG - ++ set +x
2019-08-06 18:54:27,571: DEBUG - ++ ynh_app_setting get nextcloud domain
2019-08-06 18:54:27,573: DEBUG - ++ ACTION=get
2019-08-06 18:54:27,574: DEBUG - ++ APP=nextcloud
2019-08-06 18:54:27,576: DEBUG - ++ KEY=domain
2019-08-06 18:54:27,577: DEBUG - ++ VALUE=
2019-08-06 18:54:27,578: DEBUG - ++ python -
2019-08-06 18:54:28,181: DEBUG - + domain=cloud.mydomain.net
2019-08-06 18:54:28,183: DEBUG - ++ ynh_app_setting_get nextcloud path
2019-08-06 18:54:28,183: DEBUG - ++ local legacy_args=ak
2019-08-06 18:54:28,184: DEBUG - ++ args_array=([a]=app= [k]=key=)
2019-08-06 18:54:28,185: DEBUG - ++ declare -Ar args_array
2019-08-06 18:54:28,186: DEBUG - ++ local app
2019-08-06 18:54:28,187: DEBUG - ++ local key
2019-08-06 18:54:28,187: DEBUG - ++ ynh_handle_getopts_args nextcloud path
2019-08-06 18:54:28,188: DEBUG - ++ set +x
2019-08-06 18:54:28,189: DEBUG - ++ echo '! Helper used in legacy mode !'
2019-08-06 18:54:28,190: DEBUG - ++ set +x
2019-08-06 18:54:28,190: DEBUG - ++ ynh_app_setting get nextcloud path
2019-08-06 18:54:28,191: DEBUG - ++ ACTION=get
2019-08-06 18:54:28,192: DEBUG - ++ APP=nextcloud
2019-08-06 18:54:28,193: DEBUG - ++ KEY=path
2019-08-06 18:54:28,194: DEBUG - ++ VALUE=
2019-08-06 18:54:28,194: DEBUG - ++ python -
2019-08-06 18:54:28,697: DEBUG - + path_url=/cloud
2019-08-06 18:54:28,698: DEBUG - ++ ynh_app_setting_get nextcloud final_path
2019-08-06 18:54:28,698: DEBUG - ++ local legacy_args=ak
2019-08-06 18:54:28,699: DEBUG - ++ args_array=([a]=app= [k]=key=)
2019-08-06 18:54:28,699: DEBUG - ++ declare -Ar args_array
2019-08-06 18:54:28,700: DEBUG - ++ local app
2019-08-06 18:54:28,700: DEBUG - ++ local key
2019-08-06 18:54:28,701: DEBUG - ++ ynh_handle_getopts_args nextcloud final_path
2019-08-06 18:54:28,702: DEBUG - ++ set +x
2019-08-06 18:54:28,702: DEBUG - ++ echo '! Helper used in legacy mode !'
2019-08-06 18:54:28,703: DEBUG - ++ set +x
2019-08-06 18:54:28,703: DEBUG - ++ ynh_app_setting get nextcloud final_path
2019-08-06 18:54:28,704: DEBUG - ++ ACTION=get
2019-08-06 18:54:28,705: DEBUG - ++ APP=nextcloud
2019-08-06 18:54:28,705: DEBUG - ++ KEY=final_path
2019-08-06 18:54:28,706: DEBUG - ++ VALUE=
2019-08-06 18:54:28,706: DEBUG - ++ python -
2019-08-06 18:54:29,108: DEBUG - + final_path=/var/www/nextcloud
2019-08-06 18:54:29,109: DEBUG - ++ ynh_app_setting_get nextcloud db_name
2019-08-06 18:54:29,110: DEBUG - ++ local legacy_args=ak
2019-08-06 18:54:29,111: DEBUG - ++ args_array=([a]=app= [k]=key=)
2019-08-06 18:54:29,112: DEBUG - ++ declare -Ar args_array
2019-08-06 18:54:29,113: DEBUG - ++ local app
2019-08-06 18:54:29,114: DEBUG - ++ local key
2019-08-06 18:54:29,114: DEBUG - ++ ynh_handle_getopts_args nextcloud db_name
2019-08-06 18:54:29,115: DEBUG - ++ set +x
2019-08-06 18:54:29,116: DEBUG - ++ echo '! Helper used in legacy mode !'
2019-08-06 18:54:29,117: DEBUG - ++ set +x
2019-08-06 18:54:29,117: DEBUG - ++ ynh_app_setting get nextcloud db_name
2019-08-06 18:54:29,118: DEBUG - ++ ACTION=get
2019-08-06 18:54:29,119: DEBUG - ++ APP=nextcloud
2019-08-06 18:54:29,120: DEBUG - ++ KEY=db_name
2019-08-06 18:54:29,120: DEBUG - ++ VALUE=
2019-08-06 18:54:29,121: DEBUG - ++ python -
2019-08-06 18:54:29,623: DEBUG - + db_name=nextcloud
2019-08-06 18:54:29,726: INFO - Validating restoration parameters...
2019-08-06 18:54:29,728: DEBUG - + ynh_print_info 'Validating restoration parameters...'
2019-08-06 18:54:29,729: DEBUG - + local legacy_args=m
2019-08-06 18:54:29,729: DEBUG - + args_array=([m]=message=)
2019-08-06 18:54:29,730: DEBUG - + declare -Ar args_array
2019-08-06 18:54:29,730: DEBUG - + local message
2019-08-06 18:54:29,731: DEBUG - + ynh_handle_getopts_args 'Validating restoration parameters...'
2019-08-06 18:54:29,732: DEBUG - + set +x
2019-08-06 18:54:29,734: DEBUG - + echo '! Helper used in legacy mode !'
2019-08-06 18:54:29,736: DEBUG - + set +x
2019-08-06 18:54:29,739: DEBUG - + echo 'Validating restoration parameters...'
2019-08-06 18:54:29,741: DEBUG - + ynh_webpath_available cloud.mydomain.net /cloud
2019-08-06 18:54:29,742: DEBUG - + local legacy_args=dp
2019-08-06 18:54:29,743: DEBUG - + args_array=([d]=domain= [p]=path_url=)
2019-08-06 18:54:29,743: DEBUG - + declare -Ar args_array
2019-08-06 18:54:29,745: DEBUG - + local domain
2019-08-06 18:54:29,746: DEBUG - + local path_url
2019-08-06 18:54:29,747: DEBUG - + ynh_handle_getopts_args cloud.mydomain.net /cloud
2019-08-06 18:54:29,748: DEBUG - + set +x
2019-08-06 18:54:29,749: DEBUG - + echo '! Helper used in legacy mode !'
2019-08-06 18:54:29,750: DEBUG - + set +x
2019-08-06 18:54:29,851: DEBUG - + sudo yunohost domain url-available cloud.mydomain.net /cloud
2019-08-06 18:54:32,561: DEBUG - False
2019-08-06 18:54:32,662: DEBUG - + test '!' -d /var/www/nextcloud
2019-08-06 18:54:32,663: DEBUG - + ynh_restore_file /etc/nginx/conf.d/cloud.mydomain.net.d/nextcloud.conf
2019-08-06 18:54:32,664: DEBUG - + local legacy_args=odm
2019-08-06 18:54:32,665: DEBUG - + args_array=([o]=origin_path= [d]=dest_path= [m]=not_mandatory)
2019-08-06 18:54:32,666: DEBUG - + declare -Ar args_array
2019-08-06 18:54:32,666: DEBUG - + local origin_path
2019-08-06 18:54:32,668: DEBUG - + local archive_path
2019-08-06 18:54:32,668: DEBUG - + local dest_path
2019-08-06 18:54:32,669: DEBUG - + local not_mandatory
2019-08-06 18:54:32,670: DEBUG - + ynh_handle_getopts_args /etc/nginx/conf.d/cloud.mydomain.net.d/nextcloud.conf
2019-08-06 18:54:32,670: DEBUG - + set +x
2019-08-06 18:54:32,672: DEBUG - + echo '! Helper used in legacy mode !'
2019-08-06 18:54:32,673: DEBUG - + set +x
2019-08-06 18:54:32,673: DEBUG - + local origin_path=/etc/nginx/conf.d/cloud.mydomain.net.d/nextcloud.conf
2019-08-06 18:54:32,674: DEBUG - + local archive_path=/home/yunohost.backup/tmp/nextcloud-pre-upgrade2/apps/nextcloud/backup/etc/nginx/conf.d/cloud.mydomain.net.d/nextcloud.conf
2019-08-06 18:54:32,675: DEBUG - + local dest_path=/etc/nginx/conf.d/cloud.mydomain.net.d/nextcloud.conf
2019-08-06 18:54:32,676: DEBUG - + local not_mandatory=0
2019-08-06 18:54:32,677: DEBUG - + '[' '!' -d /home/yunohost.backup/tmp/nextcloud-pre-upgrade2/apps/nextcloud/backup/etc/nginx/conf.d/cloud.mydomain.net.d/nextcloud.conf ']'
2019-08-06 18:54:32,678: DEBUG - + '[' '!' -f /home/yunohost.backup/tmp/nextcloud-pre-upgrade2/apps/nextcloud/backup/etc/nginx/conf.d/cloud.mydomain.net.d/nextcloud.conf ']'
2019-08-06 18:54:32,679: DEBUG - + [[ -e /etc/nginx/conf.d/cloud.mydomain.net.d/nextcloud.conf ]]
2019-08-06 18:54:32,679: DEBUG - ++ dirname /etc/nginx/conf.d/cloud.mydomain.net.d/nextcloud.conf
2019-08-06 18:54:32,680: DEBUG - + mkdir -p /etc/nginx/conf.d/cloud.mydomain.net.d
2019-08-06 18:54:32,680: DEBUG - + mountpoint -q /home/yunohost.backup/tmp/nextcloud-pre-upgrade2
2019-08-06 18:54:32,782: DEBUG - + mv /home/yunohost.backup/tmp/nextcloud-pre-upgrade2/apps/nextcloud/backup/etc/nginx/conf.d/cloud.mydomain.net.d/nextcloud.conf /etc/nginx/conf.d/cloud.mydomain.net.d/nextcloud.conf
2019-08-06 18:54:32,783: DEBUG - + ynh_print_info 'Restoring the app main directory...'
2019-08-06 18:54:32,783: DEBUG - + local legacy_args=m
2019-08-06 18:54:32,784: DEBUG - + args_array=([m]=message=)
2019-08-06 18:54:32,785: DEBUG - + declare -Ar args_array
2019-08-06 18:54:32,785: DEBUG - + local message
2019-08-06 18:54:32,786: DEBUG - + ynh_handle_getopts_args 'Restoring the app main directory...'
2019-08-06 18:54:32,786: DEBUG - + set +x
2019-08-06 18:54:32,787: DEBUG - + echo '! Helper used in legacy mode !'
2019-08-06 18:54:32,788: DEBUG - + set +x
2019-08-06 18:54:32,788: DEBUG - + echo 'Restoring the app main directory...'
2019-08-06 18:54:32,789: DEBUG - + ynh_restore_file /var/www/nextcloud
2019-08-06 18:54:32,789: DEBUG - + local legacy_args=odm
2019-08-06 18:54:32,790: DEBUG - + args_array=([o]=origin_path= [d]=dest_path= [m]=not_mandatory)
2019-08-06 18:54:32,790: DEBUG - + declare -Ar args_array
2019-08-06 18:54:32,791: DEBUG - + local origin_path
2019-08-06 18:54:32,792: DEBUG - + local archive_path
2019-08-06 18:54:32,792: DEBUG - + local dest_path
2019-08-06 18:54:32,793: DEBUG - + local not_mandatory
2019-08-06 18:54:32,794: DEBUG - + ynh_handle_getopts_args /var/www/nextcloud
2019-08-06 18:54:32,795: DEBUG - + set +x
2019-08-06 18:54:32,796: DEBUG - + echo '! Helper used in legacy mode !'
2019-08-06 18:54:32,797: DEBUG - + set +x
2019-08-06 18:54:32,800: DEBUG - + local origin_path=/var/www/nextcloud
2019-08-06 18:54:32,802: DEBUG - + local archive_path=/home/yunohost.backup/tmp/nextcloud-pre-upgrade2/apps/nextcloud/backup/var/www/nextcloud
2019-08-06 18:54:32,803: DEBUG - + local dest_path=/var/www/nextcloud
2019-08-06 18:54:32,804: DEBUG - + local not_mandatory=0
2019-08-06 18:54:32,805: DEBUG - + '[' '!' -d /home/yunohost.backup/tmp/nextcloud-pre-upgrade2/apps/nextcloud/backup/var/www/nextcloud ']'
2019-08-06 18:54:32,809: DEBUG - + [[ -e /var/www/nextcloud ]]
2019-08-06 18:54:32,810: DEBUG - ++ dirname /var/www/nextcloud
2019-08-06 18:54:32,811: DEBUG - + mkdir -p /var/www
2019-08-06 18:54:32,812: DEBUG - + mountpoint -q /home/yunohost.backup/tmp/nextcloud-pre-upgrade2
2019-08-06 18:54:32,813: DEBUG - + mv /home/yunohost.backup/tmp/nextcloud-pre-upgrade2/apps/nextcloud/backup/var/www/nextcloud /var/www/nextcloud
2019-08-06 18:54:32,814: DEBUG - + ynh_print_info 'Restoring the MySQL database...'
2019-08-06 18:54:32,814: DEBUG - + local legacy_args=m
2019-08-06 18:54:32,815: DEBUG - + args_array=([m]=message=)
2019-08-06 18:54:32,816: DEBUG - + declare -Ar args_array
2019-08-06 18:54:32,816: DEBUG - + local message
2019-08-06 18:54:32,817: DEBUG - + ynh_handle_getopts_args 'Restoring the MySQL database...'
2019-08-06 18:54:32,818: DEBUG - + set +x
2019-08-06 18:54:32,819: DEBUG - + echo '! Helper used in legacy mode !'
2019-08-06 18:54:32,820: DEBUG - + set +x
2019-08-06 18:54:32,821: DEBUG - + echo 'Restoring the MySQL database...'
2019-08-06 18:54:32,821: DEBUG - ++ ynh_app_setting_get nextcloud mysqlpwd
2019-08-06 18:54:32,822: DEBUG - ++ local legacy_args=ak
2019-08-06 18:54:32,823: DEBUG - ++ args_array=([a]=app= [k]=key=)
2019-08-06 18:54:32,824: DEBUG - ++ declare -Ar args_array
2019-08-06 18:54:32,825: DEBUG - ++ local app
2019-08-06 18:54:32,826: DEBUG - ++ local key
2019-08-06 18:54:32,826: DEBUG - ++ ynh_handle_getopts_args nextcloud mysqlpwd
2019-08-06 18:54:32,827: DEBUG - ++ set +x
2019-08-06 18:54:32,828: DEBUG - ++ echo '! Helper used in legacy mode !'
2019-08-06 18:54:32,829: DEBUG - ++ set +x
2019-08-06 18:54:32,829: DEBUG - ++ ynh_app_setting get nextcloud mysqlpwd
2019-08-06 18:54:32,830: DEBUG - ++ ACTION=get
2019-08-06 18:54:32,831: DEBUG - ++ APP=nextcloud
2019-08-06 18:54:32,832: DEBUG - ++ KEY=mysqlpwd
2019-08-06 18:54:32,832: DEBUG - ++ VALUE=
2019-08-06 18:54:32,833: DEBUG - ++ python -
2019-08-06 18:54:33,336: DEBUG - + db_pwd=**********
2019-08-06 18:54:33,337: DEBUG - + ynh_mysql_setup_db nextcloud nextcloud **********
2019-08-06 18:54:33,338: DEBUG - + local legacy_args=unp
2019-08-06 18:54:33,339: DEBUG - + args_array=([u]=db_user= [n]=db_name= [p]=db_pwd=)
2019-08-06 18:54:33,341: DEBUG - + declare -Ar args_array
2019-08-06 18:54:33,342: DEBUG - + local db_user
2019-08-06 18:54:33,342: DEBUG - + local db_name
2019-08-06 18:54:33,343: DEBUG - + db_pwd=
2019-08-06 18:54:33,344: DEBUG - + ynh_handle_getopts_args nextcloud nextcloud **********
2019-08-06 18:54:33,345: DEBUG - + set +x
2019-08-06 18:54:33,346: DEBUG - + echo '! Helper used in legacy mode !'
2019-08-06 18:54:33,346: DEBUG - + set +x
2019-08-06 18:54:33,347: DEBUG - ++ ynh_string_random
2019-08-06 18:54:33,347: DEBUG - ++ local legacy_args=l
2019-08-06 18:54:33,348: DEBUG - ++ args_array=([l]=length=)
2019-08-06 18:54:33,349: DEBUG - ++ declare -Ar args_array
2019-08-06 18:54:33,349: DEBUG - ++ local length
2019-08-06 18:54:33,350: DEBUG - ++ ynh_handle_getopts_args
2019-08-06 18:54:33,351: DEBUG - ++ set +x
2019-08-06 18:54:33,352: DEBUG - ++ length=24
2019-08-06 18:54:33,353: DEBUG - ++ dd if=/dev/urandom bs=1 count=1000
2019-08-06 18:54:33,354: DEBUG - ++ sed -n 's/\(.\{24\}\).*/\1/p'
2019-08-06 18:54:33,355: DEBUG - ++ tr -c -d A-Za-z0-9
2019-08-06 18:54:33,456: DEBUG - + local new_db_pwd=**********
2019-08-06 18:54:33,457: DEBUG - + db_pwd=**********
2019-08-06 18:54:33,458: DEBUG - + ynh_mysql_create_db nextcloud nextcloud **********
2019-08-06 18:54:33,459: DEBUG - + local db=nextcloud
2019-08-06 18:54:33,460: DEBUG - + local 'sql=CREATE DATABASE nextcloud;'
2019-08-06 18:54:33,461: DEBUG - + [[ 3 -gt 1 ]]
2019-08-06 18:54:33,461: DEBUG - + sql+=' GRANT ALL PRIVILEGES ON nextcloud.* TO '\''nextcloud'\''@'\''localhost'\'''
2019-08-06 18:54:33,462: DEBUG - + [[ -n ********** ]]
2019-08-06 18:54:33,463: DEBUG - + sql+=' IDENTIFIED BY '\''**********'\'''
2019-08-06 18:54:33,464: DEBUG - + sql+=' WITH GRANT OPTION;'
2019-08-06 18:54:33,465: DEBUG - + ynh_mysql_execute_as_root '--sql=CREATE DATABASE nextcloud; GRANT ALL PRIVILEGES ON nextcloud.* TO '\''nextcloud'\''@'\''localhost'\'' IDENTIFIED BY '\''**********'\'' WITH GRANT OPTION;'
2019-08-06 18:54:33,466: DEBUG - + local legacy_args=sd
2019-08-06 18:54:33,467: DEBUG - + args_array=([s]=sql= [d]=database=)
2019-08-06 18:54:33,467: DEBUG - + declare -Ar args_array
2019-08-06 18:54:33,468: DEBUG - + local sql
2019-08-06 18:54:33,469: DEBUG - + local database
2019-08-06 18:54:33,470: DEBUG - + ynh_handle_getopts_args '--sql=CREATE DATABASE nextcloud; GRANT ALL PRIVILEGES ON nextcloud.* TO '\''nextcloud'\''@'\''localhost'\'' IDENTIFIED BY '\''**********'\'' WITH GRANT OPTION;'
2019-08-06 18:54:33,471: DEBUG - + set +x
2019-08-06 18:54:33,472: DEBUG - + database=
2019-08-06 18:54:33,473: DEBUG - ++ sudo cat /etc/yunohost/mysql
2019-08-06 18:54:33,474: DEBUG - + ynh_mysql_connect_as --user=root --password=********** --database=
2019-08-06 18:54:33,475: DEBUG - + local legacy_args=upd
2019-08-06 18:54:33,476: DEBUG - + args_array=([u]=user= [p]=password= [d]=database=)
2019-08-06 18:54:33,477: DEBUG - + declare -Ar args_array
2019-08-06 18:54:33,478: DEBUG - + local user
2019-08-06 18:54:33,478: DEBUG - + local password
2019-08-06 18:54:33,479: DEBUG - + local database
2019-08-06 18:54:33,480: DEBUG - + ynh_handle_getopts_args --user=root --password=********** --database=
2019-08-06 18:54:33,481: DEBUG - + set +x
2019-08-06 18:54:33,582: DEBUG - + database=
2019-08-06 18:54:33,583: DEBUG - + mysql -u root --password=********** -B ''
2019-08-06 18:54:33,785: DEBUG - + ynh_app_setting_set --app=nextcloud --key=mysqlpwd --value=**********
2019-08-06 18:54:33,786: DEBUG - + local legacy_args=akv
2019-08-06 18:54:33,786: DEBUG - + args_array=([a]=app= [k]=key= [v]=value=)
2019-08-06 18:54:33,787: DEBUG - + declare -Ar args_array
2019-08-06 18:54:33,787: DEBUG - + local app
2019-08-06 18:54:33,788: DEBUG - + local key
2019-08-06 18:54:33,789: DEBUG - + local value
2019-08-06 18:54:33,789: DEBUG - + ynh_handle_getopts_args --app=nextcloud --key=mysqlpwd --value=**********
2019-08-06 18:54:33,790: DEBUG - + set +x
2019-08-06 18:54:33,791: DEBUG - + ynh_app_setting set nextcloud mysqlpwd **********
2019-08-06 18:54:33,791: DEBUG - + ACTION=set
2019-08-06 18:54:33,792: DEBUG - + APP=nextcloud
2019-08-06 18:54:33,792: DEBUG - + KEY=mysqlpwd
2019-08-06 18:54:33,793: DEBUG - + VALUE=**********
2019-08-06 18:54:33,794: DEBUG - + python -
2019-08-06 18:54:34,296: DEBUG - + ynh_mysql_connect_as nextcloud ********** nextcloud
2019-08-06 18:54:34,297: DEBUG - + local legacy_args=upd
2019-08-06 18:54:34,298: DEBUG - + args_array=([u]=user= [p]=password= [d]=database=)
2019-08-06 18:54:34,299: DEBUG - + declare -Ar args_array
2019-08-06 18:54:34,299: DEBUG - + local user
2019-08-06 18:54:34,300: DEBUG - + local password
2019-08-06 18:54:34,301: DEBUG - + local database
2019-08-06 18:54:34,303: DEBUG - + ynh_handle_getopts_args nextcloud ********** nextcloud
2019-08-06 18:54:34,304: DEBUG - + set +x
2019-08-06 18:54:34,304: DEBUG - + echo '! Helper used in legacy mode !'
2019-08-06 18:54:34,305: DEBUG - + set +x
2019-08-06 18:54:34,307: DEBUG - + database=nextcloud
2019-08-06 18:54:34,309: DEBUG - + mysql -u nextcloud --password=********** -B nextcloud
2019-08-06 18:54:42,642: DEBUG - + ynh_print_info 'Recreating the dedicated system user...'
2019-08-06 18:54:42,644: DEBUG - + local legacy_args=m
2019-08-06 18:54:42,645: DEBUG - + args_array=([m]=message=)
2019-08-06 18:54:42,647: DEBUG - + declare -Ar args_array
2019-08-06 18:54:42,648: DEBUG - + local message
2019-08-06 18:54:42,651: DEBUG - + ynh_handle_getopts_args 'Recreating the dedicated system user...'
2019-08-06 18:54:42,654: DEBUG - + set +x
2019-08-06 18:54:42,655: DEBUG - + echo '! Helper used in legacy mode !'
2019-08-06 18:54:42,657: DEBUG - + set +x
2019-08-06 18:54:42,658: DEBUG - + echo 'Recreating the dedicated system user...'
2019-08-06 18:54:42,659: DEBUG - + ynh_system_user_create nextcloud
2019-08-06 18:54:42,661: DEBUG - + local legacy_args=uhs
2019-08-06 18:54:42,662: DEBUG - + args_array=([u]=username= [h]=home_dir= [s]=use_shell)
2019-08-06 18:54:42,664: DEBUG - + declare -Ar args_array
2019-08-06 18:54:42,666: DEBUG - + local username
2019-08-06 18:54:42,667: DEBUG - + local home_dir
2019-08-06 18:54:42,668: DEBUG - + local use_shell
2019-08-06 18:54:42,670: DEBUG - + ynh_handle_getopts_args nextcloud
2019-08-06 18:54:42,672: DEBUG - + set +x
2019-08-06 18:54:42,674: DEBUG - + echo '! Helper used in legacy mode !'
2019-08-06 18:54:42,675: DEBUG - + set +x
2019-08-06 18:54:42,676: DEBUG - + use_shell=0
2019-08-06 18:54:42,678: DEBUG - + home_dir=
2019-08-06 18:54:42,679: DEBUG - + ynh_system_user_exists nextcloud
2019-08-06 18:54:42,680: DEBUG - + local legacy_args=u
2019-08-06 18:54:42,681: DEBUG - + args_array=([u]=username=)
2019-08-06 18:54:42,683: DEBUG - + declare -Ar args_array
2019-08-06 18:54:42,685: DEBUG - + local username
2019-08-06 18:54:42,686: DEBUG - + ynh_handle_getopts_args nextcloud
2019-08-06 18:54:42,687: DEBUG - + set +x
2019-08-06 18:54:42,689: DEBUG - + echo '! Helper used in legacy mode !'
2019-08-06 18:54:42,690: DEBUG - + set +x
2019-08-06 18:54:42,692: DEBUG - + getent passwd nextcloud
2019-08-06 18:54:42,693: DEBUG - + '[' -n '' ']'
2019-08-06 18:54:42,695: DEBUG - + local user_home_dir=--no-create-home
2019-08-06 18:54:42,696: DEBUG - + '[' 0 -eq 1 ']'
2019-08-06 18:54:42,697: DEBUG - + local 'shell=--shell /usr/sbin/nologin'
2019-08-06 18:54:42,699: DEBUG - + useradd --no-create-home --system --user-group nextcloud --shell /usr/sbin/nologin
2019-08-06 18:54:55,045: DEBUG - + ynh_restore_file /etc/php/7.0/fpm/pool.d/nextcloud.conf
2019-08-06 18:54:55,047: DEBUG - + local legacy_args=odm
2019-08-06 18:54:55,048: DEBUG - + args_array=([o]=origin_path= [d]=dest_path= [m]=not_mandatory)
2019-08-06 18:54:55,050: DEBUG - + declare -Ar args_array
2019-08-06 18:54:55,051: DEBUG - + local origin_path
2019-08-06 18:54:55,053: DEBUG - + local archive_path
2019-08-06 18:54:55,055: DEBUG - + local dest_path
2019-08-06 18:54:55,056: DEBUG - + local not_mandatory
2019-08-06 18:54:55,058: DEBUG - + ynh_handle_getopts_args /etc/php/7.0/fpm/pool.d/nextcloud.conf
2019-08-06 18:54:55,059: DEBUG - + set +x
2019-08-06 18:54:55,061: DEBUG - + echo '! Helper used in legacy mode !'
2019-08-06 18:54:55,062: DEBUG - + set +x
2019-08-06 18:54:55,063: DEBUG - + local origin_path=/etc/php/7.0/fpm/pool.d/nextcloud.conf
2019-08-06 18:54:55,065: DEBUG - + local archive_path=/home/yunohost.backup/tmp/nextcloud-pre-upgrade2/apps/nextcloud/backup/etc/php/7.0/fpm/pool.d/nextcloud.conf
2019-08-06 18:54:55,066: DEBUG - + local dest_path=/etc/php/7.0/fpm/pool.d/nextcloud.conf
2019-08-06 18:54:55,067: DEBUG - + local not_mandatory=0
2019-08-06 18:54:55,068: DEBUG - + '[' '!' -d /home/yunohost.backup/tmp/nextcloud-pre-upgrade2/apps/nextcloud/backup/etc/php/7.0/fpm/pool.d/nextcloud.conf ']'
2019-08-06 18:54:55,070: DEBUG - + '[' '!' -f /home/yunohost.backup/tmp/nextcloud-pre-upgrade2/apps/nextcloud/backup/etc/php/7.0/fpm/pool.d/nextcloud.conf ']'
2019-08-06 18:54:55,072: DEBUG - + [[ -e /etc/php/7.0/fpm/pool.d/nextcloud.conf ]]
2019-08-06 18:54:55,074: DEBUG - ++ dirname /etc/php/7.0/fpm/pool.d/nextcloud.conf
2019-08-06 18:54:55,075: DEBUG - + mkdir -p /etc/php/7.0/fpm/pool.d
2019-08-06 18:54:55,077: DEBUG - + mountpoint -q /home/yunohost.backup/tmp/nextcloud-pre-upgrade2
2019-08-06 18:54:55,078: DEBUG - + mv /home/yunohost.backup/tmp/nextcloud-pre-upgrade2/apps/nextcloud/backup/etc/php/7.0/fpm/pool.d/nextcloud.conf /etc/php/7.0/fpm/pool.d/nextcloud.conf
2019-08-06 18:54:55,079: DEBUG - + ynh_print_info 'Reinstalling dependencies...'
2019-08-06 18:54:55,081: DEBUG - + local legacy_args=m
2019-08-06 18:54:55,082: DEBUG - + args_array=([m]=message=)
2019-08-06 18:54:55,083: DEBUG - + declare -Ar args_array
2019-08-06 18:54:55,084: DEBUG - + local message
2019-08-06 18:54:55,084: DEBUG - + ynh_handle_getopts_args 'Reinstalling dependencies...'
2019-08-06 18:54:55,085: DEBUG - + set +x
2019-08-06 18:54:55,086: DEBUG - + echo '! Helper used in legacy mode !'
2019-08-06 18:54:55,087: DEBUG - + set +x
2019-08-06 18:54:55,088: DEBUG - + echo 'Reinstalling dependencies...'
2019-08-06 18:54:55,090: DEBUG - + ynh_install_app_dependencies php-gd php-json php-intl php-mcrypt php-curl php-apcu php-redis php-ldap php-imagick php-zip php-mbstring php-xml imagemagick acl tar smbclient at
2019-08-06 18:54:55,091: DEBUG - + local 'dependencies=php-gd php-json php-intl php-mcrypt php-curl php-apcu php-redis php-ldap php-imagick php-zip php-mbstring php-xml imagemagick acl tar smbclient at'
2019-08-06 18:54:55,091: DEBUG - + local 'dependencies=php-gd, php-json, php-intl, php-mcrypt, php-curl, php-apcu, php-redis, php-ldap, php-imagick, php-zip, php-mbstring, php-xml, imagemagick, acl, tar, smbclient, at'
2019-08-06 18:54:55,092: DEBUG - + local 'dependencies=php-gd, php-json, php-intl, php-mcrypt, php-curl, php-apcu, php-redis, php-ldap, php-imagick, php-zip, php-mbstring, php-xml, imagemagick, acl, tar, smbclient, at'
2019-08-06 18:54:55,093: DEBUG - + local manifest_path=../manifest.json
2019-08-06 18:54:55,094: DEBUG - + '[' '!' -e ../manifest.json ']'
2019-08-06 18:54:55,095: DEBUG - + manifest_path=../settings/manifest.json
2019-08-06 18:54:55,095: DEBUG - ++ grep '\"version\": ' ../settings/manifest.json
2019-08-06 18:54:55,096: DEBUG - ++ cut -d '"' -f 4
2019-08-06 18:54:55,198: DEBUG - + local version=15.0.5~ynh3
2019-08-06 18:54:55,199: DEBUG - + '[' 11 -eq 0 ']'
2019-08-06 18:54:55,199: DEBUG - + local dep_app=nextcloud
2019-08-06 18:54:55,200: DEBUG - + cat
2019-08-06 18:54:55,201: DEBUG - + ynh_package_install_from_equivs /tmp/nextcloud-ynh-deps.control
2019-08-06 18:54:55,202: DEBUG - + local controlfile=/tmp/nextcloud-ynh-deps.control
2019-08-06 18:54:55,202: DEBUG - ++ grep '^Package: ' /tmp/nextcloud-ynh-deps.control
2019-08-06 18:54:55,203: DEBUG - ++ cut '-d ' -f 2
2019-08-06 18:54:55,204: DEBUG - + local pkgname=nextcloud-ynh-deps
2019-08-06 18:54:55,205: DEBUG - ++ grep '^Version: ' /tmp/nextcloud-ynh-deps.control
2019-08-06 18:54:55,205: DEBUG - ++ cut '-d ' -f 2
2019-08-06 18:54:55,206: DEBUG - + local pkgversion=15.0.5~ynh3
2019-08-06 18:54:55,207: DEBUG - + [[ -z nextcloud-ynh-deps ]]
2019-08-06 18:54:55,207: DEBUG - + [[ -z 15.0.5~ynh3 ]]
2019-08-06 18:54:55,208: DEBUG - + ynh_package_update
2019-08-06 18:54:55,209: DEBUG - + ynh_apt update
2019-08-06 18:54:55,210: DEBUG - + ynh_wait_dpkg_free
2019-08-06 18:54:55,210: DEBUG - + local try
2019-08-06 18:54:55,211: DEBUG - ++ seq 1 17
2019-08-06 18:54:55,212: DEBUG - + for try in `seq 1 17`
2019-08-06 18:54:55,212: DEBUG - + sudo lsof /var/lib/dpkg/lock
2019-08-06 18:54:56,216: DEBUG - + local dpkg_dir=/var/lib/dpkg/updates/
2019-08-06 18:54:56,217: DEBUG - ++ ls -1 /var/lib/dpkg/updates/
2019-08-06 18:54:56,218: DEBUG - + read dpkg_file
2019-08-06 18:54:56,218: DEBUG - + echo ''
2019-08-06 18:54:56,219: DEBUG - + grep -Pq '^[[:digit:]]+$'
2019-08-06 18:54:56,220: DEBUG - + read dpkg_file
2019-08-06 18:54:56,220: DEBUG - + return 0
2019-08-06 18:54:56,221: DEBUG - + DEBIAN_FRONTEND=noninteractive
2019-08-06 18:54:56,221: DEBUG - + apt-get -y update
2019-08-06 18:54:56,623: DEBUG - Get:1 http://archive.raspberrypi.org/debian stretch InRelease [25.4 kB]
2019-08-06 18:54:56,725: DEBUG - Hit:2 http://forge.yunohost.org/debian stretch InRelease
2019-08-06 18:54:56,727: DEBUG - Hit:3 http://raspbian.raspberrypi.org/raspbian stretch InRelease
2019-08-06 18:54:57,231: DEBUG - Hit:4 https://www.collaboraoffice.com/repos/CollaboraOnline/CODE-debian8 ./ InRelease
2019-08-06 18:54:57,232: DEBUG - Hit:5 https://www.collaboraoffice.com/repos/CollaboraOnline/CODE-debian9 ./ InRelease
2019-08-06 18:54:57,434: DEBUG - Hit:6 https://download.docker.com/linux/raspbian stretch InRelease
2019-08-06 18:54:59,541: DEBUG - Fetched 25.4 kB in 2s (8,802 B/s)
2019-08-06 18:55:03,954: DEBUG - Reading package lists...
2019-08-06 18:55:04,056: DEBUG - ++ mktemp -d
2019-08-06 18:55:04,057: DEBUG - + local TMPDIR=/tmp/tmp.DW8GNiq0Pa
2019-08-06 18:55:04,057: DEBUG - + echo 10
2019-08-06 18:55:04,258: DEBUG - + ynh_wait_dpkg_free
2019-08-06 18:55:04,259: DEBUG - + local try
2019-08-06 18:55:04,260: DEBUG - ++ seq 1 17
2019-08-06 18:55:04,261: DEBUG - + for try in `seq 1 17`
2019-08-06 18:55:04,261: DEBUG - + sudo lsof /var/lib/dpkg/lock
2019-08-06 18:55:04,663: DEBUG - + local dpkg_dir=/var/lib/dpkg/updates/
2019-08-06 18:55:04,664: DEBUG - ++ ls -1 /var/lib/dpkg/updates/
2019-08-06 18:55:04,665: DEBUG - + read dpkg_file
2019-08-06 18:55:04,665: DEBUG - + echo ''
2019-08-06 18:55:04,666: DEBUG - + grep -Pq '^[[:digit:]]+$'
2019-08-06 18:55:04,667: DEBUG - + read dpkg_file
2019-08-06 18:55:04,667: DEBUG - + return 0
2019-08-06 18:55:04,668: DEBUG - + cp /tmp/nextcloud-ynh-deps.control /tmp/tmp.DW8GNiq0Pa/control
2019-08-06 18:55:04,668: DEBUG - + cd /tmp/tmp.DW8GNiq0Pa
2019-08-06 18:55:04,669: DEBUG - + equivs-build ./control
2019-08-06 18:55:07,979: DEBUG - + dpkg --force-depends -i ./nextcloud-ynh-deps_15.0.5~ynh3_all.deb
2019-08-06 18:55:08,181: DEBUG - Selecting previously unselected package nextcloud-ynh-deps.
2019-08-06 18:55:08,884: DEBUG - (Reading database ... 61788 files and directories currently installed.)
2019-08-06 18:55:08,885: DEBUG - Preparing to unpack .../nextcloud-ynh-deps_15.0.5~ynh3_all.deb ...
2019-08-06 18:55:08,886: DEBUG - Unpacking nextcloud-ynh-deps (15.0.5~ynh3) ...
2019-08-06 18:55:11,093: DEBUG - dpkg: nextcloud-ynh-deps: dependency problems, but configuring anyway as you requested:
2019-08-06 18:55:11,095: DEBUG - nextcloud-ynh-deps depends on php-apcu; however:
2019-08-06 18:55:11,096: DEBUG - Package php-apcu is not installed.
2019-08-06 18:55:11,098: DEBUG - nextcloud-ynh-deps depends on php-redis; however:
2019-08-06 18:55:11,099: DEBUG - Package php-redis is not installed.
2019-08-06 18:55:11,100: DEBUG - nextcloud-ynh-deps depends on php-imagick; however:
2019-08-06 18:55:11,101: DEBUG - Package php-imagick is not installed.
2019-08-06 18:55:11,103: DEBUG - nextcloud-ynh-deps depends on php-zip; however:
2019-08-06 18:55:11,104: DEBUG - Package php-zip is not installed.
2019-08-06 18:55:11,105: DEBUG - Package php7.0-zip which provides php-zip is not installed.
2019-08-06 18:55:11,107: DEBUG - nextcloud-ynh-deps depends on acl; however:
2019-08-06 18:55:11,108: DEBUG - Package acl is not installed.
2019-08-06 18:55:11,109: DEBUG - nextcloud-ynh-deps depends on at; however:
2019-08-06 18:55:11,110: DEBUG - Package at is not installed.
2019-08-06 18:55:11,112: DEBUG -
2019-08-06 18:55:11,113: DEBUG - Setting up nextcloud-ynh-deps (15.0.5~ynh3) ...
2019-08-06 18:55:11,215: DEBUG - + ynh_package_install -f
2019-08-06 18:55:11,217: DEBUG - + ynh_apt --no-remove -o Dpkg::Options::=--force-confdef -o Dpkg::Options::=--force-confold install -f
2019-08-06 18:55:11,219: DEBUG - + ynh_wait_dpkg_free
2019-08-06 18:55:11,221: DEBUG - + local try
2019-08-06 18:55:11,222: DEBUG - ++ seq 1 17
2019-08-06 18:55:11,223: DEBUG - + for try in `seq 1 17`
2019-08-06 18:55:11,225: DEBUG - + sudo lsof /var/lib/dpkg/lock
2019-08-06 18:55:11,627: DEBUG - + local dpkg_dir=/var/lib/dpkg/updates/
2019-08-06 18:55:11,628: DEBUG - ++ ls -1 /var/lib/dpkg/updates/
2019-08-06 18:55:11,629: DEBUG - + read dpkg_file
2019-08-06 18:55:11,630: DEBUG - + echo ''
2019-08-06 18:55:11,631: DEBUG - + grep -Pq '^[[:digit:]]+$'
2019-08-06 18:55:11,631: DEBUG - + read dpkg_file
2019-08-06 18:55:11,632: DEBUG - + return 0
2019-08-06 18:55:11,633: DEBUG - + DEBIAN_FRONTEND=noninteractive
2019-08-06 18:55:11,633: DEBUG - + apt-get -y --no-remove -o Dpkg::Options::=--force-confdef -o Dpkg::Options::=--force-confold install -f
2019-08-06 18:55:12,236: DEBUG - Reading package lists...
2019-08-06 18:55:13,340: DEBUG - Building dependency tree...
2019-08-06 18:55:13,341: DEBUG - Reading state information...
2019-08-06 18:55:14,144: DEBUG - Correcting dependencies... Done
2019-08-06 18:55:15,048: DEBUG - The following additional packages will be installed:
2019-08-06 18:55:15,049: DEBUG - acl at libzip4 php-apcu php-apcu-bc php-igbinary php-imagick php-redis
2019-08-06 18:55:15,050: DEBUG - php-zip php7.0-zip ttf-dejavu-core
2019-08-06 18:55:15,151: DEBUG - The following NEW packages will be installed:
2019-08-06 18:55:15,152: DEBUG - acl at libzip4 php-apcu php-apcu-bc php-igbinary php-imagick php-redis
2019-08-06 18:55:15,153: DEBUG - php-zip php7.0-zip ttf-dejavu-core
2019-08-06 18:55:19,667: DEBUG - 0 upgraded, 11 newly installed, 0 to remove and 0 not upgraded.
2019-08-06 18:55:19,668: DEBUG - 1 not fully installed or removed.
2019-08-06 18:55:19,668: DEBUG - Need to get 0 B/441 kB of archives.
2019-08-06 18:55:19,669: DEBUG - After this operation, 1,606 kB of additional disk space will be used.
2019-08-06 18:55:19,871: DEBUG - (Reading database ...
(Reading database ... 5%
(Reading database ... 10%
(Reading database ... 15%
(Reading database ... 20%
(Reading database ... 25%
(Reading database ... 30%
(Reading database ... 35%
(Reading database ... 40%
(Reading database ... 45%
(Reading database ... 50%
(Reading database ... 55%
(Reading database ... 60%
(Reading database ... 65%
(Reading database ... 70%
(Reading database ... 75%
(Reading database ... 80%
(Reading database ... 85%
(Reading database ... 90%
(Reading database ... 95%
(Reading database ... 100%
(Reading database ... 61792 files and directories currently installed.)
2019-08-06 18:55:19,872: DEBUG - Preparing to unpack .../00-at_3.1.20-3_armhf.deb ...
2019-08-06 18:55:19,872: DEBUG - Unpacking at (3.1.20-3) ...
2019-08-06 18:55:20,174: DEBUG - Preparing to unpack .../01-acl_2.2.52-3_armhf.deb ...
2019-08-06 18:55:20,175: DEBUG - Unpacking acl (2.2.52-3) ...
2019-08-06 18:55:20,377: DEBUG - Selecting previously unselected package libzip4:armhf.
2019-08-06 18:55:20,378: DEBUG - Preparing to unpack .../02-libzip4_1.1.2-1.1_armhf.deb ...
2019-08-06 18:55:20,379: DEBUG - Unpacking libzip4:armhf (1.1.2-1.1) ...
2019-08-06 18:55:20,581: DEBUG - Preparing to unpack .../03-php-apcu_5.1.8+4.0.11-1_armhf.deb ...
2019-08-06 18:55:20,684: DEBUG - Unpacking php-apcu (5.1.8+4.0.11-1) ...
2019-08-06 18:55:20,886: DEBUG - Preparing to unpack .../04-php-apcu-bc_1.0.3-2_armhf.deb ...
2019-08-06 18:55:20,988: DEBUG - Unpacking php-apcu-bc (1.0.3-2) ...
2019-08-06 18:55:21,191: DEBUG - Preparing to unpack .../05-php-igbinary_2.0.1-1_armhf.deb ...
2019-08-06 18:55:21,193: DEBUG - Unpacking php-igbinary (2.0.1-1) ...
2019-08-06 18:55:21,496: DEBUG - Preparing to unpack .../06-php-imagick_3.4.3~rc2-2_armhf.deb ...
2019-08-06 18:55:21,497: DEBUG - Unpacking php-imagick (3.4.3~rc2-2) ...
2019-08-06 18:55:21,800: DEBUG - Preparing to unpack .../07-php-redis_3.1.1-1_armhf.deb ...
2019-08-06 18:55:21,801: DEBUG - Unpacking php-redis (3.1.1-1) ...
2019-08-06 18:55:22,002: DEBUG - Preparing to unpack .../08-php7.0-zip_7.0.33-0+deb9u3_armhf.deb ...
2019-08-06 18:55:22,003: DEBUG - Unpacking php7.0-zip (7.0.33-0+deb9u3) ...
2019-08-06 18:55:22,205: DEBUG - Selecting previously unselected package php-zip.
2019-08-06 18:55:22,206: DEBUG - Preparing to unpack .../09-php-zip_1%3a7.0+49_all.deb ...
2019-08-06 18:55:22,207: DEBUG - Unpacking php-zip (1:7.0+49) ...
2019-08-06 18:55:22,308: DEBUG - Selecting previously unselected package ttf-dejavu-core.
2019-08-06 18:55:22,309: DEBUG - Preparing to unpack .../10-ttf-dejavu-core_2.37-1_all.deb ...
2019-08-06 18:55:22,311: DEBUG - Unpacking ttf-dejavu-core (2.37-1) ...
2019-08-06 18:55:22,713: DEBUG - Setting up docker-ce (5:19.03.1~3-0~raspbian-stretch) ...
2019-08-06 18:55:28,638: DEBUG - Job for docker.service failed because the control process exited with error code.
2019-08-06 18:55:28,639: DEBUG - See "systemctl status docker.service" and "journalctl -xe" for details.
2019-08-06 18:55:28,640: DEBUG - invoke-rc.d: initscript docker, action "start" failed.
2019-08-06 18:55:28,640: DEBUG - â— docker.service - Docker Application Container Engine
2019-08-06 18:55:28,641: DEBUG - Loaded: loaded (/lib/systemd/system/docker.service; enabled; vendor preset: enabled)
2019-08-06 18:55:28,642: DEBUG - Active: activating (auto-restart) (Result: exit-code) since Tue 2019-08-06 18:55:28 UTC; 30ms ago
2019-08-06 18:55:28,642: DEBUG - Docs: https://docs.docker.com
2019-08-06 18:55:28,643: DEBUG - Process: 22062 ExecStart=/usr/bin/dockerd -H fd:// --containerd=/run/containerd/containerd.sock (code=exited, status=1/FAILURE)
2019-08-06 18:55:28,643: DEBUG - Main PID: 22062 (code=exited, status=1/FAILURE)
2019-08-06 18:55:28,644: DEBUG - CPU: 971ms
2019-08-06 18:55:28,645: DEBUG -
2019-08-06 18:55:28,645: DEBUG - Aug 06 18:55:28 ihost.mydomain.net systemd[1]: docker.service: Unit entere…e.
2019-08-06 18:55:28,646: DEBUG - Aug 06 18:55:28 ihost.mydomain.net systemd[1]: docker.service: Failed with…'.
2019-08-06 18:55:28,647: DEBUG - Hint: Some lines were ellipsized, use -l to show in full.
2019-08-06 18:55:28,651: DEBUG - dpkg: error processing package docker-ce (--configure):
2019-08-06 18:55:28,655: DEBUG - subprocess installed post-installation script returned error exit status 1
2019-08-06 18:55:28,656: DEBUG - Setting up php-apcu (5.1.8+4.0.11-1) ...
2019-08-06 18:55:29,058: DEBUG - Setting up php-imagick (3.4.3~rc2-2) ...
2019-08-06 18:55:29,663: DEBUG - Setting up ttf-dejavu-core (2.37-1) ...
2019-08-06 18:55:29,665: DEBUG - Setting up php-igbinary (2.0.1-1) ...
2019-08-06 18:55:30,169: DEBUG - Setting up at (3.1.20-3) ...
2019-08-06 18:55:32,478: DEBUG - Setting up php-redis (3.1.1-1) ...
2019-08-06 18:55:32,780: DEBUG - Processing triggers for php7.0-fpm (7.0.33-0+deb9u3) ...
2019-08-06 18:55:34,688: DEBUG - Setting up libzip4:armhf (1.1.2-1.1) ...
2019-08-06 18:55:34,689: DEBUG - Setting up php7.0-zip (7.0.33-0+deb9u3) ...
2019-08-06 18:55:34,790: DEBUG - /bin/bash: BASH_XTRACEFD: 7: invalid value for trace file descriptor
2019-08-06 18:55:35,393: DEBUG - /bin/bash: BASH_XTRACEFD: 7: invalid value for trace file descriptor
2019-08-06 18:55:35,996: DEBUG - /bin/bash: BASH_XTRACEFD: 7: invalid value for trace file descriptor
2019-08-06 18:55:36,504: DEBUG - Processing triggers for libc-bin (2.24-11+deb9u4) ...
2019-08-06 18:55:36,606: DEBUG - Processing triggers for systemd (232-25+deb9u11) ...
2019-08-06 18:55:37,109: DEBUG - Processing triggers for man-db (2.7.6.1-2) ...
2019-08-06 18:55:38,013: DEBUG - Setting up php-apcu-bc (1.0.3-2) ...
2019-08-06 18:55:38,415: DEBUG - Setting up acl (2.2.52-3) ...
2019-08-06 18:55:38,517: DEBUG - Processing triggers for fontconfig (2.11.0-6.7) ...
2019-08-06 18:55:41,025: DEBUG - Setting up php-zip (1:7.0+49) ...
2019-08-06 18:55:41,128: DEBUG - Processing triggers for php7.0-fpm (7.0.33-0+deb9u3) ...
2019-08-06 18:55:42,734: DEBUG - Errors were encountered while processing:
2019-08-06 18:55:42,735: DEBUG - docker-ce
2019-08-06 18:55:44,140: DEBUG - + ynh_die '--message=Unable to install dependencies'
2019-08-06 18:55:44,142: WARNING - E: Sub-process /usr/bin/dpkg returned an error code (1)
2019-08-06 18:55:44,144: DEBUG - + local legacy_args=mc
2019-08-06 18:55:44,145: DEBUG - + args_array=([m]=message= [c]=ret_code=)
2019-08-06 18:55:44,146: DEBUG - + declare -Ar args_array
2019-08-06 18:55:44,147: DEBUG - + local message
2019-08-06 18:55:44,148: DEBUG - + local ret_code
2019-08-06 18:55:44,149: DEBUG - + ynh_handle_getopts_args '--message=Unable to install dependencies'
2019-08-06 18:55:44,150: DEBUG - + set +x
2019-08-06 18:55:44,251: DEBUG - + echo 'Unable to install dependencies'
2019-08-06 18:55:44,252: WARNING - Unable to install dependencies
2019-08-06 18:55:44,254: DEBUG - + exit 1
2019-08-06 18:55:44,254: DEBUG - + ynh_exit_properly
2019-08-06 18:55:44,255: DEBUG - + local exit_code=1
2019-08-06 18:55:44,256: DEBUG - + '[' 1 -eq 0 ']'
2019-08-06 18:55:44,256: DEBUG - + trap '' EXIT
2019-08-06 18:55:44,257: DEBUG - + set +eu
2019-08-06 18:55:44,257: DEBUG - + sleep 0.5
2019-08-06 18:55:44,760: DEBUG - + ynh_print_err '--message=!!\n nextcloud'\''s script has encountered an error. Its execution was cancelled.\n!!'
2019-08-06 18:55:44,762: WARNING - e[91me[1m[ERR]e[0m !!
2019-08-06 18:55:44,768: DEBUG - + local legacy_args=m
2019-08-06 18:55:44,769: WARNING - nextcloud's script has encountered an error. Its execution was cancelled.
2019-08-06 18:55:44,773: DEBUG - + args_array=([m]=message=)
2019-08-06 18:55:44,775: WARNING - !!
2019-08-06 18:55:44,779: DEBUG - + declare -Ar args_array
2019-08-06 18:55:44,780: WARNING -
2019-08-06 18:55:44,785: DEBUG - + local message
2019-08-06 18:55:44,787: DEBUG - + ynh_handle_getopts_args '--message=!!\n nextcloud'\''s script has encountered an error. Its execution was cancelled.\n!!'
2019-08-06 18:55:44,788: DEBUG - + set +x
2019-08-06 18:55:44,789: DEBUG - + ynh_print_log '\e[91m\e[1m[ERR]\e[0m !!\n nextcloud'\''s script has encountered an error. Its execution was cancelled.\n!!'
2019-08-06 18:55:44,791: DEBUG - + echo -e '\e[91m\e[1m[ERR]\e[0m !!\n nextcloud'\''s script has encountered an error. Its execution was cancelled.\n!!'
2019-08-06 18:55:44,794: DEBUG - + '[' api == cli ']'
2019-08-06 18:55:44,796: DEBUG - + type -t ynh_clean_setup
2019-08-06 18:55:44,797: DEBUG - + ynh_die
2019-08-06 18:55:44,798: DEBUG - + local legacy_args=mc
2019-08-06 18:55:44,800: DEBUG - + args_array=([m]=message= [c]=ret_code=)
2019-08-06 18:55:44,801: DEBUG - + declare -Ar args_array
2019-08-06 18:55:44,802: DEBUG - + local message
2019-08-06 18:55:44,803: DEBUG - + local ret_code
2019-08-06 18:55:44,805: DEBUG - + ynh_handle_getopts_args
2019-08-06 18:55:44,806: DEBUG - + set +x
2019-08-06 18:55:44,808: DEBUG - + echo ''
2019-08-06 18:55:44,810: DEBUG - + exit 1
2019-08-06 18:55:44,914: ERROR - Unable to restore the app 'nextcloud'
Traceback (most recent call last):
File "/usr/lib/moulinette/yunohost/backup.py", line 1325, in _restore_app
env=env_dict)[0]
File "/usr/lib/moulinette/yunohost/hook.py", line 397, in hook_exec
raise YunohostError('hook_exec_failed', path=path)
YunohostError: Script execution failed: /tmp/restoreRcMn1N/restore
