Comment configurer le smtp et pop de openpaas?

hi,
where i can find thess log?

hi,
Log of
systemctl status james

i don’t know where i can find these log that you need?

what is the name of this file?

Hi,
As my site, when I type:
systemctl status james
I found the error is: leak of jwt_publickey file.
Please follow
systemctl status james
and show me all the log in your terminal.
Thanks.

when i type :

root@openpaas:~# systemctl status james

i have juste that :

● james.service - James stands for Java Apache Mail Enterprise Server! It has a modular architecture based on a rich set of modern and efficient components which provides at the end complet
Loaded: loaded (/lib/systemd/system/james.service; enabled; vendor preset: enabled)
Active: active (running) since ven. 2018-11-30 11:05:45 CET; 2 days ago
Docs: http://james.apache.org
Main PID: 2330 (java)
CGroup: /system.slice/james.service
└─2330 /usr/lib/jvm/java-8-openjdk-amd64/bin/java -Dworking.directory=/var/lib/james -Xmx1024m -Dlogback.configurationFile=/etc/james/logback.xml -jar /usr/share/james/james-serv

Warning: Journal has been rotated since unit was started. Log output is incomplete or unavailable.

Hi,
That is all of your log about James. Hmm.
How about when you telnet to SMTP port after upgrade cassandra, and restart James, Openpaas?
Thanks

I was using CentOS 7, which did’t work hence reinstalled with Debian 9 (Strech). Installed everything as per http://docs.open-paas.org/getting-started/linux/
While adding admin user it was showing error and it got fixed by running
#curl -X DELETE “localhost:9200/core.events.idx”

