Ticket #316: syslog_090115_1141.txt

File syslog_090115_1141.txt, 150.8 KB (added by gyelt, 6 years ago)

syslog

Line 
1Jan 15 11:38:32 debian-gta02 syslogd 1.5.0#5: restart.
2Jan 15 11:38:33 debian-gta02 kernel: klogd 1.5.0#5, log source = /proc/kmsg started.
3Jan 15 11:38:33 debian-gta02 kernel: Linux version 2.6.24-20081103.git7172ec57 (gismo@agricola) (gcc version 4.3.2 (Debian 4.3.2-1) ) #1 PREEMPT Wed Dec 17 18:06:43 UTC 2008
4Jan 15 11:38:33 debian-gta02 kernel: CPU: ARM920T [41129200] revision 0 (ARMv4T), cr=c0007177
5Jan 15 11:38:33 debian-gta02 kernel: Machine: GTA02
6Jan 15 11:38:33 debian-gta02 kernel: Memory policy: ECC disabled, Data cache writeback
7Jan 15 11:38:33 debian-gta02 kernel: On node 0 totalpages: 32768
8Jan 15 11:38:33 debian-gta02 kernel:   DMA zone: 256 pages used for memmap
9Jan 15 11:38:33 debian-gta02 kernel:   DMA zone: 0 pages reserved
10Jan 15 11:38:33 debian-gta02 kernel:   DMA zone: 32512 pages, LIFO batch:7
11Jan 15 11:38:33 debian-gta02 kernel:   Normal zone: 0 pages used for memmap
12Jan 15 11:38:33 debian-gta02 kernel:   Movable zone: 0 pages used for memmap
13Jan 15 11:38:33 debian-gta02 kernel: CPU S3C2442B (id 0x32440aab)
14Jan 15 11:38:33 debian-gta02 kernel: S3C244X: core 400.000 MHz, memory 100.000 MHz, peripheral 50.000 MHz
15Jan 15 11:38:33 debian-gta02 kernel: S3C24XX Clocks, (c) 2004 Simtec Electronics
16Jan 15 11:38:33 debian-gta02 kernel: CLOCK: Slow mode (1.500 MHz), fast, MPLL on, UPLL on
17Jan 15 11:38:33 debian-gta02 kernel: CPU0: D VIVT write-back cache
18Jan 15 11:38:33 debian-gta02 kernel: CPU0: I cache: 16384 bytes, associativity 64, 32 byte lines, 8 sets
19Jan 15 11:38:33 debian-gta02 kernel: CPU0: D cache: 16384 bytes, associativity 64, 32 byte lines, 8 sets
20Jan 15 11:38:33 debian-gta02 kernel: Built 1 zonelists in Zone order, mobility grouping on.  Total pages: 32512
21Jan 15 11:38:33 debian-gta02 kernel: Kernel command line: rootfstype=jffs2 root=/dev/mtdblock6 console=ttySAC2,115200 console=tty0 loglevel=8 regular_boot mtdparts=physmap-flash:-(nor);neo1973-nand:0x00040000(u-boot),0x00040000(u-boot_env),0x00800000(kernel),0x000a0000(splash),0x00040000(factory),0x0f6a0000(rootfs) rootfstype=ext2 root=/dev/mmcblk0p2 rootdelay=5
22Jan 15 11:38:33 debian-gta02 kernel: irq: clearing pending ext status 000f12f0
23Jan 15 11:38:33 debian-gta02 kernel: irq: clearing pending ext status 000902d0
24Jan 15 11:38:33 debian-gta02 kernel: irq: clearing subpending status 00000087
25Jan 15 11:38:33 debian-gta02 kernel: irq: clearing subpending status 00000082
26Jan 15 11:38:33 debian-gta02 kernel: PID hash table entries: 512 (order: 9, 2048 bytes)
27Jan 15 11:38:33 debian-gta02 kernel: pclk = 50000000
28Jan 15 11:38:33 debian-gta02 kernel: timer_usec_ticks = 7864
29Jan 15 11:38:33 debian-gta02 kernel: timer tcon=00500000, tcnt a2c1, tcfg 00000200,00000000, usec 00001eb8
30Jan 15 11:38:33 debian-gta02 kernel: Console: colour dummy device 80x30
31Jan 15 11:38:33 debian-gta02 kernel: console [tty0] enabled
32Jan 15 11:38:33 debian-gta02 kernel: console [ttySAC2] enabled
33Jan 15 11:38:33 debian-gta02 kernel: Dentry cache hash table entries: 16384 (order: 4, 65536 bytes)
34Jan 15 11:38:33 debian-gta02 kernel: Inode-cache hash table entries: 8192 (order: 3, 32768 bytes)
35Jan 15 11:38:33 debian-gta02 kernel: Memory: 128MB = 128MB total
36Jan 15 11:38:33 debian-gta02 kernel: Memory: 126080KB available (3268K code, 346K data, 128K init)
37Jan 15 11:38:33 debian-gta02 kernel: Calibrating delay loop... 199.47 BogoMIPS (lpj=498688)
38Jan 15 11:38:33 debian-gta02 kernel: Mount-cache hash table entries: 512
39Jan 15 11:38:33 debian-gta02 kernel: CPU: Testing write buffer coherency: ok
40Jan 15 11:38:33 debian-gta02 kernel: net_namespace: 64 bytes
41Jan 15 11:38:33 debian-gta02 kernel: NET: Registered protocol family 16
42Jan 15 11:38:33 debian-gta02 kernel: S3C2410 Power Management, (c) 2004 Simtec Electronics
43Jan 15 11:38:33 debian-gta02 kernel: wake enabled for irq 17
44Jan 15 11:38:33 debian-gta02 kernel: wake enabled for irq 49
45Jan 15 11:38:33 debian-gta02 kernel: S3C2442: Initialising architecture
46Jan 15 11:38:33 debian-gta02 kernel: S3C24XX DMA Driver, (c) 2003-2004,2006 Simtec Electronics
47Jan 15 11:38:33 debian-gta02 kernel: DMA channel 0 at c8800000, irq 33
48Jan 15 11:38:33 debian-gta02 kernel: DMA channel 1 at c8800040, irq 34
49Jan 15 11:38:33 debian-gta02 kernel: DMA channel 2 at c8800080, irq 35
50Jan 15 11:38:33 debian-gta02 kernel: DMA channel 3 at c88000c0, irq 36
51Jan 15 11:38:33 debian-gta02 kernel: S3C2442: Clock Support, DVS off
52Jan 15 11:38:33 debian-gta02 kernel: Linux Plug and Play Support v0.97 (c) Adam Belay
53Jan 15 11:38:34 debian-gta02 kernel: usbcore: registered new interface driver usbfs
54Jan 15 11:38:34 debian-gta02 kernel: usbcore: registered new interface driver hub
55Jan 15 11:38:34 debian-gta02 kernel: usbcore: registered new device driver usb
56Jan 15 11:38:34 debian-gta02 kernel: pnp: the driver 'system' has been registered
57Jan 15 11:38:34 debian-gta02 kernel: NET: Registered protocol family 2
58Jan 15 11:38:34 debian-gta02 kernel: IP route cache hash table entries: 1024 (order: 0, 4096 bytes)
59Jan 15 11:38:34 debian-gta02 kernel: TCP established hash table entries: 4096 (order: 3, 32768 bytes)
60Jan 15 11:38:34 debian-gta02 kernel: TCP bind hash table entries: 4096 (order: 2, 16384 bytes)
61Jan 15 11:38:34 debian-gta02 kernel: TCP: Hash tables configured (established 4096 bind 4096)
62Jan 15 11:38:34 debian-gta02 kernel: TCP reno registered
63Jan 15 11:38:34 debian-gta02 kernel: s3c24xx_pwm s3c24xx_pwm.0: s3c24xx_pwm is registered
64Jan 15 11:38:34 debian-gta02 kernel: Enabling FIQ using irq 29
65Jan 15 11:38:34 debian-gta02 kernel: not changing prescaler of PWM 3, since it's shared with timer4 (clock tick)
66Jan 15 11:38:34 debian-gta02 kernel: NetWinder Floating Point Emulator V0.97 (double precision)
67Jan 15 11:38:34 debian-gta02 kernel: neo1973-version neo1973-version.0: starting
68Jan 15 11:38:34 debian-gta02 kernel: neo1973-pm-host neo1973-pm-host.0: starting
69Jan 15 11:38:34 debian-gta02 kernel: neo1973-resume neo1973-resume.0: starting
70Jan 15 11:38:34 debian-gta02 kernel: neo1973-memconfig neo1973-memconfig.0: starting
71Jan 15 11:38:34 debian-gta02 kernel: JFFS2 version 2.2. (NAND) (SUMMARY)  © 2001-2006 Red Hat, Inc.
72Jan 15 11:38:34 debian-gta02 kernel: io scheduler noop registered
73Jan 15 11:38:34 debian-gta02 kernel: io scheduler deadline registered (default)
74Jan 15 11:38:34 debian-gta02 kernel: s3c2440-uart.0: s3c2410_serial0 at MMIO 0x50000000 (irq = 70) is a S3C2440
75Jan 15 11:38:34 debian-gta02 kernel: s3c2440-uart.1: s3c2410_serial1 at MMIO 0x50004000 (irq = 73) is a S3C2440
76Jan 15 11:38:34 debian-gta02 kernel: s3c2440-uart.2: s3c2410_serial2 at MMIO 0x50008000 (irq = 76) is a S3C2440
77Jan 15 11:38:34 debian-gta02 kernel: RAMDISK driver initialized: 16 RAM disks of 4096K size 1024 blocksize
78Jan 15 11:38:34 debian-gta02 kernel: glamo3362 glamo3362.0: Detected Glamo core 3650 Revision 0002 (49119232Hz CPU / 81887232Hz Memory)
79Jan 15 11:38:34 debian-gta02 kernel: glamo3362 glamo3362.0: Glamo core now 49119232Hz CPU / 89980928Hz Memory)
80Jan 15 11:38:34 debian-gta02 kernel: Detected S-Media IRQ# pullup, enabling interrupt
81Jan 15 11:38:34 debian-gta02 kernel: glamo-spi-gpio glamo-spi-gpio.0: registering c03618a8: jbt6k74
82Jan 15 11:38:34 debian-gta02 kernel: SMEDIA Glamo frame buffer driver (C) 2007 Openmoko, Inc.
83Jan 15 11:38:34 debian-gta02 kernel: Console: switching to colour frame buffer device 80x58
84Jan 15 11:38:34 debian-gta02 kernel: fb0: SMedia Glamo frame buffer device
85Jan 15 11:38:34 debian-gta02 kernel: glamo-mci glamo-mci.0: glamo_mci driver (C)2007 Openmoko, Inc
86Jan 15 11:38:34 debian-gta02 kernel: glamo-mci glamo-mci.0: probe: mapped mci_base:c8864400 irq:0.
87Jan 15 11:38:34 debian-gta02 kernel: glamo-mci glamo-mci.0: glamo_mci_set_ios: power down.
88Jan 15 11:38:34 debian-gta02 kernel: glamo-mci glamo-mci.0: initialisation done.
89Jan 15 11:38:34 debian-gta02 kernel: mmc_set_power(power_mode=1, vdd=20
90Jan 15 11:38:34 debian-gta02 kernel: physmap platform flash device: 00200000 at 18000000
91Jan 15 11:38:34 debian-gta02 kernel: physmap-flash.0: Found 1 x16 devices at 0x0 in 16-bit bank
92Jan 15 11:38:34 debian-gta02 kernel:  Intel/Sharp Extended Query Table at 0x0039
93Jan 15 11:38:34 debian-gta02 last message repeated 4 times
94Jan 15 11:38:34 debian-gta02 kernel: cfi_cmdset_0001: Erase suspend on write enabled
95Jan 15 11:38:34 debian-gta02 kernel: erase region 0: offset=0x0,size=0x2000,blocks=8
96Jan 15 11:38:34 debian-gta02 kernel: erase region 1: offset=0x10000,size=0x10000,blocks=31
97Jan 15 11:38:34 debian-gta02 kernel: physmap-flash.0: 1 set(s) of 1 interleaved chips --> 4 partitions of 512 KiB
98Jan 15 11:38:34 debian-gta02 kernel: RedBoot partition parsing not available
99Jan 15 11:38:34 debian-gta02 kernel: S3C24XX NAND Driver, (c) 2004 Simtec Electronics
100Jan 15 11:38:34 debian-gta02 kernel: s3c2440-nand s3c2440-nand: Tacls=0, 0ns Twrph0=3 30ns, Twrph1=2 20ns
101Jan 15 11:38:34 debian-gta02 kernel: NAND device: Manufacturer ID: 0xec, Chip ID: 0xaa (Samsung NAND 256MiB 1,8V 8-bit)
102Jan 15 11:38:34 debian-gta02 kernel: s3c2410_nand_update_chip: chip c7d13eb8: 11
103Jan 15 11:38:34 debian-gta02 kernel: Bad block table found at page 131008, version 0x01
104Jan 15 11:38:34 debian-gta02 kernel: Bad block table found at page 130944, version 0x01
105Jan 15 11:38:34 debian-gta02 kernel: 6 cmdlinepart partitions found on MTD device neo1973-nand
106Jan 15 11:38:34 debian-gta02 kernel: Creating 6 MTD partitions on "neo1973-nand":
107Jan 15 11:38:34 debian-gta02 kernel: 0x00000000-0x00040000 : "u-boot"
108Jan 15 11:38:34 debian-gta02 kernel: 0x00040000-0x00080000 : "u-boot_env"
109Jan 15 11:38:34 debian-gta02 kernel: 0x00080000-0x00880000 : "kernel"
110Jan 15 11:38:34 debian-gta02 kernel: 0x00880000-0x00920000 : "splash"
111Jan 15 11:38:34 debian-gta02 kernel: 0x00920000-0x00960000 : "factory"
112Jan 15 11:38:34 debian-gta02 kernel: 0x00960000-0x10000000 : "rootfs"
113Jan 15 11:38:34 debian-gta02 kernel: usbmon: debugfs is not available
114Jan 15 11:38:34 debian-gta02 kernel: usbcore: registered new interface driver libusual
115Jan 15 11:38:34 debian-gta02 kernel: s3c2410_udc: debugfs dir creation failed -19
116Jan 15 11:38:34 debian-gta02 kernel: s3c2440-usbgadget s3c2440-usbgadget: S3C2440: increasing FIFO to 128 bytes
117Jan 15 11:38:34 debian-gta02 kernel: gta02_udc_command(2)
118Jan 15 11:38:34 debian-gta02 kernel: mice: PS/2 mouse device common for all mice
119Jan 15 11:38:34 debian-gta02 kernel: input: Neo1973 Buttons as /devices/platform/neo1973-button.0/input/input0
120Jan 15 11:38:34 debian-gta02 kernel: wake enabled for irq 48
121Jan 15 11:38:34 debian-gta02 kernel: s3c2440-ts s3c2440-ts: successfully loaded
122Jan 15 11:38:34 debian-gta02 kernel: input: s3c2410 TouchScreen as /devices/virtual/input/input1
123Jan 15 11:38:34 debian-gta02 kernel: input: lis302-1 (top) as /devices/virtual/input/input2
124Jan 15 11:38:34 debian-gta02 kernel: lis302dl lis302dl.1: Found lis302-1 (top)
125Jan 15 11:38:34 debian-gta02 kernel: input: lis302-2 (bottom) as /devices/virtual/input/input3
126Jan 15 11:38:34 debian-gta02 kernel: lis302dl lis302dl.2: Found lis302-2 (bottom)
127Jan 15 11:38:34 debian-gta02 kernel: i2c /dev entries driver
128Jan 15 11:38:34 debian-gta02 kernel: s3c2440-i2c s3c2440-i2c: slave address 0x10
129Jan 15 11:38:34 debian-gta02 kernel: s3c2440-i2c s3c2440-i2c: bus frequency set to 390 KHz
130Jan 15 11:38:34 debian-gta02 kernel: s3c2440-i2c s3c2440-i2c: i2c-0: S3C I2C adapter
131Jan 15 11:38:34 debian-gta02 kernel: input: GTA02 PMU events as /devices/platform/s3c2440-i2c/i2c-adapter/i2c-0/0-0073/input/input4
132Jan 15 11:38:34 debian-gta02 kernel: wake enabled for irq 53
133Jan 15 11:38:34 debian-gta02 kernel: pcf50633: dev (254:0)
134Jan 15 11:38:35 debian-gta02 kernel: pcf50633 0-0073: rtc core: registered pcf50633 as rtc0
135Jan 15 11:38:35 debian-gta02 kernel: pcf50633 0-0073: probe completed
136Jan 15 11:38:35 debian-gta02 kernel: neo1973-pm-bt neo1973-pm-bt.0: FIC Neo1973 Bluetooth Power Management: starting
137Jan 15 11:38:35 debian-gta02 kernel: SD power -> 3200mV
138Jan 15 11:38:35 debian-gta02 kernel: glamo-mci glamo-mci.0: powered (vdd = 20) clk: 0kHz div=255 (req: 0kHz). Bus width=0
139Jan 15 11:38:35 debian-gta02 kernel: glamo-mci glamo-mci.0: powered (vdd = 20) clk: 195kHz div=255 (req: 195kHz). Bus width=0
140Jan 15 11:38:35 debian-gta02 last message repeated 2 times
141Jan 15 11:38:35 debian-gta02 kernel: glamo-mci glamo-mci.0: Error after cmd: 0x8120
142Jan 15 11:38:35 debian-gta02 kernel: glamo-mci glamo-mci.0: Error after cmd: 0x120
143Jan 15 11:38:35 debian-gta02 kernel: glamo-mci glamo-mci.0: Error after cmd: 0x8120
144Jan 15 11:38:35 debian-gta02 kernel: glamo-mci glamo-mci.0: Error after cmd: 0x120
145Jan 15 11:38:35 debian-gta02 kernel: mmc_set_power(power_mode=2, vdd=15
146Jan 15 11:38:35 debian-gta02 kernel: SD power -> 2700mV
147Jan 15 11:38:35 debian-gta02 kernel: neo1973-pm-gps neo1973-pm-gps.0: FIC Neo1973 GPS Power Managerment:starting
148Jan 15 11:38:35 debian-gta02 kernel: APM Battery Driver
149Jan 15 11:38:35 debian-gta02 kernel: bq27000-battery bq27000-battery.0: BQ27000 Battery Driver (C) 2008 Openmoko, Inc
150Jan 15 11:38:35 debian-gta02 kernel: S3c2440 SDIO Host controller
151Jan 15 11:38:35 debian-gta02 kernel: pnp: the driver 'sdio_s3c24xx_hcd' has been registered
152Jan 15 11:38:35 debian-gta02 kernel: mapped channel 0 to 0
153Jan 15 11:38:35 debian-gta02 kernel: S3c24xx SDIO: IRQ:37 Detect IRQ:0 DMA channel:0 base@0xc9a00000 PCLK@50000 kHz
154Jan 15 11:38:35 debian-gta02 kernel: sdio_s3c24xx_hcd 00:00: driver attached
155Jan 15 11:38:35 debian-gta02 kernel: sdio_s3c24xx_hcd 00:00: SDIO device, IDs SD_0008 (active)
156Jan 15 11:38:35 debian-gta02 kernel: pnp: the driver 'sdio_wlan' has been registered
157Jan 15 11:38:35 debian-gta02 kernel: glamo-mci glamo-mci.0: powered (vdd = 15) clk: 195kHz div=255 (req: 195kHz). Bus width=0
158Jan 15 11:38:35 debian-gta02 last message repeated 2 times
159Jan 15 11:38:35 debian-gta02 kernel: Registered led device: neo1973:vibrator
160Jan 15 11:38:35 debian-gta02 kernel: Registered led device: gta02-power:orange
161Jan 15 11:38:35 debian-gta02 kernel: Registered led device: gta02-power:blue
162Jan 15 11:38:35 debian-gta02 kernel: Registered led device: gta02-aux:red
163Jan 15 11:38:35 debian-gta02 kernel: glamo-mci glamo-mci.0: powered (vdd = 15) clk: 195kHz div=255 (req: 195kHz). Bus width=0
164Jan 15 11:38:35 debian-gta02 kernel: usbcore: registered new interface driver hiddev
165Jan 15 11:38:35 debian-gta02 kernel: usbcore: registered new interface driver usbhid
166Jan 15 11:38:35 debian-gta02 kernel: drivers/hid/usbhid/hid-core.c: v2.6:USB HID core driver
167Jan 15 11:38:35 debian-gta02 kernel: glamo-mci glamo-mci.0: powered (vdd = 15) clk: 195kHz div=255 (req: 195kHz). Bus width=0
168Jan 15 11:38:35 debian-gta02 kernel: glamo-mci glamo-mci.0: powered (vdd = 15) clk: 16666kHz div=2 (req: 16666kHz). Bus width=0
169Jan 15 11:38:35 debian-gta02 kernel: glamo-mci glamo-mci.0: powered (vdd = 15) clk: 16666kHz div=2 (req: 16666kHz). Bus width=2
170Jan 15 11:38:35 debian-gta02 kernel: mmc0: new high speed SDHC card at address d65c
171Jan 15 11:38:35 debian-gta02 kernel: mmcblk0: mmc0:d65c SU04G 3979776KiB
172Jan 15 11:38:35 debian-gta02 kernel:  mmcblk0:<6>TCP cubic registered
173Jan 15 11:38:35 debian-gta02 kernel: NET: Registered protocol family 1
174Jan 15 11:38:35 debian-gta02 kernel: NET: Registered protocol family 17
175Jan 15 11:38:35 debian-gta02 kernel:  p1 p2
176Jan 15 11:38:35 debian-gta02 kernel: RPC: Registered udp transport module.
177Jan 15 11:38:35 debian-gta02 kernel: RPC: Registered tcp transport module.
178Jan 15 11:38:35 debian-gta02 kernel: pcf50633 0-0073: setting system clock to 2009-01-15 10:37:52 UTC (1232015872)
179Jan 15 11:38:35 debian-gta02 kernel: CRCFAIL 0x1a3f
180Jan 15 11:38:35 debian-gta02 kernel: Waiting 5sec before mounting root device...
181Jan 15 11:38:35 debian-gta02 kernel: CRCFAIL 0x1a3f
182Jan 15 11:38:35 debian-gta02 kernel: CRCFAIL 0x1a3f
183Jan 15 11:38:35 debian-gta02 kernel: sdio_wlan 00:01: driver attached
184Jan 15 11:38:35 debian-gta02 kernel: sdio_wlan 00:01: SDIO device, IDs SD_0001 (active)
185Jan 15 11:38:35 debian-gta02 kernel: BMI Get Target Info: Exit (ver: 0x20000059 type: 0x1)
186Jan 15 11:38:35 debian-gta02 kernel: SDIO_INT_CTRL enable IRQ
187Jan 15 11:38:35 debian-gta02 kernel: AR6000 Reg Code = 0x40000060
188Jan 15 11:38:35 debian-gta02 kernel: VFS: Mounted root (ext2 filesystem).
189Jan 15 11:38:35 debian-gta02 kernel: Freeing init memory: 128K
190Jan 15 11:38:35 debian-gta02 kernel: ether gadget: using random self ethernet address
191Jan 15 11:38:35 debian-gta02 kernel: ether gadget: using random host ethernet address
192Jan 15 11:38:35 debian-gta02 kernel: usb0: Ethernet Gadget, version: May Day 2005
193Jan 15 11:38:35 debian-gta02 kernel: usb0: using s3c2410_udc, OUT ep2-bulk IN ep1-bulk STATUS ep3-bulk
194Jan 15 11:38:35 debian-gta02 kernel: usb0: MAC 72:c1:5f:36:57:00
195Jan 15 11:38:35 debian-gta02 kernel: usb0: HOST MAC 5e:d1:03:16:0c:fe
196Jan 15 11:38:35 debian-gta02 kernel: usb0: RNDIS ready
197Jan 15 11:38:35 debian-gta02 kernel: gta02_udc_command(1)
198Jan 15 11:38:35 debian-gta02 kernel: usb0: full speed config #1: 500 mA, Ethernet Gadget, using CDC Ethernet
199Jan 15 11:38:35 debian-gta02 kernel: ASoC version 0.13.1
200Jan 15 11:38:35 debian-gta02 kernel: wm8753: WM8753 Audio Codec 0.16
201Jan 15 11:38:35 debian-gta02 kernel: asoc: WM8753 HiFi <-> s3c24xx-i2s mapping ok
202Jan 15 11:38:35 debian-gta02 kernel: asoc: WM8753 Voice <-> Bluetooth mapping ok
203Jan 15 11:38:35 debian-gta02 kernel: ohci_hcd: 2006 August 04 USB 1.1 'Open' Host Controller (OHCI) Driver
204Jan 15 11:38:35 debian-gta02 kernel: s3c2410-ohci s3c2410-ohci: S3C24XX OHCI
205Jan 15 11:38:35 debian-gta02 kernel: s3c2410-ohci s3c2410-ohci: new USB bus registered, assigned bus number 1
206Jan 15 11:38:35 debian-gta02 kernel: s3c2410-ohci s3c2410-ohci: irq 42, io mem 0x49000000
207Jan 15 11:38:35 debian-gta02 kernel: usb usb1: configuration #1 chosen from 1 choice
208Jan 15 11:38:35 debian-gta02 kernel: hub 1-0:1.0: USB hub found
209Jan 15 11:38:35 debian-gta02 kernel: hub 1-0:1.0: 2 ports detected
210Jan 15 11:38:35 debian-gta02 kernel: Bluetooth: Core ver 2.11
211Jan 15 11:38:35 debian-gta02 kernel: NET: Registered protocol family 31
212Jan 15 11:38:35 debian-gta02 kernel: Bluetooth: HCI device and connection manager initialized
213Jan 15 11:38:35 debian-gta02 kernel: Bluetooth: HCI socket layer initialized
214Jan 15 11:38:36 debian-gta02 kernel: Bluetooth: HCI USB driver ver 2.9
215Jan 15 11:38:36 debian-gta02 kernel: usbcore: registered new interface driver hci_usb
216Jan 15 11:38:37 debian-gta02 apmd[1178]: apmd 3.2.1 interfacing with apm driver 1.13 and APM BIOS 1.2
217Jan 15 11:38:38 debian-gta02 kernel: NET: Registered protocol family 10
218Jan 15 11:38:38 debian-gta02 dropbear[1194]: Running in background
219Jan 15 11:38:40 debian-gta02 fso-gpsd[1203]: WARNING: org.freedesktop.Gypsy.Server: Create: The name org.freedesktop.Gypsy was not provided by any .service files
220Jan 15 11:38:43 debian-gta02 2009.01.15 11:38:43 root     INFO     Installprefix is /usr
221Jan 15 11:38:43 debian-gta02 2009.01.15 11:38:43 root     INFO     Root dir is /etc/freesmartphone
222Jan 15 11:38:43 debian-gta02 wwwoffled[1215]: WWWOFFLE Demon Version 2.9d (with ipv6,with zlib,with gnutls) started.
223Jan 15 11:38:44 debian-gta02 2009.01.15 11:38:44 frameworkd.subsystem INFO     subsystem frameworkd took 0.10 seconds to startup
224Jan 15 11:38:44 debian-gta02 2009.01.15 11:38:44 frameworkd.controller INFO     launching subsystem odeviced
225Jan 15 11:38:44 debian-gta02 2009.01.15 11:38:44 odeviced.powercontrol INFO     NeoUsbHostPowerControl 0.0.0 initialized. Serving org.freesmartphone.Device.PowerControl at /org/freesmartphone/Device/PowerControl/UsbHost
226Jan 15 11:38:44 debian-gta02 wwwoffled[1215]: Could not import private key [Base64 unexpected header error.].
227Jan 15 11:38:45 debian-gta02 2009.01.15 11:38:45 odeviced.powercontrol INFO     NeoBluetoothPowerControl 0.0.0 initialized. Serving org.freesmartphone.Device.PowerControl at /org/freesmartphone/Device/PowerControl/Bluetooth
228Jan 15 11:38:45 debian-gta02 wwwoffled[1215]: The WWWOFFLE root CA private key file 'certificates/root/root-key.pem' cannot be loaded; delete problem file and start WWWOFFLE again to recreate it.
229Jan 15 11:38:45 debian-gta02 2009.01.15 11:38:45 odeviced.powercontrol INFO     NeoWifiPowerControl 0.0.0 initialized. Serving org.freesmartphone.Device.PowerControl at /org/freesmartphone/Device/PowerControl/WiFi
230Jan 15 11:38:45 debian-gta02 2009.01.15 11:38:45 frameworkd.subsystem INFO     skipping module odeviced.accelerometer as requested via config file.
231Jan 15 11:38:45 debian-gta02 2009.01.15 11:38:45 odeviced.idlenotifier INFO     IdleNotifier 0.9.9.3 initialized. Serving org.freesmartphone.Device.IdleNotifier at /org/freesmartphone/Device/IdleNotifier/0
232Jan 15 11:38:45 debian-gta02 2009.01.15 11:38:45 odeviced.idlenotifier INFO     skipping input node 2 due to configuration
233Jan 15 11:38:45 debian-gta02 2009.01.15 11:38:45 odeviced.idlenotifier INFO     skipping input node 3 due to configuration
234Jan 15 11:38:45 debian-gta02 2009.01.15 11:38:45 odeviced.idlenotifier INFO     opened 3 input file descriptors
235Jan 15 11:38:46 debian-gta02 2009.01.15 11:38:46 odeviced.input INFO     Input 0.9.9.4 initialized. Serving org.freesmartphone.Device.Input at /org/freesmartphone/Device/Input
236Jan 15 11:38:46 debian-gta02 2009.01.15 11:38:46 odeviced.input INFO     skipping input node 1 due to it supporting EV_ABS
237Jan 15 11:38:46 debian-gta02 2009.01.15 11:38:46 odeviced.input INFO     skipping input node 2 due to configuration
238Jan 15 11:38:46 debian-gta02 2009.01.15 11:38:46 odeviced.input INFO     skipping input node 3 due to configuration
239Jan 15 11:38:46 debian-gta02 2009.01.15 11:38:46 odeviced.input INFO     opened 2 input file descriptors
240Jan 15 11:38:46 debian-gta02 2009.01.15 11:38:46 odeviced.info INFO     Info 0.1.3 initialized. Serving org.freesmartphone.Device.Info at /org/freesmartphone/Device/Info
241Jan 15 11:38:47 debian-gta02 su[1221]: Successful su for root by root
242Jan 15 11:38:47 debian-gta02 su[1221]: + ??? root:root
243Jan 15 11:38:47 debian-gta02 su[1221]: pam_unix(su:session): session opened for user root by (uid=0)
244Jan 15 11:38:48 debian-gta02 anacron[1232]: Anacron 2.3 started on 2009-01-15
245Jan 15 11:38:48 debian-gta02 kernel: usb0: no IPv6 routers present
246Jan 15 11:38:49 debian-gta02 anacron[1232]: Normal exit (0 jobs run)
247Jan 15 11:38:49 debian-gta02 2009.01.15 11:38:49 odeviced.audio INFO     Audio 0.5.1.1 initialized. Serving org.freesmartphone.Device.Audio at /org/freesmartphone/Device/Audio
248Jan 15 11:38:49 debian-gta02 2009.01.15 11:38:49 odeviced.audio WARNING  GST can't parse modplug; Not adding mod to decoderMap
249Jan 15 11:38:50 debian-gta02 /usr/sbin/cron[1254]: (CRON) INFO (pidfile fd = 3)
250Jan 15 11:38:51 debian-gta02 /usr/sbin/cron[1255]: (CRON) STARTUP (fork ok)
251Jan 15 11:38:51 debian-gta02 /usr/sbin/cron[1255]: (CRON) INFO (Running @reboot jobs)
252Jan 15 11:38:51 debian-gta02 2009.01.15 11:38:51 odeviced.audio WARNING  GST can't parse wavparse; Not adding wav to decoderMap
253Jan 15 11:38:51 debian-gta02 2009.01.15 11:38:51 odeviced.audio WARNING  GST can't parse oggdemux ! ivorbisdec ! audioconvert; Not adding ogg to decoderMap
254Jan 15 11:38:51 debian-gta02 2009.01.15 11:38:51 odeviced.audio WARNING  GST can't parse oggdemux ! vorbisdec ! audioconvert; Not adding ogg to decoderMap
255Jan 15 11:38:51 debian-gta02 2009.01.15 11:38:51 odeviced.audio INFO      ::: using alsa scenarios in /usr/share/openmoko/scenarios, default = stereoout
256Jan 15 11:38:51 debian-gta02 2009.01.15 11:38:51 odeviced.kernel26 INFO     Display 0.9.8 initialized. Serving org.freesmartphone.Device.Display at /org/freesmartphone/Device/Display/pcf50633_bl
257Jan 15 11:38:51 debian-gta02 2009.01.15 11:38:51 odeviced.kernel26 INFO     framebuffer blanking enabled
258Jan 15 11:38:51 debian-gta02 2009.01.15 11:38:51 odeviced.kernel26 INFO     LED 0.9.8 initialized. Serving org.freesmartphone.Device.LED at /org/freesmartphone/Device/LED/neo1973_vibrator
259Jan 15 11:38:51 debian-gta02 2009.01.15 11:38:51 odeviced.kernel26 INFO     LED 0.9.8 initialized. Serving org.freesmartphone.Device.LED at /org/freesmartphone/Device/LED/gta02_power_orange
260Jan 15 11:38:51 debian-gta02 2009.01.15 11:38:51 odeviced.kernel26 INFO     LED 0.9.8 initialized. Serving org.freesmartphone.Device.LED at /org/freesmartphone/Device/LED/gta02_power_blue
261Jan 15 11:38:51 debian-gta02 2009.01.15 11:38:51 odeviced.kernel26 INFO     LED 0.9.8 initialized. Serving org.freesmartphone.Device.LED at /org/freesmartphone/Device/LED/gta02_aux_red
262Jan 15 11:38:51 debian-gta02 2009.01.15 11:38:51 odeviced.kernel26 INFO     PowerSupplyApm 0.9.8 initialized. Serving org.freesmartphone.Device.PowerSupply at /org/freesmartphone/Device/PowerSupply/apm
263Jan 15 11:38:52 debian-gta02 2009.01.15 11:38:52 odeviced.kernel26 INFO     PowerSupply 0.9.8 initialized. Serving org.freesmartphone.Device.PowerSupply at /org/freesmartphone/Device/PowerSupply/bat
264Jan 15 11:38:52 debian-gta02 2009.01.15 11:38:52 odeviced.kernel26 INFO     RealTimeClock 0.9.8 initialized. Serving org.freesmartphone.Device.RealTimeClock at /org/freesmartphone/Device/RealTimeClock/rtc0
265Jan 15 11:38:52 debian-gta02 2009.01.15 11:38:52 frameworkd.subsystem INFO     subsystem odeviced took 7.79 seconds to startup
266Jan 15 11:38:52 debian-gta02 2009.01.15 11:38:52 frameworkd.controller INFO     launching subsystem oeventsd
267Jan 15 11:38:54 debian-gta02 2009.01.15 11:38:54 oeventsd INFO     EventsManager 0.3.0 initialized. Serving org.freesmartphone.Events at /org/freesmartphone/Events
268Jan 15 11:38:59 debian-gta02 dbus-daemon: Rejected send message, 1 matched rules; type="method_call", sender=":1.1" (uid=0 pid=1200 comm="/usr/bin/python /usr/bin/frameworkd ") interface="org.freedesktop.DBus.Introspectable" member="Introspect" error name="(unset)" requested_reply=0 destination="org.freesmartphone.odeviced" (uid=0 pid=1200 comm="/usr/bin/python /usr/bin/frameworkd "))
269Jan 15 11:39:00 debian-gta02 dbus-daemon: Rejected send message, 1 matched rules; type="method_call", sender=":1.1" (uid=0 pid=1200 comm="/usr/bin/python /usr/bin/frameworkd ") interface="org.freedesktop.DBus.Introspectable" member="Introspect" error name="(unset)" requested_reply=0 destination="org.freesmartphone.odeviced" (uid=0 pid=1200 comm="/usr/bin/python /usr/bin/frameworkd "))
270Jan 15 11:39:00 debian-gta02 dbus-daemon: Rejected send message, 1 matched rules; type="method_call", sender=":1.1" (uid=0 pid=1200 comm="/usr/bin/python /usr/bin/frameworkd ") interface="org.freedesktop.DBus.Introspectable" member="Introspect" error name="(unset)" requested_reply=0 destination="org.freesmartphone.odeviced" (uid=0 pid=1200 comm="/usr/bin/python /usr/bin/frameworkd "))
271Jan 15 11:39:03 debian-gta02 2009.01.15 11:39:03 oeventsd INFO     Created new rule : on Time(12:29) if And() then Debug("A Test")
272Jan 15 11:39:03 debian-gta02 2009.01.15 11:39:03 oeventsd INFO     Created new rule : on InputTrigger if And(switch == POWER,event == released,duration == 0) then Suspend(())
273Jan 15 11:39:03 debian-gta02 2009.01.15 11:39:03 oeventsd INFO     Created new rule : on IncomingMessage if And() then MessageToneAction(play)
274Jan 15 11:39:03 debian-gta02 2009.01.15 11:39:03 oeventsd INFO     Created new rule : While CallListContains(incoming) if ~(CallListContains(active)) then [RingToneAction(), SetBrightness((90,))]
275Jan 15 11:39:03 debian-gta02 2009.01.15 11:39:03 oeventsd INFO     Created new rule : While CallStatus if Or(status == outgoing,status == active) then SetScenario(gsmhandset)
276Jan 15 11:39:03 debian-gta02 2009.01.15 11:39:03 oeventsd INFO     Created new rule : While PowerStatus if status == charging then SetLed(gta02_power_orange, light)
277Jan 15 11:39:03 debian-gta02 2009.01.15 11:39:03 oeventsd INFO     Created new rule : While PowerStatus if status == critical then SetLed(gta02_power_orange, blink)
278Jan 15 11:39:03 debian-gta02 2009.01.15 11:39:03 oeventsd INFO     Created new rule : While PowerStatus if status == full then SetLed(gta02_power_blue, light)
279Jan 15 11:39:03 debian-gta02 2009.01.15 11:39:03 oeventsd INFO     Created new rule : on PowerStatus if status == empty then CommandAction(poweroff)
280Jan 15 11:39:03 debian-gta02 2009.01.15 11:39:03 oeventsd INFO     Created new rule : on InputTrigger if And(switch == HEADSET,event == pressed) then CommandAction(amixer -d sset "Amp Spk" mute)
281Jan 15 11:39:03 debian-gta02 2009.01.15 11:39:03 oeventsd INFO     Created new rule : on InputTrigger if And(switch == HEADSET,event == released) then CommandAction(amixer -d sset "Amp Spk" unmute)
282Jan 15 11:39:03 debian-gta02 2009.01.15 11:39:03 oeventsd INFO     Created new rule : 'test-rule'
283Jan 15 11:39:03 debian-gta02 2009.01.15 11:39:03 oeventsd INFO     Created new rule : on Test(test) if And() then Debug("trigger test")
284Jan 15 11:39:03 debian-gta02 2009.01.15 11:39:03 oeventsd INFO     Created new rule : While Test(test2) if And() then RingToneAction()
285Jan 15 11:39:04 debian-gta02 2009.01.15 11:39:04 oeventsd INFO     Created new rule : on DBusTrigger(org.freesmartphone.odeviced None.State) if And() then Debug("dbus trigger test")
286Jan 15 11:39:04 debian-gta02 2009.01.15 11:39:04 oeventsd INFO     Created new rule : on IdleState if status == busy then SetBrightness((90,))
287Jan 15 11:39:04 debian-gta02 2009.01.15 11:39:04 oeventsd INFO     Created new rule : on IdleState if status == idle_dim then SetBrightness((20,))
288Jan 15 11:39:04 debian-gta02 2009.01.15 11:39:04 oeventsd INFO     Created new rule : on IdleState if status == idle_prelock then SetBrightness((0,))
289Jan 15 11:39:04 debian-gta02 2009.01.15 11:39:04 frameworkd.subsystem INFO     subsystem oeventsd took 12.06 seconds to startup
290Jan 15 11:39:04 debian-gta02 2009.01.15 11:39:04 frameworkd.controller INFO     launching subsystem otimed
291Jan 15 11:39:04 debian-gta02 2009.01.15 11:39:04 frameworkd.subsystem WARNING  Can't claim bus name 'org.freesmartphone.otimed', check configuration in /etc/dbus-1/system.d/frameworkd.conf
292Jan 15 11:39:04 debian-gta02 2009.01.15 11:39:04 otimed.alarm INFO     AlarmController initialized. Serving org.freesmartphone.Time.Alarm at /org/freesmartphone/Time/Alarm
293Jan 15 11:39:04 debian-gta02 2009.01.15 11:39:04 frameworkd.subsystem WARNING  service otimed doesn't have any busnames registered
294Jan 15 11:39:04 debian-gta02 2009.01.15 11:39:04 frameworkd.subsystem INFO     subsystem otimed took 0.28 seconds to startup
295Jan 15 11:39:04 debian-gta02 2009.01.15 11:39:04 frameworkd.controller INFO     launching subsystem ophoned
296Jan 15 11:39:04 debian-gta02 2009.01.15 11:39:04 frameworkd.subsystem INFO     subsystem ophoned took 0.27 seconds to startup
297Jan 15 11:39:04 debian-gta02 2009.01.15 11:39:04 frameworkd.controller INFO     launching subsystem ogsmd
298Jan 15 11:39:06 debian-gta02 2009.01.15 11:39:06 ogsmd.objects INFO     Device initialized. Serving org.freesmartphone.GSM.Device at /org/freesmartphone/GSM/Device
299Jan 15 11:39:06 debian-gta02 2009.01.15 11:39:06 ogsmd.objects INFO     Server initialized. Serving org.freesmartphone.GSM.Server at /org/freesmartphone/GSM/Server
300Jan 15 11:39:06 debian-gta02 dbus-daemon: Rejected send message, 1 matched rules; type="method_call", sender=":1.1" (uid=0 pid=1200 comm="/usr/bin/python /usr/bin/frameworkd ") interface="org.freedesktop.DBus.Introspectable" member="Introspect" error name="(unset)" requested_reply=0 destination=":1.1" (uid=0 pid=1200 comm="/usr/bin/python /usr/bin/frameworkd "))
301Jan 15 11:39:07 debian-gta02 2009.01.15 11:39:07 frameworkd.subsystem INFO     subsystem ogsmd took 2.14 seconds to startup
302Jan 15 11:39:07 debian-gta02 2009.01.15 11:39:07 frameworkd.controller INFO     launching subsystem opreferencesd
303Jan 15 11:39:07 debian-gta02 2009.01.15 11:39:07 opreferencesd INFO     PreferencesManager 0.2.0 initialized. Serving org.freesmartphone.Preferences at /org/freesmartphone/Preferences
304Jan 15 11:39:07 debian-gta02 2009.01.15 11:39:07 opreferencesd INFO      ::: using schema path : /etc/freesmartphone/opreferences/schema
305Jan 15 11:39:07 debian-gta02 2009.01.15 11:39:07 opreferencesd INFO      ::: using conf path : /etc/freesmartphone/opreferences/conf
306Jan 15 11:39:07 debian-gta02 2009.01.15 11:39:07 opreferencesd INFO      ::: services : ['phone', 'rules', 'profiles']
307Jan 15 11:39:07 debian-gta02 2009.01.15 11:39:07 frameworkd.subsystem INFO     subsystem opreferencesd took 0.41 seconds to startup
308Jan 15 11:39:07 debian-gta02 2009.01.15 11:39:07 frameworkd.controller INFO     skipping subsystem opimd as requested via config file.
309Jan 15 11:39:07 debian-gta02 2009.01.15 11:39:07 frameworkd.controller INFO     launching subsystem ousaged
310Jan 15 11:39:07 debian-gta02 2009.01.15 11:39:07 ousaged  INFO     GenericUsageControl initialized. Serving org.freesmartphone.Usage at /org/freesmartphone/Usage
311Jan 15 11:39:07 debian-gta02 2009.01.15 11:39:07 frameworkd.subsystem INFO     subsystem ousaged took 0.24 seconds to startup
312Jan 15 11:39:07 debian-gta02 2009.01.15 11:39:07 frameworkd.controller INFO     launching subsystem ogpsd
313Jan 15 11:39:08 debian-gta02 2009.01.15 11:39:08 ogpsd    INFO     GTA02Device initialized. Serving org.freedesktop.Gypsy at /org/freedesktop/Gypsy
314Jan 15 11:39:08 debian-gta02 2009.01.15 11:39:08 frameworkd.subsystem INFO     subsystem ogpsd took 0.94 seconds to startup
315Jan 15 11:39:08 debian-gta02 2009.01.15 11:39:08 frameworkd.controller INFO     ================== objects registered ===================
316Jan 15 11:39:08 debian-gta02 2009.01.15 11:39:08 frameworkd.controller INFO     /org/freedesktop/Gypsy [org.freedesktop.Gypsy]
317Jan 15 11:39:08 debian-gta02 2009.01.15 11:39:08 frameworkd.controller INFO     /org/freesmartphone/Device/Audio [org.freesmartphone.Device.Audio]
318Jan 15 11:39:08 debian-gta02 2009.01.15 11:39:08 frameworkd.controller INFO     /org/freesmartphone/Device/Display/pcf50633_bl [org.freesmartphone.Device.Display]
319Jan 15 11:39:08 debian-gta02 2009.01.15 11:39:08 frameworkd.controller INFO     /org/freesmartphone/Device/IdleNotifier/0 [org.freesmartphone.Device.IdleNotifier]
320Jan 15 11:39:08 debian-gta02 2009.01.15 11:39:08 frameworkd.controller INFO     /org/freesmartphone/Device/Info [org.freesmartphone.Device.Info]
321Jan 15 11:39:09 debian-gta02 2009.01.15 11:39:09 frameworkd.controller INFO     /org/freesmartphone/Device/Input [org.freesmartphone.Device.Input]
322Jan 15 11:39:09 debian-gta02 2009.01.15 11:39:09 frameworkd.controller INFO     /org/freesmartphone/Device/LED/gta02_aux_red [org.freesmartphone.Device.LED]
323Jan 15 11:39:09 debian-gta02 2009.01.15 11:39:09 frameworkd.controller INFO     /org/freesmartphone/Device/LED/gta02_power_blue [org.freesmartphone.Device.LED]
324Jan 15 11:39:09 debian-gta02 2009.01.15 11:39:09 frameworkd.controller INFO     /org/freesmartphone/Device/LED/gta02_power_orange [org.freesmartphone.Device.LED]
325Jan 15 11:39:09 debian-gta02 2009.01.15 11:39:09 frameworkd.controller INFO     /org/freesmartphone/Device/LED/neo1973_vibrator [org.freesmartphone.Device.LED]
326Jan 15 11:39:09 debian-gta02 2009.01.15 11:39:09 frameworkd.controller INFO     /org/freesmartphone/Device/PowerControl/Bluetooth [org.freesmartphone.Device.PowerControl]
327Jan 15 11:39:09 debian-gta02 2009.01.15 11:39:09 frameworkd.controller INFO     /org/freesmartphone/Device/PowerControl/UsbHost [org.freesmartphone.Device.PowerControl]
328Jan 15 11:39:09 debian-gta02 2009.01.15 11:39:09 frameworkd.controller INFO     /org/freesmartphone/Device/PowerControl/WiFi [org.freesmartphone.Device.PowerControl]
329Jan 15 11:39:09 debian-gta02 2009.01.15 11:39:09 frameworkd.controller INFO     /org/freesmartphone/Device/PowerSupply/apm [org.freesmartphone.Device.PowerSupply]
330Jan 15 11:39:09 debian-gta02 2009.01.15 11:39:09 frameworkd.controller INFO     /org/freesmartphone/Device/PowerSupply/bat [org.freesmartphone.Device.PowerSupply]
331Jan 15 11:39:09 debian-gta02 2009.01.15 11:39:09 frameworkd.controller INFO     /org/freesmartphone/Device/RealTimeClock/rtc0 [org.freesmartphone.Device.RealTimeClock]
332Jan 15 11:39:09 debian-gta02 2009.01.15 11:39:09 frameworkd.controller INFO     /org/freesmartphone/Events [org.freesmartphone.Events]
333Jan 15 11:39:09 debian-gta02 2009.01.15 11:39:09 frameworkd.controller INFO     /org/freesmartphone/Framework [org.freesmartphone.Framework]
334Jan 15 11:39:09 debian-gta02 2009.01.15 11:39:09 frameworkd.controller INFO     /org/freesmartphone/GSM/Device [org.freesmartphone.GSM.Device]
335Jan 15 11:39:09 debian-gta02 2009.01.15 11:39:09 frameworkd.controller INFO     /org/freesmartphone/GSM/Server [org.freesmartphone.GSM.Server]
336Jan 15 11:39:09 debian-gta02 2009.01.15 11:39:09 frameworkd.controller INFO     /org/freesmartphone/Phone [org.freesmartphone.Phone]
337Jan 15 11:39:09 debian-gta02 2009.01.15 11:39:09 frameworkd.controller INFO     /org/freesmartphone/Preferences [org.freesmartphone.Preferences]
338Jan 15 11:39:09 debian-gta02 2009.01.15 11:39:09 frameworkd.controller INFO     /org/freesmartphone/Time [org.freesmartphone.Time]
339Jan 15 11:39:09 debian-gta02 2009.01.15 11:39:09 frameworkd.controller INFO     /org/freesmartphone/Time/Alarm [org.freesmartphone.Time.Alarm]
340Jan 15 11:39:09 debian-gta02 2009.01.15 11:39:09 frameworkd.controller INFO     /org/freesmartphone/Usage [org.freesmartphone.Usage]
341Jan 15 11:39:09 debian-gta02 2009.01.15 11:39:09 odeviced.idlenotifier INFO     odeviced.idlenotifier state change to idle
342Jan 15 11:39:09 debian-gta02 2009.01.15 11:39:09 dbus.proxies ERROR    Introspect error on org.freesmartphone.odeviced:/org/freesmartphone/Device/LED/gta02_power_orange: dbus.exceptions.DBusException: org.freedesktop.DBus.Error.AccessDenied: Rejected send message, 1 matched rules; type="method_call", sender=":1.1" (uid=0 pid=1200 comm="/usr/bin/python /usr/bin/frameworkd ") interface="org.freedesktop.DBus.Introspectable" member="Introspect" error name="(unset)" requested_reply=0 destination="org.freesmartphone.odeviced" (uid=0 pid=1200 comm="/usr/bin/python /usr/bin/frameworkd "))
343Jan 15 11:39:09 debian-gta02 2009.01.15 11:39:09 dbus.proxies ERROR    Introspect error on org.freesmartphone.odeviced:/org/freesmartphone/Device/LED/gta02_power_orange: dbus.exceptions.DBusException: org.freedesktop.DBus.Error.AccessDenied: Rejected send message, 1 matched rules; type="method_call", sender=":1.1" (uid=0 pid=1200 comm="/usr/bin/python /usr/bin/frameworkd ") interface="org.freedesktop.DBus.Introspectable" member="Introspect" error name="(unset)" requested_reply=0 destination="org.freesmartphone.odeviced" (uid=0 pid=1200 comm="/usr/bin/python /usr/bin/frameworkd "))
344Jan 15 11:39:09 debian-gta02 2009.01.15 11:39:09 dbus.proxies ERROR    Introspect error on org.freesmartphone.odeviced:/org/freesmartphone/Device/LED/gta02_power_blue: dbus.exceptions.DBusException: org.freedesktop.DBus.Error.AccessDenied: Rejected send message, 1 matched rules; type="method_call", sender=":1.1" (uid=0 pid=1200 comm="/usr/bin/python /usr/bin/frameworkd ") interface="org.freedesktop.DBus.Introspectable" member="Introspect" error name="(unset)" requested_reply=0 destination="org.freesmartphone.odeviced" (uid=0 pid=1200 comm="/usr/bin/python /usr/bin/frameworkd "))
345Jan 15 11:39:09 debian-gta02 2009.01.15 11:39:09 dbus.proxies ERROR    Introspect error on :1.1:/org/freesmartphone/GSM/Device: dbus.exceptions.DBusException: org.freedesktop.DBus.Error.AccessDenied: Rejected send message, 1 matched rules; type="method_call", sender=":1.1" (uid=0 pid=1200 comm="/usr/bin/python /usr/bin/frameworkd ") interface="org.freedesktop.DBus.Introspectable" member="Introspect" error name="(unset)" requested_reply=0 destination=":1.1" (uid=0 pid=1200 comm="/usr/bin/python /usr/bin/frameworkd "))
346Jan 15 11:39:09 debian-gta02 2009.01.15 11:39:09 frameworkd.controller INFO     ================== mainloop   entered ===================
347Jan 15 11:39:09 debian-gta02 2009.01.15 11:39:09 frameworkd.controller INFO     startup time was 25.86 seconds
348Jan 15 11:39:09 debian-gta02 2009.01.15 11:39:09 frameworkd.resource INFO     Trying to register resource Bluetooth
349Jan 15 11:39:09 debian-gta02 2009.01.15 11:39:09 frameworkd.resource INFO     Trying to register resource WiFi
350Jan 15 11:39:10 debian-gta02 2009.01.15 11:39:10 odeviced.audio INFO     sound scenario stereoout user
351Jan 15 11:39:10 debian-gta02 2009.01.15 11:39:10 odeviced.audio INFO     default alsa scenario restored
352Jan 15 11:39:10 debian-gta02 2009.01.15 11:39:10 oeventsd INFO     Updating the rules
353Jan 15 11:39:10 debian-gta02 2009.01.15 11:39:10 opreferencesd INFO     GetService rules
354Jan 15 11:39:10 debian-gta02 2009.01.15 11:39:10 opreferencesd INFO     no conf file : '/etc/freesmartphone/opreferences/conf/rules/default.yaml'
355Jan 15 11:39:10 debian-gta02 2009.01.15 11:39:10 opreferencesd INFO     Service rules : can't find key enabled-rules, using default
356Jan 15 11:39:11 debian-gta02 2009.01.15 11:39:11 oeventsd INFO     enable rule : on Time(12:29) if And() then Debug("A Test")
357Jan 15 11:39:11 debian-gta02 2009.01.15 11:39:11 oeventsd INFO     enable rule : on InputTrigger if And(switch == POWER,event == released,duration == 0) then Suspend(())
358Jan 15 11:39:11 debian-gta02 2009.01.15 11:39:11 oeventsd INFO     enable rule : on IncomingMessage if And() then MessageToneAction(play)
359Jan 15 11:39:11 debian-gta02 2009.01.15 11:39:11 oeventsd INFO     enable rule : While CallListContains(incoming) if ~(CallListContains(active)) then [RingToneAction(), SetBrightness((90,))]
360Jan 15 11:39:11 debian-gta02 2009.01.15 11:39:11 oeventsd INFO     enable rule : CallListContains(incoming)
361Jan 15 11:39:11 debian-gta02 2009.01.15 11:39:11 oeventsd INFO     enable rule : While CallStatus if Or(status == outgoing,status == active) then SetScenario(gsmhandset)
362Jan 15 11:39:11 debian-gta02 2009.01.15 11:39:11 oeventsd INFO     enable rule : While PowerStatus if status == charging then SetLed(gta02_power_orange, light)
363Jan 15 11:39:11 debian-gta02 2009.01.15 11:39:11 oeventsd INFO     enable rule : While PowerStatus if status == critical then SetLed(gta02_power_orange, blink)
364Jan 15 11:39:11 debian-gta02 2009.01.15 11:39:11 oeventsd INFO     enable rule : While PowerStatus if status == full then SetLed(gta02_power_blue, light)
365Jan 15 11:39:11 debian-gta02 2009.01.15 11:39:11 oeventsd INFO     enable rule : on PowerStatus if status == empty then CommandAction(poweroff)
366Jan 15 11:39:11 debian-gta02 2009.01.15 11:39:11 oeventsd INFO     enable rule : on InputTrigger if And(switch == HEADSET,event == pressed) then CommandAction(amixer -d sset "Amp Spk" mute)
367Jan 15 11:39:11 debian-gta02 2009.01.15 11:39:11 oeventsd INFO     enable rule : on InputTrigger if And(switch == HEADSET,event == released) then CommandAction(amixer -d sset "Amp Spk" unmute)
368Jan 15 11:39:11 debian-gta02 2009.01.15 11:39:11 oeventsd INFO     disable rule : 'test-rule'
369Jan 15 11:39:11 debian-gta02 2009.01.15 11:39:11 oeventsd INFO     enable rule : on Test(test) if And() then Debug("trigger test")
370Jan 15 11:39:11 debian-gta02 2009.01.15 11:39:11 oeventsd INFO     enable rule : While Test(test2) if And() then RingToneAction()
371Jan 15 11:39:11 debian-gta02 2009.01.15 11:39:11 oeventsd INFO     enable rule : on DBusTrigger(org.freesmartphone.odeviced None.State) if And() then Debug("dbus trigger test")
372Jan 15 11:39:11 debian-gta02 2009.01.15 11:39:11 oeventsd INFO     enable rule : on IdleState if status == busy then SetBrightness((90,))
373Jan 15 11:39:11 debian-gta02 2009.01.15 11:39:11 oeventsd INFO     enable rule : on IdleState if status == idle_dim then SetBrightness((20,))
374Jan 15 11:39:11 debian-gta02 2009.01.15 11:39:11 oeventsd INFO     enable rule : on IdleState if status == idle_prelock then SetBrightness((0,))
375Jan 15 11:39:11 debian-gta02 2009.01.15 11:39:11 otimed.alarm INFO     getting rtc interface
376Jan 15 11:39:11 debian-gta02 2009.01.15 11:39:11 frameworkd.resource INFO     Trying to register resource GSM
377Jan 15 11:39:11 debian-gta02 2009.01.15 11:39:11 frameworkd.resource INFO     Trying to register resource GPS
378Jan 15 11:39:12 debian-gta02 2009.01.15 11:39:12 ousaged  INFO     Register new resource Bluetooth
379Jan 15 11:39:12 debian-gta02 2009.01.15 11:39:12 ousaged  INFO     Register new resource WiFi
380Jan 15 11:39:12 debian-gta02 2009.01.15 11:39:12 ousaged  INFO     Register new resource GSM
381Jan 15 11:39:12 debian-gta02 2009.01.15 11:39:12 ousaged  INFO     Register new resource GPS
382Jan 15 11:39:20 debian-gta02 2009.01.15 11:39:20 odeviced.kernel26 INFO     power status now charging
383Jan 15 11:39:21 debian-gta02 2009.01.15 11:39:21 oeventsd INFO     Receive PowerStatus, status = charging
384Jan 15 11:39:21 debian-gta02 2009.01.15 11:39:21 oeventsd INFO     turn led gta02_power_orange on
385Jan 15 11:39:21 debian-gta02 2009.01.15 11:39:21 oeventsd INFO     Receive PowerStatus, status = charging
386Jan 15 11:39:21 debian-gta02 last message repeated 2 times
387Jan 15 11:39:28 debian-gta02 2009.01.15 11:39:28 frameworkd.resource INFO     setting resource status for GSM from disabled to enabling
388Jan 15 11:39:30 debian-gta02 2009.01.15 11:39:30 ogsmd    INFO     <CallChannel via unknown>: Creating channel with timeout = 3600 seconds
389Jan 15 11:39:30 debian-gta02 2009.01.15 11:39:30 ogsmd    INFO     <UnsolicitedResponseChannel via unknown>: Creating channel with timeout = 10 seconds
390Jan 15 11:39:30 debian-gta02 2009.01.15 11:39:30 ogsmd    INFO     <MiscChannel via unknown>: Creating channel with timeout = 10 seconds
391Jan 15 11:39:30 debian-gta02 2009.01.15 11:39:30 odeviced.idlenotifier INFO     odeviced.idlenotifier state change to idle_dim
392Jan 15 11:39:30 debian-gta02 2009.01.15 11:39:30 oeventsd INFO     DebugAction : dbus trigger test
393Jan 15 11:39:30 debian-gta02 2009.01.15 11:39:30 oeventsd INFO     Receive IdleState, status = idle_dim
394Jan 15 11:39:30 debian-gta02 2009.01.15 11:39:30 oeventsd INFO     Receive IdleState, status = idle_dim
395Jan 15 11:39:30 debian-gta02 2009.01.15 11:39:30 oeventsd INFO     call dbus signal /org/freesmartphone/Device/Display/pcf50633_bl SetBrightness((20,))
396Jan 15 11:39:31 debian-gta02 2009.01.15 11:39:31 oeventsd INFO     Receive IdleState, status = idle_dim
397Jan 15 11:39:31 debian-gta02 2009.01.15 11:39:31 ogsmd.modem.abstract DEBUG    trying to open channel MISC
398Jan 15 11:39:31 debian-gta02 gsm0710muxd: gsm0710muxd.c:1935:main(): using '/sys/bus/platform/devices/neo1973-pm-gsm.0' as basedir for pm
399Jan 15 11:39:38 debian-gta02 /usr/sbin/gsm0710muxd[1305]: gsm0710muxd.c:1617:open_serial_device(): Opened serial port
400Jan 15 11:39:38 debian-gta02 /usr/sbin/gsm0710muxd[1305]: gsm0710muxd.c:1641:open_serial_device(): Configured serial device
401Jan 15 11:39:38 debian-gta02 /usr/sbin/gsm0710muxd[1305]: gsm0710muxd.c:1763:watchdog(): Watchdog started
402Jan 15 11:39:38 debian-gta02 /usr/sbin/gsm0710muxd[1305]: gsm0710muxd.c:1652:start_muxer(): Configuring modem
403Jan 15 11:39:39 debian-gta02 /usr/sbin/gsm0710muxd[1305]: gsm0710muxd.c:1656:start_muxer(): Modem does not respond to AT commands, trying close mux mode
404Jan 15 11:39:39 debian-gta02 /usr/sbin/gsm0710muxd[1305]: gsm0710muxd.c:1696:start_muxer(): Starting mux mode
405Jan 15 11:39:39 debian-gta02 /usr/sbin/gsm0710muxd[1305]: gsm0710muxd.c:1699:start_muxer(): Waiting for mux-mode
406Jan 15 11:39:40 debian-gta02 /usr/sbin/gsm0710muxd[1305]: gsm0710muxd.c:1701:start_muxer(): Init control channel
407Jan 15 11:39:40 debian-gta02 /usr/sbin/gsm0710muxd[1305]: gsm0710muxd.c:698:c_alloc_channel(): Connecting /dev/pts/0 to virtual channel 1 for ogsmd.misc on /dev/ttySAC0
408Jan 15 11:39:40 debian-gta02 2009.01.15 11:39:40 ogsmd    INFO     <MiscChannel via unknown>: initializing
409Jan 15 11:39:40 debian-gta02 2009.01.15 11:39:40 ogsmd    DEBUG    (modem init... try #1)
410Jan 15 11:39:40 debian-gta02 /usr/sbin/gsm0710muxd[1305]: gsm0710muxd.c:1421:extract_frames(): Logical channel 1 opened
411Jan 15 11:39:40 debian-gta02 2009.01.15 11:39:40 ogsmd    DEBUG    read: AT-Command Interpreter ready
412Jan 15 11:39:40 debian-gta02 2009.01.15 11:39:40 ogsmd    INFO     <MiscChannel via /dev/pts/0>: responding OK
413Jan 15 11:39:40 debian-gta02 2009.01.15 11:39:40 ogsmd.modem.abstract DEBUG    trying to open channel UNSOL
414Jan 15 11:39:40 debian-gta02 /usr/sbin/gsm0710muxd[1305]: gsm0710muxd.c:698:c_alloc_channel(): Connecting /dev/pts/1 to virtual channel 2 for ogsmd.unsolicited on /dev/ttySAC0
415Jan 15 11:39:40 debian-gta02 /usr/sbin/gsm0710muxd[1305]: gsm0710muxd.c:1421:extract_frames(): Logical channel 2 opened
416Jan 15 11:39:40 debian-gta02 2009.01.15 11:39:40 ogsmd    INFO     <UnsolicitedResponseChannel via unknown>: initializing
417Jan 15 11:39:41 debian-gta02 2009.01.15 11:39:41 ogsmd    DEBUG    (modem init... try #1)
418Jan 15 11:39:41 debian-gta02 2009.01.15 11:39:41 ogsmd    DEBUG    read: AT-Command Interpreter ready
419Jan 15 11:39:41 debian-gta02 2009.01.15 11:39:41 ogsmd    INFO     <UnsolicitedResponseChannel via /dev/pts/1>: responding OK
420Jan 15 11:39:41 debian-gta02 2009.01.15 11:39:41 ogsmd.modem.abstract DEBUG    trying to open channel CALL
421Jan 15 11:39:41 debian-gta02 /usr/sbin/gsm0710muxd[1305]: gsm0710muxd.c:698:c_alloc_channel(): Connecting /dev/pts/2 to virtual channel 3 for ogsmd.call on /dev/ttySAC0
422Jan 15 11:39:41 debian-gta02 /usr/sbin/gsm0710muxd[1305]: gsm0710muxd.c:1421:extract_frames(): Logical channel 3 opened
423Jan 15 11:39:41 debian-gta02 2009.01.15 11:39:41 ogsmd    INFO     <CallChannel via unknown>: initializing
424Jan 15 11:39:41 debian-gta02 2009.01.15 11:39:41 ogsmd    DEBUG    (modem init... try #1)
425Jan 15 11:39:41 debian-gta02 2009.01.15 11:39:41 ogsmd    DEBUG    read: AT-Command Interpreter ready
426Jan 15 11:39:41 debian-gta02 2009.01.15 11:39:41 ogsmd    INFO     <CallChannel via /dev/pts/2>: responding OK
427Jan 15 11:39:41 debian-gta02 2009.01.15 11:39:41 frameworkd.resource INFO     setting resource status for GSM from enabling to enabled
428Jan 15 11:39:41 debian-gta02 2009.01.15 11:39:41 oeventsd INFO     signal SetBrightness responded : ()
429Jan 15 11:39:41 debian-gta02 2009.01.15 11:39:41 odeviced.idlenotifier INFO     odeviced.idlenotifier state change to busy
430Jan 15 11:39:41 debian-gta02 2009.01.15 11:39:41 ogsmd    DEBUG    <MiscChannel via /dev/pts/0> queue is: deque([('ATZ\r\n', None, None, 10), ('ATE0V1\r\n', None, None, 10), ('AT+CMEE=1\r\n', None, None, 10), ('AT+CRC=1\r\n', None, None, 10), ('AT+CSCS="UCS2"\r\n', None, None, 10), ('AT+CSDH=1\r\n', None, None, 10), ('AT+CSNS=0\r\n', None, None, 10), ('AT+CMGF=0\r\n', None, None, 10), ('AT+CLIP=0\r\n', None, None, 10), ('AT+COLP=0\r\n', None, None, 10), ('AT+CCWA=0\r\n', None, None, 10)])
431Jan 15 11:39:41 debian-gta02 2009.01.15 11:39:41 ogsmd    DEBUG    <MiscChannel via /dev/pts/0>: sending 5 bytes: 'ATZ\r\n'
432Jan 15 11:39:41 debian-gta02 2009.01.15 11:39:41 ogsmd    DEBUG    <UnsolicitedResponseChannel via /dev/pts/1> queue is: deque([('ATZ\r\n', None, None, 10), ('ATE0V1\r\n', None, None, 10), ('AT+CMEE=1\r\n', None, None, 10), ('AT+CRC=1\r\n', None, None, 10), ('AT+CSCS="UCS2"\r\n', None, None, 10), ('AT+CSDH=1\r\n', None, None, 10), ('AT+CSNS=0\r\n', None, None, 10), ('AT+CMGF=0\r\n', None, None, 10), ('AT+CLIP=0\r\n', None, None, 10), ('AT+COLP=0\r\n', None, None, 10), ('AT+CCWA=0\r\n', None, None, 10), ('AT+CLIP=1\r\n', None, None, 10), ('AT+COLP=0\r\n', None, None, 10), ('AT+CCWA=1\r\n', None, None, 10), ('AT+CSSN=1,1\r\n', None, None, 10), ('AT+CTZU=1\r\n', None, None, 10), ('AT+CTZR=1\r\n', None, None, 10), ('AT+CREG=2\r\n', None, None, 10), ('AT+CAOC=2\r\n', None, None, 10), ('AT+CGEREP=2,1\r\n', None, None, 10), ('AT+CGREG=2\r\n', None, None, 10), ('AT%CPI=3\r\n', None, None, 10), ('AT%CSCN=1,2,1,2\r\n', None, None, 10), ('AT%CSQ=1\r\n', None, None, 10), ('AT%CNIV=1\r\n', None, None, 10), ('AT%CGEREP=1\r\n', None, None, 10), (
433Jan 15 11:39:41 debian-gta02 2009.01.15 11:39:41 ogsmd    DEBUG    <UnsolicitedResponseChannel via /dev/pts/1>: sending 5 bytes: 'ATZ\r\n'
434Jan 15 11:39:41 debian-gta02 2009.01.15 11:39:41 ogsmd    DEBUG    <CallChannel via /dev/pts/2> queue is: deque([('ATZ\r\n', None, None, 3600), ('ATE0V1\r\n', None, None, 3600), ('AT+CMEE=1\r\n', None, None, 3600), ('AT+CRC=1\r\n', None, None, 3600), ('AT+CSCS="UCS2"\r\n', None, None, 3600), ('AT+CSDH=1\r\n', None, None, 3600), ('AT+CSNS=0\r\n', None, None, 3600), ('AT+CMGF=0\r\n', None, None, 3600), ('AT+CLIP=0\r\n', None, None, 3600), ('AT+COLP=0\r\n', None, None, 3600), ('AT+CCWA=0\r\n', None, None, 3600)])
435Jan 15 11:39:41 debian-gta02 2009.01.15 11:39:41 ogsmd    DEBUG    <CallChannel via /dev/pts/2>: sending 5 bytes: 'ATZ\r\n'
436Jan 15 11:39:41 debian-gta02 2009.01.15 11:39:41 ogsmd    DEBUG    <MiscChannel via /dev/pts/0>: got 6 bytes from: '\r\nOK\r\n'
437Jan 15 11:39:41 debian-gta02 2009.01.15 11:39:41 ogsmd    DEBUG    <MiscChannel via /dev/pts/0>: COMPLETED 'ATZ' => ['OK']
438Jan 15 11:39:41 debian-gta02 2009.01.15 11:39:41 ogsmd    DEBUG    <UnsolicitedResponseChannel via /dev/pts/1>: got 6 bytes from: '\r\nOK\r\n'
439Jan 15 11:39:41 debian-gta02 2009.01.15 11:39:41 ogsmd    DEBUG    <UnsolicitedResponseChannel via /dev/pts/1>: COMPLETED 'ATZ' => ['OK']
440Jan 15 11:39:41 debian-gta02 2009.01.15 11:39:41 ogsmd    DEBUG    <CallChannel via /dev/pts/2>: got 6 bytes from: '\r\nOK\r\n'
441Jan 15 11:39:41 debian-gta02 2009.01.15 11:39:41 ogsmd    DEBUG    <CallChannel via /dev/pts/2>: COMPLETED 'ATZ' => ['OK']
442Jan 15 11:39:41 debian-gta02 2009.01.15 11:39:41 ogsmd    DEBUG    <MiscChannel via /dev/pts/0> queue is: deque([('ATE0V1\r\n', None, None, 10), ('AT+CMEE=1\r\n', None, None, 10), ('AT+CRC=1\r\n', None, None, 10), ('AT+CSCS="UCS2"\r\n', None, None, 10), ('AT+CSDH=1\r\n', None, None, 10), ('AT+CSNS=0\r\n', None, None, 10), ('AT+CMGF=0\r\n', None, None, 10), ('AT+CLIP=0\r\n', None, None, 10), ('AT+COLP=0\r\n', None, None, 10), ('AT+CCWA=0\r\n', None, None, 10)])
443Jan 15 11:39:41 debian-gta02 2009.01.15 11:39:41 ogsmd    DEBUG    <MiscChannel via /dev/pts/0>: sending 8 bytes: 'ATE0V1\r\n'
444Jan 15 11:39:41 debian-gta02 2009.01.15 11:39:41 ogsmd    DEBUG    <UnsolicitedResponseChannel via /dev/pts/1> queue is: deque([('ATE0V1\r\n', None, None, 10), ('AT+CMEE=1\r\n', None, None, 10), ('AT+CRC=1\r\n', None, None, 10), ('AT+CSCS="UCS2"\r\n', None, None, 10), ('AT+CSDH=1\r\n', None, None, 10), ('AT+CSNS=0\r\n', None, None, 10), ('AT+CMGF=0\r\n', None, None, 10), ('AT+CLIP=0\r\n', None, None, 10), ('AT+COLP=0\r\n', None, None, 10), ('AT+CCWA=0\r\n', None, None, 10), ('AT+CLIP=1\r\n', None, None, 10), ('AT+COLP=0\r\n', None, None, 10), ('AT+CCWA=1\r\n', None, None, 10), ('AT+CSSN=1,1\r\n', None, None, 10), ('AT+CTZU=1\r\n', None, None, 10), ('AT+CTZR=1\r\n', None, None, 10), ('AT+CREG=2\r\n', None, None, 10), ('AT+CAOC=2\r\n', None, None, 10), ('AT+CGEREP=2,1\r\n', None, None, 10), ('AT+CGREG=2\r\n', None, None, 10), ('AT%CPI=3\r\n', None, None, 10), ('AT%CSCN=1,2,1,2\r\n', None, None, 10), ('AT%CSQ=1\r\n', None, None, 10), ('AT%CNIV=1\r\n', None, None, 10), ('AT%CGEREP=1\r\n', None, None, 10), ('AT%CGREG=3\r\n', None, None,
445Jan 15 11:39:41 debian-gta02 2009.01.15 11:39:41 ogsmd    DEBUG    <UnsolicitedResponseChannel via /dev/pts/1>: sending 8 bytes: 'ATE0V1\r\n'
446Jan 15 11:39:41 debian-gta02 2009.01.15 11:39:41 ousaged  INFO     Enabled GSM in 13.1 seconds
447Jan 15 11:39:41 debian-gta02 2009.01.15 11:39:41 ogsmd    DEBUG    <MiscChannel via /dev/pts/0>: got 6 bytes from: '\r\nOK\r\n'
448Jan 15 11:39:41 debian-gta02 2009.01.15 11:39:41 ogsmd    DEBUG    <MiscChannel via /dev/pts/0>: COMPLETED 'ATE0V1' => ['OK']
449Jan 15 11:39:41 debian-gta02 2009.01.15 11:39:41 ogsmd    DEBUG    <CallChannel via /dev/pts/2> queue is: deque([('ATE0V1\r\n', None, None, 3600), ('AT+CMEE=1\r\n', None, None, 3600), ('AT+CRC=1\r\n', None, None, 3600), ('AT+CSCS="UCS2"\r\n', None, None, 3600), ('AT+CSDH=1\r\n', None, None, 3600), ('AT+CSNS=0\r\n', None, None, 3600), ('AT+CMGF=0\r\n', None, None, 3600), ('AT+CLIP=0\r\n', None, None, 3600), ('AT+COLP=0\r\n', None, None, 3600), ('AT+CCWA=0\r\n', None, None, 3600)])
450Jan 15 11:39:41 debian-gta02 2009.01.15 11:39:41 ogsmd    DEBUG    <CallChannel via /dev/pts/2>: sending 8 bytes: 'ATE0V1\r\n'
451Jan 15 11:39:41 debian-gta02 2009.01.15 11:39:41 oeventsd INFO     DebugAction : dbus trigger test
452Jan 15 11:39:41 debian-gta02 2009.01.15 11:39:41 oeventsd INFO     Receive IdleState, status = busy
453Jan 15 11:39:41 debian-gta02 2009.01.15 11:39:41 oeventsd INFO     call dbus signal /org/freesmartphone/Device/Display/pcf50633_bl SetBrightness((90,))
454Jan 15 11:39:42 debian-gta02 2009.01.15 11:39:42 oeventsd INFO     Receive IdleState, status = busy
455Jan 15 11:39:42 debian-gta02 2009.01.15 11:39:42 oeventsd INFO     Receive IdleState, status = busy
456Jan 15 11:39:42 debian-gta02 2009.01.15 11:39:42 ogsmd    DEBUG    <UnsolicitedResponseChannel via /dev/pts/1>: got 6 bytes from: '\r\nOK\r\n'
457Jan 15 11:39:42 debian-gta02 2009.01.15 11:39:42 ogsmd    DEBUG    <UnsolicitedResponseChannel via /dev/pts/1>: COMPLETED 'ATE0V1' => ['OK']
458Jan 15 11:39:42 debian-gta02 2009.01.15 11:39:42 ogsmd    DEBUG    <MiscChannel via /dev/pts/0> queue is: deque([('AT+CMEE=1\r\n', None, None, 10), ('AT+CRC=1\r\n', None, None, 10), ('AT+CSCS="UCS2"\r\n', None, None, 10), ('AT+CSDH=1\r\n', None, None, 10), ('AT+CSNS=0\r\n', None, None, 10), ('AT+CMGF=0\r\n', None, None, 10), ('AT+CLIP=0\r\n', None, None, 10), ('AT+COLP=0\r\n', None, None, 10), ('AT+CCWA=0\r\n', None, None, 10)])
459Jan 15 11:39:42 debian-gta02 2009.01.15 11:39:42 ogsmd    DEBUG    <MiscChannel via /dev/pts/0>: sending 11 bytes: 'AT+CMEE=1\r\n'
460Jan 15 11:39:42 debian-gta02 2009.01.15 11:39:42 ogsmd    DEBUG    <CallChannel via /dev/pts/2>: got 6 bytes from: '\r\nOK\r\n'
461Jan 15 11:39:42 debian-gta02 2009.01.15 11:39:42 ogsmd    DEBUG    <CallChannel via /dev/pts/2>: COMPLETED 'ATE0V1' => ['OK']
462Jan 15 11:39:42 debian-gta02 2009.01.15 11:39:42 ogsmd    DEBUG    <UnsolicitedResponseChannel via /dev/pts/1> queue is: deque([('AT+CMEE=1\r\n', None, None, 10), ('AT+CRC=1\r\n', None, None, 10), ('AT+CSCS="UCS2"\r\n', None, None, 10), ('AT+CSDH=1\r\n', None, None, 10), ('AT+CSNS=0\r\n', None, None, 10), ('AT+CMGF=0\r\n', None, None, 10), ('AT+CLIP=0\r\n', None, None, 10), ('AT+COLP=0\r\n', None, None, 10), ('AT+CCWA=0\r\n', None, None, 10), ('AT+CLIP=1\r\n', None, None, 10), ('AT+COLP=0\r\n', None, None, 10), ('AT+CCWA=1\r\n', None, None, 10), ('AT+CSSN=1,1\r\n', None, None, 10), ('AT+CTZU=1\r\n', None, None, 10), ('AT+CTZR=1\r\n', None, None, 10), ('AT+CREG=2\r\n', None, None, 10), ('AT+CAOC=2\r\n', None, None, 10), ('AT+CGEREP=2,1\r\n', None, None, 10), ('AT+CGREG=2\r\n', None, None, 10), ('AT%CPI=3\r\n', None, None, 10), ('AT%CSCN=1,2,1,2\r\n', None, None, 10), ('AT%CSQ=1\r\n', None, None, 10), ('AT%CNIV=1\r\n', None, None, 10), ('AT%CGEREP=1\r\n', None, None, 10), ('AT%CGREG=3\r\n', None, None, 10), ('AT%CSTAT=1\r\n', None, N
463Jan 15 11:39:42 debian-gta02 2009.01.15 11:39:42 ogsmd    DEBUG    <UnsolicitedResponseChannel via /dev/pts/1>: sending 11 bytes: 'AT+CMEE=1\r\n'
464Jan 15 11:39:42 debian-gta02 2009.01.15 11:39:42 ogsmd    DEBUG    <MiscChannel via /dev/pts/0>: got 6 bytes from: '\r\nOK\r\n'
465Jan 15 11:39:42 debian-gta02 2009.01.15 11:39:42 ogsmd    DEBUG    <MiscChannel via /dev/pts/0>: COMPLETED 'AT+CMEE=1' => ['OK']
466Jan 15 11:39:42 debian-gta02 2009.01.15 11:39:42 ogsmd    DEBUG    <CallChannel via /dev/pts/2> queue is: deque([('AT+CMEE=1\r\n', None, None, 3600), ('AT+CRC=1\r\n', None, None, 3600), ('AT+CSCS="UCS2"\r\n', None, None, 3600), ('AT+CSDH=1\r\n', None, None, 3600), ('AT+CSNS=0\r\n', None, None, 3600), ('AT+CMGF=0\r\n', None, None, 3600), ('AT+CLIP=0\r\n', None, None, 3600), ('AT+COLP=0\r\n', None, None, 3600), ('AT+CCWA=0\r\n', None, None, 3600)])
467Jan 15 11:39:42 debian-gta02 2009.01.15 11:39:42 ogsmd    DEBUG    <CallChannel via /dev/pts/2>: sending 11 bytes: 'AT+CMEE=1\r\n'
468Jan 15 11:39:42 debian-gta02 2009.01.15 11:39:42 ogsmd    DEBUG    <UnsolicitedResponseChannel via /dev/pts/1>: got 6 bytes from: '\r\nOK\r\n'
469Jan 15 11:39:42 debian-gta02 2009.01.15 11:39:42 ogsmd    DEBUG    <UnsolicitedResponseChannel via /dev/pts/1>: COMPLETED 'AT+CMEE=1' => ['OK']
470Jan 15 11:39:42 debian-gta02 2009.01.15 11:39:42 ogsmd    DEBUG    <MiscChannel via /dev/pts/0> queue is: deque([('AT+CRC=1\r\n', None, None, 10), ('AT+CSCS="UCS2"\r\n', None, None, 10), ('AT+CSDH=1\r\n', None, None, 10), ('AT+CSNS=0\r\n', None, None, 10), ('AT+CMGF=0\r\n', None, None, 10), ('AT+CLIP=0\r\n', None, None, 10), ('AT+COLP=0\r\n', None, None, 10), ('AT+CCWA=0\r\n', None, None, 10), ('AT+CPIN?\r\n', <bound method DeviceSetAntennaPower.intermediateResponse of <ogsmd.modems.abstract.mediator.DeviceSetAntennaPower object at 0x6c8310>>, <bound method DeviceSetAntennaPower.errorFromChannel of <ogsmd.modems.abstract.mediator.DeviceSetAntennaPower object at 0x6c8310>>, 15)])
471Jan 15 11:39:42 debian-gta02 2009.01.15 11:39:42 ogsmd    DEBUG    <MiscChannel via /dev/pts/0>: sending 10 bytes: 'AT+CRC=1\r\n'
472Jan 15 11:39:42 debian-gta02 2009.01.15 11:39:42 ogsmd    DEBUG    <CallChannel via /dev/pts/2>: got 6 bytes from: '\r\nOK\r\n'
473Jan 15 11:39:42 debian-gta02 2009.01.15 11:39:42 ogsmd    DEBUG    <CallChannel via /dev/pts/2>: COMPLETED 'AT+CMEE=1' => ['OK']
474Jan 15 11:39:42 debian-gta02 2009.01.15 11:39:42 ogsmd    DEBUG    <UnsolicitedResponseChannel via /dev/pts/1> queue is: deque([('AT+CRC=1\r\n', None, None, 10), ('AT+CSCS="UCS2"\r\n', None, None, 10), ('AT+CSDH=1\r\n', None, None, 10), ('AT+CSNS=0\r\n', None, None, 10), ('AT+CMGF=0\r\n', None, None, 10), ('AT+CLIP=0\r\n', None, None, 10), ('AT+COLP=0\r\n', None, None, 10), ('AT+CCWA=0\r\n', None, None, 10), ('AT+CLIP=1\r\n', None, None, 10), ('AT+COLP=0\r\n', None, None, 10), ('AT+CCWA=1\r\n', None, None, 10), ('AT+CSSN=1,1\r\n', None, None, 10), ('AT+CTZU=1\r\n', None, None, 10), ('AT+CTZR=1\r\n', None, None, 10), ('AT+CREG=2\r\n', None, None, 10), ('AT+CAOC=2\r\n', None, None, 10), ('AT+CGEREP=2,1\r\n', None, None, 10), ('AT+CGREG=2\r\n', None, None, 10), ('AT%CPI=3\r\n', None, None, 10), ('AT%CSCN=1,2,1,2\r\n', None, None, 10), ('AT%CSQ=1\r\n', None, None, 10), ('AT%CNIV=1\r\n', None, None, 10), ('AT%CGEREP=1\r\n', None, None, 10), ('AT%CGREG=3\r\n', None, None, 10), ('AT%CSTAT=1\r\n', None, None, 10), ('AT@ST="-26"\r\n', None,
475Jan 15 11:39:42 debian-gta02 2009.01.15 11:39:42 ogsmd    DEBUG    <UnsolicitedResponseChannel via /dev/pts/1>: sending 10 bytes: 'AT+CRC=1\r\n'
476Jan 15 11:39:42 debian-gta02 2009.01.15 11:39:42 ogsmd    DEBUG    <MiscChannel via /dev/pts/0>: got 6 bytes from: '\r\nOK\r\n'
477Jan 15 11:39:42 debian-gta02 2009.01.15 11:39:42 ogsmd    DEBUG    <MiscChannel via /dev/pts/0>: COMPLETED 'AT+CRC=1' => ['OK']
478Jan 15 11:39:42 debian-gta02 2009.01.15 11:39:42 ogsmd    DEBUG    <CallChannel via /dev/pts/2> queue is: deque([('AT+CRC=1\r\n', None, None, 3600), ('AT+CSCS="UCS2"\r\n', None, None, 3600), ('AT+CSDH=1\r\n', None, None, 3600), ('AT+CSNS=0\r\n', None, None, 3600), ('AT+CMGF=0\r\n', None, None, 3600), ('AT+CLIP=0\r\n', None, None, 3600), ('AT+COLP=0\r\n', None, None, 3600), ('AT+CCWA=0\r\n', None, None, 3600)])
479Jan 15 11:39:42 debian-gta02 2009.01.15 11:39:42 ogsmd    DEBUG    <CallChannel via /dev/pts/2>: sending 10 bytes: 'AT+CRC=1\r\n'
480Jan 15 11:39:42 debian-gta02 2009.01.15 11:39:42 ogsmd    DEBUG    <UnsolicitedResponseChannel via /dev/pts/1>: got 6 bytes from: '\r\nOK\r\n'
481Jan 15 11:39:42 debian-gta02 2009.01.15 11:39:42 ogsmd    DEBUG    <UnsolicitedResponseChannel via /dev/pts/1>: COMPLETED 'AT+CRC=1' => ['OK']
482Jan 15 11:39:42 debian-gta02 2009.01.15 11:39:42 ogsmd    DEBUG    <MiscChannel via /dev/pts/0> queue is: deque([('AT+CSCS="UCS2"\r\n', None, None, 10), ('AT+CSDH=1\r\n', None, None, 10), ('AT+CSNS=0\r\n', None, None, 10), ('AT+CMGF=0\r\n', None, None, 10), ('AT+CLIP=0\r\n', None, None, 10), ('AT+COLP=0\r\n', None, None, 10), ('AT+CCWA=0\r\n', None, None, 10), ('AT+CPIN?\r\n', <bound method DeviceSetAntennaPower.intermediateResponse of <ogsmd.modems.abstract.mediator.DeviceSetAntennaPower object at 0x6c8310>>, <bound method DeviceSetAntennaPower.errorFromChannel of <ogsmd.modems.abstract.mediator.DeviceSetAntennaPower object at 0x6c8310>>, 15)])
483Jan 15 11:39:42 debian-gta02 2009.01.15 11:39:42 ogsmd    DEBUG    <MiscChannel via /dev/pts/0>: sending 16 bytes: 'AT+CSCS="UCS2"\r\n'
484Jan 15 11:39:42 debian-gta02 2009.01.15 11:39:42 ogsmd    DEBUG    <CallChannel via /dev/pts/2>: got 6 bytes from: '\r\nOK\r\n'
485Jan 15 11:39:42 debian-gta02 2009.01.15 11:39:42 ogsmd    DEBUG    <CallChannel via /dev/pts/2>: COMPLETED 'AT+CRC=1' => ['OK']
486Jan 15 11:39:42 debian-gta02 2009.01.15 11:39:42 ogsmd    DEBUG    <UnsolicitedResponseChannel via /dev/pts/1> queue is: deque([('AT+CSCS="UCS2"\r\n', None, None, 10), ('AT+CSDH=1\r\n', None, None, 10), ('AT+CSNS=0\r\n', None, None, 10), ('AT+CMGF=0\r\n', None, None, 10), ('AT+CLIP=0\r\n', None, None, 10), ('AT+COLP=0\r\n', None, None, 10), ('AT+CCWA=0\r\n', None, None, 10), ('AT+CLIP=1\r\n', None, None, 10), ('AT+COLP=0\r\n', None, None, 10), ('AT+CCWA=1\r\n', None, None, 10), ('AT+CSSN=1,1\r\n', None, None, 10), ('AT+CTZU=1\r\n', None, None, 10), ('AT+CTZR=1\r\n', None, None, 10), ('AT+CREG=2\r\n', None, None, 10), ('AT+CAOC=2\r\n', None, None, 10), ('AT+CGEREP=2,1\r\n', None, None, 10), ('AT+CGREG=2\r\n', None, None, 10), ('AT%CPI=3\r\n', None, None, 10), ('AT%CSCN=1,2,1,2\r\n', None, None, 10), ('AT%CSQ=1\r\n', None, None, 10), ('AT%CNIV=1\r\n', None, None, 10), ('AT%CGEREP=1\r\n', None, None, 10), ('AT%CGREG=3\r\n', None, None, 10), ('AT%CSTAT=1\r\n', None, None, 10), ('AT@ST="-26"\r\n', None, None, 10), ('AT%N028B\r\n', None,
487Jan 15 11:39:42 debian-gta02 2009.01.15 11:39:42 ogsmd    DEBUG    <UnsolicitedResponseChannel via /dev/pts/1>: sending 16 bytes: 'AT+CSCS="UCS2"\r\n'
488Jan 15 11:39:42 debian-gta02 2009.01.15 11:39:42 oeventsd INFO     signal SetBrightness responded : ()
489Jan 15 11:39:43 debian-gta02 2009.01.15 11:39:43 ogsmd    DEBUG    <MiscChannel via /dev/pts/0>: got 6 bytes from: '\r\nOK\r\n'
490Jan 15 11:39:43 debian-gta02 2009.01.15 11:39:43 ogsmd    DEBUG    <MiscChannel via /dev/pts/0>: COMPLETED 'AT+CSCS="UCS2"' => ['OK']
491Jan 15 11:39:43 debian-gta02 2009.01.15 11:39:43 ogsmd    DEBUG    <CallChannel via /dev/pts/2> queue is: deque([('AT+CSCS="UCS2"\r\n', None, None, 3600), ('AT+CSDH=1\r\n', None, None, 3600), ('AT+CSNS=0\r\n', None, None, 3600), ('AT+CMGF=0\r\n', None, None, 3600), ('AT+CLIP=0\r\n', None, None, 3600), ('AT+COLP=0\r\n', None, None, 3600), ('AT+CCWA=0\r\n', None, None, 3600)])
492Jan 15 11:39:43 debian-gta02 2009.01.15 11:39:43 ogsmd    DEBUG    <CallChannel via /dev/pts/2>: sending 16 bytes: 'AT+CSCS="UCS2"\r\n'
493Jan 15 11:39:43 debian-gta02 2009.01.15 11:39:43 ogsmd    DEBUG    <UnsolicitedResponseChannel via /dev/pts/1>: got 6 bytes from: '\r\nOK\r\n'
494Jan 15 11:39:43 debian-gta02 2009.01.15 11:39:43 ogsmd    DEBUG    <UnsolicitedResponseChannel via /dev/pts/1>: COMPLETED 'AT+CSCS="UCS2"' => ['OK']
495Jan 15 11:39:43 debian-gta02 2009.01.15 11:39:43 ogsmd    DEBUG    <MiscChannel via /dev/pts/0> queue is: deque([('AT+CSDH=1\r\n', None, None, 10), ('AT+CSNS=0\r\n', None, None, 10), ('AT+CMGF=0\r\n', None, None, 10), ('AT+CLIP=0\r\n', None, None, 10), ('AT+COLP=0\r\n', None, None, 10), ('AT+CCWA=0\r\n', None, None, 10), ('AT+CPIN?\r\n', <bound method DeviceSetAntennaPower.intermediateResponse of <ogsmd.modems.abstract.mediator.DeviceSetAntennaPower object at 0x6c8310>>, <bound method DeviceSetAntennaPower.errorFromChannel of <ogsmd.modems.abstract.mediator.DeviceSetAntennaPower object at 0x6c8310>>, 15)])
496Jan 15 11:39:43 debian-gta02 2009.01.15 11:39:43 ogsmd    DEBUG    <MiscChannel via /dev/pts/0>: sending 11 bytes: 'AT+CSDH=1\r\n'
497Jan 15 11:39:43 debian-gta02 2009.01.15 11:39:43 ogsmd    DEBUG    <CallChannel via /dev/pts/2>: got 6 bytes from: '\r\nOK\r\n'
498Jan 15 11:39:43 debian-gta02 2009.01.15 11:39:43 ogsmd    DEBUG    <CallChannel via /dev/pts/2>: COMPLETED 'AT+CSCS="UCS2"' => ['OK']
499Jan 15 11:39:43 debian-gta02 2009.01.15 11:39:43 ogsmd    DEBUG    <UnsolicitedResponseChannel via /dev/pts/1> queue is: deque([('AT+CSDH=1\r\n', None, None, 10), ('AT+CSNS=0\r\n', None, None, 10), ('AT+CMGF=0\r\n', None, None, 10), ('AT+CLIP=0\r\n', None, None, 10), ('AT+COLP=0\r\n', None, None, 10), ('AT+CCWA=0\r\n', None, None, 10), ('AT+CLIP=1\r\n', None, None, 10), ('AT+COLP=0\r\n', None, None, 10), ('AT+CCWA=1\r\n', None, None, 10), ('AT+CSSN=1,1\r\n', None, None, 10), ('AT+CTZU=1\r\n', None, None, 10), ('AT+CTZR=1\r\n', None, None, 10), ('AT+CREG=2\r\n', None, None, 10), ('AT+CAOC=2\r\n', None, None, 10), ('AT+CGEREP=2,1\r\n', None, None, 10), ('AT+CGREG=2\r\n', None, None, 10), ('AT%CPI=3\r\n', None, None, 10), ('AT%CSCN=1,2,1,2\r\n', None, None, 10), ('AT%CSQ=1\r\n', None, None, 10), ('AT%CNIV=1\r\n', None, None, 10), ('AT%CGEREP=1\r\n', None, None, 10), ('AT%CGREG=3\r\n', None, None, 10), ('AT%CSTAT=1\r\n', None, None, 10), ('AT@ST="-26"\r\n', None, None, 10), ('AT%N028B\r\n', None, None, 10), ('AT%N0125\r\n', None, None,
500Jan 15 11:39:43 debian-gta02 2009.01.15 11:39:43 ogsmd    DEBUG    <UnsolicitedResponseChannel via /dev/pts/1>: sending 11 bytes: 'AT+CSDH=1\r\n'
501Jan 15 11:39:43 debian-gta02 2009.01.15 11:39:43 ogsmd    DEBUG    <MiscChannel via /dev/pts/0>: got 6 bytes from: '\r\nOK\r\n'
502Jan 15 11:39:43 debian-gta02 2009.01.15 11:39:43 ogsmd    DEBUG    <MiscChannel via /dev/pts/0>: COMPLETED 'AT+CSDH=1' => ['OK']
503Jan 15 11:39:43 debian-gta02 2009.01.15 11:39:43 ogsmd    DEBUG    <CallChannel via /dev/pts/2> queue is: deque([('AT+CSDH=1\r\n', None, None, 3600), ('AT+CSNS=0\r\n', None, None, 3600), ('AT+CMGF=0\r\n', None, None, 3600), ('AT+CLIP=0\r\n', None, None, 3600), ('AT+COLP=0\r\n', None, None, 3600), ('AT+CCWA=0\r\n', None, None, 3600)])
504Jan 15 11:39:43 debian-gta02 2009.01.15 11:39:43 ogsmd    DEBUG    <CallChannel via /dev/pts/2>: sending 11 bytes: 'AT+CSDH=1\r\n'
505Jan 15 11:39:43 debian-gta02 2009.01.15 11:39:43 ogsmd    DEBUG    <UnsolicitedResponseChannel via /dev/pts/1>: got 6 bytes from: '\r\nOK\r\n'
506Jan 15 11:39:43 debian-gta02 2009.01.15 11:39:43 ogsmd    DEBUG    <UnsolicitedResponseChannel via /dev/pts/1>: COMPLETED 'AT+CSDH=1' => ['OK']
507Jan 15 11:39:43 debian-gta02 2009.01.15 11:39:43 ogsmd    DEBUG    <MiscChannel via /dev/pts/0> queue is: deque([('AT+CSNS=0\r\n', None, None, 10), ('AT+CMGF=0\r\n', None, None, 10), ('AT+CLIP=0\r\n', None, None, 10), ('AT+COLP=0\r\n', None, None, 10), ('AT+CCWA=0\r\n', None, None, 10), ('AT+CPIN?\r\n', <bound method DeviceSetAntennaPower.intermediateResponse of <ogsmd.modems.abstract.mediator.DeviceSetAntennaPower object at 0x6c8310>>, <bound method DeviceSetAntennaPower.errorFromChannel of <ogsmd.modems.abstract.mediator.DeviceSetAntennaPower object at 0x6c8310>>, 15)])
508Jan 15 11:39:43 debian-gta02 2009.01.15 11:39:43 ogsmd    DEBUG    <MiscChannel via /dev/pts/0>: sending 11 bytes: 'AT+CSNS=0\r\n'
509Jan 15 11:39:43 debian-gta02 2009.01.15 11:39:43 ogsmd    DEBUG    <CallChannel via /dev/pts/2>: got 6 bytes from: '\r\nOK\r\n'
510Jan 15 11:39:43 debian-gta02 2009.01.15 11:39:43 ogsmd    DEBUG    <CallChannel via /dev/pts/2>: COMPLETED 'AT+CSDH=1' => ['OK']
511Jan 15 11:39:43 debian-gta02 2009.01.15 11:39:43 ogsmd    DEBUG    <UnsolicitedResponseChannel via /dev/pts/1> queue is: deque([('AT+CSNS=0\r\n', None, None, 10), ('AT+CMGF=0\r\n', None, None, 10), ('AT+CLIP=0\r\n', None, None, 10), ('AT+COLP=0\r\n', None, None, 10), ('AT+CCWA=0\r\n', None, None, 10), ('AT+CLIP=1\r\n', None, None, 10), ('AT+COLP=0\r\n', None, None, 10), ('AT+CCWA=1\r\n', None, None, 10), ('AT+CSSN=1,1\r\n', None, None, 10), ('AT+CTZU=1\r\n', None, None, 10), ('AT+CTZR=1\r\n', None, None, 10), ('AT+CREG=2\r\n', None, None, 10), ('AT+CAOC=2\r\n', None, None, 10), ('AT+CGEREP=2,1\r\n', None, None, 10), ('AT+CGREG=2\r\n', None, None, 10), ('AT%CPI=3\r\n', None, None, 10), ('AT%CSCN=1,2,1,2\r\n', None, None, 10), ('AT%CSQ=1\r\n', None, None, 10), ('AT%CNIV=1\r\n', None, None, 10), ('AT%CGEREP=1\r\n', None, None, 10), ('AT%CGREG=3\r\n', None, None, 10), ('AT%CSTAT=1\r\n', None, None, 10), ('AT@ST="-26"\r\n', None, None, 10), ('AT%N028B\r\n', None, None, 10), ('AT%N0125\r\n', None, None, 10), ('AT%SLEEP=2\r\n', None, None
512Jan 15 11:39:43 debian-gta02 2009.01.15 11:39:43 ogsmd    DEBUG    <UnsolicitedResponseChannel via /dev/pts/1>: sending 11 bytes: 'AT+CSNS=0\r\n'
513Jan 15 11:39:43 debian-gta02 2009.01.15 11:39:43 ogsmd    DEBUG    <MiscChannel via /dev/pts/0>: got 6 bytes from: '\r\nOK\r\n'
514Jan 15 11:39:43 debian-gta02 2009.01.15 11:39:43 ogsmd    DEBUG    <MiscChannel via /dev/pts/0>: COMPLETED 'AT+CSNS=0' => ['OK']
515Jan 15 11:39:43 debian-gta02 2009.01.15 11:39:43 ogsmd    DEBUG    <CallChannel via /dev/pts/2> queue is: deque([('AT+CSNS=0\r\n', None, None, 3600), ('AT+CMGF=0\r\n', None, None, 3600), ('AT+CLIP=0\r\n', None, None, 3600), ('AT+COLP=0\r\n', None, None, 3600), ('AT+CCWA=0\r\n', None, None, 3600)])
516Jan 15 11:39:43 debian-gta02 2009.01.15 11:39:43 ogsmd    DEBUG    <CallChannel via /dev/pts/2>: sending 11 bytes: 'AT+CSNS=0\r\n'
517Jan 15 11:39:43 debian-gta02 2009.01.15 11:39:43 ogsmd    DEBUG    <UnsolicitedResponseChannel via /dev/pts/1>: got 6 bytes from: '\r\nOK\r\n'
518Jan 15 11:39:43 debian-gta02 2009.01.15 11:39:43 ogsmd    DEBUG    <UnsolicitedResponseChannel via /dev/pts/1>: COMPLETED 'AT+CSNS=0' => ['OK']
519Jan 15 11:39:43 debian-gta02 2009.01.15 11:39:43 ogsmd    DEBUG    <MiscChannel via /dev/pts/0> queue is: deque([('AT+CMGF=0\r\n', None, None, 10), ('AT+CLIP=0\r\n', None, None, 10), ('AT+COLP=0\r\n', None, None, 10), ('AT+CCWA=0\r\n', None, None, 10), ('AT+CPIN?\r\n', <bound method DeviceSetAntennaPower.intermediateResponse of <ogsmd.modems.abstract.mediator.DeviceSetAntennaPower object at 0x6c8310>>, <bound method DeviceSetAntennaPower.errorFromChannel of <ogsmd.modems.abstract.mediator.DeviceSetAntennaPower object at 0x6c8310>>, 15)])
520Jan 15 11:39:43 debian-gta02 2009.01.15 11:39:43 ogsmd    DEBUG    <MiscChannel via /dev/pts/0>: sending 11 bytes: 'AT+CMGF=0\r\n'
521Jan 15 11:39:43 debian-gta02 2009.01.15 11:39:43 ogsmd    DEBUG    <CallChannel via /dev/pts/2>: got 6 bytes from: '\r\nOK\r\n'
522Jan 15 11:39:43 debian-gta02 2009.01.15 11:39:43 ogsmd    DEBUG    <CallChannel via /dev/pts/2>: COMPLETED 'AT+CSNS=0' => ['OK']
523Jan 15 11:39:43 debian-gta02 2009.01.15 11:39:43 ogsmd    DEBUG    <UnsolicitedResponseChannel via /dev/pts/1> queue is: deque([('AT+CMGF=0\r\n', None, None, 10), ('AT+CLIP=0\r\n', None, None, 10), ('AT+COLP=0\r\n', None, None, 10), ('AT+CCWA=0\r\n', None, None, 10), ('AT+CLIP=1\r\n', None, None, 10), ('AT+COLP=0\r\n', None, None, 10), ('AT+CCWA=1\r\n', None, None, 10), ('AT+CSSN=1,1\r\n', None, None, 10), ('AT+CTZU=1\r\n', None, None, 10), ('AT+CTZR=1\r\n', None, None, 10), ('AT+CREG=2\r\n', None, None, 10), ('AT+CAOC=2\r\n', None, None, 10), ('AT+CGEREP=2,1\r\n', None, None, 10), ('AT+CGREG=2\r\n', None, None, 10), ('AT%CPI=3\r\n', None, None, 10), ('AT%CSCN=1,2,1,2\r\n', None, None, 10), ('AT%CSQ=1\r\n', None, None, 10), ('AT%CNIV=1\r\n', None, None, 10), ('AT%CGEREP=1\r\n', None, None, 10), ('AT%CGREG=3\r\n', None, None, 10), ('AT%CSTAT=1\r\n', None, None, 10), ('AT@ST="-26"\r\n', None, None, 10), ('AT%N028B\r\n', None, None, 10), ('AT%N0125\r\n', None, None, 10), ('AT%SLEEP=2\r\n', None, None, 10)])
524Jan 15 11:39:43 debian-gta02 2009.01.15 11:39:43 ogsmd    DEBUG    <UnsolicitedResponseChannel via /dev/pts/1>: sending 11 bytes: 'AT+CMGF=0\r\n'
525Jan 15 11:39:43 debian-gta02 2009.01.15 11:39:43 ogsmd    DEBUG    <MiscChannel via /dev/pts/0>: got 6 bytes from: '\r\nOK\r\n'
526Jan 15 11:39:43 debian-gta02 2009.01.15 11:39:43 ogsmd    DEBUG    <MiscChannel via /dev/pts/0>: COMPLETED 'AT+CMGF=0' => ['OK']
527Jan 15 11:39:43 debian-gta02 2009.01.15 11:39:43 ogsmd    DEBUG    <CallChannel via /dev/pts/2> queue is: deque([('AT+CMGF=0\r\n', None, None, 3600), ('AT+CLIP=0\r\n', None, None, 3600), ('AT+COLP=0\r\n', None, None, 3600), ('AT+CCWA=0\r\n', None, None, 3600)])
528Jan 15 11:39:43 debian-gta02 2009.01.15 11:39:43 ogsmd    DEBUG    <CallChannel via /dev/pts/2>: sending 11 bytes: 'AT+CMGF=0\r\n'
529Jan 15 11:39:43 debian-gta02 2009.01.15 11:39:43 ogsmd    DEBUG    <UnsolicitedResponseChannel via /dev/pts/1>: got 6 bytes from: '\r\nOK\r\n'
530Jan 15 11:39:43 debian-gta02 2009.01.15 11:39:43 ogsmd    DEBUG    <UnsolicitedResponseChannel via /dev/pts/1>: COMPLETED 'AT+CMGF=0' => ['OK']
531Jan 15 11:39:43 debian-gta02 2009.01.15 11:39:43 ogsmd    DEBUG    <MiscChannel via /dev/pts/0> queue is: deque([('AT+CLIP=0\r\n', None, None, 10), ('AT+COLP=0\r\n', None, None, 10), ('AT+CCWA=0\r\n', None, None, 10), ('AT+CPIN?\r\n', <bound method DeviceSetAntennaPower.intermediateResponse of <ogsmd.modems.abstract.mediator.DeviceSetAntennaPower object at 0x6c8310>>, <bound method DeviceSetAntennaPower.errorFromChannel of <ogsmd.modems.abstract.mediator.DeviceSetAntennaPower object at 0x6c8310>>, 15)])
532Jan 15 11:39:44 debian-gta02 2009.01.15 11:39:44 ogsmd    DEBUG    <MiscChannel via /dev/pts/0>: sending 11 bytes: 'AT+CLIP=0\r\n'
533Jan 15 11:39:44 debian-gta02 2009.01.15 11:39:44 ogsmd    DEBUG    <CallChannel via /dev/pts/2>: got 6 bytes from: '\r\nOK\r\n'
534Jan 15 11:39:44 debian-gta02 2009.01.15 11:39:44 ogsmd    DEBUG    <CallChannel via /dev/pts/2>: COMPLETED 'AT+CMGF=0' => ['OK']
535Jan 15 11:39:44 debian-gta02 2009.01.15 11:39:44 ogsmd    DEBUG    <UnsolicitedResponseChannel via /dev/pts/1> queue is: deque([('AT+CLIP=0\r\n', None, None, 10), ('AT+COLP=0\r\n', None, None, 10), ('AT+CCWA=0\r\n', None, None, 10), ('AT+CLIP=1\r\n', None, None, 10), ('AT+COLP=0\r\n', None, None, 10), ('AT+CCWA=1\r\n', None, None, 10), ('AT+CSSN=1,1\r\n', None, None, 10), ('AT+CTZU=1\r\n', None, None, 10), ('AT+CTZR=1\r\n', None, None, 10), ('AT+CREG=2\r\n', None, None, 10), ('AT+CAOC=2\r\n', None, None, 10), ('AT+CGEREP=2,1\r\n', None, None, 10), ('AT+CGREG=2\r\n', None, None, 10), ('AT%CPI=3\r\n', None, None, 10), ('AT%CSCN=1,2,1,2\r\n', None, None, 10), ('AT%CSQ=1\r\n', None, None, 10), ('AT%CNIV=1\r\n', None, None, 10), ('AT%CGEREP=1\r\n', None, None, 10), ('AT%CGREG=3\r\n', None, None, 10), ('AT%CSTAT=1\r\n', None, None, 10), ('AT@ST="-26"\r\n', None, None, 10), ('AT%N028B\r\n', None, None, 10), ('AT%N0125\r\n', None, None, 10), ('AT%SLEEP=2\r\n', None, None, 10)])
536Jan 15 11:39:44 debian-gta02 2009.01.15 11:39:44 ogsmd    DEBUG    <UnsolicitedResponseChannel via /dev/pts/1>: sending 11 bytes: 'AT+CLIP=0\r\n'
537Jan 15 11:39:44 debian-gta02 2009.01.15 11:39:44 ogsmd    DEBUG    <MiscChannel via /dev/pts/0>: got 6 bytes from: '\r\nOK\r\n'
538Jan 15 11:39:44 debian-gta02 2009.01.15 11:39:44 ogsmd    DEBUG    <MiscChannel via /dev/pts/0>: COMPLETED 'AT+CLIP=0' => ['OK']
539Jan 15 11:39:44 debian-gta02 2009.01.15 11:39:44 ogsmd    DEBUG    <CallChannel via /dev/pts/2> queue is: deque([('AT+CLIP=0\r\n', None, None, 3600), ('AT+COLP=0\r\n', None, None, 3600), ('AT+CCWA=0\r\n', None, None, 3600)])
540Jan 15 11:39:44 debian-gta02 2009.01.15 11:39:44 ogsmd    DEBUG    <CallChannel via /dev/pts/2>: sending 11 bytes: 'AT+CLIP=0\r\n'
541Jan 15 11:39:44 debian-gta02 2009.01.15 11:39:44 ogsmd    DEBUG    <UnsolicitedResponseChannel via /dev/pts/1>: got 6 bytes from: '\r\nOK\r\n'
542Jan 15 11:39:44 debian-gta02 2009.01.15 11:39:44 ogsmd    DEBUG    <UnsolicitedResponseChannel via /dev/pts/1>: COMPLETED 'AT+CLIP=0' => ['OK']
543Jan 15 11:39:44 debian-gta02 2009.01.15 11:39:44 ogsmd    DEBUG    <MiscChannel via /dev/pts/0> queue is: deque([('AT+COLP=0\r\n', None, None, 10), ('AT+CCWA=0\r\n', None, None, 10), ('AT+CPIN?\r\n', <bound method DeviceSetAntennaPower.intermediateResponse of <ogsmd.modems.abstract.mediator.DeviceSetAntennaPower object at 0x6c8310>>, <bound method DeviceSetAntennaPower.errorFromChannel of <ogsmd.modems.abstract.mediator.DeviceSetAntennaPower object at 0x6c8310>>, 15)])
544Jan 15 11:39:44 debian-gta02 2009.01.15 11:39:44 ogsmd    DEBUG    <MiscChannel via /dev/pts/0>: sending 11 bytes: 'AT+COLP=0\r\n'
545Jan 15 11:39:44 debian-gta02 2009.01.15 11:39:44 ogsmd    DEBUG    <CallChannel via /dev/pts/2>: got 6 bytes from: '\r\nOK\r\n'
546Jan 15 11:39:44 debian-gta02 2009.01.15 11:39:44 ogsmd    DEBUG    <CallChannel via /dev/pts/2>: COMPLETED 'AT+CLIP=0' => ['OK']
547Jan 15 11:39:44 debian-gta02 2009.01.15 11:39:44 ogsmd    DEBUG    <UnsolicitedResponseChannel via /dev/pts/1> queue is: deque([('AT+COLP=0\r\n', None, None, 10), ('AT+CCWA=0\r\n', None, None, 10), ('AT+CLIP=1\r\n', None, None, 10), ('AT+COLP=0\r\n', None, None, 10), ('AT+CCWA=1\r\n', None, None, 10), ('AT+CSSN=1,1\r\n', None, None, 10), ('AT+CTZU=1\r\n', None, None, 10), ('AT+CTZR=1\r\n', None, None, 10), ('AT+CREG=2\r\n', None, None, 10), ('AT+CAOC=2\r\n', None, None, 10), ('AT+CGEREP=2,1\r\n', None, None, 10), ('AT+CGREG=2\r\n', None, None, 10), ('AT%CPI=3\r\n', None, None, 10), ('AT%CSCN=1,2,1,2\r\n', None, None, 10), ('AT%CSQ=1\r\n', None, None, 10), ('AT%CNIV=1\r\n', None, None, 10), ('AT%CGEREP=1\r\n', None, None, 10), ('AT%CGREG=3\r\n', None, None, 10), ('AT%CSTAT=1\r\n', None, None, 10), ('AT@ST="-26"\r\n', None, None, 10), ('AT%N028B\r\n', None, None, 10), ('AT%N0125\r\n', None, None, 10), ('AT%SLEEP=2\r\n', None, None, 10)])
548Jan 15 11:39:44 debian-gta02 2009.01.15 11:39:44 ogsmd    DEBUG    <UnsolicitedResponseChannel via /dev/pts/1>: sending 11 bytes: 'AT+COLP=0\r\n'
549Jan 15 11:39:44 debian-gta02 2009.01.15 11:39:44 ogsmd    DEBUG    <MiscChannel via /dev/pts/0>: got 6 bytes from: '\r\nOK\r\n'
550Jan 15 11:39:44 debian-gta02 2009.01.15 11:39:44 ogsmd    DEBUG    <MiscChannel via /dev/pts/0>: COMPLETED 'AT+COLP=0' => ['OK']
551Jan 15 11:39:44 debian-gta02 2009.01.15 11:39:44 ogsmd    DEBUG    <CallChannel via /dev/pts/2> queue is: deque([('AT+COLP=0\r\n', None, None, 3600), ('AT+CCWA=0\r\n', None, None, 3600)])
552Jan 15 11:39:44 debian-gta02 2009.01.15 11:39:44 ogsmd    DEBUG    <CallChannel via /dev/pts/2>: sending 11 bytes: 'AT+COLP=0\r\n'
553Jan 15 11:39:44 debian-gta02 2009.01.15 11:39:44 ogsmd    DEBUG    <UnsolicitedResponseChannel via /dev/pts/1>: got 6 bytes from: '\r\nOK\r\n'
554Jan 15 11:39:44 debian-gta02 2009.01.15 11:39:44 ogsmd    DEBUG    <UnsolicitedResponseChannel via /dev/pts/1>: COMPLETED 'AT+COLP=0' => ['OK']
555Jan 15 11:39:44 debian-gta02 2009.01.15 11:39:44 ogsmd    DEBUG    <MiscChannel via /dev/pts/0> queue is: deque([('AT+CCWA=0\r\n', None, None, 10), ('AT+CPIN?\r\n', <bound method DeviceSetAntennaPower.intermediateResponse of <ogsmd.modems.abstract.mediator.DeviceSetAntennaPower object at 0x6c8310>>, <bound method DeviceSetAntennaPower.errorFromChannel of <ogsmd.modems.abstract.mediator.DeviceSetAntennaPower object at 0x6c8310>>, 15)])
556Jan 15 11:39:44 debian-gta02 2009.01.15 11:39:44 ogsmd    DEBUG    <MiscChannel via /dev/pts/0>: sending 11 bytes: 'AT+CCWA=0\r\n'
557Jan 15 11:39:44 debian-gta02 2009.01.15 11:39:44 ogsmd    DEBUG    <CallChannel via /dev/pts/2>: got 6 bytes from: '\r\nOK\r\n'
558Jan 15 11:39:44 debian-gta02 2009.01.15 11:39:44 ogsmd    DEBUG    <CallChannel via /dev/pts/2>: COMPLETED 'AT+COLP=0' => ['OK']
559Jan 15 11:39:44 debian-gta02 2009.01.15 11:39:44 ogsmd    DEBUG    <UnsolicitedResponseChannel via /dev/pts/1> queue is: deque([('AT+CCWA=0\r\n', None, None, 10), ('AT+CLIP=1\r\n', None, None, 10), ('AT+COLP=0\r\n', None, None, 10), ('AT+CCWA=1\r\n', None, None, 10), ('AT+CSSN=1,1\r\n', None, None, 10), ('AT+CTZU=1\r\n', None, None, 10), ('AT+CTZR=1\r\n', None, None, 10), ('AT+CREG=2\r\n', None, None, 10), ('AT+CAOC=2\r\n', None, None, 10), ('AT+CGEREP=2,1\r\n', None, None, 10), ('AT+CGREG=2\r\n', None, None, 10), ('AT%CPI=3\r\n', None, None, 10), ('AT%CSCN=1,2,1,2\r\n', None, None, 10), ('AT%CSQ=1\r\n', None, None, 10), ('AT%CNIV=1\r\n', None, None, 10), ('AT%CGEREP=1\r\n', None, None, 10), ('AT%CGREG=3\r\n', None, None, 10), ('AT%CSTAT=1\r\n', None, None, 10), ('AT@ST="-26"\r\n', None, None, 10), ('AT%N028B\r\n', None, None, 10), ('AT%N0125\r\n', None, None, 10), ('AT%SLEEP=2\r\n', None, None, 10)])
560Jan 15 11:39:44 debian-gta02 2009.01.15 11:39:44 ogsmd    DEBUG    <UnsolicitedResponseChannel via /dev/pts/1>: sending 11 bytes: 'AT+CCWA=0\r\n'
561Jan 15 11:39:44 debian-gta02 2009.01.15 11:39:44 ogsmd    DEBUG    <MiscChannel via /dev/pts/0>: got 6 bytes from: '\r\nOK\r\n'
562Jan 15 11:39:44 debian-gta02 2009.01.15 11:39:44 ogsmd    DEBUG    <MiscChannel via /dev/pts/0>: COMPLETED 'AT+CCWA=0' => ['OK']
563Jan 15 11:39:44 debian-gta02 2009.01.15 11:39:44 ogsmd    DEBUG    <CallChannel via /dev/pts/2> queue is: deque([('AT+CCWA=0\r\n', None, None, 3600)])
564Jan 15 11:39:44 debian-gta02 2009.01.15 11:39:44 ogsmd    DEBUG    <CallChannel via /dev/pts/2>: sending 11 bytes: 'AT+CCWA=0\r\n'
565Jan 15 11:39:44 debian-gta02 2009.01.15 11:39:44 ogsmd    DEBUG    <UnsolicitedResponseChannel via /dev/pts/1>: got 6 bytes from: '\r\nOK\r\n'
566Jan 15 11:39:44 debian-gta02 2009.01.15 11:39:44 ogsmd    DEBUG    <UnsolicitedResponseChannel via /dev/pts/1>: COMPLETED 'AT+CCWA=0' => ['OK']
567Jan 15 11:39:44 debian-gta02 2009.01.15 11:39:44 ogsmd    DEBUG    <MiscChannel via /dev/pts/0> queue is: deque([('AT+CPIN?\r\n', <bound method DeviceSetAntennaPower.intermediateResponse of <ogsmd.modems.abstract.mediator.DeviceSetAntennaPower object at 0x6c8310>>, <bound method DeviceSetAntennaPower.errorFromChannel of <ogsmd.modems.abstract.mediator.DeviceSetAntennaPower object at 0x6c8310>>, 15)])
568Jan 15 11:39:44 debian-gta02 2009.01.15 11:39:44 ogsmd    DEBUG    <MiscChannel via /dev/pts/0>: sending 10 bytes: 'AT+CPIN?\r\n'
569Jan 15 11:39:44 debian-gta02 2009.01.15 11:39:44 ogsmd    DEBUG    <CallChannel via /dev/pts/2>: got 6 bytes from: '\r\nOK\r\n'
570Jan 15 11:39:44 debian-gta02 2009.01.15 11:39:44 ogsmd    DEBUG    <CallChannel via /dev/pts/2>: COMPLETED 'AT+CCWA=0' => ['OK']
571Jan 15 11:39:44 debian-gta02 2009.01.15 11:39:44 ogsmd    DEBUG    <UnsolicitedResponseChannel via /dev/pts/1> queue is: deque([('AT+CLIP=1\r\n', None, None, 10), ('AT+COLP=0\r\n', None, None, 10), ('AT+CCWA=1\r\n', None, None, 10), ('AT+CSSN=1,1\r\n', None, None, 10), ('AT+CTZU=1\r\n', None, None, 10), ('AT+CTZR=1\r\n', None, None, 10), ('AT+CREG=2\r\n', None, None, 10), ('AT+CAOC=2\r\n', None, None, 10), ('AT+CGEREP=2,1\r\n', None, None, 10), ('AT+CGREG=2\r\n', None, None, 10), ('AT%CPI=3\r\n', None, None, 10), ('AT%CSCN=1,2,1,2\r\n', None, None, 10), ('AT%CSQ=1\r\n', None, None, 10), ('AT%CNIV=1\r\n', None, None, 10), ('AT%CGEREP=1\r\n', None, None, 10), ('AT%CGREG=3\r\n', None, None, 10), ('AT%CSTAT=1\r\n', None, None, 10), ('AT@ST="-26"\r\n', None, None, 10), ('AT%N028B\r\n', None, None, 10), ('AT%N0125\r\n', None, None, 10), ('AT%SLEEP=2\r\n', None, None, 10)])
572Jan 15 11:39:44 debian-gta02 2009.01.15 11:39:44 ogsmd    DEBUG    <UnsolicitedResponseChannel via /dev/pts/1>: sending 11 bytes: 'AT+CLIP=1\r\n'
573Jan 15 11:39:44 debian-gta02 2009.01.15 11:39:44 ogsmd    DEBUG    <CallChannel via /dev/pts/2> queue is: deque([])
574Jan 15 11:39:44 debian-gta02 2009.01.15 11:39:44 ogsmd    DEBUG    <CallChannel via /dev/pts/2>: nothing in request queue
575Jan 15 11:39:44 debian-gta02 2009.01.15 11:39:44 ogsmd    DEBUG    <UnsolicitedResponseChannel via /dev/pts/1>: got 6 bytes from: '\r\nOK\r\n'
576Jan 15 11:39:44 debian-gta02 2009.01.15 11:39:44 ogsmd    DEBUG    <UnsolicitedResponseChannel via /dev/pts/1>: COMPLETED 'AT+CLIP=1' => ['OK']
577Jan 15 11:39:45 debian-gta02 2009.01.15 11:39:44 ogsmd    DEBUG    <UnsolicitedResponseChannel via /dev/pts/1> queue is: deque([('AT+COLP=0\r\n', None, None, 10), ('AT+CCWA=1\r\n', None, None, 10), ('AT+CSSN=1,1\r\n', None, None, 10), ('AT+CTZU=1\r\n', None, None, 10), ('AT+CTZR=1\r\n', None, None, 10), ('AT+CREG=2\r\n', None, None, 10), ('AT+CAOC=2\r\n', None, None, 10), ('AT+CGEREP=2,1\r\n', None, None, 10), ('AT+CGREG=2\r\n', None, None, 10), ('AT%CPI=3\r\n', None, None, 10), ('AT%CSCN=1,2,1,2\r\n', None, None, 10), ('AT%CSQ=1\r\n', None, None, 10), ('AT%CNIV=1\r\n', None, None, 10), ('AT%CGEREP=1\r\n', None, None, 10), ('AT%CGREG=3\r\n', None, None, 10), ('AT%CSTAT=1\r\n', None, None, 10), ('AT@ST="-26"\r\n', None, None, 10), ('AT%N028B\r\n', None, None, 10), ('AT%N0125\r\n', None, None, 10), ('AT%SLEEP=2\r\n', None, None, 10)])
578Jan 15 11:39:45 debian-gta02 2009.01.15 11:39:45 ogsmd    DEBUG    <UnsolicitedResponseChannel via /dev/pts/1>: sending 11 bytes: 'AT+COLP=0\r\n'
579Jan 15 11:39:45 debian-gta02 2009.01.15 11:39:45 ogsmd    DEBUG    <UnsolicitedResponseChannel via /dev/pts/1>: got 6 bytes from: '\r\nOK\r\n'
580Jan 15 11:39:45 debian-gta02 2009.01.15 11:39:45 ogsmd    DEBUG    <UnsolicitedResponseChannel via /dev/pts/1>: COMPLETED 'AT+COLP=0' => ['OK']
581Jan 15 11:39:45 debian-gta02 2009.01.15 11:39:45 ogsmd    DEBUG    <UnsolicitedResponseChannel via /dev/pts/1> queue is: deque([('AT+CCWA=1\r\n', None, None, 10), ('AT+CSSN=1,1\r\n', None, None, 10), ('AT+CTZU=1\r\n', None, None, 10), ('AT+CTZR=1\r\n', None, None, 10), ('AT+CREG=2\r\n', None, None, 10), ('AT+CAOC=2\r\n', None, None, 10), ('AT+CGEREP=2,1\r\n', None, None, 10), ('AT+CGREG=2\r\n', None, None, 10), ('AT%CPI=3\r\n', None, None, 10), ('AT%CSCN=1,2,1,2\r\n', None, None, 10), ('AT%CSQ=1\r\n', None, None, 10), ('AT%CNIV=1\r\n', None, None, 10), ('AT%CGEREP=1\r\n', None, None, 10), ('AT%CGREG=3\r\n', None, None, 10), ('AT%CSTAT=1\r\n', None, None, 10), ('AT@ST="-26"\r\n', None, None, 10), ('AT%N028B\r\n', None, None, 10), ('AT%N0125\r\n', None, None, 10), ('AT%SLEEP=2\r\n', None, None, 10)])
582Jan 15 11:39:45 debian-gta02 2009.01.15 11:39:45 ogsmd    DEBUG    <UnsolicitedResponseChannel via /dev/pts/1>: sending 11 bytes: 'AT+CCWA=1\r\n'
583Jan 15 11:39:45 debian-gta02 2009.01.15 11:39:45 ogsmd    DEBUG    <UnsolicitedResponseChannel via /dev/pts/1>: got 6 bytes from: '\r\nOK\r\n'
584Jan 15 11:39:45 debian-gta02 2009.01.15 11:39:45 ogsmd    DEBUG    <UnsolicitedResponseChannel via /dev/pts/1>: COMPLETED 'AT+CCWA=1' => ['OK']
585Jan 15 11:39:45 debian-gta02 2009.01.15 11:39:45 ogsmd    DEBUG    <UnsolicitedResponseChannel via /dev/pts/1> queue is: deque([('AT+CSSN=1,1\r\n', None, None, 10), ('AT+CTZU=1\r\n', None, None, 10), ('AT+CTZR=1\r\n', None, None, 10), ('AT+CREG=2\r\n', None, None, 10), ('AT+CAOC=2\r\n', None, None, 10), ('AT+CGEREP=2,1\r\n', None, None, 10), ('AT+CGREG=2\r\n', None, None, 10), ('AT%CPI=3\r\n', None, None, 10), ('AT%CSCN=1,2,1,2\r\n', None, None, 10), ('AT%CSQ=1\r\n', None, None, 10), ('AT%CNIV=1\r\n', None, None, 10), ('AT%CGEREP=1\r\n', None, None, 10), ('AT%CGREG=3\r\n', None, None, 10), ('AT%CSTAT=1\r\n', None, None, 10), ('AT@ST="-26"\r\n', None, None, 10), ('AT%N028B\r\n', None, None, 10), ('AT%N0125\r\n', None, None, 10), ('AT%SLEEP=2\r\n', None, None, 10)])
586Jan 15 11:39:45 debian-gta02 2009.01.15 11:39:45 ogsmd    DEBUG    <UnsolicitedResponseChannel via /dev/pts/1>: sending 13 bytes: 'AT+CSSN=1,1\r\n'
587Jan 15 11:39:45 debian-gta02 2009.01.15 11:39:45 ogsmd    DEBUG    <UnsolicitedResponseChannel via /dev/pts/1>: got 6 bytes from: '\r\nOK\r\n'
588Jan 15 11:39:45 debian-gta02 2009.01.15 11:39:45 ogsmd    DEBUG    <UnsolicitedResponseChannel via /dev/pts/1>: COMPLETED 'AT+CSSN=1,1' => ['OK']
589Jan 15 11:39:45 debian-gta02 2009.01.15 11:39:45 ogsmd    DEBUG    <UnsolicitedResponseChannel via /dev/pts/1> queue is: deque([('AT+CTZU=1\r\n', None, None, 10), ('AT+CTZR=1\r\n', None, None, 10), ('AT+CREG=2\r\n', None, None, 10), ('AT+CAOC=2\r\n', None, None, 10), ('AT+CGEREP=2,1\r\n', None, None, 10), ('AT+CGREG=2\r\n', None, None, 10), ('AT%CPI=3\r\n', None, None, 10), ('AT%CSCN=1,2,1,2\r\n', None, None, 10), ('AT%CSQ=1\r\n', None, None, 10), ('AT%CNIV=1\r\n', None, None, 10), ('AT%CGEREP=1\r\n', None, None, 10), ('AT%CGREG=3\r\n', None, None, 10), ('AT%CSTAT=1\r\n', None, None, 10), ('AT@ST="-26"\r\n', None, None, 10), ('AT%N028B\r\n', None, None, 10), ('AT%N0125\r\n', None, None, 10), ('AT%SLEEP=2\r\n', None, None, 10)])
590Jan 15 11:39:45 debian-gta02 2009.01.15 11:39:45 ogsmd    DEBUG    <UnsolicitedResponseChannel via /dev/pts/1>: sending 11 bytes: 'AT+CTZU=1\r\n'
591Jan 15 11:39:45 debian-gta02 2009.01.15 11:39:45 ogsmd    DEBUG    <UnsolicitedResponseChannel via /dev/pts/1>: got 6 bytes from: '\r\nOK\r\n'
592Jan 15 11:39:45 debian-gta02 2009.01.15 11:39:45 ogsmd    DEBUG    <UnsolicitedResponseChannel via /dev/pts/1>: COMPLETED 'AT+CTZU=1' => ['OK']
593Jan 15 11:39:45 debian-gta02 2009.01.15 11:39:45 ogsmd    DEBUG    <UnsolicitedResponseChannel via /dev/pts/1> queue is: deque([('AT+CTZR=1\r\n', None, None, 10), ('AT+CREG=2\r\n', None, None, 10), ('AT+CAOC=2\r\n', None, None, 10), ('AT+CGEREP=2,1\r\n', None, None, 10), ('AT+CGREG=2\r\n', None, None, 10), ('AT%CPI=3\r\n', None, None, 10), ('AT%CSCN=1,2,1,2\r\n', None, None, 10), ('AT%CSQ=1\r\n', None, None, 10), ('AT%CNIV=1\r\n', None, None, 10), ('AT%CGEREP=1\r\n', None, None, 10), ('AT%CGREG=3\r\n', None, None, 10), ('AT%CSTAT=1\r\n', None, None, 10), ('AT@ST="-26"\r\n', None, None, 10), ('AT%N028B\r\n', None, None, 10), ('AT%N0125\r\n', None, None, 10), ('AT%SLEEP=2\r\n', None, None, 10)])
594Jan 15 11:39:45 debian-gta02 2009.01.15 11:39:45 ogsmd    DEBUG    <UnsolicitedResponseChannel via /dev/pts/1>: sending 11 bytes: 'AT+CTZR=1\r\n'
595Jan 15 11:39:45 debian-gta02 2009.01.15 11:39:45 ogsmd    DEBUG    <UnsolicitedResponseChannel via /dev/pts/1>: got 6 bytes from: '\r\nOK\r\n'
596Jan 15 11:39:45 debian-gta02 2009.01.15 11:39:45 ogsmd    DEBUG    <UnsolicitedResponseChannel via /dev/pts/1>: COMPLETED 'AT+CTZR=1' => ['OK']
597Jan 15 11:39:45 debian-gta02 2009.01.15 11:39:45 ogsmd    DEBUG    <UnsolicitedResponseChannel via /dev/pts/1> queue is: deque([('AT+CREG=2\r\n', None, None, 10), ('AT+CAOC=2\r\n', None, None, 10), ('AT+CGEREP=2,1\r\n', None, None, 10), ('AT+CGREG=2\r\n', None, None, 10), ('AT%CPI=3\r\n', None, None, 10), ('AT%CSCN=1,2,1,2\r\n', None, None, 10), ('AT%CSQ=1\r\n', None, None, 10), ('AT%CNIV=1\r\n', None, None, 10), ('AT%CGEREP=1\r\n', None, None, 10), ('AT%CGREG=3\r\n', None, None, 10), ('AT%CSTAT=1\r\n', None, None, 10), ('AT@ST="-26"\r\n', None, None, 10), ('AT%N028B\r\n', None, None, 10), ('AT%N0125\r\n', None, None, 10), ('AT%SLEEP=2\r\n', None, None, 10)])
598Jan 15 11:39:45 debian-gta02 2009.01.15 11:39:45 ogsmd    DEBUG    <UnsolicitedResponseChannel via /dev/pts/1>: sending 11 bytes: 'AT+CREG=2\r\n'
599Jan 15 11:39:45 debian-gta02 2009.01.15 11:39:45 ogsmd    DEBUG    <UnsolicitedResponseChannel via /dev/pts/1>: got 6 bytes from: '\r\nOK\r\n'
600Jan 15 11:39:45 debian-gta02 2009.01.15 11:39:45 ogsmd    DEBUG    <UnsolicitedResponseChannel via /dev/pts/1>: COMPLETED 'AT+CREG=2' => ['OK']
601Jan 15 11:39:45 debian-gta02 2009.01.15 11:39:45 ogsmd    DEBUG    <UnsolicitedResponseChannel via /dev/pts/1> queue is: deque([('AT+CAOC=2\r\n', None, None, 10), ('AT+CGEREP=2,1\r\n', None, None, 10), ('AT+CGREG=2\r\n', None, None, 10), ('AT%CPI=3\r\n', None, None, 10), ('AT%CSCN=1,2,1,2\r\n', None, None, 10), ('AT%CSQ=1\r\n', None, None, 10), ('AT%CNIV=1\r\n', None, None, 10), ('AT%CGEREP=1\r\n', None, None, 10), ('AT%CGREG=3\r\n', None, None, 10), ('AT%CSTAT=1\r\n', None, None, 10), ('AT@ST="-26"\r\n', None, None, 10), ('AT%N028B\r\n', None, None, 10), ('AT%N0125\r\n', None, None, 10), ('AT%SLEEP=2\r\n', None, None, 10)])
602Jan 15 11:39:45 debian-gta02 2009.01.15 11:39:45 ogsmd    DEBUG    <UnsolicitedResponseChannel via /dev/pts/1>: sending 11 bytes: 'AT+CAOC=2\r\n'
603Jan 15 11:39:45 debian-gta02 2009.01.15 11:39:45 ogsmd    DEBUG    <UnsolicitedResponseChannel via /dev/pts/1>: got 6 bytes from: '\r\nOK\r\n'
604Jan 15 11:39:45 debian-gta02 2009.01.15 11:39:45 ogsmd    DEBUG    <UnsolicitedResponseChannel via /dev/pts/1>: COMPLETED 'AT+CAOC=2' => ['OK']
605Jan 15 11:39:45 debian-gta02 2009.01.15 11:39:45 ogsmd    DEBUG    <UnsolicitedResponseChannel via /dev/pts/1> queue is: deque([('AT+CGEREP=2,1\r\n', None, None, 10), ('AT+CGREG=2\r\n', None, None, 10), ('AT%CPI=3\r\n', None, None, 10), ('AT%CSCN=1,2,1,2\r\n', None, None, 10), ('AT%CSQ=1\r\n', None, None, 10), ('AT%CNIV=1\r\n', None, None, 10), ('AT%CGEREP=1\r\n', None, None, 10), ('AT%CGREG=3\r\n', None, None, 10), ('AT%CSTAT=1\r\n', None, None, 10), ('AT@ST="-26"\r\n', None, None, 10), ('AT%N028B\r\n', None, None, 10), ('AT%N0125\r\n', None, None, 10), ('AT%SLEEP=2\r\n', None, None, 10)])
606Jan 15 11:39:45 debian-gta02 2009.01.15 11:39:45 ogsmd    DEBUG    <UnsolicitedResponseChannel via /dev/pts/1>: sending 15 bytes: 'AT+CGEREP=2,1\r\n'
607Jan 15 11:39:45 debian-gta02 2009.01.15 11:39:45 ogsmd    DEBUG    <UnsolicitedResponseChannel via /dev/pts/1>: got 6 bytes from: '\r\nOK\r\n'
608Jan 15 11:39:45 debian-gta02 2009.01.15 11:39:45 ogsmd    DEBUG    <UnsolicitedResponseChannel via /dev/pts/1>: COMPLETED 'AT+CGEREP=2,1' => ['OK']
609Jan 15 11:39:45 debian-gta02 2009.01.15 11:39:45 ogsmd    DEBUG    <UnsolicitedResponseChannel via /dev/pts/1> queue is: deque([('AT+CGREG=2\r\n', None, None, 10), ('AT%CPI=3\r\n', None, None, 10), ('AT%CSCN=1,2,1,2\r\n', None, None, 10), ('AT%CSQ=1\r\n', None, None, 10), ('AT%CNIV=1\r\n', None, None, 10), ('AT%CGEREP=1\r\n', None, None, 10), ('AT%CGREG=3\r\n', None, None, 10), ('AT%CSTAT=1\r\n', None, None, 10), ('AT@ST="-26"\r\n', None, None, 10), ('AT%N028B\r\n', None, None, 10), ('AT%N0125\r\n', None, None, 10), ('AT%SLEEP=2\r\n', None, None, 10)])
610Jan 15 11:39:45 debian-gta02 2009.01.15 11:39:45 ogsmd    DEBUG    <UnsolicitedResponseChannel via /dev/pts/1>: sending 12 bytes: 'AT+CGREG=2\r\n'
611Jan 15 11:39:45 debian-gta02 2009.01.15 11:39:45 ogsmd    DEBUG    <UnsolicitedResponseChannel via /dev/pts/1>: got 6 bytes from: '\r\nOK\r\n'
612Jan 15 11:39:45 debian-gta02 2009.01.15 11:39:45 ogsmd    DEBUG    <UnsolicitedResponseChannel via /dev/pts/1>: COMPLETED 'AT+CGREG=2' => ['OK']
613Jan 15 11:39:45 debian-gta02 2009.01.15 11:39:45 ogsmd    DEBUG    <UnsolicitedResponseChannel via /dev/pts/1> queue is: deque([('AT%CPI=3\r\n', None, None, 10), ('AT%CSCN=1,2,1,2\r\n', None, None, 10), ('AT%CSQ=1\r\n', None, None, 10), ('AT%CNIV=1\r\n', None, None, 10), ('AT%CGEREP=1\r\n', None, None, 10), ('AT%CGREG=3\r\n', None, None, 10), ('AT%CSTAT=1\r\n', None, None, 10), ('AT@ST="-26"\r\n', None, None, 10), ('AT%N028B\r\n', None, None, 10), ('AT%N0125\r\n', None, None, 10), ('AT%SLEEP=2\r\n', None, None, 10)])
614Jan 15 11:39:45 debian-gta02 2009.01.15 11:39:45 ogsmd    DEBUG    <UnsolicitedResponseChannel via /dev/pts/1>: sending 10 bytes: 'AT%CPI=3\r\n'
615Jan 15 11:39:45 debian-gta02 2009.01.15 11:39:45 ogsmd    DEBUG    <UnsolicitedResponseChannel via /dev/pts/1>: got 6 bytes from: '\r\nOK\r\n'
616Jan 15 11:39:45 debian-gta02 2009.01.15 11:39:45 ogsmd    DEBUG    <UnsolicitedResponseChannel via /dev/pts/1>: COMPLETED 'AT%CPI=3' => ['OK']
617Jan 15 11:39:45 debian-gta02 2009.01.15 11:39:45 ogsmd    DEBUG    <UnsolicitedResponseChannel via /dev/pts/1> queue is: deque([('AT%CSCN=1,2,1,2\r\n', None, None, 10), ('AT%CSQ=1\r\n', None, None, 10), ('AT%CNIV=1\r\n', None, None, 10), ('AT%CGEREP=1\r\n', None, None, 10), ('AT%CGREG=3\r\n', None, None, 10), ('AT%CSTAT=1\r\n', None, None, 10), ('AT@ST="-26"\r\n', None, None, 10), ('AT%N028B\r\n', None, None, 10), ('AT%N0125\r\n', None, None, 10), ('AT%SLEEP=2\r\n', None, None, 10)])
618Jan 15 11:39:46 debian-gta02 2009.01.15 11:39:46 ogsmd    DEBUG    <UnsolicitedResponseChannel via /dev/pts/1>: sending 17 bytes: 'AT%CSCN=1,2,1,2\r\n'
619Jan 15 11:39:46 debian-gta02 2009.01.15 11:39:46 ogsmd    DEBUG    <UnsolicitedResponseChannel via /dev/pts/1>: got 6 bytes from: '\r\nOK\r\n'
620Jan 15 11:39:46 debian-gta02 2009.01.15 11:39:46 ogsmd    DEBUG    <UnsolicitedResponseChannel via /dev/pts/1>: COMPLETED 'AT%CSCN=1,2,1,2' => ['OK']
621Jan 15 11:39:46 debian-gta02 2009.01.15 11:39:46 ogsmd    DEBUG    <UnsolicitedResponseChannel via /dev/pts/1> queue is: deque([('AT%CSQ=1\r\n', None, None, 10), ('AT%CNIV=1\r\n', None, None, 10), ('AT%CGEREP=1\r\n', None, None, 10), ('AT%CGREG=3\r\n', None, None, 10), ('AT%CSTAT=1\r\n', None, None, 10), ('AT@ST="-26"\r\n', None, None, 10), ('AT%N028B\r\n', None, None, 10), ('AT%N0125\r\n', None, None, 10), ('AT%SLEEP=2\r\n', None, None, 10)])
622Jan 15 11:39:46 debian-gta02 2009.01.15 11:39:46 ogsmd    DEBUG    <UnsolicitedResponseChannel via /dev/pts/1>: sending 10 bytes: 'AT%CSQ=1\r\n'
623Jan 15 11:39:46 debian-gta02 2009.01.15 11:39:46 ogsmd    DEBUG    <UnsolicitedResponseChannel via /dev/pts/1>: got 12 bytes from: '\r\n%CSQ: 1 \r\n'
624Jan 15 11:39:46 debian-gta02 2009.01.15 11:39:46 ogsmd    DEBUG    <UnsolicitedResponseChannel via /dev/pts/1>: got 6 bytes from: '\r\nOK\r\n'
625Jan 15 11:39:46 debian-gta02 2009.01.15 11:39:46 ogsmd    DEBUG    <UnsolicitedResponseChannel via /dev/pts/1>: COMPLETED 'AT%CSQ=1' => ['%CSQ: 1 ', 'OK']
626Jan 15 11:39:46 debian-gta02 2009.01.15 11:39:46 ogsmd    DEBUG    <UnsolicitedResponseChannel via /dev/pts/1> queue is: deque([('AT%CNIV=1\r\n', None, None, 10), ('AT%CGEREP=1\r\n', None, None, 10), ('AT%CGREG=3\r\n', None, None, 10), ('AT%CSTAT=1\r\n', None, None, 10), ('AT@ST="-26"\r\n', None, None, 10), ('AT%N028B\r\n', None, None, 10), ('AT%N0125\r\n', None, None, 10), ('AT%SLEEP=2\r\n', None, None, 10)])
627Jan 15 11:39:46 debian-gta02 2009.01.15 11:39:46 ogsmd    DEBUG    <UnsolicitedResponseChannel via /dev/pts/1>: sending 11 bytes: 'AT%CNIV=1\r\n'
628Jan 15 11:39:46 debian-gta02 2009.01.15 11:39:46 ogsmd    DEBUG    <UnsolicitedResponseChannel via /dev/pts/1>: got 6 bytes from: '\r\nOK\r\n'
629Jan 15 11:39:46 debian-gta02 2009.01.15 11:39:46 ogsmd    DEBUG    <UnsolicitedResponseChannel via /dev/pts/1>: COMPLETED 'AT%CNIV=1' => ['OK']
630Jan 15 11:39:46 debian-gta02 2009.01.15 11:39:46 ogsmd    DEBUG    <UnsolicitedResponseChannel via /dev/pts/1> queue is: deque([('AT%CGEREP=1\r\n', None, None, 10), ('AT%CGREG=3\r\n', None, None, 10), ('AT%CSTAT=1\r\n', None, None, 10), ('AT@ST="-26"\r\n', None, None, 10), ('AT%N028B\r\n', None, None, 10), ('AT%N0125\r\n', None, None, 10), ('AT%SLEEP=2\r\n', None, None, 10)])
631Jan 15 11:39:46 debian-gta02 2009.01.15 11:39:46 ogsmd    DEBUG    <UnsolicitedResponseChannel via /dev/pts/1>: sending 13 bytes: 'AT%CGEREP=1\r\n'
632Jan 15 11:39:46 debian-gta02 2009.01.15 11:39:46 ogsmd    DEBUG    <UnsolicitedResponseChannel via /dev/pts/1>: got 6 bytes from: '\r\nOK\r\n'
633Jan 15 11:39:46 debian-gta02 2009.01.15 11:39:46 ogsmd    DEBUG    <UnsolicitedResponseChannel via /dev/pts/1>: COMPLETED 'AT%CGEREP=1' => ['OK']
634Jan 15 11:39:46 debian-gta02 2009.01.15 11:39:46 ogsmd    DEBUG    <UnsolicitedResponseChannel via /dev/pts/1> queue is: deque([('AT%CGREG=3\r\n', None, None, 10), ('AT%CSTAT=1\r\n', None, None, 10), ('AT@ST="-26"\r\n', None, None, 10), ('AT%N028B\r\n', None, None, 10), ('AT%N0125\r\n', None, None, 10), ('AT%SLEEP=2\r\n', None, None, 10)])
635Jan 15 11:39:46 debian-gta02 2009.01.15 11:39:46 ogsmd    DEBUG    <UnsolicitedResponseChannel via /dev/pts/1>: sending 12 bytes: 'AT%CGREG=3\r\n'
636Jan 15 11:39:46 debian-gta02 2009.01.15 11:39:46 ogsmd    DEBUG    <UnsolicitedResponseChannel via /dev/pts/1>: got 6 bytes from: '\r\nOK\r\n'
637Jan 15 11:39:46 debian-gta02 2009.01.15 11:39:46 ogsmd    DEBUG    <UnsolicitedResponseChannel via /dev/pts/1>: COMPLETED 'AT%CGREG=3' => ['OK']
638Jan 15 11:39:46 debian-gta02 2009.01.15 11:39:46 ogsmd    DEBUG    <UnsolicitedResponseChannel via /dev/pts/1> queue is: deque([('AT%CSTAT=1\r\n', None, None, 10), ('AT@ST="-26"\r\n', None, None, 10), ('AT%N028B\r\n', None, None, 10), ('AT%N0125\r\n', None, None, 10), ('AT%SLEEP=2\r\n', None, None, 10)])
639Jan 15 11:39:46 debian-gta02 2009.01.15 11:39:46 ogsmd    DEBUG    <UnsolicitedResponseChannel via /dev/pts/1>: sending 12 bytes: 'AT%CSTAT=1\r\n'
640Jan 15 11:39:46 debian-gta02 2009.01.15 11:39:46 ogsmd    DEBUG    <UnsolicitedResponseChannel via /dev/pts/1>: got 6 bytes from: '\r\nOK\r\n'
641Jan 15 11:39:46 debian-gta02 2009.01.15 11:39:46 ogsmd    DEBUG    <UnsolicitedResponseChannel via /dev/pts/1>: COMPLETED 'AT%CSTAT=1' => ['OK']
642Jan 15 11:39:46 debian-gta02 2009.01.15 11:39:46 ogsmd    DEBUG    <UnsolicitedResponseChannel via /dev/pts/1> queue is: deque([('AT@ST="-26"\r\n', None, None, 10), ('AT%N028B\r\n', None, None, 10), ('AT%N0125\r\n', None, None, 10), ('AT%SLEEP=2\r\n', None, None, 10)])
643Jan 15 11:39:46 debian-gta02 2009.01.15 11:39:46 ogsmd    DEBUG    <UnsolicitedResponseChannel via /dev/pts/1>: sending 13 bytes: 'AT@ST="-26"\r\n'
644Jan 15 11:39:46 debian-gta02 2009.01.15 11:39:46 ogsmd    DEBUG    <UnsolicitedResponseChannel via /dev/pts/1>: got 6 bytes from: '\r\nOK\r\n'
645Jan 15 11:39:46 debian-gta02 2009.01.15 11:39:46 ogsmd    DEBUG    <UnsolicitedResponseChannel via /dev/pts/1>: COMPLETED 'AT@ST="-26"' => ['OK']
646Jan 15 11:39:46 debian-gta02 2009.01.15 11:39:46 ogsmd    DEBUG    <UnsolicitedResponseChannel via /dev/pts/1> queue is: deque([('AT%N028B\r\n', None, None, 10), ('AT%N0125\r\n', None, None, 10), ('AT%SLEEP=2\r\n', None, None, 10)])
647Jan 15 11:39:46 debian-gta02 2009.01.15 11:39:46 ogsmd    DEBUG    <UnsolicitedResponseChannel via /dev/pts/1>: sending 10 bytes: 'AT%N028B\r\n'
648Jan 15 11:39:46 debian-gta02 2009.01.15 11:39:46 ogsmd    DEBUG    <MiscChannel via /dev/pts/0>: got 24 bytes from: '\r\n+CPIN: SIM PIN\r\n\r\nOK\r\n'
649Jan 15 11:39:46 debian-gta02 2009.01.15 11:39:46 ogsmd    DEBUG    <MiscChannel via /dev/pts/0>: COMPLETED 'AT+CPIN?' => ['+CPIN: SIM PIN', 'OK']
650Jan 15 11:39:46 debian-gta02 2009.01.15 11:39:46 ogsmd.objects INFO     auth status changed to SIM PIN
651Jan 15 11:39:46 debian-gta02 2009.01.15 11:39:46 ogsmd    DEBUG    <UnsolicitedResponseChannel via /dev/pts/1>: got 58 bytes from: '%CSTAT: PHB, 0\r\n\r\nEXT: I\r\nLong AEC -6 dB is active\r\n\r\nOK\r\n'
652Jan 15 11:39:46 debian-gta02 2009.01.15 11:39:46 ogsmd    DEBUG    <UnsolicitedResponseChannel via /dev/pts/1>: COMPLETED 'AT%N028B' => ['%CSTAT: PHB, 0', 'EXT: I', 'Long AEC -6 dB is active', 'OK']
653Jan 15 11:39:46 debian-gta02 2009.01.15 11:39:46 ogsmd    DEBUG    <MiscChannel via /dev/pts/0> queue is: deque([('AT+CFUN=1\r\n', <bound method DeviceSetAntennaPower.responseFromChannel of <ogsmd.modems.abstract.mediator.DeviceSetAntennaPower object at 0x6c8310>>, <bound method DeviceSetAntennaPower.errorFromChannel of <ogsmd.modems.abstract.mediator.DeviceSetAntennaPower object at 0x6c8310>>, 10)])
654Jan 15 11:39:46 debian-gta02 2009.01.15 11:39:46 ogsmd    DEBUG    <MiscChannel via /dev/pts/0>: sending 11 bytes: 'AT+CFUN=1\r\n'
655Jan 15 11:39:46 debian-gta02 2009.01.15 11:39:46 ogsmd    DEBUG    <UnsolicitedResponseChannel via /dev/pts/1> queue is: deque([('AT%N0125\r\n', None, None, 10), ('AT%SLEEP=2\r\n', None, None, 10)])
656Jan 15 11:39:46 debian-gta02 2009.01.15 11:39:46 ogsmd    DEBUG    <UnsolicitedResponseChannel via /dev/pts/1>: sending 10 bytes: 'AT%N0125\r\n'
657Jan 15 11:39:46 debian-gta02 2009.01.15 11:39:46 ogsmd    DEBUG    <UnsolicitedResponseChannel via /dev/pts/1>: got 10 bytes from: '\r\nEXT: I\r\n'
658Jan 15 11:39:47 debian-gta02 2009.01.15 11:39:47 ogsmd    DEBUG    <UnsolicitedResponseChannel via /dev/pts/1>: got 39 bytes from: 'Noise reduction -6 dB is active\r\n\r\nOK\r\n'
659Jan 15 11:39:47 debian-gta02 2009.01.15 11:39:47 ogsmd    DEBUG    <UnsolicitedResponseChannel via /dev/pts/1>: COMPLETED 'AT%N0125' => ['EXT: I', 'Noise reduction -6 dB is active', 'OK']
660Jan 15 11:39:47 debian-gta02 2009.01.15 11:39:47 ogsmd    DEBUG    <UnsolicitedResponseChannel via /dev/pts/1> queue is: deque([('AT%SLEEP=2\r\n', None, None, 10)])
661Jan 15 11:39:47 debian-gta02 2009.01.15 11:39:47 ogsmd    DEBUG    <UnsolicitedResponseChannel via /dev/pts/1>: sending 12 bytes: 'AT%SLEEP=2\r\n'
662Jan 15 11:39:47 debian-gta02 2009.01.15 11:39:47 ogsmd    DEBUG    <UnsolicitedResponseChannel via /dev/pts/1>: got 10 bytes from: '\r\nEXT: I\r\n'
663Jan 15 11:39:47 debian-gta02 2009.01.15 11:39:47 ogsmd    DEBUG    <UnsolicitedResponseChannel via /dev/pts/1>: got 6 bytes from: '\r\nOK\r\n'
664Jan 15 11:39:47 debian-gta02 2009.01.15 11:39:47 ogsmd    DEBUG    <UnsolicitedResponseChannel via /dev/pts/1>: COMPLETED 'AT%SLEEP=2' => ['EXT: I', 'OK']
665Jan 15 11:39:47 debian-gta02 2009.01.15 11:39:47 ogsmd    DEBUG    <UnsolicitedResponseChannel via /dev/pts/1> queue is: deque([])
666Jan 15 11:39:47 debian-gta02 2009.01.15 11:39:47 ogsmd    DEBUG    <UnsolicitedResponseChannel via /dev/pts/1>: nothing in request queue
667Jan 15 11:39:48 debian-gta02 2009.01.15 11:39:48 ogsmd    DEBUG    <UnsolicitedResponseChannel via /dev/pts/1>: got 16 bytes from: '%CSTAT: PHB, 0\r\n'
668Jan 15 11:39:48 debian-gta02 2009.01.15 11:39:48 ogsmd    INFO     subsystem PHB readyness now False
669Jan 15 11:39:48 debian-gta02 2009.01.15 11:39:48 ogsmd.objects INFO     sim ready status False
670Jan 15 11:39:48 debian-gta02 2009.01.15 11:39:48 ogsmd    INFO     full readyness now False
671Jan 15 11:39:48 debian-gta02 2009.01.15 11:39:48 ogsmd    DEBUG    <MiscChannel via /dev/pts/0>: got 18 bytes from: '\r\n+CME ERROR: 11\r\n'
672Jan 15 11:39:48 debian-gta02 2009.01.15 11:39:48 ogsmd    DEBUG    <MiscChannel via /dev/pts/0>: COMPLETED 'AT+CFUN=1' => ['+CME ERROR: 11']
673Jan 15 11:39:49 debian-gta02 2009.01.15 11:39:49 ogsmd    DEBUG    <MiscChannel via /dev/pts/0> queue is: deque([('AT+CPIN?\r\n', <bound method DeviceSetAntennaPower.intermediateResponse2 of <ogsmd.modems.abstract.mediator.DeviceSetAntennaPower object at 0x6c8310>>, <bound method DeviceSetAntennaPower.errorFromChannel of <ogsmd.modems.abstract.mediator.DeviceSetAntennaPower object at 0x6c8310>>, 15)])
674Jan 15 11:39:49 debian-gta02 2009.01.15 11:39:49 ogsmd    DEBUG    <MiscChannel via /dev/pts/0>: sending 10 bytes: 'AT+CPIN?\r\n'
675Jan 15 11:39:49 debian-gta02 2009.01.15 11:39:49 ogsmd    DEBUG    <MiscChannel via /dev/pts/0>: got 24 bytes from: '\r\n+CPIN: SIM PIN\r\n\r\nOK\r\n'
676Jan 15 11:39:49 debian-gta02 2009.01.15 11:39:49 ogsmd    DEBUG    <MiscChannel via /dev/pts/0>: COMPLETED 'AT+CPIN?' => ['+CPIN: SIM PIN', 'OK']
677Jan 15 11:39:49 debian-gta02 2009.01.15 11:39:49 ogsmd    DEBUG    <MiscChannel via /dev/pts/0> queue is: deque([('AT+CPIN?\r\n', <bound method SimGetAuthStatus.responseFromChannel of <ogsmd.modems.abstract.mediator.SimGetAuthStatus object at 0x810cf0>>, <bound method SimGetAuthStatus.errorFromChannel of <ogsmd.modems.abstract.mediator.SimGetAuthStatus object at 0x810cf0>>, 15)])
678Jan 15 11:39:49 debian-gta02 2009.01.15 11:39:49 ogsmd    DEBUG    <MiscChannel via /dev/pts/0>: sending 10 bytes: 'AT+CPIN?\r\n'
679Jan 15 11:39:49 debian-gta02 2009.01.15 11:39:49 ogsmd    DEBUG    <MiscChannel via /dev/pts/0>: got 24 bytes from: '\r\n+CPIN: SIM PIN\r\n\r\nOK\r\n'
680Jan 15 11:39:49 debian-gta02 2009.01.15 11:39:49 ogsmd    DEBUG    <MiscChannel via /dev/pts/0>: COMPLETED 'AT+CPIN?' => ['+CPIN: SIM PIN', 'OK']
681Jan 15 11:39:49 debian-gta02 2009.01.15 11:39:49 ogsmd    DEBUG    <MiscChannel via /dev/pts/0> queue is: deque([])
682Jan 15 11:39:49 debian-gta02 2009.01.15 11:39:49 ogsmd    DEBUG    <MiscChannel via /dev/pts/0>: nothing in request queue
683Jan 15 11:39:52 debian-gta02 2009.01.15 11:39:52 odeviced.idlenotifier INFO     odeviced.idlenotifier state change to idle
684Jan 15 11:39:52 debian-gta02 2009.01.15 11:39:52 oeventsd INFO     DebugAction : dbus trigger test
685Jan 15 11:39:52 debian-gta02 2009.01.15 11:39:52 oeventsd INFO     Receive IdleState, status = idle
686Jan 15 11:39:52 debian-gta02 last message repeated 2 times
687Jan 15 11:39:52 debian-gta02 2009.01.15 11:39:52 odeviced.idlenotifier INFO     odeviced.idlenotifier state change to busy
688Jan 15 11:39:52 debian-gta02 2009.01.15 11:39:52 oeventsd INFO     DebugAction : dbus trigger test
689Jan 15 11:39:52 debian-gta02 2009.01.15 11:39:52 oeventsd INFO     Receive IdleState, status = busy
690Jan 15 11:39:52 debian-gta02 2009.01.15 11:39:52 oeventsd INFO     call dbus signal /org/freesmartphone/Device/Display/pcf50633_bl SetBrightness((90,))
691Jan 15 11:39:52 debian-gta02 2009.01.15 11:39:52 oeventsd INFO     Receive IdleState, status = busy
692Jan 15 11:39:52 debian-gta02 2009.01.15 11:39:52 oeventsd INFO     Receive IdleState, status = busy
693Jan 15 11:39:53 debian-gta02 2009.01.15 11:39:52 oeventsd INFO     signal SetBrightness responded : ()
694Jan 15 11:39:55 debian-gta02 2009.01.15 11:39:55 ogsmd    WARNING  <MiscChannel via /dev/pts/0>: Got unicode input. Trying to convert to plain string...
695Jan 15 11:39:55 debian-gta02 2009.01.15 11:39:55 ogsmd    DEBUG    <MiscChannel via /dev/pts/0> queue is: deque([('AT+CPIN="2513"\r\n', <bound method SimSendAuthCode.responseFromChannel of <ogsmd.modems.abstract.mediator.SimSendAuthCode object at 0x7962d0>>, <bound method SimSendAuthCode.errorFromChannel of <ogsmd.modems.abstract.mediator.SimSendAuthCode object at 0x7962d0>>, 15)])
696Jan 15 11:39:55 debian-gta02 2009.01.15 11:39:55 ogsmd    DEBUG    <MiscChannel via /dev/pts/0>: sending 16 bytes: 'AT+CPIN="2513"\r\n'
697Jan 15 11:39:57 debian-gta02 2009.01.15 11:39:57 ogsmd    DEBUG    <UnsolicitedResponseChannel via /dev/pts/1>: got 16 bytes from: '%CSTAT: PHB, 0\r\n'
698Jan 15 11:39:57 debian-gta02 2009.01.15 11:39:57 ogsmd    INFO     subsystem PHB readyness now False
699Jan 15 11:39:57 debian-gta02 2009.01.15 11:39:57 ogsmd    INFO     full readyness now False
700Jan 15 11:39:57 debian-gta02 2009.01.15 11:39:57 ogsmd    DEBUG    <UnsolicitedResponseChannel via /dev/pts/1>: got 16 bytes from: '%CSTAT: PHB, 0\r\n'
701Jan 15 11:39:57 debian-gta02 2009.01.15 11:39:57 ogsmd    INFO     subsystem PHB readyness now False
702Jan 15 11:39:57 debian-gta02 2009.01.15 11:39:57 ogsmd    INFO     full readyness now False
703Jan 15 11:39:57 debian-gta02 2009.01.15 11:39:57 ogsmd    DEBUG    <UnsolicitedResponseChannel via /dev/pts/1>: got 16 bytes from: '%CSTAT: PHB, 0\r\n'
704Jan 15 11:39:57 debian-gta02 2009.01.15 11:39:57 ogsmd    INFO     subsystem PHB readyness now False
705Jan 15 11:39:57 debian-gta02 2009.01.15 11:39:57 ogsmd    INFO     full readyness now False
706Jan 15 11:39:57 debian-gta02 2009.01.15 11:39:57 ogsmd    DEBUG    <MiscChannel via /dev/pts/0>: got 22 bytes from: '\r\n+CPIN: READY\r\n\r\nOK\r\n'
707Jan 15 11:39:57 debian-gta02 2009.01.15 11:39:57 ogsmd    DEBUG    <MiscChannel via /dev/pts/0>: COMPLETED 'AT+CPIN="2513"' => ['+CPIN: READY', 'OK']
708Jan 15 11:39:57 debian-gta02 2009.01.15 11:39:57 ogsmd.objects INFO     auth status changed to READY
709Jan 15 11:39:57 debian-gta02 2009.01.15 11:39:57 ogsmd    DEBUG    <MiscChannel via /dev/pts/0> queue is: deque([])
710Jan 15 11:39:57 debian-gta02 2009.01.15 11:39:57 ogsmd    DEBUG    <MiscChannel via /dev/pts/0>: nothing in request queue
711Jan 15 11:39:57 debian-gta02 2009.01.15 11:39:57 ogsmd    DEBUG    <MiscChannel via /dev/pts/0> queue is: deque([('AT+CPIN?\r\n', <bound method DeviceSetAntennaPower.intermediateResponse of <ogsmd.modems.abstract.mediator.DeviceSetAntennaPower object at 0x7962d0>>, <bound method DeviceSetAntennaPower.errorFromChannel of <ogsmd.modems.abstract.mediator.DeviceSetAntennaPower object at 0x7962d0>>, 15)])
712Jan 15 11:39:57 debian-gta02 2009.01.15 11:39:57 ogsmd    DEBUG    <MiscChannel via /dev/pts/0>: sending 10 bytes: 'AT+CPIN?\r\n'
713Jan 15 11:39:57 debian-gta02 2009.01.15 11:39:57 ogsmd    DEBUG    <MiscChannel via /dev/pts/0>: got 22 bytes from: '\r\n+CPIN: READY\r\n\r\nOK\r\n'
714Jan 15 11:39:57 debian-gta02 2009.01.15 11:39:57 ogsmd    DEBUG    <MiscChannel via /dev/pts/0>: COMPLETED 'AT+CPIN?' => ['+CPIN: READY', 'OK']
715Jan 15 11:39:57 debian-gta02 2009.01.15 11:39:57 ogsmd    DEBUG    <MiscChannel via /dev/pts/0> queue is: deque([('AT+CFUN=1\r\n', <bound method DeviceSetAntennaPower.responseFromChannel of <ogsmd.modems.abstract.mediator.DeviceSetAntennaPower object at 0x7962d0>>, <bound method DeviceSetAntennaPower.errorFromChannel of <ogsmd.modems.abstract.mediator.DeviceSetAntennaPower object at 0x7962d0>>, 10)])
716Jan 15 11:39:57 debian-gta02 2009.01.15 11:39:57 ogsmd    DEBUG    <MiscChannel via /dev/pts/0>: sending 11 bytes: 'AT+CFUN=1\r\n'
717Jan 15 11:39:57 debian-gta02 2009.01.15 11:39:57 ogsmd    DEBUG    <MiscChannel via /dev/pts/0>: got 6 bytes from: '\r\nOK\r\n'
718Jan 15 11:39:57 debian-gta02 2009.01.15 11:39:57 ogsmd    DEBUG    <MiscChannel via /dev/pts/0>: COMPLETED 'AT+CFUN=1' => ['OK']
719Jan 15 11:39:57 debian-gta02 2009.01.15 11:39:57 ogsmd    DEBUG    <MiscChannel via /dev/pts/0> queue is: deque([('AT+CPIN?\r\n', <bound method DeviceSetAntennaPower.intermediateResponse2 of <ogsmd.modems.abstract.mediator.DeviceSetAntennaPower object at 0x7962d0>>, <bound method DeviceSetAntennaPower.errorFromChannel of <ogsmd.modems.abstract.mediator.DeviceSetAntennaPower object at 0x7962d0>>, 15)])
720Jan 15 11:39:57 debian-gta02 2009.01.15 11:39:57 ogsmd    DEBUG    <MiscChannel via /dev/pts/0>: sending 10 bytes: 'AT+CPIN?\r\n'
721Jan 15 11:39:57 debian-gta02 2009.01.15 11:39:57 ogsmd    DEBUG    <MiscChannel via /dev/pts/0>: got 16 bytes from: '\r\n+CPIN: READY\r\n'
722Jan 15 11:39:57 debian-gta02 2009.01.15 11:39:57 ogsmd    DEBUG    <MiscChannel via /dev/pts/0>: got 6 bytes from: '\r\nOK\r\n'
723Jan 15 11:39:58 debian-gta02 2009.01.15 11:39:58 ogsmd    DEBUG    <MiscChannel via /dev/pts/0>: COMPLETED 'AT+CPIN?' => ['+CPIN: READY', 'OK']
724Jan 15 11:39:58 debian-gta02 2009.01.15 11:39:58 ogsmd    DEBUG    <MiscChannel via /dev/pts/0> queue is: deque([])
725Jan 15 11:39:58 debian-gta02 2009.01.15 11:39:58 ogsmd    DEBUG    <MiscChannel via /dev/pts/0>: nothing in request queue
726Jan 15 11:39:58 debian-gta02 2009.01.15 11:39:58 ogsmd    DEBUG    <MiscChannel via /dev/pts/0> queue is: deque([('AT+COPS=0,0\r\n', <bound method NetworkRegister.responseFromChannel of <ogsmd.modems.abstract.mediator.NetworkRegister object at 0x6c8310>>, <bound method NetworkRegister.errorFromChannel of <ogsmd.modems.abstract.mediator.NetworkRegister object at 0x6c8310>>, 30)])
727Jan 15 11:39:58 debian-gta02 2009.01.15 11:39:58 ogsmd    DEBUG    <MiscChannel via /dev/pts/0>: sending 13 bytes: 'AT+COPS=0,0\r\n'
728Jan 15 11:39:58 debian-gta02 2009.01.15 11:39:58 ogsmd    DEBUG    <UnsolicitedResponseChannel via /dev/pts/1>: got 12 bytes from: '\r\n+CREG: 2\r\n'
729Jan 15 11:39:59 debian-gta02 2009.01.15 11:39:59 ogsmd    DEBUG    <UnsolicitedResponseChannel via /dev/pts/1>: got 17 bytes from: '%CSTAT: EONS, 0\r\n'
730Jan 15 11:39:59 debian-gta02 2009.01.15 11:39:59 ogsmd    INFO     full readyness now False
731Jan 15 11:39:59 debian-gta02 2009.01.15 11:39:59 ogsmd    DEBUG    <UnsolicitedResponseChannel via /dev/pts/1>: got 32 bytes from: '%CSTAT: PHB, 0\r\n%CSTAT: SMS, 1\r\n'
732Jan 15 11:39:59 debian-gta02 2009.01.15 11:39:59 ogsmd    INFO     subsystem PHB readyness now False
733Jan 15 11:39:59 debian-gta02 2009.01.15 11:39:59 ogsmd    INFO     full readyness now False
734Jan 15 11:39:59 debian-gta02 2009.01.15 11:39:59 ogsmd    INFO     subsystem SMS readyness now True
735Jan 15 11:39:59 debian-gta02 2009.01.15 11:39:59 ogsmd    INFO     full readyness now False
736Jan 15 11:40:03 debian-gta02 2009.01.15 11:40:03 odeviced.idlenotifier INFO     odeviced.idlenotifier state change to idle
737Jan 15 11:40:03 debian-gta02 2009.01.15 11:40:03 oeventsd INFO     DebugAction : dbus trigger test
738Jan 15 11:40:03 debian-gta02 2009.01.15 11:40:03 oeventsd INFO     Receive IdleState, status = idle
739Jan 15 11:40:03 debian-gta02 last message repeated 2 times
740Jan 15 11:40:03 debian-gta02 2009.01.15 11:40:03 ogsmd    DEBUG    <UnsolicitedResponseChannel via /dev/pts/1>: got 20 bytes from: '\r\n%CSQ:  23, 99, 2\r\n'
741Jan 15 11:40:03 debian-gta02 2009.01.15 11:40:03 ogsmd.objects INFO     org.freesmartphone.GSM.Network.SignalStrength: 91
742Jan 15 11:40:03 debian-gta02 2009.01.15 11:40:03 ogsmd    DEBUG    <MiscChannel via /dev/pts/0>: got 6 bytes from: '\r\nOK\r\n'
743Jan 15 11:40:03 debian-gta02 2009.01.15 11:40:03 ogsmd    DEBUG    <MiscChannel via /dev/pts/0>: COMPLETED 'AT+COPS=0,0' => ['OK']
744Jan 15 11:40:03 debian-gta02 2009.01.15 11:40:03 ogsmd    DEBUG    <UnsolicitedResponseChannel via /dev/pts/1>: got 26 bytes from: '\r\n+CREG: 1,"02C3","5CF5"\r\n'
745Jan 15 11:40:03 debian-gta02 2009.01.15 11:40:03 ogsmd    DEBUG    <MiscChannel via /dev/pts/0> queue is: deque([('AT+CSQ\r\n', <bound method NetworkGetStatus.genResponseFromChannel of <ogsmd.modems.abstract.mediator.NetworkGetStatus object at 0x810dd0>>, <bound method NetworkGetStatus.genErrorFromChannel of <ogsmd.modems.abstract.mediator.NetworkGetStatus object at 0x810dd0>>, 10), ('AT+CSQ\r\n', <bound method NetworkGetStatus.genResponseFromChannel of <ogsmd.modems.abstract.mediator.NetworkGetStatus object at 0x7962b0>>, <bound method NetworkGetStatus.genErrorFromChannel of <ogsmd.modems.abstract.mediator.NetworkGetStatus object at 0x7962b0>>, 10)])
746Jan 15 11:40:03 debian-gta02 2009.01.15 11:40:03 ogsmd    DEBUG    <MiscChannel via /dev/pts/0>: sending 8 bytes: 'AT+CSQ\r\n'
747Jan 15 11:40:03 debian-gta02 2009.01.15 11:40:03 ogsmd    DEBUG    <MiscChannel via /dev/pts/0>: got 16 bytes from: '\r\n+CSQ: 23,99 \r\n'
748Jan 15 11:40:03 debian-gta02 2009.01.15 11:40:03 ogsmd    DEBUG    <MiscChannel via /dev/pts/0>: got 6 bytes from: '\r\nOK\r\n'
749Jan 15 11:40:03 debian-gta02 2009.01.15 11:40:03 ogsmd    DEBUG    <MiscChannel via /dev/pts/0>: COMPLETED 'AT+CSQ' => ['+CSQ: 23,99 ', 'OK']
750Jan 15 11:40:03 debian-gta02 2009.01.15 11:40:03 ogsmd    DEBUG    <MiscChannel via /dev/pts/0> queue is: deque([('AT+CSQ\r\n', <bound method NetworkGetStatus.genResponseFromChannel of <ogsmd.modems.abstract.mediator.NetworkGetStatus object at 0x7962b0>>, <bound method NetworkGetStatus.genErrorFromChannel of <ogsmd.modems.abstract.mediator.NetworkGetStatus object at 0x7962b0>>, 10), ('AT+CREG?;+COPS=3,0;+COPS?;+COPS=3,2;+COPS?\r\n', <bound method NetworkGetStatus.genResponseFromChannel of <ogsmd.modems.abstract.mediator.NetworkGetStatus object at 0x810dd0>>, <bound method NetworkGetStatus.genErrorFromChannel of <ogsmd.modems.abstract.mediator.NetworkGetStatus object at 0x810dd0>>, 10)])
751Jan 15 11:40:03 debian-gta02 2009.01.15 11:40:03 ogsmd    DEBUG    <MiscChannel via /dev/pts/0>: sending 8 bytes: 'AT+CSQ\r\n'
752Jan 15 11:40:03 debian-gta02 2009.01.15 11:40:03 ogsmd    DEBUG    <MiscChannel via /dev/pts/0>: got 16 bytes from: '\r\n+CSQ: 23,99 \r\n'
753Jan 15 11:40:03 debian-gta02 2009.01.15 11:40:03 ogsmd    DEBUG    <MiscChannel via /dev/pts/0>: got 6 bytes from: '\r\nOK\r\n'
754Jan 15 11:40:03 debian-gta02 2009.01.15 11:40:03 ogsmd    DEBUG    <MiscChannel via /dev/pts/0>: COMPLETED 'AT+CSQ' => ['+CSQ: 23,99 ', 'OK']
755Jan 15 11:40:03 debian-gta02 2009.01.15 11:40:03 ogsmd    DEBUG    <MiscChannel via /dev/pts/0> queue is: deque([('AT+CREG?;+COPS=3,0;+COPS?;+COPS=3,2;+COPS?\r\n', <bound method NetworkGetStatus.genResponseFromChannel of <ogsmd.modems.abstract.mediator.NetworkGetStatus object at 0x810dd0>>, <bound method NetworkGetStatus.genErrorFromChannel of <ogsmd.modems.abstract.mediator.NetworkGetStatus object at 0x810dd0>>, 10), ('AT+CREG?;+COPS=3,0;+COPS?;+COPS=3,2;+COPS?\r\n', <bound method NetworkGetStatus.genResponseFromChannel of <ogsmd.modems.abstract.mediator.NetworkGetStatus object at 0x7962b0>>, <bound method NetworkGetStatus.genErrorFromChannel of <ogsmd.modems.abstract.mediator.NetworkGetStatus object at 0x7962b0>>, 10)])
756Jan 15 11:40:03 debian-gta02 2009.01.15 11:40:03 ogsmd    DEBUG    <MiscChannel via /dev/pts/0>: sending 44 bytes: 'AT+CREG?;+COPS=3,0;+COPS?;+COPS=3,2;+COPS?\r\n'
757Jan 15 11:40:03 debian-gta02 2009.01.15 11:40:03 ogsmd    DEBUG    <MiscChannel via /dev/pts/0>: got 14 bytes from: '\r\n+CREG: 0,1\r\n'
758Jan 15 11:40:03 debian-gta02 2009.01.15 11:40:03 ogsmd    DEBUG    <MiscChannel via /dev/pts/0>: got 25 bytes from: '\r\n+COPS: 0,0,"Swisscom"\r\n'
759Jan 15 11:40:04 debian-gta02 2009.01.15 11:40:03 ogsmd    DEBUG    <MiscChannel via /dev/pts/0>: got 28 bytes from: '\r\n+COPS: 0,2,"22801"\r\n\r\nOK\r\n'
760Jan 15 11:40:04 debian-gta02 2009.01.15 11:40:04 ogsmd    DEBUG    <MiscChannel via /dev/pts/0>: COMPLETED 'AT+CREG?;+COPS=3,0;+COPS?;+COPS=3,2;+COPS?' => ['+CREG: 0,1', '+COPS: 0,0,"Swisscom"', '+COPS: 0,2,"22801"', 'OK']
761Jan 15 11:40:04 debian-gta02 2009.01.15 11:40:04 ogsmd.objects INFO     org.freesmartphone.GSM.Network.Status: {'code': 22801, 'cid': '5CF5', 'registration': 'home', 'lac': '02C3', 'strength': 91, 'mode': 'automatic', 'provider': 'Swisscom'}
762Jan 15 11:40:04 debian-gta02 2009.01.15 11:40:04 ogsmd    DEBUG    <MiscChannel via /dev/pts/0> queue is: deque([('AT+CREG?;+COPS=3,0;+COPS?;+COPS=3,2;+COPS?\r\n', <bound method NetworkGetStatus.genResponseFromChannel of <ogsmd.modems.abstract.mediator.NetworkGetStatus object at 0x7962b0>>, <bound method NetworkGetStatus.genErrorFromChannel of <ogsmd.modems.abstract.mediator.NetworkGetStatus object at 0x7962b0>>, 10)])
763Jan 15 11:40:04 debian-gta02 2009.01.15 11:40:04 ogsmd    DEBUG    <MiscChannel via /dev/pts/0>: sending 44 bytes: 'AT+CREG?;+COPS=3,0;+COPS?;+COPS=3,2;+COPS?\r\n'
764Jan 15 11:40:04 debian-gta02 2009.01.15 11:40:04 ogsmd    DEBUG    <MiscChannel via /dev/pts/0>: got 67 bytes from: '\r\n+CREG: 0,1\r\n\r\n+COPS: 0,0,"Swisscom"\r\n\r\n+COPS: 0,2,"22801"\r\n\r\nOK\r\n'
765Jan 15 11:40:04 debian-gta02 2009.01.15 11:40:04 ogsmd    DEBUG    <MiscChannel via /dev/pts/0>: COMPLETED 'AT+CREG?;+COPS=3,0;+COPS?;+COPS=3,2;+COPS?' => ['+CREG: 0,1', '+COPS: 0,0,"Swisscom"', '+COPS: 0,2,"22801"', 'OK']
766Jan 15 11:40:04 debian-gta02 2009.01.15 11:40:04 ogsmd.objects INFO     org.freesmartphone.GSM.Network.Status: {'code': 22801, 'cid': '5CF5', 'registration': 'home', 'lac': '02C3', 'strength': 91, 'mode': 'automatic', 'provider': 'Swisscom'}
767Jan 15 11:40:04 debian-gta02 2009.01.15 11:40:04 ogsmd    DEBUG    <MiscChannel via /dev/pts/0> queue is: deque([])
768Jan 15 11:40:04 debian-gta02 2009.01.15 11:40:04 ogsmd    DEBUG    <MiscChannel via /dev/pts/0>: nothing in request queue
769Jan 15 11:40:08 debian-gta02 2009.01.15 11:40:08 ogsmd    DEBUG    <UnsolicitedResponseChannel via /dev/pts/1> queue is: deque([('AT+CSMS=1\r\n', None, None, 10), ('AT+CNMI=2,1,2,1,1\r\n', None, None, 10)])
770Jan 15 11:40:08 debian-gta02 2009.01.15 11:40:08 ogsmd    DEBUG    <UnsolicitedResponseChannel via /dev/pts/1>: sending 11 bytes: 'AT+CSMS=1\r\n'
771Jan 15 11:40:08 debian-gta02 2009.01.15 11:40:08 ogsmd    DEBUG    <UnsolicitedResponseChannel via /dev/pts/1>: got 16 bytes from: '\r\n+CSMS: 1,1,1\r\n'
772Jan 15 11:40:08 debian-gta02 2009.01.15 11:40:08 ogsmd    DEBUG    <UnsolicitedResponseChannel via /dev/pts/1>: got 6 bytes from: '\r\nOK\r\n'
773Jan 15 11:40:08 debian-gta02 2009.01.15 11:40:08 ogsmd    DEBUG    <UnsolicitedResponseChannel via /dev/pts/1>: COMPLETED 'AT+CSMS=1' => ['+CSMS: 1,1,1', 'OK']
774Jan 15 11:40:08 debian-gta02 2009.01.15 11:40:08 ogsmd    DEBUG    <UnsolicitedResponseChannel via /dev/pts/1> queue is: deque([('AT+CNMI=2,1,2,1,1\r\n', None, None, 10)])
775Jan 15 11:40:08 debian-gta02 2009.01.15 11:40:08 ogsmd    DEBUG    <UnsolicitedResponseChannel via /dev/pts/1>: sending 19 bytes: 'AT+CNMI=2,1,2,1,1\r\n'
776Jan 15 11:40:08 debian-gta02 2009.01.15 11:40:08 ogsmd    DEBUG    <UnsolicitedResponseChannel via /dev/pts/1>: got 6 bytes from: '\r\nOK\r\n'
777Jan 15 11:40:08 debian-gta02 2009.01.15 11:40:08 ogsmd    DEBUG    <UnsolicitedResponseChannel via /dev/pts/1>: COMPLETED 'AT+CNMI=2,1,2,1,1' => ['OK']
778Jan 15 11:40:08 debian-gta02 2009.01.15 11:40:08 ogsmd    DEBUG    <UnsolicitedResponseChannel via /dev/pts/1> queue is: deque([])
779Jan 15 11:40:08 debian-gta02 2009.01.15 11:40:08 ogsmd    DEBUG    <UnsolicitedResponseChannel via /dev/pts/1>: nothing in request queue
780Jan 15 11:40:12 debian-gta02 2009.01.15 11:40:12 ogsmd    DEBUG    <UnsolicitedResponseChannel via /dev/pts/1>: got 16 bytes from: '%CSTAT: PHB, 1\r\n'
781Jan 15 11:40:12 debian-gta02 2009.01.15 11:40:12 ogsmd    INFO     subsystem PHB readyness now True
782Jan 15 11:40:12 debian-gta02 2009.01.15 11:40:12 ogsmd.objects INFO     sim ready status True
783Jan 15 11:40:12 debian-gta02 2009.01.15 11:40:12 ogsmd    INFO     full readyness now True
784Jan 15 11:40:13 debian-gta02 2009.01.15 11:40:13 ogsmd    DEBUG    <MiscChannel via /dev/pts/0> queue is: deque([('AT+CPBS="SM";+CPBR=?\r\n', <bound method SimGetPhonebookInfo.responseFromChannel of <ogsmd.modems.abstract.mediator.SimGetPhonebookInfo object at 0x810f90>>, <bound method SimGetPhonebookInfo.errorFromChannel of <ogsmd.modems.abstract.mediator.SimGetPhonebookInfo object at 0x810f90>>, 10), ('AT+CMGL=4\r\n', <bound method SimRetrieveMessagebook.responseFromChannel of <ogsmd.modems.abstract.mediator.SimRetrieveMessagebook object at 0x810f30>>, <bound method SimRetrieveMessagebook.errorFromChannel of <ogsmd.modems.abstract.mediator.SimRetrieveMessagebook object at 0x810f30>>, 10)])
785Jan 15 11:40:13 debian-gta02 2009.01.15 11:40:13 ogsmd    DEBUG    <MiscChannel via /dev/pts/0>: sending 22 bytes: 'AT+CPBS="SM";+CPBR=?\r\n'
786Jan 15 11:40:13 debian-gta02 2009.01.15 11:40:13 ogsmd    DEBUG    <MiscChannel via /dev/pts/0>: got 24 bytes from: '\r\n+CPBR: (1-250),44,20\r\n'
787Jan 15 11:40:13 debian-gta02 2009.01.15 11:40:13 ogsmd    DEBUG    <MiscChannel via /dev/pts/0>: got 6 bytes from: '\r\nOK\r\n'
788Jan 15 11:40:13 debian-gta02 2009.01.15 11:40:13 ogsmd    DEBUG    <MiscChannel via /dev/pts/0>: COMPLETED 'AT+CPBS="SM";+CPBR=?' => ['+CPBR: (1-250),44,20', 'OK']
789Jan 15 11:40:13 debian-gta02 2009.01.15 11:40:13 ogsmd    DEBUG    <MiscChannel via /dev/pts/0> queue is: deque([('AT+CMGL=4\r\n', <bound method SimRetrieveMessagebook.responseFromChannel of <ogsmd.modems.abstract.mediator.SimRetrieveMessagebook object at 0x810f30>>, <bound method SimRetrieveMessagebook.errorFromChannel of <ogsmd.modems.abstract.mediator.SimRetrieveMessagebook object at 0x810f30>>, 10), ('AT+CPBS="SM";+CPBR=1,250\r\n', <bound method SimRetrievePhonebook.responseFromChannel of <ogsmd.modems.abstract.mediator.SimRetrievePhonebook object at 0x810db0>>, <bound method SimRetrievePhonebook.errorFromChannel of <ogsmd.modems.abstract.mediator.SimRetrievePhonebook object at 0x810db0>>, 10)])
790Jan 15 11:40:13 debian-gta02 2009.01.15 11:40:13 ogsmd    DEBUG    <MiscChannel via /dev/pts/0>: sending 11 bytes: 'AT+CMGL=4\r\n'
791Jan 15 11:40:13 debian-gta02 2009.01.15 11:40:13 ogsmd    DEBUG    <MiscChannel via /dev/pts/0>: got 18 bytes from: '\r\n+CMGL: 1,1,,84\r\n'
792Jan 15 11:40:13 debian-gta02 2009.01.15 11:40:13 ogsmd    DEBUG    <MiscChannel via /dev/pts/0>: got 64 bytes from: '07911497949900F004038108F10000801171317291404ED77419742EDFFDEEF9'
793Jan 15 11:40:13 debian-gta02 2009.01.15 11:40:13 ogsmd    DEBUG    <MiscChannel via /dev/pts/0>: got 122 bytes from: '184D07DDEB727219442ECB41D3B2DC9E1E97EFE5317A5E6683C2F5F9B96CF6A3E57417C8282FD7DD64767A8C2E838E72FF7C5E064DEFE9F97CFC6E03\r\n'
794Jan 15 11:40:13 debian-gta02 2009.01.15 11:40:13 ogsmd    DEBUG    <MiscChannel via /dev/pts/0>: got 16 bytes from: '+CMGL: 5,1,,84\r\n'
795Jan 15 11:40:13 debian-gta02 2009.01.15 11:40:13 ogsmd    DEBUG    <MiscChannel via /dev/pts/0>: got 128 bytes from: '07911497949900F04405810350F039F580216181248040440C05040B8423F008042168020256594730330086818805810301517F890A805377697373636F6D00'
796Jan 15 11:40:13 debian-gta02 2009.01.15 11:40:13 ogsmd    DEBUG    <MiscChannel via /dev/pts/0>: got 58 bytes from: '8A828E026C009657656C636F6D65204D4D53205377697373636F6D00\r\n'
797Jan 15 11:40:13 debian-gta02 2009.01.15 11:40:13 ogsmd    DEBUG    <MiscChannel via /dev/pts/0>: got 59 bytes from: '+CMGL: 13,1,"0041006E0064007200650061002C002000500072",78\r\n'
798Jan 15 11:40:13 debian-gta02 2009.01.15 11:40:13 ogsmd    DEBUG    <MiscChannel via /dev/pts/0>: got 180 bytes from: '07911497949900F0040B911497567613F700008021621160704043CA325D4F079DCB68FA1CC47ECF41ED341D442EBB4165F99C5E7683D66937B92C07B1C37573D9ED0259CBF2737A3E07ADC3EDB23C0C72A7C768BA0B\r\n\r\nOK\r\n'
799Jan 15 11:40:13 debian-gta02 2009.01.15 11:40:13 ogsmd    DEBUG    <MiscChannel via /dev/pts/0>: COMPLETED 'AT+CMGL=4' => ['+CMGL: 1,1,,84', '07911497949900F004038108F10000801171317291404ED77419742EDFFDEEF9184D07DDEB727219442ECB41D3B2DC9E1E97EFE5317A5E6683C2F5F9B96CF6A3E57417C8282FD7DD64767A8C2E838E72FF7C5E064DEFE9F97CFC6E03', '+CMGL: 5,1,,84', '07911497949900F04405810350F039F580216181248040440C05040B8423F008042168020256594730330086818805810301517F890A805377697373636F6D008A828E026C009657656C636F6D65204D4D53205377697373636F6D00', '+CMGL: 13,1,"0041006E0064007200650061002C002000500072",78', '07911497949900F0040B911497567613F700008021621160704043CA325D4F079DCB68FA1CC47ECF41ED341D442EBB4165F99C5E7683D66937B92C07B1C37573D9ED0259CBF2737A3E07ADC3EDB23C0C72A7C768BA0B', 'OK']
800Jan 15 11:40:13 debian-gta02 2009.01.15 11:40:13 ogsmd    DEBUG    <MiscChannel via /dev/pts/0> queue is: deque([('AT+CPBS="SM";+CPBR=1,250\r\n', <bound method SimRetrievePhonebook.responseFromChannel of <ogsmd.modems.abstract.mediator.SimRetrievePhonebook object at 0x810db0>>, <bound method SimRetrievePhonebook.errorFromChannel of <ogsmd.modems.abstract.mediator.SimRetrievePhonebook object at 0x810db0>>, 10)])
801Jan 15 11:40:13 debian-gta02 2009.01.15 11:40:13 ogsmd    DEBUG    <MiscChannel via /dev/pts/0>: sending 26 bytes: 'AT+CPBS="SM";+CPBR=1,250\r\n'
802Jan 15 11:40:13 debian-gta02 2009.01.15 11:40:13 ogsmd    DEBUG    <MiscChannel via /dev/pts/0>: got 64 bytes from: '\r\n+CPBR: 1,"144",129,"004100410020004E006F0074007200750066002000'
803Jan 15 11:40:13 debian-gta02 2009.01.15 11:40:13 ogsmd    DEBUG    <MiscChannel via /dev/pts/0>: got 41 bytes from: '480069006C00660065002000530063002F0057"\r\n'
804Jan 15 11:40:14 debian-gta02 2009.01.15 11:40:14 ogsmd    DEBUG    <UnsolicitedResponseChannel via /dev/pts/1> queue is: deque([('AT+CSMS=1\r\n', None, None, 10), ('AT+CNMI=2,1,2,1,1\r\n', None, None, 10)])
805Jan 15 11:40:14 debian-gta02 2009.01.15 11:40:14 ogsmd    DEBUG    <UnsolicitedResponseChannel via /dev/pts/1>: sending 11 bytes: 'AT+CSMS=1\r\n'
806Jan 15 11:40:14 debian-gta02 2009.01.15 11:40:14 ogsmd    DEBUG    <MiscChannel via /dev/pts/0>: got 64 bytes from: '+CPBR: 2,"41622861212",145,"0048006F0074006C0069006E006500200049'
807Jan 15 11:40:14 debian-gta02 2009.01.15 11:40:14 ogsmd    DEBUG    <MiscChannel via /dev/pts/0>: got 211 bytes from: '004E0054002F0048"\r\n+CPBR: 3,"1144",129,"0043006F006E006E006500630074002F0048"\r\n+CPBR: 4,"*139#",129,"0053004D005300200043006F006E006E006500630074002F0048"\r\n+CPBR: 5,"41813026607",145,"0041006E0064007200650061002'
808Jan 15 11:40:14 debian-gta02 2009.01.15 11:40:14 ogsmd    DEBUG    <UnsolicitedResponseChannel via /dev/pts/1>: got 16 bytes from: '\r\n+CSMS: 1,1,1\r\n'
809Jan 15 11:40:14 debian-gta02 2009.01.15 11:40:14 ogsmd    DEBUG    <MiscChannel via /dev/pts/0>: got 512 bytes from: 'C0020005000720069007600E9002F0048"\r\n+CPBR: 6,"41813031891",145,"0041006E0064007200650061002C0020004100720062006500690074002D00480061006E002F0057"\r\n+CPBR: 7,"41813004270",145,"00460065007500650072006400650070006F00740020005600E40074007400690073002F0057"\r\n+CPBR: 8,"41800117117",145,"004200610068006E0070006F006C0069007A00650069002F0057"\r\n+CPBR: 9,"31118650333",145,"004C007500640069002000760064002000560065006E002F0048"\r\n+CPBR: 10,"49803171077",145,"00570065006900730065002C002000520065006E006100740065002F0048"\r\n'
810Jan 15 11:40:14 debian-gta02 2009.01.15 11:40:14 ogsmd    DEBUG    <MiscChannel via /dev/pts/0>: got 384 bytes from: '+CPBR: 11,"41813031499",145,"0041006E0064007200650061002C0020004200750072006F002F0057"\r\n+CPBR: 12,"117",129,"0050006F006C0069007A006500690020004E006F0074002F0048"\r\n+CPBR: 13,"41800556464",145,"0048006F0074006C0069006E0065002000430048002F0048"\r\n+CPBR: 14,"144",129,"00530061006E0069007400E400740020004E006F0074002F0048"\r\n+CPBR: 15,"1414",129,"00480065006C0069002F0048"\r\n+CPBR: 16,"0813'
811Jan 15 11:40:14 debian-gta02 2009.01.15 11:40:14 ogsmd    DEBUG    <MiscChannel via /dev/pts/0>: got 384 bytes from: '004222",129,"0050006F006C0069007A00650069002000420061006400200052006100670061007A002F0048"\r\n+CPBR: 17,"491733562556",145,"004A0075006E0067002C00200045006C006B0065002F004D"\r\n+CPBR: 18,"491733562552",145,"005200650068006D002C0020004C006100720073002F004D"\r\n+CPBR: 19,"41813061286",145,"0045007200770069006E0020002600200052006500670075006C006100200047006F0072002F0048"\r\n+CPBR: 20,"0031118'
812Jan 15 11:40:14 debian-gta02 2009.01.15 11:40:14 ogsmd    DEBUG    <MiscChannel via /dev/pts/0>: got 384 bytes from: '617104",129,"004D00610063006800740065006C0064002F0048"\r\n+CPBR: 21,"31642825253",145,"004A0065006C006700650072002F004D"\r\n+CPBR: 23,"0041792453484",160,"005700650069007300650020005400750069006E00730074007200610061002F004D"\r\n+CPBR: 24,"41813302037",145,"00530074006500660061006E002000260020004D0061007200740069006E00610020004E002F0048"\r\n+CPBR: 25,"41813302035",145,"005300740065006600610'
813Jan 15 11:40:14 debian-gta02 2009.01.15 11:40:14 ogsmd    DEBUG    <MiscChannel via /dev/pts/0>: got 256 bytes from: '06E002000260020004D0061007200740069006E00610020004E002F0057"\r\n+CPBR: 26,"31629005902",145,"004D0061007200740069006E0061002F004D"\r\n+CPBR: 27,"393482846012",145,"0041006E006900620061006C002F0048"\r\n+CPBR: 28,"31651619038",145,"00420061007200620065007200200026'
814Jan 15 11:40:14 debian-gta02 2009.01.15 11:40:14 ogsmd    DEBUG    <MiscChannel via /dev/pts/0>: got 384 bytes from: '00200045007200690063002F004D"\r\n+CPBR: 29,"118",129,"004600650075007200770065006800720020004E006F0074002F0048"\r\n+CPBR: 30,"31640467082",145,"004C007500640069002000760064002000560065006E002F004D"\r\n+CPBR: 31,"41719888614",145,"0047006F00720074002000530074006500660061006E000A002F0048"\r\n+CPBR: 32,"41813061215",145,"0047006F007200740020004A006F00730065007000200028005600610074006500720029'
815Jan 15 11:40:14 debian-gta02 2009.01.15 11:40:14 ogsmd    DEBUG    <MiscChannel via /dev/pts/0>: got 448 bytes from: '002F0048"\r\n+CPBR: 33,"41813061373",145,"004A00FC00720067002000530070007200650063006800650072002F0048"\r\n+CPBR: 34,"41792704315",145,"0053006F006E006A0061002000530070007200650063006800650072002F004D"\r\n+CPBR: 35,"31614839349",145,"00520069006E0073006B006500200053002E002F004D"\r\n+CPBR: 36,"31622068628",145,"0054006A0065006500720064002F004D"\r\n+CPBR: 37,"4151228644444",145,"005300620062002000420061006400200052006100670061007A002F0057"\r\n+CPBR: 38,"3170'
816Jan 15 11:40:14 debian-gta02 2009.01.15 11:40:14 ogsmd    DEBUG    <MiscChannel via /dev/pts/0>: got 384 bytes from: '3569333",145,"00410073006E0020004B0061006C006B006D0061006E00200041006E006E0065006D0061002F0057"\r\n+CPBR: 39,"31112",145,"004100410020004E006F00740072007500660020004E00690065006400650072006C0061002F0057"\r\n+CPBR: 40,"31206627416",145,"004D0061007200740069006E0061002F0048"\r\n+CPBR: 41,"31703652754",145,"004A0069006D006D0079002F0048"\r\n+CPBR: 42,"31618880451",145,"004A0069006D006D0079002F'
817Jan 15 11:40:14 debian-gta02 2009.01.15 11:40:14 ogsmd    DEBUG    <MiscChannel via /dev/pts/0>: got 512 bytes from: '004D"\r\n+CPBR: 43,"31703634515",145,"004B00690072007300740065006E002F0048"\r\n+CPBR: 44,"31648272196",145,"004B00690072007300740065006E002F004D"\r\n+CPBR: 45,"31648462047",145,"004A006F0061006E0069006B0065002F004D"\r\n+CPBR: 46,"4114556002",145,"0043006F006E00730075006C0061006100740020005A00FC0072006900630068002F0057"\r\n+CPBR: 47,"41796567317",145,"0041006E0064007200650061002C0020005000720069007600E9002F004D"\r\n+CPBR: 48,"31620247245",145,"004E0061007400610073006800610020002800560061006E0020004A0069006D006D0079002F0'
818Jan 15 11:40:14 debian-gta02 2009.01.15 11:40:14 ogsmd    DEBUG    <MiscChannel via /dev/pts/0>: got 256 bytes from: '04D"\r\n+CPBR: 49,"41813026237",145,"005400720069006A006E006A006500200026002000460065006C00690078002F0048"\r\n+CPBR: 50,"41813026666",145,"005400610078006900200045007800700072006500730073002F0057"\r\n+CPBR: 51,"41795339211",145,"004400F6007200740065002F004D"\r\n+C'
819Jan 15 11:40:14 debian-gta02 2009.01.15 11:40:14 ogsmd    DEBUG    <MiscChannel via /dev/pts/0>: got 384 bytes from: 'PBR: 52,"31650954904",145,"004D00610063006800740065006C0064002F004D"\r\n+CPBR: 53,"31629082653",145,"004D00610063006800740065006C0064002F0057"\r\n+CPBR: 54,"41813061418",145,"00440061006E00690065006C0061002000260020005200610069006E0065007200200047002F0048"\r\n+CPBR: 55,"41813061368",145,"004800650069006E007A00200026002000530079006C0076006900610020004B006E0069002F0048"\r\n+CPBR: 56,"3162077'
820Jan 15 11:40:14 debian-gta02 2009.01.15 11:40:14 ogsmd    DEBUG    <MiscChannel via /dev/pts/0>: got 256 bytes from: '0563",145,"004A0061006E00200054002F004D"\r\n+CPBR: 57,"491784165677",145,"00570065006900730065002C002000520065006E006100740065002F0057"\r\n+CPBR: 58,"41813022317",145,"004C0061006500740073006300680020004800610075007300610072007A0074002F0057"\r\n+CPBR: 59,"417978'
821Jan 15 11:40:14 debian-gta02 2009.01.15 11:40:14 ogsmd    DEBUG    <MiscChannel via /dev/pts/0>: got 448 bytes from: '43441",145,"005400720069006A006E006A006500200026002000460065006C00690078002F004D"\r\n+CPBR: 60,"41793771159",145,"004200650061007400650020004B007200690065006700650072002F004D"\r\n+CPBR: 61,"491776043457",145,"00570065006900730065002C002000520065006E006100740065002F004D"\r\n+CPBR: 62,"0813061323",129,"005600E400740074006E006500720062006500720067006200610068006E002F0057"\r\n+CPBR: 63,"41812523207",145,"004400F6007200740065002F0048"\r\n+CPBR: 64,"4181306112'
822Jan 15 11:40:14 debian-gta02 2009.01.15 11:40:14 ogsmd    DEBUG    <MiscChannel via /dev/pts/0>: got 256 bytes from: '0",145,"00430068007200690073002000260020004500640069007400680020004D006100650073002F0048"\r\n+CPBR: 65,"41444221803",145,"004200650061007400650020004B007200690065006700650072002F0048"\r\n+CPBR: 66,"31334619332",145,"004B00610074006A006100200042006F006E00670065'
823Jan 15 11:40:14 debian-gta02 2009.01.15 11:40:14 ogsmd    DEBUG    <MiscChannel via /dev/pts/0>: got 448 bytes from: '00720073002F0048"\r\n+CPBR: 67,"31636174875",145,"004B00610074006A006100200042006F006E0067006500720073002F004D"\r\n+CPBR: 68,"0794483815",129,"005600E400740074006E006500720062006500720067006200610068006E002F004D"\r\n+CPBR: 70,"31622396966",145,"00480065006E00730069006E00670020004A0061006E002F004D"\r\n+CPBR: 71,"0813061246",129,"004A00F60072006700200026002000450064006900740068002000420061006D00650072002F0048"\r\n+CPBR: 72,"41765879946",145,"00420065007400'
824Jan 15 11:40:14 debian-gta02 2009.01.15 11:40:14 ogsmd    DEBUG    <MiscChannel via /dev/pts/0>: got 192 bytes from: '740069006E006100200057006500620065007200200026002000480065002F004D"\r\n+CPBR: 73,"41813061356",145,"005000610072006E00610073007300690061002F0048"\r\n+CPBR: 74,"0813004242",129,"0050006600E40066006'
825Jan 15 11:40:15 debian-gta02 2009.01.15 11:40:15 ogsmd    DEBUG    <MiscChannel via /dev/pts/0>: got 192 bytes from: '500720073002000470065006D00650069006E00640065002F0057"\r\n+CPBR: 75,"31703563563",145,"004B00610074006A006100200042006F006E0067006500720073002F0057"\r\n+CPBR: 76,"41813061372",145,"005000610074007'
826Jan 15 11:40:15 debian-gta02 2009.01.15 11:40:15 ogsmd    DEBUG    <MiscChannel via /dev/pts/0>: got 448 bytes from: '200690063006B0020002600200052006500670075006C006100200053002F0048"\r\n+CPBR: 77,"41817200970",145,"004600650075006500720061006C00610072006D002F0057"\r\n+CPBR: 78,"41813061470",145,"005000610072006E00610073007300690061002F0057"\r\n+CPBR: 79,"41813061404",145,"004B006F00720069006E006E006100200046007200F60068006C006900630068002F0048"\r\n+CPBR: 80,"41449404646",145,"004B006F00720069006E006E006100200046007200F60068006C006900630068002F0057"\r\n+CPBR: 81,"41813'
827Jan 15 11:40:15 debian-gta02 kernel: rxerr: port ch=0x2c, rxs=0x00000001
828Jan 15 11:40:15 debian-gta02 2009.01.15 11:40:15 ogsmd    DEBUG    <MiscChannel via /dev/pts/0>: got 552 bytes from: '061412",145,"00570061006C007400650072002000260020004D00610072006700720069007400680020002F0048"\r\n+CPBR: 82,\x00"41794336783",145,"00570061006C00740065007200200026002000400680020002F004D"\r\n+CPBR: 83,"41813061222",145,"004D00610072006700720069007400200026002000500065007400650072002000470065002F0048"\r\n+CPBR: 84,"41763681418",145,"00440061006E00690065006C0061002000260020005200610069006E0065007200200047002F004D"\r\n+CPBR: 85,"41813226645",145,"00420065007400740069006E006100200057006500620065007200200026002000480065002F0048"\r\n+CPBR: 86,"41774479228",145,"005'
829Jan 15 11:40:15 debian-gta02 2009.01.15 11:40:15 ogsmd    DEBUG    <MiscChannel via /dev/pts/0>: got 240 bytes from: '300740065006600660069002F0048"\r\n+CPBR: 87,"4916095135836",145,"004D00610074007400680065007500730020002600200053007500730061006E006E0065002F004D"\r\n+CPBR: 88,"31610469342",145,"004D006100720063002000440065002000430072006F006D002F004D"\r\n\r\nOK\r\n'
830Jan 15 11:40:15 debian-gta02 2009.01.15 11:40:15 ogsmd    DEBUG    <MiscChannel via /dev/pts/0>: COMPLETED 'AT+CPBS="SM";+CPBR=1,250' => ['+CPBR: 1,"144",129,"004100410020004E006F0074007200750066002000480069006C00660065002000530063002F0057"', '+CPBR: 2,"41622861212",145,"0048006F0074006C0069006E006500200049004E0054002F0048"', '+CPBR: 3,"1144",129,"0043006F006E006E006500630074002F0048"', '+CPBR: 4,"*139#",129,"0053004D005300200043006F006E006E006500630074002F0048"', '+CPBR: 5,"41813026607",145,"0041006E0064007200650061002C0020005000720069007600E9002F0048"', '+CPBR: 6,"41813031891",145,"0041006E0064007200650061002C0020004100720062006500690074002D00480061006E002F0057"', '+CPBR: 7,"41813004270",145,"00460065007500650072006400650070006F00740020005600E40074007400690073002F0057"', '+CPBR: 8,"41800117117",145,"004200610068006E0070006F006C0069007A00650069002F0057"', '+CPBR: 9,"31118650333",145,"004C007500640069002000760064002000560065006E002F0048"', '+CPBR: 10,"49803171077",145,"00570065006900730065002C002000520065006E006100740065002F0048"',
831Jan 15 11:40:15 debian-gta02 2009.01.15 11:40:15 ogsmd    WARNING  Out-of-spec GSM number type seen: 160. Please report.
832Jan 15 11:40:15 debian-gta02 2009.01.15 11:40:15 dbus.service ERROR    Unable to append ([(1, u'AA Notruf Hilfe Sc/W', '144')<<private info deleted>>2035'), (26, u'Mart
833Jan 15 11:40:15 debian-gta02 2009.01.15 11:40:15 ogsmd    ERROR    unhandled exception in response callback: expected string without null bytes Traceback (most recent call last):   File "/var/lib/python-support/python2.5/framework/subsystems/ogsmd/gsm/channel.py", line 383, in handleResponseToRequest     ok_cb( reqstring.strip(), response )   File "/var/lib/python-support/python2.5/framework/subsystems/ogsmd/modems/abstract/mediator.py", line 650, in responseFromChannel     self._ok( result )   File "/var/lib/python-support/python2.5/dbus/service.py", line 663, in <lambda>     keywords[return_callback] = lambda *retval: _method_reply_return(connection, message, method_name, signature, *retval)   File "/var/lib/python-support/python2.5/dbus/service.py", line 252, in _method_reply_return     reply.append(signature=signature, *retval) TypeError: expected string without null bytes
834Jan 15 11:40:15 debian-gta02 2009.01.15 11:40:15 ogsmd    DEBUG    <UnsolicitedResponseChannel via /dev/pts/1>: got 6 bytes from: '\r\nOK\r\n'
835Jan 15 11:40:15 debian-gta02 2009.01.15 11:40:15 ogsmd    DEBUG    <UnsolicitedResponseChannel via /dev/pts/1>: COMPLETED 'AT+CSMS=1' => ['+CSMS: 1,1,1', 'OK']
836Jan 15 11:40:15 debian-gta02 2009.01.15 11:40:15 ogsmd    DEBUG    <MiscChannel via /dev/pts/0> queue is: deque([])
837Jan 15 11:40:15 debian-gta02 2009.01.15 11:40:15 ogsmd    DEBUG    <MiscChannel via /dev/pts/0>: nothing in request queue
838Jan 15 11:40:15 debian-gta02 2009.01.15 11:40:15 ogsmd    DEBUG    <UnsolicitedResponseChannel via /dev/pts/1> queue is: deque([('AT+CNMI=2,1,2,1,1\r\n', None, None, 10)])
839Jan 15 11:40:15 debian-gta02 2009.01.15 11:40:15 ogsmd    DEBUG    <UnsolicitedResponseChannel via /dev/pts/1>: sending 19 bytes: 'AT+CNMI=2,1,2,1,1\r\n'
840Jan 15 11:40:15 debian-gta02 2009.01.15 11:40:15 ogsmd    DEBUG    <UnsolicitedResponseChannel via /dev/pts/1>: got 6 bytes from: '\r\nOK\r\n'
841Jan 15 11:40:15 debian-gta02 2009.01.15 11:40:15 ogsmd    DEBUG    <UnsolicitedResponseChannel via /dev/pts/1>: COMPLETED 'AT+CNMI=2,1,2,1,1' => ['OK']
842Jan 15 11:40:15 debian-gta02 2009.01.15 11:40:15 ogsmd    DEBUG    <UnsolicitedResponseChannel via /dev/pts/1> queue is: deque([])
843Jan 15 11:40:15 debian-gta02 2009.01.15 11:40:15 ogsmd    DEBUG    <UnsolicitedResponseChannel via /dev/pts/1>: nothing in request queue
844Jan 15 11:40:21 debian-gta02 2009.01.15 11:40:21 ogsmd    DEBUG    <MiscChannel via /dev/pts/0> queue is: deque([('AT+CMGL=2\r\n', <bound method SimRetrieveMessagebook.responseFromChannel of <ogsmd.modems.abstract.mediator.SimRetrieveMessagebook object at 0x810f70>>, <bound method SimRetrieveMessagebook.errorFromChannel of <ogsmd.modems.abstract.mediator.SimRetrieveMessagebook object at 0x810f70>>, 10)])
845Jan 15 11:40:21 debian-gta02 2009.01.15 11:40:21 ogsmd    DEBUG    <MiscChannel via /dev/pts/0>: sending 11 bytes: 'AT+CMGL=2\r\n'
846Jan 15 11:40:21 debian-gta02 2009.01.15 11:40:21 ogsmd    DEBUG    <MiscChannel via /dev/pts/0>: got 19 bytes from: '\r\n+CMS ERROR: 321\r\n'
847Jan 15 11:40:21 debian-gta02 2009.01.15 11:40:21 ogsmd    DEBUG    <MiscChannel via /dev/pts/0>: COMPLETED 'AT+CMGL=2' => ['+CMS ERROR: 321']
848Jan 15 11:40:21 debian-gta02 2009.01.15 11:40:21 ogsmd    DEBUG    <MiscChannel via /dev/pts/0> queue is: deque([])
849Jan 15 11:40:21 debian-gta02 2009.01.15 11:40:21 ogsmd    DEBUG    <MiscChannel via /dev/pts/0>: nothing in request queue
850Jan 15 11:40:23 debian-gta02 2009.01.15 11:40:23 odeviced.idlenotifier INFO     odeviced.idlenotifier state change to idle_dim
851Jan 15 11:40:23 debian-gta02 2009.01.15 11:40:23 oeventsd INFO     DebugAction : dbus trigger test
852Jan 15 11:40:23 debian-gta02 2009.01.15 11:40:23 oeventsd INFO     Receive IdleState, status = idle_dim
853Jan 15 11:40:23 debian-gta02 2009.01.15 11:40:23 oeventsd INFO     Receive IdleState, status = idle_dim
854Jan 15 11:40:23 debian-gta02 2009.01.15 11:40:23 oeventsd INFO     call dbus signal /org/freesmartphone/Device/Display/pcf50633_bl SetBrightness((20,))
855Jan 15 11:40:23 debian-gta02 2009.01.15 11:40:23 oeventsd INFO     Receive IdleState, status = idle_dim
856Jan 15 11:40:23 debian-gta02 2009.01.15 11:40:23 oeventsd INFO     signal SetBrightness responded : ()
857Jan 15 11:40:23 debian-gta02 2009.01.15 11:40:23 odeviced.idlenotifier INFO     odeviced.idlenotifier state change to busy
858Jan 15 11:40:23 debian-gta02 2009.01.15 11:40:23 oeventsd INFO     DebugAction : dbus trigger test
859Jan 15 11:40:23 debian-gta02 2009.01.15 11:40:23 oeventsd INFO     Receive IdleState, status = busy
860Jan 15 11:40:23 debian-gta02 2009.01.15 11:40:23 oeventsd INFO     call dbus signal /org/freesmartphone/Device/Display/pcf50633_bl SetBrightness((90,))
861Jan 15 11:40:23 debian-gta02 2009.01.15 11:40:23 oeventsd INFO     Receive IdleState, status = busy
862Jan 15 11:40:23 debian-gta02 2009.01.15 11:40:23 oeventsd INFO     Receive IdleState, status = busy
863Jan 15 11:40:23 debian-gta02 2009.01.15 11:40:23 oeventsd INFO     signal SetBrightness responded : ()
864Jan 15 11:40:34 debian-gta02 2009.01.15 11:40:34 odeviced.idlenotifier INFO     odeviced.idlenotifier state change to idle
865Jan 15 11:40:34 debian-gta02 2009.01.15 11:40:34 oeventsd INFO     DebugAction : dbus trigger test
866Jan 15 11:40:34 debian-gta02 2009.01.15 11:40:34 oeventsd INFO     Receive IdleState, status = idle
867Jan 15 11:40:34 debian-gta02 last message repeated 2 times
868Jan 15 11:40:34 debian-gta02 2009.01.15 11:40:34 odeviced.idlenotifier INFO     odeviced.idlenotifier state change to busy
869Jan 15 11:40:34 debian-gta02 2009.01.15 11:40:34 oeventsd INFO     DebugAction : dbus trigger test
870Jan 15 11:40:34 debian-gta02 2009.01.15 11:40:34 oeventsd INFO     Receive IdleState, status = busy
871Jan 15 11:40:34 debian-gta02 2009.01.15 11:40:34 oeventsd INFO     call dbus signal /org/freesmartphone/Device/Display/pcf50633_bl SetBrightness((90,))
872Jan 15 11:40:34 debian-gta02 2009.01.15 11:40:34 oeventsd INFO     Receive IdleState, status = busy
873Jan 15 11:40:34 debian-gta02 2009.01.15 11:40:34 oeventsd INFO     Receive IdleState, status = busy
874Jan 15 11:40:34 debian-gta02 2009.01.15 11:40:34 oeventsd INFO     signal SetBrightness responded : ()
875Jan 15 11:40:44 debian-gta02 2009.01.15 11:40:44 odeviced.idlenotifier INFO     odeviced.idlenotifier state change to idle
876Jan 15 11:40:44 debian-gta02 2009.01.15 11:40:44 oeventsd INFO     DebugAction : dbus trigger test
877Jan 15 11:40:44 debian-gta02 2009.01.15 11:40:44 oeventsd INFO     Receive IdleState, status = idle
878Jan 15 11:40:44 debian-gta02 last message repeated 2 times
879Jan 15 11:40:50 debian-gta02 dropbear[1306]: Child connection from ::ffff:192.168.0.200:57919
880Jan 15 11:40:55 debian-gta02 dropbear[1306]: password auth succeeded for 'root' from ::ffff:192.168.0.200:57919
881Jan 15 11:41:04 debian-gta02 2009.01.15 11:41:04 odeviced.idlenotifier INFO     odeviced.idlenotifier state change to idle_dim
882Jan 15 11:41:04 debian-gta02 2009.01.15 11:41:04 oeventsd INFO     DebugAction : dbus trigger test
883Jan 15 11:41:04 debian-gta02 2009.01.15 11:41:04 oeventsd INFO     Receive IdleState, status = idle_dim
884Jan 15 11:41:04 debian-gta02 2009.01.15 11:41:04 oeventsd INFO     Receive IdleState, status = idle_dim
885Jan 15 11:41:04 debian-gta02 2009.01.15 11:41:04 oeventsd INFO     call dbus signal /org/freesmartphone/Device/Display/pcf50633_bl SetBrightness((20,))
886Jan 15 11:41:04 debian-gta02 2009.01.15 11:41:04 oeventsd INFO     Receive IdleState, status = idle_dim
887Jan 15 11:41:04 debian-gta02 2009.01.15 11:41:04 oeventsd INFO     signal SetBrightness responded : ()
888Jan 15 11:41:16 debian-gta02 2009.01.15 11:41:16 odeviced.idlenotifier INFO     odeviced.idlenotifier state change to idle_prelock
889Jan 15 11:41:16 debian-gta02 2009.01.15 11:41:16 oeventsd INFO     DebugAction : dbus trigger test
890Jan 15 11:41:16 debian-gta02 2009.01.15 11:41:16 oeventsd INFO     Receive IdleState, status = idle_prelock
891Jan 15 11:41:16 debian-gta02 last message repeated 2 times
892Jan 15 11:41:16 debian-gta02 2009.01.15 11:41:16 oeventsd INFO     call dbus signal /org/freesmartphone/Device/Display/pcf50633_bl SetBrightness((0,))
893Jan 15 11:41:16 debian-gta02 2009.01.15 11:41:16 oeventsd INFO     signal SetBrightness responded : ()
894Jan 15 11:41:18 debian-gta02 2009.01.15 11:41:18 odeviced.idlenotifier INFO     odeviced.idlenotifier state change to lock
895Jan 15 11:41:18 debian-gta02 2009.01.15 11:41:18 oeventsd INFO     DebugAction : dbus trigger test
896Jan 15 11:41:18 debian-gta02 2009.01.15 11:41:18 oeventsd INFO     Receive IdleState, status = lock
897Jan 15 11:41:18 debian-gta02 last message repeated 2 times
898Jan 15 11:41:21 debian-gta02 2009.01.15 11:41:21 ogsmd    DEBUG    (<MiscChannel via /dev/pts/0>: last communication with modem was 59 seconds ago. Sending EOF to wakeup)
899Jan 15 11:41:21 debian-gta02 2009.01.15 11:41:21 ogsmd    DEBUG    <MiscChannel via /dev/pts/0> queue is: deque([('AT+CMGL=2\r\n', <bound method SimRetrieveMessagebook.responseFromChannel of <ogsmd.modems.abstract.mediator.SimRetrieveMessagebook object at 0x81e9d0>>, <bound method SimRetrieveMessagebook.errorFromChannel of <ogsmd.modems.abstract.mediator.SimRetrieveMessagebook object at 0x81e9d0>>, 10)])
900Jan 15 11:41:21 debian-gta02 2009.01.15 11:41:21 ogsmd    DEBUG    <MiscChannel via /dev/pts/0>: sending 11 bytes: 'AT+CMGL=2\r\n'
901Jan 15 11:41:21 debian-gta02 2009.01.15 11:41:21 ogsmd    DEBUG    <MiscChannel via /dev/pts/0>: got 19 bytes from: '\r\n+CMS ERROR: 321\r\n'
902Jan 15 11:41:21 debian-gta02 2009.01.15 11:41:21 ogsmd    DEBUG    <MiscChannel via /dev/pts/0>: COMPLETED 'AT+CMGL=2' => ['+CMS ERROR: 321']
903Jan 15 11:41:21 debian-gta02 2009.01.15 11:41:21 ogsmd    DEBUG    <MiscChannel via /dev/pts/0> queue is: deque([])
904Jan 15 11:41:21 debian-gta02 2009.01.15 11:41:21 ogsmd    DEBUG    <MiscChannel via /dev/pts/0>: nothing in request queue
905Jan 15 11:41:38 debian-gta02 2009.01.15 11:41:38 odeviced.idlenotifier INFO     odeviced.idlenotifier state change to suspend
906Jan 15 11:41:38 debian-gta02 2009.01.15 11:41:38 oeventsd INFO     DebugAction : dbus trigger test
907Jan 15 11:41:38 debian-gta02 2009.01.15 11:41:38 oeventsd INFO     Receive IdleState, status = suspend