Web interface (port 4044) stopped working

Support forum for MailWasher Enterprise Server
gorilladaze
Rattled Rabbit
Posts: 4
Joined: Tue Oct 06, 2015 1:38 am

Web interface (port 4044) stopped working

Tue Oct 06, 2015 1:48 am

Hello,
web interface stopped working, when I try to enter MWES web URL, i have an error aborted (the connection was reset).
This is something from log on new version 3:

Code: Select all

==> /var/log/mwes/mail.log <==
2015-10-05 14:33:40 [558413568] Error: WebChannel::ObjectThreadMethod - exception - zero-length string
2015-10-05 14:33:41 [558413568] Error: WebChannel::ObjectThreadMethod - exception - zero-length string
2015-10-05 14:33:41 [558413568] Error: WebChannel::ObjectThreadMethod - exception - zero-length string
And this is from old version 2.8.*

Code: Select all

==> /var/log/mwes/mail.log <==
2015-10-05 14:29:56 [1945130752] Debug: ListenTCPSocketThread::ObjectThreadMethod - Connected IP(xxx.xxx.xxx.xxx)
2015-10-05 14:29:56 [1945130752] Debug: WebChannel::Create - new channelID(2)
2015-10-05 14:29:56 [1877772032] Debug: WebChannel::ObjectThreadMethod - start channelID(2)
2015-10-05 14:29:56 [1877772032] Debug: WebRequest::WebRequest - start request(xxx.xxx.xxx.xxx) - GET / HTTP/1.1
2015-10-05 14:29:56 [1877772032] Error: WebChannel::ObjectThreadMethod - exception - zero-length string
2015-10-05 14:29:56 [1877772032] Debug: WebChannel::ObjectThreadMethod - end channelID(2)
2015-10-05 14:29:56 [1945130752] Debug: ListenTCPSocketThread::ObjectThreadMethod - Connected IP(xxx.xxx.xxx.xxx)
2015-10-05 14:29:56 [1945130752] Debug: WebChannel::Create - new channelID(2)
2015-10-05 14:29:56 [1877772032] Debug: WebChannel::ObjectThreadMethod - start channelID(2)
2015-10-05 14:29:56 [1877772032] Debug: WebRequest::WebRequest - start request(xxx.xxx.xxx.xxx) - GET / HTTP/1.1
2015-10-05 14:29:56 [1877772032] Error: WebChannel::ObjectThreadMethod - exception - zero-length string
2015-10-05 14:29:56 [1877772032] Debug: WebChannel::ObjectThreadMethod - end channelID(2)
2015-10-05 14:29:56 [1945130752] Debug: ListenTCPSocketThread::ObjectThreadMethod - Connected IP(xxx.xxx.xxx.xxx)
2015-10-05 14:29:56 [1945130752] Debug: WebChannel::Create - new channelID(2)
2015-10-05 14:29:56 [1877772032] Debug: WebChannel::ObjectThreadMethod - start channelID(2)
2015-10-05 14:29:56 [1877772032] Debug: WebRequest::WebRequest - start request(xxx.xxx.xxx.xxx) - GET / HTTP/1.1
2015-10-05 14:29:56 [1877772032] Error: WebChannel::ObjectThreadMethod - exception - zero-length string
2015-10-05 14:29:56 [1877772032] Debug: WebChannel::ObjectThreadMethod - end channelID(2)
where xxx.xxx.xxx.xxx is an IP address from where the web page is requested.
database size and owner -

Code: Select all

-rw-r--r-- 1 mwes mwes 278M Oct  5 14:41 /opt/mwes/mwes.db
Mail accepting and filtering seems to be working, only web interface is rejecting all connections.

How can it be solved?
P.S.: If i move away /opt/mwes/ and install a fresh MWES, i can see web interface. Issue happens only when i stop mwesd, replace db file and start mwes.
User avatar
nick.bolton
The Big Cheese
Posts: 2468
Joined: Thu Aug 28, 2008 4:02 pm

Re: Web interface (port 4044) stopped working

Tue Oct 06, 2015 5:12 am

