Request timed out due to default_socket_timeout php.ini setting
-
Hi
We had 70 VLAN interfaces and 145 CARP interfaces.
The sync was working like a charm since we have applied the patch #12827.After adding 7 new VLAN and 7 new CARP interface I have a problem with sync between MASTER and BACKUP.
On MASTER :
Jan 4 16:35:35 X.X.X.253 php-fpm[47172]: /rc.filter_synchronize: Beginning XMLRPC sync data to https://X.X.X.252:443/xmlrpc.php. Jan 4 16:36:35 X.X.X.253 php-fpm[47172]: /rc.filter_synchronize: A communications error occurred while attempting to call XMLRPC method restore_config_section: Request timed out due to default_socket_timeout php.ini setting Jan 4 16:36:35 X.X.X.253 php-fpm[47172]: /rc.filter_synchronize: New alert found: A communications error occurred while attempting to call XMLRPC method restore_config_section: Request timed out due to default_socket_timeout php.ini setting
On BACKUP the php-fpm log is flooded by :
Jan 4 16:35:35 X.X.X.252 php-fpm[48494]: /rc.carpbackup: HA cluster member "(X.X.X.201@lagg1.311): (WAN)" has resumed CARP state "BACKUP" for vhid 2 Jan 4 16:35:35 X.X.X.252 php-fpm[76961]: /rc.carpbackup: HA cluster member "(X.X.X.2@lagg1.311): (WAN)" has resumed CARP state "BACKUP" for vhid 2 Jan 4 16:35:35 X.X.X.252 php-fpm[82224]: /rc.carpbackup: HA cluster member "(X.X.X.245@lagg1.311): (WAN)" has resumed CARP state "BACKUP" for vhid 2 Jan 4 16:35:35 X.X.X.252 php-fpm[76961]: /rc.carpbackup: HA cluster member "(X.X.X.9@lagg1.311): (WAN)" has resumed CARP state "BACKUP" for vhid 2 Jan 4 16:35:35 X.X.X.252 php-fpm[98249]: /rc.carpbackup: HA cluster member "(X.X.X.49@lagg1.311): (WAN)" has resumed CARP state "BACKUP" for vhid 2 Jan 4 16:35:35 X.X.X.252 php-fpm[77095]: /rc.carpbackup: HA cluster member "(X.X.X.20@lagg1.311): (WAN)" has resumed CARP state "BACKUP" for vhid 2 Jan 4 16:35:35 X.X.X.252 php-fpm[48494]: /rc.carpbackup: HA cluster member "(X.X.X.203@lagg1.311): (WAN)" has resumed CARP state "BACKUP" for vhid 2 Jan 4 16:35:35 X.X.X.252 php-fpm[81850]: /rc.carpbackup: HA cluster member "(X.X.X.71@lagg1.311): (WAN)" has resumed CARP state "BACKUP" for vhid 2 Jan 4 16:35:35 X.X.X.252 php-fpm[82224]: /rc.carpbackup: HA cluster member "(X.X.X.55@lagg1.311): (WAN)" has resumed CARP state "BACKUP" for vhid 2 Jan 4 16:35:35 X.X.X.252 php-fpm[98249]: /rc.carpbackup: HA cluster member "(X.X.X.50@lagg1.311): (WAN)" has resumed CARP state "BACKUP" for vhid 2 Jan 4 16:35:35 X.X.X.252 php-fpm[77095]: /rc.carpbackup: HA cluster member "(X.X.X.1@lagg1.311): (WAN)" has resumed CARP state "BACKUP" for vhid 2 Jan 4 16:35:35 X.X.X.252 php-fpm[76961]: /rc.carpbackup: HA cluster member "(X.X.X.11@lagg1.311): (WAN)" has resumed CARP state "BACKUP" for vhid 2 Jan 4 16:35:35 X.X.X.252 php-fpm[48494]: /rc.carpbackup: HA cluster member "(X.X.X.204@lagg1.311): (WAN)" has resumed CARP state "BACKUP" for vhid 2 Jan 4 16:35:35 X.X.X.252 php-fpm[81850]: /rc.carpbackup: HA cluster member "(X.X.X.127@lagg1.311): (WAN)" has resumed CARP state "BACKUP" for vhid 2 Jan 4 16:35:35 X.X.X.252 php-fpm[82224]: /rc.carpbackup: HA cluster member "(X.X.X.2@lagg1.311): (WAN)" has resumed CARP state "BACKUP" for vhid 2 Jan 4 16:35:35 X.X.X.252 php-fpm[98249]: /rc.carpbackup: HA cluster member "(X.X.X.51@lagg1.311): (WAN)" has resumed CARP state "BACKUP" for vhid 2 Jan 4 16:35:35 X.X.X.252 php-fpm[77095]: /rc.carpbackup: HA cluster member "(X.X.X.2@lagg1.311): (WAN)" has resumed CARP state "BACKUP" for vhid 2 Jan 4 16:35:35 X.X.X.252 php-fpm[76961]: /rc.carpbackup: HA cluster member "(X.X.X.14@lagg1.311): (WAN)" has resumed CARP state "BACKUP" for vhid 2 Jan 4 16:35:35 X.X.X.252 php-fpm[48494]: /rc.carpbackup: HA cluster member "(X.X.X.198@lagg1.311): (WAN)" has resumed CARP state "BACKUP" for vhid 2 Jan 4 16:35:35 X.X.X.252 php-fpm[81850]: /rc.carpbackup: HA cluster member "(X.X.X.199@lagg1.311): (WAN)" has resumed CARP state "BACKUP" for vhid 2 Jan 4 16:35:35 X.X.X.252 php-fpm[82224]: /rc.carpbackup: HA cluster member "(X.X.X.1@lagg1.311): (WAN)" has resumed CARP state "BACKUP" for vhid 2 Jan 4 16:35:35 X.X.X.252 php-fpm[98249]: /rc.carpbackup: HA cluster member "(X.X.X.69@lagg1.311): (WAN)" has resumed CARP state "BACKUP" for vhid 2 Jan 4 16:35:35 X.X.X.252 php-fpm[77095]: /rc.carpbackup: HA cluster member "(X.X.X.9@lagg1.311): (WAN)" has resumed CARP state "BACKUP" for vhid 2 Jan 4 16:35:35 X.X.X.252 php-fpm[76961]: /rc.carpbackup: HA cluster member "(X.X.X.15@lagg1.311): (WAN)" has resumed CARP state "BACKUP" for vhid 2 Jan 4 16:35:35 X.X.X.252 php-fpm[48494]: /rc.carpbackup: HA cluster member "(X.X.X.72@lagg1.311): (WAN)" has resumed CARP state "BACKUP" for vhid 2 Jan 4 16:35:35 X.X.X.252 php-fpm[81850]: /rc.carpbackup: HA cluster member "(X.X.X.201@lagg1.311): (WAN)" has resumed CARP state "BACKUP" for vhid 2 Jan 4 16:35:35 X.X.X.252 php-fpm[82224]: /rc.carpbackup: HA cluster member "(X.X.X.3@lagg1.311): (WAN)" has resumed CARP state "BACKUP" for vhid 2 Jan 4 16:35:35 X.X.X.252 php-fpm[98249]: /rc.carpbackup: HA cluster member "(X.X.X.70@lagg1.311): (WAN)" has resumed CARP state "BACKUP" for vhid 2 Jan 4 16:35:35 X.X.X.252 php-fpm[38781]: /rc.carpbackup: HA cluster member "(X.X.X.20@lagg1.311): (WAN)" has resumed CARP state "BACKUP" for vhid 2 Jan 4 16:35:35 X.X.X.252 php-fpm[77095]: /rc.carpbackup: HA cluster member "(X.X.X.11@lagg1.311): (WAN)" has resumed CARP state "BACKUP" for vhid 2 Jan 4 16:35:35 X.X.X.252 php-fpm[76961]: /rc.carpbackup: HA cluster member "(X.X.X.16@lagg1.311): (WAN)" has resumed CARP state "BACKUP" for vhid 2 Jan 4 16:35:35 X.X.X.252 php-fpm[48494]: /rc.carpbackup: HA cluster member "(X.X.X.73@lagg1.311): (WAN)" has resumed CARP state "BACKUP" for vhid 2 Jan 4 16:35:35 X.X.X.252 php-fpm[81850]: /rc.carpbackup: HA cluster member "(X.X.X.203@lagg1.311): (WAN)" has resumed CARP state "BACKUP" for vhid 2 Jan 4 16:35:35 X.X.X.252 php-fpm[98249]: /rc.carpbackup: HA cluster member "(X.X.X.71@lagg1.311): (WAN)" has resumed CARP state "BACKUP" for vhid 2 Jan 4 16:35:35 X.X.X.252 php-fpm[82224]: /rc.carpbackup: HA cluster member "(X.X.X.4@lagg1.311): (WAN)" has resumed CARP state "BACKUP" for vhid 2 Jan 4 16:35:35 X.X.X.252 php-fpm[38781]: /rc.carpbackup: HA cluster member "(X.X.X.1@lagg1.311): (WAN)" has resumed CARP state "BACKUP" for vhid 2 Jan 4 16:35:35 X.X.X.252 php-fpm[77095]: /rc.carpbackup: HA cluster member "(X.X.X.14@lagg1.311): (WAN)" has resumed CARP state "BACKUP" for vhid 2 Jan 4 16:35:35 X.X.X.252 php-fpm[76961]: /rc.carpbackup: HA cluster member "(X.X.X.18@lagg1.311): (WAN)" has resumed CARP state "BACKUP" for vhid 2 Jan 4 16:35:35 X.X.X.252 php-fpm[48494]: /rc.carpbackup: HA cluster member "(X.X.X.74@lagg1.311): (WAN)" has resumed CARP state "BACKUP" for vhid 2 Jan 4 16:35:35 X.X.X.252 php-fpm[81850]: /rc.carpbackup: HA cluster member "(X.X.X.204@lagg1.311): (WAN)" has resumed CARP state "BACKUP" for vhid 2 Jan 4 16:35:35 X.X.X.252 php-fpm[98249]: /rc.carpbackup: HA cluster member "(X.X.X.127@lagg1.311): (WAN)" has resumed CARP state "BACKUP" for vhid 2 Jan 4 16:35:35 X.X.X.252 php-fpm[82224]: /rc.carpbackup: HA cluster member "(X.X.X.139@lagg1.311): (WAN)" has resumed CARP state "BACKUP" for vhid 2
Is there a way to grow up the php-fpm timeout ?
Thanks
Pfsense Version 2.6.0-RELEASE (amd64)
built on Mon Jan 31 19:57:53 UTC 2022
FreeBSD 12.3-STABLE -
@marcolefo I don't know the answer to your question about PHP timeout, but possibly it might help to change some of the CARP IPs to IP Alias?
https://docs.netgate.com/pfsense/en/latest/highavailability/reduce-heartbeat-traffic.html
-
@steveits thanks I will try that.
I will try to convert all my NAT CARP interface to IP aliases of the WAN. -
This post is deleted! -
@marcolefo said in Request timed out due to default_socket_timeout php.ini setting:
@steveits thanks I will try that.
I will try to convert all my NAT CARP interface to IP aliases of the WAN.Hello Marcolefo,
We have the same problem.
Have you solved yours by changing IP CARP TO IP ALIAS?
THANKS -
Yes. After converting a few CARP to IP alias, the problem disappear.
Note we have applied the patch #12827. -