/* SPDX-License-Identifier: LGPL-2.1-or-later */ #include "analyze.h" #include "analyze-plot.h" #include "analyze-time-data.h" #include "bus-error.h" #include "bus-map-properties.h" #include "format-table.h" #include "os-util.h" #include "sort-util.h" #include "version.h" #define SCALE_X (0.1 / 1000.0) /* pixels per us */ #define SCALE_Y (20.0) #define svg(...) printf(__VA_ARGS__) #define svg_bar(class, x1, x2, y) \ svg(" \n", \ (class), \ SCALE_X * (x1), SCALE_Y * (y), \ SCALE_X * ((x2) - (x1)), SCALE_Y - 1.0) #define svg_text(b, x, y, format, ...) \ do { \ svg(" ", (b) ? "left" : "right", SCALE_X * (x) + (b ? 5.0 : -5.0), SCALE_Y * (y) + 14.0); \ svg(format, ## __VA_ARGS__); \ svg("\n"); \ } while (false) typedef struct HostInfo { char *hostname; char *kernel_name; char *kernel_release; char *kernel_version; char *os_pretty_name; char *virtualization; char *architecture; } HostInfo; static HostInfo *free_host_info(HostInfo *hi) { if (!hi) return NULL; free(hi->hostname); free(hi->kernel_name); free(hi->kernel_release); free(hi->kernel_version); free(hi->os_pretty_name); free(hi->virtualization); free(hi->architecture); return mfree(hi); } DEFINE_TRIVIAL_CLEANUP_FUNC(HostInfo *, free_host_info); static int acquire_host_info(sd_bus *bus, HostInfo **hi) { static const struct bus_properties_map hostname_map[] = { { "Hostname", "s", NULL, offsetof(HostInfo, hostname) }, { "KernelName", "s", NULL, offsetof(HostInfo, kernel_name) }, { "KernelRelease", "s", NULL, offsetof(HostInfo, kernel_release) }, { "KernelVersion", "s", NULL, offsetof(HostInfo, kernel_version) }, { "OperatingSystemPrettyName", "s", NULL, offsetof(HostInfo, os_pretty_name) }, {} }; static const struct bus_properties_map manager_map[] = { { "Virtualization", "s", NULL, offsetof(HostInfo, virtualization) }, { "Architecture", "s", NULL, offsetof(HostInfo, architecture) }, {} }; _cleanup_(sd_bus_error_free) sd_bus_error error = SD_BUS_ERROR_NULL; _cleanup_(sd_bus_flush_close_unrefp) sd_bus *system_bus = NULL; _cleanup_(free_host_infop) HostInfo *host = NULL; int r; host = new0(HostInfo, 1); if (!host) return log_oom(); if (arg_runtime_scope != RUNTIME_SCOPE_SYSTEM) { r = bus_connect_transport(arg_transport, arg_host, RUNTIME_SCOPE_SYSTEM, &system_bus); if (r < 0) { log_debug_errno(r, "Failed to connect to system bus, ignoring: %m"); goto manager; } } r = bus_map_all_properties( system_bus ?: bus, "org.freedesktop.hostname1", "/org/freedesktop/hostname1", hostname_map, BUS_MAP_STRDUP, &error, NULL, host); if (r < 0) { log_debug_errno(r, "Failed to get host information from systemd-hostnamed, ignoring: %s", bus_error_message(&error, r)); sd_bus_error_free(&error); } manager: r = bus_map_all_properties( bus, "org.freedesktop.systemd1", "/org/freedesktop/systemd1", manager_map, BUS_MAP_STRDUP, &error, NULL, host); if (r < 0) return log_error_errno(r, "Failed to get host information from systemd: %s", bus_error_message(&error, r)); *hi = TAKE_PTR(host); return 0; } static int compare_unit_start(const UnitTimes *a, const UnitTimes *b) { return CMP(a->activating, b->activating); } static void svg_graph_box(double height, double begin, double end) { /* outside box, fill */ svg("\n", SCALE_X * (end - begin), SCALE_Y * height); for (long long i = ((long long) (begin / 100000)) * 100000; i <= end; i += 100000) { /* lines for each second */ if (i % 5000000 == 0) svg(" \n" " %.01fs\n", SCALE_X * i, SCALE_X * i, SCALE_Y * height, SCALE_X * i, -5.0, 0.000001 * i); else if (i % 1000000 == 0) svg(" \n" " %.01fs\n", SCALE_X * i, SCALE_X * i, SCALE_Y * height, SCALE_X * i, -5.0, 0.000001 * i); else svg(" \n", SCALE_X * i, SCALE_X * i, SCALE_Y * height); } } static int plot_unit_times(UnitTimes *u, double width, int y) { bool b; if (!u->name) return 0; svg_bar("activating", u->activating, u->activated, y); svg_bar("active", u->activated, u->deactivating, y); svg_bar("deactivating", u->deactivating, u->deactivated, y); /* place the text on the left if we have passed the half of the svg width */ b = u->activating * SCALE_X < width / 2; if (u->time) svg_text(b, u->activating, y, "%s (%s)", u->name, FORMAT_TIMESPAN(u->time, USEC_PER_MSEC)); else svg_text(b, u->activating, y, "%s", u->name); return 1; } static void limit_times_to_boot(const BootTimes *boot, UnitTimes *u) { if (u->deactivated > u->activating && u->deactivated <= boot->finish_time && u->activated == 0 && u->deactivating == 0) u->activated = u->deactivating = u->deactivated; if (u->activated < u->activating || u->activated > boot->finish_time) u->activated = boot->finish_time; if (u->deactivating < u->activated || u->deactivating > boot->finish_time) u->deactivating = boot->finish_time; if (u->deactivated < u->deactivating || u->deactivated > boot->finish_time) u->deactivated = boot->finish_time; } static int produce_plot_as_svg( UnitTimes *times, const HostInfo *host, const BootTimes *boot, const char *pretty_times) { int m = 1, y = 0; UnitTimes *u; double width; width = SCALE_X * (boot->firmware_time + boot->finish_time); if (width < 800.0) width = 800.0; if (boot->firmware_time > boot->loader_time) m++; if (timestamp_is_set(boot->loader_time)) { m++; if (width < 1000.0) width = 1000.0; } if (timestamp_is_set(boot->initrd_time)) m++; if (timestamp_is_set(boot->kernel_done_time)) m++; for (u = times; u->has_data; u++) { double text_start, text_width; if (u->activating > boot->finish_time) { u->name = mfree(u->name); continue; } /* If the text cannot fit on the left side then * increase the svg width so it fits on the right. * TODO: calculate the text width more accurately */ text_width = 8.0 * strlen(u->name); text_start = (boot->firmware_time + u->activating) * SCALE_X; if (text_width > text_start && text_width + text_start > width) width = text_width + text_start; limit_times_to_boot(boot, u); m++; } svg("\n" "\n"); svg("\n\n", 80.0 + width, 150.0 + (m * SCALE_Y) + 5 * SCALE_Y /* legend */); /* write some basic info as a comment, including some help */ svg("\n" "\n" "\n" "\n" "\n\n" "\n\n", GIT_VERSION); /* style sheet */ svg("\n \n\n\n"); svg("\n"); svg("%s", pretty_times); if (host) svg("%s %s (%s %s %s) %s %s", os_release_pretty_name(host->os_pretty_name, NULL), strempty(host->hostname), strempty(host->kernel_name), strempty(host->kernel_release), strempty(host->kernel_version), strempty(host->architecture), strempty(host->virtualization)); svg("\n", 20.0 + (SCALE_X * boot->firmware_time)); svg_graph_box(m, -(double) boot->firmware_time, boot->finish_time); if (timestamp_is_set(boot->firmware_time)) { svg_bar("firmware", -(double) boot->firmware_time, -(double) boot->loader_time, y); svg_text(true, -(double) boot->firmware_time, y, "firmware"); y++; } if (timestamp_is_set(boot->loader_time)) { svg_bar("loader", -(double) boot->loader_time, 0, y); svg_text(true, -(double) boot->loader_time, y, "loader"); y++; } if (timestamp_is_set(boot->kernel_done_time)) { svg_bar("kernel", 0, boot->kernel_done_time, y); svg_text(true, 0, y, "kernel"); y++; } if (timestamp_is_set(boot->initrd_time)) { svg_bar("initrd", boot->initrd_time, boot->userspace_time, y); if (boot->initrd_security_start_time < boot->initrd_security_finish_time) svg_bar("security", boot->initrd_security_start_time, boot->initrd_security_finish_time, y); if (boot->initrd_generators_start_time < boot->initrd_generators_finish_time) svg_bar("generators", boot->initrd_generators_start_time, boot->initrd_generators_finish_time, y); if (boot->initrd_unitsload_start_time < boot->initrd_unitsload_finish_time) svg_bar("unitsload", boot->initrd_unitsload_start_time, boot->initrd_unitsload_finish_time, y); svg_text(true, boot->initrd_time, y, "initrd"); y++; } for (u = times; u->has_data; u++) { if (u->activating >= boot->userspace_time) break; y += plot_unit_times(u, width, y); } svg_bar("active", boot->userspace_time, boot->finish_time, y); if (timestamp_is_set(boot->security_start_time)) svg_bar("security", boot->security_start_time, boot->security_finish_time, y); svg_bar("generators", boot->generators_start_time, boot->generators_finish_time, y); svg_bar("unitsload", boot->unitsload_start_time, boot->unitsload_finish_time, y); svg_text(true, boot->userspace_time, y, "systemd"); y++; for (; u->has_data; u++) y += plot_unit_times(u, width, y); svg("\n"); /* Legend */ svg("\n"); y++; svg_bar("activating", 0, 300000, y); svg_text(true, 400000, y, "Activating"); y++; svg_bar("active", 0, 300000, y); svg_text(true, 400000, y, "Active"); y++; svg_bar("deactivating", 0, 300000, y); svg_text(true, 400000, y, "Deactivating"); y++; if (timestamp_is_set(boot->security_start_time)) { svg_bar("security", 0, 300000, y); svg_text(true, 400000, y, "Setting up security module"); y++; } svg_bar("generators", 0, 300000, y); svg_text(true, 400000, y, "Generators"); y++; svg_bar("unitsload", 0, 300000, y); svg_text(true, 400000, y, "Loading unit files"); y++; svg("\n\n"); svg("\n"); return 0; } static int show_table(Table *table, const char *word) { int r; assert(table); assert(word); if (table_get_rows(table) > 1) { table_set_header(table, arg_legend); if (!FLAGS_SET(arg_json_format_flags, JSON_FORMAT_OFF)) r = table_print_json(table, NULL, arg_json_format_flags | JSON_FORMAT_COLOR_AUTO); else r = table_print(table, NULL); if (r < 0) return table_log_print_error(r); } if (arg_legend) { if (table_get_rows(table) > 1) printf("\n%zu %s listed.\n", table_get_rows(table) - 1, word); else printf("No %s.\n", word); } return 0; } static int produce_plot_as_text(UnitTimes *times, const BootTimes *boot) { _cleanup_(table_unrefp) Table *table = NULL; int r; table = table_new("name", "activated", "activating", "time", "deactivated", "deactivating"); if (!table) return log_oom(); for (; times->has_data; times++) { limit_times_to_boot(boot, times); r = table_add_many( table, TABLE_STRING, times->name, TABLE_TIMESPAN_MSEC, times->activated, TABLE_TIMESPAN_MSEC, times->activating, TABLE_TIMESPAN_MSEC, times->time, TABLE_TIMESPAN_MSEC, times->deactivated, TABLE_TIMESPAN_MSEC, times->deactivating); if (r < 0) return table_log_add_error(r); } return show_table(table, "Units"); } int verb_plot(int argc, char *argv[], void *userdata) { _cleanup_(free_host_infop) HostInfo *host = NULL; _cleanup_(sd_bus_flush_close_unrefp) sd_bus *bus = NULL; _cleanup_(unit_times_free_arrayp) UnitTimes *times = NULL; _cleanup_free_ char *pretty_times = NULL; bool use_full_bus = arg_runtime_scope == RUNTIME_SCOPE_SYSTEM; BootTimes *boot; int n, r; r = acquire_bus(&bus, &use_full_bus); if (r < 0) return bus_log_connect_error(r, arg_transport); n = acquire_boot_times(bus, /* require_finished = */ true, &boot); if (n < 0) return n; n = pretty_boot_time(bus, &pretty_times); if (n < 0) return n; if (use_full_bus || arg_runtime_scope != RUNTIME_SCOPE_SYSTEM) { n = acquire_host_info(bus, &host); if (n < 0) return n; } n = acquire_time_data(bus, /* require_finished = */ true, ×); if (n <= 0) return n; typesafe_qsort(times, n, compare_unit_start); if (!FLAGS_SET(arg_json_format_flags, JSON_FORMAT_OFF) || arg_table) r = produce_plot_as_text(times, boot); else r = produce_plot_as_svg(times, host, boot, pretty_times); if (r < 0) return r; return EXIT_SUCCESS; }