Bug 94664

Summary:	[PATCH] Crash on connecting Nokia N9 via Bluetooth DUN
Product:	ModemManager	Reporter:	Lubomir Rintel <lkundrak>
Component:	general	Assignee:	ModemManager bug user <modemmanager>
Status:	RESOLVED FIXED	QA Contact:
Severity:	normal
Priority:	medium
Version:	git master
Hardware:	Other
OS:	All
Whiteboard:
i915 platform:		i915 features:
Attachments:	Suggested fix

Description Lubomir Rintel 2016-03-22 20:23:47 UTC

lt-ModemManager[27228]: <debug> [1458675345.196927] [mm-plugin-manager.c:599] port_context_run(): [plugin manager] task 4,rfcomm0: found '5' plugins to try
lt-ModemManager[27228]: <debug> [1458675345.196933] [mm-plugin-manager.c:622] port_context_run(): [plugin manager] task 4,rfcomm0: will try with plugin 'Via CBP7'
lt-ModemManager[27228]: <debug> [1458675345.196938] [mm-plugin-manager.c:622] port_context_run(): [plugin manager] task 4,rfcomm0: will try with plugin 'Iridium'
lt-ModemManager[27228]: <debug> [1458675345.196943] [mm-plugin-manager.c:622] port_context_run(): [plugin manager] task 4,rfcomm0: will try with plugin 'Nokia'
lt-ModemManager[27228]: <debug> [1458675345.196949] [mm-plugin-manager.c:622] port_context_run(): [plugin manager] task 4,rfcomm0: will try with plugin 'Cinterion'
lt-ModemManager[27228]: <debug> [1458675345.196954] [mm-plugin-manager.c:622] port_context_run(): [plugin manager] task 4,rfcomm0: will try with plugin 'Generic'
lt-ModemManager[27228]: <debug> [1458675345.196987] [mm-plugin-manager.c:635] port_context_run(): [plugin manager) task 4,rfcomm0: started
lt-ModemManager[27228]: <debug> [1458675345.196994] [mm-plugin-manager.c:519] port_context_next(): [plugin manager] task 4,rfcomm0: checking with plugin 'Via CBP7'
lt-ModemManager[27228]: <debug> [1458675345.197014] [mm-plugin.c:804] mm_plugin_supports_port(): (Via CBP7) [rfcomm0] probe required: 'at, at-vendor, at-product'
lt-ModemManager[27228]: <debug> [1458675345.197054] [mm-port-probe.c:1357] mm_port_probe_run(): (tty/rfcomm0) launching port probing: 'at, at-vendor, at-product'
lt-ModemManager[27228]: <debug> [1458675345.197176] [mm-port-serial.c:1159] mm_port_serial_open(): (rfcomm0) opening serial port...
lt-ModemManager[27228]: <debug> [1458675345.197243] [mm-port-serial.c:1297] mm_port_serial_open(): (rfcomm0) device open count is 1 (open)
lt-ModemManager[27228]: <debug> [1458675345.297480] [mm-port-serial-at.c:459] debug_log(): (rfcomm0): --> 'AT<CR>'
lt-ModemManager[27228]: <debug> [1458675345.497659] [mm-port-serial-at.c:459] debug_log(): (rfcomm0): <-- 'AT'
lt-ModemManager[27228]: <debug> [1458675345.507699] [mm-port-serial-at.c:459] debug_log(): (rfcomm0): <-- '<CR>'
lt-ModemManager[27228]: <debug> [1458675345.509727] [mm-port-serial-at.c:459] debug_log(): (rfcomm0): <-- '<CR><LF>OK<CR><LF>'
lt-ModemManager[27228]: <debug> [1458675345.509781] [mm-port-probe.c:109] mm_port_probe_set_result_at(): (tty/rfcomm0) port is AT-capable
lt-ModemManager[27228]: <debug> [1458675345.509821] [mm-port-serial-at.c:459] debug_log(): (rfcomm0): --> 'AT+CGMI<CR>'
lt-ModemManager[27228]: <debug> [1458675346.195030] [mm-plugin-manager.c:1058] device_context_min_probing_time_elapsed(): [plugin manager] task 4: min probing time elapsed
lt-ModemManager[27228]: <debug> [1458675346.195088] [mm-plugin-manager.c:1005] device_context_continue(): [plugin Manager] task 4: still 1 running probes (1 active): rfcomm0
lt-ModemManager[27228]: <debug> [1458675346.210003] [mm-port-serial-at.c:459] debug_log(): (rfcomm0): <-- 'AT+CGMI'
lt-ModemManager[27228]: <debug> [1458675346.240827] [mm-port-serial-at.c:459] debug_log(): (rfcomm0): <-- '<CR>'
lt-ModemManager[27228]: <debug> [1458675346.243041] [mm-port-serial-at.c:459] debug_log(): (rfcomm0): <-- '<CR><LF>Nokia<CR><LF>'
lt-ModemManager[27228]: <debug> [1458675346.245054] [mm-port-serial-at.c:459] debug_log(): (rfcomm0): <-- '<CR><LF>OK<CR><LF>'
lt-ModemManager[27228]: <debug> [1458675346.245109] [mm-port-probe.c:136] mm_port_probe_set_result_at_vendor(): (tty/rfcomm0) vendor probing finished
lt-ModemManager[27228]: <debug> [1458675346.245166] [mm-port-serial-at.c:459] debug_log(): (rfcomm0): --> 'AT+CGMM<CR>'
lt-ModemManager[27228]: <debug> [1458675346.945310] [mm-port-serial-at.c:459] debug_log(): (rfcomm0): <-- 'AT+CGMM'
lt-ModemManager[27228]: <debug> [1458675346.993802] [mm-port-serial-at.c:459] debug_log(): (rfcomm0): <-- '<CR>'
lt-ModemManager[27228]: <debug> [1458675347.083915] [mm-port-serial-at.c:459] debug_log(): (rfcomm0): <-- '<CR><LF>Nokia N9<CR><LF>'
lt-ModemManager[27228]: <debug> [1458675347.085987] [mm-port-serial-at.c:459] debug_log(): (rfcomm0): <-- '<CR><LF>OK<CR><LF>'
lt-ModemManager[27228]: <debug> [1458675347.086041] [mm-port-probe.c:156] mm_port_probe_set_result_at_product(): (tty/rfcomm0) product probing finished
lt-ModemManager[27228]: <debug> [1458675347.086061] [mm-plugin.c:527] apply_post_probing_filters(): (Via CBP7) [rfcomm0] filtered by vendor/product strings
lt-ModemManager[27228]: <debug> [1458675347.086082] [mm-plugin-manager.c:519] port_context_next(): [plugin manager] task 4,rfcomm0: checking with plugin 'Iridium'
lt-ModemManager[27228]: <debug> [1458675347.086113] [mm-plugin.c:804] mm_plugin_supports_port(): (Iridium) [rfcomm0] probe required: 'at, at-vendor, at-product'
assertion failed: (self->priv->task == NULL)

