[SOLVED] LDAP DE ZIMBRA SE CAE
[SOLVED] LDAP DE ZIMBRA SE CAE
Buenos dias les escribo porque tengo un cliente que tiene um problema grave con zimbra
El problema del servidor es que el ldap no levanta automaticamente con zmcontrol start
Por lo que fallan otros servicios
Si ejecutamos como usuario zimbra ldap start si levanta pero solo dura entre 2 o 3 minutos levantado y luego se cae el servicio.
Servidor Virtual en VMware 6.5
12 Procesadores
64 GB de ram
Disco de 12 TB Ocupado 6
Sistema operativo instalado centos 6.9 (64 bit)
Version de Zimbra Instalada ZCS 8.7.11
El cliente no tiene backup por descuido del anterior administrador
Lo unico que se posee es una copia virtual del servidor con fecha de tres meses anteriores
Agradezco quien nos pueda colaborar
El problema del servidor es que el ldap no levanta automaticamente con zmcontrol start
Por lo que fallan otros servicios
Si ejecutamos como usuario zimbra ldap start si levanta pero solo dura entre 2 o 3 minutos levantado y luego se cae el servicio.
Servidor Virtual en VMware 6.5
12 Procesadores
64 GB de ram
Disco de 12 TB Ocupado 6
Sistema operativo instalado centos 6.9 (64 bit)
Version de Zimbra Instalada ZCS 8.7.11
El cliente no tiene backup por descuido del anterior administrador
Lo unico que se posee es una copia virtual del servidor con fecha de tres meses anteriores
Agradezco quien nos pueda colaborar
- jorgedlcruz
- Zimbra Alumni
- Posts: 2782
- Joined: Thu May 22, 2014 4:47 pm
Re: LDAP DE ZIMBRA SE CAE
Saludos,
Puedes decirnos el error exacto en los logs? Estoy seguro que alli podremos ver que esta sucediendo, zimbra.log y mailbox.log.
Un saludo
Puedes decirnos el error exacto en los logs? Estoy seguro que alli podremos ver que esta sucediendo, zimbra.log y mailbox.log.
Un saludo
Re: LDAP DE ZIMBRA SE CAE
Buenas tardes Jorge gracias por responder aqui de dejo el zimbra log
Code: Select all
Aug 21 14:17:11 mail zimbramon[2471]: 2471:info: Starting services initiated by zmcontrol
Aug 21 14:17:11 mail slapd[2533]: @(#) $OpenLDAP: slapd 2.4.44 (Sep 29 2016 10:52:08) $#012#011build@c687:/home/build/git/87/packages/thirdparty/openldap/build/RHEL6_64/zimbra-openldap/rpm/BUILD/openldap-2.4.44/servers/slapd
Aug 21 14:17:12 mail slapd[2534]: slapd starting
Aug 21 14:17:19 mail zimbramon[2471]: 2471:info: Starting zmconfigd via zmcontrol
Aug 21 14:17:32 mail zmconfigd[2556]: zmconfigd started on mail.ribasmith.net with loglevel=3 pid=2556
Aug 21 14:17:32 mail zmconfigd[2556]: Fetching All configs
Aug 21 14:17:32 mail zmconfigd[2556]: All configs fetched in 0.48 seconds
Aug 21 14:17:33 mail zmconfigd[2556]: Rewrote: /opt/zimbra/conf/opendkim.conf with mode 440 (0.04 sec)
Aug 21 14:17:33 mail zmconfigd[2556]: Rewrote: /opt/zimbra/mailboxd/webapps/service/WEB-INF/web.xml with mode 440 (0.68 sec)
Aug 21 14:17:33 mail zmconfigd[2556]: Rewrote: /opt/zimbra/mailboxd/webapps/zimbraAdmin/WEB-INF/jetty-env.xml with mode 440 (0.20 sec)
Aug 21 14:17:34 mail zmconfigd[2556]: Rewrote: /opt/zimbra/conf/dspam.conf with mode 440 (0.02 sec)
Aug 21 14:17:34 mail zmconfigd[2556]: Rewrote: /opt/zimbra/mailboxd/webapps/zimbra/WEB-INF/jetty-env.xml with mode 440 (0.01 sec)
Aug 21 14:17:34 mail zmconfigd[2556]: Rewrote: /opt/zimbra/mailboxd/webapps/zimbraAdmin/WEB-INF/web.xml with mode 440 (0.02 sec)
Aug 21 14:17:34 mail zmconfigd[2556]: Rewrote: /opt/zimbra/mailboxd/etc/spnego.conf with mode 440 (0.01 sec)
Aug 21 14:17:34 mail zmconfigd[2556]: Rewrote: /opt/zimbra/common/conf/tag_as_originating.re with mode 440 (0.01 sec)
Aug 21 14:17:34 mail zmconfigd[2556]: Rewrote: /opt/zimbra/conf/unbound.conf with mode 440 (0.01 sec)
Aug 21 14:17:34 mail zmconfigd[2556]: Rewrote: /opt/zimbra/mailboxd/webapps/zimbra/WEB-INF/web.xml with mode 440 (0.03 sec)
Aug 21 14:17:34 mail zmconfigd[2556]: Rewrote: /opt/zimbra/mailboxd/etc/jetty.xml with mode 440 (0.06 sec)
Aug 21 14:17:34 mail zmconfigd[2556]: Rewrote: /opt/zimbra/conf/spnego_java_options with mode 440 (0.00 sec)
Aug 21 14:17:34 mail zmconfigd[2556]: Rewrote: /opt/zimbra/conf/sasl2/smtpd.conf with mode 440 (0.00 sec)
Aug 21 14:17:34 mail zmconfigd[2556]: Rewrote: /opt/zimbra/mailboxd/etc/spnego.properties with mode 440 (0.00 sec)
Aug 21 14:17:34 mail zmconfigd[2556]: Rewrote: /opt/zimbra/conf/postfix_header_checks with mode 440 (0.01 sec)
Aug 21 14:17:34 mail zmconfigd[2556]: Rewrote: /opt/zimbra/conf/opendkim-localnets.conf with mode 440 (0.01 sec)
Aug 21 14:17:34 mail zmconfigd[2556]: Rewrote: /opt/zimbra/mailboxd/etc/krb5.ini with mode 440 (0.00 sec)
Aug 21 14:17:34 mail zmconfigd[2556]: Rewrote: /opt/zimbra/conf/stats.conf with mode 440 (0.01 sec)
Aug 21 14:17:34 mail zmconfigd[2556]: Rewrote: /opt/zimbra/common/conf/tag_as_foreign.re with mode 440 (0.00 sec)
Aug 21 14:17:34 mail zmconfigd[2556]: Rewrote: /opt/zimbra/conf/saslauthd.conf with mode 440 (0.00 sec)
Aug 21 14:17:34 mail zmconfigd[2556]: Rewrote: /opt/zimbra/conf/log4j.properties with mode 440 (0.01 sec)
Aug 21 14:17:34 mail zmconfigd[2556]: Rewrote: /opt/zimbra/conf/amavisd.conf with mode 440 (0.05 sec)
Aug 21 14:17:34 mail zmconfigd[2556]: Rewrote: /opt/zimbra/common/conf/master.cf with mode 440 (0.02 sec)
Aug 21 14:17:34 mail zmconfigd[2556]: Rewrote: /opt/zimbra/mailboxd/webapps/zimlet/WEB-INF/web.xml with mode 440 (0.01 sec)
Aug 21 14:17:34 mail zmconfigd[2556]: Rewrote: /opt/zimbra/mailboxd/modules/setuid.mod with mode 440 (0.03 sec)
Aug 21 14:17:34 mail zmconfigd[2556]: Rewrote: /opt/zimbra/data/spamassassin/localrules/salocal.cf with mode 440 (0.01 sec)
Aug 21 14:17:34 mail zmconfigd[2556]: Rewrote: /opt/zimbra/conf/mta_milter_options with mode 440 (0.00 sec)
Aug 21 14:17:34 mail zmconfigd[2556]: Rewrote: /opt/zimbra/mailboxd/start.d/setuid.ini with mode 440 (0.01 sec)
Aug 21 14:17:52 mail zmconfigd[2556]: All rewrite threads completed in 19.83 sec
Aug 21 14:17:52 mail zmconfigd[2556]: All restarts completed in 0.00 sec
Aug 21 14:17:53 mail zimbramon[2471]: 2471:info: Starting dnscache via zmcontrol
Aug 21 14:17:53 mail unbound: [3746:0] notice: init module 0: validator
Aug 21 14:17:53 mail unbound: [3746:0] notice: init module 1: iterator
Aug 21 14:17:53 mail unbound: [3746:0] info: start of service (unbound 1.5.9).
Aug 21 14:17:55 mail zimbramon[2471]: 2471:info: Starting logger via zmcontrol
Aug 21 14:17:59 mail zimbramon[2471]: 2471:info: Starting mailbox via zmcontrol
Aug 21 14:18:08 mail zmmailboxdmgr[4650]: stale pid 11233 found in /opt/zimbra/log/zmmailboxd_manager.pid: No such process
Aug 21 14:18:08 mail zmmailboxdmgr[4650]: assuming no other instance is running
Aug 21 14:18:08 mail zmmailboxdmgr[4650]: file /opt/zimbra/log/zmmailboxd.pid does not exist
Aug 21 14:18:08 mail zmmailboxdmgr[4650]: assuming no other instance is running
Aug 21 14:18:08 mail zmmailboxdmgr[4650]: no manager process is running
Aug 21 14:18:10 mail zmmailboxdmgr[4905]: stale pid 11233 found in /opt/zimbra/log/zmmailboxd_manager.pid: No such process
Aug 21 14:18:10 mail zmmailboxdmgr[4905]: assuming no other instance is running
Aug 21 14:18:10 mail zmmailboxdmgr[4905]: file /opt/zimbra/log/zmmailboxd.pid does not exist
Aug 21 14:18:10 mail zmmailboxdmgr[4905]: assuming no other instance is running
Aug 21 14:18:10 mail zmmailboxdmgr[4905]: no manager process is running
Aug 21 14:18:10 mail zmmailboxdmgr[5037]: stale pid 11233 found in /opt/zimbra/log/zmmailboxd_manager.pid: No such process
Aug 21 14:18:10 mail zmmailboxdmgr[5037]: assuming no other instance is running
Aug 21 14:18:10 mail zmmailboxdmgr[5037]: file /opt/zimbra/log/zmmailboxd.pid does not exist
Aug 21 14:18:10 mail zmmailboxdmgr[5037]: assuming no other instance is running
Aug 21 14:18:10 mail zmmailboxdmgr[5037]: no manager process is running
Aug 21 14:18:10 mail zmmailboxdmgr[5083]: start requested
Aug 21 14:18:10 mail zmmailboxdmgr[5083]: checking if another instance of manager is already running
Aug 21 14:18:10 mail zmmailboxdmgr[5083]: stale pid 11233 found in /opt/zimbra/log/zmmailboxd_manager.pid: No such process
Aug 21 14:18:10 mail zmmailboxdmgr[5083]: assuming no other instance is running
Aug 21 14:18:10 mail zmmailboxdmgr[5083]: file /opt/zimbra/log/zmmailboxd.pid does not exist
Aug 21 14:18:10 mail zmmailboxdmgr[5083]: assuming no other instance is running
Aug 21 14:18:10 mail zmmailboxdmgr[5084]: wrote manager pid 5084 to /opt/zimbra/log/zmmailboxd_manager.pid
Aug 21 14:18:10 mail zmmailboxdmgr[5084]: manager started mailboxd/JVM with pid 5085
Aug 21 14:18:11 mail zmmailboxdmgr[5085]: wrote java pid 5085 to /opt/zimbra/log/zmmailboxd_java.pid
Aug 21 14:18:52 mail zmconfigd[2556]: Fetching All configs
Aug 21 14:18:53 mail zmconfigd[2556]: All configs fetched in 0.09 seconds
Aug 21 14:18:53 mail zmconfigd[2556]: Tracking service amavis
Aug 21 14:18:56 mail zmconfigd[2556]: Tracking service antispam
Aug 21 14:18:56 mail zmconfigd[2556]: Tracking service dnscache
Aug 21 14:18:56 mail zmconfigd[2556]: Watchdog: service dnscache now available for watchdog.
Aug 21 14:18:56 mail zmconfigd[2556]: Tracking service ldap
Aug 21 14:18:56 mail zmconfigd[2556]: Watchdog: service ldap now available for watchdog.
Aug 21 14:18:56 mail zmconfigd[2556]: Tracking service logger
Aug 21 14:18:56 mail zmconfigd[2556]: Watchdog: service logger now available for watchdog.
Aug 21 14:18:56 mail zmconfigd[2556]: Tracking service mailbox
Aug 21 14:18:56 mail zmconfigd[2556]: Watchdog: service mailbox now available for watchdog.
Aug 21 14:18:56 mail zmconfigd[2556]: Tracking service mailboxd
Aug 21 14:18:56 mail zmconfigd[2556]: Watchdog: service mailboxd now available for watchdog.
Aug 21 14:18:56 mail zmconfigd[2556]: Tracking service memcached
Aug 21 14:18:57 mail zmconfigd[2556]: Tracking service mta
Aug 21 14:18:57 mail zmconfigd[2556]: Tracking service opendkim
Aug 21 14:18:57 mail zmconfigd[2556]: Tracking service proxy
Aug 21 14:18:57 mail zmconfigd[2556]: Tracking service sasl
Aug 21 14:18:57 mail zmconfigd[2556]: Tracking service service
Aug 21 14:18:57 mail zmconfigd[2556]: Watchdog: service service now available for watchdog.
Aug 21 14:18:57 mail zmconfigd[2556]: Tracking service snmp
Aug 21 14:18:57 mail zmconfigd[2556]: Tracking service spell
Aug 21 14:18:58 mail zmconfigd[2556]: Tracking service stats
Aug 21 14:18:58 mail zmconfigd[2556]: Watchdog: service stats now available for watchdog.
Aug 21 14:18:58 mail zmconfigd[2556]: Tracking service zimbra
Aug 21 14:18:58 mail zmconfigd[2556]: Watchdog: service zimbra now available for watchdog.
Aug 21 14:18:58 mail zmconfigd[2556]: Tracking service zimbraAdmin
Aug 21 14:18:58 mail zmconfigd[2556]: Watchdog: service zimbraAdmin now available for watchdog.
Aug 21 14:18:58 mail zmconfigd[2556]: Tracking service zimlet
Aug 21 14:18:58 mail zmconfigd[2556]: Watchdog: service zimlet now available for watchdog.
Aug 21 14:18:58 mail zmconfigd[2556]: Watchdog: skipping service antivirus. Service not yet available for restarts.
Aug 21 14:18:58 mail zmconfigd[2556]: All rewrite threads completed in 0.01 sec
Aug 21 14:18:58 mail zmconfigd[2556]: All restarts completed in 0.00 sec
Aug 21 14:19:07 mail slapd[2534]: slap_queue_csn: queueing 0x302a2c0 20170821191907.903872Z#000000#000#000000
Aug 21 14:19:13 mail zimbramon[2471]: 2471:info: Starting memcached via zmcontrol
Aug 21 14:19:18 mail zimbramon[2471]: 2471:info: Starting proxy via zmcontrol
Aug 21 14:19:18 mail zimbramon[2471]: 2471:info: Starting amavis via zmcontrol
Aug 21 14:19:18 mail amavis-mc[9740]: amavis master process starting. daemonized as PID [9740], perl 5.010001
Aug 21 14:19:18 mail amavis-mc[9740]: Process [9744] started: /opt/zimbra/common/sbin/amavis-services msg-forwarder
Aug 21 14:19:18 mail amavis-mc[9740]: Process [9745] started: /opt/zimbra/common/sbin/amavis-services childproc-minder
Aug 21 14:19:18 mail amavis-mc[9740]: Process [9746] started: /opt/zimbra/common/sbin/amavis-services snmp-responder
Aug 21 14:19:18 mail amavis-services[9744]: amavis-services-2.9.0 (20140506) task 'msg-forwarder' [9744] started. ZMQ::LibZMQ3 1.19, lib 4.1.4
Aug 21 14:19:18 mail amavis-services[9745]: amavis-services-2.9.0 (20140506) task 'childproc-minder' [9745] started. ZMQ::LibZMQ3 1.19, lib 4.1.4
Aug 21 14:19:18 mail amavis-services[9746]: amavis-services-2.9.0 (20140506) task 'snmp-responder' [9746] started. ZMQ::LibZMQ3 1.19, lib 4.1.4
Aug 21 14:19:19 mail amavis-services[9745]: childproc_minder: FLUSH process states
Aug 21 14:19:20 mail amavis[9757]: starting. /opt/zimbra/common/sbin/amavisd at mail.ribasmith.net amavisd-new-2.10.1 (20141025), Unicode aware, LC_ALL="C", LANG="C"
Aug 21 14:19:20 mail amavis[9757]: perl=5.010001, user=498, EUID: 498 (498); group=, EGID: 498 4 5 89 498 (498 4 5 89 498)
Aug 21 14:19:20 mail amavis-services[9746]: snmp_responder: FLUSH snmp data
Aug 21 14:19:20 mail amavis-services[9745]: childproc_minder: FLUSH process states
Aug 21 14:19:22 mail amavis[9757]: SpamControl: init_pre_chroot on SpamAssassin done
Aug 21 14:19:22 mail amavis[9997]: Net::Server: Process Backgrounded
Aug 21 14:19:22 mail amavis[9997]: Net::Server: 2017/08/21-14:19:22 Amavis (type Net::Server::PreForkSimple) starting! pid(9997)
Aug 21 14:19:22 mail amavis[9997]: Net::Server: Binding to UNIX socket file "/opt/zimbra/data/amavisd/amavisd.sock"
Aug 21 14:19:22 mail amavis[9997]: Net::Server: Binding to TCP port 10024 on host 127.0.0.1 with IPv4
Aug 21 14:19:22 mail amavis[9997]: Net::Server: Binding to TCP port 10024 on host ::1 with IPv6
Aug 21 14:19:22 mail amavis[9997]: Net::Server: Binding to TCP port 10026 on host 127.0.0.1 with IPv4
Aug 21 14:19:22 mail amavis[9997]: Net::Server: Binding to TCP port 10026 on host ::1 with IPv6
Aug 21 14:19:22 mail amavis[9997]: Net::Server: Binding to TCP port 10032 on host 127.0.0.1 with IPv4
Aug 21 14:19:22 mail amavis[9997]: Net::Server: Binding to TCP port 10032 on host ::1 with IPv6
Aug 21 14:19:22 mail amavis[9997]: Net::Server: Group Not Defined. Defaulting to EGID '498 4 5 89 498'
Aug 21 14:19:22 mail amavis[9997]: Net::Server: User Not Defined. Defaulting to EUID '498'
Aug 21 14:19:22 mail amavis[9997]: Module Amavis::Conf 2.404
Aug 21 14:19:22 mail amavis[9997]: Module Archive::Zip 1.53
Aug 21 14:19:22 mail amavis[9997]: Module Compress::Raw::Zlib 2.069
Aug 21 14:19:22 mail amavis[9997]: Module Compress::Zlib 2.069
Aug 21 14:19:22 mail amavis[9997]: Module Crypt::OpenSSL::RSA 0.28
Aug 21 14:19:22 mail amavis[9997]: Module DB_File 1.835
Aug 21 14:19:22 mail amavis[9997]: Module Digest::MD5 2.55
Aug 21 14:19:22 mail amavis[9997]: Module Digest::SHA 5.47
Aug 21 14:19:22 mail amavis[9997]: Module Digest::SHA1 2.13
Aug 21 14:19:22 mail amavis[9997]: Module Encode 2.35
Aug 21 14:19:22 mail amavis[9997]: Module File::LibMagic 1.15
Aug 21 14:19:22 mail amavis[9997]: Module File::Temp 0.22
Aug 21 14:19:22 mail amavis[9997]: Module IO::Socket::INET6 2.72
Aug 21 14:19:22 mail amavis[9997]: Module IO::Socket::IP 0.37
Aug 21 14:19:22 mail amavis[9997]: Module MIME::Entity 5.507
Aug 21 14:19:22 mail amavis[9997]: Module MIME::Parser 5.507
Aug 21 14:19:22 mail amavis[9997]: Module MIME::Tools 5.507
Aug 21 14:19:22 mail amavis[9997]: Module Mail::DKIM::Signer 0.4
Aug 21 14:19:22 mail amavis[9997]: Module Mail::DKIM::Verifier 0.4
Aug 21 14:19:22 mail amavis[9997]: Module Mail::Header 2.14
Aug 21 14:19:22 mail amavis[9997]: Module Mail::Internet 2.14
Aug 21 14:19:22 mail amavis[9997]: Module Mail::SPF v2.009
Aug 21 14:19:22 mail amavis[9997]: Module Mail::SpamAssassin 3.004001
Aug 21 14:19:22 mail amavis[9997]: Module Net::DNS 1.04
Aug 21 14:19:22 mail amavis[9997]: Module Net::LDAP 0.65
Aug 21 14:19:22 mail amavis[9997]: Module Net::LibIDN 0.12
Aug 21 14:19:22 mail amavis[9997]: Module Net::Server 2.008
Aug 21 14:19:22 mail amavis[9997]: Module NetAddr::IP 4.078
Aug 21 14:19:22 mail amavis[9997]: Module Razor2::Client::Version 2.84
Aug 21 14:19:22 mail amavis[9997]: Module Scalar::Util 1.21
Aug 21 14:19:22 mail amavis[9997]: Module Socket 2.020
Aug 21 14:19:22 mail amavis[9997]: Module Socket6 0.23
Aug 21 14:19:22 mail amavis[9997]: Module Time::HiRes 1.9721
Aug 21 14:19:22 mail amavis[9997]: Module URI 1.69
Aug 21 14:19:22 mail amavis[9997]: Module Unix::Getrusage 0.03
Aug 21 14:19:22 mail amavis[9997]: Module Unix::Syslog 1.1
Aug 21 14:19:22 mail amavis[9997]: Module ZMQ::LibZMQ3 1.19
Aug 21 14:19:22 mail amavis[9997]: Amavis::ZMQ code loaded
Aug 21 14:19:22 mail amavis[9997]: Amavis::DB code NOT loaded
Aug 21 14:19:22 mail amavis[9997]: SQL base code NOT loaded
Aug 21 14:19:22 mail amavis[9997]: SQL::Log code NOT loaded
Aug 21 14:19:22 mail amavis[9997]: SQL::Quarantine NOT loaded
Aug 21 14:19:22 mail amavis[9997]: Lookup::SQL code NOT loaded
Aug 21 14:19:22 mail amavis[9997]: Lookup::LDAP code loaded
Aug 21 14:19:22 mail amavis[9997]: AM.PDP-in proto code loaded
Aug 21 14:19:22 mail amavis[9997]: SMTP-in proto code loaded
Aug 21 14:19:22 mail amavis[9997]: Courier proto code NOT loaded
Aug 21 14:19:22 mail amavis[9997]: SMTP-out proto code loaded
Aug 21 14:19:22 mail amavis[9997]: Pipe-out proto code NOT loaded
Aug 21 14:19:22 mail amavis[9997]: BSMTP-out proto code NOT loaded
Aug 21 14:19:22 mail amavis[9997]: Local-out proto code loaded
Aug 21 14:19:22 mail amavis[9997]: OS_Fingerprint code NOT loaded
Aug 21 14:19:22 mail amavis[9997]: ANTI-VIRUS code NOT loaded
Aug 21 14:19:22 mail amavis[9997]: ANTI-SPAM code loaded
Aug 21 14:19:22 mail amavis[9997]: ANTI-SPAM-EXT code NOT loaded
Aug 21 14:19:22 mail amavis[9997]: ANTI-SPAM-C code NOT loaded
Aug 21 14:19:22 mail amavis[9997]: ANTI-SPAM-SA code loaded
Aug 21 14:19:22 mail amavis[9997]: Unpackers code loaded
Aug 21 14:19:22 mail amavis[9997]: DKIM code loaded
Aug 21 14:19:22 mail amavis[9997]: Tools code NOT loaded
Aug 21 14:19:22 mail amavis[9997]: Found $file at /usr/bin/file
Aug 21 14:19:22 mail amavis[9997]: No $altermime, not using it
Aug 21 14:19:22 mail amavis[9997]: Internal decoder for .mail
Aug 21 14:19:22 mail amavis[9997]: No ext program for .F, tried: unfreeze, freeze -d, melt, fcat
Aug 21 14:19:22 mail amavis[9997]: Found decoder for .Z at /usr/bin/gzip -d
Aug 21 14:19:22 mail amavis[9997]: Found decoder for .gz at /usr/bin/gzip -d
Aug 21 14:19:22 mail amavis[9997]: Found decoder for .bz2 at /usr/bin/bzip2 -d
Aug 21 14:19:22 mail amavis[9997]: Found decoder for .xz at /usr/bin/xzdec
Aug 21 14:19:22 mail amavis[9997]: Found decoder for .lzma at /usr/bin/lzmadec
Aug 21 14:19:22 mail amavis[9997]: No ext program for .lrz, tried: lrzip -q -k -d -o -, lrzcat -q -k
Aug 21 14:19:22 mail amavis[9997]: No ext program for .lzo, tried: lzop -d
Aug 21 14:19:22 mail amavis[9997]: Found decoder for .rpm at /usr/bin/rpm2cpio
Aug 21 14:19:22 mail amavis[9997]: Found decoder for .cpio at /usr/bin/pax
Aug 21 14:19:22 mail amavis[9997]: Found decoder for .tar at /usr/bin/pax
Aug 21 14:19:22 mail amavis[9997]: Found decoder for .deb at /usr/bin/ar
Aug 21 14:19:22 mail amavis[9997]: No ext program for .rar, tried: unrar, rar
Aug 21 14:19:22 mail amavis[9997]: No ext program for .arj, tried: unarj, arj
Aug 21 14:19:22 mail amavis[9997]: No ext program for .arc, tried: nomarch, arc
Aug 21 14:19:22 mail amavis[9997]: No ext program for .zoo, tried: zoo, unzoo
Aug 21 14:19:22 mail amavis[9997]: No ext program for .doc, tried: ripole
Aug 21 14:19:22 mail amavis[9997]: No ext program for .cab, tried: cabextract
Aug 21 14:19:22 mail amavis[9997]: No ext program for .tnef, tried: tnef
Aug 21 14:19:22 mail amavis[9997]: Internal decoder for .tnef
Aug 21 14:19:22 mail amavis[9997]: No ext program for .zip, tried: 7za, 7z
Aug 21 14:19:22 mail amavis[9997]: No ext program for .kmz, tried: 7za, 7z
Aug 21 14:19:22 mail amavis[9997]: Internal decoder for .zip
Aug 21 14:19:22 mail amavis[9997]: Internal decoder for .kmz
Aug 21 14:19:22 mail amavis[9997]: No ext program for .7z, tried: 7zr, 7za, 7z
Aug 21 14:19:22 mail amavis[9997]: No ext program for .7z, tried: 7za, 7z
Aug 21 14:19:22 mail amavis[9997]: No ext program for .jar, tried: 7z
Aug 21 14:19:22 mail amavis[9997]: No ext program for .arj, tried: 7z
Aug 21 14:19:22 mail amavis[9997]: No ext program for .rar, tried: 7z
Aug 21 14:19:22 mail amavis[9997]: No ext program for .swf, tried: 7z
Aug 21 14:19:22 mail amavis[9997]: No ext program for .lha, tried: 7z
Aug 21 14:19:22 mail amavis[9997]: No ext program for .iso, tried: 7z
Aug 21 14:19:22 mail amavis[9997]: No ext program for .cab, tried: 7z
Aug 21 14:19:22 mail amavis[9997]: No ext program for .exe, tried: unrar, rar; lha; unarj, arj
Aug 21 14:19:22 mail amavis[9997]: No decoder for .7z
Aug 21 14:19:22 mail amavis[9997]: No decoder for .F
Aug 21 14:19:22 mail amavis[9997]: No decoder for .arc
Aug 21 14:19:22 mail amavis[9997]: No decoder for .arj
Aug 21 14:19:22 mail amavis[9997]: No decoder for .cab
Aug 21 14:19:22 mail amavis[9997]: No decoder for .doc
Aug 21 14:19:22 mail amavis[9997]: No decoder for .exe
Aug 21 14:19:22 mail amavis[9997]: No decoder for .iso
Aug 21 14:19:22 mail amavis[9997]: No decoder for .jar
Aug 21 14:19:22 mail amavis[9997]: No decoder for .lha
Aug 21 14:19:22 mail amavis[9997]: No decoder for .lrz
Aug 21 14:19:22 mail amavis[9997]: No decoder for .lzo
Aug 21 14:19:22 mail amavis[9997]: No decoder for .rar
Aug 21 14:19:22 mail amavis[9997]: No decoder for .swf
Aug 21 14:19:22 mail amavis[9997]: No decoder for .zoo
Aug 21 14:19:22 mail amavis[9997]: initializing Mail::SpamAssassin (0)
Aug 21 14:19:22 mail zimbramon[2471]: 2471:info: Starting antispam via zmcontrol
Aug 21 14:19:25 mail zimbramon[2471]: 2471:info: Starting opendkim via zmcontrol
Aug 21 14:19:25 mail zimbramon[2471]: 2471:info: Starting snmp via zmcontrol
Aug 21 14:19:25 mail zimbramon[2471]: 2471:info: Starting spell via zmcontrol
Aug 21 14:19:27 mail zimbramon[2471]: 2471:info: Starting mta via zmcontrol
Aug 21 14:19:28 mail saslauthd[10740]: detach_tty : master pid is: 10740
Aug 21 14:19:28 mail saslauthd[10740]: ipc_init : listening on socket: /opt/zimbra/data/sasl2/state/mux
Aug 21 14:19:30 mail amavis[9997]: SA info: pyzor: [10484] error: TERMINATED, signal 15 (000f)
Aug 21 14:19:30 mail amavis[9997]: SpamControl: init_pre_fork on SpamAssassin done
Aug 21 14:19:30 mail amavis[9997]: extra modules loaded after daemonizing/chrooting: /usr/share/perl5/Net/libnet.cfg, Mail/SpamAssassin/Plugin/FreeMail.pm, Mail/SpamAssassin/Plugin/SpamCop.pm, Net/Cmd.pm, Net/Config.pm, Net/SMTP.pm
Aug 21 14:19:33 mail /postfix-script[11418]: starting the Postfix mail system
Aug 21 14:19:33 mail postfix/master[11420]: daemon started -- version 3.1.1, configuration /opt/zimbra/common/conf
Aug 21 14:19:33 mail zimbramon[2471]: 2471:info: Starting stats via zmcontrol
Aug 21 14:19:34 mail zimbramon[2471]: 2471:info: Starting service via zmcontrol
Aug 21 14:19:34 mail zimbramon[2471]: 2471:info: Starting zimbra via zmcontrol
Aug 21 14:19:34 mail zimbramon[2471]: 2471:info: Starting zimbraAdmin via zmcontrol
Aug 21 14:19:35 mail zimbramon[2471]: 2471:info: Starting zimlet via zmcontrol
Aug 21 14:19:58 mail zmconfigd[2556]: Fetching All configs
Aug 21 14:19:58 mail zmconfigd[2556]: Skipping All Reverse Proxy URLs update.
Aug 21 14:19:58 mail zmconfigd[2556]: Skipping Global system configuration update.
Aug 21 14:19:58 mail zmconfigd[2556]: getAllReverseProxyURLs <function garpu at 0x3>(None) 1 com.zimbra.common.service.ServiceException: system failure: unable to list all servers ExceptionId:mc:1503343198519:b4c68f909cf948fa Code:service.FAILURE
Aug 21 14:19:58 mail zmconfigd[2556]: gacf <function getglobal at 0x4>(None) 1 com.zimbra.common.service.ServiceException: system failure: unable to get config ExceptionId:gc:1503343198517:b4c68f909cf948fa Code:service.FAILURE
Aug 21 14:19:58 mail zmconfigd[2556]: Skipping Configuration for server update.
Aug 21 14:19:58 mail zmconfigd[2556]: gs <function getserver at 0x5>(None) 1 com.zimbra.common.service.ServiceException: system failure: unable to lookup server by name: mail.ribasmith.net message: LDAP error: - unable to get connection: ldap host=: An error occurred while attempting to connect to server mail.ribasmith.net:389: java.io.IOException: An error occurred while attempting to establish a connection to server mail.ribasmith.net:389: java.net.ConnectException: Connection refused (Connection refused) ExceptionId:sc:1503343198521:b4c68f909cf948fa Code:service.FAILURE
Aug 21 14:19:58 mail zmconfigd[2556]: Skipping All Reverse Proxy Backends update.
Aug 21 14:19:58 mail zmconfigd[2556]: getAllReverseProxyBackends <function garpb at 0x6>(None) 1 com.zimbra.common.service.ServiceException: system failure: unable to list all servers ExceptionId:mc:1503343198523:b4c68f909cf948fa Code:service.FAILURE
Aug 21 14:19:58 mail zmconfigd[2556]: Skipping All Memcached Servers update.
Aug 21 14:19:58 mail zmconfigd[2556]: getAllMemcachedServers <function gamcs at 0x7>(None) 1 com.zimbra.common.service.ServiceException: system failure: unable to list all servers ExceptionId:mc:1503343198526:b4c68f909cf948fa Code:service.FAILURE
Aug 21 14:19:58 mail zmconfigd[2556]: Skipping All MTA Authentication Target URLs update.
Aug 21 14:19:58 mail zmconfigd[2556]: getAllMtaAuthURLs <function gamau at 0x8>(None) 1 com.zimbra.common.service.ServiceException: system failure: unable to list all servers ExceptionId:mc:1503343198529:b4c68f909cf948fa Code:service.FAILURE
Aug 21 14:19:58 mail zmconfigd[2556]: All configs fetched in 0.03 seconds
Aug 21 14:19:58 mail zmconfigd[2556]: Service status change: mail.ribasmith.net amavis changed from stopped to running
Aug 21 14:19:58 mail zmconfigd[2556]: Tracking service amavis
Aug 21 14:19:58 mail zmconfigd[2556]: Watchdog: service amavis now available for watchdog.
Aug 21 14:20:01 mail zmconfigd[2556]: Service status change: mail.ribasmith.net antispam changed from stopped to running
Aug 21 14:20:01 mail zmconfigd[2556]: Tracking service antispam
Aug 21 14:20:01 mail zmconfigd[2556]: Watchdog: service antispam now available for watchdog.
Aug 21 14:20:01 mail zmconfigd[2556]: Service status change: mail.ribasmith.net ldap changed from running to stopped
Aug 21 14:20:01 mail zimbramon[12956]: 12956:info: 2017-08-21 14:20:01, QUEUE: 0 0
Aug 21 14:20:01 mail zmconfigd[2556]: Service status change: mail.ribasmith.net memcached changed from stopped to running
Aug 21 14:20:01 mail zmconfigd[2556]: Tracking service memcached
Aug 21 14:20:01 mail zmconfigd[2556]: Watchdog: service memcached now available for watchdog.
Aug 21 14:20:01 mail slapd[13280]: @(#) $OpenLDAP: slapd 2.4.44 (Sep 29 2016 10:52:08) $#012#011build@c687:/home/build/git/87/packages/thirdparty/openldap/build/RHEL6_64/zimbra-openldap/rpm/BUILD/openldap-2.4.44/servers/slapd
Aug 21 14:20:02 mail slapd[13344]: slapd starting
Aug 21 14:20:02 mail zmconfigd[2556]: Tracking service mta
Aug 21 14:20:02 mail zmconfigd[2556]: Tracking service opendkim
Aug 21 14:20:02 mail zmconfigd[2556]: Service status change: mail.ribasmith.net proxy changed from stopped to running
Aug 21 14:20:02 mail zmconfigd[2556]: Tracking service proxy
Aug 21 14:20:02 mail zmconfigd[2556]: Watchdog: service proxy now available for watchdog.
Aug 21 14:20:02 mail zmconfigd[2556]: Service status change: mail.ribasmith.net sasl changed from stopped to running
Aug 21 14:20:02 mail zmconfigd[2556]: Tracking service sasl
Aug 21 14:20:02 mail zmconfigd[2556]: Watchdog: service sasl now available for watchdog.
Aug 21 14:20:02 mail zmconfigd[2556]: Service status change: mail.ribasmith.net snmp changed from stopped to running
Aug 21 14:20:02 mail zmconfigd[2556]: Tracking service snmp
Aug 21 14:20:02 mail zmconfigd[2556]: Watchdog: service snmp now available for watchdog.
Aug 21 14:20:02 mail zmconfigd[2556]: Service status change: mail.ribasmith.net spell changed from stopped to running
Aug 21 14:20:02 mail zmconfigd[2556]: Tracking service spell
Aug 21 14:20:02 mail zmconfigd[2556]: Watchdog: service spell now available for watchdog.
Aug 21 14:20:02 mail postfix/postscreen[13559]: warning: cidr map /opt/zimbra/conf/postscreen_wblist, line 30: non-null host address bits in "192.168.5.0/2", perhaps you should use "192.0.0.0/2" instead: skipping this rule
Aug 21 14:20:02 mail postfix/postscreen[13559]: warning: cidr map /opt/zimbra/conf/postscreen_wblist, line 33: bad address pattern: "64.116.178.*": skipping this rule
Aug 21 14:20:02 mail postfix/postscreen[13559]: CONNECT from [192.168.77.96]:47142 to [192.168.77.96]:25
Aug 21 14:20:02 mail postfix/postscreen[13559]: WHITELISTED [192.168.77.96]:47142
Aug 21 14:20:03 mail postfix/smtpd[13588]: connect from mail.ribasmith.net[192.168.77.96]
Aug 21 14:20:03 mail postfix/smtpd[13588]: warning: connect to Milter service inet:127.0.0.1:7026: Connection refused
Aug 21 14:20:03 mail postfix/smtpd[13588]: NOQUEUE: milter-reject: CONNECT from mail.ribasmith.net[192.168.77.96]: 451 4.7.1 Service unavailable - try again later; proto=SMTP
Aug 21 14:20:03 mail postfix/smtpd[13588]: NOQUEUE: milter-reject: EHLO from mail.ribasmith.net[192.168.77.96]: 451 4.7.1 Service unavailable - try again later; proto=SMTP helo=<localhost.localdomain>
Aug 21 14:20:03 mail postfix/smtpd[13588]: NOQUEUE: milter-reject: MAIL from mail.ribasmith.net[192.168.77.96]: 451 4.7.1 Service unavailable - try again later; from=<admin@ribasmith.net> proto=ESMTP helo=<localhost.localdomain>
Aug 21 14:20:03 mail postfix/smtpd[13588]: lost connection after DATA from mail.ribasmith.net[192.168.77.96]
Aug 21 14:20:03 mail postfix/smtpd[13588]: disconnect from mail.ribasmith.net[192.168.77.96] ehlo=1 mail=0/1 rcpt=0/1 data=0/1 commands=1/4
Aug 21 14:20:03 mail postfix/postscreen[13559]: CONNECT from [192.168.77.96]:47150 to [192.168.77.96]:25
Aug 21 14:20:03 mail postfix/postscreen[13559]: WHITELISTED [192.168.77.96]:47150
Aug 21 14:20:03 mail postfix/smtpd[13588]: connect from mail.ribasmith.net[192.168.77.96]
Aug 21 14:20:03 mail postfix/smtpd[13588]: warning: connect to Milter service inet:127.0.0.1:7026: Connection refused
Aug 21 14:20:03 mail postfix/smtpd[13588]: NOQUEUE: milter-reject: CONNECT from mail.ribasmith.net[192.168.77.96]: 451 4.7.1 Service unavailable - try again later; proto=SMTP
Aug 21 14:20:03 mail postfix/smtpd[13588]: NOQUEUE: milter-reject: EHLO from mail.ribasmith.net[192.168.77.96]: 451 4.7.1 Service unavailable - try again later; proto=SMTP helo=<localhost.localdomain>
Aug 21 14:20:03 mail postfix/smtpd[13588]: NOQUEUE: milter-reject: MAIL from mail.ribasmith.net[192.168.77.96]: 451 4.7.1 Service unavailable - try again later; from=<admin@ribasmith.net> proto=ESMTP helo=<localhost.localdomain>
Aug 21 14:20:03 mail postfix/smtpd[13588]: lost connection after DATA from mail.ribasmith.net[192.168.77.96]
Aug 21 14:20:03 mail postfix/smtpd[13588]: disconnect from mail.ribasmith.net[192.168.77.96] ehlo=1 mail=0/1 rcpt=0/1 data=0/1 commands=1/4
Aug 21 14:20:03 mail postfix/postscreen[13559]: CONNECT from [192.168.77.96]:47156 to [192.168.77.96]:25
Aug 21 14:20:03 mail postfix/postscreen[13559]: WHITELISTED [192.168.77.96]:47156
Aug 21 14:20:03 mail postfix/smtpd[13588]: connect from mail.ribasmith.net[192.168.77.96]
Aug 21 14:20:03 mail postfix/smtpd[13588]: warning: connect to Milter service inet:127.0.0.1:7026: Connection refused
Aug 21 14:20:03 mail postfix/smtpd[13588]: NOQUEUE: milter-reject: CONNECT from mail.ribasmith.net[192.168.77.96]: 451 4.7.1 Service unavailable - try again later; proto=SMTP
Aug 21 14:20:03 mail postfix/smtpd[13588]: NOQUEUE: milter-reject: EHLO from mail.ribasmith.net[192.168.77.96]: 451 4.7.1 Service unavailable - try again later; proto=SMTP helo=<localhost.localdomain>
Aug 21 14:20:03 mail postfix/smtpd[13588]: NOQUEUE: milter-reject: MAIL from mail.ribasmith.net[192.168.77.96]: 451 4.7.1 Service unavailable - try again later; from=<admin@ribasmith.net> proto=ESMTP helo=<localhost.localdomain>
Aug 21 14:20:03 mail postfix/smtpd[13588]: lost connection after DATA from mail.ribasmith.net[192.168.77.96]
Aug 21 14:20:03 mail postfix/smtpd[13588]: disconnect from mail.ribasmith.net[192.168.77.96] ehlo=1 mail=0/1 rcpt=0/1 data=0/1 commands=1/4
Aug 21 14:20:03 mail postfix/postscreen[13559]: CONNECT from [192.168.77.96]:47162 to [192.168.77.96]:25
Aug 21 14:20:03 mail postfix/postscreen[13559]: WHITELISTED [192.168.77.96]:47162
Aug 21 14:20:03 mail postfix/smtpd[13588]: connect from mail.ribasmith.net[192.168.77.96]
Aug 21 14:20:03 mail postfix/smtpd[13588]: warning: connect to Milter service inet:127.0.0.1:7026: Connection refused
Aug 21 14:20:03 mail postfix/smtpd[13588]: NOQUEUE: milter-reject: CONNECT from mail.ribasmith.net[192.168.77.96]: 451 4.7.1 Service unavailable - try again later; proto=SMTP
Aug 21 14:20:03 mail postfix/smtpd[13588]: NOQUEUE: milter-reject: EHLO from mail.ribasmith.net[192.168.77.96]: 451 4.7.1 Service unavailable - try again later; proto=SMTP helo=<localhost.localdomain>
Aug 21 14:20:03 mail postfix/smtpd[13588]: NOQUEUE: milter-reject: MAIL from mail.ribasmith.net[192.168.77.96]: 451 4.7.1 Service unavailable - try again later; from=<admin@ribasmith.net> proto=ESMTP helo=<localhost.localdomain>
Aug 21 14:20:03 mail postfix/smtpd[13588]: lost connection after DATA from mail.ribasmith.net[192.168.77.96]
Aug 21 14:20:03 mail postfix/smtpd[13588]: disconnect from mail.ribasmith.net[192.168.77.96] ehlo=1 mail=0/1 rcpt=0/1 data=0/1 commands=1/4
Aug 21 14:20:03 mail zmconfigd[2556]: Watchdog: skipping service antivirus. Service not yet available for restarts.
Aug 21 14:20:03 mail zmconfigd[2556]: All rewrite threads completed in 0.01 sec
Aug 21 14:20:03 mail zmconfigd[2556]: All restarts completed in 0.00 sec
Aug 21 14:20:05 mail slapd[13344]: slap_queue_csn: queueing 0x2b941c0 20170821192004.999525Z#000000#000#000000
Aug 21 14:20:07 mail slapd[14033]: @(#) $OpenLDAP: slapd 2.4.44 (Sep 29 2016 10:52:08) $#012#011build@c687:/home/build/git/87/packages/thirdparty/openldap/build/RHEL6_64/zimbra-openldap/rpm/BUILD/openldap-2.4.44/servers/slapd
Aug 21 14:20:07 mail slapd[14056]: slapd starting
Aug 21 14:20:13 mail slapd[14056]: slap_queue_csn: queueing 0x3338480 20170821192013.795008Z#000000#000#000000
Aug 21 14:21:03 mail zmconfigd[2556]: Fetching All configs
Aug 21 14:21:03 mail zmconfigd[2556]: Skipping All Reverse Proxy URLs update.
Aug 21 14:21:03 mail zmconfigd[2556]: getAllReverseProxyURLs <function garpu at 0x3>(None) 1 com.zimbra.common.service.ServiceException: system failure: unable to list all servers ExceptionId:mc:1503343263546:b4c68f909cf948fa Code:service.FAILURE
Aug 21 14:21:03 mail zmconfigd[2556]: Skipping Configuration for server update.
Aug 21 14:21:03 mail zmconfigd[2556]: gs <function getserver at 0x5>(None) 1 com.zimbra.common.service.ServiceException: system failure: unable to lookup server by name: mail.ribasmith.net message: LDAP error: - unable to get connection: ldap host=: An error occurred while attempting to connect to server mail.ribasmith.net:389: java.io.IOException: An error occurred while attempting to establish a connection to server mail.ribasmith.net:389: java.net.ConnectException: Connection refused (Connection refused) ExceptionId:sc:1503343263547:b4c68f909cf948fa Code:service.FAILURE
Aug 21 14:21:03 mail zmconfigd[2556]: Skipping Global system configuration update.
Aug 21 14:21:03 mail zmconfigd[2556]: gacf <function getglobal at 0x4>(None) 1 com.zimbra.common.service.ServiceException: system failure: unable to get config ExceptionId:gc:1503343263550:b4c68f909cf948fa Code:service.FAILURE
Aug 21 14:21:03 mail zmconfigd[2556]: Skipping All Reverse Proxy Backends update.
Aug 21 14:21:03 mail zmconfigd[2556]: getAllReverseProxyBackends <function garpb at 0x6>(None) 1 com.zimbra.common.service.ServiceException: system failure: unable to list all servers ExceptionId:mc:1503343263551:b4c68f909cf948fa Code:service.FAILURE
Aug 21 14:21:03 mail zmconfigd[2556]: Skipping All Memcached Servers update.
Aug 21 14:21:03 mail zmconfigd[2556]: getAllMemcachedServers <function gamcs at 0x7>(None) 1 com.zimbra.common.service.ServiceException: system failure: unable to list all servers ExceptionId:mc:1503343263554:b4c68f909cf948fa Code:service.FAILURE
Aug 21 14:21:03 mail zmconfigd[2556]: Skipping All MTA Authentication Target URLs update.
Aug 21 14:21:03 mail zmconfigd[2556]: getAllMtaAuthURLs <function gamau at 0x8>(None) 1 com.zimbra.common.service.ServiceException: system failure: unable to list all servers ExceptionId:mc:1503343263557:b4c68f909cf948fa Code:service.FAILURE
Aug 21 14:21:03 mail zmconfigd[2556]: All configs fetched in 0.02 seconds
Aug 21 14:21:07 mail zmconfigd[2556]: Tracking service mta
Aug 21 14:21:07 mail zmconfigd[2556]: Tracking service opendkim
Aug 21 14:21:08 mail zmconfigd[2556]: Watchdog: skipping service antivirus. Service not yet available for restarts.
Aug 21 14:21:08 mail zmconfigd[2556]: All rewrite threads completed in 0.01 sec
Aug 21 14:21:08 mail zmconfigd[2556]: All restarts completed in 0.00 sec
Re: LDAP DE ZIMBRA SE CAE
Ahora que dejo mailbox.log
Code: Select all
2017-08-21 14:18:22,567 INFO [main] [] misc - DoSFilter: Configured whitelist IPs = 192.168.77.96,192.168.5.0/24,127.0.0.1,::1,0:0:0:0:0:0:0:1
2017-08-21 14:18:22,593 INFO [main] [] misc - DoSFilter: Configured whitelist IPs = 192.168.77.96,192.168.5.0/24,127.0.0.1,::1,0:0:0:0:0:0:0:1
2017-08-21 14:18:22,612 INFO [main] [] misc - ZimbraInvalidLoginFilter initialized
2017-08-21 14:18:22,638 INFO [main] [] misc - Initialized with /service:max=80%, /zimbra:max=15%, /zimbraAdmin:max=5%
2017-08-21 14:18:22,638 INFO [main] [] misc - Thread pool was configured to max=250
2017-08-21 14:18:22,666 INFO [main] [] misc - CSRF filter was initialized: CSRFAllowedRefHost: []
2017-08-21 14:18:22,820 INFO [main] [] soap - Servlet SoapServlet starting up
2017-08-21 14:18:22,853 INFO [main] [] soap - Adding service AccountService to SoapServlet
2017-08-21 14:18:22,959 INFO [main] [] soap - Adding service MailService to SoapServlet
2017-08-21 14:18:23,078 INFO [main] [] misc - version=8.7.11_GA_1854 release=20170531151956 builddate=20170531-1446 buildhost=zre-rhel6-64.eng.zimbra.com
2017-08-21 14:18:23,079 INFO [main] [] misc - LANG environment is set to: C
2017-08-21 14:18:23,079 INFO [main] [] misc - System property java.home=/opt/zimbra/common/lib/jvm/openjdk-1.8.0_144-zimbra/jre
2017-08-21 14:18:23,079 INFO [main] [] misc - System property java.runtime.version=1.8.0_144-zimbra-b01
2017-08-21 14:18:23,079 INFO [main] [] misc - System property java.version=1.8.0_144-zimbra
2017-08-21 14:18:23,079 INFO [main] [] misc - System property java.vm.info=mixed mode
2017-08-21 14:18:23,079 INFO [main] [] misc - System property java.vm.name=OpenJDK 64-Bit Server VM
2017-08-21 14:18:23,079 INFO [main] [] misc - System property java.vm.version=25.144-b01
2017-08-21 14:18:23,079 INFO [main] [] misc - System property os.arch=amd64
2017-08-21 14:18:23,079 INFO [main] [] misc - System property os.name=Linux
2017-08-21 14:18:23,079 INFO [main] [] misc - System property os.version=2.6.32-696.6.3.el6.x86_64
2017-08-21 14:18:23,079 INFO [main] [] misc - System property sun.arch.data.model=64
2017-08-21 14:18:23,079 INFO [main] [] misc - System property sun.cpu.endian=little
2017-08-21 14:18:23,079 INFO [main] [] misc - System property sun.cpu.isalist=
2017-08-21 14:18:23,080 INFO [main] [] misc - System property sun.os.patch.level=unknown
2017-08-21 14:18:23,107 INFO [main] [] system - Setting mysql connector property: maxActive=100
2017-08-21 14:18:23,107 INFO [main] [] system - Setting mysql connector property: maxActive=100
2017-08-21 14:18:23,266 INFO [main] [] sqltrace - Setting slow SQL threshold to 2000ms.
2017-08-21 14:18:24,053 INFO [main] [] ZimbraHttpConnectionManager - Starting http client idle connection reaper thread for Internal http client connection manager - reaper sleep interval=300000, reaper connection timeout=300000
2017-08-21 14:18:24,055 INFO [main] [] ZimbraHttpConnectionManager - Starting http client idle connection reaper thread for External http client connection manager - reaper sleep interval=300000, reaper connection timeout=300000
2017-08-21 14:18:24,061 WARN [main] [] ephemeral - Replacing ephemeral factory class 'com.zimbra.cs.ephemeral.LdapEphemeralStore$Factory' registered for 'ldap' with 'com.zimbra.cs.ephemeral.LdapEphemeralStore$Factory'
2017-08-21 14:18:24,064 INFO [main] [] extensions - Loading extensions from /opt/zimbra/lib/ext
2017-08-21 14:18:24,068 INFO [main] [] extensions - extension com.zimbra.bp.ZimbraBulkProvisionExt found in /opt/zimbra/lib/ext/com_zimbra_bulkprovision/com_zimbra_bulkprovision.jar
2017-08-21 14:18:24,070 WARN [main] [] extensions - no Zimbra-Extension-Class found, ignored: /opt/zimbra/lib/ext/twofactorauth
2017-08-21 14:18:24,075 INFO [main] [] extensions - extension com.zimbra.cs.nginx.NginxLookupExtension found in /opt/zimbra/lib/ext/nginx-lookup/nginx-lookup.jar
2017-08-21 14:18:24,077 INFO [main] [] extensions - extension com.zimbra.cert.ZimbraCertMgrExt found in /opt/zimbra/lib/ext/com_zimbra_cert_manager/com_zimbra_cert_manager.jar
2017-08-21 14:18:24,077 WARN [main] [] extensions - no Zimbra-Extension-Class found, ignored: /opt/zimbra/lib/ext/zimbra-license
2017-08-21 14:18:24,103 INFO [main] [] extensions - extension org.openzal.zal.extension.ZalEntrypointImpl found in /opt/zimbra/lib/ext/zimbradrive/zal.jar
2017-08-21 14:18:24,116 WARN [main] [] extensions - no Zimbra-Extension-Class found, ignored: /opt/zimbra/lib/ext/zimbra-freebusy
2017-08-21 14:18:24,132 WARN [main] [] extensions - no Zimbra-Extension-Class found, ignored: /opt/zimbra/lib/ext/openidconsumer
2017-08-21 14:18:24,133 INFO [main] [] extensions - extension com.zimbra.ssdb.SSDBEphemeralStoreExtension found in /opt/zimbra/lib/ext/com_zimbra_ssdb_ephemeral_store/zm-ssdb-ephemeral-store-8.7.11.1496133981.jar
2017-08-21 14:18:24,135 INFO [main] [] extensions - extension com.zimbra.clientuploader.ZClientUploaderExt found in /opt/zimbra/lib/ext/com_zimbra_clientuploader/com_zimbra_clientuploader.jar
2017-08-21 14:18:24,136 INFO [main] [] extensions - extension com.zimbra.clam.ClamScannerExt found in /opt/zimbra/lib/ext/clamscanner/clamscanner.jar
2017-08-21 14:18:24,161 INFO [main] [] extensions - extension org.openzal.zal.extension.ZalEntrypointImpl found in /opt/zimbra/lib/ext/openchat/zal.jar
2017-08-21 14:18:24,162 WARN [main] [] extensions - no Zimbra-Extension-Class found, ignored: /opt/zimbra/lib/ext/mitel
2017-08-21 14:18:24,165 INFO [main] [] extensions - extension com.zimbra.ldaputils.ZimbraLDAPUtilsExtension found in /opt/zimbra/lib/ext/zimbraldaputils/zimbraldaputils.jar
2017-08-21 14:18:24,165 INFO [main] [] extensions - extension com.zimbra.cs.versioncheck.VersionCheckExtension found in /opt/zimbra/lib/ext/zimbraadminversioncheck/zimbraadminversioncheck.jar
2017-08-21 14:18:24,165 INFO [main] [] extensions - Initializing extensions
2017-08-21 14:18:24,171 INFO [main] [] extensions - Handler at /com_zimbra_bulkprovision/bulkdownload starting up
2017-08-21 14:18:24,171 INFO [main] [] extensions - registered handler at /com_zimbra_bulkprovision/bulkdownload
2017-08-21 14:18:24,182 INFO [main] [] extensions - Initialized extension com_zimbra_bulkprovision: com.zimbra.bp.ZimbraBulkProvisionExt@com.zimbra.cs.extension.ZimbraExtensionClassLoader@27cbfddf
2017-08-21 14:18:24,199 INFO [main] [] extensions - registered handler at /nginx-lookup
2017-08-21 14:18:24,203 INFO [main] [] extensions - Initialized extension nginx-lookup: com.zimbra.cs.nginx.NginxLookupExtension@com.zimbra.cs.extension.ZimbraExtensionClassLoader@45673f68
2017-08-21 14:18:24,215 INFO [main] [] extensions - registered handler at /com_zimbra_cert_manager/downloadcsr
2017-08-21 14:18:24,215 INFO [main] [] extensions - Initialized extension com_zimbra_cert_manager: com.zimbra.cert.ZimbraCertMgrExt@com.zimbra.cs.extension.ZimbraExtensionClassLoader@73eb8672
2017-08-21 14:18:24,230 INFO [main] [] mailbox - Starting ZAL version 1.11.11 commit 5d9fc8a0e483adc4b7051b6ed21572d038604589
2017-08-21 14:18:24,241 INFO [main] [] mailbox - File /opt/zimbra/lib/ext/zimbradrive/extension-path not present, using standard boot
2017-08-21 14:18:24,245 INFO [main] [] extensions - Searching ZAL extension in directory /opt/zimbra/lib/ext/zimbradrive
2017-08-21 14:18:35,372 INFO [main] [] sqltrace - Slow execution (11106ms): SELECT * FROM volume
2017-08-21 14:18:35,653 INFO [main] [] extensions - Initialized extension Zimbra Abstraction Layer for: zimbradrive: org.openzal.zal.extension.ZalEntrypointImpl@com.zimbra.cs.extension.ZimbraExtensionClassLoader@6b7d1df8
2017-08-21 14:18:35,657 INFO [main] [] ephemeral - Registering ephemeral factory class 'com.zimbra.ssdb.SSDBEphemeralStore$Factory' for prefix 'ssdb'
2017-08-21 14:18:35,659 INFO [main] [] extensions - Initialized extension com_zimbra_ssdb_ephemeral_store: com.zimbra.ssdb.SSDBEphemeralStoreExtension@com.zimbra.cs.extension.ZimbraExtensionClassLoader@72805168
2017-08-21 14:18:35,663 INFO [main] [] extensions - registered handler at /clientUploader/upload
2017-08-21 14:18:35,664 INFO [main] [] extensions - Initialized extension clientUploader: com.zimbra.clientuploader.ZClientUploaderExt@com.zimbra.cs.extension.ZimbraExtensionClassLoader@278f8425
2017-08-21 14:18:35,668 INFO [main] [] extensions - attachment scan is disabled
2017-08-21 14:18:35,668 INFO [main] [] extensions - Initialized extension clamscanner: com.zimbra.clam.ClamScannerExt@com.zimbra.cs.extension.ZimbraExtensionClassLoader@19593091
2017-08-21 14:18:35,685 INFO [main] [] mailbox - Starting ZAL version 1.11.11 commit 5d9fc8a0e483adc4b7051b6ed21572d038604589
2017-08-21 14:18:35,694 INFO [main] [] mailbox - File /opt/zimbra/lib/ext/openchat/extension-path not present, using standard boot
2017-08-21 14:18:35,698 INFO [main] [] extensions - Searching ZAL extension in directory /opt/zimbra/lib/ext/openchat
2017-08-21 14:18:35,713 INFO [main] [] extensions - Initialized extension Zimbra Abstraction Layer for: openchat: org.openzal.zal.extension.ZalEntrypointImpl@com.zimbra.cs.extension.ZimbraExtensionClassLoader@afb5821
2017-08-21 14:18:35,721 INFO [main] [] extensions - Initialized extension zimbrasamba: com.zimbra.ldaputils.ZimbraLDAPUtilsExtension@com.zimbra.cs.extension.ZimbraExtensionClassLoader@abbc908
2017-08-21 14:18:35,726 INFO [main] [] extensions - Initialized extension versioncheck: com.zimbra.cs.versioncheck.VersionCheckExtension@com.zimbra.cs.extension.ZimbraExtensionClassLoader@29314cc9
2017-08-21 14:18:35,727 INFO [IncomingDirectorySweeper] [] store - IncomingDirectorySweeper thread starting
2017-08-21 14:18:35,747 INFO [main] [] store - Starting up FileCache at /opt/zimbra/data/tmp/uncompressed. maxFiles=2147483647, maxBytes=9223372036854775807.
2017-08-21 14:18:35,753 INFO [main] [] FileDescriptorCache - Loading settings: zimbraMailFileDescriptorCacheSize=1000.
2017-08-21 14:18:36,000 INFO [main] [] EhcacheManager - Cache 'imap-active-session-cache' created in EhcacheManager.
2017-08-21 14:18:36,800 INFO [main] [] OffHeapDiskStore - The index for data file ehcache-disk-store.data is more recent than the data file itself by 81447874ms : this is harmless.
2017-08-21 14:18:36,842 INFO [main] [] EhcacheManager - Cache 'imap-inactive-session-cache' created in EhcacheManager.
2017-08-21 14:18:36,848 INFO [main] [] AnnotationSizeOfFilter - Using regular expression provided through VM argument org.ehcache.sizeof.filters.AnnotationSizeOfFilter.pattern for IgnoreSizeOf annotation : ^.*cache\..*IgnoreSizeOf$
2017-08-21 14:18:36,861 INFO [main] [] AgentLoader - Located valid 'tools.jar' at '/opt/zimbra/common/lib/jvm/openjdk-1.8.0_144-zimbra/jre/../lib/tools.jar'
2017-08-21 14:18:36,870 INFO [main] [] JvmInformation - Detected JVM data model settings of: 64-Bit OpenJDK JVM with Compressed OOPs and Concurrent Mark-and-Sweep GC
2017-08-21 14:18:37,117 INFO [main] [] AgentLoader - Extracted agent jar to temporary file /opt/zimbra/mailboxd/work/ehcache-sizeof-agent3645011194338244100.jar
2017-08-21 14:18:37,117 INFO [main] [] AgentLoader - Trying to load agent @ /opt/zimbra/mailboxd/work/ehcache-sizeof-agent3645011194338244100.jar
2017-08-21 14:18:37,150 INFO [main] [] AgentLoader - Agent successfully loaded and available!
2017-08-21 14:18:37,176 INFO [main] [] OffHeapDiskStore - The index for data file ehcache-disk-store.data is more recent than the data file itself by 3902774832ms : this is harmless.
2017-08-21 14:18:37,180 INFO [main] [] EhcacheManager - Cache 'sync-state-item-cache' created in EhcacheManager.
2017-08-21 14:18:37,210 INFO [main] [] redolog - Starting pre-startup crash recovery
2017-08-21 14:18:37,241 INFO [FileLogWriter.FsyncThread-1503343117241] [] redolog - Starting fsync thread with interval 10
2017-08-21 14:18:37,246 INFO [main] [] redolog - waiting for FileLogWriter.FsyncThread-1503343117241 to finish.
2017-08-21 14:18:37,252 INFO [FileLogWriter.FsyncThread-1503343117241] [] redolog - fsync thread exiting
2017-08-21 14:18:37,253 INFO [main] [] redolog - FileLogWriter.FsyncThread-1503343117241 finished
2017-08-21 14:18:37,257 INFO [main] [] redolog - No uncommitted transactions to redo
2017-08-21 14:18:37,257 INFO [FileLogWriter.FsyncThread-1503343117256] [] redolog - Starting fsync thread with interval 10
2017-08-21 14:18:37,257 INFO [main] [] redolog - waiting for FileLogWriter.FsyncThread-1503343117256 to finish.
2017-08-21 14:18:37,268 INFO [FileLogWriter.FsyncThread-1503343117256] [] redolog - fsync thread exiting
2017-08-21 14:18:37,268 INFO [main] [] redolog - FileLogWriter.FsyncThread-1503343117256 finished
2017-08-21 14:18:37,270 INFO [main] [] redolog - Finished pre-startup crash recovery
2017-08-21 14:18:37,272 INFO [FileLogWriter.FsyncThread-1503343117271] [] redolog - Starting fsync thread with interval 10
2017-08-21 14:18:37,284 INFO [main] [] misc - MINA setUseDirectBuffers(false)
2017-08-21 14:18:37,300 INFO [main] [] lmtp - Adding LMTP callback: com.zimbra.cs.mailbox.Notification
2017-08-21 14:18:37,301 INFO [main] [] lmtp - Adding LMTP callback: com.zimbra.cs.mailbox.QuotaWarning
2017-08-21 14:18:37,524 WARN [main] [] net - unknown host ignore cannot be added to throttle mta.ribasmith.netlist. LMTP requests from this host may be throttled. If this host is a proxy please add it to your DNS.
2017-08-21 14:18:37,526 INFO [LmtpServer] [] TcpServer/7025 - Starting accept loop: 1 core threads, 20 max threads.
2017-08-21 14:18:37,616 WARN [main] [] net - unknown host ignore cannot be added to throttle mta.ribasmith.netlist. POP3 requests from this host may be throttled. If this host is a proxy please add it to your DNS.
2017-08-21 14:18:37,631 INFO [main] [] pop - Starting Pop3Server on /0.0.0.0:7110
2017-08-21 14:18:37,634 WARN [main] [] net - unknown host ignore cannot be added to throttle mta.ribasmith.netlist. POP3 requests from this host may be throttled. If this host is a proxy please add it to your DNS.
2017-08-21 14:18:37,645 INFO [main] [] pop - Starting Pop3SSLServer on /0.0.0.0:7995
2017-08-21 14:18:37,650 WARN [main] [] net - unknown host ignore cannot be added to throttle mta.ribasmith.netlist. IMAP4rev1 requests from this host may be throttled. If this host is a proxy please add it to your DNS.
2017-08-21 14:18:37,651 INFO [ImapServer] [] TcpServer/7143 - Starting accept loop: 1 core threads, 200 max threads.
2017-08-21 14:18:37,652 WARN [main] [] net - unknown host ignore cannot be added to throttle mta.ribasmith.netlist. IMAP4rev1 requests from this host may be throttled. If this host is a proxy please add it to your DNS.
2017-08-21 14:18:37,653 INFO [ImapSSLServer] [] TcpServer/7993 - Starting accept loop: 1 core threads, 200 max threads.
2017-08-21 14:18:37,703 INFO [main] [] scheduler - Loaded 42 scheduled data source tasks
2017-08-21 14:18:37,711 INFO [main] [] purge - Starting purge thread with sleep interval 1m.
2017-08-21 14:18:37,712 INFO [MailboxPurge] [] purge - Purge thread sleeping for 1800000ms before doing work.
2017-08-21 14:18:37,729 INFO [main] [] extensions - Post-Initializing extensions
2017-08-21 14:18:37,735 INFO [main] [] soap - Adding service InternalDocumentService to SoapServlet
2017-08-21 14:18:37,739 INFO [main] [] extensions - registered handler at /ZimbraDrive_NcUserZimbraBackend
2017-08-21 14:18:37,739 INFO [main] [] extensions - registered handler at /ZimbraDrive_ConnectivityTest
2017-08-21 14:18:37,739 INFO [main] [] extensions - registered handler at /ZimbraDrive_Download
2017-08-21 14:18:37,739 INFO [main] [] extensions - registered handler at /ZimbraDrive_Upload
2017-08-21 14:18:37,739 INFO [main] [] extensions - registered handler at /ZimbraDrive_CreateTempFiles
2017-08-21 14:18:37,740 INFO [main] [] extensions - registered handler at /ZimbraDrive_CloudAppTests
2017-08-21 14:18:37,740 INFO [main] [] extensions - Loaded Zimbra Drive extension.
2017-08-21 14:18:37,740 INFO [main] [] mailbox - OpenChat starting ...
2017-08-21 14:18:38,552 INFO [main] [] soap - Adding service InternalDocumentService to SoapServlet
2017-08-21 14:18:38,611 INFO [ Activity Thread] [] extensions - Listening on port 5269
2017-08-21 14:18:38,714 INFO [Thread-34] [] extensions - XMPP listening on ports 5222
2017-08-21 14:18:38,736 INFO [Thread-34] [] extensions - XMPP started
2017-08-21 14:18:38,738 INFO [main] [] extensions - OpenChat started 8.7.10(commit 422fac09da91829f883178d843371c5c8e654a1e).
2017-08-21 14:18:38,755 INFO [main] [] soap - Servlet AdminServlet starting up
2017-08-21 14:18:38,863 INFO [main] [] soap - Adding service AdminService to AdminServlet
2017-08-21 14:18:38,910 INFO [main] [] soap - Adding service AccountService to AdminServlet
2017-08-21 14:18:38,910 INFO [main] [] soap - Adding service MailService to AdminServlet
2017-08-21 14:18:38,910 INFO [main] [] soap - Adding service ZimbraBulkProvisionService to AdminServlet
2017-08-21 14:18:38,917 INFO [main] [] soap - Adding service ZimbraCertMgrService to AdminServlet
2017-08-21 14:18:38,920 INFO [main] [] soap - Adding service ZimbraLDAPUtilsService to AdminServlet
2017-08-21 14:18:38,921 INFO [main] [] soap - Adding service VersionCheckService to AdminServlet
2017-08-21 14:18:38,925 INFO [main] [] account - Servlet CertAuthServlet starting up
2017-08-21 14:18:38,927 INFO [main] [] ContentServlet - Servlet ContentServlet starting up
2017-08-21 14:18:38,930 INFO [main] [] account - Servlet ExternalUserProvServlet starting up
2017-08-21 14:18:38,932 INFO [main] [] account - Servlet PreAuthServlet starting up
2017-08-21 14:18:38,933 INFO [main] [] PublicICalServlet - Servlet PublicICalServlet starting up
2017-08-21 14:18:38,934 INFO [main] [] account - Servlet SpnegoAuthServlet starting up
2017-08-21 14:18:38,944 INFO [main] [] UserServlet - Starting up
2017-08-21 14:18:38,950 INFO [main] [] FileUploadServlet - Servlet FileUploadServlet starting up
2017-08-21 14:18:38,983 INFO [main] [] StatsImageServlet - Servlet StatsImageServlet starting up
2017-08-21 14:18:39,017 INFO [main] [] AutoDiscoverServlet - Starting up
2017-08-21 14:18:40,708 INFO [main] [] misc - DoSFilter: Configured whitelist IPs = 192.168.77.96,192.168.5.0/24,127.0.0.1,::1,0:0:0:0:0:0:0:1
2017-08-21 14:18:40,710 INFO [main] [] misc - Initialized with /service:max=80%, /zimbra:max=15%, /zimbraAdmin:max=5%
2017-08-21 14:18:40,711 INFO [main] [] misc - Thread pool was configured to max=250
2017-08-21 14:18:43,439 INFO [main] [] misc - DoSFilter: Configured whitelist IPs = 192.168.77.96,192.168.5.0/24,127.0.0.1,::1,0:0:0:0:0:0:0:1
2017-08-21 14:18:43,443 INFO [main] [] misc - Initialized with /service:max=80%, /zimbra:max=15%, /zimbraAdmin:max=5%
2017-08-21 14:18:43,443 INFO [main] [] misc - Thread pool was configured to max=250
2017-08-21 14:19:00,290 INFO [ScheduledTask-1] [mid=19;] index - Using Index Store LuceneIndex
2017-08-21 14:19:00,312 INFO [ScheduledTask-1] [mid=19;] index - OpenLuceneIndex impl=NIOFSDirectory,dir=/opt/zimbra/index/0/19/index/0
2017-08-21 14:19:00,312 INFO [ScheduledTask-1] [mid=19;] mbxmgr - Mailbox 19 account 80607466-50ce-4686-8281-a37fff7539db LOADED
2017-08-21 14:19:00,333 INFO [ScheduledTask-1] [name=galsync@rimith.com;mid=19;ds=zimbra;] datasource - Requested import.
2017-08-21 14:19:00,357 INFO [ScheduledTask-1] [name=galsync@rimith.com;mid=19;ds=zimbra;] datasource - Importing data for data source 'zimbra'
2017-08-21 14:19:00,440 WARN [ScheduledTask-1] [name=galsync@rimith.com;mid=19;ds=zimbra;] ldap - unknown GAL op
2017-08-21 14:19:02,558 INFO [ScheduledTask-1] [name=galsync@rimith.com;mid=19;ds=zimbra;] cache - initializing folder and tag caches for mailbox 19
2017-08-21 14:19:07,929 WARN [ScheduledTask-1] [name=galsync@rimith.com;mid=19;ds=zimbra;] datasource - Unable to set error status for data source zimbra.
2017-08-21 14:19:11,982 INFO [ScheduledTask-1] [name=galsync@rimith.com;mid=19;ds=zimbra;] datasource - Import completed for data source 'zimbra'
2017-08-21 14:19:11,987 WARN [ScheduledTask-1] [name=galsync@rimith.com;mid=19;ds=zimbra;] datasource - Scheduled DataSource import failed.
com.zimbra.common.service.ServiceException: system failure: unable to refresh entry
ExceptionId:ScheduledTask-1:1503343147927:e3c15726f857d685
Code:service.FAILURE
at com.zimbra.common.service.ServiceException.FAILURE(ServiceException.java:286)
at com.zimbra.cs.account.ldap.LdapProvisioning.refreshEntry(LdapProvisioning.java:761)
at com.zimbra.cs.account.ldap.LdapProvisioning.modifyLdapAttrs(LdapProvisioning.java:651)
at com.zimbra.cs.account.ldap.LdapProvisioning.modifyAttrsInternal(LdapProvisioning.java:555)
at com.zimbra.cs.account.ldap.LdapProvisioning.modifyAttrsInternal(LdapProvisioning.java:509)
at com.zimbra.cs.account.ldap.LdapProvisioning.modifyAttrs(LdapProvisioning.java:475)
at com.zimbra.cs.account.ldap.LdapProvisioning.modifyAttrs(LdapProvisioning.java:455)
at com.zimbra.cs.account.ldap.LdapProvisioning.modifyDataSource(LdapProvisioning.java:8298)
at com.zimbra.cs.gal.GalImport.setStatus(GalImport.java:80)
at com.zimbra.cs.gal.GalImport.importGal(GalImport.java:112)
at com.zimbra.cs.gal.GalImport.importData(GalImport.java:57)
at com.zimbra.cs.datasource.DataSourceManager.importData(DataSourceManager.java:379)
at com.zimbra.cs.datasource.DataSourceManager.importData(DataSourceManager.java:335)
at com.zimbra.cs.datasource.DataSourceTask.call(DataSourceTask.java:83)
at com.zimbra.cs.datasource.DataSourceTask.call(DataSourceTask.java:31)
at com.zimbra.common.util.TaskScheduler$TaskRunner.call(TaskScheduler.java:79)
at java.util.concurrent.FutureTask.run(FutureTask.java:266)
at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.access$201(ScheduledThreadPoolExecutor.java:180)
at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:293)
at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149)
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
at java.lang.Thread.run(Thread.java:748)
Caused by: com.zimbra.cs.ldap.LdapException: LDAP error: - unable to get attributes: ldap host=mail.ribasmith.net:389: An error occurred while attempting to connect to server mail.ribasmith.net:389: java.io.IOException: An error occurred while attempting to establish a connection to server mail.ribasmith.net:389: java.net.ConnectException: Connection refused (Connection refused)
ExceptionId:ScheduledTask-1:1503343147927:e3c15726f857d685
Code:ldap.LDAP_ERROR
at com.zimbra.cs.ldap.LdapException.LDAP_ERROR(LdapException.java:90)
at com.zimbra.cs.ldap.unboundid.UBIDLdapException.mapToLdapException(UBIDLdapException.java:74)
at com.zimbra.cs.ldap.unboundid.UBIDLdapContext.mapToLdapException(UBIDLdapContext.java:239)
at com.zimbra.cs.ldap.unboundid.UBIDLdapContext.getAttributes(UBIDLdapContext.java:374)
at com.zimbra.cs.account.ldap.ZLdapHelper.getAttributes(ZLdapHelper.java:278)
at com.zimbra.cs.account.ldap.LdapHelper.getAttributes(LdapHelper.java:196)
at com.zimbra.cs.account.ldap.LdapProvisioning.refreshEntry(LdapProvisioning.java:705)
... 20 more
Caused by: LDAPException(resultCode=91 (connect error), errorMessage='An error occurred while attempting to connect to server mail.ribasmith.net:389: java.io.IOException: An error occurred while attempting to establish a connection to server mail.ribasmith.net:389: java.net.ConnectException: Connection refused (Connection refused)')
at com.unboundid.ldap.sdk.LDAPConnection.connect(LDAPConnection.java:754)
at com.unboundid.ldap.sdk.LDAPConnection.connect(LDAPConnection.java:686)
at com.unboundid.ldap.sdk.LDAPConnection.<init>(LDAPConnection.java:518)
at com.unboundid.ldap.sdk.SingleServerSet.getConnection(SingleServerSet.java:229)
at com.unboundid.ldap.sdk.ServerSet.getConnection(ServerSet.java:98)
at com.unboundid.ldap.sdk.LDAPConnectionPool.createConnection(LDAPConnectionPool.java:938)
at com.unboundid.ldap.sdk.LDAPConnectionPool.getConnection(LDAPConnectionPool.java:1399)
at com.unboundid.ldap.sdk.AbstractConnectionPool.getEntry(AbstractConnectionPool.java:604)
at com.unboundid.ldap.sdk.AbstractConnectionPool.getEntry(AbstractConnectionPool.java:578)
at com.zimbra.cs.ldap.unboundid.UBIDLdapOperation$GetEntry.execute(UBIDLdapOperation.java:403)
at com.zimbra.cs.ldap.unboundid.UBIDLdapContext.getAttributes(UBIDLdapContext.java:367)
... 23 more
Caused by: java.io.IOException: An error occurred while attempting to establish a connection to server mail.ribasmith.net:389: java.net.ConnectException: Connection refused (Connection refused)
at com.unboundid.ldap.sdk.LDAPConnectionInternals.<init>(LDAPConnectionInternals.java:137)
at com.unboundid.ldap.sdk.LDAPConnection.connect(LDAPConnection.java:744)
... 33 more
2017-08-21 14:19:37,765 INFO [mailboxd.csv] [] cache - setting message cache size to 2000
2017-08-21 14:20:04,768 INFO [qtp127618319-174:https:https://localhost:7071/service/admin/soap/AuthRequest] [] AuthProvider - Adding auth provider: zimbra com.zimbra.cs.service.ZimbraAuthProvider
2017-08-21 14:20:04,770 INFO [qtp127618319-174:https:https://localhost:7071/service/admin/soap/AuthRequest] [] AuthProvider - Adding auth provider: sampleoauth com.zimbra.cs.service.ZimbraAuthProviderForOAuth
2017-08-21 14:20:04,984 INFO [qtp127618319-174:https:https://localhost:7071/service/admin/soap/AuthRequest] [name=zimbra;ua=zmprov/8.7.11_GA_1854;] extensions - Using two-factor auth factory TwoFactorAuth
2017-08-21 14:20:05,006 WARN [qtp127618319-174:https:https://localhost:7071/service/admin/soap/AuthRequest] [name=zimbra;ua=zmprov/8.7.11_GA_1854;] account - error updating zimbraLastLogonTimestamp
com.zimbra.common.service.ServiceException: system failure: unable to refresh entry
ExceptionId:qtp127618319-174:https:https://localhost:7071/service/admin/soap/AuthRequest:1503343205006:e3c15726f857d685
Code:service.FAILURE
at com.zimbra.common.service.ServiceException.FAILURE(ServiceException.java:286)
at com.zimbra.cs.account.ldap.LdapProvisioning.refreshEntry(LdapProvisioning.java:761)
at com.zimbra.cs.account.ldap.LdapProvisioning.modifyLdapAttrs(LdapProvisioning.java:651)
at com.zimbra.cs.account.ldap.LdapProvisioning.modifyAttrsInternal(LdapProvisioning.java:555)
at com.zimbra.cs.account.ldap.LdapProvisioning.modifyEphemeralAttrsInLdap(LdapProvisioning.java:448)
at com.zimbra.cs.ephemeral.LdapEphemeralStore$ZimbraLdapHelper.executeChange(LdapEphemeralStore.java:181)
at com.zimbra.cs.ephemeral.LdapEphemeralStore.set(LdapEphemeralStore.java:47)
at com.zimbra.cs.account.Entry.modifyEphemeralAttrInternal(Entry.java:919)
at com.zimbra.cs.account.Entry.modifyEphemeralAttr(Entry.java:937)
at com.zimbra.cs.account.ZAttrAccount.setLastLogonTimestamp(ZAttrAccount.java:23320)
at com.zimbra.cs.account.ldap.LdapProvisioning.updateLastLogon(LdapProvisioning.java:5438)
at com.zimbra.cs.account.ldap.LdapProvisioning.authAccount(LdapProvisioning.java:5373)
at com.zimbra.cs.account.ldap.LdapProvisioning.authAccount(LdapProvisioning.java:5327)
at com.zimbra.cs.service.admin.Auth.handle(Auth.java:173)
at com.zimbra.soap.SoapEngine.dispatchRequest(SoapEngine.java:607)
at com.zimbra.soap.SoapEngine.dispatch(SoapEngine.java:460)
at com.zimbra.soap.SoapEngine.dispatch(SoapEngine.java:273)
at com.zimbra.soap.SoapServlet.doWork(SoapServlet.java:303)
at com.zimbra.soap.SoapServlet.doPost(SoapServlet.java:213)
at javax.servlet.http.HttpServlet.service(HttpServlet.java:707)
at com.zimbra.cs.servlet.ZimbraServlet.service(ZimbraServlet.java:206)
at javax.servlet.http.HttpServlet.service(HttpServlet.java:790)
at org.eclipse.jetty.servlet.ServletHolder.handle(ServletHolder.java:821)
at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1685)
at com.zimbra.cs.servlet.CsrfFilter.doFilter(CsrfFilter.java:169)
at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1668)
at com.zimbra.cs.servlet.RequestStringFilter.doFilter(RequestStringFilter.java:54)
at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1668)
at com.zimbra.cs.servlet.SetHeaderFilter.doFilter(SetHeaderFilter.java:59)
at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1668)
at com.zimbra.cs.servlet.ETagHeaderFilter.doFilter(ETagHeaderFilter.java:47)
at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1668)
at com.zimbra.cs.servlet.ContextPathBasedThreadPoolBalancerFilter.doFilter(ContextPathBasedThreadPoolBalancerFilter.java:107)
at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1668)
at com.zimbra.cs.servlet.ZimbraQoSFilter.doFilter(ZimbraQoSFilter.java:107)
at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1668)
at com.zimbra.cs.servlet.ZimbraInvalidLoginFilter.doFilter(ZimbraInvalidLoginFilter.java:117)
at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1668)
at org.eclipse.jetty.servlets.DoSFilter.doFilterChain(DoSFilter.java:473)
at org.eclipse.jetty.servlets.DoSFilter.doFilter(DoSFilter.java:318)
at org.eclipse.jetty.servlets.DoSFilter.doFilter(DoSFilter.java:288)
at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1668)
at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:581)
at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:143)
at org.eclipse.jetty.security.SecurityHandler.handle(SecurityHandler.java:524)
at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:226)
at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1158)
at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:511)
at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:185)
at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1090)
at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:141)
at org.eclipse.jetty.server.handler.ContextHandlerCollection.handle(ContextHandlerCollection.java:213)
at org.eclipse.jetty.server.handler.HandlerCollection.handle(HandlerCollection.java:109)
at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:119)
at org.eclipse.jetty.rewrite.handler.RewriteHandler.handle(RewriteHandler.java:318)
at org.eclipse.jetty.server.handler.gzip.GzipHandler.handle(GzipHandler.java:437)
at org.eclipse.jetty.server.handler.DebugHandler.handle(DebugHandler.java:84)
at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:119)
at org.eclipse.jetty.server.Server.handle(Server.java:517)
at org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:306)
at org.eclipse.jetty.server.HttpConnection.onFillable(HttpConnection.java:242)
at org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:261)
at org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:95)
at org.eclipse.jetty.io.ssl.SslConnection.onFillable(SslConnection.java:192)
at org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:261)
at org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:95)
at org.eclipse.jetty.io.SelectChannelEndPoint$2.run(SelectChannelEndPoint.java:75)
at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.produceAndRun(ExecuteProduceConsume.java:213)
at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.run(ExecuteProduceConsume.java:147)
at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:654)
at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:572)
at java.lang.Thread.run(Thread.java:748)
Caused by: com.zimbra.cs.ldap.LdapException: LDAP error: - unable to get attributes: ldap host=mail.ribasmith.net:389: An error occurred while attempting to connect to server mail.ribasmith.net:389: java.io.IOException: An error occurred while attempting to establish a connection to server mail.ribasmith.net:389: java.net.ConnectException: Connection refused (Connection refused)
ExceptionId:qtp127618319-174:https:https://localhost:7071/service/admin/soap/AuthRequest:1503343205006:e3c15726f857d685
Code:ldap.LDAP_ERROR
at com.zimbra.cs.ldap.LdapException.LDAP_ERROR(LdapException.java:90)
at com.zimbra.cs.ldap.unboundid.UBIDLdapException.mapToLdapException(UBIDLdapException.java:74)
at com.zimbra.cs.ldap.unboundid.UBIDLdapContext.mapToLdapException(UBIDLdapContext.java:239)
at com.zimbra.cs.ldap.unboundid.UBIDLdapContext.getAttributes(UBIDLdapContext.java:374)
at com.zimbra.cs.account.ldap.ZLdapHelper.getAttributes(ZLdapHelper.java:278)
at com.zimbra.cs.account.ldap.LdapHelper.getAttributes(LdapHelper.java:196)
at com.zimbra.cs.account.ldap.LdapProvisioning.refreshEntry(LdapProvisioning.java:705)
... 70 more
Caused by: LDAPException(resultCode=91 (connect error), errorMessage='An error occurred while attempting to connect to server mail.ribasmith.net:389: java.io.IOException: An error occurred while attempting to establish a connection to server mail.ribasmith.net:389: java.net.ConnectException: Connection refused (Connection refused)')
at com.unboundid.ldap.sdk.LDAPConnection.connect(LDAPConnection.java:754)
at com.unboundid.ldap.sdk.LDAPConnection.connect(LDAPConnection.java:686)
at com.unboundid.ldap.sdk.LDAPConnection.<init>(LDAPConnection.java:518)
at com.unboundid.ldap.sdk.SingleServerSet.getConnection(SingleServerSet.java:229)
at com.unboundid.ldap.sdk.ServerSet.getConnection(ServerSet.java:98)
at com.unboundid.ldap.sdk.LDAPConnectionPool.createConnection(LDAPConnectionPool.java:938)
at com.unboundid.ldap.sdk.LDAPConnectionPool.getConnection(LDAPConnectionPool.java:1399)
at com.unboundid.ldap.sdk.AbstractConnectionPool.getEntry(AbstractConnectionPool.java:604)
at com.unboundid.ldap.sdk.AbstractConnectionPool.getEntry(AbstractConnectionPool.java:578)
at com.zimbra.cs.ldap.unboundid.UBIDLdapOperation$GetEntry.execute(UBIDLdapOperation.java:403)
at com.zimbra.cs.ldap.unboundid.UBIDLdapContext.getAttributes(UBIDLdapContext.java:367)
... 73 more
Caused by: java.io.IOException: An error occurred while attempting to establish a connection to server mail.ribasmith.net:389: java.net.ConnectException: Connection refused (Connection refused)
at com.unboundid.ldap.sdk.LDAPConnectionInternals.<init>(LDAPConnectionInternals.java:137)
at com.unboundid.ldap.sdk.LDAPConnection.connect(LDAPConnection.java:744)
... 83 more
2017-08-21 14:20:05,018 ERROR [qtp127618319-174:https:https://localhost:7071/service/admin/soap/AuthRequest] [name=zimbra;ua=zmprov/8.7.11_GA_1854;] AuthToken - unable to de-register auth token
com.zimbra.common.service.ServiceException: system failure: unable to modify attrs: LDAP error: - unable to get connection: ldap host=: An error occurred while attempting to connect to server mail.ribasmith.net:389: java.io.IOException: An error occurred while attempting to establish a connection to server mail.ribasmith.net:389: java.net.ConnectException: Connection refused (Connection refused)
ExceptionId:qtp127618319-174:https:https://localhost:7071/service/admin/soap/AuthRequest:1503343205018:e3c15726f857d685
Code:service.FAILURE
at com.zimbra.common.service.ServiceException.FAILURE(ServiceException.java:286)
at com.zimbra.cs.account.ldap.LdapProvisioning.modifyLdapAttrs(LdapProvisioning.java:648)
at com.zimbra.cs.account.ldap.LdapProvisioning.modifyAttrsInternal(LdapProvisioning.java:555)
at com.zimbra.cs.account.ldap.LdapProvisioning.modifyEphemeralAttrsInLdap(LdapProvisioning.java:448)
at com.zimbra.cs.ephemeral.LdapEphemeralStore$ZimbraLdapHelper.executeChange(LdapEphemeralStore.java:181)
at com.zimbra.cs.ephemeral.LdapEphemeralStore.deleteInternal(LdapEphemeralStore.java:96)
at com.zimbra.cs.ephemeral.LdapEphemeralStore.purgeExpired(LdapEphemeralStore.java:80)
at com.zimbra.cs.account.Entry.purgeEphemeralAttr(Entry.java:955)
at com.zimbra.cs.account.ZAttrAccount.purgeAuthTokens(ZAttrAccount.java:4862)
at com.zimbra.cs.account.Account.cleanExpiredTokens(Account.java:516)
at com.zimbra.cs.account.ZimbraAuthToken.register(ZimbraAuthToken.java:412)
at com.zimbra.cs.account.ZimbraAuthToken.<init>(ZimbraAuthToken.java:309)
at com.zimbra.cs.account.ZimbraAuthToken.<init>(ZimbraAuthToken.java:248)
at com.zimbra.cs.account.ZimbraAuthToken.<init>(ZimbraAuthToken.java:239)
at com.zimbra.cs.service.ZimbraAuthProvider.authToken(ZimbraAuthProvider.java:116)
at com.zimbra.cs.service.AuthProvider.getAuthToken(AuthProvider.java:531)
at com.zimbra.cs.service.admin.Auth.handle(Auth.java:183)
at com.zimbra.soap.SoapEngine.dispatchRequest(SoapEngine.java:607)
at com.zimbra.soap.SoapEngine.dispatch(SoapEngine.java:460)
at com.zimbra.soap.SoapEngine.dispatch(SoapEngine.java:273)
at com.zimbra.soap.SoapServlet.doWork(SoapServlet.java:303)
at com.zimbra.soap.SoapServlet.doPost(SoapServlet.java:213)
at javax.servlet.http.HttpServlet.service(HttpServlet.java:707)
at com.zimbra.cs.servlet.ZimbraServlet.service(ZimbraServlet.java:206)
at javax.servlet.http.HttpServlet.service(HttpServlet.java:790)
at org.eclipse.jetty.servlet.ServletHolder.handle(ServletHolder.java:821)
at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1685)
at com.zimbra.cs.servlet.CsrfFilter.doFilter(CsrfFilter.java:169)
at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1668)
at com.zimbra.cs.servlet.RequestStringFilter.doFilter(RequestStringFilter.java:54)
at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1668)
at com.zimbra.cs.servlet.SetHeaderFilter.doFilter(SetHeaderFilter.java:59)
at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1668)
at com.zimbra.cs.servlet.ETagHeaderFilter.doFilter(ETagHeaderFilter.java:47)
at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1668)
at com.zimbra.cs.servlet.ContextPathBasedThreadPoolBalancerFilter.doFilter(ContextPathBasedThreadPoolBalancerFilter.java:107)
at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1668)
at com.zimbra.cs.servlet.ZimbraQoSFilter.doFilter(ZimbraQoSFilter.java:107)
at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1668)
at com.zimbra.cs.servlet.ZimbraInvalidLoginFilter.doFilter(ZimbraInvalidLoginFilter.java:117)
at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1668)
at org.eclipse.jetty.servlets.DoSFilter.doFilterChain(DoSFilter.java:473)
at org.eclipse.jetty.servlets.DoSFilter.doFilter(DoSFilter.java:318)
at org.eclipse.jetty.servlets.DoSFilter.doFilter(DoSFilter.java:288)
at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1668)
at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:581)
at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:143)
at org.eclipse.jetty.security.SecurityHandler.handle(SecurityHandler.java:524)
at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:226)
at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1158)
at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:511)
at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:185)
at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1090)
at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:141)
at org.eclipse.jetty.server.handler.ContextHandlerCollection.handle(ContextHandlerCollection.java:213)
at org.eclipse.jetty.server.handler.HandlerCollection.handle(HandlerCollection.java:109)
at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:119)
at org.eclipse.jetty.rewrite.handler.RewriteHandler.handle(RewriteHandler.java:318)
at org.eclipse.jetty.server.handler.gzip.GzipHandler.handle(GzipHandler.java:437)
at org.eclipse.jetty.server.handler.DebugHandler.handle(DebugHandler.java:84)
at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:119)
at org.eclipse.jetty.server.Server.handle(Server.java:517)
at org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:306)
at org.eclipse.jetty.server.HttpConnection.onFillable(HttpConnection.java:242)
at org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:261)
at org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:95)
at org.eclipse.jetty.io.ssl.SslConnection.onFillable(SslConnection.java:192)
at org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:261)
at org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:95)
at org.eclipse.jetty.io.SelectChannelEndPoint$2.run(SelectChannelEndPoint.java:75)
at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.produceAndRun(ExecuteProduceConsume.java:213)
at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.run(ExecuteProduceConsume.java:147)
at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:654)
at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:572)
at java.lang.Thread.run(Thread.java:748)
Caused by: com.zimbra.cs.ldap.LdapException: LDAP error: - unable to get connection: ldap host=: An error occurred while attempting to connect to server mail.ribasmith.net:389: java.io.IOException: An error occurred while attempting to establish a connection to server mail.ribasmith.net:389: java.net.ConnectException: Connection refused (Connection refused)
ExceptionId:qtp127618319-174:https:https://localhost:7071/service/admin/soap/AuthRequest:1503343205018:e3c15726f857d685
Code:ldap.LDAP_ERROR
at com.zimbra.cs.ldap.LdapException.LDAP_ERROR(LdapException.java:90)
at com.zimbra.cs.ldap.unboundid.UBIDLdapException.mapToLdapException(UBIDLdapException.java:74)
at com.zimbra.cs.ldap.unboundid.UBIDLdapContext.mapToLdapException(UBIDLdapContext.java:239)
at com.zimbra.cs.ldap.unboundid.UBIDLdapContext.getConnection(UBIDLdapContext.java:209)
at com.zimbra.cs.ldap.unboundid.UBIDLdapContext.<init>(UBIDLdapContext.java:169)
at com.zimbra.cs.ldap.unboundid.UBIDLdapClient.getContextImpl(UBIDLdapClient.java:90)
at com.zimbra.cs.ldap.LdapClient.getContext(LdapClient.java:135)
at com.zimbra.cs.account.ldap.LdapProvisioning.modifyLdapAttrs(LdapProvisioning.java:637)
... 73 more
Caused by: LDAPException(resultCode=91 (connect error), errorMessage='An error occurred while attempting to connect to server mail.ribasmith.net:389: java.io.IOException: An error occurred while attempting to establish a connection to server mail.ribasmith.net:389: java.net.ConnectException: Connection refused (Connection refused)')
at com.unboundid.ldap.sdk.LDAPConnection.connect(LDAPConnection.java:754)
at com.unboundid.ldap.sdk.LDAPConnection.connect(LDAPConnection.java:686)
at com.unboundid.ldap.sdk.LDAPConnection.<init>(LDAPConnection.java:518)
at com.unboundid.ldap.sdk.SingleServerSet.getConnection(SingleServerSet.java:229)
at com.unboundid.ldap.sdk.ServerSet.getConnection(ServerSet.java:98)
at com.unboundid.ldap.sdk.LDAPConnectionPool.createConnection(LDAPConnectionPool.java:938)
at com.unboundid.ldap.sdk.LDAPConnectionPool.getConnection(LDAPConnectionPool.java:1399)
at com.zimbra.cs.ldap.unboundid.UBIDLdapOperation$GetConnection.execute(UBIDLdapOperation.java:189)
at com.zimbra.cs.ldap.unboundid.UBIDLdapContext.getConnection(UBIDLdapContext.java:200)
... 77 more
Caused by: java.io.IOException: An error occurred while attempting to establish a connection to server mail.ribasmith.net:389: java.net.ConnectException: Connection refused (Connection refused)
at com.unboundid.ldap.sdk.LDAPConnectionInternals.<init>(LDAPConnectionInternals.java:137)
at com.unboundid.ldap.sdk.LDAPConnection.connect(LDAPConnection.java:744)
... 85 more
2017-08-21 14:20:05,025 ERROR [qtp127618319-174:https:https://localhost:7071/service/admin/soap/AuthRequest] [name=zimbra;ua=zmprov/8.7.11_GA_1854;] AuthToken - unable to register auth token
com.zimbra.common.service.ServiceException: system failure: unable to modify attrs: LDAP error: - unable to get connection: ldap host=: An error occurred while attempting to connect to server mail.ribasmith.net:389: java.io.IOException: An error occurred while attempting to establish a connection to server mail.ribasmith.net:389: java.net.ConnectException: Connection refused (Connection refused)
ExceptionId:qtp127618319-174:https:https://localhost:7071/service/admin/soap/AuthRequest:1503343205025:e3c15726f857d685
Code:service.FAILURE
at com.zimbra.common.service.ServiceException.FAILURE(ServiceException.java:286)
at com.zimbra.cs.account.ldap.LdapProvisioning.modifyLdapAttrs(LdapProvisioning.java:648)
at com.zimbra.cs.account.ldap.LdapProvisioning.modifyAttrsInternal(LdapProvisioning.java:555)
at com.zimbra.cs.account.ldap.LdapProvisioning.modifyEphemeralAttrsInLdap(LdapProvisioning.java:448)
at com.zimbra.cs.ephemeral.LdapEphemeralStore$ZimbraLdapHelper.executeChange(LdapEphemeralStore.java:181)
at com.zimbra.cs.ephemeral.LdapEphemeralStore.update(LdapEphemeralStore.java:57)
at com.zimbra.cs.account.Entry.modifyEphemeralAttrInternal(Entry.java:917)
at com.zimbra.cs.account.Entry.modifyEphemeralAttr(Entry.java:937)
at com.zimbra.cs.account.ZAttrAccount.addAuthTokens(ZAttrAccount.java:4819)
at com.zimbra.cs.account.ZimbraAuthToken.register(ZimbraAuthToken.java:417)
at com.zimbra.cs.account.ZimbraAuthToken.<init>(ZimbraAuthToken.java:309)
at com.zimbra.cs.account.ZimbraAuthToken.<init>(ZimbraAuthToken.java:248)
at com.zimbra.cs.account.ZimbraAuthToken.<init>(ZimbraAuthToken.java:239)
at com.zimbra.cs.service.ZimbraAuthProvider.authToken(ZimbraAuthProvider.java:116)
at com.zimbra.cs.service.AuthProvider.getAuthToken(AuthProvider.java:531)
at com.zimbra.cs.service.admin.Auth.handle(Auth.java:183)
at com.zimbra.soap.SoapEngine.dispatchRequest(SoapEngine.java:607)
at com.zimbra.soap.SoapEngine.dispatch(SoapEngine.java:460)
at com.zimbra.soap.SoapEngine.dispatch(SoapEngine.java:273)
at com.zimbra.soap.SoapServlet.doWork(SoapServlet.java:303)
at com.zimbra.soap.SoapServlet.doPost(SoapServlet.java:213)
at javax.servlet.http.HttpServlet.service(HttpServlet.java:707)
at com.zimbra.cs.servlet.ZimbraServlet.service(ZimbraServlet.java:206)
at javax.servlet.http.HttpServlet.service(HttpServlet.java:790)
at org.eclipse.jetty.servlet.ServletHolder.handle(ServletHolder.java:821)
at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1685)
at com.zimbra.cs.servlet.CsrfFilter.doFilter(CsrfFilter.java:169)
at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1668)
at com.zimbra.cs.servlet.RequestStringFilter.doFilter(RequestStringFilter.java:54)
at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1668)
at com.zimbra.cs.servlet.SetHeaderFilter.doFilter(SetHeaderFilter.java:59)
at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1668)
at com.zimbra.cs.servlet.ETagHeaderFilter.doFilter(ETagHeaderFilter.java:47)
at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1668)
at com.zimbra.cs.servlet.ContextPathBasedThreadPoolBalancerFilter.doFilter(ContextPathBasedThreadPoolBalancerFilter.java:107)
at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1668)
at com.zimbra.cs.servlet.ZimbraQoSFilter.doFilter(ZimbraQoSFilter.java:107)
at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1668)
at com.zimbra.cs.servlet.ZimbraInvalidLoginFilter.doFilter(ZimbraInvalidLoginFilter.java:117)
at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1668)
at org.eclipse.jetty.servlets.DoSFilter.doFilterChain(DoSFilter.java:473)
at org.eclipse.jetty.servlets.DoSFilter.doFilter(DoSFilter.java:318)
at org.eclipse.jetty.servlets.DoSFilter.doFilter(DoSFilter.java:288)
at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1668)
at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:581)
at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:143)
at org.eclipse.jetty.security.SecurityHandler.handle(SecurityHandler.java:524)
at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:226)
at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1158)
at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:511)
at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:185)
at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1090)
at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:141)
at org.eclipse.jetty.server.handler.ContextHandlerCollection.handle(ContextHandlerCollection.java:213)
at org.eclipse.jetty.server.handler.HandlerCollection.handle(HandlerCollection.java:109)
at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:119)
at org.eclipse.jetty.rewrite.handler.RewriteHandler.handle(RewriteHandler.java:318)
at org.eclipse.jetty.server.handler.gzip.GzipHandler.handle(GzipHandler.java:437)
at org.eclipse.jetty.server.handler.DebugHandler.handle(DebugHandler.java:84)
at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:119)
at org.eclipse.jetty.server.Server.handle(Server.java:517)
at org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:306)
at org.eclipse.jetty.server.HttpConnection.onFillable(HttpConnection.java:242)
at org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:261)
at org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:95)
at org.eclipse.jetty.io.ssl.SslConnection.onFillable(SslConnection.java:192)
at org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:261)
at org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:95)
at org.eclipse.jetty.io.SelectChannelEndPoint$2.run(SelectChannelEndPoint.java:75)
at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.produceAndRun(ExecuteProduceConsume.java:213)
at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.run(ExecuteProduceConsume.java:147)
at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:654)
at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:572)
at java.lang.Thread.run(Thread.java:748)
Caused by: com.zimbra.cs.ldap.LdapException: LDAP error: - unable to get connection: ldap host=: An error occurred while attempting to connect to server mail.ribasmith.net:389: java.io.IOException: An error occurred while attempting to establish a connection to server mail.ribasmith.net:389: java.net.ConnectException: Connection refused (Connection refused)
ExceptionId:qtp127618319-174:https:https://localhost:7071/service/admin/soap/AuthRequest:1503343205025:e3c15726f857d685
Code:ldap.LDAP_ERROR
at com.zimbra.cs.ldap.LdapException.LDAP_ERROR(LdapException.java:90)
at com.zimbra.cs.ldap.unboundid.UBIDLdapException.mapToLdapException(UBIDLdapException.java:74)
at com.zimbra.cs.ldap.unboundid.UBIDLdapContext.mapToLdapException(UBIDLdapContext.java:239)
at com.zimbra.cs.ldap.unboundid.UBIDLdapContext.getConnection(UBIDLdapContext.java:209)
at com.zimbra.cs.ldap.unboundid.UBIDLdapContext.<init>(UBIDLdapContext.java:169)
at com.zimbra.cs.ldap.unboundid.UBIDLdapClient.getContextImpl(UBIDLdapClient.java:90)
at com.zimbra.cs.ldap.LdapClient.getContext(LdapClient.java:135)
at com.zimbra.cs.account.ldap.LdapProvisioning.modifyLdapAttrs(LdapProvisioning.java:637)
... 72 more
Caused by: LDAPException(resultCode=91 (connect error), errorMessage='An error occurred while attempting to connect to server mail.ribasmith.net:389: java.io.IOException: An error occurred while attempting to establish a connection to server mail.ribasmith.net:389: java.net.ConnectException: Connection refused (Connection refused)')
at com.unboundid.ldap.sdk.LDAPConnection.connect(LDAPConnection.java:754)
at com.unboundid.ldap.sdk.LDAPConnection.connect(LDAPConnection.java:686)
at com.unboundid.ldap.sdk.LDAPConnection.<init>(LDAPConnection.java:518)
at com.unboundid.ldap.sdk.SingleServerSet.getConnection(SingleServerSet.java:229)
at com.unboundid.ldap.sdk.ServerSet.getConnection(ServerSet.java:98)
at com.unboundid.ldap.sdk.LDAPConnectionPool.createConnection(LDAPConnectionPool.java:938)
at com.unboundid.ldap.sdk.LDAPConnectionPool.getConnection(LDAPConnectionPool.java:1399)
at com.zimbra.cs.ldap.unboundid.UBIDLdapOperation$GetConnection.execute(UBIDLdapOperation.java:189)
at com.zimbra.cs.ldap.unboundid.UBIDLdapContext.getConnection(UBIDLdapContext.java:200)
... 76 more
Caused by: java.io.IOException: An error occurred while attempting to establish a connection to server mail.ribasmith.net:389: java.net.ConnectException: Connection refused (Connection refused)
at com.unboundid.ldap.sdk.LDAPConnectionInternals.<init>(LDAPConnectionInternals.java:137)
at com.unboundid.ldap.sdk.LDAPConnection.connect(LDAPConnection.java:744)
... 84 more
2017-08-21 14:20:05,036 INFO [qtp127618319-174:https:https://localhost:7071/service/admin/soap/AuthRequest] [name=zimbra;ua=zmprov/8.7.11_GA_1854;] soap - AuthRequest elapsed=222
2017-08-21 14:20:07,522 FATAL [qtp127618319-29:https:https://localhost:7071/service/admin/soap/GetAllServersRequest] [] AuthToken - Unable to verify auth token registration in ephemeral store
com.zimbra.cs.ldap.LdapException: LDAP error: - unable to get connection: ldap host=: An error occurred while attempting to connect to server mail.ribasmith.net:389: java.io.IOException: An error occurred while attempting to establish a connection to server mail.ribasmith.net:389: java.net.ConnectException: Connection refused (Connection refused)
ExceptionId:qtp127618319-29:https:https://localhost:7071/service/admin/soap/GetAllServersRequest:1503343207522:e3c15726f857d685
Code:ldap.LDAP_ERROR
at com.zimbra.cs.ldap.LdapException.LDAP_ERROR(LdapException.java:90)
at com.zimbra.cs.ldap.unboundid.UBIDLdapException.mapToLdapException(UBIDLdapException.java:74)
at com.zimbra.cs.ldap.unboundid.UBIDLdapContext.mapToLdapException(UBIDLdapContext.java:239)
at com.zimbra.cs.ldap.unboundid.UBIDLdapContext.getConnection(UBIDLdapContext.java:209)
at com.zimbra.cs.ldap.unboundid.UBIDLdapContext.<init>(UBIDLdapContext.java:169)
at com.zimbra.cs.ldap.unboundid.UBIDLdapClient.getContextImpl(UBIDLdapClient.java:90)
at com.zimbra.cs.ldap.LdapClient.getContext(LdapClient.java:135)
at com.zimbra.cs.account.ldap.LdapProvisioning.reload(LdapProvisioning.java:694)
at com.zimbra.cs.account.ldap.LdapProvisioning.reload(LdapProvisioning.java:686)
at com.zimbra.cs.account.ZimbraAuthToken.isRegistered(ZimbraAuthToken.java:539)
at com.zimbra.soap.ZimbraSoapContext.<init>(ZimbraSoapContext.java:281)
at com.zimbra.soap.SoapEngine.dispatch(SoapEngine.java:324)
at com.zimbra.soap.SoapEngine.dispatch(SoapEngine.java:273)
at com.zimbra.soap.SoapServlet.doWork(SoapServlet.java:303)
at com.zimbra.soap.SoapServlet.doPost(SoapServlet.java:213)
at javax.servlet.http.HttpServlet.service(HttpServlet.java:707)
at com.zimbra.cs.servlet.ZimbraServlet.service(ZimbraServlet.java:206)
at javax.servlet.http.HttpServlet.service(HttpServlet.java:790)
at org.eclipse.jetty.servlet.ServletHolder.handle(ServletHolder.java:821)
at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1685)
at com.zimbra.cs.servlet.CsrfFilter.doFilter(CsrfFilter.java:169)
at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1668)
at com.zimbra.cs.servlet.RequestStringFilter.doFilter(RequestStringFilter.java:54)
at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1668)
at com.zimbra.cs.servlet.SetHeaderFilter.doFilter(SetHeaderFilter.java:59)
at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1668)
at com.zimbra.cs.servlet.ETagHeaderFilter.doFilter(ETagHeaderFilter.java:47)
at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1668)
at com.zimbra.cs.servlet.ContextPathBasedThreadPoolBalancerFilter.doFilter(ContextPathBasedThreadPoolBalancerFilter.java:107)
at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1668)
at com.zimbra.cs.servlet.ZimbraQoSFilter.doFilter(ZimbraQoSFilter.java:107)
at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1668)
at com.zimbra.cs.servlet.ZimbraInvalidLoginFilter.doFilter(ZimbraInvalidLoginFilter.java:117)
at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1668)
at org.eclipse.jetty.servlets.DoSFilter.doFilterChain(DoSFilter.java:473)
at org.eclipse.jetty.servlets.DoSFilter.doFilter(DoSFilter.java:318)
at org.eclipse.jetty.servlets.DoSFilter.doFilter(DoSFilter.java:288)
at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1668)
at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:581)
at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:143)
at org.eclipse.jetty.security.SecurityHandler.handle(SecurityHandler.java:524)
at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:226)
at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1158)
at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:511)
at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:185)
at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1090)
at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:141)
at org.eclipse.jetty.server.handler.ContextHandlerCollection.handle(ContextHandlerCollection.java:213)
at org.eclipse.jetty.server.handler.HandlerCollection.handle(HandlerCollection.java:109)
at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:119)
at org.eclipse.jetty.rewrite.handler.RewriteHandler.handle(RewriteHandler.java:318)
at org.eclipse.jetty.server.handler.gzip.GzipHandler.handle(GzipHandler.java:437)
at org.eclipse.jetty.server.handler.DebugHandler.handle(DebugHandler.java:84)
at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:119)
at org.eclipse.jetty.server.Server.handle(Server.java:517)
at org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:306)
at org.eclipse.jetty.server.HttpConnection.onFillable(HttpConnection.java:242)
at org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:261)
at org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:95)
at org.eclipse.jetty.io.ssl.SslConnection.onFillable(SslConnection.java:192)
at org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:261)
at org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:95)
at org.eclipse.jetty.io.SelectChannelEndPoint$2.run(SelectChannelEndPoint.java:75)
at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.produceAndRun(ExecuteProduceConsume.java:213)
at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.run(ExecuteProduceConsume.java:147)
at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:654)
at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:572)
at java.lang.Thread.run(Thread.java:748)
Caused by: LDAPException(resultCode=91 (connect error), errorMessage='An error occurred while attempting to connect to server mail.ribasmith.net:389: java.io.IOException: An error occurred while attempting to establish a connection to server mail.ribasmith.net:389: java.net.ConnectException: Connection refused (Connection refused)')
at com.unboundid.ldap.sdk.LDAPConnection.connect(LDAPConnection.java:754)
at com.unboundid.ldap.sdk.LDAPConnection.connect(LDAPConnection.java:686)
at com.unboundid.ldap.sdk.LDAPConnection.<init>(LDAPConnection.java:518)
at com.unboundid.ldap.sdk.SingleServerSet.getConnection(SingleServerSet.java:229)
at com.unboundid.ldap.sdk.ServerSet.getConnection(ServerSet.java:98)
at com.unboundid.ldap.sdk.LDAPConnectionPool.createConnection(LDAPConnectionPool.java:938)
at com.unboundid.ldap.sdk.LDAPConnectionPool.getConnection(LDAPConnectionPool.java:1399)
at com.zimbra.cs.ldap.unboundid.UBIDLdapOperation$GetConnection.execute(UBIDLdapOperation.java:189)
at com.zimbra.cs.ldap.unboundid.UBIDLdapContext.getConnection(UBIDLdapContext.java:200)
... 64 more
Caused by: java.io.IOException: An error occurred while attempting to establish a connection to server mail.ribasmith.net:389: java.net.ConnectException: Connection refused (Connection refused)
at com.unboundid.ldap.sdk.LDAPConnectionInternals.<init>(LDAPConnectionInternals.java:137)
at com.unboundid.ldap.sdk.LDAPConnection.connect(LDAPConnection.java:744)
... 72 more
2017-08-21 14:20:07,524 INFO [qtp127618319-29:https:https://localhost:7071/service/admin/soap/GetAllServersRequest] [] SoapEngine - auth credentials have expired: unable to construct SOAP context
2017-08-21 14:20:12,003 INFO [ScheduledTask-3] [name=galsync@rimith.com;mid=19;ds=zimbra;] datasource - Requested import.
2017-08-21 14:20:12,004 INFO [ScheduledTask-3] [name=galsync@rimith.com;mid=19;ds=zimbra;] datasource - Importing data for data source 'zimbra'
2017-08-21 14:20:12,017 WARN [ScheduledTask-3] [name=galsync@rimith.com;mid=19;ds=zimbra;] ldap - unknown GAL op
2017-08-21 14:20:13,808 WARN [ScheduledTask-3] [name=galsync@rimith.com;mid=19;ds=zimbra;] datasource - Unable to set error status for data source zimbra.
2017-08-21 14:20:13,809 INFO [ScheduledTask-3] [name=galsync@rimith.com;mid=19;ds=zimbra;] datasource - Import completed for data source 'zimbra'
2017-08-21 14:20:13,809 WARN [ScheduledTask-3] [name=galsync@rimith.com;mid=19;ds=zimbra;] datasource - Scheduled DataSource import failed.
com.zimbra.common.service.ServiceException: system failure: unable to refresh entry
ExceptionId:ScheduledTask-3:1503343213806:e3c15726f857d685
Code:service.FAILURE
at com.zimbra.common.service.ServiceException.FAILURE(ServiceException.java:286)
at com.zimbra.cs.account.ldap.LdapProvisioning.refreshEntry(LdapProvisioning.java:761)
at com.zimbra.cs.account.ldap.LdapProvisioning.modifyLdapAttrs(LdapProvisioning.java:651)
at com.zimbra.cs.account.ldap.LdapProvisioning.modifyAttrsInternal(LdapProvisioning.java:555)
at com.zimbra.cs.account.ldap.LdapProvisioning.modifyAttrsInternal(LdapProvisioning.java:509)
at com.zimbra.cs.account.ldap.LdapProvisioning.modifyAttrs(LdapProvisioning.java:475)
at com.zimbra.cs.account.ldap.LdapProvisioning.modifyAttrs(LdapProvisioning.java:455)
at com.zimbra.cs.account.ldap.LdapProvisioning.modifyDataSource(LdapProvisioning.java:8298)
at com.zimbra.cs.gal.GalImport.setStatus(GalImport.java:80)
at com.zimbra.cs.gal.GalImport.importGal(GalImport.java:112)
at com.zimbra.cs.gal.GalImport.importData(GalImport.java:57)
at com.zimbra.cs.datasource.DataSourceManager.importData(DataSourceManager.java:379)
at com.zimbra.cs.datasource.DataSourceManager.importData(DataSourceManager.java:335)
at com.zimbra.cs.datasource.DataSourceTask.call(DataSourceTask.java:83)
at com.zimbra.cs.datasource.DataSourceTask.call(DataSourceTask.java:31)
at com.zimbra.common.util.TaskScheduler$TaskRunner.call(TaskScheduler.java:79)
at java.util.concurrent.FutureTask.run(FutureTask.java:266)
at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.access$201(ScheduledThreadPoolExecutor.java:180)
at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:293)
at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149)
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
at java.lang.Thread.run(Thread.java:748)
Caused by: com.zimbra.cs.ldap.LdapException: LDAP error: - unable to get attributes: ldap host=mail.ribasmith.net:389: An error occurred while attempting to connect to server mail.ribasmith.net:389: java.io.IOException: An error occurred while attempting to establish a connection to server mail.ribasmith.net:389: java.net.ConnectException: Connection refused (Connection refused)
ExceptionId:ScheduledTask-3:1503343213806:e3c15726f857d685
Code:ldap.LDAP_ERROR
at com.zimbra.cs.ldap.LdapException.LDAP_ERROR(LdapException.java:90)
at com.zimbra.cs.ldap.unboundid.UBIDLdapException.mapToLdapException(UBIDLdapException.java:74)
at com.zimbra.cs.ldap.unboundid.UBIDLdapContext.mapToLdapException(UBIDLdapContext.java:239)
at com.zimbra.cs.ldap.unboundid.UBIDLdapContext.getAttributes(UBIDLdapContext.java:374)
at com.zimbra.cs.account.ldap.ZLdapHelper.getAttributes(ZLdapHelper.java:278)
at com.zimbra.cs.account.ldap.LdapHelper.getAttributes(LdapHelper.java:196)
at com.zimbra.cs.account.ldap.LdapProvisioning.refreshEntry(LdapProvisioning.java:705)
... 20 more
Caused by: LDAPException(resultCode=91 (connect error), errorMessage='An error occurred while attempting to connect to server mail.ribasmith.net:389: java.io.IOException: An error occurred while attempting
- jorgedlcruz
- Zimbra Alumni
- Posts: 2782
- Joined: Thu May 22, 2014 4:47 pm
Re: LDAP DE ZIMBRA SE CAE
Saludos,
El error parece claro, tu servidor de Zimbra está teniendo problemas para resolver mail.ribasmith.net y mta.ribasmith.net, te recomiendo que revises ese DNS, o mejor, si solamente tienes un Zimbra singleserver, le instales dnsmasq y configures la zona DNS allí, tengo varios ejemplos aquí: Prueba con eso y me cuentas.
Un saludo
El error parece claro, tu servidor de Zimbra está teniendo problemas para resolver mail.ribasmith.net y mta.ribasmith.net, te recomiendo que revises ese DNS, o mejor, si solamente tienes un Zimbra singleserver, le instales dnsmasq y configures la zona DNS allí, tengo varios ejemplos aquí: Prueba con eso y me cuentas.
Un saludo
Re: LDAP DE ZIMBRA SE CAE
Jorge Gracias por responder aquí te coloco el resultado de la consulta de dns para los nombres mail.ribasmith.net y mta.ribasmith.net
El nombre lo resuelve bien porque le puse un servidor de bind pero sigue sin funcionar el ldap y por su puesto falla el descache de zimbra que era un servicio que había instalado el administrador anterior .
Al iniciar si arranca el ldap pero luego de 2 o 3 minutos se cae el ldap aquí te posteo el status de zimbra cuando inició el ldap forzado
El que no arranca es el dns pero no puedo deshabilitarlo porque al ejecutar el comando
Efectivamente esta corriendo bind
Pero el problema del ldap sigue igual y aunque force el ldap con ldap start apenas dura 2 o 3 minutos y se cae
Saludos Cordiales
Code: Select all
mail.ribasmith.net
[zimbra@mail ~]$ dig mail.ribasmith.net
; <<>> DiG 9.8.2rc1-RedHat-9.8.2-0.62.rc1.el6_9.4 <<>> mail.ribasmith.net
;; global options: +cmd
;; Got answer:
;; ->>HEADER<<- opcode: QUERY, status: NOERROR, id: 2977
;; flags: qr aa rd ra; QUERY: 1, ANSWER: 1, AUTHORITY: 1, ADDITIONAL: 0
;; QUESTION SECTION:
;mail.ribasmith.net. IN A
;; ANSWER SECTION:
mail.ribasmith.net. 38400 IN A 192.168.77.96
;; AUTHORITY SECTION:
ribasmith.net. 38400 IN NS mail.ribasmith.net.
;; Query time: 0 msec
;; SERVER: 127.0.0.1#53(127.0.0.1)
;; WHEN: Mon Aug 21 21:31:22 2017
;; MSG SIZE rcvd: 66
[zimbra@mail ~]$ dig mta.ribasmith.net
<<>> DiG 9.8.2rc1-RedHat-9.8.2-0.62.rc1.el6_9.4 <<>> mta.ribasmith.net
;; global options: +cmd
;; Got answer:
;; ->>HEADER<<- opcode: QUERY, status: NOERROR, id: 12562
;; flags: qr aa rd ra; QUERY: 1, ANSWER: 1, AUTHORITY: 1, ADDITIONAL: 1
;; QUESTION SECTION:
;mta.ribasmith.net. IN A
;; ANSWER SECTION:
mta.ribasmith.net. 38400 IN A 192.168.77.96
;; AUTHORITY SECTION:
ribasmith.net. 38400 IN NS mail.ribasmith.net.
;; ADDITIONAL SECTION:
mail.ribasmith.net. 38400 IN A 192.168.77.96
;; Query time: 0 msec
;; SERVER: 127.0.0.1#53(127.0.0.1)
;; WHEN: Mon Aug 21 21:31:26 2017
;; MSG SIZE rcvd: 86
Code: Select all
Connect: Unable to determine enabled services from ldap.
Enabled services read from cache. Service list may be inaccurate.
Host mail.ribasmith.net
amavis Running
antispam Running
dnscache Stopped
dnscache is not running.
ldap Stopped
logger Running
mailbox Running
memcached Running
mta Stopped
zmmilterctl is not running
opendkim Stopped
zmopendkimctl is not running.
proxy Running
service webapp Running
snmp Running
spell Running
stats Running
zimbra webapp Running
zimbraAdmin webapp Running
zimlet webapp Running
zmconfigd Running
Al iniciar si arranca el ldap pero luego de 2 o 3 minutos se cae el ldap aquí te posteo el status de zimbra cuando inició el ldap forzado
Code: Select all
Host mail.ribasmith.net
amavis Running
antispam Running
dnscache Stopped
dnscache is not running.
ldap Stopped
logger Running
mailbox Running
memcached Running
mta Running
opendkim Running
proxy Running
service webapp Running
snmp Running
spell Running
stats Running
zimbra webapp Running
zimbraAdmin webapp Running
zimlet webapp Running
zmconfigd Running
Code: Select all
zmprov ms `zmhostname` -zimbraServiceEnabled dnscache -zimbraServiceInstalled dnscache
ERROR: ldap.LDAP_ERROR (LDAP error: - unable to get connection: ldap host=: An error occurred while attempting to connect to server mail.ribasmith.net:389: java.io.IOException: An error occurred while attempting to establish a connection to server mail.ribasmith.net:389: java.net.ConnectException: Connection refused (Connection refused))
Pero el problema del ldap sigue igual y aunque force el ldap con ldap start apenas dura 2 o 3 minutos y se cae
Saludos Cordiales
- jorgedlcruz
- Zimbra Alumni
- Posts: 2782
- Joined: Thu May 22, 2014 4:47 pm
Re: LDAP DE ZIMBRA SE CAE
Que tienes en /etc/hosts ?
Un saludo
Un saludo
Re: LDAP DE ZIMBRA SE CAE
Hola Jorge aqui coloco lo que esta en el archivo hosts
Saludos y muchas gracias por tratar de colaborarme esto me tiene loco
Code: Select all
[root@mail ~]# cat /etc/hosts
127.0.0.1 localhost localhost.localdomain localhost4 localhost4.localdomain4
192.168.77.96 mail.ribasmith.net mail
192.168.77.96 mail.rimith.com
192.168.77.96 mta.ribasmith.net
- jorgedlcruz
- Zimbra Alumni
- Posts: 2782
- Joined: Thu May 22, 2014 4:47 pm
Re: LDAP DE ZIMBRA SE CAE
Puedes probar a realizar estos pasos?
Se me ocurre que si hace mucho que lo instalaron el self signed haya caducado
Un saludo
Un saludo
Re: LDAP DE ZIMBRA SE CAE
Hola Jorge aqui lo que ocurre al intentar lo de regenerar el certificado
[zimbra@mail ~]$ /opt/zimbra/bin/zmcertmgr createca -new
** Recreating /opt/zimbra/ssl/zimbra/ca/zmssl.cnf
** Using CA private key in '/opt/zimbra/ssl/zimbra/ca/ca.key'
** Creating CA with existing private key /opt/zimbra/ssl/zimbra/ca/ca.key
[zimbra@mail ~]$ /opt/zimbra/bin/zmcertmgr deployca
** Saving config key 'zimbraCertAuthorityCertSelfSigned' via zmprov modifyConfig...failed (rc=2)
[zimbra@mail ~]$ /opt/zimbra/bin/zmcertmgr createca -new
** Recreating /opt/zimbra/ssl/zimbra/ca/zmssl.cnf
** Using CA private key in '/opt/zimbra/ssl/zimbra/ca/ca.key'
** Creating CA with existing private key /opt/zimbra/ssl/zimbra/ca/ca.key
[zimbra@mail ~]$ /opt/zimbra/bin/zmcertmgr deployca
** Saving config key 'zimbraCertAuthorityCertSelfSigned' via zmprov modifyConfig...failed (rc=2)