Skip to content
New issue

Have a question about this project? Sign up for a free GitHub account to open an issue and contact its maintainers and the community.

Sign up for GitHub

By clicking “Sign up for GitHub”, you agree to our terms of service and privacy statement. We’ll occasionally send you account related emails.

Already on GitHub? Sign in to your account

Jump to bottom

Remote extension host terminated unexpectedly 3 times within the last 5 minutes #23906

Closed
limstash opened this issue Aug 5, 2024 · 11 comments
Closed

Remote extension host terminated unexpectedly 3 times within the last 5 minutes #23906

limstash opened this issue Aug 5, 2024 · 11 comments
Assignees
@anthonykim1
Labels
info-needed Issue requires more information from poster triage-needed Needs assignment to the proper sub-team

Comments

@limstash
Copy link

limstash commented Aug 5, 2024

Type: Bug

My remote host is in an LXC container, and after installing the Python extension, it prompts "Remote extension host terminated unexpectedly 3 times within the last 5 minutes".

[13:25:08.880] [server] [05:25:07] [<unknown>][10f2c1dd][ExtensionHostConnection] <4213> Launched Extension Host Process.
[13:25:11.967] [server] [05:25:10] [<unknown>][10f2c1dd][ExtensionHostConnection] <4213> Extension Host Process exited with code: null, signal: SIGSEGV.

Extension version: 2024.12.1
VS Code version: Code 1.92.0 (b1c0a14de1414fcdaa400695b4db1c0799bc3124, 2024-07-31T23:26:45.634Z)
OS version: Windows_NT x64 10.0.22635
Modes:
Remote OS version: Linux x64 5.14.0-410.el9.x86_64

