Testing with extension dependency times out

[vritant24]

I have a web extension where I have a dependency on ms-vscode.vscode-python-web-wasm (repo link).

To run an integration test with this dependency, I am trying to use the --extensionId=ms-vscode.vscode-python-web-wasm@prerelease but it fails to find the extension. I've attached the log below.

It would be great to get assistance on understanding whether this is the incorrect way to use this command and direction to debug. The error seems to be a timeout, but even with a 5 minute timeout this fails. For additional context, there is no issue without the extension dependency.

> vscode-test-web --headless=true --browserType=chromium --extensionDevelopmentPath=. --extensionTestsPath=dist/web/test/suite/index.js --extensionId=ms-vscode.vscode-python-web-wasm@prerelease --coi --verbose --printServerLog

@vscode/test-web: 0.0.34
Serving dev extensions from C:\repos\<extension-path>
Listening on http://localhost:3000
Opening browser on http://localhost:3000...
GET / 200 6.312 ms - 3288
GET /static/build/out/vs/loader.js 200 16.041 ms - 39001
GET /static/build/out/vs/webPackagePaths.js 200 15.296 ms - 1019
GET /static/build/out/vs/code/browser/workbench/workbench.js 200 14.217 ms - 6927
GET /static/build/out/vs/workbench/workbench.web.main.css 200 18.575 ms - 548576
GET /static/build/out/vs/workbench/workbench.web.main.nls.js 200 14.552 ms - 527004
GET /static/build/out/vs/workbench/workbench.web.main.js 200 14.425 ms - 10254445
%c WARN color: #993 Via 'product.json#extensionEnabledApiProposals' extension 'ms-python.python' wants API proposal 'telemetryLogger' but that proposal DOES NOT EXIST. Likely, the proposal has been finalized (check 'vscode.d.ts') or was abandoned.
Via 'product.json#extensionEnabledApiProposals' extension 'ms-python.python' wants API proposal 'telemetryLogger' but that proposal DOES NOT EXIST. Likely, the proposal has been finalized (check 'vscode.d.ts') or was abandoned.
%c WARN color: #993 Via 'product.json#extensionEnabledApiProposals' extension 'ms-vscode.azure-repos' wants API proposal 'telemetryLogger' but that proposal DOES NOT EXIST. Likely, the proposal has been finalized (check 'vscode.d.ts') or was abandoned.
Via 'product.json#extensionEnabledApiProposals' extension 'ms-vscode.azure-repos' wants API proposal 'telemetryLogger' but that proposal DOES NOT EXIST. Likely, the proposal has been finalized (check 'vscode.d.ts') or was abandoned.
%c WARN color: #993 Via 'product.json#extensionEnabledApiProposals' extension 'ms-vscode.remote-repositories' wants API proposal 'telemetryLogger' but that proposal DOES NOT EXIST. Likely, the proposal has been finalized (check 'vscode.d.ts') or was abandoned.
Via 'product.json#extensionEnabledApiProposals' extension 'ms-vscode.remote-repositories' wants API proposal 'telemetryLogger' but that proposal DOES NOT EXIST. Likely, the proposal has been finalized (check 'vscode.d.ts') or was abandoned.
%c WARN color: #993 Via 'product.json#extensionEnabledApiProposals' extension 'github.vscode-pull-request-github' wants API proposal 'commentsResolvedState' but that proposal DOES NOT EXIST. Likely, the proposal has been finalized (check 'vscode.d.ts') or was abandoned.
Via 'product.json#extensionEnabledApiProposals' extension 'github.vscode-pull-request-github' wants API proposal 'commentsResolvedState' but that proposal DOES NOT EXIST. Likely, the proposal has been finalized (check 'vscode.d.ts') or was abandoned.
%c WARN color: #993 Via 'product.json#extensionEnabledApiProposals' extension 'github.remotehub' wants API proposal 'telemetryLogger' but that proposal DOES NOT EXIST. Likely, the proposal has been finalized (check 'vscode.d.ts') or was abandoned.
Via 'product.json#extensionEnabledApiProposals' extension 'github.remotehub' wants API proposal 'telemetryLogger' but that proposal DOES NOT EXIST. Likely, the proposal has been finalized (check 'vscode.d.ts') or was abandoned.
GET /static/build/out/vs/workbench/services/keybinding/browser/keyboardLayouts/layout.contribution.win.js 200 2.821 ms - 75206
GET /static/build/node_modules/tas-client-umd/lib/tas-client-umd.js 200 1.339 ms - 27471
GET /static/devextensions/package.json 200 2.532 ms - 4550
GET /static/build/out/vs/base/browser/ui/codicons/codicon/codicon.ttf?5d4d76ab2ce5108968ad644d591a16a6 200 1.589 ms - 72860
GET /static/devextensions/package.nls.json 200 1.621 ms - 645
GET /static/devextensions/package.nls.json 200 1.601 ms - 645
GET /static/devextensions/dist/web/nls.metadata.json 404 2.785 ms - 9
Failed to load resource: the server responded with a status of 404 (Not Found)
%c INFO color: #33f Request to 'http://localhost:3000/static/devextensions/dist/web/nls.metadata.json' failed with status code 404
Request to 'http://localhost:3000/static/devextensions/dist/web/nls.metadata.json' failed with status code 404
%c INFO color: #33f Found additional builtin gallery extensions in env [Object]
Found additional builtin gallery extensions in env [ { id: 'ms-vscode.vscode-python-web-wasm', preRelease: true } ]
%c INFO color: #33f Updating additional builtin extensions cache
Updating additional builtin extensions cache
An iframe which has both allow-scripts and allow-same-origin for its sandbox attribute can remove its sandboxing.
Mixed Content: The page at 'https://1r977mn8cig5gdpg6ld0fk2vsvigd45qp85vsi5ug9m3s2chitbv.vscode-cdn.net/insider/0a6c277e4faa44a6b6eb82ddca8bfeccf7fecef6/out/vs/workbench/contrib/webview/browser/pre/index.html?id=4283e000-71ff-410c-a0a1-6d0bf85083cf&origin=4283e000-71ff-410c-a0a1-6d0bf85083cf&swVersion=4&extensionId=&platform=browser&vscode-resource-base-authority=vscode-resource.vscode-cdn.net&parentOrigin=http%3A%2F%2Flocalhost%3A3000&vscode-coi=3' was loaded over HTTPS, but requested an insecure element 'http://localhost:3000/static/build/out/vs/workbench/contrib/welcomeGettingStarted/common/media/dark.png'. This request was automatically upgraded to HTTPS, For more information see https://blog.chromium.org/2019/10/no-more-mixed-messages-about-https.html
Mixed Content: The page at 'https://1r977mn8cig5gdpg6ld0fk2vsvigd45qp85vsi5ug9m3s2chitbv.vscode-cdn.net/insider/0a6c277e4faa44a6b6eb82ddca8bfeccf7fecef6/out/vs/workbench/contrib/webview/browser/pre/index.html?id=4283e000-71ff-410c-a0a1-6d0bf85083cf&origin=4283e000-71ff-410c-a0a1-6d0bf85083cf&swVersion=4&extensionId=&platform=browser&vscode-resource-base-authority=vscode-resource.vscode-cdn.net&parentOrigin=http%3A%2F%2Flocalhost%3A3000&vscode-coi=3' was loaded over HTTPS, but requested an insecure element 'http://localhost:3000/static/build/out/vs/workbench/contrib/welcomeGettingStarted/common/media/light.png'. This request was automatically upgraded to HTTPS, For more information see https://blog.chromium.org/2019/10/no-more-mixed-messages-about-https.html
Mixed Content: The page at 'https://1r977mn8cig5gdpg6ld0fk2vsvigd45qp85vsi5ug9m3s2chitbv.vscode-cdn.net/insider/0a6c277e4faa44a6b6eb82ddca8bfeccf7fecef6/out/vs/workbench/contrib/webview/browser/pre/index.html?id=4283e000-71ff-410c-a0a1-6d0bf85083cf&origin=4283e000-71ff-410c-a0a1-6d0bf85083cf&swVersion=4&extensionId=&platform=browser&vscode-resource-base-authority=vscode-resource.vscode-cdn.net&parentOrigin=http%3A%2F%2Flocalhost%3A3000&vscode-coi=3' was loaded over HTTPS, but requested an insecure element 'http://localhost:3000/static/build/out/vs/workbench/contrib/welcomeGettingStarted/common/media/dark-hc.png'. This request was automatically upgraded to HTTPS, For more information see https://blog.chromium.org/2019/10/no-more-mixed-messages-about-https.html
Mixed Content: The page at 'https://1r977mn8cig5gdpg6ld0fk2vsvigd45qp85vsi5ug9m3s2chitbv.vscode-cdn.net/insider/0a6c277e4faa44a6b6eb82ddca8bfeccf7fecef6/out/vs/workbench/contrib/webview/browser/pre/index.html?id=4283e000-71ff-410c-a0a1-6d0bf85083cf&origin=4283e000-71ff-410c-a0a1-6d0bf85083cf&swVersion=4&extensionId=&platform=browser&vscode-resource-base-authority=vscode-resource.vscode-cdn.net&parentOrigin=http%3A%2F%2Flocalhost%3A3000&vscode-coi=3' was loaded over HTTPS, but requested an insecure element 'http://localhost:3000/static/build/out/vs/workbench/contrib/welcomeGettingStarted/common/media/light-hc.png'. This request was automatically upgraded to HTTPS, For more information see https://blog.chromium.org/2019/10/no-more-mixed-messages-about-https.html
GET /static/build/out/vs/workbench/contrib/welcomeGettingStarted/common/media/dark.png 200 3.442 ms - 10988
GET /static/build/out/vs/workbench/contrib/welcomeGettingStarted/common/media/light.png 200 3.062 ms - 10395
GET /static/build/out/vs/workbench/contrib/welcomeGettingStarted/common/media/dark-hc.png 200 2.989 ms - 10615
GET /static/build/out/vs/workbench/contrib/welcomeGettingStarted/common/media/light-hc.png 200 4.909 ms - 10615
%c INFO color: #33f Loading development extension at \static\devextensions
Loading development extension at \static\devextensions
GET /static/build/node_modules/vscode-textmate/release/main.js 200 2.281 ms - 55846
GET /static/build/node_modules/vscode-oniguruma/release/main.js 200 2.021 ms - 11728
GET /static/build/extensions/bat/snippets/batchfile.code-snippets 200 2.625 ms - 191
GET /static/build/node_modules/vscode-oniguruma/release/onig.wasm 200 2.372 ms - 466610
GET /static/build/extensions/coffeescript/snippets/coffeescript.code-snippets 200 1.697 ms - 187
GET /static/build/extensions/cpp/snippets/c.code-snippets 200 1.944 ms - 204
GET /static/build/extensions/cpp/snippets/cpp.code-snippets 200 2.348 ms - 204
GET /static/build/extensions/csharp/snippets/csharp.code-snippets 200 2.017 ms - 190
GET /static/build/extensions/fsharp/snippets/fsharp.code-snippets 200 2.422 ms - 194
GET /static/build/extensions/groovy/snippets/groovy.code-snippets 200 3.535 ms - 3590
GET /static/build/extensions/html/snippets/html.code-snippets 200 3.769 ms - 218
GET /static/build/extensions/java/snippets/java.code-snippets 200 4.238 ms - 191
GET /static/build/extensions/javascript/snippets/javascript.code-snippets 200 5.354 ms - 3231
GET /static/build/extensions/markdown-basics/snippets/markdown.code-snippets 200 6.961 ms - 2441
GET /static/build/extensions/php/snippets/php.code-snippets 200 6.152 ms - 4362
GET /static/build/extensions/swift/snippets/swift.code-snippets 200 7.050 ms - 2165
GET /static/build/extensions/typescript-basics/snippets/typescript.code-snippets 200 6.978 ms - 4894
GET /static/build/extensions/vb/snippets/vb.code-snippets 200 6.817 ms - 1360
GET /static/build/extensions/theme-defaults/themes/light_plus.json 200 1.317 ms - 3644
GET /static/build/extensions/theme-seti/icons/vs-seti-icon-theme.json 200 1.106 ms - 42561
GET /static/devextensions/resources/learning.svg 200 1.401 ms - 785
OPTIONS /static/build/extensions/emmet/dist/browser/emmetBrowserMain.js 204 0.256 ms - -
OPTIONS /static/build/extensions/github-authentication/dist/browser/extension.js 204 0.203 ms - -
OPTIONS /static/build/extensions/git-base/dist/browser/extension.js 204 0.080 ms - -
GET /static/build/extensions/emmet/dist/browser/emmetBrowserMain.js 200 1.366 ms - 260434
GET /static/build/extensions/git-base/dist/browser/extension.js 200 2.864 ms - 7204
GET /static/build/extensions/github-authentication/dist/browser/extension.js 200 2.479 ms - 188153
GET /static/build/extensions/theme-defaults/themes/light_vs.json 200 1.268 ms - 6797
GET /static/build/extensions/log/syntaxes/log.tmLanguage.json 200 1.163 ms - 2975
OPTIONS /static/devextensions/dist/web/test/suite/index.js 204 0.121 ms - -
GET /static/devextensions/dist/web/test/suite/index.js 200 1.578 ms - 814115
OPTIONS /static/build/extensions/merge-conflict/dist/browser/mergeConflictMain.js 204 0.131 ms - -
GET /static/build/extensions/merge-conflict/dist/browser/mergeConflictMain.js 200 1.307 ms - 154277
%c INFO color: #33f %s%s

