My favorites | Sign in
Project Home Downloads Wiki Issues Code Search
New issue   Search
for
  Advanced search   Search tips   Subscriptions
Issue 154063: desktopui_DocViewing failure: Cannot open doc in 45 secs
5 people starred this issue and may be notified of changes. Back to list
 
Project Member Reported by nirnimesh@chromium.org, Aug 30, 2012
desktopui_DocViewing fails every once in a while. The logs suggest that chrome could not successfully open the doc in 45 secs.

http://atlantis2.mtv.corp.google.com/results/571913-chromeos-test/chromeos1-rack3-host8/desktopui_DocViewing/

08/30 15:48:37 ERROR|base_utils:0113| [stderr] Some features may not be available.
08/30 15:48:38 ERROR|base_utils:0113| [stderr] 2012-08-30 15:48:38,612 DEBUG    Started http server at "chrome/test/data".
08/30 15:48:38 ERROR|base_utils:0113| [stderr] [ RUN        ] doc_viewing.DocViewingTest.testOpenOfficeFiles: "Test we can open office files from the file manager."
08/30 15:49:01 ERROR|base_utils:0113| [stderr] 2012-08-30 15:49:01,415 DEBUG    WaitUntil(pyauto.py:1498 GetActiveTabTitle()) still waiting. Expecting worldhistory.docx. Last returned Document viewing.
08/30 15:50:20 ERROR|base_utils:0113| [stderr] [4329:4329:0830/155020:1342415164:ERROR:pyautolib.cc(139)] Error during automation: Chrome automation timed out after 45 seconds for {"frame_xpath": "", "javascript": "\n      pyautoAPI.executeDefaultTask()\n    ", "command": "ExecuteJavascript", "tab_index": 0, "windex": 0}
08/30 15:50:20 ERROR|base_utils:0113| [stderr] [      ERROR ] doc_viewing.DocViewingTest.testOpenOfficeFiles
08/30 15:50:20 ERROR|base_utils:0113| [stderr] 
08/30 15:50:20 ERROR|base_utils:0113| [stderr] ======================================================================
08/30 15:50:20 ERROR|base_utils:0113| [stderr] ERROR: doc_viewing.DocViewingTest.testOpenOfficeFiles: "Test we can open office files from the file manager."
08/30 15:50:20 ERROR|base_utils:0113| [stderr] ----------------------------------------------------------------------
08/30 15:50:20 ERROR|base_utils:0113| [stderr] Traceback (most recent call last):
08/30 15:50:20 ERROR|base_utils:0113| [stderr]   File "/usr/local/autotest/deps/chrome_test/test_src/chrome/test/functional/doc_viewing.py", line 65, in testOpenOfficeFiles
08/30 15:50:20 ERROR|base_utils:0113| [stderr]     file_browser.ExecuteDefaultTask()
08/30 15:50:20 ERROR|base_utils:0113| [stderr]   File "/usr/local/autotest/deps/chrome_test/test_src/chrome/test/functional/../pyautolib/chromeos/file_browser.py", line 81, in ExecuteDefaultTask
08/30 15:50:20 ERROR|base_utils:0113| [stderr]     self.executor.Execute(script)
08/30 15:50:20 ERROR|base_utils:0113| [stderr]   File "/usr/local/autotest/deps/chrome_test/test_src/chrome/test/functional/../pyautolib/pyauto.py", line 1003, in Execute
08/30 15:50:20 ERROR|base_utils:0113| [stderr]     self.frame_xpath)
08/30 15:50:20 ERROR|base_utils:0113| [stderr]   File "/usr/local/autotest/deps/chrome_test/test_src/chrome/test/functional/../pyautolib/pyauto.py", line 3911, in ExecuteJavascript
08/30 15:50:20 ERROR|base_utils:0113| [stderr]     result = self._GetResultFromJSONRequest(cmd_dict)['result']
08/30 15:50:20 ERROR|base_utils:0113| [stderr]   File "/usr/local/autotest/deps/chrome_test/test_src/chrome/test/functional/../pyautolib/pyauto.py", line 1117, in _GetResultFromJSONRequest
08/30 15:50:20 ERROR|base_utils:0113| [stderr]     raise AutomationCommandTimeout(ret_dict['error'])
08/30 15:50:20 ERROR|base_utils:0113| [stderr] AutomationCommandTimeout: Chrome automation timed out after 45 seconds for {"frame_xpath": "", "javascript": "\n      pyautoAPI.executeDefaultTask()\n    ", "command": "ExecuteJavascript", "tab_index": 0, "windex": 0}
08/30 15:50:20 ERROR|base_utils:0113| [stderr] 
Sep 26, 2012
#1 dennisjeffrey@chromium.org
 Issue 34785  has been merged into this issue.
