AW: Problem with copy e-mails via doveadm

Fri Aug 20 12:45:51 EEST 2021

Okay, i need some further help. 

What i've tried with your hint:

Executing on cmd of director&proxy server:
/usr/bin/doveadm -Dv -o mail_location=imapc: copy -u "dest_user_shard2" "dest_folder" user "source_user_shard1" mailbox "source_folder" ALL
/usr/bin/doveadm -Dv -o mail_location=imapc: -o imapc_host=<director-dns> -o imapc_user="source_user_shard1" -o imapc_password="source_user_shard1_password" copy -u "dest_user_shard2" "dest_folder" user "source_user_shard1" mailbox "source_folder" ALL

I've also tried to execute "doveadm -c" with copied and modified configuration on director&proxy server without "'y' AS proxy" in sql password_query configuration part - without luck.
This leads all to same debug output and result as command in first post.

After that i changed to cmd of backend server of dest_user_shard2 and tried:
/usr/bin/doveadm -Dv -o mail_location=imapc: -o imapc_host=<backend-shard1-dns> -o imapc_user="source_user_shard1" -o imapc_password="source_user_shard1_password" copy -u "dest_user_shard2" "dest_folder" user "source_user_shard1" mailbox "source_folder" ALL
[..]
Aug 20 08:52:38 doveadm(source_user_shard1)<2442101><qAs8KVZtH2F1QyUA5QDIzw>: Debug: imapc(<backend-shard1-dns>:143): Authenticated successfully
Aug 20 08:52:38 doveadm(source_user_shard1)<2442101><qAs8KVZtH2F1QyUA5QDIzw>: Debug: imapc: root=, index=, indexpvt=, control=, inbox=, alt=
Aug 20 08:52:38 doveadm(source_user_shard1)<2442101><qAs8KVZtH2F1QyUA5QDIzw>: Debug: quota: quota_over_flag check: quota_over_script unset - skipping
Aug 20 08:52:38 doveadm(dest_user_shard2): Debug: Mailbox dest_folder: Mailbox opened because: copy
Aug 20 08:52:38 doveadm(dest_user_shard2): Debug: Mailbox source_folder: Mailbox opened because: copy
Aug 20 08:52:38 doveadm(dest_user_shard2): Debug: Mailbox source_folder: UID 1: Opened mail because: copying
Aug 20 08:52:38 doveadm(dest_user_shard2): Error: Copying message UID 1 from 'source_folder' failed: Mailbox doesn't exist: dest_folder (0.001 + 0.000 secs).
Aug 20 08:52:38 doveadm(dest_user_shard2): Debug: Mailbox source_folder: UID 2: Opened mail because: copying
Aug 20 08:52:38 doveadm(dest_user_shard2): Error: Copying message UID 2 from 'source_folder' failed: Mailbox doesn't exist: dest_folder (0.001 + 0.000 secs).
Aug 20 08:52:38 doveadm(dest_user_shard2): Debug: Mailbox source_folder: UID 3: Opened mail because: copying
Aug 20 08:52:38 doveadm(dest_user_shard2): Error: Copying message UID 3 from 'source_folder' failed: Mailbox doesn't exist: dest_folder (0.001 + 0.000 secs).
Aug 20 08:52:38 doveadm(dest_user_shard2): Debug: Mailbox source_folder: UID 4: Opened mail because: copying
Aug 20 08:52:38 doveadm(dest_user_shard2): Error: Copying message UID 4 from 'source_folder' failed: Mailbox doesn't exist: dest_folder (0.001 + 0.000 secs).
Aug 20 08:52:38 doveadm(dest_user_shard2): Debug: Mailbox source_folder: UID 5: Opened mail because: copying
Aug 20 08:52:38 doveadm(dest_user_shard2): Error: Copying message UID 5 from 'source_folder' failed: Mailbox doesn't exist: dest_folder (0.001 + 0.000 secs).
Aug 20 08:52:38 doveadm(dest_user_shard2): Error: Syncing mailbox 'dest_folder' failed: Mailbox doesn't exist: dest_folder (0.001 + 0.000 secs).
Aug 20 08:52:38 doveadm(dest_user_shard2): Debug: imapc(<backend-shard1-dns>:143): Disconnected
Aug 20 08:52:38 doveadm(dest_user_shard2): Debug: imapc(<backend-shard1-dns>:143): Disconnected
Aug 20 08:52:38 doveadm(2442101): Debug: auth-master: conn unix:/var/run/dovecot/auth-userdb (pid=2630417,uid=0): Disconnected: Connection closed (fd=9)

