Author |
|
chrishermann Newbie
Joined: 30 May 2017 Location: United Kingdom
Online Status: Offline Posts: 19
|
Posted: 06 June 2017 at 2:54pm | IP Logged
|
|
|
Thought I would try the webmail beta 8 and see how it is standing up. I have been using webmail lite for a while for a home mail server and really like it. A recent move to a new Linux based server using the iredmail postfix et al packages resulted in my having a real good look at both Sogo and Roundcube - neither fo which I like as much as webmail-lite.
I have tried to install the beta at least three times now, and I keep hitting a problem with signing in to the mail accounts. I can logon fine, read mail and generally play with existing messages, but I am unable to send any messages at all.
Mailserver is on the local host.
Any ideas?
Thank you
|
Back to Top |
|
|
Igor AfterLogic Support
Joined: 24 June 2008 Location: United States
Online Status: Offline Posts: 6110
|
Posted: 07 June 2017 at 1:26am | IP Logged
|
|
|
We recommend to sign in as superadmin, enable logging, set Verbosity to Debug, then log back as your email user, reproduce the problem and check the logs.
If you let us know what's in the log file we may be able to help you further.
--
Regards,
Igor, AfterLogic Support
|
Back to Top |
|
|
chrishermann Newbie
Joined: 30 May 2017 Location: United Kingdom
Online Status: Offline Posts: 19
|
Posted: 07 June 2017 at 3:10am | IP Logged
|
|
|
Thanks, I did all that to start with. Gives nothing useful. Just what it says above in the original post. All it says of relevance in the main log is connection refused. User log says the same ... I will create a new test account for the purposes of running the failure, copy and post the full logs and delete the account soon - it shows passwords and usernames in plain text so I do not want to use my usual test account ... will get back to you soon. Thank you
|
Back to Top |
|
|
Igor AfterLogic Support
Joined: 24 June 2008 Location: United States
Online Status: Offline Posts: 6110
|
Posted: 07 June 2017 at 3:13am | IP Logged
|
|
|
Well, "Connection refused" message usually means the port is blocked by a firewall; this may be happening on the server itself, or externally. It's not unusual for ISPs and hosting providers to block SMTP ports for spam prevention purposes.
--
Regards,
Igor, AfterLogic Support
|
Back to Top |
|
|
chrishermann Newbie
Joined: 30 May 2017 Location: United Kingdom
Online Status: Offline Posts: 19
|
Posted: 07 June 2017 at 6:52am | IP Logged
|
|
|
No chance of the SMTP being blocked. It is physically on the same VMware virtual Ubuntu 16.04.02 server. The installation is restricted to localhost anyway. The server was built as a clean install using a minimal Ubuntu 16.04.02 installation iso and now has just the OS/kernel and the iRedmail installation on it with the addition of this Webmail Beta.
Each web app is in its own sub directory and appropriately locked down. I have added a few minor tweaks to the iRedmail system top harden it like stopping Apache show listings, but that is all. I have also successfully installed the old Webmail lite php without any trouble at all.
The machine can go out, but the server is behind a firewall to stop any inbound SMTP traffic to it anyway. It serves a local domain only. It doesn't seem to like the Port 587 and I am not opening up 465 as that has been depreciated anyway and reassigned as I understand it.
I have checked and rechecked the iptables output using -L -n switches and there is no sign of Webmail 8 being blocked - which given it is on localhost and that is set as an ignoreip in fail2ban is exactly as it should be.
I very much doubt it is a firewall issue, it is not going outside for SMTP anyway and it is not even able to send a message to an internal user on the same server.
Anyway, here is the main Webmail 8 Beta log. I cleared everything and then tried to send a message. No log entries were created for the user activity log.
[13:47:58.72][9cc346b9] [POST(4)][ip:172.16.1.124] /wm8/?/Api/
[13:47:58.72][9cc346b9] POST > [Module, Method, TenantName, Parameters]
[13:47:58.72][9cc346b9]
[13:47:58.72][9cc346b9] API: LogsViewerWebclient::ClearLog
[13:48:02.78][e6078348] [POST(4)][ip:172.16.1.124] /wm8/?/Api/
[13:48:02.78][e6078348] POST > [Module, Method, TenantName, Parameters]
[13:48:02.78][e6078348]
[13:48:02.78][e6078348] API: LogsViewerWebclient::GetLogFilesData
[13:48:04.39][6279ad22] [POST(4)][ip:172.16.1.124] /wm8/?/Api/
[13:48:04.39][6279ad22] POST > [Module, Method, TenantName, Parameters]
[13:48:04.39][6279ad22]
[13:48:04.39][6279ad22] API: Contacts::GetContacts
[13:48:04.39][6279ad22] Execute subscription: PersonalContacts::prepareFiltersFromStorage
[13:48:04.39][6279ad22] Arguments before subscription:
[13:48:04.39][6279ad22] Array
(
[Search] =>
[SortField] => 3
[SortOrder] => 1
[Storage] => all
[UserId] => 7
)
[13:48:04.39][6279ad22] Arguments after subscription:
[13:48:04.39][6279ad22] Array
(
[Search] =>
[SortField] => 3
[SortOrder] => 1
[Storage] => all
[UserId] => 7
[Filters] => Array
(
[0] => Array
(
[$AND] => Array
(
[IdUser] => Array
(
&n bsp; [0] => 7
&n bsp; [1] => =
)
[Storage] => Array
(
&n bsp; [0] => personal
&n bsp; [1] => =
)
[Frequency] => Array
(
&n bsp; [0] => -1
&n bsp; [1] => !=
)
)
)
)
)
[13:48:04.39][6279ad22] Subscription result:
[13:48:04.39][6279ad22]
[13:48:06.66][fba82ecd] [POST(4)][ip:172.16.1.124] /wm8/?/Api/
[13:48:06.66][fba82ecd] POST > [Module, Method, TenantName, Parameters]
[13:48:06.66][fba82ecd]
[13:48:06.66][fba82ecd] API: Contacts::GetContacts
[13:48:06.66][fba82ecd] Execute subscription: PersonalContacts::prepareFiltersFromStorage
[13:48:06.66][fba82ecd] Arguments before subscription:
[13:48:06.66][fba82ecd] Array
(
[Search] => test
[SortField] => 3
[SortOrder] => 1
[Storage] => all
[UserId] => 7
)
[13:48:06.66][fba82ecd] Arguments after subscription:
[13:48:06.66][fba82ecd] Array
(
[Search] => test
[SortField] => 3
[SortOrder] => 1
[Storage] => all
[UserId] => 7
[Filters] => Array
(
[0] => Array
(
[$AND] => Array
(
[IdUser] => Array
(
&n bsp; [0] => 7
&n bsp; [1] => =
)
[Storage] => Array
(
&n bsp; [0] => personal
&n bsp; [1] => =
)
[Frequency] => Array
(
&n bsp; [0] => -1
&n bsp; [1] => !=
)
)
)
)
)
[13:48:06.66][fba82ecd] Subscription result:
[13:48:06.66][fba82ecd]
[13:48:07.79][fdbfc2fe] [POST(4)][ip:172.16.1.124] /wm8/?/Api/
[13:48:07.79][fdbfc2fe] POST > [Module, Method, TenantName, Parameters]
[13:48:07.79][fdbfc2fe]
[13:48:07.79][fdbfc2fe] API: LogsViewerWebclient::GetLogFilesData
[13:48:08.46][951444c4] [POST(4)][ip:172.16.1.124] /wm8/?/Api/
[13:48:08.46][951444c4] POST > [Module, Method, TenantName, Parameters]
[13:48:08.46][951444c4]
[13:48:08.46][951444c4] API: Contacts::GetContacts
[13:48:08.46][951444c4] Execute subscription: PersonalContacts::prepareFiltersFromStorage
[13:48:08.46][951444c4] Arguments before subscription:
[13:48:08.46][951444c4] Array
(
[Search] => test@pchmt
[SortField] => 3
[SortOrder] => 1
[Storage] => all
[UserId] => 7
)
[13:48:08.46][951444c4] Arguments after subscription:
[13:48:08.46][951444c4] Array
(
[Search] => test@pchmt
[SortField] => 3
[SortOrder] => 1
[Storage] => all
[UserId] => 7
[Filters] => Array
(
[0] => Array
(
[$AND] => Array
(
[IdUser] => Array
(
&n bsp; [0] => 7
&n bsp; [1] => =
)
[Storage] => Array
(
&n bsp; [0] => personal
&n bsp; [1] => =
)
[Frequency] => Array
(
&n bsp; [0] => -1
&n bsp; [1] => !=
)
)
)
)
)
[13:48:08.46][951444c4] Subscription result:
[13:48:08.46][951444c4]
[13:48:08.88][27628421] [POST(4)][ip:172.16.1.124] /wm8/?/Api/
[13:48:08.88][27628421] POST > [Module, Method, TenantName, Parameters]
[13:48:08.88][27628421]
[13:48:08.88][27628421] API: Contacts::GetContacts
[13:48:08.88][27628421] Execute subscription: PersonalContacts::prepareFiltersFromStorage
[13:48:08.88][27628421] Arguments before subscription:
[13:48:08.88][27628421] Array
(
[Search] => test@pchmt.
[SortField] => 3
[SortOrder] => 1
[Storage] => all
[UserId] => 7
)
[13:48:08.88][27628421] Arguments after subscription:
[13:48:08.88][27628421] Array
(
[Search] => test@pchmt.
[SortField] => 3
[SortOrder] => 1
[Storage] => all
[UserId] => 7
[Filters] => Array
(
[0] => Array
(
[$AND] => Array
(
[IdUser] => Array
(
&n bsp; [0] => 7
&n bsp; [1] => =
)
[Storage] => Array
(
&n bsp; [0] => personal
&n bsp; [1] => =
)
[Frequency] => Array
(
&n bsp; [0] => -1
&n bsp; [1] => !=
)
)
)
)
)
[13:48:08.88][27628421] Subscription result:
[13:48:08.88][27628421]
[13:48:12.81][9daec73e] [POST(4)][ip:172.16.1.124] /wm8/?/Api/
[13:48:12.81][9daec73e] POST > [Module, Method, TenantName, Parameters]
[13:48:12.81][9daec73e]
[13:48:12.81][9daec73e] API: LogsViewerWebclient::GetLogFilesData
[13:48:17.80][554538a4] [POST(4)][ip:172.16.1.124] /wm8/?/Api/
[13:48:17.80][554538a4] POST > [Module, Method, TenantName, Parameters]
[13:48:17.80][554538a4]
[13:48:17.80][554538a4] API: Mail::SendMessage
[13:48:17.81][554538a4] IMAP[NOTE]: Start connection to "tcp://127.0.0.1:143"
[13:48:17.82][554538a4] IMAP[DATA]: < * OK [CAPABILITY IMAP4rev1 LITERAL+ SASL-IR LOGIN-REFERRALS ID ENABLE IDLE STARTTLS AUTH=PLAIN AUTH=LOGIN] Dovecot ready.\r\n
[13:48:17.83][72c48aee] [POST(4)][ip:172.16.1.124] /wm8/?/Api/
[13:48:17.83][72c48aee] POST > [Module, Method, TenantName, Parameters]
[13:48:17.83][72c48aee]
[13:48:17.83][72c48aee] API: LogsViewerWebclient::GetLogFilesData
[13:48:17.86][554538a4] IMAP[SECURE]: > TAG1 LOGIN "wm8b@pchmt.net" "********"\r\n
[13:48:17.87][554538a4] IMAP[DATA]: < TAG1 OK [CAPABILITY IMAP4rev1 LITERAL+ SASL-IR LOGIN-REFERRALS ID ENABLE IDLE SORT SORT=DISPLAY THREAD=REFERENCES THREAD=REFS THREAD=ORDEREDSUBJECT MULTIAPPEND URL-PARTIAL CATENATE UNSELECT CHILDREN NAMESPACE UIDPLUS LIST-EXTENDED I18NLEVEL=1 CONDSTORE QRESYNC ESEARCH ESORT SEARCHRES WITHIN CONTEXT=SEARCH LIST-STATUS BINARY MOVE SPECIAL-USE QUOTA ACL RIGHTS=texk] Logged in\r\n
[13:48:17.87][554538a4] SMTP[NOTE]: Start connection to "tcp://127.0.0.1:587"
[13:48:17.88][554538a4] SMTP[DATA]: < 220 mail2.pchmt.net ESMTP Postfix\r\n
[13:48:17.88][554538a4] SMTP[DATA]: > EHLO mail2.pchmt.net\r\n
[13:48:17.88][554538a4] SMTP[DATA]: < 250-mail2.pchmt.net\r\n
[13:48:17.88][554538a4] SMTP[DATA]: < 250-PIPELINING\r\n
[13:48:17.88][554538a4] SMTP[DATA]: < 250-SIZE 15728640\r\n
[13:48:17.88][554538a4] SMTP[DATA]: < 250-ETRN\r\n
[13:48:17.88][554538a4] SMTP[DATA]: < 250-STARTTLS\r\n
[13:48:17.88][554538a4] SMTP[DATA]: < 250-ENHANCEDSTATUSCODES\r\n
[13:48:17.88][554538a4] SMTP[DATA]: < 250-8BITMIME\r\n
[13:48:17.88][554538a4] SMTP[DATA]: < 250 SMTPUTF8\r\n
[13:48:17.88][554538a4] SMTP[DATA]: > STARTTLS\r\n
[13:48:17.88][554538a4] SMTP[DATA]: < 220 2.0.0 Ready to start TLS\r\n
[13:48:17.89][554538a4] SMTP[DATA]: > EHLO mail2.pchmt.net\r\n
[13:48:17.89][554538a4] SMTP[DATA]: < 250-mail2.pchmt.net\r\n
[13:48:17.89][554538a4] SMTP[DATA]: < 250-PIPELINING\r\n
[13:48:17.89][554538a4] SMTP[DATA]: < 250-SIZE 15728640\r\n
[13:48:17.89][554538a4] SMTP[DATA]: < 250-ETRN\r\n
[13:48:17.89][554538a4] SMTP[DATA]: < 250-AUTH PLAIN LOGIN\r\n
[13:48:17.89][554538a4] SMTP[DATA]: < 250-ENHANCEDSTATUSCODES\r\n
[13:48:17.89][554538a4] SMTP[DATA]: < 250-8BITMIME\r\n
[13:48:17.89][554538a4] SMTP[DATA]: < 250 SMTPUTF8\r\n
[13:48:17.89][554538a4] SMTP[DATA]: > MAIL FROM:<wm8b@pchmt.net> SIZE=940\r\n
[13:48:17.89][554538a4] SMTP[DATA]: < 250 2.1.0 Ok\r\n
[13:48:17.89][554538a4] SMTP[DATA]: > RCPT TO:<test@pchmt.net>\r\n
[13:48:17.89][554538a4] SMTP[DATA]: < 554 5.7.1 <unknown[127.0.0.1]>: Client host rejected: Access denied\r\n
[13:48:17.89][554538a4] SMTP[ERROR]: MailSo\Smtp\Exceptions\NegativeResponseException: 554 5.7.1 <unknown[127.0.0.1]>: Client host rejected: Access denied in /var/www/html/wm8/vendor/afterlogic/mailso/lib/MailSo/Smtp/SmtpClient.php:727
Stack trace:
#0 /var/www/html/wm8/vendor/afterlogic/mailso/lib/MailSo/Smtp/SmtpClient.php(599): MailSo\Smtp\SmtpClient->validateResponse(Array)
#1 /var/www/html/wm8/vendor/afterlogic/mailso/lib/MailSo/Smtp/SmtpClient.php(348): MailSo\Smtp\SmtpClient->sendRequestWithCheck('RCPT', Array, 'TO:<test@pchmt....')
#2 /var/www/html/wm8/modules/Mail/managers/main/manager.php(1271): MailSo\Smtp\SmtpClient->Rcpt('test@pchmt.net')
#3 /var/www/html/wm8/modules/Mail/Module.php(3340): CApiMailMainManager->sendMessage(Object(CMailAccount), Object(MailSo\Mime\Message), NULL, 'Sent', '', '')
#4 [internal function]: Aurora\Modules\Mail\Module->SendMessage(8, '', 800000, Array, '', 'test@pchmt.net', '', '', 'test to dummy u...', '<div data-crea=...', true, 3, false, Array, '', '', 0, 'Sent', '', '', '')
#5 /var/www/html/wm8/system/Module/AbstractModule.php(900): call_user_func_array(Array, Array)
#6 /var/www/html/wm8/modules/Core/Module.php(298): Aurora\System\Module\AbstractModule->CallMethod('SendMessage', Array, true)
#7 [internal function]: Aurora\Modules\Core\Module->EntryApi()
#8 /var/www/html/wm8/system/Module/AbstractModule.php(565): call_user_func_array(Array, Array)
#9 /var/www/html/wm8/system/Module/Manager.php(581): Aurora\System\Module\AbstractModule->RunEntry('api')
#10 /var/www/html/wm8/system/Application.php(80): Aurora\System\Module\Manager->RunEntry('api')
#11 /var/www/html/wm8/index.php(21): Aurora\System\Application::Start()
#12 {main}
[13:48:17.89][554538a4] Previous Exception: 554 5.7.1 <unknown[127.0.0.1]>: Client host rejected: Access denied
[13:48:17.90][554538a4] SMTP[DATA]: > QUIT\r\n
[13:48:17.90][554538a4] SMTP[DATA]: < 221 2.0.0 Bye\r\n
[13:48:17.90][554538a4] SMTP[NOTE]: Disconnected from "tcp://127.0.0.1:587" (success)
[13:48:17.90][554538a4] Aurora\System\Exceptions\ManagerException: API/MAIL_CANNOT_SEND_MESSAGE in /var/www/html/wm8/modules/Mail/managers/main/manager.php:1288
Stack trace:
#0 /var/www/html/wm8/modules/Mail/Module.php(3340): CApiMailMainManager->sendMessage(Object(CMailAccount), Object(MailSo\Mime\Message), NULL, 'Sent', '', '')
#1 [internal function]: Aurora\Modules\Mail\Module->SendMessage(8, '', 800000, Array, '', 'test@pchmt.net', '', '', 'test to dummy u...', '<div data-crea=...', true, 3, false, Array, '', '', 0, 'Sent', '', '', '')
#2 /var/www/html/wm8/system/Module/AbstractModule.php(900): call_user_func_array(Array, Array)
#3 /var/www/html/wm8/modules/Core/Module.php(298): Aurora\System\Module\AbstractModule->CallMethod('SendMessage', Array, true)
#4 [internal function]: Aurora\Modules\Core\Module->EntryApi()
#5 /var/www/html/wm8/system/Module/AbstractModule.php(565): call_user_func_array(Array, Array)
#6 /var/www/html/wm8/system/Module/Manager.php(581): Aurora\System\Module\AbstractModule->RunEntry('api')
#7 /var/www/html/wm8/system/Application.php(80): Aurora\System\Module\Manager->RunEntry('api')
#8 /var/www/html/wm8/index.php(21): Aurora\System\Application::Start()
#9 {main}
Next Aurora\System\Exceptions\ApiException: 554 5.7.1 <unknown[127.0.0.1]>: Client host rejected: Access denied in /var/www/html/wm8/modules/Mail/Module.php:3369
Stack trace:
#0 [internal function]: Aurora\Modules\Mail\Module->SendMessage(8, '', 800000, Array, '', 'test@pchmt.net', '', '', 'test to dummy u...', '<div data-crea=...', true, 3, false, Array, '', '', 0, 'Sent', '', '', '')
#1 /var/www/html/wm8/system/Module/AbstractModule.php(900): call_user_func_array(Array, Array)
#2 /var/www/html/wm8/modules/Core/Module.php(298): Aurora\System\Module\AbstractModule->CallMethod('SendMessage', Array, true)
#3 [internal function]: Aurora\Modules\Core\Module->EntryApi()
#4 /var/www/html/wm8/system/Module/AbstractModule.php(565): call_user_func_array(Array, Array)
#5 /var/www/html/wm8/system/Module/Manager.php(581): Aurora\System\Module\AbstractModule->RunEntry('api')
#6 /var/www/html/wm8/system/Application.php(80): Aurora\System\Module\Manager->RunEntry('api')
#7 /var/www/html/wm8/index.php(21): Aurora\System\Application::Start()
#8 {main}
[13:48:17.90][554538a4] INFO[MEMORY]: Memory peak usage: 2MB
[13:48:17.90][554538a4] INFO[TIME]: Time delta: 1496843297.9005
[13:48:17.90][554538a4] IMAP[DATA]: > TAG2 LOGOUT\r\n
[13:48:17.90][554538a4] IMAP[DATA]: < * BYE Logging out\r\n
[13:48:17.90][554538a4] IMAP[DATA]: < TAG2 OK Logout completed.\r\n
[13:48:17.90][554538a4] IMAP[NOTE]: Disconnected from "tcp://127.0.0.1:143" (success)
[13:48:21.29][4d7f6887] [POST(5)][ip:172.16.1.124] /wm8/?/Api/
[13:48:21.29][4d7f6887] POST > [Module, Method, TenantName, Format, Parameters]
[13:48:21.29][4d7f6887]
[13:48:21.29][4d7f6887] API: LogsViewerWebclient::GetLogFile
|
Back to Top |
|
|
Igor AfterLogic Support
Joined: 24 June 2008 Location: United States
Online Status: Offline Posts: 6110
|
Posted: 07 June 2017 at 7:08am | IP Logged
|
|
|
According to the logs, when sender and recipient info is submitted by WebMail, Postfix responds:
Code:
< 554 5.7.1 <unknown[127.0.0.1]>: Client host rejected: Access denied\r\n |
|
|
That looks like SMTP server configuration issue. One of the ways around that could help is enabling SMTP authentication in settings of WebMail account. Also, you may want to check smtpd_client_restrictions entry in Postfix configuration.
--
Regards,
Igor, AfterLogic Support
|
Back to Top |
|
|
chrishermann Newbie
Joined: 30 May 2017 Location: United Kingdom
Online Status: Offline Posts: 19
|
Posted: 08 June 2017 at 12:31am | IP Logged
|
|
|
Will do. Thx. I'll let you know what I find. I think I already tried the enabling SMTP authentication, but I will try again ...
|
Back to Top |
|
|
chrishermann Newbie
Joined: 30 May 2017 Location: United Kingdom
Online Status: Offline Posts: 19
|
Posted: 08 June 2017 at 12:55am | IP Logged
|
|
|
I was sure I already tried the enabling SMTP authentication, but that did the trick ... must not have tried it with port 587 ... thx
I will go play with it for a while (week or two) and pass back some feedback
|
Back to Top |
|
|
|
|