root@fic-gta01:~# strace gsm0710muxd
execve("/usr/bin/gsm0710muxd", ["gsm0710muxd"], [/* 12 vars */]) = 0
brk(0)                                  = 0x18000
uname({sys="Linux", node="fic-gta01", ...}) = 0
access("/etc/ld.so.preload", R_OK)      = -1 ENOENT (No such file or directory)
open("/var/run/ld.so.cache", O_RDONLY)  = 3
fstat64(3, {st_mode=S_IFREG|0644, st_size=10275, ...}) = 0
mmap2(NULL, 10275, PROT_READ, MAP_PRIVATE, 3, 0) = 0x4001b000
close(3)                                = 0
open("/usr/lib/libdbus-glib-1.so.2", O_RDONLY) = 3
read(3, "\177ELF\1\1\1\0\0\0\0\0\0\0\0\0\3\0(\0\1\0\0\0\370k\0\000"..., 512) = 512
fstat64(3, {st_mode=S_IFREG|0755, st_size=99456, ...}) = 0
mmap2(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0x4001e000
mmap2(NULL, 131060, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 3, 0) = 0x40025000
mprotect(0x4003d000, 28672, PROT_NONE)  = 0
mmap2(0x40044000, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 3, 0x17) = 0x40044000
close(3)                                = 0
open("/lib/libnsl.so.1", O_RDONLY)      = 3
read(3, "\177ELF\1\1\1\0\0\0\0\0\0\0\0\0\3\0(\0\1\0\0\0\260-\0\000"..., 512) = 512
fstat64(3, {st_mode=S_IFREG|0755, st_size=71508, ...}) = 0
mmap2(NULL, 112188, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 3, 0) = 0x40045000
mprotect(0x40056000, 28672, PROT_NONE)  = 0
mmap2(0x4005d000, 8192, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 3, 0x10) = 0x4005d000
mmap2(0x4005f000, 5692, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_ANONYMOUS, -1, 0) = 0x4005f000
close(3)                                = 0
open("/usr/lib/libdbus-1.so.3", O_RDONLY) = 3
read(3, "\177ELF\1\1\1\0\0\0\0\0\0\0\0\0\3\0(\0\1\0\0\0\314P\0\000"..., 512) = 512
fstat64(3, {st_mode=S_IFREG|0755, st_size=166008, ...}) = 0
mmap2(NULL, 197900, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 3, 0) = 0x40061000
mprotect(0x40088000, 32768, PROT_NONE)  = 0
mmap2(0x40090000, 8192, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 3, 0x27) = 0x40090000
close(3)                                = 0
open("/usr/lib/libgobject-2.0.so.0", O_RDONLY) = 3
read(3, "\177ELF\1\1\1\0\0\0\0\0\0\0\0\0\3\0(\0\1\0\0\0Th\0\000"..., 512) = 512
fstat64(3, {st_mode=S_IFREG|0755, st_size=150956, ...}) = 0
mmap2(NULL, 183712, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 3, 0) = 0x40092000
mprotect(0x400b6000, 32768, PROT_NONE)  = 0
mmap2(0x400be000, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 3, 0x24) = 0x400be000
close(3)                                = 0
open("/usr/lib/libglib-2.0.so.0", O_RDONLY) = 3
read(3, "\177ELF\1\1\1\0\0\0\0\0\0\0\0\0\3\0(\0\1\0\0\0\250\340"..., 512) = 512
fstat64(3, {st_mode=S_IFREG|0755, st_size=609572, ...}) = 0
mmap2(NULL, 641588, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 3, 0) = 0x400bf000
mprotect(0x40154000, 28672, PROT_NONE)  = 0
mmap2(0x4015b000, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 3, 0x94) = 0x4015b000
close(3)                                = 0
open("/lib/libc.so.6", O_RDONLY)        = 3
read(3, "\177ELF\1\1\1\0\0\0\0\0\0\0\0\0\3\0(\0\1\0\0\0\314I\1\000"..., 512) = 512
fstat64(3, {st_mode=S_IFREG|0755, st_size=1119576, ...}) = 0
mmap2(NULL, 1155500, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 3, 0) = 0x4015c000
mprotect(0x40269000, 32768, PROT_NONE)  = 0
mmap2(0x40271000, 12288, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 3, 0x10d) = 0x40271000
mmap2(0x40274000, 8620, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_ANONYMOUS, -1, 0) = 0x40274000
close(3)                                = 0
mmap2(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0x4001f000
open("/lib/libgcc_s.so.1", O_RDONLY)    = 3
read(3, "\177ELF\1\1\1\0\0\0\0\0\0\0\0\0\3\0(\0\1\0\0\0008!\0\000"..., 512) = 512
fstat64(3, {st_mode=S_IFREG|0644, st_size=41996, ...}) = 0
mmap2(NULL, 72204, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 3, 0) = 0x40277000
mprotect(0x40281000, 28672, PROT_NONE)  = 0
mmap2(0x40288000, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 3, 0x9) = 0x40288000
close(3)                                = 0
mmap2(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0x40020000
syscall_983045(0x4001fcb0, 0x4001fcb0, 0x40020408, 0x40020388, 0x40024058, 0, 0x58, 0xf0005, 0xffff4f70, 0x678, 0x40024000, 0xbea1bb4c, 0, 0xbea1b820, 0x40001f98, 0x40001fb0, 0x20000010, 0x4001fcb0, 0xc050, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0) = 0
mprotect(0x40271000, 4096, PROT_READ)   = 0
mprotect(0x40090000, 4096, PROT_READ)   = 0
mprotect(0x4005d000, 4096, PROT_READ)   = 0
munmap(0x4001b000, 10275)               = 0
getpid()                                = 1185
rt_sigaction(SIGHUP, {0xc084, [HUP], SA_RESTART|0x4000000}, {SIG_DFL}, 8) = 0
rt_sigaction(SIGPIPE, {0xc084, [PIPE], SA_RESTART|0x4000000}, {SIG_DFL}, 8) = 0
rt_sigaction(SIGKILL, {0xc084, [KILL], SA_RESTART|0x4000000}, {SIG_DFL}, 8) = -1 EINVAL (Invalid argument)
rt_sigaction(SIGINT, {0xc084, [INT], SA_RESTART|0x4000000}, {SIG_DFL}, 8) = 0
rt_sigaction(SIGUSR1, {0xc084, [USR1], SA_RESTART|0x4000000}, {SIG_DFL}, 8) = 0
rt_sigaction(SIGTERM, {0xc084, [TERM], SA_RESTART|0x4000000}, {SIG_DFL}, 8) = 0
mq_notify(1, ptrace: umoven: Input/output error
{...})                     = 3
fcntl64(3, F_SETFD, FD_CLOEXEC)         = 0
SYS_283(0x3, 0x40274a34, 0x6e, 0, 0x3)  = 0
brk(0)                                  = 0x18000
brk(0x39000)                            = 0x39000
gettimeofday({1204886074, 965764}, NULL) = 0
mq_notify(1, ptrace: umoven: Input/output error
{...})                     = 4
SYS_283(0x4, 0xbea1bac6, 0x21, 0, 0x1f) = 0
fcntl64(4, F_GETFL)                     = 0x2 (flags O_RDWR)
fcntl64(4, F_SETFL, O_RDWR|O_NONBLOCK)  = 0
fcntl64(4, F_GETFD)                     = 0
fcntl64(4, F_SETFD, FD_CLOEXEC)         = 0
geteuid32()                             = 0
rt_sigaction(SIGPIPE, {SIG_IGN}, {0xc084, [PIPE], SA_RESTART|0x4000000}, 8) = 0
poll([{fd=4, events=POLLOUT, revents=POLLOUT}], 1, 0) = 1
write(4, "\0", 1)                       = 1
write(4, "AUTH EXTERNAL 30\r\n", 18)    = 18
poll([{fd=4, events=POLLIN, revents=POLLIN}], 1, -1) = 1
read(4, "OK 20f25f174fd38c1fd0785f9747d11"..., 2048) = 37
poll([{fd=4, events=POLLOUT, revents=POLLOUT}], 1, -1) = 1
write(4, "BEGIN\r\n", 7)                = 7
poll([{fd=4, events=POLLIN|POLLOUT, revents=POLLOUT}], 1, -1) = 1
writev(4, [{"l\1\0\1\0\0\0\0\1\0\0\0n\0\0\0\1\1o\0\25\0\0\0/org/fre"..., 128}, {"", 0}], 2) = 128
gettimeofday({1204886075, 55270}, NULL) = 0
poll([{fd=4, events=POLLIN, revents=POLLIN}], 1, 25000) = 1
read(4, "l\2\1\1\t\0\0\0\1\0\0\0=\0\0\0\6\1s\0\4\0\0\0:1.6\0\0\0"..., 2048) = 258
read(4, 0x1e6b8, 2048)                  = -1 EAGAIN (Resource temporarily unavailable)
fstat64(4, {st_mode=S_IFSOCK|0777, st_size=0, ...}) = 0
fcntl64(4, F_GETFL)                     = 0x802 (flags O_RDWR|O_NONBLOCK)
gettimeofday({1204886075, 77915}, NULL) = 0
writev(4, [{"l\1\0\1\30\0\0\0\2\0\0\0\200\0\0\0\1\1o\0\25\0\0\0/org"..., 144}, {"\16\0\0\0org.mobile.mux\0\0\3\0\0\0", 24}], 2) = 168
gettimeofday({1204886075, 92566}, NULL) = 0
poll([{fd=4, events=POLLIN, revents=POLLIN}], 1, 25000) = 1
read(4, "l\4\1\1\23\0\0\0\3\0\0\0\215\0\0\0\1\1o\0\25\0\0\0/org"..., 2048) = 263
read(4, 0x1e6b8, 2048)                  = -1 EAGAIN (Resource temporarily unavailable)
gettimeofday({1204886075, 112097}, NULL) = 0
open("/usr/share/zoneinfo/UTC", O_RDONLY) = -1 ENOENT (No such file or directory)
writev(2, [{"gsm0710muxd[1185]: gsm0710muxd.c"..., 94}], 1gsm0710muxd[1185]: gsm0710muxd.c:1900:main(): You can quit the daemon with SIGKILL or SIGTERM
) = 94
SYS_289(0x3, 0x20618, 0x73, 0x4000, 0x1a24) = 115
gettimeofday({1204886075, 127757}, NULL) = 0
gettimeofday({1204886075, 129331}, NULL) = 0
writev(2, [{"gsm0710muxd[1185]: gsm0710muxd.c"..., 87}], 1gsm0710muxd[1185]: gsm0710muxd.c:1906:main(): Watchdog started - initilization follows
) = 87
SYS_289(0x3, 0x20618, 0x6c, 0x4000, 0x1a24) = 108
gettimeofday({1204886075, 134938}, NULL) = 0
poll([{fd=4, events=POLLIN}], 1, 0)     = 0
gettimeofday({1204886075, 138090}, NULL) = 0
poll([{fd=4, events=POLLIN}], 1, 0)     = 0
gettimeofday({1204886075, 145439}, NULL) = 0
poll([{fd=4, events=POLLIN}], 1, 4855)  = 0
gettimeofday({1204886080, 7431}, NULL)  = 0
open("/sys/bus/platform/devices/neo1973-pm-gsm.0/power_on", O_RDWR|O_NONBLOCK) = 5
write(5, "0\n", 2)                      = 2
close(5)                                = 0
open("/sys/bus/platform/devices/neo1973-pm-gsm.0/reset", O_RDWR|O_NONBLOCK) = 5
write(5, "0\n", 2)                      = 2
close(5)                                = 0
rt_sigprocmask(SIG_BLOCK, [CHLD], [], 8) = 0
rt_sigaction(SIGCHLD, NULL, {SIG_DFL}, 8) = 0
rt_sigprocmask(SIG_SETMASK, [], NULL, 8) = 0
nanosleep({1, 0}, {1, 0})               = 0
open("/sys/bus/platform/devices/neo1973-pm-gsm.0/power_on", O_RDWR|O_NONBLOCK) = 5
write(5, "1\n", 2)                      = 2
close(5)                                = 0
rt_sigprocmask(SIG_BLOCK, [CHLD], [], 8) = 0
rt_sigaction(SIGCHLD, NULL, {SIG_DFL}, 8) = 0
rt_sigprocmask(SIG_SETMASK, [], NULL, 8) = 0
nanosleep({1, 0}, {1, 0})               = 0
open("/sys/bus/platform/devices/neo1973-pm-gsm.0/reset", O_RDWR|O_NONBLOCK) = 5
write(5, "1\n", 2)                      = 2
close(5)                                = 0
rt_sigprocmask(SIG_BLOCK, [CHLD], [], 8) = 0
rt_sigaction(SIGCHLD, NULL, {SIG_DFL}, 8) = 0
rt_sigprocmask(SIG_SETMASK, [], NULL, 8) = 0
nanosleep({1, 0}, {1, 0})               = 0
open("/sys/bus/platform/devices/neo1973-pm-gsm.0/reset", O_RDWR|O_NONBLOCK) = 5
write(5, "0\n", 2)                      = 2
close(5)                                = 0
rt_sigprocmask(SIG_BLOCK, [CHLD], [], 8) = 0
rt_sigaction(SIGCHLD, NULL, {SIG_DFL}, 8) = 0
rt_sigprocmask(SIG_SETMASK, [], NULL, 8) = 0
nanosleep({1, 0}, {1, 0})               = 0
open("/dev/ttySAC0", O_RDWR|O_NONBLOCK|O_NOCTTY) = 5
gettimeofday({1204886084, 121541}, NULL) = 0
writev(2, [{"gsm0710muxd[1185]: gsm0710muxd.c"..., 79}], 1gsm0710muxd[1185]: gsm0710muxd.c:1625:open_serial_device(): Opened serial port
) = 79
SYS_289(0x3, 0x20d80, 0x64, 0x4000, 0x1a24) = 100
fcntl64(5, F_GETFL)                     = 0x802 (flags O_RDWR|O_NONBLOCK)
fcntl64(5, F_SETFL, O_RDWR)             = 0
ioctl(5, SNDCTL_TMR_TIMEBASE or TCGETS, {B115200 -opost -isig -icanon -echo ...}) = 0
ioctl(5, SNDCTL_TMR_START or TCSETS, {B115200 -opost -isig -icanon -echo ...}) = 0
ioctl(5, TIOCMBIS, [TIOCM_DTR|TIOCM_RTS]) = 0
gettimeofday({1204886084, 142713}, NULL) = 0
writev(2, [{"gsm0710muxd[1185]: gsm0710muxd.c"..., 85}], 1gsm0710muxd[1185]: gsm0710muxd.c:1649:open_serial_device(): Configured serial device
) = 85
SYS_289(0x3, 0x20d80, 0x6a, 0x4000, 0x1a24) = 106
gettimeofday({1204886084, 153508}, NULL) = 0
gettimeofday({1204886084, 157625}, NULL) = 0
writev(2, [{"gsm0710muxd[1185]: gsm0710muxd.c"..., 71}], 1gsm0710muxd[1185]: gsm0710muxd.c:1660:start_muxer(): Configuring modem
) = 71
SYS_289(0x3, 0x20d80, 0x5c, 0x4000, 0x1a24) = 92
write(5, "AT\r\n", 4)                   = 4
ioctl(5, TCSBRK, 0x1)                   = 0
select(6, [5], NULL, NULL, {1, 0})      = 1 (in [5], left {1, 0})
read(5, "A\0T-Command Inter", 1024)     = 17
select(6, [5], NULL, NULL, {1, 0})      = 0 (Timeout)
gettimeofday({1204886085, 177639}, NULL) = 0
writev(2, [{"gsm0710muxd[1185]: gsm0710muxd.c"..., 114}], 1gsm0710muxd[1185]: gsm0710muxd.c:1664:start_muxer(): Modem does not respond to AT commands, trying close mux mode
) = 114
SYS_289(0x3, 0x20d80, 0x87, 0x4000, 0x1a24) = 135
write(5, "~\3\303A~", 5)                = 5
write(5, "~\3\357\303\1p~", 7)          = 7
write(5, "AT\r\n", 4)                   = 4
ioctl(5, TCSBRK, 0x1)                   = 0
select(6, [5], NULL, NULL, {1, 0})      = 1 (in [5], left {1, 0})
read(5, "T", 1024)                      = 1
select(6, [5], NULL, NULL, {1, 0})      = 1 (in [5], left {1, 0})
read(5, "\r\nOK\r\n", 1024)             = 6
write(5, "ATZ\r\n", 5)                  = 5
ioctl(5, TCSBRK, 0x1)                   = 0
select(6, [5], NULL, NULL, {3, 0})      = 1 (in [5], left {2, 995000})
read(5, "ATZ\r", 1024)                  = 4
select(6, [5], NULL, NULL, {2, 995000}) = 1 (in [5], left {2, 995000})
read(5, "\r\nOK\r\n", 1024)             = 6
write(5, "ATE0\r\n", 6)                 = 6
ioctl(5, TCSBRK, 0x1)                   = 0
select(6, [5], NULL, NULL, {1, 0})      = 1 (in [5], left {0, 995000})
read(5, "ATE0\r", 1024)                 = 5
select(6, [5], NULL, NULL, {0, 995000}) = 1 (in [5], left {0, 995000})
read(5, "\r\nOK\r\n", 1024)             = 6
write(5, "AT+CFUN=0\r\n", 11)           = 11
ioctl(5, TCSBRK, 0x1)                   = 0
select(6, [5], NULL, NULL, {10, 0})     = 1 (in [5], left {9, 975000})
read(5, "\r\nOK\r\n", 1024)             = 6
gettimeofday({1204886085, 276129}, NULL) = 0
writev(2, [{"gsm0710muxd[1185]: gsm0710muxd.c"..., 71}], 1gsm0710muxd[1185]: gsm0710muxd.c:1695:start_muxer(): Starting mux mode
) = 71
SYS_289(0x3, 0x20d80, 0x5c, 0x4000, 0x1a24) = 92
write(5, "AT+CMUX=1,0,5,100\r\n", 19)   = 19
ioctl(5, TCSBRK, 0x1)                   = 0
select(6, [5], NULL, NULL, {1, 0})      = 1 (in [5], left {0, 990000})
read(5, "\r\nOK\r\n", 1024)             = 6
gettimeofday({1204886085, 307091}, NULL) = 0
writev(2, [{"gsm0710muxd[1185]: gsm0710muxd.c"..., 74}], 1gsm0710muxd[1185]: gsm0710muxd.c:1698:start_muxer(): Waiting for mux-mode
) = 74
SYS_289(0x3, 0x20d80, 0x5f, 0x4000, 0x1a24) = 95
rt_sigprocmask(SIG_BLOCK, [CHLD], [], 8) = 0
rt_sigaction(SIGCHLD, NULL, {SIG_DFL}, 8) = 0
rt_sigprocmask(SIG_SETMASK, [], NULL, 8) = 0
nanosleep({1, 0}, {1, 0})               = 0
gettimeofday({1204886086, 332692}, NULL) = 0
writev(2, [{"gsm0710muxd[1185]: gsm0710muxd.c"..., 74}], 1gsm0710muxd[1185]: gsm0710muxd.c:1700:start_muxer(): Init control channel
) = 74
SYS_289(0x3, 0x20d80, 0x5f, 0x4000, 0x1a24) = 95
write(5, "~\3?\374~", 5)                = 5
fstat64(5, {st_mode=S_IFCHR|0660, st_rdev=makedev(204, 64), ...}) = 0
fcntl64(5, F_GETFL)                     = 0x2 (flags O_RDWR)
gettimeofday({1204886086, 351751}, NULL) = 0
poll([{fd=4, events=POLLIN}, {fd=5, events=POLLIN, revents=POLLIN}], 2, 0) = 1
read(5, "~\3s\205~", 2048)              = 5
gettimeofday({1204886086, 361726}, NULL) = 0
gettimeofday({1204886086, 363107}, NULL) = 0
poll([{fd=4, events=POLLIN}, {fd=5, events=POLLIN}], 2, 5000) = 0
gettimeofday({1204886091, 367541}, NULL) = 0
gettimeofday({1204886091, 370713}, NULL) = 0
poll([{fd=4, events=POLLIN}, {fd=5, events=POLLIN}], 2, 629) = 0
gettimeofday({1204886092, 475}, NULL)   = 0
gettimeofday({1204886092, 1889}, NULL)  = 0
poll([{fd=4, events=POLLIN}, {fd=5, events=POLLIN}], 2, 4999) = 0
gettimeofday({1204886097, 2865}, NULL)  = 0
gettimeofday({1204886097, 6008}, NULL)  = 0
poll([{fd=4, events=POLLIN}, {fd=5, events=POLLIN}], 2, 4994) = 0
gettimeofday({1204886102, 473}, NULL)   = 0
gettimeofday({1204886102, 1885}, NULL)  = 0
poll([{fd=4, events=POLLIN}, {fd=5, events=POLLIN}], 2, 4999) = 0
gettimeofday({1204886107, 489}, NULL)   = 0
gettimeofday({1204886107, 1791}, NULL)  = 0
poll([{fd=4, events=POLLIN}, {fd=5, events=POLLIN}], 2, 4999) = 0
gettimeofday({1204886112, 465}, NULL)   = 0
gettimeofday({1204886112, 1878}, NULL)  = 0
poll([{fd=4, events=POLLIN}, {fd=5, events=POLLIN}], 2, 4999) = 0
gettimeofday({1204886117, 481}, NULL)   = 0
gettimeofday({1204886117, 1897}, NULL)  = 0
poll([{fd=4, events=POLLIN}, {fd=5, events=POLLIN}], 2, 4999) = 0
gettimeofday({1204886122, 459}, NULL)   = 0
gettimeofday({1204886122, 1873}, NULL)  = 0
poll([{fd=4, events=POLLIN}, {fd=5, events=POLLIN}], 2, 4999) = 0
gettimeofday({1204886127, 469}, NULL)   = 0
gettimeofday({1204886127, 1881}, NULL)  = 0
poll([{fd=4, events=POLLIN}, {fd=5, events=POLLIN}], 2, 4999) = 0
gettimeofday({1204886132, 472}, NULL)   = 0
gettimeofday({1204886132, 1782}, NULL)  = 0
poll([{fd=4, events=POLLIN, revents=POLLIN}, {fd=5, events=POLLIN}], 2, 4999) = 1
gettimeofday({1204886135, 862145}, NULL) = 0
read(4, "l\1\0\1\0\0\0\0\2\0\0\0\205\0\0\0\1\1o\0\34\0\0\0/org/"..., 2048) = 152
read(4, 0x1e6b8, 2048)                  = -1 EAGAIN (Resource temporarily unavailable)
gettimeofday({1204886135, 871721}, NULL) = 0
poll([{fd=5, events=POLLIN}, {fd=4, events=POLLIN}], 2, 0) = 0
writev(4, [{"l\3\1\1c\0\0\0\3\0\0\0W\0\0\0\6\1s\0\4\0\0\0:1.7\0\0\0"..., 104}, {"^\0\0\0Method \"alloc_\" with signatu"..., 99}], 2) = 203
gettimeofday({1204886135, 885626}, NULL) = 0
poll([{fd=5, events=POLLIN}, {fd=4, events=POLLIN}], 2, 1115) = 0
gettimeofday({1204886137, 462}, NULL)   = 0
gettimeofday({1204886137, 1876}, NULL)  = 0
poll([{fd=5, events=POLLIN}, {fd=4, events=POLLIN}], 2, 4999) = 0
gettimeofday({1204886142, 475}, NULL)   = 0
gettimeofday({1204886142, 1886}, NULL)  = 0
poll([{fd=5, events=POLLIN}, {fd=4, events=POLLIN}], 2, 4999) = 0
gettimeofday({1204886147, 3008}, NULL)  = 0
gettimeofday({1204886147, 5641}, NULL)  = 0
poll([{fd=5, events=POLLIN}, {fd=4, events=POLLIN, revents=POLLIN}], 2, 4995) = 1
gettimeofday({1204886148, 145903}, NULL) = 0
read(4, "l\1\0\1\10\0\0\0\2\0\0\0\225\0\0\0\1\1o\0\34\0\0\0/org"..., 2048) = 176
read(4, 0x1e6b8, 2048)                  = -1 EAGAIN (Resource temporarily unavailable)
gettimeofday({1204886148, 156685}, NULL) = 0
poll([{fd=5, events=POLLIN}, {fd=4, events=POLLIN}], 2, 0) = 0
open("/dev/ptmx", O_RDWR|O_NONBLOCK)    = 6
ioctl(6, SNDCTL_TMR_TIMEBASE or TCGETS, {B38400 opost isig icanon echo ...}) = 0
ioctl(6, TIOCGPTN, [3])                 = 0
stat64("/dev/pts/3", {st_mode=S_IFCHR|0620, st_rdev=makedev(136, 3), ...}) = 0
ioctl(6, SNDCTL_TMR_TIMEBASE or TCGETS, {B38400 opost isig icanon echo ...}) = 0
ioctl(6, SNDCTL_TMR_START or TCSETS, {B38400 -opost -isig -icanon -echo ...}) = 0
ioctl(6, SNDCTL_TMR_TIMEBASE or TCGETS, {B38400 -opost -isig -icanon -echo ...}) = 0
ioctl(6, TIOCGPTN, [3])                 = 0
stat64("/dev/pts/3", {st_mode=S_IFCHR|0620, st_rdev=makedev(136, 3), ...}) = 0
statfs("/dev/pts/3", {f_type="DEVPTS_SUPER_MAGIC", f_bsize=4096, f_blocks=0, f_bfree=0, f_bavail=0, f_files=0, f_ffree=0, f_fsid={0, 0}, f_namelen=255, f_frsize=4096}) = 0
ioctl(6, TIOCSPTLCK, [0])               = 0
fstat64(6, {st_mode=S_IFCHR|0666, st_rdev=makedev(5, 2), ...}) = 0
fcntl64(6, F_GETFL)                     = 0x802 (flags O_RDWR|O_NONBLOCK)
write(5, "~\7?\211~", 5)                = 5
gettimeofday({1204886148, 208056}, NULL) = 0
writev(2, [{"gsm0710muxd[1185]: gsm0710muxd.c"..., 123}], 1gsm0710muxd[1185]: gsm0710muxd.c:580:c_alloc_channel(): Connecting /dev/pts/3 to virtual channel 1 for foo on /dev/ttySAC0
) = 123
SYS_289(0x3, 0x21888, 0x90, 0x4000, 0x1a24) = 144
writev(4, [{"l\2\1\1\17\0\0\0\4\0\0\0\37\0\0\0\6\1s\0\4\0\0\0:1.8\0"..., 48}, {"\n\0\0\0/dev/pts/3\0", 15}], 2) = 63
gettimeofday({1204886148, 227791}, NULL) = 0
poll([{fd=5, events=POLLIN}, {fd=4, events=POLLIN}, {fd=6, events=POLLIN}], 3, 3773) = 0
gettimeofday({1204886152, 5603}, NULL)  = 0
gettimeofday({1204886152, 7014}, NULL)  = 0
poll([{fd=5, events=POLLIN}, {fd=4, events=POLLIN}, {fd=6, events=POLLIN}], 3, 4993) = 0
gettimeofday({1204886157, 3071}, NULL)  = 0
gettimeofday({1204886157, 7188}, NULL)  = 0
poll([{fd=5, events=POLLIN}, {fd=4, events=POLLIN}, {fd=6, events=POLLIN, revents=POLLIN}], 3, 4993) = 1
gettimeofday({1204886158, 301260}, NULL) = 0
read(6, "a", 4096)                      = 1
write(5, "~\7\357a\5~", 6)              = 6
gettimeofday({1204886158, 313767}, NULL) = 0
poll([{fd=5, events=POLLIN}, {fd=4, events=POLLIN}, {fd=6, events=POLLIN, revents=POLLIN}], 3, 3687) = 1
gettimeofday({1204886158, 589013}, NULL) = 0
read(6, "t", 4096)                      = 1
write(5, "~\7\357t\5~", 6)              = 6
gettimeofday({1204886158, 601216}, NULL) = 0
poll([{fd=5, events=POLLIN, revents=POLLIN}, {fd=4, events=POLLIN}, {fd=6, events=POLLIN}], 3, 3399) = 1
gettimeofday({1204886158, 609878}, NULL) = 0
read(5, "~\7\17\255~", 2048)            = 5
gettimeofday({1204886158, 618001}, NULL) = 0
writev(2, [{"gsm0710muxd[1185]: gsm0710muxd.c"..., 101}], 1gsm0710muxd[1185]: gsm0710muxd.c:1405:extract_frames(): Logical channel 1 for foo couldn't be opened
) = 101
SYS_289(0x3, 0x218c0, 0x7a, 0x4000, 0x1a24) = 122
gettimeofday({1204886158, 631038}, NULL) = 0
gettimeofday({1204886158, 635061}, NULL) = 0
poll([{fd=4, events=POLLIN}, {fd=6, events=POLLIN, revents=POLLIN}, {fd=5, events=POLLIN}], 3, 3365) = 1
gettimeofday({1204886158, 868947}, NULL) = 0
read(6, "\r", 4096)                     = 1
write(5, "~\7\357\r\5~", 6)             = 6
gettimeofday({1204886158, 880996}, NULL) = 0
poll([{fd=4, events=POLLIN}, {fd=5, events=POLLIN, revents=POLLIN}, {fd=6, events=POLLIN}], 3, 3120) = 1
gettimeofday({1204886158, 891922}, NULL) = 0
read(5, "~\7\17\255~", 2048)            = 5
gettimeofday({1204886158, 900124}, NULL) = 0
writev(2, [{"gsm0710muxd[1185]: gsm0710muxd.c"..., 101}], 1gsm0710muxd[1185]: gsm0710muxd.c:1405:extract_frames(): Logical channel 1 for foo couldn't be opened
) = 101
SYS_289(0x3, 0x21888, 0x7a, 0x4000, 0x1a24) = 122
gettimeofday({1204886158, 914725}, NULL) = 0
gettimeofday({1204886158, 917277}, NULL) = 0
poll([{fd=4, events=POLLIN}, {fd=6, events=POLLIN}, {fd=5, events=POLLIN}], 3, 3083) = 0
gettimeofday({1204886162, 7867}, NULL)  = 0
gettimeofday({1204886162, 11344}, NULL) = 0