Udn replication error

ucs-4-3

#16

Hi!

That is strange. What does netstat -anvpt | grep 6669 return on your master?
Please check on both systems, if the packetfilter is really empty: iptables -L -n -v

fingers crossed

Sönke


#17

Hi,
netstat delivered no output.
Here is the result from both commands:

Summary

`

root@hipsctrl-1:~# netstat -anvpt | grep 6669
root@hipsctrl-1:~# iptables -L -n -v
Chain INPUT (policy DROP 0 packets, 0 bytes)
 pkts bytes target     prot opt in     out     source               destination                                                                                                     
 165K   39M ACCEPT     all  --  lo     *       0.0.0.0/0            0.0.0.0/0                                                                                                       
 170K   26M ACCEPT     all  --  *      *       0.0.0.0/0            0.0.0.0/0                                                                                                                state RELATED,ESTABLISHED
   53  3396 ACCEPT     icmp --  *      *       0.0.0.0/0            0.0.0.0/0                                                                                                       
    0     0 ACCEPT     tcp  --  *      *       0.0.0.0/0            0.0.0.0/0                                                                                                                tcp dpt:7636
    0     0 ACCEPT     tcp  --  *      *       0.0.0.0/0            0.0.0.0/0                                                                                                                tcp dpt:111
    0     0 ACCEPT     tcp  --  *      *       0.0.0.0/0            0.0.0.0/0                                                                                                                tcp dpts:32765:32769
   75 26641 ACCEPT     udp  --  *      *       0.0.0.0/0            0.0.0.0/0                                                                                                                udp dpt:67
    0     0 ACCEPT     tcp  --  *      *       0.0.0.0/0            0.0.0.0/0                                                                                                                tcp dpt:544
  272 14144 ACCEPT     tcp  --  *      *       0.0.0.0/0            0.0.0.0/0                                                                                                                tcp dpt:88
 4643  272K ACCEPT     tcp  --  *      *       0.0.0.0/0            0.0.0.0/0                                                                                                                tcp dpt:7389
    0     0 ACCEPT     tcp  --  *      *       0.0.0.0/0            0.0.0.0/0                                                                                                                tcp dpt:3268
    0     0 ACCEPT     tcp  --  *      *       0.0.0.0/0            0.0.0.0/0                                                                                                                tcp dpt:464
 5401 1166K ACCEPT     udp  --  *      *       0.0.0.0/0            0.0.0.0/0                                                                                                                udp dpt:88
 1050 63000 ACCEPT     tcp  --  *      *       0.0.0.0/0            0.0.0.0/0                                                                                                                tcp dpt:6669
    0     0 ACCEPT     tcp  --  *      *       0.0.0.0/0            0.0.0.0/0                                                                                                                tcp dpt:5432
    0     0 ACCEPT     udp  --  *      *       0.0.0.0/0            0.0.0.0/0                                                                                                                udp dpts:32765:32769
   36  1872 ACCEPT     tcp  --  *      *       0.0.0.0/0            0.0.0.0/0                                                                                                                tcp dpt:53
   89  7644 ACCEPT     udp  --  *      *       0.0.0.0/0            0.0.0.0/0                                                                                                                udp dpt:123
    0     0 ACCEPT     tcp  --  *      *       0.0.0.0/0            0.0.0.0/0                                                                                                                tcp dpt:3269
    0     0 ACCEPT     udp  --  *      *       0.0.0.0/0            0.0.0.0/0                                                                                                                udp dpt:464
    4   240 ACCEPT     tcp  --  *      *       0.0.0.0/0            0.0.0.0/0                                                                                                                tcp dpt:80
11034 1382K ACCEPT     udp  --  *      *       0.0.0.0/0            0.0.0.0/0                                                                                                                udp dpt:389
    0     0 ACCEPT     tcp  --  *      *       0.0.0.0/0            0.0.0.0/0                                                                                                                tcp dpt:6080
    0     0 ACCEPT     tcp  --  *      *       0.0.0.0/0            0.0.0.0/0                                                                                                                tcp dpt:443
   81  4212 ACCEPT     tcp  --  *      *       0.0.0.0/0            0.0.0.0/0                                                                                                                tcp dpts:49152:65535
24525 2398K ACCEPT     udp  --  *      *       0.0.0.0/0            0.0.0.0/0                                                                                                                udp dpt:53
    0     0 ACCEPT     tcp  --  *      *       0.0.0.0/0            0.0.0.0/0                                                                                                                tcp dpt:2049
    0     0 ACCEPT     tcp  --  *      *       0.0.0.0/0            0.0.0.0/0                                                                                                                tcp dpt:5666
    0     0 ACCEPT     tcp  --  *      *       0.0.0.0/0            0.0.0.0/0                                                                                                                tcp dpt:636
 2130  261K ACCEPT     udp  --  *      *       0.0.0.0/0            0.0.0.0/0                                                                                                                udp dpts:137:139
    0     0 ACCEPT     udp  --  *      *       0.0.0.0/0            0.0.0.0/0                                                                                                                udp dpt:445
    0     0 ACCEPT     tcp  --  *      *       0.0.0.0/0            0.0.0.0/0                                                                                                                tcp dpt:6670
 2781  166K ACCEPT     tcp  --  *      *       0.0.0.0/0            0.0.0.0/0                                                                                                                tcp dpt:445
  119  7132 ACCEPT     tcp  --  *      *       0.0.0.0/0            0.0.0.0/0                                                                                                                tcp dpt:22
    0     0 ACCEPT     tcp  --  *      *       0.0.0.0/0            0.0.0.0/0                                                                                                                tcp dpt:749
    0     0 ACCEPT     tcp  --  *      *       0.0.0.0/0            0.0.0.0/0                                                                                                                tcp dpt:7777
    0     0 ACCEPT     udp  --  *      *       0.0.0.0/0            0.0.0.0/0                                                                                                                udp dpt:7777
  125  6844 ACCEPT     tcp  --  *      *       0.0.0.0/0            0.0.0.0/0                                                                                                                tcp dpts:137:139
    0     0 ACCEPT     udp  --  *      *       0.0.0.0/0            0.0.0.0/0                                                                                                                udp dpt:2049
  155  8060 ACCEPT     tcp  --  *      *       0.0.0.0/0            0.0.0.0/0                                                                                                                tcp dpt:389
   48  2496 ACCEPT     tcp  --  *      *       0.0.0.0/0            0.0.0.0/0                                                                                                                tcp dpt:135
    0     0 ACCEPT     udp  --  *      *       0.0.0.0/0            0.0.0.0/0                                                                                                                udp dpt:111
  129 40599 ACCEPT     udp  --  *      *       0.0.0.0/0            0.0.0.0/0                                                                                                                udp dpt:68
    0     0 ACCEPT     tcp  --  *      *       0.0.0.0/0            0.0.0.0/0                                                                                                                tcp dpt:1024
    0     0 ACCEPT     tcp  --  *      *       0.0.0.0/0            0.0.0.0/0                                                                                                                tcp dpt:11212
    0     0 ACCEPT     tcp  --  *      *       172.17.0.0/16        0.0.0.0/0                                                                                                                tcp dpt:3306
  127  4572 REJECT     all  --  *      *       0.0.0.0/0            0.0.0.0/0                                                                                                                reject-with icmp-port-unreachable

Chain FORWARD (policy ACCEPT 0 packets, 0 bytes)
 pkts bytes target     prot opt in     out     source               destination                                                                                                     
    0     0 DOCKER-ISOLATION  all  --  *      *       0.0.0.0/0            0.0.0                                                                                                    .0/0
    0     0 DOCKER     all  --  *      docker0  0.0.0.0/0            0.0.0.0/0                                                                                                      
    0     0 ACCEPT     all  --  *      docker0  0.0.0.0/0            0.0.0.0/0                                                                                                                ctstate RELATED,ESTABLISHED
    0     0 ACCEPT     all  --  docker0 !docker0  0.0.0.0/0            0.0.0.0/0                                                                                                    
    0     0 ACCEPT     all  --  docker0 docker0  0.0.0.0/0            0.0.0.0/0                                                                                                     

Chain OUTPUT (policy ACCEPT 204K packets, 52M bytes)
 pkts bytes target     prot opt in     out     source               destination                                                                                                     
 165K   39M ACCEPT     all  --  *      lo      0.0.0.0/0            0.0.0.0/0                                                                                                       

Chain DOCKER (1 references)
 pkts bytes target     prot opt in     out     source               destination                                                                                                     

Chain DOCKER-ISOLATION (1 references)
 pkts bytes target     prot opt in     out     source               destination                                                                                                     
    0     0 RETURN     all  --  *      *       0.0.0.0/0            0.0.0.0/0 `