Sep 26, 2012
#2 dennisjeffrey@chromium.org
(No comment was entered for this change.)
Labels: Test-Followup
Sep 26, 2012
#4 joshwood...@chromium.org
Can you tell if this is caused by flakiness in NaCl? There have been no changes to the extension that is the CWS since M21 - 2.2.45.1.

https://chrome.google.com/webstore/detail/gbkeegbaiigmenfmjfclcdgdpimamgkj
Sep 28, 2012
#5 benhe...@google.com
(No comment was entered for this change.)
Labels: Hotlist-BuildRel Mstone-24 ReleaseBlock-Dev
Sep 28, 2012
#6 sosa@chromium.org
This has been failing a lot on canaries and closing the tree -- see http://cautotest/results/dashboard/waterfall_index.html
Labels: -Pri-2 Pri-1
Sep 28, 2012
#7 sosa@chromium.org
Can you find someone to look into this?
Status: Assigned
Oct 1, 2012
#8 benhe...@google.com
Zel - can you traige?
Owner: zelidrag@chromium.org
Oct 1, 2012
#9 zelidrag@chromium.org
(No comment was entered for this change.)
Owner: r...@chromium.org
Oct 4, 2012
#10 rongch...@chromium.org
One more instance:
http://chromegw/i/chromeos/builders/kiev%20canary/builds/816 -->
http://atlantis4.mtv.corp.google.com/results/740848-chromeos-test/chromeos2-row5-rack7-host4/

Oct 4, 2012
#11 dd...@chromium.org
(No comment was entered for this change.)
Labels: OS-Chrome
Oct 8, 2012
#12 benhenry@chromium.org
This test is failing consistently on R23.

Example:
http://atlantis4.mtv.corp.google.com/results/762535-chromeos-test/chromeos-rack8a-host4/desktopui_DocViewing/status


Labels: -Mstone-24 -ReleaseBlock-Dev Mstone-23 ReleaseBlock-Beta
Oct 8, 2012
#13 benhenry@chromium.org
(No comment was entered for this change.)
Labels: -ReleaseBlock-Beta ReleaseBlock-Stable
Oct 8, 2012
#14 r...@chromium.org
I believe this is related to the issue we have with the NaCl sanity test. Neither of these tests are able to load their NaCl extensions after James's CL (https://chromiumcodereview.appspot.com/10949017) had landed. I did revert the CL but we've had to reland it again since it contains changes crucial to NPAPI plugin handling on Windows 8.

James is looking into figuring out why the CL is preventing these tests from working. We have verified that the extensions _do load and work fine when done manually. This is under investigation but I don't believe that this is really a release blocker. If the fail on the BVT's is an issue, we can simply disable it for now considering it is a known issue.

Oct 8, 2012
#15 dd...@chromium.org
Discussed with patricia@ - will set test as experimental for now.  Issue 154696  filed to track that action.
Labels: -Hotlist-BuildRel -Mstone-23 -ReleaseBlock-Stable Mstone-24
Oct 12, 2012
#16 vapier@chromium.org
failed again on kiev:
http://chromegw/i/chromeos/builders/kiev%20canary/builds/854
Oct 22, 2012
#17 jrbarne...@chromium.org
 Issue chromium-os:35419  has been merged into this issue.