Hi, is this the 32bit or 64bit version of MWES?

Can you change the logs level to debug in 'High' in Settings>>General>>Logging, or in the configure table of mwes.db (change logging_level = 1). It's an SQLite database.

Restart the daemon, then send us the logs from \var\log\mwes after trying to access the user interface.

Feel free to send the logs to nick.bolton@firetrust.com if you don't want to post them here.
gorilladaze
Rattled Rabbit
Posts: 4
Joined: Tue Oct 06, 2015 1:38 am

Re: Web interface (port 4044) stopped working

Tue Oct 06, 2015 8:21 am

Hi Nick, thank you for quick reply.
It is 64 bit version of MWES
I stopped mwesd, set logging_level to 1 in database and started mwesd.
Here is the log of application startup (real domain is replaced with example.com):

Code: Select all

2015-10-05 21:13:29 [2360932128] Info: starting mwes version 3.0.0.0 {U64}
2015-10-05 21:13:29 [2360932128] Info: environment....
2015-10-05 21:13:29 [2360932128] Info: cfs_max_cache_size::20000
2015-10-05 21:13:29 [2360932128] Info: database_location::/opt/mwes
2015-10-05 21:13:29 [2360932128] Info: log_level::2
2015-10-05 21:13:29 [2360932128] Info: logging::/var/log/mwes/
2015-10-05 21:13:29 [2360932128] Info: rbl_max_cache_size::20000
2015-10-05 21:13:29 [2360932128] Info: root_document::/opt/mwes/mwes-new/
2015-10-05 21:13:29 [2360932128] Info: use_syslog::0
2015-10-05 21:13:29 [2360932128] Info: Initialising database....
2015-10-05 21:13:29 [2360932128] Info: Initialising database configure table....
2015-10-05 21:13:29 [2360932128] Info: Database environment...
2015-10-05 21:13:29 [2360932128] Info: logging_level::1
2015-10-05 21:13:29 [2360932128] Info: proxy_hostname::mail.example.com
2015-10-05 21:13:29 [2360932128] Info: proxy_port::25
2015-10-05 21:13:29 [2360932128] Info: mta_hostname::mail.example.com
2015-10-05 21:13:29 [2360932128] Info: mta_port::26
2015-10-05 21:13:29 [2360932128] Info: web_hostname::mail.example.com
2015-10-05 21:13:29 [2360932128] Info: web_port::4044
2015-10-05 21:13:29 [2360932128] Info: DatabaseManager::UpgradeDatabase - version 37 ok
2015-10-05 21:13:29 [2360932128] Info: Open database....
2015-10-05 21:13:29 [2360932128] Info: Initialising database configure table....
2015-10-05 21:13:29 [2360932128] Info: Initialising database white listing table....
2015-10-05 21:13:29 [2360932128] Info: Initialising database black listing table....
2015-10-05 21:13:29 [2360932128] Info: Initialising database filter black listing table....
2015-10-05 21:13:29 [2360932128] Info: Initialising database filter white listing table....
2015-10-05 21:13:29 [2360932128] Info: Initialising database rbl listing table....
2015-10-05 21:13:29 [2360932128] Info: Initialising database quarantined table....
2015-10-05 21:13:29 [2360932128] Info: Initialising database gray listing table....
2015-10-05 21:13:29 [2360932128] Info: Initialising database white listing ip table....
2015-10-05 21:13:29 [2360932128] Info: Initialising database black listing ip table....
2015-10-05 21:13:29 [2360932128] Info: Initialising database user table....
2015-10-05 21:13:29 [2360932128] Info: Initialising database Gray listing friends table....
2015-10-05 21:13:29 [2360932128] Info: Initialising database Domain table....
2015-10-05 21:13:29 [2360932128] Info: Initialising database stat tables....
2015-10-05 21:13:29 [2360932128] Info: Initialising database delivered table....
2015-10-05 21:13:29 [2360932128] Info: Initialising database trusted ip table....
2015-10-05 21:13:29 [2360932128] Info: Initialising database track table....
2015-10-05 21:13:29 [2360932128] Info: Initialising database bypass table....
2015-10-05 21:13:29 [2360932128] Info: Initialising database bayesian table....
2015-10-05 21:13:29 [2360932128] Info: Initialising License Manager....
2015-10-05 21:13:29 [2360932128] Info: Initialising WebManager....
2015-10-05 21:13:31 [2360932128] Info: Starting StatThread....
2015-10-05 21:13:31 [2360932128] Info: Starting DigestReportThread....
2015-10-05 21:13:31 [2360932128] Info: Starting FilterManagerThreads....
2015-10-05 21:13:31 [2305050368] Info: Starting TaskThread....
2015-10-05 21:13:31 [2213963520] Info: Checking authentication
2015-10-05 21:13:31 [2296559360] Debug: DigestReportThread::ObjectThreadMethod - lastReportDatetime(2015-10-05 09:08:16), currentTime()
2015-10-05 21:13:31 [2360932128] Info: Started MTA proxy....
2015-10-05 21:13:31 [2360932128] Info: Starting HouseKeepingTask....
2015-10-05 21:13:31 [2360932128] Info: Initialising Auto-reporting....
2015-10-05 21:13:31 [2360932128] Info: ShutdownTime::42282.883264, CurrentTime::42282.884387, Clock::0.001123
2015-10-05 21:13:31 [2186807040] Debug: VersionStatus::Collect - xml size(0)
and here is log of processing http request:

