Pleroma update gone wrong

runfox · March 7, 2021, 10:58pm

My YunoHost server

Hardware: VPS bought online
YunoHost version: yunohost:
repo: stable
version: 4.1.7.3
yunohost-admin:
repo: stable
version: 4.1.4
moulinette:
repo: stable
version: 4.1.4
ssowat:
repo: stable
version: 4.1.3

I have access to my server : Through SSH | through the webadmin

Are you in a special context or did you perform some particular tweaking on your YunoHost instance ? : no

Description of my issue

I was updating my pleroma instance, it failed, and now I get a 502 bad gateway messsage when navigating to the ip address. I am also unable to restore my backup, it gives a message that says:

“The following apps can’t be restored because they are already installed: pleroma”

env:
  YNH_APP_CURRENT_VERSION: 2.2.0~ynh1
  YNH_APP_ID: pleroma
  YNH_APP_INSTANCE_NAME: pleroma
  YNH_APP_INSTANCE_NUMBER: '1'
  YNH_APP_MANIFEST_VERSION: 2.2.2~ynh1
  YNH_APP_UPGRADE_TYPE: UPGRADE_APP
  YNH_CWD: /var/cache/yunohost/from_file/scripts
  YNH_INTERFACE: api
  YNH_STDINFO: /tmp/tmpEDOZs_/stdinfo
  YNH_STDRETURN: /tmp/tmpIf70WV/stdreturn
error: An error occurred inside the app upgrade script
interface: api
operation: app_upgrade
parent: null
related_to:
- - app
  - pleroma
started_at: 2021-03-07 22:03:01.035100
success: false
yunohost_version: 4.1.7.3

the logs:
============

