"Frame not request now" and timeout errors connecting to Nokia 3510i

[tangentmonger]

Trying to communicate with a Nokia 3510i via serial cable (of unknown type) on Ubuntu. The connection wizard suggests mbus and the phone appears to connect (firmware version etc are retrieved) but after that the debug log shows errors and nothing can be retrieved.

---

Wed 2013/09/18 22:48:49: [Gammu - 1.31.0 built 03:39:58 Jan 3 2012 using GCC 4.6]
Wed 2013/09/18 22:48:49: [Connection - "mbus"]
Wed 2013/09/18 22:48:49: [Connection index - 0]
Wed 2013/09/18 22:48:49: [Model type - ""]
Wed 2013/09/18 22:48:49: [Device - "/dev/ttyS0"]
Wed 2013/09/18 22:48:49: [Running on - Linux, kernel 3.2.0-52-generic (#78-Ubuntu SMP Fri Jul 26 16:21:44 UTC 2013)]
Wed 2013/09/18 22:48:49: Setting speed to 9600
Wed 2013/09/18 22:48:49: Serial device: DTR is down, RTS is up, CAR is down, CTS is down
Wed 2013/09/18 22:48:49: [Module - "auto"]
Wed 2013/09/18 22:48:49: Getting model
Wed 2013/09/18 22:48:49: SENDING frametype 0xD1/length 0x05/5
Wed 2013/09/18 22:48:49: 00 |01 |00 |03 |00 .....
Wed 2013/09/18 22:48:51: Getting model
Wed 2013/09/18 22:48:51: SENDING frametype 0xD1/length 0x05/5
Wed 2013/09/18 22:48:51: 00 |01 |00 |03 |00 .....
Wed 2013/09/18 22:48:51: [Received Ack]
Wed 2013/09/18 22:48:51: [Sending Ack of type d2, seq: 14]
Wed 2013/09/18 22:48:51: RECEIVED frametype 0xD2/length 0x23/35
Wed 2013/09/18 22:48:51: 01 |00 |00 |03 |56V|20 |300|344|2E.|300|311|0A |311|333|2D-|300 ....V 04.01.13-0
Wed 2013/09/18 22:48:51: 322|2D-|300|333|0A |52R|48H|2D-|399|0A |28(|63c|29)|20 |4EN|4DM 2-03.RH-9.(c) NM
Wed 2013/09/18 22:48:51: 50P|2E.|00 P..
Wed 2013/09/18 22:48:51: Received model RH-9
Wed 2013/09/18 22:48:51: Received firmware date 13-02-03
Wed 2013/09/18 22:48:51: Received firmware version 04.01
Wed 2013/09/18 22:48:51: Number version is "4.010000"
Wed 2013/09/18 22:48:51: [Connected model - "RH-9"]
Wed 2013/09/18 22:48:51: [Firmware version - "04.01"]
Wed 2013/09/18 22:48:51: [Firmware date - "13-02-03"]
Wed 2013/09/18 22:48:51: [Module - "1100|1100a|1100b|1112|1200|1209|1600|1650|1680|2600|2610|2630|2650|2660|2680|2760|3100|3100b|3105|3108|3109c|3200|3200a|3205|3220|3300|3510|3510i|3530|3589i|3590|3595|5000|5100|5140|5140i|5200|5220|5300|5310|6020|6020b|6021|6030|6060|6070|6085|6086|6100|6101|6103|6111|6125|6131|6151|6170|6200|6220|6220c|6230|6230i|6233|6234|6270|6275i|6280|6300|6303c|6310|6310i|6340i|6385|6500c|6500s|6510|6600|6610|6610i|6800|6810|6820|6822|7200|7210|7210s|7230|7250|7250i|7260|7270|7360|7370|7500|7600|7900|8310|8390|8800|8910|8910i"]
Wed 2013/09/18 22:48:51: SENDING frametype 0x10/length 0x0C/12
Wed 2013/09/18 22:48:51: 00 |01 |00 |10 |07 |01 |02 |06 |0A |14 |17 |399 ...........9
Wed 2013/09/18 22:48:51: [Connected]
Wed 2013/09/18 22:48:51: Entering GSM_SetIncomingCall
Wed 2013/09/18 22:48:51: Leaving GSM_SetIncomingCall
Wed 2013/09/18 22:48:51: Entering GSM_GetSignalQuality
Wed 2013/09/18 22:48:51: Getting network level
Wed 2013/09/18 22:48:51: SENDING frametype 0x0A/length 0x09/9
Wed 2013/09/18 22:48:51: 00 |01 |00 |0B |00 |02 |00 |00 |00 .........
Wed 2013/09/18 22:48:51: [ERROR: incorrect char - 1f, not 00 and 10]
Wed 2013/09/18 22:48:51: [ERROR: incorrect char - 00, not 1f]
Wed 2013/09/18 22:48:51: [ERROR: incorrect char - 10, not 1f]
Wed 2013/09/18 22:48:51: [ERROR: incorrect char - 10, not 1f]
Wed 2013/09/18 22:48:51: [ERROR: incorrect char - 00, not 1f]
Wed 2013/09/18 22:48:51: [ERROR: incorrect char - 0c, not 1f]
Wed 2013/09/18 22:48:51: [ERROR: incorrect char - 00, not 1f]
Wed 2013/09/18 22:48:51: [ERROR: incorrect char - 01, not 1f]
Wed 2013/09/18 22:48:51: [ERROR: incorrect char - 00, not 1f]
Wed 2013/09/18 22:48:51: [ERROR: incorrect char - 10, not 1f]
Wed 2013/09/18 22:48:51: [ERROR: incorrect char - 07, not 1f]
Wed 2013/09/18 22:48:51: [ERROR: incorrect char - 01, not 1f]
Wed 2013/09/18 22:48:51: [ERROR: incorrect char - 02, not 1f]
Wed 2013/09/18 22:48:51: [ERROR: incorrect char - 06, not 1f]
Wed 2013/09/18 22:48:51: [ERROR: incorrect char - 0a, not 1f]
Wed 2013/09/18 22:48:51: [ERROR: incorrect char - 14, not 1f]
Wed 2013/09/18 22:48:51: [ERROR: incorrect char - 17, not 1f]
Wed 2013/09/18 22:48:51: [ERROR: incorrect char - 39, not 1f]
Wed 2013/09/18 22:48:51: [ERROR: incorrect char - 03, not 1f]
Wed 2013/09/18 22:48:51: [ERROR: incorrect char - 33, not 1f]
Wed 2013/09/18 22:48:51: [Sending Ack of type d2, seq: 14]
Wed 2013/09/18 22:48:51: RECEIVED frametype 0xD2/length 0x23/35
Wed 2013/09/18 22:48:51: 01 |00 |00 |03 |56V|20 |300|344|2E.|300|311|0A |311|333|2D-|300 ....V 04.01.13-0
Wed 2013/09/18 22:48:51: 322|2D-|300|333|0A |52R|48H|2D-|399|0A |28(|63c|29)|20 |4EN|4DM 2-03.RH-9.(c) NM
Wed 2013/09/18 22:48:51: 50P|2E.|00 P..
Wed 2013/09/18 22:48:51:
Wed 2013/09/18 22:48:51: Frame not request now. If you can, please report it (see http://wammu.eu/support/bugs/). Thank you
Wed 2013/09/18 22:48:51: LAST SENT frame type 0x0A/length 9
Wed 2013/09/18 22:48:51: 00 |01 |00 |0B |00 |02 |00 |00 |00 .........
Wed 2013/09/18 22:48:51: RECEIVED frame type 0xD2/length 0x23/35
Wed 2013/09/18 22:48:51: 01 |00 |00 |03 |56V|20 |300|344|2E.|300|311|0A |311|333|2D-|300 ....V 04.01.13-0
Wed 2013/09/18 22:48:51: 322|2D-|300|333|0A |52R|48H|2D-|399|0A |28(|63c|29)|20 |4EN|4DM 2-03.RH-9.(c) NM
Wed 2013/09/18 22:48:51: 50P|2E.|00 P..
Wed 2013/09/18 22:48:51:
Wed 2013/09/18 22:48:51: [ERROR: incorrect char - 1f, not 00 and 10]
Wed 2013/09/18 22:48:51: [ERROR: incorrect char - 10, not 1f]
Wed 2013/09/18 22:48:51: [ERROR: incorrect char - 00, not 1f]
Wed 2013/09/18 22:48:51: [ERROR: incorrect char - d2, not 1f]
Wed 2013/09/18 22:48:51: [ERROR: incorrect char - 00, not 1f]
Wed 2013/09/18 22:48:51: [ERROR: incorrect char - 23, not 1f]
Wed 2013/09/18 22:48:51: [ERROR: incorrect char - 01, not 1f]
Wed 2013/09/18 22:48:51: [ERROR: incorrect char - 00, not 1f]
Wed 2013/09/18 22:48:51: [ERROR: incorrect char - 00, not 1f]
Wed 2013/09/18 22:48:51: [ERROR: incorrect char - 03, not 1f]
Wed 2013/09/18 22:48:51: [ERROR: incorrect char - 56, not 1f]
Wed 2013/09/18 22:48:51: [ERROR: incorrect char - 20, not 1f]
Wed 2013/09/18 22:48:51: [ERROR: incorrect char - 30, not 1f]
Wed 2013/09/18 22:48:51: [ERROR: incorrect char - 34, not 1f]
Wed 2013/09/18 22:48:51: [ERROR: incorrect char - 2e, not 1f]
Wed 2013/09/18 22:48:51: [ERROR: incorrect char - 30, not 1f]
Wed 2013/09/18 22:48:51: [ERROR: incorrect char - 31, not 1f]
Wed 2013/09/18 22:48:51: [ERROR: incorrect char - 0a, not 1f]
Wed 2013/09/18 22:48:51: [ERROR: incorrect char - 31, not 1f]
Wed 2013/09/18 22:48:51: [ERROR: incorrect char - 33, not 1f]
Wed 2013/09/18 22:48:51: [ERROR: incorrect char - 2d, not 1f]
Wed 2013/09/18 22:48:51: [ERROR: incorrect char - 30, not 1f]
Wed 2013/09/18 22:48:51: [ERROR: incorrect char - 32, not 1f]
Wed 2013/09/18 22:48:51: [ERROR: incorrect char - 2d, not 1f]
Wed 2013/09/18 22:48:51: [ERROR: incorrect char - 30, not 1f]
Wed 2013/09/18 22:48:51: [ERROR: incorrect char - 33, not 1f]
Wed 2013/09/18 22:48:51: [ERROR: incorrect char - 0a, not 1f]
Wed 2013/09/18 22:48:51: [ERROR: incorrect char - 52, not 1f]
Wed 2013/09/18 22:48:51: [ERROR: incorrect char - 48, not 1f]
Wed 2013/09/18 22:48:51: [ERROR: incorrect char - 2d, not 1f]
Wed 2013/09/18 22:48:51: [ERROR: incorrect char - 39, not 1f]
Wed 2013/09/18 22:48:51: [ERROR: incorrect char - 0a, not 1f]
Wed 2013/09/18 22:48:51: [ERROR: incorrect char - 28, not 1f]
Wed 2013/09/18 22:48:51: [ERROR: incorrect char - 63, not 1f]
Wed 2013/09/18 22:48:51: [ERROR: incorrect char - 29, not 1f]
Wed 2013/09/18 22:48:51: [ERROR: incorrect char - 20, not 1f]
Wed 2013/09/18 22:48:51: [ERROR: incorrect char - 4e, not 1f]
Wed 2013/09/18 22:48:51: [ERROR: incorrect char - 4d, not 1f]
Wed 2013/09/18 22:48:51: [ERROR: incorrect char - 50, not 1f]
Wed 2013/09/18 22:48:51: [ERROR: incorrect char - 2e, not 1f]
Wed 2013/09/18 22:48:51: [ERROR: incorrect char - 00, not 1f]
Wed 2013/09/18 22:48:51: [ERROR: incorrect char - 14, not 1f]
Wed 2013/09/18 22:48:51: [ERROR: incorrect char - 8d, not 1f]
Wed 2013/09/18 22:49:14: GSM_GetSignalQuality failed with error TIMEOUT[14]: No response in specified timeout. Probably phone not connected.
Wed 2013/09/18 22:49:14: Leaving GSM_GetSignalQuality