Slow Send Rate on AWS EC2 Instance

@duncanc just getting time to follow up. How do I disable click tracking?

@daflores63 Edit the setting in the config.php file.

define('CLICKTRACK', 0);

@duncanc I disabled click tracking, here is the resultant event log:

|Events|Date|Message|
| --- | --- | --- |
|76436|14 July 2023 15:28:56|select id from phplist_message where status not in ("draft", "sent", "prepared", "suspended") and embargo|
|Page: pageaction||
|76435|14 July 2023 15:28:56|Maximum time for queue processing: 60|
|Page: pageaction||
|76434|14 July 2023 15:28:56|Less than batch size were sent, so reloading imminently|
|Page: pageaction||
|76433|14 July 2023 15:28:56|send() took 0.0579330000|
|Page: pageaction||
|76432|14 July 2023 15:28:46|Finished this run|
|Page: pageaction||
|76431|14 July 2023 15:28:46|4 messages sent in 60.66 seconds (237 msgs/hr)|
|Page: pageaction||
|76430|14 July 2023 15:28:46|It took 40 seconds to send this message|
|Page: pageaction||
|76429|14 July 2023 15:28:46|send() took 0.0483720000|
|Page: pageaction||
|76428|14 July 2023 15:28:36|Processed 4 out of 4 subscribers|
|Page: pageaction||
|76427|14 July 2023 15:28:36|It took 10.0709890000 seconds to send|
|Page: pageaction||
|76426|14 July 2023 15:28:36|post compatSend() took 0.0009140000|
|Page: pageaction||
|76425|14 July 2023 15:28:36|compatSend() took 0.0528040000|
|Page: pageaction||
|76424|14 July 2023 15:28:36|send() took 0.0510880000|
|Page: pageaction||
|76423|14 July 2023 15:28:36|pre compatSend() took 10.0123210000|
|Page: pageaction||
|76422|14 July 2023 15:28:26|Sending 25 to daflores@rhhaonline.com|
|Page: pageaction||
|76421|14 July 2023 15:28:26|It took 10.0725270000 seconds to send|
|Page: pageaction||
|76420|14 July 2023 15:28:26|post compatSend() took 0.0007190000|
|Page: pageaction||
|76419|14 July 2023 15:28:26|compatSend() took 0.0542470000|
|Page: pageaction||
|76418|14 July 2023 15:28:26|send() took 0.0522260000|
|Page: pageaction||
|76417|14 July 2023 15:28:26|pre compatSend() took 10.0123710000|
|Page: pageaction||
|76416|14 July 2023 15:28:16|Sending 25 to daflores1@yahoo.com|
|Page: pageaction||
|76415|14 July 2023 15:28:16|It took 10.0700570000 seconds to send|
|Page: pageaction||
|76414|14 July 2023 15:28:16|post compatSend() took 0.0007650000|
|Page: pageaction||
|76413|14 July 2023 15:28:16|compatSend() took 0.0559970000|
|Page: pageaction||
|76412|14 July 2023 15:28:16|send() took 0.0541030000|
|Page: pageaction||
|76411|14 July 2023 15:28:16|pre compatSend() took 10.0085060000|
|Page: pageaction||
|76410|14 July 2023 15:28:06|Sending 25 to daflores@dfconsults.com|
|Page: pageaction||
|76409|14 July 2023 15:28:06|It took 10.0731000000 seconds to send|
|Page: pageaction||
|76408|14 July 2023 15:28:06|post compatSend() took 0.0007600000|
|Page: pageaction||
|76407|14 July 2023 15:28:06|compatSend() took 0.0541780000|
|Page: pageaction||
|76406|14 July 2023 15:28:06|send() took 0.0523470000|
|Page: pageaction||
|76405|14 July 2023 15:28:06|pre compatSend() took 10.0136210000|
|Page: pageaction||
|76404|14 July 2023 15:27:56|Sending 25 to daflores63@gmail.com|
|Page: pageaction||
|76403|14 July 2023 15:27:56|Found them: 4 to process|
|Page: pageaction||
|76402|14 July 2023 15:27:56|User select query select distinct u.id from phplist_listuser as listuser inner join phplist_user_user as u ON u.id = listuser.userid inner join phplist_listmessage as listmessage ON listuser.listid = listmessage.listid left join phplist_usermessage as um ON (um.messageid = 25 and um.userid = listuser.userid) where listmessage.messageid = 25 and listmessage.listid = listuser.listid and u.id = listuser.userid and um.userid IS NULL and u.confirmed and !u.blacklisted and !u.disabled|
|Page: pageaction||
|76401|14 July 2023 15:27:56|Looking for subscribers|
|Page: pageaction||
|76400|14 July 2023 15:27:56|Processing campaign 25|
|Page: pageaction||
|76399|14 July 2023 15:27:56|send() took 0.2087860000|
|Page: pageaction||
|76398|14 July 2023 15:27:45|sending of this campaign will stop, if it is still going in 7 days 22 hours 32 mins 15 seconds|
|Page: pageaction||
|76397|14 July 2023 15:27:45|Report of processing will be sent by email|
|Page: pageaction||
|76396|14 July 2023 15:27:45|Please leave this window open. phpList will process your queue until all messages have been sent. This may take a while|
|Page: pageaction||
|76395|14 July 2023 15:27:45|One campaign to process.|
|Page: pageaction||
|76394|14 July 2023 15:27:45|Processing has started,|
|Page: pageaction||
|76393|14 July 2023 15:27:45|select id from phplist_message where status not in ("draft", "sent", "prepared", "suspended") and embargo|
|Page: pageaction||
|76392|14 July 2023 15:27:45|Maximum time for queue processing: 60|
|Page: pageaction||
|76391|14 July 2023 14:50:14|fetched https://www.phplist.com/downloadnews//3.6.13-en-index.txt status 404|
|Page: home||
|76390|14 July 2023 14:50:14|https://www.phplist.com/downloadnews//3.6.13-en-index.txt fetching with curl|
|Page: home|

