tejas.ghadi
New member
- Joined
- Mar 28, 2025
- Messages
- 1
Dovecot is trying reauthenticate with old password itself and because of it I am getting invalid verification code error.
First time user able to login with google authenticator code but after some time around 30 seconds I am getting below error.
Most probably sessions are getting expired or dovecot reauthenticating itself with old code.
Please find below logs:
Mar 28 14:37:08 pune.techspeed.com dovecot(pam_google_authenticator)[2600424]: Invalid verification code for tejas.ghadi
Mar 28 14:37:08 pune.techspeed.com dovecot[2600327]: auth-worker(2600424): Debug: conn unix:auth-worker (pid=2600423,uid=97): auth-worker<8>: pam(tejas.ghadi,192.168.1.45,<8mcgZWMxoN/AqAEt>): #1/1 style=1 msg=Password:
Mar 28 14:37:08 pune.techspeed.com auth[2600424]: pam_unix(dovecot:auth): authentication failure; logname= uid=0 euid=0 tty=dovecot ruser=tejas.ghadi rhost=192.168.1.45 user=tejas.ghadi
Mar 28 14:37:10 pune.techspeed.com dovecot[2600327]: auth-worker(2600424): conn unix:auth-worker (pid=2600423,uid=97): auth-worker<8>: pam(tejas.ghadi,192.168.1.45,<8mcgZWMxoN/AqAEt>): pam_authenticate() failed: Authentication failure (Password mismatch?) (given password: test833952)
Mar 28 14:37:10 pune.techspeed.com dovecot[2600327]: auth: Debug: pam(tejas.ghadi,192.168.1.45,<8mcgZWMxoN/AqAEt>): Finished passdb lookup
Mar 28 14:37:10 pune.techspeed.com dovecot[2600327]: auth: Debug: auth(tejas.ghadi,192.168.1.45,<8mcgZWMxoN/AqAEt>): Auth request finished
Mar 28 14:37:10 pune.techspeed.com dovecot[2600327]: auth-worker(2600424): Debug: conn unix:auth-worker (pid=2600423,uid=97): auth-worker<8>: pam(tejas.ghadi,192.168.1.45,<8mcgZWMxoN/AqAEt>): Finished passdb lookup
Mar 28 14:37:10 pune.techspeed.com dovecot[2600327]: auth-worker(2600424): Debug: conn unix:auth-worker (pid=2600423,uid=97): auth-worker<8>: Finished: password_mismatch
Mar 28 14:37:12 pune.techspeed.com dovecot[2600327]: auth: Debug: client passdb out: FAIL 1 user=tejas.ghadi
Mar 28 14:37:12 pune.techspeed.com dovecot[2600327]: imap-login: Disconnected: Connection closed (auth failed, 1 attempts in 4 secs): user=<tejas.ghadi>, method=PLAIN, rip=192.168.1.45, lip=192.168.1.45, secured, session=<8mcgZWMxoN/AqAEt>
Mar 28 14:37:12 pune.techspeed.com dovecot[2600327]: auth: Debug: auth client connected (pid=2600570)
Mar 28 14:37:12 pune.techspeed.com dovecot[2600327]: auth: Debug: client in: AUTH 1 PLAIN service=imap secured session=uI1cZWMxdMPAqAEt lip=192.168.1.45 rip=192.168.1.45 lport=143 rport=50036 resp=AHRlamFzLmdoYWRpAFQzakAkQHRlc3Q4MzM5NTI= (previous base64 data may contain sensitive data)
Mar 28 14:37:12 pune.techspeed.com dovecot[2600327]: auth: Debug: auth client connected (pid=2600571)
Mar 28 14:37:12 pune.techspeed.com dovecot[2600327]: auth: Debug: client in: AUTH 1 PLAIN service=imap secured session=lCpdZWMxeMPAqAEt lip=192.168.1.45 rip=192.168.1.45 lport=143 rport=50040 resp=AHRlamFzLmdoYWRpAFQzakAkQHRlc3Q4MzM5NTI= (previous base64 data may contain sensitive data)
Could someone please help me with this
First time user able to login with google authenticator code but after some time around 30 seconds I am getting below error.
Most probably sessions are getting expired or dovecot reauthenticating itself with old code.
Please find below logs:
Mar 28 14:37:08 pune.techspeed.com dovecot(pam_google_authenticator)[2600424]: Invalid verification code for tejas.ghadi
Mar 28 14:37:08 pune.techspeed.com dovecot[2600327]: auth-worker(2600424): Debug: conn unix:auth-worker (pid=2600423,uid=97): auth-worker<8>: pam(tejas.ghadi,192.168.1.45,<8mcgZWMxoN/AqAEt>): #1/1 style=1 msg=Password:
Mar 28 14:37:08 pune.techspeed.com auth[2600424]: pam_unix(dovecot:auth): authentication failure; logname= uid=0 euid=0 tty=dovecot ruser=tejas.ghadi rhost=192.168.1.45 user=tejas.ghadi
Mar 28 14:37:10 pune.techspeed.com dovecot[2600327]: auth-worker(2600424): conn unix:auth-worker (pid=2600423,uid=97): auth-worker<8>: pam(tejas.ghadi,192.168.1.45,<8mcgZWMxoN/AqAEt>): pam_authenticate() failed: Authentication failure (Password mismatch?) (given password: test833952)
Mar 28 14:37:10 pune.techspeed.com dovecot[2600327]: auth: Debug: pam(tejas.ghadi,192.168.1.45,<8mcgZWMxoN/AqAEt>): Finished passdb lookup
Mar 28 14:37:10 pune.techspeed.com dovecot[2600327]: auth: Debug: auth(tejas.ghadi,192.168.1.45,<8mcgZWMxoN/AqAEt>): Auth request finished
Mar 28 14:37:10 pune.techspeed.com dovecot[2600327]: auth-worker(2600424): Debug: conn unix:auth-worker (pid=2600423,uid=97): auth-worker<8>: pam(tejas.ghadi,192.168.1.45,<8mcgZWMxoN/AqAEt>): Finished passdb lookup
Mar 28 14:37:10 pune.techspeed.com dovecot[2600327]: auth-worker(2600424): Debug: conn unix:auth-worker (pid=2600423,uid=97): auth-worker<8>: Finished: password_mismatch
Mar 28 14:37:12 pune.techspeed.com dovecot[2600327]: auth: Debug: client passdb out: FAIL 1 user=tejas.ghadi
Mar 28 14:37:12 pune.techspeed.com dovecot[2600327]: imap-login: Disconnected: Connection closed (auth failed, 1 attempts in 4 secs): user=<tejas.ghadi>, method=PLAIN, rip=192.168.1.45, lip=192.168.1.45, secured, session=<8mcgZWMxoN/AqAEt>
Mar 28 14:37:12 pune.techspeed.com dovecot[2600327]: auth: Debug: auth client connected (pid=2600570)
Mar 28 14:37:12 pune.techspeed.com dovecot[2600327]: auth: Debug: client in: AUTH 1 PLAIN service=imap secured session=uI1cZWMxdMPAqAEt lip=192.168.1.45 rip=192.168.1.45 lport=143 rport=50036 resp=AHRlamFzLmdoYWRpAFQzakAkQHRlc3Q4MzM5NTI= (previous base64 data may contain sensitive data)
Mar 28 14:37:12 pune.techspeed.com dovecot[2600327]: auth: Debug: auth client connected (pid=2600571)
Mar 28 14:37:12 pune.techspeed.com dovecot[2600327]: auth: Debug: client in: AUTH 1 PLAIN service=imap secured session=lCpdZWMxeMPAqAEt lip=192.168.1.45 rip=192.168.1.45 lport=143 rport=50040 resp=AHRlamFzLmdoYWRpAFQzakAkQHRlc3Q4MzM5NTI= (previous base64 data may contain sensitive data)
Could someone please help me with this