What do you think?


#18

If the netstat command does not return any output, your UDN is not running on your DC master.
Please try to restart it: service univention-directory-notifier restart and check the log file /var/log/univention/notifier.log

(Btw: your filewall on the DC master is still running, but I can see, that the port 6669 for the UDN is correctly opened, so this is not your actual problem)


#19

This is strange, because I did restart that service in the morning (as written in post 14).
Now restarted again and service univention-directory-notifier status tells:

Summary

`

# service univention-directory-notifier status
● univention-directory-notifier.service - LSB: Univention Directory Notifier Daemon
   Loaded: loaded (/etc/init.d/univention-directory-notifier; generated; vendor preset: enabled)
   Active: active (exited) since Wed 2019-02-27 13:58:15 CET; 3min 30s ago
     Docs: man:systemd-sysv-generator(8)
  Process: 23318 ExecStop=/etc/init.d/univention-directory-notifier stop (code=exited, status=0/SUCCESS)
  Process: 23330 ExecStart=/etc/init.d/univention-directory-notifier start (code=exited, status=0/SUCCESS)
      CPU: 61ms

Feb 27 13:58:14 hipsctrl-1 systemd[1]: Starting LSB: Univention Directory Notifier Daemon...
Feb 27 13:58:15 hipsctrl-1 univention-directory-notifier[23330]: Starting Univention Directory Notifier Daemon: univention-directory-notifierok: run: univention-directory-notifier:
Feb 27 13:58:15 hipsctrl-1 univention-directory-notifier[23330]: .
Feb 27 13:58:15 hipsctrl-1 systemd[1]: Started LSB: Univention Directory Notifier Daemon.

`

