[horde] Active Sync Error
Andreas Mauser
andreas at mauser.info
Fri May 16 07:10:32 UTC 2025
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 >:
>
> 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
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
}
}
}
>
> Andreas Mauser <andreas at mauser.info mailto:andreas at mauser.info > schrieb am Fr., 16. Mai 2025, 08:44:
>
> >
> > Hi,
> >
> > everytinme I want to sync I get those:
> >
> > HORDE[1478752]: #16 {main} [pid 1478752 on line 76 of "/var/www/html/wm/vendor/horde/core/lib/Horde/ErrorHandler.php"]
> >
> > Message from syslogd at wm at May 16 08:41:31 ...
> > HORDE: #16 {main} [pid 1478752 on line 76 of "/var/www/html/wm/vendor/horde/core/lib/Horde/ErrorHandler.php"]
> >
> > There is no php.log.
> > What can I do? I see no approach for me to start looking.
> >
> > Best regards,
> > Andreas
> > --
> > Horde mailing list
> > Frequently Asked Questions: http://horde.org/faq/
> > To unsubscribe, mail: horde-unsubscribe at lists.horde.org mailto:horde-unsubscribe at lists.horde.org
> >
>
Mit freundlichen Grüßen,
Andreas Mauser
+49 160 551 1166
Frankfurt am Main
More information about the horde
mailing list