Error in communicating with Excel Calculation Services

When attempting to view an Excel spreadsheet in SharePoint, we get the following error displayed in the web browser:

Excel Web Access: An error has occurred

Checking the Event Log we see:

There was an error in communicating with Excel Calculation Services http://uklo2k3d02:56737/SharedServices1/ExcelCalculationServer/ExcelService.asmx  exception: The request failed with HTTP status 401: Unauthorized.
[Session: (null) User: CAPCO\jtnn].

  • The user has full admin rights over all systems
  • We are running RTM version of SharePoint 2007, Enterprise Edition
  • Excel Services is enabled, configured and activated on all levels.
  • The location is set as trusted.
  • The rest of the server works perfectly
  • Shared Services works fine apart from Excel, as My Site and Search works
  • We have set up one server using Kerberos (all SPN accounts set up and working, adsutil has ensured NEGOTIATE on all instances) but no go
  • We have set up another server using NTLM but no go
  • I have read http://support.microsoft.com/kb/923502 but no go
  • I have tried both PROCESS and IMPERSONATION in the Excel Services settings, but no difference
  • Also followed every step in this article http://msd2d.com/content/Tip_viewitem_03.aspx section=SharePoint&category=Administration&id=2d02b594-5e07-4957-921f-72e6e6954618  ...but no go.

Can anyone help




Answer this question

