Stale NFS Connections block client and increase load

Status
Not open for further replies.

Kharag

Cadet
Joined
Sep 2, 2015
Messages
2
Hello all,

I have the following symptoms with Freenas 9.3 (FreeNAS-9.3-STABLE-201508250051).

I am mounting user mail directories via NFS onto the mailserver. If the Maildirs are accessed, the NFS-Client locks up, stalling the connection of the program which made the access (in this case Dovecot).
This happens regardless if NFSv4 is enabled or disabled on the Freenas-Box.
The CPU load skyrockets on the client and I have multiple IMAP-Threads in the background, doing nothing.
A symptom is f.e. Thunderbird trying to access the mailbox, but ultimately failing due to a timeout.
The idle threads will not be terminated by exiting dovecot, I have to forcefully kill -9 them.


I can reproduce the issue with different Linux-Versions (Debian 7, 8, Centos 7.1) and Freenas 9.3, but NOT with older Freenas-Versions (9.2, 9.1)

Switching to NFSv4 would solve the problem but is in my case not possible due to issues with UID/GID.
Another solution I found working was mounting the share with "nolock", but as you can imaginethis is highly impractical in my case.

I tried the "Troubleshooting" Part of the docs (that's why I tried with nolock) but it doesn't really help me out here..

Can anyone give me some pointers please?

Possible relevant output, please let me know if you need more:

dmesg FreeNAS
Code:
Copyright (c) 1992-2014 The FreeBSD Project.
Copyright (c) 1979, 1980, 1983, 1986, 1988, 1989, 1991, 1992, 1993, 1994
    The Regents of the University of California. All rights reserved.
FreeBSD is a registered trademark of The FreeBSD Foundation.
FreeBSD 9.3-RELEASE-p23 #2 r281084+e56b349: Fri Aug 21 21:59:07 PDT 2015
    root@build3.ixsystems.com:/tank/home/jkh/build/FN/objs/os-base/amd64/tank/home/jkh/build/FN/FreeBSD/src/sys/FREENAS.amd64 amd64
gcc version 4.2.1 20070831 patched [FreeBSD]
CPU: Intel(R) Xeon(R) CPU           E5450  @ 3.00GHz (3000.07-MHz K8-class CPU)
  Origin = "GenuineIntel"  Id = 0x1067a  Family = 0x6  Model = 0x17  Stepping = 10
  Features=0xbfebfbff<FPU,VME,DE,PSE,TSC,MSR,PAE,MCE,CX8,APIC,SEP,MTRR,PGE,MCA,CMOV,PAT,PSE36,CLFLUSH,DTS,ACPI,MMX,FXSR,SSE,SSE2,SS,HTT,TM,PBE>
  Features2=0xc0ce3bd<SSE3,DTES64,MON,DS_CPL,VMX,EST,TM2,SSSE3,CX16,xTPR,PDCM,DCA,SSE4.1,XSAVE,OSXSAVE>
  AMD Features=0x20000800<SYSCALL,LM>
  AMD Features2=0x1<LAHF>
  TSC: P-state invariant, performance statistics
real memory  = 26575106048 (25343 MB)
avail memory = 24836329472 (23685 MB)
Event timer "LAPIC" quality 400
ACPI APIC Table: <HP     ProLiant>
FreeBSD/SMP: Multiprocessor System Detected: 4 CPUs
FreeBSD/SMP: 1 package(s) x 4 core(s)
 cpu0 (BSP): APIC ID:  0
 cpu1 (AP): APIC ID:  1
 cpu2 (AP): APIC ID:  2
 cpu3 (AP): APIC ID:  3
WARNING: VIMAGE (virtualized network stack) is a highly experimental feature.
ACPI Warning: Invalid length for Pm1aControlBlock: 32, using default 16 (20111123/tbfadt-658)
ACPI Warning: Invalid length for Pm2ControlBlock: 32, using default 8 (20111123/tbfadt-658)
ioapic0 <Version 2.0> irqs 0-23 on motherboard
ispfw: registered firmware <isp_1040>
ispfw: registered firmware <isp_1040_it>
ispfw: registered firmware <isp_1080>
ispfw: registered firmware <isp_1080_it>
ispfw: registered firmware <isp_12160>
ispfw: registered firmware <isp_12160_it>
ispfw: registered firmware <isp_2100>
ispfw: registered firmware <isp_2200>
ispfw: registered firmware <isp_2300>
ispfw: registered firmware <isp_2322>
ispfw: registered firmware <isp_2400>
ispfw: registered firmware <isp_2400_multi>
ispfw: registered firmware <isp_2500>
ispfw: registered firmware <isp_2500_multi>
kbd1 at kbdmux0
cryptosoft0: <software crypto> on motherboard
aesni0: No AESNI support.
padlock0: No ACE support.
acpi0: <HP ProLiant> on motherboard
acpi0: Power Button (fixed)
cpu0: <ACPI CPU> on acpi0
cpu1: <ACPI CPU> on acpi0
cpu2: <ACPI CPU> on acpi0
cpu3: <ACPI CPU> on acpi0
attimer0: <AT timer> port 0x40-0x43 irq 0 on acpi0
Timecounter "i8254" frequency 1193182 Hz quality 0
Event timer "i8254" frequency 1193182 Hz quality 100
hpet0: <High Precision Event Timer> iomem 0xfed00000-0xfed003ff on acpi0
Timecounter "HPET" frequency 14318180 Hz quality 950
Event timer "HPET" frequency 14318180 Hz quality 450
Event timer "HPET1" frequency 14318180 Hz quality 440
Event timer "HPET2" frequency 14318180 Hz quality 440
Timecounter "ACPI-fast" frequency 3579545 Hz quality 900
acpi_timer0: <24-bit timer at 3.579545MHz> port 0x908-0x90b on acpi0
pcib0: <ACPI Host-PCI bridge> on acpi0
pci0: <ACPI PCI bus> on pcib0
pcib1: <ACPI PCI-PCI bridge> at device 2.0 on pci0
ACPI Warning: For \134_SB_.PCI0.PT02._PRT: Return Package has no elements (empty) (20111123/nspredef-507)
pci9: <ACPI PCI bus> on pcib1
pcib2: <ACPI PCI-PCI bridge> at device 0.0 on pci9
pci10: <ACPI PCI bus> on pcib2
pcib3: <ACPI PCI-PCI bridge> at device 0.0 on pci10
pci11: <ACPI PCI bus> on pcib3
pcib4: <ACPI PCI-PCI bridge> at device 1.0 on pci10
pci14: <ACPI PCI bus> on pcib4
mpt0: <LSILogic SAS/SATA Adapter> port 0x5000-0x50ff mem 0xfdff0000-0xfdff3fff,0xfdfe0000-0xfdfeffff irq 17 at device 0.0 on pci14
mpt0: MPI Version=1.5.18.0
pcib5: <ACPI PCI-PCI bridge> at device 2.0 on pci10
pci17: <ACPI PCI bus> on pcib5
pcib6: <PCI-PCI bridge> at device 0.3 on pci9
pci18: <PCI bus> on pcib6
pcib7: <ACPI PCI-PCI bridge> at device 3.0 on pci0
pci6: <ACPI PCI bus> on pcib7
ciss0: <HP Smart Array P400> port 0x4000-0x40ff mem 0xfdd00000-0xfddfffff,0xfdcf0000-0xfdcf0fff irq 18 at device 0.0 on pci6
ciss0: PERFORMANT Transport
pcib8: <ACPI PCI-PCI bridge> at device 4.0 on pci0
pci19: <ACPI PCI bus> on pcib8
pcib9: <PCI-PCI bridge> at device 5.0 on pci0
pci22: <PCI bus> on pcib9
pcib10: <ACPI PCI-PCI bridge> at device 6.0 on pci0
pci23: <ACPI PCI bus> on pcib10
pcib11: <PCI-PCI bridge> at device 7.0 on pci0
pci26: <PCI bus> on pcib11
pcib12: <ACPI PCI-PCI bridge> at device 28.0 on pci0
pci2: <ACPI PCI bus> on pcib12
pcib13: <PCI-PCI bridge> at device 0.0 on pci2
pci3: <PCI bus> on pcib13
bce0: <HP NC373i Multifunction Gigabit Server Adapter (B2)> mem 0xf8000000-0xf9ffffff irq 16 at device 0.0 on pci3
bce0: /tank/home/jkh/build/FN/FreeBSD/src/sys/dev/bce/if_bce.c(1247): Management firmware enabled but not running!
miibus0: <MII bus> on bce0
brgphy0: <BCM5708C 1000BASE-T media interface> PHY 1 on miibus0
brgphy0:  10baseT, 10baseT-FDX, 100baseTX, 100baseTX-FDX, 1000baseT, 1000baseT-master, 1000baseT-FDX, 1000baseT-FDX-master, auto, auto-flow
bce0: Ethernet address: 00:1b:78:9b:e1:bc
bce0: ASIC (0x57081020); Rev (B2); Bus (PCI-X, 64-bit, 133MHz); B/C (1.9.6); Bufs (RX:2;TX:2;PG:8); Flags (SPLT|MSI|MFW); MFW (NOT RUNNING!)
Coal (RX:6,6,18,18; TX:20,20,80,80)
pcib14: <ACPI PCI-PCI bridge> at device 28.1 on pci0
pci4: <ACPI PCI bus> on pcib14
pcib15: <PCI-PCI bridge> at device 0.0 on pci4
pci5: <PCI bus> on pcib15
bce1: <HP NC373i Multifunction Gigabit Server Adapter (B2)> mem 0xfa000000-0xfbffffff irq 17 at device 0.0 on pci5
bce1: /tank/home/jkh/build/FN/FreeBSD/src/sys/dev/bce/if_bce.c(1247): Management firmware enabled but not running!
miibus1: <MII bus> on bce1
brgphy1: <BCM5708C 1000BASE-T media interface> PHY 1 on miibus1
brgphy1:  10baseT, 10baseT-FDX, 100baseTX, 100baseTX-FDX, 1000baseT, 1000baseT-master, 1000baseT-FDX, 1000baseT-FDX-master, auto, auto-flow
bce1: Ethernet address: 00:1b:78:9b:e1:ba
bce1: ASIC (0x57081020); Rev (B2); Bus (PCI-X, 64-bit, 133MHz); B/C (1.9.6); Bufs (RX:2;TX:2;PG:8); Flags (SPLT|MSI|MFW); MFW (NOT RUNNING!)
Coal (RX:6,6,18,18; TX:20,20,80,80)
uhci0: <Intel 631XESB/632XESB/3100 USB controller USB-1> port 0x1000-0x101f irq 16 at device 29.0 on pci0
usbus0 on uhci0
uhci1: <Intel 631XESB/632XESB/3100 USB controller USB-2> port 0x1020-0x103f irq 17 at device 29.1 on pci0
usbus1 on uhci1
uhci2: <Intel 631XESB/632XESB/3100 USB controller USB-3> port 0x1040-0x105f irq 18 at device 29.2 on pci0
usbus2 on uhci2
uhci3: <Intel 631XESB/632XESB/3100 USB controller USB-4> port 0x1060-0x107f irq 19 at device 29.3 on pci0
usbus3 on uhci3
ehci0: <Intel 63XXESB USB 2.0 controller> mem 0xf7df0000-0xf7df03ff irq 16 at device 29.7 on pci0
usbus4: EHCI version 1.0
usbus4 on ehci0
pcib16: <ACPI PCI-PCI bridge> at device 30.0 on pci0
pci1: <ACPI PCI bus> on pcib16
vgapci0: <VGA-compatible display> port 0x3000-0x30ff mem 0xd8000000-0xdfffffff,0xf7ff0000-0xf7ffffff irq 23 at device 3.0 on pci1
vgapci0: Boot video device
uhci4: <UHCI (generic) USB controller> port 0x3800-0x381f irq 22 at device 4.4 on pci1
usbus5 on uhci4
pci1: <serial bus> at device 4.6 (no driver attached)
isab0: <PCI-ISA bridge> at device 31.0 on pci0
isa0: <ISA bus> on isab0
atapci0: <Intel 63XXESB2 UDMA100 controller> port 0x1f0-0x1f7,0x3f6,0x170-0x177,0x376,0x500-0x50f irq 17 at device 31.1 on pci0
ata0: <ATA channel> at channel 0 on atapci0
acpi_tz0: <Thermal Zone> on acpi0
atkbdc0: <Keyboard controller (i8042)> port 0x60,0x64 irq 1 on acpi0
atkbd0: <AT Keyboard> irq 1 on atkbdc0
kbd0 at atkbd0
atkbd0: [GIANT-LOCKED]
uart0: <16550 or compatible> port 0x3f8-0x3ff irq 4 flags 0x10 on acpi0
ichwd0 on isa0
ichwd0: ICH WDT present but disabled in BIOS or hardware
device_attach: ichwd0 attach returned 6
ichwd0 at port 0x930-0x937,0x960-0x97f on isa0
ichwd0: ICH WDT present but disabled in BIOS or hardware
device_attach: ichwd0 attach returned 6
orm0: <ISA Option ROMs> at iomem 0xc0000-0xcafff,0xe6000-0xe7fff on isa0
sc0: <System console> at flags 0x100 on isa0
sc0: VGA <16 virtual consoles, flags=0x300>
vga0: <Generic ISA VGA> at port 0x3c0-0x3df iomem 0xa0000-0xbffff on isa0
atrtc0: <AT realtime clock> at port 0x70 irq 8 on isa0
Event timer "RTC" frequency 32768 Hz quality 0
uart1: <Non-standard ns8250 class UART with FIFOs> at port 0x2f8-0x2ff irq 3 on isa0
wbwd0: HEFRAS and EFER do not align: EFER 0x2e DevID 0xff DevRev 0xff CR26 0xff
coretemp0: <CPU On-Die Thermal Sensors> on cpu0
est0: <Enhanced SpeedStep Frequency Control> on cpu0
est: CPU supports Enhanced Speedstep, but is not recognized.
est: cpu_vendor GenuineIntel, msr 91c091c0600091c
device_attach: est0 attach returned 6
coretemp1: <CPU On-Die Thermal Sensors> on cpu1
est1: <Enhanced SpeedStep Frequency Control> on cpu1
est: CPU supports Enhanced Speedstep, but is not recognized.
est: cpu_vendor GenuineIntel, msr 91c091c0600091c
device_attach: est1 attach returned 6
coretemp2: <CPU On-Die Thermal Sensors> on cpu2
est2: <Enhanced SpeedStep Frequency Control> on cpu2
est: CPU supports Enhanced Speedstep, but is not recognized.
est: cpu_vendor GenuineIntel, msr 91c091c0600091c
device_attach: est2 attach returned 6
coretemp3: <CPU On-Die Thermal Sensors> on cpu3
est3: <Enhanced SpeedStep Frequency Control> on cpu3
est: CPU supports Enhanced Speedstep, but is not recognized.
est: cpu_vendor GenuineIntel, msr 91c091c0600091c
device_attach: est3 attach returned 6
ZFS filesystem version: 5
ZFS storage pool version: features support (5000)
Timecounters tick every 1.000 msec
ipfw2 (+ipv6) initialized, divert enabled, nat enabled, default to accept, logging disabled
usbus0: 12Mbps Full Speed USB v1.0
usbus1: 12Mbps Full Speed USB v1.0
usbus2: 12Mbps Full Speed USB v1.0
usbus3: 12Mbps Full Speed USB v1.0
usbus4: 480Mbps High Speed USB v2.0
usbus5: 12Mbps Full Speed USB v1.0
ugen0.1: <Intel> at usbus0
uhub0: <Intel UHCI root HUB, class 9/0, rev 1.00/1.00, addr 1> on usbus0
ugen1.1: <Intel> at usbus1
uhub1: <Intel UHCI root HUB, class 9/0, rev 1.00/1.00, addr 1> on usbus1
ugen2.1: <Intel> at usbus2
uhub2: <Intel UHCI root HUB, class 9/0, rev 1.00/1.00, addr 1> on usbus2
ugen3.1: <Intel> at usbus3
uhub3: <Intel UHCI root HUB, class 9/0, rev 1.00/1.00, addr 1> on usbus3
ugen4.1: <Intel> at usbus4
uhub4: <Intel EHCI root HUB, class 9/0, rev 2.00/1.00, addr 1> on usbus4
ugen5.1: <0x103c> at usbus5
uhub5: <0x103c UHCI root HUB, class 9/0, rev 1.00/1.00, addr 1> on usbus5
uhub0: 2 ports with 2 removable, self powered
uhub1: 2 ports with 2 removable, self powered
uhub2: 2 ports with 2 removable, self powered
uhub3: 2 ports with 2 removable, self powered
uhub5: 2 ports with 2 removable, self powered
bce0: bce_pulse(): Warning: bootcode thinks driver is absent! (bc_state = 0x00000006)
ugen5.2: <HP> at usbus5
ukbd0: <Virtual Keyboard> on usbus5
kbd2 at ukbd0
ums0: <Virtual Mouse> on usbus5
ums0: 3 buttons and [XY] coordinates ID=0
ugen5.3: <HP> at usbus5
uhub6: <Virtual Hub> on usbus5
uhub6: 7 ports with 7 removable, self powered
uhub4: 8 ports with 8 removable, self powered
ugen4.2: <vendor 0x18a5> at usbus4
umass0: <vendor 0x18a5 product 0x0302, class 0/0, rev 2.00/1.12, addr 2> on usbus4
umass0:  SCSI over Bulk-Only; quirks = 0xc100
umass0:5:0:-1: Attached to scbus5
ses0 at mpt0 bus 0 scbus0 target 25 lun 0
ses0: <HP MSA60 2.28> Fixed Enclosure Services SCSI-5 device 
ses0: Serial Number                              SGA91300VJ
ses0: 300.000MB/s transfers
ses0: SCSI-3 ENC Device
da12 at ciss0 bus 0 scbus1 target 0 lun 0
da12: <COMPAQ RAID 0 OK> Fixed Direct Access SCSI-5 device 
da12: Serial Number P61620D9SUU6CD
da12: 135.168MB/s transfers
da12: Command Queueing enabled
cd0 at ata0 bus 0 scbus3 target 0 lun 0
cd0: <HL-DT-ST RW/DVD GCC-C10N 2.00> Removable CD-ROM SCSI-0 device 
cd0: 33.300MB/s transfers (UDMA2, ATAPI 12bytes, PIO 65534bytes)
cd0: Attempt to query device size failed: NOT READY, Medium not present
da12: 139979MB (286677120 512 byte sectors: 255H 32S/T 35132C)
da12: quirks=0x1<NO_SYNC_CACHE>
da0 at mpt0 bus 0 scbus0 target 13 lun 0
da0: <ATA MB1000EBZQB HPG0> Fixed Direct Access SCSI-5 device 
da0: Serial Number Z1N0AG8Y            
da0: 300.000MB/s transfers
da0: Command Queueing enabled
da0: 953869MB (1953525168 512 byte sectors: 255H 63S/T 121601C)
da1 at mpt0 bus 0 scbus0 target 14 lun 0
da1: <ATA GB1000EAFJL HPGC> Fixed Direct Access SCSI-5 device 
da1: Serial Number 9QJ6P2V1            
da1: 300.000MB/s transfers
da1: Command Queueing enabled
da1: 953869MB (1953525168 512 byte sectors: 255H 63S/T 121601C)
da2 at mpt0 bus 0 scbus0 target 15 lun 0
da2: <ATA MB1000EBNCF HPG2> Fixed Direct Access SCSI-5 device 
da2: Serial Number WCAW34256285        
da2: 300.000MB/s transfers
da2: Command Queueing enabled
da2: 953869MB (1953525168 512 byte sectors: 255H 63S/T 121601C)
da3 at mpt0 bus 0 scbus0 target 16 lun 0
da3: <ATA MB1000EBZQB HPG2> Fixed Direct Access SCSI-5 device 
da3: Serial Number Z1N2YYYF            
da3: 300.000MB/s transfers
da3: Command Queueing enabled
da3: 953869MB (1953525168 512 byte sectors: 255H 63S/T 121601C)
da4 at mpt0 bus 0 scbus0 target 17 lun 0
da4: <ATA MB1000EBZQB HPG2> Fixed Direct Access SCSI-5 device 
da4: Serial Number Z1N2LN33            
da4: 300.000MB/s transfers
da4: Command Queueing enabled
da4: 953869MB (1953525168 512 byte sectors: 255H 63S/T 121601C)
da5 at mpt0 bus 0 scbus0 target 18 lun 0
da5: <ATA MB1000EBZQB HPG1> Fixed Direct Access SCSI-5 device 
da5: Serial Number Z1N1D2AQ            
da5: 300.000MB/s transfers
da5: Command Queueing enabled
da5: 953869MB (1953525168 512 byte sectors: 255H 63S/T 121601C)
da6 at mpt0 bus 0 scbus0 target 19 lun 0
da6: <ATA GB0750C8047 HPGC> Fixed Direct Access SCSI-5 device 
da6: Serial Number 9QK26Q96            
da6: 300.000MB/s transfers
da6: Command Queueing enabled
da6: 715404MB (1465149168 512 byte sectors: 255H 63S/T 91201C)
da7 at mpt0 bus 0 scbus0 target 20 lun 0
da7: <ATA GB0750C8047 HPGC> Fixed Direct Access SCSI-5 device 
da7: Serial Number 9QK25EN9            
da7: 300.000MB/s transfers
da7: Command Queueing enabled
da7: 715404MB (1465149168 512 byte sectors: 255H 63S/T 91201C)
da8 at mpt0 bus 0 scbus0 target 21 lun 0
da8: <ATA GB0750C8047 HPGC> Fixed Direct Access SCSI-5 device 
da8: Serial Number 9QK22C5R            
da8: 300.000MB/s transfers
da8: Command Queueing enabled
da8: 715404MB (1465149168 512 byte sectors: 255H 63S/T 91201C)
da9 at mpt0 bus 0 scbus0 target 22 lun 0
da9: <ATA GB0750C8047 HPGC> Fixed Direct Access SCSI-5 device 
da9: Serial Number 9QK25B14            
da9: 300.000MB/s transfers
da9: Command Queueing enabled
da9: 715404MB (1465149168 512 byte sectors: 255H 63S/T 91201C)
da10 at mpt0 bus 0 scbus0 target 23 lun 0
da10: <ATA GB0750C8047 HPGC> Fixed Direct Access SCSI-5 device 
da10: Serial Number 9QK25JET            
da10: 300.000MB/s transfers
da10: Command Queueing enabled
da10: 715404MB (1465149168 512 byte sectors: 255H 63S/T 91201C)
da11 at mpt0 bus 0 scbus0 target 24 lun 0
da11: <ATA GB0750C8047 HPGC> Fixed Direct Access SCSI-5 device 
da11: Serial Number 9QK26E67            
da11: 300.000MB/s transfers
da11: Command Queueing enabled
da11: 715404MB (1465149168 512 byte sectors: 255H 63S/T 91201C)
da13 at ciss0 bus 0 scbus1 target 1 lun 0
da13: <COMPAQ RAID 0 OK> Fixed Direct Access SCSI-5 device 
da13: Serial Number P61620D9SUU6CD
da13: 135.168MB/s transfers
da13: Command Queueing enabled
da13: 69973MB (143305920 512 byte sectors: 255H 32S/T 17562C)
da13: quirks=0x1<NO_SYNC_CACHE>
da14 at ciss0 bus 0 scbus1 target 2 lun 0
da14: <COMPAQ RAID 0 OK> Fixed Direct Access SCSI-5 device 
da14: Serial Number P61620D9SUU6CD
da14: 135.168MB/s transfers
da14: Command Queueing enabled
da14: 476908MB (976707632 512 byte sectors: 255H 32S/T 65535C)
da14: quirks=0x1<NO_SYNC_CACHE>
da15 at ciss0 bus 0 scbus1 target 3 lun 0
da15: <COMPAQ RAID 0 OK> Fixed Direct Access SCSI-5 device 
da15: Serial Number P61620D9SUU6CD
da15: 135.168MB/s transfers
da15: Command Queueing enabled
da15: 476908MB (976707632 512 byte sectors: 255H 32S/T 65535C)
da15: quirks=0x1<NO_SYNC_CACHE>
da16 at ciss0 bus 0 scbus1 target 4 lun 0
da16: <COMPAQ RAID 0 OK> Fixed Direct Access SCSI-5 device 
da16: Serial Number P61620D9SUU6CD
da16: 135.168MB/s transfers
da16: Command Queueing enabled
da16: 95362MB (195301440 512 byte sectors: 255H 32S/T 23934C)
da16: quirks=0x1<NO_SYNC_CACHE>
da17 at umass-sim0 bus 0 scbus5 target 0 lun 0
da17: <Verbatim  8.07> Removable Direct Access SCSI-4 device 
da17: Serial Number 13112201000904
da17: 40.000MB/s transfers
da17: 14800MB (30310400 512 byte sectors: 255H 63S/T 1886C)
da17: quirks=0x2<NO_6_BYTE>
ses0: da0,pass0: SAS Device Slot Element: 2 Phys at Slot 1, Not All Phys
ses0:  phy 0: SATA device
ses0:  phy 0: parent 5001438004f12880 addr 5001438004f12881
ses0:  phy 1: SAS device type 0 id 0
ses0:  phy 1: protocols: Initiator( None ) Target( None )
ses0:  phy 1: parent 0 addr 0
ses0: da1,pass1: SAS Device Slot Element: 2 Phys at Slot 2, Not All Phys
ses0:  phy 0: SATA device
ses0:  phy 0: parent 5001438004f12880 addr 5001438004f12882
ses0:  phy 1: SAS device type 0 id 0
ses0:  phy 1: protocols: Initiator( None ) Target( None )
ses0:  phy 1: parent 0 addr 0
ses0: da2,pass2: SAS Device Slot Element: 2 Phys at Slot 3, Not All Phys
ses0:  phy 0: SATA device
ses0:  phy 0: parent 5001438004f12880 addr 5001438004f12883
ses0:  phy 1: SAS device type 0 id 0
ses0:  phy 1: protocols: Initiator( None ) Target( None )
ses0:  phy 1: parent 0 addr 0
ses0: da3,pass3: SAS Device Slot Element: 2 Phys at Slot 4, Not All Phys
ses0:  phy 0: SATA device
ses0:  phy 0: parent 5001438004f12880 addr 5001438004f12884
ses0:  phy 1: SAS device type 0 id 0
ses0:  phy 1: protocols: Initiator( None ) Target( None )
ses0:  phy 1: parent 0 addr 0
ses0: da4,pass4: SAS Device Slot Element: 2 Phys at Slot 5, Not All Phys
ses0:  phy 0: SATA device
ses0:  phy 0: parent 5001438004f12880 addr 5001438004f12885
ses0:  phy 1: SAS device type 0 id 0
ses0:  phy 1: protocols: Initiator( None ) Target( None )
ses0:  phy 1: parent 0 addr 0
ses0: da5,pass5: SAS Device Slot Element: 2 Phys at Slot 6, Not All Phys
ses0:  phy 0: SATA device
ses0:  phy 0: parent 5001438004f12880 addr 5001438004f12886
ses0:  phy 1: SAS device type 0 id 0
ses0:  phy 1: protocols: Initiator( None ) Target( None )
ses0:  phy 1: parent 0 addr 0
ses0: da6,pass6: SAS Device Slot Element: 2 Phys at Slot 7, Not All Phys
ses0:  phy 0: SATA device
ses0:  phy 0: parent 5001438004f12880 addr 5001438004f12887
ses0:  phy 1: SAS device type 0 id 0
ses0:  phy 1: protocols: Initiator( None ) Target( None )
ses0:  phy 1: parent 0 addr 0
ses0: da7,pass7: SAS Device Slot Element: 2 Phys at Slot 8, Not All Phys
ses0:  phy 0: SATA device
ses0:  phy 0: parent 5001438004f12880 addr 5001438004f12888
ses0:  phy 1: SAS device type 0 id 0
ses0:  phy 1: protocols: Initiator( None ) Target( None )
ses0:  phy 1: parent 0 addr 0
ses0: da8,pass8: SAS Device Slot Element: 2 Phys at Slot 9, Not All Phys
ses0:  phy 0: SATA device
ses0:  phy 0: parent 5001438004f12880 addr 5001438004f12889
ses0:  phy 1: SAS device type 0 id 0
ses0:  phy 1: protocols: Initiator( None ) Target( None )
ses0:  phy 1: parent 0 addr 0
ses0: da9,pass9: SAS Device Slot Element: 2 Phys at Slot 10, Not All Phys
ses0:  phy 0: SATA device
ses0:  phy 0: parent 5001438004f12880 addr 5001438004f1288a
ses0:  phy 1: SAS device type 0 id 0
ses0:  phy 1: protocols: Initiator( None ) Target( None )
ses0:  phy 1: parent 0 addr 0
ses0: da10,pass10: SAS Device Slot Element: 2 Phys at Slot 11, Not All Phys
ses0:  phy 0: SATA device
ses0:  phy 0: parent 5001438004f12880 addr 5001438004f1288b
ses0:  phy 1: SAS device type 0 id 0
ses0:  phy 1: protocols: Initiator( None ) Target( None )
ses0:  phy 1: parent 0 addr 0
SMP: AP CPU #3 Launched!
SMP: AP CPU #1 Launched!
SMP: AP CPU #2 Launched!
Timecounter "TSC-low" frequency 1500032533 Hz quality 1000
Trying to mount root from zfs:freenas-boot/ROOT/FreeNAS-9.3-STABLE-201508250051 []...
GEOM_RAID5: Module loaded, version 1.3.20140711.62 (rev f91e28e40bf7)
ipmi0: <IPMI System Interface> port 0xca2-0xca3 on acpi0
ipmi0: KCS mode found at io 0xca2 on acpi
ipmi0: KCS error: ff
ipmi0: IPMI device rev. 1, firmware rev. 1.77, version 2.0
ipmi0: Number of channels 8
ipmi0: Attached watchdog
ichwd0 at port 0x930-0x937,0x960-0x97f on isa0
ichwd0: ICH WDT present but disabled in BIOS or hardware
device_attach: ichwd0 attach returned 6
ipmi1: <IPMI System Interface> on isa0
device_attach: ipmi1 attach returned 16
wbwd0: HEFRAS and EFER do not align: EFER 0x2e DevID 0xff DevRev 0xff CR26 0xff
ipmi2: <IPMI System Interface> mem 0xf7ef0000-0xf7ef00ff irq 21 at device 4.6 on pci1
ipmi2: using KSC interface
ipmi2: IPMI device rev. 1, firmware rev. 1.77, version 2.0
ipmi2: Number of channels 8
ipmi2: Attached watchdog
bce0: Gigabit link up!
bce1: Gigabit link up!
GEOM_ELI: Device da0p1.eli created.
GEOM_ELI: Encryption: AES-XTS 256
GEOM_ELI:     Crypto: software
GEOM_ELI: Device da1p1.eli created.
GEOM_ELI: Encryption: AES-XTS 256
GEOM_ELI:     Crypto: software
GEOM_ELI: Device da2p1.eli created.
GEOM_ELI: Encryption: AES-XTS 256
GEOM_ELI:     Crypto: software
GEOM_ELI: Device da3p1.eli created.
GEOM_ELI: Encryption: AES-XTS 256
GEOM_ELI:     Crypto: software
GEOM_ELI: Device da4p1.eli created.
GEOM_ELI: Encryption: AES-XTS 256
GEOM_ELI:     Crypto: software
GEOM_ELI: Device da5p1.eli created.
GEOM_ELI: Encryption: AES-XTS 256
GEOM_ELI:     Crypto: software
GEOM_ELI: Device da6p1.eli created.
GEOM_ELI: Encryption: AES-XTS 256
GEOM_ELI:     Crypto: software
GEOM_ELI: Device da7p1.eli created.
GEOM_ELI: Encryption: AES-XTS 256
GEOM_ELI:     Crypto: software
GEOM_ELI: Device da8p1.eli created.
GEOM_ELI: Encryption: AES-XTS 256
GEOM_ELI:     Crypto: software
GEOM_ELI: Device da9p1.eli created.
GEOM_ELI: Encryption: AES-XTS 256
GEOM_ELI:     Crypto: software
GEOM_ELI: Device da10p1.eli created.
GEOM_ELI: Encryption: AES-XTS 256
GEOM_ELI:     Crypto: software
GEOM_ELI: Device da11p1.eli created.
GEOM_ELI: Encryption: AES-XTS 256
GEOM_ELI:     Crypto: software
nfsd: can't register svc name
vboxdrv: fAsync=0 offMin=0x9a2 offMax=0x180c
ugen5.2: <HP> at usbus5 (disconnected)
ukbd0: at uhub5, port 1, addr 2 (disconnected)
ums0: at uhub5, port 1, addr 2 (disconnected)
ugen5.3: <HP> at usbus5 (disconnected)
uhub6: at uhub5, port 2, addr 3 (disconnected)
ugen5.2: <HP> at usbus5
ukbd0: <Virtual Keyboard> on usbus5
kbd2 at ukbd0
ums0: <Virtual Mouse> on usbus5
ums0: 3 buttons and [XY] coordinates ID=0
ugen5.2: <HP> at usbus5 (disconnected)
ukbd0: at uhub5, port 1, addr 2 (disconnected)
ums0: at uhub5, port 1, addr 2 (disconnected)
ugen5.2: <HP> at usbus5
ukbd0: <Virtual Keyboard> on usbus5
kbd2 at ukbd0
ums0: <Virtual Mouse> on usbus5
ums0: 3 buttons and [XY] coordinates ID=0
Limiting closed port RST response from 204 to 200 packets/sec
Limiting closed port RST response from 205 to 200 packets/sec
Limiting closed port RST response from 207 to 200 packets/sec
Limiting closed port RST response from 210 to 200 packets/sec
Limiting closed port RST response from 215 to 200 packets/sec
Limiting closed port RST response from 474 to 200 packets/sec
nfsd: can't register svc name
nfsd: can't register svc name
nfsd: can't register svc name
nfsd: can't register svc name
nfsd: can't register svc name
nfsd: can't register svc name
nfsd: can't register svc name
nfsd: can't register svc name


rpcinfo -p FreeNAS
Code:
rpcinfo -p
   program vers proto   port  service
    100000    4   tcp    111  rpcbind
    100000    3   tcp    111  rpcbind
    100000    2   tcp    111  rpcbind
    100000    4   udp    111  rpcbind
    100000    3   udp    111  rpcbind
    100000    2   udp    111  rpcbind
    100000    4 local    111  rpcbind
    100000    3 local    111  rpcbind
    100000    2 local    111  rpcbind
    100005    1   udp    797  mountd
    100005    3   udp    797  mountd
    100005    1   tcp    797  mountd
    100005    3   tcp    797  mountd
    100003    2   udp   2049  nfs
    100003    3   udp   2049  nfs
    100003    2   tcp   2049  nfs
    100003    3   tcp   2049  nfs
    100024    1   udp    741  status
    100024    1   tcp    741  status
    100021    0   udp    621  nlockmgr
    100021    0   tcp    903  nlockmgr
    100021    1   udp    621  nlockmgr
    100021    1   tcp    903  nlockmgr
    100021    3   udp    621  nlockmgr
    100021    3   tcp    903  nlockmgr
    100021    4   udp    621  nlockmgr
    100021    4   tcp    903  nlockmgr


NFS-Debug of the client
Code:
Sep  2 14:40:20 centosTest kernel: NFS: nfs_update_inode(0:37/38849209 fh_crc=0x26de678d ct=1 info=0x27e7f)
Sep  2 14:40:20 centosTest kernel: NFS: permission(0:37/38849209), mask=0x26, res=0
Sep  2 14:40:20 centosTest kernel: NFS: permission(0:37/4), mask=0x81, res=0
Sep  2 14:40:20 centosTest kernel: NFS: permission(0:37/9), mask=0x81, res=0
Sep  2 14:40:20 centosTest kernel: NFS: permission(0:37/6292), mask=0x81, res=0
Sep  2 14:40:20 centosTest kernel: NFS: permission(0:37/32568769), mask=0x81, res=0
Sep  2 14:40:20 centosTest kernel: NFS: permission(0:37/32568773), mask=0x81, res=0
Sep  2 14:40:20 centosTest kernel: NFS: permission(0:37/4), mask=0x81, res=0
Sep  2 14:40:20 centosTest kernel: NFS: permission(0:37/9), mask=0x81, res=0
Sep  2 14:40:20 centosTest kernel: NFS: permission(0:37/6292), mask=0x81, res=0
Sep  2 14:40:20 centosTest kernel: NFS: permission(0:37/32568769), mask=0x81, res=0
Sep  2 14:40:20 centosTest kernel: NFS: dentry_delete(Maildir/dovecot-uidlist.lock, 40808cc)
Sep  2 14:40:20 centosTest kernel: NFS: permission(0:37/4), mask=0x81, res=0
Sep  2 14:40:20 centosTest kernel: NFS: permission(0:37/9), mask=0x81, res=0
Sep  2 14:40:20 centosTest kernel: NFS: permission(0:37/6292), mask=0x81, res=0
Sep  2 14:40:20 centosTest kernel: NFS: permission(0:37/32568769), mask=0x81, res=0
Sep  2 14:40:20 centosTest kernel: NFS: nfs_update_inode(0:37/38484360 fh_crc=0x93a72a0d ct=1 info=0x27e7f)
Sep  2 14:40:20 centosTest kernel: NFS: permission(0:37/38484360), mask=0x24, res=0
Sep  2 14:40:20 centosTest kernel: NFS: dentry_delete(Maildir/dovecot-uidlist.lock, 40808cc)
 

Kharag

Cadet
Joined
Sep 2, 2015
Messages
2
I updated Freenas 9.3 to the latest version (STABLE-Train) and the problem still persists
 
D

dlavigne

Guest
Please create a report at bugs.freenas.org and post the issue number here.
 
Status
Not open for further replies.
Top