after creating dest_folder in source_user_shard1 mailbox output changed to:
[..]
Aug 20 08:56:11 doveadm(source_user_shard1)<2446702><0AmaCStuH2FuVSUA5QDIzw>: Debug: imapc(<backend-shard1-dns>:143): Authenticated successfully
Aug 20 08:56:11 doveadm(source_user_shard1)<2446702><0AmaCStuH2FuVSUA5QDIzw>: Debug: imapc: root=, index=, indexpvt=, control=, inbox=, alt=
Aug 20 08:56:11 doveadm(source_user_shard1)<2446702><0AmaCStuH2FuVSUA5QDIzw>: Debug: quota: quota_over_flag check: quota_over_script unset - skipping
Aug 20 08:56:11 doveadm(dest_user_shard2): Debug: Mailbox dest_folder: Mailbox opened because: copy
Aug 20 08:56:11 doveadm(dest_user_shard2): Debug: Mailbox source_folder: Mailbox opened because: copy
Aug 20 08:56:11 doveadm(dest_user_shard2): Debug: Mailbox source_folder: UID 1: Opened mail because: copying
Aug 20 08:56:11 doveadm(dest_user_shard2): Debug: Mailbox dest_folder: saving UID 1: Opened mail
Aug 20 08:56:11 doveadm(dest_user_shard2): Debug: Mailbox source_folder: UID 2: Opened mail because: copying
Aug 20 08:56:11 doveadm(dest_user_shard2): Debug: Mailbox dest_folder: saving UID 2: Opened mail
Aug 20 08:56:11 doveadm(dest_user_shard2): Debug: Mailbox source_folder: UID 3: Opened mail because: copying
Aug 20 08:56:11 doveadm(dest_user_shard2): Debug: Mailbox dest_folder: saving UID 3: Opened mail
Aug 20 08:56:11 doveadm(dest_user_shard2): Debug: Mailbox source_folder: UID 4: Opened mail because: copying
Aug 20 08:56:11 doveadm(dest_user_shard2): Debug: Mailbox dest_folder: saving UID 4: Opened mail
Aug 20 08:56:11 doveadm(dest_user_shard2): Debug: Mailbox source_folder: UID 5: Opened mail because: copying
Aug 20 08:56:11 doveadm(dest_user_shard2): Debug: Mailbox dest_folder: saving UID 5: Opened mail
Aug 20 08:56:11 doveadm(dest_user_shard2): Debug: replication: Replication requested by 'cmd_copy_box', priority=2
Aug 20 08:56:11 doveadm(dest_user_shard2): Error: Syncing mailbox 'dest_folder' failed: BUG: Unknown internal error
Aug 20 08:56:11 doveadm(dest_user_shard2): Debug: imapc(<backend-shard1-dns>:143): Disconnected
Aug 20 08:56:11 doveadm(dest_user_shard2): Debug: imapc(<backend-shard1-dns>:143): Disconnected
Aug 20 08:56:11 doveadm(2446702): Debug: auth-master: conn unix:/var/run/dovecot/auth-userdb (pid=2630417,uid=0): Disconnected: Connection closed (fd=9)

This time e-mails get copied in source_user_shard1 from source_folder to dest_folder although dest_user_shard2 is given in doveadm command and is different from source_user_shard1.
It is not what I expected and desired.

So yeah i haven't get the whole picture right now.
Maybe you can give me some details.

Christian

----- Ursprüngliche Nachricht -----
Von: Aki Tuomi aki.tuomi at open-xchange.com
Gesendet: Freitag, 20. August 2021 09:06:31
An: c.kueppers at onoffice.de
Cc: dovecot at dovecot.org
Betreff: Re: AW: Problem with copy e-mails via doveadm

The copy command gets proxied to the remote server because you used proxy=y.
To do this kind of copying, you need to specify mail_location=imapc: and
target to the director.

Aki