2021-03-07 22:03:01,066: DEBUG - Executing command 'sh -c YNH_APP_INSTANCE_NUMBER=1 YNH_APP_ID=pleroma YNH_APP_MANIFEST_VERSION='2.2.2~ynh1' YNH_STDINFO=/tmp/tmpEDOZs_/stdinfo YNH_APP_UPGRADE_TYPE=UPGRADE_APP YNH_CWD=/var/cache/yunohost/from_file/scripts YNH_APP_INSTANCE_NAME=pleroma YNH_INTERFACE=api YNH_APP_CURRENT_VERSION='2.2.0~ynh1' YNH_STDRETURN=/tmp/tmpIf70WV/stdreturn BASH_XTRACEFD=7 /bin/bash -x "./upgrade" pleroma 7>&1'
2021-03-07 22:03:01,124: DEBUG - + source _common.sh
2021-03-07 22:03:01,124: DEBUG - ++ pkg_dependencies='curl unzip libncurses5 postgresql postgresql-contrib imagemagick ffmpeg exiftool libimage-exiftool-perl'
2021-03-07 22:03:01,125: DEBUG - + source ynh_package_version
2021-03-07 22:03:01,125: DEBUG - + source ynh_detect_arch__2
2021-03-07 22:03:01,125: DEBUG - + source /usr/share/yunohost/helpers
2021-03-07 22:03:01,125: DEBUG - +++ grep xtrace
2021-03-07 22:03:01,125: DEBUG - +++ set +o
2021-03-07 22:03:01,125: DEBUG - ++ readonly 'XTRACE_ENABLE=set -o xtrace'
2021-03-07 22:03:01,125: DEBUG - ++ XTRACE_ENABLE='set -o xtrace'
2021-03-07 22:03:01,227: DEBUG - + echo '[....................] > Loading installation settings...'
2021-03-07 22:03:01,227: DEBUG - + app=pleroma
2021-03-07 22:03:01,227: DEBUG - ++ ynh_app_setting_get --app=pleroma --key=domain
2021-03-07 22:03:01,328: DEBUG - ++ [[ domain =~ (unprotected|protected|skipped)_ ]]
2021-03-07 22:03:01,328: INFO - [....................] > Loading installation settings...
2021-03-07 22:03:01,329: DEBUG - ++ ynh_app_setting get pleroma domain
2021-03-07 22:03:01,430: DEBUG - + domain=pleroma.maindomain.tld
2021-03-07 22:03:01,430: DEBUG - ++ ynh_app_setting_get --app=pleroma --key=path
2021-03-07 22:03:01,430: DEBUG - ++ [[ path =~ (unprotected|protected|skipped)_ ]]
2021-03-07 22:03:01,430: DEBUG - ++ ynh_app_setting get pleroma path
2021-03-07 22:03:01,531: DEBUG - + path_url=/
2021-03-07 22:03:01,531: DEBUG - ++ ynh_app_setting_get --app=pleroma --key=admin
2021-03-07 22:03:01,532: DEBUG - ++ [[ admin =~ (unprotected|protected|skipped)_ ]]
2021-03-07 22:03:01,532: DEBUG - ++ ynh_app_setting get pleroma admin
2021-03-07 22:03:01,632: DEBUG - + admin=runfox
2021-03-07 22:03:01,633: DEBUG - ++ ynh_app_setting_get --app=pleroma --key=final_path
2021-03-07 22:03:01,634: DEBUG - ++ [[ final_path =~ (unprotected|protected|skipped)_ ]]
2021-03-07 22:03:01,634: DEBUG - ++ ynh_app_setting get pleroma final_path
2021-03-07 22:03:01,734: DEBUG - + final_path=/var/www/pleroma
2021-03-07 22:03:01,735: DEBUG - ++ ynh_app_setting_get --app=pleroma --key=db_name
2021-03-07 22:03:01,736: DEBUG - ++ [[ db_name =~ (unprotected|protected|skipped)_ ]]
2021-03-07 22:03:01,736: DEBUG - ++ ynh_app_setting get pleroma db_name
2021-03-07 22:03:01,836: DEBUG - + db_name=pleroma
2021-03-07 22:03:01,836: DEBUG - ++ ynh_app_setting_get --app=pleroma --key=admin_email
2021-03-07 22:03:01,937: DEBUG - ++ [[ admin_email =~ (unprotected|protected|skipped)_ ]]
2021-03-07 22:03:01,938: DEBUG - ++ ynh_app_setting get pleroma admin_email
2021-03-07 22:03:02,038: DEBUG - + admin_email=runfox@maindomain.tld
2021-03-07 22:03:02,038: DEBUG - ++ ynh_app_setting_get --app=pleroma --key=random_key
2021-03-07 22:03:02,039: DEBUG - ++ [[ random_key =~ (unprotected|protected|skipped)_ ]]
2021-03-07 22:03:02,039: DEBUG - ++ ynh_app_setting get pleroma random_key
2021-03-07 22:03:02,140: DEBUG - + random_key=**********
2021-03-07 22:03:02,140: DEBUG - ++ ynh_app_setting_get --app=pleroma --key=name
2021-03-07 22:03:02,141: DEBUG - ++ [[ name =~ (unprotected|protected|skipped)_ ]]
2021-03-07 22:03:02,141: DEBUG - ++ ynh_app_setting get pleroma name
2021-03-07 22:03:02,242: DEBUG - + name=runfox_pleroma
2021-03-07 22:03:02,242: DEBUG - ++ ynh_app_setting_get --app=pleroma --key=port
2021-03-07 22:03:02,243: DEBUG - ++ [[ port =~ (unprotected|protected|skipped)_ ]]
2021-03-07 22:03:02,243: DEBUG - ++ ynh_app_setting get pleroma port
2021-03-07 22:03:02,344: DEBUG - + port=8095
2021-03-07 22:03:02,344: DEBUG - ++ ynh_app_setting_get --app=pleroma --key=db_user
2021-03-07 22:03:02,345: DEBUG - ++ [[ db_user =~ (unprotected|protected|skipped)_ ]]
2021-03-07 22:03:02,345: DEBUG - ++ ynh_app_setting get pleroma db_user
2021-03-07 22:03:02,445: DEBUG - + db_user=
2021-03-07 22:03:02,446: DEBUG - ++ ynh_app_setting_get --app=pleroma --key=db_pwd
2021-03-07 22:03:02,547: DEBUG - ++ [[ db_pwd =~ (unprotected|protected|skipped)_ ]]
2021-03-07 22:03:02,548: DEBUG - ++ ynh_app_setting get pleroma db_pwd
2021-03-07 22:03:02,648: DEBUG - + db_pwd=**********
2021-03-07 22:03:02,648: DEBUG - ++ ynh_app_setting_get --app=pleroma --key=cache
2021-03-07 22:03:02,649: DEBUG - ++ [[ cache =~ (unprotected|protected|skipped)_ ]]
2021-03-07 22:03:02,649: DEBUG - ++ ynh_app_setting get pleroma cache
2021-03-07 22:03:02,750: DEBUG - + cache=1
2021-03-07 22:03:02,750: DEBUG - ++ ynh_app_setting_get --app=pleroma --key=size
2021-03-07 22:03:02,751: DEBUG - ++ [[ size =~ (unprotected|protected|skipped)_ ]]
2021-03-07 22:03:02,751: DEBUG - ++ ynh_app_setting get pleroma size
2021-03-07 22:03:02,851: DEBUG - + size=5g
2021-03-07 22:03:02,852: DEBUG - ++ ynh_app_setting_get --app=pleroma --key=registration
2021-03-07 22:03:02,953: DEBUG - ++ [[ registration =~ (unprotected|protected|skipped)_ ]]
2021-03-07 22:03:02,953: DEBUG - ++ ynh_app_setting get pleroma registration
2021-03-07 22:03:03,054: DEBUG - + registration=0
2021-03-07 22:03:03,055: DEBUG - + echo '[+...................] > Checking version...'
2021-03-07 22:03:03,055: INFO - [+...................] > Checking version...
2021-03-07 22:03:03,056: DEBUG - ++ ynh_check_app_version_changed
2021-03-07 22:03:03,056: DEBUG - ++ local return_value=UPGRADE_APP
2021-03-07 22:03:03,056: DEBUG - ++ '[' UPGRADE_APP == UPGRADE_FULL ']'
2021-03-07 22:03:03,056: DEBUG - ++ '[' UPGRADE_APP == UPGRADE_FORCED ']'
2021-03-07 22:03:03,056: DEBUG - ++ '[' UPGRADE_APP == DOWNGRADE_FORCED ']'
2021-03-07 22:03:03,057: DEBUG - ++ echo UPGRADE_APP
2021-03-07 22:03:03,057: DEBUG - + upgrade_type=UPGRADE_APP
2021-03-07 22:03:03,158: INFO - [#+..................] > Ensuring downward compatibility...
2021-03-07 22:03:03,158: DEBUG - + echo '[#+..................] > Ensuring downward compatibility...'
2021-03-07 22:03:03,158: DEBUG - + ynh_legacy_permissions_exists
2021-03-07 22:03:03,159: DEBUG - + for permission in "skipped" "unprotected" "protected"
2021-03-07 22:03:03,159: DEBUG - + ynh_permission_exists --permission=legacy_skipped_uris
2021-03-07 22:03:03,159: DEBUG - + grep --word-regexp --quiet pleroma.legacy_skipped_uris
2021-03-07 22:03:03,160: DEBUG - + yunohost user permission list --short
2021-03-07 22:03:03,460: DEBUG - + for permission in "skipped" "unprotected" "protected"
2021-03-07 22:03:03,460: DEBUG - + ynh_permission_exists --permission=legacy_unprotected_uris
2021-03-07 22:03:03,461: DEBUG - + grep --word-regexp --quiet pleroma.legacy_unprotected_uris
2021-03-07 22:03:03,461: DEBUG - + yunohost user permission list --short
2021-03-07 22:03:03,762: DEBUG - + for permission in "skipped" "unprotected" "protected"
2021-03-07 22:03:03,762: DEBUG - + ynh_permission_exists --permission=legacy_protected_uris
2021-03-07 22:03:03,762: DEBUG - + grep --word-regexp --quiet pleroma.legacy_protected_uris
2021-03-07 22:03:03,763: DEBUG - + yunohost user permission list --short
2021-03-07 22:03:04,063: DEBUG - + return 1
2021-03-07 22:03:04,064: DEBUG - + ynh_permission_exists --permission=api
2021-03-07 22:03:04,064: DEBUG - + grep --word-regexp --quiet pleroma.api
2021-03-07 22:03:04,064: DEBUG - + yunohost user permission list --short
2021-03-07 22:03:04,365: DEBUG - ++ ynh_app_setting_get --app=pleroma --key=psql_db
2021-03-07 22:03:04,366: DEBUG - ++ [[ psql_db =~ (unprotected|protected|skipped)_ ]]
2021-03-07 22:03:04,366: DEBUG - ++ ynh_app_setting get pleroma psql_db
2021-03-07 22:03:04,467: DEBUG - + psql_db=
2021-03-07 22:03:04,467: DEBUG - + '[' -n '' ']'
2021-03-07 22:03:04,467: DEBUG - + grep -q '\- 8095$'
2021-03-07 22:03:04,467: DEBUG - + yunohost firewall list
2021-03-07 22:03:04,668: DEBUG - + ynh_secure_remove --file=/etc/apt/sources.list.d/erlang-solutions.list
2021-03-07 22:03:04,668: DEBUG - + local 'forbidden_path=     /var/www     /home/yunohost.app'
2021-03-07 22:03:04,669: DEBUG - + '[' 1 -ge 2 ']'
2021-03-07 22:03:04,669: DEBUG - + [[ -z /etc/apt/sources.list.d/erlang-solutions.list ]]
2021-03-07 22:03:04,669: DEBUG - + [[      /var/www     /home/yunohost.app =~ /etc/apt/sources\.list\.d/erlang-solutions\.list ]]
2021-03-07 22:03:04,669: DEBUG - + [[ /etc/apt/sources.list.d/erlang-solutions.list =~ ^/[[:alnum:]]+$ ]]
2021-03-07 22:03:04,669: DEBUG - + [[ t = \/ ]]
2021-03-07 22:03:04,669: DEBUG - + '[' -e /etc/apt/sources.list.d/erlang-solutions.list ']'
2021-03-07 22:03:04,669: DEBUG - + ynh_print_info '--message='\''/etc/apt/sources.list.d/erlang-solutions.list'\'' wasn'\''t deleted because it doesn'\''t exist.'
2021-03-07 22:03:04,670: DEBUG - + echo ''\''/etc/apt/sources.list.d/erlang-solutions.list'\'' wasn'\''t deleted because it doesn'\''t exist.'
2021-03-07 22:03:04,670: DEBUG - + apt-key del A14F4FCA
2021-03-07 22:03:04,872: DEBUG - OK
2021-03-07 22:03:04,872: INFO - '/etc/apt/sources.list.d/erlang-solutions.list' wasn't deleted because it doesn't exist.
2021-03-07 22:03:04,874: DEBUG - + echo '[##+.................] > Checking version number...'
2021-03-07 22:03:04,874: DEBUG - + '[' 0 -eq 1 ']'
2021-03-07 22:03:04,874: DEBUG - + abort_if_up_to_date
2021-03-07 22:03:04,874: DEBUG - ++ read_json /etc/yunohost/apps/pleroma/manifest.json version
2021-03-07 22:03:04,874: DEBUG - ++ sudo python3 -c 'import sys, json;print(json.load(open('\''/etc/yunohost/apps/pleroma/manifest.json'\''))['\''version'\''])'
2021-03-07 22:03:04,974: DEBUG - + version=2.2.0~ynh1
2021-03-07 22:03:04,975: INFO - [##+.................] > Checking version number...
2021-03-07 22:03:04,975: DEBUG - ++ read_manifest version
2021-03-07 22:03:04,975: DEBUG - ++ '[' -f ../manifest.json ']'
2021-03-07 22:03:04,975: DEBUG - ++ read_json ../manifest.json version
2021-03-07 22:03:04,976: DEBUG - ++ sudo python3 -c 'import sys, json;print(json.load(open('\''../manifest.json'\''))['\''version'\''])'
2021-03-07 22:03:04,976: DEBUG - + last_version=2.2.2~ynh1
2021-03-07 22:03:04,976: DEBUG - + '[' 2.2.0~ynh1 = 2.2.2~ynh1 ']'
2021-03-07 22:03:04,976: DEBUG - + previous_version=2.2.0~ynh1
2021-03-07 22:03:05,077: DEBUG - + echo '[###+................] > Backing up the app before upgrading (may take a while)...'
2021-03-07 22:03:05,077: DEBUG - + ynh_app_setting_set --app=pleroma --key=backup_core_only --value=1
2021-03-07 22:03:05,178: DEBUG - + [[ backup_core_only =~ (unprotected|protected|skipped)_ ]]
2021-03-07 22:03:05,178: INFO - [###+................] > Backing up the app before upgrading (may take a while)...
2021-03-07 22:03:05,179: DEBUG - + ynh_app_setting set pleroma backup_core_only 1
2021-03-07 22:03:05,179: DEBUG - + ynh_backup_before_upgrade
2021-03-07 22:03:05,179: DEBUG - + '[' '!' -e /etc/yunohost/apps/pleroma/scripts/backup ']'
2021-03-07 22:03:05,179: DEBUG - + backup_number=1
2021-03-07 22:03:05,179: DEBUG - + local old_backup_number=2
2021-03-07 22:03:05,179: DEBUG - + local app_bck=pleroma
2021-03-07 22:03:05,179: DEBUG - + NO_BACKUP_UPGRADE=0
2021-03-07 22:03:05,179: DEBUG - + '[' 0 -eq 0 ']'
2021-03-07 22:03:05,179: DEBUG - + grep --quiet pleroma-pre-upgrade1
2021-03-07 22:03:05,179: DEBUG - + yunohost backup list
2021-03-07 22:03:05,380: DEBUG - + backup_number=2
2021-03-07 22:03:05,380: DEBUG - + old_backup_number=1
2021-03-07 22:03:05,380: DEBUG - + BACKUP_CORE_ONLY=1
2021-03-07 22:03:05,380: DEBUG - + yunohost backup create --apps pleroma --name pleroma-pre-upgrade2 --debug
2021-03-07 22:03:05,480: DEBUG - 80   initializing base actions map parser for cli
2021-03-07 22:03:05,481: DEBUG - 81   loading actions map namespace 'yunohost'
2021-03-07 22:03:05,581: DEBUG - 92   building parser...
2021-03-07 22:03:05,581: DEBUG - 94   building parser took 0.002s
2021-03-07 22:03:05,581: DEBUG - 95   acquiring lock...
2021-03-07 22:03:05,581: DEBUG - 141  loading python module yunohost.backup took 0.030s
2021-03-07 22:03:05,581: DEBUG - 142  processing action [2896.1]: yunohost.backup.create with args={'methods': None, 'description': None, 'apps': ['pleroma'], 'system': None, 'output_directory': None, 'name': 'pleroma-pre-upgrade2'}
2021-03-07 22:03:05,582: DEBUG - 145  Collecting files to be backed up for pleroma...
2021-03-07 22:03:05,986: DEBUG - 502  Executing command 'sh -c YNH_APP_INSTANCE_NUMBER=1 YNH_CWD=/home/yunohost.backup/tmp/pleroma-pre-upgrade2/apps/pleroma/backup YNH_APP_MANIFEST_VERSION='2.2.0~ynh1' YNH_BACKUP_CSV=/tmp/backupcsv_7X21lf YNH_BACKUP_DIR=/home/yunohost.backup/tmp/pleroma-pre-upgrade2 YNH_APP_INSTANCE_NAME=pleroma YNH_STDRETURN=/tmp/tmp_Q0cdZ/stdreturn YNH_APP_BACKUP_DIR=/home/yunohost.backup/tmp/pleroma-pre-upgrade2/apps/pleroma/backup YNH_STDINFO=/tmp/tmp3aVUEY/stdinfo YNH_INTERFACE=cli YNH_APP_ID=pleroma BASH_XTRACEFD=7 /bin/bash -x "/tmp/backup_WqBs35" /home/yunohost.backup/tmp/pleroma-pre-upgrade2/apps/pleroma/backup pleroma 7>&1'
2021-03-07 22:03:05,986: DEBUG - 521  + source ../settings/scripts/_common.sh
2021-03-07 22:03:05,987: DEBUG - 525  ++ pkg_dependencies='curl unzip libncurses5 postgresql postgresql-contrib imagemagick ffmpeg exiftool libimage-exiftool-perl'
2021-03-07 22:03:05,987: DEBUG - 525  + source /usr/share/yunohost/helpers
2021-03-07 22:03:06,087: DEBUG - 626  +++ grep xtrace
2021-03-07 22:03:06,087: DEBUG - 626  Loading installation settings...
2021-03-07 22:03:06,087: DEBUG - 626  +++ set +o
2021-03-07 22:03:06,087: DEBUG - 626  ++ readonly 'XTRACE_ENABLE=set -o xtrace'
2021-03-07 22:03:06,087: DEBUG - 626  ++ XTRACE_ENABLE='set -o xtrace'
2021-03-07 22:03:06,088: DEBUG - 626  + ynh_abort_if_errors
2021-03-07 22:03:06,088: DEBUG - 626  + set -o errexit
2021-03-07 22:03:06,088: DEBUG - 626  + set -o nounset
2021-03-07 22:03:06,088: DEBUG - 626  + trap ynh_exit_properly EXIT
2021-03-07 22:03:06,088: DEBUG - 626  + ynh_print_info '--message=Loading installation settings...'
2021-03-07 22:03:06,088: DEBUG - 627  + echo 'Loading installation settings...'
2021-03-07 22:03:06,088: DEBUG - 627  + app=pleroma
2021-03-07 22:03:06,088: DEBUG - 627  ++ ynh_app_setting_get --app=pleroma --key=final_path
2021-03-07 22:03:06,089: DEBUG - 627  ++ [[ final_path =~ (unprotected|protected|skipped)_ ]]
2021-03-07 22:03:06,089: DEBUG - 627  ++ ynh_app_setting get pleroma final_path
2021-03-07 22:03:06,189: DEBUG - 728  + final_path=/var/www/pleroma
2021-03-07 22:03:06,190: DEBUG - 728  ++ ynh_app_setting_get --app=pleroma --key=domain
2021-03-07 22:03:06,291: DEBUG - 829  ++ [[ domain =~ (unprotected|protected|skipped)_ ]]
2021-03-07 22:03:06,291: DEBUG - 829  ++ ynh_app_setting get pleroma domain
2021-03-07 22:03:06,291: DEBUG - 829  + domain=pleroma.maindomain.tld
2021-03-07 22:03:06,392: DEBUG - 929  ++ ynh_app_setting_get --app=pleroma --key=db_name
2021-03-07 22:03:06,393: DEBUG - 930  ++ [[ db_name =~ (unprotected|protected|skipped)_ ]]
2021-03-07 22:03:06,393: DEBUG - 930  ++ ynh_app_setting get pleroma db_name
2021-03-07 22:03:06,493: DEBUG - 1030 + db_name=pleroma
2021-03-07 22:03:06,494: DEBUG - 1030 ++ ynh_app_setting_get --app=pleroma --key=cache
2021-03-07 22:03:06,494: DEBUG - 1031 ++ [[ cache =~ (unprotected|protected|skipped)_ ]]
2021-03-07 22:03:06,494: DEBUG - 1031 ++ ynh_app_setting get pleroma cache
2021-03-07 22:03:06,595: DEBUG - 1131 + cache=1
2021-03-07 22:03:06,595: DEBUG - 1131 ++ ynh_app_setting_get --app=pleroma --key=datadir
2021-03-07 22:03:06,595: DEBUG - 1132 ++ [[ datadir =~ (unprotected|protected|skipped)_ ]]
2021-03-07 22:03:06,596: DEBUG - 1132 ++ ynh_app_setting get pleroma datadir
2021-03-07 22:03:06,696: DEBUG - 1232 + datadir=/home/yunohost.app/pleroma
2021-03-07 22:03:06,696: DEBUG - 1232 Declaring files to be backed up...
2021-03-07 22:03:06,696: DEBUG - 1233 + ynh_print_info '--message=Declaring files to be backed up...'
2021-03-07 22:03:06,697: DEBUG - 1233 + echo 'Declaring files to be backed up...'
2021-03-07 22:03:06,697: DEBUG - 1233 + ynh_backup --src_path=/var/www/pleroma
2021-03-07 22:03:06,698: DEBUG - 1233 + dest_path=
2021-03-07 22:03:06,698: DEBUG - 1234 + is_big=0
2021-03-07 22:03:06,698: DEBUG - 1234 + not_mandatory=0
2021-03-07 22:03:06,698: DEBUG - 1234 + BACKUP_CORE_ONLY=1
2021-03-07 22:03:06,698: DEBUG - 1234 + test -n pleroma
2021-03-07 22:03:06,698: DEBUG - 1234 ++ ynh_app_setting_get --app=pleroma --key=do_not_backup_data
2021-03-07 22:03:06,799: DEBUG - 1335 ++ [[ do_not_backup_data =~ (unprotected|protected|skipped)_ ]]
2021-03-07 22:03:06,799: DEBUG - 1336 ++ ynh_app_setting get pleroma do_not_backup_data
2021-03-07 22:03:06,799: DEBUG - 1336 + do_not_backup_data=
2021-03-07 22:03:06,800: DEBUG - 1336 + '[' 0 -eq 1 ']'
2021-03-07 22:03:06,800: DEBUG - 1336 + '[' '!' -e /var/www/pleroma ']'
2021-03-07 22:03:06,800: DEBUG - 1336 ++ realpath /var/www/pleroma
2021-03-07 22:03:06,900: DEBUG - 1436 + src_path=/var/www/pleroma
2021-03-07 22:03:06,900: DEBUG - 1437 + [[ -z '' ]]
2021-03-07 22:03:06,900: DEBUG - 1437 + dest_path=var/www/pleroma
2021-03-07 22:03:06,901: DEBUG - 1437 + [[ -e var/www/pleroma ]]
2021-03-07 22:03:06,901: DEBUG - 1437 + local rel_dir=/apps/pleroma/backup
2021-03-07 22:03:06,901: DEBUG - 1437 + rel_dir=/apps/pleroma/backup/
2021-03-07 22:03:06,901: DEBUG - 1437 + dest_path=/apps/pleroma/backup/var/www/pleroma
2021-03-07 22:03:06,901: DEBUG - 1437 + dest_path=apps/pleroma/backup/var/www/pleroma
2021-03-07 22:03:06,901: DEBUG - 1437 ++ sed --regexp-extended 's/"/\"\"/g'
2021-03-07 22:03:06,901: DEBUG - 1437 ++ echo /var/www/pleroma
2021-03-07 22:03:06,901: DEBUG - 1437 + local src=/var/www/pleroma
2021-03-07 22:03:06,901: DEBUG - 1437 ++ sed --regexp-extended 's/"/\"\"/g'
2021-03-07 22:03:06,901: DEBUG - 1437 ++ echo apps/pleroma/backup/var/www/pleroma
2021-03-07 22:03:06,901: DEBUG - 1437 + local dest=apps/pleroma/backup/var/www/pleroma
2021-03-07 22:03:06,901: DEBUG - 1437 + echo '"/var/www/pleroma","apps/pleroma/backup/var/www/pleroma"'
2021-03-07 22:03:06,902: DEBUG - 1437 ++ dirname /home/yunohost.backup/tmp/pleroma-pre-upgrade2/apps/pleroma/backup/var/www/pleroma
2021-03-07 22:03:06,902: DEBUG - 1437 + mkdir --parents /home/yunohost.backup/tmp/pleroma-pre-upgrade2/apps/pleroma/backup/var/www
2021-03-07 22:03:06,902: DEBUG - 1437 + ynh_backup --src_path=/etc/nginx/conf.d/pleroma.maindomain.tld.d/pleroma.conf
2021-03-07 22:03:06,902: DEBUG - 1438 + dest_path=
2021-03-07 22:03:06,903: DEBUG - 1438 + is_big=0
2021-03-07 22:03:06,903: DEBUG - 1438 + not_mandatory=0
2021-03-07 22:03:06,903: DEBUG - 1438 + BACKUP_CORE_ONLY=1
2021-03-07 22:03:06,903: DEBUG - 1438 + test -n pleroma
2021-03-07 22:03:06,903: DEBUG - 1438 ++ ynh_app_setting_get --app=pleroma --key=do_not_backup_data
2021-03-07 22:03:06,903: DEBUG - 1439 ++ [[ do_not_backup_data =~ (unprotected|protected|skipped)_ ]]
2021-03-07 22:03:06,904: DEBUG - 1439 ++ ynh_app_setting get pleroma do_not_backup_data
2021-03-07 22:03:07,004: DEBUG - 1539 + do_not_backup_data=
2021-03-07 22:03:07,004: DEBUG - 1539 + '[' 0 -eq 1 ']'
2021-03-07 22:03:07,004: DEBUG - 1539 + '[' '!' -e /etc/nginx/conf.d/pleroma.maindomain.tld.d/pleroma.conf ']'
2021-03-07 22:03:07,004: DEBUG - 1539 ++ realpath /etc/nginx/conf.d/pleroma.maindomain.tld.d/pleroma.conf
2021-03-07 22:03:07,004: DEBUG - 1539 + src_path=/etc/nginx/conf.d/pleroma.maindomain.tld.d/pleroma.conf
2021-03-07 22:03:07,005: DEBUG - 1539 + [[ -z '' ]]
2021-03-07 22:03:07,005: DEBUG - 1540 + dest_path=etc/nginx/conf.d/pleroma.maindomain.tld.d/pleroma.conf
2021-03-07 22:03:07,005: DEBUG - 1540 + [[ -e etc/nginx/conf.d/pleroma.maindomain.tld.d/pleroma.conf ]]
2021-03-07 22:03:07,005: DEBUG - 1540 + local rel_dir=/apps/pleroma/backup
2021-03-07 22:03:07,005: DEBUG - 1540 + rel_dir=/apps/pleroma/backup/
2021-03-07 22:03:07,005: DEBUG - 1540 + dest_path=/apps/pleroma/backup/etc/nginx/conf.d/pleroma.maindomain.tld.d/pleroma.conf
2021-03-07 22:03:07,005: DEBUG - 1540 + dest_path=apps/pleroma/backup/etc/nginx/conf.d/pleroma.maindomain.tld.d/pleroma.conf
2021-03-07 22:03:07,005: DEBUG - 1540 ++ sed --regexp-extended 's/"/\"\"/g'
2021-03-07 22:03:07,005: DEBUG - 1540 ++ echo /etc/nginx/conf.d/pleroma.maindomain.tld.d/pleroma.conf
2021-03-07 22:03:07,005: DEBUG - 1540 + local src=/etc/nginx/conf.d/pleroma.maindomain.tld.d/pleroma.conf
2021-03-07 22:03:07,005: DEBUG - 1540 ++ sed --regexp-extended 's/"/\"\"/g'
2021-03-07 22:03:07,005: DEBUG - 1540 ++ echo apps/pleroma/backup/etc/nginx/conf.d/pleroma.maindomain.tld.d/pleroma.conf
2021-03-07 22:03:07,005: DEBUG - 1540 + local dest=apps/pleroma/backup/etc/nginx/conf.d/pleroma.maindomain.tld.d/pleroma.conf
2021-03-07 22:03:07,005: DEBUG - 1540 + echo '"/etc/nginx/conf.d/pleroma.maindomain.tld.d/pleroma.conf","apps/pleroma/backup/etc/nginx/conf.d/pleroma.maindomain.tld.d/pleroma.conf"'
2021-03-07 22:03:07,005: DEBUG - 1541 ++ dirname /home/yunohost.backup/tmp/pleroma-pre-upgrade2/apps/pleroma/backup/etc/nginx/conf.d/pleroma.maindomain.tld.d/pleroma.conf
2021-03-07 22:03:07,006: DEBUG - 1541 + mkdir --parents /home/yunohost.backup/tmp/pleroma-pre-upgrade2/apps/pleroma/backup/etc/nginx/conf.d/pleroma.maindomain.tld.d
2021-03-07 22:03:07,006: DEBUG - 1542 + '[' 1 -eq 1 ']'
2021-03-07 22:03:07,006: DEBUG - 1542 + ynh_backup --src_path=/etc/nginx/conf.d/pleroma-cache.conf
2021-03-07 22:03:07,006: DEBUG - 1543 + dest_path=
2021-03-07 22:03:07,006: DEBUG - 1543 + is_big=0
2021-03-07 22:03:07,006: DEBUG - 1543 + not_mandatory=0
2021-03-07 22:03:07,006: DEBUG - 1543 + BACKUP_CORE_ONLY=1
2021-03-07 22:03:07,007: DEBUG - 1543 + test -n pleroma
2021-03-07 22:03:07,007: DEBUG - 1543 ++ ynh_app_setting_get --app=pleroma --key=do_not_backup_data
2021-03-07 22:03:07,107: DEBUG - 1644 ++ [[ do_not_backup_data =~ (unprotected|protected|skipped)_ ]]
2021-03-07 22:03:07,108: DEBUG - 1644 ++ ynh_app_setting get pleroma do_not_backup_data
2021-03-07 22:03:07,208: DEBUG - 1744 + do_not_backup_data=
2021-03-07 22:03:07,208: DEBUG - 1744 + '[' 0 -eq 1 ']'
2021-03-07 22:03:07,208: DEBUG - 1744 + '[' '!' -e /etc/nginx/conf.d/pleroma-cache.conf ']'
2021-03-07 22:03:07,208: DEBUG - 1744 ++ realpath /etc/nginx/conf.d/pleroma-cache.conf
2021-03-07 22:03:07,209: DEBUG - 1744 + src_path=/etc/nginx/conf.d/pleroma-cache.conf
2021-03-07 22:03:07,209: DEBUG - 1745 + [[ -z '' ]]
2021-03-07 22:03:07,209: DEBUG - 1745 + dest_path=etc/nginx/conf.d/pleroma-cache.conf
2021-03-07 22:03:07,209: DEBUG - 1745 + [[ -e etc/nginx/conf.d/pleroma-cache.conf ]]
2021-03-07 22:03:07,209: DEBUG - 1745 + local rel_dir=/apps/pleroma/backup
2021-03-07 22:03:07,209: DEBUG - 1745 + rel_dir=/apps/pleroma/backup/
2021-03-07 22:03:07,209: DEBUG - 1745 + dest_path=/apps/pleroma/backup/etc/nginx/conf.d/pleroma-cache.conf
2021-03-07 22:03:07,209: DEBUG - 1745 + dest_path=apps/pleroma/backup/etc/nginx/conf.d/pleroma-cache.conf
2021-03-07 22:03:07,209: DEBUG - 1745 ++ sed --regexp-extended 's/"/\"\"/g'
2021-03-07 22:03:07,209: DEBUG - 1745 ++ echo /etc/nginx/conf.d/pleroma-cache.conf
2021-03-07 22:03:07,209: DEBUG - 1745 + local src=/etc/nginx/conf.d/pleroma-cache.conf
2021-03-07 22:03:07,209: DEBUG - 1745 ++ sed --regexp-extended 's/"/\"\"/g'
2021-03-07 22:03:07,209: DEBUG - 1745 ++ echo apps/pleroma/backup/etc/nginx/conf.d/pleroma-cache.conf
2021-03-07 22:03:07,209: DEBUG - 1745 + local dest=apps/pleroma/backup/etc/nginx/conf.d/pleroma-cache.conf
2021-03-07 22:03:07,209: DEBUG - 1745 + echo '"/etc/nginx/conf.d/pleroma-cache.conf","apps/pleroma/backup/etc/nginx/conf.d/pleroma-cache.conf"'
2021-03-07 22:03:07,210: DEBUG - 1745 ++ dirname /home/yunohost.backup/tmp/pleroma-pre-upgrade2/apps/pleroma/backup/etc/nginx/conf.d/pleroma-cache.conf
2021-03-07 22:03:07,210: DEBUG - 1745 + mkdir --parents /home/yunohost.backup/tmp/pleroma-pre-upgrade2/apps/pleroma/backup/etc/nginx/conf.d
2021-03-07 22:03:07,210: DEBUG - 1745 + ynh_backup --src_path=/etc/pleroma/config.exs
2021-03-07 22:03:07,210: DEBUG - 1747 + dest_path=
2021-03-07 22:03:07,211: DEBUG - 1747 + is_big=0
2021-03-07 22:03:07,211: DEBUG - 1747 + not_mandatory=0
2021-03-07 22:03:07,211: DEBUG - 1747 + BACKUP_CORE_ONLY=1
2021-03-07 22:03:07,211: DEBUG - 1747 + test -n pleroma
2021-03-07 22:03:07,211: DEBUG - 1747 ++ ynh_app_setting_get --app=pleroma --key=do_not_backup_data
2021-03-07 22:03:07,212: DEBUG - 1748 ++ [[ do_not_backup_data =~ (unprotected|protected|skipped)_ ]]
2021-03-07 22:03:07,212: DEBUG - 1748 ++ ynh_app_setting get pleroma do_not_backup_data
2021-03-07 22:03:07,312: DEBUG - 1848 + do_not_backup_data=
2021-03-07 22:03:07,312: DEBUG - 1848 + '[' 0 -eq 1 ']'
2021-03-07 22:03:07,312: DEBUG - 1848 + '[' '!' -e /etc/pleroma/config.exs ']'
2021-03-07 22:03:07,313: DEBUG - 1848 ++ realpath /etc/pleroma/config.exs
2021-03-07 22:03:07,313: DEBUG - 1849 + src_path=/etc/pleroma/config.exs
2021-03-07 22:03:07,313: DEBUG - 1849 + [[ -z '' ]]
2021-03-07 22:03:07,313: DEBUG - 1849 + dest_path=etc/pleroma/config.exs
2021-03-07 22:03:07,313: DEBUG - 1849 + [[ -e etc/pleroma/config.exs ]]
2021-03-07 22:03:07,313: DEBUG - 1849 + local rel_dir=/apps/pleroma/backup
2021-03-07 22:03:07,313: DEBUG - 1849 + rel_dir=/apps/pleroma/backup/
2021-03-07 22:03:07,313: DEBUG - 1849 + dest_path=/apps/pleroma/backup/etc/pleroma/config.exs
2021-03-07 22:03:07,313: DEBUG - 1849 + dest_path=apps/pleroma/backup/etc/pleroma/config.exs
2021-03-07 22:03:07,313: DEBUG - 1849 ++ sed --regexp-extended 's/"/\"\"/g'
2021-03-07 22:03:07,313: DEBUG - 1849 ++ echo /etc/pleroma/config.exs
2021-03-07 22:03:07,313: DEBUG - 1849 + local src=/etc/pleroma/config.exs
2021-03-07 22:03:07,314: DEBUG - 1849 ++ sed --regexp-extended 's/"/\"\"/g'
2021-03-07 22:03:07,314: DEBUG - 1849 ++ echo apps/pleroma/backup/etc/pleroma/config.exs
2021-03-07 22:03:07,314: DEBUG - 1849 + local dest=apps/pleroma/backup/etc/pleroma/config.exs
2021-03-07 22:03:07,314: DEBUG - 1849 + echo '"/etc/pleroma/config.exs","apps/pleroma/backup/etc/pleroma/config.exs"'
2021-03-07 22:03:07,314: DEBUG - 1849 ++ dirname /home/yunohost.backup/tmp/pleroma-pre-upgrade2/apps/pleroma/backup/etc/pleroma/config.exs
2021-03-07 22:03:07,314: DEBUG - 1849 + mkdir --parents /home/yunohost.backup/tmp/pleroma-pre-upgrade2/apps/pleroma/backup/etc/pleroma
2021-03-07 22:03:07,314: DEBUG - 1849 + ynh_backup --src_path=/etc/systemd/system/pleroma.service
2021-03-07 22:03:07,415: DEBUG - 1951 + dest_path=
2021-03-07 22:03:07,415: DEBUG - 1951 + is_big=0
2021-03-07 22:03:07,416: DEBUG - 1952 + not_mandatory=0
2021-03-07 22:03:07,416: DEBUG - 1952 + BACKUP_CORE_ONLY=1
2021-03-07 22:03:07,416: DEBUG - 1952 + test -n pleroma
2021-03-07 22:03:07,416: DEBUG - 1952 ++ ynh_app_setting_get --app=pleroma --key=do_not_backup_data
2021-03-07 22:03:07,416: DEBUG - 1952 ++ [[ do_not_backup_data =~ (unprotected|protected|skipped)_ ]]
2021-03-07 22:03:07,417: DEBUG - 1952 ++ ynh_app_setting get pleroma do_not_backup_data
2021-03-07 22:03:07,517: DEBUG - 2053 + do_not_backup_data=
2021-03-07 22:03:07,519: WARNING - 2055 Source path '/etc/systemd/system/pleroma.service' does not exist
2021-03-07 22:03:07,520: DEBUG - 2058 + '[' 0 -eq 1 ']'
2021-03-07 22:03:07,520: DEBUG - 2059 + '[' '!' -e /etc/systemd/system/pleroma.service ']'
2021-03-07 22:03:07,520: DEBUG - 2059 + ynh_print_warn '--message=Source path '\''/etc/systemd/system/pleroma.service'\'' does not exist'
2021-03-07 22:03:07,521: DEBUG - 2059 + ynh_print_log 'Source path '\''/etc/systemd/system/pleroma.service'\'' does not exist'
2021-03-07 22:03:07,521: DEBUG - 2059 + echo -e 'Source path '\''/etc/systemd/system/pleroma.service'\'' does not exist'
2021-03-07 22:03:07,521: DEBUG - 2060 + '[' 0 == 0 ']'
2021-03-07 22:03:07,521: DEBUG - 2060 + grep --quiet /etc/fail2ban
2021-03-07 22:03:07,521: DEBUG - 2060 + echo /etc/systemd/system/pleroma.service
2021-03-07 22:03:07,521: DEBUG - 2060 + return 1
2021-03-07 22:03:07,521: DEBUG - 2060 + ynh_exit_properly
2021-03-07 22:03:07,521: DEBUG - 2060 + local exit_code=1
2021-03-07 22:03:07,522: DEBUG - 2060 + '[' 1 -eq 0 ']'
2021-03-07 22:03:07,522: DEBUG - 2060 + trap '' EXIT
2021-03-07 22:03:07,522: DEBUG - 2060 + set +o errexit
2021-03-07 22:03:07,522: DEBUG - 2060 + set +o nounset
2021-03-07 22:03:07,522: DEBUG - 2060 + sleep 0.5
2021-03-07 22:03:08,023: DEBUG - 2562 + type -t ynh_clean_setup
2021-03-07 22:03:08,023: WARNING - 2591 Could not back up pleroma
2021-03-07 22:03:08,023: DEBUG - 2562 + ynh_clean_setup
2021-03-07 22:03:08,023: WARNING - 2592 Nothing to save
2021-03-07 22:03:08,024: DEBUG - 2562 + ynh_clean_check_starting
2021-03-07 22:03:08,024: DEBUG - 2562 + '[' -n '' ']'
2021-03-07 22:03:08,024: DEBUG - 2562 + '[' -n '' ']'
2021-03-07 22:03:08,024: DEBUG - 2562 + exit 1
2021-03-07 22:03:08,024: DEBUG - 2592 action [2896.1] executed in 2.450s
2021-03-07 22:03:08,024: DEBUG - + '[' 1 -eq 0 ']'
2021-03-07 22:03:08,024: DEBUG - + ynh_die '--message=Backup failed, the upgrade process was aborted.'
2021-03-07 22:03:08,125: DEBUG - + ret_code=1
2021-03-07 22:03:08,126: WARNING - Backup failed, the upgrade process was aborted.
2021-03-07 22:03:08,126: DEBUG - + echo 'Backup failed, the upgrade process was aborted.'
2021-03-07 22:03:08,126: DEBUG - + exit 1
2021-03-07 22:03:08,255: ERROR - Could not upgrade pleroma: An error occurred inside the app upgrade script

Aleks · March 8, 2021, 10:38am

zblerg that’s weird …

Can you check if

grep -inr pleroma /etc/systemd

returns anything ?

runfox · March 8, 2021, 2:00pm

Hi Aleks,

No, it doesn’t return anything.

Aleks · March 8, 2021, 8:58pm

Hmf okay I don’t know why files would just spontaneously disappear … but okay … Let’s maybe try to trick it with :

touch /etc/systemd/system/pleroma.service

then try again the upgrade

runfox · March 9, 2021, 12:23am

I tried the upgrade and it removed pleroma from my list of installed apps and won’t let me restore the backup. It says it failed:

“Failed to enable unit: Unit file /etc/systemd/system/pleroma.service is masked”

runfox · March 9, 2021, 12:30am

Logs from attempting to restore the backup:

env:
  YNH_APP_BACKUP_DIR: /home/yunohost.backup/tmp/pleroma-pre-upgrade2/apps/pleroma/backup
  YNH_APP_ID: pleroma
  YNH_APP_INSTANCE_NAME: pleroma
  YNH_APP_INSTANCE_NUMBER: '1'
  YNH_APP_MANIFEST_VERSION: 2.2.0~ynh1
  YNH_BACKUP_CSV: /home/yunohost.backup/tmp/pleroma-pre-upgrade2/backup.csv
  YNH_BACKUP_DIR: /home/yunohost.backup/tmp/pleroma-pre-upgrade2
  YNH_CWD: /home/yunohost.backup/tmp/pleroma-pre-upgrade2/apps/pleroma/backup
  YNH_INTERFACE: api
  YNH_STDINFO: /tmp/tmpWnGiEK/stdinfo
  YNH_STDRETURN: /tmp/tmpy6jxqm/stdreturn
error: Could not restore pleroma
interface: api
operation: backup_restore_app
parent: null
related_to:
- - app
  - pleroma
started_at: 2021-03-09 00:18:03.743464
success: false
yunohost_version: 4.1.7.3

============

2021-03-09 00:18:03,778: INFO - Restoring pleroma...
2021-03-09 00:18:05,001: DEBUG - Restoring the app 'pleroma'…
2021-03-09 00:18:05,454: DEBUG - Permission 'pleroma.main' updated
2021-03-09 00:18:05,499: DEBUG - Full log of this operation: '<a href="#/tools/logs/20210309-001805-permission_url-pleroma" style="text-decoration:underline">Update url related to permission 'pleroma'</a>'
2021-03-09 00:18:05,601: DEBUG - Permission 'pleroma.main' created
2021-03-09 00:18:05,602: DEBUG - Full log of this operation: '<a href="#/tools/logs/20210309-001805-permission_create-pleroma" style="text-decoration:underline">Create permission 'pleroma'</a>'
2021-03-09 00:18:05,746: DEBUG - Permission 'pleroma.api' updated
2021-03-09 00:18:05,795: DEBUG - Full log of this operation: '<a href="#/tools/logs/20210309-001805-permission_url-pleroma" style="text-decoration:underline">Update url related to permission 'pleroma'</a>'
2021-03-09 00:18:05,911: DEBUG - Permission 'pleroma.api' created
2021-03-09 00:18:05,912: DEBUG - Full log of this operation: '<a href="#/tools/logs/20210309-001805-permission_create-pleroma" style="text-decoration:underline">Create permission 'pleroma'</a>'
2021-03-09 00:18:05,961: DEBUG - The permission database has been resynchronized
2021-03-09 00:18:06,018: DEBUG - SSOwat configuration regenerated
2021-03-09 00:18:06,283: DEBUG - Executing command 'sh -c YNH_APP_INSTANCE_NUMBER=1 YNH_CWD=/home/yunohost.backup/tmp/pleroma-pre-upgrade2/apps/pleroma/backup YNH_APP_MANIFEST_VERSION='2.2.0~ynh1' YNH_BACKUP_CSV=/home/yunohost.backup/tmp/pleroma-pre-upgrade2/backup.csv YNH_BACKUP_DIR=/home/yunohost.backup/tmp/pleroma-pre-upgrade2 YNH_APP_INSTANCE_NAME=pleroma YNH_STDRETURN=/tmp/tmpy6jxqm/stdreturn YNH_APP_BACKUP_DIR=/home/yunohost.backup/tmp/pleroma-pre-upgrade2/apps/pleroma/backup YNH_STDINFO=/tmp/tmpWnGiEK/stdinfo YNH_INTERFACE=api YNH_APP_ID=pleroma BASH_XTRACEFD=7 /bin/bash -x "/tmp/restoreVTemRv/restore" /home/yunohost.backup/tmp/pleroma-pre-upgrade2/apps/pleroma/backup pleroma 7>&1'
2021-03-09 00:18:06,427: DEBUG - + source ../settings/scripts/_common.sh
2021-03-09 00:18:06,428: DEBUG - ++ pkg_dependencies='curl unzip libncurses5 postgresql postgresql-contrib imagemagick ffmpeg exiftool libimage-exiftool-perl'
2021-03-09 00:18:06,428: DEBUG - + source /usr/share/yunohost/helpers
2021-03-09 00:18:06,428: DEBUG - +++ set +o
2021-03-09 00:18:06,428: DEBUG - +++ grep xtrace
2021-03-09 00:18:06,428: DEBUG - ++ readonly 'XTRACE_ENABLE=set -o xtrace'
2021-03-09 00:18:06,428: DEBUG - ++ XTRACE_ENABLE='set -o xtrace'
2021-03-09 00:18:06,429: DEBUG - + ynh_abort_if_errors
2021-03-09 00:18:06,429: DEBUG - + set -o errexit
2021-03-09 00:18:06,429: DEBUG - + set -o nounset
2021-03-09 00:18:06,429: DEBUG - + trap ynh_exit_properly EXIT
2021-03-09 00:18:06,530: INFO - [+...................] > Loading settings...
2021-03-09 00:18:06,533: DEBUG - + echo '[+...................] > Loading settings...'
2021-03-09 00:18:06,533: DEBUG - + app=pleroma
2021-03-09 00:18:06,533: DEBUG - ++ ynh_app_setting_get --app=pleroma --key=domain
2021-03-09 00:18:06,534: DEBUG - ++ [[ domain =~ (unprotected|protected|skipped)_ ]]
2021-03-09 00:18:06,534: DEBUG - ++ ynh_app_setting get pleroma domain
2021-03-09 00:18:06,735: DEBUG - + domain=pleroma.maindomain.tld
2021-03-09 00:18:06,735: DEBUG - ++ ynh_app_setting_get --app=pleroma --key=path
2021-03-09 00:18:06,736: DEBUG - ++ [[ path =~ (unprotected|protected|skipped)_ ]]
2021-03-09 00:18:06,736: DEBUG - ++ ynh_app_setting get pleroma path
2021-03-09 00:18:06,836: DEBUG - + path_url=/
2021-03-09 00:18:06,837: DEBUG - ++ ynh_app_setting_get --app=pleroma --key=final_path
2021-03-09 00:18:06,938: DEBUG - ++ [[ final_path =~ (unprotected|protected|skipped)_ ]]
2021-03-09 00:18:06,938: DEBUG - ++ ynh_app_setting get pleroma final_path
2021-03-09 00:18:07,038: DEBUG - + final_path=/var/www/pleroma
2021-03-09 00:18:07,038: DEBUG - ++ ynh_app_setting_get --app=pleroma --key=db_name
2021-03-09 00:18:07,039: DEBUG - ++ [[ db_name =~ (unprotected|protected|skipped)_ ]]
2021-03-09 00:18:07,039: DEBUG - ++ ynh_app_setting get pleroma db_name
2021-03-09 00:18:07,140: DEBUG - + db_name=pleroma
2021-03-09 00:18:07,141: DEBUG - + db_user=pleroma
2021-03-09 00:18:07,141: DEBUG - ++ ynh_app_setting_get --app=pleroma --key=db_pwd
2021-03-09 00:18:07,141: DEBUG - ++ [[ db_pwd =~ (unprotected|protected|skipped)_ ]]
2021-03-09 00:18:07,141: DEBUG - ++ ynh_app_setting get pleroma db_pwd
2021-03-09 00:18:07,242: DEBUG - + db_pwd=**********
2021-03-09 00:18:07,242: DEBUG - ++ ynh_app_setting_get --app=pleroma --key=port
2021-03-09 00:18:07,343: DEBUG - ++ [[ port =~ (unprotected|protected|skipped)_ ]]
2021-03-09 00:18:07,343: DEBUG - ++ ynh_app_setting get pleroma port
2021-03-09 00:18:07,443: DEBUG - + port=8095
2021-03-09 00:18:07,444: DEBUG - ++ ynh_app_setting_get --app=pleroma --key=cache
2021-03-09 00:18:07,445: DEBUG - ++ [[ cache =~ (unprotected|protected|skipped)_ ]]
2021-03-09 00:18:07,445: DEBUG - ++ ynh_app_setting get pleroma cache
2021-03-09 00:18:07,546: DEBUG - + cache=1
2021-03-09 00:18:07,546: DEBUG - ++ ynh_app_setting_get --app=pleroma --key=datadir
2021-03-09 00:18:07,648: DEBUG - ++ [[ datadir =~ (unprotected|protected|skipped)_ ]]
2021-03-09 00:18:07,648: DEBUG - ++ ynh_app_setting get pleroma datadir
2021-03-09 00:18:07,749: DEBUG - + datadir=/home/yunohost.app/pleroma
2021-03-09 00:18:08,050: DEBUG - + echo '[#+..................] > Validating restoration parameters...'
2021-03-09 00:18:08,051: INFO - [#+..................] > Validating restoration parameters...
2021-03-09 00:18:08,052: DEBUG - + ynh_webpath_available --domain=pleroma.maindomain.tld --path_url=/
2021-03-09 00:18:08,265: DEBUG - + yunohost domain url-available pleroma.maindomain.tld /
2021-03-09 00:18:08,767: DEBUG - False
2021-03-09 00:18:08,867: DEBUG - + test '!' -d /var/www/pleroma
2021-03-09 00:18:08,868: DEBUG - + echo '[##++................] > Restoring the nginx configuration...'
2021-03-09 00:18:08,868: DEBUG - + ynh_restore_file --origin_path=/etc/nginx/conf.d/pleroma.maindomain.tld.d/pleroma.conf
2021-03-09 00:18:08,869: DEBUG - + origin_path=/etc/nginx/conf.d/pleroma.maindomain.tld.d/pleroma.conf
2021-03-09 00:18:08,869: DEBUG - + dest_path=/etc/nginx/conf.d/pleroma.maindomain.tld.d/pleroma.conf
2021-03-09 00:18:08,869: DEBUG - + not_mandatory=0
2021-03-09 00:18:08,869: DEBUG - + local archive_path=/home/yunohost.backup/tmp/pleroma-pre-upgrade2/apps/pleroma/backup/etc/nginx/conf.d/pleroma.maindomain.tld.d/pleroma.conf
2021-03-09 00:18:08,869: DEBUG - + '[' '!' -d /home/yunohost.backup/tmp/pleroma-pre-upgrade2/apps/pleroma/backup/etc/nginx/conf.d/pleroma.maindomain.tld.d/pleroma.conf ']'
2021-03-09 00:18:08,869: DEBUG - + '[' '!' -f /home/yunohost.backup/tmp/pleroma-pre-upgrade2/apps/pleroma/backup/etc/nginx/conf.d/pleroma.maindomain.tld.d/pleroma.conf ']'
2021-03-09 00:18:08,869: DEBUG - + [[ -e /etc/nginx/conf.d/pleroma.maindomain.tld.d/pleroma.conf ]]
2021-03-09 00:18:08,870: DEBUG - ++ dirname /etc/nginx/conf.d/pleroma.maindomain.tld.d/pleroma.conf
2021-03-09 00:18:08,870: DEBUG - + mkdir --parents /etc/nginx/conf.d/pleroma.maindomain.tld.d
2021-03-09 00:18:08,870: DEBUG - + mountpoint --quiet /home/yunohost.backup/tmp/pleroma-pre-upgrade2
2021-03-09 00:18:08,870: DEBUG - + mv /home/yunohost.backup/tmp/pleroma-pre-upgrade2/apps/pleroma/backup/etc/nginx/conf.d/pleroma.maindomain.tld.d/pleroma.conf /etc/nginx/conf.d/pleroma.maindomain.tld.d/pleroma.conf
2021-03-09 00:18:08,970: DEBUG - + '[' 1 -eq 1 ']'
2021-03-09 00:18:08,970: INFO - [##++................] > Restoring the nginx configuration...
2021-03-09 00:18:08,971: DEBUG - + ynh_restore_file --origin_path=/etc/nginx/conf.d/pleroma-cache.conf
2021-03-09 00:18:08,973: DEBUG - + origin_path=/etc/nginx/conf.d/pleroma-cache.conf
2021-03-09 00:18:08,973: DEBUG - + dest_path=/etc/nginx/conf.d/pleroma-cache.conf
2021-03-09 00:18:08,973: DEBUG - + not_mandatory=0
2021-03-09 00:18:08,973: DEBUG - + local archive_path=/home/yunohost.backup/tmp/pleroma-pre-upgrade2/apps/pleroma/backup/etc/nginx/conf.d/pleroma-cache.conf
2021-03-09 00:18:08,973: DEBUG - + '[' '!' -d /home/yunohost.backup/tmp/pleroma-pre-upgrade2/apps/pleroma/backup/etc/nginx/conf.d/pleroma-cache.conf ']'
2021-03-09 00:18:08,973: DEBUG - + '[' '!' -f /home/yunohost.backup/tmp/pleroma-pre-upgrade2/apps/pleroma/backup/etc/nginx/conf.d/pleroma-cache.conf ']'
2021-03-09 00:18:08,973: DEBUG - + [[ -e /etc/nginx/conf.d/pleroma-cache.conf ]]
2021-03-09 00:18:08,974: DEBUG - ++ dirname /etc/nginx/conf.d/pleroma-cache.conf
2021-03-09 00:18:08,974: DEBUG - + mkdir --parents /etc/nginx/conf.d
2021-03-09 00:18:08,974: DEBUG - + mountpoint --quiet /home/yunohost.backup/tmp/pleroma-pre-upgrade2
2021-03-09 00:18:08,974: DEBUG - + mv /home/yunohost.backup/tmp/pleroma-pre-upgrade2/apps/pleroma/backup/etc/nginx/conf.d/pleroma-cache.conf /etc/nginx/conf.d/pleroma-cache.conf
2021-03-09 00:18:08,974: DEBUG - + echo '[####+...............] > Restoring the app main directory...'
2021-03-09 00:18:08,975: DEBUG - + ynh_restore_file --origin_path=/var/www/pleroma
2021-03-09 00:18:09,076: DEBUG - + origin_path=/var/www/pleroma
2021-03-09 00:18:09,076: INFO - [####+...............] > Restoring the app main directory...
2021-03-09 00:18:09,076: DEBUG - + dest_path=/var/www/pleroma
2021-03-09 00:18:09,076: DEBUG - + not_mandatory=0
2021-03-09 00:18:09,077: DEBUG - + local archive_path=/home/yunohost.backup/tmp/pleroma-pre-upgrade2/apps/pleroma/backup/var/www/pleroma
2021-03-09 00:18:09,077: DEBUG - + '[' '!' -d /home/yunohost.backup/tmp/pleroma-pre-upgrade2/apps/pleroma/backup/var/www/pleroma ']'
2021-03-09 00:18:09,077: DEBUG - + [[ -e /var/www/pleroma ]]
2021-03-09 00:18:09,077: DEBUG - ++ dirname /var/www/pleroma
2021-03-09 00:18:09,077: DEBUG - + mkdir --parents /var/www
2021-03-09 00:18:09,077: DEBUG - + mountpoint --quiet /home/yunohost.backup/tmp/pleroma-pre-upgrade2
2021-03-09 00:18:09,077: DEBUG - + mv /home/yunohost.backup/tmp/pleroma-pre-upgrade2/apps/pleroma/backup/var/www/pleroma /var/www/pleroma
2021-03-09 00:18:09,077: DEBUG - + echo '[#####+..............] > Recreating the dedicated system user...'
2021-03-09 00:18:09,077: DEBUG - + ynh_system_user_create --username=pleroma --home_dir=/var/www/pleroma
2021-03-09 00:18:09,178: DEBUG - + use_shell=0
2021-03-09 00:18:09,179: INFO - [#####+..............] > Recreating the dedicated system user...
2021-03-09 00:18:09,179: DEBUG - + home_dir=/var/www/pleroma
2021-03-09 00:18:09,179: DEBUG - + ynh_system_user_exists pleroma
2021-03-09 00:18:09,181: DEBUG - + getent passwd pleroma
2021-03-09 00:18:09,181: DEBUG - + '[' -n /var/www/pleroma ']'
2021-03-09 00:18:09,181: DEBUG - + local 'user_home_dir=--home-dir /var/www/pleroma'
2021-03-09 00:18:09,181: DEBUG - + '[' 0 -eq 1 ']'
2021-03-09 00:18:09,181: DEBUG - + local 'shell=--shell /usr/sbin/nologin'
2021-03-09 00:18:09,181: DEBUG - + useradd --home-dir /var/www/pleroma --system --user-group pleroma --shell /usr/sbin/nologin
2021-03-09 00:18:09,282: INFO - [######++............] > Restoring user rights...
2021-03-09 00:18:09,283: DEBUG - + echo '[######++............] > Restoring user rights...'
2021-03-09 00:18:09,283: DEBUG - + chown -R pleroma:pleroma /var/www/pleroma
2021-03-09 00:18:09,484: INFO - [########+...........] > Recreating the data directory...
2021-03-09 00:18:09,485: DEBUG - + echo '[########+...........] > Recreating the data directory...'
2021-03-09 00:18:09,485: DEBUG - + mkdir -p /home/yunohost.app/pleroma/
2021-03-09 00:18:09,485: DEBUG - + mkdir -p /home/yunohost.app/pleroma/uploads/
2021-03-09 00:18:09,485: DEBUG - + mkdir -p /home/yunohost.app/pleroma/static/
2021-03-09 00:18:09,485: DEBUG - + mkdir -p /home/yunohost.app/pleroma/static/emoji/
2021-03-09 00:18:09,485: DEBUG - + chown -R pleroma:pleroma /home/yunohost.app/pleroma
2021-03-09 00:18:09,485: DEBUG - + ynh_app_setting_set --app=pleroma --key=datadir --value=/home/yunohost.app/pleroma
2021-03-09 00:18:09,486: DEBUG - + [[ datadir =~ (unprotected|protected|skipped)_ ]]
2021-03-09 00:18:09,486: DEBUG - + ynh_app_setting set pleroma datadir /home/yunohost.app/pleroma
2021-03-09 00:18:09,687: DEBUG - + echo '[#########+..........] > Restoring the config file...'
2021-03-09 00:18:09,687: DEBUG - + ynh_restore_file --origin_path=/etc/pleroma/config.exs
2021-03-09 00:18:09,688: DEBUG - + origin_path=/etc/pleroma/config.exs
2021-03-09 00:18:09,688: DEBUG - + dest_path=/etc/pleroma/config.exs
2021-03-09 00:18:09,688: DEBUG - + not_mandatory=0
2021-03-09 00:18:09,688: DEBUG - + local archive_path=/home/yunohost.backup/tmp/pleroma-pre-upgrade2/apps/pleroma/backup/etc/pleroma/config.exs
2021-03-09 00:18:09,689: DEBUG - + '[' '!' -d /home/yunohost.backup/tmp/pleroma-pre-upgrade2/apps/pleroma/backup/etc/pleroma/config.exs ']'
2021-03-09 00:18:09,689: DEBUG - + '[' '!' -f /home/yunohost.backup/tmp/pleroma-pre-upgrade2/apps/pleroma/backup/etc/pleroma/config.exs ']'
2021-03-09 00:18:09,689: DEBUG - + [[ -e /etc/pleroma/config.exs ]]
2021-03-09 00:18:09,689: DEBUG - ++ dirname /etc/pleroma/config.exs
2021-03-09 00:18:09,689: DEBUG - + mkdir --parents /etc/pleroma
2021-03-09 00:18:09,689: DEBUG - + mountpoint --quiet /home/yunohost.backup/tmp/pleroma-pre-upgrade2
2021-03-09 00:18:09,689: DEBUG - + mv /home/yunohost.backup/tmp/pleroma-pre-upgrade2/apps/pleroma/backup/etc/pleroma/config.exs /etc/pleroma/config.exs
2021-03-09 00:18:09,790: INFO - [#########+..........] > Restoring the config file...
2021-03-09 00:18:09,791: DEBUG - + echo '[##########++........] > Reinstalling dependencies...'
2021-03-09 00:18:09,791: DEBUG - + ynh_install_app_dependencies curl unzip libncurses5 postgresql postgresql-contrib imagemagick ffmpeg exiftool libimage-exiftool-perl
2021-03-09 00:18:09,791: DEBUG - + local 'dependencies=curl unzip libncurses5 postgresql postgresql-contrib imagemagick ffmpeg exiftool libimage-exiftool-perl'
2021-03-09 00:18:09,791: DEBUG - ++ sed 's/\([^\<=\>]\)\ \([^(]\)/\1, \2/g'
2021-03-09 00:18:09,791: DEBUG - ++ echo 'curl unzip libncurses5 postgresql postgresql-contrib imagemagick ffmpeg exiftool libimage-exiftool-perl'
2021-03-09 00:18:09,791: DEBUG - + dependencies='curl, unzip, libncurses5, postgresql, postgresql-contrib, imagemagick, ffmpeg, exiftool, libimage-exiftool-perl'
2021-03-09 00:18:09,791: DEBUG - + local 'dependencies=curl, unzip, libncurses5, postgresql, postgresql-contrib, imagemagick, ffmpeg, exiftool, libimage-exiftool-perl'
2021-03-09 00:18:09,792: DEBUG - + local manifest_path=../manifest.json
2021-03-09 00:18:09,792: DEBUG - + '[' '!' -e ../manifest.json ']'
2021-03-09 00:18:09,792: DEBUG - + manifest_path=../settings/manifest.json
2021-03-09 00:18:09,792: DEBUG - ++ cut '--delimiter="' --fields=4
2021-03-09 00:18:09,792: DEBUG - ++ grep '\"version\": ' ../settings/manifest.json
2021-03-09 00:18:09,792: DEBUG - + local version=2.2.0~ynh1
2021-03-09 00:18:09,792: DEBUG - + '[' 10 -eq 0 ']'
2021-03-09 00:18:09,792: DEBUG - + local dep_app=pleroma
2021-03-09 00:18:09,792: DEBUG - + [[ curl, unzip, libncurses5, postgresql, postgresql-contrib, imagemagick, ffmpeg, exiftool, libimage-exiftool-perl =~ [<=>] ]]
2021-03-09 00:18:09,792: DEBUG - + grep --quiet php
2021-03-09 00:18:09,792: DEBUG - + echo curl, unzip, libncurses5, postgresql, postgresql-contrib, imagemagick, ffmpeg, exiftool, libimage-exiftool-perl
2021-03-09 00:18:09,792: DEBUG - + cat
2021-03-09 00:18:09,792: DEBUG - + ynh_package_install_from_equivs /tmp/pleroma-ynh-deps.control
2021-03-09 00:18:09,792: DEBUG - + local controlfile=/tmp/pleroma-ynh-deps.control
2021-03-09 00:18:09,793: DEBUG - ++ cut '--delimiter= ' --fields=2
2021-03-09 00:18:09,793: DEBUG - ++ grep '^Package: ' /tmp/pleroma-ynh-deps.control
2021-03-09 00:18:09,793: DEBUG - + local pkgname=pleroma-ynh-deps
2021-03-09 00:18:09,793: DEBUG - ++ cut '--delimiter= ' --fields=2
2021-03-09 00:18:09,793: DEBUG - ++ grep '^Version: ' /tmp/pleroma-ynh-deps.control
2021-03-09 00:18:09,793: DEBUG - + local pkgversion=2.2.0~ynh1
2021-03-09 00:18:09,793: DEBUG - + [[ -z pleroma-ynh-deps ]]
2021-03-09 00:18:09,793: DEBUG - + [[ -z 2.2.0~ynh1 ]]
2021-03-09 00:18:09,793: DEBUG - + ynh_package_update
2021-03-09 00:18:09,793: DEBUG - + ynh_apt update
2021-03-09 00:18:09,793: DEBUG - + ynh_wait_dpkg_free
2021-03-09 00:18:09,894: DEBUG - + return 0
2021-03-09 00:18:09,894: INFO - [##########++........] > Reinstalling dependencies...
2021-03-09 00:18:09,895: DEBUG - + LC_ALL=C
2021-03-09 00:18:09,895: DEBUG - + DEBIAN_FRONTEND=noninteractive
2021-03-09 00:18:09,895: DEBUG - + apt-get --assume-yes --quiet -o=Acquire::Retries=3 -o=Dpkg::Use-Pty=0 update
2021-03-09 00:18:15,108: DEBUG - Hit:1 http://security.debian.org/debian-security buster/updates InRelease
2021-03-09 00:18:15,108: DEBUG - Hit:2 http://deb.debian.org/debian buster InRelease
2021-03-09 00:18:15,108: DEBUG - Hit:3 http://deb.debian.org/debian buster-updates InRelease
2021-03-09 00:18:15,409: DEBUG - Hit:4 http://forge.yunohost.org/debian buster InRelease
2021-03-09 00:18:16,813: DEBUG - Reading package lists...
2021-03-09 00:18:16,814: DEBUG - ++ mktemp --directory
2021-03-09 00:18:16,814: DEBUG - + local TMPDIR=/tmp/tmp.MUpZCPfa3l
2021-03-09 00:18:16,814: DEBUG - + echo 10
2021-03-09 00:18:16,814: DEBUG - + ynh_wait_dpkg_free
2021-03-09 00:18:16,915: DEBUG - + return 0
2021-03-09 00:18:16,915: DEBUG - + cp /tmp/pleroma-ynh-deps.control /tmp/tmp.MUpZCPfa3l/control
2021-03-09 00:18:16,915: DEBUG - + cd /tmp/tmp.MUpZCPfa3l
2021-03-09 00:18:16,915: DEBUG - + LC_ALL=C
2021-03-09 00:18:16,915: DEBUG - + equivs-build ./control
2021-03-09 00:18:17,817: DEBUG - + tee ./dpkg_log
2021-03-09 00:18:17,818: DEBUG - + LC_ALL=C
2021-03-09 00:18:17,818: DEBUG - + dpkg --force-depends --install ./pleroma-ynh-deps_2.2.0~ynh1_all.deb
2021-03-09 00:18:17,818: DEBUG - Selecting previously unselected package pleroma-ynh-deps.
2021-03-09 00:18:18,119: DEBUG - (Reading database ... 62804 files and directories currently installed.)
2021-03-09 00:18:18,119: DEBUG - Preparing to unpack .../pleroma-ynh-deps_2.2.0~ynh1_all.deb ...
2021-03-09 00:18:18,119: DEBUG - Unpacking pleroma-ynh-deps (2.2.0~ynh1) ...
2021-03-09 00:18:18,119: DEBUG - dpkg: pleroma-ynh-deps: dependency problems, but configuring anyway as you requested:
2021-03-09 00:18:18,119: DEBUG -  pleroma-ynh-deps depends on libncurses5; however:
2021-03-09 00:18:18,119: DEBUG -   Package libncurses5 is not installed.
2021-03-09 00:18:18,119: DEBUG -  pleroma-ynh-deps depends on imagemagick; however:
2021-03-09 00:18:18,119: DEBUG -   Package imagemagick is not installed.
2021-03-09 00:18:18,119: DEBUG -  pleroma-ynh-deps depends on exiftool; however:
2021-03-09 00:18:18,119: DEBUG -   Package exiftool is not installed.
2021-03-09 00:18:18,119: DEBUG -  pleroma-ynh-deps depends on libimage-exiftool-perl; however:
2021-03-09 00:18:18,120: DEBUG -   Package libimage-exiftool-perl is not installed.
2021-03-09 00:18:18,120: DEBUG - 
2021-03-09 00:18:18,120: DEBUG - Setting up pleroma-ynh-deps (2.2.0~ynh1) ...
2021-03-09 00:18:18,120: DEBUG - + ynh_package_install --fix-broken
2021-03-09 00:18:18,120: DEBUG - + ynh_apt --no-remove --option Dpkg::Options::=--force-confdef --option Dpkg::Options::=--force-confold install --fix-broken
2021-03-09 00:18:18,120: DEBUG - + ynh_wait_dpkg_free
2021-03-09 00:18:18,221: DEBUG - + return 0
2021-03-09 00:18:18,221: DEBUG - + LC_ALL=C
2021-03-09 00:18:18,221: DEBUG - + DEBIAN_FRONTEND=noninteractive
2021-03-09 00:18:18,221: DEBUG - + apt-get --assume-yes --quiet -o=Acquire::Retries=3 -o=Dpkg::Use-Pty=0 --no-remove --option Dpkg::Options::=--force-confdef --option Dpkg::Options::=--force-confold install --fix-broken
2021-03-09 00:18:18,422: DEBUG - Reading package lists...
2021-03-09 00:18:18,723: DEBUG - Building dependency tree...
2021-03-09 00:18:18,723: DEBUG - Reading state information...
2021-03-09 00:18:18,925: DEBUG - Correcting dependencies... Done
2021-03-09 00:18:19,226: DEBUG - The following additional packages will be installed:
2021-03-09 00:18:19,227: DEBUG -   hicolor-icon-theme imagemagick imagemagick-6-common imagemagick-6.q16
2021-03-09 00:18:19,227: DEBUG -   libde265-0 libdjvulibre-text libdjvulibre21 libheif1 libilmbase23
2021-03-09 00:18:19,227: DEBUG -   libimage-exiftool-perl libjxr-tools libjxr0 liblqr-1-0 libmagickcore-6.q16-6
2021-03-09 00:18:19,227: DEBUG -   libmagickcore-6.q16-6-extra libmagickwand-6.q16-6 libmime-charset-perl
2021-03-09 00:18:19,227: DEBUG -   libncurses5 libnetpbm10 libopenexr23 libposix-strptime-perl libsombok3
2021-03-09 00:18:19,227: DEBUG -   libtinfo5 libunicode-linebreak-perl libwmf0.2-7 netpbm
2021-03-09 00:18:19,227: DEBUG - Suggested packages:
2021-03-09 00:18:19,227: DEBUG -   imagemagick-doc autotrace cups-bsd | lpr | lprng enscript gimp gnuplot grads
2021-03-09 00:18:19,227: DEBUG -   graphviz hp2xx html2ps libwmf-bin mplayer povray radiance sane-utils
2021-03-09 00:18:19,227: DEBUG -   texlive-base-bin transfig ufraw-batch xdg-utils inkscape
2021-03-09 00:18:19,227: DEBUG -   libencode-hanextra-perl libpod2-base-perl libwmf0.2-7-gtk
2021-03-09 00:18:19,228: DEBUG - The following NEW packages will be installed:
2021-03-09 00:18:19,228: DEBUG -   hicolor-icon-theme imagemagick imagemagick-6-common imagemagick-6.q16
2021-03-09 00:18:19,228: DEBUG -   libde265-0 libdjvulibre-text libdjvulibre21 libheif1 libilmbase23
2021-03-09 00:18:19,228: DEBUG -   libimage-exiftool-perl libjxr-tools libjxr0 liblqr-1-0 libmagickcore-6.q16-6
2021-03-09 00:18:19,228: DEBUG -   libmagickcore-6.q16-6-extra libmagickwand-6.q16-6 libmime-charset-perl
2021-03-09 00:18:19,228: DEBUG -   libncurses5 libnetpbm10 libopenexr23 libposix-strptime-perl libsombok3
2021-03-09 00:18:19,228: DEBUG -   libtinfo5 libunicode-linebreak-perl libwmf0.2-7 netpbm
2021-03-09 00:18:19,930: DEBUG - 0 upgraded, 26 newly installed, 0 to remove and 0 not upgraded.
2021-03-09 00:18:19,930: DEBUG - Need to get 0 B/10.5 MB of archives.
2021-03-09 00:18:19,930: DEBUG - After this operation, 45.5 MB of additional disk space will be used.
2021-03-09 00:18:20,031: DEBUG - Selecting previously unselected package libde265-0:amd64.
2021-03-09 00:18:20,031: DEBUG - (Reading database ... 62808 files and directories currently installed.)
2021-03-09 00:18:20,031: DEBUG - Preparing to unpack .../00-libde265-0_1.0.3-1+b1_amd64.deb ...
2021-03-09 00:18:20,031: DEBUG - Unpacking libde265-0:amd64 (1.0.3-1+b1) ...
2021-03-09 00:18:20,132: DEBUG - Selecting previously unselected package libheif1:amd64.
2021-03-09 00:18:20,132: DEBUG - Preparing to unpack .../01-libheif1_1.3.2-2~deb10u1_amd64.deb ...
2021-03-09 00:18:20,132: DEBUG - Unpacking libheif1:amd64 (1.3.2-2~deb10u1) ...
2021-03-09 00:18:20,132: DEBUG - Selecting previously unselected package liblqr-1-0:amd64.
2021-03-09 00:18:20,132: DEBUG - Preparing to unpack .../02-liblqr-1-0_0.4.2-2.1_amd64.deb ...
2021-03-09 00:18:20,132: DEBUG - Unpacking liblqr-1-0:amd64 (0.4.2-2.1) ...
2021-03-09 00:18:20,132: DEBUG - Selecting previously unselected package imagemagick-6-common.
2021-03-09 00:18:20,133: DEBUG - Preparing to unpack .../03-imagemagick-6-common_8%3a6.9.10.23+dfsg-2.1+deb10u1_all.deb ...
2021-03-09 00:18:20,133: DEBUG - Unpacking imagemagick-6-common (8:6.9.10.23+dfsg-2.1+deb10u1) ...
2021-03-09 00:18:20,233: DEBUG - Selecting previously unselected package libmagickcore-6.q16-6:amd64.
2021-03-09 00:18:20,233: DEBUG - Preparing to unpack .../04-libmagickcore-6.q16-6_8%3a6.9.10.23+dfsg-2.1+deb10u1_amd64.deb ...
2021-03-09 00:18:20,234: DEBUG - Unpacking libmagickcore-6.q16-6:amd64 (8:6.9.10.23+dfsg-2.1+deb10u1) ...
2021-03-09 00:18:20,535: DEBUG - Selecting previously unselected package libmagickwand-6.q16-6:amd64.
2021-03-09 00:18:20,535: DEBUG - Preparing to unpack .../05-libmagickwand-6.q16-6_8%3a6.9.10.23+dfsg-2.1+deb10u1_amd64.deb ...
2021-03-09 00:18:20,535: DEBUG - Unpacking libmagickwand-6.q16-6:amd64 (8:6.9.10.23+dfsg-2.1+deb10u1) ...
2021-03-09 00:18:20,635: DEBUG - Selecting previously unselected package hicolor-icon-theme.
2021-03-09 00:18:20,636: DEBUG - Preparing to unpack .../06-hicolor-icon-theme_0.17-2_all.deb ...
2021-03-09 00:18:20,636: DEBUG - Unpacking hicolor-icon-theme (0.17-2) ...
2021-03-09 00:18:20,736: DEBUG - Selecting previously unselected package imagemagick-6.q16.
2021-03-09 00:18:20,737: DEBUG - Preparing to unpack .../07-imagemagick-6.q16_8%3a6.9.10.23+dfsg-2.1+deb10u1_amd64.deb ...
2021-03-09 00:18:20,737: DEBUG - Unpacking imagemagick-6.q16 (8:6.9.10.23+dfsg-2.1+deb10u1) ...
2021-03-09 00:18:20,837: DEBUG - Selecting previously unselected package imagemagick.
2021-03-09 00:18:20,838: DEBUG - Preparing to unpack .../08-imagemagick_8%3a6.9.10.23+dfsg-2.1+deb10u1_amd64.deb ...
2021-03-09 00:18:20,838: DEBUG - Unpacking imagemagick (8:6.9.10.23+dfsg-2.1+deb10u1) ...
2021-03-09 00:18:20,838: DEBUG - Selecting previously unselected package libdjvulibre-text.
2021-03-09 00:18:20,838: DEBUG - Preparing to unpack .../09-libdjvulibre-text_3.5.27.1-10_all.deb ...
2021-03-09 00:18:20,838: DEBUG - Unpacking libdjvulibre-text (3.5.27.1-10) ...
2021-03-09 00:18:20,938: DEBUG - Selecting previously unselected package libdjvulibre21:amd64.
2021-03-09 00:18:20,939: DEBUG - Preparing to unpack .../10-libdjvulibre21_3.5.27.1-10_amd64.deb ...
2021-03-09 00:18:20,939: DEBUG - Unpacking libdjvulibre21:amd64 (3.5.27.1-10) ...
2021-03-09 00:18:21,039: DEBUG - Selecting previously unselected package libilmbase23:amd64.
2021-03-09 00:18:21,040: DEBUG - Preparing to unpack .../11-libilmbase23_2.2.1-2_amd64.deb ...
2021-03-09 00:18:21,040: DEBUG - Unpacking libilmbase23:amd64 (2.2.1-2) ...
2021-03-09 00:18:21,040: DEBUG - Selecting previously unselected package libimage-exiftool-perl.
2021-03-09 00:18:21,040: DEBUG - Preparing to unpack .../12-libimage-exiftool-perl_11.16-1_all.deb ...
2021-03-09 00:18:21,040: DEBUG - Unpacking libimage-exiftool-perl (11.16-1) ...
2021-03-09 00:18:21,742: DEBUG - Selecting previously unselected package libjxr0:amd64.
2021-03-09 00:18:21,742: DEBUG - Preparing to unpack .../13-libjxr0_1.1-6+b1_amd64.deb ...
2021-03-09 00:18:21,743: DEBUG - Unpacking libjxr0:amd64 (1.1-6+b1) ...
2021-03-09 00:18:21,843: DEBUG - Selecting previously unselected package libjxr-tools.
2021-03-09 00:18:21,843: DEBUG - Preparing to unpack .../14-libjxr-tools_1.1-6+b1_amd64.deb ...
2021-03-09 00:18:21,843: DEBUG - Unpacking libjxr-tools (1.1-6+b1) ...
2021-03-09 00:18:21,844: DEBUG - Selecting previously unselected package libopenexr23:amd64.
2021-03-09 00:18:21,844: DEBUG - Preparing to unpack .../15-libopenexr23_2.2.1-4.1+deb10u1_amd64.deb ...
2021-03-09 00:18:21,844: DEBUG - Unpacking libopenexr23:amd64 (2.2.1-4.1+deb10u1) ...
2021-03-09 00:18:21,944: DEBUG - Selecting previously unselected package libwmf0.2-7:amd64.
2021-03-09 00:18:21,944: DEBUG - Preparing to unpack .../16-libwmf0.2-7_0.2.8.4-14_amd64.deb ...
2021-03-09 00:18:21,944: DEBUG - Unpacking libwmf0.2-7:amd64 (0.2.8.4-14) ...
2021-03-09 00:18:22,045: DEBUG - Selecting previously unselected package libmagickcore-6.q16-6-extra:amd64.
2021-03-09 00:18:22,045: DEBUG - Preparing to unpack .../17-libmagickcore-6.q16-6-extra_8%3a6.9.10.23+dfsg-2.1+deb10u1_amd64.deb ...
2021-03-09 00:18:22,045: DEBUG - Unpacking libmagickcore-6.q16-6-extra:amd64 (8:6.9.10.23+dfsg-2.1+deb10u1) ...
2021-03-09 00:18:22,045: DEBUG - Selecting previously unselected package libmime-charset-perl.
2021-03-09 00:18:22,045: DEBUG - Preparing to unpack .../18-libmime-charset-perl_1.012.2-1_all.deb ...
2021-03-09 00:18:22,045: DEBUG - Unpacking libmime-charset-perl (1.012.2-1) ...
2021-03-09 00:18:22,150: DEBUG - Selecting previously unselected package libtinfo5:amd64.
2021-03-09 00:18:22,151: DEBUG - Preparing to unpack .../19-libtinfo5_6.1+20181013-2+deb10u2_amd64.deb ...
2021-03-09 00:18:22,151: DEBUG - Unpacking libtinfo5:amd64 (6.1+20181013-2+deb10u2) ...
2021-03-09 00:18:22,151: DEBUG - Selecting previously unselected package libncurses5:amd64.
2021-03-09 00:18:22,151: DEBUG - Preparing to unpack .../20-libncurses5_6.1+20181013-2+deb10u2_amd64.deb ...
2021-03-09 00:18:22,151: DEBUG - Unpacking libncurses5:amd64 (6.1+20181013-2+deb10u2) ...
2021-03-09 00:18:22,151: DEBUG - Selecting previously unselected package libnetpbm10.
2021-03-09 00:18:22,151: DEBUG - Preparing to unpack .../21-libnetpbm10_2%3a10.0-15.3+b2_amd64.deb ...
2021-03-09 00:18:22,252: DEBUG - Unpacking libnetpbm10 (2:10.0-15.3+b2) ...
2021-03-09 00:18:22,252: DEBUG - Selecting previously unselected package libposix-strptime-perl.
2021-03-09 00:18:22,252: DEBUG - Preparing to unpack .../22-libposix-strptime-perl_0.13-1+b5_amd64.deb ...
2021-03-09 00:18:22,252: DEBUG - Unpacking libposix-strptime-perl (0.13-1+b5) ...
2021-03-09 00:18:22,252: DEBUG - Selecting previously unselected package libsombok3:amd64.
2021-03-09 00:18:22,252: DEBUG - Preparing to unpack .../23-libsombok3_2.4.0-2_amd64.deb ...
2021-03-09 00:18:22,253: DEBUG - Unpacking libsombok3:amd64 (2.4.0-2) ...
2021-03-09 00:18:22,353: DEBUG - Selecting previously unselected package libunicode-linebreak-perl.
2021-03-09 00:18:22,353: DEBUG - Preparing to unpack .../24-libunicode-linebreak-perl_0.0.20190101-1_amd64.deb ...
2021-03-09 00:18:22,353: DEBUG - Unpacking libunicode-linebreak-perl (0.0.20190101-1) ...
2021-03-09 00:18:22,353: DEBUG - Selecting previously unselected package netpbm.
2021-03-09 00:18:22,353: DEBUG - Preparing to unpack .../25-netpbm_2%3a10.0-15.3+b2_amd64.deb ...
2021-03-09 00:18:22,354: DEBUG - Unpacking netpbm (2:10.0-15.3+b2) ...
2021-03-09 00:18:22,654: DEBUG - Setting up imagemagick-6-common (8:6.9.10.23+dfsg-2.1+deb10u1) ...
2021-03-09 00:18:22,655: DEBUG - Setting up hicolor-icon-theme (0.17-2) ...
2021-03-09 00:18:22,655: DEBUG - Setting up libwmf0.2-7:amd64 (0.2.8.4-14) ...
2021-03-09 00:18:22,655: DEBUG - Setting up libsombok3:amd64 (2.4.0-2) ...
2021-03-09 00:18:22,655: DEBUG - Setting up libilmbase23:amd64 (2.2.1-2) ...
2021-03-09 00:18:22,655: DEBUG - Setting up libjxr0:amd64 (1.1-6+b1) ...
2021-03-09 00:18:22,655: DEBUG - Setting up libopenexr23:amd64 (2.2.1-4.1+deb10u1) ...
2021-03-09 00:18:22,655: DEBUG - Setting up libnetpbm10 (2:10.0-15.3+b2) ...
2021-03-09 00:18:22,655: DEBUG - Setting up libimage-exiftool-perl (11.16-1) ...
2021-03-09 00:18:22,656: DEBUG - Setting up libposix-strptime-perl (0.13-1+b5) ...
2021-03-09 00:18:22,656: DEBUG - Setting up netpbm (2:10.0-15.3+b2) ...
2021-03-09 00:18:22,756: DEBUG - Setting up liblqr-1-0:amd64 (0.4.2-2.1) ...
2021-03-09 00:18:22,756: DEBUG - Setting up libmime-charset-perl (1.012.2-1) ...
2021-03-09 00:18:22,757: DEBUG - Setting up libdjvulibre-text (3.5.27.1-10) ...
2021-03-09 00:18:22,757: DEBUG - Setting up libde265-0:amd64 (1.0.3-1+b1) ...
2021-03-09 00:18:22,757: DEBUG - Setting up libtinfo5:amd64 (6.1+20181013-2+deb10u2) ...
2021-03-09 00:18:22,757: DEBUG - Setting up libjxr-tools (1.1-6+b1) ...
2021-03-09 00:18:22,757: DEBUG - Setting up libheif1:amd64 (1.3.2-2~deb10u1) ...
2021-03-09 00:18:22,757: DEBUG - Setting up libdjvulibre21:amd64 (3.5.27.1-10) ...
2021-03-09 00:18:22,757: DEBUG - Setting up libncurses5:amd64 (6.1+20181013-2+deb10u2) ...
2021-03-09 00:18:22,757: DEBUG - Setting up libmagickcore-6.q16-6:amd64 (8:6.9.10.23+dfsg-2.1+deb10u1) ...
2021-03-09 00:18:22,758: DEBUG - Setting up libunicode-linebreak-perl (0.0.20190101-1) ...
2021-03-09 00:18:22,758: DEBUG - Setting up libmagickwand-6.q16-6:amd64 (8:6.9.10.23+dfsg-2.1+deb10u1) ...
2021-03-09 00:18:22,758: DEBUG - Setting up libmagickcore-6.q16-6-extra:amd64 (8:6.9.10.23+dfsg-2.1+deb10u1) ...
2021-03-09 00:18:22,758: DEBUG - Setting up imagemagick-6.q16 (8:6.9.10.23+dfsg-2.1+deb10u1) ...
2021-03-09 00:18:22,758: DEBUG - update-alternatives: using /usr/bin/compare-im6.q16 to provide /usr/bin/compare (compare) in auto mode
2021-03-09 00:18:22,758: DEBUG - update-alternatives: using /usr/bin/compare-im6.q16 to provide /usr/bin/compare-im6 (compare-im6) in auto mode
2021-03-09 00:18:22,758: DEBUG - update-alternatives: using /usr/bin/animate-im6.q16 to provide /usr/bin/animate (animate) in auto mode
2021-03-09 00:18:22,759: DEBUG - update-alternatives: using /usr/bin/animate-im6.q16 to provide /usr/bin/animate-im6 (animate-im6) in auto mode
2021-03-09 00:18:22,759: DEBUG - update-alternatives: using /usr/bin/convert-im6.q16 to provide /usr/bin/convert (convert) in auto mode
2021-03-09 00:18:22,759: DEBUG - update-alternatives: using /usr/bin/convert-im6.q16 to provide /usr/bin/convert-im6 (convert-im6) in auto mode
2021-03-09 00:18:22,759: DEBUG - update-alternatives: using /usr/bin/composite-im6.q16 to provide /usr/bin/composite (composite) in auto mode
2021-03-09 00:18:22,860: DEBUG - update-alternatives: using /usr/bin/composite-im6.q16 to provide /usr/bin/composite-im6 (composite-im6) in auto mode
2021-03-09 00:18:22,860: DEBUG - update-alternatives: using /usr/bin/conjure-im6.q16 to provide /usr/bin/conjure (conjure) in auto mode
2021-03-09 00:18:22,860: DEBUG - update-alternatives: using /usr/bin/conjure-im6.q16 to provide /usr/bin/conjure-im6 (conjure-im6) in auto mode
2021-03-09 00:18:22,860: DEBUG - update-alternatives: using /usr/bin/import-im6.q16 to provide /usr/bin/import (import) in auto mode
2021-03-09 00:18:22,860: DEBUG - update-alternatives: using /usr/bin/import-im6.q16 to provide /usr/bin/import-im6 (import-im6) in auto mode
2021-03-09 00:18:22,860: DEBUG - update-alternatives: using /usr/bin/identify-im6.q16 to provide /usr/bin/identify (identify) in auto mode
2021-03-09 00:18:22,860: DEBUG - update-alternatives: using /usr/bin/identify-im6.q16 to provide /usr/bin/identify-im6 (identify-im6) in auto mode
2021-03-09 00:18:22,861: DEBUG - update-alternatives: using /usr/bin/stream-im6.q16 to provide /usr/bin/stream (stream) in auto mode
2021-03-09 00:18:22,861: DEBUG - update-alternatives: using /usr/bin/stream-im6.q16 to provide /usr/bin/stream-im6 (stream-im6) in auto mode
2021-03-09 00:18:22,861: DEBUG - update-alternatives: using /usr/bin/display-im6.q16 to provide /usr/bin/display (display) in auto mode
2021-03-09 00:18:22,861: DEBUG - update-alternatives: using /usr/bin/display-im6.q16 to provide /usr/bin/display-im6 (display-im6) in auto mode
2021-03-09 00:18:22,861: DEBUG - update-alternatives: using /usr/bin/montage-im6.q16 to provide /usr/bin/montage (montage) in auto mode
2021-03-09 00:18:22,861: DEBUG - update-alternatives: using /usr/bin/montage-im6.q16 to provide /usr/bin/montage-im6 (montage-im6) in auto mode
2021-03-09 00:18:22,861: DEBUG - update-alternatives: using /usr/bin/mogrify-im6.q16 to provide /usr/bin/mogrify (mogrify) in auto mode
2021-03-09 00:18:22,861: DEBUG - update-alternatives: using /usr/bin/mogrify-im6.q16 to provide /usr/bin/mogrify-im6 (mogrify-im6) in auto mode
2021-03-09 00:18:22,861: DEBUG - Setting up imagemagick (8:6.9.10.23+dfsg-2.1+deb10u1) ...
2021-03-09 00:18:22,962: DEBUG - Processing triggers for libc-bin (2.28-10) ...
2021-03-09 00:18:22,962: DEBUG - Processing triggers for man-db (2.8.5-2) ...
2021-03-09 00:18:28,781: DEBUG - Processing triggers for mime-support (3.62) ...
2021-03-09 00:18:29,082: DEBUG - + [[ -n /tmp/tmp.MUpZCPfa3l ]]
2021-03-09 00:18:29,082: DEBUG - + rm --recursive --force /tmp/tmp.MUpZCPfa3l
2021-03-09 00:18:29,082: DEBUG - + ynh_package_is_installed pleroma-ynh-deps
2021-03-09 00:18:29,083: DEBUG - + ynh_wait_dpkg_free
2021-03-09 00:18:29,184: DEBUG - + return 0
2021-03-09 00:18:29,184: DEBUG - + grep --count 'ok installed'
2021-03-09 00:18:29,184: DEBUG - + dpkg-query --show '--showformat=${Status}' pleroma-ynh-deps
2021-03-09 00:18:29,285: DEBUG - + rm /tmp/pleroma-ynh-deps.control
2021-03-09 00:18:29,285: DEBUG - + ynh_app_setting_set --app=pleroma --key=apt_dependencies '--value=curl, unzip, libncurses5, postgresql, postgresql-contrib, imagemagick, ffmpeg, exiftool, libimage-exiftool-perl'
2021-03-09 00:18:29,286: DEBUG - + [[ apt_dependencies =~ (unprotected|protected|skipped)_ ]]
2021-03-09 00:18:29,286: DEBUG - + ynh_app_setting set pleroma apt_dependencies 'curl, unzip, libncurses5, postgresql, postgresql-contrib, imagemagick, ffmpeg, exiftool, libimage-exiftool-perl'
2021-03-09 00:18:29,487: DEBUG - + echo '[############+.......] > Restoring the PostgreSQL database...'
2021-03-09 00:18:29,488: DEBUG - + ynh_psql_test_if_first_run
2021-03-09 00:18:29,488: DEBUG - + grep -q 'ii  postgresql-11'
2021-03-09 00:18:29,488: DEBUG - + dpkg --list
2021-03-09 00:18:29,488: DEBUG - + '[' -e /etc/postgresql/11 ']'
2021-03-09 00:18:29,488: DEBUG - + systemctl is-active postgresql@11-main -q
2021-03-09 00:18:29,488: DEBUG - + systemctl is-enabled postgresql -q
2021-03-09 00:18:29,588: DEBUG - + '[' '!' -f /etc/yunohost/psql ']'
2021-03-09 00:18:29,589: INFO - [############+.......] > Restoring the PostgreSQL database...
2021-03-09 00:18:29,590: DEBUG - + ynh_psql_setup_db --db_user=pleroma --db_name=pleroma --db_pwd=**********
2021-03-09 00:18:29,591: DEBUG - + db_pwd=
2021-03-09 00:18:29,591: DEBUG - + ynh_psql_user_exists --user=pleroma
2021-03-09 00:18:29,592: DEBUG - + grep --quiet pleroma
2021-03-09 00:18:29,592: DEBUG - ++ cat /etc/yunohost/psql
2021-03-09 00:18:29,592: DEBUG - + sudo --login --user=postgres PGUSER=postgres PGPASSWORD=********** psql -tAc 'SELECT rolname FROM pg_roles WHERE rolname='\''pleroma'\'';'
2021-03-09 00:18:29,793: DEBUG - + return 1
2021-03-09 00:18:29,794: DEBUG - ++ ynh_string_random
2021-03-09 00:18:29,794: DEBUG - ++ length=24
2021-03-09 00:18:29,794: DEBUG - ++ sed --quiet 's/\(.\{24\}\).*/\1/p'
2021-03-09 00:18:29,794: DEBUG - ++ tr --complement --delete A-Za-z0-9
2021-03-09 00:18:29,794: DEBUG - ++ dd if=/dev/urandom bs=1 count=1000
2021-03-09 00:18:29,795: DEBUG - + local new_db_pwd=**********
2021-03-09 00:18:29,795: DEBUG - + db_pwd=**********
2021-03-09 00:18:29,795: DEBUG - + ynh_psql_create_user pleroma **********
2021-03-09 00:18:29,795: DEBUG - + local user=pleroma
2021-03-09 00:18:29,795: DEBUG - + local pwd=**********
2021-03-09 00:18:29,795: DEBUG - + ynh_psql_execute_as_root '--sql=CREATE USER pleroma WITH ENCRYPTED PASSWORD '\''**********'\'''
2021-03-09 00:18:29,795: DEBUG - + database=
2021-03-09 00:18:29,795: DEBUG - + '[' -n '' ']'
2021-03-09 00:18:29,796: DEBUG - ++ cat /etc/yunohost/psql
2021-03-09 00:18:29,796: DEBUG - + ynh_psql_connect_as --user=postgres --password=**********
2021-03-09 00:18:29,796: DEBUG - + database=
2021-03-09 00:18:29,797: DEBUG - + sudo --login --user=postgres PGUSER=postgres PGPASSWORD=********** psql ''
2021-03-09 00:18:29,897: DEBUG - CREATE ROLE
2021-03-09 00:18:29,897: DEBUG - + ynh_psql_create_db pleroma pleroma
2021-03-09 00:18:29,898: DEBUG - + local db=pleroma
2021-03-09 00:18:29,898: DEBUG - + local user=pleroma
2021-03-09 00:18:29,898: DEBUG - + local 'sql=CREATE DATABASE pleroma;'
2021-03-09 00:18:29,898: DEBUG - + '[' -n pleroma ']'
2021-03-09 00:18:29,898: DEBUG - + sql+='ALTER DATABASE pleroma OWNER TO pleroma;'
2021-03-09 00:18:29,898: DEBUG - + sql+='GRANT ALL PRIVILEGES ON DATABASE pleroma TO pleroma WITH GRANT OPTION;'
2021-03-09 00:18:29,898: DEBUG - + ynh_psql_execute_as_root '--sql=CREATE DATABASE pleroma;ALTER DATABASE pleroma OWNER TO pleroma;GRANT ALL PRIVILEGES ON DATABASE pleroma TO pleroma WITH GRANT OPTION;'
2021-03-09 00:18:29,999: DEBUG - + database=
2021-03-09 00:18:29,999: DEBUG - + '[' -n '' ']'
2021-03-09 00:18:30,000: DEBUG - ++ cat /etc/yunohost/psql
2021-03-09 00:18:30,000: DEBUG - + ynh_psql_connect_as --user=postgres --password=**********
2021-03-09 00:18:30,001: DEBUG - + database=
2021-03-09 00:18:30,001: DEBUG - + sudo --login --user=postgres PGUSER=postgres PGPASSWORD=********** psql ''
2021-03-09 00:18:30,403: DEBUG - CREATE DATABASE
2021-03-09 00:18:30,403: DEBUG - ALTER DATABASE
2021-03-09 00:18:30,403: DEBUG - GRANT
2021-03-09 00:18:30,504: DEBUG - + ynh_app_setting_set --app=pleroma --key=psqlpwd --value=**********
2021-03-09 00:18:30,505: DEBUG - + [[ psqlpwd =~ (unprotected|protected|skipped)_ ]]
2021-03-09 00:18:30,505: DEBUG - + ynh_app_setting set pleroma psqlpwd **********
2021-03-09 00:18:30,706: DEBUG - + ynh_psql_execute_as_root '--sql=CREATE EXTENSION IF NOT EXISTS unaccent;' --database=pleroma
2021-03-09 00:18:30,707: DEBUG - + database=pleroma
2021-03-09 00:18:30,707: DEBUG - + '[' -n pleroma ']'
2021-03-09 00:18:30,707: DEBUG - + database=--database=pleroma
2021-03-09 00:18:30,707: DEBUG - ++ cat /etc/yunohost/psql
2021-03-09 00:18:30,707: DEBUG - + ynh_psql_connect_as --user=postgres --password=********** --database=pleroma
2021-03-09 00:18:30,808: DEBUG - + database=pleroma
2021-03-09 00:18:30,808: DEBUG - + sudo --login --user=postgres PGUSER=postgres PGPASSWORD=********** psql pleroma
2021-03-09 00:18:30,909: DEBUG - CREATE EXTENSION
2021-03-09 00:18:30,909: DEBUG - + ynh_psql_execute_as_root '--sql=CREATE EXTENSION IF NOT EXISTS pg_trgm;' --database=pleroma
2021-03-09 00:18:30,910: DEBUG - + database=pleroma
2021-03-09 00:18:30,910: DEBUG - + '[' -n pleroma ']'
2021-03-09 00:18:30,910: DEBUG - + database=--database=pleroma
2021-03-09 00:18:30,910: DEBUG - ++ cat /etc/yunohost/psql
2021-03-09 00:18:30,910: DEBUG - + ynh_psql_connect_as --user=postgres --password=********** --database=pleroma
2021-03-09 00:18:31,011: DEBUG - + database=pleroma
2021-03-09 00:18:31,011: DEBUG - + sudo --login --user=postgres PGUSER=postgres PGPASSWORD=********** psql pleroma
2021-03-09 00:18:31,112: DEBUG - CREATE EXTENSION
2021-03-09 00:18:31,112: DEBUG - + ynh_psql_execute_as_root '--sql=CREATE EXTENSION IF NOT EXISTS citext;' --database=pleroma
2021-03-09 00:18:31,113: DEBUG - + database=pleroma
2021-03-09 00:18:31,113: DEBUG - + '[' -n pleroma ']'
2021-03-09 00:18:31,113: DEBUG - + database=--database=pleroma
2021-03-09 00:18:31,113: DEBUG - ++ cat /etc/yunohost/psql
2021-03-09 00:18:31,113: DEBUG - + ynh_psql_connect_as --user=postgres --password=********** --database=pleroma
2021-03-09 00:18:31,214: DEBUG - + database=pleroma
2021-03-09 00:18:31,214: DEBUG - + sudo --login --user=postgres PGUSER=postgres PGPASSWORD=********** psql pleroma
2021-03-09 00:18:31,315: DEBUG - CREATE EXTENSION
2021-03-09 00:18:31,315: DEBUG - + ynh_psql_execute_as_root '--sql=CREATE EXTENSION IF NOT EXISTS "uuid-ossp";' --database=pleroma
2021-03-09 00:18:31,316: DEBUG - + database=pleroma
2021-03-09 00:18:31,316: DEBUG - + '[' -n pleroma ']'
2021-03-09 00:18:31,316: DEBUG - + database=--database=pleroma
2021-03-09 00:18:31,316: DEBUG - ++ cat /etc/yunohost/psql
2021-03-09 00:18:31,316: DEBUG - + ynh_psql_connect_as --user=postgres --password=********** --database=pleroma
2021-03-09 00:18:31,417: DEBUG - + database=pleroma
2021-03-09 00:18:31,417: DEBUG - + sudo --login --user=postgres PGUSER=postgres PGPASSWORD=********** psql pleroma
2021-03-09 00:18:31,518: DEBUG - CREATE EXTENSION
2021-03-09 00:18:31,518: DEBUG - + ynh_psql_execute_file_as_root --file=./db.sql --database=pleroma
2021-03-09 00:18:31,519: DEBUG - + database=pleroma
2021-03-09 00:18:31,519: DEBUG - + '[' -n pleroma ']'
2021-03-09 00:18:31,519: DEBUG - + database=--database=pleroma
2021-03-09 00:18:31,519: DEBUG - ++ cat /etc/yunohost/psql
2021-03-09 00:18:31,519: DEBUG - + ynh_psql_connect_as --user=postgres --password=********** --database=pleroma
2021-03-09 00:18:31,621: DEBUG - + database=pleroma
2021-03-09 00:18:31,622: DEBUG - + sudo --login --user=postgres PGUSER=postgres PGPASSWORD=********** psql pleroma
2021-03-09 00:18:31,722: DEBUG - SET
2021-03-09 00:18:31,722: DEBUG - SET
2021-03-09 00:18:31,722: DEBUG - SET
2021-03-09 00:18:31,722: DEBUG - SET
2021-03-09 00:18:31,722: DEBUG - SET
2021-03-09 00:18:31,722: DEBUG -  set_config
2021-03-09 00:18:31,723: DEBUG - ------------
2021-03-09 00:18:31,723: DEBUG - 
2021-03-09 00:18:31,723: DEBUG - (1 row)
2021-03-09 00:18:31,723: DEBUG - 
2021-03-09 00:18:31,723: DEBUG - SET
2021-03-09 00:18:31,723: DEBUG - SET
2021-03-09 00:18:31,723: DEBUG - SET
2021-03-09 00:18:31,723: DEBUG - SET
2021-03-09 00:18:31,723: DEBUG - CREATE EXTENSION
2021-03-09 00:18:31,723: DEBUG - COMMENT
2021-03-09 00:18:31,723: DEBUG - CREATE EXTENSION
2021-03-09 00:18:31,723: DEBUG - COMMENT
2021-03-09 00:18:31,723: DEBUG - CREATE EXTENSION
2021-03-09 00:18:31,723: DEBUG - COMMENT
2021-03-09 00:18:31,724: DEBUG - CREATE EXTENSION
2021-03-09 00:18:31,724: DEBUG - COMMENT
2021-03-09 00:18:31,724: DEBUG - CREATE TYPE
2021-03-09 00:18:31,724: DEBUG - ALTER TYPE
2021-03-09 00:18:31,724: DEBUG - CREATE TYPE
2021-03-09 00:18:31,724: DEBUG - ALTER TYPE
2021-03-09 00:18:31,724: DEBUG - CREATE FUNCTION
2021-03-09 00:18:31,724: DEBUG - ALTER FUNCTION
2021-03-09 00:18:31,724: DEBUG - CREATE FUNCTION
2021-03-09 00:18:31,724: DEBUG - ALTER FUNCTION
2021-03-09 00:18:31,724: DEBUG - CREATE FUNCTION
2021-03-09 00:18:31,724: DEBUG - ALTER FUNCTION
2021-03-09 00:18:31,724: DEBUG - CREATE FUNCTION
2021-03-09 00:18:31,725: DEBUG - ALTER FUNCTION
2021-03-09 00:18:31,725: DEBUG - CREATE FUNCTION
2021-03-09 00:18:31,725: DEBUG - ALTER FUNCTION
2021-03-09 00:18:31,725: DEBUG - CREATE FUNCTION
2021-03-09 00:18:31,725: DEBUG - ALTER FUNCTION
2021-03-09 00:18:31,725: DEBUG - SET
2021-03-09 00:18:31,725: DEBUG - SET
2021-03-09 00:18:31,725: DEBUG - CREATE TABLE
2021-03-09 00:18:31,725: DEBUG - ALTER TABLE
2021-03-09 00:18:31,725: DEBUG - CREATE SEQUENCE
2021-03-09 00:18:31,725: DEBUG - ALTER TABLE
2021-03-09 00:18:31,725: DEBUG - ALTER SEQUENCE
2021-03-09 00:18:31,726: DEBUG - CREATE TABLE
2021-03-09 00:18:31,726: DEBUG - ALTER TABLE
2021-03-09 00:18:31,726: DEBUG - CREATE SEQUENCE
2021-03-09 00:18:31,726: DEBUG - ALTER TABLE
2021-03-09 00:18:31,726: DEBUG - ALTER SEQUENCE
2021-03-09 00:18:31,726: DEBUG - CREATE TABLE
2021-03-09 00:18:31,726: DEBUG - ALTER TABLE
2021-03-09 00:18:31,726: DEBUG - CREATE SEQUENCE
2021-03-09 00:18:31,727: DEBUG - ALTER TABLE
2021-03-09 00:18:31,727: DEBUG - ALTER SEQUENCE
2021-03-09 00:18:31,727: DEBUG - CREATE TABLE
2021-03-09 00:18:31,727: DEBUG - ALTER TABLE
2021-03-09 00:18:31,727: DEBUG - CREATE TABLE
2021-03-09 00:18:31,727: DEBUG - ALTER TABLE
2021-03-09 00:18:31,727: DEBUG - CREATE SEQUENCE
2021-03-09 00:18:31,727: DEBUG - ALTER TABLE
2021-03-09 00:18:31,727: DEBUG - ALTER SEQUENCE
2021-03-09 00:18:31,728: DEBUG - CREATE TABLE
2021-03-09 00:18:31,728: DEBUG - ALTER TABLE
2021-03-09 00:18:31,728: DEBUG - CREATE SEQUENCE
2021-03-09 00:18:31,729: DEBUG - ALTER TABLE
2021-03-09 00:18:31,729: DEBUG - ALTER SEQUENCE
2021-03-09 00:18:31,730: DEBUG - CREATE TABLE
2021-03-09 00:18:31,730: DEBUG - ALTER TABLE
2021-03-09 00:18:31,731: DEBUG - CREATE SEQUENCE
2021-03-09 00:18:31,731: DEBUG - ALTER TABLE
2021-03-09 00:18:31,732: DEBUG - ALTER SEQUENCE
2021-03-09 00:18:31,732: DEBUG - CREATE TABLE
2021-03-09 00:18:31,732: DEBUG - ALTER TABLE
2021-03-09 00:18:31,732: DEBUG - CREATE SEQUENCE
2021-03-09 00:18:31,733: DEBUG - ALTER TABLE
2021-03-09 00:18:31,733: DEBUG - ALTER SEQUENCE
2021-03-09 00:18:31,734: DEBUG - CREATE TABLE
2021-03-09 00:18:31,734: DEBUG - ALTER TABLE
2021-03-09 00:18:31,734: DEBUG - CREATE SEQUENCE
2021-03-09 00:18:31,735: DEBUG - ALTER TABLE
2021-03-09 00:18:31,736: DEBUG - ALTER SEQUENCE
2021-03-09 00:18:31,736: DEBUG - CREATE TABLE
2021-03-09 00:18:31,738: DEBUG - ALTER TABLE
2021-03-09 00:18:31,738: DEBUG - CREATE SEQUENCE
2021-03-09 00:18:31,738: DEBUG - ALTER TABLE
2021-03-09 00:18:31,738: DEBUG - ALTER SEQUENCE
2021-03-09 00:18:31,738: DEBUG - CREATE TABLE
2021-03-09 00:18:31,738: DEBUG - ALTER TABLE
2021-03-09 00:18:31,739: DEBUG - CREATE SEQUENCE
2021-03-09 00:18:31,739: DEBUG - ALTER TABLE
2021-03-09 00:18:31,739: DEBUG - ALTER SEQUENCE
2021-03-09 00:18:31,839: DEBUG - CREATE TABLE
2021-03-09 00:18:31,840: DEBUG - ALTER TABLE
2021-03-09 00:18:31,840: DEBUG - CREATE SEQUENCE
2021-03-09 00:18:31,840: DEBUG - ALTER TABLE
2021-03-09 00:18:31,840: DEBUG - ALTER SEQUENCE
2021-03-09 00:18:31,840: DEBUG - CREATE TABLE
2021-03-09 00:18:31,840: DEBUG - ALTER TABLE
2021-03-09 00:18:31,840: DEBUG - CREATE SEQUENCE
2021-03-09 00:18:31,841: DEBUG - ALTER TABLE
2021-03-09 00:18:31,841: DEBUG - ALTER SEQUENCE
2021-03-09 00:18:31,841: DEBUG - CREATE TABLE
2021-03-09 00:18:31,841: DEBUG - ALTER TABLE
2021-03-09 00:18:31,841: DEBUG - CREATE SEQUENCE
2021-03-09 00:18:31,841: DEBUG - ALTER TABLE
2021-03-09 00:18:31,841: DEBUG - ALTER SEQUENCE
2021-03-09 00:18:31,841: DEBUG - CREATE TABLE
2021-03-09 00:18:31,841: DEBUG - ALTER TABLE
2021-03-09 00:18:31,841: DEBUG - CREATE SEQUENCE
2021-03-09 00:18:31,842: DEBUG - ALTER TABLE
2021-03-09 00:18:31,842: DEBUG - ALTER SEQUENCE
2021-03-09 00:18:31,842: DEBUG - CREATE TABLE
2021-03-09 00:18:31,842: DEBUG - ALTER TABLE
2021-03-09 00:18:31,842: DEBUG - CREATE SEQUENCE
2021-03-09 00:18:31,842: DEBUG - ALTER TABLE
2021-03-09 00:18:31,842: DEBUG - ALTER SEQUENCE
2021-03-09 00:18:31,842: DEBUG - CREATE TABLE
2021-03-09 00:18:31,842: DEBUG - ALTER TABLE
2021-03-09 00:18:31,842: DEBUG - CREATE SEQUENCE
2021-03-09 00:18:31,843: DEBUG - ALTER TABLE
2021-03-09 00:18:31,843: DEBUG - ALTER SEQUENCE
2021-03-09 00:18:31,843: DEBUG - CREATE TABLE
2021-03-09 00:18:31,843: DEBUG - ALTER TABLE
2021-03-09 00:18:31,843: DEBUG - CREATE SEQUENCE
2021-03-09 00:18:31,843: DEBUG - ALTER TABLE
2021-03-09 00:18:31,843: DEBUG - ALTER SEQUENCE
2021-03-09 00:18:31,843: DEBUG - CREATE TABLE
2021-03-09 00:18:31,844: DEBUG - ALTER TABLE
2021-03-09 00:18:31,844: DEBUG - CREATE SEQUENCE
2021-03-09 00:18:31,844: DEBUG - ALTER TABLE
2021-03-09 00:18:31,844: DEBUG - ALTER SEQUENCE
2021-03-09 00:18:31,846: DEBUG - CREATE TABLE
2021-03-09 00:18:31,846: DEBUG - ALTER TABLE
2021-03-09 00:18:31,846: DEBUG - CREATE SEQUENCE
2021-03-09 00:18:31,846: DEBUG - ALTER TABLE
2021-03-09 00:18:31,846: DEBUG - ALTER SEQUENCE
2021-03-09 00:18:31,846: DEBUG - CREATE TABLE
2021-03-09 00:18:31,847: DEBUG - ALTER TABLE
2021-03-09 00:18:31,847: DEBUG - CREATE SEQUENCE
2021-03-09 00:18:31,847: DEBUG - ALTER TABLE
2021-03-09 00:18:31,847: DEBUG - ALTER SEQUENCE
2021-03-09 00:18:31,847: DEBUG - CREATE TABLE
2021-03-09 00:18:31,847: DEBUG - ALTER TABLE
2021-03-09 00:18:31,847: DEBUG - CREATE TABLE
2021-03-09 00:18:31,847: DEBUG - ALTER TABLE
2021-03-09 00:18:31,847: DEBUG - COMMENT
2021-03-09 00:18:31,848: DEBUG - CREATE SEQUENCE
2021-03-09 00:18:31,848: DEBUG - ALTER TABLE
2021-03-09 00:18:31,848: DEBUG - ALTER SEQUENCE
2021-03-09 00:18:31,848: DEBUG - CREATE TABLE
2021-03-09 00:18:31,848: DEBUG - ALTER TABLE
2021-03-09 00:18:31,849: DEBUG - CREATE SEQUENCE
2021-03-09 00:18:31,850: DEBUG - ALTER TABLE
2021-03-09 00:18:31,851: DEBUG - ALTER SEQUENCE
2021-03-09 00:18:31,851: DEBUG - CREATE TABLE
2021-03-09 00:18:31,852: DEBUG - ALTER TABLE
2021-03-09 00:18:31,852: DEBUG - CREATE SEQUENCE
2021-03-09 00:18:31,852: DEBUG - ALTER TABLE
2021-03-09 00:18:31,853: DEBUG - ALTER SEQUENCE
2021-03-09 00:18:31,854: DEBUG - CREATE TABLE
2021-03-09 00:18:31,854: DEBUG - ALTER TABLE
2021-03-09 00:18:31,854: DEBUG - CREATE SEQUENCE
2021-03-09 00:18:31,854: DEBUG - ALTER TABLE
2021-03-09 00:18:31,855: DEBUG - ALTER SEQUENCE
2021-03-09 00:18:31,855: DEBUG - CREATE TABLE
2021-03-09 00:18:31,856: DEBUG - ALTER TABLE
2021-03-09 00:18:31,857: DEBUG - CREATE TABLE
2021-03-09 00:18:31,857: DEBUG - ALTER TABLE
2021-03-09 00:18:31,860: DEBUG - CREATE SEQUENCE
2021-03-09 00:18:31,860: DEBUG - ALTER TABLE
2021-03-09 00:18:31,860: DEBUG - ALTER SEQUENCE
2021-03-09 00:18:31,861: DEBUG - CREATE TABLE
2021-03-09 00:18:31,861: DEBUG - ALTER TABLE
2021-03-09 00:18:31,861: DEBUG - CREATE SEQUENCE
2021-03-09 00:18:31,861: DEBUG - ALTER TABLE
2021-03-09 00:18:31,861: DEBUG - ALTER SEQUENCE
2021-03-09 00:18:31,861: DEBUG - CREATE TABLE
2021-03-09 00:18:31,861: DEBUG - ALTER TABLE
2021-03-09 00:18:31,862: DEBUG - CREATE TABLE
2021-03-09 00:18:31,862: DEBUG - ALTER TABLE
2021-03-09 00:18:31,862: DEBUG - CREATE SEQUENCE
2021-03-09 00:18:31,862: DEBUG - ALTER TABLE
2021-03-09 00:18:31,862: DEBUG - ALTER SEQUENCE
2021-03-09 00:18:31,862: DEBUG - CREATE TABLE
2021-03-09 00:18:31,862: DEBUG - ALTER TABLE
2021-03-09 00:18:31,862: DEBUG - CREATE SEQUENCE
2021-03-09 00:18:31,863: DEBUG - ALTER TABLE
2021-03-09 00:18:31,863: DEBUG - ALTER SEQUENCE
2021-03-09 00:18:31,863: DEBUG - CREATE TABLE
2021-03-09 00:18:31,863: DEBUG - ALTER TABLE
2021-03-09 00:18:31,863: DEBUG - CREATE SEQUENCE
2021-03-09 00:18:31,863: DEBUG - ALTER TABLE
2021-03-09 00:18:31,863: DEBUG - ALTER SEQUENCE
2021-03-09 00:18:31,964: DEBUG - CREATE TABLE
2021-03-09 00:18:31,964: DEBUG - ALTER TABLE
2021-03-09 00:18:31,964: DEBUG - CREATE SEQUENCE
2021-03-09 00:18:31,964: DEBUG - ALTER TABLE
2021-03-09 00:18:31,964: DEBUG - ALTER SEQUENCE
2021-03-09 00:18:31,964: DEBUG - ALTER TABLE
2021-03-09 00:18:31,964: DEBUG - ALTER TABLE
2021-03-09 00:18:31,965: DEBUG - ALTER TABLE
2021-03-09 00:18:31,965: DEBUG - ALTER TABLE
2021-03-09 00:18:31,965: DEBUG - ALTER TABLE
2021-03-09 00:18:31,965: DEBUG - ALTER TABLE
2021-03-09 00:18:31,965: DEBUG - ALTER TABLE
2021-03-09 00:18:31,965: DEBUG - ALTER TABLE
2021-03-09 00:18:31,965: DEBUG - ALTER TABLE
2021-03-09 00:18:31,965: DEBUG - ALTER TABLE
2021-03-09 00:18:31,965: DEBUG - ALTER TABLE
2021-03-09 00:18:31,965: DEBUG - ALTER TABLE
2021-03-09 00:18:31,965: DEBUG - ALTER TABLE
2021-03-09 00:18:31,965: DEBUG - ALTER TABLE
2021-03-09 00:18:31,965: DEBUG - ALTER TABLE
2021-03-09 00:18:31,965: DEBUG - ALTER TABLE
2021-03-09 00:18:31,965: DEBUG - ALTER TABLE
2021-03-09 00:18:31,965: DEBUG - ALTER TABLE
2021-03-09 00:18:31,966: DEBUG - ALTER TABLE
2021-03-09 00:18:31,966: DEBUG - ALTER TABLE
2021-03-09 00:18:31,966: DEBUG - ALTER TABLE
2021-03-09 00:18:31,966: DEBUG - ALTER TABLE
2021-03-09 00:18:31,966: DEBUG - ALTER TABLE
2021-03-09 00:18:31,966: DEBUG - ALTER TABLE
2021-03-09 00:18:31,966: DEBUG - ALTER TABLE
2021-03-09 00:18:31,966: DEBUG - ALTER TABLE
2021-03-09 00:18:31,966: DEBUG - ALTER TABLE
2021-03-09 00:19:06,207: DEBUG - COPY 875184
2021-03-09 00:19:06,209: DEBUG - COPY 354
2021-03-09 00:19:06,209: DEBUG - COPY 0
2021-03-09 00:19:06,209: DEBUG - COPY 0
2021-03-09 00:19:06,209: DEBUG - COPY 0
2021-03-09 00:19:06,209: DEBUG - COPY 2
2021-03-09 00:19:06,209: DEBUG - COPY 1765
2021-03-09 00:19:06,209: DEBUG - COPY 192
2021-03-09 00:19:06,209: DEBUG - COPY 26
2021-03-09 00:19:06,209: DEBUG - COPY 1235
2021-03-09 00:19:06,310: DEBUG - COPY 52761
2021-03-09 00:19:06,310: DEBUG - COPY 0
2021-03-09 00:19:06,310: DEBUG - COPY 164
2021-03-09 00:19:06,310: DEBUG - COPY 53
2021-03-09 00:19:06,310: DEBUG - COPY 0
2021-03-09 00:19:06,310: DEBUG - COPY 1
2021-03-09 00:19:06,311: DEBUG - COPY 0
2021-03-09 00:19:06,311: DEBUG - COPY 1
2021-03-09 00:19:06,311: DEBUG - COPY 2112
2021-03-09 00:19:06,311: DEBUG - COPY 867
2021-03-09 00:19:06,411: DEBUG - COPY 867
2021-03-09 00:19:06,512: DEBUG - COPY 39843
2021-03-09 00:19:06,512: DEBUG - COPY 41
2021-03-09 00:19:56,591: DEBUG - COPY 723357
2021-03-09 00:19:56,593: DEBUG - COPY 0
2021-03-09 00:19:56,594: DEBUG - COPY 0
2021-03-09 00:19:56,594: DEBUG - COPY 0
2021-03-09 00:19:56,594: DEBUG - COPY 0
2021-03-09 00:19:56,594: DEBUG - COPY 0
2021-03-09 00:19:56,594: DEBUG - COPY 239
2021-03-09 00:19:56,594: DEBUG - COPY 6
2021-03-09 00:19:56,594: DEBUG - COPY 0
2021-03-09 00:19:56,594: DEBUG - COPY 29
2021-03-09 00:19:57,496: DEBUG - COPY 15609
2021-03-09 00:19:57,497: DEBUG -  setval
2021-03-09 00:19:57,497: DEBUG - --------
2021-03-09 00:19:57,497: DEBUG -       1
2021-03-09 00:19:57,497: DEBUG - (1 row)
2021-03-09 00:19:57,497: DEBUG - 
2021-03-09 00:19:57,497: DEBUG -  setval
2021-03-09 00:19:57,498: DEBUG - --------
2021-03-09 00:19:57,498: DEBUG -     354
2021-03-09 00:19:57,498: DEBUG - (1 row)
2021-03-09 00:19:57,498: DEBUG - 
2021-03-09 00:19:57,498: DEBUG -  setval
2021-03-09 00:19:57,498: DEBUG - --------
2021-03-09 00:19:57,498: DEBUG -       1
2021-03-09 00:19:57,498: DEBUG - (1 row)
2021-03-09 00:19:57,498: DEBUG - 
2021-03-09 00:19:57,498: DEBUG -  setval
2021-03-09 00:19:57,498: DEBUG - --------
2021-03-09 00:19:57,498: DEBUG -       1
2021-03-09 00:19:57,498: DEBUG - (1 row)
2021-03-09 00:19:57,498: DEBUG - 
2021-03-09 00:19:57,499: DEBUG -  setval
2021-03-09 00:19:57,499: DEBUG - --------
2021-03-09 00:19:57,499: DEBUG -       2
2021-03-09 00:19:57,499: DEBUG - (1 row)
2021-03-09 00:19:57,499: DEBUG - 
2021-03-09 00:19:57,499: DEBUG -  setval
2021-03-09 00:19:57,499: DEBUG - --------
2021-03-09 00:19:57,499: DEBUG -    1765
2021-03-09 00:19:57,499: DEBUG - (1 row)
2021-03-09 00:19:57,499: DEBUG - 
2021-03-09 00:19:57,499: DEBUG -  setval
2021-03-09 00:19:57,499: DEBUG - --------
2021-03-09 00:19:57,500: DEBUG -     336
2021-03-09 00:19:57,500: DEBUG - (1 row)
2021-03-09 00:19:57,500: DEBUG - 
2021-03-09 00:19:57,500: DEBUG -  setval
2021-03-09 00:19:57,500: DEBUG - --------
2021-03-09 00:19:57,500: DEBUG -      69
2021-03-09 00:19:57,500: DEBUG - (1 row)
2021-03-09 00:19:57,500: DEBUG - 
2021-03-09 00:19:57,500: DEBUG -  setval
2021-03-09 00:19:57,500: DEBUG - --------
2021-03-09 00:19:57,500: DEBUG -  420529
2021-03-09 00:19:57,500: DEBUG - (1 row)
2021-03-09 00:19:57,501: DEBUG - 
2021-03-09 00:19:57,501: DEBUG -  setval
2021-03-09 00:19:57,501: DEBUG - --------
2021-03-09 00:19:57,501: DEBUG -   64157
2021-03-09 00:19:57,501: DEBUG - (1 row)
2021-03-09 00:19:57,501: DEBUG - 
2021-03-09 00:19:57,501: DEBUG -  setval
2021-03-09 00:19:57,501: DEBUG - --------
2021-03-09 00:19:57,501: DEBUG -       1
2021-03-09 00:19:57,501: DEBUG - (1 row)
2021-03-09 00:19:57,501: DEBUG - 
2021-03-09 00:19:57,501: DEBUG -  setval
2021-03-09 00:19:57,501: DEBUG - --------
2021-03-09 00:19:57,501: DEBUG -     178
2021-03-09 00:19:57,501: DEBUG - (1 row)
2021-03-09 00:19:57,501: DEBUG - 
2021-03-09 00:19:57,502: DEBUG -  setval
2021-03-09 00:19:57,502: DEBUG - --------
2021-03-09 00:19:57,502: DEBUG -      55
2021-03-09 00:19:57,502: DEBUG - (1 row)
2021-03-09 00:19:57,502: DEBUG - 
2021-03-09 00:19:57,502: DEBUG -  setval
2021-03-09 00:19:57,502: DEBUG - --------
2021-03-09 00:19:57,502: DEBUG -       1
2021-03-09 00:19:57,502: DEBUG - (1 row)
2021-03-09 00:19:57,502: DEBUG - 
2021-03-09 00:19:57,502: DEBUG -  setval
2021-03-09 00:19:57,502: DEBUG - --------
2021-03-09 00:19:57,502: DEBUG -    2970
2021-03-09 00:19:57,502: DEBUG - (1 row)
2021-03-09 00:19:57,502: DEBUG - 
2021-03-09 00:19:57,603: DEBUG -  setval
2021-03-09 00:19:57,603: DEBUG - --------
2021-03-09 00:19:57,603: DEBUG -       1
2021-03-09 00:19:57,603: DEBUG - (1 row)
2021-03-09 00:19:57,603: DEBUG - 
2021-03-09 00:19:57,603: DEBUG -  setval
2021-03-09 00:19:57,604: DEBUG - --------
2021-03-09 00:19:57,604: DEBUG -       1
2021-03-09 00:19:57,604: DEBUG - (1 row)
2021-03-09 00:19:57,604: DEBUG - 
2021-03-09 00:19:57,604: DEBUG -  setval
2021-03-09 00:19:57,604: DEBUG - --------
2021-03-09 00:19:57,604: DEBUG -    2426
2021-03-09 00:19:57,604: DEBUG - (1 row)
2021-03-09 00:19:57,604: DEBUG - 
2021-03-09 00:19:57,604: DEBUG -  setval
2021-03-09 00:19:57,604: DEBUG - --------
2021-03-09 00:19:57,604: DEBUG -     867
2021-03-09 00:19:57,604: DEBUG - (1 row)
2021-03-09 00:19:57,604: DEBUG - 
2021-03-09 00:19:57,605: DEBUG -  setval
2021-03-09 00:19:57,605: DEBUG - --------
2021-03-09 00:19:57,605: DEBUG -     867
2021-03-09 00:19:57,605: DEBUG - (1 row)
2021-03-09 00:19:57,605: DEBUG - 
2021-03-09 00:19:57,605: DEBUG -  setval
2021-03-09 00:19:57,605: DEBUG - ---------
2021-03-09 00:19:57,605: DEBUG -  1458730
2021-03-09 00:19:57,605: DEBUG - (1 row)
2021-03-09 00:19:57,605: DEBUG - 
2021-03-09 00:19:57,605: DEBUG -  setval
2021-03-09 00:19:57,605: DEBUG - --------
2021-03-09 00:19:57,605: DEBUG -  730934
2021-03-09 00:19:57,605: DEBUG - (1 row)
2021-03-09 00:19:57,605: DEBUG - 
2021-03-09 00:19:57,605: DEBUG -  setval
2021-03-09 00:19:57,605: DEBUG - --------
2021-03-09 00:19:57,606: DEBUG -       1
2021-03-09 00:19:57,606: DEBUG - (1 row)
2021-03-09 00:19:57,606: DEBUG - 
2021-03-09 00:19:57,606: DEBUG -  setval
2021-03-09 00:19:57,606: DEBUG - --------
2021-03-09 00:19:57,606: DEBUG -       1
2021-03-09 00:19:57,606: DEBUG - (1 row)
2021-03-09 00:19:57,606: DEBUG - 
2021-03-09 00:19:57,606: DEBUG -  setval
2021-03-09 00:19:57,606: DEBUG - --------
2021-03-09 00:19:57,606: DEBUG -       1
2021-03-09 00:19:57,606: DEBUG - (1 row)
2021-03-09 00:19:57,606: DEBUG - 
2021-03-09 00:19:57,606: DEBUG -  setval
2021-03-09 00:19:57,606: DEBUG - --------
2021-03-09 00:19:57,606: DEBUG -       1
2021-03-09 00:19:57,606: DEBUG - (1 row)
2021-03-09 00:19:57,607: DEBUG - 
2021-03-09 00:19:57,607: DEBUG -  setval
2021-03-09 00:19:57,607: DEBUG - --------
2021-03-09 00:19:57,607: DEBUG -       6
2021-03-09 00:19:57,607: DEBUG - (1 row)
2021-03-09 00:19:57,607: DEBUG - 
2021-03-09 00:19:57,607: DEBUG -  setval
2021-03-09 00:19:57,607: DEBUG - --------
2021-03-09 00:19:57,607: DEBUG -       1
2021-03-09 00:19:57,607: DEBUG - (1 row)
2021-03-09 00:19:57,608: DEBUG - 
2021-03-09 00:19:57,608: DEBUG -  setval
2021-03-09 00:19:57,608: DEBUG - --------
2021-03-09 00:19:57,608: DEBUG -      34
2021-03-09 00:19:57,608: DEBUG - (1 row)
2021-03-09 00:19:57,608: DEBUG - 
2021-03-09 00:19:57,608: DEBUG -  setval
2021-03-09 00:19:57,608: DEBUG - --------
2021-03-09 00:19:57,608: DEBUG -       1
2021-03-09 00:19:57,608: DEBUG - (1 row)
2021-03-09 00:19:57,608: DEBUG - 
2021-03-09 00:20:04,532: DEBUG - ALTER TABLE
2021-03-09 00:20:04,533: DEBUG - ALTER TABLE
2021-03-09 00:20:04,533: DEBUG - ALTER TABLE
2021-03-09 00:20:04,533: DEBUG - ALTER TABLE
2021-03-09 00:20:04,533: DEBUG - ALTER TABLE
2021-03-09 00:20:04,533: DEBUG - ALTER TABLE
2021-03-09 00:20:04,533: DEBUG - ALTER TABLE
2021-03-09 00:20:04,534: DEBUG - ALTER TABLE
2021-03-09 00:20:04,534: DEBUG - ALTER TABLE
2021-03-09 00:20:04,634: DEBUG - ALTER TABLE
2021-03-09 00:20:04,634: DEBUG - ALTER TABLE
2021-03-09 00:20:04,634: DEBUG - ALTER TABLE
2021-03-09 00:20:04,635: DEBUG - ALTER TABLE
2021-03-09 00:20:04,635: DEBUG - ALTER TABLE
2021-03-09 00:20:04,635: DEBUG - ALTER TABLE
2021-03-09 00:20:04,635: DEBUG - ALTER TABLE
2021-03-09 00:20:04,635: DEBUG - ALTER TABLE
2021-03-09 00:20:04,635: DEBUG - ALTER TABLE
2021-03-09 00:20:04,635: DEBUG - ALTER TABLE
2021-03-09 00:20:04,635: DEBUG - ALTER TABLE
2021-03-09 00:20:04,635: DEBUG - ALTER TABLE
2021-03-09 00:20:04,636: DEBUG - ALTER TABLE
2021-03-09 00:20:09,952: DEBUG - ALTER TABLE
2021-03-09 00:20:09,953: DEBUG - ALTER TABLE
2021-03-09 00:20:09,953: DEBUG - ALTER TABLE
2021-03-09 00:20:09,954: DEBUG - ALTER TABLE
2021-03-09 00:20:09,954: DEBUG - ALTER TABLE
2021-03-09 00:20:09,954: DEBUG - ALTER TABLE
2021-03-09 00:20:09,954: DEBUG - ALTER TABLE
2021-03-09 00:20:09,954: DEBUG - ALTER TABLE
2021-03-09 00:20:09,954: DEBUG - ALTER TABLE
2021-03-09 00:20:09,954: DEBUG - ALTER TABLE
2021-03-09 00:20:10,054: DEBUG - ALTER TABLE
2021-03-09 00:20:19,385: DEBUG - CREATE INDEX
2021-03-09 00:20:29,225: DEBUG - CREATE INDEX
2021-03-09 00:20:33,654: DEBUG - CREATE INDEX
2021-03-09 00:20:50,398: DEBUG - CREATE INDEX
2021-03-09 00:21:09,248: DEBUG - CREATE INDEX
2021-03-09 00:21:15,373: DEBUG - CREATE INDEX
2021-03-09 00:21:19,790: DEBUG - CREATE INDEX
2021-03-09 00:21:23,200: DEBUG - CREATE INDEX
2021-03-09 00:21:26,208: DEBUG - CREATE INDEX
2021-03-09 00:21:27,411: DEBUG - CREATE INDEX
2021-03-09 00:21:56,168: DEBUG - CREATE INDEX
2021-03-09 00:21:58,580: DEBUG - CREATE INDEX
2021-03-09 00:22:17,721: DEBUG - CREATE INDEX
2021-03-09 00:22:17,824: DEBUG - + echo '[#############+......] > Restoring the systemd configuration...'
2021-03-09 00:22:17,824: DEBUG - + ynh_restore_file --origin_path=/etc/systemd/system/pleroma.service
2021-03-09 00:22:17,825: DEBUG - + origin_path=/etc/systemd/system/pleroma.service
2021-03-09 00:22:17,825: DEBUG - + dest_path=/etc/systemd/system/pleroma.service
2021-03-09 00:22:17,825: DEBUG - + not_mandatory=0
2021-03-09 00:22:17,825: DEBUG - + local archive_path=/home/yunohost.backup/tmp/pleroma-pre-upgrade2/apps/pleroma/backup/etc/systemd/system/pleroma.service
2021-03-09 00:22:17,826: DEBUG - + '[' '!' -d /home/yunohost.backup/tmp/pleroma-pre-upgrade2/apps/pleroma/backup/etc/systemd/system/pleroma.service ']'
2021-03-09 00:22:17,826: DEBUG - + '[' '!' -f /home/yunohost.backup/tmp/pleroma-pre-upgrade2/apps/pleroma/backup/etc/systemd/system/pleroma.service ']'
2021-03-09 00:22:17,826: DEBUG - + [[ -e /etc/systemd/system/pleroma.service ]]
2021-03-09 00:22:17,826: DEBUG - ++ dirname /etc/systemd/system/pleroma.service
2021-03-09 00:22:17,826: DEBUG - + mkdir --parents /etc/systemd/system
2021-03-09 00:22:17,826: DEBUG - + mountpoint --quiet /home/yunohost.backup/tmp/pleroma-pre-upgrade2
2021-03-09 00:22:17,826: DEBUG - + mv /home/yunohost.backup/tmp/pleroma-pre-upgrade2/apps/pleroma/backup/etc/systemd/system/pleroma.service /etc/systemd/system/pleroma.service
2021-03-09 00:22:17,826: DEBUG - + systemctl enable pleroma.service --quiet
2021-03-09 00:22:17,926: DEBUG - + ynh_exit_properly
2021-03-09 00:22:17,927: WARNING - Failed to enable unit: Unit file /etc/systemd/system/pleroma.service is masked.
2021-03-09 00:22:17,943: INFO - [#############+......] > Restoring the systemd configuration...
2021-03-09 00:22:17,944: DEBUG - + local exit_code=1
2021-03-09 00:22:17,944: DEBUG - + '[' 1 -eq 0 ']'
2021-03-09 00:22:17,944: DEBUG - + trap '' EXIT
2021-03-09 00:22:17,944: DEBUG - + set +o errexit
2021-03-09 00:22:17,944: DEBUG - + set +o nounset
2021-03-09 00:22:17,944: DEBUG - + sleep 0.5
2021-03-09 00:22:18,347: DEBUG - + type -t ynh_clean_setup
2021-03-09 00:22:18,347: DEBUG - + ynh_clean_setup
2021-03-09 00:22:18,347: DEBUG - + ynh_clean_check_starting
2021-03-09 00:22:18,348: DEBUG - + '[' -n '' ']'
2021-03-09 00:22:18,348: DEBUG - + '[' -n '' ']'
2021-03-09 00:22:18,348: DEBUG - + exit 1
2021-03-09 00:22:18,393: ERROR - Could not restore pleroma ```

runfox · March 11, 2021, 12:29am

@Aleks is it possible to just backup the data and reinstall the pleroma app and then restore the data?

Aleks · March 11, 2021, 12:46am

Hmpf sorry for the lack of answer …

I guess theoretically yes, but it would require more work than fixing the current situation … though fixing the current situation ain’t trivial either …

Manually creating the service file was a bit of a mistake, it messes up systemd because it makes the service “masked” etc …

Anyway, the “easiest” thing to do would be to :

download and open the archive manually
find and edit the corresponding file for etc/systemd/system/pleroma.service in the subfolders of the archive
add the following content : pleroma_ynh/systemd.service at master · YunoHost-Apps/pleroma_ynh · GitHub
replace all occurences of __APP__ by pleroma, and __FINALPATH__ by /var/www/pleroma
save, and reupload the patched archive to your server
try to restore

Sorry that this is so complex just because of a “small” weird initial issue about the missing file >_> (though still pretty puzzling that the file just disappeared)

runfox · March 11, 2021, 12:51am

Ok, I am going to give this a whirl, thanks for all your help!

runfox · March 13, 2021, 12:15am

@Aleks I followed your instructions, and managed to restore the backedup archive, with the pleroma.service file.

Last night after i restored the Pleroma backup I was able to login but I was getting 500 internal server errors and couldn’t see any of the posts in the timeline. It wasn’table to fetch the timeline

Do you have any advice on how to remedy the 500 inernal server error

?

Aleks · March 13, 2021, 12:17am

Eeeeeh okay I don’t know if that’s related to the backup/restore …

Naively first thing I’d try is to have a look at the logs of the service (I’m guessing there’s a service corresponding to Pleroma ?) in Services > Pleroma(I think?)

Maybe there’s a stacktrace in these logs…

runfox · March 13, 2021, 12:19am

 journalctl
        -- Logs begin at Sat 2021-03-13 00:10:25 UTC, end at Sat 2021-03-13 00:19:03 UTC. --
Mar 13 00:19:02 pleroma[1445]:   3. Allow requests to wait longer by increasing :queue_target and :queue_interval
Mar 13 00:19:02 pleroma[1445]: See DBConnection.start_link/2 for more information
Mar 13 00:19:02 pleroma[1445]:     (db_connection 2.2.2) lib/db_connection.ex:745: DBConnection.run/3
Mar 13 00:19:02 pleroma[1445]:     (stdlib 3.12.1) gen_server.erl:637: :gen_server.try_dispatch/4
Mar 13 00:19:02 pleroma[1445]:     (stdlib 3.12.1) gen_server.erl:711: :gen_server.handle_msg/6
Mar 13 00:19:02 pleroma[1445]:     (stdlib 3.12.1) proc_lib.erl:249: :proc_lib.init_p_do_apply/3
Mar 13 00:19:02 pleroma[1445]: Last message: :poll
Mar 13 00:19:02 pleroma[1445]: State: %Oban.Queue.Producer.State{circuit: :enabled, conf: %Oban.Config{circuit_backoff: 30000, crontab: [{%Oban.Crontab.Cron{days: [:*], hours: [0], minutes: [0], months: [:*], reboot: false, weekdays: [0]}, Pleroma.Workers.Cron.DigestEmailsWorker, []}, {%Oban.Crontab.Cron{days: [:*], hours: [0], minutes: [0], months: [:*], reboot: false, weekdays: [:*]}, Pleroma.Workers.Cron.NewUsersDigestWorker, []}], dispatch_cooldown: 5, log: false, name: Oban, node: "pleroma@127.0.0.1", plugins: [Oban.Plugins.Pruner], poll_interval: 1000, prefix: "public", queues: [activity_expiration: [limit: 10], token_expiration: [limit: 5], federator_incoming: [limit: 50], federator_outgoing: [limit: 50], ingestion_queue: [limit: 50], web_push: [limit: 50], mailer: [limit: 10], transmogrifier: [limit: 20], scheduled_activities: [limit: 10], background: [limit: 5], remote_fetcher: [limit: 2], attachments_cleanup: [limit: 5], new_users_digest: [limit: 1]], repo: Pleroma.Repo, shutdown_grace_period: 15000, timezone: "Etc/UTC"}, cooldown_ref: nil, dispatch_cooldown: 5, dispatched_at: -576460248059, foreman: Oban.Queue.NewUsersDigest.Foreman, limit: 1, name: Oban.Queue.NewUsersDigest.Producer, nonce: "8bvu5d6v", paused: false, poll_interval: 1000, queue: "new_users_digest", reset_timer: nil, running: %{}, started_at: ~U[2021-03-13 00:18:54.378437Z], timer: #Reference<0.1606074685.1056964609.113165>}
Mar 13 00:19:02 pleroma[1445]: 00:19:02.649 [error] GenServer Oban.Queue.FederatorOutgoing.Producer terminating
Mar 13 00:19:02 pleroma[1445]: ** (DBConnection.ConnectionError) connection not available and request was dropped from queue after 2643ms. This means requests are coming in and your connection pool cannot serve them fast enough. You can address this by:
Mar 13 00:19:02 pleroma[1445]:   1. By tracking down slow queries and making sure they are running fast enough
Mar 13 00:19:02 pleroma[1445]:   2. Increasing the pool_size (albeit it increases resource consumption)
Mar 13 00:19:02 pleroma[1445]:   3. Allow requests to wait longer by increasing :queue_target and :queue_interval
Mar 13 00:19:02 pleroma[1445]: See DBConnection.start_link/2 for more information
Mar 13 00:19:02 pleroma[1445]:     (db_connection 2.2.2) lib/db_connection.ex:745: DBConnection.run/3
Mar 13 00:19:02 pleroma[1445]:     (stdlib 3.12.1) gen_server.erl:637: :gen_server.try_dispatch/4
Mar 13 00:19:02 pleroma[1445]:     (stdlib 3.12.1) gen_server.erl:711: :gen_server.handle_msg/6
Mar 13 00:19:02 pleroma[1445]:     (stdlib 3.12.1) proc_lib.erl:249: :proc_lib.init_p_do_apply/3
Mar 13 00:19:02 pleroma[1445]: Last message: :poll
Mar 13 00:19:02 pleroma[1445]: State: %Oban.Queue.Producer.State{circuit: :enabled, conf: %Oban.Config{circuit_backoff: 30000, crontab: [{%Oban.Crontab.Cron{days: [:*], hours: [0], minutes: [0], months: [:*], reboot: false, weekdays: [0]}, Pleroma.Workers.Cron.DigestEmailsWorker, []}, {%Oban.Crontab.Cron{days: [:*], hours: [0], minutes: [0], months: [:*], reboot: false, weekdays: [:*]}, Pleroma.Workers.Cron.NewUsersDigestWorker, []}], dispatch_cooldown: 5, log: false, name: Oban, node: "pleroma@127.0.0.1", plugins: [Oban.Plugins.Pruner], poll_interval: 1000, prefix: "public", queues: [activity_expiration: [limit: 10], token_expiration: [limit: 5], federator_incoming: [limit: 50], federator_outgoing: [limit: 50], ingestion_queue: [limit: 50], web_push: [limit: 50], mailer: [limit: 10], transmogrifier: [limit: 20], scheduled_activities: [limit: 10], background: [limit: 5], remote_fetcher: [limit: 2], attachments_cleanup: [limit: 5], new_users_digest: [limit: 1]], repo: Pleroma.Repo, shutdown_grace_period: 15000, timezone: "Etc/UTC"}, cooldown_ref: nil, dispatch_cooldown: 5, dispatched_at: -576460248057, foreman: Oban.Queue.FederatorOutgoing.Foreman, limit: 50, name: Oban.Queue.FederatorOutgoing.Producer, nonce: "959s6tkm", paused: false, poll_interval: 1000, queue: "federator_outgoing", reset_timer: nil, running: %{}, started_at: ~U[2021-03-13 00:18:54.390050Z], timer: #Reference<0.1606074685.1056964609.113190>}
Mar 13 00:19:02 pleroma[1445]: 00:19:02.649 [error] GenServer Oban.Queue.Transmogrifier.Producer terminating
Mar 13 00:19:02 pleroma[1445]: ** (DBConnection.ConnectionError) connection not available and request was dropped from queue after 2589ms. This means requests are coming in and your connection pool cannot serve them fast enough. You can address this by:
Mar 13 00:19:02 pleroma[1445]:   1. By tracking down slow queries and making sure they are running fast enough
Mar 13 00:19:02 pleroma[1445]:   2. Increasing the pool_size (albeit it increases resource consumption)
Mar 13 00:19:02 pleroma[1445]:   3. Allow requests to wait longer by increasing :queue_target and :queue_interval
Mar 13 00:19:02 pleroma[1445]: See DBConnection.start_link/2 for more information
Mar 13 00:19:02 pleroma[1445]:     (db_connection 2.2.2) lib/db_connection.ex:745: DBConnection.run/3
Mar 13 00:19:02 pleroma[1445]:     (stdlib 3.12.1) gen_server.erl:637: :gen_server.try_dispatch/4
Mar 13 00:19:02 pleroma[1445]:     (stdlib 3.12.1) gen_server.erl:711: :gen_server.handle_msg/6
Mar 13 00:19:02 pleroma[1445]:     (stdlib 3.12.1) proc_lib.erl:249: :proc_lib.init_p_do_apply/3
Mar 13 00:19:02 pleroma[1445]: Last message: :poll
Mar 13 00:19:02 pleroma[1445]: State: %Oban.Queue.Producer.State{circuit: :enabled, conf: %Oban.Config{circuit_backoff: 30000, crontab: [{%Oban.Crontab.Cron{days: [:*], hours: [0], minutes: [0], months: [:*], reboot: false, weekdays: [0]}, Pleroma.Workers.Cron.DigestEmailsWorker, []}, {%Oban.Crontab.Cron{days: [:*], hours: [0], minutes: [0], months: [:*], reboot: false, weekdays: [:*]}, Pleroma.Workers.Cron.NewUsersDigestWorker, []}], dispatch_cooldown: 5, log: false, name: Oban, node: "pleroma@127.0.0.1", plugins: [Oban.Plugins.Pruner], poll_interval: 1000, prefix: "public", queues: [activity_expiration: [limit: 10], token_expiration: [limit: 5], federator_incoming: [limit: 50], federator_outgoing: [limit: 50], ingestion_queue: [limit: 50], web_push: [limit: 50], mailer: [limit: 10], transmogrifier: [limit: 20], scheduled_activities: [limit: 10], background: [limit: 5], remote_fetcher: [limit: 2], attachments_cleanup: [limit: 5], new_users_digest: [limit: 1]], repo: Pleroma.Repo, shutdown_grace_period: 15000, timezone: "Etc/UTC"}, cooldown_ref: nil, dispatch_cooldown: 5, dispatched_at: -576460247965, foreman: Oban.Queue.Transmogrifier.Foreman, limit: 20, name: Oban.Queue.Transmogrifier.Producer, nonce: "t0d00bqq", paused: false, poll_interval: 1000, queue: "transmogrifier", reset_timer: nil, running: %{}, started_at: ~U[2021-03-13 00:18:48.673145Z], timer: #Reference<0.1606074685.1056964609.113302>}
Mar 13 00:19:02 pleroma[1445]: 00:19:02.861 [error] #PID<0.10632.0> running Pleroma.Web.Endpoint (connection #PID<0.10631.0>, stream id 1) terminated
Mar 13 00:19:02 pleroma[1445]: Server: pleroma.runfox.tk:80 (http)
Mar 13 00:19:02 pleroma[1445]: Request: POST /inbox
Mar 13 00:19:02 pleroma[1445]: ** (exit) an exception was raised:
Mar 13 00:19:02 pleroma[1445]:     ** (FunctionClauseError) no function clause matching in Plug.Conn.resp/3
Mar 13 00:19:02 pleroma[1445]:         (plug 1.10.4) lib/plug/conn.ex:580: Plug.Conn.resp(%Plug.Conn{adapter: {Plug.Cowboy.Conn, :...}, assigns: %{digest: "SHA-256=Npo+fjPIF129Miw0OFrlMqgbFIcURzxXU/m7xnpqYfU=", kind: :error, layout: false, locale: "en", reason: %DBConnection.ConnectionError{message: "connection not available and request was dropped from queue after 1768ms. This means requests are coming in and your connection pool cannot serve them fast enough. You can address this by:\n\n  1. By tracking down slow queries and making sure they are running fast enough\n  2. Increasing the pool_size (albeit it increases resource consumption)\n  3. Allow requests to wait longer by increasing :queue_target and :queue_interval\n\nSee DBConnection.start_link/2 for more information\n", severity: :error}, remote_ip_found: true, stack: [{Ecto.Adapters.SQL, :raise_sql_call_error, 1, [file: 'lib/ecto/adapters/sql.ex', line: 593]}, {Ecto.Adapters.SQL, :execute, 5, [file: 'lib/ecto/adapters/sql.ex', line: 526]}, {Ecto.Repo.Queryable, :execute, 4, [file: 'lib/ecto/repo/queryable.ex', line: 192]}, {Ecto.Repo.Queryable, :all, 3, [file: 'lib/ecto/repo/queryable.ex', line: 17]}, {Ecto.Repo.Queryable, :one, 3, [file: 'lib/ecto/repo/queryable.ex', line: 112]}, {Pleroma.Instances.Instance, :set_reachable, 1, [file: 'lib/pleroma/instances/instance.ex', line: 84]}, {Pleroma.Web.ActivityPub.ActivityPubController, :set_requester_reachable, 2, [file: 'lib/pleroma/web/activity_pub/activity_pub_controller.ex', line: 509]}, {Pleroma.Web.ActivityPub.ActivityPubController, :phoenix_controller_pipeline, 2, [file: 'lib/pleroma/web/activity_pub/activity_pub_controller.ex', line: 5]}], status: 500, user: %Pleroma.User{mutes: [], approval_pending: false, hide_favorites: true, search_rank: nil, confirmation_token: nil, emoji: %{}, __meta__: #Ecto.Schema.Metadata<:loaded, "users">, multi_factor_authentication_settings: %Pleroma.MFA.Settings{backup_codes: [], enabled: false, totp: nil}, avatar: %{"type" => "Image", "url" => [%{"href" => "https://stereophonic.space/media/7ba22f91e3f5ae145a21a3827c0b7e9d8dff36c8d026a803344c52ee8764e1b2.P36HC8CO3MVF"}]}, shared_inbox: "https://stereophonic.space/inbox", also_known_as: [], uri: "https://stereophonic.space/users/Mevie", allow_following_move: true, blocker_blocks: #Ecto.Association.NotLoaded<association :blocker_blocks is not loaded>, blocker_users: #Ecto.Association.NotLoaded<association :blocker_users is not loaded>, unread_conversation_count: 0, banner: %{"type" => "Image", "url" => [%{"href" => "https://stereophonic.space/media/63f073fc82ee007ea788390e66cac9e833d970d702377a6d0c2ee83a8bb99ca1.8EW2M6B36NGQ"}]}, is_moderator: false, note_count: 3358, following_count: 12, hide_follows: false, follower_count: 6, subscribee_users: #Ecto.Association.NotLoaded<association :subscribee_users is not loaded>, blockee_blocks: #Ecto.Association.NotLoaded<association :blockee_blocks is not loaded>, invisible: false, hide_followers_count: false, hide_follows_count: false, mastofe_settings: nil, muter_users: #Ecto.Association.NotLoaded<association :muter_users is not loaded>, reblog_muted_users: #Ecto.Association.NotLoaded<association :reblog_muted_users is not loaded>, hide_followers: false, pleroma_settings_store: %{}, muted_notifications: [], fields: [], background: %{}, show_role: true, discoverable: false, blocked_users: #Ecto.Association.NotLoaded<association :blocked_users is not loaded>, mascot: nil, ...}, valid_signature: true}, before_send: [#Function<0.49113890/1 in Pleroma.Web.Endpoint.PipelineInstrumenter.call/2>, #Function<1.129014997/1 in Plug.Logger.call/2>, #Function<0.24098476/1 in Plug.Telemetry.call/2>], body_params: %{"@context" => ["https://www.w3.org/ns/activitystreams", "https://stereophonic.space/schemas/litepub-0.1.jsonld", %{"@language" => "und"}], "actor" => "https://stereophonic.space/users/Mevie", "cc" => ["https://stereophonic.space/users/Mevie/followers"], "context" => "https://stereophonic.space/contexts/e7e7f385-4194-4bd1-9484-a58ccfd8e759", "context_id" => 22332092, "directMessage" => false, "id" => "https://stereophonic.space/activities/efbe35d5-0129-4360-a4bd-94340d4cf2b2", "object" => %{"actor" => "https://stereophonic.space/users/Mevie", "attachment" => [], "attributedTo" => "https://stereophonic.space/users/Mevie", "cc" => ["https://stereophonic.space/users/Mevie/followers"], "content" => "<span class=\"h-card\"><a class=\"u-url mention\" data-user=\"9lbtXsO78OnMPXCDse\" href=\"https://chaos.social/@a_breakin_glass\" rel=\"ugc\">@<span>a_breakin_glass</span></a></span> Think harder, than. Now I just feel worse.", "context" => "https://stereophonic.space/contexts/e7e7f385-4194-4bd1-9484-a58ccfd8e759", "conversation" => "https://stereophonic.space/contexts/e7e7f385-4194-4bd1-9484-a58ccfd8e759", "id" => "https://stereophonic.space/objects/82390715-2250-4892-88d5-669ac136dd00", "inReplyTo" => "https://chaos.social/users/a_breakin_glass/statuses/105879613122024807", "published" => "2021-03-13T00:19:00.365724Z", "sensitive" => false, "source" => "@a_breakin_glass@chaos.social Think harder, than. Now I just feel worse.", "summary" => "", "tag" => [%{"href" => "https://chaos.social/users/a_breakin_glass", "name" => "@a_breakin_glass@chaos.social", "type" => "Mention"}], "to" => ["https://chaos.social/users/a_breakin_glass", "https://www.w3.org/ns/activitystreams#Public"], "type" => "Note"}, "published" => "2021-03-13T00:19:00.363634Z", "to" => ["https://chaos.social/users/a_breakin_glass", "https://www.w3.org/ns/activitystreams#Public"], "type" => "Create"}, cookies: %Plug.Conn.Unfetched{aspect: :cookies}, halted: false, host: "pleroma.runfox.tk", method: "POST", owner: #PID<0.10632.0>, params: %{"@context" => ["https://www.w3.org/ns/activitystreams", "https://stereophonic.space/schemas/litepub-0.1.jsonld", %{"@language" => "und"}], "actor" => "https://stereophonic.space/users/Mevie", "cc" => ["https://stereophonic.space/users/Mevie/followers"], "context" => "https://stereophonic.space/contexts/e7e7f385-4194-4bd1-9484-a58ccfd8e759", "context_id" => 22332092, "directMessage" => false, "id" => "https://stereophonic.space/activities/efbe35d5-0129-4360-a4bd-94340d4cf2b2", "object" => %{"actor" => "https://stereophonic.space/users/Mevie", "attachment" => [], "attributedTo" => "https://stereophonic.space/users/Mevie", "cc" => ["https://stereophonic.space/users/Mevie/followers"], "content" => "<span class=\"h-card\"><a class=\"u-url mention\" data-user=\"9lbtXsO78OnMPXCDse\" href=\"https://chaos.social/@a_breakin_glass\" rel=\"ugc\">@<span>a_breakin_glass</span></a></span> Think harder, than. Now I just feel worse.", "context" => "https://stereophonic.space/contexts/e7e7f385-4194-4bd1-9484-a58ccfd8e759", "conversation" => "https://stereophonic.space/contexts/e7e7f385-4194-4bd1-9484-a58ccfd8e759", "id" => "https://stereophonic.space/objects/82390715-2250-4892-88d5-669ac136dd00", "inReplyTo" => "https://chaos.social/users/a_breakin_glass/statuses/105879613122024807", "published" => "2021-03-13T00:19:00.365724Z", "sensitive" => false, "source" => "@a_breakin_glass@chaos.social Think harder, than. Now I just feel worse.", "summary" => "", "tag" => [%{"href" => "https://chaos.social/users/a_breakin_glass", "name" => "@a_breakin_glass@chaos.social", "type" => "Mention"}], "to" => ["https://chaos.social/users/a_breakin_glass", "https://www.w3.org/ns/activitystreams#Public"], "type" => "Note"}, "published" => "2021-03-13T00:19:00.363634Z", "to" => ["https://chaos.social/users/a_breakin_glass", "https://www.w3.org/ns/activitystreams#Public"], "type" => "Create"}, path_info: ["inbox"], path_params: %{}, port: 80, private: %{Pleroma.Web.Router => {[], %{}}, :phoenix_endpoint => Pleroma.Web.Endpoint, :phoenix_format => "activity+json", :phoenix_layout => false, :phoenix_root_layout => false, :phoenix_rout (truncated)
Mar 13 00:19:03 pleroma[1445]: 00:19:03.012 [error] GenServer Oban.Queue.FederatorIncoming.Producer terminating
Mar 13 00:19:03 pleroma[1445]: ** (DBConnection.ConnectionError) connection not available and request was dropped from queue after 2640ms. This means requests are coming in and your connection pool cannot serve them fast enough. You can address this by:
Mar 13 00:19:03 pleroma[1445]:   1. By tracking down slow queries and making sure they are running fast enough
Mar 13 00:19:03 pleroma[1445]:   2. Increasing the pool_size (albeit it increases resource consumption)
Mar 13 00:19:03 pleroma[1445]:   3. Allow requests to wait longer by increasing :queue_target and :queue_interval
Mar 13 00:19:03 pleroma[1445]: See DBConnection.start_link/2 for more information
Mar 13 00:19:03 pleroma[1445]:     (db_connection 2.2.2) lib/db_connection.ex:745: DBConnection.run/3
Mar 13 00:19:03 pleroma[1445]:     (stdlib 3.12.1) gen_server.erl:637: :gen_server.try_dispatch/4
Mar 13 00:19:03 pleroma[1445]:     (stdlib 3.12.1) gen_server.erl:711: :gen_server.handle_msg/6
Mar 13 00:19:03 pleroma[1445]:     (stdlib 3.12.1) proc_lib.erl:249: :proc_lib.init_p_do_apply/3
Mar 13 00:19:03 pleroma[1445]: Last message: :poll
Mar 13 00:19:03 pleroma[1445]: State: %Oban.Queue.Producer.State{circuit: :enabled, conf: %Oban.Config{circuit_backoff: 30000, crontab: [{%Oban.Crontab.Cron{days: [:*], hours: [0], minutes: [0], months: [:*], reboot: false, weekdays: [0]}, Pleroma.Workers.Cron.DigestEmailsWorker, []}, {%Oban.Crontab.Cron{days: [:*], hours: [0], minutes: [0], months: [:*], reboot: false, weekdays: [:*]}, Pleroma.Workers.Cron.NewUsersDigestWorker, []}], dispatch_cooldown: 5, log: false, name: Oban, node: "pleroma@127.0.0.1", plugins: [Oban.Plugins.Pruner], poll_interval: 1000, prefix: "public", queues: [activity_expiration: [limit: 10], token_expiration: [limit: 5], federator_incoming: [limit: 50], federator_outgoing: [limit: 50], ingestion_queue: [limit: 50], web_push: [limit: 50], mailer: [limit: 10], transmogrifier: [limit: 20], scheduled_activities: [limit: 10], background: [limit: 5], remote_fetcher: [limit: 2], attachments_cleanup: [limit: 5], new_users_digest: [limit: 1]], repo: Pleroma.Repo, shutdown_grace_period: 15000, timezone: "Etc/UTC"}, cooldown_ref: nil, dispatch_cooldown: 5, dispatched_at: -576460248006, foreman: Oban.Queue.FederatorIncoming.Foreman, limit: 50, name: Oban.Queue.FederatorIncoming.Producer, nonce: "3vpkvoi0", paused: false, poll_interval: 1000, queue: "federator_incoming", reset_timer: nil, running: %{#Reference<0.1606074685.1056964609.112137> => {%Oban.Queue.Executor{conf: %Oban.Config{circuit_backoff: 30000, crontab: [{%Oban.Crontab.Cron{days: [:*], hours: [0], minutes: [0], months: [:*], reboot: false, weekdays: [0]}, Pleroma.Workers.Cron.DigestEmailsWorker, []}, {%Oban.Crontab.Cron{days: [:*], hours: [0], minutes: [0], months: [:*], reboot: false, weekdays: [:*]}, Pleroma.Workers.Cron.NewUsersDigestWorker, []}], dispatch_cooldown: 5, log: false, name: Oban, node: "pleroma@127.0.0.1", plugins: [Oban.Plugins.Pruner], poll_interval: 1000, prefix: "public", queues: [activity_expiration: [limit: 10], token_expiration: [limit: 5], federator_incoming: [limit: 50], federator_outgoing: [limit: 50], ingestion_queue: [limit: 50], web_push: [limit: 50], mailer: [limit: 10], transmogrifier: [limit: 20], scheduled_activities: [limit: 10], background: [limit: 5], remote_fetcher: [limit: 2], attachments_cleanup: [limit: 5], new_users_digest: [limit: 1]], repo: Pleroma.Repo, shutdown_grace_period: 15000, timezone: "Etc/UTC"}, duration: 0, error: nil, job: %Oban.Job{__meta__: #Ecto.Schema.Metadata<:loaded, "public", "oban_jobs">, args: %{"op" => "incoming_ap_doc", "params" => %{"@context" => ["https://www.w3.org/ns/activitystreams", "https://stereophonic.space/schemas/litepub-0.1.jsonld", %{"@language" => "und"}], "actor" => "https://stereophonic.space/users/Mevie", "cc" => ["https://stereophonic.space/users/Mevie/followers"], "context" => "https://stereophonic.space/contexts/13d6577c-66a6-4ba2-a5f8-12d42cf4516b", "context_id" => 22330556, "directMessage" => false, "id" => "https://stereophonic.space/activities/73e88651-7c9d-4b93-bbc6-d01d9f6d2886", "object" => %{"actor" => "https://stereophonic.space/users/Mevie", "attachment" => [], "attributedTo" => "https://stereophonic.space/users/Mevie", "cc" => ["https://stereophonic.space/users/Mevie/followers"], "content" => "<span class=\"h-card\"><a class=\"u-url mention\" data-user=\"A52snosxis5ALbr6Bs\" href=\"https://kiwifarms.cc/users/gumbullzzz\" rel=\"ugc\">@<span>gumbullzzz</span></a></span> Yes, being in a relationship is cringe. Redpilled individuals just dont get born.", "context" => "https://stereophonic.space/contexts/13d6577c-66a6-4ba2-a5f8-12d42cf4516b", "conversation" => "https://stereophonic.space/contexts/13d6577c-66a6-4ba2-a5f8-12d42cf4516b", "id" => "https://stereophonic.space/objects/a81f93cd-c7b6-4604-9e73-304442b7f2fa", "inReplyTo" => "https://kiwifarms.cc/objects/11d1c341-74fa-4101-a8f8-75c8c76a89bf", "published" => "2021-03-13T00:15:42.371551Z", "sensitive" => false, "source" => "@gumbullzzz@kiwifarms.cc Yes, being in a relationship is cringe. Redpilled individuals just dont get born.", "summary" => "", "tag" => [%{"href" => "https://kiwifarms.cc/users/gumbullzzz", "name" => "@gumbullzzz@kiwifarms.cc", "type" => "Mention"}], "to" => ["https://kiwifarms.cc/users/gumbullzzz", "https://www.w3.org/ns/activitystreams#Public"], "type" => "Note"}, "published" => "2021-03-13T00:15:42.369418Z", "to" => ["https://kiwifarms.cc/users/gumbullzzz", "https://www.w3.org/ns/activitystreams#Public"], "type" => "Create"}}, attempt: 5, attempted_at: ~U[2021-03-13 00:18:55.542689Z], attempted_by: ["pleroma@127.0.0.1", "federator_incoming", "3vpkvoi0"], completed_at: nil, discarded_at: nil, errors: [%{"at" => "2021-03-13T00:16:14.987698Z", "attempt" => 1, "error" => "** (DBConnection.ConnectionError) connection not available and request was dropped from queue after 1546ms. This means requests are coming in and your connection pool cannot serve them fast enough. You can address this by:\n\n  1. By tracking down slow queries and making sure they are running fast enough\n  2. Increasing the pool_size (albeit it increases resource consumption)\n  3. Allow requests to wait longer by increasing :queue_target and :queue_interval\n\nSee DBConnection.start_link/2 for more information\n\n    (ecto_sql 3.4.5) lib/ecto/adapters/sql.ex:593: Ecto.Adapters.SQL.raise_sql_call_error/1\n    (ecto_sql 3.4.5) lib/ecto/adapters/sql.ex:526: Ecto.Adapters.SQL.execute/5\n    (ecto 3.4.6) lib/ecto/repo/queryable.ex:192: Ecto.Repo.Queryable.execute/4\n    (ecto 3.4.6) lib/ecto/repo/queryable.ex:17: Ecto.Repo.Queryable.all/3\n    (ecto 3.4.6) lib/ecto/repo/queryable.ex:112: Ecto.Repo.Queryable.one/3\n    (pleroma 2.2.2-release-2-2-3) lib/pleroma/object.ex:160: Pleroma.Object.get_cached_by_ap_id/1\n    (pleroma 2.2.2-release-2-2-3) lib/pleroma/object/fetcher.ex:84: Pleroma.Object.Fetcher.fetch_object_from_id/2\n    (pleroma 2.2.2-release-2-2-3) lib/pleroma/object/fetcher.ex:137: Pleroma.Object.Fetcher.fetch_object_from_id!/2\n"}, %{"at" => "2021-03-13T00:16:55.657499Z", "attempt" => 2, "error" => "** (DBConnection.ConnectionError) tcp recv: closed (the connection was closed by the pool, possibly due to a timeout or because the pool has been terminated)\n    (ecto_sql 3.4.5) lib/ecto/adapters/sql.ex:593: Ecto.Adapters.SQL.raise_sql_call_error/1\n    (ecto_sql 3.4.5) lib/ecto/adapters/sql.ex:526: Ecto.Adapters.SQL.execute/5\n    (ecto 3.4.6) lib/ecto/repo/queryable.ex:192: Ecto.Repo.Queryable.execute/4\n    (ecto 3.4.6) lib/ecto/repo/queryable.ex:17: Ecto.Repo.Queryable.all/3\n    (ecto 3.4.6) lib/ecto/repo/queryable.ex:112: Ecto.Repo.Queryable.one/3\n    (pleroma 2.2.2-release-2-2-3) lib/pleroma/object.ex:160: Pleroma.Object.get_cached_by_ap_id/1\n    (pleroma 2.2.2-release-2-2-3) lib/pleroma/object/fetcher.ex:84: Pleroma.Object.Fetcher.fetch_object_from_id/2\n    (pleroma 2.2.2-release-2-2-3) lib/pleroma/object/fetcher.ex:137: Pleroma.Object.Fetcher.fetch_object_from_id!/2\n"}, %{"at" => "2021-03-13T00:17:44.028566Z", "attempt" => 3, "error" => "** (DBConnection.ConnectionError) tcp recv: closed (the connection was closed by the pool, possibly due to a timeout or because the pool has been terminated)\n    (ecto_sql 3.4.5) lib/ecto/adapters/sql.ex:593: Ecto.Adapters.SQL.raise_sql_call_error/1\n    (ecto_sql 3.4. (truncated)
    ```

Aleks · March 13, 2021, 12:22am

Hmmmokay on dirait un soucis avec la DB (je t’avoue que je connais pas du tout cette app … comme pleins d’autres apps d’ailleurs haha)

Autre choses à vérifier en premier, est-ce qu’il y a un service dans les choux (aussi dans la page service) ? Est-ce que le diagnostique rapporte des problèmes qui pourraient être liés ?

runfox · March 13, 2021, 12:27am

La base de données pour pleroma est postgresql et il y a des messages d’erreur dans les journaux des services


        journalctl
        -- Logs begin at Sat 2021-03-13 00:13:10 UTC, end at Sat 2021-03-13 00:25:12 UTC. --
-- No entries --
        /var/log/postgresql/postgresql-11-main.log
        2021-03-13 00:24:43.942 UTC [2973] pleroma@pleroma LOG:  could not send data to client: Broken pipe
2021-03-13 00:24:43.942 UTC [2973] pleroma@pleroma FATAL:  connection to client lost
2021-03-13 00:24:44.048 UTC [2913] pleroma@pleroma ERROR:  canceling statement due to user request
2021-03-13 00:24:44.048 UTC [2913] pleroma@pleroma STATEMENT:  UPDATE "objects" AS o0 SET "data" = safe_jsonb_set(o0."data", '{repliesCount}',
	  (coalesce((o0."data"->>'repliesCount')::int, 0) + 1)::varchar::jsonb, true)
	 WHERE (o0."data"->>'id' = $1::text)
2021-03-13 00:24:44.048 UTC [2913] pleroma@pleroma LOG:  could not send data to client: Broken pipe
2021-03-13 00:24:44.048 UTC [2913] pleroma@pleroma FATAL:  connection to client lost
2021-03-13 00:24:44.462 UTC [2982] pleroma@pleroma ERROR:  canceling statement due to user request
2021-03-13 00:24:44.462 UTC [2982] pleroma@pleroma STATEMENT:  SELECT o0."id", o0."data", o0."inserted_at", o0."updated_at" FROM "objects" AS o0 WHERE ((o0."data")->>'id' = $1)
2021-03-13 00:24:44.463 UTC [2982] pleroma@pleroma LOG:  could not send data to client: Broken pipe
2021-03-13 00:24:44.463 UTC [2982] pleroma@pleroma FATAL:  connection to client lost
2021-03-13 00:24:56.578 UTC [2980] pleroma@pleroma ERROR:  canceling statement due to user request
2021-03-13 00:24:56.578 UTC [2980] pleroma@pleroma STATEMENT:  SELECT o0."id", o0."data", o0."inserted_at", o0."updated_at" FROM "objects" AS o0 WHERE ((o0."data")->>'id' = $1)
2021-03-13 00:24:56.618 UTC [2997] FATAL:  terminating connection due to administrator command
2021-03-13 00:24:56.618 UTC [2997] STATEMENT:  SELECT o0."id", o0."data", o0."inserted_at", o0."updated_at" FROM "objects" AS o0 WHERE ((o0."data")->>'id' = $1)
2021-03-13 00:24:56.661 UTC [774] LOG:  background worker "parallel worker" (PID 2997) exited with exit code 1
2021-03-13 00:24:56.661 UTC [2980] pleroma@pleroma LOG:  could not send data to client: Broken pipe
2021-03-13 00:24:56.661 UTC [2980] pleroma@pleroma FATAL:  connection to client lost
2021-03-13 00:24:59.732 UTC [2951] pleroma@pleroma ERROR:  canceling statement due to user request
2021-03-13 00:24:59.732 UTC [2951] pleroma@pleroma STATEMENT:  SELECT o0."id", o0."data", o0."inserted_at", o0."updated_at" FROM "objects" AS o0 WHERE ((o0."data")->>'id' = $1)
2021-03-13 00:24:59.732 UTC [2951] pleroma@pleroma LOG:  could not send data to client: Broken pipe
2021-03-13 00:24:59.732 UTC [2951] pleroma@pleroma FATAL:  connection to client lost
2021-03-13 00:25:00.614 UTC [2999] pleroma@pleroma ERROR:  canceling statement due to user request
2021-03-13 00:25:00.614 UTC [2999] pleroma@pleroma STATEMENT:  SELECT o0."id", o0."data", o0."inserted_at", o0."updated_at" FROM "objects" AS o0 WHERE ((o0."data")->>'id' = $1)
2021-03-13 00:25:00.615 UTC [2999] pleroma@pleroma LOG:  could not send data to client: Broken pipe
2021-03-13 00:25:00.615 UTC [2999] pleroma@pleroma FATAL:  connection to client lost
2021-03-13 00:25:00.832 UTC [2996] pleroma@pleroma ERROR:  canceling statement due to user request
2021-03-13 00:25:00.832 UTC [2996] pleroma@pleroma STATEMENT:  SELECT o0."id", o0."data", o0."inserted_at", o0."updated_at" FROM "objects" AS o0 WHERE ((o0."data")->>'id' = $1)
2021-03-13 00:25:00.832 UTC [2996] pleroma@pleroma LOG:  could not send data to client: Broken pipe
2021-03-13 00:25:00.832 UTC [2996] pleroma@pleroma FATAL:  connection to client lost
2021-03-13 00:25:01.884 UTC [3005] pleroma@pleroma ERROR:  canceling statement due to user request
2021-03-13 00:25:01.884 UTC [3005] pleroma@pleroma STATEMENT:  SELECT o0."id", o0."data", o0."inserted_at", o0."updated_at" FROM "objects" AS o0 WHERE ((o0."data")->>'id' = $1)
2021-03-13 00:25:01.884 UTC [3005] pleroma@pleroma LOG:  could not send data to client: Broken pipe
2021-03-13 00:25:01.884 UTC [3005] pleroma@pleroma FATAL:  connection to client lost
2021-03-13 00:25:04.804 UTC [3009] pleroma@pleroma ERROR:  canceling statement due to user request
2021-03-13 00:25:04.804 UTC [3009] pleroma@pleroma STATEMENT:  SELECT o0."id", o0."data", o0."inserted_at", o0."updated_at" FROM "objects" AS o0 WHERE ((o0."data")->>'id' = $1)
2021-03-13 00:25:04.804 UTC [3009] pleroma@pleroma LOG:  could not send data to client: Broken pipe
2021-03-13 00:25:04.804 UTC [3009] pleroma@pleroma FATAL:  connection to client lost
2021-03-13 00:25:10.972 UTC [3001] pleroma@pleroma ERROR:  canceling statement due to user request
2021-03-13 00:25:10.972 UTC [3001] pleroma@pleroma STATEMENT:  SELECT o0."id", o0."data", o0."inserted_at", o0."updated_at" FROM "objects" AS o0 WHERE ((o0."data")->>'id' = $1)
2021-03-13 00:25:10.972 UTC [3001] pleroma@pleroma LOG:  could not send data to client: Broken pipe
2021-03-13 00:25:10.972 UTC [3001] pleroma@pleroma FATAL:  connection to client lost
2021-03-13 00:25:12.273 UTC [3039] pleroma@pleroma ERROR:  canceling statement due to user request
2021-03-13 00:25:12.273 UTC [3039] pleroma@pleroma STATEMENT:  SELECT o0."id", o0."data", o0."inserted_at", o0."updated_at" FROM "objects" AS o0 WHERE ((o0."data")->>'id' = $1)
2021-03-13 00:25:12.274 UTC [3040] FATAL:  terminating connection due to administrator command
2021-03-13 00:25:12.274 UTC [3040] STATEMENT:  SELECT o0."id", o0."data", o0."inserted_at", o0."updated_at" FROM "objects" AS o0 WHERE ((o0."data")->>'id' = $1)
2021-03-13 00:25:12.298 UTC [774] LOG:  background worker "parallel worker" (PID 3040) exited with exit code 1
2021-03-13 00:25:12.299 UTC [3039] pleroma@pleroma LOG:  could not send data to client: Broken pipe
2021-03-13 00:25:12.299 UTC [3039] pleroma@pleroma FATAL:  connection to client lost

ArtemS · March 14, 2021, 9:05pm

I encountered the same problem - notifications “500 inernal server error” are popping up. I could also use some advice on how to deal with this

system · March 29, 2021, 9:06pm

This topic was automatically closed 15 days after the last reply. New replies are no longer allowed.