test/stderr/5005

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