logging to determine CI error

Author: eleanorjboyd

src/features/envManagers.ts

@@ -329,6 +329,13 @@ export class PythonEnvironmentManagers implements EnvironmentManagers {
                     },
                 ]);
             }
+            traceVerbose(
+                `[setEnvironment] scope=${scope instanceof Uri ? scope.fsPath : scope}, ` +
+                    `env=${environment?.envId?.id ?? 'undefined'}, manager=${manager.id}, ` +
+                    `project=${project?.uri?.toString() ?? 'none'}, ` +
+                    `packageManager=${this.getPackageManager(environment)?.id ?? 'UNDEFINED'}, ` +
+                    `settingsPersisted=${!!(project && this.getPackageManager(environment))}`,
+            );
         }
 
         const key = project ? project.uri.toString() : 'global';
@@ -505,6 +512,10 @@ export class PythonEnvironmentManagers implements EnvironmentManagers {
     async getEnvironment(scope: GetEnvironmentScope): Promise<PythonEnvironment | undefined> {
         const manager = this.getEnvironmentManager(scope);
         if (!manager) {
+            traceVerbose(
+                `[getEnvironment] No manager found for scope=${scope instanceof Uri ? scope.fsPath : scope}, ` +
+                    `settingsManagerId=${getDefaultEnvManagerSetting(this.pm, scope instanceof Uri ? scope : undefined)}`,
+            );
             return undefined;
         }
 

src/managers/builtin/sysPythonManager.ts

@@ -166,13 +166,20 @@ export class SysPythonManager implements EnvironmentManager {
             const pw = this.api.getPythonProject(scope);
             if (!pw) {
                 this.log.warn(
-                    `Unable to set environment for ${scope.fsPath}: Not a python project, folder or PEP723 script.`,
-                    this.api.getPythonProjects().map((p) => p.uri.fsPath),
+                    `[SYS_SET] Unable to set environment for ${scope.fsPath}: Not a python project. ` +
+                        `Known projects: [${this.api
+                            .getPythonProjects()
+                            .map((p) => p.uri.fsPath)
+                            .join(', ')}]`,
                 );
                 return;
             }
 
             const normalizedPwPath = normalizePath(pw.uri.fsPath);
+            this.log.info(
+                `[SYS_SET] scope=${scope.fsPath}, project=${pw.uri.fsPath}, ` +
+                    `normalizedKey=${normalizedPwPath}, env=${environment?.envId?.id ?? 'undefined'}`,
+            );
             if (environment) {
                 this.fsPathToEnv.set(normalizedPwPath, environment);
             } else {
@@ -297,16 +304,28 @@ export class SysPythonManager implements EnvironmentManager {
     }
 
     private fromEnvMap(uri: Uri): PythonEnvironment | undefined {
+        const normalizedUri = normalizePath(uri.fsPath);
         // Find environment directly using the URI mapping
-        const env = this.fsPathToEnv.get(normalizePath(uri.fsPath));
+        const env = this.fsPathToEnv.get(normalizedUri);
         if (env) {
             return env;
         }
 
         // Find environment using the Python project for the Uri
         const project = this.api.getPythonProject(uri);
-        if (project) {
-            return this.fsPathToEnv.get(normalizePath(project.uri.fsPath));
+        const projectKey = project ? normalizePath(project.uri.fsPath) : undefined;
+        const projectEnv = projectKey ? this.fsPathToEnv.get(projectKey) : undefined;
+
+        this.log.info(
+            `[SYS_GET] uri=${uri.fsPath}, normalizedKey=${normalizedUri}, ` +
+                `project=${project?.uri?.fsPath ?? 'none'}, projectKey=${projectKey ?? 'none'}, ` +
+                `mapKeys=[${Array.from(this.fsPathToEnv.keys()).join(', ')}], ` +
+                `directHit=${!!env}, projectHit=${!!projectEnv}, ` +
+                `fallbackToGlobal=${!projectEnv}, globalEnv=${this.globalEnv?.envId?.id ?? 'none'}`,
+        );
+
+        if (projectEnv) {
+            return projectEnv;
         }
 
         return this.globalEnv;

src/test/integration/pythonProjects.integration.test.ts

@@ -185,6 +185,7 @@ suite('Integration: Python Projects', function () {
         // Track what getEnvironment returns during polling for diagnostics
         let pollCount = 0;
         let lastRetrievedId: string | undefined;
+        let lastRetrievedManagerId: string | undefined;
 
         // Wait for the environment to be retrievable with the correct ID
         // This handles async persistence across platforms
@@ -194,16 +195,18 @@ suite('Integration: Python Projects', function () {
                 const retrieved = await api.getEnvironment(project.uri);
                 pollCount++;
                 const retrievedId = retrieved?.envId?.id;
+                lastRetrievedManagerId = retrieved?.envId?.managerId;
                 if (retrievedId !== lastRetrievedId) {
                     console.log(
-                        `[TEST DEBUG] Poll #${pollCount}: getEnvironment returned envId=${retrievedId ?? 'undefined'}`,
+                        `[TEST DEBUG] Poll #${pollCount}: getEnvironment returned envId=${retrievedId ?? 'undefined'}, managerId=${lastRetrievedManagerId ?? 'undefined'}`,
                     );
                     lastRetrievedId = retrievedId;
                 }
                 return retrieved !== undefined && retrieved.envId.id === env.envId.id;
             },
             15_000,
-            `Environment was not set correctly. Expected envId: ${env.envId.id}, last retrieved: ${lastRetrievedId}`,
+            () =>
+                `Environment was not set correctly. Expected envId: ${env.envId.id} (manager: ${env.envId.managerId}), last retrieved: ${lastRetrievedId ?? 'undefined'} (manager: ${lastRetrievedManagerId ?? 'undefined'}) after ${pollCount} polls`,
         );
 
         // Final verification
@@ -285,13 +288,16 @@ suite('Integration: Python Projects', function () {
 
         // Wait for it to be set
         // Use 15s timeout - CI runners can be slow with settings persistence
+        let clearTestLastId: string | undefined;
         await waitForCondition(
             async () => {
                 const retrieved = await api.getEnvironment(project.uri);
+                clearTestLastId = retrieved?.envId?.id;
                 return retrieved !== undefined && retrieved.envId.id === env.envId.id;
             },
             15_000,
-            'Environment was not set before clearing',
+            () =>
+                `Environment was not set before clearing. Expected: ${env.envId.id} (manager: ${env.envId.managerId}), got: ${clearTestLastId ?? 'undefined'}`,
         );
 
         // Verify it was set
@@ -344,13 +350,18 @@ suite('Integration: Python Projects', function () {
 
         // Wait for it to be set
         // Use 15s timeout - CI runners can be slow with settings persistence
+        let fileTestLastId: string | undefined;
+        let fileTestLastManagerId: string | undefined;
         await waitForCondition(
             async () => {
                 const retrieved = await api.getEnvironment(project.uri);
+                fileTestLastId = retrieved?.envId?.id;
+                fileTestLastManagerId = retrieved?.envId?.managerId;
                 return retrieved !== undefined && retrieved.envId.id === env.envId.id;
             },
             15_000,
-            'Environment was not set for project',
+            () =>
+                `Environment was not set for project. Expected: ${env.envId.id} (manager: ${env.envId.managerId}), got: ${fileTestLastId ?? 'undefined'} (manager: ${fileTestLastManagerId ?? 'undefined'})`,
         );
 
         // Create a hypothetical file path inside the project

src/test/testUtils.ts

@@ -48,7 +48,7 @@ export function sleep(ms: number): Promise<void> {
 export async function waitForCondition(
     condition: () => boolean | Promise<boolean>,
     timeoutMs: number = 10_000,
-    errorMessage: string = 'Condition not met within timeout',
+    errorMessage: string | (() => string) = 'Condition not met within timeout',
     pollIntervalMs: number = 100,
 ): Promise<void> {
     return new Promise<void>((resolve, reject) => {
@@ -66,7 +66,8 @@ export async function waitForCondition(
             }
 
             if (Date.now() - startTime >= timeoutMs) {
-                reject(new Error(`${errorMessage} (waited ${timeoutMs}ms)`));
+                const msg = typeof errorMessage === 'function' ? errorMessage() : errorMessage;
+                reject(new Error(`${msg} (waited ${timeoutMs}ms)`));
                 return;
             }