New issue
Advanced search Search tips

Issue 915416 link

Starred by 2 users

Issue metadata

Status: Fixed
Owner:
Closed: Jan 7
Cc:
Components:
EstimatedDays: ----
NextAction: ----
OS: Chrome
Pri: 2
Type: Bug



Sign in to add a comment

telemetry.internal.browser.tab_unittest.TabTest.testActivateTab fails on amd64-generic-telemetry VM

Project Member Reported by osh...@chromium.org, Dec 15

Issue description

chrome is attached to this bug.


This is output:

====================================

[1/1] telemetry.internal.browser.tab_unittest.TabTest.testActivateTab failed unexpectedly 15.1649s:
  Chose browser: PossibleCrOSBrowser(browser_type=system)
  Tsproxy commandline: ['/usr/local/bin/python', '/usr/local/telemetry/src/third_party/catapult/telemetry/third_party/tsproxy/tsproxy.py', '--port=0', '--desthost=127.0.0.1']
  fcntl is supported, try setting non blocking I/O for the ts_proxy process
  TsProxy port: 43867
  DoNothingForwarder started between 127.0.0.1:43867 and 43867
  (Re)starting the ui (logs the user out)
  Restarting Chrome (pid=25354) with remote port
  dbus-send --system --type=method_call --dest=org.chromium.SessionManager /org/chromium/SessionManager org.chromium.SessionManagerInterface.EnableChromeTesting boolean:true array:string:"--enable-net-benchmarking,--metrics-recording-only,--no-default-browser-check,--no-first-run,--ignore-background-tasks,--enable-gpu-benchmarking,--deny-permission-prompts,--autoplay-policy=no-user-gesture-required,--disable-background-networking,--disable-component-extensions-with-background-pages,--disable-default-apps,--disable-search-geolocation-disclosure,--proxy-server=socks://localhost:43867,--proxy-bypass-list=<-loopback>,--ignore-certificate-errors-spki-list=PhrPvGIaAMmd29hj8BCZOq096yj7uMpRNHpn5PDxI6I=,--enable-smooth-scrolling,--enable-threaded-compositing,--remote-debugging-port=0,--start-maximized,--ash-disable-system-sounds,--mute-audio,--oobe-skip-postlogin,--disable-logging-redirect,--vmodule=*/chromeos/net/*=2\,*/chromeos/login/*=2\,chrome_browser_main_posix=2,--allow-failed-policy-fetch-for-test,--disable-gaia-services" array:string:
  DoNothingForwarder started between 127.0.0.1:46289 and 46289
  Invoking Oobe.loginForTesting
  DoNothingForwarder started between 127.0.0.1:46289 and 46289
  Browser is up!
  Browser started (pid=25394).
  OS: chromeos 
  Browser command line: /opt/google/chrome/chrome --ppapi-flash-path=/opt/google/chrome/pepper/libpepflashplayer.so --ppapi-flash-version=32.0.0.101 --ui-prioritize-in-gpu-process --use-gl=egl --gpu-sandbox-failures-fatal=no --enable-logging --log-level=1 --use-cras --enable-wayland-server --user-data-dir=/home/chronos --enable-features=MachineLearningService,MyFilesVolume,Crostini,ExperimentalCrostiniUI --system-developer-mode --login-profile=user --aura-legacy-power-button --guest-wallpaper-large=/usr/share/chromeos-assets/wallpaper/guest_large.jpg --guest-wallpaper-small=/usr/share/chromeos-assets/wallpaper/guest_small.jpg --child-wallpaper-large=/usr/share/chromeos-assets/wallpaper/child_large.jpg --child-wallpaper-small=/usr/share/chromeos-assets/wallpaper/child_small.jpg --default-wallpaper-large=/usr/share/chromeos-assets/wallpaper/default_large.jpg --default-wallpaper-small=/usr/share/chromeos-assets/wallpaper/default_small.jpg --enterprise-enrollment-initial-modulus=15 --enterprise-enrollment-modulus-limit=19 --login-manager --enable-net-benchmarking --metrics-recording-only --no-default-browser-check --no-first-run --ignore-background-tasks --enable-gpu-benchmarking --deny-permission-prompts --autoplay-policy=no-user-gesture-required --disable-background-networking --disable-component-extensions-with-background-pages --disable-default-apps --disable-search-geolocation-disclosure --proxy-server=socks://localhost:43867 --proxy-bypass-list=<-loopback> --ignore-certificate-errors-spki-list=PhrPvGIaAMmd29hj8BCZOq096yj7uMpRNHpn5PDxI6I= --enable-smooth-scrolling --enable-threaded-compositing --remote-debugging-port=0 --start-maximized --ash-disable-system-sounds --mute-audio --oobe-skip-postlogin --disable-logging-redirect --allow-failed-policy-fetch-for-test --disable-gaia-services --testing-channel=NamedTestingInterface:/tmp/.org.chromium.Chromium.GyniDx/.org.chromium.Chromium.AIq68Q --vmodule=existing_user_controller=2,*/ash/wm/tablet_mode/*=1,nss_cert_database_chromeos=1,*/assistant/*=1,*chromeos/login/*=1,auto_enrollment_controller=1,*/ui/ozone/*=1,*/ui/display/manager/chromeos/*=1,*night_light*=1,update_engine=1,component_updater_service=1,power_button_observer=2,webui_login_view=2,lock_state_controller=2,webui_screen_locker=2,screen_locker=2,*/chromeos/net/*=2,*/chromeos/login/*=2,chrome_browser_main_posix=2 --enable-features=MachineLearningService,MyFilesVolume,Crostini,ExperimentalCrostiniUI
  GPU device 0: VENDOR = 0x1af4 (VMware, Inc.), DEVICE = 0x1050 (llvmpipe (LLVM 6.0, 256 bits))
  GPU Attributes:
    amd_switchable      : False
    can_support_threaded_texture_mailbox: False
    direct_rendering    : True
    gl_extensions       : GL_ANGLE_texture_compression_dxt3 GL_ANGLE_texture_compression_dxt5 GL_APPLE_texture_max_level GL_EXT_base_instance GL_EXT_blend_func_extended GL_EXT_blend_minmax GL_EXT_clip_cull_distance GL_EXT_color_buffer_float GL_EXT_compressed_ETC1_RGB8_sub_texture GL_EXT_copy_image GL_EXT_discard_framebuffer GL_EXT_draw_buffers GL_EXT_draw_buffers_indexed GL_EXT_draw_elements_base_vertex GL_EXT_frag_depth GL_EXT_map_buffer_range GL_EXT_multi_draw_arrays GL_EXT_occlusion_query_boolean GL_EXT_polygon_offset_clamp GL_EXT_read_format_bgra GL_EXT_separate_shader_objects GL_EXT_shader_integer_mix GL_EXT_texture_border_clamp GL_EXT_texture_compression_dxt1 GL_EXT_texture_format_BGRA8888 GL_EXT_texture_rg GL_EXT_texture_sRGB_decode GL_EXT_texture_type_2_10_10_10_REV GL_EXT_unpack_subimage GL_KHR_context_flush_control GL_KHR_debug GL_KHR_no_error GL_MESA_shader_integer_functions GL_NV_draw_buffers GL_NV_fbo_color_attachments GL_NV_read_buffer GL_NV_read_depth GL_NV_read_depth_stencil GL_NV_read_stencil GL_OES_EGL_image GL_OES_EGL_image_external GL_OES_EGL_image_external_essl3 GL_OES_EGL_sync GL_OES_compressed_ETC1_RGB8_texture GL_OES_copy_image GL_OES_depth24 GL_OES_depth_texture GL_OES_depth_texture_cube_map GL_OES_draw_buffers_indexed GL_OES_draw_elements_base_vertex GL_OES_element_index_uint GL_OES_fbo_render_mipmap GL_OES_get_program_binary GL_OES_mapbuffer GL_OES_packed_depth_stencil GL_OES_required_internalformat GL_OES_rgb8_rgba8 GL_OES_standard_derivatives GL_OES_stencil8 GL_OES_surfaceless_context GL_OES_texture_3D GL_OES_texture_border_clamp GL_OES_texture_float GL_OES_texture_float_linear GL_OES_texture_half_float GL_OES_texture_half_float_linear GL_OES_texture_npot GL_OES_texture_stencil8 GL_OES_vertex_array_object GL_OES_vertex_half_float 
    gl_renderer         : llvmpipe (LLVM 6.0, 256 bits)
    gl_reset_notification_strategy: 0
    gl_vendor           : VMware, Inc.
    gl_version          : OpenGL ES 3.0 Mesa 18.2.0-devel (git-0f959215c3)
    gl_ws_extensions    : EGL_EXT_image_dma_buf_import EGL_EXT_image_dma_buf_import_modifiers EGL_KHR_cl_event2 EGL_KHR_config_attribs EGL_KHR_create_context EGL_KHR_create_context_no_error EGL_KHR_fence_sync EGL_KHR_get_all_proc_addresses EGL_KHR_gl_colorspace EGL_KHR_gl_renderbuffer_image EGL_KHR_gl_texture_2D_image EGL_KHR_gl_texture_3D_image EGL_KHR_gl_texture_cubemap_image EGL_KHR_image_base EGL_KHR_no_config_context EGL_KHR_reusable_sync EGL_KHR_surfaceless_context EGL_EXT_pixel_format_float EGL_KHR_wait_sync EGL_MESA_configless_context EGL_MESA_image_dma_buf_export 
    gl_ws_vendor        : Mesa Project
    gl_ws_version       : 1.4 (DRI2)
    in_process_gpu      : False
    initialization_time : 0.112185
    jpeg_decode_accelerator_supported: False
    max_msaa_samples    : 1
    oop_rasterization_supported: True
    optimus             : False
    passthrough_cmd_decoder: False
    pixel_shader_version: 3.00
    process_crash_count : 0
    sandboxed           : False
    software_rendering  : False
    vertex_shader_version: 3.00
    video_decode_accelerator_flags: 0
  Feature Status:
    2d_canvas           : enabled
    flash_3d            : enabled
    flash_stage3d       : enabled
    flash_stage3d_baseline: enabled
    gpu_compositing     : enabled
    multiple_raster_threads: enabled_on
    native_gpu_memory_buffers: disabled_software
    oop_rasterization   : unavailable_off
    protected_video_decode: unavailable_off
    rasterization       : unavailable_off
    skia_renderer       : disabled_off
    surface_control     : disabled_off
    surface_synchronization: enabled_on
    video_decode        : enabled
    viz_display_compositor: disabled_off
    webgl               : enabled
    webgl2              : enabled
  Driver Bug Workarounds:
    clear_uniforms_before_first_program_use
    count_all_in_varyings_packing
    disable_framebuffer_cmaa
    scalarize_vec_and_mat_constructor_args
    disabled_extension__gl__khr_blend_equation_advanced
    disabled_extension__gl__khr_blend_equation_advanced_coherent
  DevTools console [network]: Failed to load resource: net::ERR_FAILED chrome-search://local-ntp/promo.js
  DevTools console [network]: Failed to load resource: net::ERR_FAILED chrome-search://local-ntp/one-google.js
  *************** BROWSER STANDARD OUTPUT ***************
  Cannot get standard output on CrOS
  *********** END OF BROWSER STANDARD OUTPUT ************
  ********************* BROWSER LOG *********************
  No log file
  ***************** END OF BROWSER LOG ******************
  ********************* SYMBOLIZED MINIDUMP *********************
  ***************** END OF SYMBOLIZED MINIDUMP ******************
  Closing browser (pid=25394) ...
  (Re)starting the ui (logs the user out)
  Browser is closed.
  Traceback (most recent call last):
    File "/usr/local/telemetry/src/third_party/catapult/telemetry/telemetry/testing/browser_test_case.py", line 39, in WrappedMethod
      method(self)
    File "/usr/local/telemetry/src/third_party/catapult/telemetry/telemetry/internal/browser/tab_unittest.py", line 99, in testActivateTab
      self.assertFalse(_IsDocumentVisible(new_tab))
  AssertionError: True is not false