Code: Select all

2015-10-05 21:13:41 [2318075648] Debug: ListenTCPSocketThread::ObjectThreadMethod - Connected IP(46.151.249.85)
2015-10-05 21:13:41 [2318075648] Debug: WebChannel::Create - new channelID(1)
2015-10-05 21:13:41 [2177451776] Debug: WebChannel::ObjectThreadMethod - start channelID(1)
2015-10-05 21:13:41 [2177451776] Debug: WebRequest::WebRequest - start request(46.151.249.85) - GET / HTTP/1.1
2015-10-05 21:13:41 [2177451776] Debug: WebSession::WebSession - created sessionID(1001)
2015-10-05 21:13:41 [2177451776] Debug: WebRequest::InitialiseSession - Connected IP(46.151.249.85)
2015-10-05 21:13:41 [2177451776] Debug: WebRequest::InitialiseSession - UserAgent - Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11) AppleWebKit/601.1.56 (KHTML, like Gecko) Version/9.0 Safari/601.1.56
2015-10-05 21:13:41 [2177451776] Error: WebChannel::ObjectThreadMethod - exception - zero-length string
2015-10-05 21:13:41 [2177451776] Debug: WebChannel::ObjectThreadMethod - end channelID(1)
2015-10-05 21:13:42 [2318075648] Debug: ListenTCPSocketThread::ObjectThreadMethod - Connected IP(46.151.249.85)
2015-10-05 21:13:42 [2318075648] Debug: WebChannel::Create - new channelID(2)
2015-10-05 21:13:42 [2177451776] Debug: WebChannel::ObjectThreadMethod - start channelID(2)
2015-10-05 21:13:42 [2177451776] Debug: WebRequest::WebRequest - start request(46.151.249.85) - GET / HTTP/1.1
2015-10-05 21:13:42 [2177451776] Debug: WebSession::WebSession - created sessionID(1002)
2015-10-05 21:13:42 [2177451776] Debug: WebRequest::InitialiseSession - Connected IP(46.151.249.85)
2015-10-05 21:13:42 [2177451776] Debug: WebRequest::InitialiseSession - UserAgent - Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11) AppleWebKit/601.1.56 (KHTML, like Gecko) Version/9.0 Safari/601.1.56
2015-10-05 21:13:42 [2177451776] Error: WebChannel::ObjectThreadMethod - exception - zero-length string
2015-10-05 21:13:42 [2177451776] Debug: WebChannel::ObjectThreadMethod - end channelID(2)
2015-10-05 21:13:42 [2318075648] Debug: ListenTCPSocketThread::ObjectThreadMethod - Connected IP(46.151.249.85)
2015-10-05 21:13:42 [2318075648] Debug: WebChannel::Create - new channelID(2)
2015-10-05 21:13:42 [2177451776] Debug: WebChannel::ObjectThreadMethod - start channelID(2)
2015-10-05 21:13:42 [2177451776] Debug: WebRequest::WebRequest - start request(46.151.249.85) - GET / HTTP/1.1
2015-10-05 21:13:42 [2177451776] Debug: WebSession::WebSession - created sessionID(1003)
2015-10-05 21:13:42 [2177451776] Debug: WebRequest::InitialiseSession - Connected IP(46.151.249.85)
2015-10-05 21:13:42 [2177451776] Debug: WebRequest::InitialiseSession - UserAgent - Mozilla/5.0 (Macintosh; Intel Mac OS X 10_11) AppleWebKit/601.1.56 (KHTML, like Gecko) Version/9.0 Safari/601.1.56
2015-10-05 21:13:42 [2177451776] Error: WebChannel::ObjectThreadMethod - exception - zero-length string
2015-10-05 21:13:42 [2177451776] Debug: WebChannel::ObjectThreadMethod - end channelID(2)
User avatar
nick.bolton
The Big Cheese
Posts: 2468
Joined: Thu Aug 28, 2008 4:02 pm