@daflores63 Thanks. There is no change so click tracking is not the problem. Can you install the sendemaillib.php file in the latest zip file and try that?

@duncanc Here is the eventlog after installing the latest sendemaillib.php file:

|76481|14 July 2023 16:28:41|select id from phplist_message where status not in ("draft", "sent", "prepared", "suspended") and embargo|
| --- | --- | --- |
|Page: pageaction||
|76480|14 July 2023 16:28:41|Maximum time for queue processing: 60|
|Page: pageaction||
|76479|14 July 2023 16:28:41|Less than batch size were sent, so reloading imminently|
|Page: pageaction||
|76478|14 July 2023 16:28:41|send() took 0.0574320000|
|Page: pageaction||
|76477|14 July 2023 16:28:31|Finished this run|
|Page: pageaction||
|76476|14 July 2023 16:28:31|4 messages sent in 60.69 seconds (237 msgs/hr)|
|Page: pageaction||
|76475|14 July 2023 16:28:31|It took 41 seconds to send this message|
|Page: pageaction||
|76474|14 July 2023 16:28:31|send() took 0.0502620000|
|Page: pageaction||
|76473|14 July 2023 16:28:21|Processed 4 out of 4 subscribers|
|Page: pageaction||
|76472|14 July 2023 16:28:21|It took 10.0743180000 seconds to send|
|Page: pageaction||
|76471|14 July 2023 16:28:21|post compatSend() took 0.0008900000|
|Page: pageaction||
|76470|14 July 2023 16:28:21|compatSend() took 0.0552090000|
|Page: pageaction||
|76469|14 July 2023 16:28:21|send() took 0.0535400000|
|Page: pageaction||
|76468|14 July 2023 16:28:20|pre compatSend() took 10.0123690000|
|Page: pageaction||
|76467|14 July 2023 16:28:10|Sending 26 to daflores@rhhaonline.com|
|Page: pageaction||
|76466|14 July 2023 16:28:10|It took 10.0726170000 seconds to send|
|Page: pageaction||
|76465|14 July 2023 16:28:10|post compatSend() took 0.0009440000|
|Page: pageaction||
|76464|14 July 2023 16:28:10|compatSend() took 0.0543420000|
|Page: pageaction||
|76463|14 July 2023 16:28:10|send() took 0.0524980000|
|Page: pageaction||
|76462|14 July 2023 16:28:10|pre compatSend() took 10.0125260000|
|Page: pageaction||
|76461|14 July 2023 16:28:00|Sending 26 to daflores1@yahoo.com|
|Page: pageaction||
|76460|14 July 2023 16:28:00|It took 10.0763170000 seconds to send|
|Page: pageaction||
|76459|14 July 2023 16:28:00|post compatSend() took 0.0010160000|
|Page: pageaction||
|76458|14 July 2023 16:28:00|compatSend() took 0.0549720000|
|Page: pageaction||
|76457|14 July 2023 16:28:00|send() took 0.0530770000|
|Page: pageaction||
|76456|14 July 2023 16:28:00|pre compatSend() took 10.0124950000|
|Page: pageaction||
|76455|14 July 2023 16:27:50|Sending 26 to daflores@dfconsults.com|
|Page: pageaction||
|76454|14 July 2023 16:27:50|It took 10.0736400000 seconds to send|
|Page: pageaction||
|76453|14 July 2023 16:27:50|post compatSend() took 0.0009200000|
|Page: pageaction||
|76452|14 July 2023 16:27:50|compatSend() took 0.0535020000|
|Page: pageaction||
|76451|14 July 2023 16:27:50|send() took 0.0516980000|
|Page: pageaction||
|76450|14 July 2023 16:27:50|pre compatSend() took 10.0140280000|
|Page: pageaction||
|76449|14 July 2023 16:27:40|Sending 26 to daflores63@gmail.com|
|Page: pageaction||
|76448|14 July 2023 16:27:40|Found them: 4 to process|
|Page: pageaction||
|76447|14 July 2023 16:27:40|User select query select distinct u.id from phplist_listuser as listuser inner join phplist_user_user as u ON u.id = listuser.userid inner join phplist_listmessage as listmessage ON listuser.listid = listmessage.listid left join phplist_usermessage as um ON (um.messageid = 26 and um.userid = listuser.userid) where listmessage.messageid = 26 and listmessage.listid = listuser.listid and u.id = listuser.userid and um.userid IS NULL and u.confirmed and !u.blacklisted and !u.disabled|
|Page: pageaction||
|76446|14 July 2023 16:27:40|Looking for subscribers|
|Page: pageaction||
|76445|14 July 2023 16:27:40|Processing campaign 26|
|Page: pageaction||
|76444|14 July 2023 16:27:40|send() took 0.2235180000|
|Page: pageaction||
|76443|14 July 2023 16:27:30|sending of this campaign will stop, if it is still going in 7 days 23 hours 32 mins 30 seconds|
|Page: pageaction||
|76442|14 July 2023 16:27:30|Report of processing will be sent by email|
|Page: pageaction||
|76441|14 July 2023 16:27:30|Please leave this window open. phpList will process your queue until all messages have been sent. This may take a while|
|Page: pageaction||
|76440|14 July 2023 16:27:30|One campaign to process.|
|Page: pageaction||
|76439|14 July 2023 16:27:30|Processing has started,|
|Page: pageaction||
|76438|14 July 2023 16:27:30|select id from phplist_message where status not in ("draft", "sent", "prepared", "suspended") and embargo|
|Page: pageaction||
|76437|14 July 2023 16:27:30|Maximum time for queue processing: 60|

