test/stderr/5005

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