Vscode-gitlens: Line and file history not working in symlinked repository

[theseion]

• GitLens Version: 9.5.1
• VSCode Version: 1.32.1
• OS Version: macOS 10.14.3

Steps to Reproduce:

1. Create a repository (with some commits) at some arbitrary location (e.g. ~/myrepo)
2. Create a symlink to a parent directory of the repository (e.g. ~/mysymlink -> ~)
3. Open VS Code via the symlink, e.g. code ~/mysymlink/myrepo
4. Open a file.

The logs were obtained right after opening a file. As you can see, there are a couple of path concatenation problems (e.g. /apps/theapp/release/theapp/view/navigation).
I have a global symlink /apps pointing to ~/company and a repository at ~/company/theapp/release. I open the repository with code /apps/theapp/release. Line and file history work fine when opening the repository with code ~/company/theapp/release.

Note: VS Code apparently also thinks that those are two different projects, i.e. the state of open files is different the above commands. Maybe this issue will have to be moved to VS Code.

Gitlens debug log:
Debug log:

[2019-03-08 09:34:29:892] [11e] GitUri.fromUri — e=Uri(file:///apps/theapp/release/theapp/view/navigation/Scroll.js)
[2019-03-08 09:34:29:892] [11f] GitService.getRepoPath — e=Uri(file:///apps/theapp/release/theapp/view/navigation/Scroll.js)
[2019-03-08 09:34:29:893] [120] GitService.getRepository — e=Uri(file:///apps/theapp/release/theapp/view/navigation/Scroll.js), t={"skipCacheUpdate":true}
[2019-03-08 09:34:29:900] [120] GitService.getRepository returned undefined • 7 ms
[2019-03-08 09:34:29:915] [/apps/theapp/release/theapp/view/navigation] git rev-parse --show-toplevel • 14 ms 
[2019-03-08 09:34:29:915] [11f] GitService.getRepoPath returned /Users/me/company/theapp/release • 22 ms
[2019-03-08 09:34:29:915] [11e] GitUri.fromUri returned GitUri(file:///apps/theapp/release/theapp/view/navigation/Scroll.js repoPath=/Users/me/company/theapp/release) • 22 ms
[2019-03-08 09:34:29:916] [121] GitService.getRepository — e=GitUri(file:///apps/theapp/release/theapp/view/navigation/Scroll.js repoPath=/Users/me/company/theapp/release)
[2019-03-08 09:34:29:916] [121] GitService.getRepository returned /Users/me/company/theapp/release • 0 ms
[2019-03-08 09:34:29:916] [122] GitService.isTracked returned true • 0 ms — e=GitUri(file:///apps/theapp/release/theapp/view/navigation/Scroll.js repoPath=/Users/me/company/theapp/release)
[2019-03-08 09:34:30:085] [123] GitService.getBlameForFile — e=GitUri(file:///apps/theapp/release/theapp/view/navigation/Scroll.js repoPath=/Users/me/company/theapp/release)
[2019-03-08 09:34:30:085] [123] GitService.getBlameForFile Cache miss: 'blame'
[2019-03-08 09:34:30:085] [123] GitService.getBlameForFile Cache add: 'blame'
[2019-03-08 09:34:30:085] [124] GitService.isTracked returned true • 0 ms — e=GitUri(file:///apps/theapp/release/theapp/view/navigation/Scroll.js repoPath=/Users/me/company/theapp/release)
[2019-03-08 09:34:30:143] [125] GitService.getBlameForLine — e=GitUri(file:///apps/theapp/release/theapp/view/navigation/Scroll.js repoPath=/Users/me/company/theapp/release), t=119
[2019-03-08 09:34:30:143] [126] GitService.getBlameForFile — e=GitUri(file:///apps/theapp/release/theapp/view/navigation/Scroll.js repoPath=/Users/me/company/theapp/release)
[2019-03-08 09:34:30:144] [126] GitService.getBlameForFile Cache hit: 'blame'
[2019-03-08 09:34:30:319] [/Users/me/company/theapp/release] git blame --root --incremental -- /apps/theapp/release/theapp/view/navigation/Scroll.js • 233 ms 
[2019-03-08 09:34:30:319] [127] GitService.getCurrentUser — e=/Users/me/company/theapp/release
[2019-03-08 09:34:30:319] [127] GitService.getCurrentUser completed • 0 ms
[2019-03-08 09:34:30:324] [123] GitService.getBlameForFile completed • 239 ms
[2019-03-08 09:34:30:324] [126] GitService.getBlameForFile completed • 180 ms
[2019-03-08 09:34:30:324] [125] GitService.getBlameForLine completed • 180 ms
[2019-03-08 09:34:30:394] [128] RepositoriesNode(0).onActiveEditorChanged
[2019-03-08 09:34:30:394] [128] RepositoriesNode(0).onActiveEditorChanged completed • 0 ms
[2019-03-08 09:34:30:394] [129] FileHistoryTrackerNode(0).onActiveEditorChanged
[2019-03-08 09:34:30:394] [12a] FileHistoryTrackerNode(0).triggerChange
[2019-03-08 09:34:30:394] [12b] FileHistoryView.refreshNode — e=FileHistoryTrackerNode
[2019-03-08 09:34:30:394] [12c] FileHistoryTrackerNode(0).refresh — false
[2019-03-08 09:34:30:394] [12d] GitUri.fromUri — e=Uri(file:///apps/theapp/release/theapp/view/navigation/Scroll.js)
[2019-03-08 09:34:30:395] [12e] GitService.getRepoPath — e=Uri(file:///apps/theapp/release/theapp/view/navigation/Scroll.js)
[2019-03-08 09:34:30:395] [12f] GitService.getRepository — e=Uri(file:///apps/theapp/release/theapp/view/navigation/Scroll.js), t={"skipCacheUpdate":true}
[2019-03-08 09:34:30:395] [129] FileHistoryTrackerNode(0).onActiveEditorChanged completed • 0 ms
[2019-03-08 09:34:30:395] [12f] GitService.getRepository returned undefined • 0 ms
[2019-03-08 09:34:30:409] [/apps/theapp/release/theapp/view/navigation] git rev-parse --show-toplevel • 13 ms 
[2019-03-08 09:34:30:409] [12e] GitService.getRepoPath returned /Users/me/company/theapp/release • 14 ms
[2019-03-08 09:34:30:410] [12d] GitUri.fromUri returned GitUri(file:///apps/theapp/release/theapp/view/navigation/Scroll.js repoPath=/Users/me/company/theapp/release) • 15 ms
[2019-03-08 09:34:30:410] [130] FileHistoryTrackerNode(0).resetChild
[2019-03-08 09:34:30:410] [130] FileHistoryTrackerNode(0).resetChild completed • 0 ms
[2019-03-08 09:34:30:410] [12c] FileHistoryTrackerNode(0).refresh returned false, uri=GitUri(file:///apps/theapp/release/theapp/view/navigation/Scroll.js repoPath=/Users/me/company/theapp/release) • 15 ms
[2019-03-08 09:34:30:410] [131] FileHistoryView.triggerNodeChange — e=FileHistoryTrackerNode
[2019-03-08 09:34:30:410] [131] FileHistoryView.triggerNodeChange completed • 0 ms
[2019-03-08 09:34:30:410] [12b] FileHistoryView.refreshNode completed • 16 ms
[2019-03-08 09:34:30:410] [12a] FileHistoryTrackerNode(0).triggerChange completed • 16 ms
[2019-03-08 09:34:30:486] GitCodeLensProvider.provideCodeLenses: — 1 symbol(s) found
[2019-03-08 09:34:30:579] [132] LineHistoryTrackerNode(0).onActiveLinesChanged
[2019-03-08 09:34:30:579] [133] LineHistoryTrackerNode(0).triggerChange
[2019-03-08 09:34:30:580] [134] LineHistoryView.refreshNode — e=LineHistoryTrackerNode
[2019-03-08 09:34:30:580] [135] LineHistoryTrackerNode(0).refresh — false
[2019-03-08 09:34:30:580] [132] LineHistoryTrackerNode(0).onActiveLinesChanged completed • 1 ms
[2019-03-08 09:34:30:581] [135] LineHistoryTrackerNode(0).refresh completed, uri=GitUri(file:///apps/theapp/release/theapp/view/navigation/Scroll.js repoPath=/Users/me/company/theapp/release) • 0 ms
[2019-03-08 09:34:30:581] [134] LineHistoryView.refreshNode completed • 1 ms
[2019-03-08 09:34:30:581] [133] LineHistoryTrackerNode(0).triggerChange completed • 1 ms
[2019-03-08 09:34:30:618] [136] FileHistoryNode(0).ensureSubscription
[2019-03-08 09:34:30:618] [137] FileHistoryNode(0).subscribe
[2019-03-08 09:34:30:619] [138] GitService.getRepository — e=GitUri(file:///Users/me/company/theapp/release/apps/theapp/release/theapp/view/navigation/Scroll.js repoPath=/Users/me/company/theapp/release)
[2019-03-08 09:34:30:620] [138] GitService.getRepository returned /Users/me/company/theapp/release • 0 ms
[2019-03-08 09:34:30:620] [137] FileHistoryNode(0).subscribe completed • 1 ms
[2019-03-08 09:34:30:620] [136] FileHistoryNode(0).ensureSubscription completed • 1 ms
[2019-03-08 09:34:30:625] [139] GitService.getStatusForFile — e=/Users/me/company/theapp/release, t=/Users/me/company/theapp/release/apps/theapp/release/theapp/view/navigation/Scroll.js
[2019-03-08 09:34:30:644] [/Users/me/company/theapp/release] git status --porcelain=v2 -- apps/theapp/release/theapp/view/navigation/Scroll.js • 18 ms 
[2019-03-08 09:34:30:644] [139] GitService.getStatusForFile completed • 18 ms
[2019-03-08 09:34:30:645] [13a] GitService.getLogForFile — e=/Users/me/company/theapp/release, t=/Users/me/company/theapp/release/apps/theapp/release/theapp/view/navigation/Scroll.js, i={}
[2019-03-08 09:34:30:646] [13a] GitService.getLogForFile Cache hit: 'log:follow'
[2019-03-08 09:34:30:646] [13a] GitService.getLogForFile completed • 1 ms
[2019-03-08 09:34:47:800] [13b] RepositoriesNode(0).onActiveEditorChanged
[2019-03-08 09:34:47:800] [13b] RepositoriesNode(0).onActiveEditorChanged completed • 0 ms
[2019-03-08 09:34:47:800] [13c] FileHistoryTrackerNode(0).onActiveEditorChanged
[2019-03-08 09:34:47:800] [13d] FileHistoryTrackerNode(0).triggerChange
[2019-03-08 09:34:47:800] [13e] FileHistoryView.refreshNode — e=FileHistoryTrackerNode
[2019-03-08 09:34:47:800] [13f] FileHistoryTrackerNode(0).refresh — false
[2019-03-08 09:34:47:801] [13c] FileHistoryTrackerNode(0).onActiveEditorChanged completed • 0 ms
[2019-03-08 09:34:47:801] [13f] FileHistoryTrackerNode(0).refresh returned true • 0 ms
[2019-03-08 09:34:47:801] [13e] FileHistoryView.refreshNode completed • 0 ms
[2019-03-08 09:34:47:801] [13d] FileHistoryTrackerNode(0).triggerChange completed • 1 ms

Gitlens (Git) debug log:

[2019-03-08 09:34:21:518] [/Users/me/Library/Application Support/Code/User] git rev-parse --show-toplevel • 13 ms 
[2019-03-08 09:34:29:915] [/apps/theapp/release/theapp/view/navigation] git rev-parse --show-toplevel • 14 ms 
[2019-03-08 09:34:30:319] [/Users/me/theapp/release] git blame --root --incremental -- /apps/theapp/release/theapp/view/navigation/Scroll.js • 233 ms 
[2019-03-08 09:34:30:409] [/apps/theapp/release/theapp/view/navigation] git rev-parse --show-toplevel • 13 ms 
[2019-03-08 09:34:30:644] [/Users/me/theapp/release] git status --porcelain=v2 -- apps/theapp/release/theapp/view/navigation/Scroll.js • 18 ms

[SimonKagstrom]

Not sure if this is the same problem, but I have a slightly different structure:

git repo:

~/my_repo/module_foo/<...>
~/my_repo/module_bar/<...>

We build multiple projects, some which use module_foo and some which use module_bar. To workaround other vscode issues, I've setup symlinks like this:

vscode_workspace/module_foo -> ~/my_repo/module_foo

and with this, gitlens doesn't figure out that module_foo is a git repo. Using gitk in the symlink works though.

[x13machine]

How do I get these logs? I went to Help -> Toggle Developers tools. I couldn't reproduce this bug. I only saw one git repo in the gitlens panel. I did "code apps/theapp/release"

My directory tree:

.
├── apps -> company
└── company
    └── theapp
        └── release
            ├── re
            │   └── ja.txt
            └── README.md

5 directories, 2 files

[theseion]

You'll have to enable debug logging in GitLens. Search for gitlens debug in the settings, then check Gitlens: Debug and make sure that the output level is set to debug.
Once you've done that you'll see the output in the Gitlab output panel (if it's not open, click on the dropdown in the Output panel and select GitLens.

The GitLens panel only shows multiple repositories once you've opened files from multiple repositories (AFAIK).

[fantapop]

I'm in the same boat as @SimonKagstrom .

I've enabled gitlens logging and I see this:

[2019-05-01 22:36:26:751] [10] GitService.getRepoPath
[2019-05-01 22:36:26:751] [11] GitService.getRepository
[2019-05-01 22:36:26:752] [11] GitService.getRepository returned undefined • 0 ms
[2019-05-01 22:36:26:767] [/home/chris/.config/Code/User] git rev-parse --show-toplevel • 14 ms 
[2019-05-01 22:36:26:767] [10] GitService.getRepoPath returned undefined • 15 ms
[2019-05-01 22:36:26:767] [12] GitService.getRepository
[2019-05-01 22:36:26:767] [12] GitService.getRepository returned undefined • 0 ms
[2019-05-01 22:36:26:781] [] git ls-files -- /home/chris/.config/Code/User/settings.json • 13 ms 
[2019-05-01 22:36:26:781] [13] GitService.isTracked returned false • 14 ms

[ryansully]

This could be related to https://github.com/Microsoft/vscode/issues/5970.

[patpating]

Not sure if this is the same problem, but I have a slightly different structure:

git repo:

~/my_repo/module_foo/<...>
~/my_repo/module_bar/<...>

We build multiple projects, some which use module_foo and some which use module_bar. To workaround other vscode issues, I've setup symlinks like this:

vscode_workspace/module_foo -> ~/my_repo/module_foo

and with this, gitlens doesn't figure out that module_foo is a git repo. Using gitk in the symlink works though.

have the same setup.

~/my_repo/module_foo/<...>
~/my_repo/module_bar/<...>

~/Workspace/project1/module_foo -> ~/my_repo/module_foo
~/Workspace/project2/module_bar -> ~/my_repo/module_bar

File History works in v8.5.6, stopped working from v9 and up. just tried again with v10.1.1
somehow, the Repositories view is able to pick up the repo... but not the File and Line History

will go back to using 8.5.6 for now until this is resolved.

[eamodio]

@theseion @fantapop @ryansully @patpating @ampresent @marocas @an-yun

I've put in a "fix" for this issue in a new build, could you all give it a try and report back?

gitlens-10.1.3-alpha.vsix.zip

Just remove the .zip and then install the vsix into vscode.

[theseion]

Thanks @eamodio. Unfortunately, I'm still seeing the erroneous path concatenation in the debug output and the behaviour appears to be the same as before.

Activation of the alpha succeeded:

[2019-11-12 07:33:54:387] GitLens upgraded from v10.1.2 to v10.1.3-alpha
[2019-11-12 07:33:54:387] GitLens (v10.1.3-alpha) activated • 208 ms

Same problems as before, e.g.:

[2019-11-12 07:34:36:080] [a1] LineHistoryNode(gitlens:repository(/Users/me/company/theapp/server):history:line(file:///Users/me/company/theapp/server/apps/theapp/server/scripts/coupon/pdf_coupon.py[0,0-0,0])).ensureSubscription
[2019-11-12 07:34:36:080] [a2] LineHistoryNode(gitlens:repository(/Users/me/company/theapp/server):history:line(file:///Users/me/company/theapp/server/apps/theapp/server/scripts/coupon/pdf_coupon.py[0,0-0,0])).subscribe

[eamodio]

Can you try this version? And then post the log lines around No symlink detected; or Symlink detected;

gitlens-10.1.3-alpha.vsix.zip

[theseion]

[2019-11-12 08:04:10:550] GitLens (v10.1.3-alpha) activated • 350 ms
[2019-11-12 08:04:10:551] [7] LineAnnotationController.refresh completed • Skipped because there is no valid editor or no valid lines • 28 ms
[2019-11-12 08:04:10:589] [/apps/theapp/server] git rev-parse --show-toplevel • 87 ms 
[2019-11-12 08:04:10:594] [4] GitService.getRepoPathCore No symlink detected; repoPath=/Users/me/company/theapp/server
[2019-11-12 08:04:10:595] [4] GitService.getRepoPathCore completed • 95 ms
[2019-11-12 08:04:10:595] [3] GitService.repositorySearch(/apps/theapp/server) found root repository in '/Users/me/company/theapp/server'
[2019-11-12 08:04:10:598] [b] GitService.repositorySearchCore — e=/apps/theapp/server, t=1
[2019-11-12 08:04:10:605] [c] GitService.repositorySearchCore — e=/apps/theapp/server/.vscode, t=0
[2019-11-12 08:04:10:621] [c] GitService.repositorySearchCore completed • 16 ms
[2019-11-12 08:04:10:621] [d] GitService.repositorySearchCore — e=/apps/theapp/server/config, t=0
[2019-11-12 08:04:10:629] [d] GitService.repositorySearchCore completed • 7 ms
[2019-11-12 08:04:10:629] [e] GitService.repositorySearchCore — e=/apps/theapp/server/hosts, t=0
[2019-11-12 08:04:10:632] [e] GitService.repositorySearchCore completed • 3 ms
[2019-11-12 08:04:10:632] [f] GitService.repositorySearchCore — e=/apps/theapp/server/scripts, t=0
[2019-11-12 08:04:10:633] [f] GitService.repositorySearchCore completed • 0 ms
[2019-11-12 08:04:10:633] [b] GitService.repositorySearchCore completed • 34 ms
[2019-11-12 08:04:10:633] [3] GitService.repositorySearch(/apps/theapp/server) searching in '/apps/theapp/server'...
[2019-11-12 08:04:10:633] [10] GitService.getRepoPathCore — e=/apps/theapp/server, t=true
[2019-11-12 08:04:10:653] [/apps/theapp/server] git rev-parse --show-toplevel • 19 ms 
[2019-11-12 08:04:10:654] [10] GitService.getRepoPathCore No symlink detected; repoPath=/Users/me/company/theapp/server
[2019-11-12 08:04:10:654] [10] GitService.getRepoPathCore completed • 20 ms
[2019-11-12 08:04:10:654] [3] GitService.repositorySearch(/apps/theapp/server) found repository in '/Users/me/company/theapp/server'
[2019-11-12 08:04:10:655] [3] GitService.repositorySearch(/apps/theapp/server) returned 2 repositories (/Users/me/company/theapp/server, /Users/me/company/theapp/server) • 154 ms

[eamodio]

@theseion can you also provide me with a folder/symlink layout for the above? Like what the folder structure looks like

[theseion]

/apps is a symlink to /Users/me/company.
The repository root is at /Users/me/company/theapp/server.
There are several apps and repositories under /Users/me/company, e.g.
/Users/me/company/theapp/repo2
/Users/me/company/theapp/repo3
/Users/me/company/anotherApp/repo1
/Users/me/company/anotherApp/repo2

I adress all of these via /apps, e.g. /apps/anotherApp/repo1

HTH

[an-yun]

@eamodio I have tried this version , but it still doesn't work. Here are the outputs.

The folder/symlink layout is in here.

[eamodio]

@theseion @an-yun Can you try this one:
gitlens-10.1.3-alpha.vsix.zip

[theseion]

At first glance I thought it now worked but I still found a situation where it doesn't. This is the output right after opening a file where I don't get any file or line history:

[2019-11-15 08:40:55:414] [1e5] LineAnnotationController.onActiveLinesChanged — e=editor=undefined, lines=undefined, pending=false, reason=editor
[2019-11-15 08:40:55:414] [1e6] LineAnnotationController.clear completed • 0 ms
[2019-11-15 08:40:55:414] [1e5] LineAnnotationController.onActiveLinesChanged completed • 0 ms
[2019-11-15 08:40:55:414] [1e7] LineHoverController.onActiveLinesChanged — e=editor=undefined, lines=undefined, pending=false, reason=editor
[2019-11-15 08:40:55:414] [1e7] LineHoverController.onActiveLinesChanged completed • 0 ms
[2019-11-15 08:40:55:414] [1e8] StatusBarController.onActiveLinesChanged — e=editor=undefined, lines=undefined, pending=false, reason=editor
[2019-11-15 08:40:55:414] [1e8] StatusBarController.onActiveLinesChanged completed • 0 ms
[2019-11-15 08:40:55:557] [1e9] GitUri.fromUri — e=Uri(file:///apps/theapp/server/scripts/coupon/pdf_coupon.py)
[2019-11-15 08:40:55:557] [1ea] GitService.getRepoPath — e=Uri(file:///apps/theapp/server/scripts/coupon/pdf_coupon.py)
[2019-11-15 08:40:55:557] [1eb] GitService.getRepository — e=Uri(file:///apps/theapp/server/scripts/coupon/pdf_coupon.py), t={"skipCacheUpdate":true}
[2019-11-15 08:40:55:561] [1ec] LineAnnotationController.onActiveLinesChanged — e=editor=file:///apps/theapp/server/scripts/coupon/pdf_coupon.py, lines=undefined, pending=true, reason=selection
[2019-11-15 08:40:55:561] [1ed] LineAnnotationController.clear completed • 0 ms
[2019-11-15 08:40:55:561] [1ec] LineAnnotationController.onActiveLinesChanged completed • 0 ms
[2019-11-15 08:40:55:561] [1ee] LineHoverController.onActiveLinesChanged — e=editor=file:///apps/theapp/server/scripts/coupon/pdf_coupon.py, lines=undefined, pending=true, reason=selection
[2019-11-15 08:40:55:561] [1ee] LineHoverController.onActiveLinesChanged completed • 0 ms
[2019-11-15 08:40:55:561] [1ef] StatusBarController.onActiveLinesChanged — e=editor=file:///apps/theapp/server/scripts/coupon/pdf_coupon.py, lines=undefined, pending=true, reason=selection
[2019-11-15 08:40:55:561] [1ef] StatusBarController.onActiveLinesChanged completed • 0 ms
[2019-11-15 08:40:55:572] [1eb] GitService.getRepository returned undefined • 14 ms
[2019-11-15 08:40:55:572] [1f0] GitService.getRepoPathCore — e=/apps/theapp/server/scripts/coupon/pdf_coupon.py, t=false
[2019-11-15 08:40:55:596] [/apps/theapp/server/scripts/coupon] git rev-parse --show-toplevel • 23 ms 
[2019-11-15 08:40:55:596] [1f0] GitService.getRepoPathCore completed • 23 ms
[2019-11-15 08:40:55:597] [1ea] GitService.getRepoPath returned /Users/me/company/theapp/server • 39 ms
[2019-11-15 08:40:55:597] [1e9] GitUri.fromUri returned GitUri(file:///apps/theapp/server/scripts/coupon/pdf_coupon.py repoPath=/Users/me/company/theapp/server) • 39 ms
[2019-11-15 08:40:55:597] [1f1] GitService.getRepository — e=GitUri(file:///apps/theapp/server/scripts/coupon/pdf_coupon.py repoPath=/Users/me/company/theapp/server)
[2019-11-15 08:40:55:597] [1f1] GitService.getRepository returned /Users/me/company/theapp/server • 0 ms
[2019-11-15 08:40:55:597] [1f2] GitService.isTracked returned true • 0 ms — e=GitUri(file:///apps/theapp/server/scripts/coupon/pdf_coupon.py repoPath=/Users/me/company/theapp/server)
[2019-11-15 08:40:55:677] [1f3] LineHistoryTrackerNode.onActiveLinesChanged — e=editor=undefined, lines=undefined, pending=false, reason=editor
[2019-11-15 08:40:55:677] [1f4] LineHistoryTrackerNode.triggerChange
[2019-11-15 08:40:55:677] [1f5] LineHistoryView.refreshNode — e=LineHistoryTrackerNode, t=false
[2019-11-15 08:40:55:677] [1f6] LineHistoryTrackerNode.refresh — false
[2019-11-15 08:40:55:677] [1f7] GitUri.fromUri — e=Uri(file:///apps/theapp/server/scripts/coupon/pdf_coupon.py)
[2019-11-15 08:40:55:677] [1f8] GitService.getRepoPath — e=Uri(file:///apps/theapp/server/scripts/coupon/pdf_coupon.py)
[2019-11-15 08:40:55:677] [1f9] GitService.getRepository — e=Uri(file:///apps/theapp/server/scripts/coupon/pdf_coupon.py), t={"skipCacheUpdate":true}
[2019-11-15 08:40:55:677] [1f3] LineHistoryTrackerNode.onActiveLinesChanged completed • 0 ms
[2019-11-15 08:40:55:678] [1f9] GitService.getRepository returned undefined • 0 ms
[2019-11-15 08:40:55:678] [1fa] GitService.getRepoPathCore — e=/apps/theapp/server/scripts/coupon/pdf_coupon.py, t=false
[2019-11-15 08:40:55:697] [/apps/theapp/server/scripts/coupon] git rev-parse --show-toplevel • 18 ms 
[2019-11-15 08:40:55:697] [1fa] GitService.getRepoPathCore completed • 18 ms
[2019-11-15 08:40:55:697] [1f8] GitService.getRepoPath returned /Users/me/company/theapp/server • 19 ms
[2019-11-15 08:40:55:697] [1f7] GitUri.fromUri returned GitUri(file:///apps/theapp/server/scripts/coupon/pdf_coupon.py repoPath=/Users/me/company/theapp/server) • 20 ms
[2019-11-15 08:40:55:697] [1fb] LineHistoryTrackerNode.resetChild
[2019-11-15 08:40:55:697] [1fb] LineHistoryTrackerNode.resetChild completed • 0 ms
[2019-11-15 08:40:55:698] [1f6] LineHistoryTrackerNode.refresh returned false, uri=GitUri(file:///apps/theapp/server/scripts/coupon/pdf_coupon.py repoPath=/Users/me/company/theapp/server) • 20 ms
[2019-11-15 08:40:55:698] [1fc] LineHistoryView.triggerNodeChange — e=LineHistoryTrackerNode
[2019-11-15 08:40:55:698] [1fc] LineHistoryView.triggerNodeChange completed • 0 ms
[2019-11-15 08:40:55:698] [1f5] LineHistoryView.refreshNode completed • 20 ms
[2019-11-15 08:40:55:698] [1f4] LineHistoryTrackerNode.triggerChange completed • 21 ms
[2019-11-15 08:40:55:759] [1fd] GitService.getBlameForFile — e=GitUri(file:///apps/theapp/server/scripts/coupon/pdf_coupon.py repoPath=/Users/me/company/theapp/server)
[2019-11-15 08:40:55:759] [1fd] GitService.getBlameForFile Cache miss: 'blame'
[2019-11-15 08:40:55:759] [1fd] GitService.getBlameForFile Cache add: 'blame'
[2019-11-15 08:40:55:759] [1fe] GitService.isTracked returned true • 0 ms — e=GitUri(file:///apps/theapp/server/scripts/coupon/pdf_coupon.py repoPath=/Users/me/company/theapp/server)
[2019-11-15 08:40:55:813] [1ff] GitService.getBlameForLine — e=GitUri(file:///apps/theapp/server/scripts/coupon/pdf_coupon.py repoPath=/Users/me/company/theapp/server), t=24
[2019-11-15 08:40:55:813] [200] GitService.getBlameForFile — e=GitUri(file:///apps/theapp/server/scripts/coupon/pdf_coupon.py repoPath=/Users/me/company/theapp/server)
[2019-11-15 08:40:55:813] [200] GitService.getBlameForFile Cache hit: 'blame'
[2019-11-15 08:40:55:852] [/Users/me/company/theapp/server] git blame --root --incremental -- /apps/theapp/server/scripts/coupon/pdf_coupon.py • 92 ms 
[2019-11-15 08:40:55:852] [201] GitService.getCurrentUser — e=/Users/me/company/theapp/server
[2019-11-15 08:40:55:853] [201] GitService.getCurrentUser completed • 0 ms
[2019-11-15 08:40:55:853] [202] GitBlameParser.parse completed • 0 ms
[2019-11-15 08:40:55:854] [1fd] GitService.getBlameForFile completed • 94 ms
[2019-11-15 08:40:55:854] [200] GitService.getBlameForFile completed • 40 ms
[2019-11-15 08:40:55:856] [1ff] GitService.getBlameForLine completed • 43 ms
[2019-11-15 08:40:55:858] [203] LineAnnotationController.onActiveLinesChanged — e=editor=file:///apps/theapp/server/scripts/coupon/pdf_coupon.py, lines=24, pending=false, reason=selection
[2019-11-15 08:40:55:858] [204] LineAnnotationController.refresh
[2019-11-15 08:40:55:858] [205] LineAnnotationController.clear completed • 0 ms
[2019-11-15 08:40:55:858] [203] LineAnnotationController.onActiveLinesChanged completed • 0 ms
[2019-11-15 08:40:55:858] [206] LineHoverController.onActiveLinesChanged — e=editor=file:///apps/theapp/server/scripts/coupon/pdf_coupon.py, lines=24, pending=false, reason=selection
[2019-11-15 08:40:55:858] [206] LineHoverController.onActiveLinesChanged completed • 0 ms
[2019-11-15 08:40:55:858] [207] StatusBarController.onActiveLinesChanged — e=editor=file:///apps/theapp/server/scripts/coupon/pdf_coupon.py, lines=24, pending=false, reason=selection
[2019-11-15 08:40:55:859] [207] StatusBarController.onActiveLinesChanged completed • 0 ms
[2019-11-15 08:40:55:863] [204] LineAnnotationController.refresh completed • line(s)=24 • 5 ms
[2019-11-15 08:40:55:915] [208] LineHistoryView.getNodeLastKnownLimit completed • 0 ms — e=LineHistoryNode(gitlens:repository(/Users/me/company/theapp/server):history:line(file:///Users/me/company/theapp/server/apps/theapp/server/scripts/coupon/pdf_coupon.py[24,19-24,19]))
[2019-11-15 08:40:55:916] [209] LineHistoryNode(gitlens:repository(/Users/me/company/theapp/server):history:line(file:///Users/me/company/theapp/server/apps/theapp/server/scripts/coupon/pdf_coupon.py[24,19-24,19])).ensureSubscription
[2019-11-15 08:40:55:916] [20a] LineHistoryNode(gitlens:repository(/Users/me/company/theapp/server):history:line(file:///Users/me/company/theapp/server/apps/theapp/server/scripts/coupon/pdf_coupon.py[24,19-24,19])).subscribe
[2019-11-15 08:40:55:917] [20b] GitService.getRepository — e=GitUri(file:///Users/me/company/theapp/server/apps/theapp/server/scripts/coupon/pdf_coupon.py repoPath=/Users/me/company/theapp/server)
[2019-11-15 08:40:55:917] [20b] GitService.getRepository returned /Users/me/company/theapp/server • 0 ms
[2019-11-15 08:40:55:917] [20a] LineHistoryNode(gitlens:repository(/Users/me/company/theapp/server):history:line(file:///Users/me/company/theapp/server/apps/theapp/server/scripts/coupon/pdf_coupon.py[24,19-24,19])).subscribe completed • 0 ms
[2019-11-15 08:40:55:917] [209] LineHistoryNode(gitlens:repository(/Users/me/company/theapp/server):history:line(file:///Users/me/company/theapp/server/apps/theapp/server/scripts/coupon/pdf_coupon.py[24,19-24,19])).ensureSubscription completed • 1 ms
[2019-11-15 08:40:55:926] [20c] GitService.getBlameForRange — e=GitUri(file:///Users/me/company/theapp/server/apps/theapp/server/scripts/coupon/pdf_coupon.py repoPath=/Users/me/company/theapp/server), t={"start":{"line":24,"character":19},"end":{"line":24,"character":19},"active":{"line":24,"character":19},"anchor":{"line":24,"character":19}}
[2019-11-15 08:40:55:927] [20d] GitService.getBlameForFile — e=GitUri(file:///Users/me/company/theapp/server/apps/theapp/server/scripts/coupon/pdf_coupon.py repoPath=/Users/me/company/theapp/server)
[2019-11-15 08:40:55:931] [20d] GitService.getBlameForFile Cache hit: 'blame'
[2019-11-15 08:40:55:931] [20d] GitService.getBlameForFile completed • 4 ms
[2019-11-15 08:40:55:931] [20c] GitService.getBlameForRange completed • 4 ms
[2019-11-15 08:40:55:931] [20e] GitService.getLogForFile — e=/Users/me/company/theapp/server, t=/Users/me/company/theapp/server/apps/theapp/server/scripts/coupon/pdf_coupon.py, i={"limit":10,"range":{"start":{"line":24,"character":19},"end":{"line":24,"character":19},"active":{"line":24,"character":19},"anchor":{"line":24,"character":19}}}
[2019-11-15 08:40:55:932] [20f] GitService.isTracked returned false • 0 ms — e=/Users/me/company/theapp/server/apps/theapp/server/scripts/coupon/pdf_coupon.py, t=/Users/me/company/theapp/server, i={}
[2019-11-15 08:40:55:932] [20e] GitService.getLogForFile Skipping log; '/Users/me/company/theapp/server/apps/theapp/server/scripts/coupon/pdf_coupon.py' is not tracked
[2019-11-15 08:40:55:932] [20e] GitService.getLogForFile completed • 0 ms
[2019-11-15 08:40:56:058] [210] FileHistoryTrackerNode.onActiveEditorChanged
[2019-11-15 08:40:56:059] [211] FileHistoryTrackerNode.triggerChange
[2019-11-15 08:40:56:059] [212] FileHistoryView.refreshNode — e=FileHistoryTrackerNode, t=false
[2019-11-15 08:40:56:059] [213] FileHistoryTrackerNode.refresh — false
[2019-11-15 08:40:56:060] [214] GitUri.fromUri — e=Uri(file:///apps/theapp/server/scripts/coupon/pdf_coupon.py)
[2019-11-15 08:40:56:060] [215] GitService.getRepoPath — e=Uri(file:///apps/theapp/server/scripts/coupon/pdf_coupon.py)
[2019-11-15 08:40:56:060] [216] GitService.getRepository — e=Uri(file:///apps/theapp/server/scripts/coupon/pdf_coupon.py), t={"skipCacheUpdate":true}
[2019-11-15 08:40:56:060] [210] FileHistoryTrackerNode.onActiveEditorChanged completed • 0 ms
[2019-11-15 08:40:56:060] [216] GitService.getRepository returned undefined • 0 ms
[2019-11-15 08:40:56:060] [217] GitService.getRepoPathCore — e=/apps/theapp/server/scripts/coupon/pdf_coupon.py, t=false
[2019-11-15 08:40:56:071] [218] RepositoriesNode.onActiveEditorChanged
[2019-11-15 08:40:56:071] [218] RepositoriesNode.onActiveEditorChanged completed • 0 ms
[2019-11-15 08:40:56:077] [/apps/theapp/server/scripts/coupon] git rev-parse --show-toplevel • 16 ms 
[2019-11-15 08:40:56:077] [217] GitService.getRepoPathCore completed • 16 ms
[2019-11-15 08:40:56:077] [215] GitService.getRepoPath returned /Users/me/company/theapp/server • 17 ms
[2019-11-15 08:40:56:077] [214] GitUri.fromUri returned GitUri(file:///apps/theapp/server/scripts/coupon/pdf_coupon.py repoPath=/Users/me/company/theapp/server) • 17 ms
[2019-11-15 08:40:56:077] [219] FileHistoryTrackerNode.resetChild
[2019-11-15 08:40:56:077] [219] FileHistoryTrackerNode.resetChild completed • 0 ms
[2019-11-15 08:40:56:078] [213] FileHistoryTrackerNode.refresh returned false, uri=GitUri(file:///apps/theapp/server/scripts/coupon/pdf_coupon.py repoPath=/Users/me/company/theapp/server) • 18 ms
[2019-11-15 08:40:56:078] [21a] FileHistoryView.triggerNodeChange — e=FileHistoryTrackerNode
[2019-11-15 08:40:56:078] [21a] FileHistoryView.triggerNodeChange completed • 0 ms
[2019-11-15 08:40:56:078] [212] FileHistoryView.refreshNode completed • 18 ms
[2019-11-15 08:40:56:078] [211] FileHistoryTrackerNode.triggerChange completed • 19 ms
[2019-11-15 08:40:56:113] [21b] LineHistoryTrackerNode.onActiveLinesChanged — e=editor=file:///apps/theapp/server/scripts/coupon/pdf_coupon.py, lines=24, pending=false, reason=selection
[2019-11-15 08:40:56:113] [21c] LineHistoryTrackerNode.triggerChange
[2019-11-15 08:40:56:113] [21d] LineHistoryView.refreshNode — e=LineHistoryTrackerNode, t=false
[2019-11-15 08:40:56:113] [21e] LineHistoryTrackerNode.refresh — false
[2019-11-15 08:40:56:113] [21b] LineHistoryTrackerNode.onActiveLinesChanged completed • 0 ms
[2019-11-15 08:40:56:113] [21e] LineHistoryTrackerNode.refresh returned true, uri=GitUri(file:///apps/theapp/server/scripts/coupon/pdf_coupon.py repoPath=/Users/me/company/theapp/server) • 0 ms
[2019-11-15 08:40:56:114] [21d] LineHistoryView.refreshNode completed • 0 ms
[2019-11-15 08:40:56:114] [21c] LineHistoryTrackerNode.triggerChange completed • 0 ms
[2019-11-15 08:40:56:265] GitCodeLensProvider.provideCodeLenses: — 43 symbol(s) found
[2019-11-15 08:40:56:280] [21f] FileHistoryView.getNodeLastKnownLimit completed • 0 ms — e=FileHistoryNode(gitlens:repository(/Users/me/company/theapp/server):history:file(file:///Users/me/company/theapp/server/apps/theapp/server/scripts/coupon/pdf_coupon.py))
[2019-11-15 08:40:56:281] [220] FileHistoryNode(gitlens:repository(/Users/me/company/theapp/server):history:file(file:///Users/me/company/theapp/server/apps/theapp/server/scripts/coupon/pdf_coupon.py)).ensureSubscription
[2019-11-15 08:40:56:281] [221] FileHistoryNode(gitlens:repository(/Users/me/company/theapp/server):history:file(file:///Users/me/company/theapp/server/apps/theapp/server/scripts/coupon/pdf_coupon.py)).subscribe
[2019-11-15 08:40:56:281] [222] GitService.getRepository — e=GitUri(file:///Users/me/company/theapp/server/apps/theapp/server/scripts/coupon/pdf_coupon.py repoPath=/Users/me/company/theapp/server)
[2019-11-15 08:40:56:283] [222] GitService.getRepository returned /Users/me/company/theapp/server • 2 ms
[2019-11-15 08:40:56:283] [221] FileHistoryNode(gitlens:repository(/Users/me/company/theapp/server):history:file(file:///Users/me/company/theapp/server/apps/theapp/server/scripts/coupon/pdf_coupon.py)).subscribe completed • 2 ms
[2019-11-15 08:40:56:284] [220] FileHistoryNode(gitlens:repository(/Users/me/company/theapp/server):history:file(file:///Users/me/company/theapp/server/apps/theapp/server/scripts/coupon/pdf_coupon.py)).ensureSubscription completed • 2 ms
[2019-11-15 08:40:56:285] [223] GitService.getStatusForFile — e=/Users/me/company/theapp/server, t=/Users/me/company/theapp/server/apps/theapp/server/scripts/coupon/pdf_coupon.py
[2019-11-15 08:40:56:305] [/Users/me/company/theapp/server] git status --porcelain=v2 --find-renames= -- apps/theapp/server/scripts/coupon/pdf_coupon.py • 19 ms 
[2019-11-15 08:40:56:305] [224] GitStatusParser.parse completed • 0 ms
[2019-11-15 08:40:56:306] [223] GitService.getStatusForFile completed • 20 ms
[2019-11-15 08:40:56:306] [225] GitService.getLogForFile — e=/Users/me/company/theapp/server, t=/Users/me/company/theapp/server/apps/theapp/server/scripts/coupon/pdf_coupon.py, i={"limit":10}
[2019-11-15 08:40:56:306] [225] GitService.getLogForFile Cache hit: 'log:n10:follow'
[2019-11-15 08:40:56:306] [225] GitService.getLogForFile completed • 0 ms
[2019-11-15 08:40:56:526] [226] GitService.getBlameForRangeSync — e=<blame>, t=GitUri(file:///apps/theapp/server/scripts/coupon/pdf_coupon.py repoPath=/Users/me/company/theapp/server), i=[{"line":0,"character":17},{"line":96,"character":0}]
[2019-11-15 08:40:56:526] [226] GitService.getBlameForRangeSync completed • 0 ms
[2019-11-15 08:40:57:970] [227] RepositoriesNode.onActiveEditorChanged
[2019-11-15 08:40:57:970] [227] RepositoriesNode.onActiveEditorChanged completed • 0 ms
[2019-11-15 08:40:57:970] [228] FileHistoryTrackerNode.onActiveEditorChanged
[2019-11-15 08:40:57:970] [229] FileHistoryTrackerNode.triggerChange
[2019-11-15 08:40:57:971] [22a] FileHistoryView.refreshNode — e=FileHistoryTrackerNode, t=false
[2019-11-15 08:40:57:971] [22b] FileHistoryTrackerNode.refresh — false
[2019-11-15 08:40:57:971] [228] FileHistoryTrackerNode.onActiveEditorChanged completed • 0 ms
[2019-11-15 08:40:57:971] [22b] FileHistoryTrackerNode.refresh returned true • 0 ms
[2019-11-15 08:40:57:971] [22a] FileHistoryView.refreshNode completed • 0 ms
[2019-11-15 08:40:57:971] [229] FileHistoryTrackerNode.triggerChange completed • 0 ms

[an-yun]

@eamodio In my situation, it works very well in this version:

@theseion @an-yun Can you try this one:
gitlens-10.1.3-alpha.vsix.zip

Thank you very much.

[eamodio]

@theseion OK, I think this one should do it 😄
gitlens-10.1.3-alpha.vsix.zip

@theseion @an-yun thank you both so much for helping me test this!

[theseion]

You're very welcome. Thank you for trying to fix it ;)

File history now works! However, line history still doesn't, although I'm not sure that's not a separate issue.
So, when I place the cursor on a line that I know to have changed between the current and previous commits I expect the line history to show me something but it doesn't. Here's the output right after placing the cursor on such a line (line 18):
[2019-11-16 09:08:24:165] [498] LineAnnotationController.onActiveLinesChanged — e=editor=file:///apps/theapp/server/scripts/coupon/pdf_coupon.py, lines=undefined, pending=true, reason=selection [2019-11-16 09:08:24:166] [499] LineAnnotationController.clear completed • 0 ms [2019-11-16 09:08:24:166] [498] LineAnnotationController.onActiveLinesChanged completed • 0 ms [2019-11-16 09:08:24:166] [49a] LineHoverController.onActiveLinesChanged — e=editor=file:///apps/theapp/server/scripts/coupon/pdf_coupon.py, lines=undefined, pending=true, reason=selection [2019-11-16 09:08:24:166] [49a] LineHoverController.onActiveLinesChanged completed • 0 ms [2019-11-16 09:08:24:166] [49b] StatusBarController.onActiveLinesChanged — e=editor=file:///apps/theapp/server/scripts/coupon/pdf_coupon.py, lines=undefined, pending=true, reason=selection [2019-11-16 09:08:24:166] [49b] StatusBarController.onActiveLinesChanged completed • 0 ms [2019-11-16 09:08:24:420] [49c] GitService.getBlameForLine — e=GitUri(file:///apps/theapp/server/scripts/coupon/pdf_coupon.py repoPath=/apps/theapp/server), t=17 [2019-11-16 09:08:24:420] [49d] GitService.getBlameForFile — e=GitUri(file:///apps/theapp/server/scripts/coupon/pdf_coupon.py repoPath=/apps/theapp/server) [2019-11-16 09:08:24:421] [49d] GitService.getBlameForFile Cache hit: 'blame' [2019-11-16 09:08:24:421] [49d] GitService.getBlameForFile completed • 0 ms [2019-11-16 09:08:24:421] [49c] GitService.getBlameForLine completed • 0 ms [2019-11-16 09:08:24:421] [49e] LineAnnotationController.onActiveLinesChanged — e=editor=file:///apps/theapp/server/scripts/coupon/pdf_coupon.py, lines=17, pending=false, reason=selection [2019-11-16 09:08:24:421] [49f] LineAnnotationController.refresh [2019-11-16 09:08:24:422] [49e] LineAnnotationController.onActiveLinesChanged completed • 0 ms [2019-11-16 09:08:24:422] [4a0] LineHoverController.onActiveLinesChanged — e=editor=file:///apps/theapp/server/scripts/coupon/pdf_coupon.py, lines=17, pending=false, reason=selection [2019-11-16 09:08:24:422] [4a0] LineHoverController.onActiveLinesChanged completed • 0 ms [2019-11-16 09:08:24:422] [4a1] StatusBarController.onActiveLinesChanged — e=editor=file:///apps/theapp/server/scripts/coupon/pdf_coupon.py, lines=17, pending=false, reason=selection [2019-11-16 09:08:24:423] [4a1] StatusBarController.onActiveLinesChanged completed • 1 ms [2019-11-16 09:08:24:425] [49f] LineAnnotationController.refresh completed • line(s)=17 • 3 ms [2019-11-16 09:08:24:669] [4a2] FileHistoryTrackerNode.onActiveEditorChanged [2019-11-16 09:08:24:669] [4a3] FileHistoryTrackerNode.triggerChange [2019-11-16 09:08:24:669] [4a4] FileHistoryView.refreshNode — e=FileHistoryTrackerNode, t=false [2019-11-16 09:08:24:670] [4a5] FileHistoryTrackerNode.refresh — false [2019-11-16 09:08:24:670] [4a2] FileHistoryTrackerNode.onActiveEditorChanged completed • 0 ms [2019-11-16 09:08:24:670] [4a5] FileHistoryTrackerNode.refresh returned true, uri=GitUri(file:///apps/theapp/server/scripts/coupon/pdf_coupon.py repoPath=/apps/theapp/server) • 0 ms [2019-11-16 09:08:24:670] [4a4] FileHistoryView.refreshNode completed • 0 ms [2019-11-16 09:08:24:670] [4a3] FileHistoryTrackerNode.triggerChange completed • 0 ms [2019-11-16 09:08:24:671] [4a6] RepositoriesNode.onActiveEditorChanged [2019-11-16 09:08:24:671] [4a6] RepositoriesNode.onActiveEditorChanged completed • 0 ms [2019-11-16 09:08:24:674] [4a7] LineHistoryTrackerNode.onActiveLinesChanged — e=editor=file:///apps/theapp/server/scripts/coupon/pdf_coupon.py, lines=17, pending=false, reason=selection [2019-11-16 09:08:24:674] [4a8] LineHistoryTrackerNode.triggerChange [2019-11-16 09:08:24:674] [4a9] LineHistoryView.refreshNode — e=LineHistoryTrackerNode, t=false [2019-11-16 09:08:24:674] [4aa] LineHistoryTrackerNode.refresh — false [2019-11-16 09:08:24:674] [4ab] GitUri.fromUri — e=Uri(file:///apps/theapp/server/scripts/coupon/pdf_coupon.py) [2019-11-16 09:08:24:675] [4ac] GitService.getRepoPath — e=Uri(file:///apps/theapp/server/scripts/coupon/pdf_coupon.py) [2019-11-16 09:08:24:675] [4ad] GitService.getRepository — e=Uri(file:///apps/theapp/server/scripts/coupon/pdf_coupon.py), t={"skipCacheUpdate":true} [2019-11-16 09:08:24:675] [4a7] LineHistoryTrackerNode.onActiveLinesChanged completed • 0 ms [2019-11-16 09:08:24:675] [4ae] GitService.isTracked returned true • 0 ms — e=/apps/theapp/server/scripts/coupon/pdf_coupon.py, t=/apps/theapp/server, i={"skipCacheUpdate":true} [2019-11-16 09:08:24:676] [4ad] GitService.getRepository returned /apps/theapp/server • 0 ms [2019-11-16 09:08:24:676] [4ac] GitService.getRepoPath returned /apps/theapp/server • 1 ms [2019-11-16 09:08:24:676] [4ab] GitUri.fromUri returned GitUri(file:///apps/theapp/server/scripts/coupon/pdf_coupon.py repoPath=/apps/theapp/server) • 1 ms [2019-11-16 09:08:24:676] [4af] LineHistoryTrackerNode.resetChild [2019-11-16 09:08:24:676] [4b0] LineHistoryNode(gitlens:repository(/apps/theapp/server):history:line(file:///apps/theapp/server/scripts/coupon/pdf_coupon.py[16,54-16,54])).dispose [2019-11-16 09:08:24:676] [4b1] LineHistoryNode(gitlens:repository(/apps/theapp/server):history:line(file:///apps/theapp/server/scripts/coupon/pdf_coupon.py[16,54-16,54])).unsubscribe [2019-11-16 09:08:24:676] [4b0] LineHistoryNode(gitlens:repository(/apps/theapp/server):history:line(file:///apps/theapp/server/scripts/coupon/pdf_coupon.py[16,54-16,54])).dispose completed • 0 ms [2019-11-16 09:08:24:676] [4af] LineHistoryTrackerNode.resetChild completed • 0 ms [2019-11-16 09:08:24:676] [4aa] LineHistoryTrackerNode.refresh returned false, uri=GitUri(file:///apps/theapp/server/scripts/coupon/pdf_coupon.py repoPath=/apps/theapp/server) • 1 ms [2019-11-16 09:08:24:679] [4b1] LineHistoryNode(gitlens:repository(/apps/theapp/server):history:line(file:///apps/theapp/server/scripts/coupon/pdf_coupon.py[16,54-16,54])).unsubscribe completed • 2 ms [2019-11-16 09:08:24:679] [4b2] LineHistoryView.triggerNodeChange — e=LineHistoryTrackerNode [2019-11-16 09:08:24:679] [4b2] LineHistoryView.triggerNodeChange completed • 0 ms [2019-11-16 09:08:24:679] [4a9] LineHistoryView.refreshNode completed • 4 ms [2019-11-16 09:08:24:679] [4a8] LineHistoryTrackerNode.triggerChange completed • 4 ms [2019-11-16 09:08:24:889] [4b3] LineHistoryView.getNodeLastKnownLimit completed • 0 ms — e=LineHistoryNode(gitlens:repository(/apps/theapp/server):history:line(file:///apps/theapp/server/scripts/coupon/pdf_coupon.py[17,58-17,58])) [2019-11-16 09:08:24:890] [4b4] LineHistoryNode(gitlens:repository(/apps/theapp/server):history:line(file:///apps/theapp/server/scripts/coupon/pdf_coupon.py[17,58-17,58])).ensureSubscription [2019-11-16 09:08:24:890] [4b5] LineHistoryNode(gitlens:repository(/apps/theapp/server):history:line(file:///apps/theapp/server/scripts/coupon/pdf_coupon.py[17,58-17,58])).subscribe [2019-11-16 09:08:24:890] [4b6] GitService.getRepository — e=GitUri(file:///apps/theapp/server/scripts/coupon/pdf_coupon.py repoPath=/apps/theapp/server) [2019-11-16 09:08:24:892] [4b6] GitService.getRepository returned /apps/theapp/server • 1 ms [2019-11-16 09:08:24:892] [4b5] LineHistoryNode(gitlens:repository(/apps/theapp/server):history:line(file:///apps/theapp/server/scripts/coupon/pdf_coupon.py[17,58-17,58])).subscribe completed • 2 ms [2019-11-16 09:08:24:892] [4b4] LineHistoryNode(gitlens:repository(/apps/theapp/server):history:line(file:///apps/theapp/server/scripts/coupon/pdf_coupon.py[17,58-17,58])).ensureSubscription completed • 2 ms [2019-11-16 09:08:24:902] [4b7] GitService.getBlameForRange — e=GitUri(file:///apps/theapp/server/scripts/coupon/pdf_coupon.py repoPath=/apps/theapp/server), t={"start":{"line":17,"character":58},"end":{"line":17,"character":58},"active":{"line":17,"character":58},"anchor":{"line":17,"character":58}} [2019-11-16 09:08:24:902] [4b8] GitService.getBlameForFile — e=GitUri(file:///apps/theapp/server/scripts/coupon/pdf_coupon.py repoPath=/apps/theapp/server) [2019-11-16 09:08:24:903] [4b8] GitService.getBlameForFile Cache hit: 'blame' [2019-11-16 09:08:24:903] [4b8] GitService.getBlameForFile completed • 0 ms [2019-11-16 09:08:24:903] [4b9] GitService.getBlameForRangeSync — e=<blame>, t=GitUri(file:///apps/theapp/server/scripts/coupon/pdf_coupon.py repoPath=/apps/theapp/server), i={"start":{"line":17,"character":58},"end":{"line":17,"character":58},"active":{"line":17,"character":58},"anchor":{"line":17,"character":58}} [2019-11-16 09:08:24:903] [4b9] GitService.getBlameForRangeSync completed • 0 ms [2019-11-16 09:08:24:903] [4b7] GitService.getBlameForRange completed • 0 ms [2019-11-16 09:08:24:903] [4ba] GitService.getLogForFile — e=/apps/theapp/server, t=/apps/theapp/server/scripts/coupon/pdf_coupon.py, i={"limit":10,"range":{"start":{"line":17,"character":58},"end":{"line":17,"character":58},"active":{"line":17,"character":58},"anchor":{"line":17,"character":58}}} [2019-11-16 09:08:24:903] [4bb] GitService.isTracked returned true • 0 ms — e=/apps/theapp/server/scripts/coupon/pdf_coupon.py, t=/apps/theapp/server, i={} [2019-11-16 09:08:25:145] [/apps/theapp/server] git log --format=%x3c%x2ff%x3e%n%x3cr%x3e%x20%H%n%x3ca%x3e%x20%aN%n%x3ce%x3e%x20%aE%n%x3cd%x3e%x20%at%n%x3cc%x3e%x20%ct%n%x3cp%x3e%x20%P%n%x3cs%x3e%n%B%n%x3c%x2fs%x3e%n%x3cf%x3e -n10 --follow -L 18,18:scripts/coupon/pdf_coupon.py -- scripts/coupon/pdf_coupon.py • 241 ms [2019-11-16 09:08:25:145] [4ba] GitService.getLogForFile completed • 242 ms [2019-11-16 09:08:27:142] [4bc] FileHistoryTrackerNode.onActiveEditorChanged [2019-11-16 09:08:27:142] [4bd] FileHistoryTrackerNode.triggerChange [2019-11-16 09:08:27:142] [4be] FileHistoryView.refreshNode — e=FileHistoryTrackerNode, t=false [2019-11-16 09:08:27:142] [4bf] FileHistoryTrackerNode.refresh — false [2019-11-16 09:08:27:142] [4bc] FileHistoryTrackerNode.onActiveEditorChanged completed • 0 ms [2019-11-16 09:08:27:143] [4bf] FileHistoryTrackerNode.refresh returned true • 0 ms [2019-11-16 09:08:27:143] [4be] FileHistoryView.refreshNode completed • 1 ms [2019-11-16 09:08:27:143] [4bd] FileHistoryTrackerNode.triggerChange completed • 1 ms [2019-11-16 09:08:27:144] [4c0] RepositoriesNode.onActiveEditorChanged [2019-11-16 09:08:27:144] [4c0] RepositoriesNode.onActiveEditorChanged completed • 0 ms

[theseion]

I've played around with the git log command that GitLens tries to run and that fails consistently. The issue appears to be with Git though (I get an exit code of 139, which I couldn't immediately trace to anything specific in the Git sources). To me it seems that --follow and -L don't play well together, i.e., using one or the other works but together they don't.

[eamodio]

@theseion what version of Git are you using?

[theseion]

Yeah... good question :) 2.24.0

[eamodio]

@theseion do you only see the line history issue with symlinked folders? Or in general? In either case, can you open a new issue to track that one? Thanks!

[theseion]

I just figured out that this only happens with the file I was testing your fix with. Other files are fine. This is clearly a Git issue, as it's the git log command that fails for the file, regardless of whether I use a symlink or not. I won't open another issue for GitLens.

Thanks for the fix!

[patpating]

@theseion OK, I think this one should do it 😄
gitlens-10.1.3-alpha.vsix.zip

@theseion @an-yun thank you both so much for helping me test this!

unfortunately none of the attached alphas, and the 10.2 worked for me.
v8.5.6 still works.

the main difference i see is that in v8.5.6, the File History shows the relative path of the file
../../Workspace/Project/linked-repo .. whereas in the succeeding versions, it shows the absolute path... Users/pating/Workspace/Project/linked-repo

i'm on git 2.23.0

vscode
Version: 1.40.0
Commit: 86405ea23e3937316009fc27c9361deee66ffbf5
Date: 2019-11-06T17:09:34.601Z
Electron: 6.1.2
Chrome: 76.0.3809.146
Node.js: 12.4.0
V8: 7.6.303.31-electron.0
OS: Darwin x64 18.7.0

[theseion]

@patpating Can you also post the GitLens debug output? That would help. (Go to the settings, search for "GitLens output level" and set it to "debug". You'll find the contents in the output panel when you select "GitLens" as the source.)

[patpating]

gitlens.log

as requested. this is using the alpha above.

thank you so much for looking into this.

[theseion]

@patpating The file you opened when collecting the log does not appear to be event tracked by Git. Can you post a log for a file that is tracked?

[patpating]

it is tracked by Git.

here is the debug log when using v8.5.6, if it helps

getBlameForLine('/Users/pbtan/Repositories/via_calc', '/Users/pbtan/Workspaces/sfdx/via_calc/force-app/main/default/classes/CalculationUtilities.cls', 'undefined', 160)
getBlameForFile[Cached(blame)]('/Users/pbtan/Repositories/via_calc', '/Users/pbtan/Workspaces/sfdx/via_calc/force-app/main/default/classes/CalculationUtilities.cls', 'undefined')
Running(/Users/pbtan/Workspaces/sfdx/via_calc/force-app/main/default/classes): git rev-parse --show-toplevel
Completed(/Users/pbtan/Workspaces/sfdx/via_calc/force-app/main/default/classes): git rev-parse --show-toplevel Completed in 13 ms
HistoryExplorer.refresh reason='active-editor-changed'
getStatusForFile('/Users/pbtan/Repositories/via_calc', '/Users/pbtan/Workspaces/sfdx/via_calc/force-app/main/default/classes/CalculationUtilities.cls')
Running(/Users/pbtan/Repositories/via_calc): git -c color.status=false status --porcelain=v2 -- /Users/pbtan/Workspaces/sfdx/via_calc/force-app/main/default/classes/CalculationUtilities.cls
Completed(/Users/pbtan/Repositories/via_calc): git -c color.status=false status --porcelain=v2 -- /Users/pbtan/Workspaces/sfdx/via_calc/force-app/main/default/classes/CalculationUtilities.cls Completed in 13 ms
getLogForFile[Cached(log:follow)]('/Users/pbtan/Repositories/via_calc', '/Users/pbtan/Workspaces/sfdx/via_calc/force-app/main/default/classes/CalculationUtilities.cls', 'undefined', undefined, undefined, true, false)

[theseion]

Weird. Maybe that's the bug :) Let's wait for @eamodio to weigh in.

[dimbs]

Hello,

It seems i've got some similar problem on windows :

VSCode : 1.41.1
Git: 2.25.0.windows.1

It happens on all files of all projects.

Do i open an other issue ?

A log output :

` [2020-01-24 10:44:30:490] [1ab3] GitService.getBlameForLine — e=GitUri(file:///d:/Projet/workspace/core/Build.PL repoPath=D:/Projet/workspace/core), t=5 [2020-01-24 10:44:30:490] [1ab4] GitService.getBlameForFile — e=GitUri(file:///d:/Projet/workspace/core/Build.PL repoPath=D:/Projet/workspace/core) [2020-01-24 10:44:30:490] [1ab4] GitService.getBlameForFile Cache hit: 'blame' [2020-01-24 10:44:30:490] [1ab4] GitService.getBlameForFile completed • 0 ms [2020-01-24 10:44:30:490] [1ab3] GitService.getBlameForLine completed • 0 ms [2020-01-24 10:44:30:490] [1ab5] LineAnnotationController.onActiveLinesChanged — e=editor=file:///d:/Projet/workspace/core/Build.PL, lines=5, pending=false, reason=selection [2020-01-24 10:44:30:490] [1ab6] LineAnnotationController.refresh [2020-01-24 10:44:30:490] [1ab7] LineAnnotationController.clear completed • 0 ms [2020-01-24 10:44:30:490] [1ab5] LineAnnotationController.onActiveLinesChanged completed • 0 ms [2020-01-24 10:44:30:490] [1ab8] LineHoverController.onActiveLinesChanged — e=editor=file:///d:/Projet/workspace/core/Build.PL, lines=5, pending=false, reason=selection [2020-01-24 10:44:30:491] [1ab8] LineHoverController.onActiveLinesChanged completed • 0 ms [2020-01-24 10:44:30:491] [1ab9] StatusBarController.onActiveLinesChanged — e=editor=file:///d:/Projet/workspace/core/Build.PL, lines=5, pending=false, reason=selection [2020-01-24 10:44:30:493] [1ab9] StatusBarController.onActiveLinesChanged completed • 1 ms [2020-01-24 10:44:30:494] [1ab6] LineAnnotationController.refresh completed • line(s)=5 • 3 ms [2020-01-24 10:44:30:738] [1aba] FileHistoryTrackerNode.onActiveEditorChanged [2020-01-24 10:44:30:738] [1abb] FileHistoryTrackerNode.triggerChange [2020-01-24 10:44:30:738] [1abc] FileHistoryView.refreshNode — e=FileHistoryTrackerNode, t=false [2020-01-24 10:44:30:738] [1abd] FileHistoryTrackerNode.refresh — false [2020-01-24 10:44:30:738] [1abe] GitUri.fromUri — e=Uri(file:///d:/Projet/workspace/core/Build.PL) [2020-01-24 10:44:30:738] [1abf] GitService.getRepoPath — e=Uri(file:///d:/Projet/workspace/core/Build.PL) [2020-01-24 10:44:30:738] [1ac0] GitService.getRepository — e=Uri(file:///d:/Projet/workspace/core/Build.PL), t={"skipCacheUpdate":true} [2020-01-24 10:44:30:738] [1aba] FileHistoryTrackerNode.onActiveEditorChanged completed • 0 ms [2020-01-24 10:44:30:738] [1ac0] GitService.getRepository returned undefined • 0 ms [2020-01-24 10:44:30:738] [1ac1] GitService.getRepoPathCore — e=d:\Projet\workspace\core\Build.PL, t=false [2020-01-24 10:44:30:751] [1ac2] LineHistoryTrackerNode.onActiveLinesChanged — e=editor=file:///d:/Projet/workspace/core/Build.PL, lines=5, pending=false, reason=selection [2020-01-24 10:44:30:751] [1ac3] LineHistoryTrackerNode.triggerChange [2020-01-24 10:44:30:751] [1ac4] LineHistoryView.refreshNode — e=LineHistoryTrackerNode, t=false [2020-01-24 10:44:30:751] [1ac5] LineHistoryTrackerNode.refresh — false [2020-01-24 10:44:30:751] [1ac6] GitUri.fromUri — e=Uri(file:///d:/Projet/workspace/core/Build.PL) [2020-01-24 10:44:30:751] [1ac7] GitService.getRepoPath — e=Uri(file:///d:/Projet/workspace/core/Build.PL) [2020-01-24 10:44:30:751] [1ac8] GitService.getRepository — e=Uri(file:///d:/Projet/workspace/core/Build.PL), t={"skipCacheUpdate":true} [2020-01-24 10:44:30:751] [1ac2] LineHistoryTrackerNode.onActiveLinesChanged completed • 0 ms [2020-01-24 10:44:30:751] [1ac8] GitService.getRepository returned undefined • 0 ms [2020-01-24 10:44:30:751] [1ac9] GitService.getRepoPathCore — e=d:\Projet\workspace\core\Build.PL, t=false [2020-01-24 10:44:30:828] [d:\Projet\workspace\core] git rev-parse --show-toplevel • 89 ms [2020-01-24 10:44:30:828] [d:\Projet\workspace\core] git rev-parse --show-toplevel • 76 ms (await) [2020-01-24 10:44:30:828] [1ac1] GitService.getRepoPathCore completed • 89 ms [2020-01-24 10:44:30:828] [1ac9] GitService.getRepoPathCore completed • 76 ms [2020-01-24 10:44:30:828] [1abf] GitService.getRepoPath returned D:/Projet/workspace/core • 89 ms [2020-01-24 10:44:30:828] [1ac7] GitService.getRepoPath returned D:/Projet/workspace/core • 77 ms [2020-01-24 10:44:30:828] [1abe] GitUri.fromUri returned GitUri(file:///d:/Projet/workspace/core/Build.PL repoPath=D:/Projet/workspace/core) • 90 ms [2020-01-24 10:44:30:828] [1aca] FileHistoryTrackerNode.resetChild [2020-01-24 10:44:30:828] [1aca] FileHistoryTrackerNode.resetChild completed • 0 ms [2020-01-24 10:44:30:828] [1ac6] GitUri.fromUri returned GitUri(file:///d:/Projet/workspace/core/Build.PL repoPath=D:/Projet/workspace/core) • 77 ms [2020-01-24 10:44:30:828] [1acb] LineHistoryTrackerNode.resetChild [2020-01-24 10:44:30:828] [1acb] LineHistoryTrackerNode.resetChild completed • 0 ms [2020-01-24 10:44:30:828] [1abd] FileHistoryTrackerNode.refresh returned false, uri=GitUri(file:///d:/Projet/workspace/core/Build.PL repoPath=D:/Projet/workspace/core) • 90 ms [2020-01-24 10:44:30:828] [1ac5] LineHistoryTrackerNode.refresh returned false, uri=GitUri(file:///d:/Projet/workspace/core/Build.PL repoPath=D:/Projet/workspace/core) • 77 ms [2020-01-24 10:44:30:828] [1acc] FileHistoryView.triggerNodeChange — e=FileHistoryTrackerNode [2020-01-24 10:44:30:828] [1acc] FileHistoryView.triggerNodeChange completed • 0 ms [2020-01-24 10:44:30:828] [1acd] LineHistoryView.triggerNodeChange — e=LineHistoryTrackerNode [2020-01-24 10:44:30:829] [1acd] LineHistoryView.triggerNodeChange completed • 0 ms [2020-01-24 10:44:30:829] [1abc] FileHistoryView.refreshNode completed • 90 ms [2020-01-24 10:44:30:829] [1abb] FileHistoryTrackerNode.triggerChange completed • 90 ms [2020-01-24 10:44:30:829] [1ac4] LineHistoryView.refreshNode completed • 77 ms [2020-01-24 10:44:30:829] [1ac3] LineHistoryTrackerNode.triggerChange completed • 77 ms [2020-01-24 10:44:31:031] [1ace] FileHistoryView.getNodeLastKnownLimit completed • 0 ms — e=FileHistoryNode(gitlens:repository(D:/Projet/workspace/core):history:file(file:///d:/Projet/workspace/core/d:/Projet/workspace/core/Build.PL)) [2020-01-24 10:44:31:031] [1acf] LineHistoryView.getNodeLastKnownLimit completed • 0 ms — e=LineHistoryNode(gitlens:repository(D:/Projet/workspace/core):history:line(file:///d:/Projet/workspace/core/d:/Projet/workspace/core/Build.PL[5,0-5,0])) [2020-01-24 10:44:31:031] [1ad0] FileHistoryNode(gitlens:repository(D:/Projet/workspace/core):history:file(file:///d:/Projet/workspace/core/d:/Projet/workspace/core/Build.PL)).ensureSubscription [2020-01-24 10:44:31:031] [1ad1] FileHistoryNode(gitlens:repository(D:/Projet/workspace/core):history:file(file:///d:/Projet/workspace/core/d:/Projet/workspace/core/Build.PL)).subscribe [2020-01-24 10:44:31:031] [1ad2] GitService.getRepository — e=GitUri(file:///d:/Projet/workspace/core/d:/Projet/workspace/core/Build.PL repoPath=D:/Projet/workspace/core) [2020-01-24 10:44:31:031] [1ad3] LineHistoryNode(gitlens:repository(D:/Projet/workspace/core):history:line(file:///d:/Projet/workspace/core/d:/Projet/workspace/core/Build.PL[5,0-5,0])).ensureSubscription [2020-01-24 10:44:31:031] [1ad4] LineHistoryNode(gitlens:repository(D:/Projet/workspace/core):history:line(file:///d:/Projet/workspace/core/d:/Projet/workspace/core/Build.PL[5,0-5,0])).subscribe [2020-01-24 10:44:31:031] [1ad5] GitService.getRepository — e=GitUri(file:///d:/Projet/workspace/core/d:/Projet/workspace/core/Build.PL repoPath=D:/Projet/workspace/core) [2020-01-24 10:44:31:032] [1ad2] GitService.getRepository returned D:/Projet/workspace/core • 0 ms [2020-01-24 10:44:31:032] [1ad5] GitService.getRepository returned D:/Projet/workspace/core • 0 ms [2020-01-24 10:44:31:032] [1ad1] FileHistoryNode(gitlens:repository(D:/Projet/workspace/core):history:file(file:///d:/Projet/workspace/core/d:/Projet/workspace/core/Build.PL)).subscribe completed • 1 ms [2020-01-24 10:44:31:032] [1ad4] LineHistoryNode(gitlens:repository(D:/Projet/workspace/core):history:line(file:///d:/Projet/workspace/core/d:/Projet/workspace/core/Build.PL[5,0-5,0])).subscribe completed • 0 ms [2020-01-24 10:44:31:032] [1ad0] FileHistoryNode(gitlens:repository(D:/Projet/workspace/core):history:file(file:///d:/Projet/workspace/core/d:/Projet/workspace/core/Build.PL)).ensureSubscription completed • 1 ms [2020-01-24 10:44:31:032] [1ad3] LineHistoryNode(gitlens:repository(D:/Projet/workspace/core):history:line(file:///d:/Projet/workspace/core/d:/Projet/workspace/core/Build.PL[5,0-5,0])).ensureSubscription completed • 0 ms [2020-01-24 10:44:31:035] [1ad6] GitService.getStatusForFile — e=D:/Projet/workspace/core, t=d:\Projet\workspace\core\d:\Projet\workspace\core\Build.PL [2020-01-24 10:44:31:046] [1ad7] GitService.getBlameForRange — e=GitUri(file:///d:/Projet/workspace/core/d:/Projet/workspace/core/Build.PL repoPath=D:/Projet/workspace/core), t={"start":{"line":5,"character":0},"end":{"line":5,"character":0},"active":{"line":5,"character":0},"anchor":{"line":5,"character":0}} [2020-01-24 10:44:31:046] [1ad8] GitService.getBlameForFile — e=GitUri(file:///d:/Projet/workspace/core/d:/Projet/workspace/core/Build.PL repoPath=D:/Projet/workspace/core) [2020-01-24 10:44:31:052] [1ad8] GitService.getBlameForFile — failed • 5 ms Error: cannot open file:///d%3A/Projet/workspace/core/d%3A/Projet/workspace/core/Build.PL. Detail: Impossible de lire le fichier (Error: Fichier introuvable (d:\Projet\workspace\core\d:\Projet\workspace\core\Build.PL)) [2020-01-24 10:44:31:052] [1ad7] GitService.getBlameForRange — failed • 5 ms Error: cannot open file:///d%3A/Projet/workspace/core/d%3A/Projet/workspace/core/Build.PL. Detail: Impossible de lire le fichier (Error: Fichier introuvable (d:\Projet\workspace\core\d:\Projet\workspace\core\Build.PL)) [2020-01-24 10:44:31:213] [D:/Projet/workspace/core] git status --porcelain=v2 --find-renames -- d:/Projet/workspace/core/Build.PL • 177 ms [2020-01-24 10:44:31:213] [1ad9] GitStatusParser.parse completed • 0 ms [2020-01-24 10:44:31:214] [1ad6] GitService.getStatusForFile completed • 178 ms [2020-01-24 10:44:31:214] [1ada] GitService.getLogForFile — e=D:/Projet/workspace/core, t=d:\Projet\workspace\core\d:\Projet\workspace\core\Build.PL, i={"limit":10} [2020-01-24 10:44:31:220] [1ada] GitService.getLogForFile — failed • 5 ms Error: cannot open file:///d%3A/Projet/workspace/core/d%3A/Projet/workspace/core/d%3A/Projet/workspace/core/Build.PL. Detail: Impossible de lire le fichier (Error: Fichier introuvable (d:\Projet\workspace\core\d:\Projet\workspace\core\d:\Projet\workspace\core\Build.PL)) [2020-01-24 10:44:33:274] [1adb] FileHistoryTrackerNode.onActiveEditorChanged [2020-01-24 10:44:33:274] [1adc] FileHistoryTrackerNode.triggerChange [2020-01-24 10:44:33:274] [1add] FileHistoryView.refreshNode — e=FileHistoryTrackerNode, t=false [2020-01-24 10:44:33:274] [1ade] FileHistoryTrackerNode.refresh — false [2020-01-24 10:44:33:274] [1adb] FileHistoryTrackerNode.onActiveEditorChanged completed • 0 ms [2020-01-24 10:44:33:274] [1ade] FileHistoryTrackerNode.refresh returned true • 0 ms [2020-01-24 10:44:33:274] [1add] FileHistoryView.refreshNode completed • 0 ms [2020-01-24 10:44:33:274] [1adc] FileHistoryTrackerNode.triggerChange completed • 0 ms [2020-01-24 10:44:38:582] [1adf] ViewCommands.openFile — e=<error>, undefined [2020-01-24 10:44:38:582] [1ae0] GitUri.fromUri — e=GitUri(file:///d:/Projet/workspace/core/d:/Projet/workspace/core/Build.PL repoPath=D:/Projet/workspace/core) [2020-01-24 10:44:38:582] [1ae0] GitUri.fromUri returned GitUri(file:///d:/Projet/workspace/core/d:/Projet/workspace/core/Build.PL repoPath=D:/Projet/workspace/core) • 0 ms [2020-01-24 10:44:38:585] OpenWorkingFileCommand Error: cannot open file:///d%3A/Projet/workspace/core/d%3A/Projet/workspace/core/Build.PL. Detail: Impossible de lire le fichier (Error: Fichier introuvable (d:\Projet\workspace\core\d:\Projet\workspace\core\Build.PL)) [2020-01-24 10:44:38:585] ShowMessage(error, 'Unable to open working file. See output channel for more details', undefined, null) [2020-01-24 10:44:38:613] ShowMessage(error, 'Unable to open working file. See output channel for more details', undefined, null) returned undefined [2020-01-24 10:44:38:613] [1a27] ViewCommands.openFile completed • 49190 ms`

[eamodio]

@dimbs I believe GitLens 10.2.1 will fix this for you. If not, please open a new issue -- thanks!

[crazy2be]

I think I'm still seeing this same issue on GitLens 10.2.1:

[2020-04-01 13:20:47:566] [bb] LineAnnotationController.onActiveLinesChanged — e=editor=file:///home/crazy2be/src/foobar/tester_fw/company/common/palette_onewire.c, lines=undefined, pending=true, reason=selection
[2020-04-01 13:20:47:567] [bc] LineAnnotationController.clear completed • 0 ms
[2020-04-01 13:20:47:567] [bb] LineAnnotationController.onActiveLinesChanged completed • 0 ms
[2020-04-01 13:20:47:567] [bd] LineHoverController.onActiveLinesChanged — e=editor=file:///home/crazy2be/src/foobar/tester_fw/company/common/palette_onewire.c, lines=undefined, pending=true, reason=selection
[2020-04-01 13:20:47:567] [bd] LineHoverController.onActiveLinesChanged completed • 0 ms
[2020-04-01 13:20:47:567] [be] StatusBarController.onActiveLinesChanged — e=editor=file:///home/crazy2be/src/foobar/tester_fw/company/common/palette_onewire.c, lines=undefined, pending=true, reason=selection
[2020-04-01 13:20:47:568] [be] StatusBarController.onActiveLinesChanged completed • 0 ms
[2020-04-01 13:20:47:818] [bf] LineAnnotationController.onActiveLinesChanged — e=editor=file:///home/crazy2be/src/foobar/tester_fw/company/common/palette_onewire.c, lines=undefined, pending=false, reason=selection
[2020-04-01 13:20:47:819] [c0] LineAnnotationController.clear completed • 0 ms
[2020-04-01 13:20:47:819] [bf] LineAnnotationController.onActiveLinesChanged completed • 0 ms
[2020-04-01 13:20:47:819] [c1] LineHoverController.onActiveLinesChanged — e=editor=file:///home/crazy2be/src/foobar/tester_fw/company/common/palette_onewire.c, lines=undefined, pending=false, reason=selection
[2020-04-01 13:20:47:819] [c1] LineHoverController.onActiveLinesChanged completed • 0 ms
[2020-04-01 13:20:47:819] [c2] StatusBarController.onActiveLinesChanged — e=editor=file:///home/crazy2be/src/foobar/tester_fw/company/common/palette_onewire.c, lines=undefined, pending=false, reason=selection
[2020-04-01 13:20:47:819] [c2] StatusBarController.onActiveLinesChanged completed • 0 ms
[2020-04-01 13:20:48:064] [c3] RepositoriesNode.onActiveEditorChanged
[2020-04-01 13:20:48:064] [c3] RepositoriesNode.onActiveEditorChanged completed • 0 ms
[2020-04-01 13:20:48:065] [c4] FileHistoryTrackerNode.onActiveEditorChanged
[2020-04-01 13:20:48:065] [c5] FileHistoryTrackerNode.triggerChange
[2020-04-01 13:20:48:065] [c6] FileHistoryView.refreshNode — e=FileHistoryTrackerNode, t=false
[2020-04-01 13:20:48:065] [c7] FileHistoryTrackerNode.refresh — false
[2020-04-01 13:20:48:066] [c8] GitUri.fromUri — e=Uri(file:///home/crazy2be/src/foobar/tester_fw/company/common/palette_onewire.c)
[2020-04-01 13:20:48:066] [c9] GitService.getRepoPath — e=Uri(file:///home/crazy2be/src/foobar/tester_fw/company/common/palette_onewire.c)
[2020-04-01 13:20:48:066] [ca] GitService.getRepository — e=Uri(file:///home/crazy2be/src/foobar/tester_fw/company/common/palette_onewire.c), t={"skipCacheUpdate":true}
[2020-04-01 13:20:48:066] [c4] FileHistoryTrackerNode.onActiveEditorChanged completed • 1 ms
[2020-04-01 13:20:48:067] [ca] GitService.getRepository returned undefined • 0 ms
[2020-04-01 13:20:48:067] [cb] GitService.getRepoPathCore — e=/home/crazy2be/src/foobar/tester_fw/company/common/palette_onewire.c, t=false
[2020-04-01 13:20:48:089] [cc] LineHistoryTrackerNode.onActiveLinesChanged — e=editor=file:///home/crazy2be/src/foobar/tester_fw/company/common/palette_onewire.c, lines=undefined, pending=false, reason=selection
[2020-04-01 13:20:48:089] [cd] LineHistoryTrackerNode.triggerChange
[2020-04-01 13:20:48:090] [ce] LineHistoryView.refreshNode — e=LineHistoryTrackerNode, t=false
[2020-04-01 13:20:48:090] [cf] LineHistoryTrackerNode.refresh — false
[2020-04-01 13:20:48:090] [d0] GitUri.fromUri — e=Uri(file:///home/crazy2be/src/foobar/tester_fw/company/common/palette_onewire.c)
[2020-04-01 13:20:48:090] [d1] GitService.getRepoPath — e=Uri(file:///home/crazy2be/src/foobar/tester_fw/company/common/palette_onewire.c)
[2020-04-01 13:20:48:090] [d2] GitService.getRepository — e=Uri(file:///home/crazy2be/src/foobar/tester_fw/company/common/palette_onewire.c), t={"skipCacheUpdate":true}
[2020-04-01 13:20:48:090] [cc] LineHistoryTrackerNode.onActiveLinesChanged completed • 0 ms
[2020-04-01 13:20:48:091] [d2] GitService.getRepository returned undefined • 1 ms
[2020-04-01 13:20:48:091] [d3] GitService.getRepoPathCore — e=/home/crazy2be/src/foobar/tester_fw/company/common/palette_onewire.c, t=false
[2020-04-01 13:20:48:094] [/home/crazy2be/src/foobar/tester_fw/company/common] git rev-parse --show-toplevel • 26 ms 
[2020-04-01 13:20:48:095] [/home/crazy2be/src/foobar/tester_fw/company/common] git rev-parse --show-toplevel • 3 ms (await) 
[2020-04-01 13:20:48:100] [cb] GitService.getRepoPathCore Symlink detected; repoPath=/home/crazy2be/src/foobar/embedded_test_fixture, path=/home/crazy2be/src/foobar/tester_fw/company/common, resolvedPath=/home/crazy2be/src/foobar/embedded_test_fixture/platforms/atmega328pb_solution_appartusmcu/production_appartus_328pb/company/common
[2020-04-01 13:20:48:100] [cb] GitService.getRepoPathCore completed • 32 ms
[2020-04-01 13:20:48:101] [c9] GitService.getRepoPath returned /home/crazy2be/src/foobar/embedded_test_fixture • 34 ms
[2020-04-01 13:20:48:101] [c8] GitUri.fromUri returned GitUri(file:///home/crazy2be/src/foobar/tester_fw/company/common/palette_onewire.c repoPath=/home/crazy2be/src/foobar/embedded_test_fixture) • 35 ms
[2020-04-01 13:20:48:101] [d4] FileHistoryTrackerNode.resetChild
[2020-04-01 13:20:48:101] [d4] FileHistoryTrackerNode.resetChild completed • 0 ms
[2020-04-01 13:20:48:101] [c7] FileHistoryTrackerNode.refresh returned false, uri=GitUri(file:///home/crazy2be/src/foobar/tester_fw/company/common/palette_onewire.c repoPath=/home/crazy2be/src/foobar/embedded_test_fixture) • 36 ms
[2020-04-01 13:20:48:102] [d5] FileHistoryView.triggerNodeChange — e=FileHistoryTrackerNode
[2020-04-01 13:20:48:102] [d5] FileHistoryView.triggerNodeChange completed • 0 ms
[2020-04-01 13:20:48:102] [c6] FileHistoryView.refreshNode completed • 37 ms
[2020-04-01 13:20:48:102] [c5] FileHistoryTrackerNode.triggerChange completed • 37 ms
[2020-04-01 13:20:48:102] [d3] GitService.getRepoPathCore Symlink detected; repoPath=/home/crazy2be/src/foobar/embedded_test_fixture, path=/home/crazy2be/src/foobar/tester_fw/company/common, resolvedPath=/home/crazy2be/src/foobar/embedded_test_fixture/platforms/atmega328pb_solution_appartusmcu/production_appartus_328pb/company/common
[2020-04-01 13:20:48:103] [d3] GitService.getRepoPathCore completed • 11 ms
[2020-04-01 13:20:48:103] [d1] GitService.getRepoPath returned /home/crazy2be/src/foobar/embedded_test_fixture • 12 ms
[2020-04-01 13:20:48:103] [d0] GitUri.fromUri returned GitUri(file:///home/crazy2be/src/foobar/tester_fw/company/common/palette_onewire.c repoPath=/home/crazy2be/src/foobar/embedded_test_fixture) • 12 ms
[2020-04-01 13:20:48:103] [d6] LineHistoryTrackerNode.resetChild
[2020-04-01 13:20:48:103] [d6] LineHistoryTrackerNode.resetChild completed • 0 ms
[2020-04-01 13:20:48:103] [cf] LineHistoryTrackerNode.refresh returned false, uri=GitUri(file:///home/crazy2be/src/foobar/tester_fw/company/common/palette_onewire.c repoPath=/home/crazy2be/src/foobar/embedded_test_fixture) • 13 ms
[2020-04-01 13:20:48:103] [d7] LineHistoryView.triggerNodeChange — e=LineHistoryTrackerNode
[2020-04-01 13:20:48:103] [d7] LineHistoryView.triggerNodeChange completed • 0 ms
[2020-04-01 13:20:48:104] [ce] LineHistoryView.refreshNode completed • 14 ms
[2020-04-01 13:20:48:104] [cd] LineHistoryTrackerNode.triggerChange completed • 14 ms
[2020-04-01 13:20:48:105] [d8] FileHistoryView.getNodeLastKnownLimit completed • 0 ms — e=FileHistoryNode(gitlens:repository(/home/crazy2be/src/foobar/embedded_test_fixture):history:file(file:///home/crazy2be/src/foobar/embedded_test_fixture/home/crazy2be/src/foobar/tester_fw/company/common/palette_onewire.c))
[2020-04-01 13:20:48:106] [d9] FileHistoryNode(gitlens:repository(/home/crazy2be/src/foobar/embedded_test_fixture):history:file(file:///home/crazy2be/src/foobar/embedded_test_fixture/home/crazy2be/src/foobar/tester_fw/company/common/palette_onewire.c)).ensureSubscription
[2020-04-01 13:20:48:106] [da] FileHistoryNode(gitlens:repository(/home/crazy2be/src/foobar/embedded_test_fixture):history:file(file:///home/crazy2be/src/foobar/embedded_test_fixture/home/crazy2be/src/foobar/tester_fw/company/common/palette_onewire.c)).subscribe
[2020-04-01 13:20:48:106] [db] GitService.getRepository — e=GitUri(file:///home/crazy2be/src/foobar/embedded_test_fixture/home/crazy2be/src/foobar/tester_fw/company/common/palette_onewire.c repoPath=/home/crazy2be/src/foobar/embedded_test_fixture)
[2020-04-01 13:20:48:107] [db] GitService.getRepository returned /home/crazy2be/src/foobar/embedded_test_fixture • 0 ms
[2020-04-01 13:20:48:107] [da] FileHistoryNode(gitlens:repository(/home/crazy2be/src/foobar/embedded_test_fixture):history:file(file:///home/crazy2be/src/foobar/embedded_test_fixture/home/crazy2be/src/foobar/tester_fw/company/common/palette_onewire.c)).subscribe completed • 0 ms
[2020-04-01 13:20:48:107] [d9] FileHistoryNode(gitlens:repository(/home/crazy2be/src/foobar/embedded_test_fixture):history:file(file:///home/crazy2be/src/foobar/embedded_test_fixture/home/crazy2be/src/foobar/tester_fw/company/common/palette_onewire.c)).ensureSubscription completed • 1 ms
[2020-04-01 13:20:48:108] [dc] LineHistoryView.getNodeLastKnownLimit completed • 0 ms — e=LineHistoryNode(gitlens:repository(/home/crazy2be/src/foobar/embedded_test_fixture):history:line(file:///home/crazy2be/src/foobar/embedded_test_fixture/home/crazy2be/src/foobar/tester_fw/company/common/palette_onewire.c[277,41-277,41]))
[2020-04-01 13:20:48:109] [dd] LineHistoryNode(gitlens:repository(/home/crazy2be/src/foobar/embedded_test_fixture):history:line(file:///home/crazy2be/src/foobar/embedded_test_fixture/home/crazy2be/src/foobar/tester_fw/company/common/palette_onewire.c[277,41-277,41])).ensureSubscription
[2020-04-01 13:20:48:109] [de] LineHistoryNode(gitlens:repository(/home/crazy2be/src/foobar/embedded_test_fixture):history:line(file:///home/crazy2be/src/foobar/embedded_test_fixture/home/crazy2be/src/foobar/tester_fw/company/common/palette_onewire.c[277,41-277,41])).subscribe
[2020-04-01 13:20:48:109] [df] GitService.getRepository — e=GitUri(file:///home/crazy2be/src/foobar/embedded_test_fixture/home/crazy2be/src/foobar/tester_fw/company/common/palette_onewire.c repoPath=/home/crazy2be/src/foobar/embedded_test_fixture)
[2020-04-01 13:20:48:110] [df] GitService.getRepository returned /home/crazy2be/src/foobar/embedded_test_fixture • 0 ms
[2020-04-01 13:20:48:110] [de] LineHistoryNode(gitlens:repository(/home/crazy2be/src/foobar/embedded_test_fixture):history:line(file:///home/crazy2be/src/foobar/embedded_test_fixture/home/crazy2be/src/foobar/tester_fw/company/common/palette_onewire.c[277,41-277,41])).subscribe completed • 0 ms
[2020-04-01 13:20:48:110] [dd] LineHistoryNode(gitlens:repository(/home/crazy2be/src/foobar/embedded_test_fixture):history:line(file:///home/crazy2be/src/foobar/embedded_test_fixture/home/crazy2be/src/foobar/tester_fw/company/common/palette_onewire.c[277,41-277,41])).ensureSubscription completed • 1 ms
[2020-04-01 13:20:48:120] [e0] GitService.getStatusForFile — e=/home/crazy2be/src/foobar/embedded_test_fixture, t=/home/crazy2be/src/foobar/embedded_test_fixture/home/crazy2be/src/foobar/tester_fw/company/common/palette_onewire.c
[2020-04-01 13:20:48:139] [e1] GitService.getBlameForRange — e=GitUri(file:///home/crazy2be/src/foobar/embedded_test_fixture/home/crazy2be/src/foobar/tester_fw/company/common/palette_onewire.c repoPath=/home/crazy2be/src/foobar/embedded_test_fixture), t={"start":{"line":277,"character":41},"end":{"line":277,"character":41},"active":{"line":277,"character":41},"anchor":{"line":277,"character":41}}
[2020-04-01 13:20:48:139] [e2] GitService.getBlameForFile — e=GitUri(file:///home/crazy2be/src/foobar/embedded_test_fixture/home/crazy2be/src/foobar/tester_fw/company/common/palette_onewire.c repoPath=/home/crazy2be/src/foobar/embedded_test_fixture)
[2020-04-01 13:20:48:140] [e2] GitService.getBlameForFile Cache hit: 'blame'
[2020-04-01 13:20:48:140] [e2] GitService.getBlameForFile completed • 1 ms
[2020-04-01 13:20:48:140] [e1] GitService.getBlameForRange completed • 1 ms
[2020-04-01 13:20:48:142] [e3] GitService.getLogForFile — e=/home/crazy2be/src/foobar/embedded_test_fixture, t=/home/crazy2be/src/foobar/embedded_test_fixture/home/crazy2be/src/foobar/tester_fw/company/common/palette_onewire.c, i={"limit":10,"range":{"start":{"line":277,"character":41},"end":{"line":277,"character":41},"active":{"line":277,"character":41},"anchor":{"line":277,"character":41}}}
[2020-04-01 13:20:48:143] [e4] GitService.isTracked returned false • 0 ms — e=/home/crazy2be/src/foobar/embedded_test_fixture/home/crazy2be/src/foobar/tester_fw/company/common/palette_onewire.c, t=/home/crazy2be/src/foobar/embedded_test_fixture, i={}
[2020-04-01 13:20:48:143] [e3] GitService.getLogForFile Skipping log; '/home/crazy2be/src/foobar/embedded_test_fixture/home/crazy2be/src/foobar/tester_fw/company/common/palette_onewire.c' is not tracked
[2020-04-01 13:20:48:144] [e3] GitService.getLogForFile completed • 1 ms
[2020-04-01 13:20:48:145] [/home/crazy2be/src/foobar/embedded_test_fixture] git status --porcelain=v2 -- home/crazy2be/src/foobar/tester_fw/company/common/palette_onewire.c • 24 ms 
[2020-04-01 13:20:48:145] [e5] GitStatusParser.parse completed • 0 ms
[2020-04-01 13:20:48:145] [e0] GitService.getStatusForFile completed • 25 ms
[2020-04-01 13:20:48:146] [e6] GitService.getLogForFile — e=/home/crazy2be/src/foobar/embedded_test_fixture, t=/home/crazy2be/src/foobar/embedded_test_fixture/home/crazy2be/src/foobar/tester_fw/company/common/palette_onewire.c, i={"limit":10}
[2020-04-01 13:20:48:147] [e6] GitService.getLogForFile Cache miss: 'log:n10:follow'
[2020-04-01 13:20:48:147] [e6] GitService.getLogForFile Cache add: 'log:n10:follow'
[2020-04-01 13:20:48:147] [e7] GitService.isTracked returned false • 0 ms — e=/home/crazy2be/src/foobar/embedded_test_fixture/home/crazy2be/src/foobar/tester_fw/company/common/palette_onewire.c, t=/home/crazy2be/src/foobar/embedded_test_fixture, i={}
[2020-04-01 13:20:48:147] [e6] GitService.getLogForFile Skipping log; '/home/crazy2be/src/foobar/embedded_test_fixture/home/crazy2be/src/foobar/tester_fw/company/common/palette_onewire.c' is not tracked
[2020-04-01 13:20:48:148] [e6] GitService.getLogForFile completed • 1 ms

My hierarchy is:

/home/crazy2be/src/foobar:
    embedded_test_fixture: git repo
    tester_fw: symlink to /home/crazy2be/src/foobar/embedded_test_fixture/platforms/atmega328pb_solution_appartusmcu/production_appartus_328pb

I had originally opened this project _without_ using the symlink, which I suspect may have caused VSCode to record somewhere the repository root. I'll poke around with clearing various caches.
```

[github-actions[bot]]

This issue has been automatically locked since there has not been any recent activity after it was closed. Please open a new issue for related bugs.