• The Horde webmail has been deprecated. Its complete removal is scheduled for April 2025. For details and recommended actions, see the Feature and Deprecation Plan.
  • We’re working on enhancing the Monitoring feature in Plesk, and we could really use your expertise! If you’re open to sharing your experiences with server and website monitoring or providing feedback, we’d love to have a one-hour online meeting with you.

Question [Passenger] Log level not working ? Log filled with debug statistics

D

Dutiko

New Pleskian
Server operating system version
Debian 11.5
Plesk version and microupdate number
18.0.47 u2
Hello,

I'm having an issue with passenger.log. It's filled every 5 sec with that kind of logs, even when no websites was using it:

[ D 2022-10-13 12:07:40.0001 3592350/T1g age/Cor/Con/TurboCaching.h:246 ]: Clearing turbocache
[ D 2022-10-13 12:07:40.0002 3592350/T1g Ser/Server.h:691 ]: [ServerThr.23] Updating statistics
[ D 2022-10-13 12:07:40.0002 3592350/T3 age/Cor/App/Poo/AnalyticsCollection.cpp:116 ]: Analytics collection time...
[ D 2022-10-13 12:07:40.0003 3592350/T3 age/Cor/App/Poo/AnalyticsCollection.cpp:143 ]: Collecting process metrics
[ D 2022-10-13 12:07:40.0003 3592350/T1s age/Cor/Con/TurboCaching.h:246 ]: Clearing turbocache
[ D 2022-10-13 12:07:40.0003 3592350/T3 age/Cor/App/Poo/AnalyticsCollection.cpp:151 ]: Collecting system metrics
[ D 2022-10-13 12:07:40.0003 3592350/T1c age/Cor/Con/TurboCaching.h:246 ]: Clearing turbocache
[ D 2022-10-13 12:07:40.0003 3592350/T1r age/Cor/Con/TurboCaching.h:246 ]: Clearing turbocache
[ D 2022-10-13 12:07:40.0004 3592350/T1s Ser/Server.h:691 ]: [ServerThr.29] Updating statistics
[ D 2022-10-13 12:07:40.0004 3592350/T1c Ser/Server.h:691 ]: [ServerThr.21] Updating statistics
[ D 2022-10-13 12:07:40.0005 3592350/T1r Ser/Server.h:691 ]: [ServerThr.28] Updating statistics
[ D 2022-10-13 12:07:40.0011 3592350/T3 age/Cor/App/Poo/AnalyticsCollection.cpp:67 ]: Analytics collection done; next analytics collection in 4.999 sec
[ D 2022-10-13 12:07:40.0040 3592350/Ti age/Cor/Con/TurboCaching.h:246 ]: Clearing turbocache
[ D 2022-10-13 12:07:40.0041 3592350/T11 age/Cor/Con/TurboCaching.h:246 ]: Clearing turbocache
[ D 2022-10-13 12:07:40.0041 3592350/T2c age/Cor/Con/TurboCaching.h:246 ]: Clearing turbocache
[ D 2022-10-13 12:07:40.0041 3592350/T22 age/Cor/Con/TurboCaching.h:246 ]: Clearing turbocache
[ D 2022-10-13 12:07:40.0041 3592350/Ti Ser/Server.h:691 ]: [ServerThr.6] Updating statistics
[ D 2022-10-13 12:07:40.0041 3592341/T5 Ser/Server.h:691 ]: [WatchdogApiServer] Updating statistics
[ D 2022-10-13 12:07:40.0043 3592350/Tu age/Cor/Con/TurboCaching.h:246 ]: Clearing turbocache
[ D 2022-10-13 12:07:40.0041 3592350/T28 age/Cor/Con/TurboCaching.h:246 ]: Clearing turbocache
[ D 2022-10-13 12:07:40.0042 3592350/T18 age/Cor/Con/TurboCaching.h:246 ]: Clearing turbocache
[ D 2022-10-13 12:07:40.0041 3592350/T11 Ser/Server.h:691 ]: [ServerThr.15] Updating statistics
[ D 2022-10-13 12:07:40.0041 3592350/Tg age/Cor/Con/TurboCaching.h:246 ]: Clearing turbocache
[ D 2022-10-13 12:07:40.0042 3592350/T1k age/Cor/Con/TurboCaching.h:246 ]: Clearing turbocache
[ D 2022-10-13 12:07:40.0042 3592350/T2c Ser/Server.h:691 ]: [ServerThr.39] Updating statistics
[ D 2022-10-13 12:07:40.0042 3592350/T12 age/Cor/Con/TurboCaching.h:246 ]: Clearing turbocache
[ D 2022-10-13 12:07:40.0042 3592350/T22 Ser/Server.h:691 ]: [ServerThr.34] Updating statistics
[ D 2022-10-13 12:07:40.0043 3592350/T26 age/Cor/Con/TurboCaching.h:246 ]: Clearing turbocache
[ D 2022-10-13 12:07:40.0043 3592350/T1m age/Cor/Con/TurboCaching.h:246 ]: Clearing turbocache
[ D 2022-10-13 12:07:40.0043 3592350/Tw age/Cor/Con/TurboCaching.h:246 ]: Clearing turbocache
[ D 2022-10-13 12:07:40.0043 3592350/T2a age/Cor/Con/TurboCaching.h:246 ]: Clearing turbocache
[ D 2022-10-13 12:07:40.0043 3592350/T24 age/Cor/Con/TurboCaching.h:246 ]: Clearing turbocache
[ D 2022-10-13 12:07:40.0043 3592350/Tk age/Cor/Con/TurboCaching.h:246 ]: Clearing turbocache
[ D 2022-10-13 12:07:40.0043 3592350/Te age/Cor/Con/TurboCaching.h:246 ]: Clearing turbocache
[ D 2022-10-13 12:07:40.0043 3592350/T1w age/Cor/Con/TurboCaching.h:246 ]: Clearing turbocache
[ D 2022-10-13 12:07:40.0043 3592350/T16 age/Cor/Con/TurboCaching.h:246 ]: Clearing turbocache
[ D 2022-10-13 12:07:40.0043 3592350/T2e age/Cor/Con/TurboCaching.h:246 ]: Clearing turbocache
[ D 2022-10-13 12:07:40.0043 3592350/Tt age/Cor/Con/TurboCaching.h:246 ]: Clearing turbocache
[ D 2022-10-13 12:07:40.0043 3592350/T1y age/Cor/Con/TurboCaching.h:246 ]: Clearing turbocache
[ D 2022-10-13 12:07:40.0043 3592350/T1a age/Cor/Con/TurboCaching.h:246 ]: Clearing turbocache
[ D 2022-10-13 12:07:40.0044 3592350/Tu Ser/Server.h:691 ]: [ServerThr.12] Updating statistics
[ D 2022-10-13 12:07:40.0043 3592350/T1e age/Cor/Con/TurboCaching.h:246 ]: Clearing turbocache
[ D 2022-10-13 12:07:40.0043 3592350/T2g Ser/Server.h:691 ]: [ApiServer] Updating statistics
[ D 2022-10-13 12:07:40.0043 3592350/Tz age/Cor/Con/TurboCaching.h:246 ]: Clearing turbocache
[ D 2022-10-13 12:07:40.0043 3592350/Tr age/Cor/Con/TurboCaching.h:246 ]: Clearing turbocache
[ D 2022-10-13 12:07:40.0044 3592350/T28 Ser/Server.h:691 ]: [ServerThr.37] Updating statistics
[ D 2022-10-13 12:07:40.0043 3592350/T1i age/Cor/Con/TurboCaching.h:246 ]: Clearing turbocache
[ D 2022-10-13 12:07:40.0043 3592350/T14 age/Cor/Con/TurboCaching.h:246 ]: Clearing turbocache
[ D 2022-10-13 12:07:40.0043 3592350/T1u age/Cor/Con/TurboCaching.h:246 ]: Clearing turbocache
[ D 2022-10-13 12:07:40.0043 3592350/Tm age/Cor/Con/TurboCaching.h:246 ]: Clearing turbocache
[ D 2022-10-13 12:07:40.0043 3592350/T21 age/Cor/Con/TurboCaching.h:246 ]: Clearing turbocache
[ D 2022-10-13 12:07:40.0044 3592350/T18 Ser/Server.h:691 ]: [ServerThr.19] Updating statistics
[ D 2022-10-13 12:07:40.0045 3592350/Tg Ser/Server.h:691 ]: [ServerThr.5] Updating statistics
[ D 2022-10-13 12:07:40.0045 3592350/T1k Ser/Server.h:691 ]: [ServerThr.25] Updating statistics
[ D 2022-10-13 12:07:40.0045 3592350/T12 Ser/Server.h:691 ]: [ServerThr.16] Updating statistics
[ D 2022-10-13 12:07:40.0046 3592350/T1o age/Cor/Con/TurboCaching.h:246 ]: Clearing turbocache
[ D 2022-10-13 12:07:40.0046 3592350/T26 Ser/Server.h:691 ]: [ServerThr.36] Updating statistics
[ D 2022-10-13 12:07:40.0046 3592350/T1m Ser/Server.h:691 ]: [ServerThr.26] Updating statistics
[ D 2022-10-13 12:07:40.0046 3592350/Tw Ser/Server.h:691 ]: [ServerThr.13] Updating statistics
[ D 2022-10-13 12:07:40.0047 3592350/T2a Ser/Server.h:691 ]: [ServerThr.38] Updating statistics
[ D 2022-10-13 12:07:40.0047 3592350/Tp age/Cor/Con/TurboCaching.h:246 ]: Clearing turbocache
[ D 2022-10-13 12:07:40.0047 3592350/T24 Ser/Server.h:691 ]: [ServerThr.35] Updating statistics
[ D 2022-10-13 12:07:40.0047 3592350/Tk Ser/Server.h:691 ]: [ServerThr.7] Updating statistics
[ D 2022-10-13 12:07:40.0053 3592350/Tp Ser/Server.h:691 ]: [ServerThr.9] Updating statistics
[ D 2022-10-13 12:07:40.0047 3592350/Te Ser/Server.h:691 ]: [ServerThr.4] Updating statistics
[ D 2022-10-13 12:07:40.0048 3592350/T1w Ser/Server.h:691 ]: [ServerThr.31] Updating statistics
[ D 2022-10-13 12:07:40.0048 3592350/T16 Ser/Server.h:691 ]: [ServerThr.18] Updating statistics
[ D 2022-10-13 12:07:40.0048 3592350/T2e Ser/Server.h:691 ]: [ServerThr.40] Updating statistics
[ D 2022-10-13 12:07:40.0049 3592350/Tt Ser/Server.h:691 ]: [ServerThr.11] Updating statistics
[ D 2022-10-13 12:07:40.0049 3592350/Ta age/Cor/Con/TurboCaching.h:246 ]: Clearing turbocache
[ D 2022-10-13 12:07:40.0049 3592350/Td age/Cor/Con/TurboCaching.h:246 ]: Clearing turbocache
[ D 2022-10-13 12:07:40.0049 3592350/T1y Ser/Server.h:691 ]: [ServerThr.32] Updating statistics
[ D 2022-10-13 12:07:40.0049 3592350/T1a Ser/Server.h:691 ]: [ServerThr.20] Updating statistics
[ D 2022-10-13 12:07:40.0050 3592350/T1e Ser/Server.h:691 ]: [ServerThr.22] Updating statistics
[ D 2022-10-13 12:07:40.0050 3592350/T8 age/Cor/Con/TurboCaching.h:246 ]: Clearing turbocache
[ D 2022-10-13 12:07:40.0050 3592350/Tz Ser/Server.h:691 ]: [ServerThr.14] Updating statistics
[ D 2022-10-13 12:07:40.0051 3592350/Tr Ser/Server.h:691 ]: [ServerThr.10] Updating statistics
[ D 2022-10-13 12:07:40.0051 3592350/T1i Ser/Server.h:691 ]: [ServerThr.24] Updating statistics
[ D 2022-10-13 12:07:40.0051 3592350/T14 Ser/Server.h:691 ]: [ServerThr.17] Updating statistics
[ D 2022-10-13 12:07:40.0052 3592350/T1u Ser/Server.h:691 ]: [ServerThr.30] Updating statistics
[ D 2022-10-13 12:07:40.0052 3592350/Tm Ser/Server.h:691 ]: [ServerThr.8] Updating statistics
[ D 2022-10-13 12:07:40.0052 3592350/T21 Ser/Server.h:691 ]: [ServerThr.33] Updating statistics
[ D 2022-10-13 12:07:40.0053 3592350/T1o Ser/Server.h:691 ]: [ServerThr.27] Updating statistics
[ D 2022-10-13 12:07:40.0055 3592350/Ta Ser/Server.h:691 ]: [ServerThr.2] Updating statistics
[ D 2022-10-13 12:07:40.0055 3592350/Td Ser/Server.h:691 ]: [ServerThr.3] Updating statistics
[ D 2022-10-13 12:07:40.0055 3592350/T8 Ser/Server.h:691 ]: [ServerThr.1] Updating statistics
Click to expand...