And here are the last few lines of notifier.log:

Summary

alueError: need more than 1 value to unpack 2019-02-27 14:02:22,599:CRITICAL:ldap_search(reqSession=13907,cn=translog): No such object Traceback (most recent call last): File "/usr/share/univention-directory-notifier/univention-translog", line 713, in <module> exit(main()) File "/usr/share/univention-directory-notifier/univention-translog", line 374, in main return opt.func(opt) or 0 File "/usr/share/univention-directory-notifier/univention-translog", line 458, in import_all for rec in chain(lead, translog): File "/usr/share/univention-directory-notifier/univention-translog", line 306, in __iter__ rec = self.parse_line(line) File "/usr/share/univention-directory-notifier/univention-translog", line 234, in parse_line dn, command = rest.rsplit(' ', 1) ValueError: need more than 1 value to unpack 2019-02-27 14:02:34,205:CRITICAL:ldap_search(reqSession=13907,cn=translog): No such object

Formatting was lost, sorry for that.

Edit: directly after restarting the notifier service netstat again returned no result.


#20

hm, no more ideas?
here are the last lines of th listener logs from master:

Summary
28.02.19 12:54:13.622  LDAP        ( PROCESS ) : connecting to ldap://hipsctrl-1.hipsy.intranet:7389
28.02.19 12:54:13.628  LDAP        ( INFO    ) : simple_bind as cn=admin,dc=hipsy,dc=intranet
28.02.19 12:54:13.936  LISTENER    ( INFO    ) : connecting to notifier hipsctrl-1.hipsy.intranet:6669
28.02.19 12:54:13.991  LISTENER    ( INFO    ) : connection to 10.0.0.26 failed with errorcode 111: Connection refused
28.02.19 12:54:14.245  LISTENER    ( ERROR   ) : failed to connect to any notifier
28.02.19 12:54:14.245  LISTENER    ( WARN    ) : can not connect any server, retrying in 30 seconds

