Skip to content

Instantly share code, notes, and snippets.

@kajmagnus

kajmagnus/Bug report: getWindowHandles() wdio log

Last active April 9, 2020 18:26
Show Gist options
  • Save kajmagnus/2b7f4e03f4adb06678d369ef5e97252b to your computer and use it in GitHub Desktop.
Save kajmagnus/2b7f4e03f4adb06678d369ef5e97252b to your computer and use it in GitHub Desktop.
Download ZIP
Raw
Bug report: getWindowHandles() wdio log
Hi WebdriverIO people, here's the wdio log, 'trace' log level. Plus a few Bash commands. /Magnus
---------------------
20:06:27 44 ~/dev/test/bugrepros/wdio-win-handles$ ./node_modules/.bin/wdio --version
6.0.14
20:06:33 45 ~/dev/test/bugrepros/wdio-win-handles$ nodejs --version
v12.16.2
20:06:36 46 ~/dev/test/bugrepros/wdio-win-handles$ npm --version
6.13.4
20:06:38 47 ~/dev/test/bugrepros/wdio-win-handles$ cat /etc/issue
Ubuntu 16.04.6 LTS \n \l
20:06:42 48 ~/dev/test/bugrepros/wdio-win-handles$ uname -a
Linux laptop-hostname 4.4.0-177-generic #207-Ubuntu SMP Mon Mar 16 01:16:10 UTC 2020 x86_64 x86_64 x86_64 GNU/Linux
20:06:46 49 ~/dev/test/bugrepros/wdio-win-handles$
20:07:00 49 ~/dev/test/bugrepros/wdio-win-handles$ google-chrome --version
Google Chrome 81.0.4044.92
20:07:07 50 ~/dev/test/bugrepros/wdio-win-handles$
20:07:19 50 ~/dev/test/bugrepros/wdio-win-handles$ ls -al
total 288
drwxrwxr-x 3 kajmagnus kajmagnus 4096 apr 9 19:42 .
drwxrwxr-x 3 kajmagnus kajmagnus 4096 apr 9 19:24 ..
drwxrwxr-x 483 kajmagnus kajmagnus 20480 apr 9 19:28 node_modules
-rw-rw-r-- 1 kajmagnus kajmagnus 543 apr 9 19:28 package.json
-rw-rw-r-- 1 kajmagnus kajmagnus 226714 apr 9 13:08 package-lock.json
-rw-rw-r-- 1 kajmagnus kajmagnus 565 apr 9 19:42 wdio.conf.js
-rw-rw-r-- 1 kajmagnus kajmagnus 233 apr 9 13:08 wdio-get-win-handles-main.html
-rw-rw-r-- 1 kajmagnus kajmagnus 277 apr 9 13:08 wdio-get-win-handles-popup.html
-rw-rw-r-- 1 kajmagnus kajmagnus 1474 apr 9 19:42 wdio-get-win-handles-self-closing-window.test.js
20:07:42 52 ~/dev/test/bugrepros/wdio-win-handles$
20:07:46 52 ~/dev/test/bugrepros/wdio-win-handles$ grep 'services:' wdio.conf.js
services: ['devtools'], // 'chromedriver' works though
20:08:12 53 ~/dev/test/bugrepros/wdio-win-handles$
20:08:16 53 ~/dev/test/bugrepros/wdio-win-handles$ ./node_modules/.bin/wdio wdio.conf.js
Execution of 1 spec files started at 2020-04-09T18:08:27.695Z
2020-04-09T18:08:27.697Z DEBUG @wdio/utils:initialiseServices: initialise service "devtools" as NPM package
2020-04-09T18:08:27.893Z INFO @wdio/cli:launcher: Run onPrepare hook
2020-04-09T18:08:27.894Z INFO @wdio/cli:launcher: Run onWorkerStart hook
2020-04-09T18:08:27.895Z INFO @wdio/local-runner: Start worker 0-0 with arg: wdio.conf.js
[0-0] 2020-04-09T18:08:28.157Z INFO @wdio/local-runner: Run worker command: run
[0-0] 2020-04-09T18:08:28.160Z DEBUG @wdio/local-runner:utils: init remote session
[0-0] 2020-04-09T18:08:28.164Z INFO webdriverio: Initiate new session using the ./protocol-stub protocol
[0-0] RUNNING in chrome - /wdio-get-win-handles-self-closing-window.test.js
[0-0] 2020-04-09T18:08:28.214Z DEBUG @wdio/utils:initialiseServices: initialise service "devtools" as NPM package
[0-0] 2020-04-09T18:08:28.447Z DEBUG @wdio/local-runner:utils: init remote session
[0-0] 2020-04-09T18:08:28.452Z INFO webdriverio: Initiate new session using the devtools protocol
[0-0] 2020-04-09T18:08:28.453Z INFO devtools: Launch Google Chrome with flags: --disable-extensions --disable-background-networking --disable-background-timer-throttling --disable-backgrounding-occluded-windows --disable-sync --metrics-recording-only --disable-default-apps --mute-audio --no-first-run --disable-hang-monitor --disable-prompt-on-repost --disable-client-side-phishing-detection --password-store=basic --use-mock-keychain --disable-component-extensions-with-background-pages --disable-breakpad --disable-dev-shm-usage --disable-ipc-flooding-protection --disable-renderer-backgrounding --enable-features=NetworkService,NetworkServiceInProcess --disable-features=site-per-process,TranslateUI,BlinkGenPropertyTrees --window-position=0,0 --window-size=1200,900
[0-0] 2020-04-09T18:08:29.120Z INFO devtools: Connect Puppeteer with browser on port 33824
[0-0] 2020-04-09T18:08:29.178Z INFO devtools: COMMAND navigateTo("chrome://version")
[0-0] 2020-04-09T18:08:29.249Z INFO devtools: RESULT null
[0-0] 2020-04-09T18:08:29.254Z INFO devtools: COMMAND findElement("css selector", "#command_line")
[0-0] 2020-04-09T18:08:29.257Z INFO devtools: RESULT { 'element-6066-11e4-a52e-4f735466cecf': 'ELEMENT-1' }
[0-0] 2020-04-09T18:08:29.272Z INFO devtools: COMMAND getElementText("ELEMENT-1")
[0-0] 2020-04-09T18:08:29.282Z INFO devtools: RESULT /usr/bin/google-chrome-stable --disable-features=TranslateUI --disable-extensions --disable-component-extensions-with-background-pages --disable-background-networking --disable-sync --metrics-recording-only --disable-default-apps --mute-audio --no-default-browser-check --no-first-run --disable-backgrounding-occluded-windows --disable-renderer-backgrounding --disable-background-timer-throttling --remote-debugging-port=33824 --disable-setuid-sandbox --user-data-dir=/tmp/lighthouse.FpHl8da --disable-extensions --disable-background-networking --disable-background-timer-throttling --disable-backgrounding-occluded-windows --disable-sync --metrics-recording-only --disable-default-apps --mute-audio --no-first-run --disable-hang-monitor --disable-prompt-on-repost --disable-client-side-phishing-detection --password-store=basic --use-mock-keychain --disable-component-extensions-with-background-pages --disable-breakpad --disable-dev-shm-usage --disable-ipc-flooding-protection --disable-renderer-backgrounding --enable-features=NetworkService,NetworkServiceInProcess --disable-features=site-per-process,TranslateUI,BlinkGenPropertyTrees --window-position=0,0 --window-size=1200,900 --flag-switches-begin --flag-switches-end --disable-webrtc-apm-in-audio-service about:blank
[0-0] 2020-04-09T18:08:29.308Z INFO @wdio/devtools-service:DevToolsDriver: Connect to http://localhost:33824
[0-0] 2020-04-09T18:08:29.321Z INFO @wdio/devtools-service: Connected to Chrome on localhost:33824
[0-0] 2020-04-09T18:08:29.328Z INFO devtools: COMMAND navigateTo("http://localhost:8080/wdio-get-win-handles-main.html")
[0-0] 2020-04-09T18:08:29.333Z DEBUG @wdio/devtools-service:CommandHandler: cdp event: Network.requestWillBeSent with params {"requestId":"0E6A08AF5DAE16A6EDD284263AF7BC47","loaderId":"0E6A08AF5DAE16A6EDD284263AF7BC47","documentURL":"http://localhost:8080/wdio-get-win-handles-main.html","request":{"url":"http://localhost:8080/wdio-get-win-handles-main.html","method":"GET","headers":{"Upgrade-Insecure-Requests":"1","User-Agent":"Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/81.0.4044.92 Safari/537.36"},"mixedContentType":"none","initialPriority":"VeryHigh","referrerPolicy":"no-referrer-when-downgrade"},"timestamp":5927.7276,"wallTime":1586455709.33235,"initiator":{"type":"other"},"type":"Document","frameId":"20CFD545455BD028DAE94C9585811411","hasUserGesture":false}
[0-0] 2020-04-09T18:08:29.336Z DEBUG @wdio/devtools-service:CommandHandler: cdp event: Network.requestWillBeSentExtraInfo with params {"requestId":"0E6A08AF5DAE16A6EDD284263AF7BC47","blockedCookies":[],"headers":{"Host":"localhost:8080","Connection":"keep-alive","Upgrade-Insecure-Requests":"1","User-Agent":"Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/81.0.4044.92 Safari/537.36","Accept":"text/html,application/xhtml+xml,application/xml;q=0.9,image/webp,image/apng,*/*;q=0.8,application/signed-exchange;v=b3;q=0.9","Sec-Fetch-Site":"none","Sec-Fetch-Mode":"navigate","Sec-Fetch-User":"?1","Sec-Fetch-Dest":"document","Accept-Encoding":"gzip, deflate, br","Accept-Language":"en-US,en;q=0.9"}}
[0-0] 2020-04-09T18:08:29.336Z DEBUG @wdio/devtools-service:CommandHandler: cdp event: Network.responseReceivedExtraInfo with params {"requestId":"0E6A08AF5DAE16A6EDD284263AF7BC47","blockedCookies":[],"headers":{"server":"ecstatic-3.3.2","cache-control":"max-age=3600","last-modified":"Thu, 09 Apr 2020 11:08:39 GMT","etag":"W/\"11534888-233-2020-04-09T11:08:39.792Z\"","content-length":"233","content-type":"text/html; charset=UTF-8","Date":"Thu, 09 Apr 2020 18:08:29 GMT","Connection":"keep-alive"},"headersText":"HTTP/1.1 200 OK\r\nserver: ecstatic-3.3.2\r\ncache-control: max-age=3600\r\nlast-modified: Thu, 09 Apr 2020 11:08:39 GMT\r\netag: W/\"11534888-233-2020-04-09T11:08:39.792Z\"\r\ncontent-length: 233\r\ncontent-type: text/html; charset=UTF-8\r\nDate: Thu, 09 Apr 2020 18:08:29 GMT\r\nConnection: keep-alive\r\n\r\n"}
[0-0] 2020-04-09T18:08:29.337Z DEBUG @wdio/devtools-service:CommandHandler: cdp event: Network.responseReceived with params {"requestId":"0E6A08AF5DAE16A6EDD284263AF7BC47","loaderId":"0E6A08AF5DAE16A6EDD284263AF7BC47","timestamp":5927.730849,"type":"Document","response":{"url":"http://localhost:8080/wdio-get-win-handles-main.html","status":200,"statusText":"OK","headers":{"server":"ecstatic-3.3.2","cache-control":"max-age=3600","last-modified":"Thu, 09 Apr 2020 11:08:39 GMT","etag":"W/\"11534888-233-2020-04-09T11:08:39.792Z\"","content-length":"233","content-type":"text/html; charset=UTF-8","Date":"Thu, 09 Apr 2020 18:08:29 GMT","Connection":"keep-alive"},"headersText":"HTTP/1.1 200 OK\r\nserver: ecstatic-3.3.2\r\ncache-control: max-age=3600\r\nlast-modified: Thu, 09 Apr 2020 11:08:39 GMT\r\netag: W/\"11534888-233-2020-04-09T11:08:39.792Z\"\r\ncontent-length: 233\r\ncontent-type: text/html; charset=UTF-8\r\nDate: Thu, 09 Apr 2020 18:08:29 GMT\r\nConnection: keep-alive\r\n\r\n","mimeType":"text/html","requestHeaders":{"Host":"localhost:8080","Connection":"keep-alive","Upgrade-Insecure-Requests":"1","User-Agent":"Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/81.0.4044.92 Safari/537.36","Accept":"text/html,application/xhtml+xml,application/xml;q=0.9,image/webp,image/apng,*/*;q=0.8,application/signed-exchange;v=b3;q=0.9","Sec-Fetch-Site":"none","Sec-Fetch-Mode":"navigate","Sec-Fetch-User":"?1","Sec-Fetch-Dest":"document","Accept-Encoding":"gzip, deflate, br","Accept-Language":"en-US,en;q=0.9"},"requestHeadersText":"GET /wdio-get-win-handles-main.html HTTP/1.1\r\nHost: localhost:8080\r\nConnection: keep-alive\r\nUpgrade-Insecure-Requests: 1\r\nUser-Agent: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/81.0.4044.92 Safari/537.36\r\nAccept: text/html,application/xhtml+xml,application/xml;q=0.9,image/webp,image/apng,*/*;q=0.8,application/signed-exchange;v=b3;q=0.9\r\nSec-Fetch-Site: none\r\nSec-Fetch-Mode: navigate\r\nSec-Fetch-User: ?1\r\nSec-Fetch-Dest: document\r\nAccept-Encoding: gzip, deflate, br\r\nAccept-Language: en-US,en;q=0.9\r\n","connectionReused":false,"connectionId":22,"remoteIPAddress":"127.0.0.1","remotePort":8080,"fromDiskCache":false,"fromServiceWorker":false,"fromPrefetchCache":false,"encodedDataLength":289,"timing":{"requestTime":5927.728139,"proxyStart":-1,"proxyEnd":-1,"dnsStart":0.251,"dnsEnd":0.262,"connectStart":0.262,"connectEnd":0.431,"sslStart":-1,"sslEnd":-1,"workerStart":-1,"workerReady":-1,"sendStart":0.732,"sendEnd":0.789,"pushStart":0,"pushEnd":0,"receiveHeadersEnd":1.804},"protocol":"http/1.1","securityState":"secure"},"frameId":"20CFD545455BD028DAE94C9585811411"}
[0-0] 2020-04-09T18:08:29.362Z DEBUG @wdio/devtools-service:CommandHandler: cdp event: Page.frameStartedLoading with params {"frameId":"20CFD545455BD028DAE94C9585811411"}
[0-0] 2020-04-09T18:08:29.363Z DEBUG @wdio/devtools-service:CommandHandler: cdp event: Page.frameNavigated with params {"frame":{"id":"20CFD545455BD028DAE94C9585811411","loaderId":"0E6A08AF5DAE16A6EDD284263AF7BC47","url":"http://localhost:8080/wdio-get-win-handles-main.html","securityOrigin":"http://localhost:8080","mimeType":"text/html"}}
[0-0] 2020-04-09T18:08:29.369Z DEBUG @wdio/devtools-service:CommandHandler: cdp event: Network.dataReceived with params {"requestId":"0E6A08AF5DAE16A6EDD284263AF7BC47","timestamp":5927.756082,"dataLength":233,"encodedDataLength":0}
[0-0] 2020-04-09T18:08:29.370Z DEBUG @wdio/devtools-service:CommandHandler: cdp event: Network.loadingFinished with params {"requestId":"0E6A08AF5DAE16A6EDD284263AF7BC47","timestamp":5927.730446,"encodedDataLength":522,"shouldReportCorbBlocking":false}
[0-0] 2020-04-09T18:08:29.376Z INFO devtools: RESULT null
[0-0] 2020-04-09T18:08:29.379Z DEBUG @wdio/devtools-service:CommandHandler: cdp event: Page.loadEventFired with params {"timestamp":5927.76073}
[0-0] 2020-04-09T18:08:29.382Z DEBUG @wdio/devtools-service:CommandHandler: cdp event: Page.frameStoppedLoading with params {"frameId":"20CFD545455BD028DAE94C9585811411"}
[0-0] 2020-04-09T18:08:29.384Z INFO devtools: COMMAND getWindowHandle()
[0-0] 2020-04-09T18:08:29.384Z INFO devtools: RESULT 2ea862e5-2dc0-403e-b9fc-6a018ed96953
[0-0] 2020-04-09T18:08:29.386Z DEBUG @wdio/devtools-service:CommandHandler: cdp event: Page.domContentEventFired with params {"timestamp":5927.769803}
[0-0] mainWinHandle: 2ea862e5-2dc0-403e-b9fc-6a018ed96953
[0-0] Opening login popup
[0-0] 2020-04-09T18:08:29.387Z DEBUG @wdio/devtools-service:CommandHandler: cdp event: Network.requestWillBeSent with params {"requestId":"16195.2","loaderId":"0E6A08AF5DAE16A6EDD284263AF7BC47","documentURL":"http://localhost:8080/wdio-get-win-handles-main.html","request":{"url":"http://localhost:8080/favicon.ico","method":"GET","headers":{"Referer":"http://localhost:8080/wdio-get-win-handles-main.html","User-Agent":"Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/81.0.4044.92 Safari/537.36"},"mixedContentType":"none","initialPriority":"High","referrerPolicy":"no-referrer-when-downgrade"},"timestamp":5927.773282,"wallTime":1586455709.377982,"initiator":{"type":"other"},"type":"Other","frameId":"20CFD545455BD028DAE94C9585811411","hasUserGesture":false}
[0-0] 2020-04-09T18:08:29.387Z DEBUG @wdio/devtools-service:CommandHandler: cdp event: Network.requestWillBeSentExtraInfo with params {"requestId":"16195.2","blockedCookies":[],"headers":{"Host":"localhost:8080","Connection":"keep-alive","User-Agent":"Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/81.0.4044.92 Safari/537.36","Accept":"image/webp,image/apng,image/*,*/*;q=0.8","Sec-Fetch-Site":"same-origin","Sec-Fetch-Mode":"no-cors","Sec-Fetch-Dest":"empty","Referer":"http://localhost:8080/wdio-get-win-handles-main.html","Accept-Encoding":"gzip, deflate, br","Accept-Language":"en-US,en;q=0.9"}}
[0-0] 2020-04-09T18:08:29.388Z DEBUG @wdio/devtools-service:CommandHandler: cdp event: Network.responseReceivedExtraInfo with params {"requestId":"16195.2","blockedCookies":[],"headers":{"server":"ecstatic-3.3.2","Date":"Thu, 09 Apr 2020 18:08:29 GMT","Connection":"keep-alive","Content-Length":"0"},"headersText":"HTTP/1.1 404 Not Found\r\nserver: ecstatic-3.3.2\r\nDate: Thu, 09 Apr 2020 18:08:29 GMT\r\nConnection: keep-alive\r\nContent-Length: 0\r\n\r\n"}
[0-0] 2020-04-09T18:08:29.388Z DEBUG @wdio/devtools-service:CommandHandler: cdp event: Network.responseReceived with params {"requestId":"16195.2","loaderId":"0E6A08AF5DAE16A6EDD284263AF7BC47","timestamp":5927.777596,"type":"Other","response":{"url":"http://localhost:8080/favicon.ico","status":404,"statusText":"Not Found","headers":{"Date":"Thu, 09 Apr 2020 18:08:29 GMT","server":"ecstatic-3.3.2","Connection":"keep-alive","Content-Length":"0"},"mimeType":"text/plain","connectionReused":true,"connectionId":22,"remoteIPAddress":"127.0.0.1","remotePort":8080,"fromDiskCache":false,"fromServiceWorker":false,"fromPrefetchCache":false,"encodedDataLength":130,"timing":{"requestTime":5927.775162,"proxyStart":-1,"proxyEnd":-1,"dnsStart":-1,"dnsEnd":-1,"connectStart":-1,"connectEnd":-1,"sslStart":-1,"sslEnd":-1,"workerStart":-1,"workerReady":-1,"sendStart":0.254,"sendEnd":0.33,"pushStart":0,"pushEnd":0,"receiveHeadersEnd":1.768},"protocol":"http/1.1","securityState":"secure"},"frameId":"20CFD545455BD028DAE94C9585811411"}
[0-0] 2020-04-09T18:08:29.388Z INFO devtools: COMMAND findElement("css selector", "a")
[0-0] 2020-04-09T18:08:29.389Z DEBUG @wdio/devtools-service:CommandHandler: cdp event: Network.loadingFinished with params {"requestId":"16195.2","timestamp":5927.777186,"encodedDataLength":130,"shouldReportCorbBlocking":false}
[0-0] 2020-04-09T18:08:29.392Z INFO devtools: RESULT { 'element-6066-11e4-a52e-4f735466cecf': 'ELEMENT-2' }
[0-0] 2020-04-09T18:08:29.397Z INFO devtools: COMMAND elementClick("ELEMENT-2")
[0-0] 2020-04-09T18:08:29.418Z INFO devtools: RESULT null
[0-0] 2020-04-09T18:08:29.420Z DEBUG @wdio/devtools-service:CommandHandler: cdp event: Page.windowOpen with params {"url":"http://localhost:8080/wdio-get-win-handles-popup.html","windowName":"_blank","windowFeatures":["menubar","toolbar","status","scrollbars","resizable"],"userGesture":true}
[0-0] 2020-04-09T18:08:29.430Z INFO devtools: COMMAND getWindowHandles()
[0-0] 2020-04-09T18:08:29.441Z INFO devtools: RESULT [
'2ea862e5-2dc0-403e-b9fc-6a018ed96953',
'3d0170ca-ea74-43ea-9412-bad0b2cd5700'
]
[0-0] allHandles: ["2ea862e5-2dc0-403e-b9fc-6a018ed96953","3d0170ca-ea74-43ea-9412-bad0b2cd5700"]
browser.switchToWindow('3d0170ca-ea74-43ea-9412-bad0b2cd5700');
[0-0] 2020-04-09T18:08:29.444Z INFO devtools: COMMAND switchToWindow("3d0170ca-ea74-43ea-9412-bad0b2cd5700")
[0-0] 2020-04-09T18:08:29.445Z INFO devtools: RESULT 3d0170ca-ea74-43ea-9412-bad0b2cd5700
[0-0] browser.getWindowHandles(), millis elapsed: 461
[0-0] 2020-04-09T18:08:29.849Z INFO devtools: COMMAND getWindowHandles()
[0-0] 2020-04-09T18:08:29.849Z INFO devtools: RESULT [
'2ea862e5-2dc0-403e-b9fc-6a018ed96953',
'3d0170ca-ea74-43ea-9412-bad0b2cd5700'
]
[0-0] browser.getWindowHandles(), millis elapsed: 864
[0-0] 2020-04-09T18:08:30.255Z INFO devtools: COMMAND getWindowHandles()
[0-0] 2020-04-09T18:08:30.255Z INFO devtools: RESULT [
'2ea862e5-2dc0-403e-b9fc-6a018ed96953',
'3d0170ca-ea74-43ea-9412-bad0b2cd5700'
]
[0-0] browser.getWindowHandles(), millis elapsed: 1270
[0-0] 2020-04-09T18:08:30.661Z INFO devtools: COMMAND getWindowHandles()
[0-0] 2020-04-09T18:08:30.661Z INFO devtools: RESULT [
'2ea862e5-2dc0-403e-b9fc-6a018ed96953',
'3d0170ca-ea74-43ea-9412-bad0b2cd5700'
]
[0-0] browser.getWindowHandles(), millis elapsed: 1677
[0-0] 2020-04-09T18:08:31.067Z INFO devtools: COMMAND getWindowHandles()
[0-0] 2020-04-09T18:08:31.068Z INFO devtools: RESULT [
'2ea862e5-2dc0-403e-b9fc-6a018ed96953',
'3d0170ca-ea74-43ea-9412-bad0b2cd5700'
]
[0-0] browser.getWindowHandles(), millis elapsed: 2084
[0-0] 2020-04-09T18:08:31.474Z INFO devtools: COMMAND getWindowHandles()
[0-0] 2020-04-09T18:08:31.475Z INFO devtools: RESULT [
'2ea862e5-2dc0-403e-b9fc-6a018ed96953',
'3d0170ca-ea74-43ea-9412-bad0b2cd5700'
]
[0-0] browser.getWindowHandles(), millis elapsed: 2490
[0-0] 2020-04-09T18:08:31.881Z INFO devtools: COMMAND getWindowHandles()
[0-0] 2020-04-09T18:08:31.881Z INFO devtools: RESULT [
'2ea862e5-2dc0-403e-b9fc-6a018ed96953',
'3d0170ca-ea74-43ea-9412-bad0b2cd5700'
]
[0-0] browser.getWindowHandles(), millis elapsed: 2897
[0-0] 2020-04-09T18:08:32.288Z INFO devtools: COMMAND getWindowHandles()
[0-0] 2020-04-09T18:08:32.288Z INFO devtools: RESULT [
'2ea862e5-2dc0-403e-b9fc-6a018ed96953',
'3d0170ca-ea74-43ea-9412-bad0b2cd5700'
]
[0-0] browser.getWindowHandles(), millis elapsed: 3303
^C
Ending WebDriver sessions gracefully ...
(press ctrl+c again to hard kill the runner)
2020-04-09T18:08:48.233Z INFO @wdio/local-runner: Shutting down spawned worker
2020-04-09T18:08:48.484Z INFO @wdio/local-runner: Waiting for 1 to shut down gracefully
2020-04-09T18:08:48.735Z INFO @wdio/local-runner: Waiting for 1 to shut down gracefully
2020-04-09T18:08:48.986Z INFO @wdio/local-runner: Waiting for 1 to shut down gracefully
2020-04-09T18:08:49.236Z INFO @wdio/local-runner: Waiting for 1 to shut down gracefully
2020-04-09T18:08:49.487Z INFO @wdio/local-runner: Waiting for 1 to shut down gracefully
2020-04-09T18:08:49.737Z INFO @wdio/local-runner: Waiting for 1 to shut down gracefully
2020-04-09T18:08:49.988Z INFO @wdio/local-runner: Waiting for 1 to shut down gracefully
2020-04-09T18:08:50.239Z INFO @wdio/local-runner: Waiting for 1 to shut down gracefully
2020-04-09T18:08:50.489Z INFO @wdio/local-runner: Waiting for 1 to shut down gracefully
2020-04-09T18:08:50.740Z INFO @wdio/local-runner: Waiting for 1 to shut down gracefully
2020-04-09T18:08:50.990Z INFO @wdio/local-runner: Waiting for 1 to shut down gracefully
2020-04-09T18:08:51.241Z INFO @wdio/local-runner: Waiting for 1 to shut down gracefully
2020-04-09T18:08:51.491Z INFO @wdio/local-runner: Waiting for 1 to shut down gracefully
2020-04-09T18:08:51.742Z INFO @wdio/local-runner: Waiting for 1 to shut down gracefully
2020-04-09T18:08:51.993Z INFO @wdio/local-runner: Waiting for 1 to shut down gracefully
2020-04-09T18:08:52.243Z INFO @wdio/local-runner: Waiting for 1 to shut down gracefully
2020-04-09T18:08:52.494Z INFO @wdio/local-runner: Waiting for 1 to shut down gracefully
2020-04-09T18:08:52.744Z INFO @wdio/local-runner: Waiting for 1 to shut down gracefully
2020-04-09T18:08:52.995Z INFO @wdio/local-runner: Waiting for 1 to shut down gracefully
20:08:53 54 ~/dev/test/bugrepros/wdio-win-handles$
20:08:57 54 ~/dev/test/bugrepros/wdio-win-handles$ top
top - 20:08:59 up 1:39, 6 users, load average: 0,65, 0,22, 0,21
Tasks: 329 total, 2 running, 327 sleeping, 0 stopped, 0 zombie
%Cpu(s): 3,2 us, 1,0 sy, 0,2 ni, 95,4 id, 0,1 wa, 0,0 hi, 0,0 si, 0,0 st
KiB Mem : 32737248 total, 23519096 free, 4722440 used, 4495712 buff/cache
KiB Swap: 33341436 total, 33341436 free, 0 used. 26599608 avail Mem
PID USER PR NI VIRT RES SHR S %CPU %MEM TIME+ COMMAND
16047 kajmagn+ 20 0 1640460 829520 31120 R 106,7 2,5 0:29.85 node
6224 kajmagn+ 20 0 826284 296412 46152 S 6,7 0,9 0:20.96 code
1 root 20 0 185532 6048 3908 S 0,0 0,0 0:01.29 systemd
2 root 20 0 0 0 0 S 0,0 0,0 0:00.00 kthreadd
3 root 20 0 0 0 0 S 0,0 0,0 0:00.02 ksoftirqd/0
5 root 0 -20 0 0 0 S 0,0 0,0 0:00.00 kworker/0:0H
7 root 20 0 0 0 0 S 0,0 0,0 0:02.53 rcu_sched
...
20:09:00 55 ~/dev/test/bugrepros/wdio-win-handles$
20:09:07 55 ~/dev/test/bugrepros/wdio-win-handles$ kill 16047
20:09:15 56 ~/dev/test/bugrepros/wdio-win-handles$
20:09:15 56 ~/dev/test/bugrepros/wdio-win-handles$ top
top - 20:09:29 up 1:39, 6 users, load average: 0,79, 0,30, 0,24
Tasks: 328 total, 2 running, 326 sleeping, 0 stopped, 0 zombie
%Cpu(s): 18,0 us, 1,4 sy, 3,5 ni, 77,1 id, 0,0 wa, 0,0 hi, 0,0 si, 0,0 st
KiB Mem : 32737248 total, 22756040 free, 5485924 used, 4495284 buff/cache
KiB Swap: 33341436 total, 33341436 free, 0 used. 25843636 avail Mem
PID USER PR NI VIRT RES SHR S %CPU %MEM TIME+ COMMAND
16047 kajmagn+ 20 0 2389296 1,519g 31120 R 106,3 4,9 1:02.81 node
5457 kajmagn+ 20 0 18,763g 209160 83348 S 20,6 0,6 2:07.13 chrome
5304 kajmagn+ 20 0 1540168 386384 204992 S 16,9 1,2 5:08.43 chrome
16103 kajmagn+ 20 0 787636 152840 124520 S 4,0 0,5 0:01.25 chrome
...
20:09:30 57 ~/dev/test/bugrepros/wdio-win-handles$
20:09:31 57 ~/dev/test/bugrepros/wdio-win-handles$ kill -9 16047
20:09:38 58 ~/dev/test/bugrepros/wdio-win-handles$
@kajmagnus
Copy link
Author

Here, above:

[0-0] browser.getWindowHandles(),  millis elapsed:  3303
^C

wdio blocks forever — until I CTRL+C stop it. But a node process stays allive at 100% CPU and the browser won't close.

Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment