Closed Bug 1587097 Opened 5 years ago Closed 5 years ago

Intermittent testing/marionette/harness/marionette_harness/tests/unit/test_screenshot.py TestScreenCaptureChrome.test_capture_full_area | AssertionError: [truncated]... != [truncated]...

Categories

(Testing :: Marionette Client and Harness, defect, P5)

Product:
Testing
Component:
Marionette Client and Harness
Version:
Version 3
Type:
defect

Tracking

(Not tracked)

Status:
RESOLVED DUPLICATE of bug 1364762

People

(Reporter: intermittent-bug-filer, Unassigned)

Details

(Keywords: intermittent-failure)

Filed by: apavel [at] mozilla.com
Parsed log: https://treeherder.mozilla.org/logviewer.html#?job_id=270268575&repo=try
Full log: https://queue.taskcluster.net/v1/task/ZL6jgYMmSBeifFbaAcqvsg/runs/0/artifacts/public/logs/live_backing.log

[task 2019-10-08T12:03:34.834Z] 12:03:34 INFO - TEST-START | testing/marionette/harness/marionette_harness/tests/unit/test_screenshot.py TestScreenCaptureChrome.test_capture_full_area
[task 2019-10-08T12:03:34.834Z] 12:03:34 INFO - 1570536214826 Marionette DEBUG 112 <- [1,39,null,{"value":null}]
[task 2019-10-08T12:03:34.835Z] 12:03:34 INFO - 1570536214829 Marionette DEBUG Accepted connection 113 from 127.0.0.1:34116
[task 2019-10-08T12:03:34.835Z] 12:03:34 INFO - 1570536214830 Marionette DEBUG Closed connection 112
[task 2019-10-08T12:03:34.836Z] 12:03:34 INFO - 1570536214832 Marionette DEBUG 113 -> [0,1,"WebDriver:NewSession",{"strictFileInteractability":true}]
[task 2019-10-08T12:03:34.837Z] 12:03:34 INFO - 1570536214833 Marionette TRACE [282] Frame script loaded
[task 2019-10-08T12:03:34.838Z] 12:03:34 INFO - 1570536214835 Marionette TRACE [282] Frame script registered
[task 2019-10-08T12:03:34.838Z] 12:03:34 INFO - 1570536214836 Marionette DEBUG 113 <- [1,1,null,{"sessionId":"9289100b-472b-47a4-9aed-726dbe5b61f5","capabilities":{"browserName":"firefox","browserVersion":"71.0" ... mp/tmpd4c5kb.mozrunner","moz:shutdownTimeout":60000,"moz:useNonSpecCompliantPointerOrigin":false,"moz:webdriverClick":true}}]
[task 2019-10-08T12:03:34.839Z] 12:03:34 INFO - 1570536214837 Marionette DEBUG 113 -> [0,2,"WebDriver:SetTimeouts",{"script":30000}]
[task 2019-10-08T12:03:34.840Z] 12:03:34 INFO - 1570536214837 Marionette DEBUG 113 <- [1,2,null,{"value":null}]
[task 2019-10-08T12:03:34.840Z] 12:03:34 INFO - 1570536214838 Marionette DEBUG 113 -> [0,3,"WebDriver:SetTimeouts",{"pageLoad":300000}]
[task 2019-10-08T12:03:34.841Z] 12:03:34 INFO - 1570536214838 Marionette DEBUG 113 <- [1,3,null,{"value":null}]
[task 2019-10-08T12:03:34.841Z] 12:03:34 INFO - 1570536214839 Marionette DEBUG 113 -> [0,4,"WebDriver:SetTimeouts",{"implicit":0}]
[task 2019-10-08T12:03:34.842Z] 12:03:34 INFO - 1570536214839 Marionette DEBUG 113 <- [1,4,null,{"value":null}]
[task 2019-10-08T12:03:34.842Z] 12:03:34 INFO - 1570536214840 Marionette DEBUG 113 -> [0,5,"WebDriver:Navigate",{"url":"about:blank"}]
[task 2019-10-08T12:03:34.846Z] 12:03:34 INFO - 1570536214843 Marionette TRACE [282] Received DOM event beforeunload for about:blank
[task 2019-10-08T12:03:34.847Z] 12:03:34 INFO - 1570536214844 Marionette TRACE [282] Received DOM event pagehide for about:blank
[task 2019-10-08T12:03:34.848Z] 12:03:34 INFO - 1570536214847 Marionette TRACE [282] Received DOM event DOMContentLoaded for about:blank
[task 2019-10-08T12:03:34.858Z] 12:03:34 INFO - 1570536214851 Marionette TRACE [282] Received DOM event pageshow for about:blank
[task 2019-10-08T12:03:34.859Z] 12:03:34 INFO - 1570536214852 Marionette DEBUG 113 <- [1,5,null,{"value":null}]
[task 2019-10-08T12:03:34.859Z] 12:03:34 INFO - 1570536214853 Marionette DEBUG 113 -> [0,6,"WebDriver:GetChromeWindowHandle",{}]
[task 2019-10-08T12:03:34.860Z] 12:03:34 INFO - 1570536214854 Marionette DEBUG 113 <- [1,6,null,{"value":"1"}]
[task 2019-10-08T12:03:34.860Z] 12:03:34 INFO - 1570536214855 Marionette DEBUG 113 -> [0,7,"WebDriver:GetChromeWindowHandles",{}]
[task 2019-10-08T12:03:34.862Z] 12:03:34 INFO - 1570536214855 Marionette DEBUG 113 <- [1,7,null,["1"]]
[task 2019-10-08T12:03:34.862Z] 12:03:34 INFO - 1570536214857 Marionette DEBUG 113 -> [0,8,"WebDriver:GetWindowHandle",{}]
[task 2019-10-08T12:03:34.863Z] 12:03:34 INFO - 1570536214857 Marionette DEBUG 113 <- [1,8,null,{"value":"282"}]
[task 2019-10-08T12:03:34.864Z] 12:03:34 INFO - 1570536214858 Marionette DEBUG 113 -> [0,9,"WebDriver:GetWindowHandles",{}]
[task 2019-10-08T12:03:34.869Z] 12:03:34 INFO - 1570536214858 Marionette DEBUG 113 <- [1,9,null,["282"]]
[task 2019-10-08T12:03:34.869Z] 12:03:34 INFO - 1570536214859 Marionette DEBUG 113 -> [0,10,"Marionette:SetContext",{"value":"chrome"}]
[task 2019-10-08T12:03:34.870Z] 12:03:34 INFO - 1570536214859 Marionette DEBUG 113 <- [1,10,null,{"value":null}]
[task 2019-10-08T12:03:34.871Z] 12:03:34 INFO - 1570536214860 Marionette DEBUG 113 -> [0,11,"Marionette:GetContext",{}]
[task 2019-10-08T12:03:34.871Z] 12:03:34 INFO - 1570536214860 Marionette DEBUG 113 <- [1,11,null,{"value":"chrome"}]
[task 2019-10-08T12:03:34.872Z] 12:03:34 INFO - 1570536214860 Marionette DEBUG 113 -> [0,12,"Marionette:SetContext",{"value":"chrome"}]
[task 2019-10-08T12:03:34.873Z] 12:03:34 INFO - 1570536214861 Marionette DEBUG 113 <- [1,12,null,{"value":null}]
[task 2019-10-08T12:03:34.873Z] 12:03:34 INFO - 1570536214861 Marionette DEBUG 113 -> [0,13,"WebDriver:GetChromeWindowHandles",{}]
[task 2019-10-08T12:03:34.873Z] 12:03:34 INFO - 1570536214861 Marionette DEBUG 113 <- [1,13,null,["1"]]
[task 2019-10-08T12:03:34.874Z] 12:03:34 INFO - 1570536214862 Marionette DEBUG 113 -> [0,14,"WebDriver:GetWindowHandles",{}]
[task 2019-10-08T12:03:34.874Z] 12:03:34 INFO - 1570536214862 Marionette DEBUG 113 <- [1,14,null,["282"]]
[task 2019-10-08T12:03:34.874Z] 12:03:34 INFO - 1570536214863 Marionette DEBUG 113 -> [0,15,"Marionette:GetContext",{}]
[task 2019-10-08T12:03:34.875Z] 12:03:34 INFO - 1570536214863 Marionette DEBUG 113 <- [1,15,null,{"value":"chrome"}]
[task 2019-10-08T12:03:34.875Z] 12:03:34 INFO - 1570536214864 Marionette DEBUG 113 -> [0,16,"Marionette:SetContext",{"value":"chrome"}]
[task 2019-10-08T12:03:34.875Z] 12:03:34 INFO - 1570536214864 Marionette DEBUG 113 <- [1,16,null,{"value":null}]
[task 2019-10-08T12:03:34.876Z] 12:03:34 INFO - 1570536214866 Marionette DEBUG 113 -> [0,17,"WebDriver:ExecuteAsyncScript",{"scriptTimeout":null,"newSandbox":true,"args":["chrome://marionette/content/test_dialog ... }\n\n resolve(win.windowUtils.outerWindowID);\n })();","sandbox":"default","line":179}]
[task 2019-10-08T12:03:34.892Z] 12:03:34 INFO - 1570536214877 Marionette TRACE Received observer notification toplevel-window-ready
[task 2019-10-08T12:03:34.893Z] 12:03:34 INFO - ** Received DOM event activate for [object ChromeWindow]
[task 2019-10-08T12:03:34.893Z] 12:03:34 INFO - ** Received DOM event focus for [object HTMLDocument]
[task 2019-10-08T12:03:34.902Z] 12:03:34 INFO - ** Received DOM event activate for [object ChromeWindow]
[task 2019-10-08T12:03:34.903Z] 12:03:34 INFO - ** Received DOM event focus for [object HTMLDocument]
[task 2019-10-08T12:03:34.903Z] 12:03:34 INFO - 1570536214891 Marionette DEBUG 113 <- [1,17,null,{"value":390}]
[task 2019-10-08T12:03:34.907Z] 12:03:34 INFO - 1570536214905 Marionette DEBUG 113 -> [0,18,"Marionette:SetContext",{"value":"chrome"}]
[task 2019-10-08T12:03:34.908Z] 12:03:34 INFO - 1570536214905 Marionette DEBUG 113 <- [1,18,null,{"value":null}]
[task 2019-10-08T12:03:34.929Z] 12:03:34 INFO - 1570536214928 Marionette DEBUG 113 -> [0,19,"WebDriver:GetChromeWindowHandles",{}]
[task 2019-10-08T12:03:34.931Z] 12:03:34 INFO - 1570536214928 Marionette DEBUG 113 <- [1,19,null,["1","390"]]
[task 2019-10-08T12:03:34.932Z] 12:03:34 INFO - 1570536214929 Marionette DEBUG 113 -> [0,20,"WebDriver:GetChromeWindowHandles",{}]
[task 2019-10-08T12:03:34.933Z] 12:03:34 INFO - 1570536214929 Marionette DEBUG 113 <- [1,20,null,["1","390"]]
[task 2019-10-08T12:03:34.933Z] 12:03:34 INFO - 1570536214930 Marionette DEBUG 113 -> [0,21,"Marionette:GetContext",{}]
[task 2019-10-08T12:03:34.934Z] 12:03:34 INFO - 1570536214930 Marionette DEBUG 113 <- [1,21,null,{"value":"chrome"}]
[task 2019-10-08T12:03:34.935Z] 12:03:34 INFO - 1570536214930 Marionette DEBUG 113 -> [0,22,"Marionette:SetContext",{"value":"chrome"}]
[task 2019-10-08T12:03:34.935Z] 12:03:34 INFO - 1570536214930 Marionette DEBUG 113 <- [1,22,null,{"value":null}]
[task 2019-10-08T12:03:34.936Z] 12:03:34 INFO - 1570536214932 Marionette DEBUG 113 -> [0,23,"WebDriver:ExecuteScript",{"script":"Components.utils.import("resource://gre/modules/Services.jsm");\n\n ... ":"../../venv/lib/python2.7/site-packages/marionette_harness/runner/mixins/window_manager.py","sandbox":"default","line":97}]
[task 2019-10-08T12:03:34.937Z] 12:03:34 INFO - 1570536214935 Marionette DEBUG 113 <- [1,23,null,{"value":true}]
[task 2019-10-08T12:03:34.938Z] 12:03:34 INFO - 1570536214937 Marionette DEBUG 113 -> [0,24,"Marionette:SetContext",{"value":"chrome"}]
[task 2019-10-08T12:03:34.939Z] 12:03:34 INFO - 1570536214937 Marionette DEBUG 113 <- [1,24,null,{"value":null}]
[task 2019-10-08T12:03:34.940Z] 12:03:34 INFO - 1570536214937 Marionette DEBUG 113 -> [0,25,"Marionette:GetContext",{}]
[task 2019-10-08T12:03:34.941Z] 12:03:34 INFO - 1570536214938 Marionette DEBUG 113 <- [1,25,null,{"value":"chrome"}]
[task 2019-10-08T12:03:34.941Z] 12:03:34 INFO - 1570536214938 Marionette DEBUG 113 -> [0,26,"Marionette:SetContext",{"value":"chrome"}]
[task 2019-10-08T12:03:34.942Z] 12:03:34 INFO - 1570536214938 Marionette DEBUG 113 <- [1,26,null,{"value":null}]
[task 2019-10-08T12:03:34.943Z] 12:03:34 INFO - 1570536214940 Marionette DEBUG 113 -> [0,27,"WebDriver:SwitchToWindow",{"handle":"390","focus":true,"name":"390"}]
[task 2019-10-08T12:03:34.944Z] 12:03:34 INFO - 1570536214942 Marionette TRACE Received DOM event activate for [object ChromeWindow]
[task 2019-10-08T12:03:34.944Z] 12:03:34 INFO - 1570536214942 Marionette TRACE Received DOM event focus for [object HTMLDocument]
[task 2019-10-08T12:03:34.945Z] 12:03:34 INFO - 1570536214943 Marionette DEBUG 113 <- [1,27,null,{"value":null}]
[task 2019-10-08T12:03:34.953Z] 12:03:34 INFO - 1570536214946 Marionette DEBUG 113 -> [0,28,"WebDriver:FindElement",{"using":"css selector","value":":root"}]
[task 2019-10-08T12:03:34.954Z] 12:03:34 INFO - 1570536214947 Marionette DEBUG 113 <- [1,28,null,{"value":{"chromeelement-9fc5-4b51-a3c8-01716eedeb04":"5dd4b3f2-c777-4755-b436-2626432eb141"}}]
[task 2019-10-08T12:03:34.954Z] 12:03:34 INFO - 1570536214950 Marionette DEBUG 113 -> [0,29,"WebDriver:GetElementRect",{"id":"5dd4b3f2-c777-4755-b436-2626432eb141"}]
[task 2019-10-08T12:03:34.955Z] 12:03:34 INFO - 1570536214950 Marionette DEBUG 113 <- [1,29,null,{"x":0,"y":0,"width":318,"height":555}]
[task 2019-10-08T12:03:34.955Z] 12:03:34 INFO - 1570536214951 Marionette DEBUG 113 -> [0,30,"WebDriver:ExecuteScript",{"script":"return window.devicePixelRatio","newSandbox":true,"args":[],"filename":"tests/testing/marionette/harness/marionette_harness/tests/unit/test_screenshot.py","sandbox":"default","line":58}]
[task 2019-10-08T12:03:34.956Z] 12:03:34 INFO - 1570536214952 Marionette DEBUG 113 <- [1,30,null,{"value":1}]
[task 2019-10-08T12:03:34.957Z] 12:03:34 INFO - 1570536214953 Marionette DEBUG 113 -> [0,31,"WebDriver:TakeScreenshot",{"full":true,"hash":false,"id":null,"scroll":true}]
[task 2019-10-08T12:03:34.973Z] 12:03:34 INFO - 1570536214968 Marionette DEBUG 113 <- [1,31,null,{"value":"iVBORw0KGgoAAAANSUhEUgAAAT4AAAIrCAYAAAB2y/WFAAAbRklEQVR4nO3dXVdUB77n8fMC97Wec9aaFzBzM3M319HMuTo301ETQ6fN ... /P3fkOI8f9ZB73ZgwfEZmL4SMiczF8RGQuho+IzMXwEZG5GD4iMhfDR0TmYviIyFwMHxGZi+EjInMxfERkLoaPiMz1/wHSpNYU84pfgAAAAABJRU5ErkJggg=="}]
[task 2019-10-08T12:03:34.975Z] 12:03:34 INFO - 1570536214972 Marionette DEBUG 113 -> [0,32,"WebDriver:FindElement",{"using":"css selector","value":":root"}]
[task 2019-10-08T12:03:34.975Z] 12:03:34 INFO - 1570536214972 Marionette DEBUG 113 <- [1,32,null,{"value":{"chromeelement-9fc5-4b51-a3c8-01716eedeb04":"5dd4b3f2-c777-4755-b436-2626432eb141"}}]
[task 2019-10-08T12:03:34.991Z] 12:03:34 INFO - 1570536214981 Marionette DEBUG 113 -> [0,33,"WebDriver:TakeScreenshot",{"full":true,"hash":false,"id":"5dd4b3f2-c777-4755-b436-2626432eb141","scroll":true}]
[task 2019-10-08T12:03:34.999Z] 12:03:34 INFO - 1570536214994 Marionette DEBUG 113 <- [1,33,null,{"value":"iVBORw0KGgoAAAANSUhEUgAAAT4AAAIrCAYAAAB2y/WFAAAbJElEQVR4nO3d+1cTB97H8ecP658wf92udWvZrj0odb087HaVE4hFodpW ... tax8dz93/CyHE/n8e9FcNHROZi+IjIXAwfEZmL4SMiczF8RGQuho+IzMXwEZG5GD4iMhfDR0TmYviIyFwMHxGZi+EjInP9P7N/NAEYOlrRAAAAAElFTkSuQmCC"}]
[task 2019-10-08T12:03:35.000Z] 12:03:35 INFO - 1570536214995 Marionette DEBUG 113 -> [0,34,"WebDriver:CloseChromeWindow",{}]
[task 2019-10-08T12:03:35.001Z] 12:03:35 INFO - 1570536214996 Marionette TRACE Received DOM event unload for [object HTMLDocument]
[task 2019-10-08T12:03:35.001Z] 12:03:35 INFO - 1570536214997 Marionette TRACE Received observer notification message-manager-disconnect
[task 2019-10-08T12:03:35.002Z] 12:03:35 INFO - 1570536214998 Marionette DEBUG 113 <- [1,34,null,["1"]]
[task 2019-10-08T12:03:35.022Z] 12:03:35 INFO - 1570536215012 Marionette DEBUG 113 -> [0,35,"WebDriver:SwitchToWindow",{"handle":"1","focus":true,"name":"1"}]
[task 2019-10-08T12:03:35.023Z] 12:03:35 INFO - 1570536215012 Marionette DEBUG 113 <- [1,35,null,{"value":null}]
[task 2019-10-08T12:03:35.140Z] 12:03:35 INFO - 1570536215128 Marionette DEBUG 113 -> [0,36,"Marionette:GetContext",{}]
[task 2019-10-08T12:03:35.140Z] 12:03:35 INFO - 1570536215128 Marionette DEBUG 113 <- [1,36,null,{"value":"chrome"}]
[task 2019-10-08T12:03:35.156Z] 12:03:35 INFO - 1570536215146 Marionette DEBUG 113 -> [0,37,"Marionette:SetContext",{"value":"chrome"}]
[task 2019-10-08T12:03:35.156Z] 12:03:35 INFO - 1570536215146 Marionette DEBUG 113 <- [1,37,null,{"value":null}]
[task 2019-10-08T12:03:35.158Z] 12:03:35 INFO - 1570536215155 Marionette DEBUG 113 -> [0,38,"WebDriver:TakeScreenshot",{"full":true,"hash":false,"id":null,"scroll":true}]
[task 2019-10-08T12:03:35.247Z] 12:03:35 INFO - TEST-UNEXPECTED-FAIL | testing/marionette/harness/marionette_harness/tests/unit/test_screenshot.py TestScreenCaptureChrome.test_capture_full_area | AssertionError: u'iVBORw0KGgoAAAANSUhEUgAAAT4AAAIrCAYAAAB2y/WFAAAbJElEQVR4nO3d+1cTB97H8ecP658wf9 [truncated]... != u'iVBORw0KGgoAAAANSUhEUgAAAT4AAAIrCAYAAAB2y/WFAAAbRklEQVR4nO3dXVdUB77n8fMC97Wec9 [truncated]...

Status: NEW → RESOLVED
Closed: 5 years ago
Resolution: --- → DUPLICATE
Product: Testing → Remote Protocol
Moving bug to Testing::Marionette Client and Harness component per bug 1815831.
Component: Marionette → Marionette Client and Harness
Product: Remote Protocol → Testing
You need to log in before you can comment on or make changes to this bug.