and backup-dc

Summary
28.02.19 12:59:14.992  LISTENER    ( WARN    ) : can not connect any server, retrying in 30 seconds
28.02.19 12:59:44.992  LISTENER    ( WARN    ) : Notifier/LDAP server is hipsctrl-1.hipsy.intranet:7389
28.02.19 12:59:44.992  LDAP        ( PROCESS ) : connecting to ldap://hipsctrl-1.hipsy.intranet:7389
28.02.19 12:59:45.002  LISTENER    ( ERROR   ) : failed to connect to any notifier
28.02.19 12:59:45.002  LISTENER    ( WARN    ) : can not connect any server, retrying in 30 seconds

Do you think backup2master is the right choice?
I Don’t know what else to do … .:roll_eyes:


#21

Hi!

Something is wrong with the notifier on your DC master. It seems to die directly after starting it.
Can you please send some more last lines of the notifier.log?

Sönke


#22

here it is:

Summary
2019-02-27 14:39:11,604:CRITICAL:ldap_search(reqSession=13907,cn=translog): No such object
Traceback (most recent call last):
  File "/usr/share/univention-directory-notifier/univention-translog", line 713, in <module>
    exit(main())
  File "/usr/share/univention-directory-notifier/univention-translog", line 374, in main
    return opt.func(opt) or 0
  File "/usr/share/univention-directory-notifier/univention-translog", line 458, in import_all
    for rec in chain(lead, translog):
  File "/usr/share/univention-directory-notifier/univention-translog", line 306, in __iter__
    rec = self.parse_line(line)
  File "/usr/share/univention-directory-notifier/univention-translog", line 234, in parse_line
    dn, command = rest.rsplit(' ', 1)
ValueError: need more than 1 value to unpack
2019-02-27 14:39:22,945:CRITICAL:ldap_search(reqSession=13907,cn=translog): No such object
Traceback (most recent call last):
  File "/usr/share/univention-directory-notifier/univention-translog", line 713, in <module>
    exit(main())
  File "/usr/share/univention-directory-notifier/univention-translog", line 374, in main
    return opt.func(opt) or 0
  File "/usr/share/univention-directory-notifier/univention-translog", line 458, in import_all
    for rec in chain(lead, translog):
  File "/usr/share/univention-directory-notifier/univention-translog", line 306, in __iter__
    rec = self.parse_line(line)
  File "/usr/share/univention-directory-notifier/univention-translog", line 234, in parse_line
    dn, command = rest.rsplit(' ', 1)
ValueError: need more than 1 value to unpack
2019-02-27 14:39:34,567:CRITICAL:ldap_search(reqSession=13907,cn=translog): No such object
Traceback (most recent call last):
  File "/usr/share/univention-directory-notifier/univention-translog", line 713, in <module>
    exit(main())
  File "/usr/share/univention-directory-notifier/univention-translog", line 374, in main
    return opt.func(opt) or 0
  File "/usr/share/univention-directory-notifier/univention-translog", line 458, in import_all
    for rec in chain(lead, translog):
  File "/usr/share/univention-directory-notifier/univention-translog", line 306, in __iter__
    rec = self.parse_line(line)
  File "/usr/share/univention-directory-notifier/univention-translog", line 234, in parse_line
    dn, command = rest.rsplit(' ', 1)
