Project

General

Profile

Bug #685

PHP Dumping Core Repeatedly after Package Issues

Added by Steve Vigneau almost 9 years ago. Updated almost 9 years ago.

Status:
Resolved
Priority:
Normal
Assignee:
-
Category:
-
Target version:
Start date:
06/22/2010
Due date:
% Done:

0%

Estimated time:
Affected Version:
2.0
Affected Architecture:

Description

Using pfSense 2.0 BETA3 embedded nightly from sometime around 18-Jun-2010 I installed the Avahi and OpenVPN export packages. Finding that I didn't need the OpenVPN package I attempted to uninstall it, but each time I did so the web GUI would hang after the uninstall, with php dumping core repeatedly. After manually removing all packages from the config XML file, resetting to factory defaults, and then reimporting the XML things seemed fine until I went to install the Squid package. At this point the web GUI became unusable again, and php is once again continuing to dump core.

Attached to this bug report is a core file from PHP. Hopefully it will shed some light on the issue.

php.core.gz (851 KB) php.core.gz Steve Vigneau, 06/22/2010 10:16 AM

History

#1 Updated by Jim Pingle almost 9 years ago

  • Affected Version set to 2.0

This is actually pretty easy to reproduce, even in a VM, but only with NanoBSD. Full installs are OK. It seems to only be Avahi, but I haven't tried all other packages. I tried BandwidthD and nut at least, and they were OK.

  1. Go to System > Packages, click the + by Avahi
  2. While that is installing, middle click Interfaces > (assign) to open it in a new tab
  3. The new tab will spin for a while and end in a 500 error
  4. The install tab never finishes loading

On the console, PHP is repeatedly dumping core, and does not stop until the system is shut off:

Jun 23 20:50:08 pfs2n1 kernel: pid 43570 (php), uid 0: exited on signal 11 (core dumped)
Jun 23 20:50:09 pfs2n1 kernel: pid 43757 (php), uid 0: exited on signal 11 (core dumped)
Jun 23 20:50:11 pfs2n1 kernel: pid 44029 (php), uid 0: exited on signal 11 (core dumped)
Jun 23 20:50:12 pfs2n1 kernel: pid 44453 (php), uid 0: exited on signal 11 (core dumped)
Jun 23 20:50:14 pfs2n1 kernel: pid 44705 (php), uid 0: exited on signal 11 (core dumped)
Jun 23 20:50:16 pfs2n1 kernel: pid 45144 (php), uid 0: exited on signal 11 (core dumped)
Jun 23 20:50:17 pfs2n1 kernel: pid 46039 (php), uid 0: exited on signal 11 (core dumped)
Jun 23 20:50:19 pfs2n1 kernel: pid 46531 (php), uid 0: exited on signal 11 (core dumped)
Jun 23 20:50:20 pfs2n1 kernel: pid 46691 (php), uid 0: exited on signal 11 (core dumped)
Jun 23 20:50:22 pfs2n1 kernel: pid 46748 (php), uid 0: exited on signal 11 (core dumped)
Jun 23 20:50:24 pfs2n1 kernel: pid 47266 (php), uid 0: exited on signal 11 (core dumped)

And here's the top -SH output at the time:

last pid: 18403;  load averages:  0.12,  0.18,  0.11    up 0+00:07:05  20:49:03
94 processes:  3 running, 78 sleeping, 13 waiting
CPU:  0.0% user,  0.0% nice, 12.4% system, 21.0% interrupt, 66.7% idle
Mem: 40M Active, 20M Inact, 24M Wired, 232K Cache, 34M Buf, 150M Free
Swap:

  PID USERNAME PRI NICE   SIZE    RES STATE    TIME   WCPU COMMAND
   10 root     171 ki31     0K     8K RUN      5:45 69.97% idle
   11 root     -64    -     0K   112K RUN      0:20 17.97% {irq14: ata0}
    3 root      -8    -     0K     8K -        0:05  3.96% g_up
    0 root     -16    0     0K    64K sched   11:14  0.00% {swapper}
   11 root     -32    -     0K   112K WAIT     0:01  0.00% {swi4: clock}
    4 root      -8    -     0K     8K -        0:01  0.00% g_down
   18 root      44    -     0K     8K qsleep   0:01  0.00% bufdaemon
   11 root     -48    -     0K   112K WAIT     0:01  0.00% {swi0: uart uart}
