Fix: relayd: live: crash on attach to a session without trace chunk
[lttng-tools.git] / src / bin / lttng-relayd / live.c
1 /*
2 * Copyright (C) 2013 - Julien Desfossez <jdesfossez@efficios.com>
3 * David Goulet <dgoulet@efficios.com>
4 * 2015 - Mathieu Desnoyers <mathieu.desnoyers@efficios.com>
5 *
6 * This program is free software; you can redistribute it and/or modify
7 * it under the terms of the GNU General Public License, version 2 only,
8 * as published by the Free Software Foundation.
9 *
10 * This program is distributed in the hope that it will be useful, but WITHOUT
11 * ANY WARRANTY; without even the implied warranty of MERCHANTABILITY or
12 * FITNESS FOR A PARTICULAR PURPOSE. See the GNU General Public License for
13 * more details.
14 *
15 * You should have received a copy of the GNU General Public License along
16 * with this program; if not, write to the Free Software Foundation, Inc.,
17 * 51 Franklin Street, Fifth Floor, Boston, MA 02110-1301 USA.
18 */
19
20 #define _LGPL_SOURCE
21 #include <getopt.h>
22 #include <grp.h>
23 #include <limits.h>
24 #include <pthread.h>
25 #include <signal.h>
26 #include <stdio.h>
27 #include <stdlib.h>
28 #include <string.h>
29 #include <sys/mman.h>
30 #include <sys/mount.h>
31 #include <sys/resource.h>
32 #include <sys/socket.h>
33 #include <sys/stat.h>
34 #include <sys/types.h>
35 #include <sys/wait.h>
36 #include <inttypes.h>
37 #include <urcu/futex.h>
38 #include <urcu/uatomic.h>
39 #include <urcu/rculist.h>
40 #include <unistd.h>
41 #include <fcntl.h>
42
43 #include <lttng/lttng.h>
44 #include <common/common.h>
45 #include <common/compat/poll.h>
46 #include <common/compat/socket.h>
47 #include <common/compat/endian.h>
48 #include <common/defaults.h>
49 #include <common/futex.h>
50 #include <common/index/index.h>
51 #include <common/sessiond-comm/sessiond-comm.h>
52 #include <common/sessiond-comm/inet.h>
53 #include <common/sessiond-comm/relayd.h>
54 #include <common/uri.h>
55 #include <common/utils.h>
56
57 #include "cmd.h"
58 #include "live.h"
59 #include "lttng-relayd.h"
60 #include "utils.h"
61 #include "health-relayd.h"
62 #include "testpoint.h"
63 #include "viewer-stream.h"
64 #include "stream.h"
65 #include "session.h"
66 #include "ctf-trace.h"
67 #include "connection.h"
68 #include "viewer-session.h"
69
70 #define SESSION_BUF_DEFAULT_COUNT 16
71
72 static struct lttng_uri *live_uri;
73
74 /*
75 * This pipe is used to inform the worker thread that a command is queued and
76 * ready to be processed.
77 */
78 static int live_conn_pipe[2] = { -1, -1 };
79
80 /* Shared between threads */
81 static int live_dispatch_thread_exit;
82
83 static pthread_t live_listener_thread;
84 static pthread_t live_dispatcher_thread;
85 static pthread_t live_worker_thread;
86
87 /*
88 * Relay command queue.
89 *
90 * The live_thread_listener and live_thread_dispatcher communicate with this
91 * queue.
92 */
93 static struct relay_conn_queue viewer_conn_queue;
94
95 static uint64_t last_relay_viewer_session_id;
96 static pthread_mutex_t last_relay_viewer_session_id_lock =
97 PTHREAD_MUTEX_INITIALIZER;
98
99 /*
100 * Cleanup the daemon
101 */
102 static
103 void cleanup_relayd_live(void)
104 {
105 DBG("Cleaning up");
106
107 free(live_uri);
108 }
109
110 /*
111 * Receive a request buffer using a given socket, destination allocated buffer
112 * of length size.
113 *
114 * Return the size of the received message or else a negative value on error
115 * with errno being set by recvmsg() syscall.
116 */
117 static
118 ssize_t recv_request(struct lttcomm_sock *sock, void *buf, size_t size)
119 {
120 ssize_t ret;
121
122 ret = sock->ops->recvmsg(sock, buf, size, 0);
123 if (ret < 0 || ret != size) {
124 if (ret == 0) {
125 /* Orderly shutdown. Not necessary to print an error. */
126 DBG("Socket %d did an orderly shutdown", sock->fd);
127 } else {
128 ERR("Relay failed to receive request.");
129 }
130 ret = -1;
131 }
132
133 return ret;
134 }
135
136 /*
137 * Send a response buffer using a given socket, source allocated buffer of
138 * length size.
139 *
140 * Return the size of the sent message or else a negative value on error with
141 * errno being set by sendmsg() syscall.
142 */
143 static
144 ssize_t send_response(struct lttcomm_sock *sock, void *buf, size_t size)
145 {
146 ssize_t ret;
147
148 ret = sock->ops->sendmsg(sock, buf, size, 0);
149 if (ret < 0) {
150 ERR("Relayd failed to send response.");
151 }
152
153 return ret;
154 }
155
156 /*
157 * Atomically check if new streams got added in one of the sessions attached
158 * and reset the flag to 0.
159 *
160 * Returns 1 if new streams got added, 0 if nothing changed, a negative value
161 * on error.
162 */
163 static
164 int check_new_streams(struct relay_connection *conn)
165 {
166 struct relay_session *session;
167 unsigned long current_val;
168 int ret = 0;
169
170 if (!conn->viewer_session) {
171 goto end;
172 }
173 rcu_read_lock();
174 cds_list_for_each_entry_rcu(session,
175 &conn->viewer_session->session_list,
176 viewer_session_node) {
177 if (!session_get(session)) {
178 continue;
179 }
180 current_val = uatomic_cmpxchg(&session->new_streams, 1, 0);
181 ret = current_val;
182 session_put(session);
183 if (ret == 1) {
184 goto end;
185 }
186 }
187 end:
188 rcu_read_unlock();
189 return ret;
190 }
191
192 /*
193 * Send viewer streams to the given socket. The ignore_sent_flag indicates if
194 * this function should ignore the sent flag or not.
195 *
196 * Return 0 on success or else a negative value.
197 */
198 static
199 ssize_t send_viewer_streams(struct lttcomm_sock *sock,
200 uint64_t session_id, unsigned int ignore_sent_flag)
201 {
202 ssize_t ret;
203 struct lttng_viewer_stream send_stream;
204 struct lttng_ht_iter iter;
205 struct relay_viewer_stream *vstream;
206
207 rcu_read_lock();
208
209 cds_lfht_for_each_entry(viewer_streams_ht->ht, &iter.iter, vstream,
210 stream_n.node) {
211 struct ctf_trace *ctf_trace;
212
213 health_code_update();
214
215 if (!viewer_stream_get(vstream)) {
216 continue;
217 }
218
219 pthread_mutex_lock(&vstream->stream->lock);
220 /* Ignore if not the same session. */
221 if (vstream->stream->trace->session->id != session_id ||
222 (!ignore_sent_flag && vstream->sent_flag)) {
223 pthread_mutex_unlock(&vstream->stream->lock);
224 viewer_stream_put(vstream);
225 continue;
226 }
227
228 ctf_trace = vstream->stream->trace;
229 send_stream.id = htobe64(vstream->stream->stream_handle);
230 send_stream.ctf_trace_id = htobe64(ctf_trace->id);
231 send_stream.metadata_flag = htobe32(
232 vstream->stream->is_metadata);
233 if (lttng_strncpy(send_stream.path_name, vstream->path_name,
234 sizeof(send_stream.path_name))) {
235 pthread_mutex_unlock(&vstream->stream->lock);
236 viewer_stream_put(vstream);
237 ret = -1; /* Error. */
238 goto end_unlock;
239 }
240 if (lttng_strncpy(send_stream.channel_name,
241 vstream->channel_name,
242 sizeof(send_stream.channel_name))) {
243 pthread_mutex_unlock(&vstream->stream->lock);
244 viewer_stream_put(vstream);
245 ret = -1; /* Error. */
246 goto end_unlock;
247 }
248
249 DBG("Sending stream %" PRIu64 " to viewer",
250 vstream->stream->stream_handle);
251 vstream->sent_flag = 1;
252 pthread_mutex_unlock(&vstream->stream->lock);
253
254 ret = send_response(sock, &send_stream, sizeof(send_stream));
255 viewer_stream_put(vstream);
256 if (ret < 0) {
257 goto end_unlock;
258 }
259 }
260
261 ret = 0;
262
263 end_unlock:
264 rcu_read_unlock();
265 return ret;
266 }
267
268 /*
269 * Create every viewer stream possible for the given session with the seek
270 * type. Three counters *can* be return which are in order the total amount of
271 * viewer stream of the session, the number of unsent stream and the number of
272 * stream created. Those counters can be NULL and thus will be ignored.
273 *
274 * session must be locked to ensure that we see either none or all initial
275 * streams for a session, but no intermediate state..
276 *
277 * Return 0 on success or else a negative value.
278 */
279 static int make_viewer_streams(struct relay_session *session,
280 struct lttng_trace_chunk *viewer_trace_chunk,
281 enum lttng_viewer_seek seek_t,
282 uint32_t *nb_total,
283 uint32_t *nb_unsent,
284 uint32_t *nb_created,
285 bool *closed)
286 {
287 int ret;
288 struct lttng_ht_iter iter;
289 struct ctf_trace *ctf_trace;
290
291 assert(session);
292 ASSERT_LOCKED(session->lock);
293
294 if (session->connection_closed) {
295 *closed = true;
296 }
297
298 /*
299 * Create viewer streams for relay streams that are ready to be
300 * used for a the given session id only.
301 */
302 rcu_read_lock();
303 cds_lfht_for_each_entry(session->ctf_traces_ht->ht, &iter.iter, ctf_trace,
304 node.node) {
305 struct relay_stream *stream;
306
307 health_code_update();
308
309 if (!ctf_trace_get(ctf_trace)) {
310 continue;
311 }
312
313 cds_list_for_each_entry_rcu(stream, &ctf_trace->stream_list, stream_node) {
314 struct relay_viewer_stream *vstream;
315
316 if (!stream_get(stream)) {
317 continue;
318 }
319 /*
320 * stream published is protected by the session lock.
321 */
322 if (!stream->published) {
323 goto next;
324 }
325 vstream = viewer_stream_get_by_id(stream->stream_handle);
326 if (!vstream) {
327 vstream = viewer_stream_create(stream,
328 viewer_trace_chunk, seek_t);
329 if (!vstream) {
330 ret = -1;
331 ctf_trace_put(ctf_trace);
332 stream_put(stream);
333 goto error_unlock;
334 }
335
336 if (nb_created) {
337 /* Update number of created stream counter. */
338 (*nb_created)++;
339 }
340 /*
341 * Ensure a self-reference is preserved even
342 * after we have put our local reference.
343 */
344 if (!viewer_stream_get(vstream)) {
345 ERR("Unable to get self-reference on viewer stream, logic error.");
346 abort();
347 }
348 } else {
349 if (!vstream->sent_flag && nb_unsent) {
350 /* Update number of unsent stream counter. */
351 (*nb_unsent)++;
352 }
353 }
354 /* Update number of total stream counter. */
355 if (nb_total) {
356 if (stream->is_metadata) {
357 if (!stream->closed ||
358 stream->metadata_received > vstream->metadata_sent) {
359 (*nb_total)++;
360 }
361 } else {
362 if (!stream->closed ||
363 !(((int64_t) (stream->prev_data_seq - stream->last_net_seq_num)) >= 0)) {
364
365 (*nb_total)++;
366 }
367 }
368 }
369 /* Put local reference. */
370 viewer_stream_put(vstream);
371 next:
372 stream_put(stream);
373 }
374 ctf_trace_put(ctf_trace);
375 }
376
377 ret = 0;
378
379 error_unlock:
380 rcu_read_unlock();
381 return ret;
382 }
383
384 int relayd_live_stop(void)
385 {
386 /* Stop dispatch thread */
387 CMM_STORE_SHARED(live_dispatch_thread_exit, 1);
388 futex_nto1_wake(&viewer_conn_queue.futex);
389 return 0;
390 }
391
392 /*
393 * Create a poll set with O_CLOEXEC and add the thread quit pipe to the set.
394 */
395 static
396 int create_thread_poll_set(struct lttng_poll_event *events, int size)
397 {
398 int ret;
399
400 if (events == NULL || size == 0) {
401 ret = -1;
402 goto error;
403 }
404
405 ret = lttng_poll_create(events, size, LTTNG_CLOEXEC);
406 if (ret < 0) {
407 goto error;
408 }
409
410 /* Add quit pipe */
411 ret = lttng_poll_add(events, thread_quit_pipe[0], LPOLLIN | LPOLLERR);
412 if (ret < 0) {
413 goto error;
414 }
415
416 return 0;
417
418 error:
419 return ret;
420 }
421
422 /*
423 * Check if the thread quit pipe was triggered.
424 *
425 * Return 1 if it was triggered else 0;
426 */
427 static
428 int check_thread_quit_pipe(int fd, uint32_t events)
429 {
430 if (fd == thread_quit_pipe[0] && (events & LPOLLIN)) {
431 return 1;
432 }
433
434 return 0;
435 }
436
437 /*
438 * Create and init socket from uri.
439 */
440 static
441 struct lttcomm_sock *init_socket(struct lttng_uri *uri)
442 {
443 int ret;
444 struct lttcomm_sock *sock = NULL;
445
446 sock = lttcomm_alloc_sock_from_uri(uri);
447 if (sock == NULL) {
448 ERR("Allocating socket");
449 goto error;
450 }
451
452 ret = lttcomm_create_sock(sock);
453 if (ret < 0) {
454 goto error;
455 }
456 DBG("Listening on sock %d for lttng-live", sock->fd);
457
458 ret = sock->ops->bind(sock);
459 if (ret < 0) {
460 PERROR("Failed to bind lttng-live socket");
461 goto error;
462 }
463
464 ret = sock->ops->listen(sock, -1);
465 if (ret < 0) {
466 goto error;
467
468 }
469
470 return sock;
471
472 error:
473 if (sock) {
474 lttcomm_destroy_sock(sock);
475 }
476 return NULL;
477 }
478
479 /*
480 * This thread manages the listening for new connections on the network
481 */
482 static
483 void *thread_listener(void *data)
484 {
485 int i, ret, pollfd, err = -1;
486 uint32_t revents, nb_fd;
487 struct lttng_poll_event events;
488 struct lttcomm_sock *live_control_sock;
489
490 DBG("[thread] Relay live listener started");
491
492 health_register(health_relayd, HEALTH_RELAYD_TYPE_LIVE_LISTENER);
493
494 health_code_update();
495
496 live_control_sock = init_socket(live_uri);
497 if (!live_control_sock) {
498 goto error_sock_control;
499 }
500
501 /* Pass 2 as size here for the thread quit pipe and control sockets. */
502 ret = create_thread_poll_set(&events, 2);
503 if (ret < 0) {
504 goto error_create_poll;
505 }
506
507 /* Add the control socket */
508 ret = lttng_poll_add(&events, live_control_sock->fd, LPOLLIN | LPOLLRDHUP);
509 if (ret < 0) {
510 goto error_poll_add;
511 }
512
513 lttng_relay_notify_ready();
514
515 if (testpoint(relayd_thread_live_listener)) {
516 goto error_testpoint;
517 }
518
519 while (1) {
520 health_code_update();
521
522 DBG("Listener accepting live viewers connections");
523
524 restart:
525 health_poll_entry();
526 ret = lttng_poll_wait(&events, -1);
527 health_poll_exit();
528 if (ret < 0) {
529 /*
530 * Restart interrupted system call.
531 */
532 if (errno == EINTR) {
533 goto restart;
534 }
535 goto error;
536 }
537 nb_fd = ret;
538
539 DBG("Relay new viewer connection received");
540 for (i = 0; i < nb_fd; i++) {
541 health_code_update();
542
543 /* Fetch once the poll data */
544 revents = LTTNG_POLL_GETEV(&events, i);
545 pollfd = LTTNG_POLL_GETFD(&events, i);
546
547 /* Thread quit pipe has been closed. Killing thread. */
548 ret = check_thread_quit_pipe(pollfd, revents);
549 if (ret) {
550 err = 0;
551 goto exit;
552 }
553
554 if (revents & LPOLLIN) {
555 /*
556 * A new connection is requested, therefore a
557 * viewer connection is allocated in this
558 * thread, enqueued to a global queue and
559 * dequeued (and freed) in the worker thread.
560 */
561 int val = 1;
562 struct relay_connection *new_conn;
563 struct lttcomm_sock *newsock;
564
565 newsock = live_control_sock->ops->accept(live_control_sock);
566 if (!newsock) {
567 PERROR("accepting control sock");
568 goto error;
569 }
570 DBG("Relay viewer connection accepted socket %d", newsock->fd);
571
572 ret = setsockopt(newsock->fd, SOL_SOCKET, SO_REUSEADDR, &val,
573 sizeof(val));
574 if (ret < 0) {
575 PERROR("setsockopt inet");
576 lttcomm_destroy_sock(newsock);
577 goto error;
578 }
579 new_conn = connection_create(newsock, RELAY_CONNECTION_UNKNOWN);
580 if (!new_conn) {
581 lttcomm_destroy_sock(newsock);
582 goto error;
583 }
584 /* Ownership assumed by the connection. */
585 newsock = NULL;
586
587 /* Enqueue request for the dispatcher thread. */
588 cds_wfcq_enqueue(&viewer_conn_queue.head, &viewer_conn_queue.tail,
589 &new_conn->qnode);
590
591 /*
592 * Wake the dispatch queue futex.
593 * Implicit memory barrier with the
594 * exchange in cds_wfcq_enqueue.
595 */
596 futex_nto1_wake(&viewer_conn_queue.futex);
597 } else if (revents & (LPOLLERR | LPOLLHUP | LPOLLRDHUP)) {
598 ERR("socket poll error");
599 goto error;
600 } else {
601 ERR("Unexpected poll events %u for sock %d", revents, pollfd);
602 goto error;
603 }
604 }
605 }
606
607 exit:
608 error:
609 error_poll_add:
610 error_testpoint:
611 lttng_poll_clean(&events);
612 error_create_poll:
613 if (live_control_sock->fd >= 0) {
614 ret = live_control_sock->ops->close(live_control_sock);
615 if (ret) {
616 PERROR("close");
617 }
618 }
619 lttcomm_destroy_sock(live_control_sock);
620 error_sock_control:
621 if (err) {
622 health_error();
623 DBG("Live viewer listener thread exited with error");
624 }
625 health_unregister(health_relayd);
626 DBG("Live viewer listener thread cleanup complete");
627 if (lttng_relay_stop_threads()) {
628 ERR("Error stopping threads");
629 }
630 return NULL;
631 }
632
633 /*
634 * This thread manages the dispatching of the requests to worker threads
635 */
636 static
637 void *thread_dispatcher(void *data)
638 {
639 int err = -1;
640 ssize_t ret;
641 struct cds_wfcq_node *node;
642 struct relay_connection *conn = NULL;
643
644 DBG("[thread] Live viewer relay dispatcher started");
645
646 health_register(health_relayd, HEALTH_RELAYD_TYPE_LIVE_DISPATCHER);
647
648 if (testpoint(relayd_thread_live_dispatcher)) {
649 goto error_testpoint;
650 }
651
652 health_code_update();
653
654 for (;;) {
655 health_code_update();
656
657 /* Atomically prepare the queue futex */
658 futex_nto1_prepare(&viewer_conn_queue.futex);
659
660 if (CMM_LOAD_SHARED(live_dispatch_thread_exit)) {
661 break;
662 }
663
664 do {
665 health_code_update();
666
667 /* Dequeue commands */
668 node = cds_wfcq_dequeue_blocking(&viewer_conn_queue.head,
669 &viewer_conn_queue.tail);
670 if (node == NULL) {
671 DBG("Woken up but nothing in the live-viewer "
672 "relay command queue");
673 /* Continue thread execution */
674 break;
675 }
676 conn = caa_container_of(node, struct relay_connection, qnode);
677 DBG("Dispatching viewer request waiting on sock %d",
678 conn->sock->fd);
679
680 /*
681 * Inform worker thread of the new request. This
682 * call is blocking so we can be assured that
683 * the data will be read at some point in time
684 * or wait to the end of the world :)
685 */
686 ret = lttng_write(live_conn_pipe[1], &conn, sizeof(conn));
687 if (ret < 0) {
688 PERROR("write conn pipe");
689 connection_put(conn);
690 goto error;
691 }
692 } while (node != NULL);
693
694 /* Futex wait on queue. Blocking call on futex() */
695 health_poll_entry();
696 futex_nto1_wait(&viewer_conn_queue.futex);
697 health_poll_exit();
698 }
699
700 /* Normal exit, no error */
701 err = 0;
702
703 error:
704 error_testpoint:
705 if (err) {
706 health_error();
707 ERR("Health error occurred in %s", __func__);
708 }
709 health_unregister(health_relayd);
710 DBG("Live viewer dispatch thread dying");
711 if (lttng_relay_stop_threads()) {
712 ERR("Error stopping threads");
713 }
714 return NULL;
715 }
716
717 /*
718 * Establish connection with the viewer and check the versions.
719 *
720 * Return 0 on success or else negative value.
721 */
722 static
723 int viewer_connect(struct relay_connection *conn)
724 {
725 int ret;
726 struct lttng_viewer_connect reply, msg;
727
728 conn->version_check_done = 1;
729
730 health_code_update();
731
732 DBG("Viewer is establishing a connection to the relayd.");
733
734 ret = recv_request(conn->sock, &msg, sizeof(msg));
735 if (ret < 0) {
736 goto end;
737 }
738
739 health_code_update();
740
741 memset(&reply, 0, sizeof(reply));
742 reply.major = RELAYD_VERSION_COMM_MAJOR;
743 reply.minor = RELAYD_VERSION_COMM_MINOR;
744
745 /* Major versions must be the same */
746 if (reply.major != be32toh(msg.major)) {
747 DBG("Incompatible major versions ([relayd] %u vs [client] %u)",
748 reply.major, be32toh(msg.major));
749 ret = -1;
750 goto end;
751 }
752
753 conn->major = reply.major;
754 /* We adapt to the lowest compatible version */
755 if (reply.minor <= be32toh(msg.minor)) {
756 conn->minor = reply.minor;
757 } else {
758 conn->minor = be32toh(msg.minor);
759 }
760
761 if (be32toh(msg.type) == LTTNG_VIEWER_CLIENT_COMMAND) {
762 conn->type = RELAY_VIEWER_COMMAND;
763 } else if (be32toh(msg.type) == LTTNG_VIEWER_CLIENT_NOTIFICATION) {
764 conn->type = RELAY_VIEWER_NOTIFICATION;
765 } else {
766 ERR("Unknown connection type : %u", be32toh(msg.type));
767 ret = -1;
768 goto end;
769 }
770
771 reply.major = htobe32(reply.major);
772 reply.minor = htobe32(reply.minor);
773 if (conn->type == RELAY_VIEWER_COMMAND) {
774 /*
775 * Increment outside of htobe64 macro, because the argument can
776 * be used more than once within the macro, and thus the
777 * operation may be undefined.
778 */
779 pthread_mutex_lock(&last_relay_viewer_session_id_lock);
780 last_relay_viewer_session_id++;
781 pthread_mutex_unlock(&last_relay_viewer_session_id_lock);
782 reply.viewer_session_id = htobe64(last_relay_viewer_session_id);
783 }
784
785 health_code_update();
786
787 ret = send_response(conn->sock, &reply, sizeof(reply));
788 if (ret < 0) {
789 goto end;
790 }
791
792 health_code_update();
793
794 DBG("Version check done using protocol %u.%u", conn->major, conn->minor);
795 ret = 0;
796
797 end:
798 return ret;
799 }
800
801 /*
802 * Send the viewer the list of current sessions.
803 * We need to create a copy of the hash table content because otherwise
804 * we cannot assume the number of entries stays the same between getting
805 * the number of HT elements and iteration over the HT.
806 *
807 * Return 0 on success or else a negative value.
808 */
809 static
810 int viewer_list_sessions(struct relay_connection *conn)
811 {
812 int ret = 0;
813 struct lttng_viewer_list_sessions session_list;
814 struct lttng_ht_iter iter;
815 struct relay_session *session;
816 struct lttng_viewer_session *send_session_buf = NULL;
817 uint32_t buf_count = SESSION_BUF_DEFAULT_COUNT;
818 uint32_t count = 0;
819
820 DBG("List sessions received");
821
822 send_session_buf = zmalloc(SESSION_BUF_DEFAULT_COUNT * sizeof(*send_session_buf));
823 if (!send_session_buf) {
824 return -1;
825 }
826
827 rcu_read_lock();
828 cds_lfht_for_each_entry(sessions_ht->ht, &iter.iter, session,
829 session_n.node) {
830 struct lttng_viewer_session *send_session;
831
832 health_code_update();
833
834 pthread_mutex_lock(&session->lock);
835 if (session->connection_closed) {
836 /* Skip closed session */
837 goto next_session;
838 }
839 if (!session->current_trace_chunk) {
840 /*
841 * Skip un-attachable session. It is either
842 * being destroyed or has not had a trace
843 * chunk created against it yet.
844 */
845 goto next_session;
846 }
847
848 if (count >= buf_count) {
849 struct lttng_viewer_session *newbuf;
850 uint32_t new_buf_count = buf_count << 1;
851
852 newbuf = realloc(send_session_buf,
853 new_buf_count * sizeof(*send_session_buf));
854 if (!newbuf) {
855 ret = -1;
856 goto break_loop;
857 }
858 send_session_buf = newbuf;
859 buf_count = new_buf_count;
860 }
861 send_session = &send_session_buf[count];
862 if (lttng_strncpy(send_session->session_name,
863 session->session_name,
864 sizeof(send_session->session_name))) {
865 ret = -1;
866 goto break_loop;
867 }
868 if (lttng_strncpy(send_session->hostname, session->hostname,
869 sizeof(send_session->hostname))) {
870 ret = -1;
871 goto break_loop;
872 }
873 send_session->id = htobe64(session->id);
874 send_session->live_timer = htobe32(session->live_timer);
875 if (session->viewer_attached) {
876 send_session->clients = htobe32(1);
877 } else {
878 send_session->clients = htobe32(0);
879 }
880 send_session->streams = htobe32(session->stream_count);
881 count++;
882 next_session:
883 pthread_mutex_unlock(&session->lock);
884 continue;
885 break_loop:
886 pthread_mutex_unlock(&session->lock);
887 break;
888 }
889 rcu_read_unlock();
890 if (ret < 0) {
891 goto end_free;
892 }
893
894 session_list.sessions_count = htobe32(count);
895
896 health_code_update();
897
898 ret = send_response(conn->sock, &session_list, sizeof(session_list));
899 if (ret < 0) {
900 goto end_free;
901 }
902
903 health_code_update();
904
905 ret = send_response(conn->sock, send_session_buf,
906 count * sizeof(*send_session_buf));
907 if (ret < 0) {
908 goto end_free;
909 }
910 health_code_update();
911
912 ret = 0;
913 end_free:
914 free(send_session_buf);
915 return ret;
916 }
917
918 /*
919 * Send the viewer the list of current streams.
920 */
921 static
922 int viewer_get_new_streams(struct relay_connection *conn)
923 {
924 int ret, send_streams = 0;
925 uint32_t nb_created = 0, nb_unsent = 0, nb_streams = 0, nb_total = 0;
926 struct lttng_viewer_new_streams_request request;
927 struct lttng_viewer_new_streams_response response;
928 struct relay_session *session = NULL;
929 uint64_t session_id;
930 bool closed = false;
931
932 assert(conn);
933
934 DBG("Get new streams received");
935
936 health_code_update();
937
938 /* Receive the request from the connected client. */
939 ret = recv_request(conn->sock, &request, sizeof(request));
940 if (ret < 0) {
941 goto error;
942 }
943 session_id = be64toh(request.session_id);
944
945 health_code_update();
946
947 memset(&response, 0, sizeof(response));
948
949 session = session_get_by_id(session_id);
950 if (!session) {
951 DBG("Relay session %" PRIu64 " not found", session_id);
952 response.status = htobe32(LTTNG_VIEWER_NEW_STREAMS_ERR);
953 goto send_reply;
954 }
955
956 if (!viewer_session_is_attached(conn->viewer_session, session)) {
957 send_streams = 0;
958 response.status = htobe32(LTTNG_VIEWER_NEW_STREAMS_ERR);
959 goto send_reply;
960 }
961
962 send_streams = 1;
963 response.status = htobe32(LTTNG_VIEWER_NEW_STREAMS_OK);
964
965 pthread_mutex_lock(&session->lock);
966 if (!conn->viewer_session->current_trace_chunk &&
967 session->current_trace_chunk) {
968 ret = viewer_session_set_trace_chunk(conn->viewer_session,
969 session->current_trace_chunk);
970 if (ret) {
971 goto error_unlock_session;
972 }
973 }
974 ret = make_viewer_streams(session,
975 conn->viewer_session->current_trace_chunk,
976 LTTNG_VIEWER_SEEK_LAST, &nb_total, &nb_unsent,
977 &nb_created, &closed);
978 if (ret < 0) {
979 goto error_unlock_session;
980 }
981 pthread_mutex_unlock(&session->lock);
982
983 /* Only send back the newly created streams with the unsent ones. */
984 nb_streams = nb_created + nb_unsent;
985 response.streams_count = htobe32(nb_streams);
986
987 /*
988 * If the session is closed, HUP when there are no more streams
989 * with data.
990 */
991 if (closed && nb_total == 0) {
992 send_streams = 0;
993 response.streams_count = 0;
994 response.status = htobe32(LTTNG_VIEWER_NEW_STREAMS_HUP);
995 goto send_reply;
996 }
997
998 send_reply:
999 health_code_update();
1000 ret = send_response(conn->sock, &response, sizeof(response));
1001 if (ret < 0) {
1002 goto end_put_session;
1003 }
1004 health_code_update();
1005
1006 /*
1007 * Unknown or empty session, just return gracefully, the viewer
1008 * knows what is happening.
1009 */
1010 if (!send_streams || !nb_streams) {
1011 ret = 0;
1012 goto end_put_session;
1013 }
1014
1015 /*
1016 * Send stream and *DON'T* ignore the sent flag so every viewer
1017 * streams that were not sent from that point will be sent to
1018 * the viewer.
1019 */
1020 ret = send_viewer_streams(conn->sock, session_id, 0);
1021 if (ret < 0) {
1022 goto end_put_session;
1023 }
1024
1025 end_put_session:
1026 if (session) {
1027 session_put(session);
1028 }
1029 error:
1030 return ret;
1031 error_unlock_session:
1032 pthread_mutex_unlock(&session->lock);
1033 session_put(session);
1034 return ret;
1035 }
1036
1037 /*
1038 * Send the viewer the list of current sessions.
1039 */
1040 static
1041 int viewer_attach_session(struct relay_connection *conn)
1042 {
1043 int send_streams = 0;
1044 ssize_t ret;
1045 uint32_t nb_streams = 0;
1046 enum lttng_viewer_seek seek_type;
1047 struct lttng_viewer_attach_session_request request;
1048 struct lttng_viewer_attach_session_response response;
1049 struct relay_session *session = NULL;
1050 bool closed = false;
1051 uint64_t session_id;
1052
1053 assert(conn);
1054
1055 health_code_update();
1056
1057 /* Receive the request from the connected client. */
1058 ret = recv_request(conn->sock, &request, sizeof(request));
1059 if (ret < 0) {
1060 goto error;
1061 }
1062
1063 session_id = be64toh(request.session_id);
1064 health_code_update();
1065
1066 memset(&response, 0, sizeof(response));
1067
1068 if (!conn->viewer_session) {
1069 DBG("Client trying to attach before creating a live viewer session");
1070 response.status = htobe32(LTTNG_VIEWER_ATTACH_NO_SESSION);
1071 goto send_reply;
1072 }
1073
1074 session = session_get_by_id(session_id);
1075 if (!session) {
1076 DBG("Relay session %" PRIu64 " not found", session_id);
1077 response.status = htobe32(LTTNG_VIEWER_ATTACH_UNK);
1078 goto send_reply;
1079 }
1080 DBG("Attach session ID %" PRIu64 " received", session_id);
1081
1082 pthread_mutex_lock(&session->lock);
1083 if (!session->current_trace_chunk) {
1084 /*
1085 * Session is either being destroyed or it never had a trace
1086 * chunk created against it.
1087 */
1088 DBG("Session requested by live client has no current trace chunk, returning unknown session");
1089 response.status = htobe32(LTTNG_VIEWER_ATTACH_UNK);
1090 goto send_reply;
1091 }
1092 if (session->live_timer == 0) {
1093 DBG("Not live session");
1094 response.status = htobe32(LTTNG_VIEWER_ATTACH_NOT_LIVE);
1095 goto send_reply;
1096 }
1097
1098 send_streams = 1;
1099 ret = viewer_session_attach(conn->viewer_session, session);
1100 if (ret) {
1101 DBG("Already a viewer attached");
1102 response.status = htobe32(LTTNG_VIEWER_ATTACH_ALREADY);
1103 goto send_reply;
1104 }
1105
1106 switch (be32toh(request.seek)) {
1107 case LTTNG_VIEWER_SEEK_BEGINNING:
1108 case LTTNG_VIEWER_SEEK_LAST:
1109 response.status = htobe32(LTTNG_VIEWER_ATTACH_OK);
1110 seek_type = be32toh(request.seek);
1111 break;
1112 default:
1113 ERR("Wrong seek parameter");
1114 response.status = htobe32(LTTNG_VIEWER_ATTACH_SEEK_ERR);
1115 send_streams = 0;
1116 goto send_reply;
1117 }
1118
1119 if (!conn->viewer_session->current_trace_chunk &&
1120 session->current_trace_chunk) {
1121 ret = viewer_session_set_trace_chunk(conn->viewer_session,
1122 session->current_trace_chunk);
1123 if (ret) {
1124 goto end_put_session;
1125 }
1126 }
1127 ret = make_viewer_streams(session,
1128 conn->viewer_session->current_trace_chunk, seek_type,
1129 &nb_streams, NULL, NULL, &closed);
1130 if (ret < 0) {
1131 goto end_put_session;
1132 }
1133 pthread_mutex_unlock(&session->lock);
1134 session_put(session);
1135 session = NULL;
1136
1137 response.streams_count = htobe32(nb_streams);
1138 /*
1139 * If the session is closed when the viewer is attaching, it
1140 * means some of the streams may have been concurrently removed,
1141 * so we don't allow the viewer to attach, even if there are
1142 * streams available.
1143 */
1144 if (closed) {
1145 send_streams = 0;
1146 response.streams_count = 0;
1147 response.status = htobe32(LTTNG_VIEWER_ATTACH_UNK);
1148 goto send_reply;
1149 }
1150
1151 send_reply:
1152 health_code_update();
1153 ret = send_response(conn->sock, &response, sizeof(response));
1154 if (ret < 0) {
1155 goto end_put_session;
1156 }
1157 health_code_update();
1158
1159 /*
1160 * Unknown or empty session, just return gracefully, the viewer
1161 * knows what is happening.
1162 */
1163 if (!send_streams || !nb_streams) {
1164 ret = 0;
1165 goto end_put_session;
1166 }
1167
1168 /* Send stream and ignore the sent flag. */
1169 ret = send_viewer_streams(conn->sock, session_id, 1);
1170 if (ret < 0) {
1171 goto end_put_session;
1172 }
1173
1174 end_put_session:
1175 if (session) {
1176 pthread_mutex_unlock(&session->lock);
1177 session_put(session);
1178 }
1179 error:
1180 return ret;
1181 }
1182
1183 /*
1184 * Open the index file if needed for the given vstream.
1185 *
1186 * If an index file is successfully opened, the vstream will set it as its
1187 * current index file.
1188 *
1189 * Return 0 on success, a negative value on error (-ENOENT if not ready yet).
1190 *
1191 * Called with rstream lock held.
1192 */
1193 static int try_open_index(struct relay_viewer_stream *vstream,
1194 struct relay_stream *rstream)
1195 {
1196 int ret = 0;
1197 const uint32_t connection_major = rstream->trace->session->major;
1198 const uint32_t connection_minor = rstream->trace->session->minor;
1199
1200 if (vstream->index_file) {
1201 goto end;
1202 }
1203
1204 /*
1205 * First time, we open the index file and at least one index is ready.
1206 */
1207 if (rstream->index_received_seqcount == 0) {
1208 ret = -ENOENT;
1209 goto end;
1210 }
1211 vstream->index_file = lttng_index_file_create_from_trace_chunk_read_only(
1212 vstream->stream_file.trace_chunk, rstream->path_name,
1213 rstream->channel_name, rstream->tracefile_size,
1214 vstream->current_tracefile_id,
1215 lttng_to_index_major(connection_major, connection_minor),
1216 lttng_to_index_minor(connection_major, connection_minor));
1217 if (!vstream->index_file) {
1218 ret = -1;
1219 }
1220
1221 end:
1222 return ret;
1223 }
1224
1225 /*
1226 * Check the status of the index for the given stream. This function
1227 * updates the index structure if needed and can put (close) the vstream
1228 * in the HUP situation.
1229 *
1230 * Return 0 means that we can proceed with the index. A value of 1 means
1231 * that the index has been updated and is ready to be sent to the
1232 * client. A negative value indicates an error that can't be handled.
1233 *
1234 * Called with rstream lock held.
1235 */
1236 static int check_index_status(struct relay_viewer_stream *vstream,
1237 struct relay_stream *rstream, struct ctf_trace *trace,
1238 struct lttng_viewer_index *index)
1239 {
1240 int ret;
1241
1242 if ((trace->session->connection_closed || rstream->closed)
1243 && rstream->index_received_seqcount
1244 == vstream->index_sent_seqcount) {
1245 /*
1246 * Last index sent and session connection or relay
1247 * stream are closed.
1248 */
1249 index->status = htobe32(LTTNG_VIEWER_INDEX_HUP);
1250 goto hup;
1251 } else if (rstream->beacon_ts_end != -1ULL &&
1252 rstream->index_received_seqcount
1253 == vstream->index_sent_seqcount) {
1254 /*
1255 * We've received a synchronization beacon and the last index
1256 * available has been sent, the index for now is inactive.
1257 *
1258 * In this case, we have received a beacon which allows us to
1259 * inform the client of a time interval during which we can
1260 * guarantee that there are no events to read (and never will
1261 * be).
1262 */
1263 index->status = htobe32(LTTNG_VIEWER_INDEX_INACTIVE);
1264 index->timestamp_end = htobe64(rstream->beacon_ts_end);
1265 index->stream_id = htobe64(rstream->ctf_stream_id);
1266 goto index_ready;
1267 } else if (rstream->index_received_seqcount
1268 == vstream->index_sent_seqcount) {
1269 /*
1270 * This checks whether received == sent seqcount. In
1271 * this case, we have not received a beacon. Therefore,
1272 * we can only ask the client to retry later.
1273 */
1274 index->status = htobe32(LTTNG_VIEWER_INDEX_RETRY);
1275 goto index_ready;
1276 } else if (!tracefile_array_seq_in_file(rstream->tfa,
1277 vstream->current_tracefile_id,
1278 vstream->index_sent_seqcount)) {
1279 /*
1280 * The next index we want to send cannot be read either
1281 * because we need to perform a rotation, or due to
1282 * the producer having overwritten its trace file.
1283 */
1284 DBG("Viewer stream %" PRIu64 " rotation",
1285 vstream->stream->stream_handle);
1286 ret = viewer_stream_rotate(vstream);
1287 if (ret < 0) {
1288 goto end;
1289 } else if (ret == 1) {
1290 /* EOF across entire stream. */
1291 index->status = htobe32(LTTNG_VIEWER_INDEX_HUP);
1292 goto hup;
1293 }
1294 /*
1295 * If we have been pushed due to overwrite, it
1296 * necessarily means there is data that can be read in
1297 * the stream. If we rotated because we reached the end
1298 * of a tracefile, it means the following tracefile
1299 * needs to contain at least one index, else we would
1300 * have already returned LTTNG_VIEWER_INDEX_RETRY to the
1301 * viewer. The updated index_sent_seqcount needs to
1302 * point to a readable index entry now.
1303 *
1304 * In the case where we "rotate" on a single file, we
1305 * can end up in a case where the requested index is
1306 * still unavailable.
1307 */
1308 if (rstream->tracefile_count == 1 &&
1309 !tracefile_array_seq_in_file(
1310 rstream->tfa,
1311 vstream->current_tracefile_id,
1312 vstream->index_sent_seqcount)) {
1313 index->status = htobe32(LTTNG_VIEWER_INDEX_RETRY);
1314 goto index_ready;
1315 }
1316 assert(tracefile_array_seq_in_file(rstream->tfa,
1317 vstream->current_tracefile_id,
1318 vstream->index_sent_seqcount));
1319 }
1320 /* ret == 0 means successful so we continue. */
1321 ret = 0;
1322 end:
1323 return ret;
1324
1325 hup:
1326 viewer_stream_put(vstream);
1327 index_ready:
1328 return 1;
1329 }
1330
1331 /*
1332 * Send the next index for a stream.
1333 *
1334 * Return 0 on success or else a negative value.
1335 */
1336 static
1337 int viewer_get_next_index(struct relay_connection *conn)
1338 {
1339 int ret;
1340 struct lttng_viewer_get_next_index request_index;
1341 struct lttng_viewer_index viewer_index;
1342 struct ctf_packet_index packet_index;
1343 struct relay_viewer_stream *vstream = NULL;
1344 struct relay_stream *rstream = NULL;
1345 struct ctf_trace *ctf_trace = NULL;
1346 struct relay_viewer_stream *metadata_viewer_stream = NULL;
1347
1348 assert(conn);
1349
1350 DBG("Viewer get next index");
1351
1352 memset(&viewer_index, 0, sizeof(viewer_index));
1353 health_code_update();
1354
1355 ret = recv_request(conn->sock, &request_index, sizeof(request_index));
1356 if (ret < 0) {
1357 goto end;
1358 }
1359 health_code_update();
1360
1361 vstream = viewer_stream_get_by_id(be64toh(request_index.stream_id));
1362 if (!vstream) {
1363 DBG("Client requested index of unknown stream id %" PRIu64,
1364 (uint64_t) be64toh(request_index.stream_id));
1365 viewer_index.status = htobe32(LTTNG_VIEWER_INDEX_ERR);
1366 goto send_reply;
1367 }
1368
1369 /* Use back. ref. Protected by refcounts. */
1370 rstream = vstream->stream;
1371 ctf_trace = rstream->trace;
1372
1373 /* metadata_viewer_stream may be NULL. */
1374 metadata_viewer_stream =
1375 ctf_trace_get_viewer_metadata_stream(ctf_trace);
1376
1377 pthread_mutex_lock(&rstream->lock);
1378
1379 /*
1380 * The viewer should not ask for index on metadata stream.
1381 */
1382 if (rstream->is_metadata) {
1383 viewer_index.status = htobe32(LTTNG_VIEWER_INDEX_HUP);
1384 goto send_reply;
1385 }
1386
1387 /* Try to open an index if one is needed for that stream. */
1388 ret = try_open_index(vstream, rstream);
1389 if (ret < 0) {
1390 if (ret == -ENOENT) {
1391 /*
1392 * The index is created only when the first data
1393 * packet arrives, it might not be ready at the
1394 * beginning of the session
1395 */
1396 viewer_index.status = htobe32(LTTNG_VIEWER_INDEX_RETRY);
1397 } else {
1398 /* Unhandled error. */
1399 viewer_index.status = htobe32(LTTNG_VIEWER_INDEX_ERR);
1400 }
1401 goto send_reply;
1402 }
1403
1404 ret = check_index_status(vstream, rstream, ctf_trace, &viewer_index);
1405 if (ret < 0) {
1406 goto error_put;
1407 } else if (ret == 1) {
1408 /*
1409 * We have no index to send and check_index_status has populated
1410 * viewer_index's status.
1411 */
1412 goto send_reply;
1413 }
1414 /* At this point, ret is 0 thus we will be able to read the index. */
1415 assert(!ret);
1416
1417 /*
1418 * vstream->stream_fd may be NULL if it has been closed by
1419 * tracefile rotation, or if we are at the beginning of the
1420 * stream. We open the data stream file here to protect against
1421 * overwrite caused by tracefile rotation (in association with
1422 * unlink performed before overwrite).
1423 */
1424 if (!vstream->stream_file.fd) {
1425 int fd;
1426 char file_path[LTTNG_PATH_MAX];
1427 enum lttng_trace_chunk_status status;
1428
1429 ret = utils_stream_file_path(rstream->path_name,
1430 rstream->channel_name, rstream->tracefile_size,
1431 vstream->current_tracefile_id, NULL, file_path,
1432 sizeof(file_path));
1433 if (ret < 0) {
1434 goto error_put;
1435 }
1436
1437 status = lttng_trace_chunk_open_file(
1438 vstream->stream_file.trace_chunk,
1439 file_path, O_RDONLY, 0, &fd);
1440 if (status != LTTNG_TRACE_CHUNK_STATUS_OK) {
1441 PERROR("Failed to open trace file for viewer stream");
1442 goto error_put;
1443 }
1444 vstream->stream_file.fd = stream_fd_create(fd);
1445 if (!vstream->stream_file.fd) {
1446 if (close(fd)) {
1447 PERROR("Failed to close viewer stream file");
1448 }
1449 goto error_put;
1450 }
1451 }
1452
1453 ret = check_new_streams(conn);
1454 if (ret < 0) {
1455 viewer_index.status = htobe32(LTTNG_VIEWER_INDEX_ERR);
1456 goto send_reply;
1457 } else if (ret == 1) {
1458 viewer_index.flags |= LTTNG_VIEWER_FLAG_NEW_STREAM;
1459 }
1460
1461 ret = lttng_index_file_read(vstream->index_file, &packet_index);
1462 if (ret) {
1463 ERR("Relay error reading index file %d",
1464 vstream->index_file->fd);
1465 viewer_index.status = htobe32(LTTNG_VIEWER_INDEX_ERR);
1466 goto send_reply;
1467 } else {
1468 viewer_index.status = htobe32(LTTNG_VIEWER_INDEX_OK);
1469 vstream->index_sent_seqcount++;
1470 }
1471
1472 /*
1473 * Indexes are stored in big endian, no need to switch before sending.
1474 */
1475 DBG("Sending viewer index for stream %" PRIu64 " offset %" PRIu64,
1476 rstream->stream_handle,
1477 (uint64_t) be64toh(packet_index.offset));
1478 viewer_index.offset = packet_index.offset;
1479 viewer_index.packet_size = packet_index.packet_size;
1480 viewer_index.content_size = packet_index.content_size;
1481 viewer_index.timestamp_begin = packet_index.timestamp_begin;
1482 viewer_index.timestamp_end = packet_index.timestamp_end;
1483 viewer_index.events_discarded = packet_index.events_discarded;
1484 viewer_index.stream_id = packet_index.stream_id;
1485
1486 send_reply:
1487 if (rstream) {
1488 pthread_mutex_unlock(&rstream->lock);
1489 }
1490
1491 if (metadata_viewer_stream) {
1492 pthread_mutex_lock(&metadata_viewer_stream->stream->lock);
1493 DBG("get next index metadata check: recv %" PRIu64
1494 " sent %" PRIu64,
1495 metadata_viewer_stream->stream->metadata_received,
1496 metadata_viewer_stream->metadata_sent);
1497 if (!metadata_viewer_stream->stream->metadata_received ||
1498 metadata_viewer_stream->stream->metadata_received >
1499 metadata_viewer_stream->metadata_sent) {
1500 viewer_index.flags |= LTTNG_VIEWER_FLAG_NEW_METADATA;
1501 }
1502 pthread_mutex_unlock(&metadata_viewer_stream->stream->lock);
1503 }
1504
1505 viewer_index.flags = htobe32(viewer_index.flags);
1506 health_code_update();
1507
1508 ret = send_response(conn->sock, &viewer_index, sizeof(viewer_index));
1509 if (ret < 0) {
1510 goto end;
1511 }
1512 health_code_update();
1513
1514 if (vstream) {
1515 DBG("Index %" PRIu64 " for stream %" PRIu64 " sent",
1516 vstream->index_sent_seqcount,
1517 vstream->stream->stream_handle);
1518 }
1519 end:
1520 if (metadata_viewer_stream) {
1521 viewer_stream_put(metadata_viewer_stream);
1522 }
1523 if (vstream) {
1524 viewer_stream_put(vstream);
1525 }
1526 return ret;
1527
1528 error_put:
1529 pthread_mutex_unlock(&rstream->lock);
1530 if (metadata_viewer_stream) {
1531 viewer_stream_put(metadata_viewer_stream);
1532 }
1533 viewer_stream_put(vstream);
1534 return ret;
1535 }
1536
1537 /*
1538 * Send the next index for a stream
1539 *
1540 * Return 0 on success or else a negative value.
1541 */
1542 static
1543 int viewer_get_packet(struct relay_connection *conn)
1544 {
1545 int ret;
1546 off_t lseek_ret;
1547 char *reply = NULL;
1548 struct lttng_viewer_get_packet get_packet_info;
1549 struct lttng_viewer_trace_packet reply_header;
1550 struct relay_viewer_stream *vstream = NULL;
1551 uint32_t reply_size = sizeof(reply_header);
1552 uint32_t packet_data_len = 0;
1553 ssize_t read_len;
1554
1555 DBG2("Relay get data packet");
1556
1557 health_code_update();
1558
1559 ret = recv_request(conn->sock, &get_packet_info,
1560 sizeof(get_packet_info));
1561 if (ret < 0) {
1562 goto end;
1563 }
1564 health_code_update();
1565
1566 /* From this point on, the error label can be reached. */
1567 memset(&reply_header, 0, sizeof(reply_header));
1568
1569 vstream = viewer_stream_get_by_id(be64toh(get_packet_info.stream_id));
1570 if (!vstream) {
1571 DBG("Client requested packet of unknown stream id %" PRIu64,
1572 (uint64_t) be64toh(get_packet_info.stream_id));
1573 reply_header.status = htobe32(LTTNG_VIEWER_GET_PACKET_ERR);
1574 goto send_reply_nolock;
1575 } else {
1576 packet_data_len = be32toh(get_packet_info.len);
1577 reply_size += packet_data_len;
1578 }
1579
1580 reply = zmalloc(reply_size);
1581 if (!reply) {
1582 PERROR("packet reply zmalloc");
1583 reply_size = sizeof(reply_header);
1584 goto error;
1585 }
1586
1587 pthread_mutex_lock(&vstream->stream->lock);
1588 lseek_ret = lseek(vstream->stream_file.fd->fd,
1589 be64toh(get_packet_info.offset), SEEK_SET);
1590 if (lseek_ret < 0) {
1591 PERROR("lseek fd %d to offset %" PRIu64,
1592 vstream->stream_file.fd->fd,
1593 (uint64_t) be64toh(get_packet_info.offset));
1594 goto error;
1595 }
1596 read_len = lttng_read(vstream->stream_file.fd->fd,
1597 reply + sizeof(reply_header), packet_data_len);
1598 if (read_len < packet_data_len) {
1599 PERROR("Relay reading trace file, fd: %d, offset: %" PRIu64,
1600 vstream->stream_file.fd->fd,
1601 (uint64_t) be64toh(get_packet_info.offset));
1602 goto error;
1603 }
1604 reply_header.status = htobe32(LTTNG_VIEWER_GET_PACKET_OK);
1605 reply_header.len = htobe32(packet_data_len);
1606 goto send_reply;
1607
1608 error:
1609 reply_header.status = htobe32(LTTNG_VIEWER_GET_PACKET_ERR);
1610
1611 send_reply:
1612 if (vstream) {
1613 pthread_mutex_unlock(&vstream->stream->lock);
1614 }
1615 send_reply_nolock:
1616
1617 health_code_update();
1618
1619 if (reply) {
1620 memcpy(reply, &reply_header, sizeof(reply_header));
1621 ret = send_response(conn->sock, reply, reply_size);
1622 } else {
1623 /* No reply to send. */
1624 ret = send_response(conn->sock, &reply_header,
1625 reply_size);
1626 }
1627
1628 health_code_update();
1629 if (ret < 0) {
1630 PERROR("sendmsg of packet data failed");
1631 goto end_free;
1632 }
1633
1634 DBG("Sent %u bytes for stream %" PRIu64, reply_size,
1635 (uint64_t) be64toh(get_packet_info.stream_id));
1636
1637 end_free:
1638 free(reply);
1639 end:
1640 if (vstream) {
1641 viewer_stream_put(vstream);
1642 }
1643 return ret;
1644 }
1645
1646 /*
1647 * Send the session's metadata
1648 *
1649 * Return 0 on success else a negative value.
1650 */
1651 static
1652 int viewer_get_metadata(struct relay_connection *conn)
1653 {
1654 int ret = 0;
1655 ssize_t read_len;
1656 uint64_t len = 0;
1657 char *data = NULL;
1658 struct lttng_viewer_get_metadata request;
1659 struct lttng_viewer_metadata_packet reply;
1660 struct relay_viewer_stream *vstream = NULL;
1661
1662 assert(conn);
1663
1664 DBG("Relay get metadata");
1665
1666 health_code_update();
1667
1668 ret = recv_request(conn->sock, &request, sizeof(request));
1669 if (ret < 0) {
1670 goto end;
1671 }
1672 health_code_update();
1673
1674 memset(&reply, 0, sizeof(reply));
1675
1676 vstream = viewer_stream_get_by_id(be64toh(request.stream_id));
1677 if (!vstream) {
1678 /*
1679 * The metadata stream can be closed by a CLOSE command
1680 * just before we attach. It can also be closed by
1681 * per-pid tracing during tracing. Therefore, it is
1682 * possible that we cannot find this viewer stream.
1683 * Reply back to the client with an error if we cannot
1684 * find it.
1685 */
1686 DBG("Client requested metadata of unknown stream id %" PRIu64,
1687 (uint64_t) be64toh(request.stream_id));
1688 reply.status = htobe32(LTTNG_VIEWER_METADATA_ERR);
1689 goto send_reply;
1690 }
1691 pthread_mutex_lock(&vstream->stream->lock);
1692 if (!vstream->stream->is_metadata) {
1693 ERR("Invalid metadata stream");
1694 goto error;
1695 }
1696
1697 assert(vstream->metadata_sent <= vstream->stream->metadata_received);
1698
1699 len = vstream->stream->metadata_received - vstream->metadata_sent;
1700 if (len == 0) {
1701 reply.status = htobe32(LTTNG_VIEWER_NO_NEW_METADATA);
1702 goto send_reply;
1703 }
1704
1705 /* first time, we open the metadata file */
1706 if (!vstream->stream_file.fd) {
1707 int fd;
1708 char file_path[LTTNG_PATH_MAX];
1709 enum lttng_trace_chunk_status status;
1710 struct relay_stream *rstream = vstream->stream;
1711
1712 ret = utils_stream_file_path(rstream->path_name,
1713 rstream->channel_name, rstream->tracefile_size,
1714 vstream->current_tracefile_id, NULL, file_path,
1715 sizeof(file_path));
1716 if (ret < 0) {
1717 goto error;
1718 }
1719
1720 status = lttng_trace_chunk_open_file(
1721 vstream->stream_file.trace_chunk,
1722 file_path, O_RDONLY, 0, &fd);
1723 if (status != LTTNG_TRACE_CHUNK_STATUS_OK) {
1724 PERROR("Failed to open metadata file for viewer stream");
1725 goto error;
1726 }
1727 vstream->stream_file.fd = stream_fd_create(fd);
1728 if (!vstream->stream_file.fd) {
1729 if (close(fd)) {
1730 PERROR("Failed to close viewer metadata file");
1731 }
1732 goto error;
1733 }
1734 }
1735
1736 reply.len = htobe64(len);
1737 data = zmalloc(len);
1738 if (!data) {
1739 PERROR("viewer metadata zmalloc");
1740 goto error;
1741 }
1742
1743 read_len = lttng_read(vstream->stream_file.fd->fd, data, len);
1744 if (read_len < len) {
1745 PERROR("Relay reading metadata file");
1746 goto error;
1747 }
1748 vstream->metadata_sent += read_len;
1749 if (vstream->metadata_sent == vstream->stream->metadata_received
1750 && vstream->stream->closed) {
1751 /* Release ownership for the viewer metadata stream. */
1752 viewer_stream_put(vstream);
1753 }
1754
1755 reply.status = htobe32(LTTNG_VIEWER_METADATA_OK);
1756
1757 goto send_reply;
1758
1759 error:
1760 reply.status = htobe32(LTTNG_VIEWER_METADATA_ERR);
1761
1762 send_reply:
1763 health_code_update();
1764 if (vstream) {
1765 pthread_mutex_unlock(&vstream->stream->lock);
1766 }
1767 ret = send_response(conn->sock, &reply, sizeof(reply));
1768 if (ret < 0) {
1769 goto end_free;
1770 }
1771 health_code_update();
1772
1773 if (len > 0) {
1774 ret = send_response(conn->sock, data, len);
1775 if (ret < 0) {
1776 goto end_free;
1777 }
1778 }
1779
1780 DBG("Sent %" PRIu64 " bytes of metadata for stream %" PRIu64, len,
1781 (uint64_t) be64toh(request.stream_id));
1782
1783 DBG("Metadata sent");
1784
1785 end_free:
1786 free(data);
1787 end:
1788 if (vstream) {
1789 viewer_stream_put(vstream);
1790 }
1791 return ret;
1792 }
1793
1794 /*
1795 * Create a viewer session.
1796 *
1797 * Return 0 on success or else a negative value.
1798 */
1799 static
1800 int viewer_create_session(struct relay_connection *conn)
1801 {
1802 int ret;
1803 struct lttng_viewer_create_session_response resp;
1804
1805 DBG("Viewer create session received");
1806
1807 memset(&resp, 0, sizeof(resp));
1808 resp.status = htobe32(LTTNG_VIEWER_CREATE_SESSION_OK);
1809 conn->viewer_session = viewer_session_create();
1810 if (!conn->viewer_session) {
1811 ERR("Allocation viewer session");
1812 resp.status = htobe32(LTTNG_VIEWER_CREATE_SESSION_ERR);
1813 goto send_reply;
1814 }
1815
1816 send_reply:
1817 health_code_update();
1818 ret = send_response(conn->sock, &resp, sizeof(resp));
1819 if (ret < 0) {
1820 goto end;
1821 }
1822 health_code_update();
1823 ret = 0;
1824
1825 end:
1826 return ret;
1827 }
1828
1829 /*
1830 * Detach a viewer session.
1831 *
1832 * Return 0 on success or else a negative value.
1833 */
1834 static
1835 int viewer_detach_session(struct relay_connection *conn)
1836 {
1837 int ret;
1838 struct lttng_viewer_detach_session_response response;
1839 struct lttng_viewer_detach_session_request request;
1840 struct relay_session *session = NULL;
1841 uint64_t viewer_session_to_close;
1842
1843 DBG("Viewer detach session received");
1844
1845 assert(conn);
1846
1847 health_code_update();
1848
1849 /* Receive the request from the connected client. */
1850 ret = recv_request(conn->sock, &request, sizeof(request));
1851 if (ret < 0) {
1852 goto end;
1853 }
1854 viewer_session_to_close = be64toh(request.session_id);
1855
1856 if (!conn->viewer_session) {
1857 DBG("Client trying to detach before creating a live viewer session");
1858 response.status = htobe32(LTTNG_VIEWER_DETACH_SESSION_ERR);
1859 goto send_reply;
1860 }
1861
1862 health_code_update();
1863
1864 memset(&response, 0, sizeof(response));
1865 DBG("Detaching from session ID %" PRIu64, viewer_session_to_close);
1866
1867 session = session_get_by_id(be64toh(request.session_id));
1868 if (!session) {
1869 DBG("Relay session %" PRIu64 " not found",
1870 (uint64_t) be64toh(request.session_id));
1871 response.status = htobe32(LTTNG_VIEWER_DETACH_SESSION_UNK);
1872 goto send_reply;
1873 }
1874
1875 ret = viewer_session_is_attached(conn->viewer_session, session);
1876 if (ret != 1) {
1877 DBG("Not attached to this session");
1878 response.status = htobe32(LTTNG_VIEWER_DETACH_SESSION_ERR);
1879 goto send_reply_put;
1880 }
1881
1882 viewer_session_close_one_session(conn->viewer_session, session);
1883 response.status = htobe32(LTTNG_VIEWER_DETACH_SESSION_OK);
1884 DBG("Session %" PRIu64 " detached.", viewer_session_to_close);
1885
1886 send_reply_put:
1887 session_put(session);
1888
1889 send_reply:
1890 health_code_update();
1891 ret = send_response(conn->sock, &response, sizeof(response));
1892 if (ret < 0) {
1893 goto end;
1894 }
1895 health_code_update();
1896 ret = 0;
1897
1898 end:
1899 return ret;
1900 }
1901
1902 /*
1903 * live_relay_unknown_command: send -1 if received unknown command
1904 */
1905 static
1906 void live_relay_unknown_command(struct relay_connection *conn)
1907 {
1908 struct lttcomm_relayd_generic_reply reply;
1909
1910 memset(&reply, 0, sizeof(reply));
1911 reply.ret_code = htobe32(LTTNG_ERR_UNK);
1912 (void) send_response(conn->sock, &reply, sizeof(reply));
1913 }
1914
1915 /*
1916 * Process the commands received on the control socket
1917 */
1918 static
1919 int process_control(struct lttng_viewer_cmd *recv_hdr,
1920 struct relay_connection *conn)
1921 {
1922 int ret = 0;
1923 uint32_t msg_value;
1924
1925 msg_value = be32toh(recv_hdr->cmd);
1926
1927 /*
1928 * Make sure we've done the version check before any command other then a
1929 * new client connection.
1930 */
1931 if (msg_value != LTTNG_VIEWER_CONNECT && !conn->version_check_done) {
1932 ERR("Viewer conn value %" PRIu32 " before version check", msg_value);
1933 ret = -1;
1934 goto end;
1935 }
1936
1937 switch (msg_value) {
1938 case LTTNG_VIEWER_CONNECT:
1939 ret = viewer_connect(conn);
1940 break;
1941 case LTTNG_VIEWER_LIST_SESSIONS:
1942 ret = viewer_list_sessions(conn);
1943 break;
1944 case LTTNG_VIEWER_ATTACH_SESSION:
1945 ret = viewer_attach_session(conn);
1946 break;
1947 case LTTNG_VIEWER_GET_NEXT_INDEX:
1948 ret = viewer_get_next_index(conn);
1949 break;
1950 case LTTNG_VIEWER_GET_PACKET:
1951 ret = viewer_get_packet(conn);
1952 break;
1953 case LTTNG_VIEWER_GET_METADATA:
1954 ret = viewer_get_metadata(conn);
1955 break;
1956 case LTTNG_VIEWER_GET_NEW_STREAMS:
1957 ret = viewer_get_new_streams(conn);
1958 break;
1959 case LTTNG_VIEWER_CREATE_SESSION:
1960 ret = viewer_create_session(conn);
1961 break;
1962 case LTTNG_VIEWER_DETACH_SESSION:
1963 ret = viewer_detach_session(conn);
1964 break;
1965 default:
1966 ERR("Received unknown viewer command (%u)",
1967 be32toh(recv_hdr->cmd));
1968 live_relay_unknown_command(conn);
1969 ret = -1;
1970 goto end;
1971 }
1972
1973 end:
1974 return ret;
1975 }
1976
1977 static
1978 void cleanup_connection_pollfd(struct lttng_poll_event *events, int pollfd)
1979 {
1980 int ret;
1981
1982 (void) lttng_poll_del(events, pollfd);
1983
1984 ret = close(pollfd);
1985 if (ret < 0) {
1986 ERR("Closing pollfd %d", pollfd);
1987 }
1988 }
1989
1990 /*
1991 * This thread does the actual work
1992 */
1993 static
1994 void *thread_worker(void *data)
1995 {
1996 int ret, err = -1;
1997 uint32_t nb_fd;
1998 struct lttng_poll_event events;
1999 struct lttng_ht *viewer_connections_ht;
2000 struct lttng_ht_iter iter;
2001 struct lttng_viewer_cmd recv_hdr;
2002 struct relay_connection *destroy_conn;
2003
2004 DBG("[thread] Live viewer relay worker started");
2005
2006 rcu_register_thread();
2007
2008 health_register(health_relayd, HEALTH_RELAYD_TYPE_LIVE_WORKER);
2009
2010 if (testpoint(relayd_thread_live_worker)) {
2011 goto error_testpoint;
2012 }
2013
2014 /* table of connections indexed on socket */
2015 viewer_connections_ht = lttng_ht_new(0, LTTNG_HT_TYPE_ULONG);
2016 if (!viewer_connections_ht) {
2017 goto viewer_connections_ht_error;
2018 }
2019
2020 ret = create_thread_poll_set(&events, 2);
2021 if (ret < 0) {
2022 goto error_poll_create;
2023 }
2024
2025 ret = lttng_poll_add(&events, live_conn_pipe[0], LPOLLIN | LPOLLRDHUP);
2026 if (ret < 0) {
2027 goto error;
2028 }
2029
2030 restart:
2031 while (1) {
2032 int i;
2033
2034 health_code_update();
2035
2036 /* Infinite blocking call, waiting for transmission */
2037 DBG3("Relayd live viewer worker thread polling...");
2038 health_poll_entry();
2039 ret = lttng_poll_wait(&events, -1);
2040 health_poll_exit();
2041 if (ret < 0) {
2042 /*
2043 * Restart interrupted system call.
2044 */
2045 if (errno == EINTR) {
2046 goto restart;
2047 }
2048 goto error;
2049 }
2050
2051 nb_fd = ret;
2052
2053 /*
2054 * Process control. The control connection is prioritised so we don't
2055 * starve it with high throughput tracing data on the data
2056 * connection.
2057 */
2058 for (i = 0; i < nb_fd; i++) {
2059 /* Fetch once the poll data */
2060 uint32_t revents = LTTNG_POLL_GETEV(&events, i);
2061 int pollfd = LTTNG_POLL_GETFD(&events, i);
2062
2063 health_code_update();
2064
2065 /* Thread quit pipe has been closed. Killing thread. */
2066 ret = check_thread_quit_pipe(pollfd, revents);
2067 if (ret) {
2068 err = 0;
2069 goto exit;
2070 }
2071
2072 /* Inspect the relay conn pipe for new connection. */
2073 if (pollfd == live_conn_pipe[0]) {
2074 if (revents & LPOLLIN) {
2075 struct relay_connection *conn;
2076
2077 ret = lttng_read(live_conn_pipe[0],
2078 &conn, sizeof(conn));
2079 if (ret < 0) {
2080 goto error;
2081 }
2082 ret = lttng_poll_add(&events,
2083 conn->sock->fd,
2084 LPOLLIN | LPOLLRDHUP);
2085 if (ret) {
2086 ERR("Failed to add new live connection file descriptor to poll set");
2087 goto error;
2088 }
2089 connection_ht_add(viewer_connections_ht, conn);
2090 DBG("Connection socket %d added to poll", conn->sock->fd);
2091 } else if (revents & (LPOLLERR | LPOLLHUP | LPOLLRDHUP)) {
2092 ERR("Relay live pipe error");
2093 goto error;
2094 } else {
2095 ERR("Unexpected poll events %u for sock %d", revents, pollfd);
2096 goto error;
2097 }
2098 } else {
2099 /* Connection activity. */
2100 struct relay_connection *conn;
2101
2102 conn = connection_get_by_sock(viewer_connections_ht, pollfd);
2103 if (!conn) {
2104 continue;
2105 }
2106
2107 if (revents & LPOLLIN) {
2108 ret = conn->sock->ops->recvmsg(conn->sock, &recv_hdr,
2109 sizeof(recv_hdr), 0);
2110 if (ret <= 0) {
2111 /* Connection closed. */
2112 cleanup_connection_pollfd(&events, pollfd);
2113 /* Put "create" ownership reference. */
2114 connection_put(conn);
2115 DBG("Viewer control conn closed with %d", pollfd);
2116 } else {
2117 ret = process_control(&recv_hdr, conn);
2118 if (ret < 0) {
2119 /* Clear the session on error. */
2120 cleanup_connection_pollfd(&events, pollfd);
2121 /* Put "create" ownership reference. */
2122 connection_put(conn);
2123 DBG("Viewer connection closed with %d", pollfd);
2124 }
2125 }
2126 } else if (revents & (LPOLLERR | LPOLLHUP | LPOLLRDHUP)) {
2127 cleanup_connection_pollfd(&events, pollfd);
2128 /* Put "create" ownership reference. */
2129 connection_put(conn);
2130 } else {
2131 ERR("Unexpected poll events %u for sock %d", revents, pollfd);
2132 connection_put(conn);
2133 goto error;
2134 }
2135 /* Put local "get_by_sock" reference. */
2136 connection_put(conn);
2137 }
2138 }
2139 }
2140
2141 exit:
2142 error:
2143 lttng_poll_clean(&events);
2144
2145 /* Cleanup remaining connection object. */
2146 rcu_read_lock();
2147 cds_lfht_for_each_entry(viewer_connections_ht->ht, &iter.iter,
2148 destroy_conn,
2149 sock_n.node) {
2150 health_code_update();
2151 connection_put(destroy_conn);
2152 }
2153 rcu_read_unlock();
2154 error_poll_create:
2155 lttng_ht_destroy(viewer_connections_ht);
2156 viewer_connections_ht_error:
2157 /* Close relay conn pipes */
2158 utils_close_pipe(live_conn_pipe);
2159 if (err) {
2160 DBG("Viewer worker thread exited with error");
2161 }
2162 DBG("Viewer worker thread cleanup complete");
2163 error_testpoint:
2164 if (err) {
2165 health_error();
2166 ERR("Health error occurred in %s", __func__);
2167 }
2168 health_unregister(health_relayd);
2169 if (lttng_relay_stop_threads()) {
2170 ERR("Error stopping threads");
2171 }
2172 rcu_unregister_thread();
2173 return NULL;
2174 }
2175
2176 /*
2177 * Create the relay command pipe to wake thread_manage_apps.
2178 * Closed in cleanup().
2179 */
2180 static int create_conn_pipe(void)
2181 {
2182 return utils_create_pipe_cloexec(live_conn_pipe);
2183 }
2184
2185 int relayd_live_join(void)
2186 {
2187 int ret, retval = 0;
2188 void *status;
2189
2190 ret = pthread_join(live_listener_thread, &status);
2191 if (ret) {
2192 errno = ret;
2193 PERROR("pthread_join live listener");
2194 retval = -1;
2195 }
2196
2197 ret = pthread_join(live_worker_thread, &status);
2198 if (ret) {
2199 errno = ret;
2200 PERROR("pthread_join live worker");
2201 retval = -1;
2202 }
2203
2204 ret = pthread_join(live_dispatcher_thread, &status);
2205 if (ret) {
2206 errno = ret;
2207 PERROR("pthread_join live dispatcher");
2208 retval = -1;
2209 }
2210
2211 cleanup_relayd_live();
2212
2213 return retval;
2214 }
2215
2216 /*
2217 * main
2218 */
2219 int relayd_live_create(struct lttng_uri *uri)
2220 {
2221 int ret = 0, retval = 0;
2222 void *status;
2223 int is_root;
2224
2225 if (!uri) {
2226 retval = -1;
2227 goto exit_init_data;
2228 }
2229 live_uri = uri;
2230
2231 /* Check if daemon is UID = 0 */
2232 is_root = !getuid();
2233
2234 if (!is_root) {
2235 if (live_uri->port < 1024) {
2236 ERR("Need to be root to use ports < 1024");
2237 retval = -1;
2238 goto exit_init_data;
2239 }
2240 }
2241
2242 /* Setup the thread apps communication pipe. */
2243 if (create_conn_pipe()) {
2244 retval = -1;
2245 goto exit_init_data;
2246 }
2247
2248 /* Init relay command queue. */
2249 cds_wfcq_init(&viewer_conn_queue.head, &viewer_conn_queue.tail);
2250
2251 /* Set up max poll set size */
2252 if (lttng_poll_set_max_size()) {
2253 retval = -1;
2254 goto exit_init_data;
2255 }
2256
2257 /* Setup the dispatcher thread */
2258 ret = pthread_create(&live_dispatcher_thread, default_pthread_attr(),
2259 thread_dispatcher, (void *) NULL);
2260 if (ret) {
2261 errno = ret;
2262 PERROR("pthread_create viewer dispatcher");
2263 retval = -1;
2264 goto exit_dispatcher_thread;
2265 }
2266
2267 /* Setup the worker thread */
2268 ret = pthread_create(&live_worker_thread, default_pthread_attr(),
2269 thread_worker, NULL);
2270 if (ret) {
2271 errno = ret;
2272 PERROR("pthread_create viewer worker");
2273 retval = -1;
2274 goto exit_worker_thread;
2275 }
2276
2277 /* Setup the listener thread */
2278 ret = pthread_create(&live_listener_thread, default_pthread_attr(),
2279 thread_listener, (void *) NULL);
2280 if (ret) {
2281 errno = ret;
2282 PERROR("pthread_create viewer listener");
2283 retval = -1;
2284 goto exit_listener_thread;
2285 }
2286
2287 /*
2288 * All OK, started all threads.
2289 */
2290 return retval;
2291
2292 /*
2293 * Join on the live_listener_thread should anything be added after
2294 * the live_listener thread's creation.
2295 */
2296
2297 exit_listener_thread:
2298
2299 ret = pthread_join(live_worker_thread, &status);
2300 if (ret) {
2301 errno = ret;
2302 PERROR("pthread_join live worker");
2303 retval = -1;
2304 }
2305 exit_worker_thread:
2306
2307 ret = pthread_join(live_dispatcher_thread, &status);
2308 if (ret) {
2309 errno = ret;
2310 PERROR("pthread_join live dispatcher");
2311 retval = -1;
2312 }
2313 exit_dispatcher_thread:
2314
2315 exit_init_data:
2316 cleanup_relayd_live();
2317
2318 return retval;
2319 }
This page took 0.118078 seconds and 6 git commands to generate.