ValueError: need more than 1 value to unpack
2019-02-27 14:39:45,990:CRITICAL:ldap_search(reqSession=13907,cn=translog): No such object
Traceback (most recent call last):
  File "/usr/share/univention-directory-notifier/univention-translog", line 713, in <module>
    exit(main())
  File "/usr/share/univention-directory-notifier/univention-translog", line 374, in main
    return opt.func(opt) or 0
  File "/usr/share/univention-directory-notifier/univention-translog", line 458, in import_all
    for rec in chain(lead, translog):
  File "/usr/share/univention-directory-notifier/univention-translog", line 306, in __iter__
    rec = self.parse_line(line)
  File "/usr/share/univention-directory-notifier/univention-translog", line 234, in parse_line
    dn, command = rest.rsplit(' ', 1)
ValueError: need more than 1 value to unpack
2019-02-27 14:39:55,441:CRITICAL:ldap_search(reqSession=13907,cn=translog): No such object
Traceback (most recent call last):
  File "/usr/share/univention-directory-notifier/univention-translog", line 713, in <module>
    exit(main())
  File "/usr/share/univention-directory-notifier/univention-translog", line 374, in main
    return opt.func(opt) or 0
  File "/usr/share/univention-directory-notifier/univention-translog", line 458, in import_all
    for rec in chain(lead, translog):
  File "/usr/share/univention-directory-notifier/univention-translog", line 306, in __iter__
    rec = self.parse_line(line)
  File "/usr/share/univention-directory-notifier/univention-translog", line 234, in parse_line
    dn, command = rest.rsplit(' ', 1)
ValueError: need more than 1 value to unpack
2019-02-27 14:40:06,970:CRITICAL:ldap_search(reqSession=13907,cn=translog): No such object
Traceback (most recent call last):
  File "/usr/share/univention-directory-notifier/univention-translog", line 713, in <module>
    exit(main())
  File "/usr/share/univention-directory-notifier/univention-translog", line 374, in main
    return opt.func(opt) or 0
  File "/usr/share/univention-directory-notifier/univention-translog", line 458, in import_all
    for rec in chain(lead, translog):
  File "/usr/share/univention-directory-notifier/univention-translog", line 306, in __iter__
    rec = self.parse_line(line)
  File "/usr/share/univention-directory-notifier/univention-translog", line 234, in parse_line
    dn, command = rest.rsplit(' ', 1)
ValueError: need more than 1 value to unpack
2019-02-27 14:40:18,253:CRITICAL:ldap_search(reqSession=13907,cn=translog): No such object
Traceback (most recent call last):
  File "/usr/share/univention-directory-notifier/univention-translog", line 713, in <module>
    exit(main())
  File "/usr/share/univention-directory-notifier/univention-translog", line 374, in main
    return opt.func(opt) or 0
  File "/usr/share/univention-directory-notifier/univention-translog", line 458, in import_all
    for rec in chain(lead, translog):
  File "/usr/share/univention-directory-notifier/univention-translog", line 306, in __iter__
    rec = self.parse_line(line)
  File "/usr/share/univention-directory-notifier/univention-translog", line 234, in parse_line
    dn, command = rest.rsplit(' ', 1)
ValueError: need more than 1 value to unpack
2019-02-27 14:40:28,884:CRITICAL:ldap_search(reqSession=13907,cn=translog): No such object
Traceback (most recent call last):
  File "/usr/share/univention-directory-notifier/univention-translog", line 713, in <module>
    exit(main())
  File "/usr/share/univention-directory-notifier/univention-translog", line 374, in main
    return opt.func(opt) or 0
  File "/usr/share/univention-directory-notifier/univention-translog", line 458, in import_all
    for rec in chain(lead, translog):
  File "/usr/share/univention-directory-notifier/univention-translog", line 306, in __iter__
    rec = self.parse_line(line)
  File "/usr/share/univention-directory-notifier/univention-translog", line 234, in parse_line
    dn, command = rest.rsplit(' ', 1)
