Skip to content

Instantly share code, notes, and snippets.

@kivikakk
Created May 6, 2019 01:22
Show Gist options
  • Save kivikakk/777c37d27a3b3ee21f37165d589037ba to your computer and use it in GitHub Desktop.
Save kivikakk/777c37d27a3b3ee21f37165d589037ba to your computer and use it in GitHub Desktop.
[2019-05-06 11:07:57 +10:00] GVFSClone (Start) {"Version":"0.2.173.2","EnlistmentRoot":"C:\\Repos\\GVFSFunctionalTests\\enlistment\\cdc34c14441147aeac59","Remote":"https://gvfs.visualstudio.com/ci/_git/ForTests","Branch":"FunctionalTests/20180214","LocalCacheRoot":"C:\\Repos\\GVFSFunctionalTests\\enlistment\\..\\.gvfsCache","SingleBranch":false,"NoMount":false,"NoPrefetch":false,"Unattended":false,"IsElevated":true,"NamedPipeName":"GVFS_C_\\REPOS\\GVFSFUNCTIONALTESTS\\ENLISTMENT\\CDC34C14441147AEAC59","EnlistmentRootPathParameter":"C:\\Repos\\GVFSFunctionalTests\\enlistment\\cdc34c14441147aeac59","fullEnlistmentRootPathParameter":"C:\\Repos\\GVFSFunctionalTests\\enlistment\\cdc34c14441147aeac59"}
[2019-05-06 11:07:57 +10:00] AttemptAnonymousAuth (Start)
[2019-05-06 11:07:58 +10:00] Error {"RepoUrl":"https://gvfs.visualstudio.com/ci/_git/ForTests","ErrorMessage":"Failed to parse credential string for approval"}
[2019-05-06 11:07:58 +10:00] NetworkResponse {"RequestId":1,"availableConnections":2,"CacheName":"","StatusCode":200,"ContentType":"application/json; charset=utf-8","connectionWaitTimeMS":"0.0050","responseWaitTimeMS":"382.0274"}
[2019-05-06 11:07:58 +10:00] AttemptAnonymousAuth (Stop) {"HttpStatus":"200","QuerySucceeded":true,"IsAnonymous":true,"DurationMs":526}
[2019-05-06 11:07:58 +10:00] RetryConfig_LoadedRetryConfig {"Area":"RetryConfig","Timeout":"00:00:30","MaxRetries":6,"Message":"RetryConfigLoaded"}
[2019-05-06 11:07:58 +10:00] Error {"RepoUrl":"https://gvfs.visualstudio.com/ci/_git/ForTests","ErrorMessage":"Failed to parse credential string for approval"}
[2019-05-06 11:07:58 +10:00] NetworkResponse {"RequestId":2,"availableConnections":2,"CacheName":"","StatusCode":200,"ContentType":"application/json; charset=utf-8","connectionWaitTimeMS":"0.0013","responseWaitTimeMS":"236.1119"}
[2019-05-06 11:07:58 +10:00] ValidateGVFSVersion (Start)
[2019-05-06 11:07:58 +10:00] GVFSVersionValidated {"SupportedVersionRange":{"Min":{"Major":0,"Minor":0,"Build":0,"Revision":0,"MajorRevision":0,"MinorRevision":0},"Max":null}}
[2019-05-06 11:07:58 +10:00] ValidateGVFSVersion (Stop) {"DurationMs":12}
[2019-05-06 11:07:59 +10:00] Error {"RepoUrl":"https://gvfs.visualstudio.com/ci/_git/ForTests","ErrorMessage":"Failed to parse credential string for approval"}
[2019-05-06 11:07:59 +10:00] NetworkResponse {"RequestId":3,"availableConnections":2,"CacheName":"","StatusCode":200,"ContentType":"application/x-git-upload-pack-advertisement","connectionWaitTimeMS":"0.0015","responseWaitTimeMS":"252.3748"}
[2019-05-06 11:07:59 +10:00] LocalCacheResolver_ExistingKey {"Area":"LocalCacheResolver","localCacheKey":"3e698f4c50824e3fa347f224d972d1f6","this.enlistment.RepoUrl":"https://gvfs.visualstudio.com/ci/_git/ForTests","currentCacheServer":"None (https://gvfs.visualstudio.com/ci/_git/ForTests)","Message":"TryGetLocalCacheKeyFromLocalConfigOrRemoteCacheServers: Found existing local cache key"}
[2019-05-06 11:07:59 +10:00] CloneVerb_TryDetermineLocalCacheAndInitializePaths {"localCacheRoot":"C:\\Repos\\GVFSFunctionalTests\\.gvfsCache","localCacheKey":"3e698f4c50824e3fa347f224d972d1f6","Message":"Initializing cache paths"}
[2019-05-06 11:08:03 +10:00] Warning {"Area":"AllowAllLocksNamedPipeServer","Header":"PICN","WarningMessage":"HandleRequest: Unknown request"}
[2019-05-06 11:08:03 +10:00] CreateNewEnlistmentId {"enlistmentId":"867cecc4aaae46858a03d469b44f7eca"}
[2019-05-06 11:08:03 +10:00] EnlistmentInfo {"EnlistmentId":"867cecc4aaae46858a03d469b44f7eca","mountId":"bec80edb9fe0412db9aa88ce968cd53b","Enlistment":{"NamedPipeName":"GVFS_C_\\REPOS\\GVFSFUNCTIONALTESTS\\ENLISTMENT\\CDC34C14441147AEAC59","DotGVFSRoot":"C:\\Repos\\GVFSFunctionalTests\\enlistment\\cdc34c14441147aeac59\\.gvfs","GVFSLogsRoot":"C:\\Repos\\GVFSFunctionalTests\\enlistment\\cdc34c14441147aeac59\\.gvfs\\logs","LocalCacheRoot":"C:\\Repos\\GVFSFunctionalTests\\.gvfsCache","BlobSizesRoot":"C:\\Repos\\GVFSFunctionalTests\\.gvfsCache\\3e698f4c50824e3fa347f224d972d1f6\\blobSizes","GitObjectsRoot":"C:\\Repos\\GVFSFunctionalTests\\.gvfsCache\\3e698f4c50824e3fa347f224d972d1f6\\gitObjects","LocalObjectsRoot":"C:\\Repos\\GVFSFunctionalTests\\enlistment\\cdc34c14441147aeac59\\src\\.git\\objects","GitPackRoot":"C:\\Repos\\GVFSFunctionalTests\\.gvfsCache\\3e698f4c50824e3fa347f224d972d1f6\\gitObjects\\pack","GitStatusCacheFolder":"C:\\Repos\\GVFSFunctionalTests\\enlistment\\cdc34c14441147aeac59\\.gvfs\\gitStatusCache","GitStatusCachePath":"C:\\Repos\\GVFSFunctionalTests\\enlistment\\cdc34c14441147aeac59\\.gvfs\\gitStatusCache\\GitStatusCache.dat","GitVersion":"2.20.1.vfs.1.1","GVFSVersion":"0.2.173.2","GVFSHooksVersion":"0.2.173.2","EnlistmentRoot":"C:\\Repos\\GVFSFunctionalTests\\enlistment\\cdc34c14441147aeac59","WorkingDirectoryRoot":"C:\\Repos\\GVFSFunctionalTests\\enlistment\\cdc34c14441147aeac59\\src","DotGitRoot":"C:\\Repos\\GVFSFunctionalTests\\enlistment\\cdc34c14441147aeac59\\src\\.git","RepoUrl":"https://gvfs.visualstudio.com/ci/_git/ForTests","FlushFileBuffersForPacks":true,"GitBinPath":"C:\\Program Files\\Git\\cmd\\git.exe","GVFSHooksRoot":"C:\\Users\\Ashe\\Documents\\GitHub\\BuildOutput\\GVFS.FunctionalTests.Windows\\bin\\x64\\Debug","Authentication":{"IsBackingOff":false,"IsAnonymous":true}},"PhysicalDiskInfo":{"DriveLetter":"C","VolumeDriveType":"Fixed","VolumeFileSystem":"NTFS","VolumeFileSystemLabel":"","VolumeSize":"128014671872","VolumeSizeRemaining":"67370852352","DiskNumber":"0","DiskModel":"VMware Virtual S","DiskIsSystem":"True","DiskIsBoot":"True","DiskSerialNumber":"","PhysicalMediaType":"SSD","PhysicalBusType":"SAS","PhysicalSpindleSpeed":"0"}}
[2019-05-06 11:08:04 +10:00] GVFSClone (Stop) {"DurationMs":7200}
[2019-05-06 11:08:13 +10:00] GVFSMount (Start) {"Version":"0.2.173.2","EnlistmentRoot":"C:\\Repos\\GVFSFunctionalTests\\enlistment\\cdc34c14441147aeac59","Remote":"https://gvfs.visualstudio.com/ci/_git/ForTests","ObjectsEndpoint":"https://gvfs.visualstudio.com/ci/_git/ForTests","IsElevated":true,"EnlistmentRootPathParameter":"C:\\Repos\\GVFSFunctionalTests\\enlistment\\cdc34c14441147aeac59","StartedByService":"False"}
[2019-05-06 11:08:14 +10:00] RetryConfig_LoadedRetryConfig {"Area":"RetryConfig","Timeout":"00:00:30","MaxRetries":6,"Message":"RetryConfigLoaded"}
[2019-05-06 11:08:15 +10:00] GitStatusCacheConfig_Loaded {"Area":"GitStatusCacheConfig","BackOffTime":"00:00:02","Message":"GitStatusCacheConfigLoaded"}
[2019-05-06 11:08:15 +10:00] CachePathsLoaded {"gitObjectsRoot":"C:\\Repos\\GVFSFunctionalTests\\.gvfsCache\\3e698f4c50824e3fa347f224d972d1f6\\gitObjects","localCacheRoot":"C:\\Repos\\GVFSFunctionalTests\\.gvfsCache","blobSizesRoot":"C:\\Repos\\GVFSFunctionalTests\\.gvfsCache\\3e698f4c50824e3fa347f224d972d1f6\\blobSizes"}
[2019-05-06 11:08:15 +10:00] Mount_StartedNamedPipe {"NamedPipeName":"GVFS_C_\\REPOS\\GVFSFUNCTIONALTESTS\\ENLISTMENT\\CDC34C14441147AEAC59"}
[2019-05-06 11:08:15 +10:00] AttemptAnonymousAuth (Start)
[2019-05-06 11:08:16 +10:00] Error {"RepoUrl":"https://gvfs.visualstudio.com/ci/_git/ForTests","ErrorMessage":"Failed to parse credential string for approval"}
[2019-05-06 11:08:16 +10:00] NetworkResponse {"RequestId":1,"availableConnections":2,"CacheName":"","StatusCode":200,"ContentType":"application/json; charset=utf-8","connectionWaitTimeMS":"0.0095","responseWaitTimeMS":"541.9495"}
[2019-05-06 11:08:16 +10:00] AttemptAnonymousAuth (Stop) {"HttpStatus":"200","QuerySucceeded":true,"IsAnonymous":true,"DurationMs":796}
[2019-05-06 11:08:16 +10:00] Information {"Message":"Git status cache enabled. Backoff time: 2000ms"}
[2019-05-06 11:08:16 +10:00] BlobSize_Initialize_db_settings {"Area":"BlobSizes","user_version":1,"synchronous":2}
[2019-05-06 11:08:16 +10:00] FileSystemCallbacks_Constructor {"placeholders.Count":0,"background.Count":0,"Message":"FileSystemCallbacks created"}
[2019-05-06 11:08:16 +10:00] RemoveEntriesWithParentFolderEntry (Start)
[2019-05-06 11:08:16 +10:00] RemoveEntriesWithParentFolderEntry (Stop) {"startingCount":1,"EndCount":1,"DurationMs":1}
[2019-05-06 11:08:16 +10:00] ParseGitIndex (Start)
[2019-05-06 11:08:16 +10:00] ExpandPool (Start)
[2019-05-06 11:08:16 +10:00] ExpandPool (Stop) {"Area":"GitIndexProjection","PoolType":"FolderData","PreviousSize":148,"NewSize":170,"DurationMs":0}
[2019-05-06 11:08:16 +10:00] ExpandPool (Start)
[2019-05-06 11:08:16 +10:00] ExpandPool (Stop) {"Area":"GitIndexProjection","PoolType":"FolderData","PreviousSize":170,"NewSize":196,"DurationMs":0}
[2019-05-06 11:08:16 +10:00] ExpandPool (Start)
[2019-05-06 11:08:16 +10:00] ExpandPool (Stop) {"Area":"GitIndexProjection","PoolType":"FolderData","PreviousSize":196,"NewSize":225,"DurationMs":0}
[2019-05-06 11:08:16 +10:00] ExpandPool (Start)
[2019-05-06 11:08:16 +10:00] ExpandPool (Stop) {"Area":"GitIndexProjection","PoolType":"FolderData","PreviousSize":225,"NewSize":259,"DurationMs":0}
[2019-05-06 11:08:16 +10:00] ExpandPool (Start)
[2019-05-06 11:08:16 +10:00] ExpandPool (Stop) {"Area":"GitIndexProjection","PoolType":"FolderData","PreviousSize":259,"NewSize":298,"DurationMs":0}
[2019-05-06 11:08:16 +10:00] ExpandPool (Start)
[2019-05-06 11:08:16 +10:00] ExpandPool (Stop) {"Area":"GitIndexProjection","PoolType":"FolderData","PreviousSize":298,"NewSize":343,"DurationMs":0}
[2019-05-06 11:08:16 +10:00] Information {"Message":"Finished parsing 873 index entries."}
[2019-05-06 11:08:16 +10:00] ShrinkPool (Start)
[2019-05-06 11:08:16 +10:00] ShrinkPool (Stop) {"Area":"GitIndexProjection","PoolType":"FolderData","CurrentSize":343,"didShrink":false,"shrinkToSize":372,"DurationMs":0}
[2019-05-06 11:08:16 +10:00] ShrinkPool (Start)
[2019-05-06 11:08:16 +10:00] ShrinkPool (Stop) {"Area":"GitIndexProjection","PoolType":"FileData","CurrentSize":960,"didShrink":false,"shrinkToSize":959,"DurationMs":0}
[2019-05-06 11:08:16 +10:00] ShrinkPool (Start)
[2019-05-06 11:08:16 +10:00] ShrinkPool (Stop) {"Area":"GitIndexProjection","PoolType":"Byte","CurrentSize":26190,"didShrink":false,"shrinkToSize":26070,"DurationMs":0}
[2019-05-06 11:08:16 +10:00] ShrinkPool (Start)
[2019-05-06 11:08:16 +10:00] ShrinkPool (Stop) {"Area":"GitIndexProjection","PoolType":"LazyUTF8String","CurrentSize":2095,"didShrink":true,"shrinkToSize":1874,"DurationMs":0}
[2019-05-06 11:08:16 +10:00] ParseGitIndex (Stop) {"Area":"GitIndexProjection","SortedFolderEntries_FolderPoolSize":343,"SortedFolderEntries_FilePoolSize":960,"LazyUTF8String_StringPoolSize":1874,"LazyUTF8String_BytePoolSize":26190,"DurationMs":26}
[2019-05-06 11:08:16 +10:00] InitializeEnumerationPatternMatcher {"projFSPatternMatchingWorks":true}
[2019-05-06 11:08:16 +10:00] Error {"ErrorMessage":"Failed to initialize src folder callbacks. System.InvalidOperationException: Virtualization instance in invalid state.\r\n at Microsoft.Windows.ProjFS.VirtualizationInstance.StopVirtualizing() in c:\\ba\\362\\s\\projectedfslib.managed.api\\virtualizationinstance.cpp:line 733\r\n at Microsoft.Windows.ProjFS.VirtualizationInstance.StartVirtualizing(IRequiredCallbacks requiredCallbacks) in c:\\ba\\362\\s\\projectedfslib.managed.api\\virtualizationinstance.cpp:line 681\r\n at GVFS.Platform.Windows.WindowsFileSystemVirtualizer.TryStart(String& error) in C:\\Users\\Ashe\\Documents\\GitHub\\VFSForGit\\GVFS\\GVFS.Platform.Windows\\WindowsFileSystemVirtualizer.cs:line 568\r\n at GVFS.Virtualization.FileSystem.FileSystemVirtualizer.TryStart(FileSystemCallbacks fileSystemCallbacks, String& error)\r\n at GVFS.Virtualization.FileSystemCallbacks.TryStart(String& error)\r\n at GVFS.Mount.InProcessMount.MountAndStartWorkingDirectoryCallbacks(CacheServerInfo cache) in C:\\Users\\Ashe\\Documents\\GitHub\\VFSForGit\\GVFS\\GVFS.Mount\\InProcessMount.cs:line 573"}
[2019-05-06 11:08:16 +10:00] Error {"ErrorMessage":"Failed to mount: A task may only be disposed if it is in a completion state (RanToCompletion, Faulted or Canceled)."}
[2019-05-06 11:08:10 +10:00] PreMount (Start) {"Version":"0.2.173.2","EnlistmentRoot":"C:\\Repos\\GVFSFunctionalTests\\enlistment\\cdc34c14441147aeac59","Remote":"https://gvfs.visualstudio.com/ci/_git/ForTests","ObjectsEndpoint":"https://gvfs.visualstudio.com/ci/_git/ForTests","Unattended":false,"IsElevated":true,"NamedPipeName":"GVFS_C_\\REPOS\\GVFSFUNCTIONALTESTS\\ENLISTMENT\\CDC34C14441147AEAC59","EnlistmentRootPathParameter":"C:\\Repos\\GVFSFunctionalTests\\enlistment\\cdc34c14441147aeac59"}
[2019-05-06 11:08:10 +10:00] IsNativeLibInstalled {"Area":"ProjFSFilter","system32Path":"C:\\WINDOWS\\system32\\ProjectedFSLib.dll","existsInSystem32":true,"gvfsAppDirectory":"C:\\Users\\Ashe\\Documents\\GitHub\\BuildOutput\\GVFS.FunctionalTests.Windows\\bin\\x64\\Debug","nonInboxNativeLibInstallPath":"C:\\Users\\Ashe\\Documents\\GitHub\\BuildOutput\\GVFS.FunctionalTests.Windows\\bin\\x64\\Debug\\ProjectedFSLib.dll","packagedNativeLibPath":"C:\\Users\\Ashe\\Documents\\GitHub\\BuildOutput\\GVFS.FunctionalTests.Windows\\bin\\x64\\Debug\\ProjFS\\ProjectedFSLib.dll","existsInAppDirectory":false}
[2019-05-06 11:08:10 +10:00] Information {"Message":"Finished parsing 873 index entries."}
[2019-05-06 11:08:16 +10:00] PreMount (Stop) {"DurationMs":7215}
[2019-05-06 11:08:05 +10:00] Prefetch (Start) {"Version":"0.2.173.2","EnlistmentRoot":"C:\\Repos\\GVFSFunctionalTests\\enlistment\\cdc34c14441147aeac59","Remote":"https://gvfs.visualstudio.com/ci/_git/ForTests","ObjectsEndpoint":"https://gvfs.visualstudio.com/ci/_git/ForTests"}
[2019-05-06 11:08:05 +10:00] PerformPrefetch {"Commits":true,"Files":null,"Folders":null,"FileListFile":null,"FoldersListFile":null,"FilesFromStdIn":false,"FoldersFromStdIn":false,"HydrateFiles":false}
[2019-05-06 11:08:05 +10:00] RetryConfig_LoadedRetryConfig {"Area":"RetryConfig","Timeout":"00:00:30","MaxRetries":6,"Message":"RetryConfigLoaded"}
[2019-05-06 11:08:06 +10:00] Error {"RepoUrl":"https://gvfs.visualstudio.com/ci/_git/ForTests","ErrorMessage":"Failed to parse credential string for approval"}
[2019-05-06 11:08:06 +10:00] NetworkResponse {"RequestId":4,"availableConnections":2,"CacheName":"","StatusCode":200,"ContentType":"text/html","connectionWaitTimeMS":"0.0019","responseWaitTimeMS":"249.5311"}
[2019-05-06 11:08:06 +10:00] DeserializePrefetchPacks (Start)
[2019-05-06 11:08:06 +10:00] DeserializePrefetchPacks (Stop) {"DurationMs":2}
[2019-05-06 11:08:06 +10:00] TryDownloadPrefetchPacks (Stop) {"Area":"GitObjects","Success":true,"Attempts":1,"BytesDownloaded":0,"DurationMs":256}
[2019-05-06 11:08:09 +10:00] Warning {"Area":"PrefetchStep","WarningMessage":"Failed to connect to GVFS.Mount process. Skipping post-fetch job request."}
[2019-05-06 11:08:09 +10:00] Prefetch (Stop) {"DurationMs":4342}
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment