My favorites ▼ | Sign in
Project Home Downloads Wiki Issues Code Search
New issue   Search
for
  Advanced search   Search tips   Subscriptions
Issue 48546: Tests are repeatedly timing out on the OSX 10.6 bots due to mach ipc timeout
  Back to list
Status:  Duplicate
Merged:  issue 46609
Owner:  andyb...@chromium.org
Closed:  Jul 2010
Cc:  tonyg@chromium.org, cbentzel@chromium.org, mark@chromium.org, jeremy@chromium.org

Restricted
  • Only users with Commit permission may comment.


Sign in to add a comment
 
Project Member Reported by cbentzel@chromium.org, Jul 8, 2010 
It's getting a sigterm after taking 30 seconds

Note: Google Test filter = ExtensionsStartupTest.Test
[==========] Running 1 test from 1 test case.
[----------] Global test environment set-up.
[----------] 1 test from ExtensionsStartupTest
[ RUN      ] ExtensionsStartupTest.Test
[46710:263:0707/203455:2898992950943271:ERROR:/b/slave/chromium-dbg-mac-builder/build/src/chrome/browser/first_run_mac.mm(63)] Not implemented reached in static bool FirstRun::ProcessMasterPreferences(const FilePath&, FirstRun::MasterPrefs*)
[46710:22787:0707/203455:2898992955414769:INFO:/b/slave/chromium-dbg-mac-builder/build/src/net/base/host_resolver_impl.cc(1066)] IPv6Probe forced AddressFamily setting to ADDRESS_FAMILY_IPV4
[46710:263:0707/203455:2898992960444604:INFO:/b/slave/chromium-dbg-mac-builder/build/src/chrome/browser/extensions/extensions_service.cc(624)] Sending EXTENSION_LOADED
[46710:22787:0707/203455:2898992964166237:INFO:/b/slave/chromium-dbg-mac-builder/build/src/chrome/browser/net/predictor_api.cc(544)] DNS Prefetch service started
[46710:22019:0707/203455:2898992968308223:INFO:/b/slave/chromium-dbg-mac-builder/build/src/chrome/common/extensions/extension_file_util.cc(274)] Garbage collecting extensions...
[46710:22019:0707/203455:2898992968484364:WARNING:/b/slave/chromium-dbg-mac-builder/build/src/chrome/common/extensions/extension_file_util.cc(286)] Invalid extension ID encountered in extensions directory: .svn
[46710:22019:0707/203455:2898992968527400:INFO:/b/slave/chromium-dbg-mac-builder/build/src/chrome/common/extensions/extension_file_util.cc(288)] Deleting invalid extension directory /private/var/folders/Dv/DvuOAgCiHqe-M55O-YhHlU+++TM/-Tmp-/.org.chromium.Yg8tgC/test_user_data/Default/Extensions/.svn.
[46710:22019:0707/203455:2898992969574317:INFO:/b/slave/chromium-dbg-mac-builder/build/src/chrome/common/extensions/extension_file_util.cc(316)] Deleting old version for directory /private/var/folders/Dv/DvuOAgCiHqe-M55O-YhHlU+++TM/-Tmp-/.org.chromium.Yg8tgC/test_user_data/Default/Extensions/behllobkkfkfnphdnhnkndlbkcpglgmj/.svn.
[46710:22019:0707/203455:2898992971947616:INFO:/b/slave/chromium-dbg-mac-builder/build/src/chrome/common/extensions/extension_file_util.cc(316)] Deleting old version for directory /private/var/folders/Dv/DvuOAgCiHqe-M55O-YhHlU+++TM/-Tmp-/.org.chromium.Yg8tgC/test_user_data/Default/Extensions/bjafgdebaacbbbecmhlhpofkepfkgcpa/.svn.
[46710:22019:0707/203455:2898992973014888:INFO:/b/slave/chromium-dbg-mac-builder/build/src/chrome/common/extensions/extension_file_util.cc(316)] Deleting old version for directory /private/var/folders/Dv/DvuOAgCiHqe-M55O-YhHlU+++TM/-Tmp-/.org.chromium.Yg8tgC/test_user_data/Default/Extensions/hpiknbiabeeppbpihjehijgoemciehgk/.svn.
[46710:263:0707/203455:2898992979999677:INFO:/b/slave/chromium-dbg-mac-builder/build/src/chrome/browser/extensions/extensions_service.cc(624)] Sending EXTENSION_LOADED
[46710:263:0707/203455:2898992980327498:INFO:/b/slave/chromium-dbg-mac-builder/build/src/chrome/browser/extensions/extensions_service.cc(624)] Sending EXTENSION_LOADED
[46710:263:0707/203455:2898992980591460:INFO:/b/slave/chromium-dbg-mac-builder/build/src/chrome/browser/extensions/extensions_service.cc(624)] Sending EXTENSION_LOADED
[46710:263:0707/203455:2898992981394834:INFO:/b/slave/chromium-dbg-mac-builder/build/src/chrome/browser/extensions/extension_host.cc(192)] Creating RenderView for My extension 1
[46710:263:0707/203455:2898992981687726:INFO:/b/slave/chromium-dbg-mac-builder/build/src/chrome/browser/extensions/extension_host.cc(192)] Creating RenderView for My extension 3
[46710:263:0707/203455:2898992981935478:INFO:/b/slave/chromium-dbg-mac-builder/build/src/chrome/browser/extensions/extension_host.cc(192)] Creating RenderView for My extension 2
[46710:22019:0707/203455:2898992983001615:WARNING:/b/slave/chromium-dbg-mac-builder/build/src/net/base/file_stream_posix.cc(349)] Failed to open file: 2 (/private/var/folders/Dv/DvuOAgCiHqe-M55O-YhHlU+++TM/-Tmp-/.org.chromium.Yg8tgC/test_user_data/Default/Last Tabs)
[46710:22019:0707/203455:2898992983386350:INFO:/b/slave/chromium-dbg-mac-builder/build/src/chrome/browser/extensions/user_script_master.cc(177)] Loaded user script file: /private/var/folders/Dv/DvuOAgCiHqe-M55O-YhHlU+++TM/-Tmp-/.org.chromium.Yg8tgC/test_user_data/Default/Extensions/behllobkkfkfnphdnhnkndlbkcpglgmj/1.0.0.0/script1.js
[46710:22019:0707/203455:2898992983628728:INFO:/b/slave/chromium-dbg-mac-builder/build/src/chrome/browser/extensions/user_script_master.cc(177)] Loaded user script file: /private/var/folders/Dv/DvuOAgCiHqe-M55O-YhHlU+++TM/-Tmp-/.org.chromium.Yg8tgC/test_user_data/Default/Extensions/behllobkkfkfnphdnhnkndlbkcpglgmj/1.0.0.0/script2.js
[46710:263:0707/203455:2898992983803990:INFO:/b/slave/chromium-dbg-mac-builder/build/src/chrome/browser/extensions/extension_host.cc(709)] (RenderViewCreated) Resetting EFD to chrome-extension://behllobkkfkfnphdnhnkndlbkcpglgmj/backgroundpage.html for My extension 1
[46710:22019:0707/203455:2898992983966672:INFO:/b/slave/chromium-dbg-mac-builder/build/src/chrome/browser/extensions/user_script_master.cc(177)] Loaded user script file: /private/var/folders/Dv/DvuOAgCiHqe-M55O-YhHlU+++TM/-Tmp-/.org.chromium.Yg8tgC/test_user_data/Default/Extensions/behllobkkfkfnphdnhnkndlbkcpglgmj/1.0.0.0/style1.css
[46710:263:0707/203455:2898992985106656:INFO:/b/slave/chromium-dbg-mac-builder/build/src/chrome/browser/extensions/extension_host.cc(212)] Request to NavigateToURL chrome-extension://behllobkkfkfnphdnhnkndlbkcpglgmj/backgroundpage.html for My extension 1
[46710:263:0707/203455:2898992986630014:INFO:/b/slave/chromium-dbg-mac-builder/build/src/chrome/browser/extensions/extension_host.cc(233)] Navigating to chrome-extension://behllobkkfkfnphdnhnkndlbkcpglgmj/backgroundpage.html
[46710:263:0707/203455:2898992988089246:INFO:/b/slave/chromium-dbg-mac-builder/build/src/chrome/browser/extensions/extension_host.cc(709)] (RenderViewCreated) Resetting EFD to chrome-extension://bjafgdebaacbbbecmhlhpofkepfkgcpa/background.html for My extension 3
[46710:263:0707/203455:2898992988196043:INFO:/b/slave/chromium-dbg-mac-builder/build/src/chrome/browser/extensions/extension_host.cc(212)] Request to NavigateToURL chrome-extension://bjafgdebaacbbbecmhlhpofkepfkgcpa/background.html for My extension 3
[46710:263:0707/203455:2898992988219221:INFO:/b/slave/chromium-dbg-mac-builder/build/src/chrome/browser/extensions/extension_host.cc(233)] Navigating to chrome-extension://bjafgdebaacbbbecmhlhpofkepfkgcpa/background.html
[46710:263:0707/203455:2898992988935135:INFO:/b/slave/chromium-dbg-mac-builder/build/src/chrome/browser/extensions/extension_host.cc(709)] (RenderViewCreated) Resetting EFD to chrome-extension://hpiknbiabeeppbpihjehijgoemciehgk/background.html for My extension 2
[46710:22019:0707/203455:2898992989344371:INFO:/b/slave/chromium-dbg-mac-builder/build/src/chrome/browser/extensions/user_script_master.cc(177)] Loaded user script file: /private/var/folders/Dv/DvuOAgCiHqe-M55O-YhHlU+++TM/-Tmp-/.org.chromium.Yg8tgC/test_user_data/Default/Extensions/behllobkkfkfnphdnhnkndlbkcpglgmj/1.0.0.0/style2.css
[46710:263:0707/203455:2898992990694182:INFO:/b/slave/chromium-dbg-mac-builder/build/src/chrome/browser/extensions/extension_host.cc(212)] Request to NavigateToURL chrome-extension://hpiknbiabeeppbpihjehijgoemciehgk/background.html for My extension 2
[46710:263:0707/203455:2898992990728998:INFO:/b/slave/chromium-dbg-mac-builder/build/src/chrome/browser/extensions/extension_host.cc(233)] Navigating to chrome-extension://hpiknbiabeeppbpihjehijgoemciehgk/background.html
[46710:22019:0707/203455:2898992991710857:INFO:/b/slave/chromium-dbg-mac-builder/build/src/chrome/browser/extensions/user_script_master.cc(177)] Loaded user script file: /private/var/folders/Dv/DvuOAgCiHqe-M55O-YhHlU+++TM/-Tmp-/.org.chromium.Yg8tgC/test_user_data/Default/Extensions/behllobkkfkfnphdnhnkndlbkcpglgmj/1.0.0.0/style2.css
[46710:22019:0707/203455:2898992992042552:INFO:/b/slave/chromium-dbg-mac-builder/build/src/chrome/browser/extensions/user_script_master.cc(177)] Loaded user script file: /private/var/folders/Dv/DvuOAgCiHqe-M55O-YhHlU+++TM/-Tmp-/.org.chromium.Yg8tgC/test_user_data/Default/Extensions/behllobkkfkfnphdnhnkndlbkcpglgmj/1.0.0.0/js_files/script3.js
2010-07-07 20:34:55.399 browser_tests[46710:107] Could not find image named 'close_bar'.
2010-07-07 20:34:55.404 browser_tests[46710:107] Could not find image named 'close_bar_p'.
[46710:263:0707/203455:2898993148358110:INFO:/b/slave/chromium-dbg-mac-builder/build/src/chrome/browser/extensions/extension_host.cc(252)] Sending EXTENSION_PROCESS_CREATED
[46710:263:0707/203455:2898993148482146:INFO:/b/slave/chromium-dbg-mac-builder/build/src/chrome/browser/history/history.cc(746)] History backend finished loading
[46710:263:0707/203455:2898993152536635:INFO:/b/slave/chromium-dbg-mac-builder/build/src/chrome/browser/extensions/extension_host.cc(252)] Sending EXTENSION_PROCESS_CREATED
[46710:263:0707/203455:2898993152832629:INFO:/b/slave/chromium-dbg-mac-builder/build/src/chrome/browser/extensions/extension_host.cc(252)] Sending EXTENSION_PROCESS_CREATED
[46710:263:0707/203455:2898993207401844:INFO:/b/slave/chromium-dbg-mac-builder/build/src/chrome/browser/sync/profile_sync_service.cc(100)] Unofficial build, using dev channel sync server.
[46710:263:0707/203455:2898993207510288:INFO:/b/slave/chromium-dbg-mac-builder/build/src/chrome/browser/sync/profile_sync_service.cc(124)] Starting ProfileSyncService.
[46710:263:0707/203455:2898993207532909:INFO:/b/slave/chromium-dbg-mac-builder/build/src/chrome/browser/sync/profile_sync_service.cc(181)] Using https://clients4.google.com/chrome-sync/dev for sync server URL.
[46710:263:0707/203455:2898993207660005:INFO:/b/slave/chromium-dbg-mac-builder/build/src/chrome/browser/sync/profile_sync_service.cc(352)] Clearing Sync DB.
[46710:263:0707/203455:2898993208659909:INFO:/b/slave/chromium-dbg-mac-builder/build/src/chrome/browser/extensions/extension_host.cc(328)] (DidNavigate) Resetting EFD to chrome-extension://bjafgdebaacbbbecmhlhpofkepfkgcpa/background.html for My extension 3
[46710:22019:0707/203455:2898993209520660:INFO:/b/slave/chromium-dbg-mac-builder/build/src/chrome/common/important_file_writer.cc(71)] successfully saved /private/var/folders/Dv/DvuOAgCiHqe-M55O-YhHlU+++TM/-Tmp-/.org.chromium.Yg8tgC/test_user_data/Default/Bookmarks
[46710:22275:0707/203455:2898993213297336:ERROR:/b/slave/chromium-dbg-mac-builder/build/src/base/process_util_posix.cc(334)] parent WaitForMessage() failed: 0x10004003 (ipc/rcv) timed out
[46710:263:0707/203455:2898993281946572:INFO:/b/slave/chromium-dbg-mac-builder/build/src/chrome/browser/extensions/extension_host.cc(328)] (DidNavigate) Resetting EFD to chrome-extension://behllobkkfkfnphdnhnkndlbkcpglgmj/backgroundpage.html for My extension 1
[46710:263:0707/203455:2898993352096809:INFO:/b/slave/chromium-dbg-mac-builder/build/src/chrome/browser/extensions/extension_host.cc(328)] (DidNavigate) Resetting EFD to chrome-extension://hpiknbiabeeppbpihjehijgoemciehgk/background.html for My extension 2
[46710:263:0707/203456:2898993919611220:INFO:/b/slave/chromium-dbg-mac-builder/build/src/chrome/browser/extensions/extension_host.cc(395)] Sending EXTENSION_HOST_DID_STOP_LOADING
[46710:263:0707/203456:2898993949531838:INFO:/b/slave/chromium-dbg-mac-builder/build/src/chrome/browser/extensions/extension_host.cc(395)] Sending EXTENSION_HOST_DID_STOP_LOADING
[46710:263:0707/203456:2898994296186017:INFO:/b/slave/chromium-dbg-mac-builder/build/src/chrome/browser/extensions/extension_host.cc(395)] Sending EXTENSION_HOST_DID_STOP_LOADING
[46710:22019:0707/203505:2899002959627809:INFO:/b/slave/chromium-dbg-mac-builder/build/src/chrome/common/important_file_writer.cc(71)] successfully saved /private/var/folders/Dv/DvuOAgCiHqe-M55O-YhHlU+++TM/-Tmp-/.org.chromium.Yg8tgC/test_user_data/Default/Preferences
[0707/203525:ERROR:/b/slave/chromium-dbg-mac-builder/build/src/chrome/test/test_launcher/out_of_proc_test_runner.cc(95)] Test timeout (30000 ms) exceeded for ExtensionsStartupTest.Test
Handling SIGTERM.
Check failed: g_shutdown_pipe_write_fd != -1

