[Spice-devel] [spice-server v3 6/8] Use spice_debug rather than spice_info in library code
Pavel Grunt
pgrunt at redhat.com
Wed Feb 8 09:57:42 UTC 2017
On Mon, 2017-02-06 at 18:15 +0100, Christophe Fergeau wrote:
> Using spice_info() gets in the way of tests
I would say that is the problem of the test, it is possible to check
the INFO level as well. imo spice_info messages are useful
Pavel
> using
> g_test_expect_message() as all the messages emitted using
> a non-debug log level must be listed as expected, otherwise we get a
> critical about an expected message not having been logged.
---
> server/cursor-channel.c | 4 +--
> server/dcc.c | 6 ++--
> server/display-channel.c | 24 ++++++-------
> server/image-encoders.c | 18 +++++-----
> server/red-channel-client.c | 4 +--
> server/red-worker.c | 34 +++++++++---------
> server/reds-stream.c | 40 ++++++++++-----------
> server/reds.c | 86 ++++++++++++++++++++++----------
> -------------
> server/sound.c | 2 +-
> 9 files changed, 109 insertions(+), 109 deletions(-)
>
> diff --git a/server/cursor-channel.c b/server/cursor-channel.c
> index b3cbb96..c1254b7 100644
> --- a/server/cursor-channel.c
> +++ b/server/cursor-channel.c
> @@ -294,7 +294,7 @@ static void
> cursor_channel_send_item(RedChannelClient *rcc, RedPipeItem *pipe_it
> CursorChannel* cursor_channel_new(RedsState *server, QXLInstance
> *qxl,
> const SpiceCoreInterfaceInternal
> *core)
> {
> - spice_info("create cursor channel");
> + spice_debug("create cursor channel");
> return g_object_new(TYPE_CURSOR_CHANNEL,
> "spice-server", server,
> "core-interface", core,
> @@ -413,7 +413,7 @@ void cursor_channel_connect(CursorChannel
> *cursor, RedClient *client, RedsStream
>
> spice_return_if_fail(cursor != NULL);
>
> - spice_info("add cursor channel client");
> + spice_debug("add cursor channel client");
> ccc = cursor_channel_client_new(cursor, client, stream,
> migrate,
> common_caps, num_common_caps,
> diff --git a/server/dcc.c b/server/dcc.c
> index afe37b1..3c8e24d 100644
> --- a/server/dcc.c
> +++ b/server/dcc.c
> @@ -514,7 +514,7 @@ DisplayChannelClient *dcc_new(DisplayChannel
> *display,
> "jpeg-state", jpeg_state,
> "zlib-glz-state", zlib_glz_state,
> NULL);
> - spice_info("New display (client %p) dcc %p stream %p", client,
> dcc, stream);
> + spice_debug("New display (client %p) dcc %p stream %p", client,
> dcc, stream);
> common_graphics_channel_set_during_target_migrate(COMMON_GRAPHI
> CS_CHANNEL(display), mig_target);
> dcc->priv->id =
> common_graphics_channel_get_qxl(COMMON_GRAPHICS_CHANNEL(display))-
> >id;
>
> @@ -550,7 +550,7 @@ static int
> display_channel_client_wait_for_init(DisplayChannelClient *dcc)
> if (dcc->priv->pixmap_cache && dcc->priv-
> >encoders.glz_dict) {
> dcc->priv->pixmap_cache_generation = dcc->priv-
> >pixmap_cache->generation;
> /* TODO: move common.id? if it's used for a per client
> structure.. */
> - spice_info("creating encoder with id == %d", dcc->priv-
> >id);
> + spice_debug("creating encoder with id == %d", dcc-
> >priv->id);
> if (!image_encoders_glz_create(&dcc->priv->encoders,
> dcc->priv->id)) {
> spice_critical("create global lz failed");
> }
> @@ -1052,7 +1052,7 @@ static int
> dcc_handle_stream_report(DisplayChannelClient *dcc,
>
> agent = &dcc->priv->stream_agents[report->stream_id];
> if (!agent->video_encoder) {
> - spice_info("stream_report: no encoder for stream id %u. "
> + spice_debug("stream_report: no encoder for stream id %u. "
> "The stream has probably been destroyed",
> report->stream_id);
> return TRUE;
> diff --git a/server/display-channel.c b/server/display-channel.c
> index 7d3c6e4..bb1efe4 100644
> --- a/server/display-channel.c
> +++ b/server/display-channel.c
> @@ -114,7 +114,7 @@ void
> display_channel_compress_stats_print(DisplayChannel
> *display_channel)
>
> g_object_get(display_channel, "id", &id, NULL);
>
> - spice_info("==> Compression stats for display %u", id);
> + spice_debug("==> Compression stats for display %u", id);
> image_encoder_shared_stat_print(&display_channel->priv-
> >encoder_shared_data);
> #endif
> }
> @@ -192,13 +192,13 @@ void
> display_channel_set_stream_video(DisplayChannel *display, int
> stream_video)
>
> switch (stream_video) {
> case SPICE_STREAM_VIDEO_ALL:
> - spice_info("sv all");
> + spice_debug("sv all");
> break;
> case SPICE_STREAM_VIDEO_FILTER:
> - spice_info("sv filter");
> + spice_debug("sv filter");
> break;
> case SPICE_STREAM_VIDEO_OFF:
> - spice_info("sv off");
> + spice_debug("sv off");
> break;
> default:
> spice_warn_if_reached();
> @@ -239,7 +239,7 @@ static void stop_streams(DisplayChannel
> *display)
> if (!stream->current) {
> stream_stop(display, stream);
> } else {
> - spice_info("attached stream");
> + spice_debug("attached stream");
> }
> }
>
> @@ -883,17 +883,17 @@ static bool drawable_can_stream(DisplayChannel
> *display, Drawable *drawable)
> static void display_channel_print_stats(DisplayChannel *display)
> {
> stat_time_t total = display->priv->add_stat.total;
> - spice_info("add with shadow count %u",
> + spice_debug("add with shadow count %u",
> display->priv->add_with_shadow_count);
> display->priv->add_with_shadow_count = 0;
> - spice_info("add[%u] %f exclude[%u] %f __exclude[%u] %f",
> + spice_debug("add[%u] %f exclude[%u] %f __exclude[%u] %f",
> display->priv->add_stat.count,
> stat_cpu_time_to_sec(total),
> display->priv->exclude_stat.count,
> stat_cpu_time_to_sec(display->priv-
> >exclude_stat.total),
> display->priv->__exclude_stat.count,
> stat_cpu_time_to_sec(display->priv-
> >__exclude_stat.total));
> - spice_info("add %f%% exclude %f%% exclude2 %f%% __exclude
> %f%%",
> + spice_debug("add %f%% exclude %f%% exclude2 %f%% __exclude
> %f%%",
> (double)(total - display->priv->exclude_stat.total)
> / total * 100,
> (double)(display->priv->exclude_stat.total) / total
> * 100,
> (double)(display->priv->exclude_stat.total -
> @@ -1931,7 +1931,7 @@ static void on_disconnect(RedChannelClient
> *rcc)
> DisplayChannel *display;
> DisplayChannelClient *dcc;
>
> - spice_info(NULL);
> + spice_debug(NULL);
> spice_return_if_fail(rcc != NULL);
>
> dcc = DISPLAY_CHANNEL_CLIENT(rcc);
> @@ -1988,7 +1988,7 @@ DisplayChannel* display_channel_new(RedsState
> *reds,
> DisplayChannel *display;
>
> /* FIXME: migrate is not used...? */
> - spice_info("create display channel");
> + spice_debug("create display channel");
> display = g_object_new(TYPE_DISPLAY_CHANNEL,
> "spice-server", reds,
> "core-interface", core,
> @@ -2130,8 +2130,8 @@ void
> display_channel_update_compression(DisplayChannel *display,
> DisplayChannelC
> } else {
> display->priv->enable_zlib_glz_wrap =
> (dcc_get_zlib_glz_state(dcc) == SPICE_WAN_COMPRESSION_ALWAYS);
> }
> - spice_info("jpeg %s", display->priv->enable_jpeg ? "enabled" :
> "disabled");
> - spice_info("zlib-over-glz %s", display->priv-
> >enable_zlib_glz_wrap ? "enabled" : "disabled");
> + spice_debug("jpeg %s", display->priv->enable_jpeg ? "enabled" :
> "disabled");
> + spice_debug("zlib-over-glz %s", display->priv-
> >enable_zlib_glz_wrap ? "enabled" : "disabled");
> }
>
> void display_channel_gl_scanout(DisplayChannel *display)
> diff --git a/server/image-encoders.c b/server/image-encoders.c
> index 0d57260..52742ae 100644
> --- a/server/image-encoders.c
> +++ b/server/image-encoders.c
> @@ -723,7 +723,7 @@ static GlzSharedDictionary
> *create_glz_dictionary(ImageEncoders *enc,
> RedClient
> *client,
> uint8_t id, int
> window_size)
> {
> - spice_info("Lz Window %d Size=%d", id, window_size);
> + spice_debug("Lz Window %d Size=%d", id, window_size);
>
> GlzEncDictContext *glz_dict =
> glz_enc_dictionary_create(window_size, MAX_LZ_ENCODERS,
> &enc->glz_data.usr);
> @@ -838,7 +838,7 @@ int image_encoders_compress_quic(ImageEncoders
> *enc, SpiceImage *dest,
> stat_start_time_init(&start_time, &enc->shared_data-
> >quic_stat);
>
> #ifdef COMPRESS_DEBUG
> - spice_info("QUIC compress");
> + spice_debug("QUIC compress");
> #endif
>
> switch (src->format) {
> @@ -927,7 +927,7 @@ int image_encoders_compress_lz(ImageEncoders
> *enc,
> stat_start_time_init(&start_time, &enc->shared_data->lz_stat);
>
> #ifdef COMPRESS_DEBUG
> - spice_info("LZ LOCAL compress");
> + spice_debug("LZ LOCAL compress");
> #endif
>
> encoder_data_init(&lz_data->data);
> @@ -998,7 +998,7 @@ int image_encoders_compress_jpeg(ImageEncoders
> *enc, SpiceImage *dest,
> stat_start_time_init(&start_time, &enc->shared_data-
> >jpeg_alpha_stat);
>
> #ifdef COMPRESS_DEBUG
> - spice_info("JPEG compress");
> + spice_debug("JPEG compress");
> #endif
>
> switch (src->format) {
> @@ -1115,7 +1115,7 @@ int image_encoders_compress_lz4(ImageEncoders
> *enc, SpiceImage *dest,
> stat_start_time_init(&start_time, &enc->shared_data->lz4_stat);
>
> #ifdef COMPRESS_DEBUG
> - spice_info("LZ4 compress");
> + spice_debug("LZ4 compress");
> #endif
>
> encoder_data_init(&lz4_data->data);
> @@ -1227,7 +1227,7 @@ int image_encoders_compress_glz(ImageEncoders
> *enc,
> int zlib_size;
>
> #ifdef COMPRESS_DEBUG
> - spice_info("LZ global compress fmt=%d", src->format);
> + spice_debug("LZ global compress fmt=%d", src->format);
> #endif
>
> if ((src->x * src->y) >= glz_enc_dictionary_get_size(enc-
> >glz_dict->dict)) {
> @@ -1337,7 +1337,7 @@ void
> image_encoder_shared_stat_reset(ImageEncoderSharedData *shared_data)
> #ifdef COMPRESS_STAT
> static void stat_print_one(const char *name, const stat_info_t
> *stat)
> {
> - spice_info(STAT_FMT, name, stat->count,
> + spice_debug(STAT_FMT, name, stat->count,
> stat_byte_to_mega(stat->orig_size),
> stat_byte_to_mega(stat->comp_size),
> stat_cpu_time_to_sec(stat->total));
> @@ -1377,7 +1377,7 @@ void image_encoder_shared_stat_print(const
> ImageEncoderSharedData *shared_data)
> shared_data->zlib_glz_stat.comp_size;
> }
>
> - spice_info("Method \t count \torig_size(MB)\tenc_size(MB)\t
> enc_time(s)");
> + spice_debug("Method \t count \torig_size(MB)\tenc_size(MB)\
> tenc_time(s)");
> stat_print_one("OFF ", &shared_data->off_stat);
> stat_print_one("QUIC ", &shared_data->quic_stat);
> stat_print_one("GLZ ", &shared_data->glz_stat);
> @@ -1386,7 +1386,7 @@ void image_encoder_shared_stat_print(const
> ImageEncoderSharedData *shared_data)
> stat_print_one("JPEG ", &shared_data->jpeg_stat);
> stat_print_one("JPEG-RGBA", &shared_data->jpeg_alpha_stat);
> stat_print_one("LZ4 ", &shared_data->lz4_stat);
> - spice_info("---------------------------------------------------
> ----------------");
> + spice_debug("------------------------------------------------
> -------------------");
> stat_print_one("Total ", &total);
> #endif
> }
> diff --git a/server/red-channel-client.c b/server/red-channel-
> client.c
> index 0002951..342f137 100644
> --- a/server/red-channel-client.c
> +++ b/server/red-channel-client.c
> @@ -1692,7 +1692,7 @@ int
> red_channel_client_wait_pipe_item_sent(RedChannelClient *rcc,
> uint64_t end_time;
> gboolean item_in_pipe;
>
> - spice_info(NULL);
> + spice_debug(NULL);
>
> if (timeout != -1) {
> end_time = spice_get_monotonic_time_ns() + timeout;
> @@ -1747,7 +1747,7 @@ int
> red_channel_client_wait_outgoing_item(RedChannelClient *rcc,
> } else {
> end_time = UINT64_MAX;
> }
> - spice_info("blocked");
> + spice_debug("blocked");
>
> do {
> usleep(CHANNEL_BLOCKED_SLEEP_DURATION);
> diff --git a/server/red-worker.c b/server/red-worker.c
> index 475acc4..ecba2ae 100644
> --- a/server/red-worker.c
> +++ b/server/red-worker.c
> @@ -615,7 +615,7 @@ static void handle_dev_stop(void *opaque, void
> *payload)
> {
> RedWorker *worker = opaque;
>
> - spice_info("stop");
> + spice_debug("stop");
> spice_assert(worker->running);
>
> worker->running = FALSE;
> @@ -734,7 +734,7 @@ static void handle_dev_display_connect(void
> *opaque, void *payload)
> DisplayChannel *display = worker->display_channel;
> DisplayChannelClient *dcc;
>
> - spice_info("connect new client");
> + spice_debug("connect new client");
> spice_return_if_fail(display);
>
> dcc = dcc_new(display, msg->client, msg->stream, msg-
> >migration,
> @@ -757,7 +757,7 @@ static void handle_dev_display_disconnect(void
> *opaque, void *payload)
> RedChannelClient *rcc = msg->rcc;
> RedWorker *worker = opaque;
>
> - spice_info("disconnect display client");
> + spice_debug("disconnect display client");
> spice_assert(rcc);
>
> guest_set_client_capabilities(worker);
> @@ -771,7 +771,7 @@ static void handle_dev_display_migrate(void
> *opaque, void *payload)
> RedWorker *worker = opaque;
>
> RedChannelClient *rcc = msg->rcc;
> - spice_info("migrate display client");
> + spice_debug("migrate display client");
> spice_assert(rcc);
> red_migrate_display(worker->display_channel, rcc);
> }
> @@ -831,7 +831,7 @@ static void handle_dev_cursor_connect(void
> *opaque, void *payload)
> RedWorkerMessageCursorConnect *msg = payload;
> RedWorker *worker = opaque;
>
> - spice_info("cursor connect");
> + spice_debug("cursor connect");
> cursor_channel_connect(worker->cursor_channel,
> msg->client, msg->stream, msg-
> >migration,
> msg->common_caps, msg->num_common_caps,
> @@ -845,7 +845,7 @@ static void handle_dev_cursor_disconnect(void
> *opaque, void *payload)
> RedWorkerMessageCursorDisconnect *msg = payload;
> RedChannelClient *rcc = msg->rcc;
>
> - spice_info("disconnect cursor client");
> + spice_debug("disconnect cursor client");
> spice_return_if_fail(rcc);
> red_channel_client_disconnect(rcc);
> }
> @@ -855,7 +855,7 @@ static void handle_dev_cursor_migrate(void
> *opaque, void *payload)
> RedWorkerMessageCursorMigrate *msg = payload;
> RedChannelClient *rcc = msg->rcc;
>
> - spice_info("migrate cursor client");
> + spice_debug("migrate cursor client");
> cursor_channel_client_migrate(rcc);
> }
>
> @@ -867,27 +867,27 @@ static void handle_dev_set_compression(void
> *opaque, void *payload)
>
> switch (image_compression) {
> case SPICE_IMAGE_COMPRESSION_AUTO_LZ:
> - spice_info("ic auto_lz");
> + spice_debug("ic auto_lz");
> break;
> case SPICE_IMAGE_COMPRESSION_AUTO_GLZ:
> - spice_info("ic auto_glz");
> + spice_debug("ic auto_glz");
> break;
> case SPICE_IMAGE_COMPRESSION_QUIC:
> - spice_info("ic quic");
> + spice_debug("ic quic");
> break;
> #ifdef USE_LZ4
> case SPICE_IMAGE_COMPRESSION_LZ4:
> - spice_info("ic lz4");
> + spice_debug("ic lz4");
> break;
> #endif
> case SPICE_IMAGE_COMPRESSION_LZ:
> - spice_info("ic lz");
> + spice_debug("ic lz");
> break;
> case SPICE_IMAGE_COMPRESSION_GLZ:
> - spice_info("ic glz");
> + spice_debug("ic glz");
> break;
> case SPICE_IMAGE_COMPRESSION_OFF:
> - spice_info("ic off");
> + spice_debug("ic off");
> break;
> default:
> spice_warning("ic invalid");
> @@ -921,7 +921,7 @@ static void handle_dev_set_mouse_mode(void
> *opaque, void *payload)
> RedWorkerMessageSetMouseMode *msg = payload;
> RedWorker *worker = opaque;
>
> - spice_info("mouse mode %u", msg->mode);
> + spice_debug("mouse mode %u", msg->mode);
> cursor_channel_set_mouse_mode(worker->cursor_channel, msg-
> >mode);
> }
>
> @@ -1012,7 +1012,7 @@ static void handle_dev_loadvm_commands(void
> *opaque, void *payload)
> uint32_t count = msg->count;
> QXLCommandExt *ext = msg->ext;
>
> - spice_info("loadvm_commands");
> + spice_debug("loadvm_commands");
> for (i = 0 ; i < count ; ++i) {
> if (!loadvm_command(worker, &ext[i])) {
> /* XXX allow failure in loadvm? */
> @@ -1394,7 +1394,7 @@ static void *red_worker_main(void *arg)
> {
> RedWorker *worker = arg;
>
> - spice_info("begin");
> + spice_debug("begin");
> SPICE_VERIFY(MAX_PIPE_SIZE > WIDE_CLIENT_ACK_WINDOW &&
> MAX_PIPE_SIZE > NARROW_CLIENT_ACK_WINDOW); //ensure
> wakeup by ack message
>
> diff --git a/server/reds-stream.c b/server/reds-stream.c
> index d0dadb9..471989e 100644
> --- a/server/reds-stream.c
> +++ b/server/reds-stream.c
> @@ -342,7 +342,7 @@ void reds_stream_free(RedsStream *s)
> }
>
> reds_stream_remove_watch(s);
> - spice_info("close socket fd %d", s->socket);
> + spice_debug("close socket fd %d", s->socket);
> close(s->socket);
>
> free(s);
> @@ -699,7 +699,7 @@ static int auth_sasl_check_ssf(RedsSASL *sasl,
> int *runSSF)
> }
>
> ssf = *(const int *)val;
> - spice_info("negotiated an SSF of %d", ssf);
> + spice_debug("negotiated an SSF of %d", ssf);
> if (ssf < 56) {
> return 0; /* 56 is good for Kerberos */
> }
> @@ -742,7 +742,7 @@ RedsSaslError
> reds_sasl_handle_auth_step(RedsStream *stream, AsyncReadDone read_
> datalen--; /* Don't count NULL byte when passing to
> _start() */
> }
>
> - spice_info("Step using SASL Data %p (%d bytes)",
> + spice_debug("Step using SASL Data %p (%d bytes)",
> clientdata, datalen);
> err = sasl_server_step(sasl->conn,
> clientdata,
> @@ -762,7 +762,7 @@ RedsSaslError
> reds_sasl_handle_auth_step(RedsStream *stream, AsyncReadDone read_
> return REDS_SASL_ERROR_INVALID_DATA;
> }
>
> - spice_info("SASL return data %d bytes, %p", serveroutlen,
> serverout);
> + spice_debug("SASL return data %d bytes, %p", serveroutlen,
> serverout);
>
> if (serveroutlen) {
> serveroutlen += 1;
> @@ -776,7 +776,7 @@ RedsSaslError
> reds_sasl_handle_auth_step(RedsStream *stream, AsyncReadDone read_
> reds_stream_write_u8(stream, err == SASL_CONTINUE ? 0 : 1);
>
> if (err == SASL_CONTINUE) {
> - spice_info("%s", "Authentication must continue (step)");
> + spice_debug("%s", "Authentication must continue (step)");
> /* Wait for step length */
> reds_stream_async_read(stream, (uint8_t *)&sasl->len,
> sizeof(uint32_t),
> read_cb, opaque);
> @@ -789,7 +789,7 @@ RedsSaslError
> reds_sasl_handle_auth_step(RedsStream *stream, AsyncReadDone read_
> goto authreject;
> }
>
> - spice_info("Authentication successful");
> + spice_debug("Authentication successful");
> reds_stream_write_u32(stream, SPICE_LINK_ERR_OK); /* Accept
> auth */
>
> /*
> @@ -813,7 +813,7 @@ RedsSaslError
> reds_sasl_handle_auth_steplen(RedsStream *stream, AsyncReadDone re
> {
> RedsSASL *sasl = &stream->priv->sasl;
>
> - spice_info("Got steplen %d", sasl->len);
> + spice_debug("Got steplen %d", sasl->len);
> if (sasl->len > SASL_DATA_MAX_LEN) {
> spice_warning("Too much SASL data %d", sasl->len);
> return REDS_SASL_ERROR_INVALID_DATA;
> @@ -865,7 +865,7 @@ RedsSaslError
> reds_sasl_handle_auth_start(RedsStream *stream, AsyncReadDone read
> datalen--; /* Don't count NULL byte when passing to
> _start() */
> }
>
> - spice_info("Start SASL auth with mechanism %s. Data %p (%d
> bytes)",
> + spice_debug("Start SASL auth with mechanism %s. Data %p (%d
> bytes)",
> sasl->mechlist, clientdata, datalen);
> err = sasl_server_start(sasl->conn,
> sasl->mechlist,
> @@ -886,7 +886,7 @@ RedsSaslError
> reds_sasl_handle_auth_start(RedsStream *stream, AsyncReadDone read
> return REDS_SASL_ERROR_INVALID_DATA;
> }
>
> - spice_info("SASL return data %d bytes, %p", serveroutlen,
> serverout);
> + spice_debug("SASL return data %d bytes, %p", serveroutlen,
> serverout);
>
> if (serveroutlen) {
> serveroutlen += 1;
> @@ -900,7 +900,7 @@ RedsSaslError
> reds_sasl_handle_auth_start(RedsStream *stream, AsyncReadDone read
> reds_stream_write_u8(stream, err == SASL_CONTINUE ? 0 : 1);
>
> if (err == SASL_CONTINUE) {
> - spice_info("%s", "Authentication must continue (start)");
> + spice_debug("%s", "Authentication must continue (start)");
> /* Wait for step length */
> reds_stream_async_read(stream, (uint8_t *)&sasl->len,
> sizeof(uint32_t),
> read_cb, opaque);
> @@ -913,7 +913,7 @@ RedsSaslError
> reds_sasl_handle_auth_start(RedsStream *stream, AsyncReadDone read
> goto authreject;
> }
>
> - spice_info("Authentication successful");
> + spice_debug("Authentication successful");
> reds_stream_write_u32(stream, SPICE_LINK_ERR_OK); /* Accept
> auth */
>
> /*
> @@ -936,7 +936,7 @@ RedsSaslError
> reds_sasl_handle_auth_startlen(RedsStream *stream, AsyncReadDone r
> {
> RedsSASL *sasl = &stream->priv->sasl;
>
> - spice_info("Got client start len %d", sasl->len);
> + spice_debug("Got client start len %d", sasl->len);
> if (sasl->len > SASL_DATA_MAX_LEN) {
> spice_warning("Too much SASL data %d", sasl->len);
> return REDS_SASL_ERROR_INVALID_DATA;
> @@ -958,22 +958,22 @@ bool reds_sasl_handle_auth_mechname(RedsStream
> *stream, AsyncReadDone read_cb, v
> RedsSASL *sasl = &stream->priv->sasl;
>
> sasl->mechname[sasl->len] = '\0';
> - spice_info("Got client mechname '%s' check against '%s'",
> + spice_debug("Got client mechname '%s' check against '%s'",
> sasl->mechname, sasl->mechlist);
>
> if (strncmp(sasl->mechlist, sasl->mechname, sasl->len) == 0) {
> if (sasl->mechlist[sasl->len] != '\0' &&
> sasl->mechlist[sasl->len] != ',') {
> - spice_info("One %d", sasl->mechlist[sasl->len]);
> + spice_debug("One %d", sasl->mechlist[sasl->len]);
> return FALSE;
> }
> } else {
> char *offset = strstr(sasl->mechlist, sasl->mechname);
> - spice_info("Two %p", offset);
> + spice_debug("Two %p", offset);
> if (!offset) {
> return FALSE;
> }
> - spice_info("Two '%s'", offset);
> + spice_debug("Two '%s'", offset);
> if (offset[-1] != ',' ||
> (offset[sasl->len] != '\0'&&
> offset[sasl->len] != ',')) {
> @@ -984,7 +984,7 @@ bool reds_sasl_handle_auth_mechname(RedsStream
> *stream, AsyncReadDone read_cb, v
> free(sasl->mechlist);
> sasl->mechlist = spice_strdup(sasl->mechname);
>
> - spice_info("Validated mechname '%s'", sasl->mechname);
> + spice_debug("Validated mechname '%s'", sasl->mechname);
>
> reds_stream_async_read(stream, (uint8_t *)&sasl->len,
> sizeof(uint32_t),
> read_cb, opaque);
> @@ -1003,7 +1003,7 @@ bool reds_sasl_handle_auth_mechlen(RedsStream
> *stream, AsyncReadDone read_cb, vo
>
> sasl->mechname = spice_malloc(sasl->len + 1);
>
> - spice_info("Wait for client mechname");
> + spice_debug("Wait for client mechname");
> reds_stream_async_read(stream, (uint8_t *)sasl->mechname, sasl-
> >len,
> read_cb, opaque);
>
> @@ -1101,7 +1101,7 @@ bool reds_sasl_start_auth(RedsStream *stream,
> AsyncReadDone read_cb, void *opaqu
> goto error_dispose;
> }
>
> - spice_info("Available mechanisms for client: '%s'", mechlist);
> + spice_debug("Available mechanisms for client: '%s'", mechlist);
>
> sasl->mechlist = spice_strdup(mechlist);
>
> @@ -1112,7 +1112,7 @@ bool reds_sasl_start_auth(RedsStream *stream,
> AsyncReadDone read_cb, void *opaqu
> goto error;
> }
>
> - spice_info("Wait for client mechname length");
> + spice_debug("Wait for client mechname length");
> reds_stream_async_read(stream, (uint8_t *)&sasl->len,
> sizeof(uint32_t),
> read_cb, opaque);
>
> diff --git a/server/reds.c b/server/reds.c
> index ff0f0e2..55a5494 100644
> --- a/server/reds.c
> +++ b/server/reds.c
> @@ -482,7 +482,7 @@ void reds_client_disconnect(RedsState *reds,
> RedClient *client)
>
> if (reds->config->exit_on_disconnect)
> {
> - spice_info("Exiting server because of client
> disconnect.\n");
> + spice_debug("Exiting server because of client
> disconnect.\n");
> exit(0);
> }
>
> @@ -491,7 +491,7 @@ void reds_client_disconnect(RedsState *reds,
> RedClient *client)
> return;
> }
>
> - spice_info(NULL);
> + spice_debug(NULL);
> /* disconnecting is set to prevent recursion because of the
> following:
> * main_channel_client_on_disconnect->
> * reds_client_disconnect->red_client_destroy->main_channel...
> @@ -567,7 +567,7 @@ static void reds_disconnect(RedsState *reds)
> GListIter iter;
> RedClient *client;
>
> - spice_info(NULL);
> + spice_debug(NULL);
> GLIST_FOREACH(reds->clients, iter, RedClient, client) {
> reds_client_disconnect(reds, client);
> }
> @@ -1149,7 +1149,7 @@ void reds_on_main_mouse_mode_request(RedsState
> *reds, void *message, size_t size
> if (reds->is_client_mouse_allowed) {
> reds_set_mouse_mode(reds, SPICE_MOUSE_MODE_CLIENT);
> } else {
> - spice_info("client mouse is disabled");
> + spice_debug("client mouse is disabled");
> }
> break;
> case SPICE_MOUSE_MODE_SERVER:
> @@ -1563,7 +1563,7 @@ static bool reds_send_link_error(RedLinkInfo
> *link, uint32_t error)
>
> static void reds_info_new_channel(RedLinkInfo *link, int
> connection_id)
> {
> - spice_info("channel %d:%d, connected successfully, over %s
> link",
> + spice_debug("channel %d:%d, connected successfully, over %s
> link",
> link->link_mess->channel_type,
> link->link_mess->channel_id,
> reds_stream_is_ssl(link->stream) ? "Secure" : "Non
> Secure");
> @@ -1588,7 +1588,7 @@ static void
> reds_mig_target_client_add(RedsState *reds, RedClient *client)
> RedsMigTargetClient *mig_client;
>
> g_return_if_fail(reds);
> - spice_info(NULL);
> + spice_debug(NULL);
> mig_client = spice_new0(RedsMigTargetClient, 1);
> mig_client->client = client;
> mig_client->reds = reds;
> @@ -1678,7 +1678,7 @@ static void reds_handle_main_link(RedsState
> *reds, RedLinkInfo *link)
> MainChannelClient *mcc;
> int mig_target = FALSE;
>
> - spice_info(NULL);
> + spice_debug(NULL);
> spice_assert(reds->main_channel);
>
> link_mess = link->link_mess;
> @@ -1716,7 +1716,7 @@ static void reds_handle_main_link(RedsState
> *reds, RedLinkInfo *link)
> link_mess->num_common_caps,
> link_mess->num_common_caps ? caps :
> NULL, link_mess->num_channel_caps,
> link_mess->num_channel_caps ? caps +
> link_mess->num_common_caps : NULL);
> - spice_info("NEW Client %p mcc %p connect-id %d", client, mcc,
> connection_id);
> + spice_debug("NEW Client %p mcc %p connect-id %d", client, mcc,
> connection_id);
> free(link_mess);
> red_client_set_main(client, mcc);
>
> @@ -1804,10 +1804,10 @@ static int
> reds_link_mig_target_channels(RedsState *reds, RedClient *client)
> RedsMigTargetClient *mig_client;
> GList *item;
>
> - spice_info("%p", client);
> + spice_debug("%p", client);
> mig_client = reds_mig_target_client_find(reds, client);
> if (!mig_client) {
> - spice_info("Error: mig target client was not found");
> + spice_debug("Error: mig target client was not found");
> return FALSE;
> }
>
> @@ -1854,7 +1854,7 @@ void
> reds_on_client_seamless_migrate_complete(RedsState *reds, RedClient
> *client
> {
> spice_debug(NULL);
> if (!reds_find_client(reds, client)) {
> - spice_info("client no longer exists");
> + spice_debug("client no longer exists");
> return;
> }
> main_channel_client_migrate_dst_complete(red_client_get_main(cl
> ient));
> @@ -1864,7 +1864,7 @@ void
> reds_on_client_semi_seamless_migrate_complete(RedsState *reds,
> RedClient *c
> {
> MainChannelClient *mcc;
>
> - spice_info("%p", client);
> + spice_debug("%p", client);
> mcc = red_client_get_main(client);
>
> // TODO: not doing net test. consider doing it on
> client_migrate_info
> @@ -2140,7 +2140,7 @@ static void reds_handle_auth_mechanism(void
> *opaque)
> RedLinkInfo *link = (RedLinkInfo *)opaque;
> RedsState *reds = link->reds;
>
> - spice_info("Auth method: %d", link-
> >auth_mechanism.auth_mechanism);
> + spice_debug("Auth method: %d", link-
> >auth_mechanism.auth_mechanism);
>
> link->auth_mechanism.auth_mechanism = GUINT32_FROM_LE(link-
> >auth_mechanism.auth_mechanism);
> if (link->auth_mechanism.auth_mechanism ==
> SPICE_COMMON_CAP_AUTH_SPICE
> @@ -2149,7 +2149,7 @@ static void reds_handle_auth_mechanism(void
> *opaque)
> reds_get_spice_ticket(link);
> #if HAVE_SASL
> } else if (link->auth_mechanism.auth_mechanism ==
> SPICE_COMMON_CAP_AUTH_SASL) {
> - spice_info("Starting SASL");
> + spice_debug("Starting SASL");
> reds_start_auth_sasl(link);
> #endif
> } else {
> @@ -2572,9 +2572,9 @@ static int reds_init_socket(const char *addr,
> int portnr, int family)
> uaddr,INET6_ADDRSTRLEN, uport,32,
> NI_NUMERICHOST | NI_NUMERICSERV);
> if (rc == 0) {
> - spice_info("bound to %s:%s", uaddr, uport);
> + spice_debug("bound to %s:%s", uaddr, uport);
> } else {
> - spice_info("cannot resolve address spice-server is
> bound to");
> + spice_debug("cannot resolve address spice-server is
> bound to");
> }
> freeaddrinfo(res);
> goto listen;
> @@ -2795,7 +2795,7 @@ static int reds_init_ssl(RedsState *reds)
> /* Load our keys and certificates*/
> return_code = SSL_CTX_use_certificate_chain_file(reds->ctx,
> reds->config->ssl_parameters.certs_file);
> if (return_code == 1) {
> - spice_info("Loaded certificates from %s", reds->config-
> >ssl_parameters.certs_file);
> + spice_debug("Loaded certificates from %s", reds->config-
> >ssl_parameters.certs_file);
> } else {
> spice_warning("Could not load certificates from %s", reds-
> >config->ssl_parameters.certs_file);
> return -1;
> @@ -2807,7 +2807,7 @@ static int reds_init_ssl(RedsState *reds)
> return_code = SSL_CTX_use_PrivateKey_file(reds->ctx, reds-
> >config->ssl_parameters.private_key_file,
> SSL_FILETYPE_PEM);
> if (return_code == 1) {
> - spice_info("Using private key from %s", reds->config-
> >ssl_parameters.private_key_file);
> + spice_debug("Using private key from %s", reds->config-
> >ssl_parameters.private_key_file);
> } else {
> spice_warning("Could not use private key file");
> return -1;
> @@ -2816,7 +2816,7 @@ static int reds_init_ssl(RedsState *reds)
> /* Load the CAs we trust*/
> return_code = SSL_CTX_load_verify_locations(reds->ctx, reds-
> >config->ssl_parameters.ca_certificate_file, 0);
> if (return_code == 1) {
> - spice_info("Loaded CA certificates from %s", reds->config-
> >ssl_parameters.ca_certificate_file);
> + spice_debug("Loaded CA certificates from %s", reds->config-
> >ssl_parameters.ca_certificate_file);
> } else {
> spice_warning("Could not use CA file %s", reds->config-
> >ssl_parameters.ca_certificate_file);
> return -1;
> @@ -2912,7 +2912,7 @@ static void reds_mig_release(RedsState *reds)
>
> static void reds_mig_started(RedsState *reds)
> {
> - spice_info(NULL);
> + spice_debug(NULL);
> spice_assert(reds->config->mig_spice);
>
> reds->mig_inprogress = TRUE;
> @@ -2963,7 +2963,7 @@ static void
> reds_migrate_channels_seamless(RedsState *reds)
>
> static void reds_mig_finished(RedsState *reds, int completed)
> {
> - spice_info(NULL);
> + spice_debug(NULL);
>
> reds->mig_inprogress = TRUE;
>
> @@ -2994,7 +2994,7 @@ static void reds_mig_switch(RedsState *reds)
> static void migrate_timeout(void *opaque)
> {
> RedsState *reds = opaque;
> - spice_info(NULL);
> + spice_debug(NULL);
> spice_assert(reds->mig_wait_connect || reds-
> >mig_wait_disconnect);
> if (reds->mig_wait_connect) {
> /* we will fall back to the switch host scheme when
> migration completes */
> @@ -3141,7 +3141,7 @@ static int
> spice_server_char_device_add_interface(SpiceServer *reds,
> SPICE_CONTAINEROF(sin, SpiceCharDeviceInstance, base);
> RedCharDevice *dev_state = NULL;
>
> - spice_info("CHAR_DEVICE %s", char_device->subtype);
> + spice_debug("CHAR_DEVICE %s", char_device->subtype);
> if (strcmp(char_device->subtype, SUBTYPE_VDAGENT) == 0) {
> if (reds->vdagent) {
> spice_warning("vdagent already attached");
> @@ -3194,7 +3194,7 @@ static void
> spice_server_char_device_remove_interface(RedsState *reds, SpiceBase
> SpiceCharDeviceInstance* char_device =
> SPICE_CONTAINEROF(sin, SpiceCharDeviceInstance, base);
>
> - spice_info("remove CHAR_DEVICE %s", char_device->subtype);
> + spice_debug("remove CHAR_DEVICE %s", char_device->subtype);
> if (strcmp(char_device->subtype, SUBTYPE_VDAGENT) == 0) {
> if (reds->vdagent) {
> reds_agent_remove(reds);
> @@ -3222,7 +3222,7 @@ SPICE_GNUC_VISIBLE int
> spice_server_add_interface(SpiceServer *reds,
> const SpiceBaseInterface *interface = sin->sif;
>
> if (strcmp(interface->type, SPICE_INTERFACE_KEYBOARD) == 0) {
> - spice_info("SPICE_INTERFACE_KEYBOARD");
> + spice_debug("SPICE_INTERFACE_KEYBOARD");
> if (interface->major_version !=
> SPICE_INTERFACE_KEYBOARD_MAJOR ||
> interface->minor_version >
> SPICE_INTERFACE_KEYBOARD_MINOR) {
> spice_warning("unsupported keyboard interface");
> @@ -3232,7 +3232,7 @@ SPICE_GNUC_VISIBLE int
> spice_server_add_interface(SpiceServer *reds,
> return -1;
> }
> } else if (strcmp(interface->type, SPICE_INTERFACE_MOUSE) == 0)
> {
> - spice_info("SPICE_INTERFACE_MOUSE");
> + spice_debug("SPICE_INTERFACE_MOUSE");
> if (interface->major_version != SPICE_INTERFACE_MOUSE_MAJOR
> ||
> interface->minor_version > SPICE_INTERFACE_MOUSE_MINOR)
> {
> spice_warning("unsupported mouse interface");
> @@ -3244,7 +3244,7 @@ SPICE_GNUC_VISIBLE int
> spice_server_add_interface(SpiceServer *reds,
> } else if (strcmp(interface->type, SPICE_INTERFACE_QXL) == 0) {
> QXLInstance *qxl;
>
> - spice_info("SPICE_INTERFACE_QXL");
> + spice_debug("SPICE_INTERFACE_QXL");
> if (interface->major_version != SPICE_INTERFACE_QXL_MAJOR
> ||
> interface->minor_version > SPICE_INTERFACE_QXL_MINOR) {
> spice_warning("unsupported qxl interface");
> @@ -3264,7 +3264,7 @@ SPICE_GNUC_VISIBLE int
> spice_server_add_interface(SpiceServer *reds,
> red_qxl_set_compression_level(qxl,
> calc_compression_level(reds));
> } else if (strcmp(interface->type, SPICE_INTERFACE_TABLET) ==
> 0) {
> SpiceTabletInstance *tablet = SPICE_CONTAINEROF(sin,
> SpiceTabletInstance, base);
> - spice_info("SPICE_INTERFACE_TABLET");
> + spice_debug("SPICE_INTERFACE_TABLET");
> if (interface->major_version !=
> SPICE_INTERFACE_TABLET_MAJOR ||
> interface->minor_version >
> SPICE_INTERFACE_TABLET_MINOR) {
> spice_warning("unsupported tablet interface");
> @@ -3279,7 +3279,7 @@ SPICE_GNUC_VISIBLE int
> spice_server_add_interface(SpiceServer *reds,
> }
>
> } else if (strcmp(interface->type, SPICE_INTERFACE_PLAYBACK) ==
> 0) {
> - spice_info("SPICE_INTERFACE_PLAYBACK");
> + spice_debug("SPICE_INTERFACE_PLAYBACK");
> if (interface->major_version !=
> SPICE_INTERFACE_PLAYBACK_MAJOR ||
> interface->minor_version >
> SPICE_INTERFACE_PLAYBACK_MINOR) {
> spice_warning("unsupported playback interface");
> @@ -3288,7 +3288,7 @@ SPICE_GNUC_VISIBLE int
> spice_server_add_interface(SpiceServer *reds,
> snd_attach_playback(reds, SPICE_CONTAINEROF(sin,
> SpicePlaybackInstance, base));
>
> } else if (strcmp(interface->type, SPICE_INTERFACE_RECORD) ==
> 0) {
> - spice_info("SPICE_INTERFACE_RECORD");
> + spice_debug("SPICE_INTERFACE_RECORD");
> if (interface->major_version !=
> SPICE_INTERFACE_RECORD_MAJOR ||
> interface->minor_version >
> SPICE_INTERFACE_RECORD_MINOR) {
> spice_warning("unsupported record interface");
> @@ -3305,7 +3305,7 @@ SPICE_GNUC_VISIBLE int
> spice_server_add_interface(SpiceServer *reds,
> spice_server_char_device_add_interface(reds, sin);
>
> } else if (strcmp(interface->type, SPICE_INTERFACE_MIGRATION)
> == 0) {
> - spice_info("SPICE_INTERFACE_MIGRATION");
> + spice_debug("SPICE_INTERFACE_MIGRATION");
> if (reds->migration_interface) {
> spice_warning("already have migration");
> return -1;
> @@ -3335,14 +3335,14 @@ SPICE_GNUC_VISIBLE int
> spice_server_remove_interface(SpiceBaseInstance *sin)
> SpiceTabletInstance *tablet = SPICE_CONTAINEROF(sin,
> SpiceTabletInstance, base);
> g_return_val_if_fail(tablet->st != NULL, -1);
> reds = spice_tablet_state_get_server(tablet->st);
> - spice_info("remove SPICE_INTERFACE_TABLET");
> + spice_debug("remove SPICE_INTERFACE_TABLET");
> inputs_channel_detach_tablet(reds->inputs_channel, tablet);
> reds_update_mouse_mode(reds);
> } else if (strcmp(interface->type, SPICE_INTERFACE_PLAYBACK) ==
> 0) {
> - spice_info("remove SPICE_INTERFACE_PLAYBACK");
> + spice_debug("remove SPICE_INTERFACE_PLAYBACK");
> snd_detach_playback(SPICE_CONTAINEROF(sin,
> SpicePlaybackInstance, base));
> } else if (strcmp(interface->type, SPICE_INTERFACE_RECORD) ==
> 0) {
> - spice_info("remove SPICE_INTERFACE_RECORD");
> + spice_debug("remove SPICE_INTERFACE_RECORD");
> snd_detach_record(SPICE_CONTAINEROF(sin,
> SpiceRecordInstance, base));
> } else if (strcmp(interface->type, SPICE_INTERFACE_CHAR_DEVICE)
> == 0) {
> SpiceCharDeviceInstance *char_device =
> SPICE_CONTAINEROF(sin, SpiceCharDeviceInstance, base);
> @@ -3367,7 +3367,7 @@ SPICE_GNUC_VISIBLE int
> spice_server_remove_interface(SpiceBaseInstance *sin)
>
> static int do_spice_init(RedsState *reds, SpiceCoreInterface
> *core_interface)
> {
> - spice_info("starting %s", VERSION);
> + spice_debug("starting %s", VERSION);
>
> #if !GLIB_CHECK_VERSION(2,36,0)
> g_type_init();
> @@ -4047,11 +4047,11 @@ SPICE_GNUC_VISIBLE int
> spice_server_migrate_connect(SpiceServer *reds, const cha
> SpiceMigrateInterface *sif;
> int try_seamless;
>
> - spice_info(NULL);
> + spice_debug(NULL);
> spice_assert(reds->migration_interface);
>
> if (reds->expect_migrate) {
> - spice_info("consecutive calls without migration. Canceling
> previous call");
> + spice_debug("consecutive calls without migration. Canceling
> previous call");
> main_channel_migrate_src_complete(reds->main_channel,
> FALSE);
> }
>
> @@ -4082,7 +4082,7 @@ SPICE_GNUC_VISIBLE int
> spice_server_migrate_connect(SpiceServer *reds, const cha
> } else {
> if (reds->clients == NULL) {
> reds_mig_release(reds);
> - spice_info("no client connected");
> + spice_debug("no client connected");
> }
> sif->migrate_connect_complete(reds->migration_interface);
> }
> @@ -4094,7 +4094,7 @@ SPICE_GNUC_VISIBLE int
> spice_server_migrate_info(SpiceServer *reds, const char*
> int port, int
> secure_port,
> const char* cert_subject)
> {
> - spice_info(NULL);
> + spice_debug(NULL);
> spice_assert(!reds->migration_interface);
>
> if (!reds_set_migration_dest_info(reds, dest, port,
> secure_port, cert_subject)) {
> @@ -4105,7 +4105,7 @@ SPICE_GNUC_VISIBLE int
> spice_server_migrate_info(SpiceServer *reds, const char*
>
> SPICE_GNUC_VISIBLE int spice_server_migrate_start(SpiceServer
> *reds)
> {
> - spice_info(NULL);
> + spice_debug(NULL);
> if (!reds->config->mig_spice) {
> return -1;
> }
> @@ -4117,7 +4117,7 @@ SPICE_GNUC_VISIBLE int
> spice_server_migrate_end(SpiceServer *reds, int completed
> SpiceMigrateInterface *sif;
> int ret = 0;
>
> - spice_info(NULL);
> + spice_debug(NULL);
>
> spice_assert(reds->migration_interface);
>
> @@ -4131,7 +4131,7 @@ SPICE_GNUC_VISIBLE int
> spice_server_migrate_end(SpiceServer *reds, int completed
>
> reds->expect_migrate = FALSE;
> if (!reds_main_channel_connected(reds)) {
> - spice_info("no peer connected");
> + spice_debug("no peer connected");
> goto complete;
> }
> reds_mig_finished(reds, completed);
> @@ -4146,7 +4146,7 @@ complete:
> /* interface for switch-host migration */
> SPICE_GNUC_VISIBLE int spice_server_migrate_switch(SpiceServer
> *reds)
> {
> - spice_info(NULL);
> + spice_debug(NULL);
> if (reds->clients == NULL) {
> return 0;
> }
> diff --git a/server/sound.c b/server/sound.c
> index 7c36174..aa20f92 100644
> --- a/server/sound.c
> +++ b/server/sound.c
> @@ -957,7 +957,7 @@ SPICE_GNUC_VISIBLE void
> spice_server_playback_put_samples(SpicePlaybackInstance
> playback_client = frame->client;
> if (!playback_client || sin->st->channel.connection !=
> SND_CHANNEL_CLIENT(playback_client)) {
> /* lost last reference, client has been destroyed
> previously */
> - spice_info("audio samples belong to a disconnected
> client");
> + spice_debug("audio samples belong to a disconnected
> client");
> return;
> }
> spice_assert(SND_CHANNEL_CLIENT(playback_client)->active);
More information about the Spice-devel
mailing list