%c INFO color: #33f %s%s    Web Extension Test Suite
  Web Extension Test Suite
OPTIONS /static/build/extensions/microsoft-authentication/dist/browser/extension.js 204 0.245 ms - -
GET /static/build/extensions/microsoft-authentication/dist/browser/extension.js 200 75.700 ms - 161502
%c INFO color: #33f Migrating global extension storage from github.remotehub to GitHub.remotehub...
Migrating global extension storage from github.remotehub to GitHub.remotehub...
%c INFO color: #33f Migrated global extension storage from github.remotehub to GitHub.remotehub
Migrated global extension storage from github.remotehub to GitHub.remotehub
%c INFO color: #33f Migrating workspace extension storage from github.remotehub to GitHub.remotehub...
Migrating workspace extension storage from github.remotehub to GitHub.remotehub...
%c INFO color: #33f Migrated workspace extension storage from github.remotehub to GitHub.remotehub
Migrated workspace extension storage from github.remotehub to GitHub.remotehub
%c INFO color: #33f     %d) %s 1 Extension Activation Test
    1) Extension Activation Test
%c INFO color: #33f   %d passing (%s) 0 2s
  0 passing (2s)
%c INFO color: #33f   %d failing 1
  1 failing
%c INFO color: #33f   %s) %s:
     %s
