colin/ModemManager
1
0
Fork 0
Code Issues Pull Requests Actions Packages Projects Releases Wiki Activity

iface-modem-simple: improve logging of user request to connect modem

Browse Source
This commit is contained in:
Aleksander Morgado
2022-09-13 13:53:20 +00:00
parent b5a727d086
commit 794386d490
1 changed files with 48 additions and 101 deletions
Download Patch File Download Diff File Expand all files Collapse all files

149
src/mm-iface-modem-simple.c
View File

@@ -28,6 +28,7 @@
#include "mm-iface-modem-cdma.h" #include "mm-iface-modem-cdma.h"
#include "mm-iface-modem-simple.h" #include "mm-iface-modem-simple.h"
#include "mm-log-object.h" #include "mm-log-object.h"
#include "mm-log-helpers.h"
/*****************************************************************************/ /*****************************************************************************/
/* Private data context */ /* Private data context */
@@ -225,14 +226,14 @@ typedef enum {
} ConnectionStep; } ConnectionStep;
typedef struct { typedef struct {
MmGdbusModemSimple *skeleton; MmGdbusModemSimple *skeleton;
GDBusMethodInvocation *invocation; GDBusMethodInvocation *invocation;
MMIfaceModemSimple *self; MMIfaceModemSimple *self;
ConnectionStep step; ConnectionStep step;
MMBearerList *bearer_list; MMBearerList *bearer_list;
/* Expected input properties */ /* Expected input properties */
GVariant *dictionary; GVariant *dictionary;
MMSimpleConnectProperties *properties; MMSimpleConnectProperties *properties;
/* Results to set */ /* Results to set */
@@ -272,33 +273,32 @@ connection_context_free (ConnectionContext *ctx)
g_object_unref (ctx->skeleton); g_object_unref (ctx->skeleton);
g_object_unref (ctx->invocation); g_object_unref (ctx->invocation);
g_object_unref (ctx->self); g_object_unref (ctx->self);
g_free (ctx); g_slice_free (ConnectionContext, ctx);
} }
static void connection_step (ConnectionContext *ctx); static void connection_step (ConnectionContext *ctx);
static void static void
connect_bearer_ready (MMBaseBearer *bearer, connect_bearer_ready (MMBaseBearer *bearer,
GAsyncResult *res, GAsyncResult *res,
ConnectionContext *ctx) ConnectionContext *ctx)
{ {
GError *error = NULL; GError *error = NULL;
if (!mm_base_bearer_connect_finish (bearer, res, &error)) { if (!mm_base_bearer_connect_finish (bearer, res, &error)) {
mm_obj_dbg (ctx->self, "couldn't connect bearer: %s", error->message); mm_obj_warn (ctx->self, "couldn't connect bearer: %s", error->message);
g_dbus_method_invocation_take_error (ctx->invocation, error); g_dbus_method_invocation_take_error (ctx->invocation, error);
connection_context_free (ctx); connection_context_free (ctx);
return; return;
} }
/* Bearer connected.... all done!!!!! */
ctx->step++; ctx->step++;
connection_step (ctx); connection_step (ctx);
} }
static void static void
create_bearer_ready (MMIfaceModem *self, create_bearer_ready (MMIfaceModem *self,
GAsyncResult *res, GAsyncResult *res,
ConnectionContext *ctx) ConnectionContext *ctx)
{ {
GError *error = NULL; GError *error = NULL;
@@ -306,12 +306,12 @@ create_bearer_ready (MMIfaceModem *self,
/* ownership for the caller */ /* ownership for the caller */
ctx->bearer = mm_iface_modem_create_bearer_finish (self, res, &error); ctx->bearer = mm_iface_modem_create_bearer_finish (self, res, &error);
if (!ctx->bearer) { if (!ctx->bearer) {
mm_obj_warn (ctx->self, "couldn't create bearer: %s", error->message);
g_dbus_method_invocation_take_error (ctx->invocation, error); g_dbus_method_invocation_take_error (ctx->invocation, error);
connection_context_free (ctx); connection_context_free (ctx);
return; return;
} }
/* Bearer available! */
ctx->step++; ctx->step++;
connection_step (ctx); connection_step (ctx);
} }
@@ -324,30 +324,30 @@ wait_for_packet_service_state_ready (MMIfaceModem3gpp *self,
GError *error = NULL; GError *error = NULL;
if (!mm_iface_modem_3gpp_wait_for_packet_service_state_finish (self, res, &error)) { if (!mm_iface_modem_3gpp_wait_for_packet_service_state_finish (self, res, &error)) {
mm_obj_warn (ctx->self, "couldn't attach packet service: %s", error->message);
g_dbus_method_invocation_take_error (ctx->invocation, error); g_dbus_method_invocation_take_error (ctx->invocation, error);
connection_context_free (ctx); connection_context_free (ctx);
return; return;
} }
/* Packet service attached now! */
ctx->step++; ctx->step++;
connection_step (ctx); connection_step (ctx);
} }
static void static void
register_in_3gpp_or_cdma_network_ready (MMIfaceModemSimple *self, register_in_3gpp_or_cdma_network_ready (MMIfaceModemSimple *self,
GAsyncResult *res, GAsyncResult *res,
ConnectionContext *ctx) ConnectionContext *ctx)
{ {
GError *error = NULL; GError *error = NULL;
if (!register_in_3gpp_or_cdma_network_finish (self, res, &error)) { if (!register_in_3gpp_or_cdma_network_finish (self, res, &error)) {
mm_obj_warn (ctx->self, "registration in network failed: %s", error->message);
g_dbus_method_invocation_take_error (ctx->invocation, error); g_dbus_method_invocation_take_error (ctx->invocation, error);
connection_context_free (ctx); connection_context_free (ctx);
return; return;
} }
/* Registered now! */
ctx->step++; ctx->step++;
connection_step (ctx); connection_step (ctx);
} }
@@ -362,21 +362,23 @@ wait_after_enabled_ready (ConnectionContext *ctx)
} }
static void static void
wait_for_enabled_ready (MMIfaceModem *self, wait_for_enabled_ready (MMIfaceModem *self,
GAsyncResult *res, GAsyncResult *res,
ConnectionContext *ctx) ConnectionContext *ctx)
{ {
GError *error = NULL; GError *error = NULL;
MMModemState state; MMModemState state;
state = mm_iface_modem_wait_for_final_state_finish (self, res, &error); state = mm_iface_modem_wait_for_final_state_finish (self, res, &error);
if (error) { if (error) {
mm_obj_warn (ctx->self, "failed waiting for final state: %s", error->message);
g_dbus_method_invocation_take_error (ctx->invocation, error); g_dbus_method_invocation_take_error (ctx->invocation, error);
connection_context_free (ctx); connection_context_free (ctx);
return; return;
} }
if (state < MM_MODEM_STATE_ENABLED) { if (state < MM_MODEM_STATE_ENABLED) {
mm_obj_warn (ctx->self, "failed waiting for enabled state: %s", mm_modem_state_get_string (state));
g_dbus_method_invocation_return_error ( g_dbus_method_invocation_return_error (
ctx->invocation, ctx->invocation,
MM_CORE_ERROR, MM_CORE_ERROR,
@@ -387,25 +389,24 @@ wait_for_enabled_ready (MMIfaceModem *self,
return; return;
} }
/* Enabled now, cool. */
ctx->step++; ctx->step++;
connection_step (ctx); connection_step (ctx);
} }
static void static void
enable_ready (MMBaseModem *self, enable_ready (MMBaseModem *self,
GAsyncResult *res, GAsyncResult *res,
ConnectionContext *ctx) ConnectionContext *ctx)
{ {
GError *error = NULL; GError *error = NULL;
if (!mm_base_modem_enable_finish (MM_BASE_MODEM (self), res, &error)) { if (!mm_base_modem_enable_finish (MM_BASE_MODEM (self), res, &error)) {
mm_obj_warn (ctx->self, "failed enabling modem: %s", error->message);
g_dbus_method_invocation_take_error (ctx->invocation, error); g_dbus_method_invocation_take_error (ctx->invocation, error);
connection_context_free (ctx); connection_context_free (ctx);
return; return;
} }
/* Enabling done!, keep on!!! */
ctx->step++; ctx->step++;
connection_step (ctx); connection_step (ctx);
} }
@@ -419,45 +420,46 @@ wait_for_initialized_ready (MMIfaceModem *self,
mm_iface_modem_wait_for_final_state_finish (self, res, &error); mm_iface_modem_wait_for_final_state_finish (self, res, &error);
if (error) { if (error) {
mm_obj_warn (ctx->self, "failed waiting for final state: %s", error->message);
g_dbus_method_invocation_take_error (ctx->invocation, error); g_dbus_method_invocation_take_error (ctx->invocation, error);
connection_context_free (ctx); connection_context_free (ctx);
return; return;
} }
/* Initialized now, cool. */
ctx->step++; ctx->step++;
connection_step (ctx); connection_step (ctx);
} }
static void static void
send_pin_ready (MMBaseSim *sim, send_pin_ready (MMBaseSim *sim,
GAsyncResult *res, GAsyncResult *res,
ConnectionContext *ctx) ConnectionContext *ctx)
{ {
GError *error = NULL; GError *error = NULL;
if (!mm_base_sim_send_pin_finish (sim, res, &error)) { if (!mm_base_sim_send_pin_finish (sim, res, &error)) {
mm_obj_warn (ctx->self, "failed sending SIM PIN: %s", error->message);
g_dbus_method_invocation_take_error (ctx->invocation, error); g_dbus_method_invocation_take_error (ctx->invocation, error);
connection_context_free (ctx); connection_context_free (ctx);
return; return;
} }
/* Sent pin, cool. */
ctx->step++; ctx->step++;
connection_step (ctx); connection_step (ctx);
} }
static void static void
update_lock_info_ready (MMIfaceModem *self, update_lock_info_ready (MMIfaceModem *self,
GAsyncResult *res, GAsyncResult *res,
ConnectionContext *ctx) ConnectionContext *ctx)
{ {
GError *error = NULL; GError *error = NULL;
MMModemLock lock; MMModemLock lock;
MMBaseSim *sim; g_autoptr(MMBaseSim) sim = NULL;
lock = mm_iface_modem_update_lock_info_finish (self, res, &error); lock = mm_iface_modem_update_lock_info_finish (self, res, &error);
if (error) { if (error) {
mm_obj_warn (ctx->self, "failed updating lock info: %s", error->message);
g_dbus_method_invocation_take_error (ctx->invocation, error); g_dbus_method_invocation_take_error (ctx->invocation, error);
connection_context_free (ctx); connection_context_free (ctx);
return; return;
@@ -477,6 +479,8 @@ update_lock_info_ready (MMIfaceModem *self,
/* During simple connect we are only allowed to use SIM PIN */ /* During simple connect we are only allowed to use SIM PIN */
if (lock != MM_MODEM_LOCK_SIM_PIN || if (lock != MM_MODEM_LOCK_SIM_PIN ||
!mm_simple_connect_properties_get_pin (ctx->properties)) { !mm_simple_connect_properties_get_pin (ctx->properties)) {
mm_obj_warn (ctx->self, "modem is locked with '%s'",
mm_modem_lock_get_string (lock));
g_dbus_method_invocation_return_error ( g_dbus_method_invocation_return_error (
ctx->invocation, ctx->invocation,
MM_CORE_ERROR, MM_CORE_ERROR,
@@ -488,11 +492,11 @@ update_lock_info_ready (MMIfaceModem *self,
} }
/* Try to unlock the modem providing the PIN */ /* Try to unlock the modem providing the PIN */
sim = NULL;
g_object_get (ctx->self, g_object_get (ctx->self,
MM_IFACE_MODEM_SIM, &sim, MM_IFACE_MODEM_SIM, &sim,
NULL); NULL);
if (!sim) { if (!sim) {
mm_obj_warn (ctx->self, "SIM is not accessible");
g_dbus_method_invocation_return_error ( g_dbus_method_invocation_return_error (
ctx->invocation, ctx->invocation,
MM_CORE_ERROR, MM_CORE_ERROR,
@@ -506,7 +510,6 @@ update_lock_info_ready (MMIfaceModem *self,
mm_simple_connect_properties_get_pin (ctx->properties), mm_simple_connect_properties_get_pin (ctx->properties),
(GAsyncReadyCallback)send_pin_ready, (GAsyncReadyCallback)send_pin_ready,
ctx); ctx);
g_object_unref (sim);
} }
static gboolean static gboolean
@@ -517,6 +520,7 @@ completed_if_cancelled (ConnectionContext *ctx)
return FALSE; return FALSE;
/* Otherwise cancellable is valid and it's cancelled */ /* Otherwise cancellable is valid and it's cancelled */
mm_obj_warn (ctx->self, "connection attempt cancelled");
g_dbus_method_invocation_return_error ( g_dbus_method_invocation_return_error (
ctx->invocation, G_IO_ERROR, G_IO_ERROR_CANCELLED, ctx->invocation, G_IO_ERROR, G_IO_ERROR_CANCELLED,
"Connection attempt cancelled"); "Connection attempt cancelled");
@@ -676,8 +680,7 @@ connection_step (ConnectionContext *ctx)
return; return;
} }
mm_obj_dbg (ctx->self, "bearer at '%s' is already connected...", mm_obj_info (ctx->self, "bearer at '%s' is already connected...", mm_base_bearer_get_path (ctx->bearer));
mm_base_bearer_get_path (ctx->bearer));
ctx->step++; ctx->step++;
/* fall through */ /* fall through */
@@ -721,6 +724,9 @@ connect_auth_ready (MMBaseModem *self,
return; return;
} }
mm_obj_info (self, "processing user request to connect modem...");
mm_log_simple_connect_properties (self, MM_LOG_LEVEL_INFO, " ", ctx->properties);
if (!setup_cancellation (ctx, &error)) { if (!setup_cancellation (ctx, &error)) {
g_dbus_method_invocation_take_error (ctx->invocation, error); g_dbus_method_invocation_take_error (ctx->invocation, error);
connection_context_free (ctx); connection_context_free (ctx);
@@ -742,63 +748,6 @@ connect_auth_ready (MMBaseModem *self,
mm_obj_msg (self, "simple connect started..."); mm_obj_msg (self, "simple connect started...");
/* Log about all the parameters being used for the simple connect */
{
MMBearerMultiplexSupport multiplex;
MMBearerAllowedAuth allowed_auth;
MMBearerApnType apn_type;
gchar *str;
MMBearerIpFamily ip_family;
gint profile_id;
#define VALIDATE_UNSPECIFIED(str) (str ? str : "unspecified")
profile_id = mm_simple_connect_properties_get_profile_id (ctx->properties);
if (profile_id != MM_3GPP_PROFILE_ID_UNKNOWN)
mm_obj_dbg (self, " profile ID: %d", profile_id);
else
mm_obj_dbg (self, " profile ID: %s", VALIDATE_UNSPECIFIED (NULL));
mm_obj_dbg (self, " PIN: %s", VALIDATE_UNSPECIFIED (mm_simple_connect_properties_get_pin (ctx->properties)));
mm_obj_dbg (self, " operator ID: %s", VALIDATE_UNSPECIFIED (mm_simple_connect_properties_get_operator_id (ctx->properties)));
mm_obj_dbg (self, " allowed roaming: %s", mm_simple_connect_properties_get_allow_roaming (ctx->properties) ? "yes" : "no");
mm_obj_dbg (self, " APN: %s", VALIDATE_UNSPECIFIED (mm_simple_connect_properties_get_apn (ctx->properties)));
apn_type = mm_simple_connect_properties_get_apn_type (ctx->properties);
if (apn_type != MM_BEARER_APN_TYPE_NONE) {
str = mm_bearer_apn_type_build_string_from_mask (apn_type);
mm_obj_dbg (self, " APN type: %s", str);
g_free (str);
} else
mm_obj_dbg (self, " APN type: %s", VALIDATE_UNSPECIFIED (NULL));
ip_family = mm_simple_connect_properties_get_ip_type (ctx->properties);
if (ip_family != MM_BEARER_IP_FAMILY_NONE) {
str = mm_bearer_ip_family_build_string_from_mask (ip_family);
mm_obj_dbg (self, " IP family: %s", str);
g_free (str);
} else
mm_obj_dbg (self, " IP family: %s", VALIDATE_UNSPECIFIED (NULL));
allowed_auth = mm_simple_connect_properties_get_allowed_auth (ctx->properties);
if (allowed_auth != MM_BEARER_ALLOWED_AUTH_UNKNOWN) {
str = mm_bearer_allowed_auth_build_string_from_mask (allowed_auth);
mm_obj_dbg (self, " allowed authentication: %s", str);
g_free (str);
} else
mm_obj_dbg (self, " allowed authentication: %s", VALIDATE_UNSPECIFIED (NULL));
mm_obj_dbg (self, " user: %s", VALIDATE_UNSPECIFIED (mm_simple_connect_properties_get_user (ctx->properties)));
mm_obj_dbg (self, " password: %s", VALIDATE_UNSPECIFIED (mm_simple_connect_properties_get_password (ctx->properties)));
multiplex = mm_simple_connect_properties_get_multiplex (ctx->properties);
mm_obj_dbg (self, " multiplex: %s", VALIDATE_UNSPECIFIED (multiplex != MM_BEARER_MULTIPLEX_SUPPORT_UNKNOWN ?
mm_bearer_multiplex_support_get_string (multiplex) :
NULL));
#undef VALIDATE_UNSPECIFIED
}
switch (current) { switch (current) {
case MM_MODEM_STATE_FAILED: case MM_MODEM_STATE_FAILED:
case MM_MODEM_STATE_UNKNOWN: case MM_MODEM_STATE_UNKNOWN:
@@ -842,21 +791,19 @@ connect_auth_ready (MMBaseModem *self,
} }
static gboolean static gboolean
handle_connect (MmGdbusModemSimple *skeleton, handle_connect (MmGdbusModemSimple *skeleton,
GDBusMethodInvocation *invocation, GDBusMethodInvocation *invocation,
GVariant *dictionary, GVariant *dictionary,
MMIfaceModemSimple *self) MMIfaceModemSimple *self)
{ {
ConnectionContext *ctx; ConnectionContext *ctx;
ctx = g_new0 (ConnectionContext, 1); ctx = g_slice_new0 (ConnectionContext);
ctx->skeleton = g_object_ref (skeleton); ctx->skeleton = g_object_ref (skeleton);
ctx->invocation = g_object_ref (invocation); ctx->invocation = g_object_ref (invocation);
ctx->self = g_object_ref (self); ctx->self = g_object_ref (self);
ctx->dictionary = g_variant_ref (dictionary); ctx->dictionary = g_variant_ref (dictionary);
mm_obj_dbg (self, "user request to connect modem");
mm_base_modem_authorize (MM_BASE_MODEM (self), mm_base_modem_authorize (MM_BASE_MODEM (self),
invocation, invocation,
MM_AUTHORIZATION_DEVICE_CONTROL, MM_AUTHORIZATION_DEVICE_CONTROL,