hMailserver can't send or recieve emails locally w/PHPMailer "503 Bad Sequence of Commands"

Use this forum if you have installed hMailServer and want to ask a question related to a production release of hMailServer. Before posting, please read the troubleshooting guide. A large part of all reported issues are already described in detail here.
Post Reply
Colbac
New user
New user
Posts: 2
Joined: 2020-12-16 22:17

hMailserver can't send or recieve emails locally w/PHPMailer "503 Bad Sequence of Commands"

Post by Colbac » 2020-12-20 00:33

Hi,

I've been trying to setup a simple mail message to my mail server. I've given up on trying to get it to send externally (I don't need to worry about that now) and I'm only trying to send an email through to another account in the same domain (the domain on my hMailServer is called mynetwork.com). I've been trying to accomplish this with PHPMailer, I'll have the code for that below.

What I've tried (off the top of my head):
1. Followed these instructions https://www.hmailserver.com/documentati ... es_outside
2. Turned off all of my firewalls
3. Tried setting a relay with my ISP SMTP server.
4. Cried :cry:

These are my debug logs/code

PHPMailer Code

Code: Select all

<?php
  require 'php/PHPMailerAutoload.php';

  date_default_timezone_set('Etc/UTC');

  $email = $_POST['email'];
  $mail = new PHPMailer;

  $mail->SMTPDebug = SMTP::DEBUG_SERVER;
  $mail->isSMTP();
  $mail->SMTPSecure = "tls";
  $mail->SMTPAuth = true;
  $mail->Port = 587;
  $mail->Host = "localhost";
  $mail->Username = "Administrator";
  $mail->Password = "********";

  $mail->From = "ftn@mynetwork.com";
  $mail->addAddress($email, 'Test User');

  $to = $email;
  $subject = "This is a test";
  $text = "Your email test worked!";

  $mail->Subject = $subject;
  $mail->Body = $text;

  try {
    $mail->send();
    echo "<h1>Success</h1>";
  } catch (Exception $e) {
    echo "<h1>Failure</h1>";
  }
?>
PHPMailer debugger

Code: Select all

2020-12-19 22:22:55 SERVER -> CLIENT: 220 *****-PC ESMTP
2020-12-19 22:22:55 CLIENT -> SERVER: EHLO localhost
2020-12-19 22:22:55 SERVER -> CLIENT: 250-*****-PC250-SIZE 20480000250-AUTH LOGIN250 HELP
2020-12-19 22:22:55 CLIENT -> SERVER: STARTTLS
2020-12-19 22:22:55 SERVER -> CLIENT: 503 Bad sequence of commands
2020-12-19 22:22:55 SMTP ERROR: STARTTLS command failed: 503 Bad sequence of commands
SMTP Error: Could not connect to SMTP host.
2020-12-19 22:22:55 CLIENT -> SERVER: QUIT
2020-12-19 22:22:55 SERVER -> CLIENT: 221 goodbye
SMTP connect() failed. https://github.com/PHPMailer/PHPMailer/wiki/Troubleshooting
hMailServer logs

Code: Select all

"DEBUG"	5144	"2020-12-19 02:10:23.751"	"Received shutdown-request from Windows."
"APPLICATION"	5144	"2020-12-19 02:10:23.751"	"Stopping servers..."
"DEBUG"	5144	"2020-12-19 02:10:23.751"	"Application::StopServers() - Removing server work queue"
"DEBUG"	5144	"2020-12-19 02:10:23.751"	"WorkQueueManager::RemoveQueue - Server queue"
"DEBUG"	5144	"2020-12-19 02:10:23.751"	"Stopping working queue Server queue."
"DEBUG"	5144	"2020-12-19 02:10:23.751"	"Interupt and join threads in working queue Server queue"
"DEBUG"	4644	"2020-12-19 02:10:23.751"	"IOService::Stop()"
"DEBUG"	4644	"2020-12-19 02:10:23.751"	"IOService::DoWork() - removing Queue IOCP Queue"
"DEBUG"	4644	"2020-12-19 02:10:23.766"	"WorkQueueManager::RemoveQueue - IOCPQueue"
"DEBUG"	4644	"2020-12-19 02:10:23.766"	"Stopping working queue IOCPQueue."
"DEBUG"	4644	"2020-12-19 02:10:23.766"	"Interupt and join threads in working queue IOCPQueue"
"DEBUG"	9212	"2020-12-19 02:10:23.766"	"Worker exited in work queue Server queue"
"DEBUG"	9208	"2020-12-19 02:10:23.766"	"Worker exited in work queue Server queue"
"DEBUG"	8272	"2020-12-19 02:10:23.766"	"Worker exited in work queue Server queue"
"DEBUG"	9220	"2020-12-19 02:10:23.766"	"TCP - AcceptEx failed. Error code: 995, Message: The I/O operation has been aborted because of either a thread exit or an application request"
"DEBUG"	9244	"2020-12-19 02:10:23.766"	"TCP - AcceptEx failed. Error code: 995, Message: The I/O operation has been aborted because of either a thread exit or an application request"
"DEBUG"	9220	"2020-12-19 02:10:23.766"	"Ending session 2"
"DEBUG"	9244	"2020-12-19 02:10:23.766"	"Ending session 5"
"DEBUG"	5144	"2020-12-19 02:10:23.782"	"Still 2 remaining threads in queue Server queue. First task: IOService"
"DEBUG"	9244	"2020-12-19 02:10:23.782"	"Worker exited in work queue IOCPQueue"
"DEBUG"	9220	"2020-12-19 02:10:23.782"	"Worker exited in work queue IOCPQueue"
"DEBUG"	9236	"2020-12-19 02:10:23.782"	"Worker exited in work queue IOCPQueue"
"DEBUG"	9256	"2020-12-19 02:10:23.782"	"Worker exited in work queue IOCPQueue"
"DEBUG"	9252	"2020-12-19 02:10:23.798"	"Worker exited in work queue IOCPQueue"
"DEBUG"	9240	"2020-12-19 02:10:23.798"	"Worker exited in work queue IOCPQueue"
"DEBUG"	9224	"2020-12-19 02:10:23.813"	"Worker exited in work queue IOCPQueue"
"DEBUG"	9204	"2020-12-19 02:10:23.813"	"Worker exited in work queue IOCPQueue"
"DEBUG"	9264	"2020-12-19 02:10:23.813"	"Worker exited in work queue IOCPQueue"
"DEBUG"	9260	"2020-12-19 02:10:23.813"	"Worker exited in work queue IOCPQueue"
"DEBUG"	9232	"2020-12-19 02:10:23.813"	"Worker exited in work queue IOCPQueue"
"DEBUG"	9248	"2020-12-19 02:10:23.813"	"Worker exited in work queue IOCPQueue"
"DEBUG"	9228	"2020-12-19 02:10:23.813"	"Worker exited in work queue IOCPQueue"
"DEBUG"	7292	"2020-12-19 02:10:23.813"	"Worker exited in work queue IOCPQueue"
"DEBUG"	5584	"2020-12-19 02:10:23.813"	"Worker exited in work queue IOCPQueue"
"DEBUG"	4644	"2020-12-19 02:10:23.813"	"Still 3 remaining threads in queue IOCPQueue. First task: <Unknown>"
"DEBUG"	5144	"2020-12-19 02:10:24.063"	"Still 1 remaining threads in queue Server queue. First task: IOService"
"DEBUG"	4644	"2020-12-19 02:10:24.079"	"All threads are joined in queue IOCPQueue."
"DEBUG"	4644	"2020-12-19 02:10:24.079"	"WorkQueueManager::RemoveQueue - Stopped IOCPQueue"
"DEBUG"	4644	"2020-12-19 02:10:24.079"	"WorkQueueManager::RemoveQueue - Erased IOCPQueue"
"DEBUG"	4644	"2020-12-19 02:10:24.079"	"IOService::Stop() - Complete"
"DEBUG"	4644	"2020-12-19 02:10:24.079"	"Destructing work queue IOCPQueue"
"DEBUG"	4644	"2020-12-19 02:10:24.329"	"Worker exited in work queue Server queue"
"DEBUG"	5144	"2020-12-19 02:10:24.329"	"All threads are joined in queue Server queue."
"DEBUG"	5144	"2020-12-19 02:10:24.329"	"WorkQueueManager::RemoveQueue - Stopped Server queue"
"DEBUG"	5144	"2020-12-19 02:10:24.329"	"WorkQueueManager::RemoveQueue - Erased Server queue"
"DEBUG"	5144	"2020-12-19 02:10:24.329"	"Destructing work queue Server queue"
"DEBUG"	5144	"2020-12-19 02:10:24.329"	"Application::StopServers() - Clearing caches"
"DEBUG"	5144	"2020-12-19 02:10:24.329"	"Application::StopServers() - Destructing IOCP"
"DEBUG"	5144	"2020-12-19 02:10:24.329"	"IOService::~IOService - Destructing"
"DEBUG"	5144	"2020-12-19 02:10:24.329"	"TCPServer::~TCPServer"
"DEBUG"	5144	"2020-12-19 02:10:24.329"	"TCPServer::~TCPServer"
"DEBUG"	5144	"2020-12-19 02:10:24.329"	"Application::StopServers() - Destructing DeliveryManager"
"DEBUG"	5144	"2020-12-19 02:10:24.329"	"WorkQueueManager::RemoveQueue - SMTP delivery queue"
"DEBUG"	5144	"2020-12-19 02:10:24.329"	"Stopping working queue SMTP delivery queue."
"DEBUG"	5144	"2020-12-19 02:10:24.329"	"Interupt and join threads in working queue SMTP delivery queue"
"DEBUG"	6956	"2020-12-19 02:10:24.329"	"Worker exited in work queue SMTP delivery queue"
"DEBUG"	708	"2020-12-19 02:10:24.329"	"Worker exited in work queue SMTP delivery queue"
"DEBUG"	8600	"2020-12-19 02:10:24.329"	"Worker exited in work queue SMTP delivery queue"
"DEBUG"	8564	"2020-12-19 02:10:24.329"	"Worker exited in work queue SMTP delivery queue"
"DEBUG"	696	"2020-12-19 02:10:24.329"	"Worker exited in work queue SMTP delivery queue"
"DEBUG"	8732	"2020-12-19 02:10:24.329"	"Worker exited in work queue SMTP delivery queue"
"DEBUG"	8612	"2020-12-19 02:10:24.329"	"Worker exited in work queue SMTP delivery queue"
"DEBUG"	8316	"2020-12-19 02:10:24.329"	"Worker exited in work queue SMTP delivery queue"
"DEBUG"	704	"2020-12-19 02:10:24.329"	"Worker exited in work queue SMTP delivery queue"
"DEBUG"	700	"2020-12-19 02:10:24.329"	"Worker exited in work queue SMTP delivery queue"
"DEBUG"	5144	"2020-12-19 02:10:24.329"	"All threads are joined in queue SMTP delivery queue."
"DEBUG"	5144	"2020-12-19 02:10:24.329"	"WorkQueueManager::RemoveQueue - Stopped SMTP delivery queue"
"DEBUG"	5144	"2020-12-19 02:10:24.329"	"WorkQueueManager::RemoveQueue - Erased SMTP delivery queue"
"DEBUG"	5144	"2020-12-19 02:10:24.329"	"Destructing work queue SMTP delivery queue"
"DEBUG"	5144	"2020-12-19 02:10:24.329"	"Application::StopServers() - Destructing FetchManager"
"DEBUG"	5144	"2020-12-19 02:10:24.329"	"ExternalFetchManager::~ExternalFetchManager"
"DEBUG"	5144	"2020-12-19 02:10:24.329"	"WorkQueueManager::RemoveQueue - External fetch queue"
"DEBUG"	5144	"2020-12-19 02:10:24.329"	"Stopping working queue External fetch queue."
"DEBUG"	5144	"2020-12-19 02:10:24.329"	"Interupt and join threads in working queue External fetch queue"
"DEBUG"	7052	"2020-12-19 02:10:24.329"	"Worker exited in work queue External fetch queue"
"DEBUG"	5456	"2020-12-19 02:10:24.329"	"Worker exited in work queue External fetch queue"
"DEBUG"	7008	"2020-12-19 02:10:24.329"	"Worker exited in work queue External fetch queue"
"DEBUG"	7004	"2020-12-19 02:10:24.329"	"Worker exited in work queue External fetch queue"
"DEBUG"	7044	"2020-12-19 02:10:24.329"	"Worker exited in work queue External fetch queue"
"DEBUG"	8936	"2020-12-19 02:10:24.329"	"Worker exited in work queue External fetch queue"
"DEBUG"	8888	"2020-12-19 02:10:24.329"	"Worker exited in work queue External fetch queue"
"DEBUG"	7048	"2020-12-19 02:10:24.329"	"Worker exited in work queue External fetch queue"
"DEBUG"	7016	"2020-12-19 02:10:24.329"	"Worker exited in work queue External fetch queue"
"DEBUG"	6996	"2020-12-19 02:10:24.329"	"Worker exited in work queue External fetch queue"
"DEBUG"	6992	"2020-12-19 02:10:24.329"	"Worker exited in work queue External fetch queue"
"DEBUG"	5588	"2020-12-19 02:10:24.329"	"Worker exited in work queue External fetch queue"
"DEBUG"	8828	"2020-12-19 02:10:24.329"	"Worker exited in work queue External fetch queue"
"DEBUG"	5580	"2020-12-19 02:10:24.329"	"Worker exited in work queue External fetch queue"
"DEBUG"	8816	"2020-12-19 02:10:24.329"	"Worker exited in work queue External fetch queue"
"DEBUG"	5144	"2020-12-19 02:10:24.329"	"All threads are joined in queue External fetch queue."
"DEBUG"	5144	"2020-12-19 02:10:24.329"	"WorkQueueManager::RemoveQueue - Stopped External fetch queue"
"DEBUG"	5144	"2020-12-19 02:10:24.329"	"WorkQueueManager::RemoveQueue - Erased External fetch queue"
"DEBUG"	5144	"2020-12-19 02:10:24.329"	"Destructing work queue External fetch queue"
"DEBUG"	5144	"2020-12-19 02:10:24.329"	"ExternalFetchManager::~ExternalFetchManager - Removed queue"
"DEBUG"	5144	"2020-12-19 02:10:24.329"	"Application::StopServers() - Destructing Scheduler"
"DEBUG"	5144	"2020-12-19 02:10:24.329"	"Application::StopServers() - Destructing Rest"
"APPLICATION"	5144	"2020-12-19 02:10:24.329"	"Servers stopped."
"DEBUG"	5144	"2020-12-19 02:10:24.329"	"WorkQueueManager::RemoveQueue - Maintenance queue"
"DEBUG"	5144	"2020-12-19 02:10:24.329"	"Stopping working queue Maintenance queue."
"DEBUG"	5144	"2020-12-19 02:10:24.344"	"Interupt and join threads in working queue Maintenance queue"
"DEBUG"	6220	"2020-12-19 02:10:24.344"	"Worker exited in work queue Maintenance queue"
"DEBUG"	6216	"2020-12-19 02:10:24.344"	"Worker exited in work queue Maintenance queue"
"DEBUG"	6228	"2020-12-19 02:10:24.344"	"Worker exited in work queue Maintenance queue"
"DEBUG"	6224	"2020-12-19 02:10:24.344"	"Worker exited in work queue Maintenance queue"
"DEBUG"	6212	"2020-12-19 02:10:24.344"	"Worker exited in work queue Maintenance queue"
"DEBUG"	5144	"2020-12-19 02:10:24.344"	"All threads are joined in queue Maintenance queue."
"DEBUG"	5144	"2020-12-19 02:10:24.344"	"WorkQueueManager::RemoveQueue - Stopped Maintenance queue"
"DEBUG"	5144	"2020-12-19 02:10:24.344"	"WorkQueueManager::RemoveQueue - Erased Maintenance queue"
"DEBUG"	5144	"2020-12-19 02:10:24.344"	"Destructing work queue Maintenance queue"
"DEBUG"	5144	"2020-12-19 02:10:24.344"	"WorkQueueManager::RemoveQueue - Asynchronous task queue"
"DEBUG"	5144	"2020-12-19 02:10:24.344"	"Stopping working queue Asynchronous task queue."
"DEBUG"	5144	"2020-12-19 02:10:24.344"	"Interupt and join threads in working queue Asynchronous task queue"
"DEBUG"	8544	"2020-12-19 02:10:24.344"	"Worker exited in work queue Asynchronous task queue"
"DEBUG"	8556	"2020-12-19 02:10:24.344"	"Worker exited in work queue Asynchronous task queue"
"DEBUG"	8540	"2020-12-19 02:10:24.344"	"Worker exited in work queue Asynchronous task queue"
"DEBUG"	8528	"2020-12-19 02:10:24.344"	"Worker exited in work queue Asynchronous task queue"
"DEBUG"	8552	"2020-12-19 02:10:24.344"	"Worker exited in work queue Asynchronous task queue"
"DEBUG"	8524	"2020-12-19 02:10:24.344"	"Worker exited in work queue Asynchronous task queue"
"DEBUG"	8512	"2020-12-19 02:10:24.344"	"Worker exited in work queue Asynchronous task queue"
"DEBUG"	8508	"2020-12-19 02:10:24.344"	"Worker exited in work queue Asynchronous task queue"
"DEBUG"	8548	"2020-12-19 02:10:24.344"	"Worker exited in work queue Asynchronous task queue"
"DEBUG"	8536	"2020-12-19 02:10:24.344"	"Worker exited in work queue Asynchronous task queue"
"DEBUG"	8532	"2020-12-19 02:10:24.344"	"Worker exited in work queue Asynchronous task queue"
"DEBUG"	8520	"2020-12-19 02:10:24.344"	"Worker exited in work queue Asynchronous task queue"
"DEBUG"	8516	"2020-12-19 02:10:24.344"	"Worker exited in work queue Asynchronous task queue"
"DEBUG"	8504	"2020-12-19 02:10:24.344"	"Worker exited in work queue Asynchronous task queue"
"DEBUG"	8500	"2020-12-19 02:10:24.344"	"Worker exited in work queue Asynchronous task queue"
"DEBUG"	5144	"2020-12-19 02:10:24.344"	"All threads are joined in queue Asynchronous task queue."
"DEBUG"	5144	"2020-12-19 02:10:24.344"	"WorkQueueManager::RemoveQueue - Stopped Asynchronous task queue"
"DEBUG"	5144	"2020-12-19 02:10:24.344"	"WorkQueueManager::RemoveQueue - Erased Asynchronous task queue"
"DEBUG"	5144	"2020-12-19 02:10:24.344"	"Destructing work queue Asynchronous task queue"
"DEBUG"	5144	"2020-12-19 02:10:24.344"	"Application::ExitInstance - Closing database connection..."
"DEBUG"	5144	"2020-12-19 02:10:24.344"	"Application::ExitInstance - Deleting caches..."
"DEBUG"	5180	"2020-12-19 14:18:48.567"	"Application::InitInstance - Configuration loaded."
"DEBUG"	5180	"2020-12-19 14:18:48.582"	"Creating work queue Asynchronous task queue"
"DEBUG"	5180	"2020-12-19 14:18:48.582"	"Starting work queue Asynchronous task queue"
"DEBUG"	6152	"2020-12-19 14:18:48.582"	"Running worker in work queue Asynchronous task queue"
"DEBUG"	8188	"2020-12-19 14:18:48.582"	"Running worker in work queue Asynchronous task queue"
"DEBUG"	5680	"2020-12-19 14:18:48.582"	"Running worker in work queue Asynchronous task queue"
"DEBUG"	7368	"2020-12-19 14:18:48.582"	"Running worker in work queue Asynchronous task queue"
"DEBUG"	4064	"2020-12-19 14:18:48.582"	"Running worker in work queue Asynchronous task queue"
"DEBUG"	5180	"2020-12-19 14:18:48.582"	"Started work queue Asynchronous task queue"
"APPLICATION"	5180	"2020-12-19 14:18:48.582"	"Starting servers..."
"DEBUG"	7628	"2020-12-19 14:18:48.582"	"Running worker in work queue Asynchronous task queue"
"DEBUG"	7244	"2020-12-19 14:18:48.582"	"Running worker in work queue Asynchronous task queue"
"DEBUG"	8180	"2020-12-19 14:18:48.582"	"Running worker in work queue Asynchronous task queue"
"DEBUG"	8184	"2020-12-19 14:18:48.598"	"Running worker in work queue Asynchronous task queue"
"DEBUG"	6860	"2020-12-19 14:18:48.598"	"Running worker in work queue Asynchronous task queue"
"DEBUG"	6208	"2020-12-19 14:18:48.598"	"Running worker in work queue Asynchronous task queue"
"DEBUG"	7364	"2020-12-19 14:18:48.598"	"Running worker in work queue Asynchronous task queue"
"DEBUG"	7344	"2020-12-19 14:18:48.598"	"Running worker in work queue Asynchronous task queue"
"DEBUG"	7292	"2020-12-19 14:18:48.598"	"Running worker in work queue Asynchronous task queue"
"DEBUG"	7516	"2020-12-19 14:18:48.598"	"Running worker in work queue Asynchronous task queue"
"DEBUG"	5180	"2020-12-19 14:18:49.394"	"Creating work queue Server queue"
"DEBUG"	5180	"2020-12-19 14:18:49.394"	"Starting work queue Server queue"
"DEBUG"	5180	"2020-12-19 14:18:49.394"	"Started work queue Server queue"
"DEBUG"	5180	"2020-12-19 14:18:49.394"	"Adding task Scheduler to work queue Server queue"
"DEBUG"	5180	"2020-12-19 14:18:49.394"	"Adding task IOService to work queue Server queue"
"DEBUG"	5180	"2020-12-19 14:18:49.394"	"Creating work queue SMTP delivery queue"
"DEBUG"	5180	"2020-12-19 14:18:49.394"	"Starting work queue SMTP delivery queue"
"DEBUG"	8868	"2020-12-19 14:18:49.394"	"Running worker in work queue Server queue"
"DEBUG"	8868	"2020-12-19 14:18:49.394"	"Executing task Scheduler in work queue Server queue"
"DEBUG"	4616	"2020-12-19 14:18:49.394"	"Running worker in work queue Server queue"
"DEBUG"	4616	"2020-12-19 14:18:49.394"	"Executing task IOService in work queue Server queue"
"DEBUG"	4616	"2020-12-19 14:18:49.394"	"IOService::Start()"
"DEBUG"	5180	"2020-12-19 14:18:49.394"	"Started work queue SMTP delivery queue"
"DEBUG"	8856	"2020-12-19 14:18:49.394"	"Running worker in work queue SMTP delivery queue"
"DEBUG"	9080	"2020-12-19 14:18:49.394"	"Running worker in work queue SMTP delivery queue"
"DEBUG"	9128	"2020-12-19 14:18:49.394"	"Running worker in work queue SMTP delivery queue"
"DEBUG"	5180	"2020-12-19 14:18:49.394"	"Adding task SMTPDeliveryManager to work queue Server queue"
"DEBUG"	8636	"2020-12-19 14:18:49.394"	"Running worker in work queue SMTP delivery queue"
"DEBUG"	712	"2020-12-19 14:18:49.394"	"Running worker in work queue SMTP delivery queue"
"DEBUG"	5180	"2020-12-19 14:18:49.394"	"Creating work queue External fetch queue"
"DEBUG"	5180	"2020-12-19 14:18:49.394"	"Starting work queue External fetch queue"
"DEBUG"	9232	"2020-12-19 14:18:49.394"	"Running worker in work queue External fetch queue"
"DEBUG"	4684	"2020-12-19 14:18:49.394"	"Running worker in work queue Server queue"
"DEBUG"	9236	"2020-12-19 14:18:49.394"	"Running worker in work queue External fetch queue"
"DEBUG"	4684	"2020-12-19 14:18:49.394"	"Executing task SMTPDeliveryManager in work queue Server queue"
"DEBUG"	9248	"2020-12-19 14:18:49.394"	"Running worker in work queue External fetch queue"
"DEBUG"	8832	"2020-12-19 14:18:49.394"	"Running worker in work queue Server queue"
"DEBUG"	5180	"2020-12-19 14:18:49.410"	"Started work queue External fetch queue"
"DEBUG"	4684	"2020-12-19 14:18:49.410"	"SMTPDeliveryManager::Start()"
"DEBUG"	9268	"2020-12-19 14:18:49.410"	"Running worker in work queue External fetch queue"
"DEBUG"	8652	"2020-12-19 14:18:49.410"	"Running worker in work queue SMTP delivery queue"
"DEBUG"	7748	"2020-12-19 14:18:49.410"	"Running worker in work queue SMTP delivery queue"
"DEBUG"	9252	"2020-12-19 14:18:49.410"	"Running worker in work queue External fetch queue"
"DEBUG"	9212	"2020-12-19 14:18:49.410"	"Running worker in work queue SMTP delivery queue"
"DEBUG"	9068	"2020-12-19 14:18:49.410"	"Running worker in work queue SMTP delivery queue"
"DEBUG"	5180	"2020-12-19 14:18:49.410"	"Adding task ExternalFetchManager to work queue Server queue"
"DEBUG"	9272	"2020-12-19 14:18:49.410"	"Running worker in work queue External fetch queue"
"DEBUG"	4616	"2020-12-19 14:18:49.410"	"Creating session 1"
"DEBUG"	9288	"2020-12-19 14:18:49.410"	"Running worker in work queue External fetch queue"
"DEBUG"	9220	"2020-12-19 14:18:49.410"	"Running worker in work queue SMTP delivery queue"
"DEBUG"	9228	"2020-12-19 14:18:49.410"	"Running worker in work queue External fetch queue"
"DEBUG"	9240	"2020-12-19 14:18:49.410"	"Running worker in work queue External fetch queue"
"DEBUG"	8832	"2020-12-19 14:18:49.410"	"Executing task ExternalFetchManager in work queue Server queue"
"DEBUG"	8832	"2020-12-19 14:18:49.410"	"ExternalFetchManager::Start()"
"DEBUG"	9244	"2020-12-19 14:18:49.410"	"Running worker in work queue External fetch queue"
"DEBUG"	4616	"2020-12-19 14:18:49.410"	"Creating session 2"
"APPLICATION"	5180	"2020-12-19 14:18:49.410"	"Servers started."
"DEBUG"	4616	"2020-12-19 14:18:49.410"	"Creating work queue IOCPQueue"
"DEBUG"	4616	"2020-12-19 14:18:49.410"	"Starting work queue IOCPQueue"
"DEBUG"	9256	"2020-12-19 14:18:49.410"	"Running worker in work queue External fetch queue"
"DEBUG"	9264	"2020-12-19 14:18:49.410"	"Running worker in work queue External fetch queue"
"DEBUG"	4616	"2020-12-19 14:18:49.410"	"Started work queue IOCPQueue"
"DEBUG"	4616	"2020-12-19 14:18:49.410"	"Adding task IOCPQueueWorkerTask to work queue IOCPQueue"
"DEBUG"	4616	"2020-12-19 14:18:49.410"	"Adding task IOCPQueueWorkerTask to work queue IOCPQueue"
"DEBUG"	9276	"2020-12-19 14:18:49.410"	"Running worker in work queue External fetch queue"
"DEBUG"	4616	"2020-12-19 14:18:49.410"	"Adding task IOCPQueueWorkerTask to work queue IOCPQueue"
"DEBUG"	4616	"2020-12-19 14:18:49.410"	"Adding task IOCPQueueWorkerTask to work queue IOCPQueue"
"DEBUG"	4616	"2020-12-19 14:18:49.410"	"Adding task IOCPQueueWorkerTask to work queue IOCPQueue"
"DEBUG"	4616	"2020-12-19 14:18:49.410"	"Adding task IOCPQueueWorkerTask to work queue IOCPQueue"
"DEBUG"	9328	"2020-12-19 14:18:49.410"	"Running worker in work queue IOCPQueue"
"DEBUG"	4616	"2020-12-19 14:18:49.410"	"Adding task IOCPQueueWorkerTask to work queue IOCPQueue"
"DEBUG"	4616	"2020-12-19 14:18:49.426"	"Adding task IOCPQueueWorkerTask to work queue IOCPQueue"
"DEBUG"	9332	"2020-12-19 14:18:49.410"	"Running worker in work queue IOCPQueue"
"DEBUG"	4616	"2020-12-19 14:18:49.426"	"Adding task IOCPQueueWorkerTask to work queue IOCPQueue"
"DEBUG"	9328	"2020-12-19 14:18:49.426"	"Executing task IOCPQueueWorkerTask in work queue IOCPQueue"
"DEBUG"	9332	"2020-12-19 14:18:49.426"	"Executing task IOCPQueueWorkerTask in work queue IOCPQueue"
"DEBUG"	4616	"2020-12-19 14:18:49.426"	"Adding task IOCPQueueWorkerTask to work queue IOCPQueue"
"DEBUG"	4616	"2020-12-19 14:18:49.426"	"Adding task IOCPQueueWorkerTask to work queue IOCPQueue"
"DEBUG"	4616	"2020-12-19 14:18:49.426"	"Adding task IOCPQueueWorkerTask to work queue IOCPQueue"
"DEBUG"	4616	"2020-12-19 14:18:49.426"	"Adding task IOCPQueueWorkerTask to work queue IOCPQueue"
"DEBUG"	4616	"2020-12-19 14:18:49.426"	"Adding task IOCPQueueWorkerTask to work queue IOCPQueue"
"DEBUG"	4616	"2020-12-19 14:18:49.426"	"Adding task IOCPQueueWorkerTask to work queue IOCPQueue"
"DEBUG"	9344	"2020-12-19 14:18:49.426"	"Running worker in work queue IOCPQueue"
"DEBUG"	9280	"2020-12-19 14:18:49.426"	"Running worker in work queue External fetch queue"
"DEBUG"	9292	"2020-12-19 14:18:49.426"	"Running worker in work queue External fetch queue"
"DEBUG"	9344	"2020-12-19 14:18:49.426"	"Executing task IOCPQueueWorkerTask in work queue IOCPQueue"
"DEBUG"	9348	"2020-12-19 14:18:49.426"	"Running worker in work queue IOCPQueue"
"DEBUG"	9348	"2020-12-19 14:18:49.426"	"Executing task IOCPQueueWorkerTask in work queue IOCPQueue"
"DEBUG"	9364	"2020-12-19 14:18:49.426"	"Running worker in work queue IOCPQueue"
"DEBUG"	9376	"2020-12-19 14:18:49.426"	"Running worker in work queue IOCPQueue"
"DEBUG"	9380	"2020-12-19 14:18:49.426"	"Running worker in work queue IOCPQueue"
"DEBUG"	9360	"2020-12-19 14:18:49.426"	"Running worker in work queue IOCPQueue"
"DEBUG"	9364	"2020-12-19 14:18:49.426"	"Executing task IOCPQueueWorkerTask in work queue IOCPQueue"
"DEBUG"	9376	"2020-12-19 14:18:49.426"	"Executing task IOCPQueueWorkerTask in work queue IOCPQueue"
"DEBUG"	9380	"2020-12-19 14:18:49.426"	"Executing task IOCPQueueWorkerTask in work queue IOCPQueue"
"DEBUG"	9360	"2020-12-19 14:18:49.426"	"Executing task IOCPQueueWorkerTask in work queue IOCPQueue"
"DEBUG"	9324	"2020-12-19 14:18:49.426"	"Running worker in work queue IOCPQueue"
"DEBUG"	9336	"2020-12-19 14:18:49.426"	"Running worker in work queue IOCPQueue"
"DEBUG"	9340	"2020-12-19 14:18:49.426"	"Running worker in work queue IOCPQueue"
"DEBUG"	9352	"2020-12-19 14:18:49.426"	"Running worker in work queue IOCPQueue"
"DEBUG"	9356	"2020-12-19 14:18:49.426"	"Running worker in work queue IOCPQueue"
"DEBUG"	9368	"2020-12-19 14:18:49.426"	"Running worker in work queue IOCPQueue"
"DEBUG"	9324	"2020-12-19 14:18:49.426"	"Executing task IOCPQueueWorkerTask in work queue IOCPQueue"
"DEBUG"	9336	"2020-12-19 14:18:49.426"	"Executing task IOCPQueueWorkerTask in work queue IOCPQueue"
"DEBUG"	9340	"2020-12-19 14:18:49.426"	"Executing task IOCPQueueWorkerTask in work queue IOCPQueue"
"DEBUG"	9372	"2020-12-19 14:18:49.426"	"Running worker in work queue IOCPQueue"
"DEBUG"	9372	"2020-12-19 14:18:49.426"	"Executing task IOCPQueueWorkerTask in work queue IOCPQueue"
"DEBUG"	9352	"2020-12-19 14:18:49.426"	"Executing task IOCPQueueWorkerTask in work queue IOCPQueue"
"DEBUG"	9356	"2020-12-19 14:18:49.426"	"Executing task IOCPQueueWorkerTask in work queue IOCPQueue"
"DEBUG"	9368	"2020-12-19 14:18:49.426"	"Executing task IOCPQueueWorkerTask in work queue IOCPQueue"
"DEBUG"	9368	"2020-12-19 15:46:52.019"	"Creating session 3"
"TCPIP"	9368	"2020-12-19 15:46:52.021"	"TCP - 127.0.0.1 connected to 127.0.0.1:587."
"DEBUG"	9368	"2020-12-19 15:46:52.022"	"TCP connection started for session 2"
"SMTPD"	9368	2	"2020-12-19 15:46:52.022"	"127.0.0.1"	"SENT: 220 **REPLACED FOR PRIVACY**-PC ESMTP"
"SMTPD"	9352	2	"2020-12-19 15:46:52.032"	"127.0.0.1"	"RECEIVED: EHLO localhost"
"SMTPD"	9352	2	"2020-12-19 15:46:52.032"	"127.0.0.1"	"SENT: 250-**REPLACED FOR PRIVACY**-PC[nl]250-SIZE 20480000[nl]250-AUTH LOGIN[nl]250 HELP"
"SMTPD"	9356	2	"2020-12-19 15:46:52.034"	"127.0.0.1"	"RECEIVED: STARTTLS"
"SMTPD"	9356	2	"2020-12-19 15:46:52.034"	"127.0.0.1"	"SENT: 503 Bad sequence of commands"
"SMTPD"	9368	2	"2020-12-19 15:46:52.036"	"127.0.0.1"	"RECEIVED: QUIT"
"SMTPD"	9368	2	"2020-12-19 15:46:52.036"	"127.0.0.1"	"SENT: 221 goodbye"
"DEBUG"	9356	"2020-12-19 15:46:52.036"	"Ending session 2"
"DEBUG"	9368	"2020-12-19 16:31:35.240"	"Creating session 4"
"TCPIP"	9368	"2020-12-19 16:31:35.241"	"TCP - 127.0.0.1 connected to 127.0.0.1:587."
"DEBUG"	9368	"2020-12-19 16:31:35.242"	"TCP connection started for session 3"
"SMTPD"	9368	3	"2020-12-19 16:31:35.242"	"127.0.0.1"	"SENT: 220 **REPLACED FOR PRIVACY**-PC ESMTP"
"SMTPD"	9352	3	"2020-12-19 16:31:35.242"	"127.0.0.1"	"RECEIVED: EHLO localhost"
"SMTPD"	9352	3	"2020-12-19 16:31:35.243"	"127.0.0.1"	"SENT: 250-**REPLACED FOR PRIVACY**-PC[nl]250-SIZE 20480000[nl]250-AUTH LOGIN[nl]250 HELP"
"SMTPD"	9352	3	"2020-12-19 16:31:35.243"	"127.0.0.1"	"RECEIVED: STARTTLS"
"SMTPD"	9352	3	"2020-12-19 16:31:35.243"	"127.0.0.1"	"SENT: 503 Bad sequence of commands"
"SMTPD"	9352	3	"2020-12-19 16:31:35.244"	"127.0.0.1"	"RECEIVED: QUIT"
"SMTPD"	9352	3	"2020-12-19 16:31:35.244"	"127.0.0.1"	"SENT: 221 goodbye"
"DEBUG"	9356	"2020-12-19 16:31:35.244"	"Ending session 3"
"DEBUG"	9368	"2020-12-19 16:33:37.920"	"Creating session 5"
"TCPIP"	9368	"2020-12-19 16:33:37.920"	"TCP - 127.0.0.1 connected to 127.0.0.1:587."
"DEBUG"	9368	"2020-12-19 16:33:37.921"	"TCP connection started for session 4"
"SMTPD"	9368	4	"2020-12-19 16:33:37.922"	"127.0.0.1"	"SENT: 220 **REPLACED FOR PRIVACY**-PC ESMTP"
"SMTPD"	9352	4	"2020-12-19 16:33:37.931"	"127.0.0.1"	"RECEIVED: EHLO localhost"
"SMTPD"	9352	4	"2020-12-19 16:33:37.931"	"127.0.0.1"	"SENT: 250-**REPLACED FOR PRIVACY**-PC[nl]250-SIZE 20480000[nl]250-AUTH LOGIN[nl]250 HELP"
"SMTPD"	9356	4	"2020-12-19 16:33:37.932"	"127.0.0.1"	"RECEIVED: STARTTLS"
"SMTPD"	9356	4	"2020-12-19 16:33:37.932"	"127.0.0.1"	"SENT: 503 Bad sequence of commands"
"SMTPD"	9368	4	"2020-12-19 16:33:37.932"	"127.0.0.1"	"RECEIVED: QUIT"
"SMTPD"	9368	4	"2020-12-19 16:33:37.933"	"127.0.0.1"	"SENT: 221 goodbye"
"DEBUG"	9356	"2020-12-19 16:33:37.933"	"Ending session 4"
"DEBUG"	9368	"2020-12-19 16:34:17.433"	"Creating session 6"
"TCPIP"	9368	"2020-12-19 16:34:17.433"	"TCP - 127.0.0.1 connected to 127.0.0.1:587."
"DEBUG"	9368	"2020-12-19 16:34:17.435"	"TCP connection started for session 5"
"SMTPD"	9368	5	"2020-12-19 16:34:17.435"	"127.0.0.1"	"SENT: 220 **REPLACED FOR PRIVACY**-PC ESMTP"
"SMTPD"	9352	5	"2020-12-19 16:34:17.435"	"127.0.0.1"	"RECEIVED: EHLO localhost"
"SMTPD"	9352	5	"2020-12-19 16:34:17.435"	"127.0.0.1"	"SENT: 250-**REPLACED FOR PRIVACY**-PC[nl]250-SIZE 20480000[nl]250-AUTH LOGIN[nl]250 HELP"
"SMTPD"	9352	5	"2020-12-19 16:34:17.436"	"127.0.0.1"	"RECEIVED: STARTTLS"
"SMTPD"	9352	5	"2020-12-19 16:34:17.436"	"127.0.0.1"	"SENT: 503 Bad sequence of commands"
"SMTPD"	9352	5	"2020-12-19 16:34:17.436"	"127.0.0.1"	"RECEIVED: QUIT"
"SMTPD"	9352	5	"2020-12-19 16:34:17.437"	"127.0.0.1"	"SENT: 221 goodbye"
"DEBUG"	9368	"2020-12-19 16:34:17.437"	"Ending session 5"
"DEBUG"	9368	"2020-12-19 16:40:26.800"	"Creating session 7"
"TCPIP"	9368	"2020-12-19 16:40:26.800"	"TCP - 127.0.0.1 connected to 127.0.0.1:587."
"DEBUG"	9368	"2020-12-19 16:40:26.801"	"TCP connection started for session 6"
"SMTPD"	9368	6	"2020-12-19 16:40:26.801"	"127.0.0.1"	"SENT: 220 **REPLACED FOR PRIVACY**-PC ESMTP"
"SMTPD"	9352	6	"2020-12-19 16:40:26.810"	"127.0.0.1"	"RECEIVED: EHLO localhost"
"SMTPD"	9352	6	"2020-12-19 16:40:26.810"	"127.0.0.1"	"SENT: 250-**REPLACED FOR PRIVACY**-PC[nl]250-SIZE 20480000[nl]250-AUTH LOGIN[nl]250 HELP"
"SMTPD"	9356	6	"2020-12-19 16:40:26.811"	"127.0.0.1"	"RECEIVED: STARTTLS"
"SMTPD"	9356	6	"2020-12-19 16:40:26.811"	"127.0.0.1"	"SENT: 503 Bad sequence of commands"
"SMTPD"	9368	6	"2020-12-19 16:40:26.811"	"127.0.0.1"	"RECEIVED: QUIT"
"SMTPD"	9368	6	"2020-12-19 16:40:26.812"	"127.0.0.1"	"SENT: 221 goodbye"
"DEBUG"	9356	"2020-12-19 16:40:26.812"	"Ending session 6"
"DEBUG"	9368	"2020-12-19 16:42:07.115"	"Creating session 8"
"TCPIP"	9368	"2020-12-19 16:42:07.116"	"TCP - 127.0.0.1 connected to 127.0.0.1:587."
"DEBUG"	9368	"2020-12-19 16:42:07.117"	"TCP connection started for session 7"
"SMTPD"	9368	7	"2020-12-19 16:42:07.117"	"127.0.0.1"	"SENT: 220 **REPLACED FOR PRIVACY**-PC ESMTP"
"SMTPD"	9352	7	"2020-12-19 16:42:07.125"	"127.0.0.1"	"RECEIVED: EHLO localhost"
"SMTPD"	9352	7	"2020-12-19 16:42:07.125"	"127.0.0.1"	"SENT: 250-**REPLACED FOR PRIVACY**-PC[nl]250-SIZE 20480000[nl]250-AUTH LOGIN[nl]250 HELP"
"SMTPD"	9356	7	"2020-12-19 16:42:07.126"	"127.0.0.1"	"RECEIVED: STARTTLS"
"SMTPD"	9356	7	"2020-12-19 16:42:07.126"	"127.0.0.1"	"SENT: 503 Bad sequence of commands"
"SMTPD"	9352	7	"2020-12-19 16:42:07.127"	"127.0.0.1"	"RECEIVED: QUIT"
"SMTPD"	9352	7	"2020-12-19 16:42:07.127"	"127.0.0.1"	"SENT: 221 goodbye"
"DEBUG"	9356	"2020-12-19 16:42:07.127"	"Ending session 7"
"DEBUG"	9368	"2020-12-19 16:42:30.069"	"Creating session 9"
"TCPIP"	9368	"2020-12-19 16:42:30.069"	"TCP - 127.0.0.1 connected to 127.0.0.1:587."
"DEBUG"	9368	"2020-12-19 16:42:30.070"	"TCP connection started for session 8"
"SMTPD"	9368	8	"2020-12-19 16:42:30.070"	"127.0.0.1"	"SENT: 220 **REPLACED FOR PRIVACY**-PC ESMTP"
"SMTPD"	9352	8	"2020-12-19 16:42:30.080"	"127.0.0.1"	"RECEIVED: EHLO localhost"
"SMTPD"	9352	8	"2020-12-19 16:42:30.080"	"127.0.0.1"	"SENT: 250-**REPLACED FOR PRIVACY**-PC[nl]250-SIZE 20480000[nl]250-AUTH LOGIN[nl]250 HELP"
"SMTPD"	9356	8	"2020-12-19 16:42:30.081"	"127.0.0.1"	"RECEIVED: STARTTLS"
"SMTPD"	9356	8	"2020-12-19 16:42:30.081"	"127.0.0.1"	"SENT: 503 Bad sequence of commands"
"SMTPD"	9356	8	"2020-12-19 16:42:30.082"	"127.0.0.1"	"RECEIVED: QUIT"
"SMTPD"	9356	8	"2020-12-19 16:42:30.082"	"127.0.0.1"	"SENT: 221 goodbye"
"DEBUG"	9352	"2020-12-19 16:42:30.082"	"Ending session 8"
"DEBUG"	9368	"2020-12-19 16:43:31.224"	"Creating session 10"
"TCPIP"	9368	"2020-12-19 16:43:31.224"	"TCP - 127.0.0.1 connected to 127.0.0.1:587."
"DEBUG"	9368	"2020-12-19 16:43:31.225"	"TCP connection started for session 9"
"SMTPD"	9368	9	"2020-12-19 16:43:31.226"	"127.0.0.1"	"SENT: 220 **REPLACED FOR PRIVACY**-PC ESMTP"
"DEBUG"	9368	"2020-12-19 16:43:31.236"	"The read operation failed. Bytes transferred: 0 Remote IP: 127.0.0.1, Session: 9, Code: 10054, Message: An existing connection was forcibly closed by the remote host"
"DEBUG"	9368	"2020-12-19 16:43:31.236"	"Ending session 9"
"DEBUG"	9368	"2020-12-19 16:44:12.921"	"Creating session 11"
"TCPIP"	9368	"2020-12-19 16:44:12.921"	"TCP - 127.0.0.1 connected to 127.0.0.1:587."
"DEBUG"	9368	"2020-12-19 16:44:12.922"	"TCP connection started for session 10"
"SMTPD"	9368	10	"2020-12-19 16:44:12.922"	"127.0.0.1"	"SENT: 220 **REPLACED FOR PRIVACY**-PC ESMTP"
"SMTPD"	9356	10	"2020-12-19 16:44:12.931"	"127.0.0.1"	"RECEIVED: EHLO localhost"
"SMTPD"	9356	10	"2020-12-19 16:44:12.931"	"127.0.0.1"	"SENT: 250-**REPLACED FOR PRIVACY**-PC[nl]250-SIZE 20480000[nl]250-AUTH LOGIN[nl]250 HELP"
"SMTPD"	9356	10	"2020-12-19 16:44:12.932"	"127.0.0.1"	"RECEIVED: STARTTLS"
"SMTPD"	9356	10	"2020-12-19 16:44:12.932"	"127.0.0.1"	"SENT: 503 Bad sequence of commands"
"SMTPD"	9352	10	"2020-12-19 16:44:12.932"	"127.0.0.1"	"RECEIVED: QUIT"
"SMTPD"	9352	10	"2020-12-19 16:44:12.932"	"127.0.0.1"	"SENT: 221 goodbye"
"DEBUG"	9368	"2020-12-19 16:44:12.933"	"Ending session 10"
"DEBUG"	9368	"2020-12-19 16:50:15.092"	"Creating session 12"
"TCPIP"	9368	"2020-12-19 16:50:15.093"	"TCP - 127.0.0.1 connected to 127.0.0.1:25."
"DEBUG"	9368	"2020-12-19 16:50:15.094"	"TCP connection started for session 1"
"SMTPD"	9368	1	"2020-12-19 16:50:15.094"	"127.0.0.1"	"SENT: 220 **REPLACED FOR PRIVACY**-PC ESMTP"
"SMTPD"	9352	1	"2020-12-19 16:50:15.103"	"127.0.0.1"	"RECEIVED: EHLO localhost"
"SMTPD"	9352	1	"2020-12-19 16:50:15.103"	"127.0.0.1"	"SENT: 250-**REPLACED FOR PRIVACY**-PC[nl]250-SIZE 20480000[nl]250-AUTH LOGIN[nl]250 HELP"
"SMTPD"	9368	1	"2020-12-19 16:50:15.104"	"127.0.0.1"	"RECEIVED: STARTTLS"
"SMTPD"	9368	1	"2020-12-19 16:50:15.104"	"127.0.0.1"	"SENT: 503 Bad sequence of commands"
"SMTPD"	9352	1	"2020-12-19 16:50:15.104"	"127.0.0.1"	"RECEIVED: QUIT"
"SMTPD"	9352	1	"2020-12-19 16:50:15.104"	"127.0.0.1"	"SENT: 221 goodbye"
"DEBUG"	9356	"2020-12-19 16:50:15.105"	"Ending session 1"
"DEBUG"	9368	"2020-12-19 17:18:43.320"	"Creating session 13"
"TCPIP"	9368	"2020-12-19 17:18:43.321"	"TCP - 127.0.0.1 connected to 127.0.0.1:587."
"DEBUG"	9368	"2020-12-19 17:18:43.322"	"TCP connection started for session 11"
"SMTPD"	9368	11	"2020-12-19 17:18:43.322"	"127.0.0.1"	"SENT: 220 **REPLACED FOR PRIVACY**-PC ESMTP"
"SMTPD"	9352	11	"2020-12-19 17:18:43.331"	"127.0.0.1"	"RECEIVED: EHLO localhost"
"SMTPD"	9352	11	"2020-12-19 17:18:43.331"	"127.0.0.1"	"SENT: 250-**REPLACED FOR PRIVACY**-PC[nl]250-SIZE 20480000[nl]250-AUTH LOGIN[nl]250 HELP"
"SMTPD"	9368	11	"2020-12-19 17:18:43.332"	"127.0.0.1"	"RECEIVED: STARTTLS"
"SMTPD"	9368	11	"2020-12-19 17:18:43.332"	"127.0.0.1"	"SENT: 503 Bad sequence of commands"
"SMTPD"	9368	11	"2020-12-19 17:18:43.332"	"127.0.0.1"	"RECEIVED: QUIT"
"SMTPD"	9368	11	"2020-12-19 17:18:43.332"	"127.0.0.1"	"SENT: 221 goodbye"
"DEBUG"	9356	"2020-12-19 17:18:43.333"	"Ending session 11"
"DEBUG"	9368	"2020-12-19 17:19:45.329"	"Creating session 14"
"TCPIP"	9368	"2020-12-19 17:19:45.329"	"TCP - 127.0.0.1 connected to 127.0.0.1:587."
"DEBUG"	9368	"2020-12-19 17:19:45.331"	"TCP connection started for session 13"
"SMTPD"	9368	13	"2020-12-19 17:19:45.331"	"127.0.0.1"	"SENT: 220 **REPLACED FOR PRIVACY**-PC ESMTP"
"SMTPD"	9356	13	"2020-12-19 17:19:45.332"	"127.0.0.1"	"RECEIVED: EHLO localhost"
"SMTPD"	9356	13	"2020-12-19 17:19:45.332"	"127.0.0.1"	"SENT: 250-**REPLACED FOR PRIVACY**-PC[nl]250-SIZE 20480000[nl]250-AUTH LOGIN[nl]250 HELP"
"SMTPD"	9356	13	"2020-12-19 17:19:45.333"	"127.0.0.1"	"RECEIVED: STARTTLS"
"SMTPD"	9356	13	"2020-12-19 17:19:45.333"	"127.0.0.1"	"SENT: 503 Bad sequence of commands"
"SMTPD"	9368	13	"2020-12-19 17:19:45.333"	"127.0.0.1"	"RECEIVED: QUIT"
"SMTPD"	9368	13	"2020-12-19 17:19:45.333"	"127.0.0.1"	"SENT: 221 goodbye"
"DEBUG"	9352	"2020-12-19 17:19:45.334"	"Ending session 13"
"DEBUG"	9368	"2020-12-19 17:20:00.212"	"Creating session 15"
"TCPIP"	9368	"2020-12-19 17:20:00.212"	"TCP - 127.0.0.1 connected to 127.0.0.1:587."
"DEBUG"	9368	"2020-12-19 17:20:00.213"	"TCP connection started for session 14"
"SMTPD"	9368	14	"2020-12-19 17:20:00.214"	"127.0.0.1"	"SENT: 220 **REPLACED FOR PRIVACY**-PC ESMTP"
"SMTPD"	9356	14	"2020-12-19 17:20:00.222"	"127.0.0.1"	"RECEIVED: EHLO localhost"
"SMTPD"	9356	14	"2020-12-19 17:20:00.222"	"127.0.0.1"	"SENT: 250-**REPLACED FOR PRIVACY**-PC[nl]250-SIZE 20480000[nl]250-AUTH LOGIN[nl]250 HELP"
"SMTPD"	9368	14	"2020-12-19 17:20:00.223"	"127.0.0.1"	"RECEIVED: AUTH LOGIN"
"SMTPD"	9368	14	"2020-12-19 17:20:00.223"	"127.0.0.1"	"SENT: 530 A SSL/TLS-connection is required for authentication."
"SMTPD"	9368	14	"2020-12-19 17:20:00.224"	"127.0.0.1"	"RECEIVED: QUIT"
"SMTPD"	9368	14	"2020-12-19 17:20:00.224"	"127.0.0.1"	"SENT: 221 goodbye"
"DEBUG"	9356	"2020-12-19 17:20:00.224"	"Ending session 14"
"DEBUG"	9368	"2020-12-19 17:21:20.364"	"Creating session 16"
"TCPIP"	9368	"2020-12-19 17:21:20.364"	"TCP - 127.0.0.1 connected to 127.0.0.1:587."
"DEBUG"	9368	"2020-12-19 17:21:20.366"	"TCP connection started for session 15"
"SMTPD"	9368	15	"2020-12-19 17:21:20.366"	"127.0.0.1"	"SENT: 220 **REPLACED FOR PRIVACY**-PC ESMTP"
"SMTPD"	9356	15	"2020-12-19 17:21:20.374"	"127.0.0.1"	"RECEIVED: EHLO localhost"
"SMTPD"	9356	15	"2020-12-19 17:21:20.374"	"127.0.0.1"	"SENT: 250-**REPLACED FOR PRIVACY**-PC[nl]250-SIZE 20480000[nl]250-AUTH LOGIN[nl]250 HELP"
"SMTPD"	9352	15	"2020-12-19 17:21:20.375"	"127.0.0.1"	"RECEIVED: STARTTLS"
"SMTPD"	9352	15	"2020-12-19 17:21:20.375"	"127.0.0.1"	"SENT: 503 Bad sequence of commands"
"SMTPD"	9368	15	"2020-12-19 17:21:20.375"	"127.0.0.1"	"RECEIVED: QUIT"
"SMTPD"	9368	15	"2020-12-19 17:21:20.375"	"127.0.0.1"	"SENT: 221 goodbye"
"DEBUG"	9356	"2020-12-19 17:21:20.376"	"Ending session 15"
"DEBUG"	9368	"2020-12-19 17:22:55.068"	"Creating session 17"
"TCPIP"	9368	"2020-12-19 17:22:55.069"	"TCP - 127.0.0.1 connected to 127.0.0.1:587."
"DEBUG"	9368	"2020-12-19 17:22:55.070"	"TCP connection started for session 16"
"SMTPD"	9368	16	"2020-12-19 17:22:55.070"	"127.0.0.1"	"SENT: 220 **REPLACED FOR PRIVACY**-PC ESMTP"
"SMTPD"	9352	16	"2020-12-19 17:22:55.079"	"127.0.0.1"	"RECEIVED: EHLO localhost"
"SMTPD"	9352	16	"2020-12-19 17:22:55.079"	"127.0.0.1"	"SENT: 250-**REPLACED FOR PRIVACY**-PC[nl]250-SIZE 20480000[nl]250-AUTH LOGIN[nl]250 HELP"
"SMTPD"	9352	16	"2020-12-19 17:22:55.079"	"127.0.0.1"	"RECEIVED: STARTTLS"
"SMTPD"	9352	16	"2020-12-19 17:22:55.079"	"127.0.0.1"	"SENT: 503 Bad sequence of commands"
"SMTPD"	9352	16	"2020-12-19 17:22:55.080"	"127.0.0.1"	"RECEIVED: QUIT"
"SMTPD"	9352	16	"2020-12-19 17:22:55.080"	"127.0.0.1"	"SENT: 221 goodbye"
"DEBUG"	9368	"2020-12-19 17:22:55.080"	"Ending session 16"
I would appreciate any and all help. If there's anything you need from me please feel free to ask.

Thank you.

User avatar
mattg
Moderator
Moderator
Posts: 21268
Joined: 2007-06-14 05:12
Location: 'The Outback' Australia

Re: hMailserver can't send or recieve emails locally w/PHPMailer "503 Bad Sequence of Commands"

Post by mattg » 2020-12-20 01:42

Your issue is that different similarly named terms mean different things

You should turn security off in PHP Mailer for StartTLS connections to your hMailserver
StartTLS connections in hMailserver is ONLY available if you have a valid certificate installed

Try turning off the IP range requirement for SSL/TLS for AUTH for that range, and turn off StartTLS optional on port 587, AND remove security from PHPMailer to see if that works, then add them back if needed

(I doubt that security is needed when the PHPMailer and hMailserver are on the same machine anyway)
Just 'cause I link to a page and say little else doesn't mean I am not being nice.
https://www.hmailserver.com/documentation

Colbac
New user
New user
Posts: 2
Joined: 2020-12-16 22:17

Re: hMailserver can't send or recieve emails locally w/PHPMailer "503 Bad Sequence of Commands"

Post by Colbac » 2020-12-20 03:50

mattg wrote:
2020-12-20 01:42
Your issue is that different similarly named terms mean different things

You should turn security off in PHP Mailer for StartTLS connections to your hMailserver
StartTLS connections in hMailserver is ONLY available if you have a valid certificate installed

Try turning off the IP range requirement for SSL/TLS for AUTH for that range, and turn off StartTLS optional on port 587, AND remove security from PHPMailer to see if that works, then add them back if needed

(I doubt that security is needed when the PHPMailer and hMailserver are on the same machine anyway)
Thank you so much, I was finally able to get something to work, the PHPMailer debugger said it was sent successfully and it included the message I sent.

Is there a way to view the inboxes of a user in hMailServer? I was hoping to send a link that a user could click on and verify their account in the database. If not, it's alright I can work around it, so long as the code that I wrote is functional in some way to send an email I'm happy.

palinka
Senior user
Senior user
Posts: 2475
Joined: 2017-09-12 17:57

Re: hMailserver can't send or recieve emails locally w/PHPMailer "503 Bad Sequence of Commands"

Post by palinka » 2020-12-20 16:05

Colbac wrote:
2020-12-20 03:50
mattg wrote:
2020-12-20 01:42
Your issue is that different similarly named terms mean different things

You should turn security off in PHP Mailer for StartTLS connections to your hMailserver
StartTLS connections in hMailserver is ONLY available if you have a valid certificate installed

Try turning off the IP range requirement for SSL/TLS for AUTH for that range, and turn off StartTLS optional on port 587, AND remove security from PHPMailer to see if that works, then add them back if needed

(I doubt that security is needed when the PHPMailer and hMailserver are on the same machine anyway)
Thank you so much, I was finally able to get something to work, the PHPMailer debugger said it was sent successfully and it included the message I sent.

Is there a way to view the inboxes of a user in hMailServer? I was hoping to send a link that a user could click on and verify their account in the database. If not, it's alright I can work around it, so long as the code that I wrote is functional in some way to send an email I'm happy.
Any mail client would work. But what would be in the inbox if no reply from the user is necessary? You said they click a link in the confirmation email, not reply.

Post Reply