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