0 tests passed in 16.1s, 0 skipped, 1 failure.
**Non zero exit code**
If you don't see any error stack, this could have been a native crash. Consider installing faulthandler (https://faulthandler.readthedocs.io/) for more useful error message

 
chrome.log
13.1 KB View Download
I didn't see this error on amd64-generic-telemetry build any more. Currently there is timeout error on this build, see latest build: https://cros-goldeneye.corp.google.com/chromeos/healthmonitoring/buildDetails?buildbucketId=8926810882920514752

Selected error message:
05:07:58: WARNING: Traceback (most recent call last):
  File "/b/swarming/w/ir/cache/cbuild/repository/chromite/cbuildbot/stages/generic_stages.py", line 704, in Run
    self.PerformStage()
  File "/b/swarming/w/ir/cache/cbuild/repository/chromite/cbuildbot/stages/vm_test_stages.py", line 290, in PerformStage
    self._RunTest(vm_test, per_test_results_dir)
  File "/b/swarming/w/ir/cache/cbuild/repository/chromite/cbuildbot/stages/vm_test_stages.py", line 250, in _RunTest
    ssh_port=self._ssh_port
  File "/b/swarming/w/ir/cache/cbuild/repository/chromite/cbuildbot/stages/vm_test_stages.py", line 801, in RunTestSuite
    ssh_private_key, ssh_port)
  File "/b/swarming/w/ir/cache/cbuild/repository/chromite/cbuildbot/stages/vm_test_stages.py", line 892, in _RunTestSuiteUsingCtest
    kill_timeout=10 * 60)
  File "/b/swarming/w/ir/cache/cbuild/repository/chromite/lib/cros_build_lib.py", line 614, in RunCommand
    (cmd_result.output, cmd_result.error) = proc.communicate(input)
  File "/usr/lib/python2.7/subprocess.py", line 796, in communicate
    self.wait()
  File "/usr/lib/python2.7/subprocess.py", line 1376, in wait
    pid, sts = _eintr_retry_call(os.waitpid, self.pid, 0)
  File "/usr/lib/python2.7/subprocess.py", line 476, in _eintr_retry_call
    return func(*args)
  File "/b/swarming/w/ir/cache/cbuild/repository/chromite/lib/timeout_util.py", line 88, in kill_us
    raise TimeoutError(error_message % {'time': max_run_time})