@daflores63 That doesn’t show the extra debug that I expected. Just to be clear I have attached the file again here
sendemaillib.php.zip.zip (15.7 KB)

Copy the file to the lists/admin directory.

@duncanc I updated the file, here is the event log output:

|Events|Date|Message|
| --- | --- | --- |
|76606|14 July 2023 17:03:38|select id from phplist_message where status not in ("draft", "sent", "prepared", "suspended") and embargo|
|Page: pageaction||
|76605|14 July 2023 17:03:38|Maximum time for queue processing: 60|
|Page: pageaction||
|76604|14 July 2023 17:03:38|Less than batch size were sent, so reloading imminently|
|Page: pageaction||
|76603|14 July 2023 17:03:38|send() took 0.0572720000|
|Page: pageaction||
|76602|14 July 2023 17:03:28|Finished this run|
|Page: pageaction||
|76601|14 July 2023 17:03:28|4 messages sent in 60.77 seconds (236 msgs/hr)|
|Page: pageaction||
|76600|14 July 2023 17:03:28|It took 41 seconds to send this message|
|Page: pageaction||
|76599|14 July 2023 17:03:28|send() took 0.0535010000|
|Page: pageaction||
|76598|14 July 2023 17:03:18|Processed 4 out of 4 subscribers|
|Page: pageaction||
|76597|14 July 2023 17:03:18|It took 10.1065020000 seconds to send|
|Page: pageaction||
|76596|14 July 2023 17:03:18|post compatSend() took 0.0008400000|
|Page: pageaction||
|76595|14 July 2023 17:03:18|compatSend() took 0.0591350000|
|Page: pageaction||
|76594|14 July 2023 17:03:18|send() took 0.0573250000|
|Page: pageaction||
|76593|14 July 2023 17:03:18|pre compatSend() took 10.0424020000|
|Page: pageaction||
|76592|14 July 2023 17:03:18|sendEmail point 21 10.0410540000|
|Page: pageaction||
|76591|14 July 2023 17:03:18|sendEmail point 20 10.0390040000|
|Page: pageaction||
|76590|14 July 2023 17:03:08|sendEmail point 19 0.0266350000|
|Page: pageaction||
|76589|14 July 2023 17:03:08|sendEmail point 18 0.0252960000|
|Page: pageaction||
|76588|14 July 2023 17:03:08|sendEmail point 17 0.0235170000|
|Page: pageaction||
|76587|14 July 2023 17:03:08|sendEmail point 15 0.0218650000|
|Page: pageaction||
|76586|14 July 2023 17:03:08|sendEmail point 14 0.0202260000|
|Page: pageaction||
|76585|14 July 2023 17:03:08|sendEmail point 13 0.0187690000|
|Page: pageaction||
|76584|14 July 2023 17:03:08|sendEmail point 12 0.0173320000|
|Page: pageaction||
|76583|14 July 2023 17:03:08|sendEmail point 11 0.0154730000|
|Page: pageaction||
|76582|14 July 2023 17:03:08|sendEmail point 10 0.0141760000|
|Page: pageaction||
|76581|14 July 2023 17:03:08|sendEmail point 9 0.0127320000|
|Page: pageaction||
|76580|14 July 2023 17:03:08|sendEmail point 8 0.0112890000|
|Page: pageaction||
|76579|14 July 2023 17:03:08|sendEmail point 7 0.0098850000|
|Page: pageaction||
|76578|14 July 2023 17:03:08|sendEmail point 6 0.0084310000|
|Page: pageaction||
|76577|14 July 2023 17:03:08|sendEmail point 5 0.0070010000|
|Page: pageaction||
|76576|14 July 2023 17:03:08|sendEmail point 4 0.0045880000|
|Page: pageaction||
|76575|14 July 2023 17:03:08|sendEmail point 3 0.0030540000|
|Page: pageaction||
|76574|14 July 2023 17:03:08|sendEmail point 2 0.0014970000|
|Page: pageaction||
|76573|14 July 2023 17:03:08|sendEmail point 1 0.0000030000|
|Page: pageaction||
|76572|14 July 2023 17:03:08|Sending 27 to daflores@rhhaonline.com|
|Page: pageaction||
|76571|14 July 2023 17:03:08|It took 10.1098580000 seconds to send|
|Page: pageaction||
|76570|14 July 2023 17:03:08|post compatSend() took 0.0008990000|
|Page: pageaction||
|76569|14 July 2023 17:03:08|compatSend() took 0.0570200000|
|Page: pageaction||
|76568|14 July 2023 17:03:08|send() took 0.0552970000|
|Page: pageaction||
|76567|14 July 2023 17:03:08|pre compatSend() took 10.0467470000|
|Page: pageaction||
|76566|14 July 2023 17:03:07|sendEmail point 21 10.0452290000|
|Page: pageaction||
|76565|14 July 2023 17:03:07|sendEmail point 20 10.0424660000|

