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