> On 20/08/2021 09:53 Christian Küppers c.kueppers at onoffice.de wrote:
>
>
> Maybe i missunderstood this message. For me this indicates that doveadm
is searching on the wrong server (backend) for "source_user_shard1" 's 
and
> folder "source_folder". From my understanding doveadm has to look
on 192.168.0.11 or 192.168.0.12 (according to provided configuration), but
the
> message says 192.168.0.21 which is backend for "dest_user_shard2".
>
>
>
> ----- Ursprüngliche Nachricht -----
> Von: Aki Tuomi aki.tuomi at open-xchange.com
> Gesendet: Freitag, 20. August 2021 08:39:41
> An: c.kueppers at onoffice.de, dovecot at dovecot.org
> Betreff: Re: AW: Problem with copy e-mails via doveadm
>
> Aug 17 10:22:05 doveadm(dest_user_shard2): Debug: auth-master: passdb
> lookup(dest_user_shard2): Finished passdb lookup (user=dest_user_shard2
> proxy=y director_tag=shard2 proxy_refresh=450 host=192.168.0.21)
> Aug 17 10:22:05 doveadm(dest_user_shard2): Error:
> remote(192.168.0.21:24245): Mailbox source_folder: Mailbox sync failed:
> Mailbox doesn't exist: source_folder
>
> Does this help?
>
> Aki
>
> > On 20/08/2021 09:12 Christian Küppers c.kueppers at onoffice.de wrote:
> >
> >
> > Try to republish due to unreadable message (in html format) in mailing
> list archive
> > maybe someone can take a better look at it now
> >
> >
>
-------------------------------------------------------------------------------------------
> >
> > Hi,
> >
> > i want to copy e-mails from user "source_user_shard1" and folder
> "source_folder" lying on backend servers (shard1) to another
> > user "dest_user_shard2" and folder "dest_folder" lying on different
> backend servers (shard2) via command line tool doveadm copy
> > executed on dovecot proxy&director servers. But doveadm seems to look
only
> on "dest_user_shard2"'s backend for folder "source_folder"
> > of user "source_user_shard1" and can not find it. To confirm this, i've
> checked directories on filesystem on backend of "dest_user_shard2"
> > and a folder for "source_user_shard1" was created including one folder
> "mdbox" and only one file "dovecot.list.index.log" in it. Folder and file
> > timestamps match the command debug output time.
> > "doveadm list" executed for both users show the right folders
> (source_folder and dest_folder exist in respective mailbox).
> >
> > Is it a bug or wrong usage of tool? Please advice.
> >
> > command executed on dovecot proxy&director server with debug output:
> > /usr/bin/doveadm -Dv copy -u "dest_user_shard2" "dest_folder" user
> "source_user_shard1" mailbox "source_folder" ALL
> > Aug 17 10:22:05 Debug: Loading modules from directory:
> /usr/lib/dovecot/modules
> > Aug 17 10:22:05 Debug: Module loaded:
> /usr/lib/dovecot/modules/lib10_quota_plugin.so
> > Aug 17 10:22:05 Debug: Loading modules from directory:
> /usr/lib/dovecot/modules/doveadm
> > Aug 17 10:22:05 Debug: Skipping module doveadm_acl_plugin, because
> dlopen() failed:
> /usr/lib/dovecot/modules/doveadm/lib10_doveadm_acl_plugin.so:
> > undefined symbol: acl_user_module (this is usually intentional, so just
> ignore this message)
> > Aug 17 10:22:05 Debug: Module loaded:
> /usr/lib/dovecot/modules/doveadm/lib10_doveadm_quota_plugin.so
> > Aug 17 10:22:05 Debug: Module loaded:
> /usr/lib/dovecot/modules/doveadm/lib10_doveadm_sieve_plugin.so
> > Aug 17 10:22:05 Debug: Skipping module doveadm_fts_plugin, because
> dlopen() failed:
> /usr/lib/dovecot/modules/doveadm/lib20_doveadm_fts_plugin.so:
> > undefined symbol: fts_user_get_language_list (this is usually
intentional,
> so just ignore this message)
> > Aug 17 10:22:05 doveadm(dest_user_shard2): Debug: auth-master: passdb
> lookup(dest_user_shard2): Started passdb lookup
> > Aug 17 10:22:05 doveadm(dest_user_shard2): Debug: auth-master: conn
> unix:/var/run/dovecot/director-userdb: Connecting
> > Aug 17 10:22:05 doveadm(dest_user_shard2): Debug: auth-master: conn
> unix:/var/run/dovecot/director-userdb (pid=647,uid=0): Client connected
> > (fd=9)
> > Aug 17 10:22:05 doveadm(dest_user_shard2): Debug: auth-master: passdb
> lookup(dest_user_shard2): auth PASS input: user=dest_user_shard2 proxy=y
> > director_tag=shard2 proxy_refresh=450 host=192.168.0.21
> > Aug 17 10:22:05 doveadm(dest_user_shard2): Debug: auth-master: passdb
> lookup(dest_user_shard2): Finished passdb lookup (user=dest_user_shard2
> > proxy=y director_tag=shard2 proxy_refresh=450 host=192.168.0.21)
> > Aug 17 10:22:05 doveadm(dest_user_shard2): Error:
> remote(192.168.0.21:24245): Mailbox source_folder: Mailbox sync failed:
> > Mailbox doesn't exist: source_folder
> > Aug 17 10:22:05 doveadm(dest_user_shard2): Debug: auth-master: conn
> unix:/var/run/dovecot/director-userdb (pid=647,uid=0): Disconnected:
> > Connection closed (fd=9)
> >
<snip/>

> >
> > Kind regards,
> >
> >  Christian Küppers
> > Expert Administrator
> >
> >  
> >
> > onOffice GmbH
> > Charlottenburger Allee 5 | 52068 Aachen
> > Tel. +49 (0)241 446 86-0 | Fax. +49 (0)241 446 86-250
> > E-Mail:c.kueppers at onoffice.de| Web:www.onOffice.com
> >
> >  
> > Registergericht: Amtsgericht Aachen, HRB 21420
> > Geschäftsführer: Dipl.-Kfm. Stefan Mantl
> > Prokuristen: Janosch Reuschenbach, Kristina Andresen, Christian
Mähringer