Resolved Status error: 200

I also get the following error when I press help in the relevant page ( see screenshot )... is this application or server related ?

I also tried to change the php version to php73 and now I get the following error after the cron processes about 150 records

Status error: 200
Status message: parsererror
{"error":true,"process":false,"url":"administrator\/index.php?option=com_csvi&view=templates","message":"Cannot write to log file."}
Fatal error: Unknown: Failed opening required '/var/lib/sec/primary.php' (include_path='.:/usr/local/php73/pear') in Unknown on line 0

Hello,

Status error: 200
Status message: parsererror
{"error":true,"process":false,"url":"administrator\/index.php?option=com_csvi&view=templates","message":"Cannot write to log file."}
Fatal error: Unknown: Failed opening required '/var/lib/sec/primary.php' (include_path='.:/usr/local/php73/pear') in Unknown on line 0

The error says there is a missing file at location /var/lib/sec/primary.php and so writing to RO CSVI debug log is not possible. The missing file is not related to RO CSVI and is something related to server location. You may need to contact the server people on this error.

I also get the following error when I press help in the relevant page ( see screenshot )... is this application or server related ?

This is not server issue. Joomla trying to fetch Media wiki help page for RO CSVI and since there is no help page, it shows 404 page does not exists error.

I also tried to change the php version to php73 and now I get the following error after the cron processes about 150 records

This is the same error as you see when you run the template.

Hello,

If you set Debug log to No, do you also see the error about writing the log file? Check the About page in RO CSVI, see if there are any unwritable folders that may need fixing.

As for the Help button it shouldn't be there actually This is for the Help pages of the Joomla project, not our extension.

When run with error log to no I get the following.... the update is incomplete as most of the products are not correctly updated.

Processing started...
Template Marisol JCSL Import from XML
Import has finished
baseos | u84-ggejolri1ccr@c5761.sgvps.net:~/www/furnishopcy.com/public_html$ client_loop: send disconnect: Broken pipe

I got the following response from the server support team ( Siteground )

Hello,

Thank you for your patience.

We have checked your case with our system administrators and they have performed a few tests on their end and have noticed that the issue is related to the script as when it runs it hits the limit of the maximum allowed open files by a single process. They have tested also increasing the limit set but it appears that it opens up sockets and never closes them and even when it is increased to the limit, it still hits the cap:
root@c5761.sgvps.net:~# uproc2 |grep cron | awk '{print $1}' | xargs -i ls -la /proc/{}/fd/ |wc -l
257
root@c5761.sgvps.net:~# uproc2 |grep cron | awk '{print $1}' | xargs -i ls -la /proc/{}/fd/ |wc -l
2991
root@c5761.sgvps.net:~# uproc2 |grep cron | awk '{print $1}' | xargs -i ls -la /proc/{}/fd/ |wc -l
5513
root@c5761.sgvps.net:~# uproc2 |grep cron | awk '{print $1}' | xargs -i ls -la /proc/{}/fd/ |wc -l
8311
root@c5761.sgvps.net:~# uproc2 |grep cron | awk '{print $1}' | xargs -i ls -la /proc/{}/fd/ |wc -l
10683
root@c5761.sgvps.net:~# uproc2 |grep cron | awk '{print $1}' | xargs -i ls -la /proc/{}/fd/ |wc -l
12727
root@c5761.sgvps.net:~# uproc2 |grep cron | awk '{print $1}' | xargs -i ls -la /proc/{}/fd/ |wc -l
15437

I would like to inform you that the max number of files that a process may open is set in such a way that it should fulfill the needs of optimized sites without sacrificing the performance of the software. Due to this, our system administrators have restored the limit to the default value after testing.

In this situation, it is good for a developer to review the script that is being run and optimize it to close established connections whenever not necessary and control the flow of the currently open file descriptors.

Please note that this is not something that our support team can assist with as it is outside the scope of our support and is best reviewed by a professional developer but in case there is anything else we can help with, feel free to contact us again at any time as we are available 24/7.

Best Regards,

And another email correspondance I had with server support team... I can send you the trace file if you think that would help ( it is 7MB so please tell me your email transfer in order to send - I can not upload in this trhead ). It seems that for some reason when logging is enabled that many processes are opened from csvi that the server can not handle.

Hello Prodromos,

Thank you for your patience.

I thoroughly investigated your case and performed quite a few tests on my end. I indeed managed to only replicate the issue when the logging is enabled. However, the issue is not caused by a restriction on the "logs" folder as the same is properly defined in the configuration.php of your application and upon the script execution of the import process over SSH, a log file is created accordinlgy.

As such, in order to obtain more information about the actual error, I straced the system calls generated by the script during its scrip execution. By monitoring the calls, you can see that the error with which the execution is terminated is:

openat(AT_FDCWD, "/home/customer/www/furnishopcy.com/public_html/administrator/logs/com_csvi.log.53.php", O_WRONLY|O_CREAT|O_APPEND, 0666) = -1 EMFILE (Too many open files)


This is the exact same previously reported by our System Administrators - the script opens too many sockets, it never closes them and it reaches the server's limit which by default is 4000. I can also see, that my colleagues already tried to increase that limit and setting it up to 15 000 but that did not help in any way as the script basically opens new files and never closes them so the new limit is once again reached. When the limit is reached, new files cannot be opened, so naturally, data cannot be written into them and that leads to the error message at hand.