I've tried changing the PassengerLogLevel in /etc/apache2/mods-enabled/passenger.conf (which default to 5 (debug)) to warning level (2). But no improvements, still receiving tons of these logs...
Any idea on how to deal with this issue ?
 
I am not using Plesk, but I am having the same issue occurring using Redmine 4.1.1.stable.

I also tried adjusting the LogLevel setting as follows, and confirmed that I had restarted apache2 -- but, no change. Does anyone have any other ideas? Is there an application out there somewhere that will analyze Passenger settings and give you information and suggestions, etc.?

Screenshot 2023-06-22 030502.jpg

Thanks!
 
Followup: I ran the command "passenger-status -v --show=xml" and it produced the following: Hastebin

Notice line 47 of that file, it stills says that it's using Log Level 5. I'm not sure if there is another way to set/change that setting other than using the "PassengerLogLevel" directive in the apache2 config file ....but, I'll keep looking!
 
Well, I figured out my issue anyway..lol. It turns out that the PassengerLogLevel directive didn't have any effect in the passenger.conf file ..however, when I put the same directive in the apache.conf file, then it worked. The output of passenger-status -v --show=xml also reflected the log level as 1 now.

Moderator -- please feel free to delete all three of these messages if you wish.

Thanks!
 
Dutiko said:
Hello,

