* telit modem NW DETACH
@ 2017-02-07 11:49 =?unknown-8bit?q?Andr=C3=A9?= Draszik
2017-02-07 17:22 ` Denis Kenzior
0 siblings, 1 reply; 6+ messages in thread
From: =?unknown-8bit?q?Andr=C3=A9?= Draszik @ 2017-02-07 11:49 UTC (permalink / raw)
To: ofono
[-- Attachment #1: Type: text/plain, Size: 61613 bytes --]
Hi,
I am looking for advise for how to implement the TODO item in
ofono_gprs_detached_notify() in src/gprs.c
Using my Telit UE910-EU modem, the modem always reports a network initiated
detach after closing the data connection (by disconnecting the service via
connman), and oFono ends up ofono_gprs_detached_notify(). It is my
understanding that this is unusual behaviour, and that other people are
seeing the same, e.g.
https://lists.01.org/pipermail/ofono/2015-May/015765.html
I can get around that by disabling/re-enabling the modem, but I would like
to avoid that...
As a further point, whenever the modem reports that it has been disconnected
but then the CellID changes, it magically reconnects, so I believe I should
be looking to set oFono's state machine back to trying to reconnect and
eventually issue the correct AT command to do so forcefully. See 2nd part of
the log below.
Cheers,
Andre'
----- snip disconnect & detach -----
connmand[22516]: ../connman-1.33/plugins/ofono.c:network_disconnect() /telit_0 network 0x56451280
connmand[22516]: ../connman-1.33/plugins/ofono.c:get_context_with_network() network 0x56451280
connmand[22516]: ../connman-1.33/plugins/ofono.c:context_set_active() /telit_0 active 0
connmand[22516]: ../connman-1.33/plugins/ofono.c:set_property() /telit_0 path /telit_0/context2 org.ofono.ConnectionContext.Active
connmand[22516]: rp_filter restored to 2
connmand[22516]: rp_filter set to 2 (loose mode routing), old value was 2
ofonod[23391]: ../ofono-1.19/drivers/atmodem/gprs-context.c:at_gprs_deactivate_primary() cid 1
ofonod[23391]: PPP: lcp: pppcp_generate_event: current state 9:OPENED
method call time=1482938882.207935 sender=:1.0 -> destination=org.ofono serial=103 path=/telit_0/context2; interface=org.ofono.ConnectionContext; member=SetProperty
string "Active"
variant boolean false
signal time=1482938882.208839 sender=:1.0 -> destination=(null destination) serial=104 path=/net/connman/service/cellular_272032050058871_context2; interface=net.connman.Service; member=PropertyChanged
string "Timeservers"
variant array [
]
signal time=1482938882.210060 sender=:1.0 -> destination=(null destination) serial=105 path=/; interface=net.connman.Manager; member=PropertyChanged
string "State"
variant string "ready"
signal time=1482938882.211533 sender=:1.0 -> destination=(null destination) serial=106 path=/net/connman/service/cellular_272032050058871_context2; interface=net.connman.Service; member=PropertyChanged
string "State"
variant string "disconnect"
signal time=1482938882.212497 sender=:1.0 -> destination=(null destination) serial=107 path=/net/connman/service/cellular_272032050058871_context2; interface=net.connman.Service; member=PropertyChanged
string "Timeservers"
variant array [
]
ofonod[23391]: PPP: event: 3 (Close), action: 8224, new_state: 4 (CLOSING)
signal time=1482938882.213705 sender=:1.0 -> destination=(null destination) serial=108 path=/net/connman/service/cellular_272032050058871_context2; interface=net.connman.Service; member=PropertyChanged
string "Nameservers"
variant array [
]
signal time=1482938882.214861 sender=:1.0 -> destination=(null destination) serial=109 path=/net/connman/service/cellular_272032050058871_context2; interface=net.connman.Service; member=PropertyChanged
string "Domains"
variant array [
]
signal time=1482938882.216439 sender=:1.0 -> destination=(null destination) serial=110 path=/net/connman/service/cellular_272032050058871_context2; interface=net.connman.Service; member=PropertyChanged
string "Proxy"
variant array [
]
ofonod[23391]: PPP: lcp: pppcp_initialize_restart_count: current state 9:OPENED
[...]
signal time=1482938882.218801 sender=:1.0 -> destination=(null destination) serial=112 path=/net/connman/technology/cellular; interface=net.connman.Technology; member=PropertyChanged
string "Connected"
variant boolean false
ofonod[23391]: PPP: lcp: pppcp_send_terminate_request: current state 9:OPENED
ofonod[23391]: PPP: ipcp: pppcp_generate_event: current state 9:OPENED
ofonod[23391]: PPP: event: 1 (Down), action: 201, new_state: 1 (STARTING)
signal time=1482938882.233873 sender=:1.0 -> destination=(null destination) serial=113 path=/net/connman/service/cellular_272032050058871_context2; interface=net.connman.Service; member=PropertyChanged
string "Timeservers"
variant array [
]
ofonod[23391]: PPP: ../ofono-1.19/gatchat/gatppp.c:ppp_enter_phase() 5
signal time=1482938882.239141 sender=:1.0 -> destination=(null destination) serial=114 path=/net/connman/service/cellular_272032050058871_context2; interface=net.connman.Service; member=PropertyChanged
string "State"
variant string "idle"
signal time=1482938882.243882 sender=:1.0 -> destination=(null destination) serial=115 path=/net/connman/service/cellular_272032050058871_context2; interface=net.connman.Service; member=PropertyChanged
string "IPv4"
variant array [
]
signal time=1482938882.247113 sender=:1.0 -> destination=(null destination) serial=116 path=/net/connman/service/cellular_272032050058871_context2; interface=net.connman.Service; member=PropertyChanged
string "IPv6"
variant array [
]
method return time=1482938882.585180 sender=:1.0 -> destination=:1.4 serial=117 reply_serial=2
connmand[22516]: (null) {del} route 0.0.0.0 gw 0.0.0.0 scope 253 <LINK>
ofonod[23391]: ../ofono-1.19/plugins/udevng.c:remove_device() /sys/devices/virtual/net/ppp0
[...]
signal time=1482938882.592443 sender=:1.0 -> destination=(null destination) serial=119 path=/; interface=net.connman.Manager; member=ServicesChanged
array [
struct {
object path "/net/connman/service/ethernet_020000a01401_067_cable"
array [
]
}
struct {
object path "/net/connman/service/cellular_272032050058871_context2"
array [
]
}
]
array [
]
ofonod[23391]: ../ofono-1.19/plugins/udev.c:udev_event() subsystem net remove
connmand[22516]: (null) {del} route 159.134.0.11 gw 0.0.0.0 scope 253 <LINK>
ofonod[23391]: ../ofono-1.19/plugins/udev.c:remove_modem() /devices/virtual/net/ppp0
connmand[22516]: (null) {del} route 159.134.0.12 gw 0.0.0.0 scope 253 <LINK>
connmand[22516]: (null) {del} address 100.94.48.26/32 label ppp0
ofonod[23391]: ../ofono-1.19/plugins/udev.c:udev_event() subsystem net finished
connmand[22516]: (null) {RX} 14 packets 1260 bytes
connmand[22516]: (null) {TX} 15 packets 1169 bytes
connmand[22516]: (null) {update} flags 4240 <DOWN>
connmand[22516]: ppp0 {newlink} index 15 address 00:00:00:00:00:00 mtu 1500
connmand[22516]: ppp0 {newlink} index 15 operstate 2 <DOWN>
connmand[22516]: ppp0 {dellink} index 15 operstate 2 <DOWN>
connmand[22516]: (null) {RX} 14 packets 1260 bytes
connmand[22516]: (null) {TX} 15 packets 1169 bytes
connmand[22516]: (null) {remove} index 15
ofonod[23391]: PPP: lcp: pppcp_process_terminate_ack: current state 4:CLOSING
connmand[22516]: lan-p3 {add} route 82.165.8.211 gw 10.32.234.254 scope 0 <UNIVERSE>
ofonod[23391]: PPP: lcp: pppcp_generate_event: current state 4:CLOSING
ofonod[23391]: PPP: event: 11 (RTA), action: 802, new_state: 2 (CLOSED)
ofonod[23391]: PPP: lcp: pppcp_this_layer_finished: current state 2:CLOSED
ofonod[23391]: PPP: ../ofono-1.19/gatchat/gatppp.c:ppp_enter_phase() 0
ofonod[23391]: PPP: ../ofono-1.19/gatchat/gatppp.c:ppp_dead()
ofonod[23391]: ../ofono-1.19/drivers/atmodem/gprs-context.c:ppp_disconnect() Reason: 6
connmand[22516]: ../connman-1.33/plugins/ofono.c:set_property_reply() /telit_0 path /telit_0/context2 org.ofono.ConnectionContext.Active
connmand[22516]: ../connman-1.33/plugins/ofono.c:context_set_active_reply() /telit_0/context2
method return time=1482938882.620585 sender=:1.2 -> destination=:1.0 serial=66 reply_serial=103
signal time=1482938882.622771 sender=:1.2 -> destination=(null destination) serial=67 path=/telit_0/context2; interface=org.ofono.ConnectionContext; member=PropertyChanged
string "Settings"
variant array [
]
connmand[22516]: ../connman-1.33/plugins/ofono.c:context_changed() context_path /telit_0/context2
connmand[22516]: ../connman-1.33/plugins/ofono.c:get_context_with_path() path /telit_0/context2
connmand[22516]: ../connman-1.33/plugins/ofono.c:context_changed() /telit_0 Settings
connmand[22516]: ../connman-1.33/plugins/ofono.c:context_changed() context_path /telit_0/context2
connmand[22516]: ../connman-1.33/plugins/ofono.c:get_context_with_path() path /telit_0/context2
connmand[22516]: ../connman-1.33/plugins/ofono.c:context_changed() /telit_0 Active 0
connmand[22516]: ../connman-1.33/plugins/ofono.c:set_disconnected() /telit_0/context2
signal time=1482938882.640299 sender=:1.2 -> destination=(null destination) serial=68 path=/telit_0/context2; interface=org.ofono.ConnectionContext; member=PropertyChanged
string "Active"
variant boolean false
[...]
signal time=1482938882.980342 sender=:1.0 -> destination=(null destination) serial=123 path=/; interface=net.connman.Manager; member=ServicesChanged
array [
struct {
object path "/net/connman/service/ethernet_020000a01401_067_cable"
array [
]
}
struct {
object path "/net/connman/service/cellular_272032050058871_context2"
array [
]
}
]
array [
]
ofonod[23391]: Modem: < \r\nNO CARRIER\r\n
ofonod[23391]: Aux: < \r\n
ofonod[23391]: Aux: < +CGEV: ME DEACT IP, "100.94.48.26", 1\r\n
ofonod[23391]: Aux: < \r\n
ofonod[23391]: Aux: < +CGREG: 0\r\n\r\n+CGEV: NW DETACH\r\n
ofonod[23391]: ../ofono-1.19/src/gprs.c:ofono_gprs_status_notify() /telit_0 status 0
ofonod[23391]: ../ofono-1.19/src/gprs.c:gprs_attached_update() gprs->attached/attached/gprs->driver_attached/gprs->status: 1/0/1/0
ofonod[23391]: ../ofono-1.19/src/gprs.c:gprs_attached_update() step A
ofonod[23391]: ../ofono-1.19/src/gprs.c:gprs_set_attached_property() gprs: attached current/new: 0x567cc8d0 1/0
connmand[22516]: ../connman-1.33/plugins/ofono.c:cm_update_attached() /telit_0 Attached 0
connmand[22516]: ../connman-1.33/plugins/ofono.c:remove_network() /telit_0
connmand[22516]: ../connman-1.33/plugins/ofono.c:remove_network() network 0x56451280
connmand[22516]: Deleting host route failed (No such device)
connmand[22516]: Deleting host route failed (No such device)
connmand[22516]: ../connman-1.33/plugins/ofono.c:network_remove() /telit_0 network 0x56451280
signal time=1482938885.402960 sender=:1.2 -> destination=(null destination) serial=69 path=/telit_0; interface=org.ofono.ConnectionManager; member=PropertyChanged
string "Attached"
variant boolean false
ofonod[23391]: ../ofono-1.19/src/gprs.c:gprs_attached_update() out
ofonod[23391]: ../ofono-1.19/src/gprs.c:ofono_gprs_detached_notify() /telit_0
ofonod[23391]: ../ofono-1.19/src/gprs.c:gprs_attached_update() gprs->attached/attached/gprs->driver_attached/gprs->status: 0/0/0/0
signal time=1482938885.504189 sender=:1.0 -> destination=(null destination) serial=124 path=/; interface=net.connman.Manager; member=ServicesChanged
array [
struct {
object path "/net/connman/service/ethernet_020000a01401_067_cable"
array [
]
}
]
array [
object path "/net/connman/service/cellular_272032050058871_context2"
]
----- snap disconnect & detach -----
----- snip auto re-connect -----
root(a)tgm-r2:~# ofonod[23391]: Aux: < \r\n
ofonod[23391]: Aux: < +CGREG: 0\r\n\r\n+CREG: 1,"75AA","00C21B9",2\r\n
ofonod[23391]: ../ofono-1.19/src/gprs.c:ofono_gprs_status_notify() /telit_0 status 0
ofonod[23391]: ../ofono-1.19/src/gprs.c:gprs_attached_update() gprs->attached/attached/gprs->driver_attached/gprs->status: 0/0/0/0
ofonod[23391]: ../ofono-1.19/src/network.c:ofono_netreg_status_notify() /telit_0 status 1 tech 2
signal time=1482939111.500577 sender=:1.2 -> destination=(null destination) serial=70 path=/telit_0; interface=org.ofono.NetworkRegistration; member=PropertyChanged
string "CellId"
variant uint32 795065
ofonod[23391]: ../ofono-1.19/gatchat/gatchat.c:at_chat_send_common() chat/gid/cmd/prefix_list/flags: 0x567c73e0/3/AT+COPS=3,2/0x563e91c0/0x0
ofonod[23391]: ../ofono-1.19/gatchat/gatchat.c:at_chat_send_common() chat->command_queue/next_cmd_id: 0x77aa6e90/94,
ofonod[23391]: ../ofono-1.19/gatchat/gatchat.c:at_chat_send_common() c: 0x567cd110
ofonod[23391]: ../ofono-1.19/gatchat/gatchat.c:at_chat_send_common() chat/gid/cmd/prefix_list/flags: 0x567c73e0/3/AT+COPS?/0x563ddc70/0x0
ofonod[23391]: ../ofono-1.19/gatchat/gatchat.c:at_chat_send_common() chat->command_queue/next_cmd_id: 0x77aa6e90/95,
ofonod[23391]: ../ofono-1.19/gatchat/gatchat.c:at_chat_send_common() c: 0x567d02c0
ofonod[23391]: ../ofono-1.19/gatchat/gatchat.c:at_chat_send_common() chat/gid/cmd/prefix_list/flags: 0x567c73e0/3/AT+CIND?/0x563ddc60/0x0
ofonod[23391]: ../ofono-1.19/gatchat/gatchat.c:at_chat_send_common() chat->command_queue/next_cmd_id: 0x77aa6e90/96,
ofonod[23391]: ../ofono-1.19/gatchat/gatchat.c:at_chat_send_common() c: 0x567d04b0
ofonod[23391]: ../ofono-1.19/src/gprs.c:netreg_status_changed() 1
ofonod[23391]: ../ofono-1.19/src/gprs.c:gprs_netreg_update() attach: 1, driver_attached: 0
ofonod[23391]: ../ofono-1.19/gatchat/gatchat.c:at_chat_send_common() chat/gid/cmd/prefix_list/flags: 0x567c73e0/10/AT+CGATT=1/0x563e9240/0x0
ofonod[23391]: ../ofono-1.19/gatchat/gatchat.c:at_chat_send_common() chat->command_queue/next_cmd_id: 0x77aa6e90/97,
ofonod[23391]: ../ofono-1.19/gatchat/gatchat.c:at_chat_send_common() c: 0x567cfe80
ofonod[23391]: Aux: > AT+COPS=3,2\r
ofonod[23391]: Aux: < \r\nOK\r\n
ofonod[23391]: Aux: > AT+COPS?\r
ofonod[23391]: Aux: < \r\n
ofonod[23391]: Aux: < +COPS: 0,2,"27203",2\r\n\r\nOK\r\n
ofonod[23391]: ../ofono-1.19/drivers/atmodem/network-registration.c:cops_numeric_cb() Cops numeric got mcc: 272, mnc: 03
ofonod[23391]: ../ofono-1.19/gatchat/gatchat.c:at_chat_send_common() chat/gid/cmd/prefix_list/flags: 0x567c73e0/3/AT+COPS=3,0/0x563e91c0/0x0
ofonod[23391]: ../ofono-1.19/gatchat/gatchat.c:at_chat_send_common() chat->command_queue/next_cmd_id: 0x77aa6e90/98,
ofonod[23391]: ../ofono-1.19/gatchat/gatchat.c:at_chat_send_common() c: 0x567cd110k
ofonod[23391]: ../ofono-1.19/gatchat/gatchat.c:at_chat_send_common() chat/gid/cmd/prefix_list/flags: 0x567c73e0/3/AT+COPS?/0x563ddc70/0x0
ofonod[23391]: ../ofono-1.19/gatchat/gatchat.c:at_chat_send_common() chat->command_queue/next_cmd_id: 0x77aa6e90/99,
ofonod[23391]: ../ofono-1.19/gatchat/gatchat.c:at_chat_send_common() c: 0x567d3100
ofonod[23391]: Aux: > AT+CIND?\r
ofonod[23391]: Aux: < \r\n+CIND: 0,2,1,0,0,0,0,0,3\r\n\r\nOK\r\n
ofonod[23391]: Aux: > AT+CGATT=1\r
ofonod[23391]: Aux: < \r\nOK\r\n
ofonod[23391]: Aux: < \r\n+CGREG: 1,"75AA","00C21B9",2,"01"\r\n\r\n+CIEV: rssi,5\r\n
ofonod[23391]: ../ofono-1.19/src/gprs.c:gprs_attach_callback() /telit_0 error = 0
ofonod[23391]: ../ofono-1.19/gatchat/gatchat.c:at_chat_send_common() chat/gid/cmd/prefix_list/flags: 0x567c73e0/10/AT+CGREG?/0x563ddf1c/0x0
ofonod[23391]: ../ofono-1.19/gatchat/gatchat.c:at_chat_send_common() chat->command_queue/next_cmd_id: 0x77aa6e90/100,
ofonod[23391]: ../ofono-1.19/gatchat/gatchat.c:at_chat_send_common() c: 0x567d02c0
ofonod[23391]: ../ofono-1.19/src/gprs.c:ofono_gprs_status_notify() /telit_0 status 1
ofonod[23391]: ../ofono-1.19/src/network.c:ofono_netreg_strength_notify() strength 100
connmand[22516]: ../connman-1.33/plugins/ofono.c:netreg_update_strength() /telit_0 Strength 100
signal time=1482939112.767814 sender=:1.2 -> destination=(null destination) serial=71 path=/telit_0; interface=org.ofono.NetworkRegistration; member=PropertyChanged
string "Strength"
variant byte 100
ofonod[23391]: Aux: > AT+COPS=3,0\r
ofonod[23391]: Aux: < \r\nOK\r\n
ofonod[23391]: Aux: > AT+COPS?\r
ofonod[23391]: Aux: < \r\n
ofonod[23391]: Aux: < +COPS: 0,0,"eir",2\r\n\r\nOK\r\n
ofonod[23391]: ../ofono-1.19/drivers/atmodem/network-registration.c:cops_cb() cops_cb: eir, 272 03 2
ofonod[23391]: ../ofono-1.19/src/network.c:current_operator_callback() 0x567c64f0, 0x567d0430
ofonod[23391]: Aux: > AT+CGREG?\r
ofonod[23391]: Aux: < \r\n
ofonod[23391]: Aux: < +CGREG: 2,1,"75AA","00C21B9",2,"01"\r\n\r\nOK\r\n
ofonod[23391]: ../ofono-1.19/src/gprs.c:registration_status_cb() /telit_0 error 0 status 1
ofonod[23391]: ../ofono-1.19/src/gprs.c:ofono_gprs_status_notify() /telit_0 status 1
ofonod[23391]: ../ofono-1.19/src/gprs.c:gprs_attached_update() gprs->attached/attached/gprs->driver_attached/gprs->status: 0/1/1/1
ofonod[23391]: ../ofono-1.19/src/gprs.c:gprs_set_attached_property() gprs: attached current/new: 0x567cc8d0 0/1
connmand[22516]: ../connman-1.33/plugins/ofono.c:cm_update_attached() /telit_0 Attached 1
connmand[22516]: ../connman-1.33/plugins/ofono.c:get_properties() /telit_0 path /telit_0 org.ofono.NetworkRegistration
signal time=1482939112.830363 sender=:1.2 -> destination=(null destination) serial=72 path=/telit_0; interface=org.ofono.ConnectionManager; member=PropertyChanged
string "Attached"
variant boolean true
method call time=1482939112.831631 sender=:1.0 -> destination=org.ofono serial=125 path=/telit_0; interface=org.ofono.NetworkRegistration; member=GetProperties
ofonod[23391]: ../ofono-1.19/src/gprs.c:gprs_attached_update() out
connmand[22516]: ../connman-1.33/plugins/ofono.c:get_properties_reply() /telit_0 path /telit_0 org.ofono.NetworkRegistration
connmand[22516]: ../connman-1.33/plugins/ofono.c:netreg_properties_reply() /telit_0
connmand[22516]: ../connman-1.33/plugins/ofono.c:netreg_update_regdom() /telit_0 MobileContryCode 272
connmand[22516]: ../connman-1.33/plugins/ofono.c:netreg_update_name() /telit_0 Name eir
connmand[22516]: ../connman-1.33/plugins/ofono.c:netreg_update_strength() /telit_0 Strength 100
connmand[22516]: ../connman-1.33/plugins/ofono.c:add_network() /telit_0
connmand[22516]: ../connman-1.33/plugins/ofono.c:add_network() network 0x56452a20
connmand[22516]: ../connman-1.33/plugins/ofono.c:network_probe() /telit_0 network 0x56452a20
connmand[22516]: ../connman-1.33/plugins/ofono.c:network_probe() /telit_0 network 0x56452a20
method return time=1482939112.840127 sender=:1.2 -> destination=:1.0 serial=73 reply_serial=125
array [
dict entry(
string "Status"
variant string "registered"
)
dict entry(
string "Mode"
variant string "auto"
)
dict entry(
string "LocationAreaCode"
variant uint16 30122
)
dict entry(
string "CellId"
variant uint32 795065
)
dict entry(
string "Technology"
variant string "umts"
)
dict entry(
string "MobileCountryCode"
variant string "272"
)
dict entry(
string "MobileNetworkCode"
variant string "03"
)
dict entry(
string "Name"
variant string "eir"
)
dict entry(
string "Strength"
variant byte 100
)
]
signal time=1482939112.942121 sender=:1.0 -> destination=(null destination) serial=126 path=/; interface=net.connman.Manager; member=ServicesChanged
array [
struct {
object path "/net/connman/service/ethernet_020000a01401_067_cable"
array [
]
}
struct {
object path "/net/connman/service/cellular_272032050058871_context2"
array [
dict entry(
string "Type"
variant string "cellular"
)
dict entry(
string "Security"
variant array [
]
)
dict entry(
string "State"
variant string "idle"
)
dict entry(
string "Strength"
variant byte 100
)
dict entry(
string "Favorite"
variant boolean true
)
dict entry(
string "Immutable"
variant boolean false
)
dict entry(
string "AutoConnect"
variant boolean true
)
dict entry(
string "Name"
variant string "eir"
)
dict entry(
string "Roaming"
variant boolean false
)
dict entry(
string "Ethernet"
variant array [
dict entry(
string "Method"
variant string "auto"
)
]
)
dict entry(
string "IPv4"
variant array [
]
)
dict entry(
string "IPv4.Configuration"
variant array [
dict entry(
string "Method"
variant string "fixed"
)
dict entry(
string "Address"
variant string "100.94.48.26"
)
dict entry(
string "Netmask"
variant string "255.255.255.255"
)
]
)
dict entry(
string "IPv6"
variant array [
]
)
dict entry(
string "IPv6.Configuration"
variant array [
dict entry(
string "Method"
variant string "off"
)
]
)
dict entry(
string "Nameservers"
variant array [
]
)
dict entry(
string "Nameservers.Configuration"
variant array [
]
)
dict entry(
string "Timeservers"
variant array [
]
)
dict entry(
string "Timeservers.Configuration"
variant array [
]
)
dict entry(
string "Domains"
variant array [
]
)
dict entry(
string "Domains.Configuration"
variant array [
]
)
dict entry(
string "Proxy"
variant array [
]
)
dict entry(
string "Proxy.Configuration"
variant array [
]
)
dict entry(
string "Provider"
variant array [
]
)
]
}
]
array [
]
connmand[22516]: Skipping disconnect of /telit_0/context2, network is connecting.
connmand[22516]: ../connman-1.33/plugins/ofono.c:network_connect() /telit_0 network 0x56452a20
connmand[22516]: ../connman-1.33/plugins/ofono.c:get_context_with_network() network 0x56452a20
connmand[22516]: ../connman-1.33/plugins/ofono.c:context_set_active() /telit_0 active 1
connmand[22516]: ../connman-1.33/plugins/ofono.c:set_property() /telit_0 path /telit_0/context2 org.ofono.ConnectionContext.Active
connmand[22516]: ipconfig state 2 ipconfig method 1
method call time=1482939113.290993 sender=:1.0 -> destination=org.ofono serial=127 path=/telit_0/context2; interface=org.ofono.ConnectionContext; member=SetProperty
string "Active"
variant boolean true
signal time=1482939113.291173 sender=:1.0 -> destination=(null destination) serial=128 path=/net/connman/service/cellular_272032050058871_context2; interface=net.connman.Service; member=PropertyChanged
string "Timeservers"
variant array [
]
signal time=1482939113.291303 sender=:1.0 -> destination=(null destination) serial=129 path=/net/connman/service/cellular_272032050058871_context2; interface=net.connman.Service; member=PropertyChanged
string "State"
variant string "association"
signal time=1482939113.629315 sender=:1.0 -> destination=(null destination) serial=130 path=/; interface=net.connman.Manager; member=ServicesChanged
array [
struct {
object path "/net/connman/service/ethernet_020000a01401_067_cable"
array [
]
}
struct {
object path "/net/connman/service/cellular_272032050058871_context2"
array [
]
}
]
array [
]
ofonod[23391]: ../ofono-1.19/drivers/atmodem/gprs-context.c:at_gprs_activate_primary() cid 1
ofonod[23391]: ../ofono-1.19/drivers/atmodem/gprs-context.c:at_gprs_activate_primary() ctx->auth_method 0 chap
ofonod[23391]: ../ofono-1.19/gatchat/gatchat.c:at_chat_send_common() chat/gid/cmd/prefix_list/flags: 0x567c78c0/1/AT+CGDCONT=1,"IP","data.eircom.ie"/0x563e9250/0x0
ofonod[23391]: ../ofono-1.19/gatchat/gatchat.c:at_chat_send_common() chat->command_queue/next_cmd_id: 0x77aa6eb0/5,
ofonod[23391]: ../ofono-1.19/gatchat/gatchat.c:at_chat_send_common() c: 0x567d02b0
ofonod[23391]: Modem: > AT+CGDCONT=1,"IP","data.eircom.ie"\r
ofonod[23391]: Modem: < \r\nOK\r\n
ofonod[23391]: ../ofono-1.19/drivers/atmodem/gprs-context.c:at_cgdcont_cb() ok 1
ofonod[23391]: ../ofono-1.19/gatchat/gatchat.c:at_chat_send_common() chat/gid/cmd/prefix_list/flags: 0x567c78c0/1/AT+CGDATA="PPP",1/0x563e9250/0x0
ofonod[23391]: ../ofono-1.19/gatchat/gatchat.c:at_chat_send_common() chat->command_queue/next_cmd_id: 0x77aa6eb0/6,
ofonod[23391]: ../ofono-1.19/gatchat/gatchat.c:at_chat_send_common() c: 0x567cd110
ofonod[23391]: Modem: > AT+CGDATA="PPP",1\r
ofonod[23391]: Modem: < \r\nCONNECT\r\n
ofonod[23391]: ../ofono-1.19/drivers/atmodem/gprs-context.c:at_cgdata_cb() ok 1
ofonod[23391]: ../ofono-1.19/drivers/atmodem/gprs-context.c:setup_ppp()
ofonod[23391]: PPP: lcp: pppcp_generate_event: current state 0:INITIAL
ofonod[23391]: PPP: event: 0 (Up), action: 2, new_state: 2 (CLOSED)
ofonod[23391]: PPP: lcp: pppcp_generate_event: current state 2:CLOSED
ofonod[23391]: PPP: event: 2 (Open), action: 1026, new_state: 6 (REQSENT)
ofonod[23391]: PPP: lcp: pppcp_initialize_restart_count: current state 2:CLOSED
ofonod[23391]: PPP: lcp: pppcp_send_configure_request: current state 2:CLOSED
ofonod[23391]: PPP: ../ofono-1.19/gatchat/gatppp.c:ppp_enter_phase() 1
ofonod[23391]: PPP: lcp: pppcp_process_configure_request: current state 6:REQSENT
ofonod[23391]: PPP: lcp: pppcp_generate_event: current state 6:REQSENT
ofonod[23391]: PPP: event: 6 (RCR+), action: 2008, new_state: 8 (ACKSENT)
ofonod[23391]: PPP: lcp: pppcp_send_configure_ack: current state 6:REQSENT
ofonod[23391]: PPP: lcp: pppcp_process_configure_ack: current state 8:ACKSENT
ofonod[23391]: PPP: lcp: pppcp_generate_event: current state 8:ACKSENT
ofonod[23391]: PPP: event: 8 (RCA), action: 129, new_state: 9 (OPENED)
ofonod[23391]: PPP: lcp: pppcp_initialize_restart_count: current state 8:ACKSENT
ofonod[23391]: PPP: ../ofono-1.19/gatchat/gatppp.c:ppp_enter_phase() 3
ofonod[23391]: PPP: ipcp: pppcp_generate_event: current state 0:INITIAL
ofonod[23391]: PPP: event: 2 (Open), action: 401, new_state: 1 (STARTING)
ofonod[23391]: PPP: ipcp: pppcp_generate_event: current state 1:STARTING
ofonod[23391]: PPP: event: 0 (Up), action: 1026, new_state: 6 (REQSENT)
ofonod[23391]: PPP: ipcp: pppcp_initialize_restart_count: current state 1:STARTING
ofonod[23391]: PPP: ipcp: pppcp_send_configure_request: current state 1:STARTING
ofonod[23391]: PPP: ipcp: pppcp_timeout: current state 6:REQSENT
ofonod[23391]: PPP: ipcp: pppcp_generate_event: current state 6:REQSENT
ofonod[23391]: PPP: event: 4 (TO+), action: 1006, new_state: 6 (REQSENT)
ofonod[23391]: PPP: ipcp: pppcp_send_configure_request: current state 6:REQSENT
ofonod[23391]: PPP: ipcp: pppcp_process_configure_request: current state 6:REQSENT
ofonod[23391]: PPP: ipcp: pppcp_generate_event: current state 6:REQSENT
ofonod[23391]: PPP: event: 6 (RCR+), action: 2008, new_state: 8 (ACKSENT)
ofonod[23391]: PPP: ipcp: pppcp_send_configure_ack: current state 6:REQSENT
ofonod[23391]: PPP: ipcp: pppcp_process_configure_reject: current state 8:ACKSENT
ofonod[23391]: PPP: ipcp: pppcp_generate_event: current state 8:ACKSENT
ofonod[23391]: PPP: event: 9 (RCN), action: 1028, new_state: 8 (ACKSENT)
ofonod[23391]: PPP: ipcp: pppcp_initialize_restart_count: current state 8:ACKSENT
ofonod[23391]: PPP: ipcp: pppcp_send_configure_request: current state 8:ACKSENT
ofonod[23391]: PPP: ipcp: pppcp_process_configure_nak: current state 8:ACKSENT
ofonod[23391]: PPP: ipcp: pppcp_generate_event: current state 8:ACKSENT
ofonod[23391]: PPP: event: 9 (RCN), action: 1028, new_state: 8 (ACKSENT)
ofonod[23391]: PPP: ipcp: pppcp_initialize_restart_count: current state 8:ACKSENT
ofonod[23391]: PPP: ipcp: pppcp_send_configure_request: current state 8:ACKSENT
ofonod[23391]: Aux: < \r\n#PSNT: 3\r\n
signal time=1482939117.037235 sender=:1.2 -> destination=(null destination) serial=74 path=/telit_0; interface=org.ofono.ConnectionManager; member=PropertyChanged
string "Bearer"
variant string "hsdpa"
ofonod[23391]: PPP: ipcp: pppcp_process_configure_ack: current state 8:ACKSENT
ofonod[23391]: PPP: ipcp: pppcp_generate_event: current state 8:ACKSENT
ofonod[23391]: PPP: event: 8 (RCA), action: 129, new_state: 9 (OPENED)
ofonod[23391]: PPP: ipcp: pppcp_initialize_restart_count: current state 8:ACKSENT
connmand[22516]: ppp0 {create} index 16 type 65534 <NONE>
connmand[22516]: ppp0 {update} flags 4240 <DOWN>
connmand[22516]: ppp0 {newlink} index 16 address 00:00:00:00:00:00 mtu 1500
connmand[22516]: ppp0 {newlink} index 16 operstate 2 <DOWN>
ofonod[23391]: PPP: ../ofono-1.19/gatchat/gatppp.c:ppp_enter_phase() 4
ofonod[23391]: ../ofono-1.19/drivers/atmodem/gprs-context.c:ppp_connect()
ofonod[23391]: IP: 100.94.6.59
ofonod[23391]: PTP: 0.0.0.0
ofonod[23391]: DNS: 159.134.0.11, 159.134.0.12
ofonod[23391]: ../ofono-1.19/src/gprs.c:pri_activate_callback() 0x567ceeb0
connmand[22516]: ../connman-1.33/plugins/ofono.c:set_property_reply() /telit_0 path /telit_0/context2 org.ofono.ConnectionContext.Active
connmand[22516]: ../connman-1.33/plugins/ofono.c:context_set_active_reply() /telit_0/context2
method return time=1482939117.089099 sender=:1.2 -> destination=:1.0 serial=75 reply_serial=127
connmand[22516]: ppp0 {update} flags 69841 <UP,RUNNING,LOWER_UP>
connmand[22516]: ppp0 {newlink} index 16 address 00:00:00:00:00:00 mtu 1500
connmand[22516]: ppp0 {newlink} index 16 operstate 0 <UNKNOWN>
signal time=1482939117.094404 sender=:1.2 -> destination=(null destination) serial=76 path=/telit_0/context2; interface=org.ofono.ConnectionContext; member=PropertyChanged
string "Settings"
variant array [
dict entry(
string "Interface"
variant string "ppp0"
)
dict entry(
string "Method"
variant string "static"
)
dict entry(
string "Address"
variant string "100.94.6.59"
)
dict entry(
string "Netmask"
variant string "255.255.255.255"
)
dict entry(
string "DomainNameServers"
variant array [
string "159.134.0.11"
string "159.134.0.12"
]
)
]
connmand[22516]: ../connman-1.33/plugins/ofono.c:context_changed() context_path /telit_0/context2
connmand[22516]: ../connman-1.33/plugins/ofono.c:get_context_with_path() path /telit_0/context2
connmand[22516]: ../connman-1.33/plugins/ofono.c:context_changed() /telit_0 Settings
connmand[22516]: ../connman-1.33/plugins/ofono.c:extract_ipv4_settings() Interface ppp0
connmand[22516]: ../connman-1.33/plugins/ofono.c:extract_ipv4_settings() index 16
connmand[22516]: ../connman-1.33/plugins/ofono.c:extract_ipv4_settings() Method static
connmand[22516]: ../connman-1.33/plugins/ofono.c:extract_ipv4_settings() Address 100.94.6.59
connmand[22516]: ../connman-1.33/plugins/ofono.c:extract_ipv4_settings() Netmask 255.255.255.255
connmand[22516]: ../connman-1.33/plugins/ofono.c:extract_ipv4_settings() Nameservers 159.134.0.11 159.134.0.12
signal time=1482939117.100696 sender=:1.2 -> destination=(null destination) serial=77 path=/telit_0/context2; interface=org.ofono.ConnectionContext; member=PropertyChanged
string "Active"
variant boolean true
connmand[22516]: ../connman-1.33/plugins/ofono.c:context_changed() context_path /telit_0/context2
connmand[22516]: ../connman-1.33/plugins/ofono.c:get_context_with_path() path /telit_0/context2
connmand[22516]: ../connman-1.33/plugins/ofono.c:context_changed() /telit_0 Active 1
connmand[22516]: ../connman-1.33/plugins/ofono.c:set_connected() /telit_0
signal time=1482939117.106322 sender=:1.0 -> destination=(null destination) serial=131 path=/net/connman/service/cellular_272032050058871_context2; interface=net.connman.Service; member=PropertyChanged
string "Timeservers"
variant array [
]
signal time=1482939117.443707 sender=:1.0 -> destination=(null destination) serial=132 path=/net/connman/service/cellular_272032050058871_context2; interface=net.connman.Service; member=PropertyChanged
string "State"
variant string "configuration"
signal time=1482939117.443860 sender=:1.0 -> destination=(null destination) serial=133 path=/net/connman/service/cellular_272032050058871_context2; interface=net.connman.Service; member=PropertyChanged
string "Ethernet"
variant array [
dict entry(
string "Method"
variant string "auto"
)
dict entry(
string "Interface"
variant string "ppp0"
)
dict entry(
string "Address"
variant string "00:00:00:00:00:00"
)
dict entry(
string "MTU"
variant uint16 1500
)
]
ofonod[23391]: ../ofono-1.19/plugins/udev.c:udev_event() subsystem net add
connmand[22516]: Adding host route failed (Invalid argument)
connmand[22516]: Adding host route failed (Invalid argument)
signal time=1482939117.449166 sender=:1.0 -> destination=(null destination) serial=134 path=/net/connman/service/cellular_272032050058871_context2; interface=net.connman.Service; member=PropertyChanged
string "Timeservers"
variant array [
]
ofonod[23391]: ../ofono-1.19/plugins/udev.c:udev_event() subsystem net finished
signal time=1482939117.452321 sender=:1.0 -> destination=(null destination) serial=135 path=/net/connman/service/cellular_272032050058871_context2; interface=net.connman.Service; member=PropertyChanged
string "State"
variant string "ready"
signal time=1482939117.463933 sender=:1.0 -> destination=(null destination) serial=136 path=/net/connman/service/cellular_272032050058871_context2; interface=net.connman.Service; member=PropertyChanged
string "Nameservers"
variant array [
string "159.134.0.11"
string "159.134.0.12"
]
signal time=1482939117.465312 sender=:1.0 -> destination=(null destination) serial=137 path=/net/connman/service/cellular_272032050058871_context2; interface=net.connman.Service; member=PropertyChanged
string "Domains"
variant array [
]
signal time=1482939117.466694 sender=:1.0 -> destination=(null destination) serial=138 path=/net/connman/service/cellular_272032050058871_context2; interface=net.connman.Service; member=PropertyChanged
string "Proxy"
variant array [
dict entry(
string "Method"
variant string "direct"
)
]
signal time=1482939117.468090 sender=:1.0 -> destination=(null destination) serial=139 path=/net/connman/technology/cellular; interface=net.connman.Technology; member=PropertyChanged
string "Connected"
variant boolean true
connmand[22516]: ipconfig state 3 ipconfig method 1
connmand[22516]: ppp0 {add} address 100.94.6.59/32 label ppp0 family 2
signal time=1482939117.471525 sender=:1.0 -> destination=(null destination) serial=140 path=/net/connman/service/cellular_272032050058871_context2; interface=net.connman.Service; member=PropertyChanged
string "IPv4"
variant array [
dict entry(
string "Method"
variant string "fixed"
)
dict entry(
string "Address"
variant string "100.94.6.59"
)
dict entry(
string "Netmask"
variant string "255.255.255.255"
)
]
signal time=1482939117.473153 sender=:1.0 -> destination=(null destination) serial=141 path=/; interface=net.connman.Manager; member=ServicesChanged
array [
struct {
object path "/net/connman/service/ethernet_020000a01401_067_cable"
array [
]
}
struct {
object path "/net/connman/service/cellular_272032050058871_context2"
array [
]
}
]
array [
]
connmand[22516]: ppp0 {add} route 100.94.6.59 gw 0.0.0.0 scope 253 <LINK>
connmand[22516]: ppp0 {add} route 159.134.0.11 gw 0.0.0.0 scope 253 <LINK>
connmand[22516]: ppp0 {add} route 159.134.0.12 gw 0.0.0.0 scope 253 <LINK>
ofonod[23391]: ../ofono-1.19/plugins/udevng.c:check_modem_list()
signal time=1482939118.643066 sender=:1.0 -> destination=(null destination) serial=142 path=/net/connman/service/cellular_272032050058871_context2; interface=net.connman.Service; member=PropertyChanged
string "Timeservers"
variant array [
]
signal time=1482939118.644373 sender=:1.0 -> destination=(null destination) serial=143 path=/; interface=net.connman.Manager; member=PropertyChanged
string "State"
variant string "ready"
signal time=1482939118.645685 sender=:1.0 -> destination=(null destination) serial=144 path=/net/connman/service/ethernet_020000a01401_067_cable; interface=net.connman.Service; member=PropertyChanged
string "State"
variant string "ready"
signal time=1482939118.648141 sender=:1.0 -> destination=(null destination) serial=145 path=/net/connman/service/cellular_272032050058871_context2; interface=net.connman.Service; member=PropertyChanged
string "Timeservers"
variant array [
]
signal time=1482939118.651379 sender=:1.0 -> destination=(null destination) serial=146 path=/net/connman/service/ethernet_020000a01401_067_cable; interface=net.connman.Service; member=PropertyChanged
string "Timeservers"
variant array [
]
signal time=1482939118.654578 sender=:1.0 -> destination=(null destination) serial=147 path=/net/connman/service/cellular_272032050058871_context2; interface=net.connman.Service; member=PropertyChanged
string "Timeservers"
variant array [
]
signal time=1482939118.656642 sender=:1.0 -> destination=(null destination) serial=148 path=/net/connman/service/cellular_272032050058871_context2; interface=net.connman.Service; member=PropertyChanged
string "State"
variant string "online"
signal time=1482939118.658276 sender=:1.0 -> destination=(null destination) serial=149 path=/; interface=net.connman.Manager; member=PropertyChanged
string "State"
variant string "online"
signal time=1482939118.662615 sender=:1.0 -> destination=(null destination) serial=150 path=/net/connman/service/ethernet_020000a01401_067_cable; interface=net.connman.Service; member=PropertyChanged
string "IPv4"
variant array [
dict entry(
string "Method"
variant string "dhcp"
)
dict entry(
string "Address"
variant string "10.32.234.98"
)
dict entry(
string "Netmask"
variant string "255.255.255.0"
)
]
connmand[22516]: lan-p3 {del} route 0.0.0.0 gw 10.32.234.254 scope 0 <UNIVERSE>
connmand[22516]: ppp0 {add} route 0.0.0.0 gw 0.0.0.0 scope 253 <LINK>
signal time=1482939118.759317 sender=:1.0 -> destination=(null destination) serial=151 path=/; interface=net.connman.Manager; member=ServicesChanged
array [
struct {
object path "/net/connman/service/cellular_272032050058871_context2"
array [
]
}
struct {
object path "/net/connman/service/ethernet_020000a01401_067_cable"
array [
]
}
]
array [
]
signal time=1482939119.274598 sender=:1.0 -> destination=(null destination) serial=152 path=/net/connman/service/cellular_272032050058871_context2; interface=net.connman.Service; member=PropertyChanged
string "Timeservers"
variant array [
]
ofonod[23391]: Aux: < \r\n
ofonod[23391]: Aux: < #PSNT: 2\r\n
signal time=1482939127.025764 sender=:1.2 -> destination=(null destination) serial=78 path=/telit_0; interface=org.ofono.ConnectionManager; member=PropertyChanged
string "Bearer"
variant string "umts"
ofonod[23391]: Aux: < \r\n+CGREG: 1,"75AA","00CCB55",2,"01"\r\n\r\n+CREG: 1,"75AA","00CCB55",2\r\n
ofonod[23391]: ../ofono-1.19/src/gprs.c:ofono_gprs_status_notify() /telit_0 status 1
ofonod[23391]: ../ofono-1.19/src/gprs.c:gprs_attached_update() gprs->attached/attached/gprs->driver_attached/gprs->status: 1/1/1/1
ofonod[23391]: ../ofono-1.19/src/network.c:ofono_netreg_status_notify() /telit_0 status 1 tech 2
signal time=1482939146.702388 sender=:1.2 -> destination=(null destination) serial=79 path=/telit_0; interface=org.ofono.NetworkRegistration; member=PropertyChanged
string "CellId"
variant uint32 838485
ofonod[23391]: ../ofono-1.19/gatchat/gatchat.c:at_chat_send_common() chat/gid/cmd/prefix_list/flags: 0x567c73e0/3/AT+COPS=3,2/0x563e91c0/0x0
ofonod[23391]: ../ofono-1.19/gatchat/gatchat.c:at_chat_send_common() chat->command_queue/next_cmd_id: 0x77aa6e90/101,
ofonod[23391]: ../ofono-1.19/gatchat/gatchat.c:at_chat_send_common() c: 0x567d3eb0
ofonod[23391]: ../ofono-1.19/gatchat/gatchat.c:at_chat_send_common() chat/gid/cmd/prefix_list/flags: 0x567c73e0/3/AT+COPS?/0x563ddc70/0x0
ofonod[23391]: ../ofono-1.19/gatchat/gatchat.c:at_chat_send_common() chat->command_queue/next_cmd_id: 0x77aa6e90/102,
ofonod[23391]: ../ofono-1.19/gatchat/gatchat.c:at_chat_send_common() c: 0x567d3fb0
ofonod[23391]: ../ofono-1.19/gatchat/gatchat.c:at_chat_send_common() chat/gid/cmd/prefix_list/flags: 0x567c73e0/3/AT+CIND?/0x563ddc60/0x0
ofonod[23391]: ../ofono-1.19/gatchat/gatchat.c:at_chat_send_common() chat->command_queue/next_cmd_id: 0x77aa6e90/103,
ofonod[23391]: ../ofono-1.19/gatchat/gatchat.c:at_chat_send_common() c: 0x567cf600
ofonod[23391]: ../ofono-1.19/src/gprs.c:netreg_status_changed() 1
ofonod[23391]: ../ofono-1.19/src/gprs.c:gprs_netreg_update() attach: 1, driver_attached: 1
ofonod[23391]: Aux: > AT+COPS=3,2\r
ofonod[23391]: Aux: < \r\nOK\r\n
ofonod[23391]: Aux: > AT+COPS?\r
ofonod[23391]: Aux: < \r\n
ofonod[23391]: Aux: < +COPS: 0,2,"27203",2\r\n\r\nOK\r\n
ofonod[23391]: ../ofono-1.19/drivers/atmodem/network-registration.c:cops_numeric_cb() Cops numeric got mcc: 272, mnc: 03
ofonod[23391]: ../ofono-1.19/gatchat/gatchat.c:at_chat_send_common() chat/gid/cmd/prefix_list/flags: 0x567c73e0/3/AT+COPS=3,0/0x563e91c0/0x0
ofonod[23391]: ../ofono-1.19/gatchat/gatchat.c:at_chat_send_common() chat->command_queue/next_cmd_id: 0x77aa6e90/104,
ofonod[23391]: ../ofono-1.19/gatchat/gatchat.c:at_chat_send_common() c: 0x567d3f50
ofonod[23391]: ../ofono-1.19/gatchat/gatchat.c:at_chat_send_common() chat/gid/cmd/prefix_list/flags: 0x567c73e0/3/AT+COPS?/0x563ddc70/0x0
ofonod[23391]: ../ofono-1.19/gatchat/gatchat.c:at_chat_send_common() chat->command_queue/next_cmd_id: 0x77aa6e90/105,
ofonod[23391]: ../ofono-1.19/gatchat/gatchat.c:at_chat_send_common() c: 0x567cf690
ofonod[23391]: Aux: > AT+CIND?\r
ofonod[23391]: Aux: < \r\n
ofonod[23391]: Aux: < +CIND: 0,4,1,0,0,0,0,0,5\r\n\r\nOK\r\n
ofonod[23391]: Aux: > AT+COPS=3,0\r
ofonod[23391]: Aux: < \r\nOK\r\n
ofonod[23391]: Aux: > AT+COPS?\r
ofonod[23391]: Aux: < \r\n
ofonod[23391]: Aux: < +COPS: 0,0,"eir",2\r\n\r\nOK\r\n
ofonod[23391]: ../ofono-1.19/drivers/atmodem/network-registration.c:cops_cb() cops_cb: eir, 272 03 2
ofonod[23391]: ../ofono-1.19/src/network.c:current_operator_callback() 0x567c64f0, 0x567d0430
ofonod[23391]: Aux: < \r\n+CIEV: rssi,3\r\n
ofonod[23391]: ../ofono-1.19/src/network.c:ofono_netreg_strength_notify() strength 60
connmand[22516]: ../connman-1.33/plugins/ofono.c:netreg_update_strength() /telit_0 Strength 60
signal time=1482939147.027769 sender=:1.2 -> destination=(null destination) serial=80 path=/telit_0; interface=org.ofono.NetworkRegistration; member=PropertyChanged
string "Strength"
variant byte 60
signal time=1482939147.028856 sender=:1.0 -> destination=(null destination) serial=153 path=/net/connman/service/cellular_272032050058871_context2; interface=net.connman.Service; member=PropertyChanged
string "Strength"
variant byte 60
signal time=1482939147.128997 sender=:1.0 -> destination=(null destination) serial=154 path=/; interface=net.connman.Manager; member=ServicesChanged
array [
struct {
object path "/net/connman/service/cellular_272032050058871_context2"
array [
]
}
struct {
object path "/net/connman/service/ethernet_020000a01401_067_cable"
array [
]
}
]
array [
]
ofonod[23391]: Aux: < \r\n
ofonod[23391]: Aux: < +CGREG: 1,"75AA","00C21B9",2,"01"\r\n\r\n+CREG: 1,"75AA","00C21B9",2\r\n
ofonod[23391]: ../ofono-1.19/src/gprs.c:ofono_gprs_status_notify() /telit_0 status 1
ofonod[23391]: ../ofono-1.19/src/gprs.c:gprs_attached_update() gprs->attached/attached/gprs->driver_attached/gprs->status: 1/1/1/1
ofonod[23391]: ../ofono-1.19/src/network.c:ofono_netreg_status_notify() /telit_0 status 1 tech 2
signal time=1482940398.545425 sender=:1.2 -> destination=(null destination) serial=81 path=/telit_0; interface=org.ofono.NetworkRegistration; member=PropertyChanged
string "CellId"
variant uint32 795065
ofonod[23391]: ../ofono-1.19/gatchat/gatchat.c:at_chat_send_common() chat/gid/cmd/prefix_list/flags: 0x567c73e0/3/AT+COPS=3,2/0x563e91c0/0x0
ofonod[23391]: ../ofono-1.19/gatchat/gatchat.c:at_chat_send_common() chat->command_queue/next_cmd_id: 0x77aa6e90/106,
ofonod[23391]: ../ofono-1.19/gatchat/gatchat.c:at_chat_send_common() c: 0x567d3eb0
ofonod[23391]: ../ofono-1.19/gatchat/gatchat.c:at_chat_send_common() chat/gid/cmd/prefix_list/flags: 0x567c73e0/3/AT+COPS?/0x563ddc70/0x0
ofonod[23391]: ../ofono-1.19/gatchat/gatchat.c:at_chat_send_common() chat->command_queue/next_cmd_id: 0x77aa6e90/107,
ofonod[23391]: ../ofono-1.19/gatchat/gatchat.c:at_chat_send_common() c: 0x567d3fb0
ofonod[23391]: ../ofono-1.19/gatchat/gatchat.c:at_chat_send_common() chat/gid/cmd/prefix_list/flags: 0x567c73e0/3/AT+CIND?/0x563ddc60/0x0
ofonod[23391]: ../ofono-1.19/gatchat/gatchat.c:at_chat_send_common() chat->command_queue/next_cmd_id: 0x77aa6e90/108,
ofonod[23391]: ../ofono-1.19/gatchat/gatchat.c:at_chat_send_common() c: 0x567cf600
ofonod[23391]: ../ofono-1.19/src/gprs.c:netreg_status_changed() 1
ofonod[23391]: ../ofono-1.19/src/gprs.c:gprs_netreg_update() attach: 1, driver_attached: 1
ofonod[23391]: Aux: > AT+COPS=3,2\r
ofonod[23391]: Aux: < \r\nOK\r\n
ofonod[23391]: Aux: > AT+COPS?\r
ofonod[23391]: Aux: < \r\n
ofonod[23391]: Aux: < +COPS: 0,2,"27203",2\r\n\r\nOK\r\n
ofonod[23391]: ../ofono-1.19/drivers/atmodem/network-registration.c:cops_numeric_cb() Cops numeric got mcc: 272, mnc: 03
ofonod[23391]: ../ofono-1.19/gatchat/gatchat.c:at_chat_send_common() chat/gid/cmd/prefix_list/flags: 0x567c73e0/3/AT+COPS=3,0/0x563e91c0/0x0
ofonod[23391]: ../ofono-1.19/gatchat/gatchat.c:at_chat_send_common() chat->command_queue/next_cmd_id: 0x77aa6e90/109,
ofonod[23391]: ../ofono-1.19/gatchat/gatchat.c:at_chat_send_common() c: 0x567d3f50
ofonod[23391]: ../ofono-1.19/gatchat/gatchat.c:at_chat_send_common() chat/gid/cmd/prefix_list/flags: 0x567c73e0/3/AT+COPS?/0x563ddc70/0x0
ofonod[23391]: ../ofono-1.19/gatchat/gatchat.c:at_chat_send_common() chat->command_queue/next_cmd_id: 0x77aa6e90/110,
ofonod[23391]: ../ofono-1.19/gatchat/gatchat.c:at_chat_send_common() c: 0x567cf690
ofonod[23391]: Aux: > AT+CIND?\r
ofonod[23391]: Aux: < \r\n
ofonod[23391]: Aux: < +CIND: 0,3,1,0,0,0,0,0,3\r\n\r\nOK\r\n
ofonod[23391]: Aux: > AT+COPS=3,0\r
ofonod[23391]: Aux: < \r\nOK\r\n
ofonod[23391]: Aux: > AT+COPS?\r
ofonod[23391]: Aux: < \r\n
ofonod[23391]: Aux: < +COPS: 0,0,"eir",2\r\n\r\nOK\r\n
ofonod[23391]: ../ofono-1.19/drivers/atmodem/network-registration.c:cops_cb() cops_cb: eir, 272 03 2
ofonod[23391]: ../ofono-1.19/src/network.c:current_operator_callback() 0x567c64f0, 0x567d0430
ofonod[23391]: Aux: < \r\n
ofonod[23391]: Aux: < +CGREG: 1,"75AA","00CCB55",2,"01"\r\n\r\n+CREG: 1,"75AA","00CCB55",2\r\n
ofonod[23391]: ../ofono-1.19/src/gprs.c:ofono_gprs_status_notify() /telit_0 status 1
ofonod[23391]: ../ofono-1.19/src/gprs.c:gprs_attached_update() gprs->attached/attached/gprs->driver_attached/gprs->status: 1/1/1/1
ofonod[23391]: ../ofono-1.19/src/network.c:ofono_netreg_status_notify() /telit_0 status 1 tech 2
signal time=1482940401.744378 sender=:1.2 -> destination=(null destination) serial=82 path=/telit_0; interface=org.ofono.NetworkRegistration; member=PropertyChanged
string "CellId"
variant uint32 838485
ofonod[23391]: ../ofono-1.19/gatchat/gatchat.c:at_chat_send_common() chat/gid/cmd/prefix_list/flags: 0x567c73e0/3/AT+COPS=3,2/0x563e91c0/0x0
ofonod[23391]: ../ofono-1.19/gatchat/gatchat.c:at_chat_send_common() chat->command_queue/next_cmd_id: 0x77aa6e90/111,
ofonod[23391]: ../ofono-1.19/gatchat/gatchat.c:at_chat_send_common() c: 0x567d3eb0
ofonod[23391]: ../ofono-1.19/gatchat/gatchat.c:at_chat_send_common() chat/gid/cmd/prefix_list/flags: 0x567c73e0/3/AT+COPS?/0x563ddc70/0x0
ofonod[23391]: ../ofono-1.19/gatchat/gatchat.c:at_chat_send_common() chat->command_queue/next_cmd_id: 0x77aa6e90/112,
ofonod[23391]: ../ofono-1.19/gatchat/gatchat.c:at_chat_send_common() c: 0x567d3fb0
ofonod[23391]: ../ofono-1.19/gatchat/gatchat.c:at_chat_send_common() chat/gid/cmd/prefix_list/flags: 0x567c73e0/3/AT+CIND?/0x563ddc60/0x0
ofonod[23391]: ../ofono-1.19/gatchat/gatchat.c:at_chat_send_common() chat->command_queue/next_cmd_id: 0x77aa6e90/113,
ofonod[23391]: ../ofono-1.19/gatchat/gatchat.c:at_chat_send_common() c: 0x567cf600
ofonod[23391]: ../ofono-1.19/src/gprs.c:netreg_status_changed() 1
ofonod[23391]: ../ofono-1.19/src/gprs.c:gprs_netreg_update() attach: 1, driver_attached: 1
ofonod[23391]: Aux: > AT+COPS=3,2\r
ofonod[23391]: Aux: < \r\nOK\r\n
ofonod[23391]: Aux: < \r\n+CIEV: rssi,4\r\n
ofonod[23391]: ../ofono-1.19/src/network.c:ofono_netreg_strength_notify() strength 80
connmand[22516]: ../connman-1.33/plugins/ofono.c:netreg_update_strength() /telit_0 Strength 80
signal time=1482940401.793832 sender=:1.2 -> destination=(null destination) serial=83 path=/telit_0; interface=org.ofono.NetworkRegistration; member=PropertyChanged
string "Strength"
variant byte 80
signal time=1482940401.794866 sender=:1.0 -> destination=(null destination) serial=155 path=/net/connman/service/cellular_272032050058871_context2; interface=net.connman.Service; member=PropertyChanged
string "Strength"
variant byte 80
ofonod[23391]: Aux: > AT+COPS?\r
ofonod[23391]: Aux: < \r\n
ofonod[23391]: Aux: < +COPS: 0,2,"27203",2\r\n\r\nOK\r\n
ofonod[23391]: ../ofono-1.19/drivers/atmodem/network-registration.c:cops_numeric_cb() Cops numeric got mcc: 272, mnc: 03
ofonod[23391]: ../ofono-1.19/gatchat/gatchat.c:at_chat_send_common() chat/gid/cmd/prefix_list/flags: 0x567c73e0/3/AT+COPS=3,0/0x563e91c0/0x0
ofonod[23391]: ../ofono-1.19/gatchat/gatchat.c:at_chat_send_common() chat->command_queue/next_cmd_id: 0x77aa6e90/114,
ofonod[23391]: ../ofono-1.19/gatchat/gatchat.c:at_chat_send_common() c: 0x567d3f50
ofonod[23391]: ../ofono-1.19/gatchat/gatchat.c:at_chat_send_common() chat/gid/cmd/prefix_list/flags: 0x567c73e0/3/AT+COPS?/0x563ddc70/0x0
ofonod[23391]: ../ofono-1.19/gatchat/gatchat.c:at_chat_send_common() chat->command_queue/next_cmd_id: 0x77aa6e90/115,
ofonod[23391]: ../ofono-1.19/gatchat/gatchat.c:at_chat_send_common() c: 0x567cf690
ofonod[23391]: Aux: > AT+CIND?\r
ofonod[23391]: Aux: < \r\n
ofonod[23391]: Aux: < +CIND: 0,4,1,0,0,0,0,0,4\r\n\r\nOK\r\n
ofonod[23391]: Aux: > AT+COPS=3,0\r
ofonod[23391]: Aux: < \r\nOK\r\n
ofonod[23391]: Aux: > AT+COPS?\r
ofonod[23391]: Aux: < \r\n
ofonod[23391]: Aux: < +COPS: 0,0,"eir",2\r\n\r\nOK\r\n
ofonod[23391]: ../ofono-1.19/drivers/atmodem/network-registration.c:cops_cb() cops_cb: eir, 272 03 2
ofonod[23391]: ../ofono-1.19/src/network.c:current_operator_callback() 0x567c64f0, 0x567d0430
signal time=1482940401.895081 sender=:1.0 -> destination=(null destination) serial=156 path=/; interface=net.connman.Manager; member=ServicesChanged
array [
struct {
object path "/net/connman/service/cellular_272032050058871_context2"
array [
]
}
struct {
object path "/net/connman/service/ethernet_020000a01401_067_cable"
array [
]
}
]
array [
]
ofonod[23391]: Aux: < \r\n
ofonod[23391]: Aux: < +CIEV: rssi,3\r\n
ofonod[23391]: ../ofono-1.19/src/network.c:ofono_netreg_strength_notify() strength 60
connmand[22516]: ../connman-1.33/plugins/ofono.c:netreg_update_strength() /telit_0 Strength 60
signal time=1482940406.794630 sender=:1.2 -> destination=(null destination) serial=84 path=/telit_0; interface=org.ofono.NetworkRegistration; member=PropertyChanged
string "Strength"
variant byte 60
signal time=1482940406.795715 sender=:1.0 -> destination=(null destination) serial=157 path=/net/connman/service/cellular_272032050058871_context2; interface=net.connman.Service; member=PropertyChanged
string "Strength"
variant byte 60
signal time=1482940406.895874 sender=:1.0 -> destination=(null destination) serial=158 path=/; interface=net.connman.Manager; member=ServicesChanged
array [
struct {
object path "/net/connman/service/cellular_272032050058871_context2"
array [
]
}
struct {
object path "/net/connman/service/ethernet_020000a01401_067_cable"
array [
]
}
]
array [
]
----- snap auto re-connect -----
^ permalink raw reply [flat|nested] 6+ messages in thread
* Re: telit modem NW DETACH
2017-02-07 11:49 telit modem NW DETACH =?unknown-8bit?q?Andr=C3=A9?= Draszik
@ 2017-02-07 17:22 ` Denis Kenzior
2017-02-09 9:15 ` =?unknown-8bit?q?Andr=C3=A9?= Draszik
2017-02-21 8:59 ` =?unknown-8bit?q?Andr=C3=A9?= Draszik
0 siblings, 2 replies; 6+ messages in thread
From: Denis Kenzior @ 2017-02-07 17:22 UTC (permalink / raw)
To: ofono
[-- Attachment #1: Type: text/plain, Size: 2306 bytes --]
Hi André
On 02/07/2017 05:49 AM, André Draszik wrote:
> Hi,
>
> I am looking for advise for how to implement the TODO item in
> ofono_gprs_detached_notify() in src/gprs.c
>
> Using my Telit UE910-EU modem, the modem always reports a network initiated
> detach after closing the data connection (by disconnecting the service via
> connman), and oFono ends up ofono_gprs_detached_notify(). It is my
> understanding that this is unusual behaviour, and that other people are
> seeing the same, e.g.
> https://lists.01.org/pipermail/ofono/2015-May/015765.html
>
Generally the network shouldn't just detach you if you deactivated a
context, so my first guess would be that the modem firmware is doing
something silly. Do you have another modem to test by any chance?
> I can get around that by disabling/re-enabling the modem, but I would like
> to avoid that...
>
> As a further point, whenever the modem reports that it has been disconnected
> but then the CellID changes, it magically reconnects, so I believe I should
Even more evidence that seems to indicate a firmware issue. But who knows.
> be looking to set oFono's state machine back to trying to reconnect and
> eventually issue the correct AT command to do so forcefully. See 2nd part of
> the log below.
>
You can try the simplistic approach of trying to re-attach whenever we
have been detached. Though ideally we'd need some form of detach reason
enumeration to be added in the API (obtained via +CEER or similar) so
that the gprs atom can try and make an informed guess whether the attach
is likely to succeed.
From 27.007, Section 6.10 Extended error report +CEER:
Execution command causes the TA to return one or more lines of
information text <report>, determined by the MT manufacturer, which
should offer the user of the TA an extended report of the reason for
- the failure in the last unsuccessful call setup (originating or
answering) or in‑call modification;
- the last call release;
- the last unsuccessful GPRS attach or unsuccessful PDP context activation;
- the last GPRS detach or PDP context deactivation.
Typically, the text will consist of a single line containing the cause
information given by GSM/UMTS network in textual format.
Regards,
-Denis
^ permalink raw reply [flat|nested] 6+ messages in thread
* Re: telit modem NW DETACH
2017-02-07 17:22 ` Denis Kenzior
@ 2017-02-09 9:15 ` =?unknown-8bit?q?Andr=C3=A9?= Draszik
2017-02-09 16:04 ` Denis Kenzior
2017-02-21 8:56 ` =?unknown-8bit?q?Andr=C3=A9?= Draszik
2017-02-21 8:59 ` =?unknown-8bit?q?Andr=C3=A9?= Draszik
1 sibling, 2 replies; 6+ messages in thread
From: =?unknown-8bit?q?Andr=C3=A9?= Draszik @ 2017-02-09 9:15 UTC (permalink / raw)
To: ofono
[-- Attachment #1: Type: text/plain, Size: 954 bytes --]
Thanks Denis for your advise,
On Tue, 2017-02-07 at 11:22 -0600, Denis Kenzior wrote:
>
> [...]
>
> Generally the network shouldn't just detach you if you deactivated a
> context, so my first guess would be that the modem firmware is doing
> something silly. Do you have another modem to test by any chance?
No... Are you saying it could (in theory) actually be the network itself
indeed (i.e. not the modem (firmware))?
> > I can get around that by disabling/re-enabling the modem, but I would
> > like
> > to avoid that...
> >
> > As a further point, whenever the modem reports that it has been
> > disconnected
> > but then the CellID changes, it magically reconnects, so I believe I
> > should
>
> Even more evidence that seems to indicate a firmware issue. But who
> knows.
I got my hands on a more recent firmware version, once I get a chance to
update my modem I will report back.
Cheers,
Andre'
^ permalink raw reply [flat|nested] 6+ messages in thread
* Re: telit modem NW DETACH
2017-02-09 9:15 ` =?unknown-8bit?q?Andr=C3=A9?= Draszik
@ 2017-02-09 16:04 ` Denis Kenzior
2017-02-21 8:56 ` =?unknown-8bit?q?Andr=C3=A9?= Draszik
1 sibling, 0 replies; 6+ messages in thread
From: Denis Kenzior @ 2017-02-09 16:04 UTC (permalink / raw)
To: ofono
[-- Attachment #1: Type: text/plain, Size: 187 bytes --]
Hi André,
>
> No... Are you saying it could (in theory) actually be the network itself
> indeed (i.e. not the modem (firmware))?
Yes, this is a possibility.
Regards,
-Denis
^ permalink raw reply [flat|nested] 6+ messages in thread
* Re: telit modem NW DETACH
2017-02-09 9:15 ` =?unknown-8bit?q?Andr=C3=A9?= Draszik
2017-02-09 16:04 ` Denis Kenzior
@ 2017-02-21 8:56 ` =?unknown-8bit?q?Andr=C3=A9?= Draszik
1 sibling, 0 replies; 6+ messages in thread
From: =?unknown-8bit?q?Andr=C3=A9?= Draszik @ 2017-02-21 8:56 UTC (permalink / raw)
To: ofono
[-- Attachment #1: Type: text/plain, Size: 1293 bytes --]
On Thu, 2017-02-09 at 09:15 +0000, André Draszik wrote:
> Thanks Denis for your advise,
>
> On Tue, 2017-02-07 at 11:22 -0600, Denis Kenzior wrote:
> >
> > [...]
> >
> > Generally the network shouldn't just detach you if you deactivated a
> > context, so my first guess would be that the modem firmware is doing
> > something silly. Do you have another modem to test by any chance?
>
> No... Are you saying it could (in theory) actually be the network itself
> indeed (i.e. not the modem (firmware))?
>
> > > I can get around that by disabling/re-enabling the modem, but I would
> > > like
> > > to avoid that...
> > >
> > > As a further point, whenever the modem reports that it has been
> > > disconnected
> > > but then the CellID changes, it magically reconnects, so I believe I
> > > should
> >
> > Even more evidence that seems to indicate a firmware issue. But who
> > knows.
>
> I got my hands on a more recent firmware version, once I get a chance to
> update my modem I will report back.
The most recent firmware available didn't make any difference to the
behaviour, neither did changing the mobile provider.
A colleague of mine is looking to implement something now that will
hopefully be upstreamable.
Cheers,
Andre'
^ permalink raw reply [flat|nested] 6+ messages in thread
* Re: telit modem NW DETACH
2017-02-07 17:22 ` Denis Kenzior
2017-02-09 9:15 ` =?unknown-8bit?q?Andr=C3=A9?= Draszik
@ 2017-02-21 8:59 ` =?unknown-8bit?q?Andr=C3=A9?= Draszik
1 sibling, 0 replies; 6+ messages in thread
From: =?unknown-8bit?q?Andr=C3=A9?= Draszik @ 2017-02-21 8:59 UTC (permalink / raw)
To: ofono
[-- Attachment #1: Type: text/plain, Size: 403 bytes --]
On Tue, 2017-02-07 at 11:22 -0600, Denis Kenzior wrote:
> You can try the simplistic approach of trying to re-attach whenever we
> have been detached. Though ideally we'd need some form of detach reason
> enumeration to be added in the API (obtained via +CEER or similar) so
Unfortunately, this modem reports no error, just 'Normal, unspecified' in
reply to +CEER.
Cheers,
Andre'
^ permalink raw reply [flat|nested] 6+ messages in thread
end of thread, other threads:[~2017-02-21 8:59 UTC | newest]
Thread overview: 6+ messages (download: mbox.gz / follow: Atom feed)
-- links below jump to the message on this page --
2017-02-07 11:49 telit modem NW DETACH =?unknown-8bit?q?Andr=C3=A9?= Draszik
2017-02-07 17:22 ` Denis Kenzior
2017-02-09 9:15 ` =?unknown-8bit?q?Andr=C3=A9?= Draszik
2017-02-09 16:04 ` Denis Kenzior
2017-02-21 8:56 ` =?unknown-8bit?q?Andr=C3=A9?= Draszik
2017-02-21 8:59 ` =?unknown-8bit?q?Andr=C3=A9?= Draszik
This is an external index of several public inboxes,
see mirroring instructions on how to clone and mirror
all data and code used by this external index.