@daflores63 Thanks, that narrows further where the problem is but I will need to add further debug statements. i will do that shortly.

I can see that you are using Bitnami on EC2. Do you access phplist through the external URL, phplist.dfconsults.net or through some sort of internal address?
Also, do you remember any changes to the server prior to this problem starting? I’m guessing a php or server call is taking a long time for some reason.
files.zip (22.5 KB)

@duncanc I use the external URL. No changes to the server other than upgrading phpList to v3.6.13 from v3.6.10. Here is the updated event log output:

Events	Date			Message
76859	14 July 2023 19:25:23	select id from phplist_message where status not in ("draft", "sent", "prepared", "suspended") and embargo
Page: pageaction
  
76858	14 July 2023 19:25:23	Maximum time for queue processing: 60
Page: pageaction
  
76857	14 July 2023 19:25:22	Less than batch size were sent, so reloading imminently
Page: pageaction
  
76856	14 July 2023 19:25:22	send() took 0.0599250000
Page: pageaction
  
76855	14 July 2023 19:25:22	phplistmailer point 5 10.0162370000
Page: pageaction
  
76854	14 July 2023 19:25:12	phplistmailer point 4 0.0045140000
Page: pageaction
  
76853	14 July 2023 19:25:12	phplistmailer point 3 0.0031130000
Page: pageaction
  
76852	14 July 2023 19:25:12	phplistmailer point 2 0.0014540000
Page: pageaction
  
76851	14 July 2023 19:25:12	phplistmailer point 1 0.0000030000
Page: pageaction
  
76850	14 July 2023 19:25:12	Finished this run
Page: pageaction
  
76849	14 July 2023 19:25:12	4 messages sent in 60.77 seconds (236 msgs/hr)
Page: pageaction
  
76848	14 July 2023 19:25:12	It took 40 seconds to send this message
Page: pageaction
  
76847	14 July 2023 19:25:12	send() took 0.0581140000
Page: pageaction
  
76846	14 July 2023 19:25:12	phplistmailer point 5 10.0174190000
Page: pageaction
  
76845	14 July 2023 19:25:02	phplistmailer point 4 0.0057960000
Page: pageaction
  
76844	14 July 2023 19:25:02	phplistmailer point 3 0.0042690000
Page: pageaction
  
76843	14 July 2023 19:25:02	phplistmailer point 2 0.0026950000
Page: pageaction
  
76842	14 July 2023 19:25:02	phplistmailer point 1 0.0000030000
Page: pageaction
  
76841	14 July 2023 19:25:02	Processed 4 out of 4 subscribers
Page: pageaction
  
76840	14 July 2023 19:25:02	It took 10.0974540000 seconds to send
Page: pageaction
  
76839	14 July 2023 19:25:02	post compatSend() took 0.0008420000
Page: pageaction
  
76838	14 July 2023 19:25:02	compatSend() took 0.0636230000
Page: pageaction
  
76837	14 July 2023 19:25:02	send() took 0.0618020000
Page: pageaction
  
76836	14 July 2023 19:25:02	pre compatSend() took 10.0285540000
Page: pageaction
  
76835	14 July 2023 19:25:02	sendEmail point 24 10.0272000000
Page: pageaction
  
76834	14 July 2023 19:25:02	sendEmail point 23 10.0249090000
Page: pageaction
  
76833	14 July 2023 19:25:02	sendEmail point 22 10.0232250000
Page: pageaction
  
76832	14 July 2023 19:25:02	sendEmail point 21 10.0216790000
Page: pageaction
  
76831	14 July 2023 19:25:02	sendEmail point 20 10.0203400000
Page: pageaction
  
76830	14 July 2023 19:25:02	phplistmailer point 5 10.0161070000
Page: pageaction
  
76829	14 July 2023 19:24:52	phplistmailer point 4 0.0037540000
Page: pageaction
  
76828	14 July 2023 19:24:52	phplistmailer point 3 0.0025730000
Page: pageaction
  
76827	14 July 2023 19:24:52	phplistmailer point 2 0.0012690000
Page: pageaction
  
76826	14 July 2023 19:24:52	phplistmailer point 1 0.0000020000
Page: pageaction
  
76825	14 July 2023 19:24:52	sendEmail point 19 0.0012770000
Page: pageaction
  
76824	14 July 2023 19:24:52	Sending 29 to daflores@rhhaonline.com
Page: pageaction
  
76823	14 July 2023 19:24:52	It took 10.0923990000 seconds to send
Page: pageaction
  
