INFO : 2023-07-01 02:36:53Z - Acquiring server... INFO : 2023-07-01 02:36:53Z - Server 'winbuildsv1' acquired. INFO : 2023-07-01 02:36:54Z - Found 5 issues. INFO : 2023-07-01 02:36:54Z - Changinge state on issues to Completed... INFO : 2023-07-01 02:36:54Z - State change applied. INFO : 2023-07-01 02:36:54Z - Template applied. INFO : 2023-07-01 02:36:54Z - Performing HTTP POST request to https://my.inedo.com/services/legacy/releases/pg/create... INFO : 2023-07-01 02:36:55Z - Server responded with status code 200 - OK INFO : 2023-07-01 02:36:55Z - Uploading file notes.xml to https://my.inedo.com/services/legacy/releases/pg/upload-notes?releaseNumber=22.0.30... INFO : 2023-07-01 02:36:55Z - Server responded with status code 200 - OK INFO : 2023-07-01 02:36:55Z - HTTP file upload completed. INFO : 2023-07-01 02:36:55Z - Repackaging InedoReleases/ProGet.Service 22.0.30-rc.5 to 22.0.30 on PrereleaseProducts (PrereleaseProducts feed)... INFO : 2023-07-01 02:36:56Z - Repackage was successful. INFO : 2023-07-01 02:36:56Z - Promoting InedoReleases/ProGet.Service 22.0.30 to Products... INFO : 2023-07-01 02:36:56Z - Promotion was successful. INFO : 2023-07-01 02:36:56Z - Repackaging InedoReleases/ProGet.SqlScripts 22.0.30-rc.5 to 22.0.30 on PrereleaseProducts (PrereleaseProducts feed)... INFO : 2023-07-01 02:36:57Z - Repackage was successful. INFO : 2023-07-01 02:36:57Z - Promoting InedoReleases/ProGet.SqlScripts 22.0.30 to Products... INFO : 2023-07-01 02:36:57Z - Promotion was successful. INFO : 2023-07-01 02:36:57Z - Repackaging InedoReleases/ProGet.Extensions 22.0.30-rc.5 to 22.0.30 on PrereleaseProducts (PrereleaseProducts feed)... INFO : 2023-07-01 02:36:57Z - Repackage was successful. INFO : 2023-07-01 02:36:57Z - Promoting InedoReleases/ProGet.Extensions 22.0.30 to Products... INFO : 2023-07-01 02:36:57Z - Promotion was successful. INFO : 2023-07-01 02:36:57Z - Repackaging InedoReleases/ProGet.RompPack 22.0.30-rc.5 to 22.0.30 on PrereleaseProducts (PrereleaseProducts feed)... INFO : 2023-07-01 02:36:57Z - Repackage was successful. INFO : 2023-07-01 02:36:57Z - Promoting InedoReleases/ProGet.RompPack 22.0.30 to Products... INFO : 2023-07-01 02:36:57Z - Promotion was successful. INFO : 2023-07-01 02:36:57Z - Updating local repository for https://git.inedo.com/Inedo/ProGet.git... INFO : 2023-07-01 02:36:57Z - Tagging 4f6406ce820eeaff189e9ca3f8cf7e5e9805fbc5 with ProGet-22.0.30.5... INFO : 2023-07-01 02:37:02Z - Template applied. INFO : 2023-07-01 02:37:02Z - Sleeping for 30 seconds... INFO : 2023-07-01 02:37:32Z - Done sleeping. INFO : 2023-07-01 02:37:32Z - Downloading package... INFO : 2023-07-01 02:37:32Z - Installing package to C:\Users\builds\AppData\Local\Temp\InedoAgent\BuildMaster\192.168.44.60\Temp\_E349092\installer... INFO : 2023-07-01 02:37:32Z - Package installed. INFO : 2023-07-01 02:37:32Z - Package installation complete. INFO : 2023-07-01 02:37:32Z - Downloading package... INFO : 2023-07-01 02:37:32Z - Installing package to C:\Users\builds\AppData\Local\Temp\InedoAgent\BuildMaster\192.168.44.60\Temp\_E349092\installer\hub... INFO : 2023-07-01 02:37:33Z - Package installed. INFO : 2023-07-01 02:37:33Z - Package installation complete. INFO : 2023-07-01 02:37:33Z - Creating file... INFO : 2023-07-01 02:37:33Z - C:\Users\builds\AppData\Local\Temp\InedoAgent\BuildMaster\192.168.44.60\Temp\_E349092\installer\hub\DesktopHub.config file created. INFO : 2023-07-01 02:37:33Z - Creating file... INFO : 2023-07-01 02:37:33Z - C:\Users\builds\AppData\Local\Temp\InedoAgent\BuildMaster\192.168.44.60\Temp\_E349092\installer\config.txt file created. INFO : 2023-07-01 02:37:33Z - Downloading https://proget1000.inedo.com/upack/PrereleaseProducts/download/InedoReleases/ProGet/22.0.30 to ~\installer\hub\Packages\ProGet-22.0.30.upack... INFO : 2023-07-01 02:37:36Z - Server responded with status code 200 - OK INFO : 2023-07-01 02:37:37Z - HTTP file download completed. INFO : 2023-07-01 02:37:38Z - Deleted 12 files and 0 directories. INFO : 2023-07-01 02:37:38Z - Executing C:\Users\builds\AppData\Local\Temp\InedoAgent\BuildMaster\192.168.44.60\Temp\_E349092\installer\7za.exe... INFO : 2023-07-01 02:37:58Z - INFO : 2023-07-01 02:37:58Z - 7-Zip (a) 19.00 (x86) : Copyright (c) 1999-2018 Igor Pavlov : 2019-02-21 INFO : 2023-07-01 02:37:58Z - INFO : 2023-07-01 02:37:58Z - Scanning the drive: INFO : 2023-07-01 02:37:58Z - 30 files, 75733714 bytes (73 MiB) INFO : 2023-07-01 02:37:58Z - INFO : 2023-07-01 02:37:58Z - Creating archive: ..\InedoHub.7z INFO : 2023-07-01 02:37:58Z - INFO : 2023-07-01 02:37:58Z - Add new data to archive: 30 files, 75733714 bytes (73 MiB) INFO : 2023-07-01 02:37:58Z - INFO : 2023-07-01 02:37:58Z - INFO : 2023-07-01 02:37:58Z - Files read from disk: 30 INFO : 2023-07-01 02:37:58Z - Archive size: 70280945 bytes (68 MiB) INFO : 2023-07-01 02:37:58Z - Everything is Ok INFO : 2023-07-01 02:37:58Z - Process exited with code: 0 (success) INFO : 2023-07-01 02:37:58Z - Executing C:\Windows\system32\cmd.exe... INFO : 2023-07-01 02:37:58Z - 7zS2.sfx INFO : 2023-07-01 02:37:58Z - config.txt INFO : 2023-07-01 02:37:58Z - InedoHub.7z INFO : 2023-07-01 02:37:58Z - 1 file(s) copied. INFO : 2023-07-01 02:37:58Z - Process exited with code: 0 (success) INFO : 2023-07-01 02:37:58Z - Signing C:\Users\builds\AppData\Local\Temp\InedoAgent\BuildMaster\192.168.44.60\Temp\_E349092\installer\ProGetInstaller22.0.30_Offline.exe... INFO : 2023-07-01 02:38:00Z - Transferring C:\Users\builds\AppData\Local\Temp\InedoAgent\BuildMaster\192.168.44.60\Temp\_E349092\installer\ProGetInstaller22.0.30_Offline.exe to downloads/proget/ProGetInstaller22.0.30_Offline.exe (67.1 MB)... INFO : 2023-07-01 02:38:18Z - Ensuring "Fix version" for project ProGet has a version 22.0.30 that is released and archived... ERROR: 2023-07-01 02:38:18Z - Unhandled exception: System.InvalidOperationException: The requested operation requires an element of type 'String', but the target element has type 'Object'. at System.Text.Json.JsonDocument.TextEquals(Int32 index, ReadOnlySpan`1 otherUtf8Text, Boolean isPropertyName, Boolean shouldUnescape) at System.Text.Json.JsonDocument.TextEquals(Int32 index, ReadOnlySpan`1 otherText, Boolean isPropertyName) at Inedo.Extensions.YouTrack.YouTrackClient.g__getFieldId|13_0(JsonDocument doc, String name)+MoveNext() in C:\Users\builds\AppData\Local\Temp\InedoAgent\BuildMaster\192.168.44.60\Temp\_E285755\Src\YouTrack\InedoExtension\YouTrackClient.cs:line 301 at Inedo.Extensions.YouTrack.YouTrackClient.GetPaginatedListAsync[T](String relativeUrl, Func`2 getItems, CancellationToken cancellationToken)+MoveNext() in C:\Users\builds\AppData\Local\Temp\InedoAgent\BuildMaster\192.168.44.60\Temp\_E285755\Src\YouTrack\InedoExtension\YouTrackClient.cs:line 361 at Inedo.Extensions.YouTrack.YouTrackClient.GetPaginatedListAsync[T](String relativeUrl, Func`2 getItems, CancellationToken cancellationToken)+System.Threading.Tasks.Sources.IValueTaskSource.GetResult() at Inedo.Extensions.YouTrack.YouTrackClient.FirstOrDefaultAsync[T](IAsyncEnumerable`1 values) in C:\Users\builds\AppData\Local\Temp\InedoAgent\BuildMaster\192.168.44.60\Temp\_E285755\Src\YouTrack\InedoExtension\YouTrackClient.cs:line 323 at Inedo.Extensions.YouTrack.YouTrackClient.FirstOrDefaultAsync[T](IAsyncEnumerable`1 values) in C:\Users\builds\AppData\Local\Temp\InedoAgent\BuildMaster\192.168.44.60\Temp\_E285755\Src\YouTrack\InedoExtension\YouTrackClient.cs:line 323 at Inedo.Extensions.YouTrack.YouTrackClient.EnsureVersionAsync(String versionField, String projectName, String version, Nullable`1 released, Nullable`1 archived, CancellationToken cancellationToken) in C:\Users\builds\AppData\Local\Temp\InedoAgent\BuildMaster\192.168.44.60\Temp\_E285755\Src\YouTrack\InedoExtension\YouTrackClient.cs:line 219 at Inedo.Extensions.YouTrack.Operations.EnsureYouTrackVersionOperation.ExecuteAsync(IOperationExecutionContext context, YouTrackClient client) in C:\Users\builds\AppData\Local\Temp\InedoAgent\BuildMaster\192.168.44.60\Temp\_E285755\Src\YouTrack\InedoExtension\Operations\EnsureYouTrackVersionOperation.cs:line 83 at Inedo.Extensions.YouTrack.Operations.YouTrackOperationBase.ExecuteAsync(IOperationExecutionContext context) in C:\Users\builds\AppData\Local\Temp\InedoAgent\BuildMaster\192.168.44.60\Temp\_E285755\Src\YouTrack\InedoExtension\Operations\YouTrackOperationBase.cs:line 51 at Inedo.BuildMaster.Windows.ServiceApplication.Executions.PlanExecuter.OtterScriptExecuter.Inedo.ExecutionEngine.Executer.IExecutionHostEnvironment.ExecuteActionAsync(ActionStatement actionStatement, IExecuterContext context) WARN : 2023-07-01 02:38:18Z - Failed to automatically archive release. INFO : 2023-07-01 02:38:18Z - Stopping service ProGet_22_0_30_5... INFO : 2023-07-01 02:38:18Z - Stopping service ProGet_22_0_30_5_Web... INFO : 2023-07-01 02:38:19Z - Deleted directory C:\Websites\CI\ProGet.22.0.30.5. INFO : 2023-07-01 02:38:19Z - Executing database statement: DROP DATABASE IF EXISTS ProGet_22_0_30_5 ERROR: 2023-07-01 02:38:39Z - Unhandled exception: Microsoft.Data.SqlClient.SqlException (0x80131904): Cannot drop database "ProGet_22_0_30_5" because it is currently in use. at Microsoft.Data.SqlClient.SqlConnection.OnError(SqlException exception, Boolean breakConnection, Action`1 wrapCloseInAction) at Microsoft.Data.SqlClient.TdsParser.ThrowExceptionAndWarning(TdsParserStateObject stateObj, Boolean callerHasConnectionLock, Boolean asyncClose) at Microsoft.Data.SqlClient.TdsParser.TryRun(RunBehavior runBehavior, SqlCommand cmdHandler, SqlDataReader dataStream, BulkCopySimpleResultSet bulkCopyHandler, TdsParserStateObject stateObj, Boolean& dataReady) at Microsoft.Data.SqlClient.SqlCommand.InternalEndExecuteNonQuery(IAsyncResult asyncResult, Boolean isInternal, String endMethod) at Microsoft.Data.SqlClient.SqlCommand.EndExecuteNonQueryInternal(IAsyncResult asyncResult) at Microsoft.Data.SqlClient.SqlCommand.EndExecuteNonQueryAsync(IAsyncResult asyncResult) at System.Threading.Tasks.TaskFactory`1.FromAsyncCoreLogic(IAsyncResult iar, Func`2 endFunction, Action`1 endAction, Task`1 promise, Boolean requiresSynchronization) --- End of stack trace from previous location --- at Inedo.Extensions.SqlServer.SqlServerDatabaseProvider.ExecuteQueryAsync(String query, SqlTransaction transaction, CancellationToken cancellationToken) in C:\Users\builds\AppData\Local\Temp\InedoAgent\BuildMaster\192.168.44.60\Temp\_E285736\Src\SqlServer\InedoExtension\DatabaseProviders\SqlServerDatabaseProvider.cs:line 241 at Inedo.BuildMaster.DatabaseConnections.ExecuteStatementJob.ExecuteAsync(CancellationToken cancellationToken) at Inedo.Agents.AgentCommand`1.Inedo.Agents.IAgentCommandWithResponse.ExecuteAsync(Stream responseStream) at Inedo.Agents.AgentCommandDispatcher.ExecuteCommandAsync(AgentCommand command, IClientConnection connection) ClientConnectionId:df7906ec-f087-4a3c-b7e9-d51c4c12da4d Error Number:3702,State:4,Class:16 WARN : 2023-07-01 02:38:39Z - Failed to drop the ProGet_22_0_30_5 database. INFO : 2023-07-01 02:38:40Z - proget-22-0-30-5 INFO : 2023-07-01 02:38:40Z - proget-sql-22-0-30-5 ERROR: 2023-07-01 02:38:40Z - Error response from daemon: No such image: proget.inedo.com/productimages/inedo/proget:22.0.30-ci.5 INFO : 2023-07-01 02:38:41Z - Untagged: proget1000.inedo.com/productimages/inedo/proget:22.0.30-ci.5 INFO : 2023-07-01 02:38:41Z - Untagged: proget1000.inedo.com/productimages/inedo/proget@sha256:f230ee55c930da2a8be2e7b8257838461b86f7914143793fb5367989217b60bc INFO : 2023-07-01 02:38:41Z - Deleted: sha256:ef657ae23955295833149a3606785c7c4408d62d1dab46a84140489c76c5b78d INFO : 2023-07-01 02:38:41Z - Deleted: sha256:96e9ecef670e96037b5069a17a22a86398d785c8adf1b98fa33960ccbdd4eebf INFO : 2023-07-01 02:38:41Z - Deleted: sha256:da2797223e072e47fc4ad254e44d40b584029c87c55f35c6398ff33f5932241e INFO : 2023-07-01 02:38:41Z - Deleted: sha256:608f3a074261105f129d707e4d9ad3d41b5baa94887f092b7c2857f7274a2fce