Logs flooded with No such file or directory errors

[linucksrox]

Actual behaviour

Many errors appearing in the logs saying
unlink(/var/www/nextcloud/data/appdata_***/avatar/***/generated): No such file or directory at /var/www/nextcloud/lib/private/Files/Storage/Local.php#227
unlink(/var/www/nextcloud/data/appdata_***/avatar/***/avatar.png): No such file or directory at /var/www/nextcloud/lib/private/Files/Storage/Local.php#227
unlink(/var/www/nextcloud/data/appdata_***/avatar/***/avatar.381.png): No such file or directory at /var/www/nextcloud/lib/private/Files/Storage/Local.php#227

Server configuration

Operating system: Ubuntu 16.04

Web server: Apache 2.4

Database: Mariadb 10.3

PHP version: 7.2

Nextcloud version: 16.0.1

Updated from an older Nextcloud/ownCloud or fresh install: Updated

Where did you install Nextcloud from: From .tar.gz package

Signing status:

Signing status

No errors have been found.

List of activated apps:

App list

Enabled: - accessibility: 1.2.0 - activity: 2.9.1 - admin_audit: 1.6.0 - bruteforcesettings: 1.3.0 - cloud_federation_api: 0.2.0 - comments: 1.6.0 - dav: 1.9.2 - drawio: 0.9.3 - federatedfilesharing: 1.6.0 - federation: 1.6.0 - files: 1.11.0 - files_downloadactivity: 1.5.0 - files_rightclick: 0.13.0 - files_sharing: 1.8.0 - files_texteditor: 2.8.0 - files_trashbin: 1.6.0 - files_versions: 1.9.0 - files_videoplayer: 1.5.0 - gallery: 18.3.0 - groupfolders: 4.0.0 - impersonate: 1.3.0 - logreader: 2.1.0 - lookup_server_connector: 1.4.0 - nextcloud_announcements: 1.5.0 - notifications: 2.4.1 - oauth2: 1.4.2 - password_policy: 1.6.0 - privacy: 1.0.0 - provisioning_api: 1.6.0 - serverinfo: 1.6.0 - sharebymail: 1.6.0 - support: 1.0.0 - systemtags: 1.6.0 - theming: 1.7.0 - twofactor_backupcodes: 1.5.0 - updatenotification: 1.6.0 - user_ldap: 1.6.0 - viewer: 1.0.0 - workflowengine: 1.6.0 Disabled: - encryption - files_external - files_pdfviewer - firstrunwizard - recommendations - survey_client

Nextcloud configuration:

Config report

{ "system": { "instanceid": "***REMOVED SENSITIVE VALUE***", "passwordsalt": "***REMOVED SENSITIVE VALUE***", "secret": "***REMOVED SENSITIVE VALUE***", "trusted_domains": [ "localhost", "***REMOVED SENSITIVE VALUE***" ], "datadirectory": "***REMOVED SENSITIVE VALUE***", "overwrite.cli.url": "***REMOVED SENSITIVE VALUE***", "htaccess.RewriteBase": "\/", "dbtype": "mysql", "version": "16.0.1.1", "dbname": "***REMOVED SENSITIVE VALUE***", "dbhost": "***REMOVED SENSITIVE VALUE***", "dbport": "", "dbtableprefix": "oc_", "dbuser": "***REMOVED SENSITIVE VALUE***", "dbpassword": "***REMOVED SENSITIVE VALUE***", "logtimezone": "UTC", "installed": true, "check_for_working_htaccess": true, "memcache.local": "\\OC\\Memcache\\APCu", "filelocking.enabled": "true", "memcache.locking": "\\OC\\Memcache\\Redis", "redis": { "host": "***REMOVED SENSITIVE VALUE***", "port": 0, "timeout": 0 }, "mail_smtpmode": "smtp", "mail_from_address": "***REMOVED SENSITIVE VALUE***", "mail_domain": "***REMOVED SENSITIVE VALUE***", "ldapIgnoreNamingRules": false, "ldapProviderFactory": "\\OCA\\User_LDAP\\LDAPProviderFactory", "loglevel": 2, "trashbin_retention_obligation": "auto", "mail_smtphost": "***REMOVED SENSITIVE VALUE***", "mail_smtpport": "25", "maintenance": false, "share_folder": "\/Shared With You", "theme": "", "updater.release.channel": "stable", "mysql.utf8mb4": true, "app_install_overwrite": [ "files_downloadactivity", "groupfolders", "impersonate" ] } }

Are you using external storage, if yes which one: No

Are you using encryption: No

Are you using an external user-backend, if yes which one: Active Directory

LDAP configuration (delete this part if not used)

LDAP config