I'm having an issue with passenger.log. It's filled every 5 sec with that kind of logs, even when no websites was using it:



I've tried changing the PassengerLogLevel in /etc/apache2/mods-enabled/passenger.conf (which default to 5 (debug)) to warning level (2). But no improvements, still receiving tons of these logs...
Any idea on how to deal with this issue ?
Click to expand...
@Dutiko Did you get this to work? I've updated...
/etc/apache2/mods-enabled/passenger.conf
Click to expand...
...then restarted Apache as suggested by @Maarten.

However I am still seeing a constant flow of log entries i don't really need to see due to space issues (my passenger.log was 5GB+).

Code: 
[ D 2023-06-23 11:08:30.0044 4055/T14 Ser/Server.h:691 ]: [ApiServer] Updating statistics
[ D 2023-06-23 11:08:30.0044 4055/Ts Ser/Server.h:691 ]: [ServerThr.11] Updating statistics
[ D 2023-06-23 11:08:30.0044 4055/Tl Ser/Server.h:691 ]: [ServerThr.7] Updating statistics
[ D 2023-06-23 11:08:30.0044 4055/Ty age/Cor/Con/TurboCaching.h:246 ]: Clearing turbocache
[ D 2023-06-23 11:08:30.0044 4055/Ty Ser/Server.h:691 ]: [ServerThr.14] Updating statistics
[ D 2023-06-23 11:08:30.0045 4055/T8 age/Cor/Con/TurboCaching.h:246 ]: Clearing turbocache
[ D 2023-06-23 11:08:30.0045 4055/Tw age/Cor/Con/TurboCaching.h:246 ]: Clearing turbocache
[ D 2023-06-23 11:08:30.0045 4055/T8 Ser/Server.h:691 ]: [ServerThr.1] Updating statistics
[ D 2023-06-23 11:08:30.0045 4055/Tw Ser/Server.h:691 ]: [ServerThr.13] Updating statistics

