Tickets :: [#13276] ActiveSync Outlook 2013 E-Mails get sent twice

6.0.0-beta1

7/6/25

Summary	ActiveSync Outlook 2013 E-Mails get sent twice
Queue	Horde Groupware Webmail Edition
Queue Version	5.1.4
Type	Bug
State	Resolved
Priority	1. Low
Owners	mrubinsk (at) horde (dot) org
Requester	stefan (at) stmq (dot) de
Created	06/20/2014 (4034 days ago)
Due
Updated	07/09/2014 (4015 days ago)
Assigned	06/20/2014 (4034 days ago)
Resolved	07/09/2014 (4015 days ago)
Github Issue Link
Github Pull Request
Milestone
Patch	No

07/09/2014 04:18:33 PM	Michael Rubinsky	State ⇒ Resolved

06/30/2014 04:47:41 PM	Michael Rubinsky	Comment #9 Assigned to Michael Rubinsky	Reply to this comment
Possibly fixed by these two commits in Horde_ActiveSync and Horde_Core. Cannot reproduce, so I'm not 100% sure this fixes.

06/30/2014 04:45:31 PM	Git Commit	Comment #8	Reply to this comment
Changes have been made in Git (master): commit 459b32988884812655066d1d3c57f69769b8cc4b Author: Michael J Rubinsky <mrubinsk@horde.org> Date: Mon Jun 30 12:44:00 2014 -0400 ~~Bug: 13276~~ Log, and then ignore, exceptions when trying to get maillog. .../Core/lib/Horde/Core/ActiveSync/Driver.php \| 3 +++ 1 files changed, 3 insertions(+), 0 deletions(-) http://github.com/horde/horde/commit/459b32988884812655066d1d3c57f69769b8cc4b

06/30/2014 04:45:29 PM	Git Commit	Comment #7	Reply to this comment
Changes have been made in Git (master): commit 4baf29293d184734a0f91e44e954131aa9b8eb26 Author: Michael J Rubinsky <mrubinsk@horde.org> Date: Mon Jun 30 12:43:29 2014 -0400 ~~Bug: 13276~~ Catch exceptions from Horde_Imap_Client. .../lib/Horde/ActiveSync/Imap/Adapter.php \| 7 ++++++- 1 files changed, 6 insertions(+), 1 deletions(-) http://github.com/horde/horde/commit/4baf29293d184734a0f91e44e954131aa9b8eb26

06/27/2014 07:54:28 AM	stefan (at) stmq (dot) de	Comment #6	Reply to this comment
Here is the relevant log from horde: 2014-06-27T07:02:13+00:00 ERR: HORDE [horde] Returning HTTP 500 while handling SendMail command. [pid 9952 on line 156 of "/usr/share/horde/rpc.php"] 2014-06-27T07:02:13+00:00 ERR: HORDE [horde] Error in communicating with ActiveSync server: Fehler während der Kommunikation mit dem E-Mail-Server. [pid 9952 on line 162 of "/usr/share/php/Horde/Rpc/ActiveSync.php"] 2014-06-27T07:02:13+00:00 ERR: HORDE [horde] #0 /usr/share/php/Horde/Imap/Client/Socket.php(4252): Horde_Imap_Client_Socket_Connection_Socket->read() #1 /usr/share/php/Horde/Imap/Client/Socket.php(4048): Horde_Imap_Client_Socket->_getLine(Object(Horde_Imap_Client_Interaction_Pipeline)) #2 /usr/share/php/Horde/Imap/Client/Socket.php(3970): Horde_Imap_Client_Socket->_sendCmdChunk(Object(Horde_Imap_Client_Interaction_Pipeline), Array) #3 /usr/share/php/Horde/Imap/Client/Socket.php(2269): Horde_Imap_Client_Socket->_sendCmd(Object(Horde_Imap_Client_Interaction_Pipeline)) #4 /usr/share/php/Horde/Imap/Client/Base.php(2193): Horde_Imap_Client_Socket->_search(Object(Horde_Imap_Client_Search_Query), Array) #5 /usr/share/php/Horde/ActiveSync/Imap/Adapter.php(547): Horde_Imap_Client_Base->search(Object(Horde_Imap_Client_Mailbox), Object(Horde_Imap_Client_Search_Query)) #6 /usr/share/php/Horde/Core/ActiveSync/Driver.php(1585): Horde_ActiveSync_Imap_Adapter->getUidFromMidInFolders('<6D0711C7-5B85-...', Array) #7 /usr/share/php/Horde/ActiveSync/Request/SendMail.php(115): Horde_Core_ActiveSync_Driver->sendMail(NULL, false, false, NULL, NULL, Object(Horde_ActiveSync_Message_SendMail)) #8 /usr/share/php/Horde/ActiveSync/Request/SendMail.php(66): Horde_ActiveSync_Request_SendMail->_handleWbxmlRequest() #9 /usr/share/php/Horde/ActiveSync/Request/Base.php(253): Horde_ActiveSync_Request_SendMail->_handle() ~~#10~~ /usr/share/php/Horde/ActiveSync.php(880): Horde_ActiveSync_Request_Base->handle() ~~#11~~ /usr/share/php/Horde/Rpc/ActiveSync.php(143): Horde_ActiveSync->handleRequest('SendMail', 'C23793BF3914476...') ~~#12~~ /usr/share/horde/rpc.php(156): Horde_Rpc_ActiveSync->getResponse(NULL) #13 {main} [pid 9952 on line 162 of "/usr/share/php/Horde/Rpc/ActiveSync.php"] 2014-06-27T07:02:13+00:00 ERR: HORDE [horde] Buffer contents: [pid 9952 on line 162 of "/usr/share/php/Horde/Rpc/ActiveSync.php"]

06/27/2014 07:28:39 AM	stefan (at) stmq (dot) de	Comment #5 New Attachment: imap_log_twice_email_bug.txt	Reply to this comment
This is my horde debug log. That's not what I asked for. Mr. Rubinsky, is this what you asked for?

06/25/2014 07:05:05 PM	Michael Rubinsky	Comment #4	Reply to this comment
This is my horde debug log. That's not what I asked for.

06/25/2014 11:57:15 AM	stefan (at) stmq (dot) de	Comment #3 New Attachment: horde_debug.log	Reply to this comment
This looks like an error with the imap server or the imap client library. Please provide imap debug and sync debug logs for further assistance. This is my horde debug log.

06/21/2014 09:23:50 PM	Michael Rubinsky	Summary ⇒ ActiveSync Outlook 2013 E-Mails get sent twice

06/20/2014 05:12:05 PM	Michael Rubinsky	Comment #2 State ⇒ Feedback	Reply to this comment
This looks like an error with the imap server or the imap client library. Please provide imap debug and sync debug logs for further assistance.

06/20/2014 12:51:36 PM	stefan (at) stmq (dot) de	Comment #1 Patch ⇒ No State ⇒ Unconfirmed Milestone ⇒ Queue ⇒ Horde Groupware Webmail Edition Summary ⇒ Active Sync Outlook 2013 E-Mails get send twice Type ⇒ Bug Priority ⇒ 1. Low	Reply to this comment
When sending Mails with Outlook 2013 and Active Sync enabled, the mail sometimes get send twice because of the following error: HORDE: [horde] Returning HTTP 500 while handling SendMail command. [pid 13656 on line 156 of "/usr/share/horde/rpc.php"] HORDE: [horde] Error in communicating with ActiveSync server: Fehler während der Kommunikation mit dem E-Mail-Server. [pid 13656 on line 162 of "/usr/share/php/Horde/Rpc/ActiveSync.php"] HORDE: [horde] #0 /usr/share/php/Horde/Imap/Client/Socket.php(4228): Horde_Imap_Client_Socket_Connection_Socket->read()#012#1 /usr/share/php/Horde/Imap/Client/Socket.php(4024): Horde_Imap_Client_Socket->_getLine(Object(Horde_Imap_Client_Interaction_Pipeline))#012#2 /usr/share/php/Horde/Imap/Client/Socket.php(3946): Horde_Imap_Client_Socket->_sendCmdChunk(Object(Horde_Imap_Client_Interaction_Pipeline), Array)#012#3 /usr/share/php/Horde/Imap/Client/Socket.php(2245): Horde_Imap_Client_Socket->_sendCmd(Object(Horde_Imap_Client_Interaction_Pipeline))#012#4 /usr/share/php/Horde/Imap/Client/Base.php(2189): Horde_Imap_Client_Socket->_search(Object(Horde_Imap_Client_Search_Query), Array)#012#5 /usr/share/php/Horde/ActiveSync/Imap/Adapter.php(547): Horde_Imap_Client_Base->search(Object(Horde_Imap_Client_Mailbox), Object(Horde_Imap_Client_Search_Query))#012#6 /usr/share/php/Horde/Core/ActiveSync/Driver.php(1585): Horde_ActiveSync_Imap_Adapter->getUidFromMidInFolders('<53A429F5.90407...', Array)#012#7 /usr/share/php/Horde/ActiveSync/Request/SendMail.php(115): Horde_Core_ActiveSync_Driver->sendMail(NULL, false, false, NULL, NULL, Object(Horde_ActiveSync_Message_SendMail))#012#8 /usr/share/php/Horde/ActiveSync/Request/SendMail.php(66): Horde_ActiveSync_Request_SendMail->_handleWbxmlRequest()#012#9 /usr/share/php/Horde/ActiveSync/Request/Base.php(253): Horde_ActiveSync_Request_SendMail->_handle()#012#10 /usr/share/php/Horde/ActiveSync.php(880): Horde_ActiveSync_Request_Base->handle()#012#11 /usr/share/php/Horde/Rpc/ActiveSync.php(143): Horde_ActiveSync->handleRequest('SendMail', 'C23793BF3914476...')#012#12 /usr/share/horde/rpc.php(156): Horde_Rpc_ActiveSync->getResponse(NULL)#012#13 {main} [pid 13656 on line 162 of "/usr/share/php/Horde/Rpc/ActiveSync.php"] HORDE: [horde] Buffer contents: [pid 13656 on line 162 of "/usr/share/php/Horde/Rpc/ActiveSync.php"]