|
お手数おかけします。
x64 v6.25b2 にupして検証しています。
dump.txtの記録をONにしてからアカウントBで振り分けが無視されたメール
がまだ4通でサンプルが少ないのですが、dump.txtを取る前からの振り分け
無視メールを確認してみましたらすべて
X-TuruKame-Filter: spam (UrlChecker: spam-site)
で、dump.txtの記録開始後に失敗した4通とも、受信直後に
I 迷惑メールフィルターの遅延処理開始:xx
が挿入されていました。
振り分け問題のないメールには「迷惑メールフィルターの遅延処理」などの
一行は入っていないようです。
※定かではないですが、色づけ失敗はURLチェッカーのダイアログが開いて
いるときに受信したメールの時に集中して発生していたかもしれません。
メール本文受信後のおしゃべりを抜き出します。
【失敗1】
15:53:51.888 R ...(1920バイト)
15:53:51.888 (9523) 1 / 3 済み (1.8K / 7Kバイト)
I 迷惑メールフィルターの遅延処理開始:12
15:53:51.903 (4826) filterlog.txt succeeded offset=3738384
15:53:51.932 (5660) Appended (Aアカウント)/6/ file=受信ログ201404_10.txt off
set1=1576773 offset2=1576771 size=1958
15:53:51.932 (5677) (Aアカウント),6 cEach=0
15:53:51.934 S DELE 1
15:53:51.934 (5660) Appended (Aアカウント)/0/ file=受信201404_27.txt offset1
=19161 offset2=19159 size=1605
15:53:52.022 R +OK
【成功1】
15:53:52.406 R ...(1095バイト)
15:53:52.406 (9523) 2 / 3 済み (2.9K / 7Kバイト)
15:53:52.411 (4634) filter action=00000001
15:53:52.412 (4826) filterlog.txt succeeded offset=3738615
15:53:52.412 (4634) filter action=00054001
15:53:52.412 (4826) filterlog.txt succeeded offset=3738829
15:53:52.415 (5660) Appended (Aアカウント)/6/ file=受信ログ201404_10.txt off
set1=1578733 offset2=1578731 size=1133
15:53:52.416 (5677) (Aアカウント),6 cEach=0
15:53:52.417 S DELE 2
15:53:52.417 (5660) Appended (Bアカウント)/0/(Bアカウント) file=(Bアカウン
ト)201404_01.txt offset1=227517 offset2=227515 size=1134
15:53:52.492 R +OK
↓filter.logでは、先に【失敗2】の振り分け処理後に【成功2】を処理していますが
dump.txtでは前後しています。
【成功2】
16:55:29.488 R ...(3475バイト)
16:55:29.489 (9523) 4 / 4 済み (7.4K / 7Kバイト)
16:55:29.493 (4634) filter action=00000001
16:55:29.493 (4826) filterlog.txt succeeded offset=3751207
16:55:29.494 (4634) filter action=00054001
16:55:29.494 (4826) filterlog.txt succeeded offset=3751429
16:55:29.496 (5660) Appended (Aアカウント)/6/ file=受信ログ201404_10.txt off
set1=1631023 offset2=1631021 size=3513
16:55:29.496 (5677) (Aアカウント),6 cEach=0
16:55:29.497 S DELE 4
16:55:29.498 (5660) Appended (Bアカウント)/0/(Bアカウント) file=(Bアカウン
ト)201404_01.txt offset1=292078 offset2=292076 size=3586
16:55:29.623 R +OK
【失敗2】
16:55:27.939 R ...(1229バイト)
16:55:27.940 (9523) 1 / 4 済み (1.1K / 7Kバイト)
I 迷惑メールフィルターの遅延処理開始:13
16:55:27.962 (4826) filterlog.txt succeeded offset=3749890
16:55:27.966 (5660) Appended (Aアカウント)/6/ file=受信ログ201404_10.txt off
set1=1626724 offset2=1626722 size=1267
16:55:27.966 (5677) (Aアカウント),6 cEach=0
16:55:27.967 S DELE 1
16:55:27.968 (5660) Appended (Aアカウント)/0/ file=受信201404_27.txt offset1
=19161 offset2=19159 size=1206
16:55:28.052 R +OK
↓こちらは一つのメールがfilter.logに3段表示されて振り分け失敗していました。
【失敗3 filter.log】
2014/04/16 17:07:41 (Aアカウント) 受 自 From:○ <**@**.biz> Message-Id:
<xxx> 振り分け動作なし
2014/04/16 17:07:42 (Aアカウント) 受 コ From:○ <**@**.biz> Message-Id:
<xxx> ヒット(19):迷惑メール (SPAM)で始まる,(ZIP DELETED)を含まない 移動:
アカウントのバイパス:(Bアカウント)
2014/04/16 17:07:42 (Bアカウント) 受 コ From:○ <**@**.biz> Message-Id:
<xxx> 振り分け動作なし
【失敗3 dump.log】
17:07:41.042 R ...(1435バイト)
17:07:41.042 (9523) 1 / 1 済み (1.4K / 1Kバイト)
I 迷惑メールフィルターの遅延処理開始:14
17:07:41.055 (4826) filterlog.txt succeeded offset=3754786
17:07:41.059 (5660) Appended (Aアカウント)/6/ file=受信ログ201404_10.txt off
set1=1652994 offset2=1652992 size=1473
17:07:41.059 (5677) (Aアカウント),6 cEach=0
17:07:41.061 S DELE 1
17:07:41.061 (5660) Appended (Aアカウント)/0/ file=受信201404_27.txt offset1
=30539 offset2=30537 size=1382
17:07:41.143 R +OK
17:07:41.143 S QUIT
17:07:41.254 R +OK
17:07:41.254 (9533) tid=5116 ThreadExit 5116
17:07:41.255 (9523) 迷惑メールフィルターの遅延処理待ち
I 迷惑メールフィルターの遅延処理終了:14
17:07:42.489 (9523) 受信フォルダ中の新着メールを振り分け直し
17:07:42.491 (27249) URL-Checker filter 1,1018
17:07:42.491 (9326) SetWaitCursor 0
17:07:42.491 (1127) InitializeFilter
17:07:42.493 (10849) AlterSave (Aアカウント)/0/ file=受信201404_27.txt offse
t=30539 prevsize=1382
17:07:42.493 (4634) filter action=00000001
17:07:42.494 (4826) filterlog.txt succeeded offset=3754948
17:07:42.494 (4826) filterlog.txt succeeded offset=3755185
17:07:42.494 (7822) MailFileOperation ope=5 (Aアカウント)/0/ count=1 file=受
信201404_27.txt offset=30539
17:07:42.494 (7825) dest=(Bアカウント)/0/
17:07:42.494 (9326) SetWaitCursor 1
17:07:42.499 (9417) RestoreWaitCursor 1
17:07:42.499 (7822) MailFileOperation ope=0 (Aアカウント)/0/ count=1 file=受
信201404_27.txt offset=30539
17:07:42.499 (9326) SetWaitCursor 1
17:07:42.499 (9417) RestoreWaitCursor 1
17:07:42.499 (9326) SetWaitCursor 1
17:07:42.500 (15363) NotifyListCacheOffsetMoved 101F5FA3,-176,0,0,0
17:07:42.500 (9417) RestoreWaitCursor 1
17:07:42.501 (9417) RestoreWaitCursor 0
17:07:42.501 (27252) done 1017
17:07:42.501 (9523) 振り分け 1通/1通
17:07:42.503 (8029) IDTIMER_SOCKET_END received
17:07:42.503 (8091) IDTIMER_TRANS_START post
17:07:42.503 (7776) IDTIMER_TRANS_START kill
17:07:42.503 (9523) 終了
|
|