Comment configurer le smtp et pop de openpaas?


#21

hi,
where i can find thess log?


#22

hi,
Log of
systemctl status james


#23

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


#24

what is the name of this file?


#25

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.


#26

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.


#27

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


#28

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


#29

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.


#30

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’


#31

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


#32

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


#33

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


#34

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”


#35

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


#36

Hi hoangdat,

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

Thanks,
Daniel


#37

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.


#38

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.


#39

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”


#40

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.