Output: Python 
2024-08-05 05:24:24.247 [info] Experiment 'pythonCreateEnvOnPipInstall' is active
2024-08-05 05:24:24.247 [info] Experiment 'pythonRecommendTensorboardExt' is active
2024-08-05 05:24:24.247 [info] Experiment 'pythonSurveyNotification' is active
2024-08-05 05:24:24.247 [info] Experiment 'pythonTerminalEnvVarActivation' is active
2024-08-05 05:24:24.247 [info] Experiment 'pythonTestAdapter' is active
2024-08-05 05:24:24.247 [error] Reading directory to watch failed [Error: ENOENT: no such file or directory, scandir '/home/limstash/safety/.pixi/envs'
	at Object.readdirSync (node:fs:1507:26)
	at /home/limstash/.vscode-server/extensions/ms-python.python-2024.12.1/out/client/extension.js:2:586747
	at /home/limstash/.vscode-server/extensions/ms-python.python-2024.12.1/out/client/extension.js:2:586938
	at Array.map (<anonymous>)
	at d.initWatchers (/home/limstash/.vscode-server/extensions/ms-python.python-2024.12.1/out/client/extension.js:2:586656)
	at async d.ensureWatchersReady (/home/limstash/.vscode-server/extensions/ms-python.python-2024.12.1/out/client/extension.js:2:543067)] {
  errno: -2,
  code: 'ENOENT',
  syscall: 'scandir',
  path: '/home/limstash/safety/.pixi/envs'
}
2024-08-05 05:24:24.247 [error] Dir "/home/limstash/safety/.pixi/envs" is not watchable (directory does not exist)
2024-08-05 05:24:24.247 [info] Default formatter is set to null for workspace /home/limstash/safety
2024-08-05 05:24:24.247 [info] Python interpreter path: /usr/bin/python3
2024-08-05 05:24:24.288 [info] > pyenv which python
2024-08-05 05:24:24.288 [info] cwd: .
2024-08-05 05:24:24.383 [info] > pixi --version
2024-08-05 05:24:24.384 [error] [Error: spawn pixi ENOENT
	at ChildProcess._handle.onexit (node:internal/child_process:286:19)
	at onErrorNT (node:internal/child_process:484:16)
	at process.processTicksAndRejections (node:internal/process/task_queues:82:21)] {
  errno: -2,
  code: 'ENOENT',
  syscall: 'spawn pixi',
  path: 'pixi',
  spawnargs: [ '--version' ]
}
2024-08-05 05:24:24.384 [warning] could not find a pixi interpreter for the interpreter at /usr/bin/python3
2024-08-05 05:24:46.497 [info] Experiment 'pythonCreateEnvOnPipInstall' is active
2024-08-05 05:24:46.504 [info] Experiment 'pythonRecommendTensorboardExt' is active
2024-08-05 05:24:46.504 [info] Experiment 'pythonSurveyNotification' is active
2024-08-05 05:24:46.504 [info] Experiment 'pythonTerminalEnvVarActivation' is active
2024-08-05 05:24:46.504 [info] Experiment 'pythonTestAdapter' is active
2024-08-05 05:24:46.504 [error] Reading directory to watch failed [Error: ENOENT: no such file or directory, scandir '/home/limstash/safety/.pixi/envs'
	at Object.readdirSync (node:fs:1507:26)
	at /home/limstash/.vscode-server/extensions/ms-python.python-2024.12.1/out/client/extension.js:2:586747
	at /home/limstash/.vscode-server/extensions/ms-python.python-2024.12.1/out/client/extension.js:2:586938
	at Array.map (<anonymous>)
	at d.initWatchers (/home/limstash/.vscode-server/extensions/ms-python.python-2024.12.1/out/client/extension.js:2:586656)
	at async d.ensureWatchersReady (/home/limstash/.vscode-server/extensions/ms-python.python-2024.12.1/out/client/extension.js:2:543067)] {
  errno: -2,
  code: 'ENOENT',
  syscall: 'scandir',
  path: '/home/limstash/safety/.pixi/envs'
}
2024-08-05 05:24:46.504 [error] Dir "/home/limstash/safety/.pixi/envs" is not watchable (directory does not exist)
2024-08-05 05:24:46.659 [info] Default formatter is set to null for workspace /home/limstash/safety
2024-08-05 05:24:46.820 [info] Python interpreter path: /usr/bin/python3
2024-08-05 05:24:47.134 [info] > pyenv which python
2024-08-05 05:24:47.134 [info] cwd: .
2024-08-05 05:24:47.433 [info] > pixi --version
2024-08-05 05:24:47.434 [error] [Error: spawn pixi ENOENT
	at ChildProcess._handle.onexit (node:internal/child_process:286:19)
	at onErrorNT (node:internal/child_process:484:16)
	at process.processTicksAndRejections (node:internal/process/task_queues:82:21)] {
  errno: -2,
  code: 'ENOENT',
  syscall: 'spawn pixi',
  path: 'pixi',
  spawnargs: [ '--version' ]
}
2024-08-05 05:24:47.435 [warning] could not find a pixi interpreter for the interpreter at /usr/bin/python3
2024-08-05 05:25:09.849 [info] Experiment 'pythonCreateEnvOnPipInstall' is active
2024-08-05 05:25:09.849 [info] Experiment 'pythonRecommendTensorboardExt' is active
2024-08-05 05:25:09.849 [info] Experiment 'pythonSurveyNotification' is active
2024-08-05 05:25:09.849 [info] Experiment 'pythonTerminalEnvVarActivation' is active
2024-08-05 05:25:09.849 [info] Experiment 'pythonTestAdapter' is active
2024-08-05 05:25:09.849 [error] Reading directory to watch failed [Error: ENOENT: no such file or directory, scandir '/home/limstash/safety/.pixi/envs'
	at Object.readdirSync (node:fs:1507:26)
	at /home/limstash/.vscode-server/extensions/ms-python.python-2024.12.1/out/client/extension.js:2:586747
	at /home/limstash/.vscode-server/extensions/ms-python.python-2024.12.1/out/client/extension.js:2:586938
	at Array.map (<anonymous>)
	at d.initWatchers (/home/limstash/.vscode-server/extensions/ms-python.python-2024.12.1/out/client/extension.js:2:586656)
	at async d.ensureWatchersReady (/home/limstash/.vscode-server/extensions/ms-python.python-2024.12.1/out/client/extension.js:2:543067)] {
  errno: -2,
  code: 'ENOENT',
  syscall: 'scandir',
  path: '/home/limstash/safety/.pixi/envs'
}
2024-08-05 05:25:09.849 [error] Dir "/home/limstash/safety/.pixi/envs" is not watchable (directory does not exist)
2024-08-05 05:25:09.849 [info] Default formatter is set to null for workspace /home/limstash/safety
2024-08-05 05:25:09.853 [info] Python interpreter path: /usr/bin/python3
2024-08-05 05:25:10.384 [info] > pyenv which python
2024-08-05 05:25:10.384 [info] cwd: .
2024-08-05 05:25:10.715 [info] > pixi --version
2024-08-05 05:25:10.716 [error] [Error: spawn pixi ENOENT
	at ChildProcess._handle.onexit (node:internal/child_process:286:19)
	at onErrorNT (node:internal/child_process:484:16)
	at process.processTicksAndRejections (node:internal/process/task_queues:82:21)] {
  errno: -2,
  code: 'ENOENT',
  syscall: 'spawn pixi',
  path: 'pixi',
  spawnargs: [ '--version' ]
}
2024-08-05 05:25:10.717 [warning] could not find a pixi interpreter for the interpreter at /usr/bin/python3
2024-08-05 05:26:16.190 [info] Experiment 'pythonCreateEnvOnPipInstall' is active
2024-08-05 05:26:16.190 [info] Experiment 'pythonRecommendTensorboardExt' is active
2024-08-05 05:26:16.190 [info] Experiment 'pythonSurveyNotification' is active
2024-08-05 05:26:16.190 [info] Experiment 'pythonTerminalEnvVarActivation' is active
2024-08-05 05:26:16.190 [info] Experiment 'pythonTestAdapter' is active
2024-08-05 05:26:16.190 [error] Reading directory to watch failed [Error: ENOENT: no such file or directory, scandir '/home/limstash/safety/.pixi/envs'
	at Object.readdirSync (node:fs:1507:26)
	at /home/limstash/.vscode-server/extensions/ms-python.python-2024.12.1/out/client/extension.js:2:586747
	at /home/limstash/.vscode-server/extensions/ms-python.python-2024.12.1/out/client/extension.js:2:586938
	at Array.map (<anonymous>)
	at d.initWatchers (/home/limstash/.vscode-server/extensions/ms-python.python-2024.12.1/out/client/extension.js:2:586656)
	at async d.ensureWatchersReady (/home/limstash/.vscode-server/extensions/ms-python.python-2024.12.1/out/client/extension.js:2:543067)] {
  errno: -2,
  code: 'ENOENT',
  syscall: 'scandir',
  path: '/home/limstash/safety/.pixi/envs'
}
2024-08-05 05:26:16.190 [error] Dir "/home/limstash/safety/.pixi/envs" is not watchable (directory does not exist)
2024-08-05 05:26:16.350 [info] Default formatter is set to null for workspace /home/limstash/safety
2024-08-05 05:26:16.487 [info] Python interpreter path: /usr/bin/python3
2024-08-05 05:26:16.585 [info] > pyenv which python
2024-08-05 05:26:16.585 [info] cwd: .
2024-08-05 05:26:17.000 [info] > pixi --version
2024-08-05 05:26:17.001 [error] [Error: spawn pixi ENOENT
	at ChildProcess._handle.onexit (node:internal/child_process:286:19)
	at onErrorNT (node:internal/child_process:484:16)
	at process.processTicksAndRejections (node:internal/process/task_queues:82:21)] {
  errno: -2,
  code: 'ENOENT',
  syscall: 'spawn pixi',
  path: 'pixi',
  spawnargs: [ '--version' ]
}
2024-08-05 05:26:17.001 [warning] could not find a pixi interpreter for the interpreter at /usr/bin/python3
Output: Remote - SSH 
[13:24:18.996] Log Level: 2
[13:24:19.002] VS Code version: 1.92.0
[13:24:19.002] Remote-SSH version: remote-ssh@0.112.0
[13:24:19.003] win32 x64
[13:24:19.003] SSH Resolver called for "ssh-remote+ecjtu", attempt 1
[13:24:19.003] "remote.SSH.useLocalServer": false
[13:24:19.003] "remote.SSH.useExecServer": true
[13:24:19.004] "remote.SSH.showLoginTerminal": false
[13:24:19.004] "remote.SSH.remotePlatform": {"zju-law":"linux","ecjtu":"linux","ecjtu-router":"linux","ecjtu-s02":"linux","ecjtu-s03":"linux","zju-hpc":"linux","zju-A100":"linux","zju-A10":"linux","local":"linux"}
[13:24:19.004] "remote.SSH.path": undefined
[13:24:19.004] "remote.SSH.configFile": undefined
[13:24:19.004] "remote.SSH.useFlock": true
[13:24:19.004] "remote.SSH.lockfilesInTmp": false
[13:24:19.004] "remote.SSH.localServerDownload": auto
[13:24:19.004] "remote.SSH.remoteServerListenOnSocket": false
[13:24:19.004] "remote.SSH.showLoginTerminal": false
[13:24:19.004] "remote.SSH.defaultExtensions": []
[13:24:19.004] "remote.SSH.loglevel": 2
[13:24:19.004] "remote.SSH.enableDynamicForwarding": true
[13:24:19.004] "remote.SSH.enableRemoteCommand": false
[13:24:19.004] "remote.SSH.serverPickPortsFromRange": {}
[13:24:19.004] "remote.SSH.serverInstallPath": {}
[13:24:19.011] SSH Resolver called for host: ecjtu
[13:24:19.011] Setting up SSH remote "ecjtu"
[13:24:19.013] Using commit id "b1c0a14de1414fcdaa400695b4db1c0799bc3124" and quality "stable" for server
[13:24:19.014] Install and start server if needed
[13:24:19.016] Checking ssh with "C:\Program Files (x86)\VMware\VMware Workstation\bin\ssh.exe -V"
[13:24:19.018] Got error from ssh: spawn C:\Program Files (x86)\VMware\VMware Workstation\bin\ssh.exe ENOENT
[13:24:19.018] Checking ssh with "C:\Program Files\Python\Scripts\ssh.exe -V"
[13:24:19.018] Got error from ssh: spawn C:\Program Files\Python\Scripts\ssh.exe ENOENT
[13:24:19.018] Checking ssh with "C:\Program Files\Python\ssh.exe -V"
[13:24:19.019] Got error from ssh: spawn C:\Program Files\Python\ssh.exe ENOENT
[13:24:19.019] Checking ssh with "C:\Windows\system32\ssh.exe -V"
[13:24:19.020] Got error from ssh: spawn C:\Windows\system32\ssh.exe ENOENT
[13:24:19.020] Checking ssh with "C:\Windows\ssh.exe -V"
[13:24:19.020] Got error from ssh: spawn C:\Windows\ssh.exe ENOENT
[13:24:19.021] Checking ssh with "C:\Windows\System32\Wbem\ssh.exe -V"
[13:24:19.021] Got error from ssh: spawn C:\Windows\System32\Wbem\ssh.exe ENOENT
[13:24:19.021] Checking ssh with "C:\Windows\System32\WindowsPowerShell\v1.0\ssh.exe -V"
[13:24:19.022] Got error from ssh: spawn C:\Windows\System32\WindowsPowerShell\v1.0\ssh.exe ENOENT
[13:24:19.022] Checking ssh with "C:\Windows\System32\OpenSSH\ssh.exe -V"
[13:24:19.084] > OpenSSH_for_Windows_8.6p1, LibreSSL 3.4.3