This has failed numerous times on Mac Tests (dbg)(3) and Mac Tests 10.6 (dbg)(3) on July 08.
Jul 8, 2010
#1 cbentzel@chromium.org 
That date should be July 8, 2010 for clarification.
Jul 8, 2010
#2 andyb...@chromium.org 
Issue 48151 is also exhibiting this behavior, but you can see it in other components by looking at the stdout of
http://build.chromium.org/buildbot/waterfall/builders/Mac10.6%20Tests%20(dbg)(3)/builds/6443/steps/browser_tests/logs/stdio
http://build.chromium.org/buildbot/waterfall/builders/Mac10.6%20Tests%20(dbg)(3)/builds/6437/steps/browser_tests/logs/stdio
and 
http://build.chromium.org/buildbot/waterfall/builders/Mac10.6%20Tests/builds/4672/steps/browser_tests/logs/stdio
(search for "WaitForMessage() failed")

I'm unclear on what the interaction is with sync and extensions. Fred, do you have any insight? Could this be sync-related? It started to occur shortly after r51226 is why I ask.
Summary: Extension Tests are repeatedly timing out on the OSX 10.6 bots
Owner: aka...@chromium.org
Jul 8, 2010
#3 andyb...@chromium.org 
This is leaking into other tests. Doesn't look like it's extensions-specific. It just so happens that most of browser tests are extensions tests. Maybe OOM problems?

look for "RestoreWithExistingSiteInstance" in http://build.chromium.org/buildbot/waterfall/builders/Mac10.6%20Tests%20(dbg)(2)/builds/6085/steps/ui_tests/logs/stdio
Summary: Tests are repeatedly timing out on the OSX 10.6 bots due to mach ipc timeout
Owner: andyb...@chromium.org
Cc: m...@chromium.org jer...@chromium.org
Jul 8, 2010
#4 andyb...@chromium.org 
looks like pathorn has a very similar bug.
Status: Duplicate
Labels: -Feature-Extensions
Mergedinto: 46609
Oct 12, 2012
#5 bugdroid1@chromium.org 
This issue has been closed for some time. No one will pay attention to new comments.
If you are seeing this bug or have new data, please click New Issue to start a new bug.
Labels: Restrict-AddIssueComment-Commit
Mergedinto: chromium:46609
Mar 10, 2013
#6 bugdroid1@chromium.org 
(No comment was entered for this change.)
Labels: -Area-UI Cr-UI
► Sign in to add a comment

Powered by Google Project Hosting