76822	14 July 2023 19:24:52	post compatSend() took 0.0006670000
Page: pageaction
  
76821	14 July 2023 19:24:52	compatSend() took 0.0609960000
Page: pageaction
  
76820	14 July 2023 19:24:52	send() took 0.0594550000
Page: pageaction
  
76819	14 July 2023 19:24:52	pre compatSend() took 10.0269260000
Page: pageaction
  
76818	14 July 2023 19:24:52	sendEmail point 24 10.0255340000
Page: pageaction
  
76817	14 July 2023 19:24:52	sendEmail point 23 10.0236100000
Page: pageaction
  
76816	14 July 2023 19:24:52	sendEmail point 22 10.0224420000
Page: pageaction
  
76815	14 July 2023 19:24:52	sendEmail point 21 10.0212220000
Page: pageaction
  
76814	14 July 2023 19:24:52	sendEmail point 20 10.0199980000
Page: pageaction
  
76813	14 July 2023 19:24:52	phplistmailer point 5 10.0153420000
Page: pageaction
  
76812	14 July 2023 19:24:42	phplistmailer point 4 0.0038570000
Page: pageaction
  
76811	14 July 2023 19:24:42	phplistmailer point 3 0.0024820000
Page: pageaction
  
76810	14 July 2023 19:24:42	phplistmailer point 2 0.0012650000
Page: pageaction

76809	14 July 2023 19:24:42	phplistmailer point 1 0.0000030000
Page: pageaction
  
76808	14 July 2023 19:24:42	sendEmail point 19 0.0017430000
Page: pageaction
  
76807	14 July 2023 19:24:42	Sending 29 to daflores1@yahoo.com
Page: pageaction
  
76806	14 July 2023 19:24:42	It took 10.0998470000 seconds to send
Page: pageaction
  
76805	14 July 2023 19:24:42	post compatSend() took 0.0008190000
Page: pageaction
  
76804	14 July 2023 19:24:42	compatSend() took 0.0686430000
Page: pageaction
  
76803	14 July 2023 19:24:42	send() took 0.0669520000
Page: pageaction
  
76802	14 July 2023 19:24:42	pre compatSend() took 10.0267660000
Page: pageaction
  
76801	14 July 2023 19:24:42	sendEmail point 24 10.0254070000
Page: pageaction
  
76800	14 July 2023 19:24:42	sendEmail point 23 10.0237310000
Page: pageaction
  
76799	14 July 2023 19:24:42	sendEmail point 22 10.0224840000
Page: pageaction
  
76798	14 July 2023 19:24:42	sendEmail point 21 10.0211650000
Page: pageaction
  
76797	14 July 2023 19:24:42	sendEmail point 20 10.0199620000
Page: pageaction
  
76796	14 July 2023 19:24:42	phplistmailer point 5 10.0158280000
Page: pageaction
  
76795	14 July 2023 19:24:32	phplistmailer point 4 0.0043150000
Page: pageaction
  
76794	14 July 2023 19:24:32	phplistmailer point 3 0.0030740000
Page: pageaction
  
76793	14 July 2023 19:24:32	phplistmailer point 2 0.0016480000
Page: pageaction
  
76792	14 July 2023 19:24:32	phplistmailer point 1 0.0000030000
Page: pageaction
  
76791	14 July 2023 19:24:32	sendEmail point 19 0.0013330000
Page: pageaction
  
76790	14 July 2023 19:24:32	Sending 29 to daflores@dfconsults.com
Page: pageaction
  
76789	14 July 2023 19:24:32	It took 10.0981370000 seconds to send
Page: pageaction
  
76788	14 July 2023 19:24:32	post compatSend() took 0.0007740000
Page: pageaction
  
76787	14 July 2023 19:24:32	compatSend() took 0.0647060000
Page: pageaction
  
76786	14 July 2023 19:24:32	send() took 0.0629020000
Page: pageaction
  
76785	14 July 2023 19:24:32	pre compatSend() took 10.0287290000
Page: pageaction
  
76784	14 July 2023 19:24:32	sendEmail point 24 10.0273780000
Page: pageaction
  
76783	14 July 2023 19:24:32	sendEmail point 23 10.0255060000
Page: pageaction
  
76782	14 July 2023 19:24:32	sendEmail point 22 10.0241800000
Page: pageaction
  
76781	14 July 2023 19:24:32	sendEmail point 21 10.0225180000
Page: pageaction
  
76780	14 July 2023 19:24:32	sendEmail point 20 10.0211030000
Page: pageaction
  
76779	14 July 2023 19:24:32	phplistmailer point 5 10.0160030000
Page: pageaction
  
76778	14 July 2023 19:24:22	phplistmailer point 4 0.0038940000
Page: pageaction
  
76777	14 July 2023 19:24:22	phplistmailer point 3 0.0025240000
Page: pageaction
  
76776	14 July 2023 19:24:22	phplistmailer point 2 0.0012460000
Page: pageaction
  
76775	14 July 2023 19:24:22	phplistmailer point 1 0.0000030000
Page: pageaction
  
76774	14 July 2023 19:24:22	sendEmail point 19 0.0022780000
Page: pageaction
  
76773	14 July 2023 19:24:22	Sending 29 to daflores63@gmail.com
Page: pageaction
  
