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