Hi, I've got the problem that sasyncd fails to start on system boot. On the console screen I see:
'starting early daemons: syslogd pflogd ntpd isakmpd sasyncd(failed)' This is my /etc/rc.conf.local: ftpproxy_flags= sasyncd_flags="-vvvv" isakmpd_flags="-K" ipsec="YES" ntpd_flags= pkg_scripts="netsnmpd" In /var/log/messages I see, that sasyncd attempts to start but seems to die subsequently. Mar 29 23:15:18 deffmfrw04-node0 isakmpd[14274]: isakmpd: starting Mar 29 23:15:19 deffmfrw04-node0 sasyncd[24749]: config: add peer 1.1.1.2 Mar 29 23:15:19 deffmfrw04-node0 sasyncd[24749]: config: interface carp0 Mar 29 23:15:19 deffmfrw04-node0 sasyncd[24749]: config: 32 byte shared hex key Mar 29 23:15:19 deffmfrw04-node0 sasyncd[24749]: config: shared key set Mar 29 23:15:19 deffmfrw04-node0 sasyncd[24749]: carp_demote: incremented the demote state of group 'carp' Mar 29 23:15:19 deffmfrw04-node0 savecore: no core dump Mar 29 23:15:20 deffmfrw04-node0 ftp-proxy[31093]: listening on 127.0.0.1 port 8021 Mar 29 23:15:20 deffmfrw04-node0 /bsd: carp: carp0 demoted group carp by -1 to 168 (carpdev) Mar 29 23:15:20 deffmfrw04-node0 /bsd: carp: carp100 demoted group carp by -1 to 39 (carpdev) Mar 29 23:15:20 deffmfrw04-node0 /bsd: carp: carp101 demoted group carp by -1 to 38 (carpdev) Mar 29 23:15:20 deffmfrw04-node0 /bsd: carp: pfsync0 demoted group carp by -1 to 37 (pfsync bulk done) Mar 29 23:15:20 deffmfrw04-node0 /bsd: carp: pfsync0 demoted group pfsync by -1 to 32 (pfsync bulk done) Mar 29 23:15:20 deffmfrw04-node0 /bsd: carp: pfsync0 demoted group carp by -32 to 5 (pfsync init) Mar 29 23:15:20 deffmfrw04-node0 /bsd: carp: pfsync0 demoted group pfsync by -32 to 0 (pfsync init) Mar 29 23:15:21 deffmfrw04-node0 /bsd: carp: carp14 demoted group carp by -1 to 4 (carpdev) Mar 29 23:15:21 deffmfrw04-node0 /bsd: carp: carp16 demoted group carp by -1 to 3 (carpdev) Mar 29 23:15:21 deffmfrw04-node0 /bsd: carp: carp17 demoted group carp by -1 to 2 (carpdev) Mar 29 23:15:21 deffmfrw04-node0 /bsd: carp: carp18 demoted group carp by -1 to 1 (carpdev) Mar 29 23:15:22 deffmfrw04-node0 /bsd: carp: carp14 demoted group carp by 1 to 2 (carpdev) Mar 29 23:15:22 deffmfrw04-node0 /bsd: carp: carp16 demoted group carp by 1 to 3 (carpdev) Mar 29 23:15:22 deffmfrw04-node0 /bsd: carp: carp17 demoted group carp by 1 to 4 (carpdev) Mar 29 23:15:22 deffmfrw04-node0 /bsd: carp: carp18 demoted group carp by 1 to 5 (carpdev) Mar 29 23:15:24 deffmfrw04-node0 /bsd: carp: carp14 demoted group carp by -1 to 4 (carpdev) Mar 29 23:15:24 deffmfrw04-node0 /bsd: carp: carp16 demoted group carp by -1 to 3 (carpdev) Mar 29 23:15:24 deffmfrw04-node0 /bsd: carp: carp17 demoted group carp by -1 to 2 (carpdev) Mar 29 23:15:24 deffmfrw04-node0 /bsd: carp: carp18 demoted group carp by -1 to 1 (carpdev) ~# ps aux | grep sasyncd | grep -v grep ~# If I start sasyncd manually via /etc/rc.d/sasyncd start after the boot process has been finished sasyncd starts without any isssues. Also, if I add 'sleep 5' right before 'rc_cmd $1' in /etc/rc.d/sasyncd the daemon will start without errors on system boot. Mar 29 23:27:34 deffmfrw04-node0 sasyncd[9330]: config: add peer 1.1.1.2 Mar 29 23:27:34 deffmfrw04-node0 sasyncd[9330]: config: interface carp0 Mar 29 23:27:34 deffmfrw04-node0 sasyncd[9330]: config: 32 byte shared hex key Mar 29 23:27:34 deffmfrw04-node0 sasyncd[9330]: config: shared key set Mar 29 23:27:34 deffmfrw04-node0 sasyncd[9330]: carp_demote: incremented the demote state of group 'carp' Mar 29 23:27:34 deffmfrw04-node0 sasyncd[9330]: carp_init: initializing runstate to SLAVE Mar 29 23:27:34 deffmfrw04-node0 sasyncd[9330]: listening on 0.0.0.0 port 500 fd 5 Mar 29 23:27:34 deffmfrw04-node0 sasyncd[9330]: net_queue: computed hash b82e377b94340f336f7b4eb7b7358e5552727efd Mar 29 23:27:34 deffmfrw04-node0 sasyncd[9330]: net_queue: IV 6bd59b3a7e2020da18579f39b8b6c96e Mar 29 23:27:34 deffmfrw04-node0 sasyncd[9330]: net_queue: pre encrypt 00000001000000010000000004030201 Mar 29 23:27:34 deffmfrw04-node0 sasyncd[9330]: net_queue: post encrypt 539dba6c61174fb10aa09ce033a67e76 Mar 29 23:27:34 deffmfrw04-node0 sasyncd[9330]: net_connect: peer "1.1.1.2" connected, fd 6 Mar 29 23:27:34 deffmfrw04-node0 sasyncd[9330]: timer_add: new event "peer recheck" (expiring in 600s) Mar 29 23:27:34 deffmfrw04-node0 sasyncd[5263]: timer_add: new event "carp_undemote" (expiring in 60s) Mar 29 23:27:34 deffmfrw04-node0 sasyncd[5263]: net_send_messages: msg 0x49275dc02b0 len 64 ref 1 to peer 1.1.1.2 Mar 29 23:27:34 deffmfrw04-node0 sasyncd[5263]: net_send_messages: freeing msg 0x49275dc02b0 Mar 29 23:27:34 deffmfrw04-node0 sasyncd[5263]: net_read: got hash 0ba46d92a1c799ad7e419724c21882ec2dafda6d Mar 29 23:27:34 deffmfrw04-node0 sasyncd[5263]: net_read: got IV d7fd5d0b1cec605fdd24e9b3b20dd1e6 Mar 29 23:27:34 deffmfrw04-node0 sasyncd[5263]: net_read: pre decrypt 18e777992bb2db575815ce048ef57d00 Mar 29 23:27:34 deffmfrw04-node0 sasyncd[5263]: net_read: post decrypt 00000003000000010000000204030201 Mar 29 23:27:34 deffmfrw04-node0 sasyncd[5263]: net_read: computed hash 0ba46d92a1c799ad7e419724c21882ec2dafda6d Mar 29 23:27:34 deffmfrw04-node0 sasyncd[5263]: net_handle_messages: got msg type 0 len 12 from peer 1.1.1.2 Mar 29 23:27:34 deffmfrw04-node0 sasyncd[5263]: net_ctl: got CTL_STATE ACK from peer "1.1.1.2" Mar 29 23:27:34 deffmfrw04-node0 sasyncd[5263]: net_ctl: peer "1.1.1.2" state change to MASTER Mar 29 23:27:36 deffmfrw04-node0 sasyncd[5263]: net_read: got hash b4b6fb0763a97bf74af7b346f431b9a51b306a15 Mar 29 23:27:36 deffmfrw04-node0 sasyncd[5263]: net_read: got IV 91adfb44c57bcf28f0bee425b1a0cfe9 Mar 29 23:27:36 deffmfrw04-node0 sasyncd[5263]: net_read: pre decrypt b39d45f2390dd46bd9dfdde27dd935a2 Mar 29 23:27:36 deffmfrw04-node0 sasyncd[5263]: net_read: post decrypt 0209000002000000010000007d0b0000 Mar 29 23:27:36 deffmfrw04-node0 sasyncd[5263]: net_read: computed hash b4b6fb0763a97bf74af7b346f431b9a51b306a15 Mar 29 23:27:36 deffmfrw04-node0 sasyncd[5263]: net_handle_messages: got msg type 1 len 16 from peer 1.1.1.2 Mar 29 23:27:36 deffmfrw04-node0 sasyncd[5263]: pfkey_queue_message: pfkey FLUSH len 16 seq 1 Mar 29 23:27:36 deffmfrw04-node0 sasyncd[5263]: net_read: got hash d2306a49c9b64e5337a01cc4893e0964bf983222 Mar 29 23:27:36 deffmfrw04-node0 sasyncd[5263]: net_read: got IV b445b8c7543f3bc54caaa9cc50687880 Mar 29 23:27:36 deffmfrw04-node0 sasyncd[5263]: net_read: pre decrypt 8eaffeeaf8a99ffd14be665ed94bd651 Mar 29 23:27:36 deffmfrw04-node0 sasyncd[5263]: net_read: post decrypt 00000004000000000000000004030201 Mar 29 23:27:36 deffmfrw04-node0 sasyncd[5263]: net_read: computed hash d2306a49c9b64e5337a01cc4893e0964bf983222 Mar 29 23:27:36 deffmfrw04-node0 sasyncd[5263]: net_handle_messages: got msg type 0 len 12 from peer 1.1.1.2 Mar 29 23:27:36 deffmfrw04-node0 sasyncd[5263]: net_ctl: got CTL_ENDSNAP from peer "1.1.1.2" Mar 29 23:27:36 deffmfrw04-node0 sasyncd[13618]: carp_demote: decremented the demote state of group 'carp' Mar 29 23:28:34 deffmfrw04-node0 sasyncd[5263]: timer_run: event "carp_undemote" Curiously, if I run a similar configuration in my test lab (VMware), sasyncd starts without any modifications. I'm somewhat helpless now. dmesg output: OpenBSD 5.8 (GENERIC.MP) #2: Mon Dec 7 10:54:37 CET 2015 superman@fahrenheit:/usr/local/binpatchng/work-binpatch58-amd64/src/sys/arch/amd64/compile/GENERIC.MP real mem = 8541536256 (8145MB) avail mem = 8278777856 (7895MB) mpath0 at root scsibus0 at mpath0: 256 targets mainbus0 at root bios0 at mainbus0: SMBIOS rev. 2.7 @ 0xe65f0 (57 entries) bios0: vendor Dell Inc. version "2.8.0" date 06/24/2014 bios0: Dell Inc. PowerEdge R210 II acpi0 at bios0: rev 2 acpi0: sleep states S0 S4 S5 acpi0: tables DSDT FACP SPMI DMAR ASF! HPET APIC MCFG BOOT SSDT ASPT SSDT SSDT HEST ERST BERT EINJ acpi0: wakeup devices P0P1(S4) GLAN(S0) EHC1(S4) EHC2(S4) XHC_(S4) PXSX(S4) RP01(S5) PXSX(S4) RP02(S5) PXSX(S4) RP03(S5) PXSX(S4) RP04(S5) PXSX(S4) RP05(S5) PXSX(S4) [...] acpitimer0 at acpi0: 3579545 Hz, 24 bits acpihpet0 at acpi0: 14318179 Hz acpimadt0 at acpi0 addr 0xfee00000: PC-AT compat cpu0 at mainbus0: apid 0 (boot processor) cpu0: Intel(R) Xeon(R) CPU E3-1220 V2 @ 3.10GHz, 3093.41 MHz cpu0: FPU,VME,DE,PSE,TSC,MSR,PAE,MCE,CX8,APIC,SEP,MTRR,PGE,MCA,CMOV,PAT,PSE36,CFLUSH,DS,ACPI,MMX,FXSR,SSE,SSE2,SS,HTT,TM,PBE,SSE3,PCLMUL,DTES64,MWAIT,DS-CPL,VMX,SMX,EST,TM2,SSSE3,CX16,xTPR,PDCM,PCID,SSE4.1,SSE4.2,x2APIC,POPCNT,DEADLINE,AES,XSAVE,AVX,F16C,RDRAND,NXE,LONG,LAHF,PERF,ITSC,FSGSBASE,SMEP,ERMS,SENSOR,ARAT cpu0: 256KB 64b/line 8-way L2 cache cpu0: smt 0, core 0, package 0 mtrr: Pentium Pro MTRR support, 10 var ranges, 88 fixed ranges cpu0: apic clock running at 99MHz cpu0: mwait min=64, max=64, C-substates=0.2.1.1, IBE cpu1 at mainbus0: apid 2 (application processor) cpu1: Intel(R) Xeon(R) CPU E3-1220 V2 @ 3.10GHz, 3092.98 MHz cpu1: FPU,VME,DE,PSE,TSC,MSR,PAE,MCE,CX8,APIC,SEP,MTRR,PGE,MCA,CMOV,PAT,PSE36,CFLUSH,DS,ACPI,MMX,FXSR,SSE,SSE2,SS,HTT,TM,PBE,SSE3,PCLMUL,DTES64,MWAIT,DS-CPL,VMX,SMX,EST,TM2,SSSE3,CX16,xTPR,PDCM,PCID,SSE4.1,SSE4.2,x2APIC,POPCNT,DEADLINE,AES,XSAVE,AVX,F16C,RDRAND,NXE,LONG,LAHF,PERF,ITSC,FSGSBASE,SMEP,ERMS,SENSOR,ARAT cpu1: 256KB 64b/line 8-way L2 cache cpu1: smt 0, core 1, package 0 cpu2 at mainbus0: apid 4 (application processor) cpu2: Intel(R) Xeon(R) CPU E3-1220 V2 @ 3.10GHz, 3092.98 MHz cpu2: FPU,VME,DE,PSE,TSC,MSR,PAE,MCE,CX8,APIC,SEP,MTRR,PGE,MCA,CMOV,PAT,PSE36,CFLUSH,DS,ACPI,MMX,FXSR,SSE,SSE2,SS,HTT,TM,PBE,SSE3,PCLMUL,DTES64,MWAIT,DS-CPL,VMX,SMX,EST,TM2,SSSE3,CX16,xTPR,PDCM,PCID,SSE4.1,SSE4.2,x2APIC,POPCNT,DEADLINE,AES,XSAVE,AVX,F16C,RDRAND,NXE,LONG,LAHF,PERF,ITSC,FSGSBASE,SMEP,ERMS,SENSOR,ARAT cpu2: 256KB 64b/line 8-way L2 cache cpu2: smt 0, core 2, package 0 cpu3 at mainbus0: apid 6 (application processor) cpu3: Intel(R) Xeon(R) CPU E3-1220 V2 @ 3.10GHz, 3092.98 MHz cpu3: FPU,VME,DE,PSE,TSC,MSR,PAE,MCE,CX8,APIC,SEP,MTRR,PGE,MCA,CMOV,PAT,PSE36,CFLUSH,DS,ACPI,MMX,FXSR,SSE,SSE2,SS,HTT,TM,PBE,SSE3,PCLMUL,DTES64,MWAIT,DS-CPL,VMX,SMX,EST,TM2,SSSE3,CX16,xTPR,PDCM,PCID,SSE4.1,SSE4.2,x2APIC,POPCNT,DEADLINE,AES,XSAVE,AVX,F16C,RDRAND,NXE,LONG,LAHF,PERF,ITSC,FSGSBASE,SMEP,ERMS,SENSOR,ARAT cpu3: 256KB 64b/line 8-way L2 cache cpu3: smt 0, core 3, package 0 ioapic0 at mainbus0: apid 0 pa 0xfec00000, version 20, 24 pins acpimcfg0 at acpi0 addr 0xe0000000, bus 0-255 acpiprt0 at acpi0: bus 0 (PCI0) acpiprt1 at acpi0: bus 3 (P0P1) acpiprt2 at acpi0: bus 2 (RP01) acpiprt3 at acpi0: bus -1 (RP02) acpiprt4 at acpi0: bus -1 (RP03) acpiprt5 at acpi0: bus -1 (RP04) acpiprt6 at acpi0: bus -1 (RP05) acpiprt7 at acpi0: bus -1 (RP06) acpiprt8 at acpi0: bus -1 (RP07) acpiprt9 at acpi0: bus -1 (RP08) acpiprt10 at acpi0: bus 1 (PEG0) acpiprt11 at acpi0: bus -1 (PEG1) acpiprt12 at acpi0: bus -1 (PEG2) acpiprt13 at acpi0: bus -1 (PEG3) acpicpu0 at acpi0: C3(350@80 mwait.1@0x20), C2(500@59 mwait.1@0x10), C1(1000@1 mwait.1), PSS acpicpu1 at acpi0: C3(350@80 mwait.1@0x20), C2(500@59 mwait.1@0x10), C1(1000@1 mwait.1), PSS acpicpu2 at acpi0: C3(350@80 mwait.1@0x20), C2(500@59 mwait.1@0x10), C1(1000@1 mwait.1), PSS acpicpu3 at acpi0: C3(350@80 mwait.1@0x20), C2(500@59 mwait.1@0x10), C1(1000@1 mwait.1), PSS acpipwrres0 at acpi0: FN00, resource for FAN0 acpipwrres1 at acpi0: FN01, resource for FAN1 acpipwrres2 at acpi0: FN02, resource for FAN2 acpipwrres3 at acpi0: FN03, resource for FAN3 acpipwrres4 at acpi0: FN04, resource for FAN4 acpitz0 at acpi0: critical temperature is 106 degC ipmi at mainbus0 not configured cpu0: Enhanced SpeedStep 3093 MHz: speeds: 3101, 3100, 3000, 2900, 2800, 2700, 2600, 2500, 2300, 2200, 2100, 2000, 1900, 1800, 1700, 1600 MHz pci0 at mainbus0 bus 0 pchb0 at pci0 dev 0 function 0 "Intel Xeon E3-1200 v2 Host" rev 0x09 ppb0 at pci0 dev 1 function 0 "Intel Core 3G PCIE" rev 0x09: msi pci1 at ppb0 bus 1 em0 at pci1 dev 0 function 0 "Intel 82571EB" rev 0x06: apic 0 int 16, address 00:1f:29:5b:5f:8a em1 at pci1 dev 0 function 1 "Intel 82571EB" rev 0x06: apic 0 int 17, address 00:1f:29:5b:5f:8b ehci0 at pci0 dev 26 function 0 "Intel 6 Series USB" rev 0x04: apic 0 int 20 usb0 at ehci0: USB revision 2.0 uhub0 at usb0 "Intel EHCI root hub" rev 2.00/1.00 addr 1 ppb1 at pci0 dev 28 function 0 "Intel 6 Series PCIE" rev 0xb4: msi pci2 at ppb1 bus 2 bnx0 at pci2 dev 0 function 0 "Broadcom BCM5716" rev 0x20: apic 0 int 16 bnx1 at pci2 dev 0 function 1 "Broadcom BCM5716" rev 0x20: apic 0 int 17 ehci1 at pci0 dev 29 function 0 "Intel 6 Series USB" rev 0x04: apic 0 int 23 usb1 at ehci1: USB revision 2.0 uhub1 at usb1 "Intel EHCI root hub" rev 2.00/1.00 addr 1 ppb2 at pci0 dev 30 function 0 "Intel 82801BA Hub-to-PCI" rev 0xa4 pci3 at ppb2 bus 3 3:3:0: mem address conflict 0xffff0000/0x10000 vga1 at pci3 dev 3 function 0 "Matrox MGA G200eW" rev 0x0a wsdisplay0 at vga1 mux 1: console (80x25, vt100 emulation) wsdisplay0: screen 1-5 added (80x25, vt100 emulation) pcib0 at pci0 dev 31 function 0 "Intel C202 LPC" rev 0x04 ahci0 at pci0 dev 31 function 2 "Intel 6 Series AHCI" rev 0x04: msi, AHCI 1.3 ahci0: port 0: 3.0Gb/s ahci0: port 4: 1.5Gb/s scsibus1 at ahci0: 32 targets sd0 at scsibus1 targ 0 lun 0: <ATA, ST500NM0011, > SCSI3 0/direct fixed naa.5000c5004ef78815 sd0: 476940MB, 512 bytes/sector, 976773168 sectors cd0 at scsibus1 targ 4 lun 0: <PLDS, DVD+-RW DS-8A8SH, KD51> ATAPI 5/cdrom removable ichiic0 at pci0 dev 31 function 3 "Intel 6 Series SMBus" rev 0x04: apic 0 int 19 iic0 at ichiic0 sdtemp0 at iic0 addr 0x18: cat34ts02 sdtemp1 at iic0 addr 0x19: cat34ts02 sdtemp2 at iic0 addr 0x1a: cat34ts02 sdtemp3 at iic0 addr 0x1b: cat34ts02 spdmem0 at iic0 addr 0x50: 2GB DDR3 SDRAM ECC PC3-10600 with thermal sensor spdmem1 at iic0 addr 0x51: 2GB DDR3 SDRAM ECC PC3-10600 with thermal sensor spdmem2 at iic0 addr 0x52: 2GB DDR3 SDRAM ECC PC3-10600 with thermal sensor spdmem3 at iic0 addr 0x53: 2GB DDR3 SDRAM ECC PC3-10600 with thermal sensor isa0 at pcib0 isadma0 at isa0 com0 at isa0 port 0x3f8/8 irq 4: ns16550a, 16 byte fifo com1 at isa0 port 0x2f8/8 irq 3: ns16550a, 16 byte fifo pckbc0 at isa0 port 0x60/5 irq 1 irq 12 pcppi0 at isa0 port 0x61 spkr0 at pcppi0 uhub2 at uhub0 port 1 "Intel Rate Matching Hub" rev 2.00/0.00 addr 2 uhub3 at uhub1 port 1 "Intel Rate Matching Hub" rev 2.00/0.00 addr 2 uhub4 at uhub3 port 5 "Standard Microsystems product 0x2514" rev 2.00/0.00 addr 3 vscsi0 at root scsibus2 at vscsi0: 256 targets softraid0 at root scsibus3 at softraid0: 256 targets root on sd0a (32f432c3d8959b90.a) swap on sd0b dump on sd0b bnx0: address d4:ae:52:c5:e1:aa brgphy0 at bnx0 phy 1: BCM5709 10/100/1000baseT PHY, rev. 8 bnx1: address d4:ae:52:c5:e1:ab brgphy1 at bnx1 phy 1: BCM5709 10/100/1000baseT PHY, rev. 8 carp: carp0 demoted group carp by 1 to 129 (carpdev) carp: carp100 demoted group carp by 1 to 130 (carpdev) carp: carp101 demoted group carp by 1 to 131 (carpdev) carp: carp14 demoted group carp by 1 to 132 (carpdev) carp: carp16 demoted group carp by 1 to 133 (carpdev) carp: carp17 demoted group carp by 1 to 134 (carpdev) carp: carp18 demoted group carp by 1 to 135 (carpdev) carp: pfsync0 demoted group carp by 32 to 167 (pfsync init) carp: pfsync0 demoted group pfsync by 32 to 32 (pfsync init) carp: pfsync0 demoted group carp by 1 to 168 (pfsync bulk start) carp: pfsync0 demoted group pfsync by 1 to 33 (pfsync bulk start) carp: carp0 demoted group carp by -1 to 168 (carpdev) carp: carp100 demoted group carp by -1 to 39 (carpdev) carp: carp101 demoted group carp by -1 to 38 (carpdev) carp: pfsync0 demoted group carp by -1 to 37 (pfsync bulk done) carp: pfsync0 demoted group pfsync by -1 to 32 (pfsync bulk done) carp: pfsync0 demoted group carp by -32 to 5 (pfsync init) carp: pfsync0 demoted group pfsync by -32 to 0 (pfsync init) carp: carp14 demoted group carp by -1 to 4 (carpdev) carp: carp16 demoted group carp by -1 to 3 (carpdev) carp: carp17 demoted group carp by -1 to 2 (carpdev) carp: carp18 demoted group carp by -1 to 1 (carpdev) carp: carp14 demoted group carp by 1 to 2 (carpdev) carp: carp16 demoted group carp by 1 to 3 (carpdev) carp: carp17 demoted group carp by 1 to 4 (carpdev) carp: carp18 demoted group carp by 1 to 5 (carpdev) carp: carp14 demoted group carp by -1 to 4 (carpdev) carp: carp16 demoted group carp by -1 to 3 (carpdev) carp: carp17 demoted group carp by -1 to 2 (carpdev) carp: carp18 demoted group carp by -1 to 1 (carpdev) root@deffmfrw04-node0:~# Regards, Bernd