Does anyone have some more tips or can confirm how to stop the insane log level happening?

Ubuntu 18.04.6 LTS / Plesk Obsidian / Version 18.0.51 Update #1
 
@Organizer
Are you using Apache or Nginx? For Nginx, there is a config file in /etc/nginx/conf.d where you can set the log level:
Code: 
# grep log_level /etc/nginx/conf.d/phusion-passenger.conf
passenger_log_level 0;
 
Maarten. said:
@Organizer
Are you using Apache or Nginx? For Nginx, there is a config file in /etc/nginx/conf.d where you can set the log level:
Code: 
# grep log_level /etc/nginx/conf.d/phusion-passenger.conf
passenger_log_level 0;
Click to expand...
Thank you @Maarten. ah, I am of course using NGIX should have thought about that, I'm pretty sure it will work now
 
You could post a Uservoice request to set it to level 2 by default. I am sure they have good reasons for their version, but I am not so sure what the outcome of the response could be and how it could help. Maybe it is better to simply request a change to level 2.
 
I just found this Uservoice request:

plesk.uservoice.com

Lower passenger log level to 3 by default

In plesk the log level of passenger in /etc/nginx/conf.d/phusion-passenger.conf and /etc/apache2/mods-enabled/passenger.conf is set to 5, which is a debug log level https://www.phusionpassenger.com/library/config/nginx/reference/#passenger_log_level This is too high and creates logs of 300Mb...
plesk.uservoice.com
 
I think the developers forgot to set the log level to a reasonable level. The current level is insane.
 
You must log in or register to reply here.

Similar threads

Ming
Issue Passenger issue - boost::thread_resource_error: Resource temporarily unavailable
Replies
12
Views
4K
Ming
Ming
Back
Top