| 1 | Exim version x.yz .... |
| 2 | changed uid/gid: forcing real = effective |
| 3 | uid=uuuu gid=CALLER_GID pid=pppp |
| 4 | configuration file is TESTSUITE/test-config |
| 5 | admin user |
| 6 | changed uid/gid: privilege not needed |
| 7 | uid=EXIM_UID gid=EXIM_GID pid=pppp |
| 8 | seeking password data for user "CALLER": cache not available |
| 9 | getpwnam() succeeded uid=CALLER_UID gid=CALLER_GID |
| 10 | originator: uid=CALLER_UID gid=CALLER_GID login=CALLER name=CALLER_NAME |
| 11 | sender address = CALLER@test.ex |
| 12 | set_process_info: pppp accepting a local non-SMTP message from <CALLER@test.ex> |
| 13 | spool directory space = nnnnnK inodes = nnnnn check_space = 10240K inodes = 100 msg_size = 0 |
| 14 | log directory space = nnnnnK inodes = nnnnn check_space = 10240K inodes = 100 |
| 15 | Sender: CALLER@test.ex |
| 16 | Recipients: |
| 17 | nofile@test.ex |
| 18 | search_tidyup called |
| 19 | >>Headers received: |
| 20 | |
| 21 | rewrite_one_header: type=F: |
| 22 | From: CALLER_NAME <CALLER@test.ex> |
| 23 | search_tidyup called |
| 24 | >>Headers after rewriting and local additions: |
| 25 | I Message-Id: <E10HmaX-0005vi-00@myhost.test.ex> |
| 26 | F From: CALLER_NAME <CALLER@test.ex> |
| 27 | Date: Tue, 2 Mar 1999 09:44:33 +0000 |
| 28 | |
| 29 | Data file name: TESTSUITE/spool//input//10HmaX-0005vi-00-D |
| 30 | Data file written for message 10HmaX-0005vi-00 |
| 31 | >>Generated Received: header line |
| 32 | P Received: from CALLER by myhost.test.ex with local (Exim x.yz) |
| 33 | (envelope-from <CALLER@test.ex>) |
| 34 | id 10HmaX-0005vi-00 |
| 35 | for nofile@test.ex; Tue, 2 Mar 1999 09:44:33 +0000 |
| 36 | Writing spool header file: TESTSUITE/spool//input//hdr.10HmaX-0005vi-00 |
| 37 | DSN: **** SPOOL_OUT - address: <nofile@test.ex> errorsto: <NULL> orcpt: <NULL> dsn_flags: 0x0 |
| 38 | Renaming spool header file: TESTSUITE/spool//input//10HmaX-0005vi-00-H |
| 39 | Size of headers = sss |
| 40 | LOG: MAIN |
| 41 | <= CALLER@test.ex U=CALLER P=local S=sss |
| 42 | created log directory TESTSUITE/spool/log |
| 43 | search_tidyup called |
| 44 | exec TESTSUITE/eximdir/exim -DEXIM_PATH=TESTSUITE/eximdir/exim -C TESTSUITE/test-config -d=0xf7715cfd -MCd local-accept-delivery -odi -Mc 10HmaX-0005vi-00 |
| 45 | Exim version x.yz .... |
| 46 | changed uid/gid: forcing real = effective |
| 47 | uid=uuuu gid=EXIM_GID pid=pppp |
| 48 | configuration file is TESTSUITE/test-config |
| 49 | trusted user |
| 50 | admin user |
| 51 | dropping to exim gid; retaining priv uid |
| 52 | seeking password data for user "CALLER": cache not available |
| 53 | getpwnam() succeeded uid=CALLER_UID gid=CALLER_GID |
| 54 | set_process_info: pppp delivering specified messages |
| 55 | set_process_info: pppp delivering 10HmaX-0005vi-00 |
| 56 | Trying spool file TESTSUITE/spool//input//10HmaX-0005vi-00-D |
| 57 | reading spool file 10HmaX-0005vi-00-H |
| 58 | user=CALLER uid=CALLER_UID gid=CALLER_GID sender=CALLER@test.ex |
| 59 | sender_local=1 ident=CALLER |
| 60 | Non-recipients: |
| 61 | Empty Tree |
| 62 | ---- End of tree ---- |
| 63 | recipients_count=1 |
| 64 | **** SPOOL_IN - No additional fields |
| 65 | body_linecount=1 message_linecount=7 |
| 66 | DSN: set orcpt: flags: 0x0 |
| 67 | Delivery address list: |
| 68 | nofile@test.ex |
| 69 | locking TESTSUITE/spool/db/retry.lockfile |
| 70 | locked TESTSUITE/spool/db/retry.lockfile |
| 71 | EXIM_DBOPEN: file <TESTSUITE/spool/db/retry> dir <TESTSUITE/spool/db> flags=O_RDONLY |
| 72 | returned from EXIM_DBOPEN: (nil) |
| 73 | ensuring TESTSUITE/spool/db/retry.lockfile is owned by exim |
| 74 | failed to open DB file TESTSUITE/spool/db/retry.lockfile: No such file or directory |
| 75 | no retry data available |
| 76 | >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>> |
| 77 | Considering: nofile@test.ex |
| 78 | unique = nofile@test.ex |
| 79 | no domain retry record |
| 80 | no address retry record |
| 81 | nofile@test.ex: queued for routing |
| 82 | >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>> |
| 83 | routing nofile@test.ex |
| 84 | --------> r1 router <-------- |
| 85 | local_part=nofile domain=test.ex |
| 86 | calling r1 router |
| 87 | r1 router called for nofile@test.ex |
| 88 | domain = test.ex |
| 89 | set transport t1 |
| 90 | queued for t1 transport: local_part = nofile |
| 91 | domain = test.ex |
| 92 | errors_to=NULL |
| 93 | domain_data=NULL localpart_data=NULL |
| 94 | routed by r1 router |
| 95 | envelope to: nofile@test.ex |
| 96 | transport: t1 |
| 97 | >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>> |
| 98 | After routing: |
| 99 | Local deliveries: |
| 100 | nofile@test.ex |
| 101 | Remote deliveries: |
| 102 | Failed addresses: |
| 103 | Deferred addresses: |
| 104 | search_tidyup called |
| 105 | >>>>>>>>>>>>>>>> Local deliveries >>>>>>>>>>>>>>>> |
| 106 | --------> nofile@test.ex <-------- |
| 107 | locking TESTSUITE/spool/db/retry.lockfile |
| 108 | locked TESTSUITE/spool/db/retry.lockfile |
| 109 | EXIM_DBOPEN: file <TESTSUITE/spool/db/retry> dir <TESTSUITE/spool/db> flags=O_RDONLY |
| 110 | returned from EXIM_DBOPEN: (nil) |
| 111 | failed to open DB file TESTSUITE/spool/db/retry: No such file or directory |
| 112 | no retry data available |
| 113 | search_tidyup called |
| 114 | changed uid/gid: local delivery to nofile <nofile@test.ex> transport=t1 |
| 115 | uid=CALLER_UID gid=CALLER_GID pid=pppp |
| 116 | home=NULL current=/ |
| 117 | set_process_info: pppp delivering 10HmaX-0005vi-00 to nofile using t1 |
| 118 | appendfile transport entered |
| 119 | appendfile: mode=600 notify_comsat=0 quota=500 warning=0 |
| 120 | directory=TESTSUITE/test-mail/nofile format=maildir |
| 121 | message_prefix=null |
| 122 | message_suffix=null |
| 123 | maildir_use_size_file=yes |
| 124 | ensuring maildir directories exist in TESTSUITE/test-mail/nofile |
| 125 | created directory TESTSUITE/test-mail/nofile |
| 126 | created directory TESTSUITE/test-mail/nofile/tmp |
| 127 | created directory TESTSUITE/test-mail/nofile/new |
| 128 | created directory TESTSUITE/test-mail/nofile/cur |
| 129 | using regex for maildir directory selection: ^(?:cur|new|\..*)$ |
| 130 | looking for maildirsize in TESTSUITE/test-mail/nofile |
| 131 | TESTSUITE/test-mail/nofile/maildirsize does not exist: recalculating |
| 132 | MUNGED: the check_dir_size lines have been sorted to ensure consistency |
| 133 | check_dir_size: dir=TESTSUITE/test-mail/nofile/cur sum=0 count=dd |
| 134 | check_dir_size: dir=TESTSUITE/test-mail/nofile/new sum=0 count=dd |
| 135 | skipping TESTSUITE/test-mail/nofile/tmp: dir_regex does not match |
| 136 | maildir_compute_size: path=TESTSUITE/test-mail/nofile |
| 137 | sum=0 filecount=0 timestamp=ddddddd |
| 138 | checking subdirectory timestamps |
| 139 | MUNGED: the check_dir_size lines have been sorted to ensure consistency |
| 140 | skipping TESTSUITE/test-mail/nofile/maildirsize: dir_regex does not match |
| 141 | skipping TESTSUITE/test-mail/nofile/tmp: dir_regex does not match |
| 142 | maildir_compute_size (timestamp_only): ddddddd |
| 143 | returning maildir size=sss filecount=0 |
| 144 | delivering in maildir format in TESTSUITE/test-mail/nofile |
| 145 | writing to tmp/MAILDIR.myhost.test.ex |
| 146 | Exim quota = 500 old size = sssss this message = sss (included) |
| 147 | file count quota = 0 count = 0 |
| 148 | cannot use sendfile for body: spoolfile not wireformat |
| 149 | writing data block fd=dddd size=sss timeout=0 |
| 150 | added 'ddd 1' to maildirsize file |
| 151 | renaming temporary file |
| 152 | renamed tmp/MAILDIR.myhost.test.ex as new/MAILDIR.myhost.test.ex |
| 153 | appendfile yields 0 with errno=dd more_errno=dd |
| 154 | search_tidyup called |
| 155 | journalling nofile@test.ex |
| 156 | t1 transport returned OK for nofile@test.ex |
| 157 | post-process nofile@test.ex (0) |
| 158 | nofile@test.ex delivered |
| 159 | LOG: MAIN |
| 160 | => nofile <nofile@test.ex> R=r1 T=t1 |
| 161 | >>>>>>>>>>>>>>>> deliveries are done >>>>>>>>>>>>>>>> |
| 162 | changed uid/gid: post-delivery tidying |
| 163 | uid=EXIM_UID gid=EXIM_GID pid=pppp |
| 164 | set_process_info: pppp tidying up after delivering 10HmaX-0005vi-00 |
| 165 | Processing retry items |
| 166 | Succeeded addresses: |
| 167 | nofile@test.ex: no retry items |
| 168 | Failed addresses: |
| 169 | Deferred addresses: |
| 170 | end of retry processing |
| 171 | DSN: processing router : r1 |
| 172 | DSN: processing successful delivery address: nofile@test.ex |
| 173 | DSN: Sender_address: CALLER@test.ex |
| 174 | DSN: orcpt: NULL flags: 0x0 |
| 175 | DSN: envid: NULL ret: 0 |
| 176 | DSN: Final recipient: nofile@test.ex |
| 177 | DSN: Remote SMTP server supports DSN: 0 |
| 178 | DSN: not sending DSN success message |
| 179 | LOG: MAIN |
| 180 | Completed |
| 181 | end delivery of 10HmaX-0005vi-00 |
| 182 | search_tidyup called |
| 183 | search_tidyup called |
| 184 | >>>>>>>>>>>>>>>> Exim pid=pppp (local-accept-delivery) terminating with rc=0 >>>>>>>>>>>>>>>> |
| 185 | search_tidyup called |
| 186 | >>>>>>>>>>>>>>>> Exim pid=pppp (fresh-exec) terminating with rc=0 >>>>>>>>>>>>>>>> |
| 187 | Exim version x.yz .... |
| 188 | changed uid/gid: forcing real = effective |
| 189 | uid=uuuu gid=CALLER_GID pid=pppp |
| 190 | configuration file is TESTSUITE/test-config |
| 191 | admin user |
| 192 | changed uid/gid: privilege not needed |
| 193 | uid=EXIM_UID gid=EXIM_GID pid=pppp |
| 194 | seeking password data for user "CALLER": cache not available |
| 195 | getpwnam() succeeded uid=CALLER_UID gid=CALLER_GID |
| 196 | originator: uid=CALLER_UID gid=CALLER_GID login=CALLER name=CALLER_NAME |
| 197 | sender address = CALLER@test.ex |
| 198 | set_process_info: pppp accepting a local non-SMTP message from <CALLER@test.ex> |
| 199 | spool directory space = nnnnnK inodes = nnnnn check_space = 10240K inodes = 100 msg_size = 0 |
| 200 | log directory space = nnnnnK inodes = nnnnn check_space = 10240K inodes = 100 |
| 201 | Sender: CALLER@test.ex |
| 202 | Recipients: |
| 203 | userx@test.ex |
| 204 | search_tidyup called |
| 205 | >>Headers received: |
| 206 | |
| 207 | rewrite_one_header: type=F: |
| 208 | From: CALLER_NAME <CALLER@test.ex> |
| 209 | search_tidyup called |
| 210 | >>Headers after rewriting and local additions: |
| 211 | I Message-Id: <E10HmaY-0005vi-00@myhost.test.ex> |
| 212 | F From: CALLER_NAME <CALLER@test.ex> |
| 213 | Date: Tue, 2 Mar 1999 09:44:33 +0000 |
| 214 | |
| 215 | Data file name: TESTSUITE/spool//input//10HmaY-0005vi-00-D |
| 216 | Data file written for message 10HmaY-0005vi-00 |
| 217 | >>Generated Received: header line |
| 218 | P Received: from CALLER by myhost.test.ex with local (Exim x.yz) |
| 219 | (envelope-from <CALLER@test.ex>) |
| 220 | id 10HmaY-0005vi-00 |
| 221 | for userx@test.ex; Tue, 2 Mar 1999 09:44:33 +0000 |
| 222 | Writing spool header file: TESTSUITE/spool//input//hdr.10HmaY-0005vi-00 |
| 223 | DSN: **** SPOOL_OUT - address: <userx@test.ex> errorsto: <NULL> orcpt: <NULL> dsn_flags: 0x0 |
| 224 | Renaming spool header file: TESTSUITE/spool//input//10HmaY-0005vi-00-H |
| 225 | Size of headers = sss |
| 226 | LOG: MAIN |
| 227 | <= CALLER@test.ex U=CALLER P=local S=sss |
| 228 | search_tidyup called |
| 229 | exec TESTSUITE/eximdir/exim -DEXIM_PATH=TESTSUITE/eximdir/exim -C TESTSUITE/test-config -d=0xf7715cfd -MCd local-accept-delivery -odi -Mc 10HmaY-0005vi-00 |
| 230 | Exim version x.yz .... |
| 231 | changed uid/gid: forcing real = effective |
| 232 | uid=uuuu gid=EXIM_GID pid=pppp |
| 233 | configuration file is TESTSUITE/test-config |
| 234 | trusted user |
| 235 | admin user |
| 236 | dropping to exim gid; retaining priv uid |
| 237 | seeking password data for user "CALLER": cache not available |
| 238 | getpwnam() succeeded uid=CALLER_UID gid=CALLER_GID |
| 239 | set_process_info: pppp delivering specified messages |
| 240 | set_process_info: pppp delivering 10HmaY-0005vi-00 |
| 241 | Trying spool file TESTSUITE/spool//input//10HmaY-0005vi-00-D |
| 242 | reading spool file 10HmaY-0005vi-00-H |
| 243 | user=CALLER uid=CALLER_UID gid=CALLER_GID sender=CALLER@test.ex |
| 244 | sender_local=1 ident=CALLER |
| 245 | Non-recipients: |
| 246 | Empty Tree |
| 247 | ---- End of tree ---- |
| 248 | recipients_count=1 |
| 249 | **** SPOOL_IN - No additional fields |
| 250 | body_linecount=1 message_linecount=7 |
| 251 | DSN: set orcpt: flags: 0x0 |
| 252 | Delivery address list: |
| 253 | userx@test.ex |
| 254 | locking TESTSUITE/spool/db/retry.lockfile |
| 255 | locked TESTSUITE/spool/db/retry.lockfile |
| 256 | EXIM_DBOPEN: file <TESTSUITE/spool/db/retry> dir <TESTSUITE/spool/db> flags=O_RDONLY |
| 257 | returned from EXIM_DBOPEN: (nil) |
| 258 | failed to open DB file TESTSUITE/spool/db/retry: No such file or directory |
| 259 | no retry data available |
| 260 | >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>> |
| 261 | Considering: userx@test.ex |
| 262 | unique = userx@test.ex |
| 263 | no domain retry record |
| 264 | no address retry record |
| 265 | userx@test.ex: queued for routing |
| 266 | >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>> |
| 267 | routing userx@test.ex |
| 268 | --------> r1 router <-------- |
| 269 | local_part=userx domain=test.ex |
| 270 | calling r1 router |
| 271 | r1 router called for userx@test.ex |
| 272 | domain = test.ex |
| 273 | set transport t1 |
| 274 | queued for t1 transport: local_part = userx |
| 275 | domain = test.ex |
| 276 | errors_to=NULL |
| 277 | domain_data=NULL localpart_data=NULL |
| 278 | routed by r1 router |
| 279 | envelope to: userx@test.ex |
| 280 | transport: t1 |
| 281 | >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>> |
| 282 | After routing: |
| 283 | Local deliveries: |
| 284 | userx@test.ex |
| 285 | Remote deliveries: |
| 286 | Failed addresses: |
| 287 | Deferred addresses: |
| 288 | search_tidyup called |
| 289 | >>>>>>>>>>>>>>>> Local deliveries >>>>>>>>>>>>>>>> |
| 290 | --------> userx@test.ex <-------- |
| 291 | locking TESTSUITE/spool/db/retry.lockfile |
| 292 | locked TESTSUITE/spool/db/retry.lockfile |
| 293 | EXIM_DBOPEN: file <TESTSUITE/spool/db/retry> dir <TESTSUITE/spool/db> flags=O_RDONLY |
| 294 | returned from EXIM_DBOPEN: (nil) |
| 295 | failed to open DB file TESTSUITE/spool/db/retry: No such file or directory |
| 296 | no retry data available |
| 297 | search_tidyup called |
| 298 | changed uid/gid: local delivery to userx <userx@test.ex> transport=t1 |
| 299 | uid=CALLER_UID gid=CALLER_GID pid=pppp |
| 300 | home=NULL current=/ |
| 301 | set_process_info: pppp delivering 10HmaY-0005vi-00 to userx using t1 |
| 302 | appendfile transport entered |
| 303 | appendfile: mode=600 notify_comsat=0 quota=500 warning=0 |
| 304 | directory=TESTSUITE/test-mail/userx format=maildir |
| 305 | message_prefix=null |
| 306 | message_suffix=null |
| 307 | maildir_use_size_file=yes |
| 308 | ensuring maildir directories exist in TESTSUITE/test-mail/userx |
| 309 | created directory TESTSUITE/test-mail/userx/tmp |
| 310 | created directory TESTSUITE/test-mail/userx/new |
| 311 | created directory TESTSUITE/test-mail/userx/cur |
| 312 | using regex for maildir directory selection: ^(?:cur|new|\..*)$ |
| 313 | looking for maildirsize in TESTSUITE/test-mail/userx |
| 314 | reading quota parameters from maildirsize data |
| 315 | cached quota is out of date: recalculating |
| 316 | quota=500 cached_quota=50 filecount_quota=0 cached_quota_filecount=2 |
| 317 | MUNGED: the check_dir_size lines have been sorted to ensure consistency |
| 318 | check_dir_size: dir=TESTSUITE/test-mail/userx/cur sum=0 count=dd |
| 319 | check_dir_size: dir=TESTSUITE/test-mail/userx/new sum=0 count=dd |
| 320 | skipping TESTSUITE/test-mail/userx/maildirsize: dir_regex does not match |
| 321 | skipping TESTSUITE/test-mail/userx/tmp: dir_regex does not match |
| 322 | maildir_compute_size: path=TESTSUITE/test-mail/userx |
| 323 | sum=0 filecount=0 timestamp=ddddddd |
| 324 | checking subdirectory timestamps |
| 325 | MUNGED: the check_dir_size lines have been sorted to ensure consistency |
| 326 | skipping TESTSUITE/test-mail/userx/maildirsize: dir_regex does not match |
| 327 | skipping TESTSUITE/test-mail/userx/tmp: dir_regex does not match |
| 328 | maildir_compute_size (timestamp_only): ddddddd |
| 329 | returning maildir size=sss filecount=0 |
| 330 | delivering in maildir format in TESTSUITE/test-mail/userx |
| 331 | writing to tmp/MAILDIR.myhost.test.ex |
| 332 | Exim quota = 500 old size = sssss this message = sss (included) |
| 333 | file count quota = 0 count = 0 |
| 334 | cannot use sendfile for body: spoolfile not wireformat |
| 335 | writing data block fd=dddd size=sss timeout=0 |
| 336 | added 'ddd 1' to maildirsize file |
| 337 | renaming temporary file |
| 338 | renamed tmp/MAILDIR.myhost.test.ex as new/MAILDIR.myhost.test.ex |
| 339 | appendfile yields 0 with errno=dd more_errno=dd |
| 340 | search_tidyup called |
| 341 | journalling userx@test.ex |
| 342 | t1 transport returned OK for userx@test.ex |
| 343 | post-process userx@test.ex (0) |
| 344 | userx@test.ex delivered |
| 345 | LOG: MAIN |
| 346 | => userx <userx@test.ex> R=r1 T=t1 |
| 347 | >>>>>>>>>>>>>>>> deliveries are done >>>>>>>>>>>>>>>> |
| 348 | changed uid/gid: post-delivery tidying |
| 349 | uid=EXIM_UID gid=EXIM_GID pid=pppp |
| 350 | set_process_info: pppp tidying up after delivering 10HmaY-0005vi-00 |
| 351 | Processing retry items |
| 352 | Succeeded addresses: |
| 353 | userx@test.ex: no retry items |
| 354 | Failed addresses: |
| 355 | Deferred addresses: |
| 356 | end of retry processing |
| 357 | DSN: processing router : r1 |
| 358 | DSN: processing successful delivery address: userx@test.ex |
| 359 | DSN: Sender_address: CALLER@test.ex |
| 360 | DSN: orcpt: NULL flags: 0x0 |
| 361 | DSN: envid: NULL ret: 0 |
| 362 | DSN: Final recipient: userx@test.ex |
| 363 | DSN: Remote SMTP server supports DSN: 0 |
| 364 | DSN: not sending DSN success message |
| 365 | LOG: MAIN |
| 366 | Completed |
| 367 | end delivery of 10HmaY-0005vi-00 |
| 368 | search_tidyup called |
| 369 | search_tidyup called |
| 370 | >>>>>>>>>>>>>>>> Exim pid=pppp (local-accept-delivery) terminating with rc=0 >>>>>>>>>>>>>>>> |
| 371 | search_tidyup called |
| 372 | >>>>>>>>>>>>>>>> Exim pid=pppp (fresh-exec) terminating with rc=0 >>>>>>>>>>>>>>>> |
| 373 | Exim version x.yz .... |
| 374 | changed uid/gid: forcing real = effective |
| 375 | uid=uuuu gid=CALLER_GID pid=pppp |
| 376 | configuration file is TESTSUITE/test-config |
| 377 | admin user |
| 378 | changed uid/gid: privilege not needed |
| 379 | uid=EXIM_UID gid=EXIM_GID pid=pppp |
| 380 | seeking password data for user "CALLER": cache not available |
| 381 | getpwnam() succeeded uid=CALLER_UID gid=CALLER_GID |
| 382 | originator: uid=CALLER_UID gid=CALLER_GID login=CALLER name=CALLER_NAME |
| 383 | sender address = CALLER@test.ex |
| 384 | set_process_info: pppp accepting a local non-SMTP message from <CALLER@test.ex> |
| 385 | spool directory space = nnnnnK inodes = nnnnn check_space = 10240K inodes = 100 msg_size = 0 |
| 386 | log directory space = nnnnnK inodes = nnnnn check_space = 10240K inodes = 100 |
| 387 | Sender: CALLER@test.ex |
| 388 | Recipients: |
| 389 | userx@test.ex |
| 390 | search_tidyup called |
| 391 | >>Headers received: |
| 392 | |
| 393 | rewrite_one_header: type=F: |
| 394 | From: CALLER_NAME <CALLER@test.ex> |
| 395 | search_tidyup called |
| 396 | >>Headers after rewriting and local additions: |
| 397 | I Message-Id: <E10HmaZ-0005vi-00@myhost.test.ex> |
| 398 | F From: CALLER_NAME <CALLER@test.ex> |
| 399 | Date: Tue, 2 Mar 1999 09:44:33 +0000 |
| 400 | |
| 401 | Data file name: TESTSUITE/spool//input//10HmaZ-0005vi-00-D |
| 402 | Data file written for message 10HmaZ-0005vi-00 |
| 403 | >>Generated Received: header line |
| 404 | P Received: from CALLER by myhost.test.ex with local (Exim x.yz) |
| 405 | (envelope-from <CALLER@test.ex>) |
| 406 | id 10HmaZ-0005vi-00 |
| 407 | for userx@test.ex; Tue, 2 Mar 1999 09:44:33 +0000 |
| 408 | Writing spool header file: TESTSUITE/spool//input//hdr.10HmaZ-0005vi-00 |
| 409 | DSN: **** SPOOL_OUT - address: <userx@test.ex> errorsto: <NULL> orcpt: <NULL> dsn_flags: 0x0 |
| 410 | Renaming spool header file: TESTSUITE/spool//input//10HmaZ-0005vi-00-H |
| 411 | Size of headers = sss |
| 412 | LOG: MAIN |
| 413 | <= CALLER@test.ex U=CALLER P=local S=sss |
| 414 | search_tidyup called |
| 415 | exec TESTSUITE/eximdir/exim -DEXIM_PATH=TESTSUITE/eximdir/exim -C TESTSUITE/test-config -d=0xf7715cfd -MCd local-accept-delivery -odi -Mc 10HmaZ-0005vi-00 |
| 416 | Exim version x.yz .... |
| 417 | changed uid/gid: forcing real = effective |
| 418 | uid=uuuu gid=EXIM_GID pid=pppp |
| 419 | configuration file is TESTSUITE/test-config |
| 420 | trusted user |
| 421 | admin user |
| 422 | dropping to exim gid; retaining priv uid |
| 423 | seeking password data for user "CALLER": cache not available |
| 424 | getpwnam() succeeded uid=CALLER_UID gid=CALLER_GID |
| 425 | set_process_info: pppp delivering specified messages |
| 426 | set_process_info: pppp delivering 10HmaZ-0005vi-00 |
| 427 | Trying spool file TESTSUITE/spool//input//10HmaZ-0005vi-00-D |
| 428 | reading spool file 10HmaZ-0005vi-00-H |
| 429 | user=CALLER uid=CALLER_UID gid=CALLER_GID sender=CALLER@test.ex |
| 430 | sender_local=1 ident=CALLER |
| 431 | Non-recipients: |
| 432 | Empty Tree |
| 433 | ---- End of tree ---- |
| 434 | recipients_count=1 |
| 435 | **** SPOOL_IN - No additional fields |
| 436 | body_linecount=1 message_linecount=7 |
| 437 | DSN: set orcpt: flags: 0x0 |
| 438 | Delivery address list: |
| 439 | userx@test.ex |
| 440 | locking TESTSUITE/spool/db/retry.lockfile |
| 441 | locked TESTSUITE/spool/db/retry.lockfile |
| 442 | EXIM_DBOPEN: file <TESTSUITE/spool/db/retry> dir <TESTSUITE/spool/db> flags=O_RDONLY |
| 443 | returned from EXIM_DBOPEN: (nil) |
| 444 | failed to open DB file TESTSUITE/spool/db/retry: No such file or directory |
| 445 | no retry data available |
| 446 | >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>> |
| 447 | Considering: userx@test.ex |
| 448 | unique = userx@test.ex |
| 449 | no domain retry record |
| 450 | no address retry record |
| 451 | userx@test.ex: queued for routing |
| 452 | >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>> |
| 453 | routing userx@test.ex |
| 454 | --------> r1 router <-------- |
| 455 | local_part=userx domain=test.ex |
| 456 | calling r1 router |
| 457 | r1 router called for userx@test.ex |
| 458 | domain = test.ex |
| 459 | set transport t1 |
| 460 | queued for t1 transport: local_part = userx |
| 461 | domain = test.ex |
| 462 | errors_to=NULL |
| 463 | domain_data=NULL localpart_data=NULL |
| 464 | routed by r1 router |
| 465 | envelope to: userx@test.ex |
| 466 | transport: t1 |
| 467 | >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>> |
| 468 | After routing: |
| 469 | Local deliveries: |
| 470 | userx@test.ex |
| 471 | Remote deliveries: |
| 472 | Failed addresses: |
| 473 | Deferred addresses: |
| 474 | search_tidyup called |
| 475 | >>>>>>>>>>>>>>>> Local deliveries >>>>>>>>>>>>>>>> |
| 476 | --------> userx@test.ex <-------- |
| 477 | locking TESTSUITE/spool/db/retry.lockfile |
| 478 | locked TESTSUITE/spool/db/retry.lockfile |
| 479 | EXIM_DBOPEN: file <TESTSUITE/spool/db/retry> dir <TESTSUITE/spool/db> flags=O_RDONLY |
| 480 | returned from EXIM_DBOPEN: (nil) |
| 481 | failed to open DB file TESTSUITE/spool/db/retry: No such file or directory |
| 482 | no retry data available |
| 483 | search_tidyup called |
| 484 | changed uid/gid: local delivery to userx <userx@test.ex> transport=t1 |
| 485 | uid=CALLER_UID gid=CALLER_GID pid=pppp |
| 486 | home=NULL current=/ |
| 487 | set_process_info: pppp delivering 10HmaZ-0005vi-00 to userx using t1 |
| 488 | appendfile transport entered |
| 489 | appendfile: mode=600 notify_comsat=0 quota=500 warning=0 |
| 490 | directory=TESTSUITE/test-mail/userx format=maildir |
| 491 | message_prefix=null |
| 492 | message_suffix=null |
| 493 | maildir_use_size_file=yes |
| 494 | ensuring maildir directories exist in TESTSUITE/test-mail/userx |
| 495 | using regex for maildir directory selection: ^(?:cur|new|\..*)$ |
| 496 | looking for maildirsize in TESTSUITE/test-mail/userx |
| 497 | reading quota parameters from maildirsize data |
| 498 | computing maildir size from maildirsize data |
| 499 | over quota and maildirsize has more than 1 entry: recalculating |
| 500 | MUNGED: the check_dir_size lines have been sorted to ensure consistency |
| 501 | check_dir_size: dir=TESTSUITE/test-mail/userx/cur sum=0 count=dd |
| 502 | check_dir_size: dir=TESTSUITE/test-mail/userx/new sum=dddd count=dd |
| 503 | skipping TESTSUITE/test-mail/userx/maildirsize: dir_regex does not match |
| 504 | skipping TESTSUITE/test-mail/userx/tmp: dir_regex does not match |
| 505 | maildir_compute_size: path=TESTSUITE/test-mail/userx |
| 506 | sum=dddd filecount=1 timestamp=ddddddd |
| 507 | checking subdirectory timestamps |
| 508 | MUNGED: the check_dir_size lines have been sorted to ensure consistency |
| 509 | skipping TESTSUITE/test-mail/userx/maildirsize: dir_regex does not match |
| 510 | skipping TESTSUITE/test-mail/userx/tmp: dir_regex does not match |
| 511 | maildir_compute_size (timestamp_only): ddddddd |
| 512 | returning maildir size=sss filecount=1 |
| 513 | delivering in maildir format in TESTSUITE/test-mail/userx |
| 514 | writing to tmp/MAILDIR.myhost.test.ex |
| 515 | Exim quota = 500 old size = sssss this message = sss (included) |
| 516 | file count quota = 0 count = 1 |
| 517 | mailbox quota exceeded |
| 518 | maildir: time since "new" directory modified = 10s |
| 519 | Exim quota exceeded for tmp/dddddddddd.HddddddPddddd.myhost.test.ex |
| 520 | appendfile yields 1 with errno=-22 more_errno=dd |
| 521 | search_tidyup called |
| 522 | t1 transport returned DEFER for userx@test.ex |
| 523 | added retry item for T:userx@test.ex: errno=-22 more_errno=dd flags=0 |
| 524 | post-process userx@test.ex (1) |
| 525 | LOG: MAIN |
| 526 | == userx@test.ex R=r1 T=t1 defer (-22): mailbox is full (MTA-imposed quota exceeded while writing to tmp/MAILDIR.myhost.test.ex) |
| 527 | >>>>>>>>>>>>>>>> deliveries are done >>>>>>>>>>>>>>>> |
| 528 | changed uid/gid: post-delivery tidying |
| 529 | uid=EXIM_UID gid=EXIM_GID pid=pppp |
| 530 | set_process_info: pppp tidying up after delivering 10HmaZ-0005vi-00 |
| 531 | Processing retry items |
| 532 | Succeeded addresses: |
| 533 | Failed addresses: |
| 534 | Deferred addresses: |
| 535 | userx@test.ex |
| 536 | locking TESTSUITE/spool/db/retry.lockfile |
| 537 | locked TESTSUITE/spool/db/retry.lockfile |
| 538 | EXIM_DBOPEN: file <TESTSUITE/spool/db/retry> dir <TESTSUITE/spool/db> flags=O_RDWR |
| 539 | returned from EXIM_DBOPEN: 0xAAAAAAAA |
| 540 | opened hints database TESTSUITE/spool/db/retry: flags=O_RDWR |
| 541 | address match test: subject=userx@test.ex pattern=* |
| 542 | test.ex in "*"? yes (matched "*") |
| 543 | userx@test.ex in "*"? yes (matched "*") |
| 544 | retry for T:userx@test.ex = * 0 0 |
| 545 | dbfn_read: key=T:userx@test.ex |
| 546 | failing_interval=ttt message_age=ttt |
| 547 | Writing retry data for T:userx@test.ex |
| 548 | first failed=dddd last try=dddd next try=+86400 expired=0 |
| 549 | errno=-22 more_errno=dd mailbox is full (MTA-imposed quota exceeded while writing to tmp/MAILDIR.myhost.test.ex) |
| 550 | dbfn_write: key=T:userx@test.ex |
| 551 | EXIM_DBCLOSE(0xAAAAAAAA) |
| 552 | closed hints database and lockfile |
| 553 | end of retry processing |
| 554 | delivery deferred: update_spool=1 header_rewritten=0 |
| 555 | Writing spool header file: TESTSUITE/spool//input//hdr.10HmaZ-0005vi-00 |
| 556 | DSN: **** SPOOL_OUT - address: <userx@test.ex> errorsto: <NULL> orcpt: <NULL> dsn_flags: 0x0 |
| 557 | Renaming spool header file: TESTSUITE/spool//input//10HmaZ-0005vi-00-H |
| 558 | Size of headers = sss |
| 559 | end delivery of 10HmaZ-0005vi-00 |
| 560 | search_tidyup called |
| 561 | search_tidyup called |
| 562 | >>>>>>>>>>>>>>>> Exim pid=pppp (local-accept-delivery) terminating with rc=0 >>>>>>>>>>>>>>>> |
| 563 | search_tidyup called |
| 564 | >>>>>>>>>>>>>>>> Exim pid=pppp (fresh-exec) terminating with rc=0 >>>>>>>>>>>>>>>> |
| 565 | Exim version x.yz .... |
| 566 | changed uid/gid: forcing real = effective |
| 567 | uid=uuuu gid=CALLER_GID pid=pppp |
| 568 | configuration file is TESTSUITE/test-config |
| 569 | admin user |
| 570 | changed uid/gid: privilege not needed |
| 571 | uid=EXIM_UID gid=EXIM_GID pid=pppp |
| 572 | seeking password data for user "CALLER": cache not available |
| 573 | getpwnam() succeeded uid=CALLER_UID gid=CALLER_GID |
| 574 | originator: uid=CALLER_UID gid=CALLER_GID login=CALLER name=CALLER_NAME |
| 575 | sender address = CALLER@test.ex |
| 576 | set_process_info: pppp accepting a local non-SMTP message from <CALLER@test.ex> |
| 577 | spool directory space = nnnnnK inodes = nnnnn check_space = 10240K inodes = 100 msg_size = 0 |
| 578 | log directory space = nnnnnK inodes = nnnnn check_space = 10240K inodes = 100 |
| 579 | Sender: CALLER@test.ex |
| 580 | Recipients: |
| 581 | userx@test.ex |
| 582 | search_tidyup called |
| 583 | >>Headers received: |
| 584 | |
| 585 | rewrite_one_header: type=F: |
| 586 | From: CALLER_NAME <CALLER@test.ex> |
| 587 | search_tidyup called |
| 588 | >>Headers after rewriting and local additions: |
| 589 | I Message-Id: <E10HmbA-0005vi-00@myhost.test.ex> |
| 590 | F From: CALLER_NAME <CALLER@test.ex> |
| 591 | Date: Tue, 2 Mar 1999 09:44:33 +0000 |
| 592 | |
| 593 | Data file name: TESTSUITE/spool//input//10HmbA-0005vi-00-D |
| 594 | Data file written for message 10HmbA-0005vi-00 |
| 595 | >>Generated Received: header line |
| 596 | P Received: from CALLER by myhost.test.ex with local (Exim x.yz) |
| 597 | (envelope-from <CALLER@test.ex>) |
| 598 | id 10HmbA-0005vi-00 |
| 599 | for userx@test.ex; Tue, 2 Mar 1999 09:44:33 +0000 |
| 600 | Writing spool header file: TESTSUITE/spool//input//hdr.10HmbA-0005vi-00 |
| 601 | DSN: **** SPOOL_OUT - address: <userx@test.ex> errorsto: <NULL> orcpt: <NULL> dsn_flags: 0x0 |
| 602 | Renaming spool header file: TESTSUITE/spool//input//10HmbA-0005vi-00-H |
| 603 | Size of headers = sss |
| 604 | LOG: MAIN |
| 605 | <= CALLER@test.ex U=CALLER P=local S=sss |
| 606 | search_tidyup called |
| 607 | exec TESTSUITE/eximdir/exim -DEXIM_PATH=TESTSUITE/eximdir/exim -C TESTSUITE/test-config -d=0xf7715cfd -MCd local-accept-delivery -odi -Mc 10HmbA-0005vi-00 |
| 608 | Exim version x.yz .... |
| 609 | changed uid/gid: forcing real = effective |
| 610 | uid=uuuu gid=EXIM_GID pid=pppp |
| 611 | configuration file is TESTSUITE/test-config |
| 612 | trusted user |
| 613 | admin user |
| 614 | dropping to exim gid; retaining priv uid |
| 615 | seeking password data for user "CALLER": cache not available |
| 616 | getpwnam() succeeded uid=CALLER_UID gid=CALLER_GID |
| 617 | set_process_info: pppp delivering specified messages |
| 618 | set_process_info: pppp delivering 10HmbA-0005vi-00 |
| 619 | Trying spool file TESTSUITE/spool//input//10HmbA-0005vi-00-D |
| 620 | reading spool file 10HmbA-0005vi-00-H |
| 621 | user=CALLER uid=CALLER_UID gid=CALLER_GID sender=CALLER@test.ex |
| 622 | sender_local=1 ident=CALLER |
| 623 | Non-recipients: |
| 624 | Empty Tree |
| 625 | ---- End of tree ---- |
| 626 | recipients_count=1 |
| 627 | **** SPOOL_IN - No additional fields |
| 628 | body_linecount=1 message_linecount=7 |
| 629 | DSN: set orcpt: flags: 0x0 |
| 630 | Delivery address list: |
| 631 | userx@test.ex |
| 632 | locking TESTSUITE/spool/db/retry.lockfile |
| 633 | locked TESTSUITE/spool/db/retry.lockfile |
| 634 | EXIM_DBOPEN: file <TESTSUITE/spool/db/retry> dir <TESTSUITE/spool/db> flags=O_RDONLY |
| 635 | returned from EXIM_DBOPEN: 0xAAAAAAAA |
| 636 | opened hints database TESTSUITE/spool/db/retry: flags=O_RDONLY |
| 637 | >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>> |
| 638 | Considering: userx@test.ex |
| 639 | unique = userx@test.ex |
| 640 | dbfn_read: key=R:test.ex |
| 641 | dbfn_read: key=R:userx@test.ex |
| 642 | dbfn_read: key=R:userx@test.ex:<CALLER@test.ex> |
| 643 | no domain retry record |
| 644 | no address retry record |
| 645 | userx@test.ex: queued for routing |
| 646 | EXIM_DBCLOSE(0xAAAAAAAA) |
| 647 | closed hints database and lockfile |
| 648 | >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>> |
| 649 | routing userx@test.ex |
| 650 | --------> r1 router <-------- |
| 651 | local_part=userx domain=test.ex |
| 652 | calling r1 router |
| 653 | r1 router called for userx@test.ex |
| 654 | domain = test.ex |
| 655 | set transport t1 |
| 656 | queued for t1 transport: local_part = userx |
| 657 | domain = test.ex |
| 658 | errors_to=NULL |
| 659 | domain_data=NULL localpart_data=NULL |
| 660 | routed by r1 router |
| 661 | envelope to: userx@test.ex |
| 662 | transport: t1 |
| 663 | >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>> |
| 664 | After routing: |
| 665 | Local deliveries: |
| 666 | userx@test.ex |
| 667 | Remote deliveries: |
| 668 | Failed addresses: |
| 669 | Deferred addresses: |
| 670 | search_tidyup called |
| 671 | >>>>>>>>>>>>>>>> Local deliveries >>>>>>>>>>>>>>>> |
| 672 | --------> userx@test.ex <-------- |
| 673 | locking TESTSUITE/spool/db/retry.lockfile |
| 674 | locked TESTSUITE/spool/db/retry.lockfile |
| 675 | EXIM_DBOPEN: file <TESTSUITE/spool/db/retry> dir <TESTSUITE/spool/db> flags=O_RDONLY |
| 676 | returned from EXIM_DBOPEN: 0xAAAAAAAA |
| 677 | opened hints database TESTSUITE/spool/db/retry: flags=O_RDONLY |
| 678 | dbfn_read: key=T:userx@test.ex |
| 679 | retry record exists: age=ttt (max 1w) |
| 680 | time to retry = tttt expired = 0 |
| 681 | EXIM_DBCLOSE(0xAAAAAAAA) |
| 682 | closed hints database and lockfile |
| 683 | search_tidyup called |
| 684 | changed uid/gid: local delivery to userx <userx@test.ex> transport=t1 |
| 685 | uid=CALLER_UID gid=CALLER_GID pid=pppp |
| 686 | home=NULL current=/ |
| 687 | set_process_info: pppp delivering 10HmbA-0005vi-00 to userx using t1 |
| 688 | appendfile transport entered |
| 689 | appendfile: mode=600 notify_comsat=0 quota=500 warning=0 |
| 690 | directory=TESTSUITE/test-mail/userx format=maildir |
| 691 | message_prefix=null |
| 692 | message_suffix=null |
| 693 | maildir_use_size_file=yes |
| 694 | ensuring maildir directories exist in TESTSUITE/test-mail/userx |
| 695 | using regex for maildir directory selection: ^(?:cur|new|\..*)$ |
| 696 | looking for maildirsize in TESTSUITE/test-mail/userx |
| 697 | reading quota parameters from maildirsize data |
| 698 | computing maildir size from maildirsize data |
| 699 | returning maildir size=sss filecount=1 |
| 700 | delivering in maildir format in TESTSUITE/test-mail/userx |
| 701 | writing to tmp/MAILDIR.myhost.test.ex |
| 702 | Exim quota = 500 old size = sssss this message = sss (included) |
| 703 | file count quota = 0 count = 1 |
| 704 | mailbox quota exceeded |
| 705 | maildir: time since "new" directory modified = 10s |
| 706 | Exim quota exceeded for tmp/dddddddddd.HddddddPddddd.myhost.test.ex |
| 707 | appendfile yields 1 with errno=-22 more_errno=dd |
| 708 | search_tidyup called |
| 709 | t1 transport returned DEFER for userx@test.ex |
| 710 | added retry item for T:userx@test.ex: errno=-22 more_errno=dd flags=0 |
| 711 | post-process userx@test.ex (1) |
| 712 | LOG: MAIN |
| 713 | == userx@test.ex R=r1 T=t1 defer (-22): mailbox is full (MTA-imposed quota exceeded while writing to tmp/MAILDIR.myhost.test.ex) |
| 714 | >>>>>>>>>>>>>>>> deliveries are done >>>>>>>>>>>>>>>> |
| 715 | changed uid/gid: post-delivery tidying |
| 716 | uid=EXIM_UID gid=EXIM_GID pid=pppp |
| 717 | set_process_info: pppp tidying up after delivering 10HmbA-0005vi-00 |
| 718 | Processing retry items |
| 719 | Succeeded addresses: |
| 720 | Failed addresses: |
| 721 | Deferred addresses: |
| 722 | userx@test.ex |
| 723 | locking TESTSUITE/spool/db/retry.lockfile |
| 724 | locked TESTSUITE/spool/db/retry.lockfile |
| 725 | EXIM_DBOPEN: file <TESTSUITE/spool/db/retry> dir <TESTSUITE/spool/db> flags=O_RDWR |
| 726 | returned from EXIM_DBOPEN: 0xAAAAAAAA |
| 727 | opened hints database TESTSUITE/spool/db/retry: flags=O_RDWR |
| 728 | address match test: subject=userx@test.ex pattern=* |
| 729 | test.ex in "*"? yes (matched "*") |
| 730 | userx@test.ex in "*"? yes (matched "*") |
| 731 | retry for T:userx@test.ex = * 0 0 |
| 732 | dbfn_read: key=T:userx@test.ex |
| 733 | failing_interval=ttt message_age=ttt |
| 734 | Writing retry data for T:userx@test.ex |
| 735 | first failed=dddd last try=dddd next try=+86400 expired=0 |
| 736 | errno=-22 more_errno=dd mailbox is full (MTA-imposed quota exceeded while writing to tmp/MAILDIR.myhost.test.ex) |
| 737 | dbfn_write: key=T:userx@test.ex |
| 738 | EXIM_DBCLOSE(0xAAAAAAAA) |
| 739 | closed hints database and lockfile |
| 740 | end of retry processing |
| 741 | delivery deferred: update_spool=1 header_rewritten=0 |
| 742 | Writing spool header file: TESTSUITE/spool//input//hdr.10HmbA-0005vi-00 |
| 743 | DSN: **** SPOOL_OUT - address: <userx@test.ex> errorsto: <NULL> orcpt: <NULL> dsn_flags: 0x0 |
| 744 | Renaming spool header file: TESTSUITE/spool//input//10HmbA-0005vi-00-H |
| 745 | Size of headers = sss |
| 746 | end delivery of 10HmbA-0005vi-00 |
| 747 | search_tidyup called |
| 748 | search_tidyup called |
| 749 | >>>>>>>>>>>>>>>> Exim pid=pppp (local-accept-delivery) terminating with rc=0 >>>>>>>>>>>>>>>> |
| 750 | search_tidyup called |
| 751 | >>>>>>>>>>>>>>>> Exim pid=pppp (fresh-exec) terminating with rc=0 >>>>>>>>>>>>>>>> |