server kernel[0]: jnl: flushing fs disk buffer returned 0x5

[csmosarski]

OSX Server 10.4.9
2 x 2 Ghz Dual Core Xeon, 4GB RAM
SAS Drive 1 – System
SAS Drives 2-3 Software RAD Mirrored
Fibre Channel Card ATTO Celerity FC-41ES – United Digital SATA RAID (Raid 5 – 2 arrays) – ATTO Celerity Host Bus Adapter Mac OS X Driver v3.01

We have been experiencing a number of kernel panics which we think are related to the RAID. Part of the system log is included below. One of the more common errors in the logs is “server kernel[0]: jnl: flushing fs disk buffer returned 0x5”

Can anyone shed any light on this error?

The server share points/directories are on the RAID :

Aug 1 12:37:31 localhost kernel[0]: hi mem tramps at 0xffe00000
Aug 1 12:37:31 localhost kernel[0]: PAE enabled
Aug 1 12:37:31 localhost kernel[0]: 64 bit mode enabled
Aug 1 12:37:31 localhost kernel[0]: standard timeslicing quantum is 10000 us
Aug 1 12:37:31 localhost kernel[0]: vm_page_bootstrap: 973454 free pages
Aug 1 12:37:31 localhost kernel[0]: mig_table_max_displ = 71
Aug 1 12:37:31 localhost kernel[0]: Enabling XMM register save/restore and SSE/SSE2 opcodes
Aug 1 12:37:31 localhost kernel[0]: 91 prelinked modules
Aug 1 12:37:31 localhost kernel[0]: ACPI CA 20060421
Aug 1 12:37:31 localhost kernel[0]: AppleIntelCPUPowerManagement: ready
Aug 1 12:37:31 localhost kernel[0]: AppleACPICPU: ProcessorApicId=0 LocalApicId=0 Enabled
Aug 1 12:37:31 localhost kernel[0]: AppleACPICPU: ProcessorApicId=1 LocalApicId=1 Enabled
Aug 1 12:37:31 localhost kernel[0]: AppleACPICPU: ProcessorApicId=2 LocalApicId=7 Enabled
Aug 1 12:37:31 localhost kernel[0]: AppleACPICPU: ProcessorApicId=3 LocalApicId=6 Enabled
Aug 1 12:37:31 localhost kernel[0]: AppleACPICPU: ProcessorApicId=4 LocalApicId=0 Disabled
Aug 1 12:37:31 localhost kernel[0]: AppleACPICPU: ProcessorApicId=5 LocalApicId=0 Disabled
Aug 1 12:37:31 localhost kernel[0]: AppleACPICPU: ProcessorApicId=6 LocalApicId=0 Disabled
Aug 1 12:37:31 localhost kernel[0]: AppleACPICPU: ProcessorApicId=7 LocalApicId=0 Disabled
Aug 1 12:37:31 localhost kernel[0]: Copyright (c) 1982, 1986, 1989, 1991, 1993
Aug 1 12:37:31 localhost kernel[0]: The Regents of the University of California. All rights reserved.
Aug 1 12:37:31 localhost kernel[0]: using 16384 buffer headers and 4096 cluster IO buffer headers
Aug 1 12:37:31 localhost kernel[0]: Enabling XMM register save/restore and SSE/SSE2 opcodes
Aug 1 12:37:31 localhost kernel[0]: Started CPU 01
Aug 1 12:37:31 localhost kernel[0]: Enabling XMM register save/restore and SSE/SSE2 opcodes
Aug 1 12:37:31 localhost kernel[0]: Started CPU 02
Aug 1 12:37:31 localhost kernel[0]: Enabling XMM register save/restore and SSE/SSE2 opcodes
Aug 1 12:37:31 localhost kernel[0]: IOAPIC: Version 0x20 Vectors 64:87
Aug 1 12:37:31 localhost kernel[0]: Started CPU 03
Aug 1 12:37:31 localhost kernel[0]: ACPI: System State [S0 S3 S4 S5] (S3)
Aug 1 12:37:31 localhost kernel[0]: Security auditing service present
Aug 1 12:37:31 localhost kernel[0]: BSM auditing present
Aug 1 12:37:31 localhost kernel[0]: disabled
Aug 1 12:37:31 localhost kernel[0]: rooting via boot-uuid from /chosen: 86B529B8-5E5D-4CD0-85DB-5C82CD6BE4A5
Aug 1 12:37:31 localhost kernel[0]: Waiting on IOProviderClassIOResourcesIOResourceMatchboot-uuid-media
Aug 1 12:37:31 localhost kernel[0]: USB caused wake event (EHCI)
Aug 1 12:37:31 localhost kernel[0]: FireWire (OHCI) TI ID 8025 built-in now active, GUID 0016cbfffe754852; max speed s800.
Aug 1 12:37:31 localhost kernel[0]: FusionMPT: Notification = 10 (Event Change) for SCSI Domain = 0
Aug 1 12:37:31 localhost kernel[0]: FusionMPT: Notification = 22 (SAS Discovery) for SCSI Domain = 0
Aug 1 12:37:31 localhost kernel[0]: Discovery condition = 0x000f0001
Aug 1 12:37:31 localhost kernel[0]: FusionMPT: Notification = 18 (SAS Phy Link Status) for SCSI Domain = 0
Aug 1 12:37:31 localhost kernel[0]: SAS Phy Link Status: PhyNum = 0, old link rate = 0, new link rate = 8, SASAddress = 50080007000008b8
Aug 1 12:37:31 localhost kernel[0]: FusionMPT: Notification = 18 (SAS Phy Link Status) for SCSI Domain = 0
Aug 1 12:37:31 localhost kernel[0]: SAS Phy Link Status: PhyNum = 1, old link rate = 0, new link rate = 8, SASAddress = 50080007000008ba
Aug 1 12:37:31 localhost kernel[0]: FusionMPT: Notification = 18 (SAS Phy Link Status) for SCSI Domain = 0
Aug 1 12:37:31 localhost kernel[0]: SAS Phy Link Status: PhyNum = 2, old link rate = 0, new link rate = 8, SASAddress = 50080007000008bb
Aug 1 12:37:31 localhost kernel[0]: FusionMPT: Notification = 15 (SAS Device Status Change) for SCSI Domain = 0
Aug 1 12:37:31 localhost kernel[0]: FusionSAS: SASAddress = 955520558895B30 added. Mapped to targetID = 3, bus = 0 on SCSI Domain = 0.
Aug 1 12:37:31 localhost kernel[0]: FusionMPT: Notification = 15 (SAS Device Status Change) for SCSI Domain = 0
Aug 1 12:37:31 localhost kernel[0]: FusionSAS: SASAddress = 38221B056A7C5B3C added. Mapped to targetID = 4, bus = 0 on SCSI Domain = 0.
Aug 1 12:37:31 localhost kernel[0]: FusionMPT: Notification = 15 (SAS Device Status Change) for SCSI Domain = 0
Aug 1 12:37:31 localhost kernel[0]: FusionSAS: SASAddress = 38221B0567976042 added. Mapped to targetID = 5, bus = 0 on SCSI Domain = 0.
Aug 1 12:37:31 localhost kernel[0]: Got boot device = IOService:/AppleACPIPlatformExpert/PCI0@0/AppleACPIPCI/RP01@1C/IOPCI2PCIBridge/P8PC@0/IOPCI2PCIBridge/SAS@2/AppleLSIFusionSAS/SAS Target 0955520558895B30@3/IOSCSITargetDevice/IOSCSILogicalUnitNub@0/IOSCSIPeripheralDeviceType00/IOBlockStorageServices/IOBlockStorageDriver/ST3808110AS PN Media/IOGUIDPartitionScheme/Customer@2
Aug 1 12:37:31 localhost kernel[0]: BSD root: disk3s2, major 14, minor 25
Aug 1 12:37:31 localhost kernel[0]: jnl: replay_journal: from: 900096 to: 6544896 (joffset 0x6401000)
Aug 1 12:37:31 localhost kernel[0]: HFS: Removed 3 orphaned unlinked files
Aug 1 12:37:31 localhost kernel[0]: FusionMPT: Notification = 22 (SAS Discovery) for SCSI Domain = 0
Aug 1 12:37:31 localhost kernel[0]: Discovery condition = 0x00000000
Aug 1 12:37:31 localhost kernel[0]: Jettisoning kernel linker.
Aug 1 12:37:31 localhost kernel[0]: Resetting IOCatalogue.
Aug 1 12:37:31 localhost kernel[0]: Matching service count = 0
Aug 1 12:37:31 localhost kernel[0]: Matching service count = 0
Aug 1 12:37:31 localhost kernel[0]: Matching service count = 0
Aug 1 12:37:31 localhost kernel[0]: Matching service count = 0
Aug 1 12:37:31 localhost kernel[0]: Matching service count = 0
Aug 1 12:37:31 localhost kernel[0]: Matching service count = 0
Aug 1 12:37:31 localhost kernel[0]: Apple16X50ACPI1: Identified Serial Port on ACPI Device=UAR1
Aug 1 12:37:31 localhost kernel[0]: Apple16X50ACPI::start FOUND DB9 Property for AAPL,connector
Aug 1 12:37:31 localhost kernel[0]: Apple16X50UARTSync: Detected 16550AF/C/CF FIFO=16 MaxBaud=115200
Aug 1 12:37:31 localhost kernel[0]: Previous Shutdown Cause: 3
Aug 1 12:37:31 localhost mDNSResponder-108.4 (Jan 8 2007 20: 39:46)[44]: starting
Aug 1 12:37:31 localhost memberd[58]: memberd starting up
Aug 1 12:37:31 localhost named[51]: starting BIND 9.3.2 -f
Aug 1 12:37:31 localhost DirectoryService[63]: Launched version 2.1 (v353.6)
Aug 1 12:37:32 localhost named[51]: command channel listening on 127.0.0.1#54
Aug 1 12:37:32 localhost vpnd[47]: Server ‘com.apple.ppp.l2tp’ starting…\n
Aug 1 12:37:32 localhost lookupd[64]: lookupd (version 369.6) starting – Wed Aug 1 12:37:32 2007
Aug 1 12:37:32 localhost vpnd[47]: Loading plugin /System/Library/Extensions/L2TP.ppp\n
Aug 1 12:37:32 localhost kernel[0]: L2TP domain init
Aug 1 12:37:32 localhost vpnd[47]: Listening for connections…\n
Aug 1 12:37:32 localhost kernel[0]: L2TP domain init complete
Aug 1 12:37:33 localhost diskarbitrationd[56]: disk4s3 hfs 2EF5B321-ACCA-3035-BC16-2F7DF4F13C5B Boot OSX [not mounted]
Aug 1 12:37:33 localhost kernel[0]: AppleIntel8254XEthernet: Ethernet address 00:17:f2:93:87:00
Aug 1 12:37:33 localhost diskarbitrationd[56]: disk3s2 hfs 60F08B09-3744-3184-9990-F87216715BB9 Server HD /
Aug 1 12:37:33 localhost kernel[0]: AppleIntel8254XEthernet: Ethernet address 00:17:f2:93:87:01
Aug 1 12:37:33 localhost diskarbitrationd[56]: disk6s3 hfs 2EF5B321-ACCA-3035-BC16-2F7DF4F13C5B Boot OSX [not mounted]
Aug 1 12:37:33 localhost configd[54]: No AirPort Driver found.
Aug 1 12:37:33 localhost lookupd[106]: lookupd (version 369.6) starting – Wed Aug 1 12:37:33 2007
Aug 1 12:37:33 localhost /System/Library/CoreServices/loginwindow.app/Contents/MacOS/loginwindow: Login Window Application Started
Aug 1 12:37:34 localhost WindowServer[89]: CGXRestoreCredentials: seteuid() failed; errno 1; Session 256, EUID 88, old UID 88, request UID 88
Aug 1 12:37:34 localhost loginwindow[122]: Login Window Started Security Agent
Aug 1 12:37:34 localhost /System/Library/CoreServices/mcxd.app/Contents/MacOS/mcxd: DSGetLocallyHostedNodeNames(): dsFindDirNode() == -14008
Aug 1 12:37:34 localhost /System/Library/CoreServices/mcxd.app/Contents/MacOS/mcxd: DSGetSearchPath(): DSGetLocallyHostedNodeNames() == -14956
Aug 1 12:37:34 localhost /System/Library/CoreServices/mcxd.app/Contents/MacOS/mcxd: DSGetCurrentConfigInfo(): DSGetSearchPath() == -14956
Aug 1 12:37:34 localhost /System/Library/CoreServices/mcxd.app/Contents/MacOS/mcxd: DSGetCacheInfo(): DSGetCurrentConfigInfo() == -14956
Aug 1 12:37:34 localhost /System/Library/CoreServices/mcxd.app/Contents/MacOS/mcxd: *** MCXD.getComputerInfo: Couldn’t get cache info -14956
Aug 1 12:37:36 localhost mDNSResponder: Adding browse domain local.
Aug 1 12:37:37 localhost kernel[0]: Intel8254x — Link Up — 00:17:f2:93:87:00 — called by interruptOccurred() —
Aug 1 12:37:37 localhost kernel[0]: — Auto-Neg Advertise Reg (04d) = 0xde1, Link Partner Ability Reg (05d) = 0xc5e1, Gig Advertise Reg (09d) = 0xe00, Gig Link Partner Ability Reg (10d) = 0x7c00
Aug 1 12:37:37 localhost servermgrd: servermgr_dns: Reloaded named
Aug 1 12:37:38 localhost kernel[0]: jnl: replay_journal: from: 9171456 to: 9212928 (joffset 0xe90000)
Aug 1 12:37:38 localhost diskarbitrationd[56]: disk0s3 hfs E72B3F01-A789-3B31-A996-ECA5F85825D2 Kube C /Volumes/Kube C
Aug 1 12:37:38 localhost kernel[0]: jnl: replay_journal: from: 45848576 to: 46097408 (joffset 0x15d5000)
Aug 1 12:37:38 localhost kernel[0]: jnl: replay_journal: from: 1641984 to: 3103232 (joffset 0x90000)
Aug 1 12:37:39 localhost kernel[0]: jnl: journal start/end pointers reset! (jnl 0x621bad0; s 0x64e00 e 0x6d000)
Aug 1 12:37:39 localhost diskarbitrationd[56]: disk1s3 hfs F9DE20FC-E83C-3DB4-B0C2-D163973A75BC Kube D /Volumes/Kube D
Aug 1 12:37:39 localhost diskarbitrationd[56]: disk5 hfs 3202230A-898B-320D-9140-3A559E62E91F Server Mirror /Volumes/Server Mirror
Aug 1 12:37:39 localhost kernel[0]: jnl: flushing fs disk buffer returned 0x5
Aug 1 12:37:39 localhost diskarbitrationd[56]: disk2s10 hfs 921508BB-5FAF-38EB-8E68-EB2287509093 Temp Server /Volumes/Temp Server
Aug 1 12:37:39 localhost kernel[0]: jnl: replay_journal: from: 3324416 to: 4686336 (joffset 0x90000)
Aug 1 12:37:39 localhost diskarbitrationd[56]: disk2s12 hfs C535D37B-00A7-3690-9655-4097D6E7EA43 Secure Server /Volumes/Secure Server
Aug 1 12:37:39 localhost kernel[0]: jnl: flushing fs disk buffer returned 0x5
Aug 1 12:37:39 localhost kernel[0]: hfs mount: enabling extended security on Secure Server
Aug 1 12:37:39 localhost kernel[0]: jnl: replay_journal: from: 2847744 to: 2987520 (joffset 0x57c000)
Aug 1 12:37:39 localhost diskarbitrationd[56]: disk2s14 hfs CB6265A8-3965-3392-A911-7F1B460F5210 New Media Server /Volumes/New Media Server
Aug 1 12:37:39 localhost kernel[0]: jnl: flushing fs disk buffer returned 0x5
Aug 1 12:37:40 localhost kernel[0]: jnl: replay_journal: from: 3209216 to: 3398144 (joffset 0x57c000)
Aug 1 12:37:40 localhost diskarbitrationd[56]: disk2s16 hfs F73768EB-EDF1-3970-BC02-9B036CBB1D55 Masters Server /Volumes/Masters Server
Aug 1 12:37:40 localhost kernel[0]: jnl: flushing fs disk buffer returned 0x5
Aug 1 12:37:40 localhost kernel[0]: jnl: replay_journal: from: 4797440 to: 5379072 (joffset 0x57c000)
Aug 1 12:37:40 localhost diskarbitrationd[56]: disk2s18 hfs 44B73D5D-E9B5-367E-894D-D4B172E6E7CE Project Management Server /Volumes/Project Management Server
Aug 1 12:37:40 localhost kernel[0]: jnl: flushing fs disk buffer returned 0x5
Aug 1 12:37:40 localhost kernel[0]: jnl: replay_journal: from: 13216768 to: 14243840 (joffset 0x15e4000)
Aug 1 12:37:40 localhost diskarbitrationd[56]: disk2s20 hfs 32B6C0E9-EF2E-3E08-A9E7-D407543DECB6 Production Server /Volumes/Production Server
Aug 1 12:37:40 localhost kernel[0]: jnl: flushing fs disk buffer returned 0x5
Aug 1 12:37:40 localhost kernel[0]: hfs mount: enabling extended security on Production Server
Aug 1 12:37:41 server kernel[0]: Intel8254x — Link down — 00:17:f2:93:87:01 — called by enableHardware() —
Aug 1 12:37:41 server kernel[0]: — Auto-Neg Advertise Reg (04d) = 0xde1, Link Partner Ability Reg (05d) = 0x0, Gig Advertise Reg (09d) = 0xe00, Gig Link Partner Ability Reg (10d) = 0x4000
Aug 1 12:37:41 server configd[54]: setting hostname to “server.bostockandpollitt.com”
Aug 1 12:37:41 server configd[54]: AppleTalk startup
Aug 1 12:37:41 server kernel[0]: jnl: replay_journal: from: 2166784 to: 2208256 (joffset 0x106c000)
Aug 1 12:37:41 server diskarbitrationd[56]: disk2s22 hfs 8FF10B33-39D8-3FCF-B646-A7739AB8A239 Design Server( TO BE CLOSED) /Volumes/Design Server( TO BE CLOSED)
Aug 1 12:37:41 server kernel[0]: jnl: flushing fs disk buffer returned 0x5
Aug 1 12:37:42 server kernel[0]: jnl: replay_journal: from: 5600256 to: 10111488 (joffset 0x1b24000)
Aug 1 12:37:42 server kernel[0]: jnl: flushing fs disk buffer returned 0x5
Aug 1 12:37:42 server diskarbitrationd[56]: disk2s24 hfs 22FA89DE-E86A-3277-AF56-132E1B754765 Bostock and Pollitt Server /Volumes/Bostock and Pollitt Server
Aug 1 12:37:42 server configd[54]: executing /System/Library/SystemConfiguration/Kicker.bundle/Contents/Resources/enable-network
Aug 1 12:37:42 server configd[54]: posting notification com.apple.system.config.network_change
Aug 1 12:37:42 server lookupd[171]: lookupd (version 369.6) starting – Wed Aug 1 12:37:42 2007
Aug 1 12:37:43 server servermgrd: servermgr_dns: Reloaded named
Aug 1 12:37:43 server servermgrd: servermgr_dns: hostname and DNS entries for this server are synchronized
Aug 1 12:37:45 server servermgrd: servermgr_dns: Reloaded named
Aug 1 12:37:46 server configd[54]: AppleTalk startup complete
Aug 1 12:37:48 server kernel[0]: jnl: replay_journal: from: 42590208 to: 53137408 (joffset 0x32da000)
Aug 1 12:37:50 server configd[54]: target=enable-network: disabled
Aug 1 12:37:51 server /usr/sbin/serialnumberd[266]: serialnumberd: Firewall rule #1 added to allow port 626.
Aug 1 12:37:53 server kernel[0]: jnl: flushing fs disk buffer returned 0x5
Aug 1 12:37:53 server diskarbitrationd[56]: disk7s3 hfs 138E3DF4-A93F-31F5-920D-4A2636CC12D6 RAID ARRAY 2 /Volumes/RAID ARRAY 2
Aug 1 12:37:55 server /usr/sbin/serveradmin: servermgr_ipfilter:ipfw config:Notice:Disabled firewall
Aug 1 12:38:16 server kernel[0]: disk1s3: I/O error.
Aug 1 12:38:16 server kernel[0]: jnl: do_jnl_io: strategy err 0x5
Aug 1 12:38:16 server kernel[0]: jnl: end_transaction: only wrote 0 of 16896 bytes to the journal!
Aug 1 12:38:16 server kernel[0]: jnl: flushing fs disk buffer returned 0x5
Aug 1 12:38:16 server kernel[0]: jnl: flushing fs disk buffer returned 0x5
Aug 1 12:38:16 server kernel[0]: jnl: flushing fs disk buffer returned 0x5
Aug 1 12:38:16 server kernel[0]: jnl: flushing fs disk buffer returned 0x5
Aug 1 12:38:16 server kernel[0]: jnl: flushing fs disk buffer returned 0x5
Aug 1 12:38:16 server kernel[0]: jnl: flushing fs disk buffer returned 0x5
Aug 1 12:38:16 server kernel[0]: jnl: flushing fs disk buffer returned 0x5
Aug 1 12:38:16 server kernel[0]: jnl: flushing fs disk buffer returned 0x5
Aug 1 12:38:16 server kernel[0]: jnl: flushing fs disk buffer returned 0x5

[Author]

Posts