[horde] Active Sync Error
Andreas Mauser
andreas at mauser.info
Sun May 25 20:28:34 UTC 2025
Zitat von Lang, Ralf <ralf.lang at gmail.com>:
> Hello Andreas,
>
> On 16/05/2025 09:10, Andreas Mauser wrote:
>> Am 16. Mai 2025 um 08:49 schrieb "Ralf Lang"<ralf.lang at gmail.com
>> mailto:ralf.lang at gmail.com?to=%22Ralf%20Lang%22%20%3Cralf.lang%40gmail.com%3E
>> >:
Know what? After last update, ActiveSync on my Android 15 with
9Folders App did sync all emails until today.
Please find below the last update, I just did recently today.
sudo -u www-data composer update
Loading composer repositories with package information
Updating dependencies
Lock file operations: 0 installs, 9 updates, 0 removals
- Upgrading horde/autoloader (v3.0.0alpha4 => v3.0.0alpha5)
- Upgrading horde/cache (v3.0.0alpha4 => v3.1.0)
- Upgrading horde/core (v3.0.0alpha21 => v3.0.0alpha22)
- Upgrading horde/form (v3.0.0alpha5 => v3.0.0alpha6)
- Upgrading horde/group (v3.0.0alpha4 => v3.0.0alpha5)
- Upgrading horde/horde (v6.0.0alpha10 => v6.0.0alpha11)
- Upgrading horde/nag (v5.0.0alpha8 => v5.0.0alpha9)
- Upgrading horde/turba (v5.0.0alpha9 => v5.0.0alpha10)
- Upgrading horde/util (v3.0.0alpha7 => v3.0.0alpha8)
Writing lock file
Installing dependencies from lock file (including require-dev)
Package operations: 0 installs, 9 updates, 0 removals
- Downloading horde/util (v3.0.0alpha8)
- Downloading horde/group (v3.0.0alpha5)
- Downloading horde/cache (v3.1.0)
- Downloading horde/autoloader (v3.0.0alpha5)
- Downloading horde/core (v3.0.0alpha22)
- Downloading horde/form (v3.0.0alpha6)
- Downloading horde/horde (v6.0.0alpha11)
- Downloading horde/nag (v5.0.0alpha9)
- Downloading horde/turba (v5.0.0alpha10)
- Upgrading horde/util (v3.0.0alpha7 => v3.0.0alpha8): Extracting archive
- Upgrading horde/group (v3.0.0alpha4 => v3.0.0alpha5): Extracting archive
- Upgrading horde/cache (v3.0.0alpha4 => v3.1.0): Extracting archive
- Upgrading horde/autoloader (v3.0.0alpha4 => v3.0.0alpha5):
Extracting archive
- Upgrading horde/core (v3.0.0alpha21 => v3.0.0alpha22): Extracting archive
- Upgrading horde/form (v3.0.0alpha5 => v3.0.0alpha6): Extracting archive
- Upgrading horde/horde (v6.0.0alpha10 => v6.0.0alpha11): Extracting archive
- Upgrading horde/nag (v5.0.0alpha8 => v5.0.0alpha9): Extracting archive
- Upgrading horde/turba (v5.0.0alpha9 => v5.0.0alpha10): Extracting archive
Generating autoload files
Applying /presets for absent files in /var/config
Looking for registry snippets from apps
Configuration mode: symlink
Writing app configs to /var/config dir
Linking app configs to /web Dir
Linking javascript tree to /web/js
Linking themes tree to /web/themes
No security vulnerability advisories found
Great progress guys, thank you so much!
>>
>>> hi andreas,
>>> depending in your configuration the error handler writes to
>>> stdout, to a horde log file, to apache/webserver log, to a php-fpm
>>> log or to the syslog/systemd journal. We would need the trace to
>>> help you hunt this down.
>> It is set to log to syslog. Below some of the lines, when start a sync:
>>
>> 2025-05-16T09:09:29.867574+02:00 wm HORDE: #15
>> /var/www/html/wm/vendor/horde/horde/rpc.php(165):
>> Horde_Rpc_ActiveSync->getResponse()
>> 2025-05-16T09:09:29.867787+02:00 wm HORDE: #16 {main} [pid 565 on
>> line 76 of
>> "/var/www/html/wm/vendor/horde/core/lib/Horde/ErrorHandler.php"]
>> 2025-05-16T09:09:34.657124+02:00 wm HORDE: [imp] Login success for
>> andreas (10.0.25.8) (forwarded for [80.152.143.17]) to
>> {imap://10.0.25.2/} [pid 564 on line 145 of
>> "/var/www/html/wm/vendor/horde/imp/lib/Auth.php"]
>> 2025-05-16T09:09:34.733152+02:00 wm*HORDE: ValueError: mb_substr():
>> Argument #4 ($encoding) must be a valid encoding, "windows-1258"
>> given in /var/www/html/wm/vendor/horde/util/lib/Horde/String.php:329*
>
> *HORDE: ValueError: mb_substr(): Argument #4 ($encoding) must be a
> valid encoding, "windows-1258" given in
> /var/www/html/wm/vendor/horde/util/lib/Horde/String.php:329*
>
> Bingo!
>
> That's something I think we can address.
>
> Tickets :: [#15191] ActiveSync: mb_substr croaks on windows native
> encoding <https://bugs.horde.org/ticket/15191>
>
>> 2025-05-16T09:09:34.733442+02:00 wm HORDE: Stack trace:
>> 2025-05-16T09:09:34.734529+02:00 wm HORDE: #0
>> /var/www/html/wm/vendor/horde/util/lib/Horde/String.php(329):
>> mb_substr()
>> 2025-05-16T09:09:34.735295+02:00 wm HORDE: #1
>> /var/www/html/wm/vendor/horde/activesync/lib/Horde/ActiveSync/Imap/MessageBodyData.php(453):
>> Horde_String::substr()
>> 2025-05-16T09:09:34.735997+02:00 wm HORDE: #2
>> /var/www/html/wm/vendor/horde/activesync/lib/Horde/ActiveSync/Imap/MessageBodyData.php(302):
>> Horde_ActiveSync_Imap_MessageBodyData->_getPlainPart()
>> 2025-05-16T09:09:34.736653+02:00 wm HORDE: #3
>> /var/www/html/wm/vendor/horde/activesync/lib/Horde/ActiveSync/Imap/MessageBodyData.php(145):
>> Horde_ActiveSync_Imap_MessageBodyData->_getParts()
>> 2025-05-16T09:09:34.737142+02:00 wm HORDE: #4
>> /var/www/html/wm/vendor/horde/activesync/lib/Horde/ActiveSync/Imap/Message.php(303):
>> Horde_ActiveSync_Imap_MessageBodyData->__construct()
>> 2025-05-16T09:09:34.737430+02:00 wm HORDE: #5
>> /var/www/html/wm/vendor/horde/activesync/lib/Horde/ActiveSync/Imap/EasMessageBuilder.php(514):
>> Horde_ActiveSync_Imap_Message->getMessageBodyDataObject()
>> 2025-05-16T09:09:34.737747+02:00 wm HORDE: #6
>> /var/www/html/wm/vendor/horde/activesync/lib/Horde/ActiveSync/Imap/Adapter.php(811):
>> Horde_ActiveSync_Imap_EasMessageBuilder::create()
>> 2025-05-16T09:09:34.738027+02:00 wm HORDE: #7
>> /var/www/html/wm/vendor/horde/activesync/lib/Horde/ActiveSync/Imap/Adapter.php(423):
>> Horde_ActiveSync_Imap_Adapter->_buildMailMessage()
>> 2025-05-16T09:09:34.738305+02:00 wm HORDE: #8
>> /var/www/html/wm/vendor/horde/core/lib/Horde/Core/ActiveSync/Driver.php(1515):
>> Horde_ActiveSync_Imap_Adapter->getMessages()
>> 2025-05-16T09:09:34.738588+02:00 wm HORDE: #9
>> /var/www/html/wm/vendor/horde/activesync/lib/Horde/ActiveSync/Connector/Exporter/Sync.php(480):
>> Horde_Core_ActiveSync_Driver->getMessage()
>> 2025-05-16T09:09:34.738922+02:00 wm HORDE: #10
>> /var/www/html/wm/vendor/horde/activesync/lib/Horde/ActiveSync/Connector/Exporter/Sync.php(62):
>> Horde_ActiveSync_Connector_Exporter_Sync->_sendNextChange()
>> 2025-05-16T09:09:34.739201+02:00 wm HORDE: #11
>> /var/www/html/wm/vendor/horde/activesync/lib/Horde/ActiveSync/Request/Sync.php(461):
>> Horde_ActiveSync_Connector_Exporter_Sync->sendNextChange()
>> 2025-05-16T09:09:34.739479+02:00 wm HORDE: #12
>> /var/www/html/wm/vendor/horde/activesync/lib/Horde/ActiveSync/Request/Base.php(250):
>> Horde_ActiveSync_Request_Sync->_handle()
>> 2025-05-16T09:09:34.739801+02:00 wm HORDE: #13
>> /var/www/html/wm/vendor/horde/activesync/lib/Horde/ActiveSync.php(833):
>> Horde_ActiveSync_Request_Base->handle()
>> 2025-05-16T09:09:34.740083+02:00 wm HORDE: #14
>> /var/www/html/wm/vendor/horde/rpc/lib/Horde/Rpc/ActiveSync.php(144):
>> Horde_ActiveSync->handleRequest()
>> 2025-05-16T09:09:34.740360+02:00 wm HORDE: #15
>> /var/www/html/wm/vendor/horde/horde/rpc.php(165):
>> Horde_Rpc_ActiveSync->getResponse()
>> 2025-05-16T09:09:34.740639+02:00 wm HORDE: #16 {main} [pid 564 on
>> line 76 of
>> "/var/www/html/wm/vendor/horde/core/lib/Horde/ErrorHandler.php"]
>> 2025-05-16T09:09:35.532481+02:00 wm HORDE: [imp] Login success for
>> andreas (10.0.25.8) (forwarded for [80.152.143.17]) to
>> {imap://10.0.25.2/} [pid 566 on line 145 of
>> "/var/www/html/wm/vendor/horde/imp/lib/Auth.php"]
>> 2025-05-16T09:09:35.565086+02:00 wm HORDE: ValueError: mb_substr():
>> Argument #4 ($encoding) must be a valid encoding, "windows-1256"
>> given in /var/www/html/wm/vendor/horde/util/lib/Horde/String.php:329
>> 2025-05-16T09:09:35.565890+02:00 wm HORDE: Stack trace:
>> 2025-05-16T09:09:35.566352+02:00 wm HORDE: #0
>> /var/www/html/wm/vendor/horde/util/lib/Horde/String.php(329):
>> mb_substr()
>> 2025-05-16T09:09:35.566956+02:00 wm HORDE: #1
>> /var/www/html/wm/vendor/horde/activesync/lib/Horde/ActiveSync/Imap/MessageBodyData.php(453):
>> Horde_String::substr()
>> 2025-05-16T09:09:35.567631+02:00 wm HORDE: #2
>> /var/www/html/wm/vendor/horde/activesync/lib/Horde/ActiveSync/Imap/MessageBodyData.php(302):
>> Horde_ActiveSync_Imap_MessageBodyData->_getPlainPart()
>> 2025-05-16T09:09:35.567988+02:00 wm HORDE: #3
>> /var/www/html/wm/vendor/horde/activesync/lib/Horde/ActiveSync/Imap/MessageBodyData.php(145):
>> Horde_ActiveSync_Imap_MessageBodyData->_getParts()
>> 2025-05-16T09:09:35.568248+02:00 wm HORDE: #4
>> /var/www/html/wm/vendor/horde/activesync/lib/Horde/ActiveSync/Imap/Message.php(303):
>> Horde_ActiveSync_Imap_MessageBodyData->__construct()
>> 2025-05-16T09:09:35.568524+02:00 wm HORDE: #5
>> /var/www/html/wm/vendor/horde/activesync/lib/Horde/ActiveSync/Imap/EasMessageBuilder.php(514):
>> Horde_ActiveSync_Imap_Message->getMessageBodyDataObject()
>> 2025-05-16T09:09:35.568827+02:00 wm HORDE: #6
>> /var/www/html/wm/vendor/horde/activesync/lib/Horde/ActiveSync/Imap/Adapter.php(811):
>> Horde_ActiveSync_Imap_EasMessageBuilder::create()
>> 2025-05-16T09:09:35.569089+02:00 wm HORDE: #7
>> /var/www/html/wm/vendor/horde/activesync/lib/Horde/ActiveSync/Imap/Adapter.php(423):
>> Horde_ActiveSync_Imap_Adapter->_buildMailMessage()
>> 2025-05-16T09:09:35.569304+02:00 wm HORDE: #8
>> /var/www/html/wm/vendor/horde/core/lib/Horde/Core/ActiveSync/Driver.php(1515):
>> Horde_ActiveSync_Imap_Adapter->getMessages()
>> 2025-05-16T09:09:35.569555+02:00 wm HORDE: #9
>> /var/www/html/wm/vendor/horde/activesync/lib/Horde/ActiveSync/Connector/Exporter/Sync.php(480):
>> Horde_Core_ActiveSync_Driver->getMessage()
>> 2025-05-16T09:09:35.569760+02:00 wm HORDE: #10
>> /var/www/html/wm/vendor/horde/activesync/lib/Horde/ActiveSync/Connector/Exporter/Sync.php(62):
>> Horde_ActiveSync_Connector_Exporter_Sync->_sendNextChange()
>> 2025-05-16T09:09:35.570013+02:00 wm HORDE: #11
>> /var/www/html/wm/vendor/horde/activesync/lib/Horde/ActiveSync/Request/Sync.php(461):
>> Horde_ActiveSync_Connector_Exporter_Sync->sendNextChange()
>> 2025-05-16T09:09:35.570264+02:00 wm HORDE: #12
>> /var/www/html/wm/vendor/horde/activesync/lib/Horde/ActiveSync/Request/Base.php(250):
>> Horde_ActiveSync_Request_Sync->_handle()
>> 2025-05-16T09:09:35.570472+02:00 wm HORDE: #13
>> /var/www/html/wm/vendor/horde/activesync/lib/Horde/ActiveSync.php(833):
>> Horde_ActiveSync_Request_Base->handle()
>> 2025-05-16T09:09:35.570705+02:00 wm HORDE: #14
>> /var/www/html/wm/vendor/horde/rpc/lib/Horde/Rpc/ActiveSync.php(144):
>> Horde_ActiveSync->handleRequest()
>> 2025-05-16T09:09:35.570964+02:00 wm HORDE: #15
>> /var/www/html/wm/vendor/horde/horde/rpc.php(165):
>> Horde_Rpc_ActiveSync->getResponse()
>> 2025-05-16T09:09:35.571214+02:00 wm HORDE: #16 {main} [pid 566 on
>> line 76 of
>> "/var/www/html/wm/vendor/horde/core/lib/Horde/ErrorHandler.php"]
>>
>>
>>
>>
>>> also helpful: composer.json and composer.log file, horde test page content
>> Here is what I have in the webmail root:
>>
>> /var/www/html/wm# ls
>> composer.json composer.lock presets README.md var vendor web
>>
>> Here is the composer.json:
>>
>> /var/www/html/wm# cat composer.json
>> {
>> "name": "horde/bundle",
>> "description": "A base project for a horde installation",
>> "type": "project",
>> "require": {
>> "composer-plugin-api": "^2.0",
>> "horde/horde-installer-plugin": "^2.5.1 ||
>> dev-FRAMEWORK_6_0 || dev-master",
>> "horde/horde": "^6 || dev-FRAMEWORK_6_0",
>> "horde/routes": "^3 || dev-FRAMEWORK_6_0",
>> "horde/hordectl": "^1 || dev-FRAMEWORK_6_0 || dev-master",
>> "pear/console_color2": "^0.1.2",
>> "pear/console_table": "^1.3",
>> "horde/kronolith": "^5",
>> "horde/nag": "^5",
>> "horde/content": "^3",
>> "horde/timeobjects": "^3",
>> "horde/mnemo": "^5",
>> "horde/turba": "^5",
>> "horde/passwd": "^6.0 at alpha",
>> "horde/imp": "^7",
>> "horde/ingo": "^4",
>> "horde/activesync": "^3",
>> "horde/memcache": "^3.0 at alpha"
>> },
>> "require-dev": {
>> "horde/test": "^3 || dev-FRAMEWORK_6_0 || dev-master"
>> },
>> "license": "GPL-3.0-only",
>> "authors": [
>> {
>> "name": "Ralf Lang",
>> "email":"ralf.lang at ralf-lang.de"
>> }
>> ],
>> "minimum-stability": "dev",
>> "prefer-stable": true,
>> "extra": {
>> "installer-types": [
>> "horde-library",
>> "horde-application"
>> ]
>> },
>> "config": {
>> "allow-plugins": {
>> "horde/horde-installer-plugin": true
>> }
>> }
>> }
>
> Much appreciated.
>
> I should probably build a helper for fetching this kind of report
> from the users.
>
> Regards
>
>
> Ralf
More information about the horde
mailing list