Bug #77430 [Com]: php-fpm crashes with Main process exited, code=dumped, status=11/SEGV

Edit report at https://bugs.php.net/bug.php?id=77430&edit=1 ID: 77430 Comment by: claudiu_beta at yahoo dot com Reported by: claudiu_beta at yahoo dot com Summary: php-fpm crashes with Main process exited, code=dumped, status=11/SEGV Status: Assigned Type: Bug Package: FPM related Operating System: Fedora 28 PHP Version: 7.3.1RC1 Assigned To: bukka Block user comment: N Private report: N New Comment: I'm using exactly the same templates for all 7.1,7.2,7.3 on few servers. I only have issues with 7.3. My monitoring script finds php73 service down several times a day, sometimes two or three times each hour. Maybe a coincidence, I don't know. Till RC6 I had no issues or, let say, just 1-2 issues a week (under 100 pools). After 7.3.0 GA, the number of issues increased a lot (number of pools per server on average 200-300). Different servers, different sites, the same issue. In logs I have no errors, nor "pipe is closed", nor anything else. I have checked the logs before and after the crash, nothing. With 7.2, for example, I have 1000+ pools on the same server with no crash issues. I have errors in logs like [07-Jan-2019 20:34:25] ERROR: unable to read what child say: Bad file descriptor (9) [07-Jan-2019 20:34:25] ERROR: unable to read what child say: Bad file descriptor (9) [07-Jan-2019 20:35:27] NOTICE: [pool poolname] child 23542 exited with code 0 after 69.601713 seconds from start [07-Jan-2019 20:35:27] NOTICE: [pool poolname] child 23797 started but service will not crash. php-fpm.conf include=/etc/opt/remi/php73/php-fpm.d/*.conf [global] pid = /var/opt/remi/php73/run/php-fpm/php-fpm.pid error_log = /var/log/php-fpm/master73.log syslog.ident = php-fpm73 daemonize = yes rlimit_files = 30000 and a pool [poolname] user = apache group = apache listen = /var/opt/remi/php73/run/php-fpm/pool.sock listen.acl_users = apache listen.allowed_clients = 127.0.0.1 pm = ondemand pm.max_children = 15 pm.process_idle_timeout = 4s pm.max_requests = 30 pm.status_path = /fpmstats slowlog = /var/log/php-fpm/00000_www-slow.log request_slowlog_timeout = 60 request_terminate_timeout = 63 chdir = /home/users/domain catch_workers_output = yes security.limit_extensions = .php .phtml .phar php_admin_value[mail.log] = /var/log/php-fpm/php_mail.log php_admin_value[mail.add_x_header] = On php_admin_value[error_log] = /var/log/php-fpm/domain.73.log php_admin_value[doc_root] = "/home/users/domain" php_admin_value[max_execution_time] = 60 php_admin_value[max_input_time] = 90 php_admin_value[max_input_vars] = 1000 php_admin_value[memory_limit] = 256M php_admin_value[post_max_size] = 10M php_admin_value[upload_max_filesize] = 10M php_admin_value[default_socket_timeout] = 30 php_admin_value[open_basedir] = /home/users/domain/:/tmp/:/usr/share/pear/ php_admin_value[disable_functions] = mail, mb_send_mail, system, exec, shell_exec, passthru, error_log, dl, sys_getloadavg, pfsockopen, openlog, syslog, readlink, symlink, link, leak, popen, escapeshellcmd Previous Comments: ------------------------------------------------------------------------ [2019-01-08 19:48:28] bukka@php.net > #0 0x000055a8f4f64703 in zlog_stream_set_msg_suffix (stream=stream@entry=0x200, > suffix=suffix@entry=0x0, final_suffix=final_suffix@entry=0x55a8f4fc37f6 ", pipe is > closed") This looks like something went really wrong as initially reading of the pipe failed and then the stream pointer is 0x200 which looks like the child structure got corrupted maybe. Could you share your FPM config and possibly a bit more details about the app? Can you see "pipe is closed" in the logs when using 7.2 or 7.1 (just want check if the pipe is getting closed in there as well)? ------------------------------------------------------------------------ [2019-01-08 10:16:27] remi@php.net No need to be private ------------------------------------------------------------------------ [2019-01-08 10:10:38] claudiu_beta at yahoo dot com Description: ------------ I'm using php 7.3 RC1 from Remi repo. PHP 7.1, 7.2 and 7.3 running on the same machine with same php-fpm configuration and same pool configuration. I only have issues with php 7.3 which is going down frequently. Redirecting to /bin/systemctl status php73-php-fpm.service ● php73-php-fpm.service - The PHP FastCGI Process Manager Loaded: loaded (/usr/lib/systemd/system/php73-php-fpm.service; disabled; vendor preset: disabled) Active: failed (Result: core-dump) since Mon 2019-01-07 14:56:05 EET; 54s ago Process: 9541 ExecStart=/opt/remi/php73/root/usr/sbin/php-fpm --nodaemonize (code=dumped, signal=SEGV) Main PID: 9541 (code=dumped, signal=SEGV) Status: "Processes active: 0, idle: 2, Requests: 225, slow: 3, Traffic: 0.9req/sec" Jan 07 14:48:12 serv systemd[1]: Starting The PHP FastCGI Process Manager... Jan 07 14:48:12 serv systemd[1]: Started The PHP FastCGI Process Manager. Jan 07 14:56:05 serv systemd[1]: php73-php-fpm.service: Main process exited, code=dumped, status=11/SEGV Jan 07 14:56:05 serv systemd[1]: php73-php-fpm.service: Failed with result 'core-dump'. Installed packages: php73-php-debuginfo-7.3.1~RC1-1.fc28.remi.x86_64 php73-php-common-7.3.1~RC1-1.fc28.remi.x86_64 php73-php-devel-7.3.1~RC1-1.fc28.remi.x86_64 php73-php-pecl-zip-1.15.4-1.fc28.remi.x86_64 php73-php-bcmath-7.3.1~RC1-1.fc28.remi.x86_64 php73-php-xml-7.3.1~RC1-1.fc28.remi.x86_64 php73-php-gd-7.3.1~RC1-1.fc28.remi.x86_64 php73-php-ioncube-loader-10.3.2-1.fc28.remi.x86_64 php73-php-mysqlnd-7.3.1~RC1-1.fc28.remi.x86_64 php73-php-soap-7.3.1~RC1-1.fc28.remi.x86_64 php73-php-fpm-debuginfo-7.3.1~RC1-1.fc28.remi.x86_64 php73-build-1.0-1.fc28.remi.x86_64 php73-php-intl-7.3.1~RC1-1.fc28.remi.x86_64 php73-php-pear-1.10.7-4.fc28.remi.noarch php73-php-mbstring-7.3.1~RC1-1.fc28.remi.x86_64 php73-php-gmp-7.3.1~RC1-1.fc28.remi.x86_64 php73-php-pecl-imagick-3.4.3-13.fc28.remi.x86_64 php73-1.0-1.fc28.remi.x86_64 php73-php-pecl-memcached-3.1.3-1.fc28.remi.x86_64 php73-runtime-1.0-1.fc28.remi.x86_64 php73-php-imap-7.3.1~RC1-1.fc28.remi.x86_64 php73-php-pdo-7.3.1~RC1-1.fc28.remi.x86_64 php73-php-fpm-7.3.1~RC1-1.fc28.remi.x86_64 php73-php-json-7.3.1~RC1-1.fc28.remi.x86_64 php73-php-pecl-igbinary-2.0.8-1.fc28.remi.x86_64 php73-php-xmlrpc-7.3.1~RC1-1.fc28.remi.x86_64 php73-php-process-7.3.1~RC1-1.fc28.remi.x86_64 php73-php-cli-7.3.1~RC1-1.fc28.remi.x86_64 php73-php-pecl-msgpack-2.0.3-1.fc28.remi.x86_64 (gdb) bt #0 0x000055a8f4f64703 in zlog_stream_set_msg_suffix (stream=stream@entry=0x200, suffix=suffix@entry=0x0, final_suffix=final_suffix@entry=0x55a8f4fc37f6 ", pipe is closed") at /usr/src/debug/php73-php-7.3.1~RC1-1.fc28.remi.x86_64/sapi/fpm/fpm/zlog.c:602 #1 0x000055a8f4f61b99 in fpm_stdio_child_said (ev=<optimized out>, which=<optimized out>, arg=0x55a8f6b9bdd0) at /usr/src/debug/php73-php-7.3.1~RC1-1.fc28.remi.x86_64/sapi/fpm/fpm/fpm_stdio.c:199 #2 0x000055a8f4f67026 in fpm_event_epoll_wait (queue=<optimized out>, timeout=<optimized out>) at /usr/src/debug/php73-php-7.3.1~RC1-1.fc28.remi.x86_64/sapi/fpm/fpm/events/epoll.c:145 #3 0x000055a8f4f59914 in fpm_event_loop (err=err@entry=0) at /usr/src/debug/php73-php-7.3.1~RC1-1.fc28.remi.x86_64/sapi/fpm/fpm/fpm_events.c:409 #4 0x000055a8f4f53ca7 in fpm_run (max_requests=0x7ffc4910c26c) at /usr/src/debug/php73-php-7.3.1~RC1-1.fc28.remi.x86_64/sapi/fpm/fpm/fpm.c:113 #5 0x000055a8f4d31404 in main (argc=2, argv=0x7ffc4910c888) at /usr/src/debug/php73-php-7.3.1~RC1-1.fc28.remi.x86_64/sapi/fpm/fpm/fpm_main.c:1864 ------------------------------------------------------------------------ -- Edit this bug report at https://bugs.php.net/bug.php?id=77430&edit=1