freemangordon | Wizzup: so, do we have more pending issues in ofono? or it is too early to say? :) | 08:56 |
---|---|---|
Wizzup | I will check but pretty sure we have some more | 08:56 |
Wizzup | did you check the abort/segfault that I mentioned, or is that related? | 08:57 |
Wizzup | will also need to try SMSes some more | 08:58 |
Wizzup | freemangordon: I need to debug more whether context active works out of the box or not through dbus | 09:00 |
Wizzup | there are some timeout issues, but that could be dbus side | 09:01 |
Wizzup | but what would often happen to me before is that it would block in dbus trying to activate until I send myself a text | 09:01 |
Wizzup | to I need to test that some more, which would kind of suggest some issues kicking still with kicking qmimodem, so need to test if you fixed that | 09:01 |
Wizzup | then there's just making a lot of sms/calls | 09:01 |
Wizzup | I don't believe switching operator works currently either, but that could be QMI limitation as well | 09:02 |
Wizzup | hmmm I think that just happened | 09:04 |
Wizzup | I don't know what exactly ~+CIEV=5,2... does, but it seems that after that (and kernel printing motmdm_voice_get_state) the context should be active, but ofono doesn't realise until I send out a sms | 09:05 |
Wizzup | I did not see any CREG this time | 09:05 |
Wizzup | looks like the CREG came minutes later, doesn't make sense to me | 09:08 |
Wizzup | [Sat Aug 27 09:02:10 2022] gsd_receive_buf: 00000000: f9 07 ef 25 55 30 30 38 37 7e 2b 43 49 45 56 3d ...%U0087~+CIEV= | 09:08 |
Wizzup | around here I activate context | 09:08 |
Wizzup | CREG comes here | 09:09 |
Wizzup | [Sat Aug 27 09:05:50 2022] gsd_receive_buf: 00000000: f9 07 ef 57 55 30 31 33 36 7e 2b 43 52 45 47 3d ...WU0136~+CREG= | 09:09 |
freemangordon | could you have SCRN=1 and re-test | 09:09 |
Wizzup | I had SCRN=1 I think | 09:09 |
Wizzup | I was looking at the display all the time | 09:09 |
freemangordon | ah, ok | 09:09 |
Wizzup | I guess CREG technically is not something ofono should wait for | 09:09 |
Wizzup | looking at this: https://m2msupport.net/m2msupport/atcreg-network-registration/ | 09:09 |
freemangordon | hmm, cannot open that site | 09:10 |
Wizzup | so what surprises me is that ~+CIEV= is matched only in motorolamodem/voicecall.c | 09:10 |
freemangordon | ah, it opened :) | 09:10 |
Wizzup | even though it seems to very clearly be used for internet contexts | 09:10 |
Wizzup | so I worry perhaps the wrong thing is being kicked | 09:10 |
Wizzup | or worse, no kicks at all | 09:10 |
Wizzup | at least looking at ciev_notify in motorolamodem/voicecall.c | 09:11 |
Wizzup | fwiw I use this: mdbus2 -s org.ofono /motmdm_0/context1 org.ofono.ConnectionContext.SetProperty Active true | 09:11 |
Wizzup | so I think this is another ofono issue | 09:11 |
freemangordon | what is this site? | 09:12 |
Wizzup | hm? | 09:13 |
freemangordon | https://m2msupport.net/m2msupport/atcreg-network-registration/ | 09:13 |
Wizzup | No idea, just first hit on google for 'at creg' | 09:13 |
freemangordon | ah :) | 09:14 |
Wizzup | I cannot exactly find what CIEV is, but in any case just matching for it in voicecall is likely the root cause here | 09:18 |
freemangordon | seems this is some unsol event, and parameters to it describe what has happened | 09:19 |
Wizzup | well it happens in response to the context activation | 09:21 |
Wizzup | but it's not a direct result it seems yes | 09:21 |
Wizzup | https://www.coniugo.de/tl_files/dateien/downloads/at/AT_Commands_G24.pdf | 09:22 |
Wizzup | maybe it is just the roaming indicator in this case? not sure | 09:22 |
Wizzup | or gprs coverage, it's usually 5,2 something though | 09:22 |
Wizzup | btw, I don't think the sms got sent either, but trying to send the sms with sphone did trigger the context being active | 09:24 |
Wizzup | the message is still pending in ofono: | 09:24 |
Wizzup | /motmdm_0/message_CC09967A6C013B436C54A7742FE20E838DEACDB8 | 09:24 |
Wizzup | # mdbus2 -s org.ofono /motmdm_0/message_CC09967A6C013B436C54A7742FE20E838DEACDB8 org.ofono.Message.GetProperties | 09:25 |
Wizzup | ({'State': <'pending'>},) | 09:25 |
Wizzup | let's send the d4 a text and see if that flushes things out | 09:27 |
freemangordon | seems we have some general issue with events from the modem | 09:27 |
Wizzup | right | 09:28 |
Wizzup | I don't think I ever saw the command come in to actually send the sms (in kernel log) | 09:29 |
Wizzup | (this is with scrn:0) | 09:29 |
freemangordon | hmm, yesterday I sent a couple of SMSes here | 09:30 |
freemangordon | no issue | 09:30 |
tmlind | we use usb qmimodem for sending and motorolamodem for receiving fyi | 09:31 |
tmlind | running ofono with logging enabled should show why an outgoing sms is pending | 09:31 |
Wizzup | freemangordon: yeah it only works sometimes | 09:33 |
tmlind | the CIEV shows the line status for voice and data i think | 09:33 |
freemangordon | Wizzup: I have to leave (will be MIA till tomorrow evening), please, gather some issues and the way to repro them. I will have a look | 09:33 |
Wizzup | tmlind: yes but we don't handle it for data :) | 09:33 |
tmlind | oh ok | 09:34 |
Wizzup | freemangordon: most of these are "works sometimes" | 09:34 |
freemangordon | hmm | 09:34 |
freemangordon | ok, enable ofono logs | 09:34 |
Wizzup | I have ofono debug enables I tihnk | 09:34 |
Wizzup | root 2841 0.0 0.3 4876 3440 ? Ss Aug26 0:08 /usr/sbin/ofonod -d *,*/*,*/*/* | 09:34 |
freemangordon | ok | 09:34 |
freemangordon | and also export OFONO_AT_DEBUG=1 | 09:35 |
freemangordon | somewhere in the startup script | 09:35 |
Wizzup | ok | 09:36 |
freemangordon | that way we'll have messages logged in ofono log as well | 09:36 |
Wizzup | I also will take a break today | 09:36 |
freemangordon | :) | 09:36 |
Wizzup | but I will add it in | 09:36 |
Wizzup | ideally we would document all these 'how to debug modem issues and provide logs' steps somewhere on the wiki | 09:36 |
freemangordon | yeah, enable that so we'll have the logs when something wrong happens | 09:36 |
freemangordon | bbl | 09:36 |
Wizzup | freemangordon: maybe this is ok: | 09:36 |
Wizzup | # cat /etc/default/ofono | 09:37 |
Wizzup | OFONO_AT_DEBUG=1 | 09:37 |
Wizzup | export OFONO_AT_DEBUG=1 | 09:37 |
Wizzup | DAEMON_OPTS="-d "*,*/*,*/*/*"" | 09:37 |
Wizzup | cc buZz ^^ :p | 09:37 |
freemangordon | don;t know, just reboot and see if you have AT commands logged in ofonod.log | 09:38 |
buZz | gee > hildon-meta-droid4 : Depends: linux-image-omap but it is not installable | 13:05 |
buZz | @ https://phoenix.maemo.org/view/Images/job/leste-image-droid4/lastFailedBuild/console | 13:05 |
uvos | yeah that issue was alleardy reported | 13:19 |
uvos | Wizzup assigned it to himself | 13:19 |
buZz | alrighty, was just browing , noticed most images havent been building | 13:49 |
uvos | thanks for checking ;) | 14:47 |
buZz | Wizzup: i stored that blurb to start a 'help to debug X' wikipage | 15:00 |
Wizzup | yeah, the image builder vms are finnicky | 16:34 |
Wizzup | after a whole java consumes all cores and it loses the ssh key | 16:34 |
Wizzup | buZz: :) | 16:46 |
Wizzup | freemangordon: well one of those entries in /etc/default/ofono did it | 16:53 |
Generated by irclog2html.py 2.17.0 by Marius Gedminas - find it at https://mg.pov.lt/irclog2html/!