Cc: dd...@chromium.org vbendeb@chromium.org dbaseh...@chromium.org kr...@chromium.org
Oct 22, 2012
#18 craigdh@chromium.org
(No comment was entered for this change.)
Owner: sadrul@chromium.org
Oct 22, 2012
#19 sadrul@chromium.org
I inherited the task to mark the test as experimental because I was the sheriff/gardener today, not because I know anything about this :) Resetting owner to rkc@
Owner: r...@chromium.org
Oct 22, 2012
#20 r...@chromium.org
Just marking it as experimental is the correct solution at this post. People are working on revamping our tests at the moment anyway.

Feel free to mark this as WontFix or Fixed once the test is marked as experimental (not sure if it is, I didn't see a CL attached to this bug).

Owner: sadrul@chromium.org
Cc: be...@chromium.org be...@chromium.org
Oct 23, 2012
#21 dennisjeffrey@chromium.org
 Issue chromium-os:35612  has been merged into this issue.
Oct 23, 2012
#22 dennisjeffrey@chromium.org
Happened again on:

"stumpy-r24 build, R24-3080.0.0, running on stumpy"

Test fail screenshot attached.  Screenshot shows a file present.
test-fail-screenshot-0.png
181 KB   View   Download
Oct 23, 2012
#23 craigdh@chromium.org
The experimental label is for tests that may not yet be stable enough for the BVT, not for ignoring tests that aren't being actively investigated.

If a test has been adequately replaced by other tests it should be removed from the bvt entirely.
Owner: r...@chromium.org
Oct 23, 2012
#24 be...@chromium.org
Assigning back to kaznacheev, git says he is the most qualified to look at this. 
Owner: kaznacheev@chromium.org
Cc: r...@chromium.org
Oct 23, 2012
#25 dennisjeffrey@chromium.org
Happened again on "stumpy-r24 build, R24-3081.0.0, running on stumpy".

Failure screenshot shows a different file this time.
test-fail-screenshot-0.png
181 KB   View   Download
Oct 23, 2012
#26 mkr...@chromium.org
This seems to have broken the tree again: http://chromegw/i/chromeos/builders/x86-alex%20canary/builds/2741  See  issue 35648  for why an "experimental" autotest still broke the tree.

I see the following in http://atlantis4.mtv.corp.google.com/results/851577-chromeos-test/chromeos2-row1-rack7-host10/desktopui_DocViewing/debug/desktopui_DocViewing.DEBUG:
  10/23 13:27:46.839 ERROR|base_utils:0113| [stderr] 2012-10-23 13:27:46,838 DEBUG    WaitUntil(pyauto.py:1494 GetActiveTabTitle()) still waiting. Expecting chapt13.pptx. Last returned Quickoffice Viewer.

What's strange to me is that it looks like there was also an issue taking a screenshot:
  10/23 13:27:53.113 INFO |cros_ui_te:0357| Saving screenshot to /usr/local/autotest/results/default/desktopui_DocViewing/results/test-fail-screenshot-0.png.
  10/23 13:27:53.115 DEBUG|base_utils:0081| Running 'DISPLAY=:0.0 XAUTHORITY=/home/chronos/.Xauthority /usr/local/bin/import -window root /usr/local/autotest/results/default/desktopui_DocViewing/results/test-fail-screenshot-0.png'
  10/23 13:27:53.488 ERROR|base_utils:0113| [stderr] XIO:  fatal IO error 11 (Resource temporarily unavailable) on X server ":0.0"
  10/23 13:27:53.492 ERROR|base_utils:0113| [stderr]       after 19 requests (19 known processed) with 0 events remaining.
Not sure if that should be filed as a separate bug.

Oct 23, 2012
#27 mkr...@chromium.org
(No comment was entered for this change.)
Cc: mkr...@chromium.org kati...@chromium.org oleg@chromium.org
Oct 29, 2012
#28 kaznacheev@chromium.org
(No comment was entered for this change.)
Labels: -Mstone-24 Mstone-25
Oct 30, 2012
#29 craigdh@chromium.org
Again: http://atlantis4.mtv.corp.google.com/results/898748-chromeos-test/chromeos1-rack8c-host6/desktopui_DocViewing/

  [ RUN        ] doc_viewing.DocViewingTest.testOpenOfficeFiles: "Test we can open office files from the file manager."
  2012-10-30 02:48:35,053 DEBUG    WaitUntil(file_browser.py:183 return self._ui_test.WaitUntil(lambda: _IsInitialized())) still waiting. Expecting True. Last returned False.
  2012-10-30 02:48:43,415 DEBUG    WaitUntil(pyauto.py:1494 GetActiveTabTitle()) still waiting. Expecting wghstyle.doc. Last returned Downloads.
  2012-10-30 02:48:48,455 DEBUG    WaitUntil(pyauto.py:1494 GetActiveTabTitle()) still waiting. Expecting wghstyle.doc. Last returned Downloads.
  2012-10-30 02:48:53,495 DEBUG    WaitUntil(pyauto.py:1494 GetActiveTabTitle()) still waiting. Expecting wghstyle.doc. Last returned Downloads.
  2012-10-30 02:48:58,533 DEBUG    WaitUntil(pyauto.py:1494 GetActiveTabTitle()) still waiting. Expecting wghstyle.doc. Last returned Downloads.
  2012-10-30 02:49:03,571 DEBUG    WaitUntil(pyauto.py:1494 GetActiveTabTitle()) still waiting. Expecting wghstyle.doc. Last returned Downloads.
  2012-10-30 02:49:08,608 DEBUG    WaitUntil(pyauto.py:1494 GetActiveTabTitle()) still waiting. Expecting wghstyle.doc. Last returned Downloads.
  2012-10-30 02:49:13,394 DEBUG    WaitUntil(pyauto.py:1494 GetActiveTabTitle()) still waiting. Expecting wghstyle.doc. Last returned Downloads.
  2012-10-30 02:49:18,433 DEBUG    WaitUntil(pyauto.py:1494 GetActiveTabTitle()) still waiting. Expecting wghstyle.doc. Last returned Downloads.
  [     FAILED ] doc_viewing.DocViewingTest.testOpenOfficeFiles
  
  ======================================================================
  FAIL: doc_viewing.DocViewingTest.testOpenOfficeFiles: "Test we can open office files from the file manager."
  ----------------------------------------------------------------------

  AssertionError: "wghstyle.doc" does not open.
Oct 30, 2012
#30 craigdh@chromium.org
And again.

http://cautotest/tko/retrieve_logs.cgi?job=/results/901499-chromeos-test/chromeos1-rack8b-host7/desktopui_DocViewing

AssertionError: "Jingjing Wang.ppt" does not open.
Oct 31, 2012
#31 craigdh@chromium.org
http://cautotest/tko/retrieve_logs.cgi?job=/results/902963-chromeos-test/chromeos2-row3-rack6-host1/desktopui_DocViewing

  AutomationCommandTimeout: Chrome automation timed out after 45 seconds for {"frame_xpath": "", "javascript": "\n      pyautoAPI.executeDefaultTask()\n    ", "command": "ExecuteJavascript", "tab_index": 0, "windex": 0}
Dec 19, 2012
#32 kaznacheev@chromium.org
I have no idea how to repro this. Lets check if this still occurs.
Owner: joshwood...@chromium.org
Dec 19, 2012
#33 joshwood...@chromium.org
No longer seeing this with the new Chrome Office Viewer 2.5.72.1.

Google Chrome	25.0.1363.0 (Official Build 173396) canary
Platform	3417.0.0 (Official Build) canary-channel stumpy
Status: WontFix
Mar 10, 2013
#34 bugdro...@chromium.org
(No comment was entered for this change.)
Labels: -Area-UI -Feature-Docs -TreeCloser -Mstone-25 Cr-Plaform-Apps-Default-DocViewer Cr-UI M-25 Hotlist-TreeCloser
Mar 10, 2013
#35 lafo...@google.com
(No comment was entered for this change.)
Labels: -Cr-Plaform-Apps-Default-DocViewer Cr-Platform-Apps-Default-DocViewer
Sign in to add a comment

Powered by Google Project Hosting