[ZODB-Dev] zeopack error

[Kaweh Kazemi]

On 30.01.2012, at 14:01, Martijn Pieters wrote:

> On Mon, Jan 30, 2012 at 13:41, Kaweh Kazemi <kaweh at me.com> wrote:
>> Unfortunately I'm not seeing anything useful, which is my problem:
> 
> That's because that's not the ZEO server log output, but the output
> from zeopack. Your ZEO server keeps logs too, Jim is asking for the
> information you'll find there.


I believe my output is confusing, because I additionally  redirected the zeopack output into my zeo.log.

I get INFO/WARNING/ERROR loggings from zeo into zeo.log (you can see when 127.0.0.1:58682 starts the pack and after the error gets disconnected). 

Here are some more parts. And as far as I can see an Error is raised "in delayed method", but I have no more information in my log. I might be missing something - can I ask zeo to be more verbose about it's doings?


....

[INFO] 2012-01-30T12:20:22: new connection ('::ffff:127.0.0.1', 58681): <ManagedServerConnection ('::ffff:127.0.0.1', 58681)>
[INFO] 2012-01-30T12:20:22: new connection ('::ffff:127.0.0.1', 58682): <ManagedServerConnection ('::ffff:127.0.0.1', 58682)>
[INFO] 2012-01-30T12:20:22: new connection ('::ffff:127.0.0.1', 58683): <ManagedServerConnection ('::ffff:127.0.0.1', 58683)>
[INFO] 2012-01-30T12:20:22: (::ffff:127.0.0.1:58682) received handshake 'Z3101'
[INFO] 2012-01-30T12:20:22: (unconnected) disconnected
[INFO] 2012-01-30T12:20:22: (unconnected) disconnected
[INFO] 2012-01-30T12:20:22: (::ffff:127.0.0.1:58682) pack(time=1327922422.871784) started...
[WARNING] 2012-01-30T12:31:28: (::ffff:83.164.139.135:51056) ('users') queue lock: transactions waiting: 4
[WARNING] 2012-01-30T12:31:41: (::ffff:83.164.139.135:50921) ('users') unlock: transactions waiting: 4
[WARNING] 2012-01-30T12:31:41: (::ffff:83.164.139.135:50921) ('users') queue lock: transactions waiting: 4

....

[WARNING] 2012-01-30T13:36:13: (::ffff:83.164.139.135:50977) ('users') unlock: transactions waiting: 5
[WARNING] 2012-01-30T13:36:13: (::ffff:83.164.139.135:50940) ('users') lock: transactions waiting: 4
[WARNING] 2012-01-30T13:36:13: (::ffff:83.164.139.135:50940) ('users') unlock: transactions waiting: 4
[WARNING] 2012-01-30T13:36:17: (::ffff:83.164.139.135:50977) ('users') queue lock: transactions waiting: 4
[WARNING] 2012-01-30T13:36:17: (::ffff:83.164.139.135:51019) ('users') unlock: transactions waiting: 4
[ERROR] 2012-01-30T13:36:18: (22455) Error raised in delayed method
None
Traceback (most recent call last):
  File "/usr/local/lib/python2.6/dist-packages/ZODB3-3.10.3-py2.6-linux-i686.egg/ZEO/scripts/zeopack.py", line 159, in _main
    cs.pack(packt, wait=True)
  File "/usr/local/lib/python2.6/dist-packages/ZODB3-3.10.3-py2.6-linux-i686.egg/ZEO/ClientStorage.py", line 916, in pack
    return self._server.pack(t, wait)
  File "/usr/local/lib/python2.6/dist-packages/ZODB3-3.10.3-py2.6-linux-i686.egg/ZEO/ServerStub.py", line 155, in pack
    self.rpc.call('pack', t, wait)
  File "/usr/local/lib/python2.6/dist-packages/ZODB3-3.10.3-py2.6-linux-i686.egg/ZEO/zrpc/connection.py", line 768, in call
    raise inst # error raised by server
TypeError: unhashable type: 'list'
Error:
Error packing storage users in ('localhost', 9100)
[INFO] 2012-01-30T13:36:18: (::ffff:127.0.0.1:58682) disconnected

....

Kind regards,
Kaweh