(gdb) bt
#0  0x00007ffff626c0f8 in __GI_raise (sig=sig@entry=6) at ../sysdeps/unix/sysv/linux/raise.c:54
#1  0x00007ffff626dd0a in __GI_abort () at abort.c:89
#2  0x00007ffff688f315 in g_assertion_message (domain=domain@entry=0x0, file=file@entry=0x555555632c2a "mm-port-probe.c", line=line@entry=1316, func=func@entry=0x555555633aa0 <__func__.45696> "mm_port_probe_run", message=message@entry=0x5555558913c0 "assertion failed: (self->priv->task == NULL)") at gtestutils.c:2429
#3  0x00007ffff688f3aa in g_assertion_message_expr (domain=domain@entry=0x0, file=file@entry=0x555555632c2a "mm-port-probe.c", line=line@entry=1316, func=func@entry=0x555555633aa0 <__func__.45696> "mm_port_probe_run", expr=expr@entry=0x555555632dae "self->priv->task == NULL") at gtestutils.c:2452
#4  0x00005555555d963d in mm_port_probe_run (self=0x555555937080 [MMPortProbe], flags=(MM_PORT_PROBE_AT | MM_PORT_PROBE_AT_VENDOR | MM_PORT_PROBE_AT_PRODUCT), at_send_delay=100000, at_remove_echo=1, at_send_lf=0, at_custom_probe=0x0, at_custom_init=0x0, cancellable=0x7fffe0004420 [GCancellable], callback=0x5555555dabf0 <port_probe_run_ready>, user_data=0x55555591bd40) at mm-port-probe.c:1316
#5  0x00005555555dc68a in mm_plugin_supports_port (self=<optimized out>, device=<optimized out>, port=0x5555558d4040 [GUdevDevice], cancellable=0x7fffe0004420 [GCancellable], callback=<optimized out>, user_data=<optimized out>) at mm-plugin.c:807
#6  0x000055555558f5d9 in plugin_supports_port_ready (plugin=0x55555589d310 [MMPluginVia], port_context=0x55555590e120) at mm-plugin-manager.c:379
#7  0x000055555558f5d9 in plugin_supports_port_ready (plugin=0x55555589d310 [MMPluginVia], res=<optimized out>, port_context=port_context@entry=0x55555590e120) at mm-plugin-manager.c:480
#8  0x00007ffff6e0cbd9 in g_task_return_now (task=0x55555591bba0 [GTask]) at gtask.c:1107
#9  0x00007ffff6e0d426 in g_task_return (task=0x55555591bba0 [GTask], type=<optimized out>) at gtask.c:1165
#10 0x00005555555dac67 in port_probe_run_ready (probe=0x555555937080 [MMPortProbe], probe_result=<optimized out>, task=task@entry=0x55555591bba0 [GTask]) at mm-plugin.c:659
#11 0x00007ffff6e0cbd9 in g_task_return_now (task=0x55555591bc70 [GTask]) at gtask.c:1107
#12 0x00007ffff6e0d426 in g_task_return (task=0x55555591bc70 [GTask], type=<optimized out>) at gtask.c:1165
#13 0x00005555555d7512 in serial_probe_schedule (self=0x555555937080 [MMPortProbe]) at mm-port-probe.c:1103
#14 0x00005555555d79ed in serial_probe_at_parse_response (port=<optimized out>, res=0x7fffe0005c10, self=self@entry=0x555555937080 [MMPortProbe]) at mm-port-probe.c:925
#15 0x00007ffff6dfa9cd in g_simple_async_result_complete (simple=0x7fffe0005c10 [GSimpleAsyncResult]) at gsimpleasyncresult.c:801
#16 0x000055555561778a in serial_command_ready (port=<optimized out>, res=<optimized out>, simple=simple@entry=0x7fffe0005c10 [GSimpleAsyncResult]) at mm-port-serial-at.c:389
#17 0x00007ffff6dfa9cd in g_simple_async_result_complete (simple=0x55555589c090 [GSimpleAsyncResult]) at gsimpleasyncresult.c:801
#18 0x0000555555613e65 in command_context_complete_and_free (ctx=ctx@entry=0x5555558f3a80, idle=idle@entry=0) at mm-port-serial.c:141
#19 0x0000555555614c11 in port_serial_got_response (self=0x555555921140 [MMPortSerialAt], parsed_response=0x7fffe8002410, error=0x0) at mm-port-serial.c:741
#20 0x0000555555616fa6 in common_input_available (self=0x555555921140 [MMPortSerialAt]) at mm-port-serial.c:909
#21 0x0000555555616fa6 in common_input_available (self=0x555555921140 [MMPortSerialAt], condition=<optimized out>) at mm-port-serial.c:1020
#22 0x00007ffff68698c3 in g_main_context_dispatch (context=0x555555881fe0) at gmain.c:3154
#23 0x00007ffff68698c3 in g_main_context_dispatch (context=context@entry=0x555555881fe0) at gmain.c:3769
#24 0x00007ffff6869c70 in g_main_context_iterate (context=0x555555881fe0, block=block@entry=1, dispatch=dispatch@entry=1, self=<optimized out>) at gmain.c:3840
#25 0x00007ffff6869f92 in g_main_loop_run (loop=0x55555588adb0) at gmain.c:4034
#26 0x000055555558959c in main (argc=<optimized out>, argv=<optimized out>) at main.c:181
(gdb)

Comment 1 Lubomir Rintel 2016-03-22 20:24:20 UTC

Created attachment 122485 [details]
Suggested fix

Comment 2 Aleksander Morgado 2016-03-22 21:28:00 UTC

(In reply to Lubomir Rintel from comment #1)
> Created attachment 122485 [details]
> Suggested fix

Nice one, thanks!

Use of freedesktop.org services, including Bugzilla, is subject to our Code of Conduct. How we collect and use information is described in our Privacy Policy.