Odhiambo WASHINGTON
2007-Jun-03 18:20 UTC
[Dovecot] Dovecot Authentication Problem - Help pls!
Hello List,
This is dovecot 1.0.0 on FreeBSD 4.11-STABLE. I did not provide this
information before:-)
I am back again and I think I am edging closer to getting a solution.
I have done some modifications and now dovecot gives me a different
error message than before....
Here is what I have for the password_query and user_query
password_query = SELECT popbox.cleartext AS password FROM popbox, domain \
WHERE popbox.local_part = 'eddie' AND popbox.domain_name =
'demo.wananchi.com' \
AND popbox.domain_name = domain.domain_name;
+----------+
| password |
+----------+
| boeing8 |
+----------+
user_query = SELECT CONCAT(domain.path, '/', popbox.mbox_name) as home,
\
69 as uid, 6 as gid FROM popbox, domain WHERE popbox.local_part =
'eddie' \
AND popbox.domain_name = 'demo.wananchi.com' AND \
popbox.domain_name = domain.domain_name;
+--------------------------------------------+-----+-----+
| home | uid | gid |
+--------------------------------------------+-----+-----+
| /var/spool/virtual/demo.wananchi.com/eddie | 69 | 6 |
+--------------------------------------------+-----+-----+
When I test to connect to the pop3 daemon, this is what happens now:
root at ns2]#telnet 0 7173
Trying 0.0.0.0...
Connected to 0.
Escape character is '^]'.
+OK Welcome. Dovecot is Ready to serve your emails.
user eddie at demo.wananchi.com
+OK
pass boeing8
-ERR [IN-USE] Internal login failure. Refer to server log for more information.
Connection closed by foreign host.
...and this is what dovecot writes to the log:
[root at ns2]#less /var/log/dovecot.log
dovecot: May 30 12:00:04 Info: auth(default): client in: AUTH 1 PLAIN
service=POP3 secured lip=62.8.64.4 rip=62.8.64.4
resp=AGVkZGllQGRlbW8ud2FuYW5jaGkuY29tAGJvZWluZzgdovecot: May 30 12:00:04 Info:
auth-worker(default): mysql: Connected to localhost (virtualemail)
dovecot: May 30 12:00:04 Info: auth-worker(default): sql(eddie at
demo.wananchi.com,62.8.64.4): query: SELECT popbox.cleartext AS password FROM
popbox, domain WHERE popbox.local_part = 'eddie' AND popbox.domain_name
= 'demo.wananchi.com' AND popbox.domain_name = domain.domain_name
dovecot: May 30 12:00:04 Info: auth(default): client out: OK 1
user=eddie at demo.wananchi.com
dovecot: May 30 12:00:04 Info: auth(default): master in: REQUEST 2
36772 1
dovecot: May 30 12:00:04 Info: auth-worker(default): sql(eddie at
demo.wananchi.com,62.8.64.4): SELECT CONCAT(domain.path, '/',
popbox.mbox_name) as home, 69 as uid, 6 as gid FROM popbox, domain WHERE
popbox.local_part = 'eddie' AND popbox.domain_name =
'demo.wananchi.com' AND popbox.domain_name = domain.domain_name
dovecot: May 30 12:00:05 Error: child 39853 (auth-worker) killed with signal 11
dovecot: May 30 12:00:05 Info: auth(default): master out: FAIL 2
dovecot: May 30 12:00:05 Info: pop3-login: Internal login failure:
user=<eddie at demo.wananchi.com>, method=PLAIN, rip=62.8.64.4,
lip=62.8.64.4, secured
User's mail is stored in /var/spool/virtual/$domain/$user/{new,cur,tmp}
The path /var/spool/virtual/ is owned by uid:gid 69:6, and is writeable
by that uid.
dovecot -n:
# /usr/local/etc/dovecot.conf
base_dir: /var/run/dovecot/
log_path: /var/log/dovecot.log
protocols: imap pop3
listen(default): *:7143
listen(imap): *:7143
listen(pop3): *:7110
ssl_disable: yes
disable_plaintext_auth: no
shutdown_clients: no
login_dir: /var/run/dovecot/login
login_executable(default): /usr/local/libexec/dovecot/imap-login
login_executable(imap): /usr/local/libexec/dovecot/imap-login
login_executable(pop3): /usr/local/libexec/dovecot/pop3-login
login_user: exim
login_greeting: Welcome. Dovecot is Ready to serve your emails.
login_process_size: 64
login_max_processes_count: 200
verbose_proctitle: yes
first_valid_uid: 69
first_valid_gid: 0
mail_extra_groups: dovecot:mail
mail_location: maildir:/var/spool/virtual/%d/%n
mail_executable(default): /usr/local/libexec/dovecot/imap
mail_executable(imap): /usr/local/libexec/dovecot/imap
mail_executable(pop3): /usr/local/libexec/dovecot/pop3
mail_plugin_dir(default): /usr/local/lib/dovecot/imap
mail_plugin_dir(imap): /usr/local/lib/dovecot/imap
mail_plugin_dir(pop3): /usr/local/lib/dovecot/pop3
imap_client_workarounds(default): delay-newmail outlook-idle netscape-eoh
tb-extra-mailbox-sep
imap_client_workarounds(imap): delay-newmail outlook-idle netscape-eoh
tb-extra-mailbox-sep
imap_client_workarounds(pop3): outlook-idle
pop3_uidl_format(default):
pop3_uidl_format(imap):
pop3_uidl_format(pop3): %08Xu%08Xv
pop3_client_workarounds(default):
pop3_client_workarounds(imap):
pop3_client_workarounds(pop3): outlook-no-nuls oe-ns-eoh
auth default:
mechanisms: plain login digest-md5 cram-md5
verbose: yes
debug_passwords: yes
passdb:
driver: sql
args: /usr/local/etc/dovecot-sql.conf
userdb:
driver: sql
args: /usr/local/etc/dovecot-sql.conf
socket:
type: listen
client:
path: /var/run/dovecot/auth-client
mode: 432
master:
path: /var/run/dovecot/auth-master
mode: 384
user: root
group: wheel
Here is a backtrace of the dovecot-auth crash:
[root at ns2]#gdb /usr/local/libexec/dovecot/dovecot-auth dovecot-auth.core
GNU gdb 4.18 (FreeBSD)
Copyright 1998 Free Software Foundation, Inc.
GDB is free software, covered by the GNU General Public License, and you are
welcome to change it and/or distribute copies of it under certain conditions.
Type "show copying" to see the conditions.
There is absolutely no warranty for GDB. Type "show warranty" for
details.
This GDB was configured as "i386-unknown-freebsd"...(no debugging
symbols found)...
Core was generated by `dovecot-auth'.
Program terminated with signal 11, Segmentation fault.
Reading symbols from /usr/lib/libcrypt.so.2...(no debugging symbols
found)...done.
Reading symbols from /usr/lib/libpam.so.1...(no debugging symbols found)...done.
Reading symbols from /usr/local/lib/compat/pkg/libmysqlclient.so.10...(no
debugging symbols found)...done.
Reading symbols from /usr/lib/libm.so.2...(no debugging symbols found)...done.
Reading symbols from /usr/local/lib/libsqlite3.so.8...(no debugging symbols
found)...done.
Reading symbols from /usr/lib/libc.so.4...(no debugging symbols found)...done.
Reading symbols from /usr/lib/libz.so.2...(no debugging symbols found)...done.
Reading symbols from /usr/libexec/ld-elf.so.1...(no debugging symbols
found)...done.
#0 0x805dc00 in userdb_blocking_lookup ()
(gdb) bt
#0 0x805dc00 in userdb_blocking_lookup ()
#1 0x805dd50 in userdb_blocking_lookup ()
#2 0x806175a in sql_drivers_register_all ()
#3 0x8060d1c in sql_query ()
#4 0x805de62 in userdb_blocking_lookup ()
#5 0x8055724 in auth_stream_is_empty ()
#6 0x80557f4 in auth_stream_is_empty ()
#7 0x8055894 in auth_stream_is_empty ()
#8 0x80668ac in io_loop_handler_run ()
#9 0x80662a1 in io_loop_run ()
#10 0x805770f in main ()
#11 0x804fd52 in _start ()
(gdb)
Please help!
-Wash
http://www.netmeister.org/news/learn2quote.html
DISCLAIMER: See http://www.wananchi.com/bms/terms.php
--
+======================================================================+
|\ _,,,---,,_ | Odhiambo Washington <wash at wananchi.com>
Zzz /,`.-'`' -. ;-;;,_ | Wananchi Online Ltd. www.wananchi.com
|,4- ) )-,_. ,\ ( `'-'| Tel: +254 20 313985-9 +254 20 313922
'---''(_/--' `-'\_) | GSM: +254 722 743223 +254 733
744121
+======================================================================+
Hindsight is an exact science.
On Sun, 2007-06-03 at 21:20 +0300, Odhiambo WASHINGTON wrote:> Here is a backtrace of the dovecot-auth crash:Two problems with it:> #0 0x805dc00 in userdb_blocking_lookup ()Debugging symbols were stripped. Could you try building it without removing them, at least from dovecot-auth binary? I guess "make install" does the stripping, so maybe copying the file manually would preserve it. You can anyway check this with "file dovecot-auth" to see if it says "stripped" or "not stripped".> (gdb) bt > #0 0x805dc00 in userdb_blocking_lookup () > #1 0x805dd50 in userdb_blocking_lookup () > #2 0x806175a in sql_drivers_register_all () > #3 0x8060d1c in sql_query () > #4 0x805de62 in userdb_blocking_lookup () > #5 0x8055724 in auth_stream_is_empty () > #6 0x80557f4 in auth_stream_is_empty () > #7 0x8055894 in auth_stream_is_empty () > #8 0x80668ac in io_loop_handler_run () > #9 0x80662a1 in io_loop_run () > #10 0x805770f in main () > #11 0x804fd52 in _start ()Also this backtrace is corrupted for some reason. One (pretty) sure way to get a non-corrupted backtrace is to attach gdb to dovecot-auth while it's still running: gdb attach <pid of dovecot-auth -w process> cont <wait for crash> bt full -------------- next part -------------- A non-text attachment was scrubbed... Name: signature.asc Type: application/pgp-signature Size: 189 bytes Desc: This is a digitally signed message part URL: <http://dovecot.org/pipermail/dovecot/attachments/20070604/4c6dd5af/attachment-0002.bin>
Odhiambo WASHINGTON
2007-Jun-04 06:02 UTC
[Dovecot] Dovecot Authentication Problem - Help pls!
* On 04/06/07 02:59 +0300, Timo Sirainen wrote:
| On Sun, 2007-06-03 at 21:20 +0300, Odhiambo WASHINGTON wrote:
| > Here is a backtrace of the dovecot-auth crash:
|
| Two problems with it:
|
| > #0 0x805dc00 in userdb_blocking_lookup ()
|
| Debugging symbols were stripped. Could you try building it without
| removing them, at least from dovecot-auth binary? I guess "make
install"
| does the stripping, so maybe copying the file manually would preserve
| it. You can anyway check this with "file dovecot-auth" to see if it
says
| "stripped" or "not stripped".
|
| > (gdb) bt
| > #0 0x805dc00 in userdb_blocking_lookup ()
| > #1 0x805dd50 in userdb_blocking_lookup ()
| > #2 0x806175a in sql_drivers_register_all ()
| > #3 0x8060d1c in sql_query ()
| > #4 0x805de62 in userdb_blocking_lookup ()
| > #5 0x8055724 in auth_stream_is_empty ()
| > #6 0x80557f4 in auth_stream_is_empty ()
| > #7 0x8055894 in auth_stream_is_empty ()
| > #8 0x80668ac in io_loop_handler_run ()
| > #9 0x80662a1 in io_loop_run ()
| > #10 0x805770f in main ()
| > #11 0x804fd52 in _start ()
|
| Also this backtrace is corrupted for some reason. One (pretty) sure way
| to get a non-corrupted backtrace is to attach gdb to dovecot-auth while
| it's still running:
|
| gdb attach <pid of dovecot-auth -w process>
| cont
| <wait for crash>
| bt full
Hi Timo,
You were right. `make install` did strip it.
file `locate dovecot-auth`
/usr/local/libexec/dovecot/dovecot-auth: ELF 32-bit LSB executable, \
Intel 80386, version 1 (FreeBSD), for FreeBSD 4.9.2, dynamically linked \
(uses shared libs), stripped
I have built and manually copied dovecot-auth to the install destination
and now it id not stripped. Now this is the result of the debug:
[root at ns2]#gdb /usr/local/libexec/dovecot/dovecot-auth
/var/run/dovecot/dovecot-auth.core
GNU gdb 4.18 (FreeBSD)
Copyright 1998 Free Software Foundation, Inc.
GDB is free software, covered by the GNU General Public License, and you are
welcome to change it and/or distribute copies of it under certain conditions.
Type "show copying" to see the conditions.
There is absolutely no warranty for GDB. Type "show warranty" for
details.
This GDB was configured as "i386-unknown-freebsd"...(no debugging
symbols found)...
Core was generated by `dovecot-auth'.
Program terminated with signal 11, Segmentation fault.
Reading symbols from /usr/lib/libcrypt.so.2...(no debugging symbols
found)...done.
Reading symbols from /usr/lib/libpam.so.1...(no debugging symbols found)...done.
Reading symbols from /usr/local/lib/compat/pkg/libmysqlclient.so.10...(no
debugging symbols found)...done.
Reading symbols from /usr/lib/libm.so.2...(no debugging symbols found)...done.
Reading symbols from /usr/lib/libc.so.4...(no debugging symbols found)...done.
Reading symbols from /usr/lib/libz.so.2...(no debugging symbols found)...done.
Reading symbols from /usr/libexec/ld-elf.so.1...(no debugging symbols
found)...done.
#0 0x805d848 in sql_query_get_result ()
(gdb) bt
#0 0x805d848 in sql_query_get_result ()
#1 0x805d998 in sql_query_callback ()
#2 0x8061396 in driver_mysql_query ()
#3 0x8060964 in sql_query ()
#4 0x805daaa in userdb_sql_lookup ()
#5 0x805536c in auth_worker_handle_user ()
#6 0x805543c in auth_worker_handle_line ()
#7 0x80554dc in auth_worker_input ()
#8 0x8065e34 in io_loop_handler_run ()
#9 0x8065829 in io_loop_run ()
#10 0x8057357 in main ()
#11 0x804f99a in _start ()
(gdb)
BTW, I don't understand all that stuff:-)
While trying the other method you have detailed, I just don't seem to get it
right:
[root at ns2]#ps ax | grep dove
11446 ?? Ss 0:00.04 /usr/local/sbin/dovecot
11447 ?? S 0:00.02 dovecot-auth
17279 p2 RV 0:00.00 grep dove (csh)
[root at ns2]#gdb attach 11447 -w process
Excess command line arguments ignored. (process)
GNU gdb 4.18 (FreeBSD)
Copyright 1998 Free Software Foundation, Inc.
GDB is free software, covered by the GNU General Public License, and you are
welcome to change it and/or distribute copies of it under certain conditions.
Type "show copying" to see the conditions.
There is absolutely no warranty for GDB. Type "show warranty" for
details.
This GDB was configured as "i386-unknown-freebsd"...
attach: No such file or directory.
/var/run/dovecot/11447: No such file or directory.
Attaching to process 11447
0x2812bc50 in ?? ()
(gdb)
Why does it say "attach: No such file or directory"?
(gdb) quit
The program is running. Quit anyway (and detach it)? (y or n) n
Not confirmed.
(gdb) cont
Continuing.
After that, I connect to either the pop3/imap and try to authenticate, upon
which I get the error I have been getting, but when I tell gdb 'bt
full', then
nothing happens...
I could be mising another point along the way, even after reading
the man page of gdb on this FreeBSD box.
-Wash
http://www.netmeister.org/news/learn2quote.html
DISCLAIMER: See http://www.wananchi.com/bms/terms.php
--
+======================================================================+
|\ _,,,---,,_ | Odhiambo Washington <wash at wananchi.com>
Zzz /,`.-'`' -. ;-;;,_ | Wananchi Online Ltd. www.wananchi.com
|,4- ) )-,_. ,\ ( `'-'| Tel: +254 20 313985-9 +254 20 313922
'---''(_/--' `-'\_) | GSM: +254 722 743223 +254 733
744121
+======================================================================+
Finding out what goes on in the C.I.A. is like performing acupuncture
on a rock.
-- New York Times, Jan. 20, 1981
Odhiambo WASHINGTON
2007-Jun-04 07:06 UTC
[Dovecot] Dovecot Authentication Problem - Help pls!
* On 04/06/07 02:59 +0300, Timo Sirainen wrote:
| On Sun, 2007-06-03 at 21:20 +0300, Odhiambo WASHINGTON wrote:
| > Here is a backtrace of the dovecot-auth crash:
|
| Two problems with it:
|
| > #0 0x805dc00 in userdb_blocking_lookup ()
|
| Debugging symbols were stripped. Could you try building it without
| removing them, at least from dovecot-auth binary? I guess "make
install"
| does the stripping, so maybe copying the file manually would preserve
| it. You can anyway check this with "file dovecot-auth" to see if it
says
| "stripped" or "not stripped".
|
| > (gdb) bt
| > #0 0x805dc00 in userdb_blocking_lookup ()
| > #1 0x805dd50 in userdb_blocking_lookup ()
| > #2 0x806175a in sql_drivers_register_all ()
| > #3 0x8060d1c in sql_query ()
| > #4 0x805de62 in userdb_blocking_lookup ()
| > #5 0x8055724 in auth_stream_is_empty ()
| > #6 0x80557f4 in auth_stream_is_empty ()
| > #7 0x8055894 in auth_stream_is_empty ()
| > #8 0x80668ac in io_loop_handler_run ()
| > #9 0x80662a1 in io_loop_run ()
| > #10 0x805770f in main ()
| > #11 0x804fd52 in _start ()
|
| Also this backtrace is corrupted for some reason. One (pretty) sure way
| to get a non-corrupted backtrace is to attach gdb to dovecot-auth while
| it's still running:
|
| gdb attach <pid of dovecot-auth -w process>
| cont
| <wait for crash>
| bt full
How about a ktrace of the process? This is what I have obtained:
11447 dovecot-auth 1180940592.819025 RET poll 0
11447 dovecot-auth 1180940592.819090 CALL gettimeofday(0x8080f3c,0x8080f44)
11447 dovecot-auth 1180940592.819100 RET gettimeofday 0
11447 dovecot-auth 1180940592.819110 CALL gettimeofday(0xbfbff988,0)
11447 dovecot-auth 1180940592.819119 RET gettimeofday 0
11447 dovecot-auth 1180940592.819125 CALL poll(0x808d000,0xb,0x7d0)
11447 dovecot-auth 1180940594.831510 RET poll 0
11447 dovecot-auth 1180940594.831527 CALL gettimeofday(0x8080f3c,0x8080f44)
11447 dovecot-auth 1180940594.831537 RET gettimeofday 0
11447 dovecot-auth 1180940594.831547 CALL gettimeofday(0xbfbff988,0)
11447 dovecot-auth 1180940594.831555 RET gettimeofday 0
11447 dovecot-auth 1180940594.831562 CALL poll(0x808d000,0xb,0x3cd)
11447 dovecot-auth 1180940595.805384 RET poll 0
11447 dovecot-auth 1180940595.805403 CALL gettimeofday(0x8080f3c,0x8080f44)
11447 dovecot-auth 1180940595.805412 RET gettimeofday 0
11447 dovecot-auth 1180940595.805435 CALL gettimeofday(0xbfbff988,0)
11447 dovecot-auth 1180940595.805444 RET gettimeofday 0
11447 dovecot-auth 1180940595.805450 CALL poll(0x808d000,0xb,0x402)
11447 dovecot-auth 1180940596.832265 RET poll 0
11447 dovecot-auth 1180940596.832286 CALL gettimeofday(0x8080f3c,0x8080f44)
11447 dovecot-auth 1180940596.832295 RET gettimeofday 0
11447 dovecot-auth 1180940596.832305 CALL gettimeofday(0xbfbff988,0)
11447 dovecot-auth 1180940596.832314 RET gettimeofday 0
11447 dovecot-auth 1180940596.832319 CALL poll(0x808d000,0xb,0x7d0)
11447 dovecot-auth 1180940598.833031 RET poll 0
11447 dovecot-auth 1180940598.833048 CALL gettimeofday(0x8080f3c,0x8080f44)
11447 dovecot-auth 1180940598.833057 RET gettimeofday 0
11447 dovecot-auth 1180940598.833067 CALL gettimeofday(0xbfbff988,0)
11447 dovecot-auth 1180940598.833075 RET gettimeofday 0
11447 dovecot-auth 1180940598.833082 CALL poll(0x808d000,0xb,0x7b4)
11447 dovecot-auth 1180940600.805923 RET poll 0
11447 dovecot-auth 1180940600.805936 CALL gettimeofday(0x8080f3c,0x8080f44)
11447 dovecot-auth 1180940600.805945 RET gettimeofday 0
11447 dovecot-auth 1180940600.805968 CALL gettimeofday(0xbfbff988,0)
11447 dovecot-auth 1180940600.805977 RET gettimeofday 0
11447 dovecot-auth 1180940600.805983 CALL poll(0x808d000,0xb,0x1c)
11447 dovecot-auth 1180940600.834805 RET poll 0
11447 dovecot-auth 1180940600.834864 CALL gettimeofday(0x8080f3c,0x8080f44)
11447 dovecot-auth 1180940600.834874 RET gettimeofday 0
11447 dovecot-auth 1180940600.834884 CALL gettimeofday(0xbfbff988,0)
11447 dovecot-auth 1180940600.834893 RET gettimeofday 0
11447 dovecot-auth 1180940600.834900 CALL poll(0x808d000,0xb,0x7d0)
11447 dovecot-auth 1180940602.835552 RET poll 0
11447 dovecot-auth 1180940602.835568 CALL gettimeofday(0x8080f3c,0x8080f44)
11447 dovecot-auth 1180940602.835577 RET gettimeofday 0
11447 dovecot-auth 1180940602.835586 CALL gettimeofday(0xbfbff988,0)
11447 dovecot-auth 1180940602.835595 RET gettimeofday 0
11447 dovecot-auth 1180940602.835600 CALL poll(0x808d000,0xb,0x7d0)
11447 dovecot-auth 1180940604.836309 RET poll 0
11447 dovecot-auth 1180940604.836323 CALL gettimeofday(0x8080f3c,0x8080f44)
11447 dovecot-auth 1180940604.836332 RET gettimeofday 0
11447 dovecot-auth 1180940604.836342 CALL gettimeofday(0xbfbff988,0)
11447 dovecot-auth 1180940604.836351 RET gettimeofday 0
11447 dovecot-auth 1180940604.836357 CALL poll(0x808d000,0xb,0x3c9)
11447 dovecot-auth 1180940605.806192 RET poll 0
11447 dovecot-auth 1180940605.806211 CALL gettimeofday(0x8080f3c,0x8080f44)
11447 dovecot-auth 1180940605.806220 RET gettimeofday 0
11447 dovecot-auth 1180940605.806243 CALL gettimeofday(0xbfbff988,0)
11447 dovecot-auth 1180940605.806251 RET gettimeofday 0
11447 dovecot-auth 1180940605.806258 CALL poll(0x808d000,0xb,0x406)
11447 dovecot-auth 1180940606.844701 RET poll 0
11447 dovecot-auth 1180940606.844714 CALL gettimeofday(0x8080f3c,0x8080f44)
11447 dovecot-auth 1180940606.844723 RET gettimeofday 0
11447 dovecot-auth 1180940606.844733 CALL gettimeofday(0xbfbff988,0)
11447 dovecot-auth 1180940606.844742 RET gettimeofday 0
11447 dovecot-auth 1180940606.844749 CALL poll(0x808d000,0xb,0x7d0)
11447 dovecot-auth 1180940608.846133 RET poll 0
11447 dovecot-auth 1180940608.846146 CALL gettimeofday(0x8080f3c,0x8080f44)
11447 dovecot-auth 1180940608.846155 RET gettimeofday 0
11447 dovecot-auth 1180940608.846165 CALL gettimeofday(0xbfbff988,0)
11447 dovecot-auth 1180940608.846173 RET gettimeofday 0
11447 dovecot-auth 1180940608.846180 CALL poll(0x808d000,0xb,0x7a8)
11447 dovecot-auth 1180940610.815952 RET poll 0
11447 dovecot-auth 1180940610.815988 CALL gettimeofday(0x8080f3c,0x8080f44)
11447 dovecot-auth 1180940610.815998 RET gettimeofday 0
11447 dovecot-auth 1180940610.816019 CALL gettimeofday(0xbfbff988,0)
11447 dovecot-auth 1180940610.816028 RET gettimeofday 0
11447 dovecot-auth 1180940610.816034 CALL poll(0x808d000,0xb,0x1e)
11447 dovecot-auth 1180940610.846755 RET poll 0
11447 dovecot-auth 1180940610.846777 CALL gettimeofday(0x8080f3c,0x8080f44)
11447 dovecot-auth 1180940610.846786 RET gettimeofday 0
11447 dovecot-auth 1180940610.846796 CALL gettimeofday(0xbfbff988,0)
11447 dovecot-auth 1180940610.846805 RET gettimeofday 0
11447 dovecot-auth 1180940610.846811 CALL poll(0x808d000,0xb,0x7d0)
11447 dovecot-auth 1180940612.863115 RET poll 0
11447 dovecot-auth 1180940612.863134 CALL gettimeofday(0x8080f3c,0x8080f44)
11447 dovecot-auth 1180940612.863144 RET gettimeofday 0
11447 dovecot-auth 1180940612.863153 CALL gettimeofday(0xbfbff988,0)
11447 dovecot-auth 1180940612.863162 RET gettimeofday 0
11447 dovecot-auth 1180940612.863168 CALL poll(0x808d000,0xb,0x7d0)
11447 dovecot-auth 1180940612.910073 RET poll 1
11447 dovecot-auth 1180940612.910092 CALL gettimeofday(0x8080f3c,0x8080f44)
11447 dovecot-auth 1180940612.910101 RET gettimeofday 0
11447 dovecot-auth 1180940612.910112 CALL accept(0x3,0xbfbff904,0xbfbff900)
11447 dovecot-auth 1180940612.910121 RET accept 9
11447 dovecot-auth 1180940612.910127 CALL fcntl(0x9,0x3,0)
11447 dovecot-auth 1180940612.910132 RET fcntl 6
11447 dovecot-auth 1180940612.910138 CALL fcntl(0x9,0x4,0x6)
11447 dovecot-auth 1180940612.910142 RET fcntl 0
11447 dovecot-auth 1180940612.910155 CALL fstat(0x9,0xbfbff870)
11447 dovecot-auth 1180940612.910162 RET fstat 0
11447 dovecot-auth 1180940612.910172 CALL lseek(0x9,0,0,0,0x1)
11447 dovecot-auth 1180940612.910178 RET lseek -1 errno 29 Illegal seek
11447 dovecot-auth 1180940612.910186 CALL
getsockname(0x9,0xbfbff834,0xbfbff830)
11447 dovecot-auth 1180940612.910192 RET getsockname 0
11447 dovecot-auth 1180940612.910214 CALL writev(0x9,0xbfbff910,0x2)
11447 dovecot-auth 1180940612.910224 GIO fd 9 wrote 156 bytes
"MECH PLAIN plaintext
MECH LOGIN plaintext
MECH DIGEST-MD5 dictionary active mutual-auth
MECH CRAM-MD5 dictionary active
VERSION 1 0
SPID 11447
CUID 10
DONE
"
11447 dovecot-auth 1180940612.910250 RET writev 156/0x9c
11447 dovecot-auth 1180940612.910258 CALL gettimeofday(0xbfbff988,0)
11447 dovecot-auth 1180940612.910267 RET gettimeofday 0
11447 dovecot-auth 1180940612.910274 CALL poll(0x808d000,0xc,0x7a1)
11447 dovecot-auth 1180940612.910561 RET poll 1
11447 dovecot-auth 1180940612.910571 CALL gettimeofday(0x8080f3c,0x8080f44)
11447 dovecot-auth 1180940612.910579 RET gettimeofday 0
11447 dovecot-auth 1180940612.910589 CALL read(0x9,0x8093000,0x1000)
11447 dovecot-auth 1180940612.910596 GIO fd 9 read 23 bytes
"VERSION 1 0
CPID 76525
"
11447 dovecot-auth 1180940612.910602 RET read 23/0x17
11447 dovecot-auth 1180940612.910618 CALL gettimeofday(0xbfbff988,0)
11447 dovecot-auth 1180940612.910628 RET gettimeofday 0
11447 dovecot-auth 1180940612.910634 CALL poll(0x808d000,0xc,0x7a1)
11447 dovecot-auth 1180940614.865304 RET poll 0
11447 dovecot-auth 1180940614.865322 CALL gettimeofday(0x8080f3c,0x8080f44)
11447 dovecot-auth 1180940614.865331 RET gettimeofday 0
11447 dovecot-auth 1180940614.865341 CALL gettimeofday(0xbfbff988,0)
11447 dovecot-auth 1180940614.865350 RET gettimeofday 0
11447 dovecot-auth 1180940614.865356 CALL poll(0x808d000,0xc,0x3b6)
11447 dovecot-auth 1180940615.831798 RET poll 0
11447 dovecot-auth 1180940615.831823 CALL gettimeofday(0x8080f3c,0x8080f44)
11447 dovecot-auth 1180940615.831832 RET gettimeofday 0
11447 dovecot-auth 1180940615.831855 CALL gettimeofday(0xbfbff988,0)
11447 dovecot-auth 1180940615.831864 RET gettimeofday 0
11447 dovecot-auth 1180940615.831870 CALL poll(0x808d000,0xc,0x40a)
11447 dovecot-auth 1180940616.866880 RET poll 0
11447 dovecot-auth 1180940616.866902 CALL gettimeofday(0x8080f3c,0x8080f44)
11447 dovecot-auth 1180940616.866911 RET gettimeofday 0
11447 dovecot-auth 1180940616.866921 CALL gettimeofday(0xbfbff988,0)
11447 dovecot-auth 1180940616.866930 RET gettimeofday 0
11447 dovecot-auth 1180940616.866936 CALL poll(0x808d000,0xc,0x7d0)
11447 dovecot-auth 1180940618.867639 RET poll 0
11447 dovecot-auth 1180940618.867658 CALL gettimeofday(0x8080f3c,0x8080f44)
11447 dovecot-auth 1180940618.867668 RET gettimeofday 0
11447 dovecot-auth 1180940618.867678 CALL gettimeofday(0xbfbff988,0)
11447 dovecot-auth 1180940618.867704 RET gettimeofday 0
11447 dovecot-auth 1180940618.867711 CALL poll(0x808d000,0xc,0x7ac)
11447 dovecot-auth 1180940620.834631 RET poll 0
11447 dovecot-auth 1180940620.834652 CALL gettimeofday(0x8080f3c,0x8080f44)
11447 dovecot-auth 1180940620.834661 RET gettimeofday 0
11447 dovecot-auth 1180940620.834686 CALL gettimeofday(0xbfbff988,0)
11447 dovecot-auth 1180940620.834694 RET gettimeofday 0
11447 dovecot-auth 1180940620.834701 CALL poll(0x808d000,0xc,0x21)
11447 dovecot-auth 1180940620.868482 RET poll 0
11447 dovecot-auth 1180940620.868498 CALL gettimeofday(0x8080f3c,0x8080f44)
11447 dovecot-auth 1180940620.868508 RET gettimeofday 0
11447 dovecot-auth 1180940620.868518 CALL gettimeofday(0xbfbff988,0)
11447 dovecot-auth 1180940620.868526 RET gettimeofday 0
11447 dovecot-auth 1180940620.868533 CALL poll(0x808d000,0xc,0x7d0)
11447 dovecot-auth 1180940622.869408 RET poll 0
11447 dovecot-auth 1180940622.869431 CALL gettimeofday(0x8080f3c,0x8080f44)
11447 dovecot-auth 1180940622.869441 RET gettimeofday 0
11447 dovecot-auth 1180940622.869451 CALL gettimeofday(0xbfbff988,0)
11447 dovecot-auth 1180940622.869460 RET gettimeofday 0
11447 dovecot-auth 1180940622.869467 CALL poll(0x808d000,0xc,0x129)
11447 dovecot-auth 1180940623.167442 RET poll 0
11447 dovecot-auth 1180940623.167460 CALL gettimeofday(0x8080f3c,0x8080f44)
11447 dovecot-auth 1180940623.167469 RET gettimeofday 0
11447 dovecot-auth 1180940623.167479 CALL gettimeofday(0xbfbff988,0)
11447 dovecot-auth 1180940623.167488 RET gettimeofday 0
11447 dovecot-auth 1180940623.167495 CALL poll(0x808d000,0xc,0x6a6)
11447 dovecot-auth 1180940624.870922 RET poll 0
11447 dovecot-auth 1180940624.870940 CALL gettimeofday(0x8080f3c,0x8080f44)
11447 dovecot-auth 1180940624.870950 RET gettimeofday 0
11447 dovecot-auth 1180940624.870960 CALL gettimeofday(0xbfbff988,0)
11447 dovecot-auth 1180940624.870969 RET gettimeofday 0
11447 dovecot-auth 1180940624.870975 CALL poll(0x808d000,0xc,0x3c4)
11447 dovecot-auth 1180940625.844986 RET poll 0
11447 dovecot-auth 1180940625.845001 CALL gettimeofday(0x8080f3c,0x8080f44)
11447 dovecot-auth 1180940625.845010 RET gettimeofday 0
11447 dovecot-auth 1180940625.845033 CALL gettimeofday(0xbfbff988,0)
11447 dovecot-auth 1180940625.845056 RET gettimeofday 0
11447 dovecot-auth 1180940625.845062 CALL poll(0x808d000,0xc,0x401)
11447 dovecot-auth 1180940626.186135 RET poll 1
11447 dovecot-auth 1180940626.186149 CALL gettimeofday(0x8080f3c,0x8080f44)
11447 dovecot-auth 1180940626.186158 RET gettimeofday 0
11447 dovecot-auth 1180940626.186168 CALL read(0x10,0x80a2017,0xfe9)
11447 dovecot-auth 1180940626.186178 GIO fd 16 read 112 bytes
"AUTH 1 PLAIN service=POP3 secured lip=62.8.64.4 rip=62.8.64.4
resp=AGVkZGllQGRlbW8ud2FuYW5jaGkuY29tAGJvZWluZzg "
11447 dovecot-auth 1180940626.186184 RET read 112/0x70
11447 dovecot-auth 1180940626.186199 CALL write(0x2,0x8082160,0x7d)
11447 dovecot-auth 1180940626.186209 GIO fd 2 wrote 125 bytes
"\^AIclient in: AUTH 1 PLAIN service=POP3 secured lip=62.8.64.4
rip=62.8.64.4 resp=AGVkZGllQGRlbW8ud2FuYW5jaGkuY29tAG\
JvZWluZzg "
11447 dovecot-auth 1180940626.186458 RET write 125/0x7d
11447 dovecot-auth 1180940626.186502 CALL socket(0x1,0x1,0)
11447 dovecot-auth 1180940626.186514 RET socket 14/0xe
11447 dovecot-auth 1180940626.186520 CALL fcntl(0xe,0x3,0)
11447 dovecot-auth 1180940626.186525 RET fcntl 2
11447 dovecot-auth 1180940626.186531 CALL fcntl(0xe,0x4,0x6)
11447 dovecot-auth 1180940626.186536 RET fcntl 0
11447 dovecot-auth 1180940626.186541 CALL connect(0xe,0xbfbff6c4,0x6a)
11447 dovecot-auth 1180940626.186549 NAMI
"/var/run/dovecot//auth-worker.11447"
11447 dovecot-auth 1180940626.186671 RET connect 0
11447 dovecot-auth 1180940626.186680 CALL fstat(0xe,0xbfbff6c0)
11447 dovecot-auth 1180940626.186686 RET fstat 0
11447 dovecot-auth 1180940626.186694 CALL lseek(0xe,0,0,0,0x1)
11447 dovecot-auth 1180940626.186701 RET lseek -1 errno 29 Illegal seek
11447 dovecot-auth 1180940626.186707 CALL
getsockname(0xe,0xbfbff684,0xbfbff680)
11447 dovecot-auth 1180940626.186713 RET getsockname 0
11447 dovecot-auth 1180940626.186725 CALL writev(0xe,0xbfbff788,0x3)
11447 dovecot-auth 1180940626.186734 GIO fd 14 wrote 88 bytes
"1 PASSV 1 boeing8 user=eddie at demo.wananchi.com service=POP3
lip=62.8.64.4 rip=62.8.64.4
"
11447 dovecot-auth 1180940626.186741 RET writev 88/0x58
11447 dovecot-auth 1180940626.186748 CALL gettimeofday(0xbfbff988,0)
11447 dovecot-auth 1180940626.186781 RET gettimeofday 0
11447 dovecot-auth 1180940626.186788 CALL poll(0x808d000,0xd,0x2ac)
11447 dovecot-auth 1180940626.266877 RET poll 1
11447 dovecot-auth 1180940626.266897 CALL gettimeofday(0x8080f3c,0x8080f44)
11447 dovecot-auth 1180940626.266906 RET gettimeofday 0
11447 dovecot-auth 1180940626.266917 CALL read(0xe,0x80a4400,0x400)
11447 dovecot-auth 1180940626.266925 GIO fd 14 read 44 bytes
"1 OK eddie at demo.wananchi.com {PLAIN}boeing8
"
11447 dovecot-auth 1180940626.266932 RET read 44/0x2c
11447 dovecot-auth 1180940626.266954 CALL write(0x2,0x8082368,0x30)
11447 dovecot-auth 1180940626.266964 GIO fd 2 wrote 48 bytes
"\^AIclient out: OK 1 user=eddie at demo.wananchi.com
"
11447 dovecot-auth 1180940626.267073 RET write 48/0x30
11447 dovecot-auth 1180940626.267082 CALL write(0x10,0x8082238,0x22)
11447 dovecot-auth 1180940626.267090 GIO fd 16 wrote 34 bytes
"OK 1 user=eddie at demo.wananchi.com
"
11447 dovecot-auth 1180940626.267202 RET write 34/0x22
11447 dovecot-auth 1180940626.267212 CALL gettimeofday(0xbfbff988,0)
11447 dovecot-auth 1180940626.267220 RET gettimeofday 0
11447 dovecot-auth 1180940626.267227 CALL poll(0x808d000,0xd,0x25b)
11447 dovecot-auth 1180940626.267237 RET poll 1
11447 dovecot-auth 1180940626.267243 CALL gettimeofday(0x8080f3c,0x8080f44)
11447 dovecot-auth 1180940626.267252 RET gettimeofday 0
11447 dovecot-auth 1180940626.267259 CALL read(0,0x808dc42,0x3be)
11447 dovecot-auth 1180940626.267266 GIO fd 0 read 18 bytes
"REQUEST 4 12387 1
"
11447 dovecot-auth 1180940626.267273 RET read 18/0x12
11447 dovecot-auth 1180940626.267281 CALL write(0x2,0x8082160,0x1f)
11447 dovecot-auth 1180940626.267289 GIO fd 2 wrote 31 bytes
"\^AImaster in: REQUEST 4 12387 1
"
11447 dovecot-auth 1180940626.267359 RET write 31/0x1f
11447 dovecot-auth 1180940626.267384 CALL writev(0xe,0xbfbff828,0x3)
11447 dovecot-auth 1180940626.267394 GIO fd 14 wrote 79 bytes
"2 USER 0 user=eddie at demo.wananchi.com service=POP3 lip=62.8.64.4
rip=62.8.64.4
"
11447 dovecot-auth 1180940626.267498 RET writev 79/0x4f
11447 dovecot-auth 1180940626.267507 CALL gettimeofday(0xbfbff988,0)
11447 dovecot-auth 1180940626.267516 RET gettimeofday 0
11447 dovecot-auth 1180940626.267539 CALL poll(0x808d000,0xd,0x25b)
11447 dovecot-auth 1180940626.570798 RET poll 1
11447 dovecot-auth 1180940626.570812 CALL gettimeofday(0x8080f3c,0x8080f44)
11447 dovecot-auth 1180940626.570821 RET gettimeofday 0
11447 dovecot-auth 1180940626.570831 CALL read(0xe,0x80a442c,0x3d4)
11447 dovecot-auth 1180940626.570838 GIO fd 14 read 0 bytes
""
11447 dovecot-auth 1180940626.570844 RET read 0
11447 dovecot-auth 1180940626.570866 CALL write(0x2,0x80822a8,0x15)
11447 dovecot-auth 1180940626.570875 GIO fd 2 wrote 21 bytes
"\^AImaster out: FAIL 4
"
11447 dovecot-auth 1180940626.570930 RET write 21/0x15
11447 dovecot-auth 1180940626.570940 CALL writev(0,0xbfbff840,0x2)
11447 dovecot-auth 1180940626.570948 GIO fd 0 wrote 7 bytes
"FAIL 4
"
11447 dovecot-auth 1180940626.571449 RET writev 7
11447 dovecot-auth 1180940626.571466 CALL close(0xe)
11447 dovecot-auth 1180940626.571476 RET close 0
11447 dovecot-auth 1180940626.571484 CALL gettimeofday(0xbfbff988,0)
11447 dovecot-auth 1180940626.571493 RET gettimeofday 0
11447 dovecot-auth 1180940626.571500 CALL poll(0x808d000,0xc,0x12b)
11447 dovecot-auth 1180940626.571915 RET poll 1
11447 dovecot-auth 1180940626.571925 CALL gettimeofday(0x8080f3c,0x8080f44)
11447 dovecot-auth 1180940626.571933 RET gettimeofday 0
11447 dovecot-auth 1180940626.571941 CALL read(0x10,0x80a2087,0xf79)
11447 dovecot-auth 1180940626.571947 GIO fd 16 read 0 bytes
""
11447 dovecot-auth 1180940626.571953 RET read 0
11447 dovecot-auth 1180940626.571961 CALL close(0x10)
11447 dovecot-auth 1180940626.571968 RET close 0
11447 dovecot-auth 1180940626.571981 CALL gettimeofday(0xbfbff988,0)
11447 dovecot-auth 1180940626.571991 RET gettimeofday 0
11447 dovecot-auth 1180940626.571998 CALL poll(0x808d000,0xb,0x12b)
11447 dovecot-auth 1180940626.874715 RET poll 0
11447 dovecot-auth 1180940626.874736 CALL gettimeofday(0x8080f3c,0x8080f44)
11447 dovecot-auth 1180940626.874745 RET gettimeofday 0
11447 dovecot-auth 1180940626.874755 CALL gettimeofday(0xbfbff988,0)
11447 dovecot-auth 1180940626.874780 RET gettimeofday 0
11447 dovecot-auth 1180940626.874786 CALL poll(0x808d000,0xb,0x7d0)
11447 dovecot-auth 1180940628.884158 RET poll 0
11447 dovecot-auth 1180940628.884192 CALL gettimeofday(0x8080f3c,0x8080f44)
11447 dovecot-auth 1180940628.884201 RET gettimeofday 0
11447 dovecot-auth 1180940628.884211 CALL gettimeofday(0xbfbff988,0)
11447 dovecot-auth 1180940628.884219 RET gettimeofday 0
11447 dovecot-auth 1180940628.884226 CALL poll(0x808d000,0xb,0x7a9)
11447 dovecot-auth 1180940630.846254 RET poll 0
11447 dovecot-auth 1180940630.846276 CALL gettimeofday(0x8080f3c,0x8080f44)
11447 dovecot-auth 1180940630.846285 RET gettimeofday 0
11447 dovecot-auth 1180940630.846306 CALL gettimeofday(0xbfbff988,0)
11447 dovecot-auth 1180940630.846315 RET gettimeofday 0
11447 dovecot-auth 1180940630.846322 CALL poll(0x808d000,0xb,0x26)
11447 dovecot-auth 1180940630.893320 RET poll 0
11447 dovecot-auth 1180940630.893341 CALL gettimeofday(0x8080f3c,0x8080f44)
11447 dovecot-auth 1180940630.893352 RET gettimeofday 0
11447 dovecot-auth 1180940630.893361 CALL gettimeofday(0xbfbff988,0)
11447 dovecot-auth 1180940630.893370 RET gettimeofday 0
11447 dovecot-auth 1180940630.893376 CALL poll(0x808d000,0xb,0x7d0)
11447 dovecot-auth 1180940632.893969 RET poll 0
11447 dovecot-auth 1180940632.893990 CALL gettimeofday(0x8080f3c,0x8080f44)
11447 dovecot-auth 1180940632.894000 RET gettimeofday 0
11447 dovecot-auth 1180940632.894010 CALL gettimeofday(0xbfbff988,0)
11447 dovecot-auth 1180940632.894018 RET gettimeofday 0
11447 dovecot-auth 1180940632.894025 CALL poll(0x808d000,0xb,0x7cf)
11447 dovecot-auth 1180940634.894438 RET poll 0
11447 dovecot-auth 1180940634.894457 CALL gettimeofday(0x8080f3c,0x8080f44)
11447 dovecot-auth 1180940634.894467 RET gettimeofday 0
11447 dovecot-auth 1180940634.894476 CALL gettimeofday(0xbfbff988,0)
11447 dovecot-auth 1180940634.894485 RET gettimeofday 0
11447 dovecot-auth 1180940634.894491 CALL poll(0x808d000,0xb,0x3b8)
-Wash
http://www.netmeister.org/news/learn2quote.html
DISCLAIMER: See http://www.wananchi.com/bms/terms.php
--
+======================================================================+
|\ _,,,---,,_ | Odhiambo Washington <wash at wananchi.com>
Zzz /,`.-'`' -. ;-;;,_ | Wananchi Online Ltd. www.wananchi.com
|,4- ) )-,_. ,\ ( `'-'| Tel: +254 20 313985-9 +254 20 313922
'---''(_/--' `-'\_) | GSM: +254 722 743223 +254 733
744121
+======================================================================+
The older I grow the more I distrust the familiar doctrine that age
brings wisdom.
-- H. L. Mencken