76772	14 July 2023 19:24:22	Found them: 4 to process
Page: pageaction
  
76771	14 July 2023 19:24:22	User select query select distinct u.id from phplist_listuser as listuser inner join phplist_user_user as u ON u.id = listuser.userid inner join phplist_listmessage as listmessage ON listuser.listid = listmessage.listid left join phplist_usermessage as um ON (um.messageid = 29 and um.userid = listuser.userid) where listmessage.messageid = 29 and listmessage.listid = listuser.listid and u.id = listuser.userid and um.userid IS NULL and u.confirmed and !u.blacklisted and !u.disabled
Page: pageaction
  
76770	14 July 2023 19:24:22	Looking for subscribers
Page: pageaction
  
76769	14 July 2023 19:24:22	Processing campaign 29
Page: pageaction
  
76768	14 July 2023 19:24:22	send() took 0.1812070000
Page: pageaction
  
76767	14 July 2023 19:24:21	phplistmailer point 5 10.0158760000
Page: pageaction
  
76766	14 July 2023 19:24:11	phplistmailer point 4 0.0076930000
Page: pageaction
  
76765	14 July 2023 19:24:11	phplistmailer point 3 0.0058390000
Page: pageaction
  
76764	14 July 2023 19:24:11	phplistmailer point 2 0.0035240000
Page: pageaction
  
76763	14 July 2023 19:24:11	phplistmailer point 1 0.0000050000
Page: pageaction
  
76762	14 July 2023 19:24:11	sending of this campaign will stop, if it is still going in 7 days 23 hours 59 mins 49 seconds
Page: pageaction
  
76761	14 July 2023 19:24:11	Report of processing will be sent by email
Page: pageaction
  
76760	14 July 2023 19:24:11	Please leave this window open. phpList will process your queue until all messages have been sent. This may take a while
Page: pageaction

76759	14 July 2023 19:24:11	One campaign to process.
Page: pageaction
  
76758	14 July 2023 19:24:11	Processing has started,
Page: pageaction
  
76757	14 July 2023 19:24:11	select id from phplist_message where status not in ("draft", "sent", "prepared", "suspended") and embargo
Page: pageaction
  
76756	14 July 2023 19:24:11	Maximum time for queue processing: 60
Page: pageaction
  
76755	14 July 2023 18:23:05	Fetching https://api.github.com/repos/bramley/phplist-plugin-sendgrid/tags success
Page: plugins
  
76754	14 July 2023 18:23:05	fetched https://api.github.com/repos/bramley/phplist-plugin-sendgrid/tags status 200
Page: plugins
  
76753	14 July 2023 18:23:05	https://api.github.com/repos/bramley/phplist-plugin-sendgrid/tags fetching with curl
Page: plugins
  
76752	14 July 2023 18:23:05	Fetching https://api.github.com/repos/bramley/phplist-plugin-recaptcha/tags success
Page: plugins
  
76751	14 July 2023 18:23:05	fetched https://api.github.com/repos/bramley/phplist-plugin-recaptcha/tags status 200
Page: plugins
  
76750	14 July 2023 18:23:05	https://api.github.com/repos/bramley/phplist-plugin-recaptcha/tags fetching with curl
Page: plugins

@daflores63 I think it might be this line in file class.phplistmailer.php

        $ip_domain = gethostbyaddr($ip_address);

The function gethostbyaddr() is used to try to find a host name for your browser’s IP address when phplist is creating the header

Received: from [172.56.93.57] by phplist.dfconsults.net with HTTP; Mon, 03 Jul 2023 21:52:10 +0000

Can you try replacing that line to avoid the call

        $ip_domain = $ip_address;

This is line 221 in my file.

1 Like

@duncanc You are a gentleman and a scholar! That was it. Is this something I will have to change in the code going forward?

Events
Date
Message
76963	14 July 2023 22:34:14	select id from phplist_message where status not in ("draft", "sent", "prepared", "suspended") and embargo
Page: pageaction
  
76962	14 July 2023 22:34:14	Maximum time for queue processing: 60
Page: pageaction
  
76961	14 July 2023 22:34:14	Less than batch size were sent, so reloading imminently
Page: pageaction
  
76960	14 July 2023 22:34:14	send() took 0.0300790000
Page: pageaction
  
76959	14 July 2023 22:34:14	phplistmailer point 5 0.0054530000
Page: pageaction
  
76958	14 July 2023 22:34:14	phplistmailer point 4 0.0041330000
Page: pageaction
  
76957	14 July 2023 22:34:14	phplistmailer point 3 0.0027380000
Page: pageaction
  
76956	14 July 2023 22:34:14	phplistmailer point 2 0.0013340000
Page: pageaction
  
76955	14 July 2023 22:34:14	phplistmailer point 1 0.0000030000
Page: pageaction
  
76954	14 July 2023 22:34:14	Finished this run
Page: pageaction
  
76953	14 July 2023 22:34:14	4 messages sent in 0.72 seconds (20116 msgs/hr)
Page: pageaction
  
76952	14 July 2023 22:34:14	It took 01 seconds to send this message
Page: pageaction
  
76951	14 July 2023 22:34:14	send() took 0.0280430000
Page: pageaction
  
76950	14 July 2023 22:34:14	phplistmailer point 5 0.0072260000
Page: pageaction
  