ValueError: need more than 1 value to unpack
2019-02-27 14:40:40,446:CRITICAL:ldap_search(reqSession=13907,cn=translog): No such object
Traceback (most recent call last):
  File "/usr/share/univention-directory-notifier/univention-translog", line 713, in <module>
    exit(main())
  File "/usr/share/univention-directory-notifier/univention-translog", line 374, in main
    return opt.func(opt) or 0
  File "/usr/share/univention-directory-notifier/univention-translog", line 458, in import_all
    for rec in chain(lead, translog):
  File "/usr/share/univention-directory-notifier/univention-translog", line 306, in __iter__
    rec = self.parse_line(line)
  File "/usr/share/univention-directory-notifier/univention-translog", line 234, in parse_line
    dn, command = rest.rsplit(' ', 1)
ValueError: need more than 1 value to unpack
2019-02-27 14:40:51,647:CRITICAL:ldap_search(reqSession=13907,cn=translog): No such object
Traceback (most recent call last):
  File "/usr/share/univention-directory-notifier/univention-translog", line 713, in <module>
    exit(main())
  File "/usr/share/univention-directory-notifier/univention-translog", line 374, in main
    return opt.func(opt) or 0
  File "/usr/share/univention-directory-notifier/univention-translog", line 458, in import_all
    for rec in chain(lead, translog):
  File "/usr/share/univention-directory-notifier/univention-translog", line 306, in __iter__
    rec = self.parse_line(line)
  File "/usr/share/univention-directory-notifier/univention-translog", line 234, in parse_line
    dn, command = rest.rsplit(' ', 1)
ValueError: need more than 1 value to unpack
2019-02-27 14:41:02,961:CRITICAL:ldap_search(reqSession=13907,cn=translog): No such object
Traceback (most recent call last):
  File "/usr/share/univention-directory-notifier/univention-translog", line 713, in <module>
    exit(main())
  File "/usr/share/univention-directory-notifier/univention-translog", line 374, in main
    return opt.func(opt) or 0
  File "/usr/share/univention-directory-notifier/univention-translog", line 458, in import_all
    for rec in chain(lead, translog):
  File "/usr/share/univention-directory-notifier/univention-translog", line 306, in __iter__
    rec = self.parse_line(line)
  File "/usr/share/univention-directory-notifier/univention-translog", line 234, in parse_line
    dn, command = rest.rsplit(' ', 1)
ValueError: need more than 1 value to unpack
2019-02-27 14:41:14,101:CRITICAL:ldap_search(reqSession=13907,cn=translog): No such object
Traceback (most recent call last):
  File "/usr/share/univention-directory-notifier/univention-translog", line 713, in <module>
    exit(main())
  File "/usr/share/univention-directory-notifier/univention-translog", line 374, in main
    return opt.func(opt) or 0
  File "/usr/share/univention-directory-notifier/univention-translog", line 458, in import_all
    for rec in chain(lead, translog):
  File "/usr/share/univention-directory-notifier/univention-translog", line 306, in __iter__
    rec = self.parse_line(line)
  File "/usr/share/univention-directory-notifier/univention-translog", line 234, in parse_line
    dn, command = rest.rsplit(' ', 1)
ValueError: need more than 1 value to unpack
2019-02-27 14:41:25,747:CRITICAL:ldap_search(reqSession=13907,cn=translog): No such object
Traceback (most recent call last):
  File "/usr/share/univention-directory-notifier/univention-translog", line 713, in <module>
    exit(main())
  File "/usr/share/univention-directory-notifier/univention-translog", line 374, in main
    return opt.func(opt) or 0
  File "/usr/share/univention-directory-notifier/univention-translog", line 458, in import_all
    for rec in chain(lead, translog):
  File "/usr/share/univention-directory-notifier/univention-translog", line 306, in __iter__
    rec = self.parse_line(line)
  File "/usr/share/univention-directory-notifier/univention-translog", line 234, in parse_line
    dn, command = rest.rsplit(' ', 1)
