fix retry time
[Pman.Core] / NotifySend.php
1 <?php
2 require_once 'Pman.php';
3
4 /**
5  * notification script sender - designed to be run by the Notify script - with many children running
6  * in parallel.
7  *
8  * called with an id of a core_notify element
9  *
10  * uses core_notify - to find an event to object and person.
11  *
12  * uses Events table to log failures
13  * 
14  * 
15  * calls $object->toEmail($person,$last_send, $notify) to generate an email struct with
16  *  array (
17  *      headers =>
18  *      recipients =>
19  *      body =>
20  *  )
21  *
22  *
23  * Note uses configuration
24  *
25  * Pman_Core_NotifySend[host] = 'localhost' << to override direct sending..
26  * Mail[helo] << helo host name
27  * Mail[socket_options] << any socket option.
28  */
29 class Pman_Core_NotifySend_Exception_Success extends Exception {}
30 class Pman_Core_NotifySend_Exception_Fail extends Exception {}
31
32
33 class Pman_Core_NotifySend extends Pman
34 {
35     static $cli_desc = "Send out single notification email (usually called from  Core/Notify)";
36     
37     static $cli_opts = array(
38         'debug' => array(
39             'desc' => 'Turn on debugging (see DataObjects debugLevel )',
40             'default' => 0,
41             'short' => 'v',
42             'min' => 0,
43             'max' => 0,
44             
45         ),
46         'DB_DataObject-debug' => array(
47             'desc' => 'Turn on debugging (see DataObjects debugLevel )',
48             'default' => 0,
49             'short' => 'd',
50             'min' => 1,
51             'max' => 1,
52             
53         ),
54         'force' => array(
55             'desc' => 'Force redelivery, even if it has been sent before or not queued...',
56             'default' => 0,
57             'short' => 'f',
58             'min' => 0,
59             'max' => 0,
60         ),
61         'send-to' => array(
62             'desc' => 'Send the message to this address, rather than the one listed.',
63             'default' => '',
64             'short' => 't',
65             'min' => 0,
66             'max' => 1,
67         )
68         
69         
70         
71     );
72     var $table = 'core_notify';
73     var $error_handler = 'die';
74     var $poolname = 'core';
75     var $server; // core_notify_server
76     
77     function getAuth()
78     {
79         $ff = HTML_FlexyFramework::get();
80         if (!$ff->cli) {
81             $this->errorHandler("access denied");
82         }
83         //HTML_FlexyFramework::ensureSingle(__FILE__, $this);
84         return true;
85         
86     }
87    
88     function get($id,$opts=array())
89     {
90
91         //print_r($opts);
92         if (!empty($opts['DB_DataObject-debug'])) {
93             DB_DataObject::debugLevel($opts['DB_DataObject-debug']);
94         }
95         
96         //DB_DataObject::debugLevel(1);
97         //date_default_timezone_set('UTC');
98         // phpinfo();exit;
99         $force = empty($opts['force']) ? 0 : 1;
100         
101         $w = DB_DataObject::factory($this->table);
102
103         if (!$w->get($id)) {
104             $this->errorHandler("invalid id\n");
105         }
106
107         if (!$force && !empty($w->sent) && strtotime($w->act_when) < strtotime($w->sent)) {
108              
109             $this->errorHandler("already sent - repeat to early\n");
110         }
111         
112         $this->server = DB_DataObject::Factory('core_notify_server')->getCurrent($this, $force);
113         if (!$force &&  $w->server_id != $this->server->id) {
114             $this->errorHandler("Server id does not match - use force to try again\n");
115         }
116         
117         
118         if (!empty($opts['debug'])) {
119             print_r($w);
120             $ff = HTML_FlexyFramework::get();
121             if (!isset($ff->Core_Mailer)) {
122                 $ff->Core_Mailer = array();
123             }
124             HTML_FlexyFramework::get()->Core_Mailer['debug'] = true;
125         }
126         
127         $sent = (empty($w->sent) || preg_match('/^0000/', $w->sent)) ? false : true;
128         
129         if (!$force && (!empty($w->msgid) || $sent)) {
130             $ww = clone($w);
131             if (!$sent) {   // fix sent.
132                 $w->sent = $w->sent == '0000-00-00 00:00:00' ? $w->sqlValue('NOW()') :$w->sent; // do not update if sent.....
133                 $w->update($ww);
134             }    
135             $this->errorHandler("message has been sent already.\n");
136         }
137         
138         $o = $w->object();
139         
140         if ($o === false)  {
141              
142             $ev = $this->addEvent('NOTIFY', $w,   "Notification event cleared (underlying object does not exist)" );
143             $w->flagDone($ev, '');
144             $this->errorHandler(  $ev->remarks);
145         }
146      
147         
148         
149         $p = $w->person();
150         
151         if (isset($p->active) && empty($p->active)) {
152             $ev = $this->addEvent('NOTIFY', $w, "Notification event cleared (not user not active any more)" );;
153              $w->flagDone($ev, '');
154             $this->errorHandler(  $ev->remarks);
155         }
156         // has it failed mutliple times..
157         
158         if (!empty($w->field) && isset($p->{$w->field .'_fails'}) && $p->{$w->field .'_fails'} > 9) {
159             $ev = $this->addEvent('NOTIFY', $w, "Notification event cleared (user has to many failures)" );;
160             $w->flagDone($ev, '');
161             $this->errorHandler(  $ev->remarks);
162         }
163         
164         // let's work out the last notification sent to this user..
165         $l = DB_DataObject::factory($this->table);
166         
167         $lar = array(
168                 'ontable' => $w->ontable,
169                 'onid' => $w->onid,
170         );
171         // only newer version of the database us this..
172         if (isset($w->person_table)) {
173             $personid_col = strtolower($w->person_table).'_id';
174             if (isset($w->{$personid_col})) {
175                 $lar[$personid_col] = $w->{$personid_col};
176             }
177         }
178         
179         
180         $l->setFrom( $lar );       
181         $l->whereAdd('id != '. $w->id);
182         $l->orderBy('sent DESC');
183         $l->limit(1);
184         $ar = $l->fetchAll('sent');
185         $last = empty($ar) ? date('Y-m-d H:i:s', 0) : $ar[0];
186         
187         // find last event..
188         $ev = DB_DataObject::factory('Events');
189         $ev->on_id = $w->id;                           // int(11)
190         $ev->on_table = $this->table;
191         $ev->limit(1);
192         $ev->orderBy('event_when DESC');
193         $ar = $ev->fetchAll('event_when');
194         $last_event = empty($ar) ? 0 : $ar[0];
195         $next_try_min = 5;
196         if ($last_event) {
197             $next_try_min = floor((time() - strtotime($last_event)) / 60) * 2;
198         }
199         $next_try = $next_try_min . ' MINUTES';
200          
201         // this may modify $p->email. (it will not update it though)
202         $email =  $this->makeEmail($o, $p, $last, $w, $force);
203         
204         if ($email === true)  {
205             $ev = $this->addEvent('NOTIFY', $w, "Notification event cleared (not required any more) - toEmail=true" );;
206             $w->flagDone($ev, '');
207             $this->errorHandler( $ev->remarks);
208         }
209         if (is_a($email, 'PEAR_Error')) {
210             $email =array(
211                 'error' => $email->toString()
212             );
213         }
214         
215         if (empty($p) && !empty($email['recipients'])) {
216             // make a fake person..
217             $p = (object) array(
218                 'email' => $email['recipients']
219             );
220         }
221          
222         if ($email === false || isset($email['error']) || empty($p)) {
223             // object returned 'false' - it does not know how to send it..
224             $ev = $this->addEvent('NOTIFYFAIL', $w, isset($email['error'])  ? $email['error'] : "INTERNAL ERROR  - We can not handle " . $w->ontable); 
225             $w->flagDone($ev, '');
226             $this->errorHandler(  $ev->remarks);
227         }
228         
229          
230         
231         if (isset($email['later'])) {
232             
233             $this->server->updateNotifyToNextServer($w, $email['later'],true);
234              
235             $this->errorHandler("Delivery postponed by email creator to {$email['later']}");
236         }
237         
238          
239         if (empty($email['headers']['Message-Id'])) {
240             $HOST = gethostname();
241             $email['headers']['Message-Id'] = "<{$this->table}-{$id}@{$HOST}>";
242             
243         }
244         
245         
246             
247         
248         //$p->email = 'alan@akbkhome.com'; //for testing..
249         //print_r($email);exit;
250         // should we fetch the watch that caused it.. - which should contain the method to call..
251         // --send-to=test@xxx.com
252        
253         if (!empty($email['send-to'])) {
254             $p->email = $email['send-to'];
255         }
256          if (!empty($opts['send-to'])) {
257             $p->email = $opts['send-to'];
258         }
259         
260             // since some of them have spaces?!?!
261         $p->email = trim($p->email);
262         $ww = clone($w);
263         $ww->to_email = empty($ww->to_email) ? $p->email : $ww->to_email;
264         $explode_email = explode('@', $ww->to_email);
265         $dom = array_pop($explode_email);
266         
267         $core_domain = DB_DataObject::factory('core_domain')->loadOrCreate($dom);
268
269         
270         $ww->domain_id = $core_domain->id;
271         // if to_email has not been set!?
272         $ww->update($w); // if nothing has changed this will not do anything.
273         $w = clone($ww);
274     
275       
276         
277         require_once 'Validate.php';
278         if (!Validate::email($p->email, true)) {
279             $ev = $this->addEvent('NOTIFYFAIL', $w, "INVALID ADDRESS: " . $p->email);
280             $w->flagDone($ev, '');
281             $this->errorHandler($ev->remarks);
282             
283         }
284         
285         
286         $ff = HTML_FlexyFramework::get();
287         
288      
289         $mxs = $this->mxs($dom);
290         $ww = clone($w);
291
292         // we might fail doing this...
293         // need to handle temporary failure..
294        
295         
296           // we try for 2 days..
297         $retry = 15;
298         if (strtotime($w->act_start) <  strtotime('NOW - 1 HOUR')) {
299             // older that 1 hour.
300             $retry = 60;
301         }
302         
303         if (strtotime($w->act_start) <  strtotime('NOW - 1 DAY')) {
304             // older that 1 day.
305             $retry = 120;
306         }
307         if (strtotime($w->act_start) <  strtotime('NOW - 2 DAY')) {
308             // older that 1 day.
309             $retry = 240;
310         }
311         
312         if (empty($mxs)) {
313             // only retry for 1 day if the MX issue..
314             if ($retry < 240) {
315                 $this->addEvent('NOTIFY', $w, 'MX LOOKUP FAILED ' . $dom );
316                 $w->flagLater(date('Y-m-d H:i:s', strtotime('NOW + ' . $retry . ' MINUTES')));
317                 $this->errorHandler($ev->remarks);
318             }
319             
320             $ev = $this->addEvent('NOTIFYFAIL', $w, "BAD ADDRESS - BAD DOMAIN - ". $p->email );
321             $w->flagDone($ev, '');
322             $this->errorHandler($ev->remarks);
323             
324             
325         }
326         
327         
328         
329         
330         if (!$force && strtotime($w->act_start) <  strtotime('NOW - 3 DAY')) {
331             $ev = $this->addEvent('NOTIFYFAIL', $w, "BAD ADDRESS - GIVE UP - ". $p->email );
332             $w->flagDone($ev, '');
333             $this->errorHandler(  $ev->remarks);
334         }
335         
336         $retry_when = date('Y-m-d H:i:s', strtotime('NOW + ' . $retry . ' MINUTES'));
337         
338         //$this->addEvent('NOTIFY', $w, 'GREYLISTED ' . $p->email . ' ' . $res->toString());
339         // we can only update act_when if it has not been sent already (only happens when running in force mode..)
340         // set act when if it's empty...
341         $w->act_when =  (!$w->act_when || $w->act_when == '0000-00-00 00:00:00') ? $retry_when : $w->act_when;
342         
343         $w->update($ww);
344         
345         $ww = clone($w);   
346         
347         $fail = false;
348         require_once 'Mail.php';
349         
350         
351         $this->server->initHelo();
352         
353         if (!isset($ff->Mail['helo'])) {
354             $this->errorHandler("config Mail[helo] is not set");
355         }
356         
357         
358                         
359         foreach($mxs as $mx) {
360             
361            
362             $this->debug_str = '';
363             $this->debug("Trying SMTP: $mx / HELO {$ff->Mail['helo']}");
364             $mailer = Mail::factory('smtp', array(
365                     'host'    => $mx ,
366                     'localhost' => $ff->Mail['helo'],
367                     'timeout' => 15,
368                     'socket_options' =>  isset($ff->Mail['socket_options']) ? $ff->Mail['socket_options'] : null,
369                     //'debug' => isset($opts['debug']) ?  1 : 0,
370                     'debug' => 1,
371                     'debug_handler' => array($this, 'debugHandler')
372             ));
373             
374             // if the host is the mail host + it's authenticated add auth details
375             // this normally will happen if you sent  Pman_Core_NotifySend['host']
376              
377             
378             if (isset($ff->Mail['host']) && $ff->Mail['host'] == $mx && !empty($ff->Mail['auth'] )) {
379                 
380                 $mailer->auth = true;
381                 $mailer->username = $ff->Mail['username'];
382                 $mailer->password = $ff->Mail['password'];        
383             }
384             
385             if(!empty($ff->Core_Notify) && !empty($ff->Core_Notify['routes'])){
386                 
387                 // we might want to regex 'office365 as a mx host 
388                 foreach ($ff->Core_Notify['routes'] as $server => $settings){
389                     if(!in_array($dom, $settings['domains'])){
390                         continue;
391                     }
392                     
393                     // what's the minimum timespan.. - if we have 60/hour.. that's 1 every minute.
394                     // if it's newer that '1' minute...
395                     // then shunt it..
396                     
397                     $settings['rate'] = isset( $settings['rate']) ?  $settings['rate']  : 360;
398                     
399                     $seconds = floor((60 * 60) / $settings['rate']);
400                     
401                     $core_notify = DB_DataObject::factory($this->table);
402                     $core_notify->domain_id = $core_domain->id;
403                     $core_notify->server_id = $this->server->id;
404                     $core_notify->whereAdd("
405                         sent >= NOW() - INTERVAL $seconds SECOND
406                     ");
407                     
408                     if($core_notify->count()){
409                         $this->server->updateNotifyToNextServer( $w , date("Y-m-d H:i:s", time() + $seconds), true);
410                         $this->errorHandler( " Too many emails sent by {$dom} - requeing");
411                     }
412                      
413                     
414                     
415                     $mailer->host = $server;
416                     $mailer->auth = isset($settings['auth']) ? $settings['auth'] : true;
417                     $mailer->username = $settings['username'];
418                     $mailer->password = $settings['password'];
419                     if (isset($settings['port'])) {
420                         $mailer->port = $settings['port'];
421                     }
422                     if (isset($settings['socket_options'])) {
423                         $mailer->socket_options = $settings['socket_options'];
424                         
425                     }
426                     
427                     
428                     break;
429                 }
430                 
431             }
432         
433             
434             $res = $mailer->send($p->email, $email['headers'], $email['body']);
435             if (is_object($res)) {
436                 $res->backtrace = array(); 
437             }
438             $this->debug("GOT response to send: ". print_r($res,true)); 
439             
440             if ($res === true) {
441                 // success....
442                 
443                 $successEventName = (empty($email['successEventName'])) ? 'NOTIFYSENT' : $email['successEventName'];
444                 
445                 $ev = $this->addEvent($successEventName, $w, "{$w->to_email} - {$email['headers']['Subject']}");
446                 
447                 $ev->writeEventLog($this->debug_str);
448                  
449                 $w->flagDone($ev,$email['headers']['Message-Id']);
450                 
451                  
452                 // enable cc in notify..
453                 if (!empty($email['headers']['Cc'])) {
454                     $cmailer = Mail::factory('smtp',  isset($ff->Mail) ? $ff->Mail : array() );
455                     $email['headers']['Subject'] = "(CC): " . $email['headers']['Subject'];
456                     $cmailer->send($email['headers']['Cc'],    $email['headers'], $email['body']);
457                     
458                 }
459                 
460                 if (!empty($email['bcc'])) {
461                     $cmailer = Mail::factory('smtp', isset($ff->Mail) ? $ff->Mail : array() );
462                     $email['headers']['Subject'] = "(CC): " . $email['headers']['Subject'];
463                     $res = $cmailer->send($email['bcc'],  $email['headers'], $email['body']);
464                     if (!$res || is_a($res, 'PEAR_Error')) {
465                         echo "could not send bcc..\n";
466                     } else {
467                         echo "Sent BCC to {$email['bcc']}\n";
468                     }
469                 }
470                  
471                 $this->errorHandler( " SENT {$w->id} - {$ev->remarks}", true);
472             }
473             // what type of error..
474             $code = empty($res->userinfo['smtpcode']) ? -1 : $res->userinfo['smtpcode'];
475             if (!empty($res->code) && $res->code == 10001) {
476                 // fake greylist if timed out.
477                 $code = -1; 
478             }
479             
480             if ($code < 0) {
481                 $this->debug($res->message);
482                 continue; // try next mx... ??? should we wait??? - nope we did not even connect..
483             }
484             // give up after 2 days..
485             if (in_array($code, array( 421, 450, 451, 452))   && $next_try_min < (2*24*60)) {
486                 // try again later..
487                 // check last event for this item..
488                 //$errmsg=  $fail ? ($res->userinfo['smtpcode'] . ': ' .$res->toString()) :  " - UNKNOWN ERROR";
489                 $errmsg=  $res->userinfo['smtpcode'] . ': ' .$res->message ;
490                 if (!empty($res->userinfo['smtptext'])) {
491                     $errmsg=  $res->userinfo['smtpcode'] . ':' . $res->userinfo['smtptext'];
492                 }
493                 //print_r($res);
494                 $ev = $this->addEvent('NOTIFY', $w, 'GREYLISTED - ' . $errmsg);
495                 
496                 $this->server->updateNotifyToNextServer($w,  $retry_when,true);
497                 
498                 $this->errorHandler(  $ev->remarks);
499             }
500             
501             $fail = true;
502             break;
503         }
504         
505         // after trying all mxs - could not connect...
506         if  (!$fail && ($next_try_min > (2*24*60) || strtotime($w->act_start) < strtotime('NOW - 3 DAYS'))) {
507             
508             $errmsg=  " - UNKNOWN ERROR";
509             if (isset($res->userinfo['smtptext'])) {
510                 $errmsg=  $res->userinfo['smtpcode'] . ':' . $res->userinfo['smtptext'];
511             }
512             
513             $ev = $this->addEvent('NOTIFYFAIL', $w,  "RETRY TIME EXCEEDED - " .  $errmsg);
514             $w->flagDone($ev, '');
515             $this->errorHandler( $ev->remarks);
516         }
517         
518         if ($fail) { //// !!!!<<< BLACKLIST DETECT?
519         // fail.. = log and give up..
520             $errmsg=   $res->userinfo['smtpcode'] . ': ' .$res->toString();
521             if (isset($res->userinfo['smtptext'])) {
522                 $errmsg=  $res->userinfo['smtpcode'] . ':' . $res->userinfo['smtptext'];
523             }
524             
525             if ($res->userinfo['smtpcode'] == 550) {
526                 if ($this->server->checkSmtpResponse($errmsg, $core_domain)) {
527                     $ev = $this->addEvent('NOTIFY', $w, 'BLACKLISTED  - ' . $errmsg);
528                     $this->server->updateNotifyToNextServer($w,  $retry_when,true);
529                     $this->errorHandler( $ev->remarks);
530                 }
531             }
532              
533             $ev = $this->addEvent('NOTIFYFAIL', $w, ($fail ? "FAILED - " : "RETRY TIME EXCEEDED - ") .  $errmsg);
534             $w->flagDone($ev, '');
535              
536             $this->errorHandler( $ev->remarks);
537         }
538         
539         // at this point we just could not find any MX records..
540         
541         
542         // try again.
543         
544         $ev = $this->addEvent('NOTIFY', $w, 'GREYLIST - NO HOST CAN BE CONTACTED:' . $p->email);
545         
546         $this->server->updateNotifyToNextServer($w,  $retry_when ,true);
547
548         
549          
550         $this->errorHandler($ev->remarks);
551
552         
553     }
554     function mxs($fqdn)
555     {
556         $ff = HTML_FlexyFramework::get();
557         if (isset($ff->Pman_Core_NotifySend['host'])) {
558             return array($ff->Pman_Core_NotifySend['host']);
559         }
560         
561         $mx_records = array();
562         $mx_weight = array();
563         $mxs = array();
564         if (!getmxrr($fqdn, $mx_records, $mx_weight)) {
565             if (!checkdnsrr($fqdn)) {
566                 return false;
567             }
568             return array($fqdn);
569         }
570         
571         asort($mx_weight,SORT_NUMERIC);
572         
573         foreach($mx_weight as $k => $weight) {
574             if (!empty($mx_records[$k])) {
575                 $mxs[] = $mx_records[$k];
576             }
577         }
578         return empty($mxs) ? false : $mxs;
579     }
580     
581     /**
582      * wrapper to call object->toEmail()
583      *
584      * return
585      *   {
586         headers : {AssocArray},
587         body: {String}
588         
589         // optional..
590         error :  {String} // error message in log.
591         send-to: {String} // use to override rcpt
592          
593      }
594      **/
595     function makeEmail($object, $rcpt, $last_sent_date, $notify, $force =false)
596     {
597         $m = 'notify'. $notify->evtype;
598         //var_dump(get_class($object) . '::' .$m);
599         if (!empty($notify->evtype) && method_exists($object,$m)) {
600             echo "calling :" . get_class($object) . '::' .$m . "\n";
601             return $object->$m($rcpt, $last_sent_date, $notify, $force);
602         }
603         
604         $type = explode('::', $notify->evtype);
605         
606         if(!empty($type[1]) && method_exists($object,$type[1])){
607             $m = $type[1];
608             echo "calling :" . get_class($object) . '::' .$m . "\n";
609             return $object->$m($rcpt, $last_sent_date, $notify, $force);
610         }
611         // fallback if evtype is empty..
612         
613         if (method_exists($object, 'toMailerData')) {
614             return $object->toMailerData(array(
615                 'rcpts'=>$rcpt,
616                 'person'=>$rcpt, // added as mediaoutreach used this?
617             )); //this is core_email - i think it's only used for testing...
618             //var_Dump($object);
619             //exit;
620         }
621         if (method_exists($object, 'toEmail')) {
622             return $object->toEmail($rcpt, $last_sent_date, $notify, $force);
623         }
624         // no way to send this.. - this needs to handle core_notify how we have used it for the approval stuff..
625         
626         return false;
627     }
628     
629     function debug($str)
630     {
631         if (empty($this->cli_args['debug'])) {
632             return;
633             
634         }
635         echo $str . "\n";
636     }
637     function output()
638     {
639         $this->errorHandler("done\n");
640     }
641     var $debug_str = '';
642     
643     function debugHandler ($smtp, $message)
644     {
645         $this->debug_str .= strlen($this->debug_str) ? "\n" : '';
646         $this->debug_str .= $message;
647         //echo $message ."\n";
648     }
649     
650     function errorHandler($msg, $success = false)
651     {
652         if($this->error_handler == 'exception'){
653             if($success){
654                 throw new Pman_Core_NotifySend_Exception_Success($msg);
655             }
656             
657             throw new Pman_Core_NotifySend_Exception_Fail($msg);
658         }
659         
660         die(date('Y-m-d h:i:s') . ' ' . $msg ."\n");
661         
662         
663     }
664     
665     function updateServer($w)
666     {
667         $ff = HTML_FlexyFramework::get();
668          
669         if (empty($ff->Core_Notify['servers'])) {
670             return;
671         }
672         // some classes dont support server routing
673         if (!property_exists($w, 'server_id')) {
674             return;
675         }
676         // next server..
677         $w->server_id = ($w->server_id + 1) % count(array_keys($ff->Core_Notify['servers']));
678          
679     }
680     
681
682     
683 }