76949	14 July 2023 22:34:14	phplistmailer point 4 0.0042140000
Page: pageaction
  
76948	14 July 2023 22:34:14	phplistmailer point 3 0.0028810000
Page: pageaction
  
76947	14 July 2023 22:34:14	phplistmailer point 2 0.0014090000
Page: pageaction
  
76946	14 July 2023 22:34:14	phplistmailer point 1 0.0000030000
Page: pageaction
  
76945	14 July 2023 22:34:14	Processed 4 out of 4 subscribers
Page: pageaction
  
76944	14 July 2023 22:34:14	It took 0.0663140000 seconds to send
Page: pageaction
  
76943	14 July 2023 22:34:14	post compatSend() took 0.0007960000
Page: pageaction
  
76942	14 July 2023 22:34:14	compatSend() took 0.0306960000
Page: pageaction
  
76941	14 July 2023 22:34:14	send() took 0.0290970000
Page: pageaction
  
76940	14 July 2023 22:34:14	pre compatSend() took 0.0302420000
Page: pageaction
  
76939	14 July 2023 22:34:14	sendEmail point 24 0.0282100000
Page: pageaction
  
76938	14 July 2023 22:34:14	sendEmail point 23 0.0257030000
Page: pageaction
  
76937	14 July 2023 22:34:14	sendEmail point 22 0.0242240000
Page: pageaction
  
76936	14 July 2023 22:34:14	sendEmail point 21 0.0226600000
Page: pageaction
  
76935	14 July 2023 22:34:14	sendEmail point 20 0.0208780000
Page: pageaction
  
76934	14 July 2023 22:34:14	phplistmailer point 5 0.0157540000
Page: pageaction
  
76933	14 July 2023 22:34:14	phplistmailer point 4 0.0139490000
Page: pageaction
  
76932	14 July 2023 22:34:14	phplistmailer point 3 0.0122890000
Page: pageaction
  
76931	14 July 2023 22:34:14	phplistmailer point 2 0.0104690000
Page: pageaction
  
76930	14 July 2023 22:34:14	phplistmailer point 1 0.0000040000
Page: pageaction
  
76929	14 July 2023 22:34:14	sendEmail point 19 0.0014350000
Page: pageaction
  
76928	14 July 2023 22:34:14	Sending 30 to daflores@rhhaonline.com
Page: pageaction
  
76927	14 July 2023 22:34:14	It took 0.0893210000 seconds to send
Page: pageaction
  
76926	14 July 2023 22:34:14	post compatSend() took 0.0007750000
Page: pageaction
  
76925	14 July 2023 22:34:14	compatSend() took 0.0344110000
Page: pageaction
  
76924	14 July 2023 22:34:14	send() took 0.0326730000
Page: pageaction
  
76923	14 July 2023 22:34:14	pre compatSend() took 0.0498170000
Page: pageaction
  
76922	14 July 2023 22:34:14	sendEmail point 24 0.0438810000
Page: pageaction
  
76921	14 July 2023 22:34:14	sendEmail point 23 0.0417530000
Page: pageaction
  
76920	14 July 2023 22:34:14	sendEmail point 22 0.0395250000
Page: pageaction
  
76919	14 July 2023 22:34:14	sendEmail point 21 0.0381630000
Page: pageaction
  
76918	14 July 2023 22:34:14	sendEmail point 20 0.0365290000
Page: pageaction
  
76917	14 July 2023 22:34:14	phplistmailer point 5 0.0088920000
Page: pageaction
  
76916	14 July 2023 22:34:14	phplistmailer point 4 0.0041530000
Page: pageaction
  
76915	14 July 2023 22:34:14	phplistmailer point 3 0.0028610000
Page: pageaction
  
76914	14 July 2023 22:34:14	phplistmailer point 2 0.0015140000
Page: pageaction

76913	14 July 2023 22:34:14	phplistmailer point 1 0.0000060000
Page: pageaction
  
76912	14 July 2023 22:34:14	sendEmail point 19 0.0012760000
Page: pageaction
  
76911	14 July 2023 22:34:14	Sending 30 to daflores1@yahoo.com
Page: pageaction
  
76910	14 July 2023 22:34:14	It took 0.0762290000 seconds to send
Page: pageaction
  
76909	14 July 2023 22:34:14	post compatSend() took 0.0008160000
Page: pageaction
  
76908	14 July 2023 22:34:14	compatSend() took 0.0313720000
Page: pageaction
  
76907	14 July 2023 22:34:14	send() took 0.0298700000
Page: pageaction
  
76906	14 July 2023 22:34:14	pre compatSend() took 0.0372300000
Page: pageaction
  
76905	14 July 2023 22:34:13	sendEmail point 24 0.0295500000
Page: pageaction
  
76904	14 July 2023 22:34:13	sendEmail point 23 0.0273920000
Page: pageaction
  
76903	14 July 2023 22:34:13	sendEmail point 22 0.0258600000
Page: pageaction
  
76902	14 July 2023 22:34:13	sendEmail point 21 0.0243950000
Page: pageaction
  
76901	14 July 2023 22:34:13	sendEmail point 20 0.0225990000
Page: pageaction
  
76900	14 July 2023 22:34:13	phplistmailer point 5 0.0054040000
Page: pageaction
  