ValueError: need more than 1 value to unpack
2019-02-27 14:41:37,029:CRITICAL:ldap_search(reqSession=13907,cn=translog): No such object
Traceback (most recent call last):
  File "/usr/share/univention-directory-notifier/univention-translog", line 713, in <module>
    exit(main())
  File "/usr/share/univention-directory-notifier/univention-translog", line 374, in main
    return opt.func(opt) or 0
  File "/usr/share/univention-directory-notifier/univention-translog", line 458, in import_all
    for rec in chain(lead, translog):
  File "/usr/share/univention-directory-notifier/univention-translog", line 306, in __iter__
    rec = self.parse_line(line)
  File "/usr/share/univention-directory-notifier/univention-translog", line 234, in parse_line
    dn, command = rest.rsplit(' ', 1)
ValueError: need more than 1 value to unpack
2019-02-27 14:41:48,602:CRITICAL:ldap_search(reqSession=13907,cn=translog): No such object
Traceback (most recent call last):
  File "/usr/share/univention-directory-notifier/univention-translog", line 713, in <module>
    exit(main())
  File "/usr/share/univention-directory-notifier/univention-translog", line 374, in main
    return opt.func(opt) or 0
  File "/usr/share/univention-directory-notifier/univention-translog", line 458, in import_all
    for rec in chain(lead, translog):
  File "/usr/share/univention-directory-notifier/univention-translog", line 306, in __iter__
    rec = self.parse_line(line)
  File "/usr/share/univention-directory-notifier/univention-translog", line 234, in parse_line
    dn, command = rest.rsplit(' ', 1)
ValueError: need more than 1 value to unpack
2019-02-27 14:42:00,114:CRITICAL:ldap_search(reqSession=13907,cn=translog): No such object
Traceback (most recent call last):
  File "/usr/share/univention-directory-notifier/univention-translog", line 713, in <module>
    exit(main())
  File "/usr/share/univention-directory-notifier/univention-translog", line 374, in main
    return opt.func(opt) or 0
  File "/usr/share/univention-directory-notifier/univention-translog", line 458, in import_all
    for rec in chain(lead, translog):
  File "/usr/share/univention-directory-notifier/univention-translog", line 306, in __iter__
    rec = self.parse_line(line)
  File "/usr/share/univention-directory-notifier/univention-translog", line 234, in parse_line
    dn, command = rest.rsplit(' ', 1)
ValueError: need more than 1 value to unpack
2019-02-27 14:42:11,112:CRITICAL:ldap_search(reqSession=13907,cn=translog): No such object
Traceback (most recent call last):
  File "/usr/share/univention-directory-notifier/univention-translog", line 713, in <module>
    exit(main())
  File "/usr/share/univention-directory-notifier/univention-translog", line 374, in main
    return opt.func(opt) or 0
  File "/usr/share/univention-directory-notifier/univention-translog", line 458, in import_all
    for rec in chain(lead, translog):
  File "/usr/share/univention-directory-notifier/univention-translog", line 306, in __iter__
    rec = self.parse_line(line)
  File "/usr/share/univention-directory-notifier/univention-translog", line 234, in parse_line
    dn, command = rest.rsplit(' ', 1)
ValueError: need more than 1 value to unpack

thx
bernhard


#23

Hi!

I suspect, that your transaction file /var/lib/univention-ldap/notify/transaction is somewhere broken around transaction id 13907. The file consists of 3 columns: transaction id, DN, change type (a, m or d). Empty lines are not allowed and all columns have to exist.
Please have a look at it and correct it if possible. If the error is fixed, try to restart the UDN.

Best regards,

Sönke


#24

Good Morning Sönke,