Upgraded Cassandra to 3.11 (per https://github.com/linagora/james-project/blob/master/upgrade-instructions.md#cassandra-3113-upgrade)

Went to Administration Center (platform administration mode) > Mail > SMTP server = server_name and port 25 (also tried 1025)

On server console smtp ports are not opened

telnet localhost 1025
Trying ::1…
Trying 127.0.0.1…
telnet: Unable to connect to remote host: Connection refused

telnet localhost 25
Trying ::1…
Trying 127.0.0.1…
telnet: Unable to connect to remote host: Connection refused

/var/log/james/james.log is empty
/var/log/openpaas/james/error.log : Empty
/var/log/openpaas/james/access.log : Empty

What am I missing? Please help.

Thanks,
Daniel

hi,
please run:
systemctl status james
Then show me all of the result.
I think it related to James. We need the log of James for more details.
Thanks.

systemctl status james

● james.service - James stands for Java Apache Mail Enterprise Server! It has a modular architecture based on a rich set of modern and efficient components which provides at the end complete, stable, secure and extendable Mail Servers running on the JVM.
Loaded: loaded (/lib/systemd/system/james.service; enabled; vendor preset: enabled)
Active: failed (Result: exit-code) since Thu 2018-12-06 23:07:50 UTC; 4h 7min ago
Docs: http://james.apache.org
Process: 4748 ExecStart=/usr/lib/jvm/java-8-openjdk-amd64/bin/java -Dworking.directory=${WORKING_DIRECTORY} -Xmx${XMX} -Dlogback.configurationFile=/etc/james/logback.xml -jar /usr/share/james/james-server.jar (code=exited, status=100)
Main PID: 4748 (code=exited, status=100)

Dec 06 23:07:27 unityon.co java[4748]: 18:07:27,284 |-INFO in ch.qos.logback.classic.joran.action.LoggerAction - Setting level of logger [http.jmap] to DEBUG
Dec 06 23:07:27 unityon.co java[4748]: 18:07:27,284 |-INFO in ch.qos.logback.classic.jul.LevelChangePropagator@7d70d1b1 - Propagating DEBUG level on Logger[http.jmap] onto the JUL framework
Dec 06 23:07:27 unityon.co java[4748]: 18:07:27,284 |-INFO in ch.qos.logback.classic.joran.action.RootLoggerAction - Setting level of ROOT logger to INFO
Dec 06 23:07:27 unityon.co java[4748]: 18:07:27,284 |-INFO in ch.qos.logback.classic.jul.LevelChangePropagator@7d70d1b1 - Propagating INFO level on Logger[ROOT] onto the JUL framework
Dec 06 23:07:27 unityon.co java[4748]: 18:07:27,284 |-INFO in ch.qos.logback.core.joran.action.AppenderRefAction - Attaching appender named [LOG_FILE] to Logger[ROOT]
Dec 06 23:07:27 unityon.co java[4748]: 18:07:27,285 |-INFO in ch.qos.logback.classic.joran.action.ConfigurationAction - End of configuration.
Dec 06 23:07:27 unityon.co java[4748]: 18:07:27,286 |-INFO in ch.qos.logback.classic.joran.JoranConfigurator@467aecef - Registering current configuration as safe fallback point
Dec 06 23:07:50 unityon.co systemd[1]: james.service: Main process exited, code=exited, status=100/n/a
Dec 06 23:07:50 unityon.co systemd[1]: james.service: Unit entered failed state.
Dec 06 23:07:50 unityon.co systemd[1]: james.service: Failed with result ‘exit-code’

Please find my james log (after changing hostname in /etc/james/domainlist.xml it started logging)
23:45:24.600 [INFO ] o.a.j.u.r.RetryExecutorUtil - The action should retry when [class com.datastax.driver.core.exceptions.NoHostAvailableException] and retry to 10 times if needed
23:45:24.625 [INFO ] o.a.j.m.m.ResilientClusterProvider - Trying to connect to Cassandra service at 2018-12-06T23:45:24.621 (list [localhost:9042])
23:45:24.643 [INFO ] c.d.driver.core - DataStax Java driver 3.5.1 for Apache Cassandra
23:45:24.650 [INFO ] c.d.d.c.GuavaCompatibility - Detected Guava >= 19 in the classpath, using modern compatibility layer
23:45:24.663 [INFO ] o.a.j.b.c.i.ClusterBuilder - No cassandra host specified. Falling back to localhost
23:45:24.663 [INFO ] o.a.j.b.c.i.ClusterBuilder - No cassandra port specified. Falling back to 9042
23:45:24.844 [INFO ] c.d.d.c.ClockFactory - Using native clock to generate timestamps.
23:45:24.907 [INFO ] c.d.d.c.NettyUtil - Detected shaded Netty classes in the classpath; native epoll transport will not work properly, defaulting to NIO.
23:45:25.116 [WARN ] c.d.d.c.Cluster - You listed localhost/0:0:0:0:0:0:0:1:9042 in your contact points, but it wasn’t found in the control host’s system.peers at startup
23:45:25.254 [INFO ] c.d.d.c.p.DCAwareRoundRobinPolicy - Using data-center name ‘datacenter1’ for DCAwareRoundRobinPolicy (if this is incorrect, please provide the correct datacenter name with DCAwareRoundRobinPolicy constructor)
23:45:25.255 [INFO ] c.d.d.c.Cluster - New Cassandra host localhost/127.0.0.1:9042 added
23:45:25.681 [INFO ] o.a.a.b.BrokerService - Loaded the Bouncy Castle security provider.
23:45:25.691 [WARN ] o.a.a.b.BrokerService - Memory Usage for the Broker (1024mb) is more than the maximum available for the JVM: 910 mb - resetting to 70% of maximum available: 637 mb
23:45:25.708 [INFO ] o.a.a.b.BrokerService - Using Persistence Adapter: KahaDBPersistenceAdapter[/var/lib/james/var/store/activemq/brokers/KahaDB]
23:45:25.840 [INFO ] o.a.a.s.k.MessageDatabase - KahaDB is version 6
23:45:25.851 [INFO ] o.a.a.s.k.MessageDatabase - Recovering from the journal @1:28
23:45:25.861 [INFO ] o.a.a.s.k.MessageDatabase - Recovery replayed 7 operations from the journal in 0.011 seconds.
23:45:25.870 [INFO ] o.a.a.s.k.p.PListStoreImpl - PListStore:[/var/lib/james/var/store/activemq/brokers/james/tmp_storage] started
23:45:26.035 [INFO ] o.a.a.p.StatisticsBrokerPlugin - Installing StaticsBroker
23:45:26.043 [INFO ] o.a.a.b.BrokerService - Apache ActiveMQ 5.15.5 (james, broker) is starting
23:45:26.049 [INFO ] o.a.a.p.StatisticsBroker - Starting StatisticsBroker
23:45:26.053 [INFO ] o.a.a.t.TransportServerThreadSupport - Listening for connections at: tcp://localhost:46479
23:45:26.053 [INFO ] o.a.a.b.TransportConnector - Connector tcp://localhost:46479 started
23:45:26.053 [INFO ] o.a.a.b.BrokerService - Apache ActiveMQ 5.15.5 (james, broker) started
23:45:26.053 [INFO ] o.a.a.b.BrokerService - For help or more information please see: http://activemq.apache.org
23:45:26.054 [WARN ] o.a.a.b.BrokerService - Store limit is 102400 mb (current store usage is 0 mb). The data directory: /var/lib/james/var/store/activemq/brokers/KahaDB only has 15070 mb of usable space. - resetting to maximum available disk space: 15070 mb
23:45:26.054 [WARN ] o.a.a.b.BrokerService - Temporary Store limit is 51200 mb (current store usage is 0 mb). The data directory: /var/lib/james/var/store/activemq/brokers only has 15070 mb of usable space. - resetting to maximum available disk space: 15070 mb
23:45:26.080 [INFO ] o.a.j.q.a.EmbeddedActiveMQ - Started embedded activeMq
23:45:26.271 [INFO ] o.a.j.u.r.RetryExecutorUtil - The action should retry when [class org.elasticsearch.client.transport.NoNodeAvailableException] and retry to 7 times if needed
23:45:26.272 [INFO ] o.a.j.m.m.ElasticSearchMailboxModule - Trying to connect to ElasticSearch service at 2018-12-06T23:45:26.272
23:45:26.332 [INFO ] o.e.plugins - [Copycat] modules [], plugins [], sites []
23:45:26.905 [INFO ] o.a.j.b.e.IndexCreationFactory - Index [org.apache.james.backends.es.IndexName@318788d3] already exist
23:45:26.955 [INFO ] o.a.j.b.e.IndexCreationFactory - Index [org.apache.james.backends.es.IndexName@3118dd35] already exist
23:45:26.969 [WARN ] o.a.j.m.m.TikaMailboxModule - Could not find tika configuration file. Disabling Tika.
23:45:27.079 [INFO ] o.a.j.m.m.TikaMailboxModule - Tika text extraction has been disabled. Using DefaultTextExtractor instead. No complex extraction will be done.
23:45:27.128 [INFO ] o.a.a.b.TransportConnector - Connector vm://james started
23:45:27.625 [INFO ] o.e.j.util.log - Logging initialized @5568ms to org.eclipse.jetty.util.log.Slf4jLog
23:45:27.706 [INFO ] o.a.j.d.d.DNSJavaService - Autodiscovery is enabled - trying to discover your system’s DNS Servers
23:45:27.710 [INFO ] o.a.j.d.d.DNSJavaService - Adding autodiscovered server 127.0.0.1
23:45:27.710 [INFO ] o.a.j.d.d.DNSJavaService - Adding autodiscovered server 192.186.33.99
23:45:27.711 [INFO ] o.a.j.d.d.DNSJavaService - Adding autodiscovered search path oc.net.
23:45:27.711 [INFO ] o.a.j.d.d.DNSJavaService - DNS Server is: 127.0.0.1
23:45:27.711 [INFO ] o.a.j.d.d.DNSJavaService - DNS Server is: 192.186.33.99
23:45:27.717 [INFO ] o.a.j.d.d.DNSJavaService - Registered cache, resolver and search paths as DNSJava defaults
23:45:27.732 [INFO ] o.a.j.m.m.MemoryMailRepositoryStore - JamesMailStore init… org.apache.james.mailrepository.memory.MemoryMailRepositoryStore@7209ffb5
23:45:27.736 [INFO ] o.a.j.d.l.AbstractDomainList - Set autodetect to: false
23:45:27.736 [INFO ] o.a.j.d.l.AbstractDomainList - Set autodetectIP to: false
23:45:27.848 [INFO ] o.a.c.i.DefaultCamelContext - Apache Camel 2.22.1 (CamelContext: camel-1) is starting
23:45:27.850 [INFO ] o.a.c.m.DefaultManagementStrategy - JMX is disabled
23:45:27.896 [INFO ] o.a.c.i.c.DefaultTypeConverter - Type converters loaded (core: 195, classpath: 0)
23:45:27.911 [INFO ] o.a.c.i.DefaultCamelContext - StreamCaching is not in use. If using streams then its recommended to enable stream caching. See more details at http://camel.apache.org/stream-caching.html
23:45:27.913 [INFO ] o.a.c.i.DefaultCamelContext - Total 0 routes, of which 0 are started
23:45:27.914 [INFO ] o.a.c.i.DefaultCamelContext - Apache Camel 2.22.1 (CamelContext: camel-1) started in 0.066 seconds
23:45:27.927 [INFO ] o.a.j.m.l.AbstractStateMailetProcessor - Matcher All instantiated.
23:45:27.937 [INFO ] o.a.j.m.l.AbstractStateMailetProcessor - Mailet PostmasterAlias instantiated.
23:45:27.939 [INFO ] o.a.j.m.l.AbstractStateMailetProcessor - Matcher RelayLimit=30 instantiated.
23:45:27.941 [INFO ] o.a.j.m.l.AbstractStateMailetProcessor - Mailet Null instantiated.
23:45:27.944 [INFO ] o.a.j.m.l.AbstractStateMailetProcessor - Matcher dlp.Dlp instantiated.
23:45:27.948 [INFO ] o.a.j.m.l.AbstractStateMailetProcessor - Mailet ToProcessor instantiated.
23:45:27.949 [INFO ] o.a.j.m.l.AbstractStateMailetProcessor - Matcher All instantiated.
23:45:27.949 [INFO ] o.a.j.m.l.AbstractStateMailetProcessor - Mailet ToProcessor instantiated.
23:45:28.407 [INFO ] o.a.c.i.DefaultCamelContext - Route: root started and consuming from: direct://processor.root
23:45:28.414 [INFO ] o.a.j.m.l.AbstractStateMailetProcessor - Matcher All instantiated.
23:45:28.418 [INFO ] o.a.j.m.l.AbstractStateMailetProcessor - Mailet ToSenderDomainRepository instantiated.
23:45:28.423 [INFO ] o.a.c.i.DefaultCamelContext - Route: dlpQuarantine started and consuming from: direct://processor.dlpQuarantine
23:45:28.424 [INFO ] o.a.j.m.l.AbstractStateMailetProcessor - Matcher All instantiated.
23:45:28.425 [INFO ] o.a.j.m.l.AbstractStateMailetProcessor - Mailet ToSenderDomainRepository instantiated.
23:45:28.430 [INFO ] o.a.c.i.DefaultCamelContext - Route: dlpReject started and consuming from: direct://processor.dlpReject
23:45:28.432 [INFO ] o.a.j.m.l.AbstractStateMailetProcessor - Matcher All instantiated.
23:45:28.441 [INFO ] o.a.j.m.l.AbstractStateMailetProcessor - Mailet Bounce instantiated.
23:45:28.442 [INFO ] o.a.j.m.l.AbstractStateMailetProcessor - Matcher All instantiated.
23:45:28.455 [INFO ] o.a.j.m.l.AbstractStateMailetProcessor - Mailet ToRepository instantiated.
23:45:28.468 [INFO ] o.a.c.i.DefaultCamelContext - Route: error started and consuming from: direct://processor.error
23:45:28.484 [INFO ] o.a.j.m.l.AbstractStateMailetProcessor - Matcher SMTPAuthSuccessful instantiated.
23:45:28.486 [INFO ] o.a.j.m.l.AbstractStateMailetProcessor - Mailet SetMimeHeader instantiated.
23:45:28.488 [INFO ] o.a.j.m.l.AbstractStateMailetProcessor - Matcher HasMailAttribute=org.apache.james.SMIMECheckSignature instantiated.
23:45:28.489 [INFO ] o.a.j.m.l.AbstractStateMailetProcessor - Mailet SetMimeHeader instantiated.
23:45:28.491 [INFO ] o.a.j.m.l.AbstractStateMailetProcessor - Matcher SenderIsLocal instantiated.
23:45:28.495 [INFO ] o.a.j.m.l.AbstractStateMailetProcessor - Mailet ContactExtractor instantiated.
23:45:28.495 [INFO ] o.a.j.m.l.AbstractStateMailetProcessor - Matcher All instantiated.
23:45:28.517 [INFO ] o.a.j.m.l.AbstractStateMailetProcessor - Mailet AmqpForwardAttribute instantiated.
23:45:28.517 [INFO ] o.a.j.m.l.AbstractStateMailetProcessor - Matcher All instantiated.
23:45:28.519 [INFO ] o.a.j.m.l.AbstractStateMailetProcessor - Mailet RemoveMimeHeader instantiated.
23:45:28.519 [INFO ] o.a.j.m.l.AbstractStateMailetProcessor - Matcher All instantiated.
23:45:28.520 [INFO ] o.a.j.m.l.AbstractStateMailetProcessor - Mailet RemoveMimeHeader instantiated.
23:45:28.520 [INFO ] o.a.j.m.l.AbstractStateMailetProcessor - Matcher All instantiated.
23:45:28.525 [INFO ] o.a.j.m.l.AbstractStateMailetProcessor - Mailet RecipientRewriteTable instantiated.
23:45:28.525 [INFO ] o.a.j.m.l.AbstractStateMailetProcessor - Matcher mdn-matcher instantiated.
23:45:28.528 [INFO ] o.a.j.m.l.AbstractStateMailetProcessor - Mailet org.apache.james.jmap.mailet.ExtractMDNOriginalJMAPMessageId instantiated.
23:45:28.530 [INFO ] o.a.j.m.l.AbstractStateMailetProcessor - Matcher RecipientIsLocal instantiated.
23:45:28.535 [INFO ] o.a.j.m.l.AbstractStateMailetProcessor - Mailet org.apache.james.jmap.mailet.VacationMailet instantiated.
23:45:28.535 [INFO ] o.a.j.m.l.AbstractStateMailetProcessor - Matcher RecipientIsLocal instantiated.
23:45:28.538 [INFO ] o.a.j.m.l.AbstractStateMailetProcessor - Mailet org.apache.james.jmap.mailet.filter.JMAPFiltering instantiated.
23:45:28.539 [INFO ] o.a.j.m.l.AbstractStateMailetProcessor - Matcher RecipientIsLocal instantiated.
23:45:28.539 [INFO ] o.a.j.m.l.AbstractStateMailetProcessor - Mailet ToProcessor instantiated.
23:45:28.541 [INFO ] o.a.j.m.l.AbstractStateMailetProcessor - Matcher org.apache.james.jmap.mailet.SentByJmap instantiated.
23:45:28.541 [INFO ] o.a.j.m.l.AbstractStateMailetProcessor - Mailet ToProcessor instantiated.
23:45:28.543 [INFO ] o.a.j.m.l.AbstractStateMailetProcessor - Matcher SentByMailet instantiated.
23:45:28.544 [INFO ] o.a.j.m.l.AbstractStateMailetProcessor - Mailet ToProcessor instantiated.
23:45:28.544 [INFO ] o.a.j.m.l.AbstractStateMailetProcessor - Matcher SMTPAuthSuccessful instantiated.
23:45:28.544 [INFO ] o.a.j.m.l.AbstractStateMailetProcessor - Mailet ToProcessor instantiated.
23:45:28.545 [INFO ] o.a.j.m.l.AbstractStateMailetProcessor - Matcher All instantiated.
23:45:28.545 [INFO ] o.a.j.m.l.AbstractStateMailetProcessor - Mailet ToProcessor instantiated.
23:45:28.577 [INFO ] o.a.c.i.DefaultCamelContext - Route: transport started and consuming from: direct://processor.transport
23:45:28.580 [INFO ] o.a.j.m.l.AbstractStateMailetProcessor - Matcher All instantiated.
23:45:28.582 [INFO ] o.a.j.m.l.AbstractStateMailetProcessor - Mailet org.apache.james.jmap.mailet.TextCalendarBodyToAttachment instantiated.
23:45:28.583 [INFO ] o.a.j.m.l.AbstractStateMailetProcessor - Matcher All instantiated.
23:45:28.586 [INFO ] o.a.j.m.l.AbstractStateMailetProcessor - Mailet StripAttachment instantiated.
23:45:28.586 [INFO ] o.a.j.m.l.AbstractStateMailetProcessor - Matcher All instantiated.
23:45:28.589 [INFO ] o.a.j.m.l.AbstractStateMailetProcessor - Mailet MimeDecodingMailet instantiated.
23:45:28.589 [INFO ] o.a.j.m.l.AbstractStateMailetProcessor - Matcher All instantiated.
23:45:28.594 [INFO ] n.f.i.u.Configurator - ical4j.properties not found.
23:45:28.594 [INFO ] o.a.j.m.l.AbstractStateMailetProcessor - Mailet ICalendarParser instantiated.
23:45:28.595 [INFO ] o.a.j.m.l.AbstractStateMailetProcessor - Matcher All instantiated.
23:45:28.599 [INFO ] o.a.j.m.l.AbstractStateMailetProcessor - Mailet ICALToHeader instantiated.
23:45:28.600 [INFO ] o.a.j.m.l.AbstractStateMailetProcessor - Matcher RecipientIsLocal instantiated.
23:45:28.602 [INFO ] o.a.j.m.l.AbstractStateMailetProcessor - Mailet LogMessage instantiated.
23:45:28.602 [INFO ] o.a.j.m.l.AbstractStateMailetProcessor - Matcher All instantiated.
23:45:28.606 [INFO ] o.a.j.m.l.AbstractStateMailetProcessor - Mailet ICALToJsonAttribute instantiated.
23:45:28.606 [INFO ] o.a.j.m.l.AbstractStateMailetProcessor - Matcher All instantiated.
23:45:28.607 [INFO ] o.a.j.m.l.AbstractStateMailetProcessor - Mailet AmqpForwardAttribute instantiated.
23:45:28.607 [INFO ] o.a.j.m.l.AbstractStateMailetProcessor - Matcher All instantiated.
23:45:28.609 [INFO ] o.a.j.m.l.AbstractStateMailetProcessor - Mailet AddDeliveredToHeader instantiated.
23:45:28.609 [INFO ] o.a.j.m.l.AbstractStateMailetProcessor - Matcher All instantiated.
23:45:28.614 [INFO ] o.a.j.m.l.AbstractStateMailetProcessor - Mailet LocalDelivery instantiated.
23:45:28.634 [INFO ] o.a.c.i.DefaultCamelContext - Route: local-recipient started and consuming from: direct://processor.local-recipient
23:45:28.637 [INFO ] o.a.j.m.l.AbstractStateMailetProcessor - Matcher All instantiated.
23:45:28.645 [WARN ] o.a.j.t.m.r.d.DelaysAndMaxRetry - maxRetries is larger than total number of attempts specified. Increasing last delayTime with 22 attempts
23:45:28.646 [WARN ] o.a.j.t.m.r.d.DelaysAndMaxRetry - Delay of 500000 msecs is now attempted: 1 times
23:45:28.688 [INFO ] o.a.j.m.l.AbstractStateMailetProcessor - Mailet RemoteDelivery instantiated.
23:45:28.694 [INFO ] o.a.c.i.DefaultCamelContext - Route: relay started and consuming from: direct://processor.relay
23:45:28.695 [INFO ] o.a.j.m.l.AbstractStateMailetProcessor - Matcher All instantiated.
23:45:28.695 [INFO ] o.a.j.m.l.AbstractStateMailetProcessor - Mailet Bounce instantiated.
23:45:28.696 [INFO ] o.a.j.m.l.AbstractStateMailetProcessor - Matcher All instantiated.
23:45:28.698 [INFO ] o.a.j.m.l.AbstractStateMailetProcessor - Mailet ToRepository instantiated.
23:45:28.707 [INFO ] o.a.c.i.DefaultCamelContext - Route: local-address-error started and consuming from: direct://processor.local-address-error
23:45:28.708 [INFO ] o.a.j.m.l.AbstractStateMailetProcessor - Matcher All instantiated.
23:45:28.709 [INFO ] o.a.j.m.l.AbstractStateMailetProcessor - Mailet Bounce instantiated.
23:45:28.709 [INFO ] o.a.j.m.l.AbstractStateMailetProcessor - Matcher All instantiated.
23:45:28.711 [INFO ] o.a.j.m.l.AbstractStateMailetProcessor - Mailet ToRepository instantiated.
23:45:28.718 [INFO ] o.a.c.i.DefaultCamelContext - Route: relay-denied started and consuming from: direct://processor.relay-denied
23:45:28.720 [INFO ] o.a.j.m.l.AbstractStateMailetProcessor - Matcher All instantiated.
23:45:28.762 [INFO ] o.a.j.m.l.AbstractStateMailetProcessor - Mailet DSNBounce instantiated.
23:45:28.767 [INFO ] o.a.c.i.DefaultCamelContext - Route: bounces started and consuming from: direct://processor.bounces
23:45:28.778 [INFO ] o.a.j.m.i.JamesMailSpooler - org.apache.james.mailetcontainer.impl.JamesMailSpooler init…
23:45:28.778 [INFO ] o.a.j.m.i.JamesMailSpooler - org.apache.james.mailetcontainer.impl.JamesMailSpooler uses 20 Thread(s)
23:45:28.781 [INFO ] o.a.j.m.i.JamesMailSpooler - Run org.apache.james.mailetcontainer.impl.JamesMailSpooler: dequeuer-1
23:45:28.781 [INFO ] o.a.j.m.i.JamesMailSpooler - Run org.apache.james.mailetcontainer.impl.JamesMailSpooler: dequeuer-2
23:45:28.781 [INFO ] o.a.j.m.i.JamesMailSpooler - Queue=MailQueue:spool
23:45:28.781 [INFO ] o.a.j.m.i.JamesMailSpooler - Queue=MailQueue:spool
23:45:28.803 [INFO ] o.a.j.p.l.n.AbstractConfigurableAsyncServer - IMAP Service bound to: 0.0.0.0:143
23:45:28.803 [INFO ] o.a.j.p.l.n.AbstractConfigurableAsyncServer - IMAP Service is running on: unit.co

Hi,
I still find the reason of your problem.
Please direct run James with cmd:
usr/lib/jvm/java-8-openjdk-amd64/bin/java -Dworking.directory=${WORKING_DIRECTORY} -Xmx${XMX} -Dlogback.configurationFile=/etc/james/logback.xml -jar /usr/share/james/james-server.jar
Log will be more details. ^^
Thanks

Hi,
I tried to reinstall it again in debian 9 follow https://docs.open-paas.org/getting-started/linux/

And then I update cassandra. Then I restart all the service:
systemctl restart {mongodb,elasticsearch,cassandra,redis-server,rabbitmq-server,nginx,james,openpaas}
Then iI found the error related to jwt_publickey

Dec 07 10:55:49 stretch java[4975]: Caused by: java.io.FileNotFoundException: File '/etc/openpaas/private/jwt_publickey' does not exist
Dec 07 10:55:49 stretch java[4975]:         at org.apache.commons.io.FileUtils.openInputStream(FileUtils.java:297)
Dec 07 10:55:49 stretch java[4975]:         at org.apache.commons.io.FileUtils.readFileToString(FileUtils.java:1805)
Dec 07 10:55:49 stretch java[4975]:         at org.apache.james.jmap.JMAPModule.lambda$loadPublicKey$2(JMAPModule.java:139)
Dec 07 10:55:49 stretch java[4975]:         at com.github.fge.lambdas.functions.FunctionChainer.doApply(FunctionChainer.java:20)
Dec 07 10:55:49 stretch java[4975]:         at com.github.fge.lambdas.functions.ThrowingFunction.apply(ThrowingFunction.java:17)
Dec 07 10:55:49 stretch java[4975]:         ... 41 more

After reinstalling using Debian9, things start looks better however “Contacts” showing error
“Something went wrong, please try again later”

In server log
[error] 32359#32359: *125 FastCGI sent in stderr: “PHP message: PHP Fatal error: Uncaught Error: Class ‘MongoDB\Driver\Manager’ not found in /usr/share/openpaas-davserver/vendor/mongodb/mongodb/src/Client.php:87
Stack trace:
#0 /usr/share/openpaas-davserver/esn.php(33): MongoDB\Client->__construct(‘mongodb://local…’, Array)
#1 {main}
thrown in /usr/share/openpaas-davserver/vendor/mongodb/mongodb/src/Client.php on line 87” while reading response header from upstream, client: 54.39.105.157, server: dav.unityon.co, request: “GET /addressbooks/5c0a145ad819a372fe284514.json?inviteStatus=2&personal=true&shared=true&subscribed=true HTTP/1.1”, upstream: “fastcgi://unix:/var/run/php/php7.0-fpm.sock:”, host: “openpaas.local”

hi,
You can send/receive email?
@tuanlc, can you give some guide for this error related to contact?
Thanks

Hi hoangdat,

I am not able to send / receive emails, also contacts not working.

Thanks,
Daniel

Hi Daniel,

We still work in more details to find the root cause of this installation and update when it is ready.
Please provide me the log, when you run James directly.
Thanks.

Hi,
When i ran in command line, i got following response
/usr/lib/jvm/java-8-openjdk-amd64/bin/java -Dworking.directory=${WORKING_DIRECTORY} -Xmx${XMX} -Dlogback.configurationFile=/etc/james/logback.xml -jar /usr/share/james/james-server.jar
Invalid maximum heap size: -Xmx
Error: Could not create the Java Virtual Machine.
Error: A fatal exception has occurred. Program will exit.

In /var/log/openpaas/davserver/error.log

2018/12/11 19:37:04 [error] 6578#6578: *4 FastCGI sent in stderr: “PHP message: PHP Fatal error: Uncaught Error: Class ‘MongoDB\Driver\Manager’ not found in /usr/share/openpaas-davserver/vendor/mongodb/mongodb/src/Client.php:87
Stack trace:
#0 /usr/share/openpaas-davserver/esn.php(33): MongoDB\Client->__construct(‘mongodb://local…’, Array)
#1 {main}
thrown in /usr/share/openpaas-davserver/vendor/mongodb/mongodb/src/Client.php on line 87” while reading response header from upstream, client: 192.168.52.10, server: dav.openpaas.local, request: “GET / HTTP/1.1”, upstream: “fastcgi://unix:/var/run/php/php7.0-fpm.sock:”, host: “dav.openpaas.local”

Following commands works OK
/usr/lib/jvm/java-8-openjdk-amd64/bin/java -Dworking.directory=/var/lib/james -Xmx1024m -Dlogback.configurationFile=/etc/james/logback.xml -jar /usr/share/james/james-server.jar

14:42:07,699 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Found resource [/etc/james/logback.xml] at [file:/etc/james/logback.xml]
14:42:07,774 |-INFO in ch.qos.logback.classic.joran.action.ConfigurationAction - debug attribute not set
14:42:07,785 |-INFO in ch.qos.logback.classic.joran.action.ConfigurationAction - Will scan for changes in [file:/etc/james/logback.xml]
14:42:07,785 |-INFO in ch.qos.logback.classic.joran.action.ConfigurationAction - Setting ReconfigureOnChangeTask scanning period to 30 seconds
14:42:07,788 |-INFO in ch.qos.logback.classic.joran.action.LoggerContextListenerAction - Adding LoggerContextListener of type [ch.qos.logback.classic.jul.LevelChangePropagator] to the object stack
14:42:07,801 |-INFO in ch.qos.logback.classic.jul.LevelChangePropagator@7d70d1b1 - Propagating DEBUG level on Logger[ROOT] onto the JUL framework
14:42:07,801 |-INFO in ch.qos.logback.classic.joran.action.LoggerContextListenerAction - Starting LoggerContextListener
14:42:07,801 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - About to instantiate appender of type [ch.qos.logback.core.rolling.RollingFileAppender]
14:42:07,807 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - Naming appender as [LOG_FILE]
14:42:07,818 |-INFO in c.q.l.core.rolling.SizeAndTimeBasedRollingPolicy@712256162 - setting totalSizeCap to 2 GB
14:42:07,822 |-INFO in c.q.l.core.rolling.SizeAndTimeBasedRollingPolicy@712256162 - Archive files will be limited to [100 MB] each.
14:42:07,855 |-INFO in c.q.l.core.rolling.SizeAndTimeBasedRollingPolicy@712256162 - No compression will be used
14:42:07,857 |-INFO in c.q.l.core.rolling.SizeAndTimeBasedRollingPolicy@712256162 - Will use the pattern logFile.%d{yyyy-MM-dd}.%i.log for the active file
14:42:07,860 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@3cb1ffe6 - The date pattern is ‘yyyy-MM-dd’ from file name pattern ‘logFile.%d{yyyy-MM-dd}.%i.log’.
14:42:07,860 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@3cb1ffe6 - Roll-over at midnight.
14:42:07,863 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@3cb1ffe6 - Setting initial period to Tue Dec 11 14:41:01 EST 2018
14:42:07,865 |-INFO in ch.qos.logback.core.joran.action.NestedComplexPropertyIA - Assuming default type [ch.qos.logback.classic.encoder.PatternLayoutEncoder] for [encoder] property
14:42:07,867 |-WARN in ch.qos.logback.classic.encoder.PatternLayoutEncoder@3dfc5fb8 - As of version 1.2.0 “immediateFlush” property should be set within the enclosing Appender.
14:42:07,867 |-WARN in ch.qos.logback.classic.encoder.PatternLayoutEncoder@3dfc5fb8 - Please move “immediateFlush” property into the enclosing appender.
14:42:07,888 |-WARN in ch.qos.logback.classic.encoder.PatternLayoutEncoder@3dfc5fb8 - Setting the “immediateFlush” property of the enclosing appender to false
14:42:07,890 |-INFO in ch.qos.logback.core.rolling.RollingFileAppender[LOG_FILE] - Active log file name: /var/log/james/james.log
14:42:07,890 |-INFO in ch.qos.logback.core.rolling.RollingFileAppender[LOG_FILE] - File property is set to [/var/log/james/james.log]
14:42:07,891 |-INFO in ch.qos.logback.classic.joran.action.LoggerAction - Setting level of logger [http.jmap] to DEBUG
14:42:07,891 |-INFO in ch.qos.logback.classic.jul.LevelChangePropagator@7d70d1b1 - Propagating DEBUG level on Logger[http.jmap] onto the JUL framework
14:42:07,892 |-INFO in ch.qos.logback.classic.joran.action.RootLoggerAction - Setting level of ROOT logger to INFO
14:42:07,892 |-INFO in ch.qos.logback.classic.jul.LevelChangePropagator@7d70d1b1 - Propagating INFO level on Logger[ROOT] onto the JUL framework
14:42:07,892 |-INFO in ch.qos.logback.core.joran.action.AppenderRefAction - Attaching appender named [LOG_FILE] to Logger[ROOT]
14:42:07,892 |-INFO in ch.qos.logback.classic.joran.action.ConfigurationAction - End of configuration.
14:42:07,893 |-INFO in ch.qos.logback.classic.joran.JoranConfigurator@467aecef - Registering current configuration as safe fallback point

However contacts not working.