[13:24:19.087] Running script with connection command: "C:\Windows\System32\OpenSSH\ssh.exe" -T -D 9589 ecjtu bash
[13:24:19.089] Terminal shell path: C:\Windows\System32\cmd.exe
[13:24:19.671] > bdc24b82c470: running
> �]0;C:\Windows\System32\cmd.exe 
[13:24:19.671] Got some output, clearing connection timeout
[13:24:19.710] > Found existing installation at /home/limstash/.vscode-server...
> Starting VS Code CLI... "/home/limstash/.vscode-server/code-b1c0a14de1414fcdaa400695b4db1c0799bc3124" command-shell --cli-data-dir "/home/limstash/.vscode-server/cli" --on-port --on-host=127.0.0.1 --parent-process-id 3757 &> "/home/limstash/.vscode-server/.cli.b1c0a14de1414fcdaa400695b4db1c0799bc3124.log" < /dev/null
> printenv:
>     SHELL=/bin/bash
>     PWD=/home/limstash
>     LOGNAME=limstash
>     XDG_SESSION_TYPE=tty
>     MOTD_SHOWN=pam
>     HOME=/home/limstash
>     LANG=en_US.UTF-8
>     VSCODE_AGENT_FOLDER=/home/limstash/.vscode-server
>     SSH_CONNECTION=10.242.174.177 9590 10.242.59.81 22
>     XDG_SESSION_CLASS=user
>     USER=limstash
>     SHLVL=0
>     XDG_SESSION_ID=856
>     XDG_RUNTIME_DIR=/run/user/1001
>     SSH_CLIENT=10.242.174.177 9590 22
>     PATH=/opt/anaconda3/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/games:/usr/local/games:/snap/bin
>     _=/usr/bin/printenv
> Removing old logfile at /home/limstash/.vscode-server/.cli.b1c0a14de1414fcdaa400695b4db1c0799bc3124.log
[13:24:19.726] > Spawned remote CLI: 3776
[13:24:19.788] > Waiting for server log...
[13:24:19.803] > bdc24b82c470: start
> SSH_AUTH_SOCK====
> DISPLAY====
> listeningOn==127.0.0.1:35969==
> osReleaseId==ubuntu==
> arch==x86_64==
> vscodeArch==x64==
> bitness==64==
> tmpDir==/run/user/1001==
> platform==linux==
> unpackResult====
> didLocalDownload==0==
> downloadTime====
> installTime====
> serverStartTime==103==
> execServerToken==111a1111-1111-1a11-a1a1-aa11111a1111==
> bdc24b82c470: end
[13:24:19.803] Received install output: 
SSH_AUTH_SOCK====
DISPLAY====
listeningOn==127.0.0.1:35969==
osReleaseId==ubuntu==
arch==x86_64==
vscodeArch==x64==
bitness==64==
tmpDir==/run/user/1001==
platform==linux==
unpackResult====
didLocalDownload==0==
downloadTime====
installTime====
serverStartTime==103==
execServerToken==111a1111-1111-1a11-a1a1-aa11111a1111==

