locked
TFS 2017 issue (create project) RRS feed

  • 問題

  • 最近我們改安裝 VS2017 + TFS2017 update1, 進行程式碼控管, 目前遇到一個問題,

    我在 Team Foundation Server Express Administration console 開了幾個不同的專案集合給各 owner,

    owner透過 web 方式建立各個專案

    它們建立 project 會顯示正在建立” , 這個 status 會維持到 幾個小時或超過 2 天以上 , web可能失敗 (如下圖所示)

    我想請教, 有關建立專案與刪除專案,

    1. 要如何順利建立與刪除?
    2. 操作時間如何改善順暢?

    PS: 透過VS 2017 對已經建立在 TFS2017 的專案上, check-in / check-out code 是很順暢的.

    2017年8月22日 上午 09:55

所有回覆

  • 我用VS2017(Lastest)搭配TFS2017 Update1(非Express版), 瀏覽器用IE11, 系統為WIN10, DB為SQL Server, 不會發生很慢的問題, 用VS2017建立Team專案也會很慢嗎?
    2017年8月23日 上午 01:34
  • 我給幾個 Team Foundation Server Express Adminstration 幾個專案集合內, Create Porject 的 log

    分別為 Case 1: Create 失敗, Case 2: Create 成功時間 1hr, 50 min, 請確認 Importing work item types, 我看過正常的 log, 這個動作可以很順利完成, 整體建立時間可以到 4sec, 但是這兩個 case 的 log . Importing work item types 都有些問題.

    Case 1: Create 失敗

    ====================================================================
    Collection name : SW_RD_Ctr-SW_RD_Div1-ACC_SW_RD_Dep
    Operation class : CreateProject
    Time Zone       : Taipei Standard Time
    Queue time      : 08/24/2017 14:10:34
    Start time      : 08/24/2017 14:10:35
    ====================================================================
    [13:42:31.500]   Creating dictionary with 2 initial items:
    [13:42:31.500]    CollectionProperties => Value: 92bc66ac-6db9-40c9-bbae-f033fa1f1662 (SW_RD_Ctr-SW_RD_Div1-ACC_SW_RD_Dep)
    [13:42:31.500]    RequestingIdentity => Value: System.Security.Principal.WindowsIdentity;S-1-5-21-1540110904-195728068-3330098977-1335
    [13:42:31.500]   Acquiring servicing job lock 'Servicing-92bc66ac-6db9-40c9-bbae-f033fa1f1662'
    [13:42:31.507]   Setting token. Key: JobId. Value: 38ee7ccc-d405-41bb-a168-cbf23b1cc0b9.
    [13:42:31.570]   OperationClass: CreateProject
    [13:42:31.570]   Framework connection string was not found in servicing items
    [13:42:31.570]   Setting item. Key: ConnectionInfo. Value: Data Source=TP-TFS2012-V01;Initial Catalog=Tfs_SW_RD_Ctr-SW_RD_Div1-ACC_SW_RD_Dep;Integrated Security=True.
    [13:42:31.570]   Dbo connection string was not found in servicing items
    [13:42:31.570]   Setting item. Key: DboConnectionInfo. Value: Data Source=TP-TFS2012-V01;Initial Catalog=Tfs_SW_RD_Ctr-SW_RD_Div1-ACC_SW_RD_Dep;Integrated Security=True.
    [13:42:31.570]   Setting token. Key: OnlineUpdate. Value: true.
    [13:42:31.570]   Registering the servicing job as running.
    [13:42:31.687]   Registered the job.
    [13:42:31.687]   onlineUpdate: False
    [13:42:31.687]   Setting item. Key: HostedDeployment. Value: False.
    [13:42:31.780]   Adding item. Key: ProcessTemplate. Value: Microsoft.TeamFoundation.Server.Core.TeamFoundationProcessService+LegacyProcessPackage.
    [13:42:31.783]   Adding item. Key: PluginTaskXml. Value: System.Collections.Generic.Dictionary`2[System.String,System.String].
    [13:42:31.857] +++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++
    [13:42:31.857] ++ Executing - Operation: ProjectCreate, Group: ProjectCreate.TfsFramework
    [13:42:31.857] +++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++
    [13:42:31.857] Executing step: Ensure Team Project Tokens
    [13:42:31.857]   Executing step: 'Ensure Team Project Tokens' Framework.EnsureTeamProjectTokens (1 of 12)
    [13:42:31.857]   Begin EnsureTeamProjectTokens.
    [13:42:31.857]   Setting token. Key: ProjectUri. Value: vstfs:///Classification/TeamProject/2ab90d7d-391e-4972-9978-d8eab045ced3.
    [13:42:31.857]   Setting item. Key: RequestingUserContext. Value: Request Context Details
    [13:42:31.857]       Url:
    [13:42:31.857]       Method:
    [13:42:31.857]       Parameters:
    [13:42:31.857]       Activity Id: 6c656ef8-613f-499b-9ca0-9fae545f1589
    [13:42:31.857]       Type: Microsoft.TeamFoundation.Framework.Server.DefaultRequestContext
    [13:42:31.857]       User Name:
    [13:42:31.857]       User Agent:
    [13:42:31.857]       Unique Id: 00000000-0000-0000-0000-000000000000.
    [13:42:31.857] Step passed: Ensure Team Project Tokens. Execution time: 1 millisecond.
    [13:42:31.857]   [StepDuration] 0.0004517
    [13:42:31.857] +++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++
    [13:42:31.857] Executing step: Create the Team Project
    [13:42:31.857]   Executing step: 'Create the Team Project' Framework.CreateTeamProject (2 of 12)
    [13:42:36.220] Step passed: Create the Team Project. Execution time: 4 seconds.
    [13:42:36.220]   [StepDuration] 4.3633701
    [13:42:36.247]   [GroupDuration] 4.4625336
    [13:42:36.247] +++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++
    [13:42:36.247] ++ Executing - Operation: ProjectCreate, Group: ProjectCreate.TfsIntegration
    [13:42:36.247] +++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++
    [13:42:36.247] Executing step: Create the Team Project
    [13:42:36.247]   Executing step: 'Create the Team Project' Integration.CreateTeamProject (3 of 12)
    [13:42:44.947] Step passed: Create the Team Project. Execution time: 8 seconds.
    [13:42:44.947]   [StepDuration] 8.7018906
    [13:42:45.017]   [GroupDuration] 8.7715601
    [13:42:45.017] +++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++
    [13:42:45.017] ++ Executing - Operation: ProjectCreate, Group: ProjectCreate.TfsWorkItemTracking
    [13:42:45.017] +++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++
    [13:42:45.017] Executing step: Create the Team Project
    [13:42:45.017]   Executing step: 'Create the Team Project' WorkItemTracking.CreateTeamProject (4 of 12)
    [13:42:45.017]   Getting process template.
    [13:42:45.243]   Refreshing server caches.
    [13:42:45.243]   Importing work item link types.
    [13:42:45.490]   Importing work item types
    [13:58:35.873]   ServicingContext.Canceled was called. Stack trace:    at System.Environment.GetStackTrace(Exception e, Boolean needFileInfo)
    [13:58:35.873]      at System.Environment.get_StackTrace()
    [13:58:35.873]      at Microsoft.TeamFoundation.Framework.Server.ServicingContext.Microsoft.TeamFoundation.Framework.Server.ICancelable.Cancel()
    [13:58:35.873]      at Microsoft.TeamFoundation.Framework.Server.VssRequestContext.Cancel(String reason, HttpStatusCode httpStatusCode)
    [13:58:35.873]      at Microsoft.TeamFoundation.Framework.Server.JobRequestContext.Cancel(String reason, Boolean tryUpdateQueueState)
    [13:58:35.873]      at Microsoft.TeamFoundation.Framework.Server.ServiceHost`1.CancelAllRequests(Boolean wait)
    [13:58:35.873]      at Microsoft.TeamFoundation.Framework.Server.HostManagementKernel`2.CancelAllRequestsRecursive(Guid instanceId, Int64 requestId)
    [13:58:35.873]      at Microsoft.TeamFoundation.Framework.Server.HostManagementKernel`2.CancelAllRequestsRecursive(Guid instanceId, Int64 requestId)
    [13:58:35.873]      at Microsoft.TeamFoundation.Framework.Server.HostManagementKernel`2.<>c__DisplayClass21_0.<Stop>b__0()
    [13:58:35.873]      at System.Threading.Tasks.Task.Execute()
    [13:58:35.873]      at System.Threading.ExecutionContext.RunInternal(ExecutionContext executionContext, ContextCallback callback, Object state, Boolean preserveSyncCtx)
    [13:58:35.873]      at System.Threading.ExecutionContext.Run(ExecutionContext executionContext, ContextCallback callback, Object state, Boolean preserveSyncCtx)
    [13:58:35.873]      at System.Threading.Tasks.Task.ExecuteWithThreadLocal(Task& currentTaskSlot)
    [13:58:35.873]      at System.Threading.Tasks.Task.ExecuteEntry(Boolean bPreventDoubleExecution)
    [13:58:35.873]      at System.Threading.ThreadPoolWorkQueue.Dispatch()
    [13:58:35.873]   Calling Cancel on target request context.
    [13:58:35.873]   Calling Cancel on the delployment request context.
    [13:58:35.873]   ServicingContext.Canceled complete.
    [14:10:35.410]   Creating dictionary with 2 initial items:
    [14:10:35.410]    CollectionProperties => Value: 92bc66ac-6db9-40c9-bbae-f033fa1f1662 (SW_RD_Ctr-SW_RD_Div1-ACC_SW_RD_Dep)
    [14:10:35.410]    RequestingIdentity => Value: System.Security.Principal.WindowsIdentity;S-1-5-21-1540110904-195728068-3330098977-1335
    [14:10:35.410]   Acquiring servicing job lock 'Servicing-92bc66ac-6db9-40c9-bbae-f033fa1f1662'
    [14:10:35.417]   Setting token. Key: JobId. Value: 38ee7ccc-d405-41bb-a168-cbf23b1cc0b9.
    [14:10:35.477]   OperationClass: CreateProject
    [14:10:35.477]   Framework connection string was not found in servicing items
    [14:10:35.477]   Setting item. Key: ConnectionInfo. Value: Data Source=TP-TFS2012-V01;Initial Catalog=Tfs_SW_RD_Ctr-SW_RD_Div1-ACC_SW_RD_Dep;Integrated Security=True.
    [14:10:35.477]   Dbo connection string was not found in servicing items
    [14:10:35.477]   Setting item. Key: DboConnectionInfo. Value: Data Source=TP-TFS2012-V01;Initial Catalog=Tfs_SW_RD_Ctr-SW_RD_Div1-ACC_SW_RD_Dep;Integrated Security=True.
    [14:10:35.477]   Setting token. Key: OnlineUpdate. Value: true.
    [14:10:35.477]   Registering the servicing job as running.
    [14:10:35.490]   Registered the job.
    [14:10:35.490]   onlineUpdate: False
    [14:10:35.490]   Setting item. Key: HostedDeployment. Value: False.
    [14:10:35.490]   Adding item. Key: ProcessTemplate. Value: Microsoft.TeamFoundation.Server.Core.TeamFoundationProcessService+LegacyProcessPackage.
    [14:10:35.490]   Adding item. Key: PluginTaskXml. Value: System.Collections.Generic.Dictionary`2[System.String,System.String].
    [14:10:35.517] +++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++
    [14:10:35.517] ++ Executing - Operation: ProjectCreate, Group: ProjectCreate.TfsFramework
    [14:10:35.517] +++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++
    [14:10:35.517] Executing step: Ensure Team Project Tokens
    [14:10:35.517]   Executing step: 'Ensure Team Project Tokens' Framework.EnsureTeamProjectTokens (1 of 12)
    [14:10:35.517]   Begin EnsureTeamProjectTokens.
    [14:10:35.517]   Setting token. Key: ProjectUri. Value: vstfs:///Classification/TeamProject/2ab90d7d-391e-4972-9978-d8eab045ced3.
    [14:10:35.517]   Setting item. Key: RequestingUserContext. Value: Request Context Details
    [14:10:35.517]       Url:
    [14:10:35.517]       Method:
    [14:10:35.517]       Parameters:
    [14:10:35.517]       Activity Id: 73119f7a-8d82-467a-8232-963ff405910e
    [14:10:35.517]       Type: Microsoft.TeamFoundation.Framework.Server.DefaultRequestContext
    [14:10:35.517]       User Name:
    [14:10:35.517]       User Agent:
    [14:10:35.517]       Unique Id: 00000000-0000-0000-0000-000000000000.
    [14:10:35.517] Step passed: Ensure Team Project Tokens. Execution time: 1 millisecond.
    [14:10:35.517]   [StepDuration] 0.0004561
    [14:10:35.517] +++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++
    [14:10:35.517] Step skipped: Create the Team Project.
    [14:10:35.517]   [GroupDuration] 0.0257195
    [14:10:35.517] +++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++
    [14:10:35.517] Step skipped: Create the Team Project.
    [14:10:35.517]   [GroupDuration] 2.49E-05
    [14:10:35.517] +++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++
    [14:10:35.517] ++ Executing - Operation: ProjectCreate, Group: ProjectCreate.TfsWorkItemTracking
    [14:10:35.517] +++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++
    [14:10:35.517] Executing step: Create the Team Project
    [14:10:35.517]   Executing step: 'Create the Team Project' WorkItemTracking.CreateTeamProject (4 of 12)
    [14:10:35.517]   Getting process template.
    [14:10:35.687]   Refreshing server caches.
    [14:10:35.687]   Importing work item link types.
    [14:10:35.700]   Importing work item types
    [14:20:36.343]   [Error] TF246018: The database operation exceeded the timeout limit and has been cancelled. Verify that the parameters of the operation are correct.
    [14:20:36.563]   Microsoft.TeamFoundation.Framework.Server.DatabaseOperationTimeoutException: TF246018: The database operation exceeded the timeout limit and has been cancelled. Verify that the parameters of the operation are correct. ---> System.Data.SqlClient.SqlException: Execution Timeout Expired.  The timeout period elapsed prior to completion of the operation or the server is not responding. ---> System.ComponentModel.Win32Exception: The wait operation timed out
    [14:20:36.563]      --- End of inner exception stack trace ---
    [14:20:36.563]      at System.Data.SqlClient.SqlConnection.OnError(SqlException exception, Boolean breakConnection, Action`1 wrapCloseInAction)
    [14:20:36.563]      at System.Data.SqlClient.TdsParser.ThrowExceptionAndWarning(TdsParserStateObject stateObj, Boolean callerHasConnectionLock, Boolean asyncClose)
    [14:20:36.563]      at System.Data.SqlClient.TdsParser.TryRun(RunBehavior runBehavior, SqlCommand cmdHandler, SqlDataReader dataStream, BulkCopySimpleResultSet bulkCopyHandler, TdsParserStateObject stateObj, Boolean& dataReady)
    [14:20:36.563]      at System.Data.SqlClient.SqlCommand.FinishExecuteReader(SqlDataReader ds, RunBehavior runBehavior, String resetOptionsString, Boolean isInternal, Boolean forDescribeParameterEncryption)
    [14:20:36.563]      at System.Data.SqlClient.SqlCommand.RunExecuteReaderTds(CommandBehavior cmdBehavior, RunBehavior runBehavior, Boolean returnStream, Boolean async, Int32 timeout, Task& task, Boolean asyncWrite, Boolean inRetry, SqlDataReader ds, Boolean describeParameterEncryptionRequest)
    [14:20:36.563]      at System.Data.SqlClient.SqlCommand.RunExecuteReader(CommandBehavior cmdBehavior, RunBehavior runBehavior, Boolean returnStream, String method, TaskCompletionSource`1 completion, Int32 timeout, Task& task, Boolean& usedCache, Boolean asyncWrite, Boolean inRetry)
    [14:20:36.563]      at System.Data.SqlClient.SqlCommand.InternalExecuteNonQuery(TaskCompletionSource`1 completion, String methodName, Boolean sendToPipe, Int32 timeout, Boolean& usedCache, Boolean asyncWrite, Boolean inRetry)
    [14:20:36.563]      at System.Data.SqlClient.SqlCommand.ExecuteNonQuery()
    [14:20:36.563]      at Microsoft.TeamFoundation.Framework.Server.TeamFoundationSqlResourceComponent.ExecuteCommand(ExecuteType executeType, CommandBehavior behavior, String performanceGroupName)
    [14:20:36.563]      --- End of inner exception stack trace ---
    [14:20:36.563]      at Microsoft.TeamFoundation.Framework.Server.TeamFoundationSqlResourceComponent.TranslateException(Int32 errorNumber, SqlException sqlException, SqlError sqlError)
    [14:20:36.563]      at Microsoft.TeamFoundation.Framework.Server.TeamFoundationSqlResourceComponent.TranslateException(SqlException sqlException)
    [14:20:36.563]      at Microsoft.TeamFoundation.Framework.Server.TeamFoundationSqlResourceComponent.MapException(SqlException ex, QueryExecutionState queryState)
    [14:20:36.563]      at Microsoft.TeamFoundation.Framework.Server.TeamFoundationSqlResourceComponent.HandleException(Exception exception)
    [14:20:36.563]      at Microsoft.TeamFoundation.Framework.Server.TeamFoundationSqlResourceComponent.ExecuteCommand(ExecuteType executeType, CommandBehavior behavior, String performanceGroupName)
    [14:20:36.563]      at Microsoft.VisualStudio.Services.CircuitBreaker.Command.<>c__DisplayClass7_0.<Execute>b__0()
    [14:20:36.563]      at Microsoft.VisualStudio.Services.CircuitBreaker.CommandAsync.<Execute>d__28.MoveNext()
    [14:20:36.563]   --- End of stack trace from previous location where exception was thrown ---
    [14:20:36.563]      at System.Runtime.ExceptionServices.ExceptionDispatchInfo.Throw()
    [14:20:36.563]      at Microsoft.VisualStudio.Services.CircuitBreaker.Command.Execute(Action run, Action fallback)
    [14:20:36.563]      at Microsoft.TeamFoundation.Framework.Server.TeamFoundationSqlResourceComponent.ExecuteCommandWithBaseCircuitBreaker(ExecuteType executeType, CommandBehavior behavior, String performanceGroupName)
    [14:20:36.563]      at Microsoft.TeamFoundation.Framework.Server.TeamFoundationSqlResourceComponent.ExecuteNonQuery(Boolean bindReturnValue)
    [14:20:36.563]      at Microsoft.TeamFoundation.Framework.Server.TeamFoundationSqlResourceComponent.ExecuteNonQuery()
    [14:20:36.563]      at Microsoft.TeamFoundation.WorkItemTracking.Server.Metadata.WorkItemTypeService.CreateProjectWorkItemType(IVssRequestContext requestContext, Guid projectGuid)
    [14:20:36.563]      at Microsoft.TeamFoundation.WorkItemTracking.Server.ProvisioningService.InternalImportWorkItemTypes(IVssRequestContext requestContext, Int32 projectNodeId, String methodologyName, IEnumerable`1 typeElements, ProvisioningActionType actionType, Boolean overwrite, ProvisioningImportEventsCallback importEventCallback, XmlDocument& updatePackage)
    [14:20:36.563]      at Microsoft.TeamFoundation.WorkItemTracking.Server.ProvisioningService.InternalImportWorkItemTypesOrGlobalWorkflows(IVssRequestContext requestContext, Int32 projectId, String methodologyName, IEnumerable`1 typeElements, ProvisioningActionType actionType, InternalSchemaType schemaType, Boolean overwrite, ProvisioningImportEventsCallback importEventCallback)
    [14:20:36.563]      at Microsoft.TeamFoundation.WorkItemTracking.Server.ProvisioningService.ImportWorkItemTypes(IVssRequestContext requestContext, Int32 projectId, String methodologyName, IEnumerable`1 definitions, ProvisioningImportEventsCallback importEventCallback)
    [14:20:36.563]      at Microsoft.TeamFoundation.Server.Deploy.TFCollection.Project.WorkItemTrackingImporter.ImportWorkItemTypes()
    [14:20:36.563]      at Microsoft.TeamFoundation.Server.Servicing.TFCollection.WorkItemStepPerformer.ProvisionTeamProject(IVssRequestContext requestContext, ServicingContext servicingContext, WorkItemTrackingImporter witImporter, String projectUri)
    [14:20:36.563]      at Microsoft.TeamFoundation.Server.Servicing.TFCollection.WorkItemStepPerformer.CreateTeamProject(ServicingContext servicingContext)
    [14:20:36.563]      at Microsoft.TeamFoundation.Framework.Server.TeamFoundationStepPerformerBase.PerformHostStep(String servicingOperation, ServicingOperationTarget target, IServicingStep servicingStep, String stepData, ServicingContext servicingContext)
    [14:20:36.563]      at Microsoft.TeamFoundation.Framework.Server.TeamFoundationStepPerformerBase.PerformStep(String servicingOperation, ServicingOperationTarget target, IServicingStep servicingStep, String stepType, String stepData, ServicingContext servicingContext)
    [14:20:36.563]      at Microsoft.TeamFoundation.Framework.Server.TeamFoundationStepPerformerBase.PerformStep(String servicingOperation, ServicingOperationTarget target, String stepType, String stepData, ServicingContext servicingContext)
    [14:20:36.563]      at Microsoft.TeamFoundation.Framework.Server.ServicingStepDriver.PerformServicingStep(ServicingStep step, ServicingContext servicingContext, ServicingStepGroup group, ServicingOperation servicingOperation, Int32 stepNumber, Int32 totalSteps)
    [14:20:36.563] Step failed: Create the Team Project. Execution time: 10 minutes and 1 second.
    [14:20:36.563]   [StepDuration] 601.0398632
    [14:20:36.583]   [GroupDuration] 601.0584711
    [14:20:36.957]   [OperationDuration] 601.4587951
    [14:20:37.117]   Clearing dictionary, removing all items.

    ======================================================================================================
     Step execution times in descending order
    ======================================================================================================
    Create the Team Project (ProjectCreate.TfsWorkItemTracking, ProjectCreate) - 10 minutes and 1 second
    Create the Team Project (ProjectCreate.TfsIntegration, ProjectCreate)      - 8 seconds
    Create the Team Project (ProjectCreate.TfsFramework, ProjectCreate)        - 4 seconds
    Ensure Team Project Tokens (ProjectCreate.TfsFramework, ProjectCreate)     - 1 millisecond
    Ensure Team Project Tokens (ProjectCreate.TfsFramework, ProjectCreate)     - 1 millisecond

    ======================================================================================================
     Execution times by group in descending order
    ======================================================================================================
    ProjectCreate.TfsWorkItemTracking (ProjectCreate)                          - 10 minutes and 1 second
    ProjectCreate.TfsIntegration (ProjectCreate)                               - 8 seconds
    ProjectCreate.TfsFramework (ProjectCreate)                                 - 4 seconds

    Case 2: Create 時間 1hr, 50 min

    ====================================================================
    Collection name : SW_RD_Ctr-SW_RD_Div1-SW_RD_Dept1-Sec2
    Operation class : CreateProject
    Time Zone       : Taipei Standard Time
    Queue time      : 08/21/2017 16:29:11
    Start time      : 08/21/2017 16:29:11
    End time        : 08/21/2017 18:20:24
    Execution time  : 0:01:51:12
    Job result      : Succeeded
    ====================================================================
    [16:29:11.480]   Creating dictionary with 2 initial items:
    [16:29:11.480]    CollectionProperties => Value: 1ff8f7d1-5d56-4f0a-b526-12f134de19dc (SW_RD_Ctr-SW_RD_Div1-SW_RD_Dept1-Sec2)
    [16:29:11.480]    RequestingIdentity => Value: System.Security.Principal.WindowsIdentity;S-1-5-21-2085568609-544615495-1279470122-2812
    [16:29:11.480]   Acquiring servicing job lock 'Servicing-1ff8f7d1-5d56-4f0a-b526-12f134de19dc'
    [16:29:11.483]   Setting token. Key: JobId. Value: bdc7618e-ccba-4c0d-9203-7dc2f2a5b039.
    [16:29:11.563]   OperationClass: CreateProject
    [16:29:11.563]   Framework connection string was not found in servicing items
    [16:29:11.563]   Setting item. Key: ConnectionInfo. Value: Data Source=TP-TFS2012-V01;Initial Catalog=Tfs_SW_RD_Ctr-SW_RD_Div1-SW_RD_Dept1-Sec2;Integrated Security=True.
    [16:29:11.563]   Dbo connection string was not found in servicing items
    [16:29:11.563]   Setting item. Key: DboConnectionInfo. Value: Data Source=TP-TFS2012-V01;Initial Catalog=Tfs_SW_RD_Ctr-SW_RD_Div1-SW_RD_Dept1-Sec2;Integrated Security=True.
    [16:29:11.563]   Setting token. Key: OnlineUpdate. Value: true.
    [16:29:11.563]   Registering the servicing job as running.
    [16:29:11.893]   Registered the job.
    [16:29:11.893]   onlineUpdate: False
    [16:29:11.897]   Setting item. Key: HostedDeployment. Value: False.
    [16:29:12.010]   Adding item. Key: ProcessTemplate. Value: Microsoft.TeamFoundation.Server.Core.TeamFoundationProcessService+LegacyProcessPackage.
    [16:29:12.013]   Adding item. Key: PluginTaskXml. Value: System.Collections.Generic.Dictionary`2[System.String,System.String].
    [16:29:12.197] +++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++
    [16:29:12.197] ++ Executing - Operation: ProjectCreate, Group: ProjectCreate.TfsFramework
    [16:29:12.197] +++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++
    [16:29:12.197] Executing step: Ensure Team Project Tokens
    [16:29:12.200]   Executing step: 'Ensure Team Project Tokens' Framework.EnsureTeamProjectTokens (1 of 12)
    [16:29:12.200]   Begin EnsureTeamProjectTokens.
    [16:29:12.200]   Setting token. Key: ProjectUri. Value: vstfs:///Classification/TeamProject/e0925997-0769-43ca-b61e-76e36bd1419e.
    [16:29:12.200]   Setting item. Key: RequestingUserContext. Value: Request Context Details
    [16:29:12.200]       Url:
    [16:29:12.200]       Method:
    [16:29:12.200]       Parameters:
    [16:29:12.200]       Activity Id: 6c72821a-613f-499b-9ca0-9fae545f1589
    [16:29:12.200]       Type: Microsoft.TeamFoundation.Framework.Server.DefaultRequestContext
    [16:29:12.200]       User Name:
    [16:29:12.200]       User Agent:
    [16:29:12.200]       Unique Id: 00000000-0000-0000-0000-000000000000.
    [16:29:12.200] Step passed: Ensure Team Project Tokens. Execution time: 3 milliseconds.
    [16:29:12.200]   [StepDuration] 0.0008482
    [16:29:12.200] +++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++
    [16:29:12.200] Executing step: Create the Team Project
    [16:29:12.200]   Executing step: 'Create the Team Project' Framework.CreateTeamProject (2 of 12)
    [16:29:16.820] Step passed: Create the Team Project. Execution time: 4 seconds.
    [16:29:16.820]   [StepDuration] 4.6205718
    [16:29:16.920]   [GroupDuration] 4.9059509
    [16:29:16.920] +++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++
    [16:29:16.920] ++ Executing - Operation: ProjectCreate, Group: ProjectCreate.TfsIntegration
    [16:29:16.920] +++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++
    [16:29:16.920] Executing step: Create the Team Project
    [16:29:16.920]   Executing step: 'Create the Team Project' Integration.CreateTeamProject (3 of 12)
    [16:29:26.040] Step passed: Create the Team Project. Execution time: 9 seconds.
    [16:29:26.040]   [StepDuration] 9.1205119
    [16:29:26.080]   [GroupDuration] 9.1576198
    [16:29:26.080] +++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++
    [16:29:26.080] ++ Executing - Operation: ProjectCreate, Group: ProjectCreate.TfsWorkItemTracking
    [16:29:26.080] +++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++
    [16:29:26.080] Executing step: Create the Team Project
    [16:29:26.080]   Executing step: 'Create the Team Project' WorkItemTracking.CreateTeamProject (4 of 12)
    [16:29:26.080]   Getting process template.
    [16:29:26.237]   Refreshing server caches.
    [16:29:26.237]   Importing work item link types.
    [16:29:26.320]   Importing work item types
    [17:29:45.543]   Importing work item types
    [18:19:34.667]   Importing work item type categories.
    [18:19:43.603]   Importing queries.
    [18:19:49.340]   Importing process settings.
    [18:20:04.057] Step passed: Create the Team Project. Execution time: 1 hour and 50 minutes.
    [18:20:04.057]   [StepDuration] 6637.8942269
    [18:20:04.553]   [GroupDuration] 6638.388814
    [18:20:04.553] +++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++
    [18:20:04.553] ++ Executing - Operation: ProjectCreate, Group: ProjectCreate.TfsSourceControl
    [18:20:04.553] +++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++
    [18:20:04.553] Executing step: Create the Team Project
    [18:20:04.553]   Executing step: 'Create the Team Project' VersionControl.CreateTeamProject (5 of 12)
    [18:20:12.663] Step passed: Create the Team Project. Execution time: 8 seconds.
    [18:20:12.663]   [StepDuration] 8.111992
    [18:20:12.867]   [GroupDuration] 8.3146682
    [18:20:12.867] +++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++
    [18:20:12.867] ++ Executing - Operation: ProjectCreate, Group: ProjectCreate.TfsTeamBuild
    [18:20:12.867] +++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++
    [18:20:12.867] Executing step: Create the Team Project
    [18:20:12.867]   Executing step: 'Create the Team Project' Build.CreateTeamProject (6 of 12)
    [18:20:19.547] Step passed: Create the Team Project. Execution time: 6 seconds.
    [18:20:19.547]   [StepDuration] 6.6783424
    [18:20:19.563]   [GroupDuration] 6.6942177
    [18:20:19.563] +++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++
    [18:20:19.563] ++ Executing - Operation: ProjectCreate, Group: ProjectCreate.TfsLabExecution
    [18:20:19.563] +++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++
    [18:20:19.563] Executing step: Create the Team Project
    [18:20:19.563]   Executing step: 'Create the Team Project' LabManagement.CreateTeamProject (7 of 12)
    [18:20:20.787] Step passed: Create the Team Project. Execution time: 1224 milliseconds.
    [18:20:20.787]   [StepDuration] 1.2255545
    [18:20:20.883]   [GroupDuration] 1.3223055
    [18:20:20.883] +++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++
    [18:20:20.883] ++ Executing - Operation: ProjectCreate, Group: ProjectCreate.TfsTestManagement
    [18:20:20.883] +++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++
    [18:20:20.883] Executing step: Create the Team Project
    [18:20:20.883]   Executing step: 'Create the Team Project' TestManagement.CreateTeamProject (8 of 12)
    [18:20:21.743] Step passed: Create the Team Project. Execution time: 860 milliseconds.
    [18:20:21.743]   [StepDuration] 0.8579407
    [18:20:21.753]   [GroupDuration] 0.8695005
    [18:20:22.010] +++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++
    [18:20:22.010] Step skipped: Create the Team Project.
    [18:20:22.020]   [GroupDuration] 0.2667231
    [18:20:22.700] +++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++
    [18:20:22.700] Step skipped: Create the Team Project.
    [18:20:22.713]   [GroupDuration] 0.6944235
    [18:20:22.713] +++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++
    [18:20:22.713] ++ Executing - Operation: ProjectCreate, Group: ProjectCreate.ServiceHooksPublisher
    [18:20:22.713] +++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++
    [18:20:22.713] Executing step: Initialize Service Hooks project-level permissions
    [18:20:22.713]   Executing step: 'Initialize Service Hooks project-level permissions' ServiceHooksPublisher.CreateTeamProject (11 of 12)
    [18:20:23.047] Step passed: Initialize Service Hooks project-level permissions. Execution time: 334 milliseconds.
    [18:20:23.047]   [StepDuration] 0.3309484
    [18:20:23.177]   [GroupDuration] 0.4619006
    [18:20:23.177] +++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++
    [18:20:23.177] ++ Executing - Operation: ProjectCreate, Group: ProjectCreate.FinishTfsFramework
    [18:20:23.177] +++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++
    [18:20:23.177] Executing step: Finalize the Team Project
    [18:20:23.177]   Executing step: 'Finalize the Team Project' Framework.FinalizeTeamProject (12 of 12)
    [18:20:24.480] Step passed: Finalize the Team Project. Execution time: 1303 milliseconds.
    [18:20:24.480]   [StepDuration] 1.30169
    [18:20:24.493]   [GroupDuration] 1.3156763
    [18:20:24.493]   [OperationDuration] 6672.5110057
    [18:20:24.533]   Clearing dictionary, removing all items.

    ======================================================================================================
     Step execution times in descending order
    ======================================================================================================
    Create the Team Project (ProjectCreate.TfsWorkItemTracking, ProjectCreate)                              - 1 hour and 50 minutes
    Create the Team Project (ProjectCreate.TfsIntegration, ProjectCreate)                                   - 9 seconds
    Create the Team Project (ProjectCreate.TfsSourceControl, ProjectCreate)                                 - 8 seconds
    Create the Team Project (ProjectCreate.TfsTeamBuild, ProjectCreate)                                     - 6 seconds
    Create the Team Project (ProjectCreate.TfsFramework, ProjectCreate)                                     - 4 seconds
    Finalize the Team Project (ProjectCreate.FinishTfsFramework, ProjectCreate)                             - 1303 milliseconds
    Create the Team Project (ProjectCreate.TfsLabExecution, ProjectCreate)                                  - 1224 milliseconds
    Create the Team Project (ProjectCreate.TfsTestManagement, ProjectCreate)                                - 860 milliseconds
    Initialize Service Hooks project-level permissions (ProjectCreate.ServiceHooksPublisher, ProjectCreate) - 334 milliseconds
    Ensure Team Project Tokens (ProjectCreate.TfsFramework, ProjectCreate)                                  - 3 milliseconds

    ======================================================================================================
     Execution times by group in descending order
    ======================================================================================================
    ProjectCreate.TfsWorkItemTracking (ProjectCreate)                                                       - 1 hour and 50 minutes
    ProjectCreate.TfsIntegration (ProjectCreate)                                                            - 9 seconds
    ProjectCreate.TfsSourceControl (ProjectCreate)                                                          - 8 seconds
    ProjectCreate.TfsTeamBuild (ProjectCreate)                                                              - 6 seconds
    ProjectCreate.TfsFramework (ProjectCreate)                                                              - 4 seconds
    ProjectCreate.FinishTfsFramework (ProjectCreate)                                                        - 1303 milliseconds
    ProjectCreate.TfsLabExecution (ProjectCreate)                                                           - 1224 milliseconds
    ProjectCreate.TfsTestManagement (ProjectCreate)                                                         - 860 milliseconds
    ProjectCreate.ServiceHooksPublisher (ProjectCreate)                                                     - 334 milliseconds


    • 已編輯 anderson0n 2017年8月24日 上午 09:18
    2017年8月24日 上午 06:33
  • 補充回復

    2.在2017/8/24 17:41 用建議改 VS2017 create 也需要很久時間, 安裝的進度條狀態: Work item types create. 然後顯示發生下列錯誤無法繼續. TFS server 原先在該專案集合的專案 本來從狀態 New  改為整個專案消失

        錯誤
        TF30170: 在群組 WorkItemTracking 的工作 WITs 進行期間外掛程式
        Microsoft.ProjectCreationWizard.WorkItemTracking 失敗。 

        說明
        外掛程式錯誤文字: “工作項目類型驗證失敗。無法完成作業。” 


        使用者的動作
        請連絡您的 Team Foundation Server 系統管理員。

    case3. 在  Server 端 看不到 2017/8/24 17:41 有 CreateProject, 反而在 2017/8/24 17:48:17 有 Delete Project, log 如下

    ====================================================================
    Collection name : TestPC_Anderson
    Operation class : DeleteProject
    Time Zone       : Taipei Standard Time
    Queue time      : 08/24/2017 17:48:17
    Start time      : 08/24/2017 17:48:18
    End time        : 08/24/2017 17:48:46
    Execution time  : 0:00:00:27
    Job result      : Succeeded
    ====================================================================
    [17:48:18.383]   Creating dictionary with 2 initial items:
    [17:48:18.383]    CollectionProperties => Value: a7dcac82-d7b3-43e2-a250-43c86ae80a84 (TestPC_Anderson)
    [17:48:18.383]    RequestingIdentity => Value: System.Security.Principal.WindowsIdentity;S-1-5-21-2085568609-544615495-1279470122-158915
    [17:48:18.383]   Acquiring servicing job lock 'Servicing-a7dcac82-d7b3-43e2-a250-43c86ae80a84'
    [17:48:18.390]   Setting token. Key: JobId. Value: 5a71404f-1051-4365-9841-dad30a5cce97.
    [17:48:18.480]   OperationClass: DeleteProject
    [17:48:18.480]   Framework connection string was not found in servicing items
    [17:48:18.480]   Setting item. Key: ConnectionInfo. Value: Data Source=TP-TFS2012-V01;Initial Catalog=Tfs_TestPC_Anderson;Integrated Security=True.
    [17:48:18.480]   Dbo connection string was not found in servicing items
    [17:48:18.480]   Setting item. Key: DboConnectionInfo. Value: Data Source=TP-TFS2012-V01;Initial Catalog=Tfs_TestPC_Anderson;Integrated Security=True.
    [17:48:18.480]   Setting token. Key: OnlineUpdate. Value: true.
    [17:48:18.480]   Registering the servicing job as running.
    [17:48:18.637]   Registered the job.
    [17:48:18.637]   onlineUpdate: False
    [17:48:18.640]   Setting item. Key: HostedDeployment. Value: False.
    [17:48:18.743] +++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++
    [17:48:18.743] ++ Executing - Operation: ProjectDelete, Group: ProjectDelete.Prereq
    [17:48:18.743] +++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++
    [17:48:18.743] Executing step: Ensure Team Project Tokens
    [17:48:18.747]   Executing step: 'Ensure Team Project Tokens' Framework.EnsureTeamProjectTokens (1 of 13)
    [17:48:18.747]   Begin EnsureTeamProjectTokens.
    [17:48:18.863]   Setting item. Key: RequestingUserContext. Value: Request Context Details
    [17:48:18.863]       Url:
    [17:48:18.863]       Method:
    [17:48:18.863]       Parameters:
    [17:48:18.863]       Activity Id: 7310c9b4-8d82-467a-8232-963ff405910e
    [17:48:18.863]       Type: Microsoft.TeamFoundation.Framework.Server.DefaultRequestContext
    [17:48:18.863]       User Name:
    [17:48:18.863]       User Agent:
    [17:48:18.863]       Unique Id: 00000000-0000-0000-0000-000000000000.
    [17:48:18.863] Step passed: Ensure Team Project Tokens. Execution time: 120 milliseconds.
    [17:48:18.863]   [StepDuration] 0.1179157
    [17:48:18.863] +++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++
    [17:48:18.863] Executing step: Put team project in the Deleting state
    [17:48:18.863]   Executing step: 'Put team project in the Deleting state' Framework.MarkTeamProjectAsDeleting (2 of 13)
    [17:48:18.863]   Marking team project vstfs:///Classification/TeamProject/5a71404f-1051-4365-9841-dad30a5cce97 for deletion.
    [17:48:21.233] Step passed: Put team project in the Deleting state. Execution time: 2 seconds.
    [17:48:21.233]   [StepDuration] 2.3708969
    [17:48:21.397]   [GroupDuration] 2.7597128
    [17:48:21.397] +++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++
    [17:48:21.397] ++ Executing - Operation: ProjectDelete, Group: ProjectDelete.TfsSourceControl
    [17:48:21.397] +++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++
    [17:48:21.397] Executing step: Delete the team project data from Version Control
    [17:48:21.397]   Executing step: 'Delete the team project data from Version Control' VersionControl.DeleteTeamProject (3 of 13)
    [17:48:22.007] Step passed: Delete the team project data from Version Control. Execution time: 610 milliseconds.
    [17:48:22.007]   [StepDuration] 0.6077905
    [17:48:22.030]   [GroupDuration] 0.631387
    [17:48:22.030] +++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++
    [17:48:22.030] ++ Executing - Operation: ProjectDelete, Group: ProjectDelete.TfsGit
    [17:48:22.030] +++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++
    [17:48:22.030] Executing step: Delete the team project data from Git
    [17:48:22.030]   Executing step: 'Delete the team project data from Git' Git.DeleteTeamProject (4 of 13)
    [17:48:22.050] Step passed: Delete the team project data from Git. Execution time: 20 milliseconds.
    [17:48:22.050]   [StepDuration] 0.0220186
    [17:48:22.057]   [GroupDuration] 0.0273275
    [17:48:22.057] +++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++
    [17:48:22.057] ++ Executing - Operation: ProjectDelete, Group: ProjectDelete.TfsWorkItemTracking
    [17:48:22.057] +++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++
    [17:48:22.057] Executing step: Delete the team project data from Work Item Tracking
    [17:48:22.057]   Executing step: 'Delete the team project data from Work Item Tracking' WorkItemTracking.DeleteTeamProject (5 of 13)
    [17:48:22.057]   Deleting process and team settings.
    [17:48:23.070]   Deleting work item tracking artifacts.
    [17:48:30.093] Step passed: Delete the team project data from Work Item Tracking. Execution time: 8 seconds.
    [17:48:30.093]   [StepDuration] 8.0375112
    [17:48:30.127]   [GroupDuration] 8.0682329
    [17:48:30.127] +++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++
    [17:48:30.127] ++ Executing - Operation: ProjectDelete, Group: ProjectDelete.TfsTeamBuild
    [17:48:30.127] +++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++
    [17:48:30.127] Executing step: Delete the team project data from Build
    [17:48:30.127]   Executing step: 'Delete the team project data from Build' Build.DeleteTeamProject (6 of 13)
    [17:48:30.137] Step passed: Delete the team project data from Build. Execution time: 10 milliseconds.
    [17:48:30.137]   [StepDuration] 0.0100881
    [17:48:30.143]   [GroupDuration] 0.0186689
    [17:48:30.143] +++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++
    [17:48:30.143] ++ Executing - Operation: ProjectDelete, Group: ProjectDelete.TfsTestManagement
    [17:48:30.143] +++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++
    [17:48:30.143] Executing step: Delete the team project data from Team Test
    [17:48:30.143]   Executing step: 'Delete the team project data from Team Test' TestManagement.DeleteTeamProject (7 of 13)
    [17:48:30.420] Step passed: Delete the team project data from Team Test. Execution time: 277 milliseconds.
    [17:48:30.420]   [StepDuration] 0.2747419
    [17:48:30.433]   [GroupDuration] 0.2891288
    [17:48:30.433] +++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++
    [17:48:30.433] ++ Executing - Operation: ProjectDelete, Group: ProjectDelete.TfsLabExecution
    [17:48:30.433] +++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++
    [17:48:30.433] Executing step: Delete the team project data from Lab Management
    [17:48:30.433]   Executing step: 'Delete the team project data from Lab Management' LabManagement.DeleteTeamProject (8 of 13)
    [17:48:30.437] Step passed: Delete the team project data from Lab Management. Execution time: 4 milliseconds.
    [17:48:30.437]   [StepDuration] 0.0043057
    [17:48:30.440]   [GroupDuration] 0.0066284
    [17:48:31.540] +++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++
    [17:48:31.540] Step skipped: Delete the team project data from Reporting.
    [17:48:31.553]   [GroupDuration] 1.1145299
    [17:48:32.033] +++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++
    [17:48:32.033] Step skipped: Delete the team project data from SharePoint.
    [17:48:32.087]   [GroupDuration] 0.5328775
    [17:48:32.087] +++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++
    [17:48:32.087] ++ Executing - Operation: ProjectDelete, Group: ProjectDelete.TfsReleaseManagement
    [17:48:32.087] +++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++
    [17:48:32.087] Executing step: Delete the team project data from Release
    [17:48:32.087]   Executing step: 'Delete the team project data from Release' ReleaseManagement.DeleteTeamProject (11 of 13)
    [17:48:32.133] Step passed: Delete the team project data from Release. Execution time: 46 milliseconds.
    [17:48:32.133]   [StepDuration] 0.0470666
    [17:48:32.267]   [GroupDuration] 0.1783649
    [17:48:32.267] +++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++
    [17:48:32.267] ++ Executing - Operation: ProjectDelete, Group: ProjectDelete.TfsIntegration
    [17:48:32.267] +++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++
    [17:48:32.267] Executing step: Delete the team project integration data
    [17:48:32.267]   Executing step: 'Delete the team project integration data' Integration.DeleteTeamProject (12 of 13)
    [17:48:32.267]   Deleting team project.
    [17:48:32.267]   Done.
    [17:48:32.267] Step passed: Delete the team project integration data. Execution time: 1 millisecond.
    [17:48:32.267]   [StepDuration] 4.14E-05
    [17:48:32.287]   [GroupDuration] 0.0195314
    [17:48:32.287] +++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++
    [17:48:32.287] ++ Executing - Operation: ProjectDelete, Group: ProjectDelete.TfsFramework
    [17:48:32.287] +++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++++
    [17:48:32.287] Executing step: Delete the team project framework data
    [17:48:32.287]   Executing step: 'Delete the team project framework data' Framework.DeleteTeamProject (13 of 13)
    [17:48:32.287]   Deleting team project, catalog entries and project identities using CommonStructureService.
    [17:48:46.310]   Done.
    [17:48:46.310] Step passed: Delete the team project framework data. Execution time: 14 seconds.
    [17:48:46.310]   [StepDuration] 14.0256617
    [17:48:46.530]   [GroupDuration] 14.2446388
    [17:48:46.530]   [OperationDuration] 27.8912923
    [17:48:46.643]   Clearing dictionary, removing all items.

    ======================================================================================================
     Step execution times in descending order
    ======================================================================================================
    Delete the team project framework data (ProjectDelete.TfsFramework, ProjectDelete)                      - 14 seconds
    Delete the team project data from Work Item Tracking (ProjectDelete.TfsWorkItemTracking, ProjectDelete) - 8 seconds
    Put team project in the Deleting state (ProjectDelete.Prereq, ProjectDelete)                            - 2 seconds
    Delete the team project data from Version Control (ProjectDelete.TfsSourceControl, ProjectDelete)       - 610 milliseconds
    Delete the team project data from Team Test (ProjectDelete.TfsTestManagement, ProjectDelete)            - 277 milliseconds
    Ensure Team Project Tokens (ProjectDelete.Prereq, ProjectDelete)                                        - 120 milliseconds
    Delete the team project data from Release (ProjectDelete.TfsReleaseManagement, ProjectDelete)           - 46 milliseconds
    Delete the team project data from Git (ProjectDelete.TfsGit, ProjectDelete)                             - 20 milliseconds
    Delete the team project data from Build (ProjectDelete.TfsTeamBuild, ProjectDelete)                     - 10 milliseconds
    Delete the team project data from Lab Management (ProjectDelete.TfsLabExecution, ProjectDelete)         - 4 milliseconds
    Delete the team project integration data (ProjectDelete.TfsIntegration, ProjectDelete)                  - 1 millisecond

    ======================================================================================================
     Execution times by group in descending order
    ======================================================================================================
    ProjectDelete.TfsFramework (ProjectDelete)                                                              - 14 seconds
    ProjectDelete.TfsWorkItemTracking (ProjectDelete)                                                       - 8 seconds
    ProjectDelete.Prereq (ProjectDelete)                                                                    - 2 seconds
    ProjectDelete.TfsSourceControl (ProjectDelete)                                                          - 610 milliseconds
    ProjectDelete.TfsTestManagement (ProjectDelete)                                                         - 277 milliseconds
    ProjectDelete.TfsReleaseManagement (ProjectDelete)                                                      - 46 milliseconds
    ProjectDelete.TfsGit (ProjectDelete)                                                                    - 20 milliseconds
    ProjectDelete.TfsTeamBuild (ProjectDelete)                                                              - 10 milliseconds
    ProjectDelete.TfsLabExecution (ProjectDelete)                                                           - 4 milliseconds
    ProjectDelete.TfsIntegration (ProjectDelete)                                                            - 1 millisecond

     

    2017年8月24日 上午 10:03
  • 1. 在發現後續無法透過 IE (web)或 VS2017 create project 之後 (cpu 的利用率一直在 5x%, process 為 SQL Server windows NT -64bit),

    做了大膽的動作, 下 shutdown /reboot 對 server 重新reboot, 然後在 client 端針對 TFS 上觀察正在 NEW 的專案進行刪除,

    後續 create 專案的時間瞬間變正常,

    2. 所謂的正常是 1x 秒可以 create 一個專案, 同個時間有兩個不同專案集合同時建立不同 team project;  或同時間, 一個 create team project, 另一個 delete team project 均有運作正常

    3. 接著後續進行下列動作 (目前 create project 不正常複製手法), 只要曾經在建立專案的同時, 在很短時間內按下取消 , 會發現 server cpu 利用率從個位數飆到 5x~7x%, 建立與刪除專案的時間就拉長到 38 分鐘 & 3sec

    4.上述動作進行後, 後續只要有人在不同專案集合建立其他的新的 team project, 建立時間開始會拉長到4.5分鐘, 14 分鐘 (server cpu 利用率在建立期間, 可以發現 SQL Server Windows NT-64bit 這個 process 會在 5x~8x% 跳動).

    請問這個不穩定的狀況, 除了對 server reboot 之外, 是否有 SQL server/TFS server 可以排除這種使用者情境造成 create project 不穩定的問題 ?


    • 已編輯 anderson0n 2017年8月25日 上午 08:59 modify content
    2017年8月25日 上午 08:52