/usr/local/sbin/check_reload_status

m3usv0x · May 29, 2014, 11:31 PM

After setting traffic shaping this particular thread is consuming 100% of CPU, and the queue never reloads.

Running 2.2 alpha, i386 built 5/29/2014.

m3usv0x · May 30, 2014, 2:02 AM

Checked my logs, found some clues.
If anyone could help me out, I'd appreciate it.

check_reload_status: Reloading check_reload_status because it exited from an error!
kernel: pid 44605 (check_reload_status), uid 0: exited on signal 11 (core dumped)
check_reload_status: check_reload_status is starting.
heck_reload_status: fcgipath /var/run/php-fpm.socket
check_reload_status: Reloading check_reload_status because it exited from an error!

This is all from 2.2-ALPHA (amd64) Mon May 26 10:16:02 CDT 2014

adam65535 · May 30, 2014, 3:58 PM

I am having 100% CPU because of check_reload_status too. I don't see the core dump error though. I upgraded from a 28th snapshot. Saving seems to take a lot longer than with the 28th snapshot too which might be related. As an example… I unchecked the 'display logs in reverse order' and hit save and took about a minute to complete.

2.2-ALPHA (i386)
built on Thu May 29 06:53:30 CDT 2014
FreeBSD 10.0-STABLE

last pid: 52594;  load averages:  2.28,  2.20,  2.11  up 1+02:35:07    11:37:02
110 processes: 6 running, 87 sleeping, 17 waiting

Mem: 64M Active, 534M Inact, 124M Wired, 85M Buf, 220M Free
Swap: 8192M Total, 8192M Free

  PID USERNAME   PRI NICE   SIZE    RES STATE    TIME    WCPU COMMAND
  270 root       120   20 10184K  1768K RUN     24.9H  92.29% /usr/local/sbin/check_reload_status
40940 root        23    0 80260K 57980K uwait   22:38   5.66% /usr/local/bin/suricata -i rl0 -D -c /usr/p
  256 root        28    0 90704K 42948K piperd   0:41   2.39% php-fpm: pool lighty (php-fpm){php-fpm}
   12 root       -60    -     0K   136K WAIT    16:45   0.00% [intr{swi4: clock}]
   15 root       -16    -     0K     8K -        7:35   0.00% [rand_harvestq]
   12 root       -92    -     0K   136K WAIT     6:34   0.00% [intr{irq12: rl0 uhci0}]
   12 root       -92    -     0K   136K WAIT     3:08   0.00% [intr{irq10: rl1}]
    5 root       -16    -     0K     8K pftm     1:22   0.00% [pf purge]
40940 root        20    0 80260K 57980K nanslp   0:55   0.00% /usr/local/bin/suricata -i rl0 -D -c /usr/p
    0 root       -16    0     0K    80K swapin   0:45   0.00% [kernel{swapper}]
43413 root        52   20 10544K  2060K wait     0:37   0.00% /bin/sh /var/db/rrd/updaterrd.sh
20236 root        20    0 10100K  1740K select   0:35   0.00% /usr/local/sbin/apinger -c /var/etc/apinger
 6912 root        20    0 10256K  1968K select   0:32   0.00% /usr/sbin/syslogd -s -c -c -l /var/dhcpd/va
  257 root        52    0 86480K 39472K accept   0:27   0.00% php-fpm: pool lighty (php-fpm){php-fpm}
40940 root        20    0 80260K 57980K uwait    0:20   0.00% /usr/local/bin/suricata -i rl0 -D -c /usr/p
  255 root        46    0 86608K 37568K accept   0:17   0.00% php-fpm: pool lighty (php-fpm){php-fpm}
    4 root       -16    -     0K    16K -        0:15   0.00% [cam{doneq0}]
33483 nobody      20    0 15432K  5192K select   0:15   0.00% [dnsmasq]

