Bug #68630 [NEW]: "ALERT: oops, unknown child (...) exited with code 0."
| From: | dz at heroku dot com | Date: | Fri, 19 Dec 2014 15:27:03 +0000 |
| Subject: | Bug #68630 [NEW]: "ALERT: oops, unknown child (...) exited with code 0." | ||
| Groups: | php.bugs | ||
| Request: | Send a blank email to php-bugs+get-189132@lists.php.net to get a copy of this message | ||
From: dz at heroku dot com
Operating system: Ubuntu 14.04
PHP version: 5.6.4
Package: FPM related
Bug Type: Bug
Bug description:"ALERT: oops, unknown child (...) exited with code 0."
Description:
------------
[19-Dec-2014 14:27:38.971730] NOTICE: pid 106, fpm_unix_conf_wp(), line
128: [pool www] 'user' directive is ignored when FPM is not running as
root
[19-Dec-2014 14:27:38.971730] NOTICE: pid 106, fpm_unix_conf_wp(), line
128: [pool www] 'user' directive is ignored when FPM is not running as
root
[19-Dec-2014 14:27:38.973187] DEBUG: pid 106,
fpm_scoreboard_init_main(), line 40: got clock tick '100'
[19-Dec-2014 14:27:38.973690] DEBUG: pid 106, fpm_event_init_main(),
line 337: event module is epoll and 11 fds have been reserved
[19-Dec-2014 14:27:38.973912] NOTICE: pid 106, fpm_init(), line 85: fpm
is running, pid 106
[19-Dec-2014 14:27:38.976294] DEBUG: pid 106, fpm_children_make(), line
421: [pool www] child 117 started
[19-Dec-2014 14:27:38.978554] DEBUG: pid 106, fpm_children_make(), line
421: [pool www] child 118 started
[19-Dec-2014 14:27:38.978608] DEBUG: pid 106, fpm_event_loop(), line
366: 5992 bytes have been reserved in SHM
[19-Dec-2014 14:27:38.978616] NOTICE: pid 106, fpm_event_loop(), line
367: ready to handle connections
...
[19-Dec-2014 14:44:20.240893] DEBUG: pid 106,
fpm_pctl_perform_idle_server_maintenance(), line 379: [pool www]
currently 0 active children, 3 spare children, 3 running children.
Spawning rate 1
[19-Dec-2014 14:44:21.256687] DEBUG: pid 106,
fpm_pctl_perform_idle_server_maintenance(), line 379: [pool www]
currently 3 active children, 0 spare children, 3 running children.
Spawning rate 1
[19-Dec-2014 14:44:21.279763] DEBUG: pid 106, fpm_children_make(), line
421: [pool www] child 135 started
[19-Dec-2014 14:44:21.279813] DEBUG: pid 106,
fpm_pctl_perform_idle_server_maintenance(), line 428: [pool www] 1
child(ren) have been created dynamically
[19-Dec-2014 14:44:22.258713] DEBUG: pid 106,
fpm_pctl_perform_idle_server_maintenance(), line 379: [pool www]
currently 0 active children, 4 spare children, 4 running children.
Spawning rate 2
[19-Dec-2014 14:44:22.279948] DEBUG: pid 106, fpm_event_loop(), line
419: event module triggered 1 events
[19-Dec-2014 14:44:22.280206] DEBUG: pid 106, fpm_event_loop(), line
419: event module triggered 1 events
[19-Dec-2014 14:44:22.285477] DEBUG: pid 106, fpm_got_signal(), line 76:
received SIGCHLD
[19-Dec-2014 14:44:22.285598] ALERT: pid 106, fpm_children_bury(), line
295: oops, unknown child (113) exited with code 0. Please open a bug
report (https://bugs.php.net).
[19-Dec-2014 14:44:22.285672] DEBUG: pid 106, fpm_children_bury(), line
254: [pool www] child 117 has been killed by the process management
after 1003.309423 seconds from start
[19-Dec-2014 14:44:22.285715] DEBUG: pid 106, fpm_event_loop(), line
419: event module triggered 1 events
[19-Dec-2014 14:44:23.260780] DEBUG: pid 106,
fpm_pctl_perform_idle_server_maintenance(), line 379: [pool www]
currently 0 active children, 3 spare children, 3 running children.
Spawning rate 1
[19-Dec-2014 14:44:24.263014] DEBUG: pid 106,
fpm_pctl_perform_idle_server_maintenance(), line 379: [pool www]
currently 0 active children, 3 spare children, 3 running children.
Spawning rate 1
[19-Dec-2014 14:44:25.264402] DEBUG: pid 106,
fpm_pctl_perform_idle_server_maintenance(), line 379: [pool www]
currently 0 active children, 3 spare children, 3 running children.
Spawning rate 1
[19-Dec-2014 14:44:26.266396] DEBUG: pid 106,
fpm_pctl_perform_idle_server_maintenance(), line 379: [pool www]
currently 0 active children, 3 spare children, 3 running children.
Spawning rate 1
[19-Dec-2014 14:44:27.267484] DEBUG: pid 106,
fpm_pctl_perform_idle_server_maintenance(), line 379: [pool www]
currently 0 active children, 3 spare children, 3 running children.
Spawning rate 1
Could this be some kind of race condition in fpm_got_signal() and
fpm_children_bury()?
The weird thing is that the lowest child PID spawned was 117.
Any idea where this is coming from or how to investigate? I cannot
generate a GDB backtrace unfortunately.
--
Edit bug report at https://bugs.php.net/bug.php?id=68630&edit=1
--
Try a snapshot (PHP 5.4): https://bugs.php.net/fix.php?id=68630&r=trysnapshot54
Try a snapshot (PHP 5.5): https://bugs.php.net/fix.php?id=68630&r=trysnapshot55
Try a snapshot (trunk): https://bugs.php.net/fix.php?id=68630&r=trysnapshottrunk
Fixed in SVN: https://bugs.php.net/fix.php?id=68630&r=fixed
Fixed in release: https://bugs.php.net/fix.php?id=68630&r=alreadyfixed
Need backtrace: https://bugs.php.net/fix.php?id=68630&r=needtrace
Need Reproduce Script: https://bugs.php.net/fix.php?id=68630&r=needscript
Try newer version: https://bugs.php.net/fix.php?id=68630&r=oldversion
Not developer issue: https://bugs.php.net/fix.php?id=68630&r=support
Expected behavior: https://bugs.php.net/fix.php?id=68630&r=notwrong
Not enough info: https://bugs.php.net/fix.php?id=68630&r=notenoughinfo
Submitted twice: https://bugs.php.net/fix.php?id=68630&r=submittedtwice
register_globals: https://bugs.php.net/fix.php?id=68630&r=globals
PHP 4 support discontinued: https://bugs.php.net/fix.php?id=68630&r=php4
Daylight Savings: https://bugs.php.net/fix.php?id=68630&r=dst
IIS Stability: https://bugs.php.net/fix.php?id=68630&r=isapi
Install GNU Sed: https://bugs.php.net/fix.php?id=68630&r=gnused
Floating point limitations: https://bugs.php.net/fix.php?id=68630&r=float
No Zend Extensions: https://bugs.php.net/fix.php?id=68630&r=nozend
MySQL Configuration Error: https://bugs.php.net/fix.php?id=68630&r=mysqlcfg