[Apr 14 21:40:19] DEBUG[16708] chan_mobile.c: [gsm3] +CIEV: 6,1
[Apr 14 21:40:19] DEBUG[16708] chan_mobile.c: [gsm3] incoming call, waiting for caller id
[Apr 14 21:40:20] DEBUG[16708] chan_mobile.c: rfcomm_read: \r
[Apr 14 21:40:20] DEBUG[16708] chan_mobile.c: rfcomm_read: \n
[Apr 14 21:40:20] DEBUG[16708] chan_mobile.c: rfcomm_read: +
[Apr 14 21:40:20] DEBUG[16708] chan_mobile.c: rfcomm_read: C
[Apr 14 21:40:20] DEBUG[16708] chan_mobile.c: rfcomm_read: I
[Apr 14 21:40:20] DEBUG[16708] chan_mobile.c: rfcomm_read: E
[Apr 14 21:40:20] DEBUG[16708] chan_mobile.c: rfcomm_read: V
[Apr 14 21:40:20] DEBUG[16708] chan_mobile.c: rfcomm_read: :
[Apr 14 21:40:20] DEBUG[16708] chan_mobile.c: rfcomm_read:  
[Apr 14 21:40:20] DEBUG[16708] chan_mobile.c: rfcomm_read: 5
[Apr 14 21:40:20] DEBUG[16708] chan_mobile.c: rfcomm_read: ,
[Apr 14 21:40:20] DEBUG[16708] chan_mobile.c: rfcomm_read: 4
[Apr 14 21:40:20] DEBUG[16708] chan_mobile.c: rfcomm_read: \r
[Apr 14 21:40:20] DEBUG[16708] chan_mobile.c: rfcomm_read: \n
[Apr 14 21:40:20] DEBUG[16708] chan_mobile.c: [gsm3] +CIEV: 5,4
[Apr 14 21:40:21] DEBUG[16708] chan_mobile.c: rfcomm_read: \r
[Apr 14 21:40:21] DEBUG[16708] chan_mobile.c: rfcomm_read: \n
[Apr 14 21:40:21] DEBUG[16708] chan_mobile.c: rfcomm_read: +
[Apr 14 21:40:21] DEBUG[16708] chan_mobile.c: rfcomm_read: C
[Apr 14 21:40:21] DEBUG[16708] chan_mobile.c: rfcomm_read: I
[Apr 14 21:40:21] DEBUG[16708] chan_mobile.c: rfcomm_read: E
[Apr 14 21:40:21] DEBUG[16708] chan_mobile.c: rfcomm_read: V
[Apr 14 21:40:21] DEBUG[16708] chan_mobile.c: rfcomm_read: :
[Apr 14 21:40:21] DEBUG[16708] chan_mobile.c: rfcomm_read:  
[Apr 14 21:40:21] DEBUG[16708] chan_mobile.c: rfcomm_read: 5
[Apr 14 21:40:21] DEBUG[16708] chan_mobile.c: rfcomm_read: ,
[Apr 14 21:40:21] DEBUG[16708] chan_mobile.c: rfcomm_read: 5
[Apr 14 21:40:21] DEBUG[16708] chan_mobile.c: rfcomm_read: \r
[Apr 14 21:40:21] DEBUG[16708] chan_mobile.c: rfcomm_read: \n
[Apr 14 21:40:21] DEBUG[16708] chan_mobile.c: [gsm3] +CIEV: 5,5
[Apr 14 21:40:21] DEBUG[16708] chan_mobile.c: rfcomm_read: \r
[Apr 14 21:40:21] DEBUG[16708] chan_mobile.c: rfcomm_read: \n
[Apr 14 21:40:21] DEBUG[16708] chan_mobile.c: rfcomm_read: R
[Apr 14 21:40:21] DEBUG[16708] chan_mobile.c: rfcomm_read: I
[Apr 14 21:40:21] DEBUG[16708] chan_mobile.c: rfcomm_read: N
[Apr 14 21:40:21] DEBUG[16708] chan_mobile.c: rfcomm_read: G
[Apr 14 21:40:21] DEBUG[16708] chan_mobile.c: rfcomm_read: \r
[Apr 14 21:40:21] DEBUG[16708] chan_mobile.c: rfcomm_read: \n
[Apr 14 21:40:21] DEBUG[16708] chan_mobile.c: [gsm3] RING
[Apr 14 21:40:21] DEBUG[16708] chan_mobile.c: [gsm3] got ring while waiting for caller id
[Apr 14 21:40:21] DEBUG[16708] chan_mobile.c: rfcomm_read: \r
[Apr 14 21:40:21] DEBUG[16708] chan_mobile.c: rfcomm_read: \n
[Apr 14 21:40:21] DEBUG[16708] chan_mobile.c: rfcomm_read: +
[Apr 14 21:40:21] DEBUG[16708] chan_mobile.c: rfcomm_read: C
[Apr 14 21:40:21] DEBUG[16708] chan_mobile.c: rfcomm_read: L
[Apr 14 21:40:21] DEBUG[16708] chan_mobile.c: rfcomm_read: I
[Apr 14 21:40:21] DEBUG[16708] chan_mobile.c: rfcomm_read: P
[Apr 14 21:40:21] DEBUG[16708] chan_mobile.c: rfcomm_read: :
[Apr 14 21:40:21] DEBUG[16708] chan_mobile.c: rfcomm_read:  
[Apr 14 21:40:21] DEBUG[16708] chan_mobile.c: rfcomm_read: "
[Apr 14 21:40:21] DEBUG[16708] chan_mobile.c: rfcomm_read: +
[Apr 14 21:40:21] DEBUG[16708] chan_mobile.c: rfcomm_read: 3
[Apr 14 21:40:21] DEBUG[16708] chan_mobile.c: rfcomm_read: 1
[Apr 14 21:40:21] DEBUG[16708] chan_mobile.c: rfcomm_read: 6
[Apr 14 21:40:21] DEBUG[16708] chan_mobile.c: rfcomm_read: 2
[Apr 14 21:40:21] DEBUG[16708] chan_mobile.c: rfcomm_read: 1
[Apr 14 21:40:21] DEBUG[16708] chan_mobile.c: rfcomm_read: 6
[Apr 14 21:40:21] DEBUG[16708] chan_mobile.c: rfcomm_read: 5
[Apr 14 21:40:21] DEBUG[16708] chan_mobile.c: rfcomm_read: 8
[Apr 14 21:40:21] DEBUG[16708] chan_mobile.c: rfcomm_read: 5
[Apr 14 21:40:21] DEBUG[16708] chan_mobile.c: rfcomm_read: 4
[Apr 14 21:40:21] DEBUG[16708] chan_mobile.c: rfcomm_read: 3
[Apr 14 21:40:21] DEBUG[16708] chan_mobile.c: rfcomm_read: "
[Apr 14 21:40:21] DEBUG[16708] chan_mobile.c: rfcomm_read: ,
[Apr 14 21:40:21] DEBUG[16708] chan_mobile.c: rfcomm_read: 1
[Apr 14 21:40:21] DEBUG[16708] chan_mobile.c: rfcomm_read: 4
[Apr 14 21:40:21] DEBUG[16708] chan_mobile.c: rfcomm_read: 5
[Apr 14 21:40:21] DEBUG[16708] chan_mobile.c: rfcomm_read: \r
[Apr 14 21:40:21] DEBUG[16708] chan_mobile.c: rfcomm_read: \n
[Apr 14 21:40:21] DEBUG[16708] chan_mobile.c: [gsm3] +CLIP: "+31621658543",145
[Apr 14 21:40:21] DEBUG[16748] chan_mobile.c: rfcomm_write() (25) [ATA]
[Apr 14 21:40:21] DEBUG[16675] chan_mobile.c: Checking device state for device gsm3
[Apr 14 21:40:21] DEBUG[16688] chan_mobile.c: Incoming Audio Connection from device 00:15:A8:9F:94:15 MTU is 64
[Apr 14 21:40:22] DEBUG[16708] chan_mobile.c: rfcomm_read: \r
[Apr 14 21:40:22] DEBUG[16708] chan_mobile.c: rfcomm_read: \n
[Apr 14 21:40:22] DEBUG[16708] chan_mobile.c: rfcomm_read: +
[Apr 14 21:40:22] DEBUG[16708] chan_mobile.c: rfcomm_read: C
[Apr 14 21:40:22] DEBUG[16708] chan_mobile.c: rfcomm_read: I
[Apr 14 21:40:22] DEBUG[16708] chan_mobile.c: rfcomm_read: E
[Apr 14 21:40:22] DEBUG[16708] chan_mobile.c: rfcomm_read: V
[Apr 14 21:40:22] DEBUG[16708] chan_mobile.c: rfcomm_read: :
[Apr 14 21:40:22] DEBUG[16708] chan_mobile.c: rfcomm_read:  
[Apr 14 21:40:22] DEBUG[16708] chan_mobile.c: rfcomm_read: 5
[Apr 14 21:40:22] DEBUG[16708] chan_mobile.c: rfcomm_read: ,
[Apr 14 21:40:22] DEBUG[16708] chan_mobile.c: rfcomm_read: 4
[Apr 14 21:40:22] DEBUG[16708] chan_mobile.c: rfcomm_read: \r
[Apr 14 21:40:22] DEBUG[16708] chan_mobile.c: rfcomm_read: \n
[Apr 14 21:40:22] DEBUG[16708] chan_mobile.c: [gsm3] +CIEV: 5,4
[Apr 14 21:40:22] DEBUG[16708] chan_mobile.c: rfcomm_read: \r
[Apr 14 21:40:22] DEBUG[16708] chan_mobile.c: rfcomm_read: \n
[Apr 14 21:40:22] DEBUG[16708] chan_mobile.c: rfcomm_read: O
[Apr 14 21:40:22] DEBUG[16708] chan_mobile.c: rfcomm_read: K
[Apr 14 21:40:22] DEBUG[16708] chan_mobile.c: rfcomm_read: \r
[Apr 14 21:40:22] DEBUG[16708] chan_mobile.c: rfcomm_read: \n
[Apr 14 21:40:22] DEBUG[16708] chan_mobile.c: [gsm3] OK
[Apr 14 21:40:22] DEBUG[16708] chan_mobile.c: [gsm3] answer sent successfully
[Apr 14 21:40:23] DEBUG[16708] chan_mobile.c: rfcomm_read: \r
[Apr 14 21:40:23] DEBUG[16708] chan_mobile.c: rfcomm_read: \n
[Apr 14 21:40:23] DEBUG[16708] chan_mobile.c: rfcomm_read: +
[Apr 14 21:40:23] DEBUG[16708] chan_mobile.c: rfcomm_read: C
[Apr 14 21:40:23] DEBUG[16708] chan_mobile.c: rfcomm_read: I
[Apr 14 21:40:23] DEBUG[16708] chan_mobile.c: rfcomm_read: E
[Apr 14 21:40:23] DEBUG[16708] chan_mobile.c: rfcomm_read: V
[Apr 14 21:40:23] DEBUG[16708] chan_mobile.c: rfcomm_read: :
[Apr 14 21:40:23] DEBUG[16708] chan_mobile.c: rfcomm_read:  
[Apr 14 21:40:23] DEBUG[16708] chan_mobile.c: rfcomm_read: 3
[Apr 14 21:40:23] DEBUG[16708] chan_mobile.c: rfcomm_read: ,
[Apr 14 21:40:23] DEBUG[16708] chan_mobile.c: rfcomm_read: 1
[Apr 14 21:40:23] DEBUG[16708] chan_mobile.c: rfcomm_read: \r
[Apr 14 21:40:23] DEBUG[16708] chan_mobile.c: rfcomm_read: \n
[Apr 14 21:40:23] DEBUG[16708] chan_mobile.c: [gsm3] +CIEV: 3,1
[Apr 14 21:40:23] DEBUG[16708] chan_mobile.c: rfcomm_read: \r
[Apr 14 21:40:23] DEBUG[16708] chan_mobile.c: rfcomm_read: \n
[Apr 14 21:40:23] DEBUG[16708] chan_mobile.c: rfcomm_read: +
[Apr 14 21:40:23] DEBUG[16708] chan_mobile.c: rfcomm_read: C
[Apr 14 21:40:23] DEBUG[16708] chan_mobile.c: rfcomm_read: I
[Apr 14 21:40:23] DEBUG[16708] chan_mobile.c: rfcomm_read: E
[Apr 14 21:40:23] DEBUG[16708] chan_mobile.c: rfcomm_read: V
[Apr 14 21:40:23] DEBUG[16708] chan_mobile.c: rfcomm_read: :
[Apr 14 21:40:23] DEBUG[16708] chan_mobile.c: rfcomm_read:  
[Apr 14 21:40:23] DEBUG[16708] chan_mobile.c: rfcomm_read: 6
[Apr 14 21:40:23] DEBUG[16708] chan_mobile.c: rfcomm_read: ,
[Apr 14 21:40:23] DEBUG[16708] chan_mobile.c: rfcomm_read: 0
[Apr 14 21:40:23] DEBUG[16708] chan_mobile.c: rfcomm_read: \r
[Apr 14 21:40:23] DEBUG[16708] chan_mobile.c: rfcomm_read: \n
[Apr 14 21:40:23] DEBUG[16708] chan_mobile.c: [gsm3] +CIEV: 6,0
[Apr 14 21:40:23] DEBUG[16708] chan_mobile.c: rfcomm_read: \r
[Apr 14 21:40:23] DEBUG[16708] chan_mobile.c: rfcomm_read: \n
[Apr 14 21:40:23] DEBUG[16708] chan_mobile.c: rfcomm_read: +
[Apr 14 21:40:23] DEBUG[16708] chan_mobile.c: rfcomm_read: C
[Apr 14 21:40:23] DEBUG[16708] chan_mobile.c: rfcomm_read: I
[Apr 14 21:40:23] DEBUG[16708] chan_mobile.c: rfcomm_read: E
[Apr 14 21:40:23] DEBUG[16708] chan_mobile.c: rfcomm_read: V
[Apr 14 21:40:23] DEBUG[16708] chan_mobile.c: rfcomm_read: :
[Apr 14 21:40:23] DEBUG[16708] chan_mobile.c: rfcomm_read:  
[Apr 14 21:40:23] DEBUG[16708] chan_mobile.c: rfcomm_read: 5
[Apr 14 21:40:23] DEBUG[16708] chan_mobile.c: rfcomm_read: ,
[Apr 14 21:40:23] DEBUG[16708] chan_mobile.c: rfcomm_read: 5
[Apr 14 21:40:23] DEBUG[16708] chan_mobile.c: rfcomm_read: \r
[Apr 14 21:40:23] DEBUG[16708] chan_mobile.c: rfcomm_read: \n
[Apr 14 21:40:23] DEBUG[16708] chan_mobile.c: [gsm3] +CIEV: 5,5
[Apr 14 21:40:32] DEBUG[16708] chan_mobile.c: rfcomm_read: \r
[Apr 14 21:40:32] DEBUG[16708] chan_mobile.c: rfcomm_read: \n
[Apr 14 21:40:32] DEBUG[16708] chan_mobile.c: rfcomm_read: +
[Apr 14 21:40:32] DEBUG[16708] chan_mobile.c: rfcomm_read: C
[Apr 14 21:40:32] DEBUG[16708] chan_mobile.c: rfcomm_read: I
[Apr 14 21:40:32] DEBUG[16708] chan_mobile.c: rfcomm_read: E
[Apr 14 21:40:32] DEBUG[16708] chan_mobile.c: rfcomm_read: V
[Apr 14 21:40:32] DEBUG[16708] chan_mobile.c: rfcomm_read: :
[Apr 14 21:40:32] DEBUG[16708] chan_mobile.c: rfcomm_read:  
[Apr 14 21:40:32] DEBUG[16708] chan_mobile.c: rfcomm_read: 3
[Apr 14 21:40:32] DEBUG[16708] chan_mobile.c: rfcomm_read: ,
[Apr 14 21:40:32] DEBUG[16708] chan_mobile.c: rfcomm_read: 0
[Apr 14 21:40:32] DEBUG[16708] chan_mobile.c: rfcomm_read: \r
[Apr 14 21:40:32] DEBUG[16708] chan_mobile.c: rfcomm_read: \n
[Apr 14 21:40:32] DEBUG[16708] chan_mobile.c: [gsm3] +CIEV: 3,0
[Apr 14 21:40:32] DEBUG[16708] chan_mobile.c: rfcomm_read: \r
[Apr 14 21:40:32] DEBUG[16708] chan_mobile.c: rfcomm_read: \n
[Apr 14 21:40:32] DEBUG[16708] chan_mobile.c: rfcomm_read: +
[Apr 14 21:40:32] DEBUG[16708] chan_mobile.c: rfcomm_read: C
[Apr 14 21:40:32] DEBUG[16708] chan_mobile.c: rfcomm_read: I
[Apr 14 21:40:32] DEBUG[16708] chan_mobile.c: rfcomm_read: E
[Apr 14 21:40:32] DEBUG[16708] chan_mobile.c: rfcomm_read: V
[Apr 14 21:40:32] DEBUG[16708] chan_mobile.c: rfcomm_read: :
[Apr 14 21:40:32] DEBUG[16708] chan_mobile.c: rfcomm_read:  
[Apr 14 21:40:32] DEBUG[16708] chan_mobile.c: rfcomm_read: 2
[Apr 14 21:40:32] DEBUG[16708] chan_mobile.c: rfcomm_read: ,
[Apr 14 21:40:32] DEBUG[16708] chan_mobile.c: rfcomm_read: 1
[Apr 14 21:40:32] DEBUG[16708] chan_mobile.c: rfcomm_read: \r
[Apr 14 21:40:32] DEBUG[16708] chan_mobile.c: rfcomm_read: \n
[Apr 14 21:40:32] DEBUG[16708] chan_mobile.c: [gsm3] +CIEV: 2,1
[Apr 14 21:40:32] DEBUG[16708] chan_mobile.c: rfcomm_read: \r
[Apr 14 21:40:32] DEBUG[16708] chan_mobile.c: rfcomm_read: \n
[Apr 14 21:40:32] DEBUG[16708] chan_mobile.c: rfcomm_read: +
[Apr 14 21:40:32] DEBUG[16708] chan_mobile.c: rfcomm_read: C
[Apr 14 21:40:32] DEBUG[16708] chan_mobile.c: rfcomm_read: I
[Apr 14 21:40:32] DEBUG[16708] chan_mobile.c: rfcomm_read: E
[Apr 14 21:40:32] DEBUG[16708] chan_mobile.c: rfcomm_read: V
[Apr 14 21:40:32] DEBUG[16708] chan_mobile.c: rfcomm_read: :
[Apr 14 21:40:32] DEBUG[16708] chan_mobile.c: rfcomm_read:  
[Apr 14 21:40:32] DEBUG[16708] chan_mobile.c: rfcomm_read: 4
[Apr 14 21:40:32] DEBUG[16708] chan_mobile.c: rfcomm_read: ,
[Apr 14 21:40:32] DEBUG[16708] chan_mobile.c: rfcomm_read: 0
[Apr 14 21:40:32] DEBUG[16708] chan_mobile.c: rfcomm_read: \r
[Apr 14 21:40:32] DEBUG[16708] chan_mobile.c: rfcomm_read: \n
[Apr 14 21:40:32] DEBUG[16708] chan_mobile.c: [gsm3] +CIEV: 4,0
[Apr 14 21:40:32] DEBUG[16708] chan_mobile.c: [gsm3] error parsing CIND: +CIEV: 4,0