Re: NetworkManager 1.1.90 : nm-exported-object.c:293:nm_exported_object_class_add_interface: assertion failed: (object_property != NULL)

[Dan Williams]

On Mon, 2016-03-14 at 10:51 -0700, Ali Nematollahi wrote:
> Hello Dan
> Ok, some progress
> One of my colleagues suggested sending an "AT" at the same time as
> "AT^SCFG": AT^SCFG\r\AT"...So I changed the plugin that sends SCFG
> and it
> actually worked. The modem responds to SCFG immediately and MM sees
> the
> response.
> It still asks for AT+CGDCONT=? and the modem responds but the result
> is
> still IP = none:

Yeah, ModemManager chokes on the split PDP context IDs.  Does this
patch give you the right response for supported IP methods?

--- a/src/mm-modem-helpers.c
+++ b/src/mm-modem-helpers.c
@@ -876,7 +876,7 @@ mm_3gpp_parse_cgdcont_test_response (const gchar *response,
 return NULL;
 }
 
-r = g_regex_new 
("\\+CGDCONT:\\s*\\(\\s*(\\d+)\\s*-?\\s*(\\d+)?\\s*\\)\\s*,\\s*\\(?\"(\\S+)\"",
+r = g_regex_new 
("\\+CGDCONT:\\s*\\(\\s*(\\d+)\\s*-?\\s*(\\d+)?[^\\)]*\\)\\s*,\\s*\\(?\"(\\S+)\"",
  G_REGEX_DOLLAR_ENDONLY | G_REGEX_RAW,
  0, _error);
 g_assert (r != NULL);

Dan

> 
> broadband-modem.c:951] modem_load_device_identifier_finish(): loaded
> device
> identifier: 1d1cf54b58614b08fcc472e0fee0860904397d92
> ModemManager[2805]:  [1457951710.659410] [mm-broadband-
> modem.c:1601]
> modem_load_supported_modes(): loading supported modes...
> ModemManager[2805]:  [1457951710.660119] [mm-port-
> serial.c:1237]
> mm_port_serial_open(): (ttyUSB2) device open count is 3 (open)
> ModemManager[2805]:  [1457951710.660878] [mm-port-
> serial.c:1294]
> _close_internal(): (ttyUSB2) device open count is 2 (close)
> ModemManager[2805]:  [1457951710.661516] [mm-port-serial-
> at.c:440]
> debug_log(): (ttyUSB2): --> 'AT*CNTI=2'
> ModemManager[2805]:  [1457951710.684448] [mm-port-serial-
> at.c:440]
> debug_log(): (ttyUSB2): <-- 'ERROR'
> ModemManager[2805]:  [1457951710.685881] [mm-serial-
> parsers.c:364]
> mm_serial_parser_v1_parse(): Got failure code 100: Unknown error
> ModemManager[2805]:  [1457951710.686652] [mm-broadband-
> modem.c:1535]
> supported_modes_cnti_ready(): Generic query of supported 3GPP
> networks with
> *CNTI failed: 'Unknown error'
> ModemManager[2805]:  [1457951710.687360] [mm-port-
> serial.c:1237]
> mm_port_serial_open(): (ttyUSB2) device open count is 3 (open)
> ModemManager[2805]:  [1457951710.688027] [mm-port-
> serial.c:1294]
> _close_internal(): (ttyUSB2) device open count is 2 (close)
> ModemManager[2805]:   [1457951710.689190] [mm-port-
> serial.c:811]
> port_serial_queue_process(): (ttyUSB2) response array is not empty
> when
> using cached reply, cleaning up 5 bytes
> ModemManager[2805]:  [1457951710.689928] [mm-broadband-
> modem.c:1438]
> supported_modes_ws46_test_ready(): Device allows (3GPP) 2G-only
> network mode
> ModemManager[2805]:  [1457951710.690440] [mm-broadband-
> modem.c:1443]
> supported_modes_ws46_test_ready(): Device allows (3GPP) 3G-only
> network mode
> ModemManager[2805]:  [1457951710.691255] [mm-broadband-
> modem.c:1472]
> supported_modes_ws46_test_ready(): Device allows every supported 3GPP
> network mode (2G/3G)
> ModemManager[2805]:  [1457951711.027536] [mm-port-
> serial.c:1237]
> mm_port_serial_open(): (ttyUSB2) device open count is 3 (open)
> ModemManager[2805]:  [1457951711.028543] [mm-port-
> serial.c:1294]
> _close_internal(): (ttyUSB2) device open count is 2 (close)
> ModemManager[2805]:  [1457951711.029459] [mm-port-serial-
> at.c:440]
> debug_log(): (ttyUSB2): --> 'AT^SCFG=?AT'
> ModemManager[2805]:  [1457951711.089542] [mm-port-serial-
> at.c:440]
> debug_log(): (ttyUSB2): <-- '^SCFG:
> "Audio/Loop",("0","1")^SCFG: "Call/ECC",("0"-
> "255")^SCFG:
> "Call/Speech/Codec",("0","1")^SCFG:
> "GPRS/Auth",("0","1","2")^SCFG:
> "GPRS/AutoAttach",("disabled","enabled")^SCFG:
> "GPRS/MaxDataRate/HSDPA",("0","1")^SCFG:
> "GPRS/MaxDataRate/HSUPA",("0","1")^SCFG:
> "Ident/Manufacturer",(25)^SCFG:
> "Ident/Product",(25)^SCFG:
> "MEopMode/Airplane",("off","on")^SCFG:
> "MEopMode/CregRoam",("0","1")^SCFG:
> "MEopMode/CFUN",("0","1")^SCFG:
> "MEopMode/PowerMgmt/LCI",("disabled","enabled")^SCFG:
> "MEopMode/PowerMgmt/VExt",("high","low")^SCFG:
> "MEopMode/PwrSave",("disabled","enabled"),("0-600"),("1-
> 36000")^SCFG:
> "MEopMode/RingOnData",("on","off")^SCFG:
> "MEopMode/RingUrcOnCall",("on","off")^SCFG:
> "MEShutdown/OnIgnition",("on","off")^SCFG:
> "Radio/Band",("4-108","0-1")^SCFG:
> "Radio/Mtpl",("0-3","1-8","4-108","18-33","18-27")^SCFG:
> "Radio/NWSM",("0","1","2")^SCFG:
> "Radio/OutputPowerReduction",("4"-"8")^SCFG:
> "Serial/USB/DDD",("0","1"),("0"),(4),(4),(4),(63),(63),(4)^SC
> FG:
> "Serial/USB/DeviceClass/RmNet",("Vendor","CDC-ECM")^SCFG:
> "URC/DstIfc",("mdm","app")^SCFG:
> "URC/Datamode/Ringline",("off","on")^SCFG:
> "URC/Ringline",("off","local","asc0","wakeup")^SCFG:
> "URC/Ringline/ActiveTime",("0","1","2","keep")OK<
> LF>OK'
> ModemManager[2805]:  [1457951711.092246] [mm-broadband-
> modem.c:1675]
> modem_load_supported_ip_families(): loading supported IP families...
> 

Re: NetworkManager 1.1.90 : nm-exported-object.c:293:nm_exported_object_class_add_interface: assertion failed: (object_property != NULL)

[Dan Williams]

On Fri, 2016-03-11 at 10:53 -0800, Ali Nematollahi wrote:
> Hi Dan
> 
> I did the changes, and it still fails. I made the wait a little
> longer,
> still fails. I sent an mmcli AT command to the modem, it fails to
> respond:
> 



> Isn't that a response to ^SCFG?

Yes, it is.  But notice how it doesn't actually come as a response to
the AT^SCFG=? request, but only when ModemManager sends the next
request.

Dan


> 
> 
> 
> 
> On Fri, Mar 11, 2016 at 6:59 AM, Dan Williams 
> wrote:
> 
> > 
> > On Thu, 2016-03-10 at 17:34 -0800, Ali Nematollahi wrote:
> > > 
> > > So I've started looking at the code and I looked for the error
> > > message that
> > > says Missing +CGDCONT prefix. I added debugging code to print out
> > > the
> > > "response" and the result of g_str_has_prefix () function call in
> > > src/mm-modem-helpers.c: mm_3gpp_parse_cgdcont_test_response()
> > > 
> > > Here is my debugging output (highlighted in red).
> > > The response clearly has "+CGDCONT" at the beginning...but
> > > g_str_has_prefix() fails to read it. Is it because my glib is
> > > old? Or
> > > could
> > > it be because it comes out with  before it and
> > > g_str_has_prefix()
> > > is confused as a result??
> > The reason it fails is because of the "Serial command timed out";
> > the
> > modem doesn't respond to the AT^SCFG request within the expected
> > time,
> > so ModemManager gives up.  Then the response actually does happen a
> > bit
> > later, but MM has already sent the CGDCONT request, and expects a
> > CGDCONT reply instead of the ^SCFG reply.  So we probably just need
> > to
> > increase the timeout for this modem.  Can you try this change?
> > 
> > In plugins/cinterion/mm-broadband-modem-cinterion.c:
> > 
> > static void
> > load_supported_bands (MMIfaceModem *self,
> >   GAsyncReadyCallback callback,
> >   gpointer user_data)
> > {
> > GSimpleAsyncResult *simple;
> > 
> > simple = g_simple_async_result_new (G_OBJECT (self),
> > callback,
> > user_data,
> > load_supported_bands);
> > 
> > mm_base_modem_at_command (MM_BASE_MODEM (self),
> >   "AT^SCFG=?",
> > - 3,
> > + 6,
> >   FALSE,
> >   (GAsyncReadyCallback)scfg_test_ready,
> >   simple);
> > }
> > 
> > and I bet it'll start working.
> > 
> > Dan
> > 
> > > 
> > > 
> > > 
> > > 
> > > 
> > > Manager[4969]:  [1457629898.039154] [mm-port-serial-
> > > at.c:440]
> > > debug_log(): (ttyUSB2): --> 'AT^SCFG=?'
> > > ModemManager[4969]:   [1457629901.672443] [mm-iface-
> > > modem.c:3961]
> > > load_supported_bands_ready(): couldn't load Supported Bands:
> > > 'Serial
> > > command timed out'
> > > ModemManager[4969]:  [1457629901.674453] [mm-broadband-
> > > modem.c:1675]
> > > modem_load_supported_ip_families(): loading supported IP
> > > families...
> > > ModemManager[4969]:  [1457629901.675897] [mm-port-
> > > serial.c:1237]
> > > mm_port_serial_open(): (ttyUSB2) device open count is 3 (open)
> > > ModemManager[4969]:  [1457629901.676875] [mm-port-
> > > serial.c:1294]
> > > _close_internal(): (ttyUSB2) device open count is 2 (close)
> > > ModemManager[4969]:  [1457629901.677831] [mm-port-serial-
> > > at.c:440]
> > > debug_log(): (ttyUSB2): --> 'AT+CGDCONT=?'
> > > ModemManager[4969]:  [1457629901.712009] [mm-port-serial-
> > > at.c:440]
> > > debug_log(): (ttyUSB2): <-- '^SCFG:
> > > "Audio/Loop",("0","1")^SCFG: "Call/ECC",("0"-
> > > "255")^SCFG:
> > > "Call/Speech/Codec",("0","1")^SCFG:
> > > "GPRS/Auth",("0","1","2")^SCFG:
> > > "GPRS/AutoAttach",("disabled","enabled")^SCFG:
> > > "GPRS/MaxDataRate/HSDPA",("0","1")^SCFG:
> > > "GPRS/MaxDataRate/HSUPA",("0","1")^SCFG:
> > > "Ident/Manufacturer",(25)^SCFG:
> > > "Ident/Product",(25)^SCFG:
> > > "MEopMode/Airplane",("off","on")^SCFG:
> > > "MEopMode/CregRoam",("0","1")^SCFG:
> > > "MEopMode/CFUN",("0","1")^SCFG:
> > > "MEopMode/PowerMgmt/LCI",("disabled","enabled")^SCFG:
> > > "MEopMode/PowerMgmt/VExt",("high","low")^SCFG:
> > > "MEopMode/PwrSave",("disabled","enabled"),("0-600"),("1-
> > > 36000")^SCFG:
> > > "MEopMode/RingOnData",("on","off")^SCFG:
> > > "MEopMode/RingUrcOnCall",("on","off")^SCFG:
> > > "MEShutdown/OnIgnition",("on","off")^SCFG:
> > > "Radio/Band",("4-108","0-1")^SCFG:
> > > "Radio/NWSM",("0","1","2")^SCFG:
> > > "Radio/OutputPowerReduction",("4"-"8")^SCFG:
> > > "Serial/USB/DDD",("0","1"),("0"),(4),(4),(4),(63),(63),(4) > > >^SC
> > > FG:
> > > "URC/DstIfc",("mdm","app")^SCFG:
> > > "URC/Datamode/Ringline",("off","on")^SCFG:
> > > "URC/Ringline",("off","local","asc0","wakeup")^SCFG:
> > > "URC/Ringline/ActiveTime",("0","1","2","keep")OK<
> > > CR><
> > > LF>+CGDCONT:
> > > (1-16,101-116),"IP",,,(0),(0-4)OK'
> > > ModemManager[4969]:  

Re: NetworkManager 1.1.90 : nm-exported-object.c:293:nm_exported_object_class_add_interface: assertion failed: (object_property != NULL)

[Ali Nematollahi]

Hi Thomas

Thanks! Here is the results (full logs from start to finish attached):


(ModemManager:2691): GLib-GObject-CRITICAL **: g_object_unref: assertion
`G_IS_OBJECT (object)' failed
ModemManager[2691]:  [1457692760.677812] [mm-port-serial.c:1294]
_close_internal(): (ttyUSB2) device open count is 1 (close)
ModemManager[2691]:  [1457692782.685898] [mm-port-serial.c:1237]
mm_port_serial_open(): (ttyUSB2) device open count is 2 (open)
ModemManager[2691]:  [1457692782.686408] [mm-broadband-modem.c:1991]
modem_load_signal_quality(): loading signal quality...
ModemManager[2691]:  [1457692782.686621] [mm-port-serial.c:1237]
mm_port_serial_open(): (ttyUSB2) device open count is 3 (open)
ModemManager[2691]:  [1457692782.686891] [mm-port-serial-at.c:440]
debug_log(): (ttyUSB2): --> 'AT^SIND?'
ModemManager[2691]:  [1457692785.677307] [mm-iface-modem.c:934]
access_technologies_check_ready(): Couldn't refresh access technologies:
'Serial command timed out'
ModemManager[2691]:  [1457692785.677657] [mm-port-serial.c:1294]
_close_internal(): (ttyUSB2) device open count is 2 (close)
ModemManager[2691]:  [1457692785.677951] [mm-port-serial-at.c:440]
debug_log(): (ttyUSB2): --> 'AT+CSQ'
ModemManager[2691]:  [1457692785.695618] [mm-port-serial-at.c:440]
debug_log(): (ttyUSB2): <-- '^SIND: signal,0,99^SIND:
service,0,1^SIND: sounder,0,0^SIND:
message,0,0^SIND: call,0,0^SIND: roam,0,0^SIND:
smsfull,0,0^SIND: rssi,0,4^SIND: audio,0,0^SIND:
simstatus,1,5^SIND: simdata,0^SIND:
eons,0,1,"0052004F0047004500520053","0052004F0047004500520053",1^SIND:
nitz,0,"00310036002F00300033002F00310031002C00310038003A00310039003A00330031",-32^SIND:
psinfo,0,9^SIND: vcall,0,0^SIND: simlocal,0,1^SIND:
lsta,0,0^SIND: ratmode,0,99^SIND: pacsp,0,1^SIND:
steerroam,0OK+CSQ:
26,99OK'
ModemManager[2691]:  [1457692785.696808] [mm-port-serial.c:1294]
_close_internal(): (ttyUSB2) device open count is 1 (close)
ModemManager[2691]:  [1457692785.697730] [mm-iface-modem.c:1221]
signal_quality_check_ready(): Couldn't refresh signal quality: 'Could not
parse signal quality results'
ModemManager[2691]:  [1457692812.700866] [mm-port-serial.c:1237]
mm_port_serial_open(): (ttyUSB2) device open count is 2 (open)
ModemManager[2691]:  [1457692812.701470] [mm-iface-modem.c:1101]
expire_signal_quality(): Signal quality value not updated in 60s, marking
as not being recent
ModemManager[2691]:  [1457692812.701969] [mm-broadband-modem.c:1991]
modem_load_signal_quality(): loading signal quality...
ModemManager[2691]:  [1457692812.702183] [mm-port-serial.c:1237]
mm_port_serial_open(): (ttyUSB2) device open count is 3 (open)
ModemManager[2691]:  [1457692812.713307] [mm-port-serial-at.c:440]
debug_log(): (ttyUSB2): --> 'AT^SIND?'
ModemManager[2691]:  [1457692812.730761] [mm-port-serial-at.c:440]
debug_log(): (ttyUSB2): <-- 'OK'
ModemManager[2691]:  [1457692815.676468] [mm-iface-modem.c:934]
access_technologies_check_ready(): Couldn't refresh access technologies:
'Serial command timed out'
ModemManager[2691]:  [1457692815.676810] [mm-port-serial.c:1294]
_close_internal(): (ttyUSB2) device open count is 2 (close)
ModemManager[2691]:  [1457692815.677095] [mm-port-serial-at.c:440]
debug_log(): (ttyUSB2): --> 'AT+CSQ'
ModemManager[2691]:  [1457692815.694298] [mm-port-serial-at.c:440]
debug_log(): (ttyUSB2): <-- '+CSQ: 26,99OK'
ModemManager[2691]:  [1457692815.695115] [mm-port-serial.c:1294]
_close_internal(): (ttyUSB2) device open count is 1 (close)
ModemManager[2691]:  [1457692815.695970] [mm-iface-modem.c:1165]
update_signal_quality(): Modem /org/freedesktop/ModemManager1/Modem/0:
signal quality updated (83)
NetworkManager[2723]:   keyfile: add connection
/etc/NetworkManager/system-connections/ali
(b4f8b0d5-6ad0-4469-93f0-8e8cf4108c75,"ali")
NetworkManager[2723]:   op="connection-add"
uuid="b4f8b0d5-6ad0-4469-93f0-8e8cf4108c75" name="ali" pid=2753 uid=0
result="success"
NetworkManager[2723]:   Auto-activating connection 'ali'.
**
NetworkManager:ERROR:nm-exported-object.c:293:nm_exported_object_class_add_interface:
assertion failed: (object_property != NULL)

Program received signal SIGABRT, Aborted.
0xb6ab8f96 in ?? () from /lib/arm-linux-gnueabihf/libc.so.6
(gdb)
(gdb)
(gdb) bt full
#0  0xb6ab8f96 in ?? () from /lib/arm-linux-gnueabihf/libc.so.6
No symbol table info available.
#1  0xb6ac6f6a in raise () from /lib/arm-linux-gnueabihf/libc.so.6
No symbol table info available.
#2  0xb6ac9408 in abort () from /lib/arm-linux-gnueabihf/libc.so.6
No symbol table info available.
#3  0xb6cb3d6a in g_assertion_message ()
   from /lib/arm-linux-gnueabihf/libglib-2.0.so.0
No symbol table info available.
#4  0xb6cb4142 in g_assertion_message_expr ()
   from /lib/arm-linux-gnueabihf/libglib-2.0.so.0
No symbol table info available.
#5  0x000b1a06 in nm_exported_object_class_add_interface (
object_class=0xb1a07, dbus_skeleton_type=2404352)
at nm-exported-object.c:293
hyphen_name = 0xb6d23000 "\350\336\v"
classinfo = 0xb6cc750f
method = {dbus_skeleton_type = 0, 

Re: NetworkManager 1.1.90 : nm-exported-object.c:293:nm_exported_object_class_add_interface: assertion failed: (object_property != NULL)

[Thomas Haller]

On Thu, 2016-03-10 at 10:24 -0800, Ali Nematollahi wrote:
> 
> NetworkManager[2717]:   startup complete
> [New Thread 0xb4e0d3c0 (LWP 2724)]
> NetworkManager[2717]:   ModemManager available in the bus
> NetworkManager[2717]:   (ttyUSB2): new Broadband device
> (/org/freedesktop/NetworkManager/Devices/4)
> NetworkManager[2717]:   (ttyUSB2): device state change:
> unmanaged -> unavailable (reason 'managed') [10 20 2]
> NetworkManager[2717]:   (ttyUSB2): modem state 'connected'
> NetworkManager[2717]:   (ttyUSB2): device state change:
> unavailable -> disconnected (reason 'none') [20 30 0]
> NetworkManager[2717]:   Auto-activating connection 'ali'.
> **
> NetworkManager:ERROR:nm-exported-
> object.c:293:nm_exported_object_class_add_interface: assertion
> failed: (object_property != NULL)

Hi Ali,


Beside your issues with ModemManager, there is a crash in
NetworkManager.

Can you try to add the line:

     nm_log_info (LOGD_CORE, "NetworkManager (version " NM_DIST_VERSION ") is 
starting...");
 
+g_type_ensure (NM_TYPE_ACTIVE_CONNECTION);
+
 /* Parse the state file */


to src/main.c?

You will also need:
  #include "nm-active-connection.h


Then try again with

  export G_DEBUG=fatal-criticals




Thomas


> 
> Program received signal SIGABRT, Aborted.
> 0xb6ab8f96 in ?? () from /lib/arm-linux-gnueabihf/libc.so.6
> (gdb) bt


signature.asc
Description: This is a digitally signed message part
___
networkmanager-list mailing list
networkmanager-list@gnome.org
https://mail.gnome.org/mailman/listinfo/networkmanager-list

Re: NetworkManager 1.1.90 : nm-exported-object.c:293:nm_exported_object_class_add_interface: assertion failed: (object_property != NULL)

[Dan Williams]

On Thu, 2016-03-10 at 17:34 -0800, Ali Nematollahi wrote:
> So I've started looking at the code and I looked for the error
> message that
> says Missing +CGDCONT prefix. I added debugging code to print out the
> "response" and the result of g_str_has_prefix () function call in
> src/mm-modem-helpers.c: mm_3gpp_parse_cgdcont_test_response()
> 
> Here is my debugging output (highlighted in red).
> The response clearly has "+CGDCONT" at the beginning...but
> g_str_has_prefix() fails to read it. Is it because my glib is old? Or
> could
> it be because it comes out with  before it and
> g_str_has_prefix()
> is confused as a result??

The reason it fails is because of the "Serial command timed out"; the
modem doesn't respond to the AT^SCFG request within the expected time,
so ModemManager gives up.  Then the response actually does happen a bit
later, but MM has already sent the CGDCONT request, and expects a
CGDCONT reply instead of the ^SCFG reply.  So we probably just need to
increase the timeout for this modem.  Can you try this change?

In plugins/cinterion/mm-broadband-modem-cinterion.c:

static void
load_supported_bands (MMIfaceModem *self,
  GAsyncReadyCallback callback,
  gpointer user_data)
{
GSimpleAsyncResult *simple;

simple = g_simple_async_result_new (G_OBJECT (self),
callback,
user_data,
load_supported_bands);

mm_base_modem_at_command (MM_BASE_MODEM (self),
  "AT^SCFG=?",
-                             3,
+                             6,
  FALSE,
  (GAsyncReadyCallback)scfg_test_ready,
  simple);
}

and I bet it'll start working.

Dan

> 
> 
> 
> 
> Manager[4969]:  [1457629898.039154] [mm-port-serial-at.c:440]
> debug_log(): (ttyUSB2): --> 'AT^SCFG=?'
> ModemManager[4969]:   [1457629901.672443] [mm-iface-
> modem.c:3961]
> load_supported_bands_ready(): couldn't load Supported Bands: 'Serial
> command timed out'
> ModemManager[4969]:  [1457629901.674453] [mm-broadband-
> modem.c:1675]
> modem_load_supported_ip_families(): loading supported IP families...
> ModemManager[4969]:  [1457629901.675897] [mm-port-
> serial.c:1237]
> mm_port_serial_open(): (ttyUSB2) device open count is 3 (open)
> ModemManager[4969]:  [1457629901.676875] [mm-port-
> serial.c:1294]
> _close_internal(): (ttyUSB2) device open count is 2 (close)
> ModemManager[4969]:  [1457629901.677831] [mm-port-serial-
> at.c:440]
> debug_log(): (ttyUSB2): --> 'AT+CGDCONT=?'
> ModemManager[4969]:  [1457629901.712009] [mm-port-serial-
> at.c:440]
> debug_log(): (ttyUSB2): <-- '^SCFG:
> "Audio/Loop",("0","1")^SCFG: "Call/ECC",("0"-
> "255")^SCFG:
> "Call/Speech/Codec",("0","1")^SCFG:
> "GPRS/Auth",("0","1","2")^SCFG:
> "GPRS/AutoAttach",("disabled","enabled")^SCFG:
> "GPRS/MaxDataRate/HSDPA",("0","1")^SCFG:
> "GPRS/MaxDataRate/HSUPA",("0","1")^SCFG:
> "Ident/Manufacturer",(25)^SCFG:
> "Ident/Product",(25)^SCFG:
> "MEopMode/Airplane",("off","on")^SCFG:
> "MEopMode/CregRoam",("0","1")^SCFG:
> "MEopMode/CFUN",("0","1")^SCFG:
> "MEopMode/PowerMgmt/LCI",("disabled","enabled")^SCFG:
> "MEopMode/PowerMgmt/VExt",("high","low")^SCFG:
> "MEopMode/PwrSave",("disabled","enabled"),("0-600"),("1-
> 36000")^SCFG:
> "MEopMode/RingOnData",("on","off")^SCFG:
> "MEopMode/RingUrcOnCall",("on","off")^SCFG:
> "MEShutdown/OnIgnition",("on","off")^SCFG:
> "Radio/Band",("4-108","0-1")^SCFG:
> "Radio/NWSM",("0","1","2")^SCFG:
> "Radio/OutputPowerReduction",("4"-"8")^SCFG:
> "Serial/USB/DDD",("0","1"),("0"),(4),(4),(4),(63),(63),(4)^SC
> FG:
> "URC/DstIfc",("mdm","app")^SCFG:
> "URC/Datamode/Ringline",("off","on")^SCFG:
> "URC/Ringline",("off","local","asc0","wakeup")^SCFG:
> "URC/Ringline/ActiveTime",("0","1","2","keep")OK<
> LF>+CGDCONT:
> (1-16,101-116),"IP",,,(0),(0-4)OK'
> ModemManager[4969]:  [1457629901.714967] [mm-modem-
> helpers.c:762]
> mm_3gpp_parse_cgdcont_test_response(): *
> mm_3gpp_parse_cgdcont_test_response *
> ModemManager[4969]:  [1457629901.716188] [mm-modem-
> helpers.c:763]
> mm_3gpp_parse_cgdcont_test_response(): response = ^SCFG:
> "Audio/Loop",("0","1")
> ^SCFG: "Call/ECC",("0"-"255")
> ^SCFG: "Call/Speech/Codec",("0","1")
> ^SCFG: "GPRS/Auth",("0","1","2")
> ^SCFG: "GPRS/AutoAttach",("disabled","enabled")
> ^SCFG: "GPRS/MaxDataRate/HSDPA",("0","1")
> ^SCFG: "GPRS/MaxDataRate/HSUPA",("0","1")
> ^SCFG: "Ident/Manufacturer",(25)
> ^SCFG: "Ident/Product",(25)
> ^SCFG: "MEopMode/Airplane",("off","on")
> ^SCFG: "MEopMode/CregRoam",("0","1")
> ^SCFG: "MEopMode/CFUN",("0","1")
> ^SCFG: "MEopMode/PowerMgmt/LCI",("disabled","enabled")
> ^SCFG: "MEopMode/PowerMgmt/VExt",("high","low")
> ^SCFG: "MEopMode/PwrSave",("disabled","enabled"),("0-600"),("1-
> 36000")
> ^SCFG: "MEopMode/RingOnData",("on","off")
> ^SCFG: "MEopMode/RingUrcOnCall",("on","off")
> 

Re: NetworkManager 1.1.90 : nm-exported-object.c:293:nm_exported_object_class_add_interface: assertion failed: (object_property != NULL)

[Ali Nematollahi]

So I've started looking at the code and I looked for the error message that
says Missing +CGDCONT prefix. I added debugging code to print out the
"response" and the result of g_str_has_prefix () function call in
src/mm-modem-helpers.c: mm_3gpp_parse_cgdcont_test_response()

Here is my debugging output (highlighted in red).
The response clearly has "+CGDCONT" at the beginning...but
g_str_has_prefix() fails to read it. Is it because my glib is old? Or could
it be because it comes out with  before it and g_str_has_prefix()
is confused as a result??





Manager[4969]:  [1457629898.039154] [mm-port-serial-at.c:440]
debug_log(): (ttyUSB2): --> 'AT^SCFG=?'
ModemManager[4969]:   [1457629901.672443] [mm-iface-modem.c:3961]
load_supported_bands_ready(): couldn't load Supported Bands: 'Serial
command timed out'
ModemManager[4969]:  [1457629901.674453] [mm-broadband-modem.c:1675]
modem_load_supported_ip_families(): loading supported IP families...
ModemManager[4969]:  [1457629901.675897] [mm-port-serial.c:1237]
mm_port_serial_open(): (ttyUSB2) device open count is 3 (open)
ModemManager[4969]:  [1457629901.676875] [mm-port-serial.c:1294]
_close_internal(): (ttyUSB2) device open count is 2 (close)
ModemManager[4969]:  [1457629901.677831] [mm-port-serial-at.c:440]
debug_log(): (ttyUSB2): --> 'AT+CGDCONT=?'
ModemManager[4969]:  [1457629901.712009] [mm-port-serial-at.c:440]
debug_log(): (ttyUSB2): <-- '^SCFG:
"Audio/Loop",("0","1")^SCFG: "Call/ECC",("0"-"255")^SCFG:
"Call/Speech/Codec",("0","1")^SCFG:
"GPRS/Auth",("0","1","2")^SCFG:
"GPRS/AutoAttach",("disabled","enabled")^SCFG:
"GPRS/MaxDataRate/HSDPA",("0","1")^SCFG:
"GPRS/MaxDataRate/HSUPA",("0","1")^SCFG:
"Ident/Manufacturer",(25)^SCFG: "Ident/Product",(25)^SCFG:
"MEopMode/Airplane",("off","on")^SCFG:
"MEopMode/CregRoam",("0","1")^SCFG:
"MEopMode/CFUN",("0","1")^SCFG:
"MEopMode/PowerMgmt/LCI",("disabled","enabled")^SCFG:
"MEopMode/PowerMgmt/VExt",("high","low")^SCFG:
"MEopMode/PwrSave",("disabled","enabled"),("0-600"),("1-36000")^SCFG:
"MEopMode/RingOnData",("on","off")^SCFG:
"MEopMode/RingUrcOnCall",("on","off")^SCFG:
"MEShutdown/OnIgnition",("on","off")^SCFG:
"Radio/Band",("4-108","0-1")^SCFG:
"Radio/NWSM",("0","1","2")^SCFG:
"Radio/OutputPowerReduction",("4"-"8")^SCFG:
"Serial/USB/DDD",("0","1"),("0"),(4),(4),(4),(63),(63),(4)^SCFG:
"URC/DstIfc",("mdm","app")^SCFG:
"URC/Datamode/Ringline",("off","on")^SCFG:
"URC/Ringline",("off","local","asc0","wakeup")^SCFG:
"URC/Ringline/ActiveTime",("0","1","2","keep")OK+CGDCONT:
(1-16,101-116),"IP",,,(0),(0-4)OK'
ModemManager[4969]:  [1457629901.714967] [mm-modem-helpers.c:762]
mm_3gpp_parse_cgdcont_test_response(): *
mm_3gpp_parse_cgdcont_test_response *
ModemManager[4969]:  [1457629901.716188] [mm-modem-helpers.c:763]
mm_3gpp_parse_cgdcont_test_response(): response = ^SCFG:
"Audio/Loop",("0","1")
^SCFG: "Call/ECC",("0"-"255")
^SCFG: "Call/Speech/Codec",("0","1")
^SCFG: "GPRS/Auth",("0","1","2")
^SCFG: "GPRS/AutoAttach",("disabled","enabled")
^SCFG: "GPRS/MaxDataRate/HSDPA",("0","1")
^SCFG: "GPRS/MaxDataRate/HSUPA",("0","1")
^SCFG: "Ident/Manufacturer",(25)
^SCFG: "Ident/Product",(25)
^SCFG: "MEopMode/Airplane",("off","on")
^SCFG: "MEopMode/CregRoam",("0","1")
^SCFG: "MEopMode/CFUN",("0","1")
^SCFG: "MEopMode/PowerMgmt/LCI",("disabled","enabled")
^SCFG: "MEopMode/PowerMgmt/VExt",("high","low")
^SCFG: "MEopMode/PwrSave",("disabled","enabled"),("0-600"),("1-36000")
^SCFG: "MEopMode/RingOnData",("on","off")
^SCFG: "MEopMode/RingUrcOnCall",("on","off")
^SCFG: "MEShutdown/OnIgnition",("on","off")
^SCFG: "Radio/Band",("4-108","0-1")
^SCFG: "Radio/NWSM",("0","1","2")
^SCFG: "Radio/OutputPowerReduction",("4"-"8")
^SCFG: "Serial/USB/DDD",("0","1"),("0"),(4),(4),(4),(63),(63),(4)
^SCFG: "URC/DstIfc",("mdm","app")
^SCFG: "URC/Datamode/Ringline",("off","on")
^SCFG: "URC/Ringline",("off","local","asc0","wakeup")
^SCFG: "URC/Ringline/ActiveTime",("0","1","2","keep")

OK

+CGDCONT: (1-16,101-116),"IP",,,(0),(0-4), g_str_has_prefix = 0

ModemManager[4969]:   [1457629901.718044] [mm-iface-modem.c:3984]
load_supported_ip_families_ready(): couldn't load Supported IP families:
'Missing +CGDCONT prefix'
ModemManager[4969]:  [1457629901.719369] [mm-broadband-modem.c:3132]
load_power_state(): loading power state...
ModemManager[4969]:  [1457629901.720687] [mm-port-serial.c:1237]
mm_port_serial_open(): (ttyUSB2) device open count is 3 (open)
ModemManager[4969]:  [1457629901.721917] [mm-port-serial.c:1294]
_close_internal(): (ttyUSB2) device open count is 2 (close)
ModemManager[4969]:  [1457629901.723342] [mm-port-serial-at.c:440]
debug_log(): (ttyUSB2): --> 'AT+CFUN?'
ModemManager[4969]:   [1457629904.671850] [mm-iface-modem.c:3993]
load_power_state_ready(): couldn't load Power State: 'Serial command timed
out'
ModemManager[4969]:  [1457629904.672282] [mm-broadband-modem.c:1290]
modem_load_unlock_required(): checking if unlock required...
ModemManager[4969]:  [1457629904.672492] [mm-port-serial.c:1237]
mm_port_serial_open(): 

Re: NetworkManager 1.1.90 : nm-exported-object.c:293:nm_exported_object_class_add_interface: assertion failed: (object_property != NULL)

[Dan Williams]

On Thu, 2016-03-10 at 13:49 -0800, Ali Nematollahi wrote:
> ^SCFG query comes after CGDCONT query:

Do you see any "AT^SCFG=?" sent by ModemManager anywhere in the logs?

Dan

> ModemManager[2738]:  [946691988.680690] [mm-port-serial-
> at.c:440]
> debug_log(): (ttyUSB2): --> 'AT+CGDCONT=?'
> ModemManager[2738]:  [946691988.699302] [mm-port-serial-
> at.c:440]
> debug_log(): (ttyUSB2): <-- '^SCFG:
> "Audio/Loop",("0","1")^SCFG: "Call/ECC",("0"-
> "255")^SCFG:
> "Call/Speech/Codec",("0","1")^SCFG:
> "GPRS/Auth",("0","1","2")^SCFG:
> "GPRS/AutoAttach",("disabled","enabled")^SCFG:
> "GPRS/MaxDataRate/HSDPA",("0","1")^SCFG:
> "GPRS/MaxDataRate/HSUPA",("0","1")^SCFG:
> "Ident/Manufacturer",(25)^SCFG:
> "Ident/Product",(25)^SCFG:
> "MEopMode/Airplane",("off","on")^SCFG:
> "MEopMode/CregRoam",("0","1")^SCFG:
> "MEopMode/CFUN",("0","1")^SCFG:
> "MEopMode/PowerMgmt/LCI",("disabled","enabled")^SCFG:
> "MEopMode/PowerMgmt/VExt",("high","low")^SCFG:
> "MEopMode/PwrSave",("disabled","enabled"),("0-600"),("1-
> 36000")^SCFG:
> "MEopMode/RingOnData",("on","off")^SCFG:
> "MEopMode/RingUrcOnCall",("on","off")^SCFG:
> "MEShutdown/OnIgnition",("on","off")^SCFG:
> "Radio/Band",("4-108","0-1")^SCFG:
> "Radio/NWSM",("0","1","2")^SCFG:
> "Radio/OutputPowerReduction",("4"-"8")^SCFG:
> "Serial/USB/DDD",("0","1"),("0"),(4),(4),(4),(63),(63),(4)^SC
> FG:
> "URC/DstIfc",("mdm","app")^SCFG:
> "URC/Datamode/Ringline",("off","on")^SCFG:
> "URC/Ringline",("off","local","asc0","wakeup")^SCFG:
> "URC/Ringline/ActiveTime",("0","1","2","keep")OK<
> LF>+CGDCONT:
> (1-16,101-116),"IP",,,(0),(0-4)OK'
> ModemManager[2738]:   [946691988.701381] [mm-iface-
> modem.c:3984]
> load_supported_ip_families_ready(): couldn't load Supported IP
> families:
> 'Missing +CGDCONT prefix'
> ModemManager[2738]:  [946691988.702102] [mm-broadband-
> modem.c:3132]
> load_power_state(): loading power state...
> ModemManager[2738]:  [946691988.702786] [mm-port-
> serial.c:1237]
> mm_port_serial_open(): (ttyUSB2) device open count is 3 (open)
> ModemManager[2738]:  [946691988.703592] [mm-port-
> serial.c:1294]
> _close_internal(): (ttyUSB2) device open count is 2 (close)
> ModemManager[2738]:  [946691988.704322] [mm-port-serial-
> at.c:440]
> debug_log(): (ttyUSB2): --> 'AT+CFUN?'
> ModemManager[2738]:   [946691991.677255] [mm-iface-
> modem.c:3993]
> load_power_state_ready(): couldn't load Power State: 'Serial command
> timed
> out'
> ModemManager[2738]:  [946691991.683414] [mm-broadband-
> modem.c:1290]
> modem_load_unlock_required(): checking if unlock required...
> 
> 
> On Thu, Mar 10, 2016 at 1:26 PM, Dan Williams 
> wrote:
> 
> > 
> > On Thu, 2016-03-10 at 11:00 -0800, Ali Nematollahi wrote:
> > > 
> > > Hi Dan
> > > 
> > > Perfect. I did that and I see this:
> > > 
> > > 
> > > ModemManager[2757]:  (ttyUSB2) device open count is 2
> > > (close)
> > > ModemManager[2757]:  (ttyUSB2): --> 'AT+CGDCONT=?'
> > > 
> > What are the previous 10 lines here?  Does the modem really respond
> > to
> > AT+CGDCONT=? with unsolicited ^SCFG output or is that left-over
> > from a
> > previous AT^SCFG=? request that MM is making?
> > 
> > Dan
> > 
> > > 
> > > ModemManager[2757]:  (ttyUSB2): <-- '^SCFG:
> > > "Audio/Loop",("0","1")^SCFG: "Call/ECC",("0"-
> > > "255")^SCFG:
> > > "Call/Speech/Codec",("0","1")^SCFG:
> > > "GPRS/Auth",("0","1","2")^SCFG:
> > > "GPRS/AutoAttach",("disabled","enabled")^SCFG:
> > > "GPRS/MaxDataRate/HSDPA",("0","1")^SCFG:
> > > "GPRS/MaxDataRate/HSUPA",("0","1")^SCFG:
> > > "Ident/Manufacturer",(25)^SCFG:
> > > "Ident/Product",(25)^SCFG:
> > > "MEopMode/Airplane",("off","on")^SCFG:
> > > "MEopMode/CregRoam",("0","1")^SCFG:
> > > "MEopMode/CFUN",("0","1")^SCFG:
> > > "MEopMode/PowerMgmt/LCI",("disabled","enabled")^SCFG:
> > > "MEopMode/PowerMgmt/VExt",("high","low")^SCFG:
> > > "MEopMode/PwrSave",("disabled","enabled"),("0-600"),("1-
> > > 36000")^SCFG:
> > > "MEopMode/RingOnData",("on","off")^SCFG:
> > > "MEopMode/RingUrcOnCall",("on","off")^SCFG:
> > > "MEShutdown/OnIgnition",("on","off")^SCFG:
> > > "Radio/Band",("4-108","0-1")^SCFG:
> > > "Radio/NWSM",("0","1","2")^SCFG:
> > > "Radio/OutputPowerReduction",("4"-"8")^SCFG:
> > > "Serial/USB/DDD",("0","1"),("0"),(4),(4),(4),(63),(63),(4) > > >^SC
> > > FG:
> > > "URC/DstIfc",("mdm","app")^SCFG:
> > > "URC/Datamode/Ringline",("off","on")^SCFG:
> > > "URC/Ringline",("off","local","asc0","wakeup")^SCFG:
> > > "URC/Ringline/ActiveTime",("0","1","2","keep")OK<
> > > CR><
> > > LF>+CGDCONT:
> > > (1-16,101-116),"IP",,,(0),(0-4)OK'
> > > ModemManager[2757]:   couldn't load Supported IP families:
> > > 'Missing
> > > +CGDCONT prefix'
> > > ModemManager[2757]:  loading power state...
> > > ModemManager[2757]:  (ttyUSB2) device open count is 3
> > > (open)
> > > ModemManager[2757]:  (ttyUSB2) device open count is 2
> > > (close)
> > > 
> > > This is a modem that only supports IPv4.
> > > 
> > > How can I get around this problem?
> > > 
> > > 
> > > 
> > > On Thu, Mar 10, 2016 at 10:32 AM, Dan 

Re: NetworkManager 1.1.90 : nm-exported-object.c:293:nm_exported_object_class_add_interface: assertion failed: (object_property != NULL)

[Ali Nematollahi]

^SCFG query comes after CGDCONT query:

ModemManager[2738]:  [946691988.680690] [mm-port-serial-at.c:440]
debug_log(): (ttyUSB2): --> 'AT+CGDCONT=?'
ModemManager[2738]:  [946691988.699302] [mm-port-serial-at.c:440]
debug_log(): (ttyUSB2): <-- '^SCFG:
"Audio/Loop",("0","1")^SCFG: "Call/ECC",("0"-"255")^SCFG:
"Call/Speech/Codec",("0","1")^SCFG:
"GPRS/Auth",("0","1","2")^SCFG:
"GPRS/AutoAttach",("disabled","enabled")^SCFG:
"GPRS/MaxDataRate/HSDPA",("0","1")^SCFG:
"GPRS/MaxDataRate/HSUPA",("0","1")^SCFG:
"Ident/Manufacturer",(25)^SCFG: "Ident/Product",(25)^SCFG:
"MEopMode/Airplane",("off","on")^SCFG:
"MEopMode/CregRoam",("0","1")^SCFG:
"MEopMode/CFUN",("0","1")^SCFG:
"MEopMode/PowerMgmt/LCI",("disabled","enabled")^SCFG:
"MEopMode/PowerMgmt/VExt",("high","low")^SCFG:
"MEopMode/PwrSave",("disabled","enabled"),("0-600"),("1-36000")^SCFG:
"MEopMode/RingOnData",("on","off")^SCFG:
"MEopMode/RingUrcOnCall",("on","off")^SCFG:
"MEShutdown/OnIgnition",("on","off")^SCFG:
"Radio/Band",("4-108","0-1")^SCFG:
"Radio/NWSM",("0","1","2")^SCFG:
"Radio/OutputPowerReduction",("4"-"8")^SCFG:
"Serial/USB/DDD",("0","1"),("0"),(4),(4),(4),(63),(63),(4)^SCFG:
"URC/DstIfc",("mdm","app")^SCFG:
"URC/Datamode/Ringline",("off","on")^SCFG:
"URC/Ringline",("off","local","asc0","wakeup")^SCFG:
"URC/Ringline/ActiveTime",("0","1","2","keep")OK+CGDCONT:
(1-16,101-116),"IP",,,(0),(0-4)OK'
ModemManager[2738]:   [946691988.701381] [mm-iface-modem.c:3984]
load_supported_ip_families_ready(): couldn't load Supported IP families:
'Missing +CGDCONT prefix'
ModemManager[2738]:  [946691988.702102] [mm-broadband-modem.c:3132]
load_power_state(): loading power state...
ModemManager[2738]:  [946691988.702786] [mm-port-serial.c:1237]
mm_port_serial_open(): (ttyUSB2) device open count is 3 (open)
ModemManager[2738]:  [946691988.703592] [mm-port-serial.c:1294]
_close_internal(): (ttyUSB2) device open count is 2 (close)
ModemManager[2738]:  [946691988.704322] [mm-port-serial-at.c:440]
debug_log(): (ttyUSB2): --> 'AT+CFUN?'
ModemManager[2738]:   [946691991.677255] [mm-iface-modem.c:3993]
load_power_state_ready(): couldn't load Power State: 'Serial command timed
out'
ModemManager[2738]:  [946691991.683414] [mm-broadband-modem.c:1290]
modem_load_unlock_required(): checking if unlock required...


On Thu, Mar 10, 2016 at 1:26 PM, Dan Williams  wrote:

> On Thu, 2016-03-10 at 11:00 -0800, Ali Nematollahi wrote:
> > Hi Dan
> >
> > Perfect. I did that and I see this:
> >
> >
> > ModemManager[2757]:  (ttyUSB2) device open count is 2 (close)
> > ModemManager[2757]:  (ttyUSB2): --> 'AT+CGDCONT=?'
> >
>
> What are the previous 10 lines here?  Does the modem really respond to
> AT+CGDCONT=? with unsolicited ^SCFG output or is that left-over from a
> previous AT^SCFG=? request that MM is making?
>
> Dan
>
> > ModemManager[2757]:  (ttyUSB2): <-- '^SCFG:
> > "Audio/Loop",("0","1")^SCFG: "Call/ECC",("0"-
> > "255")^SCFG:
> > "Call/Speech/Codec",("0","1")^SCFG:
> > "GPRS/Auth",("0","1","2")^SCFG:
> > "GPRS/AutoAttach",("disabled","enabled")^SCFG:
> > "GPRS/MaxDataRate/HSDPA",("0","1")^SCFG:
> > "GPRS/MaxDataRate/HSUPA",("0","1")^SCFG:
> > "Ident/Manufacturer",(25)^SCFG:
> > "Ident/Product",(25)^SCFG:
> > "MEopMode/Airplane",("off","on")^SCFG:
> > "MEopMode/CregRoam",("0","1")^SCFG:
> > "MEopMode/CFUN",("0","1")^SCFG:
> > "MEopMode/PowerMgmt/LCI",("disabled","enabled")^SCFG:
> > "MEopMode/PowerMgmt/VExt",("high","low")^SCFG:
> > "MEopMode/PwrSave",("disabled","enabled"),("0-600"),("1-
> > 36000")^SCFG:
> > "MEopMode/RingOnData",("on","off")^SCFG:
> > "MEopMode/RingUrcOnCall",("on","off")^SCFG:
> > "MEShutdown/OnIgnition",("on","off")^SCFG:
> > "Radio/Band",("4-108","0-1")^SCFG:
> > "Radio/NWSM",("0","1","2")^SCFG:
> > "Radio/OutputPowerReduction",("4"-"8")^SCFG:
> > "Serial/USB/DDD",("0","1"),("0"),(4),(4),(4),(63),(63),(4)^SC
> > FG:
> > "URC/DstIfc",("mdm","app")^SCFG:
> > "URC/Datamode/Ringline",("off","on")^SCFG:
> > "URC/Ringline",("off","local","asc0","wakeup")^SCFG:
> > "URC/Ringline/ActiveTime",("0","1","2","keep")OK<
> > LF>+CGDCONT:
> > (1-16,101-116),"IP",,,(0),(0-4)OK'
> > ModemManager[2757]:   couldn't load Supported IP families:
> > 'Missing
> > +CGDCONT prefix'
> > ModemManager[2757]:  loading power state...
> > ModemManager[2757]:  (ttyUSB2) device open count is 3 (open)
> > ModemManager[2757]:  (ttyUSB2) device open count is 2 (close)
> >
> > This is a modem that only supports IPv4.
> >
> > How can I get around this problem?
> >
> >
> >
> > On Thu, Mar 10, 2016 at 10:32 AM, Dan Williams 
> > wrote:
> >
> > >
> > > On Thu, 2016-03-10 at 10:24 -0800, Ali Nematollahi wrote:
> > > >
> > > > Hi Thomas
> > > >
> > > > Thanks! This is much better...here is the output from start to
> > > > finish:
> > > > mmcli -m 0
> > > >
> > > > /org/freedesktop/ModemManager1/Modem/0 (device id
> > > > '2ea06a44171a29335a8b7f781e0f9559bc24976d')
> > > >   -
> > > >   Hardware |   manufacturer: 'Cinterion'
> > > >|  

Re: NetworkManager 1.1.90 : nm-exported-object.c:293:nm_exported_object_class_add_interface: assertion failed: (object_property != NULL)

[Dan Williams]

On Thu, 2016-03-10 at 11:00 -0800, Ali Nematollahi wrote:
> Hi Dan
> 
> Perfect. I did that and I see this:
> 
> 
> ModemManager[2757]:  (ttyUSB2) device open count is 2 (close)
> ModemManager[2757]:  (ttyUSB2): --> 'AT+CGDCONT=?'
> 

What are the previous 10 lines here?  Does the modem really respond to
AT+CGDCONT=? with unsolicited ^SCFG output or is that left-over from a
previous AT^SCFG=? request that MM is making?

Dan

> ModemManager[2757]:  (ttyUSB2): <-- '^SCFG:
> "Audio/Loop",("0","1")^SCFG: "Call/ECC",("0"-
> "255")^SCFG:
> "Call/Speech/Codec",("0","1")^SCFG:
> "GPRS/Auth",("0","1","2")^SCFG:
> "GPRS/AutoAttach",("disabled","enabled")^SCFG:
> "GPRS/MaxDataRate/HSDPA",("0","1")^SCFG:
> "GPRS/MaxDataRate/HSUPA",("0","1")^SCFG:
> "Ident/Manufacturer",(25)^SCFG:
> "Ident/Product",(25)^SCFG:
> "MEopMode/Airplane",("off","on")^SCFG:
> "MEopMode/CregRoam",("0","1")^SCFG:
> "MEopMode/CFUN",("0","1")^SCFG:
> "MEopMode/PowerMgmt/LCI",("disabled","enabled")^SCFG:
> "MEopMode/PowerMgmt/VExt",("high","low")^SCFG:
> "MEopMode/PwrSave",("disabled","enabled"),("0-600"),("1-
> 36000")^SCFG:
> "MEopMode/RingOnData",("on","off")^SCFG:
> "MEopMode/RingUrcOnCall",("on","off")^SCFG:
> "MEShutdown/OnIgnition",("on","off")^SCFG:
> "Radio/Band",("4-108","0-1")^SCFG:
> "Radio/NWSM",("0","1","2")^SCFG:
> "Radio/OutputPowerReduction",("4"-"8")^SCFG:
> "Serial/USB/DDD",("0","1"),("0"),(4),(4),(4),(63),(63),(4)^SC
> FG:
> "URC/DstIfc",("mdm","app")^SCFG:
> "URC/Datamode/Ringline",("off","on")^SCFG:
> "URC/Ringline",("off","local","asc0","wakeup")^SCFG:
> "URC/Ringline/ActiveTime",("0","1","2","keep")OK<
> LF>+CGDCONT:
> (1-16,101-116),"IP",,,(0),(0-4)OK'
> ModemManager[2757]:   couldn't load Supported IP families:
> 'Missing
> +CGDCONT prefix'
> ModemManager[2757]:  loading power state...
> ModemManager[2757]:  (ttyUSB2) device open count is 3 (open)
> ModemManager[2757]:  (ttyUSB2) device open count is 2 (close)
> 
> This is a modem that only supports IPv4.
> 
> How can I get around this problem?
> 
> 
> 
> On Thu, Mar 10, 2016 at 10:32 AM, Dan Williams 
> wrote:
> 
> > 
> > On Thu, 2016-03-10 at 10:24 -0800, Ali Nematollahi wrote:
> > > 
> > > Hi Thomas
> > > 
> > > Thanks! This is much better...here is the output from start to
> > > finish:
> > > mmcli -m 0
> > > 
> > > /org/freedesktop/ModemManager1/Modem/0 (device id
> > > '2ea06a44171a29335a8b7f781e0f9559bc24976d')
> > >   -
> > >   Hardware |   manufacturer: 'Cinterion'
> > >    |  model: 'PHS8-USA'
> > >    |   revision: 'REVISION 03.001'
> > >    |  supported: 'gsm-umts'
> > >    |current: 'gsm-umts'
> > >    |   equipment id: '351502050184415'
> > >   -
> > >   System   | device:
> > > '/sys/devices/ocp.2/4740.usb/47401c00.usb/musb-
> > > hdrc.1.auto/usb2/2-1'
> > >    |drivers: 'option1'
> > >    | plugin: 'Cinterion'
> > >    |   primary port: 'ttyUSB2'
> > >    |  ports: 'ttyUSB1 (gps), ttyUSB2 (at),
> > > ttyUSB3
> > > (at)'
> > >   -
> > >   Numbers  |   own : '+12899368246'
> > >   -
> > >   Status   |   lock: 'none'
> > >    | unlock retries: 'sim-pin (5), sim-pin2 (5), sim-puk
> > > (10),
> > > sim-puk2 (10), ph-net-pin (10), ph-net-puk (32), ph-fsim-pin
> > > (10),
> > > ph-fsim-puk (32)'
> > >    |  state: 'disabled'
> > >    |power state: 'unknown'
> > >    |access tech: 'unknown'
> > >    | signal quality: '0' (cached)
> > >   -
> > >   Modes|  supported: 'allowed: 2g; preferred: none
> > >    |  allowed: 3g; preferred: none
> > >    |  allowed: 2g, 3g; preferred: none'
> > >    |current: 'allowed: any; preferred: none'
> > >   -
> > >   Bands|  supported: 'unknown'
> > >    |current: 'unknown'
> > >   -
> > >   IP   |  supported: 'none'
> > > 
> > Ok, here's the problem.  Could you grab the ModemManager debug
> > output?
> > 
> > mmcli --set-logging=debug
> > 
> > and then replug the modem (if you can!) or rmmod the modem drivers
> > and
> > modprobe them again.  We're looking for the response to the
> > "AT+CGDCONT=?" command and why MM apparently doesn't parse that
> > correctly.  That'll look something like this:
> > 
> > ModemManager[2768]:  [1457634614.295964] [mm-port-serial-
> > at.c:459]
> > debug_log(): (ttyACM3): --> 'AT+CGDCONT=?'
> > ModemManager[2768]:  [1457634614.309936] [mm-port-serial-
> > at.c:459]
> > debug_log(): (ttyACM3): <-- '+CGDCONT:
> > (1-10),"IP",,,(0,1),(0,1)+CGDCONT:
> > (1-10),"IPV6",,,(0,1),(0,1)+CGDCONT:
> > (1-10),"IPV4V6",,,(0,1),(0,1)OK'
> > 
> > which for this device results in:
> > 
> >   IP   |  supported: 'ipv4, ipv6, 

Re: NetworkManager 1.1.90 : nm-exported-object.c:293:nm_exported_object_class_add_interface: assertion failed: (object_property != NULL)

[Ali Nematollahi]

Hi Dan

Perfect. I did that and I see this:


ModemManager[2757]:  (ttyUSB2) device open count is 2 (close)
ModemManager[2757]:  (ttyUSB2): --> 'AT+CGDCONT=?'
ModemManager[2757]:  (ttyUSB2): <-- '^SCFG:
"Audio/Loop",("0","1")^SCFG: "Call/ECC",("0"-"255")^SCFG:
"Call/Speech/Codec",("0","1")^SCFG:
"GPRS/Auth",("0","1","2")^SCFG:
"GPRS/AutoAttach",("disabled","enabled")^SCFG:
"GPRS/MaxDataRate/HSDPA",("0","1")^SCFG:
"GPRS/MaxDataRate/HSUPA",("0","1")^SCFG:
"Ident/Manufacturer",(25)^SCFG: "Ident/Product",(25)^SCFG:
"MEopMode/Airplane",("off","on")^SCFG:
"MEopMode/CregRoam",("0","1")^SCFG:
"MEopMode/CFUN",("0","1")^SCFG:
"MEopMode/PowerMgmt/LCI",("disabled","enabled")^SCFG:
"MEopMode/PowerMgmt/VExt",("high","low")^SCFG:
"MEopMode/PwrSave",("disabled","enabled"),("0-600"),("1-36000")^SCFG:
"MEopMode/RingOnData",("on","off")^SCFG:
"MEopMode/RingUrcOnCall",("on","off")^SCFG:
"MEShutdown/OnIgnition",("on","off")^SCFG:
"Radio/Band",("4-108","0-1")^SCFG:
"Radio/NWSM",("0","1","2")^SCFG:
"Radio/OutputPowerReduction",("4"-"8")^SCFG:
"Serial/USB/DDD",("0","1"),("0"),(4),(4),(4),(63),(63),(4)^SCFG:
"URC/DstIfc",("mdm","app")^SCFG:
"URC/Datamode/Ringline",("off","on")^SCFG:
"URC/Ringline",("off","local","asc0","wakeup")^SCFG:
"URC/Ringline/ActiveTime",("0","1","2","keep")OK+CGDCONT:
(1-16,101-116),"IP",,,(0),(0-4)OK'
ModemManager[2757]:   couldn't load Supported IP families: 'Missing
+CGDCONT prefix'
ModemManager[2757]:  loading power state...
ModemManager[2757]:  (ttyUSB2) device open count is 3 (open)
ModemManager[2757]:  (ttyUSB2) device open count is 2 (close)

This is a modem that only supports IPv4.

How can I get around this problem?



On Thu, Mar 10, 2016 at 10:32 AM, Dan Williams  wrote:

> On Thu, 2016-03-10 at 10:24 -0800, Ali Nematollahi wrote:
> > Hi Thomas
> >
> > Thanks! This is much better...here is the output from start to
> > finish:
> > mmcli -m 0
> >
> > /org/freedesktop/ModemManager1/Modem/0 (device id
> > '2ea06a44171a29335a8b7f781e0f9559bc24976d')
> >   -
> >   Hardware |   manufacturer: 'Cinterion'
> >|  model: 'PHS8-USA'
> >|   revision: 'REVISION 03.001'
> >|  supported: 'gsm-umts'
> >|current: 'gsm-umts'
> >|   equipment id: '351502050184415'
> >   -
> >   System   | device:
> > '/sys/devices/ocp.2/4740.usb/47401c00.usb/musb-
> > hdrc.1.auto/usb2/2-1'
> >|drivers: 'option1'
> >| plugin: 'Cinterion'
> >|   primary port: 'ttyUSB2'
> >|  ports: 'ttyUSB1 (gps), ttyUSB2 (at), ttyUSB3
> > (at)'
> >   -
> >   Numbers  |   own : '+12899368246'
> >   -
> >   Status   |   lock: 'none'
> >| unlock retries: 'sim-pin (5), sim-pin2 (5), sim-puk
> > (10),
> > sim-puk2 (10), ph-net-pin (10), ph-net-puk (32), ph-fsim-pin (10),
> > ph-fsim-puk (32)'
> >|  state: 'disabled'
> >|power state: 'unknown'
> >|access tech: 'unknown'
> >| signal quality: '0' (cached)
> >   -
> >   Modes|  supported: 'allowed: 2g; preferred: none
> >|  allowed: 3g; preferred: none
> >|  allowed: 2g, 3g; preferred: none'
> >|current: 'allowed: any; preferred: none'
> >   -
> >   Bands|  supported: 'unknown'
> >|current: 'unknown'
> >   -
> >   IP   |  supported: 'none'
> >
> Ok, here's the problem.  Could you grab the ModemManager debug output?
>
> mmcli --set-logging=debug
>
> and then replug the modem (if you can!) or rmmod the modem drivers and
> modprobe them again.  We're looking for the response to the
> "AT+CGDCONT=?" command and why MM apparently doesn't parse that
> correctly.  That'll look something like this:
>
> ModemManager[2768]:  [1457634614.295964] [mm-port-serial-at.c:459]
> debug_log(): (ttyACM3): --> 'AT+CGDCONT=?'
> ModemManager[2768]:  [1457634614.309936] [mm-port-serial-at.c:459]
> debug_log(): (ttyACM3): <-- '+CGDCONT:
> (1-10),"IP",,,(0,1),(0,1)+CGDCONT:
> (1-10),"IPV6",,,(0,1),(0,1)+CGDCONT:
> (1-10),"IPV4V6",,,(0,1),(0,1)OK'
>
> which for this device results in:
>
>   IP   |  supported: 'ipv4, ipv6, ipv4v6'
>
> Dan
>
> >   -
> >   3GPP |   imei: '351502050184415'
> >|  enabled locks: 'none'
> >|operator id: 'unknown'
> >|  operator name: 'unknown'
> >|   subscription: 'unknown'
> >|   registration: 'unknown'
> >   -
> >   SIM  |   path: '/org/freedesktop/ModemManager1/SIM/0'
> >
> >   -
> >   Bearers  |  paths: 'none'
> >
> > root@beaglebone:~# mmcli -m 0 -e
> > ModemManager[2687]:   

Re: NetworkManager 1.1.90 : nm-exported-object.c:293:nm_exported_object_class_add_interface: assertion failed: (object_property != NULL)

[Dan Williams]

On Thu, 2016-03-10 at 10:24 -0800, Ali Nematollahi wrote:
> Hi Thomas
> 
> Thanks! This is much better...here is the output from start to
> finish:
> mmcli -m 0
> 
> /org/freedesktop/ModemManager1/Modem/0 (device id
> '2ea06a44171a29335a8b7f781e0f9559bc24976d')
>   -
>   Hardware |   manufacturer: 'Cinterion'
>    |  model: 'PHS8-USA'
>    |   revision: 'REVISION 03.001'
>    |  supported: 'gsm-umts'
>    |current: 'gsm-umts'
>    |   equipment id: '351502050184415'
>   -
>   System   | device:
> '/sys/devices/ocp.2/4740.usb/47401c00.usb/musb-
> hdrc.1.auto/usb2/2-1'
>    |drivers: 'option1'
>    | plugin: 'Cinterion'
>    |   primary port: 'ttyUSB2'
>    |  ports: 'ttyUSB1 (gps), ttyUSB2 (at), ttyUSB3
> (at)'
>   -
>   Numbers  |   own : '+12899368246'
>   -
>   Status   |   lock: 'none'
>    | unlock retries: 'sim-pin (5), sim-pin2 (5), sim-puk
> (10),
> sim-puk2 (10), ph-net-pin (10), ph-net-puk (32), ph-fsim-pin (10),
> ph-fsim-puk (32)'
>    |  state: 'disabled'
>    |power state: 'unknown'
>    |access tech: 'unknown'
>    | signal quality: '0' (cached)
>   -
>   Modes|  supported: 'allowed: 2g; preferred: none
>    |  allowed: 3g; preferred: none
>    |  allowed: 2g, 3g; preferred: none'
>    |current: 'allowed: any; preferred: none'
>   -
>   Bands|  supported: 'unknown'
>    |current: 'unknown'
>   -
>   IP   |  supported: 'none'
> 
Ok, here's the problem.  Could you grab the ModemManager debug output?

mmcli --set-logging=debug

and then replug the modem (if you can!) or rmmod the modem drivers and
modprobe them again.  We're looking for the response to the
"AT+CGDCONT=?" command and why MM apparently doesn't parse that
correctly.  That'll look something like this:

ModemManager[2768]:  [1457634614.295964] [mm-port-serial-at.c:459] 
debug_log(): (ttyACM3): --> 'AT+CGDCONT=?'
ModemManager[2768]:  [1457634614.309936] [mm-port-serial-at.c:459] 
debug_log(): (ttyACM3): <-- '+CGDCONT: 
(1-10),"IP",,,(0,1),(0,1)+CGDCONT: 
(1-10),"IPV6",,,(0,1),(0,1)+CGDCONT: 
(1-10),"IPV4V6",,,(0,1),(0,1)OK'

which for this device results in:

  IP   |  supported: 'ipv4, ipv6, ipv4v6'

Dan

>   -
>   3GPP |   imei: '351502050184415'
>    |  enabled locks: 'none'
>    |operator id: 'unknown'
>    |  operator name: 'unknown'
>    |   subscription: 'unknown'
>    |   registration: 'unknown'
>   -
>   SIM  |   path: '/org/freedesktop/ModemManager1/SIM/0'
> 
>   -
>   Bearers  |  paths: 'none'
> 
> root@beaglebone:~# mmcli -m 0 -e
> ModemManager[2687]:   Modem
> /org/freedesktop/ModemManager1/Modem/0:
> state changed (disabled -> enabling)
> ModemManager[2687]:   (ttyUSB2): port attributes not fully set
> ModemManager[2687]:   Modem
> /org/freedesktop/ModemManager1/Modem/0:
> 3GPP Registration state changed (unknown -> registering)
> ModemManager[2687]:   Modem
> /org/freedesktop/ModemManager1/Modem/0:
> 3GPP Registration state changed (registering -> home)
> 
> mmcli -m 0 --simple-connect="apn=m2minternet.apn"
> ModemManager[2687]:   Modem
> /org/freedesktop/ModemManager1/Modem/0:
> state changed (enabling -> registered)
> successfully enabled the modem
> root@beaglebone:~#
> root@beaglebone:~# mmcli -m 0 --simple-connect="apn=m2minternet.apn"
> ModemManager[2687]:   Simple connect started...
> ModemManager[2687]:   Simple connect state (4/8): Wait to get
> fully
> enabled
> ModemManager[2687]:   Simple connect state (5/8): Register
> ModemManager[2687]:   Simple connect state (6/8): Bearer
> ModemManager[2687]:   Simple connect state (7/8): Connect
> ModemManager[2687]:   Modem
> /org/freedesktop/ModemManager1/Modem/0:
> state changed (registered -> connecting)
> ModemManager[2687]:   (ttyUSB3): port attributes not fully set
> ModemManager[2687]:   Modem
> /org/freedesktop/ModemManager1/Modem/0:
> state changed (connecting -> connected)
> ModemManager[2687]:   Simple connect state (8/8): All done
> successfully connected the modem
> root@beaglebone:~# mmcli -b 0
> Bearer '/org/freedesktop/ModemManager1/Bearer/0'
>   -
>   Status |   connected: 'yes'
>  |   suspended: 'no'
>  |   interface: 'ttyUSB3'
>  |  IP timeout: '20'
>   -
>   Properties | apn: 'm2minternet.apn'
>  | roaming: 'allowed'
>  | IP type: 'none'
> 

Re: NetworkManager 1.1.90 : nm-exported-object.c:293:nm_exported_object_class_add_interface: assertion failed: (object_property != NULL)

[Ali Nematollahi]

Hi Thomas

Thanks! This is much better...here is the output from start to finish:
mmcli -m 0

/org/freedesktop/ModemManager1/Modem/0 (device id
'2ea06a44171a29335a8b7f781e0f9559bc24976d')
  -
  Hardware |   manufacturer: 'Cinterion'
   |  model: 'PHS8-USA'
   |   revision: 'REVISION 03.001'
   |  supported: 'gsm-umts'
   |current: 'gsm-umts'
   |   equipment id: '351502050184415'
  -
  System   | device:
'/sys/devices/ocp.2/4740.usb/47401c00.usb/musb-hdrc.1.auto/usb2/2-1'
   |drivers: 'option1'
   | plugin: 'Cinterion'
   |   primary port: 'ttyUSB2'
   |  ports: 'ttyUSB1 (gps), ttyUSB2 (at), ttyUSB3 (at)'
  -
  Numbers  |   own : '+12899368246'
  -
  Status   |   lock: 'none'
   | unlock retries: 'sim-pin (5), sim-pin2 (5), sim-puk (10),
sim-puk2 (10), ph-net-pin (10), ph-net-puk (32), ph-fsim-pin (10),
ph-fsim-puk (32)'
   |  state: 'disabled'
   |power state: 'unknown'
   |access tech: 'unknown'
   | signal quality: '0' (cached)
  -
  Modes|  supported: 'allowed: 2g; preferred: none
   |  allowed: 3g; preferred: none
   |  allowed: 2g, 3g; preferred: none'
   |current: 'allowed: any; preferred: none'
  -
  Bands|  supported: 'unknown'
   |current: 'unknown'
  -
  IP   |  supported: 'none'
  -
  3GPP |   imei: '351502050184415'
   |  enabled locks: 'none'
   |operator id: 'unknown'
   |  operator name: 'unknown'
   |   subscription: 'unknown'
   |   registration: 'unknown'
  -
  SIM  |   path: '/org/freedesktop/ModemManager1/SIM/0'

  -
  Bearers  |  paths: 'none'

root@beaglebone:~# mmcli -m 0 -e
ModemManager[2687]:   Modem /org/freedesktop/ModemManager1/Modem/0:
state changed (disabled -> enabling)
ModemManager[2687]:   (ttyUSB2): port attributes not fully set
ModemManager[2687]:   Modem /org/freedesktop/ModemManager1/Modem/0:
3GPP Registration state changed (unknown -> registering)
ModemManager[2687]:   Modem /org/freedesktop/ModemManager1/Modem/0:
3GPP Registration state changed (registering -> home)

mmcli -m 0 --simple-connect="apn=m2minternet.apn"
ModemManager[2687]:   Modem /org/freedesktop/ModemManager1/Modem/0:
state changed (enabling -> registered)
successfully enabled the modem
root@beaglebone:~#
root@beaglebone:~# mmcli -m 0 --simple-connect="apn=m2minternet.apn"
ModemManager[2687]:   Simple connect started...
ModemManager[2687]:   Simple connect state (4/8): Wait to get fully
enabled
ModemManager[2687]:   Simple connect state (5/8): Register
ModemManager[2687]:   Simple connect state (6/8): Bearer
ModemManager[2687]:   Simple connect state (7/8): Connect
ModemManager[2687]:   Modem /org/freedesktop/ModemManager1/Modem/0:
state changed (registered -> connecting)
ModemManager[2687]:   (ttyUSB3): port attributes not fully set
ModemManager[2687]:   Modem /org/freedesktop/ModemManager1/Modem/0:
state changed (connecting -> connected)
ModemManager[2687]:   Simple connect state (8/8): All done
successfully connected the modem
root@beaglebone:~# mmcli -b 0
Bearer '/org/freedesktop/ModemManager1/Bearer/0'
  -
  Status |   connected: 'yes'
 |   suspended: 'no'
 |   interface: 'ttyUSB3'
 |  IP timeout: '20'
  -
  Properties | apn: 'm2minternet.apn'
 | roaming: 'allowed'
 | IP type: 'none'
 |user: 'none'
 |password: 'none'
 |  number: 'none'
 | Rm protocol: 'unknown'
  -
  IPv4 configuration |   method: 'ppp'
 |  address: 'unknown'
 |   prefix: '0'
 |  gateway: 'unknown'
 |  DNS: none
  -
  IPv6 configuration |   method: 'unknown'
root@beaglebone:~#   export G_DEBUG=fatal-criticals
root@beaglebone:~# export G_DEBUG=fatal-criticals
root@beaglebone:~# echo $G_DEBUG
fatal-criticals
root@beaglebone:~#   gdb /usr/sbin/NetworkManager
GNU gdb (GDB) 7.4.1-debian
Copyright (C) 2012 Free Software Foundation, Inc.
License GPLv3+: GNU GPL version 3 or later 
This is free software: you are free to change and redistribute it.
There is NO WARRANTY, to the extent permitted by law.  Type "show copying"
and "show warranty" for details.
This GDB was configured as 

Re: NetworkManager 1.1.90 : nm-exported-object.c:293:nm_exported_object_class_add_interface: assertion failed: (object_property != NULL)

[Thomas Haller]

On Wed, 2016-03-09 at 14:35 -0800, Ali Nematollahi wrote:
> I'm not concerned about IPv6 at all. 
> I'm running Kernel 3.12
> 
> Here is the backtrace:
> root@beaglebone:~# gdb /usr/sbin/NetworkManager
> GNU gdb (GDB) 7.4.1-debian
> Copyright (C) 2012 Free Software Foundation, Inc.
> License GPLv3+: GNU GPL version 3 or later  pl.html>
> This is free software: you are free to change and redistribute it.
> There is NO WARRANTY, to the extent permitted by law.  Type "show
> copying"
> and "show warranty" for details.
> This GDB was configured as "arm-linux-gnueabihf".
> For bug reporting instructions, please see:
> ...
> Reading symbols from /usr/sbin/NetworkManager...done.
> (gdb) run --debug --g-fatal-warnings
> Starting program: /usr/sbin/NetworkManager --debug --g-fatal-warnings
> [Thread debugging using libthread_db enabled]
> Using host libthread_db library "/lib/arm-linux-
> gnueabihf/libthread_db.so.1".
> NetworkManager-Message:   No config file found or given; using
> /etc/NetworkManager/NetworkManager.conf
> 
> [New Thread 0xb686b3c0 (LWP 2821)]
> 
> (NetworkManager:2818): NetworkManager-WARNING **:   glib-
> version: cannot handle SIGUSR1 and SIGUSR2 signals. Consider
> upgrading glib to 2.36.0 or newer


Hmpf, seems you cannot use --g-fatal-warnings because then NM dumps
core on this warning. This would be fixed now on master
https://cgit.freedesktop.org/NetworkManager/NetworkManager/commit/?id=b49322b568725c8c92c0732b14cc726748ec57d3


Can you try again without --g-fatal-warnings:

  export G_DEBUG=fatal-criticals
  gdb /usr/sbin/NetworkManager
  > run --debug


Thomas




> > 

signature.asc
Description: This is a digitally signed message part
___
networkmanager-list mailing list
networkmanager-list@gnome.org
https://mail.gnome.org/mailman/listinfo/networkmanager-list

Re: NetworkManager 1.1.90 : nm-exported-object.c:293:nm_exported_object_class_add_interface: assertion failed: (object_property != NULL)

[Ali Nematollahi]

I'm not concerned about IPv6 at all.
I'm running Kernel 3.12

Here is the backtrace:
root@beaglebone:~# gdb /usr/sbin/NetworkManager
GNU gdb (GDB) 7.4.1-debian
Copyright (C) 2012 Free Software Foundation, Inc.
License GPLv3+: GNU GPL version 3 or later 
This is free software: you are free to change and redistribute it.
There is NO WARRANTY, to the extent permitted by law.  Type "show copying"
and "show warranty" for details.
This GDB was configured as "arm-linux-gnueabihf".
For bug reporting instructions, please see:
...
Reading symbols from /usr/sbin/NetworkManager...done.
(gdb) run --debug --g-fatal-warnings
Starting program: /usr/sbin/NetworkManager --debug --g-fatal-warnings
[Thread debugging using libthread_db enabled]
Using host libthread_db library
"/lib/arm-linux-gnueabihf/libthread_db.so.1".
NetworkManager-Message:   No config file found or given; using
/etc/NetworkManager/NetworkManager.conf

[New Thread 0xb686b3c0 (LWP 2821)]

(NetworkManager:2818): NetworkManager-WARNING **:   glib-version:
cannot handle SIGUSR1 and SIGUSR2 signals. Consider upgrading glib to
2.36.0 or newer

Program received signal SIGTRAP, Trace/breakpoint trap.
0xb6c3c416 in __libc_do_syscall () from
/lib/arm-linux-gnueabihf/libpthread.so.0
(gdb) bt full
#0  0xb6c3c416 in __libc_do_syscall () from
/lib/arm-linux-gnueabihf/libpthread.so.0
No symbol table info available.
#1  0xb6c3b710 in raise () from /lib/arm-linux-gnueabihf/libpthread.so.0
No symbol table info available.
#2  0xb6ca2d44 in g_logv () from /lib/arm-linux-gnueabihf/libglib-2.0.so.0
No symbol table info available.
#3  0xb6ca2e2e in g_log () from /lib/arm-linux-gnueabihf/libglib-2.0.so.0
No symbol table info available.
#4  0x000ba55a in _nm_log_impl (file=, line=86,
func=0x16fa4c "nm_main_utils_setup_signals", level=,
domain=LOGD_CORE,
error=, fmt=0x16faf4 "glib-version: cannot handle
SIGUSR1 and SIGUSR2 signals. Consider upgrading glib to 2.36.0 or newer")
at nm-logging.c:585
args = {__ap = 0xbefffb70}
msg = 0x1d21c8 "glib-version: cannot handle SIGUSR1 and SIGUSR2
signals. Consider upgrading glib to 2.36.0 or newer"
fullmsg = 0x1d23e8 "  glib-version: cannot handle SIGUSR1 and
SIGUSR2 signals. Consider upgrading glib to 2.36.0 or newer"
tv = {tv_sec = 0, tv_usec = 389145}
__PRETTY_FUNCTION__ = "_nm_log_impl"
#5  0x0005f0b0 in nm_main_utils_setup_signals (main_loop=0x1cb7f0) at
main-utils.c:86
__PRETTY_FUNCTION__ = "nm_main_utils_setup_signals"
#6  0x0004fcb8 in main (argc=1, argv=0xbefffd44) at main.c:410
wifi_enabled = 1
net_enabled = 1
wwan_enabled = 1
success = 0
config = 0x1cec10
error = 0x0
wrote_pidfile = 0
bad_domains = 0x0
config_cli = 0x0
__PRETTY_FUNCTION__ = "main"
(gdb)


I don't think it shows much but hope it's helpful in figuring out what the
problem is. I'll try to compile the version you suggested.



On Wed, Mar 9, 2016 at 1:24 AM, Thomas Haller  wrote:

> On Tue, 2016-03-08 at 15:20 -0800, Ali Nematollahi wrote:
> > Hi guys
>
> Hi,
>
> >
> > I installed the development version of NM 1.1.90 and I was trying to
> > add a connection but NM crapped out with the error:
> > NetworkManager:ERROR:nm-exported-
> > object.c:293:nm_exported_object_class_add_interface: assertion
> > failed: (object_property != NULL)
> >
> >
> > Any ideas why?
>
>
> >
> > root@beaglebone:/etc/NetworkManager/system-connections#
> > NetworkManager --debug &
> > [2] 2751
> > root@beaglebone:/etc/NetworkManager/system-connections#
> > NetworkManager: /lib/arm-linux-gnueabihf/libnl-3.so.200: no version
> > information available (required by NetworkManager)
> > NetworkManager-Message:   No config file found or given; using
> > /etc/NetworkManager/NetworkManager.conf
> >
> >
> > (NetworkManager:2751): NetworkManager-WARNING **:   glib-
> > version: cannot handle SIGUSR1 and SIGUSR2 signals. Consider
> > upgrading glib to 2.36.0 or newer
>
> Just to confirm, which glib version are you using? (This warning by
> itself is not critical).
>
>
> > NetworkManager[2751]:   NetworkManager (version 1.1.90) is
> > starting...
> > NetworkManager[2751]:   Read config:
> > /etc/NetworkManager/NetworkManager.conf
> > NetworkManager[2751]:   monitoring kernel firmware directory
> > '/lib/firmware'.
> > NetworkManager[2751]:   dns-mgr[0x1f4c20]: set resolv-conf-
> > mode: default
> > NetworkManager[2751]:   dns-mgr[0x1f4c20]: using resolv.conf
> > manager 'none'
> > NetworkManager[2751]:   init!
> > NetworkManager[2751]: interface-parser: parsing file
> > /etc/network/interfaces
> > NetworkManager[2751]: interface-parser: finished
> > parsing file /etc/network/interfaces
> > NetworkManager[2751]:   guessed connection type (eth0) = 802-3-
> > ethernet
> > NetworkManager[2751]: 
> >  update_connection_setting_from_if_block: name:eth0, type:802-3-
> > 

Re: NetworkManager 1.1.90 : nm-exported-object.c:293:nm_exported_object_class_add_interface: assertion failed: (object_property != NULL)

[Thomas Haller]

On Tue, 2016-03-08 at 15:20 -0800, Ali Nematollahi wrote:
> Hi guys

Hi,

> 
> I installed the development version of NM 1.1.90 and I was trying to
> add a connection but NM crapped out with the error:
> NetworkManager:ERROR:nm-exported-
> object.c:293:nm_exported_object_class_add_interface: assertion
> failed: (object_property != NULL)
> 
> 
> Any ideas why?


> 
> root@beaglebone:/etc/NetworkManager/system-connections#
> NetworkManager --debug &
> [2] 2751
> root@beaglebone:/etc/NetworkManager/system-connections#
> NetworkManager: /lib/arm-linux-gnueabihf/libnl-3.so.200: no version
> information available (required by NetworkManager)
> NetworkManager-Message:   No config file found or given; using
> /etc/NetworkManager/NetworkManager.conf
> 
> 
> (NetworkManager:2751): NetworkManager-WARNING **:   glib-
> version: cannot handle SIGUSR1 and SIGUSR2 signals. Consider
> upgrading glib to 2.36.0 or newer

Just to confirm, which glib version are you using? (This warning by
itself is not critical).


> NetworkManager[2751]:   NetworkManager (version 1.1.90) is
> starting...
> NetworkManager[2751]:   Read config:
> /etc/NetworkManager/NetworkManager.conf
> NetworkManager[2751]:   monitoring kernel firmware directory
> '/lib/firmware'.
> NetworkManager[2751]:   dns-mgr[0x1f4c20]: set resolv-conf-
> mode: default
> NetworkManager[2751]:   dns-mgr[0x1f4c20]: using resolv.conf
> manager 'none'
> NetworkManager[2751]:   init!
> NetworkManager[2751]:         interface-parser: parsing file
> /etc/network/interfaces
> NetworkManager[2751]:         interface-parser: finished
> parsing file /etc/network/interfaces
> NetworkManager[2751]:   guessed connection type (eth0) = 802-3-
> ethernet
> NetworkManager[2751]: 
>  update_connection_setting_from_if_block: name:eth0, type:802-3-
> ethernet, id:Ifupdown (eth0), uuid: 681b428f-beaf-8932-dce4-
> 687ed5bae28e
> NetworkManager[2751]:   adding eth0 to connections
> NetworkManager[2751]:   adding iface eth0 to eni_ifaces
> NetworkManager[2751]:   guessed connection type (usb0) = 802-3-
> ethernet
> NetworkManager[2751]: 
>  update_connection_setting_from_if_block: name:usb0, type:802-3-
> ethernet, id:Ifupdown (usb0), uuid: 3232978a-bef5-2ef2-3aa8-
> fdd650bb306d
> NetworkManager[2751]:   addresses count: 1
> NetworkManager[2751]:   No dns-nameserver configured in
> /etc/network/interfaces
> NetworkManager[2751]:   adding usb0 to connections
> NetworkManager[2751]:   adding iface usb0 to eni_ifaces
> NetworkManager[2751]:   autoconnect
> NetworkManager[2751]:   management mode: unmanaged
> NetworkManager[2751]:   devices added (path:
> /sys/devices/ocp.2/481cc000.d_can/net/can0, iface: can0)
> NetworkManager[2751]:   device added (path:
> /sys/devices/ocp.2/481cc000.d_can/net/can0, iface: can0): no ifupdown
> configuration found.
> NetworkManager[2751]:   devices added (path:
> /sys/devices/ocp.2/481d.d_can/net/can1, iface: can1)
> NetworkManager[2751]:   device added (path:
> /sys/devices/ocp.2/481d.d_can/net/can1, iface: can1): no ifupdown
> configuration found.
> NetworkManager[2751]:   devices added (path:
> /sys/devices/ocp.2/4a10.ethernet/net/eth0, iface: eth0)
> NetworkManager[2751]:   locking wired connection setting
> NetworkManager[2751]:   devices added (path:
> /sys/devices/virtual/net/lo, iface: lo)
> NetworkManager[2751]:   device added (path:
> /sys/devices/virtual/net/lo, iface: lo): no ifupdown configuration
> found.
> NetworkManager[2751]:   end _init.
> NetworkManager[2751]:   Loaded settings plugin ifupdown: (C)
> 2008 Canonical Ltd.  To report bugs please use the NetworkManager
> mailing list. (/usr/lib/NetworkManager/libnm-settings-plugin-
> ifupdown.so)
> NetworkManager[2751]:   Loaded settings plugin iBFT: (c) 2014
> Red Hat, Inc.  To report bugs please use the NetworkManager mailing
> list. (/usr/lib/NetworkManager/libnm-settings-plugin-ibft.so)
> NetworkManager[2751]:   Loaded settings plugin keyfile: (c)
> 2007 - 2015 Red Hat, Inc.  To report bugs please use the
> NetworkManager mailing list.
> NetworkManager[2751]:   (2088960) ... get_connections.
> NetworkManager[2751]:   (2088960) ... get_connections
> (managed=false): return empty list.
> NetworkManager[2751]:   get unmanaged devices count: 1
> NetworkManager[2751]:   hostname: couldn't get property from
> hostnamed
> NetworkManager[2751]:   WiFi enabled by radio killswitch;
> enabled by state file
> NetworkManager[2751]:   WWAN enabled by radio killswitch;
> enabled by state file
> NetworkManager[2751]:   Networking is enabled by state file
> NetworkManager[2751]:   Loaded device plugin: NMVxlanFactory
> (internal)
> NetworkManager[2751]:   Loaded device plugin: NMVlanFactory
> (internal)
> NetworkManager[2751]:   Loaded device plugin: NMVethFactory
> (internal)
> NetworkManager[2751]:   Loaded device plugin: NMTunFactory
> (internal)
> NetworkManager[2751]:   Loaded device plugin: NMMacvlanFactory
> (internal)
> NetworkManager[2751]:   Loaded device plugin: NMIPTunnelFactory
> 

NetworkManager 1.1.90 : nm-exported-object.c:293:nm_exported_object_class_add_interface: assertion failed: (object_property != NULL)

[Ali Nematollahi]

Hi guys

I installed the development version of NM 1.1.90 and I was trying to add a
connection but NM crapped out with the error:
NetworkManager:ERROR:nm-exported-object.c:293:nm_exported_object_class_add_interface:
assertion failed: (object_property != NULL)


Any ideas why?


root@beaglebone:/etc/NetworkManager/system-connections# NetworkManager
--debug &
[2] 2751
root@beaglebone:/etc/NetworkManager/system-connections# NetworkManager:
/lib/arm-linux-gnueabihf/libnl-3.so.200: no version information available
(required by NetworkManager)
NetworkManager-Message:   No config file found or given; using
/etc/NetworkManager/NetworkManager.conf


(NetworkManager:2751): NetworkManager-WARNING **:   glib-version:
cannot handle SIGUSR1 and SIGUSR2 signals. Consider upgrading glib to
2.36.0 or newer
NetworkManager[2751]:   NetworkManager (version 1.1.90) is starting...
NetworkManager[2751]:   Read config:
/etc/NetworkManager/NetworkManager.conf
NetworkManager[2751]:   monitoring kernel firmware directory
'/lib/firmware'.
NetworkManager[2751]:   dns-mgr[0x1f4c20]: set resolv-conf-mode:
default
NetworkManager[2751]:   dns-mgr[0x1f4c20]: using resolv.conf manager
'none'
NetworkManager[2751]:   init!
NetworkManager[2751]: interface-parser: parsing file
/etc/network/interfaces
NetworkManager[2751]: interface-parser: finished parsing file
/etc/network/interfaces
NetworkManager[2751]:   guessed connection type (eth0) =
802-3-ethernet
NetworkManager[2751]:   update_connection_setting_from_if_block:
name:eth0, type:802-3-ethernet, id:Ifupdown (eth0), uuid:
681b428f-beaf-8932-dce4-687ed5bae28e
NetworkManager[2751]:   adding eth0 to connections
NetworkManager[2751]:   adding iface eth0 to eni_ifaces
NetworkManager[2751]:   guessed connection type (usb0) =
802-3-ethernet
NetworkManager[2751]:   update_connection_setting_from_if_block:
name:usb0, type:802-3-ethernet, id:Ifupdown (usb0), uuid:
3232978a-bef5-2ef2-3aa8-fdd650bb306d
NetworkManager[2751]:   addresses count: 1
NetworkManager[2751]:   No dns-nameserver configured in
/etc/network/interfaces
NetworkManager[2751]:   adding usb0 to connections
NetworkManager[2751]:   adding iface usb0 to eni_ifaces
NetworkManager[2751]:   autoconnect
NetworkManager[2751]:   management mode: unmanaged
NetworkManager[2751]:   devices added (path:
/sys/devices/ocp.2/481cc000.d_can/net/can0, iface: can0)
NetworkManager[2751]:   device added (path:
/sys/devices/ocp.2/481cc000.d_can/net/can0, iface: can0): no ifupdown
configuration found.
NetworkManager[2751]:   devices added (path:
/sys/devices/ocp.2/481d.d_can/net/can1, iface: can1)
NetworkManager[2751]:   device added (path:
/sys/devices/ocp.2/481d.d_can/net/can1, iface: can1): no ifupdown
configuration found.
NetworkManager[2751]:   devices added (path:
/sys/devices/ocp.2/4a10.ethernet/net/eth0, iface: eth0)
NetworkManager[2751]:   locking wired connection setting
NetworkManager[2751]:   devices added (path:
/sys/devices/virtual/net/lo, iface: lo)
NetworkManager[2751]:   device added (path:
/sys/devices/virtual/net/lo, iface: lo): no ifupdown configuration found.
NetworkManager[2751]:   end _init.
NetworkManager[2751]:   Loaded settings plugin ifupdown: (C) 2008
Canonical Ltd.  To report bugs please use the NetworkManager mailing list.
(/usr/lib/NetworkManager/libnm-settings-plugin-ifupdown.so)
NetworkManager[2751]:   Loaded settings plugin iBFT: (c) 2014 Red
Hat, Inc.  To report bugs please use the NetworkManager mailing list.
(/usr/lib/NetworkManager/libnm-settings-plugin-ibft.so)
NetworkManager[2751]:   Loaded settings plugin keyfile: (c) 2007 -
2015 Red Hat, Inc.  To report bugs please use the NetworkManager mailing
list.
NetworkManager[2751]:   (2088960) ... get_connections.
NetworkManager[2751]:   (2088960) ... get_connections
(managed=false): return empty list.
NetworkManager[2751]:   get unmanaged devices count: 1
NetworkManager[2751]:   hostname: couldn't get property from hostnamed
NetworkManager[2751]:   WiFi enabled by radio killswitch; enabled by
state file
NetworkManager[2751]:   WWAN enabled by radio killswitch; enabled by
state file
NetworkManager[2751]:   Networking is enabled by state file
NetworkManager[2751]:   Loaded device plugin: NMVxlanFactory
(internal)
NetworkManager[2751]:   Loaded device plugin: NMVlanFactory (internal)
NetworkManager[2751]:   Loaded device plugin: NMVethFactory (internal)
NetworkManager[2751]:   Loaded device plugin: NMTunFactory (internal)
NetworkManager[2751]:   Loaded device plugin: NMMacvlanFactory
(internal)
NetworkManager[2751]:   Loaded device plugin: NMIPTunnelFactory
(internal)
NetworkManager[2751]:   Loaded device plugin: NMInfinibandFactory
(internal)
NetworkManager[2751]:   Loaded device plugin: NMEthernetFactory
(internal)
NetworkManager[2751]:   Loaded device plugin: NMBridgeFactory
(internal)
NetworkManager[2751]:   Loaded device plugin: NMBondFactory (internal)
NetworkManager[2751]:   Loaded device plugin: NMWifiFactory