again I ran the python script for finding enumeration mistakes, but it’s ok (no output).
But I can see some lines with blanks wich are not used as column-separator but are due to container names with a blank in it. For UCS also seems to use cns incuding blanks, this should not cause my probs. Beside this I can’t see anything wrong.


#25

Hi!

I’m pretty sure, that your transaction file is broken. There is one line, that contains only 1 space character.
You can send me your transaction file via direct message if you want.

Sönke


#26

Hi!

Thanks for your transaction file. The last column is missing for transaction IDs 11709 and 11710.
Please add a m to both lines. Then, the traceback should be gone.

Best regards,

Sönke


#27

Hi,
thank you very much.
I added the missing m now and restarted the service
but the warning “problem with udn-replication” regrettably still persists.

Edit: No, wait, I have to set the counts of listener / notifer to be equal


#28

Okay, univention-directory-listener-ctrl status
now returns

Current Notifier ID on "hipsctrl-1.hipsy.intranet"
 14365

Last Notifier ID processed by local Listener:
 13205

Last transaction processed:
 14365 zoneName=hipsy.intranet,cn=dns,dc=hipsy,dc=intranet m

/var/lib/univention-ldap/last_id is set to the last number.
So, how can the listener be persuaded to process the last thousand lines?

Best regards

Bernhard


#29

Hi!

Simply restart the listener and check the listerner.log.

Sönke


#30

Hm, service univention-directory-listener restart
doesn’t solve the discrepancy:

v# univention-directory-listener-ctrl status
Listener status:
 finish: univention-directory-listener: (pid 14785) 6s, normally down

Current Notifier ID on "hipsctrl-1.hipsy.intranet"
 14365

Last Notifier ID processed by local Listener:
 13205

Last transaction processed:
 14365 zoneName=hipsy.intranet,cn=dns,dc=hipsy,dc=intranet m


#31

Your UDN seems to run. Have a look at /var/log/univention/listener.log why the UDL is not catching up the missing transactions.


#32

Hi,
that is what i see:

UNIVENTION_DEBUG_BEGIN  : uldap.__open host=hipsctrl-1.hipsy.intranet port=7389 base=dc=hipsy,dc=intranet
01.03.19 12:30:14.196  LDAP        ( INFO    ) : establishing new connection with retry_max=11
01.03.19 12:30:14.203  LDAP        ( INFO    ) : bind binddn=cn=admin,dc=hipsy,dc=intranet
UNIVENTION_DEBUG_END    : uldap.__open host=hipsctrl-1.hipsy.intranet port=7389 base=dc=hipsy,dc=intranet
01.03.19 12:30:14.204  LISTENER    ( INFO    ) : Last Notifier ID: 13205
01.03.19 12:30:14.204  LISTENER    ( INFO    ) : notifier returned = id:14365	dn:<LDAP>	cmd:*
01.03.19 12:30:14.205  LISTENER    ( ERROR   ) : notifier.c:129:notifier_wait_id_result LDAP failed No such object (32): id:13206
01.03.19 12:30:14.205  LISTENER    ( ERROR   ) : listener: 32
01.03.19 12:30:14.205  LDAP        ( INFO    ) : closing connection

:pouting_man:


#33

Hi,
things are getting more confusing (for me).
The transaction file now shows a jump over some hundred lines (13907 followed 14364), while the notifier-id sticks with 13205. I don’t know how to handle that.


#34

Hi!

The thread (Transaction file checking) you mentioned in your first post, contains a section Discontinuity in the numbering can be refilled by editing the transaction file manually, that may help you.

Best regards,

Sönke


#35

Hello,
I know that article. I had these problems 8 weeks ago and solved them following the methods explained there. But now - as described above - it does not work this way this time and I don’t wish to do that every couple of weeks. Control over the system is lost and I decided to rebuild the domain from scratch.

Nevertheless I’m particularly interested in the question how to avoid a udn-error in the future for it causing me serious trouble.

Regards

Bernhard