[horde] Problem with sending mail via mobile interface

Jens Grüntjes jens.gruentjes at ebira.de
Tue Nov 6 22:26:48 UTC 2012


Zitat von Michael M Slusarz <slusarz at horde.org>:

> Quoting Jens Grüntjes <jens.gruentjes at ebira.de>:
>
>> Zitat von Michael M Slusarz <slusarz at horde.org>:
>>
>>> Quoting Jens Grüntjes <jens.gruentjes at ebira.de>:
>>>
>>>> Zitat von Jens Grüntjes <jens.gruentjes at ebira.de>:
>>>>
>>>>> Zitat von Michael M Slusarz <slusarz at horde.org>:
>>>>>
>>>>>> Quoting Jens Grüntjes <jens.gruentjes at ebira.de>:
>>>>>>
>>>>>>> Hello list,
>>>>>>>
>>>>>>> when I send a mail via smartphone I receive an error message  
>>>>>>> saying "Beim Versenden der Nachricht ist ein Fehler  
>>>>>>> aufgetreten: Ungültige E-Mail-Adresse ( )." In English it  
>>>>>>> means something like "Error while sending mail: Invalid  
>>>>>>> E-Mail-Address ( )." (Sorry, I could not get the english  
>>>>>>> message because changing the language at the login page seems  
>>>>>>> to be overwritten by some preference I guess, so the error  
>>>>>>> message is in german.)
>>>>>>>
>>>>>>> Obviously the E-Mail-Address is empty. In the Horde-Logfile I  
>>>>>>> find the following entry
>>>>>>>
>>>>>>> 2012-10-31T09:49:04+00:00 ERR: HORDE [imp] Ungültige  
>>>>>>> E-Mail-Adresse ( ). [pid 10135 on line 1155 of  
>>>>>>> "/var/www/horde/imp/lib/Compose.php"]
>>>>>>>
>>>>>>> It is interesting that the mail is however sent to the  
>>>>>>> recipient but does *not* show up in my sent-mail folder. Did I  
>>>>>>> misconfigure something?
>>>>>>
>>>>>> My guess is that the charset of your DB changed and you did not  
>>>>>> convert your values (Horde/IMP can't do this for you).
>>>>>>
>>>>>> michael
>>>>>
>>>>> Which values are you referring to? I *guess* that nothing in the  
>>>>> databases although it is possible that changes were made during  
>>>>> a mysql-upgrade in the last time. But I know that I didn't make  
>>>>> any changes to databases myself. I am not a DB-specialist but I  
>>>>> can see that all tables in the horde-related DBs have the  
>>>>> collation set to "utf8_general_ci". Can you tell me how to find  
>>>>> out if the values in the DB have the wrong charset?
>>>>>
>>>>> But apart from that, should the error also occur if the  
>>>>> recipient's name does not contain any special chars like  
>>>>> umlauts? It's only a guess.
>>>>>
>>>>> -- 
>>>>> Viele Grüße
>>>>> Jens
>>>>
>>>> I tried to debug a bit, so here is some output while trying to  
>>>> send a mail via mobile. As there are other users using horde at  
>>>> the same time it is possible that I mixed up some log entries  
>>>> and/or I forgot some lines. Maybe you can tell me which lines are  
>>>> interesting for further debugging.
>>>
>>> Check your identity.  Is your from address:
>>>
>>> Jens Grüntjes <jens.gruentjes at ebira.de>
>>>
>>> as opposed to:
>>>
>>> "Jens Grüntjes" <jens.gruentjes at ebira.de>
>>>
>>> That first e-mail address is invalid.  We probably weren't so  
>>> strict previously in allowing that, but now we are.  If verified,  
>>> we should probably upgrade this in an upgrade task.
>>>
>>> michael
>>>
>>> ___________________________________
>>> Michael Slusarz [slusarz at horde.org]
>>
>> In the mobile interface (I hope that's what you mean by identity)  
>> the From-Address shows up as
>>
>> Jens Grüntjes <jens.gruentjes at ebira.de>
>>
>> So there are no "" around my name. In the horde identities I can't  
>> see the "" either but I think they shouldn't be there or should they?
>
> I tested this personally, and this doesn't matter - the identity is  
> correctly converted to a valid e-mail address when sending when the  
> personal part of the email address contains non-7bit characters.
>
> You'll either have to debug yourself or else try deleting your  
> identity and re-adding and see if that helps.
>
> michael
>
> ___________________________________
> Michael Slusarz [slusarz at horde.org]

Hello and sorry for the following lengthy mail but as I didn't know  
what is important for you experts I copied and pasted a lot.

I've deleted my identity but that didn't change anything.


Then I tried to debug a little more by changing Horde's log level to DEBUG.
This is the output of sending via the "standard" interface on my  
desktop computer:

2012-11-06T21:44:01+00:00 DEBUG: HORDE Connected to the following  
memcache servers:localhost:11211 [pid 10595 on line 163 of  
"/usr/share/php/Horde/Memcache.php"]
2012-11-06T21:44:01+00:00 DEBUG: HORDE Horde_Registry: retrieved app  
with cache ID  
horde_registry|app|1351668179|9bebaa886f21f24da33182ded9057727 [pid  
10595 on line 1969 of "/usr/share/php/Horde/Registry.php"]
2012-11-06T21:44:01+00:00 DEBUG: HORDE [imp] Load config file  
(conf.php; app: imp) [pid 10595 on line 477 of  
"/usr/share/php/Horde.php"]
2012-11-06T21:44:01+00:00 DEBUG: HORDE [imp] Load config file  
(hooks.php; app: imp) [pid 10595 on line 477 of  
"/usr/share/php/Horde.php"]
2012-11-06T21:44:01+00:00 DEBUG: HORDE [imp] SQL  (0,0006s)
         SELECT COUNT(*) FROM imp_sentmail WHERE sentmail_ts > 1352151841 AND
           sentmail_who = 'jens' [pid 10595 on line 806 of  
"/usr/share/php/Horde/Db/Adapter/Base.php"]
2012-11-06T21:44:02+00:00 DEBUG: HORDE [imp] SQL  (0,0013s)
         INSERT INTO imp_sentmail (sentmail_who, sentmail_ts,
           sentmail_messageid, sentmail_action, sentmail_recipient,
           sentmail_success) VALUES ('jens', 1352238242,
            
'<20121106214401.Horde.9Sx9d0rzi9JQmYSh6UJiljA at mail.ebira.de>', 'new',
           'jens.gruentjes at provider.de', 1) [pid 10595 on line 806 of  
"/usr/share/php/Horde/Db/Adapter/Base.php"]
2012-11-06T21:44:02+00:00 INFO: HORDE [imp] 94.79.128.222 Message sent  
to Jens Gruentjes <jens.gruentjes at provider.de> from jens [pid 10595 on  
line 866 of "/var/www/horde/imp/lib/Compose.php"]
2012-11-06T21:44:02+00:00 DEBUG: HORDE [imp] Nachricht "Test Desktop"  
wurde erfolgreich versendet. [pid 10595 on line 27 of  
"/usr/share/php/Horde/Core/Notification/Handler/Decorator/Hordelog.php"]
2012-11-06T21:44:02+00:00 DEBUG: HORDE [imp] SQL  (0,0007s)
         SELECT alarm_id, alarm_uid, alarm_start, alarm_end, alarm_methods,
           alarm_params, alarm_title, alarm_text, alarm_snooze, alarm_internal
           FROM horde_alarms WHERE alarm_dismissed = 0 AND  
((alarm_snooze IS NULL
           AND alarm_start <= '2012-11-06T21:44:02') OR alarm_snooze <=
           '2012-11-06T21:44:02') AND (alarm_end IS NULL OR alarm_end >=
           '2012-11-06T21:44:02') AND (alarm_uid IS NULL OR alarm_uid = '' OR
           alarm_uid = 'jens') ORDER BY alarm_start, alarm_end [pid  
10595 on line 806 of "/usr/share/php/Horde/Db/Adapter/Base.php"]
2012-11-06T21:44:02+00:00 DEBUG: HORDE [imp] Max memory usage: 6291456  
bytes [pid 10595 on line 542 of "/usr/share/php/Horde/Registry.php"]

Then I had a look at the database which looks okay to me (I took the  
value for sentmail_ts from the INSERT):

mysql> SELECT * FROM imp_sentmail WHERE sentmail_ts >= 1352238242 AND  
sentmail_who = 'jens';
+-------------+--------------+-------------+--------------------------------------------------------------+-----------------+----------------------------+------------------+
| sentmail_id | sentmail_who | sentmail_ts | sentmail_messageid         
                                    | sentmail_action |  
sentmail_recipient         | sentmail_success |
+-------------+--------------+-------------+--------------------------------------------------------------+-----------------+----------------------------+------------------+
|        7886 | jens         |  1352238242 |  
<20121106214401.Horde.9Sx9d0rzi9JQmYSh6UJiljA at mail.ebira.de> | new      
         | jens.gruentjes at provider.de |                1 |
+-------------+--------------+-------------+--------------------------------------------------------------+-----------------+----------------------------+------------------+


Now this is the output of sending via smartphone

2012-11-06T22:04:33+00:00 DEBUG: HORDE Connected to the following  
memcache servers:localhost:11211 [pid 10596 on line 163 of  
"/usr/share/php/Horde/Memcache.php"]
2012-11-06T22:04:33+00:00 DEBUG: HORDE Horde_Registry: retrieved app  
with cache ID  
horde_registry|app|1351668179|99d0f6250d0d744d46d0d7b10956c5ec [pid  
10596 on line 1969 of "/usr/share/php/Horde/Registry.php"]
2012-11-06T22:04:33+00:00 DEBUG: HORDE [imp] Load config file  
(conf.php; app: imp) [pid 10596 on line 477 of  
"/usr/share/php/Horde.php"]
2012-11-06T22:04:33+00:00 DEBUG: HORDE [imp] Load config file  
(hooks.php; app: imp) [pid 10596 on line 477 of  
"/usr/share/php/Horde.php"]
2012-11-06T22:04:33+00:00 DEBUG: HORDE [imp] Connected to the  
following memcache servers:localhost:11211 [pid 10596 on line 163 of  
"/usr/share/php/Horde/Memcache.php"]
2012-11-06T22:04:33+00:00 DEBUG: HORDE [imp] Connected to the  
following memcache servers:localhost:11211 [pid 10596 on line 163 of  
"/usr/share/php/Horde/Memcache.php"]
2012-11-06T22:04:33+00:00 DEBUG: HORDE [imp] SQL  (0,0006s)
         SELECT COUNT(*) FROM imp_sentmail WHERE sentmail_ts > 1352153073 AND
           sentmail_who = 'jens' [pid 10596 on line 806 of  
"/usr/share/php/Horde/Db/Adapter/Base.php"]
2012-11-06T22:04:33+00:00 DEBUG: HORDE [imp] SQL  (0,0014s)
         INSERT INTO imp_sentmail (sentmail_who, sentmail_ts,
           sentmail_messageid, sentmail_action, sentmail_recipient,
           sentmail_success) VALUES ('jens', 1352239473,
            
'<20121106220433.Horde.k-N6CErzi9JQmYlxZnNilkA at mail.ebira.de>', 'new',
           'jens.gruentjes at provider.de', 1) [pid 10596 on line 806 of  
"/usr/share/php/Horde/Db/Adapter/Base.php"]
2012-11-06T22:04:33+00:00 DEBUG: HORDE [imp] SQL  (0,0010s)
         SELECT COUNT(*) FROM imp_sentmail WHERE sentmail_ts > 1352153073 AND
           sentmail_who = 'jens' [pid 10596 on line 806 of  
"/usr/share/php/Horde/Db/Adapter/Base.php"]
2012-11-06T22:04:33+00:00 ERR: HORDE [imp] Ungültige E-Mail-Adresse  
( ). [pid 10596 on line 1155 of "/var/www/horde/imp/lib/Compose.php"]
2012-11-06T22:04:33+00:00 DEBUG: HORDE 1.  
Horde_Core_Ajax_Application->doAction()  
/var/www/horde/services/ajax.php:56
2. call_user_func() /usr/share/php/Horde/Core/Ajax/Application.php:155
3. IMP_Ajax_Application_Handler_Common->sendMessage()
4. IMP_Compose->buildAndSendMessage()  
/var/www/horde/imp/lib/Ajax/Application/Handler/Common.php:485
5. IMP_Compose->sendMessage() /var/www/horde/imp/lib/Compose.php:823
6. IMP_Compose->_prepSendMessage() /var/www/horde/imp/lib/Compose.php:1037
7. IMP_Compose->_prepSendMessageEncode()  
/var/www/horde/imp/lib/Compose.php:1081

2012-11-06T22:04:33+00:00 DEBUG: HORDE [imp] SQL  (0,0007s)
         INSERT INTO imp_sentmail (sentmail_who, sentmail_ts,
           sentmail_messageid, sentmail_action, sentmail_recipient,
           sentmail_success) VALUES ('jens', 1352239473,
            
'<20121106220433.Horde.k-N6CErzi9JQmYlxZnNilkA at mail.ebira.de>', 'new',
           ' ', 0) [pid 10596 on line 806 of  
"/usr/share/php/Horde/Db/Adapter/Base.php"]
2012-11-06T22:04:33+00:00 DEBUG: HORDE [imp] Beim Versenden der  
Nachricht ist ein Fehler aufgetreten: Ungültige E-Mail-Adresse ( ).  
[pid 10596 on line 27 of  
"/usr/share/php/Horde/Core/Notification/Handler/Decorator/Hordelog.php"]
2012-11-06T22:04:33+00:00 DEBUG: HORDE [imp] SQL  (0,0006s)
         SELECT alarm_id, alarm_uid, alarm_start, alarm_end, alarm_methods,
           alarm_params, alarm_title, alarm_text, alarm_snooze, alarm_internal
           FROM horde_alarms WHERE alarm_dismissed = 0 AND  
((alarm_snooze IS NULL
           AND alarm_start <= '2012-11-06T22:04:33') OR alarm_snooze <=
           '2012-11-06T22:04:33') AND (alarm_end IS NULL OR alarm_end >=
           '2012-11-06T22:04:33') AND (alarm_uid IS NULL OR alarm_uid = '' OR
           alarm_uid = 'jens') ORDER BY alarm_start, alarm_end [pid  
10596 on line 806 of "/usr/share/php/Horde/Db/Adapter/Base.php"]
2012-11-06T22:04:34+00:00 DEBUG: HORDE [imp] Max memory usage: 6029312  
bytes [pid 10596 on line 542 of "/usr/share/php/Horde/Registry.php"]

Obviously there are two SELECT and two INSERT statements but I don't  
know why this happens. The second INSERT contains the value ' ' as  
sentmail_recipient. If I execute a similar SQL-statement as in the  
desktop-example then I get this result:

mysql> SELECT * FROM imp_sentmail WHERE sentmail_ts >= 1352239473 AND  
sentmail_who = 'jens';
+-------------+--------------+-------------+--------------------------------------------------------------+-----------------+----------------------------+------------------+
| sentmail_id | sentmail_who | sentmail_ts | sentmail_messageid         
                                    | sentmail_action |  
sentmail_recipient         | sentmail_success |
+-------------+--------------+-------------+--------------------------------------------------------------+-----------------+----------------------------+------------------+
|        7887 | jens         |  1352239473 |  
<20121106220433.Horde.k-N6CErzi9JQmYlxZnNilkA at mail.ebira.de> | new      
         | jens.gruentjes at provider.de |                1 |
|        7888 | jens         |  1352239473 |  
<20121106220433.Horde.k-N6CErzi9JQmYlxZnNilkA at mail.ebira.de> | new      
         | �                          |                0 |
+-------------+--------------+-------------+--------------------------------------------------------------+-----------------+----------------------------+------------------+

As I mentioned in a post before the mail is sent in both cases but in  
the latter I get an error message on my phone saying the mail could  
not be sent and the mail is not saved in the sent-mail folder.

Any further help is greatly appreciated. And thanks for reading until here.
-- 
Viele Grüße
Jens



More information about the horde mailing list