test/stderr/5005

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