[13:24:19.803] Remote server is listening on port 35969
[13:24:19.803] Parsed server configuration: {"serverConfiguration":{"remoteListeningOn":{"port":35969},"osReleaseId":"ubuntu","arch":"x86_64","sshAuthSock":"","display":"","tmpDir":"/run/user/1001","platform":"linux","execServerToken":"111a1111-1111-1a11-a1a1-aa11111a1111"},"serverStartTime":103,"installUnpackCode":""}
[13:24:19.806] Starting forwarding server. local port 9591 -> socksPort 9589 -> remotePort 35969
[13:24:19.807] Forwarding server listening on port 9591
[13:24:19.807] Waiting for ssh tunnel to be ready
[13:24:19.808] [Forwarding server port 9591] Got connection 0
[13:24:19.809] Tunneled port 35969 to local port 9591
[13:24:19.809] Resolved "ssh-remote+ecjtu" to "port 9591"
[13:24:19.812] Initizing new exec server for ssh-remote+ecjtu
[13:24:19.813] Resolving exec server at port 9591
[13:24:19.831] [Forwarding server port 9591] Got connection 1
[13:24:19.832] > 
[13:24:19.959] Exec server for ssh-remote+ecjtu created and cached
[13:24:19.961] ------




[13:24:19.973] [server] Checking /home/limstash/.vscode-server/cli/servers/Stable-b1c0a14de1414fcdaa400695b4db1c0799bc3124/log.txt and /home/limstash/.vscode-server/cli/servers/Stable-b1c0a14de1414fcdaa400695b4db1c0799bc3124/pid.txt for a running server...
[13:24:20.016] [server] Installing and setting up Visual Studio Code Server...
[13:24:20.016] [server] Server setup complete
[13:24:20.016] [server] Starting server...
[13:24:20.016] [server] Starting server with command... Command { std: "/home/limstash/.vscode-server/cli/servers/Stable-b1c0a14de1414fcdaa400695b4db1c0799bc3124/server/bin/code-server" "--connection-token=remotessh" "--accept-server-license-terms" "--start-server" "--enable-remote-auto-shutdown" "--socket-path=/tmp/code-b6b48ddf-bca5-4145-a03e-153e182018c1", kill_on_drop: false }
[13:24:20.115] [server] *
[13:24:20.115] [server] * Visual Studio Code Server
[13:24:20.115] [server] *
[13:24:20.115] [server] * By using the software, you agree to
[13:24:20.115] [server] * the Visual Studio Code Server License Terms (https://aka.ms/vscode-server-license) and
[13:24:20.115] [server] * the Microsoft Privacy Statement (https://privacy.microsoft.com/en-US/privacystatement).
[13:24:20.119] [server] Server bound to /tmp/code-b6b48ddf-bca5-4145-a03e-153e182018c1
[13:24:20.119] [server] Extension host agent listening on /tmp/code-b6b48ddf-bca5-4145-a03e-153e182018c1
[13:24:20.119] [server] parsed location: "/tmp/code-b6b48ddf-bca5-4145-a03e-153e182018c1"
[13:24:20.120] [server] 
[13:24:20.120] [server] Server started
[13:24:20.554] [server] [05:24:19] 
[13:24:20.600] [server] 
[13:24:20.600] [server] 
[13:24:20.600] [server] 
[13:24:20.686] [server] [05:24:19] Extension host agent started.
[13:24:20.847] [server] [05:24:19] [<unknown>][0d2a1b65][ExtensionHostConnection] New connection established.
[13:24:20.847] [server] [05:24:19] [<unknown>][737cc262][ManagementConnection] New connection established.
[13:24:21.939] [server] [05:24:20] [<unknown>][0d2a1b65][ExtensionHostConnection] <3849> Launched Extension Host Process.
[13:24:25.508] [server] [05:24:24] [<unknown>][0d2a1b65][ExtensionHostConnection] <3849> Extension Host Process exited with code: null, signal: SIGSEGV.
[13:24:25.544] [server] Cancelling previous shutdown timeout
[13:24:25.544] [server] [05:24:24] Cancelling previous shutdown timeout
[13:24:25.544] [server] Last EH closed, waiting before shutting down
[13:24:45.493] [server] [05:24:44] [<unknown>][0d2a1b65][ExtensionHostConnection] Unknown reconnection token (seen before).
[13:24:45.591] [server] [05:24:44] [<unknown>][6918a7ff][ExtensionHostConnection] New connection established.
[13:24:45.592] [server] [05:24:44] [<unknown>][6918a7ff][ExtensionHostConnection] <4038> Launched Extension Host Process.
[13:24:48.884] [server] [05:24:47] [<unknown>][6918a7ff][ExtensionHostConnection] <4038> Extension Host Process exited with code: null, signal: SIGSEGV.
[13:24:48.896] [server] Cancelling previous shutdown timeout
[13:24:48.896] [server] [05:24:47] Cancelling previous shutdown timeout
[13:24:48.896] [server] Last EH closed, waiting before shutting down
[13:25:08.748] [server] [05:25:07] [<unknown>][6918a7ff][ExtensionHostConnection] Unknown reconnection token (seen before).
[13:25:08.880] [server] [05:25:07] [<unknown>][10f2c1dd][ExtensionHostConnection] New connection established.
[13:25:08.880] [server] [05:25:07] [<unknown>][10f2c1dd][ExtensionHostConnection] <4213> Launched Extension Host Process.
[13:25:11.967] [server] [05:25:10] [<unknown>][10f2c1dd][ExtensionHostConnection] <4213> Extension Host Process exited with code: null, signal: SIGSEGV.
[13:25:12.008] [server] Cancelling previous shutdown timeout
[13:25:12.008] [server] [05:25:10] Cancelling previous shutdown timeout
[13:25:12.009] [server] Last EH closed, waiting before shutting down
[13:25:31.810] [server] [05:25:30] [<unknown>][10f2c1dd][ExtensionHostConnection] Unknown reconnection token (seen before).
[13:26:16.093] [server] [05:26:15] [<unknown>][b33ce475][ExtensionHostConnection] New connection established.
[13:26:16.093] [server] [05:26:15] [<unknown>][b33ce475][ExtensionHostConnection] <4400> Launched Extension Host Process.
[13:26:18.142] [server] [05:26:17] [<unknown>][b33ce475][ExtensionHostConnection] <4400> Extension Host Process exited with code: null, signal: SIGSEGV.
[13:26:18.182] [server] Cancelling previous shutdown timeout
[13:26:18.182] [server] [05:26:17] Cancelling previous shutdown timeout
[13:26:18.182] [server] Last EH closed, waiting before shutting down
[13:26:38.008] [server] [05:26:37] [<unknown>][b33ce475][ExtensionHostConnection] Unknown reconnection token (seen before).
[13:31:18.141] [server] Last EH closed, shutting down
[13:31:18.182] [server] [05:31:17] Last EH closed, shutting down
[13:31:38.993] ------




[13:31:38.993] SSH Resolver called for "ssh-remote+ecjtu", attempt 2, (Reconnection)
[13:31:38.995] SSH Resolver called for host: ecjtu
[13:31:38.995] Setting up SSH remote "ecjtu"
[13:31:38.997] Using commit id "b1c0a14de1414fcdaa400695b4db1c0799bc3124" and quality "stable" for server
[13:31:38.999] Install and start server if needed
[13:31:39.002] Running script with connection command: "C:\Windows\System32\OpenSSH\ssh.exe" -T -D 9821 ecjtu bash
[13:31:39.005] Terminal shell path: C:\Windows\System32\cmd.exe
[13:31:40.965] > cd71605206a8: running
> �]0;C:\Windows\System32\cmd.exe Found existing installation at /home/limstash/.vscode-server...
> Starting VS Code CLI... "/home/limstash/.vscode-server/code-b1c0a14de1414fcdaa400695b4db1c0799bc3124" command-shell --cli-data-dir "/home/limstash/.vscode-server/cli" --on-port --on-host=127.0.0.1 --parent-process-id 4715 &> "/home/limstash/.vscode-server/.cli.b1c0a14de1414fcdaa400695b4db1c0799bc3124.log" < /dev/null
> printenv:
>     SHELL=/bin/bash
>     PWD=/home/limstash
>     LOGNAME=limstash
>     XDG_SESSION_TYPE=tty
>     MOTD_SHOWN=pam
>     HOME=/home/limstash
>     LANG=en_US.UTF-8
>     VSCODE_AGENT_FOLDER=/home/limstash/.vscode-server
>     SSH_CONNECTION=10.242.174.177 9822 10.242.59.81 22
>     XDG_SESSION_CLASS=user
>     USER=limstash
>     SHLVL=0
>     XDG_SESSION_ID=857
>     XDG_RUNTIME_DIR=/run/user/1001
>     SSH_CLIENT=10.242.174.177 9822 22
>     PATH=/opt/anaconda3/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/games:/usr/local/games:/snap/bin
>     _=/usr/bin/printenv
> Removing old logfile at /home/limstash/.vscode-server/.cli.b1c0a14de1414fcdaa400695b4db1c0799bc3124.log
> Spawned remote CLI: 4734
> Waiting for server log...
> Waiting for server log...
> cd71605206a8: start
> SSH_AUTH_SOCK====
> DISPLAY====
> listeningOn==127.0.0.1:41131==
> osReleaseId==ubuntu==
> arch==x86_64==
> vscodeArch==x64==
> bitness==64==
> tmpDir==/run/user/1001==
> platform==linux==
> unpackResult====
> didLocalDownload==0==
> downloadTime====
> installTime====
> serverStartTime==133==
> execServerToken==a11a111a-a1aa-1a11-111a-1a11111a11a1==
> cd71605206a8: end
[13:31:40.966] Got some output, clearing connection timeout
[13:31:40.966] Received install output: 
SSH_AUTH_SOCK====
DISPLAY====
listeningOn==127.0.0.1:41131==
osReleaseId==ubuntu==
arch==x86_64==
vscodeArch==x64==
bitness==64==
tmpDir==/run/user/1001==
platform==linux==
unpackResult====
didLocalDownload==0==
downloadTime====
installTime====
serverStartTime==133==
execServerToken==a11a111a-a1aa-1a11-111a-1a11111a11a1==

[13:31:40.966] Remote server is listening on port 41131
[13:31:40.966] Parsed server configuration: {"serverConfiguration":{"remoteListeningOn":{"port":41131},"osReleaseId":"ubuntu","arch":"x86_64","sshAuthSock":"","display":"","tmpDir":"/run/user/1001","platform":"linux","execServerToken":"a11a111a-a1aa-1a11-111a-1a11111a11a1"},"serverStartTime":133,"installUnpackCode":""}
[13:31:40.968] Starting forwarding server. local port 9823 -> socksPort 9821 -> remotePort 41131
[13:31:40.969] Forwarding server listening on port 9823
[13:31:40.969] Waiting for ssh tunnel to be ready
[13:31:40.970] [Forwarding server port 9823] Got connection 0
[13:31:40.972] Tunneled port 41131 to local port 9823
[13:31:40.972] Resolved "ssh-remote+ecjtu" to "port 9823"
[13:31:40.977] Verified and reusing cached exec server for ssh-remote+ecjtu
[13:31:40.978] ------
System Info
Item Value
CPUs 12th Gen Intel(R) Core(TM) i7-12700H (20 x 2688)
GPU Status 2d_canvas: enabled
canvas_oop_rasterization: enabled_on
direct_rendering_display_compositor: disabled_off_ok
gpu_compositing: enabled
multiple_raster_threads: enabled_on
opengl: enabled_on
rasterization: enabled
raw_draw: disabled_off_ok
skia_graphite: disabled_off
video_decode: enabled
video_encode: enabled
vulkan: disabled_off
webgl: enabled
webgl2: enabled
webgpu: enabled
webnn: disabled_off
Load (avg) undefined
Memory (System) 31.73GB (17.14GB free)
Process Argv --crash-reporter-id 130cfe31-0747-4c8d-a901-29312b385e70
Screen Reader no
VM 50%
Item Value
Remote SSH: ecjtu
OS Linux x64 5.14.0-410.el9.x86_64
CPUs Intel(R) Xeon(R) Gold 6133 CPU @ 2.50GHz (4 x 2800)
Memory (System) 8.00GB (7.77GB free)
VM 100%
A/B Experiments 
vsliv368cf:30146710
vspor879:30202332
vspor708:30202333
vspor363:30204092
vstes627:30244334
vscod805:30301674
binariesv615:30325510
vsaa593:30376534
py29gd2263:31024239
c4g48928:30535728
azure-dev_surveyone:30548225
962ge761:30959799
pythongtdpath:30769146
welcomedialogc:30910334
pythonnoceb:30805159
asynctok:30898717
pythonregdiag2:30936856
pythonmypyd1:30879173
h48ei257:31000450
pythontbext0:30879054
accentitlementst:30995554
dsvsc016:30899300
dsvsc017:30899301
dsvsc018:30899302
cppperfnew:31000557
dsvsc020:30976470
pythonait:31006305
dsvsc021:30996838
g316j359:31013175
pythoncenvpt:31062603
a69g1124:31058053
dvdeprecation:31068756
dwnewjupyter:31046869
2f103344:31071589
impr_priority:31102340
refactort:31108082
ccplt:31103426
pythonrstrctxtcf:31103194
hdi1a554:31097393
wkspc-onlycs-c:31106320
@github-actions github-actions bot added the triage-needed Needs assignment to the proper sub-team label Aug 5, 2024
@limstash
Copy link
Author

limstash commented Aug 5, 2024 •
edited
Loading

Here is the log file 20240805T145926.tar.gz in the remote server ~/.vscode-server/data/logs

This problem appeared after I moved the LXC container from machine A to machine B, when I moved back to A again, the extension worked fine.

@anthonykim1
Copy link

Hi @limstash Thank you much for filing this.

Just for the sake of diagnosing where this issue is coming from, are you using pixi for your Python project?

@github-actions github-actions bot added the info-needed Issue requires more information from poster label Aug 9, 2024
@limstash
Copy link
Author

limstash commented Aug 9, 2024 •
edited
Loading

@anthonykim1 Thanks for your reply, I don't use pixi.

It seems that this is an issue unrelated to pixi. I rolled back the versions of Python and Pylance, and the last usable versions were Python v2024.0.1 and Pylance v2024.2.3.

When Python v2024.2.0 OR Pylance v2024.3.1 are installed, the extension host crashes.

@github-actions github-actions bot removed the info-needed Issue requires more information from poster label Aug 9, 2024
@anthonykim1 anthonykim1 mentioned this issue Aug 12, 2024
Merged
anthonykim1 added a commit that referenced this issue Aug 12, 2024
@anthonykim1
Attempt to handle pixi error more gracefully (#23937)
f417024 
For: #23911 and
#23906

(For virtual/remote scenario) Locating pixi environment, regardless of
presence of pixi environment, is leading to crash. Hoping to address
this and handle errors more gracefully so program does not terminate.

/cc @baszalmstra
@anthonykim1
Copy link

Hello @limstash Thanks for the feedback here.
I am seeing

2024-08-05 05:24:24.247 [error] Reading directory to watch failed [Error: ENOENT: no such file or directory, scandir '/home/limstash/safety/.pixi/envs'
	at Object.readdirSync (node:fs:1507:26)
	at /home/limstash/.vscode-server/extensions/ms-python.python-2024.12.1/out/client/extension.js:2:586747
	at /home/limstash/.vscode-server/extensions/ms-python.python-2024.12.1/out/client/extension.js:2:586938
	at Array.map (<anonymous>)
	at d.initWatchers (/home/limstash/.vscode-server/extensions/ms-python.python-2024.12.1/out/client/extension.js:2:586656)
	at async d.ensureWatchersReady (/home/limstash/.vscode-server/extensions/ms-python.python-2024.12.1/out/client/extension.js:2:543067)] {
  errno: -2,
  code: 'ENOENT',
  syscall: 'scandir',
  path: '/home/limstash/safety/.pixi/envs'
}

in your logs so it may be implicitly related to pixi. I just merged in #23937 so hoping this will take of the problem.

That being said, the changes should be available starting tomorrow's pre-release version of the Python extension.
Could you please give it a try after tomorrow and see if you can still repro the problem?

@github-actions github-actions bot added the info-needed Issue requires more information from poster label Aug 12, 2024
@anthonykim1
Copy link

I have additional efforts #23942 which might help you resolve issue.

@limstash
Copy link
Author

limstash commented Aug 13, 2024 •
edited
Loading

Hi @anthonykim1 Thanks for your efforts in investigating and fixing this.

After updating to Python v2024.13.2024081301(pre-release) and Pylance v2024.8.101(pre-release), the issue was not resolved.

Additionally, as I mentioned before, I only encounter this issue when running virtual containers on specific host machines, and their hard drive contents are exactly the same (mirrored).

In another host machine, the pixi error still occurs, but it doesn't crash.

Output: Python (same disk image on another host machine) 
2024-08-13 17:07:27.643 [info] Experiment 'pythonCreateEnvOnPipInstall' is active
2024-08-13 17:07:27.643 [info] Experiment 'pythonRecommendTensorboardExt' is active
2024-08-13 17:07:27.643 [info] Experiment 'pythonSurveyNotification' is active
2024-08-13 17:07:27.643 [info] Experiment 'pythonTerminalEnvVarActivation' is active
2024-08-13 17:07:27.643 [info] Experiment 'pythonTestAdapter' is active
2024-08-13 17:07:27.643 [error] Reading directory to watch failed [Error: ENOENT: no such file or directory, scandir '/home/limstash/AMIC/.pixi/envs'
	at Object.readdirSync (node:fs:1507:26)
	at /home/limstash/.vscode-server/extensions/ms-python.python-2024.12.2-linux-x64/out/client/extension.js:2:586747
	at /home/limstash/.vscode-server/extensions/ms-python.python-2024.12.2-linux-x64/out/client/extension.js:2:586938
	at Array.map (<anonymous>)
	at d.initWatchers (/home/limstash/.vscode-server/extensions/ms-python.python-2024.12.2-linux-x64/out/client/extension.js:2:586656)
	at process.processTicksAndRejections (node:internal/process/task_queues:95:5)
	at async d.ensureWatchersReady (/home/limstash/.vscode-server/extensions/ms-python.python-2024.12.2-linux-x64/out/client/extension.js:2:543067)] {
  errno: -2,
  code: 'ENOENT',
  syscall: 'scandir',
  path: '/home/limstash/AMIC/.pixi/envs'
}
2024-08-13 17:07:27.643 [error] Dir "/home/limstash/AMIC/.pixi/envs" is not watchable (directory does not exist)
2024-08-13 17:07:27.643 [info] Default formatter is set to null for workspace /home/limstash/AMIC
2024-08-13 17:07:27.651 [info] > conda info --json
2024-08-13 17:07:28.104 [info] > pyenv which python
2024-08-13 17:07:28.104 [info] cwd: .
2024-08-13 17:07:28.567 [info] Shell integration status changed, can confirm it's working.
2024-08-13 17:07:28.820 [info] > ~/.conda/envs/AMIC/bin/python -I ~/.vscode-server/extensions/ms-python.python-2024.12.2-linux-x64/python_files/get_output_via_markers.py ~/.vscode-server/extensions/ms-python.python-2024.12.2-linux-x64/python_files/interpreterInfo.py
2024-08-13 17:07:28.882 [info] Python interpreter path: ~/.conda/envs/AMIC/bin/python
2024-08-13 17:07:28.894 [info] > conda info --json
2024-08-13 17:07:28.894 [info] shell: bash
2024-08-13 17:07:30.024 [info] > conda run -n AMIC --no-capture-output python ~/.vscode-server/extensions/ms-python.python-2024.12.2-linux-x64/python_files/get_output_via_markers.py ~/.vscode-server/extensions/ms-python.python-2024.12.2-linux-x64/python_files/printEnvVariables.py
2024-08-13 17:07:30.024 [info] shell: bash
2024-08-13 17:07:30.025 [info] > conda run -n AMIC --no-capture-output python ~/.vscode-server/extensions/ms-python.python-2024.12.2-linux-x64/python_files/get_output_via_markers.py ~/.vscode-server/extensions/ms-python.python-2024.12.2-linux-x64/python_files/printEnvVariables.py
2024-08-13 17:07:30.025 [info] shell: bash
2024-08-13 17:07:30.227 [info] Starting Pylance language server.
2024-08-13 17:07:31.369 [info] > python ~/.vscode-server/extensions/ms-python.python-2024.12.2-linux-x64/python_files/printEnvVariables.py
2024-08-13 17:07:31.369 [info] shell: bash
2024-08-13 17:07:31.437 [info] > python ~/.vscode-server/extensions/ms-python.python-2024.12.2-linux-x64/python_files/printEnvVariables.py
2024-08-13 17:07:31.437 [info] shell: bash
2024-08-13 17:07:31.445 [info] Setting environment variable CONDA_ROOT in collection to /opt/anaconda3 {"applyAtShellIntegration":true,"applyAtProcessCreation":true}
2024-08-13 17:07:31.445 [info] Setting environment variable CONDA_PREFIX in collection to /home/limstash/.conda/envs/AMIC {"applyAtShellIntegration":true,"applyAtProcessCreation":true}
2024-08-13 17:07:31.445 [info] Setting environment variable CONDA_PROMPT_MODIFIER in collection to (AMIC)  {"applyAtShellIntegration":true,"applyAtProcessCreation":true}
2024-08-13 17:07:31.445 [info] Setting environment variable CONDA_SHLVL in collection to 2 {"applyAtShellIntegration":true,"applyAtProcessCreation":true}
2024-08-13 17:07:31.445 [info] Setting environment variable CONDA_DEFAULT_ENV in collection to AMIC {"applyAtShellIntegration":true,"applyAtProcessCreation":true}
2024-08-13 17:07:31.446 [info] Prepending environment variable PATH in collection to /home/limstash/.vscode-server/cli/servers/Stable-eaa41d57266683296de7d118f574d0c2652e1fc4/server/bin/remote-cli:/home/limstash/.conda/envs/AMIC/bin:/opt/anaconda3/condabin:/opt/anaconda3/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/games:/usr/local/games:/snap/bin:/usr/local/cuda-12.2/bin: {"applyAtShellIntegration":true,"applyAtProcessCreation":true}
2024-08-13 17:07:31.446 [info] Setting environment variable CONDA_PREFIX_1 in collection to /opt/anaconda3 {"applyAtShellIntegration":true,"applyAtProcessCreation":true}
2024-08-13 17:07:31.446 [info] Prepending environment variable PS1 in collection with (AMIC)  {"applyAtShellIntegration":true,"applyAtProcessCreation":false}
2024-08-13 17:07:31.447 [info] Send text to terminal: python /home/limstash/.vscode-server/extensions/ms-python.python-2024.12.2-linux-x64/python_files/printEnvVariablesToFile.py /home/limstash/.vscode-server/extensions/ms-python.python-2024.12.2-linux-x64/python_files/deactivate/bash/envVars.txt
2024-08-13 17:07:31.484 [info] Setting environment variable CONDA_ROOT in collection to /opt/anaconda3 {"applyAtShellIntegration":true,"applyAtProcessCreation":true}
2024-08-13 17:07:31.484 [info] Setting environment variable CONDA_PREFIX in collection to /home/limstash/.conda/envs/AMIC {"applyAtShellIntegration":true,"applyAtProcessCreation":true}
2024-08-13 17:07:31.484 [info] Setting environment variable CONDA_PROMPT_MODIFIER in collection to (AMIC)  {"applyAtShellIntegration":true,"applyAtProcessCreation":true}
2024-08-13 17:07:31.484 [info] Setting environment variable CONDA_SHLVL in collection to 2 {"applyAtShellIntegration":true,"applyAtProcessCreation":true}
2024-08-13 17:07:31.484 [info] Setting environment variable CONDA_DEFAULT_ENV in collection to AMIC {"applyAtShellIntegration":true,"applyAtProcessCreation":true}
2024-08-13 17:07:31.484 [info] Prepending environment variable PATH in collection to /home/limstash/.vscode-server/cli/servers/Stable-eaa41d57266683296de7d118f574d0c2652e1fc4/server/bin/remote-cli:/home/limstash/.conda/envs/AMIC/bin:/opt/anaconda3/condabin:/opt/anaconda3/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/games:/usr/local/games:/snap/bin:/usr/local/cuda-12.2/bin: {"applyAtShellIntegration":true,"applyAtProcessCreation":true}
2024-08-13 17:07:31.484 [info] Setting environment variable CONDA_PREFIX_1 in collection to /opt/anaconda3 {"applyAtShellIntegration":true,"applyAtProcessCreation":true}
2024-08-13 17:07:31.484 [info] Prepending environment variable PS1 in collection with (AMIC)  {"applyAtShellIntegration":true,"applyAtProcessCreation":false}

I can also confirm that this is a regression introduced in v2024.0.1...2024.2.0.

@github-actions github-actions bot removed the info-needed Issue requires more information from poster label Aug 13, 2024
@limstash
Copy link
Author

limstash commented Aug 13, 2024 •
edited
Loading

More specifically, it works with Python v2024.1.10511008 (pre-release), while it doesn't work with v2024.1.10521007 (pre-release).

This seems to be related to commit bae7d40.

@karthiknadig karthiknadig mentioned this issue Aug 16, 2024
Closed
@anthonykim1
Copy link

@limstash Hello and thanks again for the feedback here.
I think merging #23942 should help resolve your issue. Will let you know when that happens so you can try it out! Thanks

@github-actions github-actions bot added the info-needed Issue requires more information from poster label Aug 20, 2024
@limstash
Copy link
Author

Hi @anthonykim1, it looks like PR #23942 has been merged.

But in the latest pre-release v2024.13.2024082701, this issue is still not solved.

@github-actions github-actions bot removed the info-needed Issue requires more information from poster label Aug 27, 2024
@anthonykim1
Copy link

anthonykim1 commented Aug 27, 2024 •
edited
Loading

I see @limstash Are you able to repro the same problem if you uninstall Python extension and try out different things in VS Code? For example, try launching different language file in your remote connection and see if that also terminates your extension host.

@github-actions github-actions bot added the info-needed Issue requires more information from poster label Aug 27, 2024
@github-actions GitHub Actions
Copy link

Because we have not heard back with the information we requested, we are closing this issue for now. If you are able to provide the info later on, then we will be happy to re-open this issue to pick up where we left off.

Happy Coding!

@github-actions github-actions bot closed this as not planned Won't fix, can't repro, duplicate, stale Sep 28, 2024
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment
Assignees

@anthonykim1 anthonykim1

Labels
info-needed Issue requires more information from poster triage-needed Needs assignment to the proper sub-team
Projects
None yet
Milestone
No milestone
Development

No branches or pull requests
2 participants
@limstash @anthonykim1