May 29 09:02:25	syslogd: kernel boot file is /boot/kernel/kernel
May 29 09:02:25	kernel: Copyright (c) 1992-2014 The FreeBSD Project.
May 29 09:02:25	kernel: Copyright (c) 1979, 1980, 1983, 1986, 1988, 1989, 1991, 1992, 1993, 1994
May 29 09:02:25	kernel: The Regents of the University of California. All rights reserved.
May 29 09:02:25	kernel: FreeBSD is a registered trademark of The FreeBSD Foundation.
May 29 09:02:25	kernel: FreeBSD 10.0-STABLE #33 e852cd6(HEAD)-dirty: Thu May 29 07:25:23 CDT 2014
May 29 09:02:25	kernel: root@pf22-i386-snap:/usr/obj.i386/usr/pfSensesrc/src/sys/pfSense_SMP.10 i386
May 29 09:02:25	kernel: FreeBSD clang version 3.3 (tags/RELEASE_33/final 183502) 20130610
May 29 09:02:25	kernel: CPU: Intel(R) Celeron(R) processor 600MHz (599.95-MHz 686-class CPU)
May 29 09:02:25	kernel: Origin = "GenuineIntel" Id = 0x695 Family = 0x6 Model = 0x9 Stepping = 5
May 29 09:02:25	kernel: Features=0xa7e9f9bf <fpu,vme,de,pse,tsc,msr,mce,cx8,sep,mtrr,pge,mca,cmov,pat,clflush,dts,acpi,mmx,fxsr,sse,sse2,tm,pbe>May 29 09:02:25	kernel: real memory = 1040187392 (992 MB)
May 29 09:02:25	kernel: avail memory = 983924736 (938 MB)
May 29 09:02:25	kernel: wlan: mac acl policy registered
May 29 09:02:25	kernel: ipw_bss: You need to read the LICENSE file in /usr/share/doc/legal/intel_ipw/.
May 29 09:02:25	kernel: ipw_bss: If you agree with the license, set legal.intel_ipw.license_ack=1 in /boot/loader.conf.
May 29 09:02:25	kernel: module_register_init: MOD_LOAD (ipw_bss_fw, 0xc07cd730, 0) error 1
May 29 09:02:25	kernel: ipw_ibss: You need to read the LICENSE file in /usr/share/doc/legal/intel_ipw/.
May 29 09:02:25	kernel: ipw_ibss: If you agree with the license, set legal.intel_ipw.license_ack=1 in /boot/loader.conf.
May 29 09:02:25	kernel: module_register_init: MOD_LOAD (ipw_ibss_fw, 0xc07cd7e0, 0) error 1
May 29 09:02:25	kernel: ipw_monitor: You need to read the LICENSE file in /usr/share/doc/legal/intel_ipw/.
May 29 09:02:25	kernel: ipw_monitor: If you agree with the license, set legal.intel_ipw.license_ack=1 in /boot/loader.conf.
May 29 09:02:25	kernel: module_register_init: MOD_LOAD (ipw_monitor_fw, 0xc07cd890, 0) error 1
May 29 09:02:25	kernel: iwi_bss: You need to read the LICENSE file in /usr/share/doc/legal/intel_iwi/.
May 29 09:02:25	kernel: iwi_bss: If you agree with the license, set legal.intel_iwi.license_ack=1 in /boot/loader.conf.
May 29 09:02:25	kernel: module_register_init: MOD_LOAD (iwi_bss_fw, 0xc07f3c80, 0) error 1
May 29 09:02:25	kernel: iwi_ibss: You need to read the LICENSE file in /usr/share/doc/legal/intel_iwi/.
May 29 09:02:25	kernel: iwi_ibss: If you agree with the license, set legal.intel_iwi.license_ack=1 in /boot/loader.conf.
May 29 09:02:25	kernel: module_register_init: MOD_LOAD (iwi_ibss_fw, 0xc07f3d30, 0) error 1
May 29 09:02:25	kernel: iwi_monitor: You need to read the LICENSE file in /usr/share/doc/legal/intel_iwi/.
May 29 09:02:25	kernel: iwi_monitor: If you agree with the license, set legal.intel_iwi.license_ack=1 in /boot/loader.conf.
May 29 09:02:25	kernel: module_register_init: MOD_LOAD (iwi_monitor_fw, 0xc07f3de0, 0) error 1
May 29 09:02:25	kernel: kbd1 at kbdmux0
May 29 09:02:25	kernel: random: <software, yarrow=""> initialized
May 29 09:02:25	kernel: ACPI BIOS Error (bug): A valid RSDP was not found (20130823/tbxfroot-223)
May 29 09:02:25	kernel: ACPI: Table initialisation failed: AE_NOT_FOUND
May 29 09:02:25	kernel: ACPI: Try disabling either ACPI or apic support.
May 29 09:02:25	kernel: cryptosoft0: <software crypto=""> on motherboard
May 29 09:02:25	kernel: padlock0: No ACE support.
May 29 09:02:25	kernel: pcib0 pcibus 0 on motherboard
May 29 09:02:25	kernel: pir0: <pci 10="" interrupt="" routing="" table:="" entries=""> on motherboard
May 29 09:02:25	kernel: pci0: <pci bus=""> on pcib0
May 29 09:02:25	kernel: pci0: <base peripheral=""> at device 0.1 (no driver attached)
May 29 09:02:25	kernel: pci0: <base peripheral=""> at device 0.3 (no driver attached)
May 29 09:02:25	kernel: vgapci0: <vga-compatible display=""> port 0xe200-0xe207 mem 0xd8000000-0xdfffffff,0xe8180000-0xe81fffff irq 12 at device 2.0 on pci0
May 29 09:02:25	kernel: agp0: <intel 8285xm="" (85xgm="" gmch)="" svga="" controller=""> on vgapci0
May 29 09:02:25	kernel: agp0: aperture size is 128M, detected 32636k stolen memory
May 29 09:02:25	kernel: vgapci0: Boot video device
May 29 09:02:25	kernel: vgapci1: <vga-compatible display=""> mem 0xe0000000-0xe7ffffff,0xe8100000-0xe817ffff at device 2.1 on pci0
May 29 09:02:25	kernel: uhci0: <intel 82801db="" (ich4)="" usb="" controller="" usb-a=""> port 0xe000-0xe01f irq 12 at device 29.0 on pci0
May 29 09:02:25	kernel: usbus0 on uhci0
May 29 09:02:25	kernel: uhci1: <intel 82801db="" (ich4)="" usb="" controller="" usb-b=""> port 0xe100-0xe11f irq 5 at device 29.1 on pci0
May 29 09:02:25	kernel: usbus1 on uhci1
May 29 09:02:25	kernel: ehci0: <intel 82801db="" l="" m="" (ich4)="" usb="" 2.0="" controller=""> mem 0xe8200000-0xe82003ff irq 9 at device 29.7 on pci0
May 29 09:02:25	kernel: usbus2: EHCI version 1.0
May 29 09:02:25	kernel: usbus2 on ehci0
May 29 09:02:25	kernel: pcib1: <pcibios pci-pci="" bridge=""> at device 30.0 on pci0
May 29 09:02:25	kernel: pci1: <pci bus=""> on pcib1
May 29 09:02:25	kernel: rl0: <realtek 10="" 8139="" 100basetx=""> port 0xd000-0xd0ff mem 0xe8000000-0xe80000ff irq 12 at device 4.0 on pci1
May 29 09:02:25	kernel: miibus0: <mii bus=""> on rl0
May 29 09:02:25	kernel: rlphy0: <realtek internal="" media="" interface=""> PHY 0 on miibus0
May 29 09:02:25	kernel: rlphy0: 10baseT, 10baseT-FDX, 100baseTX, 100baseTX-FDX, auto
May 29 09:02:25	kernel: rl1: <realtek 10="" 8139="" 100basetx=""> port 0xd100-0xd1ff mem 0xe8001000-0xe80010ff irq 10 at device 5.0 on pci1
May 29 09:02:25	kernel: miibus1: <mii bus=""> on rl1
May 29 09:02:25	kernel: rlphy1: <realtek internal="" media="" interface=""> PHY 0 on miibus1
May 29 09:02:25	kernel: rlphy1: 10baseT, 10baseT-FDX, 100baseTX, 100baseTX-FDX, auto
May 29 09:02:25	kernel: rl2: <realtek 10="" 8139="" 100basetx=""> port 0xd200-0xd2ff mem 0xe8002000-0xe80020ff irq 11 at device 6.0 on pci1
May 29 09:02:25	kernel: miibus2: <mii bus=""> on rl2
May 29 09:02:25	kernel: rlphy2: <realtek internal="" media="" interface=""> PHY 0 on miibus2
May 29 09:02:25	kernel: rlphy2: 10baseT, 10baseT-FDX, 100baseTX, 100baseTX-FDX, auto
May 29 09:02:25	kernel: rl3: <realtek 10="" 8139="" 100basetx=""> port 0xd300-0xd3ff mem 0xe8003000-0xe80030ff irq 5 at device 7.0 on pci1
May 29 09:02:25	kernel: miibus3: <mii bus=""> on rl3
May 29 09:02:25	kernel: rlphy3: <realtek internal="" media="" interface=""> PHY 0 on miibus3
May 29 09:02:25	kernel: rlphy3: 10baseT, 10baseT-FDX, 100baseTX, 100baseTX-FDX, auto
May 29 09:02:25	kernel: isab0: <pci-isa bridge=""> at device 31.0 on pci0
May 29 09:02:25	kernel: isa0: <isa bus=""> on isab0
May 29 09:02:25	kernel: atapci0: <intel ich4="" udma100="" controller=""> port 0x1f0-0x1f7,0x3f6,0x170-0x177,0x376,0xf000-0xf00f at device 31.1 on pci0
May 29 09:02:25	kernel: ata0: <ata channel=""> at channel 0 on atapci0
May 29 09:02:25	kernel: ata1: <ata channel=""> at channel 1 on atapci0
May 29 09:02:25	kernel: pci0: <serial bus,="" smbus=""> at device 31.3 (no driver attached)
May 29 09:02:25	kernel: cpu0 on motherboard
May 29 09:02:25	kernel: p4tcc0: <cpu frequency="" thermal="" control=""> on cpu0
May 29 09:02:25	kernel: pmtimer0 on isa0
May 29 09:02:25	kernel: attimer0: <at timer=""> at port 0x40-0x43 irq 0 pnpid PNP0100 on isa0
May 29 09:02:25	kernel: Timecounter "i8254" frequency 1193182 Hz quality 0
May 29 09:02:25	kernel: Event timer "i8254" frequency 1193182 Hz quality 100
May 29 09:02:25	kernel: atrtc0: <at realtime="" clock=""> at port 0x70-0x71 irq 8 pnpid PNP0b00 on isa0
May 29 09:02:25	kernel: Event timer "RTC" frequency 32768 Hz quality 0
May 29 09:02:25	kernel: atkbdc0: <keyboard controller="" (i8042)=""> at port 0x60,0x64 irq 1 pnpid PNP0303 on isa0
May 29 09:02:25	kernel: atkbd0: <at keyboard=""> irq 1 on atkbdc0
May 29 09:02:25	kernel: kbd0 at atkbd0
May 29 09:02:25	kernel: atkbd0: [GIANT-LOCKED]
May 29 09:02:25	kernel: unknown: <pnp0c01> can't assign resources (memory)
May 29 09:02:25	kernel: unknown: <pnp0c02> can't assign resources (memory)
May 29 09:02:25	kernel: uart0: <16550 or compatible> at port 0x3f8-0x3ff irq 4 flags 0x10 pnpid PNP0501 on isa0
May 29 09:02:25	kernel: uart1: <16550 or compatible> at port 0x2f8-0x2ff irq 3 pnpid PNP0501 on isa0
May 29 09:02:25	kernel: orm0: <isa option="" roms=""> at iomem 0xc0000-0xcc7ff,0xd0000-0xd3fff pnpid ORM0000 on isa0
May 29 09:02:25	kernel: sc0: <system console=""> at flags 0x100 on isa0
May 29 09:02:25	kernel: sc0: VGA <16 virtual consoles, flags=0x300>
May 29 09:02:25	kernel: vga0: <generic isa="" vga=""> at port 0x3c0-0x3df iomem 0xa0000-0xbffff on isa0
May 29 09:02:25	kernel: ppc0: parallel port not found.
May 29 09:02:25	kernel: unknown: <pnp0c01> can't assign resources (memory)
May 29 09:02:25	kernel: unknown: <pnp0c02> can't assign resources (memory)
May 29 09:02:25	kernel: Timecounters tick every 1.000 msec
May 29 09:02:25	kernel: IPsec: Initialized Security Association Processing.
May 29 09:02:25	kernel: random: unblocking device.
May 29 09:02:25	kernel: usbus0: 12Mbps Full Speed USB v1.0
May 29 09:02:25	kernel: usbus1: 12Mbps Full Speed USB v1.0
May 29 09:02:25	kernel: usbus2: 480Mbps High Speed USB v2.0
May 29 09:02:25	kernel: ugen1.1: <intel> at usbus1
May 29 09:02:25	kernel: uhub0: <intel 1="" 9="" uhci="" root="" hub,="" class="" 0,="" rev="" 1.00="" 1.00,="" addr=""> on usbus1
May 29 09:02:25	kernel: ugen0.1: <intel> at usbus0
May 29 09:02:25	kernel: uhub1: <intel 1="" 9="" uhci="" root="" hub,="" class="" 0,="" rev="" 1.00="" 1.00,="" addr=""> on usbus0
May 29 09:02:25	kernel: ugen2.1: <intel> at usbus2
May 29 09:02:25	kernel: uhub2: <intel 1="" 9="" ehci="" root="" hub,="" class="" 0,="" rev="" 2.00="" 1.00,="" addr=""> on usbus2
May 29 09:02:25	kernel: ata0: DMA limited to UDMA33, controller found non-ATA66 cable
May 29 09:02:25	kernel: ada0 at ata0 bus 0 scbus0 target 0 lun 0
May 29 09:02:25	kernel: ada0: <fujitsu mht2040ah="" 006c=""> ATA-6 device
May 29 09:02:25	kernel: ada0: Serial Number NP0ET472HS1E
May 29 09:02:25	kernel: ada0: 33.300MB/s transfers (UDMA2, PIO 8192bytes)
May 29 09:02:25	kernel: ada0: 38154MB (78140160 512 byte sectors: 16H 63S/T 16383C)
May 29 09:02:25	kernel: ada0: Previously was known as ad0
May 29 09:02:25	kernel: Timecounter "TSC" frequency 599945224 Hz quality 800
May 29 09:02:25	kernel: Root mount waiting for: usbus2 usbus1 usbus0
May 29 09:02:25	kernel: uhub0: 2 ports with 2 removable, self powered
May 29 09:02:25	kernel: uhub1: 2 ports with 2 removable, self powered
May 29 09:02:25	kernel: Root mount waiting for: usbus2
May 29 09:02:25	kernel: uhub2: 4 ports with 4 removable, self powered
May 29 09:02:25	kernel: Trying to mount root from ufs:/dev/ad0s1a [rw]...
May 29 09:02:25	kernel: warning: total configured swap (2097152 pages) exceeds maximum recommended amount (1930656 pages).
May 29 09:02:25	kernel: warning: increase kern.maxswzone or reduce amount of swap.
May 29 09:02:25	kernel: rl0: link state changed to DOWN
May 29 09:02:25	kernel: rl0: link state changed to UP
May 29 09:02:22	devd: Executing '/usr/local/sbin/pfSctl -c 'interface linkup stop rl0''
May 29 09:02:22	check_reload_status: Linkup starting rl0
May 29 09:02:24	devd: Executing '/usr/local/sbin/pfSctl -c 'interface linkup start rl0''
May 29 09:02:24	check_reload_status: Linkup starting rl0
May 29 09:02:26	syslogd: sendto: No route to host
May 29 09:02:26	syslogd: sendto: No route to host
May 29 09:02:26	syslogd: sendto: No route to host
May 29 09:02:26	syslogd: sendto: No route to host
May 29 09:02:26	syslogd: sendto: No route to host
May 29 09:02:27	check_reload_status: rc.newwanip starting rl0
May 29 09:02:27	kernel: rl1: link state changed to DOWN
May 29 09:02:27	devd: Executing '/usr/local/sbin/pfSctl -c 'interface linkup stop rl1''
May 29 09:02:27	check_reload_status: Linkup starting rl1
May 29 09:02:28	php: rc.bootup: Resyncing OpenVPN instances.
May 29 09:02:28	kernel:
May 29 09:02:28	kernel: tun1: changing name to 'ovpns1'
May 29 09:02:29	kernel: rl1: link state changed to UP
May 29 09:02:29	devd: Executing '/usr/local/sbin/pfSctl -c 'interface linkup start rl1''
May 29 09:02:29	check_reload_status: Linkup starting rl1
May 29 09:02:33	kernel: pflog0: promiscuous mode enabled
May 29 09:02:33	kernel: .
May 29 09:02:33	kernel:
May 29 09:02:33	kernel: ovpns1: link state changed to UP
May 29 09:02:33	check_reload_status: rc.newwanip starting ovpns1
May 29 09:02:35	kernel: ..
May 29 09:02:37	kernel: .
May 29 09:02:37	kernel: done.
May 29 09:02:42	kernel: done.
May 29 09:02:45	php: rc.bootup: The command '/usr/sbin/pw userdel -n 'admin'' returned exit code '1', the output was 'pw: entry inconsistent pw: gr_copy(): Invalid argument'
May 29 09:03:07	kernel: done.
May 29 09:03:12	php: rc.bootup: ROUTING: setting default route to y.y.y.1
May 29 09:03:12	kernel: done.
May 29 09:03:12	kernel: done.
May 29 09:03:18	kernel: done.
May 29 09:03:18	check_reload_status: Updating all dyndns
May 29 09:03:18	kernel: .
May 29 09:03:19	kernel: .
May 29 09:03:20	kernel: ..
May 29 09:03:21	kernel: .done.
May 29 09:03:37	php: rc.bootup: Creating rrd update script
May 29 09:03:37	kernel: done.
May 29 09:03:38	php-fpm[257]: /rc.start_packages: Restarting/Starting all packages.
May 29 09:03:40	login: login on ttyv1 as root
May 29 09:03:40	login: login on ttyv0 as root
May 29 09:03:40	sshlockout[70677]: sshlockout/webConfigurator v3.0 starting up
May 29 09:07:38	kernel: rl2: link state changed to DOWN
May 29 09:07:38	kernel: rl3: link state changed to DOWN
May 29 09:07:38	devd: Executing '/usr/local/sbin/pfSctl -c 'interface linkup stop rl2''
May 29 09:07:38	devd: Executing '/usr/local/sbin/pfSctl -c 'interface linkup stop rl3''
May 29 09:07:38	check_reload_status: Linkup starting rl2
May 29 09:07:38	check_reload_status: Linkup starting rl3
May 29 09:38:47	php-fpm[257]: /index.php: Successful login for user 'admin' from: 192.168.1.4
May 29 09:38:47	php-fpm[257]: /index.php: Successful login for user 'admin' from: 192.168.1.4
May 30 01:01:03	php: rc.dyndns.update: phpDynDNS (xxxxxxxxxxxxx.homenet.org): No change in my IP address and/or 25 days has not passed. Not updating dynamic DNS entry.
May 30 04:25:06	php-fpm[256]: /index.php: Session timed out for user 'admin' from: 192.168.1.4
May 30 04:25:12	php-fpm[256]: /index.php: Successful login for user 'admin' from: 192.168.1.4
May 30 04:25:12	php-fpm[256]: /index.php: Successful login for user 'admin' from: 192.168.1.4
May 30 04:29:52	check_reload_status: Syncing firewall
May 30 04:29:52	php-fpm[255]: /pkg_mgr_install.php: Beginning package installation for suricata .
May 30 04:29:53	check_reload_status: Syncing firewall
May 30 04:30:22	check_reload_status: Syncing firewall
May 30 04:30:24	check_reload_status: Syncing firewall
May 30 04:30:26	check_reload_status: Syncing firewall
May 30 04:30:26	check_reload_status: Reloading filter
May 30 04:30:31	check_reload_status: Something wrong happened while sending request: Broken pipe
May 30 04:31:22	check_reload_status: Syncing firewall
May 30 04:31:22	php-fpm[257]: /pkg_mgr_install.php: Beginning package installation for suricata .
May 30 04:31:23	check_reload_status: Syncing firewall
May 30 04:31:53	check_reload_status: Syncing firewall
May 30 04:31:55	check_reload_status: Syncing firewall
May 30 04:31:57	check_reload_status: Syncing firewall
May 30 04:31:57	check_reload_status: Reloading filter
May 30 04:32:02	check_reload_status: Something wrong happened while sending request: Broken pipe
May 30 04:34:36	check_reload_status: Syncing firewall
May 30 04:34:36	check_reload_status: Reloading filter
May 30 04:34:56	check_reload_status: Syncing firewall
May 30 04:34:56	php-fpm[256]: /pkg_mgr_install.php: Beginning package installation for suricata .
May 30 04:34:57	check_reload_status: Syncing firewall
May 30 04:39:50	php-fpm[256]: /pkg_mgr_install.php: [Suricata] Package post-installation tasks completed...
May 30 04:39:50	check_reload_status: Syncing firewall
May 30 04:39:54	check_reload_status: Syncing firewall
May 30 04:39:54	check_reload_status: Reloading filter
May 30 04:44:35	check_reload_status: Syncing firewall
May 30 04:44:41	php-fpm[255]: /suricata/suricata_download_rules.php: [Suricata] There is a new set of Emerging Threats Open rules posted. Downloading emerging.rules.tar.gz...
May 30 04:44:42	php-fpm[255]: /suricata/suricata_download_rules.php: [Suricata] Emerging Threats Open rules file update downloaded successfully
May 30 04:44:46	php-fpm[255]: /suricata/suricata_download_rules.php: [Suricata] The Rules update has finished.
May 30 04:44:47	check_reload_status: Syncing firewall
May 30 04:49:12	check_reload_status: Syncing firewall
May 30 04:49:12	php-fpm[257]: /suricata/suricata_interfaces_edit.php: [Suricata] Updating rules configuration for: WAN ...
May 30 04:49:23	php-fpm[257]: /suricata/suricata_interfaces_edit.php: [Suricata] Building new sig-msg.map file for WAN...
May 30 04:49:26	check_reload_status: Syncing firewall
May 30 04:49:28	check_reload_status: Syncing firewall
May 30 04:49:30	check_reload_status: Syncing firewall
May 30 04:49:35	check_reload_status: Something wrong happened while sending request: Broken pipe
May 30 04:49:52	php-fpm[256]: /suricata/suricata_interfaces.php: Toggle (suricata starting) for WAN(WAN)...
May 30 04:49:52	php-fpm[256]: /suricata/suricata_interfaces.php: [Suricata] Updating rules configuration for: WAN ...
May 30 04:50:02	php-fpm[256]: /suricata/suricata_interfaces.php: [Suricata] Building new sig-msg.map file for WAN...
May 30 04:50:04	check_reload_status: Syncing firewall
May 30 04:50:05	check_reload_status: Syncing firewall
May 30 04:50:07	check_reload_status: Syncing firewall
May 30 04:50:07	php-fpm[256]: /suricata/suricata_interfaces.php: [Suricata] Suricata START for WAN(rl0)...
May 30 04:50:11	kernel: rl0: promiscuous mode enabled
May 30 04:50:12	check_reload_status: Something wrong happened while sending request: Broken pipe
May 30 04:51:23	check_reload_status: Syncing firewall
May 30 04:51:24	check_reload_status: Syncing firewall
May 30 04:51:26	check_reload_status: Syncing firewall
May 30 04:51:31	check_reload_status: Something wrong happened while sending request: Broken pipe
May 30 04:55:05	php: sendmail: Could not send the message to xxxxxx@xxxxx.com -- Error: 454 4.3.3 TLS not available after start
May 30 05:00:04	php: sendmail: Could not send the message to xxxxxx@xxxxx.com -- Error: 454 4.3.3 TLS not available after start
May 30 05:05:04	php: sendmail: Could not send the message to xxxxxx@xxxxx.com -- Error: 454 4.3.3 TLS not available after start
May 30 05:10:04	php: sendmail: Could not send the message to xxxxxx@xxxxx.com -- Error: 454 4.3.3 TLS not available after start
May 30 05:13:21	check_reload_status: Syncing firewall
May 30 05:13:22	check_reload_status: Syncing firewall
May 30 05:13:24	check_reload_status: Syncing firewall
May 30 05:13:29	check_reload_status: Something wrong happened while sending request: Broken pipe
May 30 05:14:05	php-fpm[257]: /suricata/suricata_interfaces.php: Toggle (suricata stopping) for WAN(WAN)...
May 30 05:14:05	php-fpm[257]: /suricata/suricata_interfaces.php: [Suricata] Suricata STOP for WAN(rl0)...
May 30 05:14:06	kernel: rl0: promiscuous mode disabled
May 30 05:14:15	php-fpm[256]: /suricata/suricata_interfaces.php: Toggle (suricata starting) for WAN(WAN)...
May 30 05:14:15	php-fpm[256]: /suricata/suricata_interfaces.php: [Suricata] Updating rules configuration for: WAN ...
May 30 05:14:24	php-fpm[256]: /suricata/suricata_interfaces.php: [Suricata] Building new sig-msg.map file for WAN...
May 30 05:14:26	check_reload_status: Syncing firewall
May 30 05:14:28	check_reload_status: Syncing firewall
May 30 05:14:30	check_reload_status: Syncing firewall
May 30 05:14:30	php-fpm[256]: /suricata/suricata_interfaces.php: [Suricata] Suricata START for WAN(rl0)...
May 30 05:14:32	kernel: rl0: promiscuous mode enabled
May 30 05:14:35	check_reload_status: Something wrong happened while sending request: Broken pipe
May 30 05:15:04	php: sendmail: Could not send the message to xxxxxx@xxxxx.com -- Error: 454 4.3.3 TLS not available after start
May 30 05:20:04	php: sendmail: Could not send the message to xxxxxx@xxxxx.com -- Error: 454 4.3.3 TLS not available after start
May 30 05:25:04	php: sendmail: Could not send the message to xxxxxx@xxxxx.com -- Error: 454 4.3.3 TLS not available after start
May 30 05:30:04	php: sendmail: Could not send the message to xxxxxx@xxxxx.com -- Error: 454 4.3.3 TLS not available after start
May 30 05:35:04	php: sendmail: Could not send the message to xxxxxx@xxxxx.com -- Error: 454 4.3.3 TLS not available after start
May 30 05:40:06	php: sendmail: Could not send the message to xxxxxx@xxxxx.com -- Error: 454 4.3.3 TLS not available after start
May 30 05:45:24	php: sendmail: Could not send the message to xxxxxx@xxxxx.com -- Error: 454 4.3.3 TLS not available after start
May 30 05:50:11	php: sendmail: Could not send the message to xxxxxx@xxxxx.com -- Error: 454 4.3.3 TLS not available after start
May 30 05:55:25	php: sendmail: Could not send the message to xxxxxx@xxxxx.com -- Error: 454 4.3.3 TLS not available after start
May 30 06:00:37	php: sendmail: Could not send the message to xxxxxx@xxxxx.com -- Error: 454 4.3.3 TLS not available after start
May 30 06:05:43	php: sendmail: Could not send the message to xxxxxx@xxxxx.com -- Error: 454 4.3.3 TLS not available after start
May 30 06:11:03	php: sendmail: Could not send the message to xxxxxx@xxxxx.com -- Error: 454 4.3.3 TLS not available after start
May 30 06:15:35	php: sendmail: Could not send the message to xxxxxx@xxxxx.com -- Error: 454 4.3.3 TLS not available after start
May 30 06:20:40	php: sendmail: Could not send the message to xxxxxx@xxxxx.com -- Error: 454 4.3.3 TLS not available after start
May 30 06:25:54	php: sendmail: Could not send the message to xxxxxx@xxxxx.com -- Error: 454 4.3.3 TLS not available after start
May 30 06:30:49	php: sendmail: Could not send the message to xxxxxx@xxxxx.com -- Error: 454 4.3.3 TLS not available after start
May 30 06:35:53	php: sendmail: Could not send the message to xxxxxx@xxxxx.com -- Error: 454 4.3.3 TLS not available after start
May 30 06:40:58	php: sendmail: Could not send the message to xxxxxx@xxxxx.com -- Error: 454 4.3.3 TLS not available after start
May 30 06:46:03	php: sendmail: Could not send the message to xxxxxx@xxxxx.com -- Error: 454 4.3.3 TLS not available after start</fujitsu></intel></intel></intel></intel></intel></intel></pnp0c02></pnp0c01></generic></system></isa></pnp0c02></pnp0c01></at></keyboard></at></at></cpu></serial></ata></ata></intel></isa></pci-isa></realtek></mii></realtek></realtek></mii></realtek></realtek></mii></realtek></realtek></mii></realtek></pci></pcibios></intel></intel></intel></vga-compatible></intel></vga-compatible></pci></pci></software></software,></fpu,vme,de,pse,tsc,msr,mce,cx8,sep,mtrr,pge,mca,cmov,pat,clflush,dts,acpi,mmx,fxsr,sse,sse2,tm,pbe>

