Home Forums SQL Server 2012 SQL 2012 - General SQL Server has encountered 1 occurrence of I/O Requests taking longer than 15 seconds RE: SQL Server has encountered 1 occurrence of I/O Requests taking longer than 15 seconds

  • sqlbuddy123 (3/26/2014)


    tony28 (3/26/2014)

    And Now I am seeing that I forgot System log, but time is after the problem, but maybe was problem with failoverclustering and it caused restart service,,, is it possible?

    Good that you didn't have a SQL Server dump file. And basically SQL Error Log entries are logged in Application log too.

    Are you using Clustering with Always ON or just Always ON ?

    First find the exact stop time of the SQL services from the error log. Note that stop time and check a bunch of log entries before that time.

    Looks like we can find some clue from the system log. The system log you posted is not enough. It's better to go back a little bit. Can you post all the system log entries on that day before the SQL Server failure ? You can attach it as a text file.

    Also check the same on the SQL\Application log file too i.e all the events before the SQL Server stop time (on that day).

    --

    SQLBuddy

    --

    SQLBuddy

    1. I am not sure, because it was set up by external company, I can just handle it. But I think with Failover Cluster

    We have 3nodes. First two are in SQL Server Failover Cluster and then this group is with node 3 in AlwaysOn Availability Group. This is according to presentation what I have.

    2.

    Date3/21/2014 6:08:41 PM

    LogSQL Server (Archive #1 - 3/21/2014 6:08:00 PM)

    Sourcespid198

    Message

    Configuration option 'Agent XPs' changed from 1 to 0. Run the RECONFIGURE statement to install.

    Date3/21/2014 6:08:39 PM

    LogSQL Server Agent (Archive #2 - 3/21/2014 6:08:00 PM)

    Message

    [131] SQLSERVERAGENT service stopping due to a stop request from a user, process, or the OS...

    3. There is nothing more,

    Just sometimes shows this error

    Volume Shadow Copy Service error: Unexpected error querying for the IVssWriterCallback interface. hr = 0x80070005, Access is denied.

    . This is often caused by incorrect security settings in either the writer or requestor process.

    Operation:

    Gathering Writer Data

    Context:

    Writer Class Id: {e8132975-6f93-4464-a53e-1050253ae220}

    Writer Name: System Writer

    Writer Instance ID: {fe75e400-b924-45d3-81d3-bb0ee1096cb3}

    and this

    Log Name: Application

    Source: MSSQLSERVER

    Date: 21. 3. 2014 18:08:41

    Event ID: 15457

    Task Category: Server

    Level: Information

    Keywords: Classic

    User: User

    Computer: NameOfServer

    Description:

    Configuration option 'Agent XPs' changed from 1 to 0. Run the RECONFIGURE statement to install.

    Event Xml:

    <Event xmlns="http://schemas.microsoft.com/win/2004/08/events/event">

    <System>

    <Provider Name="MSSQLSERVER" />

    <EventID Qualifiers="16384">15457</EventID>

    <Level>4</Level>

    <Task>2</Task>

    <Keywords>0x80000000000000</Keywords>

    <TimeCreated SystemTime="2014-03-21T17:08:41.000000000Z" />

    <EventRecordID>30331</EventRecordID>

    <Channel>Application</Channel>

    <Computer>NameOfServer</Computer>

    <Security UserID="S-1-5-21-3074418465-2115644625-3052645785-1108" />

    </System>

    <EventData>

    <Data>Agent XPs</Data>

    <Data>1</Data>

    <Data>0</Data>

    <Binary>613C00000A0000000F0000004D00450053002D0048004100440052002D00560053005200560031000000050000006D007300640062000000</Binary>

    </EventData>

    </Event>

    Log Name: Application

    Source: SQLVDI

    Date: 21. 3. 2014 18:08:31

    Event ID: 1

    Task Category: None

    Level: Error

    Keywords: Classic

    User: N/A

    Computer: NameOfServer

    Description:

    SQLVDI: Loc=SignalAbort. Desc=Client initiates abort. ErrorCode=(0). Process=3192. Thread=10908. Client. Instance=. VD=Global\TDPSQL-00000C78-0000_SQLVDIMemoryName_0.

    Event Xml:

    <Event xmlns="http://schemas.microsoft.com/win/2004/08/events/event">

    <System>

    <Provider Name="SQLVDI" />

    <EventID Qualifiers="0">1</EventID>

    <Level>2</Level>

    <Task>0</Task>

    <Keywords>0x80000000000000</Keywords>

    <TimeCreated SystemTime="2014-03-21T17:08:31.000000000Z" />

    <EventRecordID>30330</EventRecordID>

    <Channel>Application</Channel>

    <Computer>NameOfServer</Computer>

    <Security />

    </System>

    <EventData>

    <Data>SignalAbort</Data>

    <Data>Client initiates abort</Data>

    <Data>0</Data>

    <Data>

    </Data>

    <Data>3192</Data>

    <Data>10908</Data>

    <Data>Client</Data>

    <Data>

    </Data>

    <Data>Global\TDPSQL-00000C78-0000_SQLVDIMemoryName_0</Data>

    </EventData>

    </Event>

    Log Name: Application

    Source: MSSQLSERVER

    Date: 21. 3. 2014 18:07:43

    Event ID: 833

    Task Category: Server

    Level: Information

    Keywords: Classic

    User: N/A

    Computer: NameOfServer

    Description:

    SQL Server has encountered 1 occurrence(s) of I/O requests taking longer than 15 seconds to complete on file [G:\USERDB\MCS_MESDB_1.ldf] in database [MCS_MESDB] (8). The OS file handle is 0x0000000000000D08. The offset of the latest long I/O is: 0x000002e70cb000

    Event Xml:

    <Event xmlns="http://schemas.microsoft.com/win/2004/08/events/event">

    <System>

    <Provider Name="MSSQLSERVER" />

    <EventID Qualifiers="16384">833</EventID>

    <Level>4</Level>

    <Task>2</Task>

    <Keywords>0x80000000000000</Keywords>

    <TimeCreated SystemTime="2014-03-21T17:07:43.000000000Z" />

    <EventRecordID>30329</EventRecordID>

    <Channel>Application</Channel>

    <Computer>NameOfServer</Computer>

    <Security />

    </System>

    <EventData>

    <Data>1</Data>

    <Data>15</Data>

    <Data>G:\USERDB\MCS_MESDB_1.ldf</Data>

    <Data>MCS_MESDB</Data>

    <Data>8</Data>

    <Data>0000000000000D08</Data>

    <Data>0x000002e70cb000</Data>

    <Binary>410300000A0000000F0000004D00450053002D0048004100440052002D0056005300520056003100000000000000</Binary>

    </EventData>

    </Event>

    Then I find in FDLAUNCHERRORLOG

    2014-03-21 18:09:39.877MSSQLFDLauncher service received control message.

    2014-03-21 18:09:39.979MSSQLFDLauncher service successfully launched FDHost.exe Process(process id = 9124).

    then in ERRORLOG

    2014-03-21 09:17:43.97 Server The Service Broker endpoint is in disabled or stopped state

    then just Log was backed up, and last backup wasnt, but backup in 22:00 was ok .. it was first time, but you know we work 24/5 and it could be problem...

    2014-03-21 18:07:43.41 spid8s SQL Server has encountered 1 occurrence(s) of I/O requests taking longer than 15 seconds to complete on file [G:\USERDB\MCS_MESDB_1.ldf] in database [MCS_MESDB] (8). The OS file handle is 0x0000000000000D08. The offset of the latest long I/O is: 0x000002e70cb000

    2014-03-21 18:08:41.91 spid198 Configuration option 'Agent XPs' changed from 1 to 0. Run the RECONFIGURE statement to install.

    .