%s
 1 Web Extension Test Suite
       Extension Activation Test Error: Timeout of 2000ms exceeded. For async tests and hooks, ensure "done()" is called; if returning a Promise, ensure it resolves.           at createTimeoutError$1 (http://localhost:3000/static/devextensions/dist/web/test/suite/index.js#vscode-extension:12738:17)
        at Runnable$3._timeoutError (http://localhost:3000/static/devextensions/dist/web/test/suite/index.js#vscode-extension:13224:12)
        at eval (http://localhost:3000/static/devextensions/dist/web/test/suite/index.js#vscode-extension:13039:26)
  1) Web Extension Test Suite
       Extension Activation Test:
     Error: Timeout of 2000ms exceeded. For async tests and hooks, ensure "done()" is called; if returning a Promise, ensure it resolves.
        at createTimeoutError$1 (http://localhost:3000/static/devextensions/dist/web/test/suite/index.js#vscode-extension:12738:17)
        at Runnable$3._timeoutError (http://localhost:3000/static/devextensions/dist/web/test/suite/index.js#vscode-extension:13224:12)
        at eval (http://localhost:3000/static/devextensions/dist/web/test/suite/index.js#vscode-extension:13039:26)

%c  ERR color: #f33 Error: 1 tests failed.
        at eval (http://localhost:3000/static/devextensions/dist/web/test/suite/index.js#vscode-extension:25689:23)
        at eval (http://localhost:3000/static/devextensions/dist/web/test/suite/index.js#vscode-extension:20636:9)
        at done (http://localhost:3000/static/devextensions/dist/web/test/suite/index.js#vscode-extension:20135:9)
Error: 1 tests failed.
        at eval (http://localhost:3000/static/devextensions/dist/web/test/suite/index.js#vscode-extension:25689:23)
        at eval (http://localhost:3000/static/devextensions/dist/web/test/suite/index.js#vscode-extension:20636:9)
        at done (http://localhost:3000/static/devextensions/dist/web/test/suite/index.js#vscode-extension:20135:9)
Error: 1 tests failed.
        at eval (http://localhost:3000/static/devextensions/dist/web/test/suite/index.js#vscode-extension:25689:23)
        at eval (http://localhost:3000/static/devextensions/dist/web/test/suite/index.js#vscode-extension:20636:9)
        at done (http://localhost:3000/static/devextensions/dist/web/test/suite/index.js#vscode-extension:20135:9)
Error running tests: Error: Test failed
    at C:\repos\<extension-path>\node_modules\@vscode\test-web\out\index.js:57:23
    at async BindingCall.call (C:\repos\<extension-path>\node_modules\playwright-core\lib\client\page.js:642:130)
    at async BrowserContext._onBinding (C:\repos\<extension-path>\node_modules\playwright-core\lib\client\browserContext.js:174:5)