wdio-bidi-log

sriharsha@EPINHYDW017A wdio-bidi-tests % npm run wdio

> wdio
> wdio run ./wdio.conf.js


Execution of 1 workers started at 2023-09-14T09:44:46.788Z

2023-09-14T09:44:46.794Z INFO @wdio/cli:launcher: Run onPrepare hook
2023-09-14T09:44:46.794Z INFO @wdio/utils: Setting up browser driver for: chrome@stable
2023-09-14T09:44:46.795Z INFO @wdio/utils: Setting up browser binaries for: chrome@stable
2023-09-14T09:44:46.823Z INFO webdriver: Using Chromedriver v117.0.5938.62 from cache directory /var/folders/n5/p17czgdn0dv7mw1vvns2pfz00000gn/T
2023-09-14T09:44:46.850Z INFO @wdio/cli:launcher: Run onWorkerStart hook
2023-09-14T09:44:46.851Z INFO @wdio/local-runner: Start worker 0-0 with arg: run,./wdio.conf.js
[0-0] 2023-09-14T09:44:47.195Z INFO @wdio/local-runner: Run worker command: run
[0-0] RUNNING in chrome - file:///test/specs/BrowsingContext.spec.js
[0-0] 2023-09-14T09:44:47.234Z INFO webdriver: Initiate new session using the WebDriver protocol
[0-0] 2023-09-14T09:44:47.263Z INFO webdriver: Using Chromedriver v117.0.5938.62 from cache directory /var/folders/n5/p17czgdn0dv7mw1vvns2pfz00000gn/T
[0-0] 2023-09-14T09:44:48.278Z INFO @wdio/utils: Started Chromedriver v117.0.5938.62 with params --port=64949 --allowed-origins=* --allowed-ips=0.0.0.0 in 1044ms on port 64949
[0-0] 2023-09-14T09:44:48.298Z INFO webdriver: [POST] http://0.0.0.0:64949/session
[0-0] 2023-09-14T09:44:48.298Z INFO webdriver: DATA {
[0-0]   capabilities: {
[0-0]     alwaysMatch: {
[0-0]       browserName: 'chrome',
[0-0]       webSocketUrl: true,
[0-0]       'goog:chromeOptions': [Object]
[0-0]     },
[0-0]     firstMatch: [ {} ]
[0-0]   },
[0-0]   desiredCapabilities: {
[0-0]     browserName: 'chrome',
[0-0]     webSocketUrl: true,
[0-0]     'goog:chromeOptions': {
[0-0]       binary: '/Applications/Google Chrome.app/Contents/MacOS/Google Chrome',
[0-0]       excludeSwitches: [Array]
[0-0]     }
[0-0]   }
[0-0] }
[0-0] 2023-09-14T09:44:48.951Z INFO webdriver: Register BiDi handler for session with id 27804a1b5f0244f9683d280202097a5d
[0-0] 2023-09-14T09:44:48.951Z INFO webdriver: Connect to webSocketUrl ws://0.0.0.0:64949/session/27804a1b5f0244f9683d280202097a5d
[0-0] 2023-09-14T09:44:48.956Z INFO webdriver: Connected session to Bidi protocol
[0-0] 2023-09-14T09:44:48.960Z INFO webdriver: BIDI COMMAND browsingContextGetTree({})
[0-0] 2023-09-14T09:44:48.968Z INFO webdriver: BIDI RESULT {"id":1,"result":{"contexts":[{"children":[],"context":"1EA943D754D1902F5EE97F8E93339BF8","parent":null,"url":"about:blank"}]},"type":"success"}
[0-0] 2023-09-14T09:44:48.968Z INFO webdriver: BIDI COMMAND browsingContextNavigate({"context":"1EA943D754D1902F5EE97F8E93339BF8","url":"https://www.google.co.in/"})
[0-0] 2023-09-14T09:44:49.457Z INFO webdriver: BIDI RESULT {"id":2,"result":{"navigation":"4295B6C9423F62DE34A1EF9AD0D8040B","url":"https://www.google.co.in/"},"type":"success"}
[0-0] 2023-09-14T09:44:49.458Z INFO webdriver: COMMAND getWindowHandle()
[0-0] 2023-09-14T09:44:49.458Z INFO webdriver: [GET] http://0.0.0.0:64949/session/27804a1b5f0244f9683d280202097a5d/window
[0-0] 2023-09-14T09:44:49.472Z INFO webdriver: RESULT 1EA943D754D1902F5EE97F8E93339BF8
[0-0] 2023-09-14T09:44:49.472Z INFO webdriver: BIDI COMMAND browsingContextNavigate({"url":"https://www.selenium.dev/selenium/web/bidi/logEntryAdded.html","context":"1EA943D754D1902F5EE97F8E93339BF8"})
[0-0] 2023-09-14T09:44:49.621Z INFO webdriver: BIDI RESULT {"id":3,"result":{"navigation":"6DCB295596B572388AFFABA2296FEBD1","url":"https://www.selenium.dev/selenium/web/bidi/logEntryAdded.html"},"type":"success"}
[0-0] 2023-09-14T09:44:49.621Z INFO webdriver: BIDI COMMAND sessionStatus({})
[0-0] received {"id":4,"result":{"message":"already connected","ready":false},"type":"success"}
[0-0] 2023-09-14T09:44:49.627Z INFO webdriver: BIDI RESULT {"id":4,"result":{"message":"already connected","ready":false},"type":"success"}
[0-0] { message: 'already connected', ready: false }
[0-0] 2023-09-14T09:44:49.628Z INFO webdriver: BIDI COMMAND sessionEnd({})
[0-0] received {"error":"unknown command","id":5,"message":"Unknown command 'session.end'.","type":"error"}
[0-0] 2023-09-14T09:44:49.630Z INFO webdriver: BIDI RESULT {"error":"unknown command","id":5,"message":"Unknown command 'session.end'.","type":"error"}
[0-0] Error in "Browsing context text.should have navigation id"
Error: unknown command
    at WebSocket.emit (node:events:526:35)
    at WebSocket.emit (node:domain:489:12)
    at Receiver.receiverOnMessage (/Users/sriharsha/Desktop/wdio-bidi-tests/node_modules/ws/lib/websocket.js:1184:20)
    at Receiver.emit (node:events:514:28)
    at Receiver.emit (node:domain:489:12)
    at Receiver.dataMessage (/Users/sriharsha/Desktop/wdio-bidi-tests/node_modules/ws/lib/receiver.js:541:14)
    at /Users/sriharsha/Desktop/wdio-bidi-tests/node_modules/ws/lib/receiver.js:492:23
    at /Users/sriharsha/Desktop/wdio-bidi-tests/node_modules/ws/lib/permessage-deflate.js:309:9
    at /Users/sriharsha/Desktop/wdio-bidi-tests/node_modules/ws/lib/permessage-deflate.js:392:7
    at afterWrite (node:internal/streams/writable:500:5)
    at onwrite (node:internal/streams/writable:480:7)
    at Zlib.cb (node:internal/streams/transform:190:7)
    at Zlib.processCallback (node:zlib:613:8)
