could not be scrolled into view","stacktrace":"WebDriverError@chrome://marionette/content/error.js:226:5\nElementNotInteractableError@chrome://marionette/content/error.js:315:5\nwebdriverClickElement@chrome://marionette/content/interaction.js:183:11\nTaskImpl_run@resource://gre/modules/Task.jsm:331:42\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nTaskImpl_handleResultValue@resource://gre/modules/Task.jsm:401:16\nTaskImpl_run@resource://gre/modules/Task.jsm:339:15\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nTaskImpl_handleResultValue@resource://gre/modules/Task.jsm:401:16\nTaskImpl_run@resource://gre/modules/Task.jsm:339:15\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nnavigate@chrome://marionette/content/listener.js:397:12\nclickElement@chrome://marionette/content/listener.js:1317:5\n"},null]
10:43:28 INFO - 1500486208277 Marionette TRACE 352 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-END: test_click.py TestClick.test_clicking_an_element_that_is_not_displayed_raises')","sandbox":"simpletest","line":328}]
10:43:28 INFO - TEST-END: test_click.py TestClick.test_clicking_an_element_that_is_not_displayed_raises1500486208288 Marionette TRACE 352 <- [1,5,null,{"value":null}]
10:43:28 INFO - 1500486208291 Marionette TRACE 352 -> [0,6,"deleteSession",{}]
10:43:28 INFO - [Parent 3236] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:43:28 INFO - 1500486208295 Marionette TRACE 352 <- [1,6,null,{}]
10:43:28 INFO - TEST-PASS | test_click.py TestClick.test_clicking_an_element_that_is_not_displayed_raises | took 551ms
10:43:28 INFO - TEST-START | test_click.py TestClick.test_clicking_on_a_multiline_link
10:43:28 INFO - [Parent 3236] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:43:28 INFO - 1500486208301 Marionette DEBUG Closed connection 352
10:43:28 INFO - 1500486208304 Marionette DEBUG Accepted connection 353 from 127.0.0.1:49799
10:43:28 INFO - 1500486208305 Marionette DEBUG Closed connection 353
10:43:28 INFO - 1500486208307 Marionette DEBUG Accepted connection 354 from 127.0.0.1:49800
10:43:28 INFO - 1500486208309 Marionette TRACE 354 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
10:43:28 INFO - 1500486208312 Marionette CONFIG Matched capabilities: {"browserName":"firefox","browserVersion":"56.0a1","platformName":"windows_nt","platformVersion":"6.2","pageLoadStrategy":"normal","acceptInsecureCerts":false,"timeouts":{"implicit":0,"pageLoad":300000,"script":30000},"rotatable":false,"specificationLevel":0,"moz:processID":3236,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-216.001\\AppData\\Local\\Temp\\tmpqiuwk0.mozrunner","moz:accessibilityChecks":false}
10:43:28 INFO - 1500486208335 Marionette DEBUG Register listener.js for window 6442450945
10:43:28 INFO - 1500486208347 Marionette TRACE 354 <- [1,1,null,{"sessionId":"2f983c6b-03a0-4e4d-86cd-5008c445cb52","capabilities":{"browserName":"firefox","browserVersion":"56.0a1","platformName":"windows_nt","platformVersion":"6.2","pageLoadStrategy":"normal","acceptInsecureCerts":false,"timeouts":{"implicit":0,"pageLoad":300000,"script":30000},"rotatable":false,"specificationLevel":0,"moz:processID":3236,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-216.001\\AppData\\Local\\Temp\\tmpqiuwk0.mozrunner","moz:accessibilityChecks":false}}]
10:43:28 INFO - 1500486208358 Marionette TRACE 354 -> [0,2,"setTimeouts",{"script":30000}]
10:43:28 INFO - 1500486208360 Marionette TRACE 354 <- [1,2,null,{}]
10:43:28 INFO - 1500486208362 Marionette TRACE 354 -> [0,3,"setTimeouts",{"pageLoad":300000}]
10:43:28 INFO - 1500486208363 Marionette TRACE 354 <- [1,3,null,{}]
10:43:28 INFO - 1500486208365 Marionette TRACE 354 -> [0,4,"setTimeouts",{"implicit":0}]
10:43:28 INFO - 1500486208367 Marionette TRACE 354 <- [1,4,null,{}]
10:43:28 INFO - 1500486208370 Marionette TRACE 354 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-START: test_click.py TestClick.test_clicking_on_a_multiline_link')","sandbox":"simpletest","line":316}]
10:43:28 INFO - TEST-START: test_click.py TestClick.test_clicking_on_a_multiline_link1500486208377 Marionette TRACE 354 <- [1,5,null,{"value":null}]
10:43:28 INFO - 1500486208379 Marionette TRACE 354 -> [0,6,"deleteSession",{}]
10:43:28 INFO - [Parent 3236] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:43:28 INFO - 1500486208385 Marionette TRACE 354 <- [1,6,null,{}]
10:43:28 INFO - [Parent 3236] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:43:28 INFO - 1500486208391 Marionette DEBUG Closed connection 354
10:43:28 INFO - 1500486208393 Marionette DEBUG Accepted connection 355 from 127.0.0.1:49801
10:43:28 INFO - 1500486208403 Marionette DEBUG Closed connection 355
10:43:28 INFO - 1500486208405 Marionette DEBUG Accepted connection 356 from 127.0.0.1:49802
10:43:28 INFO - 1500486208408 Marionette TRACE 356 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
10:43:28 INFO - 1500486208411 Marionette CONFIG Matched capabilities: {"browserName":"firefox","browserVersion":"56.0a1","platformName":"windows_nt","platformVersion":"6.2","pageLoadStrategy":"normal","acceptInsecureCerts":false,"timeouts":{"implicit":0,"pageLoad":300000,"script":30000},"rotatable":false,"specificationLevel":0,"moz:processID":3236,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-216.001\\AppData\\Local\\Temp\\tmpqiuwk0.mozrunner","moz:accessibilityChecks":false}
10:43:28 INFO - 1500486208438 Marionette DEBUG Register listener.js for window 6442450945
10:43:28 INFO - 1500486208451 Marionette TRACE 356 <- [1,1,null,{"sessionId":"b180e76d-83ca-466a-a9d2-042f80a6eb5c","capabilities":{"browserName":"firefox","browserVersion":"56.0a1","platformName":"windows_nt","platformVersion":"6.2","pageLoadStrategy":"normal","acceptInsecureCerts":false,"timeouts":{"implicit":0,"pageLoad":300000,"script":30000},"rotatable":false,"specificationLevel":0,"moz:processID":3236,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-216.001\\AppData\\Local\\Temp\\tmpqiuwk0.mozrunner","moz:accessibilityChecks":false}}]
10:43:28 INFO - 1500486208454 Marionette TRACE 356 -> [0,2,"deleteSession",{}]
10:43:28 INFO - [Parent 3236] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:43:28 INFO - 1500486208459 Marionette TRACE 356 <- [1,2,null,{}]
10:43:28 INFO - [Parent 3236] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:43:28 INFO - 1500486208465 Marionette DEBUG Closed connection 356
10:43:28 INFO - 1500486208467 Marionette DEBUG Accepted connection 357 from 127.0.0.1:49803
10:43:28 INFO - 1500486208469 Marionette DEBUG Closed connection 357
10:43:28 INFO - 1500486208470 Marionette DEBUG Accepted connection 358 from 127.0.0.1:49804
10:43:28 INFO - 1500486208473 Marionette TRACE 358 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
10:43:28 INFO - 1500486208476 Marionette CONFIG Matched capabilities: {"browserName":"firefox","browserVersion":"56.0a1","platformName":"windows_nt","platformVersion":"6.2","pageLoadStrategy":"normal","acceptInsecureCerts":false,"timeouts":{"implicit":0,"pageLoad":300000,"script":30000},"rotatable":false,"specificationLevel":1,"moz:processID":3236,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-216.001\\AppData\\Local\\Temp\\tmpqiuwk0.mozrunner","moz:accessibilityChecks":false}
10:43:28 INFO - --DOMWINDOW == 15 (000000116D765800) [pid = 3960] [serial = 9] [outer = 0000000000000000] [url = http://127.0.0.1:49336/test_accessibility.html]
10:43:28 INFO - --DOMWINDOW == 14 (000000116ED0E800) [pid = 3960] [serial = 15] [outer = 0000000000000000] [url = http://127.0.0.1:49336/test_accessibility.html]
10:43:28 INFO - --DOMWINDOW == 13 (000000116C080800) [pid = 3960] [serial = 14] [outer = 0000000000000000] [url = http://127.0.0.1:49336/test_accessibility.html]
10:43:28 INFO - --DOMWINDOW == 12 (000000116C06A000) [pid = 3960] [serial = 13] [outer = 0000000000000000] [url = http://127.0.0.1:49336/test_accessibility.html]
10:43:28 INFO - --DOMWINDOW == 11 (000000116BC72800) [pid = 3960] [serial = 12] [outer = 0000000000000000] [url = http://127.0.0.1:49336/test_accessibility.html]
10:43:28 INFO - --DOMWINDOW == 10 (000000116986B800) [pid = 3960] [serial = 11] [outer = 0000000000000000] [url = http://127.0.0.1:49336/test_accessibility.html]
10:43:28 INFO - --DOMWINDOW == 9 (00000011692ED800) [pid = 3960] [serial = 10] [outer = 0000000000000000] [url = http://127.0.0.1:49336/test_accessibility.html]
10:43:28 INFO - 1500486208501 Marionette DEBUG Register listener.js for window 6442450945
10:43:28 INFO - 1500486208515 Marionette TRACE 358 <- [1,1,null,{"sessionId":"39c8c9d0-c6bc-44be-a2a9-0e82641eadf7","capabilities":{"browserName":"firefox","browserVersion":"56.0a1","platformName":"windows_nt","platformVersion":"6.2","pageLoadStrategy":"normal","acceptInsecureCerts":false,"timeouts":{"implicit":0,"pageLoad":300000,"script":30000},"rotatable":false,"specificationLevel":1,"moz:processID":3236,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-216.001\\AppData\\Local\\Temp\\tmpqiuwk0.mozrunner","moz:accessibilityChecks":false}}]
10:43:28 INFO - 1500486208517 Marionette TRACE 358 -> [0,2,"get",{"url":"http://127.0.0.1:49336/clicks.html"}]
10:43:28 INFO - 1500486208522 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49336/hidden.html"
10:43:28 INFO - 1500486208544 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49336/hidden.html"
10:43:28 INFO - 1500486208545 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49336/hidden.html"
10:43:28 INFO - ++DOMWINDOW == 10 (00000011692F5800) [pid = 3960] [serial = 24] [outer = 00000011630AB800]
10:43:28 INFO - 1500486208581 Marionette DEBUG Received DOM event "DOMContentLoaded" for "http://127.0.0.1:49336/clicks.html"
10:43:28 INFO - 1500486208586 Marionette DEBUG Received DOM event "pageshow" for "http://127.0.0.1:49336/clicks.html"
10:43:28 INFO - 1500486208588 Marionette TRACE 358 <- [1,2,null,{}]
10:43:28 INFO - 1500486208605 Marionette TRACE 358 -> [0,3,"findElement",{"using":"id","value":"overflowLink"}]
10:43:28 INFO - 1500486208612 Marionette TRACE 358 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"5ed0e946-f16a-4787-a8b9-d7de883e9e08","ELEMENT":"5ed0e946-f16a-4787-a8b9-d7de883e9e08"}}]
10:43:28 INFO - 1500486208614 Marionette TRACE 358 -> [0,4,"clickElement",{"id":"5ed0e946-f16a-4787-a8b9-d7de883e9e08"}]
10:43:28 INFO - 1500486208835 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49336/clicks.html"
10:43:28 INFO - 1500486208856 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49336/clicks.html"
10:43:28 INFO - 1500486208857 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49336/clicks.html"
10:43:28 INFO - ++DOMWINDOW == 11 (000000116986D800) [pid = 3960] [serial = 25] [outer = 00000011630AB800]
10:43:28 INFO - 1500486208888 Marionette DEBUG Received DOM event "DOMContentLoaded" for "http://127.0.0.1:49336/test.html"
10:43:28 INFO - 1500486208892 Marionette DEBUG Received DOM event "pageshow" for "http://127.0.0.1:49336/test.html"
10:43:28 INFO - 1500486208903 Marionette TRACE 358 <- [1,4,null,{}]
10:43:29 INFO - 1500486209287 Marionette TRACE 358 -> [0,5,"findElement",{"using":"id","value":"testDiv"}]
10:43:29 INFO - 1500486209296 Marionette TRACE 358 <- [1,5,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"fa177486-e3da-4c7a-912d-4decc40fa358","ELEMENT":"fa177486-e3da-4c7a-912d-4decc40fa358"}}]
10:43:29 INFO - 1500486209298 Marionette TRACE 358 -> [0,6,"getTitle",{}]
10:43:29 INFO - 1500486209299 Marionette TRACE 358 <- [1,6,null,{"value":"Marionette Test"}]
10:43:29 INFO - 1500486209302 Marionette TRACE 358 -> [0,7,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-END: test_click.py TestClick.test_clicking_on_a_multiline_link')","sandbox":"simpletest","line":328}]
10:43:29 INFO - TEST-END: test_click.py TestClick.test_clicking_on_a_multiline_link1500486209309 Marionette TRACE 358 <- [1,7,null,{"value":null}]
10:43:29 INFO - 1500486209311 Marionette TRACE 358 -> [0,8,"deleteSession",{}]
10:43:29 INFO - TEST-PASS | test_click.py TestClick.test_clicking_on_a_multiline_link | took 1021ms
10:43:29 INFO - [Parent 3236] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:43:29 INFO - 1500486209316 Marionette TRACE 358 <- [1,8,null,{}]
10:43:29 INFO - TEST-START | test_click.py TestClick.test_container_element
10:43:29 INFO - [Parent 3236] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:43:29 INFO - 1500486209320 Marionette DEBUG Closed connection 358
10:43:29 INFO - 1500486209321 Marionette DEBUG Accepted connection 359 from 127.0.0.1:49811
10:43:29 INFO - 1500486209323 Marionette DEBUG Closed connection 359
10:43:29 INFO - 1500486209324 Marionette DEBUG Accepted connection 360 from 127.0.0.1:49812
10:43:29 INFO - 1500486209327 Marionette TRACE 360 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
10:43:29 INFO - 1500486209329 Marionette CONFIG Matched capabilities: {"browserName":"firefox","browserVersion":"56.0a1","platformName":"windows_nt","platformVersion":"6.2","pageLoadStrategy":"normal","acceptInsecureCerts":false,"timeouts":{"implicit":0,"pageLoad":300000,"script":30000},"rotatable":false,"specificationLevel":0,"moz:processID":3236,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-216.001\\AppData\\Local\\Temp\\tmpqiuwk0.mozrunner","moz:accessibilityChecks":false}
10:43:29 INFO - 1500486209353 Marionette DEBUG Register listener.js for window 6442450945
10:43:29 INFO - 1500486209364 Marionette TRACE 360 <- [1,1,null,{"sessionId":"90e886b7-a946-427b-9cc9-5365fe5de560","capabilities":{"browserName":"firefox","browserVersion":"56.0a1","platformName":"windows_nt","platformVersion":"6.2","pageLoadStrategy":"normal","acceptInsecureCerts":false,"timeouts":{"implicit":0,"pageLoad":300000,"script":30000},"rotatable":false,"specificationLevel":0,"moz:processID":3236,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-216.001\\AppData\\Local\\Temp\\tmpqiuwk0.mozrunner","moz:accessibilityChecks":false}}]
10:43:29 INFO - 1500486209367 Marionette TRACE 360 -> [0,2,"setTimeouts",{"script":30000}]
10:43:29 INFO - 1500486209369 Marionette TRACE 360 <- [1,2,null,{}]
10:43:29 INFO - 1500486209370 Marionette TRACE 360 -> [0,3,"setTimeouts",{"pageLoad":300000}]
10:43:29 INFO - 1500486209372 Marionette TRACE 360 <- [1,3,null,{}]
10:43:29 INFO - 1500486209373 Marionette TRACE 360 -> [0,4,"setTimeouts",{"implicit":0}]
10:43:29 INFO - 1500486209375 Marionette TRACE 360 <- [1,4,null,{}]
10:43:29 INFO - 1500486209377 Marionette TRACE 360 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-START: test_click.py TestClick.test_container_element')","sandbox":"simpletest","line":316}]
10:43:29 INFO - TEST-START: test_click.py TestClick.test_container_element1500486209385 Marionette TRACE 360 <- [1,5,null,{"value":null}]
10:43:29 INFO - 1500486209387 Marionette TRACE 360 -> [0,6,"deleteSession",{}]
10:43:29 INFO - [Parent 3236] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:43:29 INFO - 1500486209391 Marionette TRACE 360 <- [1,6,null,{}]
10:43:29 INFO - [Parent 3236] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:43:29 INFO - 1500486209395 Marionette DEBUG Closed connection 360
10:43:29 INFO - 1500486209397 Marionette DEBUG Accepted connection 361 from 127.0.0.1:49813
10:43:29 INFO - 1500486209398 Marionette DEBUG Closed connection 361
10:43:29 INFO - 1500486209400 Marionette DEBUG Accepted connection 362 from 127.0.0.1:49814
10:43:29 INFO - 1500486209402 Marionette TRACE 362 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
10:43:29 INFO - 1500486209404 Marionette CONFIG Matched capabilities: {"browserName":"firefox","browserVersion":"56.0a1","platformName":"windows_nt","platformVersion":"6.2","pageLoadStrategy":"normal","acceptInsecureCerts":false,"timeouts":{"implicit":0,"pageLoad":300000,"script":30000},"rotatable":false,"specificationLevel":0,"moz:processID":3236,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-216.001\\AppData\\Local\\Temp\\tmpqiuwk0.mozrunner","moz:accessibilityChecks":false}
10:43:29 INFO - 1500486209425 Marionette DEBUG Register listener.js for window 6442450945
10:43:29 INFO - 1500486209435 Marionette TRACE 362 <- [1,1,null,{"sessionId":"8983a3b0-2f21-4a1a-b64b-50071fbd71c2","capabilities":{"browserName":"firefox","browserVersion":"56.0a1","platformName":"windows_nt","platformVersion":"6.2","pageLoadStrategy":"normal","acceptInsecureCerts":false,"timeouts":{"implicit":0,"pageLoad":300000,"script":30000},"rotatable":false,"specificationLevel":0,"moz:processID":3236,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-216.001\\AppData\\Local\\Temp\\tmpqiuwk0.mozrunner","moz:accessibilityChecks":false}}]
10:43:29 INFO - 1500486209438 Marionette TRACE 362 -> [0,2,"deleteSession",{}]
10:43:29 INFO - [Parent 3236] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:43:29 INFO - 1500486209442 Marionette TRACE 362 <- [1,2,null,{}]
10:43:29 INFO - [Parent 3236] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:43:29 INFO - 1500486209446 Marionette DEBUG Closed connection 362
10:43:29 INFO - 1500486209448 Marionette DEBUG Accepted connection 363 from 127.0.0.1:49815
10:43:29 INFO - 1500486209449 Marionette DEBUG Closed connection 363
10:43:29 INFO - 1500486209451 Marionette DEBUG Accepted connection 364 from 127.0.0.1:49816
10:43:29 INFO - 1500486209453 Marionette TRACE 364 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
10:43:29 INFO - 1500486209455 Marionette CONFIG Matched capabilities: {"browserName":"firefox","browserVersion":"56.0a1","platformName":"windows_nt","platformVersion":"6.2","pageLoadStrategy":"normal","acceptInsecureCerts":false,"timeouts":{"implicit":0,"pageLoad":300000,"script":30000},"rotatable":false,"specificationLevel":1,"moz:processID":3236,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-216.001\\AppData\\Local\\Temp\\tmpqiuwk0.mozrunner","moz:accessibilityChecks":false}
10:43:29 INFO - 1500486209477 Marionette DEBUG Register listener.js for window 6442450945
10:43:29 INFO - 1500486209499 Marionette TRACE 364 <- [1,1,null,{"sessionId":"cf902652-05b6-4140-a294-727b53a9461b","capabilities":{"browserName":"firefox","browserVersion":"56.0a1","platformName":"windows_nt","platformVersion":"6.2","pageLoadStrategy":"normal","acceptInsecureCerts":false,"timeouts":{"implicit":0,"pageLoad":300000,"script":30000},"rotatable":false,"specificationLevel":1,"moz:processID":3236,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-216.001\\AppData\\Local\\Temp\\tmpqiuwk0.mozrunner","moz:accessibilityChecks":false}}]
10:43:29 INFO - 1500486209501 Marionette TRACE 364 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efoo%3C/option%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"}]
10:43:29 INFO - 1500486209506 Marionette DEBUG Received DOM event "beforeunload" for "http://127.0.0.1:49336/test.html"
10:43:29 INFO - 1500486209510 Marionette DEBUG Received DOM event "pagehide" for "http://127.0.0.1:49336/test.html"
10:43:29 INFO - 1500486209510 Marionette DEBUG Received DOM event "unload" for "http://127.0.0.1:49336/test.html"
10:43:29 INFO - ++DOMWINDOW == 12 (0000001169869800) [pid = 3960] [serial = 26] [outer = 00000011630AB800]
10:43:29 INFO - 1500486209541 Marionette DEBUG Received DOM event "DOMContentLoaded" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efoo%3C/option%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
10:43:29 INFO - 1500486209551 Marionette DEBUG Received DOM event "pageshow" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efoo%3C/option%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
10:43:29 INFO - 1500486209552 Marionette TRACE 364 <- [1,2,null,{}]
10:43:29 INFO - 1500486209558 Marionette TRACE 364 -> [0,3,"findElement",{"using":"tag name","value":"option"}]
10:43:29 INFO - 1500486209568 Marionette TRACE 364 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"b8328747-9276-429f-b980-a10721bcc104","ELEMENT":"b8328747-9276-429f-b980-a10721bcc104"}}]
10:43:29 INFO - 1500486209570 Marionette TRACE 364 -> [0,4,"clickElement",{"id":"b8328747-9276-429f-b980-a10721bcc104"}]
10:43:29 INFO - [Child 3960] WARNING: NS_ENSURE_TRUE(mouseEvent) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/layout/forms/nsListControlFrame.cpp, line 1905
10:43:29 INFO - [Child 3960] WARNING: NS_ENSURE_TRUE(mouseEvent) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/layout/forms/nsListControlFrame.cpp, line 1813
10:43:29 INFO - [Child 3960] WARNING: NS_ENSURE_TRUE(mouseEvent) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/layout/forms/nsListControlFrame.cpp, line 1619
10:43:30 INFO - 1500486209996 Marionette DEBUG Canceled page load listener because no navigation has been detected
10:43:30 INFO - 1500486209998 Marionette TRACE 364 <- [1,4,null,{}]
10:43:30 INFO - 1500486210000 Marionette TRACE 364 -> [0,5,"getElementProperty",{"id":"b8328747-9276-429f-b980-a10721bcc104","name":"selected"}]
10:43:30 INFO - 1500486210028 Marionette TRACE 364 <- [1,5,null,{"value":true}]
10:43:30 INFO - 1500486210031 Marionette TRACE 364 -> [0,6,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-END: test_click.py TestClick.test_container_element')","sandbox":"simpletest","line":328}]
10:43:30 INFO - TEST-END: test_click.py TestClick.test_container_element1500486210038 Marionette TRACE 364 <- [1,6,null,{"value":null}]
10:43:30 INFO - 1500486210040 Marionette TRACE 364 -> [0,7,"deleteSession",{}]
10:43:30 INFO - [Parent 3236] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:43:30 INFO - TEST-PASS | test_click.py TestClick.test_container_element | took 729ms
10:43:30 INFO - TEST-START | test_click.py TestClick.test_container_element_outside_view
10:43:30 INFO - 1500486210045 Marionette TRACE 364 <- [1,7,null,{}]
10:43:30 INFO - [Parent 3236] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:43:30 INFO - 1500486210050 Marionette DEBUG Closed connection 364
10:43:30 INFO - 1500486210051 Marionette DEBUG Accepted connection 365 from 127.0.0.1:49817
10:43:30 INFO - 1500486210053 Marionette DEBUG Closed connection 365
10:43:30 INFO - 1500486210054 Marionette DEBUG Accepted connection 366 from 127.0.0.1:49818
10:43:30 INFO - 1500486210057 Marionette TRACE 366 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
10:43:30 INFO - 1500486210059 Marionette CONFIG Matched capabilities: {"browserName":"firefox","browserVersion":"56.0a1","platformName":"windows_nt","platformVersion":"6.2","pageLoadStrategy":"normal","acceptInsecureCerts":false,"timeouts":{"implicit":0,"pageLoad":300000,"script":30000},"rotatable":false,"specificationLevel":0,"moz:processID":3236,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-216.001\\AppData\\Local\\Temp\\tmpqiuwk0.mozrunner","moz:accessibilityChecks":false}
10:43:30 INFO - 1500486210082 Marionette DEBUG Register listener.js for window 6442450945
10:43:30 INFO - 1500486210093 Marionette TRACE 366 <- [1,1,null,{"sessionId":"67c90732-0071-409a-920f-34a6bae205a9","capabilities":{"browserName":"firefox","browserVersion":"56.0a1","platformName":"windows_nt","platformVersion":"6.2","pageLoadStrategy":"normal","acceptInsecureCerts":false,"timeouts":{"implicit":0,"pageLoad":300000,"script":30000},"rotatable":false,"specificationLevel":0,"moz:processID":3236,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-216.001\\AppData\\Local\\Temp\\tmpqiuwk0.mozrunner","moz:accessibilityChecks":false}}]
10:43:30 INFO - 1500486210096 Marionette TRACE 366 -> [0,2,"setTimeouts",{"script":30000}]
10:43:30 INFO - 1500486210098 Marionette TRACE 366 <- [1,2,null,{}]
10:43:30 INFO - 1500486210100 Marionette TRACE 366 -> [0,3,"setTimeouts",{"pageLoad":300000}]
10:43:30 INFO - 1500486210101 Marionette TRACE 366 <- [1,3,null,{}]
10:43:30 INFO - 1500486210103 Marionette TRACE 366 -> [0,4,"setTimeouts",{"implicit":0}]
10:43:30 INFO - 1500486210104 Marionette TRACE 366 <- [1,4,null,{}]
10:43:30 INFO - 1500486210107 Marionette TRACE 366 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-START: test_click.py TestClick.test_container_element_outside_view')","sandbox":"simpletest","line":316}]
10:43:30 INFO - TEST-START: test_click.py TestClick.test_container_element_outside_view1500486210115 Marionette TRACE 366 <- [1,5,null,{"value":null}]
10:43:30 INFO - 1500486210117 Marionette TRACE 366 -> [0,6,"deleteSession",{}]
10:43:30 INFO - [Parent 3236] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:43:30 INFO - 1500486210121 Marionette TRACE 366 <- [1,6,null,{}]
10:43:30 INFO - [Parent 3236] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:43:30 INFO - 1500486210126 Marionette DEBUG Closed connection 366
10:43:30 INFO - 1500486210127 Marionette DEBUG Accepted connection 367 from 127.0.0.1:49819
10:43:30 INFO - 1500486210129 Marionette DEBUG Closed connection 367
10:43:30 INFO - 1500486210131 Marionette DEBUG Accepted connection 368 from 127.0.0.1:49820
10:43:30 INFO - 1500486210133 Marionette TRACE 368 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
10:43:30 INFO - 1500486210135 Marionette CONFIG Matched capabilities: {"browserName":"firefox","browserVersion":"56.0a1","platformName":"windows_nt","platformVersion":"6.2","pageLoadStrategy":"normal","acceptInsecureCerts":false,"timeouts":{"implicit":0,"pageLoad":300000,"script":30000},"rotatable":false,"specificationLevel":0,"moz:processID":3236,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-216.001\\AppData\\Local\\Temp\\tmpqiuwk0.mozrunner","moz:accessibilityChecks":false}
10:43:30 INFO - 1500486210160 Marionette DEBUG Register listener.js for window 6442450945
10:43:30 INFO - 1500486210171 Marionette TRACE 368 <- [1,1,null,{"sessionId":"202df59d-1e02-4250-8e16-ebe1bcf8fbc6","capabilities":{"browserName":"firefox","browserVersion":"56.0a1","platformName":"windows_nt","platformVersion":"6.2","pageLoadStrategy":"normal","acceptInsecureCerts":false,"timeouts":{"implicit":0,"pageLoad":300000,"script":30000},"rotatable":false,"specificationLevel":0,"moz:processID":3236,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-216.001\\AppData\\Local\\Temp\\tmpqiuwk0.mozrunner","moz:accessibilityChecks":false}}]
10:43:30 INFO - 1500486210174 Marionette TRACE 368 -> [0,2,"deleteSession",{}]
10:43:30 INFO - [Parent 3236] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:43:30 INFO - 1500486210179 Marionette TRACE 368 <- [1,2,null,{}]
10:43:30 INFO - [Parent 3236] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:43:30 INFO - 1500486210183 Marionette DEBUG Closed connection 368
10:43:30 INFO - 1500486210185 Marionette DEBUG Accepted connection 369 from 127.0.0.1:49821
10:43:30 INFO - 1500486210186 Marionette DEBUG Closed connection 369
10:43:30 INFO - 1500486210188 Marionette DEBUG Accepted connection 370 from 127.0.0.1:49822
10:43:30 INFO - 1500486210190 Marionette TRACE 370 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
10:43:30 INFO - 1500486210193 Marionette CONFIG Matched capabilities: {"browserName":"firefox","browserVersion":"56.0a1","platformName":"windows_nt","platformVersion":"6.2","pageLoadStrategy":"normal","acceptInsecureCerts":false,"timeouts":{"implicit":0,"pageLoad":300000,"script":30000},"rotatable":false,"specificationLevel":1,"moz:processID":3236,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-216.001\\AppData\\Local\\Temp\\tmpqiuwk0.mozrunner","moz:accessibilityChecks":false}
10:43:30 INFO - 1500486210216 Marionette DEBUG Register listener.js for window 6442450945
10:43:30 INFO - 1500486210228 Marionette TRACE 370 <- [1,1,null,{"sessionId":"6df0eb3e-38ea-4ce9-af66-182719b5e9c4","capabilities":{"browserName":"firefox","browserVersion":"56.0a1","platformName":"windows_nt","platformVersion":"6.2","pageLoadStrategy":"normal","acceptInsecureCerts":false,"timeouts":{"implicit":0,"pageLoad":300000,"script":30000},"rotatable":false,"specificationLevel":1,"moz:processID":3236,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-216.001\\AppData\\Local\\Temp\\tmpqiuwk0.mozrunner","moz:accessibilityChecks":false}}]
10:43:30 INFO - 1500486210230 Marionette TRACE 370 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%20style%3D%22margin-top%3A%20100vh%22%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efoo%3C/option%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"}]
10:43:30 INFO - 1500486210235 Marionette DEBUG Received DOM event "beforeunload" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efoo%3C/option%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
10:43:30 INFO - 1500486210239 Marionette DEBUG Received DOM event "pagehide" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efoo%3C/option%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
10:43:30 INFO - 1500486210240 Marionette DEBUG Received DOM event "unload" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efoo%3C/option%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
10:43:30 INFO - ++DOMWINDOW == 13 (000000116E8DC000) [pid = 3960] [serial = 27] [outer = 00000011630AB800]
10:43:30 INFO - 1500486210264 Marionette DEBUG Received DOM event "DOMContentLoaded" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%20style%3D%22margin-top%3A%20100vh%22%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efoo%3C/option%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
10:43:30 INFO - 1500486210271 Marionette DEBUG Received DOM event "pageshow" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%20style%3D%22margin-top%3A%20100vh%22%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efoo%3C/option%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
10:43:30 INFO - 1500486210290 Marionette TRACE 370 <- [1,2,null,{}]
10:43:30 INFO - 1500486210300 Marionette TRACE 370 -> [0,3,"findElement",{"using":"tag name","value":"option"}]
10:43:30 INFO - 1500486210306 Marionette TRACE 370 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"ea965b49-eb31-4bcf-8dfe-cc8ccbbe5f6f","ELEMENT":"ea965b49-eb31-4bcf-8dfe-cc8ccbbe5f6f"}}]
10:43:30 INFO - 1500486210308 Marionette TRACE 370 -> [0,4,"clickElement",{"id":"ea965b49-eb31-4bcf-8dfe-cc8ccbbe5f6f"}]
10:43:30 INFO - [Child 3960] WARNING: NS_ENSURE_TRUE(mouseEvent) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/layout/forms/nsListControlFrame.cpp, line 1905
10:43:30 INFO - [Child 3960] WARNING: NS_ENSURE_TRUE(mouseEvent) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/layout/forms/nsListControlFrame.cpp, line 1813
10:43:30 INFO - [Child 3960] WARNING: NS_ENSURE_TRUE(mouseEvent) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/layout/forms/nsListControlFrame.cpp, line 1619
10:43:30 INFO - 1500486210742 Marionette DEBUG Canceled page load listener because no navigation has been detected
10:43:30 INFO - 1500486210744 Marionette TRACE 370 <- [1,4,null,{}]
10:43:30 INFO - 1500486210746 Marionette TRACE 370 -> [0,5,"getElementProperty",{"id":"ea965b49-eb31-4bcf-8dfe-cc8ccbbe5f6f","name":"selected"}]
10:43:30 INFO - 1500486210772 Marionette TRACE 370 <- [1,5,null,{"value":true}]
10:43:30 INFO - 1500486210775 Marionette TRACE 370 -> [0,6,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-END: test_click.py TestClick.test_container_element_outside_view')","sandbox":"simpletest","line":328}]
10:43:30 INFO - TEST-END: test_click.py TestClick.test_container_element_outside_view1500486210782 Marionette TRACE 370 <- [1,6,null,{"value":null}]
10:43:30 INFO - 1500486210784 Marionette TRACE 370 -> [0,7,"deleteSession",{}]
10:43:30 INFO - TEST-PASS | test_click.py TestClick.test_container_element_outside_view | took 742ms
10:43:30 INFO - [Parent 3236] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:43:30 INFO - 1500486210788 Marionette TRACE 370 <- [1,7,null,{}]
10:43:30 INFO - TEST-START | test_click.py TestClick.test_css_transforms
10:43:30 INFO - [Parent 3236] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:43:30 INFO - 1500486210792 Marionette DEBUG Closed connection 370
10:43:30 INFO - 1500486210793 Marionette DEBUG Accepted connection 371 from 127.0.0.1:49823
10:43:30 INFO - 1500486210795 Marionette DEBUG Closed connection 371
10:43:30 INFO - 1500486210796 Marionette DEBUG Accepted connection 372 from 127.0.0.1:49824
10:43:30 INFO - 1500486210799 Marionette TRACE 372 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
10:43:30 INFO - 1500486210801 Marionette CONFIG Matched capabilities: {"browserName":"firefox","browserVersion":"56.0a1","platformName":"windows_nt","platformVersion":"6.2","pageLoadStrategy":"normal","acceptInsecureCerts":false,"timeouts":{"implicit":0,"pageLoad":300000,"script":30000},"rotatable":false,"specificationLevel":0,"moz:processID":3236,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-216.001\\AppData\\Local\\Temp\\tmpqiuwk0.mozrunner","moz:accessibilityChecks":false}
10:43:30 INFO - 1500486210823 Marionette DEBUG Register listener.js for window 6442450945
10:43:30 INFO - 1500486210834 Marionette TRACE 372 <- [1,1,null,{"sessionId":"8c1b3278-fc52-403f-b86b-1e2214d454f8","capabilities":{"browserName":"firefox","browserVersion":"56.0a1","platformName":"windows_nt","platformVersion":"6.2","pageLoadStrategy":"normal","acceptInsecureCerts":false,"timeouts":{"implicit":0,"pageLoad":300000,"script":30000},"rotatable":false,"specificationLevel":0,"moz:processID":3236,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-216.001\\AppData\\Local\\Temp\\tmpqiuwk0.mozrunner","moz:accessibilityChecks":false}}]
10:43:30 INFO - 1500486210836 Marionette TRACE 372 -> [0,2,"setTimeouts",{"script":30000}]
10:43:30 INFO - 1500486210838 Marionette TRACE 372 <- [1,2,null,{}]
10:43:30 INFO - 1500486210840 Marionette TRACE 372 -> [0,3,"setTimeouts",{"pageLoad":300000}]
10:43:30 INFO - 1500486210841 Marionette TRACE 372 <- [1,3,null,{}]
10:43:30 INFO - 1500486210844 Marionette TRACE 372 -> [0,4,"setTimeouts",{"implicit":0}]
10:43:30 INFO - 1500486210845 Marionette TRACE 372 <- [1,4,null,{}]
10:43:30 INFO - 1500486210847 Marionette TRACE 372 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-START: test_click.py TestClick.test_css_transforms')","sandbox":"simpletest","line":316}]
10:43:30 INFO - TEST-START: test_click.py TestClick.test_css_transforms1500486210854 Marionette TRACE 372 <- [1,5,null,{"value":null}]
10:43:30 INFO - 1500486210856 Marionette TRACE 372 -> [0,6,"deleteSession",{}]
10:43:30 INFO - [Parent 3236] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:43:30 INFO - 1500486210860 Marionette TRACE 372 <- [1,6,null,{}]
10:43:30 INFO - [Parent 3236] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:43:30 INFO - 1500486210864 Marionette DEBUG Closed connection 372
10:43:30 INFO - 1500486210865 Marionette DEBUG Accepted connection 373 from 127.0.0.1:49825
10:43:30 INFO - 1500486210867 Marionette DEBUG Closed connection 373
10:43:30 INFO - 1500486210869 Marionette DEBUG Accepted connection 374 from 127.0.0.1:49826
10:43:30 INFO - 1500486210871 Marionette TRACE 374 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
10:43:30 INFO - 1500486210873 Marionette CONFIG Matched capabilities: {"browserName":"firefox","browserVersion":"56.0a1","platformName":"windows_nt","platformVersion":"6.2","pageLoadStrategy":"normal","acceptInsecureCerts":false,"timeouts":{"implicit":0,"pageLoad":300000,"script":30000},"rotatable":false,"specificationLevel":0,"moz:processID":3236,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-216.001\\AppData\\Local\\Temp\\tmpqiuwk0.mozrunner","moz:accessibilityChecks":false}
10:43:30 INFO - 1500486210895 Marionette DEBUG Register listener.js for window 6442450945
10:43:30 INFO - 1500486210906 Marionette TRACE 374 <- [1,1,null,{"sessionId":"7a5e1f38-cda1-46c6-aed1-a40e32eb5f30","capabilities":{"browserName":"firefox","browserVersion":"56.0a1","platformName":"windows_nt","platformVersion":"6.2","pageLoadStrategy":"normal","acceptInsecureCerts":false,"timeouts":{"implicit":0,"pageLoad":300000,"script":30000},"rotatable":false,"specificationLevel":0,"moz:processID":3236,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-216.001\\AppData\\Local\\Temp\\tmpqiuwk0.mozrunner","moz:accessibilityChecks":false}}]
10:43:30 INFO - 1500486210908 Marionette TRACE 374 -> [0,2,"deleteSession",{}]
10:43:30 INFO - [Parent 3236] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:43:30 INFO - 1500486210912 Marionette TRACE 374 <- [1,2,null,{}]
10:43:30 INFO - [Parent 3236] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:43:30 INFO - 1500486210916 Marionette DEBUG Closed connection 374
10:43:30 INFO - 1500486210917 Marionette DEBUG Accepted connection 375 from 127.0.0.1:49827
10:43:30 INFO - 1500486210919 Marionette DEBUG Closed connection 375
10:43:30 INFO - 1500486210920 Marionette DEBUG Accepted connection 376 from 127.0.0.1:49828
10:43:30 INFO - 1500486210922 Marionette TRACE 376 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
10:43:30 INFO - 1500486210925 Marionette CONFIG Matched capabilities: {"browserName":"firefox","browserVersion":"56.0a1","platformName":"windows_nt","platformVersion":"6.2","pageLoadStrategy":"normal","acceptInsecureCerts":false,"timeouts":{"implicit":0,"pageLoad":300000,"script":30000},"rotatable":false,"specificationLevel":1,"moz:processID":3236,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-216.001\\AppData\\Local\\Temp\\tmpqiuwk0.mozrunner","moz:accessibilityChecks":false}
10:43:30 INFO - 1500486210947 Marionette DEBUG Register listener.js for window 6442450945
10:43:30 INFO - 1500486210957 Marionette TRACE 376 <- [1,1,null,{"sessionId":"cf354639-4d4b-40b6-9c31-02ac1d440ab6","capabilities":{"browserName":"firefox","browserVersion":"56.0a1","platformName":"windows_nt","platformVersion":"6.2","pageLoadStrategy":"normal","acceptInsecureCerts":false,"timeouts":{"implicit":0,"pageLoad":300000,"script":30000},"rotatable":false,"specificationLevel":1,"moz:processID":3236,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-216.001\\AppData\\Local\\Temp\\tmpqiuwk0.mozrunner","moz:accessibilityChecks":false}}]
10:43:30 INFO - 1500486210960 Marionette TRACE 376 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cstyle%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%2A%20%7B%20margin%3A%200%3B%20padding%3A%200%3B%20%7D%0A%20%20%20%20%20%20%20%20%20%20%20%20div%20%7B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20display%3A%20block%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20background-color%3A%20blue%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20width%3A%20200px%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20height%3A%20200px%3B%0A%0A%20%20%20%20%20%20%20%20%20%20%20%20%20transform%3A%20translateX%28-105px%29%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%7D%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/style%3E%0A%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cdiv%3E%3C/div%3E"}]
10:43:30 INFO - 1500486210964 Marionette DEBUG Received DOM event "beforeunload" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%20style%3D%22margin-top%3A%20100vh%22%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efoo%3C/option%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
10:43:30 INFO - 1500486210969 Marionette DEBUG Received DOM event "pagehide" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%20style%3D%22margin-top%3A%20100vh%22%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efoo%3C/option%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
10:43:30 INFO - 1500486210970 Marionette DEBUG Received DOM event "unload" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%20style%3D%22margin-top%3A%20100vh%22%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efoo%3C/option%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
10:43:30 INFO - ++DOMWINDOW == 14 (000000116C078000) [pid = 3960] [serial = 28] [outer = 00000011630AB800]
10:43:30 INFO - 1500486210991 Marionette DEBUG Received DOM event "DOMContentLoaded" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cstyle%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%2A%20%7B%20margin%3A%200%3B%20padding%3A%200%3B%20%7D%0A%20%20%20%20%20%20%20%20%20%20%20%20div%20%7B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20display%3A%20block%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20background-color%3A%20blue%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20width%3A%20200px%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20height%3A%20200px%3B%0A%0A%20%20%20%20%20%20%20%20%20%20%20%20%20transform%3A%20translateX%28-105px%29%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%7D%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/style%3E%0A%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cdiv%3E%3C/div%3E"
10:43:31 INFO - 1500486210997 Marionette DEBUG Received DOM event "pageshow" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cstyle%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%2A%20%7B%20margin%3A%200%3B%20padding%3A%200%3B%20%7D%0A%20%20%20%20%20%20%20%20%20%20%20%20div%20%7B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20display%3A%20block%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20background-color%3A%20blue%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20width%3A%20200px%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20height%3A%20200px%3B%0A%0A%20%20%20%20%20%20%20%20%20%20%20%20%20transform%3A%20translateX%28-105px%29%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%7D%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/style%3E%0A%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cdiv%3E%3C/div%3E"
10:43:31 INFO - 1500486211008 Marionette TRACE 376 <- [1,2,null,{}]
10:43:31 INFO - 1500486211016 Marionette TRACE 376 -> [0,3,"findElement",{"using":"tag name","value":"div"}]
10:43:31 INFO - 1500486211022 Marionette TRACE 376 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"059fe02e-f0bb-407f-8fe8-d5bbdf2bb6cf","ELEMENT":"059fe02e-f0bb-407f-8fe8-d5bbdf2bb6cf"}}]
10:43:31 INFO - 1500486211024 Marionette TRACE 376 -> [0,4,"clickElement",{"id":"059fe02e-f0bb-407f-8fe8-d5bbdf2bb6cf"}]
10:43:31 INFO - 1500486211440 Marionette DEBUG Canceled page load listener because no navigation has been detected
10:43:31 INFO - 1500486211441 Marionette TRACE 376 <- [1,4,null,{}]
10:43:31 INFO - 1500486211444 Marionette TRACE 376 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-END: test_click.py TestClick.test_css_transforms')","sandbox":"simpletest","line":328}]
10:43:31 INFO - TEST-END: test_click.py TestClick.test_css_transforms1500486211451 Marionette TRACE 376 <- [1,5,null,{"value":null}]
10:43:31 INFO - 1500486211453 Marionette TRACE 376 -> [0,6,"deleteSession",{}]
10:43:31 INFO - [Parent 3236] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:43:31 INFO - 1500486211457 Marionette TRACE 376 <- [1,6,null,{}]
10:43:31 INFO - TEST-PASS | test_click.py TestClick.test_css_transforms | took 669ms
10:43:31 INFO - TEST-START | test_click.py TestClick.test_inclusive_descendant
10:43:31 INFO - [Parent 3236] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:43:31 INFO - 1500486211462 Marionette DEBUG Closed connection 376
10:43:31 INFO - 1500486211463 Marionette DEBUG Accepted connection 377 from 127.0.0.1:49829
10:43:31 INFO - 1500486211465 Marionette DEBUG Closed connection 377
10:43:31 INFO - 1500486211466 Marionette DEBUG Accepted connection 378 from 127.0.0.1:49830
10:43:31 INFO - 1500486211470 Marionette TRACE 378 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
10:43:31 INFO - 1500486211472 Marionette CONFIG Matched capabilities: {"browserName":"firefox","browserVersion":"56.0a1","platformName":"windows_nt","platformVersion":"6.2","pageLoadStrategy":"normal","acceptInsecureCerts":false,"timeouts":{"implicit":0,"pageLoad":300000,"script":30000},"rotatable":false,"specificationLevel":0,"moz:processID":3236,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-216.001\\AppData\\Local\\Temp\\tmpqiuwk0.mozrunner","moz:accessibilityChecks":false}
10:43:31 INFO - 1500486211494 Marionette DEBUG Register listener.js for window 6442450945
10:43:31 INFO - 1500486211505 Marionette TRACE 378 <- [1,1,null,{"sessionId":"15770255-010e-4d48-aeac-efea50e0d268","capabilities":{"browserName":"firefox","browserVersion":"56.0a1","platformName":"windows_nt","platformVersion":"6.2","pageLoadStrategy":"normal","acceptInsecureCerts":false,"timeouts":{"implicit":0,"pageLoad":300000,"script":30000},"rotatable":false,"specificationLevel":0,"moz:processID":3236,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-216.001\\AppData\\Local\\Temp\\tmpqiuwk0.mozrunner","moz:accessibilityChecks":false}}]
10:43:31 INFO - 1500486211508 Marionette TRACE 378 -> [0,2,"setTimeouts",{"script":30000}]
10:43:31 INFO - 1500486211510 Marionette TRACE 378 <- [1,2,null,{}]
10:43:31 INFO - 1500486211511 Marionette TRACE 378 -> [0,3,"setTimeouts",{"pageLoad":300000}]
10:43:31 INFO - 1500486211513 Marionette TRACE 378 <- [1,3,null,{}]
10:43:31 INFO - 1500486211515 Marionette TRACE 378 -> [0,4,"setTimeouts",{"implicit":0}]
10:43:31 INFO - 1500486211516 Marionette TRACE 378 <- [1,4,null,{}]
10:43:31 INFO - 1500486211519 Marionette TRACE 378 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-START: test_click.py TestClick.test_inclusive_descendant')","sandbox":"simpletest","line":316}]
10:43:31 INFO - TEST-START: test_click.py TestClick.test_inclusive_descendant1500486211526 Marionette TRACE 378 <- [1,5,null,{"value":null}]
10:43:31 INFO - 1500486211528 Marionette TRACE 378 -> [0,6,"deleteSession",{}]
10:43:31 INFO - [Parent 3236] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:43:31 INFO - 1500486211533 Marionette TRACE 378 <- [1,6,null,{}]
10:43:31 INFO - [Parent 3236] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:43:31 INFO - 1500486211538 Marionette DEBUG Closed connection 378
10:43:31 INFO - 1500486211540 Marionette DEBUG Accepted connection 379 from 127.0.0.1:49831
10:43:31 INFO - 1500486211542 Marionette DEBUG Closed connection 379
10:43:31 INFO - 1500486211543 Marionette DEBUG Accepted connection 380 from 127.0.0.1:49832
10:43:31 INFO - 1500486211545 Marionette TRACE 380 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
10:43:31 INFO - 1500486211547 Marionette CONFIG Matched capabilities: {"browserName":"firefox","browserVersion":"56.0a1","platformName":"windows_nt","platformVersion":"6.2","pageLoadStrategy":"normal","acceptInsecureCerts":false,"timeouts":{"implicit":0,"pageLoad":300000,"script":30000},"rotatable":false,"specificationLevel":0,"moz:processID":3236,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-216.001\\AppData\\Local\\Temp\\tmpqiuwk0.mozrunner","moz:accessibilityChecks":false}
10:43:31 INFO - 1500486211570 Marionette DEBUG Register listener.js for window 6442450945
10:43:31 INFO - 1500486211581 Marionette TRACE 380 <- [1,1,null,{"sessionId":"468ab0f1-873b-43c2-8734-ea4606882859","capabilities":{"browserName":"firefox","browserVersion":"56.0a1","platformName":"windows_nt","platformVersion":"6.2","pageLoadStrategy":"normal","acceptInsecureCerts":false,"timeouts":{"implicit":0,"pageLoad":300000,"script":30000},"rotatable":false,"specificationLevel":0,"moz:processID":3236,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-216.001\\AppData\\Local\\Temp\\tmpqiuwk0.mozrunner","moz:accessibilityChecks":false}}]
10:43:31 INFO - 1500486211584 Marionette TRACE 380 -> [0,2,"deleteSession",{}]
10:43:31 INFO - [Parent 3236] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:43:31 INFO - 1500486211588 Marionette TRACE 380 <- [1,2,null,{}]
10:43:31 INFO - [Parent 3236] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:43:31 INFO - 1500486211592 Marionette DEBUG Closed connection 380
10:43:31 INFO - 1500486211594 Marionette DEBUG Accepted connection 381 from 127.0.0.1:49833
10:43:31 INFO - 1500486211595 Marionette DEBUG Closed connection 381
10:43:31 INFO - 1500486211596 Marionette DEBUG Accepted connection 382 from 127.0.0.1:49834
10:43:31 INFO - 1500486211598 Marionette TRACE 382 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
10:43:31 INFO - 1500486211601 Marionette CONFIG Matched capabilities: {"browserName":"firefox","browserVersion":"56.0a1","platformName":"windows_nt","platformVersion":"6.2","pageLoadStrategy":"normal","acceptInsecureCerts":false,"timeouts":{"implicit":0,"pageLoad":300000,"script":30000},"rotatable":false,"specificationLevel":1,"moz:processID":3236,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-216.001\\AppData\\Local\\Temp\\tmpqiuwk0.mozrunner","moz:accessibilityChecks":false}
10:43:31 INFO - 1500486211624 Marionette DEBUG Register listener.js for window 6442450945
10:43:31 INFO - 1500486211635 Marionette TRACE 382 <- [1,1,null,{"sessionId":"e98054a7-880e-42f1-b2dc-a35723fb5254","capabilities":{"browserName":"firefox","browserVersion":"56.0a1","platformName":"windows_nt","platformVersion":"6.2","pageLoadStrategy":"normal","acceptInsecureCerts":false,"timeouts":{"implicit":0,"pageLoad":300000,"script":30000},"rotatable":false,"specificationLevel":1,"moz:processID":3236,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-216.001\\AppData\\Local\\Temp\\tmpqiuwk0.mozrunner","moz:accessibilityChecks":false}}]
10:43:31 INFO - 1500486211637 Marionette TRACE 382 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%20multiple%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efirst%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Esecond%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Ethird%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"}]
10:43:31 INFO - 1500486211641 Marionette DEBUG Received DOM event "beforeunload" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cstyle%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%2A%20%7B%20margin%3A%200%3B%20padding%3A%200%3B%20%7D%0A%20%20%20%20%20%20%20%20%20%20%20%20div%20%7B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20display%3A%20block%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20background-color%3A%20blue%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20width%3A%20200px%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20height%3A%20200px%3B%0A%0A%20%20%20%20%20%20%20%20%20%20%20%20%20transform%3A%20translateX%28-105px%29%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%7D%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/style%3E%0A%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cdiv%3E%3C/div%3E"
10:43:31 INFO - 1500486211645 Marionette DEBUG Received DOM event "pagehide" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cstyle%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%2A%20%7B%20margin%3A%200%3B%20padding%3A%200%3B%20%7D%0A%20%20%20%20%20%20%20%20%20%20%20%20div%20%7B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20display%3A%20block%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20background-color%3A%20blue%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20width%3A%20200px%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20height%3A%20200px%3B%0A%0A%20%20%20%20%20%20%20%20%20%20%20%20%20transform%3A%20translateX%28-105px%29%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%7D%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/style%3E%0A%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cdiv%3E%3C/div%3E"
10:43:31 INFO - 1500486211646 Marionette DEBUG Received DOM event "unload" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cstyle%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%2A%20%7B%20margin%3A%200%3B%20padding%3A%200%3B%20%7D%0A%20%20%20%20%20%20%20%20%20%20%20%20div%20%7B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20display%3A%20block%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20background-color%3A%20blue%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20width%3A%20200px%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20height%3A%20200px%3B%0A%0A%20%20%20%20%20%20%20%20%20%20%20%20%20transform%3A%20translateX%28-105px%29%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%7D%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/style%3E%0A%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cdiv%3E%3C/div%3E"
10:43:31 INFO - ++DOMWINDOW == 15 (000000116E14F800) [pid = 3960] [serial = 29] [outer = 00000011630AB800]
10:43:31 INFO - 1500486211668 Marionette DEBUG Received DOM event "DOMContentLoaded" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%20multiple%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efirst%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Esecond%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Ethird%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
10:43:31 INFO - 1500486211675 Marionette DEBUG Received DOM event "pageshow" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%20multiple%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efirst%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Esecond%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Ethird%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
10:43:31 INFO - 1500486211682 Marionette TRACE 382 <- [1,2,null,{}]
10:43:31 INFO - 1500486211690 Marionette TRACE 382 -> [0,3,"findElement",{"using":"tag name","value":"select"}]
10:43:31 INFO - 1500486211700 Marionette TRACE 382 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"cebe4a0b-4d60-4b5e-b9cd-2097a490d252","ELEMENT":"cebe4a0b-4d60-4b5e-b9cd-2097a490d252"}}]
10:43:31 INFO - 1500486211702 Marionette TRACE 382 -> [0,4,"clickElement",{"id":"cebe4a0b-4d60-4b5e-b9cd-2097a490d252"}]
10:43:32 INFO - 1500486212137 Marionette DEBUG Canceled page load listener because no navigation has been detected
10:43:32 INFO - 1500486212139 Marionette TRACE 382 <- [1,4,null,{}]
10:43:32 INFO - 1500486212141 Marionette TRACE 382 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-END: test_click.py TestClick.test_inclusive_descendant')","sandbox":"simpletest","line":328}]
10:43:32 INFO - TEST-END: test_click.py TestClick.test_inclusive_descendant1500486212148 Marionette TRACE 382 <- [1,5,null,{"value":null}]
10:43:32 INFO - 1500486212150 Marionette TRACE 382 -> [0,6,"deleteSession",{}]
10:43:32 INFO - [Parent 3236] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:43:32 INFO - 1500486212154 Marionette TRACE 382 <- [1,6,null,{}]
10:43:32 INFO - TEST-PASS | test_click.py TestClick.test_inclusive_descendant | took 695ms
10:43:32 INFO - TEST-START | test_click.py TestClick.test_input_file
10:43:32 INFO - [Parent 3236] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:43:32 INFO - 1500486212158 Marionette DEBUG Closed connection 382
10:43:32 INFO - 1500486212159 Marionette DEBUG Accepted connection 383 from 127.0.0.1:49835
10:43:32 INFO - 1500486212161 Marionette DEBUG Closed connection 383
10:43:32 INFO - 1500486212162 Marionette DEBUG Accepted connection 384 from 127.0.0.1:49836
10:43:32 INFO - 1500486212164 Marionette TRACE 384 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
10:43:32 INFO - 1500486212166 Marionette CONFIG Matched capabilities: {"browserName":"firefox","browserVersion":"56.0a1","platformName":"windows_nt","platformVersion":"6.2","pageLoadStrategy":"normal","acceptInsecureCerts":false,"timeouts":{"implicit":0,"pageLoad":300000,"script":30000},"rotatable":false,"specificationLevel":0,"moz:processID":3236,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-216.001\\AppData\\Local\\Temp\\tmpqiuwk0.mozrunner","moz:accessibilityChecks":false}
10:43:32 INFO - 1500486212189 Marionette DEBUG Register listener.js for window 6442450945
10:43:32 INFO - 1500486212200 Marionette TRACE 384 <- [1,1,null,{"sessionId":"e47ba852-e54b-4bce-8106-9e116617e4c1","capabilities":{"browserName":"firefox","browserVersion":"56.0a1","platformName":"windows_nt","platformVersion":"6.2","pageLoadStrategy":"normal","acceptInsecureCerts":false,"timeouts":{"implicit":0,"pageLoad":300000,"script":30000},"rotatable":false,"specificationLevel":0,"moz:processID":3236,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-216.001\\AppData\\Local\\Temp\\tmpqiuwk0.mozrunner","moz:accessibilityChecks":false}}]
10:43:32 INFO - 1500486212203 Marionette TRACE 384 -> [0,2,"setTimeouts",{"script":30000}]
10:43:32 INFO - 1500486212204 Marionette TRACE 384 <- [1,2,null,{}]
10:43:32 INFO - 1500486212206 Marionette TRACE 384 -> [0,3,"setTimeouts",{"pageLoad":300000}]
10:43:32 INFO - 1500486212207 Marionette TRACE 384 <- [1,3,null,{}]
10:43:32 INFO - 1500486212209 Marionette TRACE 384 -> [0,4,"setTimeouts",{"implicit":0}]
10:43:32 INFO - 1500486212211 Marionette TRACE 384 <- [1,4,null,{}]
10:43:32 INFO - 1500486212214 Marionette TRACE 384 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-START: test_click.py TestClick.test_input_file')","sandbox":"simpletest","line":316}]
10:43:32 INFO - TEST-START: test_click.py TestClick.test_input_file1500486212221 Marionette TRACE 384 <- [1,5,null,{"value":null}]
10:43:32 INFO - 1500486212223 Marionette TRACE 384 -> [0,6,"deleteSession",{}]
10:43:32 INFO - [Parent 3236] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:43:32 INFO - 1500486212228 Marionette TRACE 384 <- [1,6,null,{}]
10:43:32 INFO - [Parent 3236] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:43:32 INFO - 1500486212232 Marionette DEBUG Closed connection 384
10:43:32 INFO - 1500486212234 Marionette DEBUG Accepted connection 385 from 127.0.0.1:49837
10:43:32 INFO - 1500486212235 Marionette DEBUG Closed connection 385
10:43:32 INFO - 1500486212237 Marionette DEBUG Accepted connection 386 from 127.0.0.1:49838
10:43:32 INFO - 1500486212239 Marionette TRACE 386 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
10:43:32 INFO - 1500486212241 Marionette CONFIG Matched capabilities: {"browserName":"firefox","browserVersion":"56.0a1","platformName":"windows_nt","platformVersion":"6.2","pageLoadStrategy":"normal","acceptInsecureCerts":false,"timeouts":{"implicit":0,"pageLoad":300000,"script":30000},"rotatable":false,"specificationLevel":0,"moz:processID":3236,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-216.001\\AppData\\Local\\Temp\\tmpqiuwk0.mozrunner","moz:accessibilityChecks":false}
10:43:32 INFO - 1500486212264 Marionette DEBUG Register listener.js for window 6442450945
10:43:32 INFO - 1500486212274 Marionette TRACE 386 <- [1,1,null,{"sessionId":"b4359a48-4a6a-465c-b4c8-2d096f9f3d28","capabilities":{"browserName":"firefox","browserVersion":"56.0a1","platformName":"windows_nt","platformVersion":"6.2","pageLoadStrategy":"normal","acceptInsecureCerts":false,"timeouts":{"implicit":0,"pageLoad":300000,"script":30000},"rotatable":false,"specificationLevel":0,"moz:processID":3236,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-216.001\\AppData\\Local\\Temp\\tmpqiuwk0.mozrunner","moz:accessibilityChecks":false}}]
10:43:32 INFO - 1500486212277 Marionette TRACE 386 -> [0,2,"deleteSession",{}]
10:43:32 INFO - [Parent 3236] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:43:32 INFO - 1500486212282 Marionette TRACE 386 <- [1,2,null,{}]
10:43:32 INFO - [Parent 3236] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:43:32 INFO - 1500486212286 Marionette DEBUG Closed connection 386
10:43:32 INFO - 1500486212287 Marionette DEBUG Accepted connection 387 from 127.0.0.1:49839
10:43:32 INFO - 1500486212289 Marionette DEBUG Closed connection 387
10:43:32 INFO - 1500486212290 Marionette DEBUG Accepted connection 388 from 127.0.0.1:49840
10:43:32 INFO - 1500486212292 Marionette TRACE 388 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
10:43:32 INFO - 1500486212295 Marionette CONFIG Matched capabilities: {"browserName":"firefox","browserVersion":"56.0a1","platformName":"windows_nt","platformVersion":"6.2","pageLoadStrategy":"normal","acceptInsecureCerts":false,"timeouts":{"implicit":0,"pageLoad":300000,"script":30000},"rotatable":false,"specificationLevel":1,"moz:processID":3236,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-216.001\\AppData\\Local\\Temp\\tmpqiuwk0.mozrunner","moz:accessibilityChecks":false}
10:43:32 INFO - 1500486212318 Marionette DEBUG Register listener.js for window 6442450945
10:43:32 INFO - 1500486212328 Marionette TRACE 388 <- [1,1,null,{"sessionId":"6aa57cdf-dfe7-43ab-86c5-c510dbf70aff","capabilities":{"browserName":"firefox","browserVersion":"56.0a1","platformName":"windows_nt","platformVersion":"6.2","pageLoadStrategy":"normal","acceptInsecureCerts":false,"timeouts":{"implicit":0,"pageLoad":300000,"script":30000},"rotatable":false,"specificationLevel":1,"moz:processID":3236,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-216.001\\AppData\\Local\\Temp\\tmpqiuwk0.mozrunner","moz:accessibilityChecks":false}}]
10:43:32 INFO - 1500486212331 Marionette TRACE 388 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"}]
10:43:32 INFO - 1500486212346 Marionette DEBUG Received DOM event "beforeunload" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%20multiple%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efirst%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Esecond%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Ethird%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
10:43:32 INFO - 1500486212350 Marionette DEBUG Received DOM event "pagehide" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%20multiple%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efirst%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Esecond%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Ethird%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
10:43:32 INFO - 1500486212351 Marionette DEBUG Received DOM event "unload" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cselect%20multiple%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Efirst%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Esecond%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20%3Coption%3Ethird%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%3C/select%3E"
10:43:32 INFO - ++DOMWINDOW == 16 (000000116BE5E800) [pid = 3960] [serial = 30] [outer = 00000011630AB800]
10:43:32 INFO - 1500486212372 Marionette DEBUG Received DOM event "DOMContentLoaded" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
10:43:32 INFO - 1500486212382 Marionette DEBUG Received DOM event "pageshow" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
10:43:32 INFO - 1500486212386 Marionette TRACE 388 <- [1,2,null,{}]
10:43:32 INFO - 1500486212400 Marionette TRACE 388 -> [0,3,"findElement",{"using":"tag name","value":"input"}]
10:43:32 INFO - 1500486212406 Marionette TRACE 388 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"84944be3-eaa3-4c84-ad40-13703d63c8fb","ELEMENT":"84944be3-eaa3-4c84-ad40-13703d63c8fb"}}]
10:43:32 INFO - 1500486212408 Marionette TRACE 388 -> [0,4,"clickElement",{"id":"84944be3-eaa3-4c84-ad40-13703d63c8fb"}]
10:43:32 INFO - 1500486212554 Marionette TRACE 388 <- [1,4,{"error":"invalid argument","message":"Cannot click
elements","stacktrace":"WebDriverError@chrome://marionette/content/error.js:226:5\nInvalidArgumentError@chrome://marionette/content/error.js:329:5\nwebdriverClickElement@chrome://marionette/content/interaction.js:165:11\nTaskImpl_run@resource://gre/modules/Task.jsm:331:42\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nTaskImpl_handleResultValue@resource://gre/modules/Task.jsm:401:16\nTaskImpl_run@resource://gre/modules/Task.jsm:339:15\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nTaskImpl_handleResultValue@resource://gre/modules/Task.jsm:401:16\nTaskImpl_run@resource://gre/modules/Task.jsm:339:15\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nnavigate@chrome://marionette/content/listener.js:397:12\nclickElement@chrome://marionette/content/listener.js:1317:5\n"},null]
10:43:32 INFO - 1500486212557 Marionette TRACE 388 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-END: test_click.py TestClick.test_input_file')","sandbox":"simpletest","line":328}]
10:43:32 INFO - TEST-END: test_click.py TestClick.test_input_file1500486212564 Marionette TRACE 388 <- [1,5,null,{"value":null}]
10:43:32 INFO - 1500486212566 Marionette TRACE 388 -> [0,6,"deleteSession",{}]
10:43:32 INFO - [Parent 3236] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:43:32 INFO - TEST-PASS | test_click.py TestClick.test_input_file | took 416ms
10:43:32 INFO - TEST-START | test_click.py TestClick.test_obscured_element
10:43:32 INFO - 1500486212570 Marionette TRACE 388 <- [1,6,null,{}]
10:43:32 INFO - [Parent 3236] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:43:32 INFO - 1500486212574 Marionette DEBUG Closed connection 388
10:43:32 INFO - 1500486212576 Marionette DEBUG Accepted connection 389 from 127.0.0.1:49841
10:43:32 INFO - 1500486212577 Marionette DEBUG Closed connection 389
10:43:32 INFO - 1500486212579 Marionette DEBUG Accepted connection 390 from 127.0.0.1:49842
10:43:32 INFO - 1500486212581 Marionette TRACE 390 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
10:43:32 INFO - 1500486212583 Marionette CONFIG Matched capabilities: {"browserName":"firefox","browserVersion":"56.0a1","platformName":"windows_nt","platformVersion":"6.2","pageLoadStrategy":"normal","acceptInsecureCerts":false,"timeouts":{"implicit":0,"pageLoad":300000,"script":30000},"rotatable":false,"specificationLevel":0,"moz:processID":3236,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-216.001\\AppData\\Local\\Temp\\tmpqiuwk0.mozrunner","moz:accessibilityChecks":false}
10:43:33 INFO - 1500486213005 Marionette DEBUG Register listener.js for window 6442450945
10:43:33 INFO - 1500486213016 Marionette TRACE 390 <- [1,1,null,{"sessionId":"2892e51f-f5ea-4d63-81e0-4e2c08e73f54","capabilities":{"browserName":"firefox","browserVersion":"56.0a1","platformName":"windows_nt","platformVersion":"6.2","pageLoadStrategy":"normal","acceptInsecureCerts":false,"timeouts":{"implicit":0,"pageLoad":300000,"script":30000},"rotatable":false,"specificationLevel":0,"moz:processID":3236,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-216.001\\AppData\\Local\\Temp\\tmpqiuwk0.mozrunner","moz:accessibilityChecks":false}}]
10:43:33 INFO - 1500486213019 Marionette TRACE 390 -> [0,2,"setTimeouts",{"script":30000}]
10:43:33 INFO - 1500486213021 Marionette TRACE 390 <- [1,2,null,{}]
10:43:33 INFO - 1500486213023 Marionette TRACE 390 -> [0,3,"setTimeouts",{"pageLoad":300000}]
10:43:33 INFO - 1500486213024 Marionette TRACE 390 <- [1,3,null,{}]
10:43:33 INFO - 1500486213026 Marionette TRACE 390 -> [0,4,"setTimeouts",{"implicit":0}]
10:43:33 INFO - 1500486213028 Marionette TRACE 390 <- [1,4,null,{}]
10:43:33 INFO - 1500486213030 Marionette TRACE 390 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-START: test_click.py TestClick.test_obscured_element')","sandbox":"simpletest","line":316}]
10:43:33 INFO - TEST-START: test_click.py TestClick.test_obscured_element1500486213072 Marionette TRACE 390 <- [1,5,null,{"value":null}]
10:43:33 INFO - 1500486213074 Marionette TRACE 390 -> [0,6,"deleteSession",{}]
10:43:33 INFO - [Parent 3236] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:43:33 INFO - 1500486213078 Marionette TRACE 390 <- [1,6,null,{}]
10:43:33 INFO - [Parent 3236] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:43:33 INFO - 1500486213082 Marionette DEBUG Closed connection 390
10:43:33 INFO - 1500486213084 Marionette DEBUG Accepted connection 391 from 127.0.0.1:49843
10:43:33 INFO - 1500486213086 Marionette DEBUG Closed connection 391
10:43:33 INFO - 1500486213087 Marionette DEBUG Accepted connection 392 from 127.0.0.1:49844
10:43:33 INFO - 1500486213090 Marionette TRACE 392 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
10:43:33 INFO - 1500486213092 Marionette CONFIG Matched capabilities: {"browserName":"firefox","browserVersion":"56.0a1","platformName":"windows_nt","platformVersion":"6.2","pageLoadStrategy":"normal","acceptInsecureCerts":false,"timeouts":{"implicit":0,"pageLoad":300000,"script":30000},"rotatable":false,"specificationLevel":0,"moz:processID":3236,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-216.001\\AppData\\Local\\Temp\\tmpqiuwk0.mozrunner","moz:accessibilityChecks":false}
10:43:33 INFO - 1500486213128 Marionette DEBUG Register listener.js for window 6442450945
10:43:33 INFO - 1500486213151 Marionette TRACE 392 <- [1,1,null,{"sessionId":"1f588601-672a-46ed-a574-58c858804d5d","capabilities":{"browserName":"firefox","browserVersion":"56.0a1","platformName":"windows_nt","platformVersion":"6.2","pageLoadStrategy":"normal","acceptInsecureCerts":false,"timeouts":{"implicit":0,"pageLoad":300000,"script":30000},"rotatable":false,"specificationLevel":0,"moz:processID":3236,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-216.001\\AppData\\Local\\Temp\\tmpqiuwk0.mozrunner","moz:accessibilityChecks":false}}]
10:43:33 INFO - 1500486213154 Marionette TRACE 392 -> [0,2,"deleteSession",{}]
10:43:33 INFO - [Parent 3236] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:43:33 INFO - 1500486213158 Marionette TRACE 392 <- [1,2,null,{}]
10:43:33 INFO - [Parent 3236] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:43:33 INFO - 1500486213162 Marionette DEBUG Closed connection 392
10:43:33 INFO - 1500486213163 Marionette DEBUG Accepted connection 393 from 127.0.0.1:49845
10:43:33 INFO - 1500486213165 Marionette DEBUG Closed connection 393
10:43:33 INFO - 1500486213166 Marionette DEBUG Accepted connection 394 from 127.0.0.1:49846
10:43:33 INFO - 1500486213168 Marionette TRACE 394 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
10:43:33 INFO - 1500486213171 Marionette CONFIG Matched capabilities: {"browserName":"firefox","browserVersion":"56.0a1","platformName":"windows_nt","platformVersion":"6.2","pageLoadStrategy":"normal","acceptInsecureCerts":false,"timeouts":{"implicit":0,"pageLoad":300000,"script":30000},"rotatable":false,"specificationLevel":1,"moz:processID":3236,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-216.001\\AppData\\Local\\Temp\\tmpqiuwk0.mozrunner","moz:accessibilityChecks":false}
10:43:33 INFO - 1500486213194 Marionette DEBUG Register listener.js for window 6442450945
10:43:33 INFO - 1500486213205 Marionette TRACE 394 <- [1,1,null,{"sessionId":"b92ad058-bca5-4277-bf5f-ed6f47ddda2b","capabilities":{"browserName":"firefox","browserVersion":"56.0a1","platformName":"windows_nt","platformVersion":"6.2","pageLoadStrategy":"normal","acceptInsecureCerts":false,"timeouts":{"implicit":0,"pageLoad":300000,"script":30000},"rotatable":false,"specificationLevel":1,"moz:processID":3236,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-216.001\\AppData\\Local\\Temp\\tmpqiuwk0.mozrunner","moz:accessibilityChecks":false}}]
10:43:33 INFO - 1500486213208 Marionette TRACE 394 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%0A%3Cstyle%3E%0A%2A%20%7B%20margin%3A%200%3B%20padding%3A%200%3B%20%7D%0Abody%20%7B%20height%3A%20100vh%20%7D%0A%23overlay%20%7B%0A%20%20background-color%3A%20pink%3B%0A%20%20position%3A%20absolute%3B%0A%20%20width%3A%20100%25%3B%0A%20%20height%3A%20100%25%3B%0A%7D%0A%3C/style%3E%0A%0A%3Cdiv%20id%3Doverlay%3E%3C/div%3E%0A%3Ca%20id%3Dobscured%20href%3D%23%3Elink%3C/a%3E%0A%0A%3Cscript%3E%0Awindow.clicked%20%3D%20false%3B%0A%0Alet%20link%20%3D%20document.querySelector%28%22%23obscured%22%29%3B%0Alink.addEventListener%28%22click%22%2C%20%28%29%20%3D%3E%20window.clicked%20%3D%20true%29%3B%0A%3C/script%3E%0A"}]
10:43:33 INFO - 1500486213212 Marionette DEBUG Received DOM event "beforeunload" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
10:43:33 INFO - 1500486213216 Marionette DEBUG Received DOM event "pagehide" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
10:43:33 INFO - 1500486213217 Marionette DEBUG Received DOM event "unload" for "data:text/html;charset=utf-8,%3Cinput%20type%3Dfile%3E"
10:43:33 INFO - ++DOMWINDOW == 17 (000000116E012000) [pid = 3960] [serial = 31] [outer = 00000011630AB800]
10:43:33 INFO - 1500486213239 Marionette DEBUG Received DOM event "DOMContentLoaded" for "data:text/html;charset=utf-8,%0A%3Cstyle%3E%0A%2A%20%7B%20margin%3A%200%3B%20padding%3A%200%3B%20%7D%0Abody%20%7B%20height%3A%20100vh%20%7D%0A%23overlay%20%7B%0A%20%20background-color%3A%20pink%3B%0A%20%20position%3A%20absolute%3B%0A%20%20width%3A%20100%25%3B%0A%20%20height%3A%20100%25%3B%0A%7D%0A%3C/style%3E%0A%0A%3Cdiv%20id%3Doverlay%3E%3C/div%3E%0A%3Ca%20id%3Dobscured%20href%3D%23%3Elink%3C/a%3E%0A%0A%3Cscript%3E%0Awindow.clicked%20%3D%20false%3B%0A%0Alet%20link%20%3D%20document.querySelector%28%22%23obscured%22%29%3B%0Alink.addEventListener%28%22click%22%2C%20%28%29%20%3D%3E%20window.clicked%20%3D%20true%29%3B%0A%3C/script%3E%0A"
10:43:33 INFO - 1500486213246 Marionette DEBUG Received DOM event "pageshow" for "data:text/html;charset=utf-8,%0A%3Cstyle%3E%0A%2A%20%7B%20margin%3A%200%3B%20padding%3A%200%3B%20%7D%0Abody%20%7B%20height%3A%20100vh%20%7D%0A%23overlay%20%7B%0A%20%20background-color%3A%20pink%3B%0A%20%20position%3A%20absolute%3B%0A%20%20width%3A%20100%25%3B%0A%20%20height%3A%20100%25%3B%0A%7D%0A%3C/style%3E%0A%0A%3Cdiv%20id%3Doverlay%3E%3C/div%3E%0A%3Ca%20id%3Dobscured%20href%3D%23%3Elink%3C/a%3E%0A%0A%3Cscript%3E%0Awindow.clicked%20%3D%20false%3B%0A%0Alet%20link%20%3D%20document.querySelector%28%22%23obscured%22%29%3B%0Alink.addEventListener%28%22click%22%2C%20%28%29%20%3D%3E%20window.clicked%20%3D%20true%29%3B%0A%3C/script%3E%0A"
10:43:33 INFO - 1500486213252 Marionette TRACE 394 <- [1,2,null,{}]
10:43:33 INFO - 1500486213266 Marionette TRACE 394 -> [0,3,"findElement",{"using":"id","value":"overlay"}]
10:43:33 INFO - 1500486213272 Marionette TRACE 394 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"f9d4531d-d322-4649-8367-c31cb1ec31e9","ELEMENT":"f9d4531d-d322-4649-8367-c31cb1ec31e9"}}]
10:43:33 INFO - 1500486213274 Marionette TRACE 394 -> [0,4,"findElement",{"using":"id","value":"obscured"}]
10:43:33 INFO - 1500486213280 Marionette TRACE 394 <- [1,4,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"b1af6dc6-d7bc-4db6-bf1f-cf00728829a1","ELEMENT":"b1af6dc6-d7bc-4db6-bf1f-cf00728829a1"}}]
10:43:33 INFO - 1500486213281 Marionette TRACE 394 -> [0,5,"clickElement",{"id":"f9d4531d-d322-4649-8367-c31cb1ec31e9"}]
10:43:33 INFO - 1500486213707 Marionette DEBUG Canceled page load listener because no navigation has been detected
10:43:33 INFO - 1500486213709 Marionette TRACE 394 <- [1,5,null,{}]
10:43:33 INFO - 1500486213711 Marionette TRACE 394 -> [0,6,"clickElement",{"id":"b1af6dc6-d7bc-4db6-bf1f-cf00728829a1"}]
10:43:33 INFO - 1500486213839 Marionette TRACE 394 <- [1,6,{"error":"element click intercepted","message":"Element
is not clickable at point (12.449996948242188,10) because another element obscures it","stacktrace":"WebDriverError@chrome://marionette/content/error.js:226:5\nElementClickInterceptedError@chrome://marionette/content/error.js:308:5\nwebdriverClickElement@chrome://marionette/content/interaction.js:192:11\nTaskImpl_run@resource://gre/modules/Task.jsm:331:42\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nTaskImpl_handleResultValue@resource://gre/modules/Task.jsm:401:16\nTaskImpl_run@resource://gre/modules/Task.jsm:339:15\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nTaskImpl_handleResultValue@resource://gre/modules/Task.jsm:401:16\nTaskImpl_run@resource://gre/modules/Task.jsm:339:15\nTaskImpl@resource://gre/modules/Task.jsm:280:3\nasyncFunction@resource://gre/modules/Task.jsm:252:14\nTask_spawn@resource://gre/modules/Task.jsm:166:12\nnavigate@chrome://marionette/content/listener.js:397:12\nclickElement@chrome://marionette/content/listener.js:1317:5\n"},null]
10:43:33 INFO - 1500486213841 Marionette TRACE 394 -> [0,7,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"test_click.py","script":"return window.clicked","sandbox":null,"line":259}]
10:43:33 INFO - 1500486213856 Marionette TRACE 394 <- [1,7,null,{"value":false}]
10:43:33 INFO - 1500486213859 Marionette TRACE 394 -> [0,8,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-END: test_click.py TestClick.test_obscured_element')","sandbox":"simpletest","line":328}]
10:43:33 INFO - TEST-END: test_click.py TestClick.test_obscured_element1500486213866 Marionette TRACE 394 <- [1,8,null,{"value":null}]
10:43:33 INFO - 1500486213868 Marionette TRACE 394 -> [0,9,"deleteSession",{}]
10:43:33 INFO - [Parent 3236] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:43:33 INFO - 1500486213872 Marionette TRACE 394 <- [1,9,null,{}]
10:43:33 INFO - TEST-PASS | test_click.py TestClick.test_obscured_element | took 1301ms
10:43:33 INFO - TEST-START | test_click.py TestClick.test_pointer_events_none
10:43:33 INFO - [Parent 3236] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:43:33 INFO - 1500486213876 Marionette DEBUG Closed connection 394
10:43:33 INFO - 1500486213877 Marionette DEBUG Accepted connection 395 from 127.0.0.1:49847
10:43:33 INFO - 1500486213879 Marionette DEBUG Closed connection 395
10:43:33 INFO - 1500486213880 Marionette DEBUG Accepted connection 396 from 127.0.0.1:49848
10:43:33 INFO - 1500486213883 Marionette TRACE 396 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
10:43:33 INFO - 1500486213885 Marionette CONFIG Matched capabilities: {"browserName":"firefox","browserVersion":"56.0a1","platformName":"windows_nt","platformVersion":"6.2","pageLoadStrategy":"normal","acceptInsecureCerts":false,"timeouts":{"implicit":0,"pageLoad":300000,"script":30000},"rotatable":false,"specificationLevel":0,"moz:processID":3236,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-216.001\\AppData\\Local\\Temp\\tmpqiuwk0.mozrunner","moz:accessibilityChecks":false}
10:43:33 INFO - 1500486213908 Marionette DEBUG Register listener.js for window 6442450945
10:43:33 INFO - 1500486213919 Marionette TRACE 396 <- [1,1,null,{"sessionId":"a874ba40-e9a8-42f2-a8f0-f588230510f0","capabilities":{"browserName":"firefox","browserVersion":"56.0a1","platformName":"windows_nt","platformVersion":"6.2","pageLoadStrategy":"normal","acceptInsecureCerts":false,"timeouts":{"implicit":0,"pageLoad":300000,"script":30000},"rotatable":false,"specificationLevel":0,"moz:processID":3236,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-216.001\\AppData\\Local\\Temp\\tmpqiuwk0.mozrunner","moz:accessibilityChecks":false}}]
10:43:33 INFO - 1500486213921 Marionette TRACE 396 -> [0,2,"setTimeouts",{"script":30000}]
10:43:33 INFO - 1500486213923 Marionette TRACE 396 <- [1,2,null,{}]
10:43:33 INFO - 1500486213925 Marionette TRACE 396 -> [0,3,"setTimeouts",{"pageLoad":300000}]
10:43:33 INFO - 1500486213927 Marionette TRACE 396 <- [1,3,null,{}]
10:43:33 INFO - 1500486213928 Marionette TRACE 396 -> [0,4,"setTimeouts",{"implicit":0}]
10:43:33 INFO - 1500486213930 Marionette TRACE 396 <- [1,4,null,{}]
10:43:33 INFO - 1500486213932 Marionette TRACE 396 -> [0,5,"executeScript",{"scriptTimeout":null,"newSandbox":true,"args":[],"filename":"testcases.py","script":"dump('TEST-START: test_click.py TestClick.test_pointer_events_none')","sandbox":"simpletest","line":316}]
10:43:33 INFO - TEST-START: test_click.py TestClick.test_pointer_events_none1500486213939 Marionette TRACE 396 <- [1,5,null,{"value":null}]
10:43:33 INFO - 1500486213941 Marionette TRACE 396 -> [0,6,"deleteSession",{}]
10:43:33 INFO - [Parent 3236] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:43:33 INFO - 1500486213945 Marionette TRACE 396 <- [1,6,null,{}]
10:43:33 INFO - [Parent 3236] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:43:33 INFO - 1500486213949 Marionette DEBUG Closed connection 396
10:43:33 INFO - 1500486213951 Marionette DEBUG Accepted connection 397 from 127.0.0.1:49849
10:43:33 INFO - 1500486213952 Marionette DEBUG Closed connection 397
10:43:33 INFO - 1500486213953 Marionette DEBUG Accepted connection 398 from 127.0.0.1:49850
10:43:33 INFO - 1500486213956 Marionette TRACE 398 -> [0,1,"newSession",{"sessionId":null,"capabilities":null}]
10:43:33 INFO - 1500486213957 Marionette CONFIG Matched capabilities: {"browserName":"firefox","browserVersion":"56.0a1","platformName":"windows_nt","platformVersion":"6.2","pageLoadStrategy":"normal","acceptInsecureCerts":false,"timeouts":{"implicit":0,"pageLoad":300000,"script":30000},"rotatable":false,"specificationLevel":0,"moz:processID":3236,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-216.001\\AppData\\Local\\Temp\\tmpqiuwk0.mozrunner","moz:accessibilityChecks":false}
10:43:33 INFO - 1500486213981 Marionette DEBUG Register listener.js for window 6442450945
10:43:34 INFO - 1500486213991 Marionette TRACE 398 <- [1,1,null,{"sessionId":"9bafedbe-f826-406c-af91-0d36b6e68c56","capabilities":{"browserName":"firefox","browserVersion":"56.0a1","platformName":"windows_nt","platformVersion":"6.2","pageLoadStrategy":"normal","acceptInsecureCerts":false,"timeouts":{"implicit":0,"pageLoad":300000,"script":30000},"rotatable":false,"specificationLevel":0,"moz:processID":3236,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-216.001\\AppData\\Local\\Temp\\tmpqiuwk0.mozrunner","moz:accessibilityChecks":false}}]
10:43:34 INFO - 1500486213994 Marionette TRACE 398 -> [0,2,"deleteSession",{}]
10:43:34 INFO - [Parent 3236] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:43:34 INFO - 1500486213998 Marionette TRACE 398 <- [1,2,null,{}]
10:43:34 INFO - [Parent 3236] WARNING: NS_ENSURE_TRUE(weak) failed: file c:/builds/moz2_slave/m-cen-w64-d-000000000000000000/build/src/dom/base/nsFrameMessageManager.cpp, line 343
10:43:34 INFO - 1500486214002 Marionette DEBUG Closed connection 398
10:43:34 INFO - 1500486214004 Marionette DEBUG Accepted connection 399 from 127.0.0.1:49851
10:43:34 INFO - 1500486214006 Marionette DEBUG Closed connection 399
10:43:34 INFO - 1500486214008 Marionette DEBUG Accepted connection 400 from 127.0.0.1:49852
10:43:34 INFO - 1500486214010 Marionette TRACE 400 -> [0,1,"newSession",{"sessionId":null,"capabilities":{"requiredCapabilities":{"specificationLevel":1}}}]
10:43:34 INFO - 1500486214012 Marionette CONFIG Matched capabilities: {"browserName":"firefox","browserVersion":"56.0a1","platformName":"windows_nt","platformVersion":"6.2","pageLoadStrategy":"normal","acceptInsecureCerts":false,"timeouts":{"implicit":0,"pageLoad":300000,"script":30000},"rotatable":false,"specificationLevel":1,"moz:processID":3236,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-216.001\\AppData\\Local\\Temp\\tmpqiuwk0.mozrunner","moz:accessibilityChecks":false}
10:43:34 INFO - 1500486214037 Marionette DEBUG Register listener.js for window 6442450945
10:43:34 INFO - 1500486214047 Marionette TRACE 400 <- [1,1,null,{"sessionId":"638097b1-9813-43d9-b6c9-36c673e5508a","capabilities":{"browserName":"firefox","browserVersion":"56.0a1","platformName":"windows_nt","platformVersion":"6.2","pageLoadStrategy":"normal","acceptInsecureCerts":false,"timeouts":{"implicit":0,"pageLoad":300000,"script":30000},"rotatable":false,"specificationLevel":1,"moz:processID":3236,"moz:profile":"C:\\Users\\cltbld.T-W864-IX-216.001\\AppData\\Local\\Temp\\tmpqiuwk0.mozrunner","moz:accessibilityChecks":false}}]
10:43:34 INFO - 1500486214050 Marionette TRACE 400 -> [0,2,"get",{"url":"data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cbutton%20style%3D%22pointer-events%3A%20none%22%3Eclick%20me%3C/button%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cscript%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20window.clicked%20%3D%20false%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20let%20button%20%3D%20document.querySelector%28%22button%22%29%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20button.addEventListener%28%22click%22%2C%20%28%29%20%3D%3E%20window.clicked%20%3D%20true%29%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/script%3E%0A%20%20%20%20%20%20%20%20"}]
10:43:34 INFO - 1500486214054 Marionette DEBUG Received DOM event "beforeunload" for "data:text/html;charset=utf-8,%0A%3Cstyle%3E%0A%2A%20%7B%20margin%3A%200%3B%20padding%3A%200%3B%20%7D%0Abody%20%7B%20height%3A%20100vh%20%7D%0A%23overlay%20%7B%0A%20%20background-color%3A%20pink%3B%0A%20%20position%3A%20absolute%3B%0A%20%20width%3A%20100%25%3B%0A%20%20height%3A%20100%25%3B%0A%7D%0A%3C/style%3E%0A%0A%3Cdiv%20id%3Doverlay%3E%3C/div%3E%0A%3Ca%20id%3Dobscured%20href%3D%23%3Elink%3C/a%3E%0A%0A%3Cscript%3E%0Awindow.clicked%20%3D%20false%3B%0A%0Alet%20link%20%3D%20document.querySelector%28%22%23obscured%22%29%3B%0Alink.addEventListener%28%22click%22%2C%20%28%29%20%3D%3E%20window.clicked%20%3D%20true%29%3B%0A%3C/script%3E%0A"
10:43:34 INFO - 1500486214059 Marionette DEBUG Received DOM event "pagehide" for "data:text/html;charset=utf-8,%0A%3Cstyle%3E%0A%2A%20%7B%20margin%3A%200%3B%20padding%3A%200%3B%20%7D%0Abody%20%7B%20height%3A%20100vh%20%7D%0A%23overlay%20%7B%0A%20%20background-color%3A%20pink%3B%0A%20%20position%3A%20absolute%3B%0A%20%20width%3A%20100%25%3B%0A%20%20height%3A%20100%25%3B%0A%7D%0A%3C/style%3E%0A%0A%3Cdiv%20id%3Doverlay%3E%3C/div%3E%0A%3Ca%20id%3Dobscured%20href%3D%23%3Elink%3C/a%3E%0A%0A%3Cscript%3E%0Awindow.clicked%20%3D%20false%3B%0A%0Alet%20link%20%3D%20document.querySelector%28%22%23obscured%22%29%3B%0Alink.addEventListener%28%22click%22%2C%20%28%29%20%3D%3E%20window.clicked%20%3D%20true%29%3B%0A%3C/script%3E%0A"
10:43:34 INFO - 1500486214060 Marionette DEBUG Received DOM event "unload" for "data:text/html;charset=utf-8,%0A%3Cstyle%3E%0A%2A%20%7B%20margin%3A%200%3B%20padding%3A%200%3B%20%7D%0Abody%20%7B%20height%3A%20100vh%20%7D%0A%23overlay%20%7B%0A%20%20background-color%3A%20pink%3B%0A%20%20position%3A%20absolute%3B%0A%20%20width%3A%20100%25%3B%0A%20%20height%3A%20100%25%3B%0A%7D%0A%3C/style%3E%0A%0A%3Cdiv%20id%3Doverlay%3E%3C/div%3E%0A%3Ca%20id%3Dobscured%20href%3D%23%3Elink%3C/a%3E%0A%0A%3Cscript%3E%0Awindow.clicked%20%3D%20false%3B%0A%0Alet%20link%20%3D%20document.querySelector%28%22%23obscured%22%29%3B%0Alink.addEventListener%28%22click%22%2C%20%28%29%20%3D%3E%20window.clicked%20%3D%20true%29%3B%0A%3C/script%3E%0A"
10:43:34 INFO - ++DOMWINDOW == 18 (000000116FDCC800) [pid = 3960] [serial = 32] [outer = 00000011630AB800]
10:43:34 INFO - 1500486214082 Marionette DEBUG Received DOM event "DOMContentLoaded" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cbutton%20style%3D%22pointer-events%3A%20none%22%3Eclick%20me%3C/button%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cscript%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20window.clicked%20%3D%20false%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20let%20button%20%3D%20document.querySelector%28%22button%22%29%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20button.addEventListener%28%22click%22%2C%20%28%29%20%3D%3E%20window.clicked%20%3D%20true%29%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/script%3E%0A%20%20%20%20%20%20%20%20"
10:43:34 INFO - 1500486214096 Marionette DEBUG Received DOM event "pageshow" for "data:text/html;charset=utf-8,%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cbutton%20style%3D%22pointer-events%3A%20none%22%3Eclick%20me%3C/button%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%3Cscript%3E%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20window.clicked%20%3D%20false%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20let%20button%20%3D%20document.querySelector%28%22button%22%29%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%20%20button.addEventListener%28%22click%22%2C%20%28%29%20%3D%3E%20window.clicked%20%3D%20true%29%3B%0A%20%20%20%20%20%20%20%20%20%20%20%20%3C/script%3E%0A%20%20%20%20%20%20%20%20"
10:43:34 INFO - 1500486214098 Marionette TRACE 400 <- [1,2,null,{}]
10:43:34 INFO - 1500486214105 Marionette TRACE 400 -> [0,3,"findElement",{"using":"tag name","value":"button"}]
10:43:34 INFO - 1500486214124 Marionette TRACE 400 <- [1,3,null,{"value":{"element-6066-11e4-a52e-4f735466cecf":"0a1bebbd-a26b-48cf-bc99-885b41a596cf","ELEMENT":"0a1bebbd-a26b-48cf-bc99-885b41a596cf"}}]
10:43:34 INFO - 1500486214126 Marionette TRACE 400 -> [0,4,"getElementValueOfCssProperty",{"propertyName":"pointer-events","id":"0a1bebbd-a26b-48cf-bc99-885b41a596cf"}]
10:43:34 INFO - 1500486214245 Marionette TRACE 400 <- [1,4,null,{"value":"none"}]
10:43:34 INFO - 1500486214247 Marionette TRACE 400 -> [0,5,"clickElement",{"id":"0a1bebbd-a26b-48cf-bc99-885b41a596cf"}]
10:43:34 INFO - 1500486214375 Marionette TRACE 400 <- [1,5,{"error":"element click intercepted","message":"Element