+-------------------------------+-----------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------+ | Configuration | | +-------------------------------+-----------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------+ | hasMemberOfFilterSupport | 1 | | homeFolderNamingRule | | | lastJpegPhotoLookup | 0 | | ldapAgentName | CN=***,OU=AdministrativeUsers,OU=User&Groups,DC=***,DC=local | | ldapAgentPassword | *** | | ldapAttributesForGroupSearch | | | ldapAttributesForUserSearch | sAMAccountName;mail;givenName;sn | | ldapBackupHost | *** | | ldapBackupPort | 389 | | ldapBase | DC=***,DC=local | | ldapBaseGroups | OU=SecurityGroups,OU=Groups,OU=User&Groups,DC=***,DC=local | | ldapBaseUsers | OU=AdministrativeUsers,OU=User&Groups,DC=***,DC=local;OU=BoardMembers,OU=User&Groups,DC=***,DC=local;OU=UsersLocal,OU=Users,OU=User&Groups,DC=***,DC=local;OU=UsersRemote,OU=Users,OU=User&Groups,DC=***,DC=local;OU=Contractors,OU=Users,OU=User&Groups,DC=***,DC=local | | ldapCacheTTL | 3600 | | ldapConfigurationActive | 1 | | ldapDefaultPPolicyDN | | | ldapDynamicGroupMemberURL | | | ldapEmailAttribute | mail | | ldapExperiencedAdmin | 0 | | ldapExpertUUIDGroupAttr | | | ldapExpertUUIDUserAttr | | | ldapExpertUsernameAttr | sAMAccountName | | ldapExtStorageHomeAttribute | | | ldapGidNumber | gidNumber | | ldapGroupDisplayName | cn | | ldapGroupFilter | | | ldapGroupFilterGroups | | | ldapGroupFilterMode | 1 | | ldapGroupFilterObjectclass | | | ldapGroupMemberAssocAttr | member | | ldapHost | *** | | ldapIgnoreNamingRules | | | ldapLoginFilter | (&(&(|(objectclass=user))(|(|(memberof=CN=OwnCloud,OU=SecurityGroups,OU=Groups,OU=User&Groups,DC=***,DC=local)(primaryGroupID=2741))))(samaccountname=%uid)(!(userAccountControl:1.2.840.113556.1.4.803:=2))) | | ldapLoginFilterAttributes | | | ldapLoginFilterEmail | 0 | | ldapLoginFilterMode | 1 | | ldapLoginFilterUsername | 1 | | ldapNestedGroups | 0 | | ldapOverrideMainServer | | | ldapPagingSize | 500 | | ldapPort | 389 | | ldapQuotaAttribute | | | ldapQuotaDefault | | | ldapTLS | 0 | | ldapUserAvatarRule | default | | ldapUserDisplayName | displayname | | ldapUserDisplayName2 | | | ldapUserFilter | (&(|(objectclass=user))(|(|(memberof=CN=OwnCloud,OU=SecurityGroups,OU=Groups,OU=User&Groups,DC=***,DC=local)(primaryGroupID=2741)))(!(userAccountControl:1.2.840.113556.1.4.803:=2))) | | ldapUserFilterGroups | OwnCloud | | ldapUserFilterMode | 1 | | ldapUserFilterObjectclass | user | | ldapUuidGroupAttribute | auto | | ldapUuidUserAttribute | auto | | turnOffCertCheck | 0 | | turnOnPasswordChange | 0 | | useMemberOfToDetectMembership | 1 | +-------------------------------+-----------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------+

Logs

Web server error log

Web server error log

{"reqId":"EblfeNytaqj4M5YHDYFW","level":3,"time":"2019-05-17T19:41:50+00:00","remoteAddr":"192.168.1.21","user":"username","app":"PHP","method":"GET","url":"\/index.php\/204","message":"unlink(\/var\/www\/nextcloud\/data\/appdata_***\/avatar\/username\/generated): No such file or directory at \/var\/www\/nextcloud\/lib\/private\/Files\/Storage\/Local.php#227","userAgent":"Mozilla\/5.0 (Android) ownCloud-android\/3.6.1","version":"16.0.1.1"}

When downloading the nextcloud.log file, it reveals that the user agent is always the Android client (current version 3.6.1). A similar issue was just closed #8635 which also was linked to the Android client every time.

[linucksrox]

@blizzz Just to update, I have run occ files:scan-app-data but I'm still seeing the same errors at about the same frequency as before.

[blizzz]

@rullzer from the hip, an idea?

[doftnet]

For whatever it's worth, I'm seeing the same sort of messages in my logs but only for the one LDAP account that has the avatar image stored in the jpegPhoto attribute in the LDAP entry. Other than the logs filing up with these errors, it appears to be working just fine as far as displaying the correct avatar everywhere it ought to be including the android app even though the error appears to be triggered by the android client. Since the only thing on my network that's making any sort of use of that attribute is Nextcloud, for the moment, I'm just going to remove the LDAP stored avatar and use Nextcloud's internal avatar storage and see if that takes care of the log.

[linucksrox]

@blizzz So you fixed #8635 and I have not seen that error since the fix. However, I'm still seeing an inordinate number of these "unlink..." errors in the logs related to the avatar. It feels like we're halfway there!

[szaimen]

Please run occ files:scan-app-data on your instance which should fix the issue. Thanks!
I'm closing this issue due to inactivity. If this is still happening please make sure to upgrade to the latest version. After that, feel free to reopen.