Error in communicating with Excel Calculation Services

  • Learning VB

    Randine, John,

    I assume from your posts, that you wish to deploy MOSS in a Kerberos enviroment. Please let me know if that isn't the case, or not a requirement.

    So lets try the following:

    In addition to the stsadm commands I suggested running at the beginning of the thread, please try running the following:

    stsadm -o setsharedwebserviceauthn -negotiate

    stsadm -o execadmsvcjobs

    iisreset

    Now, retry your scenario.

    If it's still failing, then I suspect you have an SPN registration issue. Can you describe which SPNs you've registered for the Shared Services AppPool  Under which account is the AppPool running as Could it be that in your production enviroment (the one that works,) the AppPool was running as Network service  


  • airwalker2000

    Hi Luis,

    I am working with John on this Excel Calculation Services on our Development server. I can comfirm that none of the recommendations worked on the dev server. We are still searching for a solution.

    Randine



  • estyles

    No, the suggested fix did not work.

    We have spent two weeks installing MOSS on different servers. Fortuately the production servers work fine. However, the development and test servers do not - which makes it hard to develop and test. We have attempted to isolate the problem, but no joy. Here is a summary of what we tried:

    Our installation of SharePoint 2007 Enterprise Edition on goes through the following steps:

    1) Install and follow DB Config Wizard

    2) Used the Advance Settings (Select Complete installation)

    3) Create a new Farm

    4) Specify Database Settings (seperate database server is being used)

    5) Configure SharePoint Central Admin Web Application (Kerberos Authentication)

    Log into Central Admin and continue configuration as follows below.

    6) From the operation menu, configure Services on Server

    7) Configure the Search Services, Tick Query, Indexing boxes and provide email address, Farm Search Services Account, Search Databases etc..

    8) Create and configure Farms shared services from application management.

    9) Create new SSP

    10) Create a new web application for our shared services, using port 80, host header and again (Kerberos Security), tick IIS restart automatically

    11) Create a new web application for our mysite services, using port 80, host header and again (Kerberos Security), tick IIS restart automatically

    12) Success! (Great)

    Tasks still outstanding to complete (Keep in mind we want to use excel web access)

    1) Configure outgoing email settings (Not used as yet)

    2) Configure workflow settings (Not Used as yet)

    3) Configure infopath forms (Not used as yet)

    4) Setup Services Account as single sign-on services (not used)

    5) Configure diagnostic logging

    6) Configure Web application general settings

    7) Create site collection

    Select my Web Application

    Web site address as the root

    Select Enterprise reports

    Site collection administrators 1 and 2

    No quota

    So we have a new site that works. So we need to configure Excel Services.

    1) From the operations menu in Central admin, select Enabled Excel Services feature on all sites

    2) Switch in on and wait for success.

    3) Configure a trusted path location for Excel and add webpart to page

    4) Use the sample file the report library

    5) And Excel Services works - but only on the production server!!

    To enabled features, this can also be selected from within the shared services page to enable individual features, same can be done from you website page from within the site settings option.

    Kerboros setup

    We have SPNs set up for the production server and the development server - but no joy.

    Both computers are trusted for delegation.

    THE BIG PROBLEM

    Repeat all the above steps on development server and excel services give the below error message.

    An error has occurred.

    Please contact your system administrator if this problem persists.

    After at least six attempts on the development server and lots of reading on every blog out in cyber space, can someone help please We would really like to get excel services working on our development server not just on our production.



  • xlordt

    Hi Ira,

    I've been having this problem as well. the 401 on Excel services problem is solved by:

    stsadm -o setsharedwebserviceauthn -negotiate

    stsadm -o execadmsvcjobs

    iisreset

    But I now get the following errors in eventlog, plain excel sheets on MOSS work now but SSAS data refresh fails

    Description:
    The description for Event ID ( 0 ) in Source ( .NET Runtime ) cannot be found. The local computer may not have the necessary registry information or message DLL files to display messages from a remote computer. You may be able to use the /AUXSOURCE= flag to retrieve this description; see Help and Support for details. The following information is part of the event: Unable to open shim database version registry key - v2.0.50727.00000.

    Event Type: Error
    Event Source: Office SharePoint Server Error Reporting
    Event Category: None
    Event ID: 5000
    Date: 3/15/2007
    Time: 1:22:47 PM
    User: N/A
    Computer: SENA-SHAREPOINT
    Description:
    EventType ulsexception12, P1 w3wp.exe, P2 6.0.3790.1830, P3 42435e74, P4 microsoft.office.excel.server, P5 12.0.4518.0, P6 45417eea, P7 489, P8 17, P9 timeoutexception, P10 8jfu.

    For more information, see Help and Support Center at http://go.microsoft.com/fwlink/events.asp.
    Data:
    0000: 75 00 6c 00 73 00 65 00 u.l.s.e.
    0008: 78 00 63 00 65 00 70 00 x.c.e.p.
    0010: 74 00 69 00 6f 00 6e 00 t.i.o.n.
    0018: 31 00 32 00 2c 00 20 00 1.2.,. .
    0020: 77 00 33 00 77 00 70 00 w.3.w.p.
    0028: 2e 00 65 00 78 00 65 00 ..e.x.e.
    0030: 2c 00 20 00 36 00 2e 00 ,. .6...
    0038: 30 00 2e 00 33 00 37 00 0...3.7.
    0040: 39 00 30 00 2e 00 31 00 9.0...1.
    0048: 38 00 33 00 30 00 2c 00 8.3.0.,.
    0050: 20 00 34 00 32 00 34 00 .4.2.4.
    0058: 33 00 35 00 65 00 37 00 3.5.e.7.
    0060: 34 00 2c 00 20 00 6d 00 4.,. .m.
    0068: 69 00 63 00 72 00 6f 00 i.c.r.o.
    0070: 73 00 6f 00 66 00 74 00 s.o.f.t.
    0078: 2e 00 6f 00 66 00 66 00 ..o.f.f.
    0080: 69 00 63 00 65 00 2e 00 i.c.e...
    0088: 65 00 78 00 63 00 65 00 e.x.c.e.
    0090: 6c 00 2e 00 73 00 65 00 l...s.e.
    0098: 72 00 76 00 65 00 72 00 r.v.e.r.
    00a0: 2c 00 20 00 31 00 32 00 ,. .1.2.
    00a8: 2e 00 30 00 2e 00 34 00 ..0...4.
    00b0: 35 00 31 00 38 00 2e 00 5.1.8...
    00b8: 30 00 2c 00 20 00 34 00 0.,. .4.
    00c0: 35 00 34 00 31 00 37 00 5.4.1.7.
    00c8: 65 00 65 00 61 00 2c 00 e.e.a.,.
    00d0: 20 00 34 00 38 00 39 00 .4.8.9.
    00d8: 2c 00 20 00 31 00 37 00 ,. .1.7.
    00e0: 2c 00 20 00 74 00 69 00 ,. .t.i.
    00e8: 6d 00 65 00 6f 00 75 00 m.e.o.u.
    00f0: 74 00 65 00 78 00 63 00 t.e.x.c.
    00f8: 65 00 70 00 74 00 69 00 e.p.t.i.
    0100: 6f 00 6e 00 20 00 38 00 o.n. .8.
    0108: 6a 00 66 00 75 00 0d 00 j.f.u...
    0110: 0a 00 ..



  • melkor

    In addition I now have been able to log the following messages that seem to have an effect on Excel services. The user is validated OK against sharepoint but still these messages appear (I've offcourse removed user and domain names)

    Event Type: Failure Audit
    Event Source: Security
    Event Category: Object Access
    Event ID: 560
    Date:  3/15/2007
    Time:  3:53:52 PM
    User:  
    Computer: SHAREPOINT
    Description:
    Object Open:
      Object Server: Security Account Manager
      Object Type: SAM_ALIAS
      Object Name: DOMAINS\Account\Aliases\000003ED
      Handle ID: -
      Operation ID: {0,325835}
      Process ID: 436
      Image File Name: C:\WINDOWS\system32\lsass.exe
      Primary User Name: SHAREPOINT$
      Primary Domain: 
      Primary Logon ID: (0x0,0x3E7)
      Client User Name: 
      Client Domain: 
      Client Logon ID: (0x0,0x4BA2A)
      Accesses: AddMember
       RemoveMember
       ListMembers
       ReadInformation
       
      Privileges: -
      Restricted Sid Count: 0
      Access Mask: 0xF


    For more information, see Help and Support Center at http://go.microsoft.com/fwlink/events.asp.

    Event Type: Failure Audit
    Event Source: Security
    Event Category: Object Access
    Event ID: 560
    Date:  3/15/2007
    Time:  3:53:44 PM
    User:  
    Computer: SHAREPOINT
    Description:
    Object Open:
      Object Server: SC Manager
      Object Type: SC_MANAGER OBJECT
      Object Name: ServicesActive
      Handle ID: -
      Operation ID: {0,312251}
      Process ID: 424
      Image File Name: C:\WINDOWS\system32\services.exe
      Primary User Name: SHAREPOINT$
      Primary Domain: 
      Primary Logon ID: (0x0,0x3E7)
      Client User Name: 
      Client Domain: 
      Client Logon ID: (0x0,0x4BA2A)
      Accesses: READ_CONTROL
       Connect to service controller
       Enumerate services
       Query service database lock state
       
      Privileges: -
      Restricted Sid Count: 0
      Access Mask: 0x20015


    For more information, see Help and Support Center at http://go.microsoft.com/fwlink/events.asp.

    Event Type: Failure Audit
    Event Source: Security
    Event Category: Object Access
    Event ID: 560
    Date:  3/15/2007
    Time:  3:53:11 PM
    User:  
    Computer: SHAREPOINT
    Description:
    Object Open:
      Object Server: Security Account Manager
      Object Type: SAM_ALIAS
      Object Name: DOMAINS\Account\Aliases\000003ED
      Handle ID: -
      Operation ID: {0,286316}
      Process ID: 436
      Image File Name: C:\WINDOWS\system32\lsass.exe
      Primary User Name: SHAREPOINT$
      Primary Domain: 
      Primary Logon ID: (0x0,0x3E7)
      Client User Name: 
      Client Domain: 
      Client Logon ID: (0x0,0x45D1D)
      Accesses: AddMember
       RemoveMember
       ListMembers
       ReadInformation
       
      Privileges: -
      Restricted Sid Count: 0
      Access Mask: 0xF


    For more information, see Help and Support Center at http://go.microsoft.com/fwlink/events.asp.



  • Paolo Tosiani

    Dr. John,

    I'm posting because I just resolved an issue that was yielding exactly the same error messages you are seeing, namely, an error has occurred and HTTP 401: Unauthorized. I was trying to programmatically open a workbook from a PC on the intranet and from another PC on the internet. All was well on the intranet, but no joy on the internet. I worked on the problem for a solid month, then hired Microsoft support for $245. Within Microsoft, the problem propagated through at least 4 levels of support until it got to one of the MOSS 2007 developers. The developer asked if I had setup any alternate URLs (aka Alternate Access Mappings on the Operations tab) for the site so that I could access it from a non-intranet DNS or IP address. I had not. So, I added a couple mappings: http://MyServerName and http://MyServersActualIPAddress (e.g., http://111.222.333.444). After adding these alternate URLs, my Web Excel Services calls worked properly.

    Admittedly, what prompted me to post this little blurb is only the fact that you are seeing the exact error messages that I struggled with for a month. If your experience has been anything like mine (it sounds like it has been rather painful), then you might be willing to try just about anything at this point. Just a newbie's quick two cents. Frankly, just a shot in the dark.

    KrisF


  • prawin

    John,

    Did the above post answer your question   Let us know if there's any more info needed, otherwise it would be great if you could mark the post Answered so we can get it off the radar.

     

    Thanks!

     



  • Hubajube

    John,

    Can you check the Security Event Log on uklo2k3dmoss, and check if kerberos authentication succeeded to that machine.

    Also, can you check on that machine whether the web.config has the following section:

    <location path="XXXXX/ExcelCalculationServer" allowOverride="true" inheritInChildApplications="true">
    <system.web>
    <authorization>
    <allow users="*" />
    </authorization>
    </system.web>
    </location>

    The web.config is located at: %program files%\\Microsoft Office Server\12.0\WebServices\Root\Web.Config


  • Richard Wilson

    Here is a sample of our log.

    01/30/2007 12:54:39.21 w3wp.exe (0x0B74) 0x0600 Excel Services Excel Web Access 5cbf Medium ExcelWebRenderer.OnLoad: Starting loading external EWR
    01/30/2007 12:54:39.21 w3wp.exe (0x0B74) 0x0600 Windows SharePoint Services Web Controls 90i3 Verbose PersonalActions::CreateChildControls() - Was called.
    01/30/2007 12:54:39.22 w3wp.exe (0x0B74) 0x0600 434 8ofj Verbose Menu::OnLoad() - Was called. ID="Menu"
    01/30/2007 12:54:39.22 w3wp.exe (0x0B74) 0x0600 434 8ofj Verbose Menu::OnLoad() - Was called. ID="MyLinksMenuMenu"
    01/30/2007 12:54:39.22 w3wp.exe (0x0B74) 0x0600 434 8ofj Verbose Menu::OnLoad() - Was called. ID="SiteActionsMenu"
    01/30/2007 12:54:39.22 w3wp.exe (0x0B74) 0x0600 Windows SharePoint Services Database 880l Verbose ConnectionString: 'Data Source=UKLO2K3DENTDB;Initial Catalog=WSS_Content;Integrated Security=True;Enlist=False;Connect Timeout=15' ConnectionState: Closed ConnectionTimeout: 15
    01/30/2007 12:54:39.22 w3wp.exe (0x0B74) 0x0600 1624 8acb Verbose Reverting to process identity
    01/30/2007 12:54:39.23 w3wp.exe (0x0B74) 0x0600 1624 8acc Verbose Current user before SqlConnection.Open: Name: CAPCO\SERV_SharePoint SID: S-1-5-21-486879912-1543852476-316617838-9409 ImpersonationLevel: None
    01/30/2007 12:54:39.23 w3wp.exe (0x0B74) 0x0600 1624 8acf Verbose Current user after SqlConnection.Open: Name: CAPCO\SERV_SharePoint SID: S-1-5-21-486879912-1543852476-316617838-9409 ImpersonationLevel: None
    01/30/2007 12:54:39.23 w3wp.exe (0x0B74) 0x0600 Windows SharePoint Services Database 880m Verbose SqlCommand: ' SELECT TOP 6 t1.[Type] AS c0,UserData.[tp_ContentTypeId],UserData.[ntext2],t2.[tp_ID] AS c5c7,UserData.[tp_ID],t1.[TimeCreated] AS c4,t2.[tp_Created] AS c5c10,UserData.[tp_Created],CASE WHEN DATALENGTH(t1.DirName) = 0 THEN t1.LeafName WHEN DATALENGTH(t1.LeafName) = 0 THEN t1.DirName ELSE t1.DirName + N'/' + t1.LeafName END AS c1,UserData.[tp_ModerationStatus],UserData.[tp_Level],UserData.[nvarchar1],UserData.[tp_Author],t2.[nvarchar1] AS c5c6,t2.[nvarchar4] AS c5c8,t1.[LeafName] AS c3,UserData.[nvarchar2],UserData.[tp_HasAttachment],t1.[ScopeId] AS c2,t2.[nvarchar5] AS c5c9,UserData.[tp_Modified] FROM UserData INNER MERGE JOIN Docs AS t1 WITH(NOLOCK) ON ( 1 = 1 AND UserData.[tp_RowOrdinal] = 0 AND t1.SiteId = UserData.tp_SiteId AND t1.SiteId = @L2 AND t1.DirName = UserData...
    01/30/2007 12:54:39.23* w3wp.exe (0x0B74) 0x0600 Windows SharePoint Services Database 880m Verbose ....tp_DirName AND t1.LeafName = UserData.tp_LeafName AND t1.Level = UserData.tp_Level AND t1.IsCurrentVersion = 1 AND (1 = 1)) LEFT OUTER JOIN AllUserData AS t2 WITH(NOLOCK, INDEX=AllUserData_PK) ON (UserData.[tp_Author]=t2.[tp_ID] AND UserData.[tp_RowOrdinal] = 0 AND t2.[tp_RowOrdinal] = 0 AND ( (t2.tp_IsCurrent = 1) ) AND t2.[tp_CalculatedVersion] = 0 AND t2.[tp_DeleteTransactionId] = 0x AND t2.tp_ListId = @L3 AND UserData.tp_ListId = @L4) WHERE (UserData.tp_IsCurrent = 1) AND UserData.tp_SiteId=@L2 AND (UserData.tp_DirName=@DN) AND UserData.tp_RowOrdinal=0 AND (((UserData.[datetime1] IS NULL ) OR (UserData.[datetime1] >= @L5DTP)) AND t1.SiteId=@L2 AND (t1.DirName=@DN)) ORDER BY UserData.[tp_Modified] Desc,UserData.[tp_ID] Asc OPTION (FORCE ORDER) ' CommandType: Text CommandTime...
    01/30/2007 12:54:39.23* w3wp.exe (0x0B74) 0x0600 Windows SharePoint Services Database 880m Verbose ...out: 0 Parameter: '@L0' Type: UniqueIdentifier Size: 0 Direction: Input Value: '00000000-0000-0000-0000-000000000000' Parameter: '@L2' Type: UniqueIdentifier Size: 0 Direction: Input Value: '3c22eefc-a7f6-470b-8e75-b82abf624a5c' Parameter: '@L3' Type: UniqueIdentifier Size: 0 Direction: Input Value: 'ff1a8950-7565-43f8-bd08-1d5a3d42d6ed' Parameter: '@L4' Type: UniqueIdentifier Size: 0 Direction: Input Value: '5aea8f0f-0e0b-4ac0-9e7b-8705dd6050a5' Parameter: '@L5DTP' Type: DateTime Size: 0 Direction: Input Value: '1/30/2007 12:00:00 AM' Parameter: '@DN' Type: NVarChar Size: 260 Direction: Input Value: 'Lists/Announcements'
    01/30/2007 12:54:39.24 w3wp.exe (0x0B74) 0x0600 Windows SharePoint Services Database 880l Verbose ConnectionString: 'Data Source=UKLO2K3DENTDB;Initial Catalog=WSS_Content;Integrated Security=True;Enlist=False;Connect Timeout=15' ConnectionState: Closed ConnectionTimeout: 15
    01/30/2007 12:54:39.24 w3wp.exe (0x0B74) 0x0600 1624 8acb Verbose Reverting to process identity
    01/30/2007 12:54:39.25 w3wp.exe (0x0B74) 0x0600 1624 8acc Verbose Current user before SqlConnection.Open: Name: CAPCO\SERV_SharePoint SID: S-1-5-21-486879912-1543852476-316617838-9409 ImpersonationLevel: None
    01/30/2007 12:54:39.25 w3wp.exe (0x0B74) 0x0600 1624 8acf Verbose Current user after SqlConnection.Open: Name: CAPCO\SERV_SharePoint SID: S-1-5-21-486879912-1543852476-316617838-9409 ImpersonationLevel: None
    01/30/2007 12:54:39.25 w3wp.exe (0x0B74) 0x0600 Windows SharePoint Services Database 880m Verbose SqlCommand: ' SELECT t1.[Type] AS c0,UserData.[datetime1],UserData.[tp_ContentTypeId],UserData.[ntext2],UserData.[int3],t1.[TimeCreated] AS c4,UserData.[nvarchar4],UserData.[tp_Created],UserData.[ntext4],CASE WHEN DATALENGTH(t1.DirName) = 0 THEN t1.LeafName WHEN DATALENGTH(t1.LeafName) = 0 THEN t1.DirName ELSE t1.DirName + N'/' + t1.LeafName END AS c1,UserData.[tp_ModerationStatus],UserData.[tp_Level],UserData.[nvarchar1],UserData.[bit2],UserData.[datetime3],UserData.[int4],t1.[LeafName] AS c3,UserData.[nvarchar2],UserData.[tp_HasAttachment],UserData.[int1],UserData.[bit3],t1.[ScopeId] AS c2,UserData.[bit4],UserData.[int2],UserData.[bit1],UserData.[datetime2],UserData.[tp_ID],UserData.[ntext3],UserData.[uniqueidentifier1],UserData.[nvarchar5] FROM UserData LEFT OUTER LOOP JOIN Docs AS t...
    01/30/2007 12:54:39.25* w3wp.exe (0x0B74) 0x0600 Windows SharePoint Services Database 880m Verbose ...1 WITH(NOLOCK) ON ( 1 = 1 AND UserData.[tp_RowOrdinal] = 0 AND t1.SiteId = UserData.tp_SiteId AND t1.SiteId = @L2 AND t1.DirName = UserData.tp_DirName AND t1.LeafName = UserData.tp_LeafName AND t1.Level = UserData.tp_Level AND t1.IsCurrentVersion = 1 AND (1 = 1)) WHERE UserData.tp_ListID=@L5 AND ( (UserData.tp_IsCurrent = 1) ) AND UserData.tp_SiteId=@L2 AND (UserData.tp_DirName=@DN) AND UserData.tp_RowOrdinal=0 AND (((( CAST(UserData.[datetime1] AS datetime ) <= @L3DTP AND (( CAST(UserData.[datetime2] AS datetime ) IS NULL AND CAST(UserData.[datetime1] AS datetime ) >= @L4DTP) OR ( CAST(UserData.[datetime2] AS datetime ) >= @L4DTP))) OR (UserData.[datetime3] <= @L3DTP AND UserData.[datetime3] >= @L4DTP))) AND t1.SiteId=@L2 AND (t1.DirName=@DN)) ORDER BY UserData.[tp_ID] Asc OPTION (...
    01/30/2007 12:54:39.25* w3wp.exe (0x0B74) 0x0600 Windows SharePoint Services Database 880m Verbose ...FORCE ORDER) ' CommandType: Text CommandTimeout: 0 Parameter: '@L0' Type: UniqueIdentifier Size: 0 Direction: Input Value: '00000000-0000-0000-0000-000000000000' Parameter: '@L2' Type: UniqueIdentifier Size: 0 Direction: Input Value: '3c22eefc-a7f6-470b-8e75-b82abf624a5c' Parameter: '@L3DTP' Type: DateTime Size: 0 Direction: Input Value: '1/29/2009 11:59:59 PM' Parameter: '@L4DTP' Type: DateTime Size: 0 Direction: Input Value: '1/30/2007 12:00:00 AM' Parameter: '@DN' Type: NVarChar Size: 260 Direction: Input Value: 'Lists/Calendar' Parameter: '@L5' Type: UniqueIdentifier Size: 0 Direction: Input Value: '00d045c2-c401-4f35-80e9-7d867f57725c'
    01/30/2007 12:54:39.26 w3wp.exe (0x0B74) 0x0600 Windows SharePoint Services Database 880l Verbose ConnectionString: 'Data Source=UKLO2K3DENTDB;Initial Catalog=WSS_Content;Integrated Security=True;Enlist=False;Connect Timeout=15' ConnectionState: Closed ConnectionTimeout: 15
    01/30/2007 12:54:39.26 w3wp.exe (0x0B74) 0x0600 1624 8acb Verbose Reverting to process identity
    01/30/2007 12:54:39.26 w3wp.exe (0x0B74) 0x0600 1624 8acc Verbose Current user before SqlConnection.Open: Name: CAPCO\SERV_SharePoint SID: S-1-5-21-486879912-1543852476-316617838-9409 ImpersonationLevel: None
    01/30/2007 12:54:39.26 w3wp.exe (0x0B74) 0x0600 1624 8acf Verbose Current user after SqlConnection.Open: Name: CAPCO\SERV_SharePoint SID: S-1-5-21-486879912-1543852476-316617838-9409 ImpersonationLevel: None
    01/30/2007 12:54:39.26 w3wp.exe (0x0B74) 0x0600 Windows SharePoint Services Database 880m Verbose SqlCommand: ' SELECT TOP 21 t1.[Type] AS c0,t1.[ScopeId] AS c2,UserData.[nvarchar3],UserData.[tp_ID],UserData.[nvarchar4],UserData.[tp_Created],CASE WHEN DATALENGTH(t1.DirName) = 0 THEN t1.LeafName WHEN DATALENGTH(t1.LeafName) = 0 THEN t1.DirName ELSE t1.DirName + N'/' + t1.LeafName END AS c1,UserData.[tp_ModerationStatus],UserData.[tp_Level],t1.[LeafName] AS c3 FROM UserData INNER MERGE JOIN Docs AS t1 WITH(NOLOCK) ON ( 1 = 1 AND UserData.[tp_RowOrdinal] = 0 AND t1.SiteId = UserData.tp_SiteId AND t1.SiteId = @L2 AND t1.DirName = UserData.tp_DirName AND t1.LeafName = UserData.tp_LeafName AND t1.Level = UserData.tp_Level AND t1.IsCurrentVersion = 1 AND (1 = 1)) WHERE (UserData.tp_IsCurrent = 1) AND UserData.tp_SiteId=@L2 AND (UserData.tp_DirName=@DN) AND UserData.tp_RowOrdinal=0 AND ...
    01/30/2007 12:54:39.26* w3wp.exe (0x0B74) 0x0600 Windows SharePoint Services Database 880m Verbose ...(t1.SiteId=@L2 AND (t1.DirName=@DN)) ORDER BY t1.[Type] Desc,UserData.[tp_ItemOrder] Asc,UserData.[tp_ID] Asc OPTION (FORCE ORDER) ' CommandType: Text CommandTimeout: 0 Parameter: '@L0' Type: UniqueIdentifier Size: 0 Direction: Input Value: '00000000-0000-0000-0000-000000000000' Parameter: '@L2' Type: UniqueIdentifier Size: 0 Direction: Input Value: '3c22eefc-a7f6-470b-8e75-b82abf624a5c' Parameter: '@DN' Type: NVarChar Size: 260 Direction: Input Value: 'Lists/Links'
    01/30/2007 12:54:39.27 w3wp.exe (0x0B74) 0x0600 434 8ewq Verbose PersonalActions::OnPreRender() - Was called.
    01/30/2007 12:54:39.28 w3wp.exe (0x0B74) 0x0600 434 8ofk Verbose Menu::Render() - Was called. ID="Menu"
    01/30/2007 12:54:39.28 w3wp.exe (0x0B74) 0x0600 Windows SharePoint Services Web Controls 88w6 Verbose Rendering menu control with id=Menu, Text=""
    01/30/2007 12:54:39.28 w3wp.exe (0x0B74) 0x0600 434 8ewr Verbose PostCacheSubstitutionText::Render() - Was called.
    01/30/2007 12:54:39.28 w3wp.exe (0x0B74) 0x0600 434 8ewr Verbose PostCacheSubstitutionText::Render() - Was called.
    01/30/2007 12:54:39.28 w3wp.exe (0x0B74) 0x0600 434 8ofk Verbose Menu::Render() - Was called. ID="MyLinksMenuMenu"
    01/30/2007 12:54:39.28 w3wp.exe (0x0B74) 0x0600 434 8ofk Verbose Menu::Render() - Was called. ID="SiteActionsMenu"
    01/30/2007 12:54:39.28 w3wp.exe (0x0B74) 0x0600 Windows SharePoint Services Web Controls 88w6 Verbose Rendering menu control with id=SiteActionsMenu, Text="Site Actions"
    01/30/2007 12:54:39.30 w3wp.exe (0x0B74) 0x0600 Excel Services Excel Web Access 5cbg Medium ExcelWebRenderer.RenderWebPart: Finished rendering external EWR
    01/30/2007 12:54:39.31 w3wp.exe (0x0B74) 0x0600 Windows SharePoint Services General 0 Verbose Releasing SPRequest with allocation Id {A6D34E10-F4BF-40F6-9CC6-9D6F3F60B2E2}
    01/30/2007 12:54:39.31 w3wp.exe (0x0B74) 0x0600 Windows SharePoint Services General 0 Verbose Releasing SPRequest with allocation Id {4AA296CB-4372-4A6C-9DBC-8EC3669D54CB}
    01/30/2007 12:54:39.31 w3wp.exe (0x0B74) 0x0600 Windows SharePoint Services General 0 Verbose Releasing SPRequest with allocation Id {44662513-730C-452A-BEE8-4536941F17DA}
    01/30/2007 12:54:39.57 w3wp.exe (0x0B74) 0x0600 CMS Publishing 8zug Medium PublishingHttpModule.Init() calling AppDomainUnloadListener.Register()
    01/30/2007 12:54:39.57 w3wp.exe (0x0B74) 0x0600 CMS Publishing 8x0a High AppDomainUnloadListener.RegisterSelf() entered lock(this=32347029)
    01/30/2007 12:54:39.57 w3wp.exe (0x0B74) 0x0600 Office Server Session State Service 8z8f Verbose Partition resolver initialized
    01/30/2007 12:54:41.59 w3wp.exe (0x0B74) 0x0600 Windows SharePoint Services General 6t8b Verbose Looking up context site http://dev.mycapco.com:80/_layouts/ExcelRenderer.aspx in the farm SharePoint_Config
    01/30/2007 12:54:41.59 w3wp.exe (0x0B74) 0x0600 Windows SharePoint Services General 6t8d Verbose Looking up the additional information about the typical site http://dev.mycapco.com:80/_layouts/ExcelRenderer.aspx.
    01/30/2007 12:54:41.59 w3wp.exe (0x0B74) 0x0600 Windows SharePoint Services General 6t8f Verbose Site lookup is replacing http://dev.mycapco.com:80/_layouts/ExcelRenderer.aspx with the alternate access url http://dev.mycapco.com.
    01/30/2007 12:54:41.59 w3wp.exe (0x0B74) 0x0600 Windows SharePoint Services General 6t8g Verbose Looking up typical site http://dev.mycapco.com:80/_layouts/ExcelRenderer.aspx in web application SPWebApplication Name=SharePoint - dev.mycapco.com Parent=SPWebService.
    01/30/2007 12:54:41.59 w3wp.exe (0x0B74) 0x0600 Windows SharePoint Services General 6t8h Verbose Found typical site / (3c22eefc-a7f6-470b-8e75-b82abf624a5c) in web application SPWebApplication Name=SharePoint - dev.mycapco.com Parent=SPWebService.
    01/30/2007 12:54:41.91 w3wp.exe (0x0B74) 0x0600 Excel Services Excel Web Access 27ew Verbose EWR is starting
    01/30/2007 12:54:41.91 w3wp.exe (0x0B74) 0x0600 Excel Services Excel Web Access 27ew Verbose EWR is starting
    01/30/2007 12:54:41.92 w3wp.exe (0x0B74) 0x0600 Excel Services Excel Web Access 5cbi Medium InternalEwr.OnInit: Starting loading external EWR
    01/30/2007 12:54:41.93 w3wp.exe (0x0B74) 0x0600 Windows SharePoint Services Database 880l Verbose ConnectionString: 'Data Source=UKLO2K3DENTDB;Initial Catalog=SharePoint_Config;Integrated Security=True;Enlist=False' ConnectionState: Closed ConnectionTimeout: 15
    01/30/2007 12:54:41.93 w3wp.exe (0x0B74) 0x0600 1624 8acb Verbose Reverting to process identity
    01/30/2007 12:54:41.93 w3wp.exe (0x0B74) 0x0600 1624 8acc Verbose Current user before SqlConnection.Open: Name: CAPCO\SERV_SharePoint SID: S-1-5-21-486879912-1543852476-316617838-9409 ImpersonationLevel: None
    01/30/2007 12:54:41.94 w3wp.exe (0x0B74) 0x0600 1624 8acf Verbose Current user after SqlConnection.Open: Name: CAPCO\SERV_SharePoint SID: S-1-5-21-486879912-1543852476-316617838-9409 ImpersonationLevel: None
    01/30/2007 12:54:41.94 w3wp.exe (0x0B74) 0x0600 Windows SharePoint Services Database 880m Verbose SqlCommand: 'dbo.proc_getDependentObjectsByBaseClass' CommandType: StoredProcedure CommandTimeout: 0 Parameter: '@RETURN_VALUE' Type: Int Size: 0 Direction: ReturnValue Value: '' Parameter: '@BaseClassId' Type: UniqueIdentifier Size: 0 Direction: Input Value: '983c4b09-fbc0-4f4b-92bc-42fabf556ed5' Parameter: '@DependeeId' Type: UniqueIdentifier Size: 0 Direction: Input Value: '9b0f7d37-bbab-40d4-abf3-ef513c5d4f86'
    01/30/2007 12:54:41.99 w3wp.exe (0x0B74) 0x0600 Excel Services Excel Services Web Front End 6k38 Medium ExcelServerProxy.ExecuteWebMethod: sending request of type OpenWorkbook, to server=http://uklo2k3dmoss:56737/SharedServices2/ExcelCalculationServer/ExcelService.asmx, session=(null), state id=0
    01/30/2007 12:54:42.22 mssearch.exe (0x0FBC) 0x0D48 Search Server Common Common 0 Verbose Application 3fcb86b8-0efe-4aaa-ac74-a5fda012d11a: The Application root doesn't exist or access denied. - File:d:\office\source\search\search\searchdll\resourcemanagerimpl.cpp Line:698
    01/30/2007 12:54:42.22 mssearch.exe (0x0FBC) 0x0D48 Search Server Common Common 0 Monitorable Application 3fcb86b8-0efe-4aaa-ac74-a5fda012d11a: The parent farm application root doesn't exist or access denied. - File:d:\office\source\search\search\searchdll\resourcemanagerimpl.cpp Line:703
    01/30/2007 12:54:42.22 mssearch.exe (0x0FBC) 0x0D48 Search Server Common Common 0 Monitorable Application 3fcb86b8-0efe-4aaa-ac74-a5fda012d11a: Database session creation error for resource type 0. - File:d:\office\source\search\search\searchdll\resourcemanagerimpl.cpp Line:555
    01/30/2007 12:54:42.22 mssearch.exe (0x0FBC) 0x0D48 Search Server Common Exceptions 0 Monitorable <Exception><HR>0xc0041228</HR><eip>0070C870</eip><module>d:\office\source\search\ytrip\tripoli\scopes\database.cxx</module><line>316</line></Exception>
    01/30/2007 12:54:42.81 w3wp.exe (0x0B74) 0x0600 Excel Services Excel Services Web Front End 6k3i Medium ExcelServerProxy.ProcessWebException: A Web exception during ExecuteWebMethod has occurred for server: http://uklo2k3dmoss:56737/SharedServices2/ExcelCalculationServer/ExcelService.asmx, method: OpenWorkbook, ex: System.Net.WebException: The request failed with HTTP status 401: Unauthorized. at System.Web.Services.Protocols.SoapHttpClientProtocol.ReadResponse(SoapClientMessage message, WebResponse response, Stream responseStream, Boolean asyncCall) at System.Web.Services.Protocols.SoapHttpClientProtocol.Invoke(String methodName, Object[] parameters) at Microsoft.Office.Excel.Server.CalculationServer.Proxy.ExcelServiceSoap.OpenWorkbook(String url, CommandParameter parameter, CultureCommandParameter cultureParameter, Guid requestSiteId, String& workbookId, Boolean& hasOpenItemPer...
    01/30/2007 12:54:42.81* w3wp.exe (0x0B74) 0x0600 Excel Services Excel Services Web Front End 6k3i Medium ...mission) at Microsoft.Office.Excel.Server.CalculationServer.Proxy.ExcelServerProxy.<>c__DisplayClass1.<OpenWorkbook>b__0(CommandParameter parameterDelegate, ExcelServiceSoap excelService) at Microsoft.Office.Excel.Server.CalculationServer.Proxy.ExcelServerProxy.ExecuteWithSecurityContext(Boolean revertToSelf, CoreWebMethod coreWebMethod, ExcelServiceSoap excelService, CommandParameter parameter) at Microsoft.Office.Excel.Server.CalculationServer.Proxy.ExcelServerProxy.ExecuteWebMethod(WebMethodType webMethodType, PreProcessWebMethod preProcessWebMethod, CoreWebMethod coreWebMethod, Boolean& noServerResponse), response: 'System.Net.HttpWebResponse', status ProtocolError, user name: CAPCO\jtnn.
    01/30/2007 12:54:42.81 w3wp.exe (0x0B74) 0x0600 Excel Services Excel Services Web Front End 3skf Critical There was an error in communicating with Excel Calculation Services http://uklo2k3dmoss:56737/SharedServices2/ExcelCalculationServer/ExcelService.asmx exception: The request failed with HTTP status 401: Unauthorized. [Session: (null) User: CAPCO\jtnn].
    01/30/2007 12:54:42.82 w3wp.exe (0x0B74) 0x0600 Excel Services Excel Web Access 5cbj Medium InternalEwr.RenderWebPart: Finished rendering internal EWR
    01/30/2007 12:54:42.82 w3wp.exe (0x0B74) 0x0600 Windows SharePoint Services General 0 Verbose Releasing SPRequest with allocation Id {9E088BB6-DFAD-4078-A51E-87BD1FCC5D87}
    01/30/2007 12:54:42.82 w3wp.exe (0x0B74) 0x0600 Windows SharePoint Services General 0 Verbose Releasing SPRequest with allocation Id {5C2ACCC4-77BB-4174-BB01-D9D0BDAED9B7}
    01/30/2007 12:54:44.48 OWSTIMER.EXE (0x0D4C) 0x0ED0 Windows SharePoint Services Topology 88b9 Verbose Determining if the current user is a SharePoint Farm Administrator
    01/30/2007 12:54:44.48 OWSTIMER.EXE (0x0D4C) 0x0D50 Windows SharePoint Services Timer 5utp Verbose Scheduled timer job Indexing Schedule Manager on UKLO2K3DMOSS, id {92EF6AC3-5061-4A59-9167-ADFD6E80F229} at 30 Jan 2007 12:55:44 -0000 (now is 30 Jan 2007 12:54:44 -0000)
    01/30/2007 12:54:44.48 OWSTIMER.EXE (0x0D4C) 0x01BC Windows SharePoint Services Topology 88b9 Verbose Determining if the current user is a SharePoint Farm Administrator
    01/30/2007 12:54:44.49 OWSTIMER.EXE (0x0D4C) 0x0D50 Windows SharePoint Services Timer 5utp Verbose Scheduled timer job Variations Propagate Page Job Definition, id {CCDE3A11-3E6C-4BB2-8DF7-E608F3E8773A} at 30 Jan 2007 12:55:44 -0000 (now is 30 Jan 2007 12:54:44 -0000)
    01/30/2007 12:54:44.52 OWSTIMER.EXE (0x0D4C) 0x0ED0 Windows SharePoint Services Timer 8e45 Verbose Begin invoke timer job Indexing Schedule Manager on UKLO2K3DMOSS, id {92EF6AC3-5061-4A59-9167-ADFD6E80F229}, DB n/a
    01/30/2007 12:54:44.52 OWSTIMER.EXE (0x0D4C) 0x0ED0 Office Server Office Server Shared Services 6pll Verbose Cache miss for shared object '1dd1db1d-8a07-4e27-9249-b7d328818fa2' of type 'Microsoft.Office.Server.Search.Administration.SearchSharedApplication'.
    01/30/2007 12:54:44.52 OWSTIMER.EXE (0x0D4C) 0x0ED0 484 880l Verbose ConnectionString: 'Server=UKLO2K3DENTDB;Database=SharedServices2_DB;Trusted_Connection=yes;App=Windows SharePoint Services;Timeout=15' ConnectionState: Closed ConnectionTimeout: 15
    01/30/2007 12:54:44.52 OWSTIMER.EXE (0x0D4C) 0x0ED0 1624 8acb Verbose Reverting to process identity
    01/30/2007 12:54:44.52 OWSTIMER.EXE (0x0D4C) 0x0ED0 1624 8acc Verbose Current user before SqlConnection.Open: Name: CAPCO\SERV_SharePoint SID: S-1-5-21-486879912-1543852476-316617838-9409 ImpersonationLevel: None
    01/30/2007 12:54:44.53 OWSTIMER.EXE (0x0D4C) 0x0ED0 1624 8acf Verbose Current user after SqlConnection.Open: Name: CAPCO\SERV_SharePoint SID: S-1-5-21-486879912-1543852476-316617838-9409 ImpersonationLevel: None
    01/30/2007 12:54:44.53 OWSTIMER.EXE (0x0D4C) 0x0ED0 484 880m Verbose SqlCommand: 'dbo.proc_MIP_GetObject' CommandType: StoredProcedure CommandTimeout: 0 Parameter: '@RETURN_VALUE' Type: Int Size: 0 Direction: ReturnValue Value: '' Parameter: '@ObjectId' Type: UniqueIdentifier Size: 0 Direction: Input Value: '1dd1db1d-8a07-4e27-9249-b7d328818fa2'
    01/30/2007 12:54:44.57 OWSTIMER.EXE (0x0D4C) 0x0ED0 Office Server Office Server Shared Services 6plp Verbose Retrieved shared object '1dd1db1d-8a07-4e27-9249-b7d328818fa2' of type 'Microsoft.Office.Server.Search.Administration.SearchSharedApplication'.
    01/30/2007 12:54:44.57 OWSTIMER.EXE (0x0D4C) 0x0ED0 Office Server Office Server Shared Services 6plq Verbose Cached shared object '1dd1db1d-8a07-4e27-9249-b7d328818fa2' of type 'Microsoft.Office.Server.Search.Administration.SearchSharedApplication'.
    01/30/2007 12:54:44.59 OWSTIMER.EXE (0x0D4C) 0x0ED0 Office Server Office Server Shared Services 6pll Verbose Cache miss for shared object '1dd1db1d-8a07-4e27-9249-b7d328818fa2' of type 'Microsoft.Office.Server.Search.Administration.SearchSharedApplication'.
    01/30/2007 12:54:44.59 OWSTIMER.EXE (0x0D4C) 0x0ED0 484 880l Verbose ConnectionString: 'Server=UKLO2K3DENTDB;Database=SharedServices2_DB;Trusted_Connection=yes;App=Windows SharePoint Services;Timeout=15' ConnectionState: Closed ConnectionTimeout: 15
    01/30/2007 12:54:44.59 OWSTIMER.EXE (0x0D4C) 0x0ED0 1624 8acb Verbose Reverting to process identity
    01/30/2007 12:54:44.60 OWSTIMER.EXE (0x0D4C) 0x0ED0 1624 8acc Verbose Current user before SqlConnection.Open: Name: CAPCO\SERV_SharePoint SID: S-1-5-21-486879912-1543852476-316617838-9409 ImpersonationLevel: None
    01/30/2007 12:54:44.60 OWSTIMER.EXE (0x0D4C) 0x0ED0 1624 8acf Verbose Current user after SqlConnection.Open: Name: CAPCO\SERV_SharePoint SID: S-1-5-21-486879912-1543852476-316617838-9409 ImpersonationLevel: None
    01/30/2007 12:54:44.60 OWSTIMER.EXE (0x0D4C) 0x0ED0 484 880m Verbose SqlCommand: 'dbo.proc_MIP_GetObject' CommandType: StoredProcedure CommandTimeout: 0 Parameter: '@RETURN_VALUE' Type: Int Size: 0 Direction: ReturnValue Value: '' Parameter: '@ObjectId' Type: UniqueIdentifier Size: 0 Direction: Input Value: '1dd1db1d-8a07-4e27-9249-b7d328818fa2'
    01/30/2007 12:54:44.60 OWSTIMER.EXE (0x0D4C) 0x01BC Windows SharePoint Services Timer 8e45 Verbose Begin invoke timer job Variations Propagate Page Job Definition, id {CCDE3A11-3E6C-4BB2-8DF7-E608F3E8773A}, DB {09ED42AD-61FA-460A-AF2E-C0F0A2F4D7A8}
    01/30/2007 12:54:44.60 OWSTIMER.EXE (0x0D4C) 0x01BC Windows SharePoint Services Database 880l Verbose ConnectionString: 'Data Source=UKLO2K3DENTDB;Initial Catalog=WSS_Content;Integrated Security=True;Enlist=False;Connect Timeout=15' ConnectionState: Closed ConnectionTimeout: 15
    01/30/2007 12:54:44.60 OWSTIMER.EXE (0x0D4C) 0x01BC 1624 8acb Verbose Reverting to process identity
    01/30/2007 12:54:44.60 OWSTIMER.EXE (0x0D4C) 0x01BC 1624 8acc Verbose Current user before SqlConnection.Open: Name: CAPCO\SERV_SharePoint SID: S-1-5-21-486879912-1543852476-316617838-9409 ImpersonationLevel: None
    01/30/2007 12:54:44.61 OWSTIMER.EXE (0x0D4C) 0x01BC 1624 8acf Verbose Current user after SqlConnection.Open: Name: CAPCO\SERV_SharePoint SID: S-1-5-21-486879912-1543852476-316617838-9409 ImpersonationLevel: None
    01/30/2007 12:54:44.61 OWSTIMER.EXE (0x0D4C) 0x01BC Windows SharePoint Services Database 880m Verbose SqlCommand: 'dbo.proc_GetRunnableWorkItems' CommandType: StoredProcedure CommandTimeout: 0 Parameter: '@RETURN_VALUE' Type: Int Size: 0 Direction: ReturnValue Value: '' Parameter: '@ProcessingId' Type: UniqueIdentifier Size: 0 Direction: Input Value: 'ebb65ebe-5756-4889-9a13-0ec439781ff5' Parameter: '@SiteId' Type: NVarChar Size: 0 Direction: Input Value: '' Parameter: '@WorkItemType' Type: UniqueIdentifier Size: 0 Direction: Input Value: 'ea95ab64-3857-4403-96d0-3aeb3dbdb123' Parameter: '@BatchId' Type: NVarChar Size: 0 Direction: Input Value: '' Parameter: '@MaxFetchSize' Type: Int Size: 0 Direction: Input Value: '100' Parameter: '@ThrottleThreshold' Type: Int Size: 0 Direction: Input Value: '0'
    01/30/2007 12:54:44.61 OWSTIMER.EXE (0x0D4C) 0x0ED0 Office Server Office Server Shared Services 6plp Verbose Retrieved shared object '1dd1db1d-8a07-4e27-9249-b7d328818fa2' of type 'Microsoft.Office.Server.Search.Administration.SearchSharedApplication'.
    01/30/2007 12:54:44.61 OWSTIMER.EXE (0x0D4C) 0x0ED0 Office Server Office Server Shared Services 6plq Verbose Cached shared object '1dd1db1d-8a07-4e27-9249-b7d328818fa2' of type 'Microsoft.Office.Server.Search.Administration.SearchSharedApplication'.
    01/30/2007 12:54:44.61 OWSTIMER.EXE (0x0D4C) 0x0ED0 Search Server Common MS Search Administration 7pht Verbose IsConfigurationOnline: SSP 'SharedServices2' status is 'Online'. SSP database status is 'Online'.
    01/30/2007 12:54:44.65 OWSTIMER.EXE (0x0D4C) 0x01BC Windows SharePoint Services Timer 8e46 Verbose End invoke timer job Variations Propagate Page Job Definition, id {CCDE3A11-3E6C-4BB2-8DF7-E608F3E8773A}, DB {09ED42AD-61FA-460A-AF2E-C0F0A2F4D7A8}
    01/30/2007 12:54:44.81 mssearch.exe (0x0FBC) 0x0814 Search Server Common GatherSvc 0 Medium CGatherApplication::CGatherApplication::GetRole - What is the role of this server - File:d:\office\source\search\search\gather\gthrsvc\gthrapp.cxx Line:730
    01/30/2007 12:54:44.81 mssearch.exe (0x0FBC) 0x0814 Search Server Common GatherSvc 0 Medium CGatherApplication::CGatherApplication::GetRole - The role of this server is 3 - File:d:\office\source\search\search\gather\gthrsvc\gthrapp.cxx Line:752
    01/30/2007 12:54:44.97 OWSTIMER.EXE (0x0D4C) 0x0ED0 Windows SharePoint Services Timer 8e46 Verbose End invoke timer job Indexing Schedule Manager on UKLO2K3DMOSS, id {92EF6AC3-5061-4A59-9167-ADFD6E80F229}, DB n/a
    01/30/2007 12:54:45.49 OWSTIMER.EXE (0x0D4C) 0x0FC8 Windows SharePoint Services Topology 88b9 Verbose Determining if the current user is a SharePoint Farm Administrator
    01/30/2007 12:54:45.50 OWSTIMER.EXE (0x0D4C) 0x0D50 Windows SharePoint Services Timer 5utp Verbose Scheduled timer job Config Refresh, id {7DFEDB1B-EF70-4CC0-BD2F-A9A384C36200} at 30 Jan 2007 12:55:00 -0000 (now is 30 Jan 2007 12:54:45 -0000)
    01/30/2007 12:54:45.50 OWSTIMER.EXE (0x0D4C) 0x0FC8 Windows SharePoint Services Timer 8e45 Verbose Begin invoke timer job Config Refresh, id {7DFEDB1B-EF70-4CC0-BD2F-A9A384C36200}, DB n/a
    01/30/2007 12:54:45.51 OWSTIMER.EXE (0x0D4C) 0x0FC8 Windows SharePoint Services Database 880l Verbose ConnectionString: 'Data Source=UKLO2K3DENTDB;Initial Catalog=SharePoint_Config;Integrated Security=True;Enlist=False' ConnectionState: Closed ConnectionTimeout: 15
    01/30/2007 12:54:45.51 OWSTIMER.EXE (0x0D4C) 0x0FC8 1624 8acb Verbose Reverting to process identity
    01/30/2007 12:54:45.51 OWSTIMER.EXE (0x0D4C) 0x0FC8 1624 8acc Verbose Current user before SqlConnection.Open: Name: CAPCO\SERV_SharePoint SID: S-1-5-21-486879912-1543852476-316617838-9409 ImpersonationLevel: None
    01/30/2007 12:54:45.51 OWSTIMER.EXE (0x0D4C) 0x0FC8 1624 8acf Verbose Current user after SqlConnection.Open: Name: CAPCO\SERV_SharePoint SID: S-1-5-21-486879912-1543852476-316617838-9409 ImpersonationLevel: None
    01/30/2007 12:54:45.51 OWSTIMER.EXE (0x0D4C) 0x0FC8 Windows SharePoint Services Database 880m Verbose SqlCommand: 'dbo.proc_getNewObjects' CommandType: StoredProcedure CommandTimeout: 0 Parameter: '@RETURN_VALUE' Type: Int Size: 0 Direction: ReturnValue Value: '' Parameter: '@NewestCachedVersion' Type: BigInt Size: 0 Direction: Input Value: '4746'
    01/30/2007 12:54:45.52 OWSTIMER.EXE (0x0D4C) 0x0FC8 Windows SharePoint Services Timer 8e46 Verbose End invoke timer job Config Refresh, id {7DFEDB1B-EF70-4CC0-BD2F-A9A384C36200}, DB n/a
    01/30/2007 12:54:46.00 mssearch.exe (0x0FBC) 0x0D48 Search Server Common Common 0 Verbose Application 3fcb86b8-0efe-4aaa-ac74-a5fda012d11a: The Application root doesn't exist or access denied. - File:d:\office\source\search\search\searchdll\resourcemanagerimpl.cpp Line:698
    01/30/2007 12:54:46.00 mssearch.exe (0x0FBC) 0x0D48 Search Server Common Common 0 Monitorable Application 3fcb86b8-0efe-4aaa-ac74-a5fda012d11a: The parent farm application root doesn't exist or access denied. - File:d:\office\source\search\search\searchdll\resourcemanagerimpl.cpp Line:703
    01/30/2007 12:54:46.00 mssearch.exe (0x0FBC) 0x0D48 Search Server Common Common 0 Monitorable Application 3fcb86b8-0efe-4aaa-ac74-a5fda012d11a: Database session creation error for resource type 0. - File:d:\office\source\search\search\searchdll\resourcemanagerimpl.cpp Line:555
    01/30/2007 12:54:46.00 mssearch.exe (0x0FBC) 0x0D48 Search Server Common GatherPI 0 Monitorable SearchDB GetSession failed application 3fcb86b8-0efe-4aaa-ac74-a5fda012d11a Error is 0xc0041228 or Session pointer is null - File:d:\office\source\search\search\gather\gthrsvc\srchschema.cxx Line:3334
    01/30/2007 12:54:46.00 mssearch.exe (0x0FBC) 0x0D48 Search Server Common Common 0 Verbose Application 3fcb86b8-0efe-4aaa-ac74-a5fda012d11a: The Application root doesn't exist or access denied. - File:d:\office\source\search\search\searchdll\resourcemanagerimpl.cpp Line:698
    01/30/2007 12:54:46.00 mssearch.exe (0x0FBC) 0x0D48 Search Server Common Common 0 Monitorable Application 3fcb86b8-0efe-4aaa-ac74-a5fda012d11a: The parent farm application root doesn't exist or access denied. - File:d:\office\source\search\search\searchdll\resourcemanagerimpl.cpp Line:703
    01/30/2007 12:54:46.00 mssearch.exe (0x0FBC) 0x0D48 Search Server Common Common 0 Monitorable Application 3fcb86b8-0efe-4aaa-ac74-a5fda012d11a: Database session creation error for resource type 0. - File:d:\office\source\search\search\searchdll\resourcemanagerimpl.cpp Line:555
    01/30/2007 12:54:46.00 mssearch.exe (0x0FBC) 0x0D48 Search Server Common GatherPI 0 Monitorable SearchDB GetSession failed application 3fcb86b8-0efe-4aaa-ac74-a5fda012d11a Error is 0xc0041228 or Session pointer is null - File:d:\office\source\search\search\gather\gthrsvc\srchschema.cxx Line:3348
    01/30/2007 12:54:46.00 mssearch.exe (0x0FBC) 0x0D48 Search Server Common Common 0 Verbose Application 3fcb86b8-0efe-4aaa-ac74-a5fda012d11a: The Application root doesn't exist or access denied. - File:d:\office\source\search\search\searchdll\resourcemanagerimpl.cpp Line:698
    01/30/2007 12:54:46.00 mssearch.exe (0x0FBC) 0x0D48 Search Server Common Common 0 Monitorable Application 3fcb86b8-0efe-4aaa-ac74-a5fda012d11a: The parent farm application root doesn't exist or access denied. - File:d:\office\source\search\search\searchdll\resourcemanagerimpl.cpp Line:703
    01/30/2007 12:54:46.00 mssearch.exe (0x0FBC) 0x0D48 Search Server Common Common 0 Monitorable Application 3fcb86b8-0efe-4aaa-ac74-a5fda012d11a: Database session creation error for resource type 0. - File:d:\office\source\search\search\searchdll\resourcemanagerimpl.cpp Line:555
    01/30/2007 12:54:46.00 mssearch.exe (0x0FBC) 0x0D48 Search Server Common GatherPI 0 Monitorable SearchDB GetSession failed application 3fcb86b8-0efe-4aaa-ac74-a5fda012d11a Error is 0xc0041228 or Session pointer is null - File:d:\office\source\search\search\gather\gthrsvc\srchschema.cxx Line:3348
    01/30/2007 12:54:46.00 mssearch.exe (0x0FBC) 0x0D48 Search Server Common GatherPI 0 Monitorable SearchDB Re-initializing DataSource application 3fcb86b8-0efe-4aaa-ac74-a5fda012d11a - File:d:\office\source\search\search\gather\gthrsvc\srchschema.cxx Line:3359
    01/30/2007 12:54:46.00 mssearch.exe (0x0FBC) 0x0D48 Search Server Common Common 0 Verbose Application 3fcb86b8-0efe-4aaa-ac74-a5fda012d11a: The Application root doesn't exist or access denied. - File:d:\office\source\search\search\searchdll\resourcemanagerimpl.cpp Line:698
    01/30/2007 12:54:46.00 mssearch.exe (0x0FBC) 0x0D48 Search Server Common Common 0 Monitorable Application 3fcb86b8-0efe-4aaa-ac74-a5fda012d11a: The parent farm application root doesn't exist or access denied. - File:d:\office\source\search\search\searchdll\resourcemanagerimpl.cpp Line:703
    01/30/2007 12:54:46.00 mssearch.exe (0x0FBC) 0x0D48 Search Server Common Common 0 Monitorable Application 3fcb86b8-0efe-4aaa-ac74-a5fda012d11a: Database session creation error for resource type 0. - File:d:\office\source\search\search\searchdll\resourcemanagerimpl.cpp Line:555
    01/30/2007 12:54:46.00 mssearch.exe (0x0FBC) 0x0D48 Search Server Common GatherPI 0 Monitorable SearchDB GetSession failed application 3fcb86b8-0efe-4aaa-ac74-a5fda012d11a Error is 0xc0041228 or Session pointer is null - File:d:\office\source\search\search\gather\gthrsvc\srchschema.cxx Line:3348
    01/30/2007 12:54:46.00 mssearch.exe (0x0FBC) 0x0D48 Search Server Common Common 0 Verbose Application 3fcb86b8-0efe-4aaa-ac74-a5fda012d11a: The Application root doesn't exist or access denied. - File:d:\office\source\search\search\searchdll\resourcemanagerimpl.cpp Line:698
    01/30/2007 12:54:46.00 mssearch.exe (0x0FBC) 0x0D48 Search Server Common Common 0 Monitorable Application 3fcb86b8-0efe-4aaa-ac74-a5fda012d11a: The parent farm application root doesn't exist or access denied. - File:d:\office\source\search\search\searchdll\resourcemanagerimpl.cpp Line:703
    01/30/2007 12:54:46.00 mssearch.exe (0x0FBC) 0x0D48 Search Server Common Common 0 Monitorable Application 3fcb86b8-0efe-4aaa-ac74-a5fda012d11a: Database session creation error for resource type 0. - File:d:\office\source\search\search\searchdll\resourcemanagerimpl.cpp Line:555
    01/30/2007 12:54:46.00 mssearch.exe (0x0FBC) 0x0D48 Search Server Common GatherPI 0 Monitorable SearchDB GetSession failed application 3fcb86b8-0efe-4aaa-ac74-a5fda012d11a Error is 0xc0041228 or Session pointer is null - File:d:\office\source\search\search\gather\gthrsvc\srchschema.cxx Line:3348
    01/30/2007 12:54:46.00 mssearch.exe (0x0FBC) 0x0D48 Search Server Common GatherPI 0 Monitorable SearchDB Re-initializing DataSource application 3fcb86b8-0efe-4aaa-ac74-a5fda012d11a - File:d:\office\source\search\search\gather\gthrsvc\srchschema.cxx Line:3359
    01/30/2007 12:54:46.00 mssearch.exe (0x0FBC) 0x0D48 Search Server Common Common 0 Verbose Application 3fcb86b8-0efe-4aaa-ac74-a5fda012d11a: The Application root doesn't exist or access denied. - File:d:\office\source\search\search\searchdll\resourcemanagerimpl.cpp Line:698
    01/30/2007 12:54:46.00 mssearch.exe (0x0FBC) 0x0D48 Search Server Common Common 0 Monitorable Application 3fcb86b8-0efe-4aaa-ac74-a5fda012d11a: The parent farm application root doesn't exist or access denied. - File:d:\office\source\search\search\searchdll\resourcemanagerimpl.cpp Line:703
    01/30/2007 12:54:46.00 mssearch.exe (0x0FBC) 0x0D48 Search Server Common Common 0 Monitorable Application 3fcb86b8-0efe-4aaa-ac74-a5fda012d11a: Database session creation error for resource type 0. - File:d:\office\source\search\search\searchdll\resourcemanagerimpl.cpp Line:555
    01/30/2007 12:54:46.00 mssearch.exe (0x0FBC) 0x0D48 Search Server Common GatherPI 0 Monitorable SearchDB GetSession failed application 3fcb86b8-0efe-4aaa-ac74-a5fda012d11a Error is 0xc0041228 or Session pointer is null - File:d:\office\source\search\search\gather\gthrsvc\srchschema.cxx Line:3376
    01/30/2007 12:54:46.00 mssearch.exe (0x0FBC) 0x0D48 Search Server Common GathererSql 0 Monitorable GetManagedPropertyAliases: Failed in GetSession, Error is 0xc0041228 - File:d:\office\source\search\search\gather\gthrsvc\srchschema.cxx Line:2993
    01/30/2007 12:54:46.00 mssearch.exe (0x0FBC) 0x0D48 Search Server Common Exceptions 0 Monitorable <Exception><HR>0xc0041228</HR><eip>6007AB74</eip><module>d:\office\source\search\search\gather\gthrsvc\srchschema.cxx</module><line>2994</line></Exception>
    01/30/2007 12:54:47.34 mssearch.exe (0x0FBC) 0x0D48 Search Server Common Common 0 Verbose Application 3fcb86b8-0efe-4aaa-ac74-a5fda012d11a: The Application root doesn't exist or access denied. - File:d:\office\source\search\search\searchdll\resourcemanagerimpl.cpp Line:698
    01/30/2007 12:54:47.34 mssearch.exe (0x0FBC) 0x0D48 Search Server Common Common 0 Monitorable Application 3fcb86b8-0efe-4aaa-ac74-a5fda012d11a: The parent farm application root doesn't exist or access denied. - File:d:\office\source\search\search\searchdll\resourcemanagerimpl.cpp Line:703
    01/30/2007 12:54:47.34 mssearch.exe (0x0FBC) 0x0D48 Search Server Common Common 0 Monitorable Application 3fcb86b8-0efe-4aaa-ac74-a5fda012d11a: Database session creation error for resource type 0. - File:d:\office\source\search\search\searchdll\resourcemanagerimpl.cpp Line:555
    01/30/2007 12:54:47.34 mssearch.exe (0x0FBC) 0x0D48 Search Server Common Exceptions 0 Monitorable <Exception><HR>0xc0041228</HR><eip>0070C870</eip><module>d:\office\source\search\ytrip\tripoli\scopes\database.cxx</module><line>316</line></Exception>



  • Musafir

    Did you check the two points Ira mentioned That Kerberos Authentication succeeded and that the web.config contains the snippet he included

  • m0nkeyforce

    Hey John,

    Any luck Did you get a chance to check Ira's post



  • SrinivasanN

    Here is a shorter and perhaps more pertinent log file:

    01/30/2007 13:58:32.93 w3wp.exe (0x0AB0) 0x0D24 484 880m Verbose SqlCommand: 'dbo.proc_MIP_GetObjectUpdates' CommandType: StoredProcedure CommandTimeout: 0 Parameter: '@RETURN_VALUE' Type: Int Size: 0 Direction: ReturnValue Value: '' Parameter: '@Version' Type: BigInt Size: 0 Direction: Input Value: '50' Parameter: '@CurrentVersion' Type: BigInt Size: 0 Direction: Output Value: ''
    01/30/2007 13:58:33.06 w3wp.exe (0x0E78) 0x0C60 Excel Services Excel Services Web Front End 6k3i Medium ExcelServerProxy.ProcessWebException: A Web exception during ExecuteWebMethod has occurred for server: http://uklo2k3dmoss:56737/SharedServices3/ExcelCalculationServer/ExcelService.asmx, method: OpenWorkbook, ex: System.Net.WebException: The request failed with HTTP status 401: Unauthorized. at System.Web.Services.Protocols.SoapHttpClientProtocol.ReadResponse(SoapClientMessage message, WebResponse response, Stream responseStream, Boolean asyncCall) at System.Web.Services.Protocols.SoapHttpClientProtocol.Invoke(String methodName, Object[] parameters) at Microsoft.Office.Excel.Server.CalculationServer.Proxy.ExcelServiceSoap.OpenWorkbook(String url, CommandParameter parameter, CultureCommandParameter cultureParameter, Guid requestSiteId, String& workbookId, Boolean& hasOpenItemPer...
    01/30/2007 13:58:33.06* w3wp.exe (0x0E78) 0x0C60 Excel Services Excel Services Web Front End 6k3i Medium ...mission) at Microsoft.Office.Excel.Server.CalculationServer.Proxy.ExcelServerProxy.<>c__DisplayClass1.<OpenWorkbook>b__0(CommandParameter parameterDelegate, ExcelServiceSoap excelService) at Microsoft.Office.Excel.Server.CalculationServer.Proxy.ExcelServerProxy.ExecuteWithSecurityContext(Boolean revertToSelf, CoreWebMethod coreWebMethod, ExcelServiceSoap excelService, CommandParameter parameter) at Microsoft.Office.Excel.Server.CalculationServer.Proxy.ExcelServerProxy.ExecuteWebMethod(WebMethodType webMethodType, PreProcessWebMethod preProcessWebMethod, CoreWebMethod coreWebMethod, Boolean& noServerResponse), response: 'System.Net.HttpWebResponse', status ProtocolError, user name: CAPCO\jtnn.
    01/30/2007 13:58:33.06 w3wp.exe (0x0E78) 0x0C60 Excel Services Excel Services Web Front End 3skf Critical There was an error in communicating with Excel Calculation Services http://uklo2k3dmoss:56737/SharedServices3/ExcelCalculationServer/ExcelService.asmx exception: The request failed with HTTP status 401: Unauthorized. [Session: (null) User: CAPCO\jtnn].
    01/30/2007 13:58:33.07 w3wp.exe (0x0E78) 0x0C60 Excel Services Excel Web Access 5cbj Medium InternalEwr.RenderWebPart: Finished rendering internal EWR
    01/30/2007 13:58:33.07 w3wp.exe (0x0E78) 0x0C60 Windows SharePoint Services General 0 Verbose Releasing SPRequest with allocation Id {9A206831-733E-46B9-AC6C-DF616C0A9B30}
    01/30/2007 13:58:33.07 w3wp.exe (0x0E78) 0x0C60 Windows SharePoint Services General 0 Verbose Releasing SPRequest with allocation Id {DF72425B-35BD-4CC5-8C9B-898EB8E2FB79}



  • mallakishore

    Thanks for the detailed info!

    Could you post a snippet of your logs at the exact moment (a few minutes before and after will help as well) you are loading a workbook and receive this error message

    You can find them under:

    <system drive>\Program Files\Common Files\Microsoft Shared\Web Server Extensions\12\LOGS

    This should help us figure out why the workbook is giving you this error.



  • baswegan2

    From your description of the topology, I assume you're trying to use kerberos delegation for communicating in the farm.

    To set Excel Services to delegation please run:

    stsadm -o set-ecssecurity -accessmodel delegation -ssp sharedservices1

    If the timer service isn't running on the Shared Services machine please, run the following on that machine:

    stsadm -o execadmsvcjobs

    Last, do iisreset for both the web front end and shared services machines.

    Then check See if that solves the issue.


  • Error in communicating with Excel Calculation Services