[0-0] 2023-09-14T09:44:49.631Z INFO webdriver: COMMAND deleteSession()
[0-0] 2023-09-14T09:44:49.631Z INFO webdriver: [DELETE] http://0.0.0.0:64949/session/27804a1b5f0244f9683d280202097a5d
[0-0] 2023-09-14T09:44:49.688Z INFO webdriver: RESULT null
[0-0] 2023-09-14T09:44:49.689Z INFO webdriver: Kill /var/folders/n5/p17czgdn0dv7mw1vvns2pfz00000gn/T/chromedriver/mac_arm-117.0.5938.62/chromedriver-mac-arm64/chromedriver driver process with command line: --port=64949 --allowed-origins=* --allowed-ips=0.0.0.0
[0-0] FAILED in chrome - file:///test/specs/BrowsingContext.spec.js
2023-09-14T09:44:49.797Z INFO @wdio/cli:launcher: Run onWorkerEnd hook
2023-09-14T09:44:49.797Z INFO @wdio/cli:launcher: Run onComplete hook

 "spec" Reporter:
------------------------------------------------------------------
[chrome 117.0.5938.62 mac os x #0-0] Running: chrome (v117.0.5938.62) on mac os x
[chrome 117.0.5938.62 mac os x #0-0] Session ID: 27804a1b5f0244f9683d280202097a5d
[chrome 117.0.5938.62 mac os x #0-0]
[chrome 117.0.5938.62 mac os x #0-0] » /test/specs/BrowsingContext.spec.js
[chrome 117.0.5938.62 mac os x #0-0] Browsing context text
[chrome 117.0.5938.62 mac os x #0-0]    ✖ should have navigation id
[chrome 117.0.5938.62 mac os x #0-0]
[chrome 117.0.5938.62 mac os x #0-0] 1 failing (732ms)
[chrome 117.0.5938.62 mac os x #0-0]
[chrome 117.0.5938.62 mac os x #0-0] 1) Browsing context text should have navigation id
[chrome 117.0.5938.62 mac os x #0-0] unknown command
[chrome 117.0.5938.62 mac os x #0-0] Error: unknown command
[chrome 117.0.5938.62 mac os x #0-0]     at WebSocket.emit (node:events:526:35)
[chrome 117.0.5938.62 mac os x #0-0]     at WebSocket.emit (node:domain:489:12)
[chrome 117.0.5938.62 mac os x #0-0]     at Receiver.receiverOnMessage (/Users/sriharsha/Desktop/wdio-bidi-tests/node_modules/ws/lib/websocket.js:1184:20)
[chrome 117.0.5938.62 mac os x #0-0]     at Receiver.emit (node:events:514:28)
[chrome 117.0.5938.62 mac os x #0-0]     at Receiver.emit (node:domain:489:12)
[chrome 117.0.5938.62 mac os x #0-0]     at Receiver.dataMessage (/Users/sriharsha/Desktop/wdio-bidi-tests/node_modules/ws/lib/receiver.js:541:14)
[chrome 117.0.5938.62 mac os x #0-0]     at /Users/sriharsha/Desktop/wdio-bidi-tests/node_modules/ws/lib/receiver.js:492:23
[chrome 117.0.5938.62 mac os x #0-0]     at /Users/sriharsha/Desktop/wdio-bidi-tests/node_modules/ws/lib/permessage-deflate.js:309:9
[chrome 117.0.5938.62 mac os x #0-0]     at /Users/sriharsha/Desktop/wdio-bidi-tests/node_modules/ws/lib/permessage-deflate.js:392:7
[chrome 117.0.5938.62 mac os x #0-0]     at afterWrite (node:internal/streams/writable:500:5)
[chrome 117.0.5938.62 mac os x #0-0]     at onwrite (node:internal/streams/writable:480:7)
[chrome 117.0.5938.62 mac os x #0-0]     at Zlib.cb (node:internal/streams/transform:190:7)
[chrome 117.0.5938.62 mac os x #0-0]     at Zlib.processCallback (node:zlib:613:8)


Spec Files:      0 passed, 1 failed, 1 total (100% completed) in 00:00:03 

2023-09-14T09:44:49.799Z INFO @wdio/local-runner: Shutting down spawned worker
2023-09-14T09:44:50.050Z INFO @wdio/local-runner: Waiting for 0 to shut down gracefully
2023-09-14T09:44:50.052Z INFO @wdio/local-runner: shutting down