Re: Web interface (port 4044) stopped working

Tue Oct 06, 2015 9:50 am

I think you may have upgraded incorrectly, instructions for upgrading are here: http://www.firetrust.com/en/products/ma ... #upgrading

Does this directory exist and contain the new user interface files? /opt/mwes/mwes-new/
gorilladaze
Rattled Rabbit
Posts: 4
Joined: Tue Oct 06, 2015 1:38 am

Re: Web interface (port 4044) stopped working

Tue Oct 06, 2015 9:20 pm

nick.bolton wrote:I think you may have upgraded incorrectly, instructions for upgrading are here: http://www.firetrust.com/en/products/ma ... #upgrading
Nick, i did upgrade as in instruction. Also, when i restore old MWES from daily backups, where version is 2.8.* - there is the same issue. So this issue is not related to the upgrade process. It happened before, but i didnt notice it, i noticed it only after upgrade.
nick.bolton wrote:Does this directory exist and contain the new user interface files? /opt/mwes/mwes-new/
Yes, it exists. I followed the upgrade instruction.

Maybe there is something wrong with database content? Because if i install fresh MWES 3000 on this server without restoring mwes.db - everything is working (of course, it's unconfigured).
May I send you by email the dropbox link with mwes.db database, so you can verify is the db file ok?
User avatar
nick.bolton
The Big Cheese
Posts: 2468
Joined: Thu Aug 28, 2008 4:02 pm

Re: Web interface (port 4044) stopped working

Tue Oct 06, 2015 9:45 pm

Thanks, that was our second concern that perhaps the database is corrupted. If you can send me the link to it at nick.bolton@firetrust.com we'll take a look. It might have to be 12 hours until I get back to you as the programmers will want to take a look - it's 9:45pm here now
gorilladaze
Rattled Rabbit
Posts: 4
Joined: Tue Oct 06, 2015 1:38 am

Re: Web interface (port 4044) stopped working

Tue Oct 06, 2015 10:18 pm

I sent you the link for possibly corrupted database. No worries about time to investigate it, as mail filtering is working, only the web interface is down.
Thank you very much!
User avatar
nick.bolton
The Big Cheese
Posts: 2468
Joined: Thu Aug 28, 2008 4:02 pm

Re: Web interface (port 4044) stopped working

Sat Aug 13, 2016 12:43 pm

If you go to the configure table of the MWES.db file (in /opt/mwes/mwes.db) you can see the username and password field there to change
User avatar
nick.bolton
The Big Cheese
Posts: 2468
Joined: Thu Aug 28, 2008 4:02 pm

Re: Web interface (port 4044) stopped working

Sat Aug 13, 2016 12:43 pm

If you go to the configure table of the MWES.db file (in /opt/mwes/mwes.db) you can see the username and password field there to change

Return to “MailWasher Enterprise Server”