As for why exactly the script is behaving in such a way is something we cannot assist with as it is outside of the scope of support and expertise. It would be best to consult to the developers of the stock program for more information about the issue at hand and how it can be resolved. You may also provide them with the strace output from the tests I have performed which is located in your account with the following document root:

/home/customer/www/furnishopcy.com/strace4107780.txt


If they suggest any server-level change with which we may be able to assist you, please let us know.

Best Regards,

Preslav Kenanov
Senior Technical Support

Hello,

Thank you for the information from your hosting company. So seeing it is the logfile giving the issue I looked it up but this is Joomla code writing the file but the function used by Joomla automatically closes the connection. So I really do not understand why Siteground says the connection is not closed. Nor is this a problem with any other user.

The problem should not occur if you turn off logging as the logfile won't be written then. The other idea I had was that perhaps it is with the images as that uses sockets too but that also closes the connection after checking the image.

Perhaps Siteground can run some tests to see what happens if you have debug log turned off. So far this is the only host that has such issues that I am aware of.

Sending you part of the trance ( lines at the end ) you may be able to figure out what might be going wrong. Will ask the server team to provide with a trace for No logging option which runs ok .

lseek(5034, 0, SEEK_CUR) = 0
write(5034, "2021-10-17\t08:05:28\t173\t[DEBUG]\t"..., 47) = 47
close(5034) = 0
access("/chroot/tmp/upmon.sock", W_OK) = 0
socket(AF_UNIX, SOCK_STREAM|SOCK_CLOEXEC|SOCK_NONBLOCK, 0) = 5034
connect(5034, {sa_family=AF_UNIX, sun_path="/chroot/tmp/upmon.sock"}, 110) = -1 EAGAIN (Resource temporarily unavailable)
access("/home/customer/www/furnishopcy.com/public_html/administrator/logs/com_csvi.log.53.php", F_OK) = 0
openat(AT_FDCWD, "/home/customer/www/furnishopcy.com/public_html/administrator/logs/com_csvi.log.53.php", O_WRONLY|O_CREAT|O_APPEND, 0666) = 5035
fstat(5035, {st_mode=S_IFREG|0644, st_size=1139923, ...}) = 0
lseek(5035, 0, SEEK_CUR) = 0
lseek(5035, 0, SEEK_CUR) = 0
write(5035, "2021-10-17\t08:05:28\t173\t[QUERY]\t"..., 1190) = 1190
close(5035) = 0
access("/chroot/tmp/upmon.sock", W_OK) = 0
socket(AF_UNIX, SOCK_STREAM|SOCK_CLOEXEC|SOCK_NONBLOCK, 0) = 5035
connect(5035, {sa_family=AF_UNIX, sun_path="/chroot/tmp/upmon.sock"}, 110) = -1 EAGAIN (Resource temporarily unavailable)
sendto(3, "\244\0\0\0\3INSERT INTO `tfsar_csvi_log"..., 168, MSG_DONTWAIT, NULL, 0) = 168
poll([{fd=3, events=POLLIN|POLLERR|POLLHUP}], 1, 86400000) = 1 ([{fd=3, revents=POLLIN}])
recvfrom(3, "\n\0\0\1\0\1\375\304R\1\2\0\0\0", 32768, MSG_DONTWAIT, NULL, NULL) = 14
sendto(3, "s\0\0\0\3SELECT `virtuemart_product_"..., 119, MSG_DONTWAIT, NULL, 0) = 119
poll([{fd=3, events=POLLIN|POLLERR|POLLHUP}], 1, 86400000) = 1 ([{fd=3, revents=POLLIN}])
recvfrom(3, "\1\0\0\1\2\214\0\0\2\3def\16dbbsqzqivetuwy\37tfs"..., 32768, MSG_DONTWAIT, NULL, NULL) = 328
access("/home/customer/www/furnishopcy.com/public_html/administrator/logs/com_csvi.log.53.php", F_OK) = 0
openat(AT_FDCWD, "/home/customer/www/furnishopcy.com/public_html/administrator/logs/com_csvi.log.53.php", O_WRONLY|O_CREAT|O_APPEND, 0666) = 5036
fstat(5036, {st_mode=S_IFREG|0644, st_size=1141113, ...}) = 0
lseek(5036, 0, SEEK_CUR) = 0
lseek(5036, 0, SEEK_CUR) = 0
write(5036, "2021-10-17\t08:05:28\t173\t[DEBUG]\t"..., 61) = 61
close(5036) = 0
access("/chroot/tmp/upmon.sock", W_OK) = 0
socket(AF_UNIX, SOCK_STREAM|SOCK_CLOEXEC|SOCK_NONBLOCK, 0) = 5036
connect(5036, {sa_family=AF_UNIX, sun_path="/chroot/tmp/upmon.sock"}, 110) = -1 EAGAIN (Resource temporarily unavailable)
access("/home/customer/www/furnishopcy.com/public_html/administrator/logs/com_csvi.log.53.php", F_OK) = 0
openat(AT_FDCWD, "/home/customer/www/furnishopcy.com/public_html/administrator/logs/com_csvi.log.53.php", O_WRONLY|O_CREAT|O_APPEND, 0666) = 5037
fstat(5037, {st_mode=S_IFREG|0644, st_size=1141174, ...}) = 0
lseek(5037, 0, SEEK_CUR) = 0
lseek(5037, 0, SEEK_CUR) = 0
write(5037, "2021-10-17\t08:05:28\t173\t[QUERY]\t"..., 148) = 148
close(5037) = 0
access("/chroot/tmp/upmon.sock", W_OK) = 0
socket(AF_UNIX, SOCK_STREAM|SOCK_CLOEXEC|SOCK_NONBLOCK, 0) = 5037
connect(5037, {sa_family=AF_UNIX, sun_path="/chroot/tmp/upmon.sock"}, 110) = -1 EAGAIN (Resource temporarily unavailable)
access("/home/customer/www/furnishopcy.com/public_html/administrator/logs/com_csvi.log.53.php", F_OK) = 0
openat(AT_FDCWD, "/home/customer/www/furnishopcy.com/public_html/administrator/logs/com_csvi.log.53.php", O_WRONLY|O_CREAT|O_APPEND, 0666) = 5038
fstat(5038, {st_mode=S_IFREG|0644, st_size=1141322, ...}) = 0
lseek(5038, 0, SEEK_CUR) = 0
lseek(5038, 0, SEEK_CUR) = 0
write(5038, "2021-10-17\t08:05:28\t173\t[DEBUG]\t"..., 43) = 43
close(5038) = 0
access("/chroot/tmp/upmon.sock", W_OK) = 0
socket(AF_UNIX, SOCK_STREAM|SOCK_CLOEXEC|SOCK_NONBLOCK, 0) = 5038
connect(5038, {sa_family=AF_UNIX, sun_path="/chroot/tmp/upmon.sock"}, 110) = -1 EAGAIN (Resource temporarily unavailable)
sendto(3, "V\0\0\0\3SELECT *\nFROM tfsar_virtuem"..., 90, MSG_DONTWAIT, NULL, 0) = 90
poll([{fd=3, events=POLLIN|POLLERR|POLLHUP}], 1, 86400000) = 1 ([{fd=3, revents=POLLIN}])
recvfrom(3, "\1\0\0\1\10\214\0\0\2\3def\16dbbsqzqivetuwy\37tfs"..., 32768, MSG_DONTWAIT, NULL, NULL) = 2972
sendto(3, "\252\0\0\0\3SELECT COUNT(`virtuemart_pr"..., 174, MSG_DONTWAIT, NULL, 0) = 174
poll([{fd=3, events=POLLIN|POLLERR|POLLHUP}], 1, 86400000) = 1 ([{fd=3, revents=POLLIN}])
recvfrom(3, "\1\0\0\1\0014\0\0\2\3def\0\0\0\36COUNT(`virtuema"..., 32768, MSG_DONTWAIT, NULL, NULL) = 85
access("/home/customer/www/furnishopcy.com/public_html/administrator/logs/com_csvi.log.53.php", F_OK) = 0
openat(AT_FDCWD, "/home/customer/www/furnishopcy.com/public_html/administrator/logs/com_csvi.log.53.php", O_WRONLY|O_CREAT|O_APPEND, 0666) = 5039
fstat(5039, {st_mode=S_IFREG|0644, st_size=1141365, ...}) = 0
lseek(5039, 0, SEEK_CUR) = 0
lseek(5039, 0, SEEK_CUR) = 0
write(5039, "2021-10-17\t08:05:28\t173\t[DEBUG]\t"..., 65) = 65
close(5039) = 0
access("/chroot/tmp/upmon.sock", W_OK) = 0
socket(AF_UNIX, SOCK_STREAM|SOCK_CLOEXEC|SOCK_NONBLOCK, 0) = 5039
connect(5039, {sa_family=AF_UNIX, sun_path="/chroot/tmp/upmon.sock"}, 110) = -1 EAGAIN (Resource temporarily unavailable)
access("/home/customer/www/furnishopcy.com/public_html/administrator/logs/com_csvi.log.53.php", F_OK) = 0
openat(AT_FDCWD, "/home/customer/www/furnishopcy.com/public_html/administrator/logs/com_csvi.log.53.php", O_WRONLY|O_CREAT|O_APPEND, 0666) = 5040
fstat(5040, {st_mode=S_IFREG|0644, st_size=1141430, ...}) = 0
lseek(5040, 0, SEEK_CUR) = 0
lseek(5040, 0, SEEK_CUR) = 0
write(5040, "2021-10-17\t08:05:28\t173\t[QUERY]\t"..., 203) = 203
close(5040) = 0
access("/chroot/tmp/upmon.sock", W_OK) = 0
socket(AF_UNIX, SOCK_STREAM|SOCK_CLOEXEC|SOCK_NONBLOCK, 0) = 5040
connect(5040, {sa_family=AF_UNIX, sun_path="/chroot/tmp/upmon.sock"}, 110) = -1 EAGAIN (Resource temporarily unavailable)
access("/home/customer/www/furnishopcy.com/public_html/administrator/logs/com_csvi.log.53.php", F_OK) = 0
openat(AT_FDCWD, "/home/customer/www/furnishopcy.com/public_html/administrator/logs/com_csvi.log.53.php", O_WRONLY|O_CREAT|O_APPEND, 0666) = 5041
fstat(5041, {st_mode=S_IFREG|0644, st_size=1141633, ...}) = 0
lseek(5041, 0, SEEK_CUR) = 0
lseek(5041, 0, SEEK_CUR) = 0
write(5041, "2021-10-17\t08:05:28\t173\t[DEBUG]\t"..., 54) = 54
close(5041) = 0
access("/chroot/tmp/upmon.sock", W_OK) = 0
socket(AF_UNIX, SOCK_STREAM|SOCK_CLOEXEC|SOCK_NONBLOCK, 0) = 5041
connect(5041, {sa_family=AF_UNIX, sun_path="/chroot/tmp/upmon.sock"}, 110) = -1 EAGAIN (Resource temporarily unavailable)
sendto(3, "q\10\0\0\3UPDATE `tfsar_virtuemart_pr"..., 2165, MSG_DONTWAIT, NULL, 0) = 2165
poll([{fd=3, events=POLLIN|POLLERR|POLLHUP}], 1, 86400000) = 1 ([{fd=3, revents=POLLIN}])
recvfrom(3, "0\0\0\1\0\0\0\2\0\0\0(Rows matched: 1 Cha"..., 32768, MSG_DONTWAIT, NULL, NULL) = 52
access("/home/customer/www/furnishopcy.com/public_html/administrator/logs/com_csvi.log.53.php", F_OK) = 0
openat(AT_FDCWD, "/home/customer/www/furnishopcy.com/public_html/administrator/logs/com_csvi.log.53.php", O_WRONLY|O_CREAT|O_APPEND, 0666) = 5042
fstat(5042, {st_mode=S_IFREG|0644, st_size=1141687, ...}) = 0
lseek(5042, 0, SEEK_CUR) = 0
lseek(5042, 0, SEEK_CUR) = 0
write(5042, "2021-10-17\t08:05:28\t173\t[DEBUG]\t"..., 47) = 47
close(5042) = 0
access("/chroot/tmp/upmon.sock", W_OK) = 0
socket(AF_UNIX, SOCK_STREAM|SOCK_CLOEXEC|SOCK_NONBLOCK, 0) = 5042
connect(5042, {sa_family=AF_UNIX, sun_path="/chroot/tmp/upmon.sock"}, 110) = -1 EAGAIN (Resource temporarily unavailable)
access("/home/customer/www/furnishopcy.com/public_html/administrator/logs/com_csvi.log.53.php", F_OK) = 0
openat(AT_FDCWD, "/home/customer/www/furnishopcy.com/public_html/administrator/logs/com_csvi.log.53.php", O_WRONLY|O_CREAT|O_APPEND, 0666) = 5043
fstat(5043, {st_mode=S_IFREG|0644, st_size=1141734, ...}) = 0
lseek(5043, 0, SEEK_CUR) = 0
lseek(5043, 0, SEEK_CUR) = 0
write(5043, "2021-10-17\t08:05:28\t173\t[QUERY]\t"..., 2193) = 2193
close(5043) = 0
access("/chroot/tmp/upmon.sock", W_OK) = 0
socket(AF_UNIX, SOCK_STREAM|SOCK_CLOEXEC|SOCK_NONBLOCK, 0) = 5043
connect(5043, {sa_family=AF_UNIX, sun_path="/chroot/tmp/upmon.sock"}, 110) = -1 EAGAIN (Resource temporarily unavailable)
sendto(3, "\271\0\0\0\3INSERT INTO `tfsar_csvi_log"..., 189, MSG_DONTWAIT, NULL, 0) = 189
poll([{fd=3, events=POLLIN|POLLERR|POLLHUP}], 1, 86400000) = 1 ([{fd=3, revents=POLLIN}])
recvfrom(3, "\n\0\0\1\0\1\375\305R\1\2\0\0\0", 32768, MSG_DONTWAIT, NULL, NULL) = 14
access("/home/customer/www/furnishopcy.com/public_html/administrator/logs/com_csvi.log.53.php", F_OK) = 0
openat(AT_FDCWD, "/home/customer/www/furnishopcy.com/public_html/administrator/logs/com_csvi.log.53.php", O_WRONLY|O_CREAT|O_APPEND, 0666) = 5044
fstat(5044, {st_mode=S_IFREG|0644, st_size=1143927, ...}) = 0
lseek(5044, 0, SEEK_CUR) = 0
lseek(5044, 0, SEEK_CUR) = 0
write(5044, "2021-10-17\t08:05:28\t173\t[DEBUG]\t"..., 59) = 59
close(5044) = 0
access("/chroot/tmp/upmon.sock", W_OK) = 0
socket(AF_UNIX, SOCK_STREAM|SOCK_CLOEXEC|SOCK_NONBLOCK, 0) = 5044
connect(5044, {sa_family=AF_UNIX, sun_path="/chroot/tmp/upmon.sock"}, 110) = -1 EAGAIN (Resource temporarily unavailable)
access("/home/customer/www/furnishopcy.com/public_html/administrator/logs/com_csvi.log.53.php", F_OK) = 0
openat(AT_FDCWD, "/home/customer/www/furnishopcy.com/public_html/administrator/logs/com_csvi.log.53.php", O_WRONLY|O_CREAT|O_APPEND, 0666) = 5045
fstat(5045, {st_mode=S_IFREG|0644, st_size=1143986, ...}) = 0
lseek(5045, 0, SEEK_CUR) = 0
lseek(5045, 0, SEEK_CUR) = 0
write(5045, "2021-10-17\t08:05:28\t173\t[QUERY]\t"..., 454) = 454
close(5045) = 0
access("/chroot/tmp/upmon.sock", W_OK) = 0
socket(AF_UNIX, SOCK_STREAM|SOCK_CLOEXEC|SOCK_NONBLOCK, 0) = 5045
connect(5045, {sa_family=AF_UNIX, sun_path="/chroot/tmp/upmon.sock"}, 110) = -1 EAGAIN (Resource temporarily unavailable)
sendto(3, "\245\1\0\0\3SELECT `virtuemart_product_"..., 425, MSG_DONTWAIT, NULL, 0) = 425
poll([{fd=3, events=POLLIN|POLLERR|POLLHUP}], 1, 86400000) = 1 ([{fd=3, revents=POLLIN}])
recvfrom(3, "\1\0\0\1\1\230\0\0\2\3def\16dbbsqzqivetuwy\37tfs"..., 32768, MSG_DONTWAIT, NULL, NULL) = 189
access("/home/customer/www/furnishopcy.com/public_html/administrator/logs/com_csvi.log.53.php", F_OK) = 0
openat(AT_FDCWD, "/home/customer/www/furnishopcy.com/public_html/administrator/logs/com_csvi.log.53.php", O_WRONLY|O_CREAT|O_APPEND, 0666) = 5046
fstat(5046, {st_mode=S_IFREG|0644, st_size=1144440, ...}) = 0
lseek(5046, 0, SEEK_CUR) = 0
lseek(5046, 0, SEEK_CUR) = 0
write(5046, "2021-10-17\t08:05:28\t173\t[DEBUG]\t"..., 43) = 43
close(5046) = 0
access("/chroot/tmp/upmon.sock", W_OK) = 0
socket(AF_UNIX, SOCK_STREAM|SOCK_CLOEXEC|SOCK_NONBLOCK, 0) = 5046
connect(5046, {sa_family=AF_UNIX, sun_path="/chroot/tmp/upmon.sock"}, 110) = -1 EAGAIN (Resource temporarily unavailable)
sendto(3, "\\\0\0\0\3SELECT *\nFROM tfsar_virtuem"..., 96, MSG_DONTWAIT, NULL, 0) = 96
poll([{fd=3, events=POLLIN|POLLERR|POLLHUP}], 1, 86400000) = 1 ([{fd=3, revents=POLLIN}])
recvfrom(3, "\1\0\0\1\23\230\0\0\2\3def\16dbbsqzqivetuwy\37tfs"..., 32768, MSG_DONTWAIT, NULL, NULL) = 2735
access("/home/customer/www/furnishopcy.com/public_html/administrator/logs/com_csvi.log.53.php", F_OK) = 0
openat(AT_FDCWD, "/home/customer/www/furnishopcy.com/public_html/administrator/logs/com_csvi.log.53.php", O_WRONLY|O_CREAT|O_APPEND, 0666) = 5047
fstat(5047, {st_mode=S_IFREG|0644, st_size=1144483, ...}) = 0
lseek(5047, 0, SEEK_CUR) = 0
lseek(5047, 0, SEEK_CUR) = 0
write(5047, "2021-10-17\t08:05:28\t173\t[DEBUG]\t"..., 55) = 55
close(5047) = 0
access("/chroot/tmp/upmon.sock", W_OK) = 0
socket(AF_UNIX, SOCK_STREAM|SOCK_CLOEXEC|SOCK_NONBLOCK, 0) = 5047
connect(5047, {sa_family=AF_UNIX, sun_path="/chroot/tmp/upmon.sock"}, 110) = -1 EAGAIN (Resource temporarily unavailable)
sendto(3, "\24\2\0\0\3UPDATE `tfsar_virtuemart_pr"..., 536, MSG_DONTWAIT, NULL, 0) = 536
poll([{fd=3, events=POLLIN|POLLERR|POLLHUP}], 1, 86400000) = 1 ([{fd=3, revents=POLLIN}])
recvfrom(3, "0\0\0\1\0\0\0\2\0\0\0(Rows matched: 1 Cha"..., 32768, MSG_DONTWAIT, NULL, NULL) = 52
access("/home/customer/www/furnishopcy.com/public_html/administrator/logs/com_csvi.log.53.php", F_OK) = 0
openat(AT_FDCWD, "/home/customer/www/furnishopcy.com/public_html/administrator/logs/com_csvi.log.53.php", O_WRONLY|O_CREAT|O_APPEND, 0666) = 5048
fstat(5048, {st_mode=S_IFREG|0644, st_size=1144538, ...}) = 0
lseek(5048, 0, SEEK_CUR) = 0
lseek(5048, 0, SEEK_CUR) = 0
write(5048, "2021-10-17\t08:05:28\t173\t[DEBUG]\t"..., 47) = 47
close(5048) = 0
access("/chroot/tmp/upmon.sock", W_OK) = 0
socket(AF_UNIX, SOCK_STREAM|SOCK_CLOEXEC|SOCK_NONBLOCK, 0) = 5048
connect(5048, {sa_family=AF_UNIX, sun_path="/chroot/tmp/upmon.sock"}, 110) = -1 EAGAIN (Resource temporarily unavailable)
access("/home/customer/www/furnishopcy.com/public_html/administrator/logs/com_csvi.log.53.php", F_OK) = 0
openat(AT_FDCWD, "/home/customer/www/furnishopcy.com/public_html/administrator/logs/com_csvi.log.53.php", O_WRONLY|O_CREAT|O_APPEND, 0666) = 5049
fstat(5049, {st_mode=S_IFREG|0644, st_size=1144585, ...}) = 0
lseek(5049, 0, SEEK_CUR) = 0
lseek(5049, 0, SEEK_CUR) = 0
write(5049, "2021-10-17\t08:05:28\t173\t[QUERY]\t"..., 564) = 564
close(5049) = 0
access("/chroot/tmp/upmon.sock", W_OK) = 0
socket(AF_UNIX, SOCK_STREAM|SOCK_CLOEXEC|SOCK_NONBLOCK, 0) = 5049
connect(5049, {sa_family=AF_UNIX, sun_path="/chroot/tmp/upmon.sock"}, 110) = -1 EAGAIN (Resource temporarily unavailable)
sendto(3, "\260\0\0\0\3INSERT INTO `tfsar_csvi_log"..., 180, MSG_DONTWAIT, NULL, 0) = 180
poll([{fd=3, events=POLLIN|POLLERR|POLLHUP}], 1, 86400000) = 1 ([{fd=3, revents=POLLIN}])
recvfrom(3, "\n\0\0\1\0\1\375\306R\1\2\0\0\0", 32768, MSG_DONTWAIT, NULL, NULL) = 14
access("/home/customer/www/furnishopcy.com/public_html/administrator/logs/com_csvi.log.53.php", F_OK) = 0
openat(AT_FDCWD, "/home/customer/www/furnishopcy.com/public_html/administrator/logs/com_csvi.log.53.php", O_WRONLY|O_CREAT|O_APPEND, 0666) = 5050
fstat(5050, {st_mode=S_IFREG|0644, st_size=1145149, ...}) = 0
lseek(5050, 0, SEEK_CUR) = 0
lseek(5050, 0, SEEK_CUR) = 0
write(5050, "2021-10-17\t08:05:28\t173\t[DEBUG]\t"..., 54) = 54
close(5050) = 0
access("/chroot/tmp/upmon.sock", W_OK) = 0
socket(AF_UNIX, SOCK_STREAM|SOCK_CLOEXEC|SOCK_NONBLOCK, 0) = 5050
connect(5050, {sa_family=AF_UNIX, sun_path="/chroot/tmp/upmon.sock"}, 110) = -1 EAGAIN (Resource temporarily unavailable)
access("/home/customer/www/furnishopcy.com/public_html/administrator/logs/com_csvi.log.53.php", F_OK) = 0
openat(AT_FDCWD, "/home/customer/www/furnishopcy.com/public_html/administrator/logs/com_csvi.log.53.php", O_WRONLY|O_CREAT|O_APPEND, 0666) = 5051
fstat(5051, {st_mode=S_IFREG|0644, st_size=1145203, ...}) = 0
lseek(5051, 0, SEEK_CUR) = 0
lseek(5051, 0, SEEK_CUR) = 0
write(5051, "2021-10-17\t08:05:28\t173\t[DEBUG]\t"..., 74) = 74
close(5051) = 0
access("/chroot/tmp/upmon.sock", W_OK) = 0
socket(AF_UNIX, SOCK_STREAM|SOCK_CLOEXEC|SOCK_NONBLOCK, 0) = 5051
connect(5051, {sa_family=AF_UNIX, sun_path="/chroot/tmp/upmon.sock"}, 110) = -1 EAGAIN (Resource temporarily unavailable)
access("/home/customer/www/furnishopcy.com/public_html/administrator/logs/com_csvi.log.53.php", F_OK) = 0
openat(AT_FDCWD, "/home/customer/www/furnishopcy.com/public_html/administrator/logs/com_csvi.log.53.php", O_WRONLY|O_CREAT|O_APPEND, 0666) = 5052
fstat(5052, {st_mode=S_IFREG|0644, st_size=1145277, ...}) = 0
lseek(5052, 0, SEEK_CUR) = 0
lseek(5052, 0, SEEK_CUR) = 0
write(5052, "2021-10-17\t08:05:28\t173\t[DEBUG]\t"..., 73) = 73
close(5052) = 0
access("/chroot/tmp/upmon.sock", W_OK) = 0
socket(AF_UNIX, SOCK_STREAM|SOCK_CLOEXEC|SOCK_NONBLOCK, 0) = 5052
connect(5052, {sa_family=AF_UNIX, sun_path="/chroot/tmp/upmon.sock"}, 110) = -1 EAGAIN (Resource temporarily unavailable)
access("/home/customer/www/furnishopcy.com/public_html/administrator/logs/com_csvi.log.53.php", F_OK) = 0
openat(AT_FDCWD, "/home/customer/www/furnishopcy.com/public_html/administrator/logs/com_csvi.log.53.php", O_WRONLY|O_CREAT|O_APPEND, 0666) = 5053
fstat(5053, {st_mode=S_IFREG|0644, st_size=1145350, ...}) = 0
lseek(5053, 0, SEEK_CUR) = 0
lseek(5053, 0, SEEK_CUR) = 0
write(5053, "2021-10-17\t08:05:28\t173\t[DEBUG]\t"..., 72) = 72
close(5053) = 0
access("/chroot/tmp/upmon.sock", W_OK) = 0
socket(AF_UNIX, SOCK_STREAM|SOCK_CLOEXEC|SOCK_NONBLOCK, 0) = 5053
connect(5053, {sa_family=AF_UNIX, sun_path="/chroot/tmp/upmon.sock"}, 110) = -1 EAGAIN (Resource temporarily unavailable)
access("/home/customer/www/furnishopcy.com/public_html/administrator/logs/com_csvi.log.53.php", F_OK) = 0
openat(AT_FDCWD, "/home/customer/www/furnishopcy.com/public_html/administrator/logs/com_csvi.log.53.php", O_WRONLY|O_CREAT|O_APPEND, 0666) = 5054
fstat(5054, {st_mode=S_IFREG|0644, st_size=1145422, ...}) = 0
lseek(5054, 0, SEEK_CUR) = 0
lseek(5054, 0, SEEK_CUR) = 0
write(5054, "2021-10-17\t08:05:28\t173\t[DEBUG]\t"..., 81) = 81
close(5054) = 0
access("/chroot/tmp/upmon.sock", W_OK) = 0
socket(AF_UNIX, SOCK_STREAM|SOCK_CLOEXEC|SOCK_NONBLOCK, 0) = 5054
connect(5054, {sa_family=AF_UNIX, sun_path="/chroot/tmp/upmon.sock"}, 110) = -1 EAGAIN (Resource temporarily unavailable)
access("/home/customer/www/furnishopcy.com/public_html/administrator/logs/com_csvi.log.53.php", F_OK) = 0
openat(AT_FDCWD, "/home/customer/www/furnishopcy.com/public_html/administrator/logs/com_csvi.log.53.php", O_WRONLY|O_CREAT|O_APPEND, 0666) = 5055
fstat(5055, {st_mode=S_IFREG|0644, st_size=1145503, ...}) = 0
lseek(5055, 0, SEEK_CUR) = 0
lseek(5055, 0, SEEK_CUR) = 0
write(5055, "2021-10-17\t08:05:28\t173\t[DEBUG]\t"..., 92) = 92
close(5055) = 0
access("/chroot/tmp/upmon.sock", W_OK) = 0
socket(AF_UNIX, SOCK_STREAM|SOCK_CLOEXEC|SOCK_NONBLOCK, 0) = 5055
connect(5055, {sa_family=AF_UNIX, sun_path="/chroot/tmp/upmon.sock"}, 110) = -1 EAGAIN (Resource temporarily unavailable)
access("/home/customer/www/furnishopcy.com/public_html/administrator/logs/com_csvi.log.53.php", F_OK) = 0
openat(AT_FDCWD, "/home/customer/www/furnishopcy.com/public_html/administrator/logs/com_csvi.log.53.php", O_WRONLY|O_CREAT|O_APPEND, 0666) = 5056
fstat(5056, {st_mode=S_IFREG|0644, st_size=1145595, ...}) = 0
lseek(5056, 0, SEEK_CUR) = 0
lseek(5056, 0, SEEK_CUR) = 0
write(5056, "2021-10-17\t08:05:28\t173\t[DEBUG]\t"..., 72) = 72
close(5056) = 0
access("/chroot/tmp/upmon.sock", W_OK) = 0
socket(AF_UNIX, SOCK_STREAM|SOCK_CLOEXEC|SOCK_NONBLOCK, 0) = 5056
connect(5056, {sa_family=AF_UNIX, sun_path="/chroot/tmp/upmon.sock"}, 110) = -1 EAGAIN (Resource temporarily unavailable)
access("/home/customer/www/furnishopcy.com/public_html/administrator/logs/com_csvi.log.53.php", F_OK) = 0
openat(AT_FDCWD, "/home/customer/www/furnishopcy.com/public_html/administrator/logs/com_csvi.log.53.php", O_WRONLY|O_CREAT|O_APPEND, 0666) = 5057
fstat(5057, {st_mode=S_IFREG|0644, st_size=1145667, ...}) = 0
lseek(5057, 0, SEEK_CUR) = 0
lseek(5057, 0, SEEK_CUR) = 0
write(5057, "2021-10-17\t08:05:28\t173\t[DEBUG]\t"..., 73) = 73
close(5057) = 0
access("/chroot/tmp/upmon.sock", W_OK) = 0
socket(AF_UNIX, SOCK_STREAM|SOCK_CLOEXEC|SOCK_NONBLOCK, 0) = 5057
connect(5057, {sa_family=AF_UNIX, sun_path="/chroot/tmp/upmon.sock"}, 110) = -1 EAGAIN (Resource temporarily unavailable)
sendto(3, "\300\0\0\0\3UPDATE `tfsar_virtuemart_pr"..., 196, MSG_DONTWAIT, NULL, 0) = 196
poll([{fd=3, events=POLLIN|POLLERR|POLLHUP}], 1, 86400000) = 1 ([{fd=3, revents=POLLIN}])
recvfrom(3, "0\0\0\1\0\0\0\2\0\0\0(Rows matched: 1 Cha"..., 32768, MSG_DONTWAIT, NULL, NULL) = 52
access("/home/customer/www/furnishopcy.com/public_html/administrator/logs/com_csvi.log.53.php", F_OK) = 0
openat(AT_FDCWD, "/home/customer/www/furnishopcy.com/public_html/administrator/logs/com_csvi.log.53.php", O_WRONLY|O_CREAT|O_APPEND, 0666) = 5058
fstat(5058, {st_mode=S_IFREG|0644, st_size=1145740, ...}) = 0
lseek(5058, 0, SEEK_CUR) = 0
lseek(5058, 0, SEEK_CUR) = 0
write(5058, "2021-10-17\t08:05:28\t173\t[DEBUG]\t"..., 71) = 71
close(5058) = 0
access("/chroot/tmp/upmon.sock", W_OK) = 0
socket(AF_UNIX, SOCK_STREAM|SOCK_CLOEXEC|SOCK_NONBLOCK, 0) = 5058
connect(5058, {sa_family=AF_UNIX, sun_path="/chroot/tmp/upmon.sock"}, 110) = -1 EAGAIN (Resource temporarily unavailable)
access("/home/customer/www/furnishopcy.com/public_html/administrator/logs/com_csvi.log.53.php", F_OK) = 0
openat(AT_FDCWD, "/home/customer/www/furnishopcy.com/public_html/administrator/logs/com_csvi.log.53.php", O_WRONLY|O_CREAT|O_APPEND, 0666) = 5059
fstat(5059, {st_mode=S_IFREG|0644, st_size=1145811, ...}) = 0
lseek(5059, 0, SEEK_CUR) = 0
lseek(5059, 0, SEEK_CUR) = 0
write(5059, "2021-10-17\t08:05:28\t173\t[QUERY]\t"..., 225) = 225
close(5059) = 0
access("/chroot/tmp/upmon.sock", W_OK) = 0
socket(AF_UNIX, SOCK_STREAM|SOCK_CLOEXEC|SOCK_NONBLOCK, 0) = 5059
connect(5059, {sa_family=AF_UNIX, sun_path="/chroot/tmp/upmon.sock"}, 110) = -1 EAGAIN (Resource temporarily unavailable)
read(4, "\317\204\316\277.<br />\r\n\316\244\316\277 \317\203\317\204\317\201\317\216\316\274\316\261 \316"..., 8192) = 8192
access("/home/customer/www/furnishopcy.com/public_html/administrator/logs/com_csvi.log.53.php", F_OK) = 0
openat(AT_FDCWD, "/home/customer/www/furnishopcy.com/public_html/administrator/logs/com_csvi.log.53.php", O_WRONLY|O_CREAT|O_APPEND, 0666) = -1 EMFILE (Too many open files)
access("/home/customer/www/furnishopcy.com/public_html/administrator/logs/com_csvi.log.53.php", F_OK) = 0
openat(AT_FDCWD, "/home/customer/www/furnishopcy.com/public_html/administrator/logs/com_csvi.log.53.php", O_WRONLY|O_CREAT|O_APPEND, 0666) = -1 EMFILE (Too many open files)
write(1, "Cannot write to log file.\r\n", 27) = 27
lstat("/etc/local/DISABLE_APP_STATS", 0x7ffc3ab2a450) = -1 ENOENT (No such file or directory)
sendto(3, "A\3\0\0\3UPDATE `tfsar_session`\nSET "..., 837, MSG_DONTWAIT, NULL, 0) = 837
poll([{fd=3, events=POLLIN|POLLERR|POLLHUP}], 1, 86400000) = 1 ([{fd=3, revents=POLLIN}])
recvfrom(3, "0\0\0\1\0\1\0\2\0\0\0(Rows matched: 1 Cha"..., 32768, MSG_DONTWAIT, NULL, NULL) = 52
sendto(3, "\1\0\0\0\t", 5, MSG_DONTWAIT, NULL, 0) = 5
poll([{fd=3, events=POLLIN|POLLERR|POLLHUP}], 1, 86400000) = 1 ([{fd=3, revents=POLLIN}])
recvfrom(3, "\230\0\0\1Uptime: 618742 Threads: 2 "..., 32768, MSG_DONTWAIT, NULL, NULL) = 156
sendto(3, "\1\0\0\0\1", 5, MSG_DONTWAIT, NULL, 0) = 5
close(3) = 0
umask(022) = 022
close(4) = 0
close(2) = 0
close(1) = 0
close(0) = 0
munmap(0x7f40f8000000, 2097152) = 0
munmap(0x7f40f9a00000, 2097152) = 0
munmap(0x7f40f9600000, 2097152) = 0
munmap(0x7f4107064000, 122824) = 0
munmap(0x7f410701e000, 24624) = 0
munmap(0x7f4107025000, 209328) = 0
munmap(0x7f40f9d60000, 196608) = 0
munmap(0x7f4107082000, 167936) = 0
munmap(0x7f40f9d90000, 568392) = 0
munmap(0x7f41070d4000, 135168) = 0
munmap(0x7f40f9800000, 2097152) = 0
munmap(0x7f40f9400000, 2097152) = 0
munmap(0x7f4106e00000, 2097152) = 0
munmap(0x7f40f9c6e000, 659456) = 0
exit_group(0) = ?
+++ exited with 0 +++

Also very starnge but true... When I run the stock update with Logging ( Yes ) from the back-end it runs ok and produces the log file just fine. Any ideas ?

Hello,

The stack trace doesn't tell me much really, I am not a system administrator What I do see is that after the log has written it does a close statement. Really no idea why SiteGround has an issue with this.

Will ask the server team to provide with a trace for No logging option which runs ok .

Without the logging you had another error about broken pipe, that is why I asked what they see why that would happen.

When I run the stock update with Logging ( Yes ) from the back-end it runs ok and produces the log file just fine. Any ideas ?

There is less logging with the stock update. So I guess you do not hit their maximum.