mirror of
https://gitlab.freedesktop.org/pipewire/pipewire.git
synced 2025-11-02 09:01:50 -05:00
b47d28bad6
Don't truncate the measurements when we convert to usec but keep the fractional part to get a more accurate graph.
801 lines
21 KiB
C
801 lines
21 KiB
C
/* PipeWire */
|
|
/* SPDX-FileCopyrightText: Copyright © 2020 Wim Taymans */
|
|
/* SPDX-License-Identifier: MIT */
|
|
|
|
#include <stdio.h>
|
|
#include <signal.h>
|
|
#include <getopt.h>
|
|
#include <locale.h>
|
|
|
|
#include <spa/utils/result.h>
|
|
#include <spa/utils/string.h>
|
|
#include <spa/utils/json.h>
|
|
#include <spa/pod/parser.h>
|
|
#include <spa/debug/types.h>
|
|
|
|
#include <pipewire/impl.h>
|
|
#include <pipewire/extensions/profiler.h>
|
|
|
|
#define MAX_NAME 128
|
|
#define MAX_FOLLOWERS 64
|
|
#define DEFAULT_FILENAME "profiler.log"
|
|
|
|
struct follower {
|
|
uint32_t id;
|
|
char name[MAX_NAME];
|
|
};
|
|
|
|
struct data {
|
|
struct pw_main_loop *loop;
|
|
struct pw_context *context;
|
|
|
|
struct pw_core *core;
|
|
struct spa_hook core_listener;
|
|
|
|
struct pw_registry *registry;
|
|
struct spa_hook registry_listener;
|
|
|
|
const char *filename;
|
|
FILE *output;
|
|
bool json_dump;
|
|
uint32_t iterations;
|
|
|
|
int64_t count;
|
|
int64_t start_status;
|
|
int64_t last_status;
|
|
|
|
struct pw_proxy *profiler;
|
|
struct spa_hook profiler_listener;
|
|
int check_profiler;
|
|
|
|
uint32_t driver_id;
|
|
|
|
int n_followers;
|
|
struct follower followers[MAX_FOLLOWERS];
|
|
};
|
|
|
|
struct measurement {
|
|
int64_t period;
|
|
int64_t prev_signal;
|
|
int64_t signal;
|
|
int64_t awake;
|
|
int64_t finish;
|
|
int32_t status;
|
|
struct spa_fraction latency;
|
|
int32_t xrun_count;
|
|
};
|
|
|
|
struct point {
|
|
int64_t count;
|
|
float cpu_load[3];
|
|
struct spa_io_clock clock;
|
|
int transport_state;
|
|
struct measurement driver;
|
|
struct measurement follower[MAX_FOLLOWERS];
|
|
};
|
|
|
|
static const char *status_to_string(int status)
|
|
{
|
|
switch (status) {
|
|
case 0:
|
|
return "not-triggered";
|
|
case 1:
|
|
return "triggered";
|
|
case 2:
|
|
return "awake";
|
|
case 3:
|
|
return "finished";
|
|
case 4:
|
|
return "inactive";
|
|
}
|
|
return "unknown";
|
|
}
|
|
static const char *transport_to_string(int state)
|
|
{
|
|
switch(state) {
|
|
case SPA_IO_POSITION_STATE_STOPPED:
|
|
return "stopped";
|
|
case SPA_IO_POSITION_STATE_STARTING:
|
|
return "starting";
|
|
case SPA_IO_POSITION_STATE_RUNNING:
|
|
return "running";
|
|
}
|
|
return "unknown";
|
|
}
|
|
|
|
static int process_info(struct data *d, const struct spa_pod *pod, struct point *point)
|
|
{
|
|
int res;
|
|
char cpu_load0[128], cpu_load1[128], cpu_load2[128];
|
|
|
|
res = spa_pod_parse_struct(pod,
|
|
SPA_POD_Long(&point->count),
|
|
SPA_POD_Float(&point->cpu_load[0]),
|
|
SPA_POD_Float(&point->cpu_load[1]),
|
|
SPA_POD_Float(&point->cpu_load[2]));
|
|
if (d->json_dump) {
|
|
fprintf(stdout, "{ \"type\": \"info\", \"count\": %"PRIu64", "
|
|
"\"cpu_load0\": %s, \"cpu_load1\": %s, \"cpu_load2\": %s },\n",
|
|
point->count,
|
|
spa_json_format_float(cpu_load0, sizeof(cpu_load0), point->cpu_load[0]),
|
|
spa_json_format_float(cpu_load1, sizeof(cpu_load1), point->cpu_load[1]),
|
|
spa_json_format_float(cpu_load2, sizeof(cpu_load2), point->cpu_load[2]));
|
|
}
|
|
return res;
|
|
}
|
|
|
|
static int process_clock(struct data *d, const struct spa_pod *pod, struct point *point)
|
|
{
|
|
int res;
|
|
char val[128];
|
|
res = spa_pod_parse_struct(pod,
|
|
SPA_POD_Int(&point->clock.flags),
|
|
SPA_POD_Int(&point->clock.id),
|
|
SPA_POD_Stringn(point->clock.name, sizeof(point->clock.name)),
|
|
SPA_POD_Long(&point->clock.nsec),
|
|
SPA_POD_Fraction(&point->clock.rate),
|
|
SPA_POD_Long(&point->clock.position),
|
|
SPA_POD_Long(&point->clock.duration),
|
|
SPA_POD_Long(&point->clock.delay),
|
|
SPA_POD_Double(&point->clock.rate_diff),
|
|
SPA_POD_Long(&point->clock.next_nsec),
|
|
SPA_POD_Int(&point->transport_state),
|
|
SPA_POD_OPT_Int(&point->clock.cycle),
|
|
SPA_POD_OPT_Long(&point->clock.xrun));
|
|
if (d->json_dump) {
|
|
fprintf(stdout, "{ \"type\": \"clock\", \"flags\": %u, \"id\": %u, "
|
|
"\"name\": \"%s\", \"nsec\": %"PRIu64", \"rate\": \"%u/%u\", "
|
|
"\"position\": %"PRIu64", \"duration\": %"PRIu64", "
|
|
"\"delay\": %"PRIu64", \"diff\": %s, \"next_nsec\": %"PRIu64", "
|
|
"\"transport\": \"%s\", \"cycle\": %u, \"xrun\": %"PRIu64" },\n",
|
|
point->clock.flags, point->clock.id, point->clock.name,
|
|
point->clock.nsec, point->clock.rate.num, point->clock.rate.denom,
|
|
point->clock.position, point->clock.duration,
|
|
point->clock.delay,
|
|
spa_json_format_float(val, sizeof(val), (float)point->clock.rate_diff),
|
|
point->clock.next_nsec, transport_to_string(point->transport_state),
|
|
point->clock.cycle, point->clock.xrun);
|
|
}
|
|
return res;
|
|
}
|
|
|
|
static int process_driver_block(struct data *d, const struct spa_pod *pod, struct point *point)
|
|
{
|
|
char *name = NULL;
|
|
uint32_t driver_id = 0;
|
|
struct measurement driver;
|
|
int res;
|
|
|
|
spa_zero(driver);
|
|
if ((res = spa_pod_parse_struct(pod,
|
|
SPA_POD_Int(&driver_id),
|
|
SPA_POD_String(&name),
|
|
SPA_POD_Long(&driver.prev_signal),
|
|
SPA_POD_Long(&driver.signal),
|
|
SPA_POD_Long(&driver.awake),
|
|
SPA_POD_Long(&driver.finish),
|
|
SPA_POD_Int(&driver.status),
|
|
SPA_POD_Fraction(&driver.latency),
|
|
SPA_POD_Int(&driver.xrun_count))) < 0)
|
|
return res;
|
|
|
|
if (d->json_dump) {
|
|
fprintf(stdout, "{ \"type\": \"driver\", \"id\": %u, \"name\": \"%s\", \"prev\": %"PRIu64", "
|
|
"\"signal\": %"PRIu64", \"awake\": %"PRIu64", "
|
|
"\"finish\": %"PRIu64", \"status\": \"%s\", \"latency\": \"%u/%u\", "
|
|
"\"xrun_count\": %u },\n",
|
|
driver_id, name, driver.prev_signal, driver.signal,
|
|
driver.awake, driver.finish, status_to_string(driver.status),
|
|
driver.latency.num, driver.latency.denom,
|
|
driver.xrun_count);
|
|
}
|
|
|
|
if (d->driver_id == 0) {
|
|
d->driver_id = driver_id;
|
|
pw_log_info("logging driver %u", driver_id);
|
|
}
|
|
else if (d->driver_id != driver_id && !d->json_dump)
|
|
return -1;
|
|
|
|
point->driver = driver;
|
|
return 0;
|
|
}
|
|
|
|
static int find_follower(struct data *d, uint32_t id, const char *name)
|
|
{
|
|
int i;
|
|
for (i = 0; i < d->n_followers; i++) {
|
|
if (d->followers[i].id == id && spa_streq(d->followers[i].name, name))
|
|
return i;
|
|
}
|
|
return -1;
|
|
}
|
|
|
|
static int add_follower(struct data *d, uint32_t id, const char *name)
|
|
{
|
|
int idx = d->n_followers;
|
|
|
|
if (idx == MAX_FOLLOWERS)
|
|
return -1;
|
|
|
|
d->n_followers++;
|
|
|
|
strncpy(d->followers[idx].name, name, MAX_NAME);
|
|
d->followers[idx].name[MAX_NAME-1] = '\0';
|
|
d->followers[idx].id = id;
|
|
|
|
pw_log_info("logging follower %u (\"%s\")", id, name);
|
|
|
|
return idx;
|
|
}
|
|
|
|
static int process_follower_block(struct data *d, const struct spa_pod *pod, struct point *point)
|
|
{
|
|
uint32_t id = 0;
|
|
const char *name = NULL;
|
|
struct measurement m;
|
|
int res, idx;
|
|
|
|
spa_zero(m);
|
|
if ((res = spa_pod_parse_struct(pod,
|
|
SPA_POD_Int(&id),
|
|
SPA_POD_String(&name),
|
|
SPA_POD_Long(&m.prev_signal),
|
|
SPA_POD_Long(&m.signal),
|
|
SPA_POD_Long(&m.awake),
|
|
SPA_POD_Long(&m.finish),
|
|
SPA_POD_Int(&m.status),
|
|
SPA_POD_Fraction(&m.latency),
|
|
SPA_POD_Int(&m.xrun_count))) < 0)
|
|
return res;
|
|
|
|
if (d->json_dump) {
|
|
fprintf(stdout, "{ \"type\": \"follower\", \"id\": %u, \"name\": \"%s\", \"prev\": %"PRIu64", "
|
|
"\"signal\": %"PRIu64", \"awake\": %"PRIu64", "
|
|
"\"finish\": %"PRIu64", \"status\": \"%s\", \"latency\": \"%u/%u\", "
|
|
"\"xrun_count\": %u },\n",
|
|
id, name, m.prev_signal, m.signal,
|
|
m.awake, m.finish, status_to_string(m.status),
|
|
m.latency.num, m.latency.denom,
|
|
m.xrun_count);
|
|
}
|
|
|
|
|
|
if ((idx = find_follower(d, id, name)) < 0) {
|
|
if ((idx = add_follower(d, id, name)) < 0) {
|
|
pw_log_warn("too many followers");
|
|
return -ENOSPC;
|
|
}
|
|
}
|
|
point->follower[idx] = m;
|
|
return 0;
|
|
}
|
|
|
|
static int process_follower_clock(struct data *d, const struct spa_pod *pod, struct point *point)
|
|
{
|
|
int res;
|
|
char val[128];
|
|
struct spa_io_clock clock;
|
|
|
|
res = spa_pod_parse_struct(pod,
|
|
SPA_POD_Int(&clock.id),
|
|
SPA_POD_Stringn(clock.name, sizeof(clock.name)),
|
|
SPA_POD_Long(&clock.nsec),
|
|
SPA_POD_Fraction(&clock.rate),
|
|
SPA_POD_Long(&clock.position),
|
|
SPA_POD_Long(&clock.duration),
|
|
SPA_POD_Long(&clock.delay),
|
|
SPA_POD_Double(&clock.rate_diff),
|
|
SPA_POD_Long(&clock.next_nsec),
|
|
SPA_POD_Long(&clock.xrun));
|
|
if (d->json_dump) {
|
|
fprintf(stdout, "{ \"type\": \"followerClock\", \"id\": %u, "
|
|
"\"name\": \"%s\", \"nsec\": %"PRIu64", \"rate\": \"%u/%u\", "
|
|
"\"position\": %"PRIu64", \"duration\": %"PRIu64", "
|
|
"\"delay\": %"PRIu64", \"diff\": %s, \"next_nsec\": %"PRIu64", "
|
|
"\"xrun\": %"PRIu64" },\n",
|
|
clock.id, clock.name,
|
|
clock.nsec, clock.rate.num, clock.rate.denom,
|
|
clock.position, clock.duration,
|
|
clock.delay,
|
|
spa_json_format_float(val, sizeof(val), (float)clock.rate_diff),
|
|
clock.next_nsec, clock.xrun);
|
|
}
|
|
return res;
|
|
}
|
|
|
|
static void dump_point(struct data *d, struct point *point)
|
|
{
|
|
int i;
|
|
double d1, d2;
|
|
double delay, period_usecs;
|
|
|
|
#define CLOCK_AS_USEC(cl,val) (double)(val * (double)SPA_USEC_PER_SEC / (cl)->rate.denom)
|
|
#define CLOCK_AS_SUSEC(cl,val) (double)(val * (double)SPA_USEC_PER_SEC / ((cl)->rate.denom * (cl)->rate_diff))
|
|
|
|
delay = CLOCK_AS_USEC(&point->clock, point->clock.delay);
|
|
period_usecs = CLOCK_AS_SUSEC(&point->clock, point->clock.duration);
|
|
|
|
d1 = (point->driver.signal - point->driver.prev_signal) / 1000.0;
|
|
d2 = (point->driver.finish - point->driver.signal) / 1000.0;
|
|
|
|
if (d1 > period_usecs * 1.3 ||
|
|
d2 > period_usecs * 1.3)
|
|
d1 = d2 = (double)(period_usecs * 1.4);
|
|
|
|
/* 4 columns for the driver */
|
|
fprintf(d->output, "%.3f\t%.3f\t%.3f\t%.3f\t",
|
|
d1 > 0 ? d1 : 0, d2 > 0 ? d2 : 0, delay, period_usecs);
|
|
|
|
for (i = 0; i < MAX_FOLLOWERS; i++) {
|
|
/* 8 columns for each follower */
|
|
if (point->follower[i].status == 0) {
|
|
fprintf(d->output, " \t \t \t \t \t \t \t \t");
|
|
} else {
|
|
double d4 = (point->follower[i].signal - point->driver.signal) / 1000.0;
|
|
double d5 = (point->follower[i].awake - point->driver.signal) / 1000.0;
|
|
double d6 = (point->follower[i].finish - point->driver.signal) / 1000.0;
|
|
|
|
fprintf(d->output, "%u\t%.3f\t%.3f\t%.3f\t%.3f\t%.3f\t%d\t0\t",
|
|
d->followers[i].id,
|
|
d4 > 0 ? d4 : 0,
|
|
d5 > 0 ? d5 : 0,
|
|
d6 > 0 ? d6 : 0,
|
|
(d5 > 0 && d4 >= 0 && d5 > d4) ? d5 - d4 : 0,
|
|
(d6 > 0 && d5 > 0 && d6 > d5) ? d6 - d5 : 0,
|
|
point->follower[i].status);
|
|
}
|
|
}
|
|
fprintf(d->output, "\n");
|
|
if (d->count == 0) {
|
|
d->start_status = point->clock.nsec;
|
|
d->last_status = point->clock.nsec;
|
|
}
|
|
else if (point->clock.nsec - d->last_status > SPA_NSEC_PER_SEC) {
|
|
fprintf(stderr, "logging %"PRIi64" samples %"PRIi64" seconds [CPU %f %f %f]\r",
|
|
d->count, (int64_t) ((d->last_status - d->start_status) / SPA_NSEC_PER_SEC),
|
|
point->cpu_load[0], point->cpu_load[1], point->cpu_load[2]);
|
|
d->last_status = point->clock.nsec;
|
|
}
|
|
d->count++;
|
|
}
|
|
|
|
static void dump_scripts(struct data *d)
|
|
{
|
|
FILE *out;
|
|
int i;
|
|
|
|
if (d->driver_id == 0)
|
|
return;
|
|
|
|
fprintf(stderr, "\ndumping scripts for %d followers\n", d->n_followers);
|
|
|
|
out = fopen("Timing1.plot", "we");
|
|
if (out == NULL) {
|
|
pw_log_error("Can't open Timing1.plot: %m");
|
|
} else {
|
|
fprintf(out,
|
|
"set output 'Timing1.svg\n"
|
|
"set terminal svg\n"
|
|
"set multiplot\n"
|
|
"set grid\n"
|
|
"set title \"Audio driver timing\"\n"
|
|
"set xlabel \"audio cycles\"\n"
|
|
"set ylabel \"usec\"\n"
|
|
"plot \"%1$s\" using 3 title \"Audio driver delay (h/w ptr - wakeup time)\" with lines, "
|
|
"\"%1$s\" using 1 title \"Audio period (current wakeup - prev wakeup)\" with lines,"
|
|
"\"%1$s\" using 4 title \"Audio estimated (cycle period or quantum)\" with lines\n"
|
|
"unset multiplot\n"
|
|
"unset output\n", d->filename);
|
|
fclose(out);
|
|
}
|
|
|
|
out = fopen("Timing2.plot", "we");
|
|
if (out == NULL) {
|
|
pw_log_error("Can't open Timing2.plot: %m");
|
|
} else {
|
|
fprintf(out,
|
|
"set output 'Timing2.svg\n"
|
|
"set terminal svg\n"
|
|
"set grid\n"
|
|
"set title \"Driver end date (total cycle processing time)\"\n"
|
|
"set xlabel \"audio cycles\"\n"
|
|
"set ylabel \"usec\"\n"
|
|
"plot \"%s\" using 2 title \"Driver end date\" with lines \n"
|
|
"unset output\n", d->filename);
|
|
fclose(out);
|
|
}
|
|
|
|
out = fopen("Timing3.plot", "we");
|
|
if (out == NULL) {
|
|
pw_log_error("Can't open Timing3.plot: %m");
|
|
} else {
|
|
fprintf(out,
|
|
"set output 'Timing3.svg\n"
|
|
"set terminal svg\n"
|
|
"set multiplot\n"
|
|
"set grid\n"
|
|
"set key tmargin\n"
|
|
"set title \"Clients end date (scheduled -> finished)\"\n"
|
|
"set xlabel \"audio cycles\"\n"
|
|
"set ylabel \"usec\"\n"
|
|
"plot "
|
|
"\"%s\" using 1 title \"Audio period\" with lines%s",
|
|
d->filename,
|
|
d->n_followers > 0 ? ", " : "");
|
|
|
|
for (i = 0; i < d->n_followers; i++) {
|
|
fprintf(out,
|
|
"\"%s\" using %d title \"%s/%u\" with lines%s",
|
|
d->filename, 4 + (i * 8) + 4,
|
|
d->followers[i].name, d->followers[i].id,
|
|
i+1 < d->n_followers ? ", " : "");
|
|
}
|
|
fprintf(out,
|
|
"\nunset multiplot\n"
|
|
"unset output\n");
|
|
fclose(out);
|
|
}
|
|
|
|
out = fopen("Timing4.plot", "we");
|
|
if (out == NULL) {
|
|
pw_log_error("Can't open Timing4.plot: %m");
|
|
} else {
|
|
fprintf(out,
|
|
"set output 'Timing4.svg\n"
|
|
"set terminal svg\n"
|
|
"set multiplot\n"
|
|
"set grid\n"
|
|
"set key tmargin\n"
|
|
"set title \"Clients scheduling latency (scheduled -> active)\"\n"
|
|
"set xlabel \"audio cycles\"\n"
|
|
"set ylabel \"usec\"\n"
|
|
"plot ");
|
|
|
|
for (i = 0; i < d->n_followers; i++) {
|
|
fprintf(out,
|
|
"\"%s\" using %d title \"%s/%u\" with lines%s",
|
|
d->filename, 4 + (i * 8) + 5,
|
|
d->followers[i].name, d->followers[i].id,
|
|
i+1 < d->n_followers ? ", " : "");
|
|
}
|
|
fprintf(out,
|
|
"\nunset multiplot\n"
|
|
"unset output\n");
|
|
fclose(out);
|
|
}
|
|
|
|
out = fopen("Timing5.plot", "we");
|
|
if (out == NULL) {
|
|
pw_log_error("Can't open Timing5.plot: %m");
|
|
} else {
|
|
fprintf(out,
|
|
"set output 'Timing5.svg\n"
|
|
"set terminal svg\n"
|
|
"set multiplot\n"
|
|
"set grid\n"
|
|
"set key tmargin\n"
|
|
"set title \"Clients duration (active -> finished)\"\n"
|
|
"set xlabel \"audio cycles\"\n"
|
|
"set ylabel \"usec\"\n"
|
|
"plot ");
|
|
|
|
for (i = 0; i < d->n_followers; i++) {
|
|
fprintf(out,
|
|
"\"%s\" using %d title \"%s/%u\" with lines%s",
|
|
d->filename, 4 + (i * 8) + 6,
|
|
d->followers[i].name, d->followers[i].id,
|
|
i+1 < d->n_followers ? ", " : "");
|
|
}
|
|
fprintf(out,
|
|
"\nunset multiplot\n"
|
|
"unset output\n");
|
|
fclose(out);
|
|
}
|
|
out = fopen("Timings.html", "we");
|
|
if (out == NULL) {
|
|
pw_log_error("Can't open Timings.html: %m");
|
|
} else {
|
|
fprintf(out,
|
|
"<?xml version='1.0' encoding='utf-8'?>\n"
|
|
"<!DOCTYPE html PUBLIC \"-//W3C//DTD XHTML 1.0 Transitional//EN\"\n"
|
|
"\"http://www.w3.org/TR/xhtml1/DTD/xhtml1-transitional.dtd\">\n"
|
|
"<html xmlns='http://www.w3.org/1999/xhtml' lang='en'>\n"
|
|
" <head>\n"
|
|
" <title>PipeWire profiling</title>\n"
|
|
" <!-- assuming that images are 600px wide -->\n"
|
|
" <style media='all' type='text/css'>\n"
|
|
" .center { margin-left:auto ; margin-right: auto; width: 650px; height: 550px }\n"
|
|
" </style>\n"
|
|
" </head>\n"
|
|
" <body>\n"
|
|
" <h2 style='text-align:center'>PipeWire profiling</h2>\n"
|
|
" <div class='center'><object class='center' type='image/svg+xml' data='Timing1.svg'>Timing1</object></div>"
|
|
" <div class='center'><object class='center' type='image/svg+xml' data='Timing2.svg'>Timing2</object></div>"
|
|
" <div class='center'><object class='center' type='image/svg+xml' data='Timing3.svg'>Timing3</object></div>"
|
|
" <div class='center'><object class='center' type='image/svg+xml' data='Timing4.svg'>Timing4</object></div>"
|
|
" <div class='center'><object class='center' type='image/svg+xml' data='Timing5.svg'>Timing5</object></div>"
|
|
" </body>\n"
|
|
"</html>\n");
|
|
fclose(out);
|
|
}
|
|
|
|
out = fopen("generate_timings.sh", "we");
|
|
if (out == NULL) {
|
|
pw_log_error("Can't open generate_timings.sh: %m");
|
|
} else {
|
|
fprintf(out,
|
|
"gnuplot Timing1.plot\n"
|
|
"gnuplot Timing2.plot\n"
|
|
"gnuplot Timing3.plot\n"
|
|
"gnuplot Timing4.plot\n"
|
|
"gnuplot Timing5.plot\n");
|
|
fclose(out);
|
|
}
|
|
printf("run 'sh generate_timings.sh' and load Timings.html in a browser\n");
|
|
}
|
|
|
|
static void profiler_profile(void *data, const struct spa_pod *pod)
|
|
{
|
|
struct data *d = data;
|
|
struct spa_pod *o;
|
|
struct spa_pod_prop *p;
|
|
struct point point;
|
|
|
|
SPA_POD_STRUCT_FOREACH(pod, o) {
|
|
int res = 0;
|
|
if (!spa_pod_is_object_type(o, SPA_TYPE_OBJECT_Profiler))
|
|
continue;
|
|
|
|
spa_zero(point);
|
|
SPA_POD_OBJECT_FOREACH((struct spa_pod_object*)o, p) {
|
|
switch(p->key) {
|
|
case SPA_PROFILER_info:
|
|
res = process_info(d, &p->value, &point);
|
|
break;
|
|
case SPA_PROFILER_clock:
|
|
res = process_clock(d, &p->value, &point);
|
|
break;
|
|
case SPA_PROFILER_driverBlock:
|
|
res = process_driver_block(d, &p->value, &point);
|
|
break;
|
|
case SPA_PROFILER_followerBlock:
|
|
process_follower_block(d, &p->value, &point);
|
|
break;
|
|
case SPA_PROFILER_followerClock:
|
|
process_follower_clock(d, &p->value, &point);
|
|
break;
|
|
default:
|
|
break;
|
|
}
|
|
if (res < 0)
|
|
break;
|
|
}
|
|
if (res < 0)
|
|
continue;
|
|
|
|
if (!d->json_dump)
|
|
dump_point(d, &point);
|
|
|
|
if (d->iterations > 0 && --d->iterations == 0) {
|
|
pw_main_loop_quit(d->loop);
|
|
break;
|
|
}
|
|
}
|
|
}
|
|
|
|
static const struct pw_profiler_events profiler_events = {
|
|
PW_VERSION_PROFILER_EVENTS,
|
|
.profile = profiler_profile,
|
|
};
|
|
|
|
static void registry_event_global(void *data, uint32_t id,
|
|
uint32_t permissions, const char *type, uint32_t version,
|
|
const struct spa_dict *props)
|
|
{
|
|
struct data *d = data;
|
|
struct pw_proxy *proxy;
|
|
|
|
if (!spa_streq(type, PW_TYPE_INTERFACE_Profiler))
|
|
return;
|
|
|
|
if (d->profiler != NULL) {
|
|
fprintf(stderr, "Ignoring profiler %d: already attached\n", id);
|
|
return;
|
|
}
|
|
|
|
proxy = pw_registry_bind(d->registry, id, type, PW_VERSION_PROFILER, 0);
|
|
if (proxy == NULL)
|
|
goto error_proxy;
|
|
|
|
pw_log_info("Attaching to Profiler id:%d", id);
|
|
d->profiler = proxy;
|
|
pw_proxy_add_object_listener(proxy, &d->profiler_listener, &profiler_events, d);
|
|
|
|
return;
|
|
|
|
error_proxy:
|
|
pw_log_error("failed to create proxy: %m");
|
|
return;
|
|
}
|
|
|
|
static const struct pw_registry_events registry_events = {
|
|
PW_VERSION_REGISTRY_EVENTS,
|
|
.global = registry_event_global,
|
|
};
|
|
|
|
static void on_core_error(void *_data, uint32_t id, int seq, int res, const char *message)
|
|
{
|
|
struct data *data = _data;
|
|
|
|
pw_log_error("error id:%u seq:%d res:%d (%s): %s",
|
|
id, seq, res, spa_strerror(res), message);
|
|
|
|
if (id == PW_ID_CORE && res == -EPIPE)
|
|
pw_main_loop_quit(data->loop);
|
|
}
|
|
|
|
static void on_core_done(void *_data, uint32_t id, int seq)
|
|
{
|
|
struct data *d = _data;
|
|
|
|
if (seq == d->check_profiler) {
|
|
if (d->profiler == NULL) {
|
|
pw_log_error("no Profiler Interface found, please load one in the server");
|
|
pw_main_loop_quit(d->loop);
|
|
}
|
|
}
|
|
}
|
|
|
|
|
|
static const struct pw_core_events core_events = {
|
|
PW_VERSION_CORE_EVENTS,
|
|
.error = on_core_error,
|
|
.done = on_core_done,
|
|
};
|
|
|
|
static void do_quit(void *data, int signal_number)
|
|
{
|
|
struct data *d = data;
|
|
pw_main_loop_quit(d->loop);
|
|
}
|
|
|
|
static void show_help(const char *name, bool error)
|
|
{
|
|
fprintf(error ? stderr : stdout, "%s [options]\n"
|
|
" -h, --help Show this help\n"
|
|
" --version Show version\n"
|
|
" -r, --remote Remote daemon name\n"
|
|
" -o, --output Profiler output name (default \"%s\")\n"
|
|
" -J, --json Dump raw data as JSON\n"
|
|
" -n, --iterations Collect this many samples\n",
|
|
name,
|
|
DEFAULT_FILENAME);
|
|
}
|
|
|
|
int main(int argc, char *argv[])
|
|
{
|
|
struct data data = { 0 };
|
|
struct pw_loop *l;
|
|
const char *opt_remote = NULL;
|
|
const char *opt_output = DEFAULT_FILENAME;
|
|
static const struct option long_options[] = {
|
|
{ "help", no_argument, NULL, 'h' },
|
|
{ "version", no_argument, NULL, 'V' },
|
|
{ "remote", required_argument, NULL, 'r' },
|
|
{ "output", required_argument, NULL, 'o' },
|
|
{ "json", no_argument, NULL, 'J' },
|
|
{ "iterations", required_argument, NULL, 'n' },
|
|
{ NULL, 0, NULL, 0}
|
|
};
|
|
int c;
|
|
|
|
setlocale(LC_ALL, "");
|
|
pw_init(&argc, &argv);
|
|
|
|
while ((c = getopt_long(argc, argv, "hVr:o:Jn:", long_options, NULL)) != -1) {
|
|
switch (c) {
|
|
case 'h':
|
|
show_help(argv[0], false);
|
|
return 0;
|
|
case 'V':
|
|
printf("%s\n"
|
|
"Compiled with libpipewire %s\n"
|
|
"Linked with libpipewire %s\n",
|
|
argv[0],
|
|
pw_get_headers_version(),
|
|
pw_get_library_version());
|
|
return 0;
|
|
case 'o':
|
|
opt_output = optarg;
|
|
break;
|
|
case 'r':
|
|
opt_remote = optarg;
|
|
break;
|
|
case 'J':
|
|
data.json_dump = true;
|
|
break;
|
|
case 'n':
|
|
spa_atou32(optarg, &data.iterations, 10);
|
|
break;
|
|
default:
|
|
show_help(argv[0], true);
|
|
return -1;
|
|
}
|
|
}
|
|
|
|
data.loop = pw_main_loop_new(NULL);
|
|
if (data.loop == NULL) {
|
|
fprintf(stderr, "Can't create data loop: %m\n");
|
|
return -1;
|
|
}
|
|
|
|
l = pw_main_loop_get_loop(data.loop);
|
|
pw_loop_add_signal(l, SIGINT, do_quit, &data);
|
|
pw_loop_add_signal(l, SIGTERM, do_quit, &data);
|
|
|
|
data.context = pw_context_new(l, NULL, 0);
|
|
if (data.context == NULL) {
|
|
fprintf(stderr, "Can't create context: %m\n");
|
|
return -1;
|
|
}
|
|
|
|
pw_context_load_module(data.context, PW_EXTENSION_MODULE_PROFILER, NULL, NULL);
|
|
|
|
data.core = pw_context_connect(data.context,
|
|
pw_properties_new(
|
|
PW_KEY_REMOTE_NAME, opt_remote,
|
|
NULL),
|
|
0);
|
|
if (data.core == NULL) {
|
|
fprintf(stderr, "Can't connect: %m\n");
|
|
return -1;
|
|
}
|
|
|
|
data.filename = opt_output;
|
|
|
|
if (!data.json_dump) {
|
|
data.output = fopen(data.filename, "we");
|
|
if (data.output == NULL) {
|
|
fprintf(stderr, "Can't open file %s: %m\n", data.filename);
|
|
return -1;
|
|
}
|
|
fprintf(stderr, "Logging to %s\n", data.filename);
|
|
} else {
|
|
printf("[");
|
|
}
|
|
|
|
pw_core_add_listener(data.core,
|
|
&data.core_listener,
|
|
&core_events, &data);
|
|
data.registry = pw_core_get_registry(data.core,
|
|
PW_VERSION_REGISTRY, 0);
|
|
pw_registry_add_listener(data.registry,
|
|
&data.registry_listener,
|
|
®istry_events, &data);
|
|
|
|
data.check_profiler = pw_core_sync(data.core, 0, 0);
|
|
|
|
pw_main_loop_run(data.loop);
|
|
|
|
if (data.profiler) {
|
|
spa_hook_remove(&data.profiler_listener);
|
|
pw_proxy_destroy((struct pw_proxy*)data.profiler);
|
|
}
|
|
spa_hook_remove(&data.registry_listener);
|
|
pw_proxy_destroy((struct pw_proxy*)data.registry);
|
|
spa_hook_remove(&data.core_listener);
|
|
pw_context_destroy(data.context);
|
|
pw_main_loop_destroy(data.loop);
|
|
|
|
if (!data.json_dump) {
|
|
fclose(data.output);
|
|
dump_scripts(&data);
|
|
} else {
|
|
printf("{ } ]\n");
|
|
}
|
|
|
|
pw_deinit();
|
|
|
|
return 0;
|
|
}
|