25777 root      44    0  5532K  3944K kqread   0:00  0.00% lighttpd
   13 root     -16    -     0K     8K -        0:00  0.00% yarrow
    0 root     -68    0     0K    64K -        0:00  0.00% {em0 taskq}
18887 root      44    0  3316K  1292K select   0:00  0.00% apinger
    2 root      -8    -     0K     8K -        0:00  0.00% g_event
35857 root      76   20  3656K  1364K wait     0:00  0.00% sh
14975 root      44    0  3448K  1372K select   0:00  0.00% syslogd
25921 root      54    0 40336K  7936K wait     0:00  0.00% php
   35 root      -8    -     0K     8K mdwait   0:00  0.00% md1

Seems a lot of hdd activity is happening, but not much else.

Full ps uxawww output:

USER     PID %CPU %MEM   VSZ   RSS  TT  STAT STARTED      TIME COMMAND
root   26793 33.0  3.2 40336  7892  ??  Rs    9:04PM   0:10.73 /usr/local/bin/php
root       0  0.0  0.0     0    64  ??  DLs   9:04PM   0:01.42 [kernel]
root       1  0.0  0.2  1888   460  ??  ILs   9:04PM   0:00.04 /sbin/init --
root       2  0.0  0.0     0     8  ??  DL    9:04PM   0:00.09 [g_event]
root       3  0.0  0.0     0     8  ??  DL    9:04PM   0:01.24 [g_up]
root       4  0.0  0.0     0     8  ??  DL    9:04PM   0:01.94 [g_down]
root       5  0.0  0.0     0     8  ??  DL    9:04PM   0:00.00 [crypto]
root       6  0.0  0.0     0     8  ??  DL    9:04PM   0:00.00 [crypto returns]
root       7  0.0  0.0     0     8  ??  DL    9:04PM   0:00.01 [pfpurge]
root       8  0.0  0.0     0     8  ??  DL    9:04PM   0:00.00 [xpt_thrd]
root       9  0.0  0.0     0     8  ??  DL    9:04PM   0:00.00 [pagedaemon]
root      10  0.0  0.0     0     8  ??  RL    9:04PM   4:22.72 [idle]
root      11  0.0  0.0     0   112  ??  WL    9:04PM   0:04.02 [intr]
root      12  0.0  0.0     0     8  ??  DL    9:04PM   0:00.00 [ng_queue]
root      13  0.0  0.0     0     8  ??  DL    9:04PM   0:00.08 [yarrow]
root      14  0.0  0.0     0    64  ??  DL    9:04PM   0:00.02 [usb]
root      15  0.0  0.0     0     8  ??  DL    9:04PM   0:00.00 [vmdaemon]
root      16  0.0  0.0     0     8  ??  DL    9:04PM   0:00.00 [pagezero]
root      17  0.0  0.0     0     8  ??  DL    9:04PM   0:00.00 [idlepoll]
root      18  0.0  0.0     0     8  ??  DL    9:04PM   0:00.04 [bufdaemon]
root      19  0.0  0.0     0     8  ??  DL    9:04PM   0:00.00 [vnlru]
root      20  0.0  0.0     0     8  ??  DL    9:04PM   0:00.02 [syncer]
root      21  0.0  0.0     0     8  ??  DL    9:04PM   0:00.00 [softdepflush]
root      29  0.0  0.0     0     8  ??  DL    9:04PM   0:00.00 [md0]
root      35  0.0  0.0     0     8  ??  DL    9:04PM   0:00.25 [md1]
root     148  0.0  0.2  1888   528  ??  Is    9:04PM   0:00.00 /sbin/devd
root     443  0.0  0.6  4812  1384  ??  SNs   9:04PM   0:00.04 /usr/local/sbin/check_reload_status
root    3059  0.0  0.4  3316   920  ??  Is    9:04PM   0:00.01 /usr/local/sbin/sshlockout_pf
root    6880  0.0  0.5  3316  1220  ??  Is    9:04PM   0:00.00 dhclient: em0 [priv] (dhclient)
root    9051  0.0  1.2  5272  2972  ??  Is    9:04PM   0:00.00 /usr/sbin/sshd
_ntp    9890  0.0  0.5  3316  1328  ??  I     9:04PM   0:00.01 ntpd: ntp engine (ntpd)
root   10218  0.0  0.5  3316  1324  ??  Ss    9:04PM   0:00.00 ntpd: [priv] (ntpd)
root   12298  0.0  1.3  5116  3164  ??  SNs   9:04PM   0:00.04 openvpn --config /var/etc/openvpn/client1.conf
_dhcp  15182  0.0  0.6  3316  1352  ??  Is    9:04PM   0:00.00 dhclient: em0 (dhclient)
root   16337  0.0  0.6  3448  1368  ??  Ss    9:04PM   0:00.89 /usr/sbin/syslogd -c -f /var/etc/syslog.conf
root   17351  0.0  0.6  3436  1388  ??  Is    9:04PM   0:00.01 /usr/sbin/inetd -wW -R 0 -a 127.0.0.1 /var/etc/inetd.conf
root   20753  0.0  0.5  3316  1292  ??  Ss    9:04PM   0:00.10 /usr/local/sbin/apinger -c /var/etc/apinger.conf
root   20931  0.0  0.6  4476  1584  ??  S     9:04PM   0:00.01 /usr/local/bin/rrdtool -
root   21202  0.0  0.5  3656  1348  ??  SN    9:09PM   0:00.00 /bin/sh /var/db/rrd/updaterrd.sh
root   26399  0.0  1.7  6556  4084  ??  S     9:04PM   0:01.49 /usr/local/sbin/lighttpd -f /var/etc/lighty-webConfigurator.conf
nobody 29820  0.0  0.9  4528  2148  ??  I     9:04PM   0:00.00 /usr/local/sbin/dnsmasq --local-ttl 1 --all-servers --dns-forward-max=5000 --cache-size=10000
root   36213  0.0  0.7  3712  1772  ??  SN    9:09PM   0:00.00 /usr/bin/top -d 2 -s 1 0
root   36434  0.0  0.5  3420  1264  ??  SN    9:09PM   0:00.00 [awk]
dhcpd  44201  0.0  0.8  3316  2064  ??  Ss    9:04PM   0:00.02 /usr/local/sbin/dhcpd -user dhcpd -group _dhcp -chroot /var/dhcpd -cf /var/dhcpd/etc/dhcpd.conf em1
root   54842  0.0  0.6  3404  1396  ??  Is    9:04PM   0:00.02 /usr/sbin/cron -s
root   62255  0.0  0.4  3316  1020  ??  Is    9:04PM   0:00.00 minicron 240 /var/run/ping_hosts.pid /usr/local/bin/ping_hosts.sh
root   62568  0.0  0.4  3316  1020  ??  Is    9:04PM   0:00.00 minicron 3600 /var/run/expire_accounts.pid /etc/rc.exipireaccounts
root   62888  0.0  0.4  3316  1020  ??  Is    9:04PM   0:00.00 minicron 86400 /var/run/update_alias_url_data.pid /etc/rc.update_alias_url_data
root    2633  0.0  0.6  3684  1568  u0  Is    9:04PM   0:00.01 login [pam] (login)
root    3067  0.0  0.6  3656  1360  u0  I     9:04PM   0:00.01 -sh (sh)
root    4236  0.0  0.6  3656  1364  u0  I     9:04PM   0:00.02 /bin/sh /etc/rc.initial
root    7790  0.0  0.5  3456  1220  u0  R+    9:09PM   0:00.00 ps uxawww
root   13508  0.0  1.0  4696  2352  u0  S     9:05PM   0:00.04 /bin/tcsh
root   16658  0.0  0.9  5912  2160  u0- S     9:04PM   0:00.02 /usr/sbin/tcpdump -s 256 -v -l -n -e -ttt -i pflog0
root   16769  0.0  0.4  3316   888  u0- S     9:04PM   0:00.01 logger -t pf -p local0.info
root   37562  0.0  0.5  3656  1320  u0- SN    9:04PM   0:00.06 /bin/sh /var/db/rrd/updaterrd.sh

Not sure if it's related, but when shutting down, dnsmasq also crashes:

pid 29820 (dnsmasq), uid 65534: exited on signal 11

#2 Updated by Chris Buechler almost 9 years ago

  • Target version set to 2.0

#3 Updated by Jim Pingle almost 9 years ago

  • Status changed from New to Feedback

This may be a sign of another problem, but the Avahi package was downloading its .tgz file to /tmp/ and extracting from there. I changed the package to instead download to /root/ and can no longer reproduce the problem.

I checked and the OpenVPN status package also downloads to /tmp/ and extracts but I did not get a crash when installing that package. I'll switch it to /root/ anyhow.

#4 Updated by Chris Buechler almost 9 years ago

  • Status changed from Feedback to Resolved

Also available in: Atom PDF