TimeoutError: Timeout occurred- waited 7200.0 seconds. Reached VMTestStage test run timeout.

05:07:58: INFO: Running cidb query on pid 14897, repr(query) starts with <sqlalchemy.sql.expression.Update object at 0x7f5780b3aa90>
The bot's issue is  crbug.com/915416 . It (timeout/storage issue) won't happen if you run tets manually, but you get this error instead.

I assume the same error will happen once 915416 is resolved.

Re oshima: you seemed linked a wrong bug. 

The failed test changed again. Now it failed /tmp/cbuildbotd2n4q_/telemetry_unit_server/test_harness/all/SimpleTestVerify/1_autotest_tests/results-3-telemetry_UnitTestsServer_perf/telemetry_UnitTestsServer.perf and /tmp/cbuildbotd2n4q_/telemetry_unit_server/test_harness/all/SimpleTestVerify/1_autotest_tests/results-3-telemetry_UnitTestsServer_perf/telemetry_UnitTestsServer.perf/telemetry_UnitTests unittests.

achuith@, do you know who should be the right owner to take a look at telemetry tests failure?
Cc: mukai@chromium.org
Owner: glevin@chromium.org
Yes, it looks like the previous failures in the unit test stage have stopped? The perf stage is failing with an import pandas failure, which is the same as:
https://bugs.chromium.org/p/chromium/issues/detail?id=908662

Cc: -mukai@chromium.org glevin@chromium.org
Owner: mukai@chromium.org
Status: Fixed (was: Available)
Confirmed reproducing this locally, but the test failure is gone after updating the chrome through simple-chrome workflow. I think that means it's been fixed already.

Sign in to add a comment