76899	14 July 2023 22:34:13	phplistmailer point 4 0.0040190000
Page: pageaction
  
76898	14 July 2023 22:34:13	phplistmailer point 3 0.0027170000
Page: pageaction
  
76897	14 July 2023 22:34:13	phplistmailer point 2 0.0014560000
Page: pageaction
  
76896	14 July 2023 22:34:13	phplistmailer point 1 0.0000070000
Page: pageaction
  
76895	14 July 2023 22:34:13	sendEmail point 19 0.0012180000
Page: pageaction
  
76894	14 July 2023 22:34:13	Sending 30 to daflores@dfconsults.com
Page: pageaction
  
76893	14 July 2023 22:34:13	It took 0.1216590000 seconds to send
Page: pageaction
  
76892	14 July 2023 22:34:13	post compatSend() took 0.0007660000
Page: pageaction
  
76891	14 July 2023 22:34:13	compatSend() took 0.0532830000
Page: pageaction
  
76890	14 July 2023 22:34:13	send() took 0.0516740000
Page: pageaction
  
76889	14 July 2023 22:34:13	pre compatSend() took 0.0520550000
Page: pageaction
  
76888	14 July 2023 22:34:13	sendEmail point 24 0.0503400000
Page: pageaction
  
76887	14 July 2023 22:34:13	sendEmail point 23 0.0345600000
Page: pageaction
  
76886	14 July 2023 22:34:13	sendEmail point 22 0.0329860000
Page: pageaction
  
76885	14 July 2023 22:34:13	sendEmail point 21 0.0312570000
Page: pageaction
  
76884	14 July 2023 22:34:13	sendEmail point 20 0.0294800000
Page: pageaction
  
76883	14 July 2023 22:34:13	phplistmailer point 5 0.0060510000
Page: pageaction
  
76882	14 July 2023 22:34:13	phplistmailer point 4 0.0046420000
Page: pageaction
  
76881	14 July 2023 22:34:13	phplistmailer point 3 0.0031010000
Page: pageaction
  
76880	14 July 2023 22:34:13	phplistmailer point 2 0.0017440000
Page: pageaction
  
76879	14 July 2023 22:34:13	phplistmailer point 1 0.0000050000
Page: pageaction
  
76878	14 July 2023 22:34:13	sendEmail point 19 0.0017690000
Page: pageaction
  
76877	14 July 2023 22:34:13	Sending 30 to daflores63@gmail.com
Page: pageaction
  
76876	14 July 2023 22:34:13	Found them: 4 to process
Page: pageaction
  
76875	14 July 2023 22:34:13	User select query select distinct u.id from phplist_listuser as listuser inner join phplist_user_user as u ON u.id = listuser.userid inner join phplist_listmessage as listmessage ON listuser.listid = listmessage.listid left join phplist_usermessage as um ON (um.messageid = 30 and um.userid = listuser.userid) where listmessage.messageid = 30 and listmessage.listid = listuser.listid and u.id = listuser.userid and um.userid IS NULL and u.confirmed and !u.blacklisted and !u.disabled
Page: pageaction
  
76874	14 July 2023 22:34:13	Looking for subscribers
Page: pageaction
  
76873	14 July 2023 22:34:13	Processing campaign 30
Page: pageaction
  
76872	14 July 2023 22:34:13	send() took 0.2224210000
Page: pageaction
  
76871	14 July 2023 22:34:13	phplistmailer point 5 0.0053890000
Page: pageaction
  
76870	14 July 2023 22:34:13	phplistmailer point 4 0.0040720000
Page: pageaction
  
76869	14 July 2023 22:34:13	phplistmailer point 3 0.0028810000
Page: pageaction
  
76868	14 July 2023 22:34:13	phplistmailer point 2 0.0014290000
Page: pageaction
  
76867	14 July 2023 22:34:13	phplistmailer point 1 0.0000040000
Page: pageaction
  
76866	14 July 2023 22:34:13	sending of this campaign will stop, if it is still going in 7 days 23 hours 59 mins 47 seconds
Page: pageaction
  
76865	14 July 2023 22:34:13	Report of processing will be sent by email
Page: pageaction
  
76864	14 July 2023 22:34:13	Please leave this window open. phpList will process your queue until all messages have been sent. This may take a while
Page: pageaction

76863	14 July 2023 22:34:13	One campaign to process.
Page: pageaction
  
76862	14 July 2023 22:34:13	Processing has started,
Page: pageaction
  
76861	14 July 2023 22:34:13	select id from phplist_message where status not in ("draft", "sent", "prepared", "suspended") and embargo
Page: pageaction
  
76860	14 July 2023 22:34:13	Maximum time for queue processing: 60
Page: pageaction

@daflores63 You can avoid the problem by using a cron job to process the queue. That section of code is not used when phplist is run as a cron job. Otherwise you will need to make that one line change after each upgrade.

However, if you use the Updater plugin to upgrade phplist then you can tell it to restore that particular file so that your change remains.

You should restore the original versions of the three files that I amended. if you didn’t keep the originals then you can download phplist from phpList - Browse /phplist at SourceForge.net

Also you might want to investigate why gethostbyaddr() is taking so long. It might indicate a misconfiguration somewhere.

1 Like