This repository was archived by the owner on Apr 26, 2024. It is now read-only.
-
-
Notifications
You must be signed in to change notification settings - Fork 2.1k
This repository was archived by the owner on Apr 26, 2024. It is now read-only.
Synpase breaking on sync requests with new state res #4131
Copy link
Copy link
Closed
Description
2018-11-01 19:01:05,216 - synapse.access.http.8008 - 233 - INFO - GET-402- 127.0.0.1 - 8008 - Received request: GET /_matrix/client/r0/sync?filter=7&timeout=0&since=s1815156_91664496_3296_3201948_135437_250_21563_224488_40
2018-11-01 19:01:05,218 - synapse.util.caches.response_cache - 151 - INFO - GET-402- [sync]: no cached result for [(@andrewm:amorgan.xyz, 0, u's1815156_91664496_3296_3201948_135437_250_21563_224488_40', u'7', False, u'MIAUBHDWBS')], calculating new on
e
2018-11-01 19:01:05,218 - synapse.handlers.sync - 898 - INFO - GET-402- Calculating sync response for @andrewm:amorgan.xyz
2018-11-01 19:01:05,230 - synapse.metrics - 374 - INFO - - Collecting gc 0
2018-11-01 19:01:05,251 - synapse.metrics - 374 - INFO - - Collecting gc 1
2018-11-01 19:01:05,270 - synapse.metrics - 374 - INFO - - Collecting gc 0
2018-11-01 19:01:05,287 - synapse.metrics - 374 - INFO - - Collecting gc 0
2018-11-01 19:01:05,302 - synapse.metrics - 374 - INFO - - Collecting gc 0
2018-11-01 19:01:05,352 - synapse.metrics - 374 - INFO - - Collecting gc 0
2018-11-01 19:01:05,372 - synapse.util.async_helpers - 205 - INFO - GET-402- Acquired uncontended linearizer lock 'state_resolve_lock' for key frozenset([509393L, 509402L, 509442L, 509422L])
2018-11-01 19:01:05,373 - synapse.state - 476 - INFO - GET-402- Resolving state for !eKTrlepAvBEhUIyoQV:jki.re with 4 groups
2018-11-01 19:01:05,373 - synapse.state - 497 - INFO - GET-402- Resolving conflicted state for u'!eKTrlepAvBEhUIyoQV:jki.re'
2018-11-01 19:01:05,387 - synapse.handlers.sync - 1740 - INFO - GET-402- Incremental gappy sync of !UwfyezyoefyCIPOOXS:matrix.org for user @andrewm:amorgan.xyz with 3 state events
2018-11-01 19:01:05,447 - synapse.metrics - 374 - INFO - - Collecting gc 0
2018-11-01 19:01:05,477 - synapse.util.async_helpers - 205 - INFO - GET-402- Acquired uncontended linearizer lock 'state_resolve_lock' for key frozenset([507485L, 509423L])
2018-11-01 19:01:05,478 - synapse.util.async_helpers - 218 - INFO - GET-402- Releasing linearizer lock 'state_resolve_lock' for key frozenset([507485L, 509423L])
2018-11-01 19:01:05,503 - synapse.handlers.sync - 1740 - INFO - GET-402- Incremental gappy sync of !ruaviCwHdJSWfKcBam:half-shot.uk for user @andrewm:amorgan.xyz with 4 state events
2018-11-01 19:01:05,517 - synapse.handlers.sync - 1740 - INFO - GET-402- Incremental gappy sync of !JbPpaLPZXXczkQYgDa:matrix.org for user @andrewm:amorgan.xyz with 3 state events
2018-11-01 19:01:05,525 - synapse.handlers.sync - 1740 - INFO - GET-402- Incremental gappy sync of !hqPCbJufgVqRCHxgTD:matrix.org for user @andrewm:amorgan.xyz with 2 state events
2018-11-01 19:01:05,531 - synapse.handlers.sync - 1740 - INFO - GET-402- Incremental gappy sync of !iNmaIQExDMeqdITdHH:matrix.org for user @andrewm:amorgan.xyz with 3 state events
2018-11-01 19:01:05,560 - synapse.util.async_helpers - 218 - INFO - GET-402- Releasing linearizer lock 'state_resolve_lock' for key frozenset([509393L, 509402L, 509442L, 509422L])
2018-11-01 19:01:05,563 - synapse.http.server - 112 - ERROR - GET-402- Failed handle request via <function _async_render at 0x7f66a30632a8>: <SynapseRequest at 0x7f666c8c97e8 method=u'GET' uri=u'/_matrix/client/r0/sync?filter=7&timeout=0&since=s181515
6_91664496_3296_3201948_135437_250_21563_224488_40' clientproto=u'HTTP/1.0' site=8008>: Traceback (most recent call last):
File "/home/ops/.synapse/local/lib/python2.7/site-packages/twisted/internet/defer.py", line 653, in _runCallbacks
current.result = callback(current.result, *args, **kw)
File "/home/ops/.synapse/local/lib/python2.7/site-packages/twisted/internet/defer.py", line 1442, in gotResult
_inlineCallbacks(r, g, deferred)
File "/home/ops/.synapse/local/lib/python2.7/site-packages/twisted/internet/defer.py", line 1384, in _inlineCallbacks
result = result.throwExceptionIntoGenerator(g)
File "/home/ops/.synapse/local/lib/python2.7/site-packages/twisted/python/failure.py", line 422, in throwExceptionIntoGenerator
return g.throw(self.type, self.value, self.tb)
--- <exception caught here> ---
File "/home/ops/.synapse/local/lib/python2.7/site-packages/synapse/http/server.py", line 81, in wrapped_request_handler
yield h(self, request)
File "/home/ops/.synapse/local/lib/python2.7/site-packages/twisted/internet/defer.py", line 1384, in _inlineCallbacks
result = result.throwExceptionIntoGenerator(g)
File "/home/ops/.synapse/local/lib/python2.7/site-packages/twisted/python/failure.py", line 422, in throwExceptionIntoGenerator
return g.throw(self.type, self.value, self.tb)
File "/home/ops/.synapse/local/lib/python2.7/site-packages/synapse/http/server.py", line 316, in _async_render
callback_return = yield callback(request, **kwargs)
File "/home/ops/.synapse/local/lib/python2.7/site-packages/twisted/internet/defer.py", line 1384, in _inlineCallbacks
result = result.throwExceptionIntoGenerator(g)
File "/home/ops/.synapse/local/lib/python2.7/site-packages/twisted/python/failure.py", line 422, in throwExceptionIntoGenerator
return g.throw(self.type, self.value, self.tb)
File "/home/ops/.synapse/local/lib/python2.7/site-packages/synapse/rest/client/v2_alpha/sync.py", line 167, in on_GET
full_state=full_state
File "/home/ops/.synapse/local/lib/python2.7/site-packages/twisted/internet/defer.py", line 1384, in _inlineCallbacks
result = result.throwExceptionIntoGenerator(g)
File "/home/ops/.synapse/local/lib/python2.7/site-packages/twisted/python/failure.py", line 422, in throwExceptionIntoGenerator
return g.throw(self.type, self.value, self.tb)
File "/home/ops/.synapse/local/lib/python2.7/site-packages/synapse/handlers/sync.py", line 239, in wait_for_sync_for_user
sync_config, since_token, timeout, full_state,
File "/home/ops/.synapse/local/lib/python2.7/site-packages/twisted/internet/defer.py", line 1384, in _inlineCallbacks
result = result.throwExceptionIntoGenerator(g)
File "/home/ops/.synapse/local/lib/python2.7/site-packages/twisted/python/failure.py", line 422, in throwExceptionIntoGenerator
return g.throw(self.type, self.value, self.tb)
File "/home/ops/.synapse/local/lib/python2.7/site-packages/synapse/handlers/sync.py", line 261, in _wait_for_sync_for_user
sync_config, since_token, full_state=full_state,
File "/home/ops/.synapse/local/lib/python2.7/site-packages/twisted/internet/defer.py", line 1384, in _inlineCallbacks
result = result.throwExceptionIntoGenerator(g)
File "/home/ops/.synapse/local/lib/python2.7/site-packages/twisted/python/failure.py", line 422, in throwExceptionIntoGenerator
return g.throw(self.type, self.value, self.tb)
File "/home/ops/.synapse/local/lib/python2.7/site-packages/synapse/handlers/sync.py", line 929, in generate_sync_result
sync_result_builder, account_data_by_room
File "/home/ops/.synapse/local/lib/python2.7/site-packages/twisted/internet/defer.py", line 1384, in _inlineCallbacks
result = result.throwExceptionIntoGenerator(g)
File "/home/ops/.synapse/local/lib/python2.7/site-packages/twisted/python/failure.py", line 422, in throwExceptionIntoGenerator
return g.throw(self.type, self.value, self.tb)
File "/home/ops/.synapse/local/lib/python2.7/site-packages/synapse/handlers/sync.py", line 1298, in _generate_sync_entry_for_rooms
yield concurrently_execute(handle_room_entries, room_entries, 10)
File "/home/ops/.synapse/local/lib/python2.7/site-packages/twisted/internet/defer.py", line 1384, in _inlineCallbacks
result = result.throwExceptionIntoGenerator(g)
File "/home/ops/.synapse/local/lib/python2.7/site-packages/twisted/python/failure.py", line 422, in throwExceptionIntoGenerator
return g.throw(self.type, self.value, self.tb)
File "/home/ops/.synapse/local/lib/python2.7/site-packages/synapse/util/async_helpers.py", line 149, in _concurrently_execute_inner
yield func(next(it))
File "/home/ops/.synapse/local/lib/python2.7/site-packages/twisted/internet/defer.py", line 1384, in _inlineCallbacks
result = result.throwExceptionIntoGenerator(g)
File "/home/ops/.synapse/local/lib/python2.7/site-packages/twisted/python/failure.py", line 422, in throwExceptionIntoGenerator
return g.throw(self.type, self.value, self.tb)
File "/home/ops/.synapse/local/lib/python2.7/site-packages/synapse/handlers/sync.py", line 1642, in _generate_room_entry
newly_joined_room=newly_joined,
File "/home/ops/.synapse/local/lib/python2.7/site-packages/twisted/internet/defer.py", line 1384, in _inlineCallbacks
result = result.throwExceptionIntoGenerator(g)
File "/home/ops/.synapse/local/lib/python2.7/site-packages/twisted/python/failure.py", line 422, in throwExceptionIntoGenerator
return g.throw(self.type, self.value, self.tb)
File "/home/ops/.synapse/local/lib/python2.7/site-packages/synapse/handlers/sync.py", line 383, in _load_filtered_recents
current_state_ids = yield self.state.get_current_state_ids(room_id)
File "/home/ops/.synapse/local/lib/python2.7/site-packages/twisted/internet/defer.py", line 1384, in _inlineCallbacks
result = result.throwExceptionIntoGenerator(g)
File "/home/ops/.synapse/local/lib/python2.7/site-packages/twisted/python/failure.py", line 422, in throwExceptionIntoGenerator
return g.throw(self.type, self.value, self.tb)
File "/home/ops/.synapse/local/lib/python2.7/site-packages/synapse/state/__init__.py", line 157, in get_current_state_ids
ret = yield self.resolve_state_groups_for_events(room_id, latest_event_ids)
File "/home/ops/.synapse/local/lib/python2.7/site-packages/twisted/internet/defer.py", line 1384, in _inlineCallbacks
result = result.throwExceptionIntoGenerator(g)
File "/home/ops/.synapse/local/lib/python2.7/site-packages/twisted/python/failure.py", line 422, in throwExceptionIntoGenerator
return g.throw(self.type, self.value, self.tb)
File "/home/ops/.synapse/local/lib/python2.7/site-packages/synapse/state/__init__.py", line 376, in resolve_state_groups_for_events
state_res_store=StateResolutionStore(self.store),
File "/home/ops/.synapse/local/lib/python2.7/site-packages/twisted/internet/defer.py", line 1384, in _inlineCallbacks
result = result.throwExceptionIntoGenerator(g)
File "/home/ops/.synapse/local/lib/python2.7/site-packages/twisted/python/failure.py", line 422, in throwExceptionIntoGenerator
return g.throw(self.type, self.value, self.tb)
File "/home/ops/.synapse/local/lib/python2.7/site-packages/synapse/state/__init__.py", line 503, in resolve_state_groups
state_res_store=state_res_store,
File "/home/ops/.synapse/local/lib/python2.7/site-packages/twisted/internet/defer.py", line 1386, in _inlineCallbacks
result = g.send(result)
File "/home/ops/.synapse/local/lib/python2.7/site-packages/synapse/state/v2.py", line 78, in resolve_events_with_store
if eid not in event_map
exceptions.TypeError: argument of type 'NoneType' is not iterable
2018-11-01 19:01:05,565 - synapse.access.http.8008 - 302 - INFO - GET-402- 127.0.0.1 - 8008 - {@andrewm:amorgan.xyz} Processed request: 0.348sec/0.000sec (0.272sec, 0.048sec) (0.148sec/0.648sec/108) 67B 500 "GET /_matrix/client/r0/sync?filter=7&timeou
t=0&since=s1815156_91664496_3296_3201948_135437_250_21563_224488_40 HTTP/1.0" "Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Riot/0.17.3 Chrome/66.0.3359.181 Electron/3.0.5 Safari/537.36" [0 dbevts]
2018-11-01 19:01:05,565 - synapse.metrics - 374 - INFO - - Collecting gc 0
2018-11-01 19:01:05,583 - synapse.handlers.sync - 1740 - INFO - GET-402- Incremental gappy sync of !OluOzqbTJgecdDIuKn:half-shot.uk for user @andrewm:amorgan.xyz with 4 state events
2018-11-01 19:01:05,585 - synapse.metrics - 374 - INFO - - Collecting gc 0
2018-11-01 19:01:05,598 - synapse.handlers.sync - 1740 - INFO - GET-402- Incremental gappy sync of !ciirqRAoioaytTwWEQ:matrix.org for user @andrewm:amorgan.xyz with 4 state events
2018-11-01 19:01:05,600 - synapse.handlers.sync - 1740 - INFO - GET-402- Incremental gappy sync of !NwLDclCUYcfkZaBuJe:matrix.org for user @andrewm:amorgan.xyz with 1 state events
2018-11-01 19:01:05,618 - synapse.util.async_helpers - 205 - INFO - GET-402- Acquired uncontended linearizer lock 'state_resolve_lock' for key frozenset([509450L, 424347L])
2018-11-01 19:01:05,618 - synapse.util.async_helpers - 218 - INFO - GET-402- Releasing linearizer lock 'state_resolve_lock' for key frozenset([509450L, 424347L])
2018-11-01 19:01:05,629 - synapse.metrics - 374 - INFO - - Collecting gc 0
...
Riot is not getting the syncing data it wants :')
Reactions are currently unavailable
Metadata
Metadata
Assignees
Labels
No labels