adam65535 · May 30, 2014, 3:58 PM

Added system log to my previous post.

charliem · May 30, 2014, 4:18 PM

Hmm, and your webgui is apparently working !? My webgui is borken now for a few days, but I'm on amd-64. Maybe I'll have to try an i386 snapshot.

m3usv0x · May 30, 2014, 4:23 PM

It only works because I did a fresh install from a snapshot made a few days ago.
I thought I said that but I'm on a tiny iPhone.
Snapshot is from the 26th, and I've used 64 and 86, this problem persists in both.

adam65535 · May 30, 2014, 5:56 PM

My webgui is working it is just slow at times since CPU is getting eaten up by check_reload_status. I think it all started (It did according to the graph) when I installed the snapshot from the 29th build. I can see that RRD graph was fine cpu wise before then. I installed the snaphot of the 29th around 9am on the 29th.

I am going to reboot and see if the CPU load changes.

rbgarga · Jun 3, 2014, 12:40 PM

I pushed a fix for check_reload_status this morning, could you please wait a new snapshot and give it a try?

adam65535 · Jun 3, 2014, 2:49 PM

It seems to be working fine for me. I have changed a lot of things in the gui and haven't seen any issues with it or php-fpm locking up either. Thanks! That certianly makes running the Alpha easier.

EDIT: removed sshd info. That is handled in another thread and is working in the current release now from 7am this morning.