4 from retry import RetryLoop
14 from ws4py.client.threadedclient import WebSocketClient
16 _logger = logging.getLogger('arvados.events')
19 class _EventClient(WebSocketClient):
20 def __init__(self, url, filters, on_event, last_log_id, on_closed):
21 ssl_options = {'ca_certs': arvados.util.ca_certs_path()}
22 if config.flag_is_true('ARVADOS_API_HOST_INSECURE'):
23 ssl_options['cert_reqs'] = ssl.CERT_NONE
25 ssl_options['cert_reqs'] = ssl.CERT_REQUIRED
27 # Warning: If the host part of url resolves to both IPv6 and
28 # IPv4 addresses (common with "localhost"), only one of them
29 # will be attempted -- and it might not be the right one. See
30 # ws4py's WebSocketBaseClient.__init__.
31 super(_EventClient, self).__init__(url, ssl_options=ssl_options)
33 self.filters = filters
34 self.on_event = on_event
35 self.last_log_id = last_log_id
36 self._closing_lock = threading.RLock()
38 self._closed = threading.Event()
39 self.on_closed = on_closed
42 for f in self.filters:
43 self.subscribe(f, self.last_log_id)
45 def closed(self, code, reason=None):
49 def received_message(self, m):
50 with self._closing_lock:
52 self.on_event(json.loads(str(m)))
54 def close(self, code=1000, reason='', timeout=0):
55 """Close event client and optionally wait for it to finish.
57 :timeout: is the number of seconds to wait for ws4py to
58 indicate that the connection has closed.
60 super(_EventClient, self).close(code, reason)
61 with self._closing_lock:
62 # make sure we don't process any more messages.
64 # wait for ws4py to tell us the connection is closed.
65 self._closed.wait(timeout=timeout)
67 def subscribe(self, f, last_log_id=None):
68 m = {"method": "subscribe", "filters": f}
69 if last_log_id is not None:
70 m["last_log_id"] = last_log_id
71 self.send(json.dumps(m))
73 def unsubscribe(self, f):
74 self.send(json.dumps({"method": "unsubscribe", "filters": f}))
77 class EventClient(object):
78 def __init__(self, url, filters, on_event_cb, last_log_id):
81 self.filters = [filters]
84 self.on_event_cb = on_event_cb
85 self.last_log_id = last_log_id
86 self.is_closed = threading.Event()
87 self._setup_event_client()
89 def _setup_event_client(self):
90 self.ec = _EventClient(self.url, self.filters, self.on_event,
91 self.last_log_id, self.on_closed)
96 self.ec.close_connection()
99 def subscribe(self, f, last_log_id=None):
100 self.filters.append(f)
101 self.ec.subscribe(f, last_log_id)
103 def unsubscribe(self, f):
104 del self.filters[self.filters.index(f)]
105 self.ec.unsubscribe(f)
107 def close(self, code=1000, reason='', timeout=0):
109 self.ec.close(code, reason, timeout)
111 def on_event(self, m):
112 if m.get('id') != None:
113 self.last_log_id = m.get('id')
116 except Exception as e:
117 _logger.exception("Unexpected exception from event callback.")
118 thread.interrupt_main()
121 if not self.is_closed.is_set():
122 _logger.warn("Unexpected close. Reconnecting.")
123 for tries_left in RetryLoop(num_retries=25, backoff_start=.1, max_wait=15):
125 self._setup_event_client()
127 except Exception as e:
128 _logger.warn("Error '%s' during websocket reconnect.", e)
130 _logger.exception("EventClient thread could not contact websocket server.")
132 thread.interrupt_main()
135 def run_forever(self):
136 # Have to poll here to let KeyboardInterrupt get raised.
137 while not self.is_closed.wait(1):
141 class PollClient(threading.Thread):
142 def __init__(self, api, filters, on_event, poll_time, last_log_id):
143 super(PollClient, self).__init__()
146 self.filters = [filters]
149 self.on_event = on_event
150 self.poll_time = poll_time
152 self.last_log_id = last_log_id
153 self._closing = threading.Event()
154 self._closing_lock = threading.RLock()
158 if self.last_log_id != None:
159 self.id = self.last_log_id
161 for f in self.filters:
162 for tries_left in RetryLoop(num_retries=25, backoff_start=.1, max_wait=self.poll_time):
164 items = self.api.logs().list(limit=1, order="id desc", filters=f).execute()['items']
166 except errors.ApiError as error:
172 _logger.exception("PollClient thread could not contact API server.")
173 with self._closing_lock:
175 thread.interrupt_main()
178 if items[0]['id'] > self.id:
179 self.id = items[0]['id']
181 self.on_event({'status': 200})
183 while not self._closing.is_set():
186 for f in self.filters:
187 for tries_left in RetryLoop(num_retries=25, backoff_start=.1, max_wait=self.poll_time):
189 items = self.api.logs().list(order="id asc", filters=f+[["id", ">", str(self.id)]]).execute()
191 except errors.ApiError as error:
197 _logger.exception("PollClient thread could not contact API server.")
198 with self._closing_lock:
200 thread.interrupt_main()
202 for i in items["items"]:
205 with self._closing_lock:
206 if self._closing.is_set():
210 except Exception as e:
211 _logger.exception("Unexpected exception from event callback.")
212 thread.interrupt_main()
213 if items["items_available"] > len(items["items"]):
217 self._closing.wait(self.poll_time)
219 def run_forever(self):
220 # Have to poll here, otherwise KeyboardInterrupt will never get processed.
221 while not self._closing.is_set():
222 self._closing.wait(1)
224 def close(self, code=None, reason=None, timeout=0):
225 """Close poll client and optionally wait for it to finish.
227 If an :on_event: handler is running in a different thread,
228 first wait (indefinitely) for it to return.
230 After closing, wait up to :timeout: seconds for the thread to
231 finish the poll request in progress (if any).
233 :code: and :reason: are ignored. They are present for
234 interface compatibility with EventClient.
237 with self._closing_lock:
240 self.join(timeout=timeout)
242 # "join() raises a RuntimeError if an attempt is made to join the
243 # current thread as that would cause a deadlock. It is also an
244 # error to join() a thread before it has been started and attempts
245 # to do so raises the same exception."
248 def subscribe(self, f):
249 self.on_event({'status': 200})
250 self.filters.append(f)
252 def unsubscribe(self, f):
253 del self.filters[self.filters.index(f)]
256 def _subscribe_websocket(api, filters, on_event, last_log_id=None):
257 endpoint = api._rootDesc.get('websocketUrl', None)
259 raise errors.FeatureNotEnabledError(
260 "Server does not advertise a websocket endpoint")
261 uri_with_token = "{}?api_token={}".format(endpoint, api.api_token)
263 client = EventClient(uri_with_token, filters, on_event, last_log_id)
265 _logger.warn("Failed to connect to websockets on %s" % endpoint)
271 def subscribe(api, filters, on_event, poll_fallback=15, last_log_id=None):
274 a client object retrieved from arvados.api(). The caller should not use this client object for anything else after calling subscribe().
276 Initial subscription filters.
278 The callback when a message is received.
280 If websockets are not available, fall back to polling every N seconds. If poll_fallback=False, this will return None if websockets are not available.
282 Log rows that are newer than the log id
285 if not poll_fallback:
286 return _subscribe_websocket(api, filters, on_event, last_log_id)
289 if not config.flag_is_true('ARVADOS_DISABLE_WEBSOCKETS'):
290 return _subscribe_websocket(api, filters, on_event, last_log_id)
292 _logger.info("Using polling because ARVADOS_DISABLE_WEBSOCKETS is true")
293 except Exception as e:
294 _logger.warn("Falling back to polling after websocket error: %s" % e)
295 p = PollClient(api, filters, on_event, poll_fallback, last_log_id)