New issue
Advanced search Search tips
Note: Color blocks (like or ) mean that a user may not be available. Tooltip shows the reason.

Issue 661233 link

Starred by 1 user

Issue metadata

Status: Verified
Owner:
Closed: Nov 2016
Cc:
Components:
EstimatedDays: ----
NextAction: ----
OS: Android
Pri: 1
Type: Bug-Regression



Sign in to add a comment

maps_pixel_test failing on Android, Nexus 5X in particular

Project Member Reported by kbr@chromium.org, Nov 1 2016

Issue description

maps_pixel_test became flaky on the Nexus 5X within the past few days. Please see this bot:
https://build.chromium.org/p/chromium.gpu.fyi/builders/Android%20Release%20%28Nexus%205X%29?numbuilds=200

The first build in which it flaked included this Catapult roll:

https://chromium.googlesource.com/chromium/src/+/66729904d0d4b9a00dd671db4714cbc7e40495d0

Could the ADB roll that was part of that roll have introduced this flakiness?

Here's a log excerpt from one of the recent failing builds. John, could you please take this on?

https://build.chromium.org/p/chromium.gpu.fyi/builders/Android%20Release%20%28Nexus%205X%29/builds/3631

[ RUN      ] Maps.maps_004
...
(INFO) 2016-11-01 10:09:54,551 browser.DumpStateUponFailure:350  *************** BROWSER STANDARD OUTPUT ***************
(INFO) 2016-11-01 10:09:54,551 browser.DumpStateUponFailure:352  Cannot get standard output on Android
(INFO) 2016-11-01 10:09:54,551 browser.DumpStateUponFailure:355  *********** END OF BROWSER STANDARD OUTPUT ************
(INFO) 2016-11-01 10:09:54,551 browser.DumpStateUponFailure:357  ********************* BROWSER LOG *********************
(INFO) 2016-11-01 10:09:54,551 browser.DumpStateUponFailure:359  No log file
(INFO) 2016-11-01 10:09:54,551 browser.DumpStateUponFailure:362  ***************** END OF BROWSER LOG ******************
...
Traceback (most recent call last):
...
  File "/b/swarm_slave/w/irx8C1hz/third_party/catapult/telemetry/third_party/websocket-client/websocket.py", line 746, in _recv_strict
    bytes = self._recv(shortage)
  File "/b/swarm_slave/w/irx8C1hz/third_party/catapult/telemetry/third_party/websocket-client/websocket.py", line 739, in _recv
    raise WebSocketConnectionClosedException()
DevtoolsTargetCrashException: Devtools target crashed
********************************************************************************
(/b/swarm_slave/w/irx8C1hz/third_party/catapult/telemetry/telemetry/internal/backends/chrome_inspector/inspector_backend.py:397 _ConvertExceptionFromInspectorWebsocket) Original exception:

********************************************************************************
(/b/swarm_slave/w/irx8C1hz/third_party/catapult/telemetry/telemetry/internal/backends/chrome_inspector/inspector_backend.py:418 _AddDebuggingInformation) Received a socket error in the browser connection and the tab no longer exists. The tab probably crashed.
********************************************************************************
(/b/swarm_slave/w/irx8C1hz/third_party/catapult/telemetry/telemetry/internal/backends/chrome_inspector/inspector_backend.py:419 _AddDebuggingInformation) Debugger url: ws://127.0.0.1:37407/devtools/page/0
Found Minidump: True
Stack Trace:
********************************************************************************
	UI dump
	- (no package):
	  - (no id)
	- org.chromium.chrome:
	  - (no id)
	  - android:id/content
	  - map_div
	  - org.chromium.chrome:id/action_bar_root
	  - org.chromium.chrome:id/compositor_view_holder
	  - org.chromium.chrome:id/control_container
	  - org.chromium.chrome:id/location_bar
	  - org.chromium.chrome:id/menu_button
	  - org.chromium.chrome:id/menu_button_wrapper
	  - org.chromium.chrome:id/tab_switcher_button
	  - org.chromium.chrome:id/toolbar
	  - org.chromium.chrome:id/toolbar_buttons
	  - org.chromium.chrome:id/toolbar_container
	  - org.chromium.chrome:id/toolbar_shadow
	  - org.chromium.chrome:id/url_bar['map-test/performance.html']
	********************************************************************************
	Logcat
	--------- beginning of main
	11-01 17:09:45.117 24538 24538 D AndroidRuntime: >>>>>> START com.android.internal.os.RuntimeInit uid 0 <<<<<<
	11-01 17:09:45.124 24538 24538 D AndroidRuntime: CheckJNI is OFF
	11-01 17:09:45.153 24538 24538 D ICU     : No timezone override file found: /data/misc/zoneinfo/current/icu/icu_tzdata.dat
	11-01 17:09:45.189 24538 24538 I Radio-JNI: register_android_hardware_Radio DONE
	11-01 17:09:45.206 24538 24538 D AndroidRuntime: Calling main entry com.android.commands.am.Am
	--------- beginning of system
	11-01 17:09:45.209   945  4066 I ActivityManager: START u0 {dat=about:blank flg=0x10000000 cmp=org.chromium.chrome/com.google.android.apps.chrome.Main} from uid 0 on display 0
	11-01 17:09:45.222  4217  4233 W SearchService: Abort, client detached.
	11-01 17:09:45.227  4217  4217 I HotwordDetector: Closing mic
	11-01 17:09:45.227  4217  4591 I MicrophoneInputStream: mic_close com.google.android.apps.gsa.speech.audio.x@77184f5
	11-01 17:09:45.227  4217 24173 E AudioRecord-JNI: Error -4 during AudioRecord native read
	11-01 17:09:45.235   945  5287 I ActivityManager: Start proc 24546:org.chromium.chrome/u0a160 for activity org.chromium.chrome/com.google.android.apps.chrome.Main
	11-01 17:09:45.281   666 24175 D audio_hw_primary: disable_audio_route: reset and update mixer path: audio-record
	11-01 17:09:45.282   666 24175 D audio_hw_primary: disable_snd_device: snd_device(61: voice-rec-mic)
	11-01 17:09:45.284   666 24175 I soundtrigger: audio_extn_sound_trigger_update_device_status: device 0x3d of type 1 for Event 0
	11-01 17:09:45.284   666 24175 D sound_trigger_platform: platform_stdev_check_and_update_concurrency: concurrency active 0, tx 0, rx 0, concurrency session_allowed 1
	11-01 17:09:45.285   666  3135 I SoundTriggerHwService::Module: void android::SoundTriggerHwService::Module::onCallbackEvent(const android::sp<android::SoundTriggerHwService::CallbackEvent>&) mClient == 0
	11-01 17:09:45.286  4217  4593 I MicroRecognitionRnrImpl: Stopping hotword detection.
	11-01 17:09:45.286  4217 24172 I MicroRecognitionRnrImpl: Detection finished
	11-01 17:09:45.300 24546 24546 I cr_InstantAppsHandler: Not handling with Instant Apps
	11-01 17:09:45.304   945   957 I ActivityManager: START u0 {dat=about:blank flg=0x14002000 cmp=org.chromium.chrome/.browser.ChromeTabbedActivity (has extras)} from uid 10160 on display 0
	11-01 17:09:45.413 24546 24568 I cr_LibraryLoader: Using linker: org.chromium.base.library_loader.ModernLinker
	11-01 17:09:45.417 24546 24569 I cr_base : Extracting resource /data/user/0/org.chromium.chrome/app_chrome/paks/en-GB.pak
	11-01 17:09:45.422 24546 24570 W cr_tabmodel: Starting to perform legacy migration.
	11-01 17:09:45.423 24546 24569 I cr_base : Extracting resource /data/user/0/org.chromium.chrome/app_chrome/paks/en-US.pak
	11-01 17:09:45.425 24546 24570 W cr_tabmodel: Finished performing legacy migration.
	11-01 17:09:45.425 24546 24570 W cr_tabmodel: Starting to perform multi-instance migration.
	11-01 17:09:45.426 24546 24570 W cr_tabmodel: Finished performing multi-instance migration.
	11-01 17:09:45.427 24546 24571 W cr_tabmodel: Starting to fetch tab list.
	11-01 17:09:45.428 24546 24571 E cr_tabmodel: State file does not exist.
	11-01 17:09:45.430 24546 24572 D OpenGLRenderer: Use EGL_SWAP_BEHAVIOR_PRESERVED: true
	11-01 17:09:45.432 24546 24568 I cr_LibraryLoader: Loading chrome from within /data/app/org.chromium.chrome-1/base.apk
	11-01 17:09:45.488 24546 24572 I Adreno  : QUALCOMM build                   : 63c06b2, I8366cd0437
	11-01 17:09:45.488 24546 24572 I Adreno  : Build Date                       : 10/21/15
	11-01 17:09:45.488 24546 24572 I Adreno  : OpenGL ES Shader Compiler Version: XE031.05.13.02
	11-01 17:09:45.488 24546 24572 I Adreno  : Local Branch                     : 
	11-01 17:09:45.488 24546 24572 I Adreno  : Remote Branch                    : quic/LA.BF64.1.2.9_v2
	11-01 17:09:45.488 24546 24572 I Adreno  : Remote Branch                    : NONE
	11-01 17:09:45.488 24546 24572 I Adreno  : Reconstruct Branch               : NOTHING
	11-01 17:09:45.514 24546 24572 I OpenGLRenderer: Initialized EGL, version 1.4
	11-01 17:09:45.536 24546 24568 I cr_LibraryLoader: Time to load native libraries: 123 ms (timestamps 8466-8589)
	11-01 17:09:45.537 24546 24568 I cr_LibraryLoader: Expected native library version number "56.0.2907.0", actual native library version number "56.0.2907.0"
	11-01 17:09:45.537 24546 24568 W chromium: [1101/170945:WARNING:trace_config_file.cc(80)] The trace config file does not exist.
	11-01 17:09:45.537 24546 24568 I chromium: [INFO:library_loader_hooks.cc(163)] Chromium logging enabled: level = 0, default verbosity = 0
	11-01 17:09:45.539 24546 24568 W cr_ChildProcLauncher: Create a new ChildConnectionAllocator with package name = org.chromium.chrome, inSandbox = true
	11-01 17:09:45.553   945   956 I ActivityManager: Start proc 24575:org.chromium.chrome:sandboxed_process0/u0i52 for service org.chromium.chrome/org.chromium.content.app.SandboxedProcessService0
	11-01 17:09:45.569 24575 24575 W dboxed_process0: type=1400 audit(0.0:634): avc: denied { search } for name="tmp" dev="dm-2" ino=384274 scontext=u:r:isolated_app:s0:c512,c768 tcontext=u:object_r:shell_data_file:s0 tclass=dir permissive=0
	11-01 17:09:45.586 24575 24575 I cr_ChildProcessService: Creating new ChildProcessService pid=24575
	11-01 17:09:45.629   945   970 I ActivityManager: Displayed org.chromium.chrome/.browser.ChromeTabbedActivity: +319ms (total +404ms)
	11-01 17:09:45.630 24538 24538 D AndroidRuntime: Shutting down VM
	11-01 17:09:45.632  3873  3873 I Keyboard.Facilitator: onFinishInput()
	11-01 17:09:45.662 24546 24546 I cr_BrowserStartup: Initializing chromium process, singleProcess=false
	11-01 17:09:45.679 24546 24590 W chromium: [WARNING:dns_config_service_posix.cc(316)] Failed to read DnsConfig.
	11-01 17:09:45.740 24546 24546 E chromium: [ERROR:shell_integration_android.cc(22)] Not implemented reached in shell_integration::DefaultWebClientSetPermission shell_integration::GetDefaultWebClientSetPermission()
	11-01 17:09:45.745 24546 24546 W GooglePlayServicesUtil: Google Play services out of date.  Requires 9877000 but found 8186448
	11-01 17:09:45.768   945  3544 I ActivityManager: Start proc 24611:org.chromium.chrome:privileged_process0/u0a160 for service org.chromium.chrome/org.chromium.content.app.PrivilegedProcessService0
	11-01 17:09:45.787 24546 24546 W GooglePlayServicesUtil: Google Play services out of date.  Requires 9877000 but found 8186448
	11-01 17:09:45.787 24546 24546 I cr_SnippetsLauncher: Disabling SnippetsLauncher because Play Services is not up to date.
	11-01 17:09:45.811   945  3925 D ConnectivityService: listenForNetwork for Listen from uid/pid:10160/24546 for NetworkRequest [ id=309, legacyType=-1, [ Capabilities: INTERNET&NOT_RESTRICTED&TRUSTED] ]
	11-01 17:09:45.813 24611 24611 I cr_ChildProcessService: Creating new ChildProcessService pid=24611
	11-01 17:09:45.814 24546 24546 W GooglePlayServicesUtil: Google Play services out of date.  Requires 9877000 but found 8186448
	11-01 17:09:45.814 24546 24546 I cr_BgSyncLauncher: Disabling Background Sync because Play Services is not up to date.
	11-01 17:09:45.819 24611 24630 I cr_LibraryLoader: Using linker: org.chromium.base.library_loader.ModernLinker
	11-01 17:09:45.834 24611 24630 I cr_LibraryLoader: Loading chrome from within /data/app/org.chromium.chrome-1/base.apk
	11-01 17:09:45.843   945  3298 D ConnectivityService: listenForNetwork for Listen from uid/pid:10160/24546 for NetworkRequest [ id=310, legacyType=-1, [ Capabilities: INTERNET&NOT_RESTRICTED&TRUSTED] ]
	11-01 17:09:45.876 24611 24630 I cr_LibraryLoader: Time to load native libraries: 55 ms (timestamps 8874-8929)
	11-01 17:09:45.876 24611 24630 I cr_LibraryLoader: Expected native library version number "56.0.2907.0", actual native library version number "56.0.2907.0"
	11-01 17:09:45.877 24611 24630 W chromium: [1101/170945:WARNING:trace_config_file.cc(80)] The trace config file does not exist.
	11-01 17:09:45.877 24611 24630 I chromium: [INFO:library_loader_hooks.cc(163)] Chromium logging enabled: level = 0, default verbosity = 0
	11-01 17:09:45.891 24611 24630 E libEGL  : validate_display:255 error 3008 (EGL_BAD_DISPLAY)
	11-01 17:09:45.891 24611 24630 I Adreno  : QUALCOMM build                   : 63c06b2, I8366cd0437
	11-01 17:09:45.891 24611 24630 I Adreno  : Build Date                       : 10/21/15
	11-01 17:09:45.891 24611 24630 I Adreno  : OpenGL ES Shader Compiler Version: XE031.05.13.02
	11-01 17:09:45.891 24611 24630 I Adreno  : Local Branch                     : 
	11-01 17:09:45.891 24611 24630 I Adreno  : Remote Branch                    : quic/LA.BF64.1.2.9_v2
	11-01 17:09:45.891 24611 24630 I Adreno  : Remote Branch                    : NONE
	11-01 17:09:45.891 24611 24630 I Adreno  : Reconstruct Branch               : NOTHING
	11-01 17:09:45.919 24586 24586 W Binder_1: type=1400 audit(0.0:635): avc: denied { ioctl } for path="socket:[91023]" dev="sockfs" ino=91023 ioctlcmd=7704 scontext=u:r:isolated_app:s0:c512,c768 tcontext=u:r:untrusted_app:s0:c512,c768 tclass=unix_stream_socket permissive=0
	11-01 17:09:45.919 24586 24586 W Binder_1: type=1400 audit(0.0:636): avc: denied { ioctl } for path="/data/data/org.chromium.chrome/app_chrome/paks/en-US.pak" dev="dm-2" ino=581599 ioctlcmd=7704 scontext=u:r:isolated_app:s0:c512,c768 tcontext=u:object_r:app_data_file:s0:c512,c768 tclass=file permissive=0
	11-01 17:09:45.919 24586 24586 W Binder_1: type=1400 audit(0.0:637): avc: denied { ioctl } for path=2F646174612F646174612F6F72672E6368726F6D69756D2E6368726F6D652F6170705F6368726F6D652F52454C524F3A6C69626368726F6D652E736F202864656C6574656429 dev="dm-2" ino=581611 ioctlcmd=7704 scontext=u:r:isolated_app:s0:c512,c768 tcontext=u:object_r:app_data_file:s0:c512,c768 tclass=file permissive=0
	11-01 17:09:45.919 24586 24586 W Binder_1: type=1400 audit(0.0:638): avc: denied { ioctl } for path=2F646174612F646174612F6F72672E6368726F6D69756D2E6368726F6D652F6170705F6368726F6D652F52454C524F3A6C69626368726F6D652E736F202864656C6574656429 dev="dm-2" ino=581611 ioctlcmd=7704 scontext=u:r:isolated_app:s0:c512,c768 tcontext=u:object_r:app_data_file:s0:c512,c768 tclass=file permissive=0
	11-01 17:09:45.919 24586 24586 W Binder_1: type=1400 audit(0.0:639): avc: denied { ioctl } for path=2F646174612F646174612F6F72672E6368726F6D69756D2E6368726F6D652F6170705F6368726F6D652F52454C524F3A6C69626368726F6D652E736F202864656C6574656429 dev="dm-2" ino=581611 ioctlcmd=7704 scontext=u:r:isolated_app:s0:c512,c768 tcontext=u:object_r:app_data_file:s0:c512,c768 tclass=file permissive=0
	11-01 17:09:45.919 24586 24586 W Binder_1: type=1400 audit(0.0:640): avc: denied { ioctl } for path="/data/data/org.chromium.chrome/app_chrome/paks/en-US.pak" dev="dm-2" ino=581599 ioctlcmd=7704 scontext=u:r:isolated_app:s0:c512,c768 tcontext=u:object_r:app_data_file:s0:c512,c768 tclass=file permissive=0
	11-01 17:09:45.919 24586 24586 W Binder_1: type=1400 audit(0.0:641): avc: denied { ioctl } for path="socket:[91023]" dev="sockfs" ino=91023 ioctlcmd=7704 scontext=u:r:isolated_app:s0:c512,c768 tcontext=u:r:untrusted_app:s0:c512,c768 tclass=unix_stream_socket permissive=0
	11-01 17:09:45.919 24586 24586 W Binder_1: type=1400 audit(0.0:642): avc: denied { ioctl } for path=2F646174612F646174612F6F72672E6368726F6D69756D2E6368726F6D652F6170705F6368726F6D652F52454C524F3A6C69626368726F6D652E736F202864656C6574656429 dev="dm-2" ino=581611 ioctlcmd=7704 scontext=u:r:isolated_app:s0:c512,c768 tcontext=u:object_r:app_data_file:s0:c512,c768 tclass=file permissive=0
	11-01 17:09:45.929   945   969 D BluetoothManagerService: Added callback: android.bluetooth.IBluetoothManagerCallback$Stub$Proxy@a5c5845:true
	11-01 17:09:45.931 24575 24586 I cr_LibraryLoader: Using linker: org.chromium.base.library_loader.ModernLinker
	11-01 17:09:45.949 24611 24630 W VideoCapabilities: Unrecognized profile 2130706433 for video/avc
	11-01 17:09:45.949 24575 24588 I cr_LibraryLoader: Loading chrome from within /data/app/org.chromium.chrome-1/base.apk
	11-01 17:09:45.962 24546 24546 W GooglePlayServicesUtil: Google Play services out of date.  Requires 9877000 but found 8186448
	11-01 17:09:45.967 24611 24630 I VideoCapabilities: Unsupported profile 4 for video/mp4v-es
	11-01 17:09:45.991 24575 24588 I cr_LibraryLoader: Time to load native libraries: 59 ms (timestamps 8986-9045)
	11-01 17:09:45.992 24546 24592 I X509Util: Failed to validate the certificate chain, error: java.security.cert.CertPathValidatorException: Trust anchor for certification path not found.
	11-01 17:09:45.992 24575 24588 I cr_LibraryLoader: Expected native library version number "56.0.2907.0", actual native library version number "56.0.2907.0"
	11-01 17:09:45.992 24575 24588 W chromium: [1101/170945:WARNING:trace_config_file.cc(80)] The trace config file does not exist.
	11-01 17:09:45.993 24575 24588 I chromium: [INFO:library_loader_hooks.cc(163)] Chromium logging enabled: level = 0, default verbosity = 0
	11-01 17:09:45.993  3873  3873 I Keyboard.Facilitator: onFinishInput()
	11-01 17:09:45.994 24546 24591 I X509Util: Failed to validate the certificate chain, error: java.security.cert.CertPathValidatorException: Trust anchor for certification path not found.
	11-01 17:09:46.069 24546 24546 I cr_Ime  : ImeThread is enabled.
	11-01 17:09:46.209 24546 24546 I cr_BindingManager: Moderate binding enabled: maxSize=20
	11-01 17:09:46.217 24546 24636 W cr_CrashFileManager: /data/user/0/org.chromium.chrome/cache/Crash Reports does not exist or is not a directory
	11-01 17:09:46.217 24546 24651 W cr_CrashFileManager: /data/user/0/org.chromium.chrome/cache/Crash Reports does not exist or is not a directory
	11-01 17:09:46.217 24546 24636 W cr_CrashFileManager: /data/user/0/org.chromium.chrome/cache/Crash Reports does not exist or is not a directory
	11-01 17:09:46.217 24546 24636 W cr_CrashFileManager: /data/user/0/org.chromium.chrome/cache/Crash Reports does not exist or is not a directory
	11-01 17:09:46.217 24546 24651 W cr_CrashFileManager: /data/user/0/org.chromium.chrome/cache/Crash Reports does not exist or is not a directory
	11-01 17:09:46.217 24546 24651 I cr_MinidmpUploadService: Attempting to upload accumulated crash dumps.
	11-01 17:09:46.227 24546 24652 W GooglePlayServicesUtil: Google Play services out of date.  Requires 9877000 but found 8186448
	11-01 17:09:46.265 24546 24546 I cr_PhysicalWeb: Nearby connection failed: ConnectionResult{statusCode=SERVICE_VERSION_UPDATE_REQUIRED, resolution=null, message=null}
	11-01 17:09:46.275 24546 24546 W GooglePlayServicesUtil: Google Play services out of date.  Requires 9877000 but found 8186448
	11-01 17:09:46.277 24546 24546 W GooglePlayServicesUtil: Google Play services out of date.  Requires 9877000 but found 8186448
	11-01 17:09:46.437 24546 24606 E cr_SafeBrowsingApi: Failed to init handler: Attempt to invoke virtual method 'java.lang.Object java.lang.Class.newInstance()' on a null object reference
	11-01 17:09:47.646 24575 24588 I chromium: [INFO:SkFontMgr_android.cpp(163)] Requested font file /system/fonts/NanumGothic.ttf does not exist or cannot be opened.
	11-01 17:09:47.646 24575 24588 I chromium: 
	11-01 17:09:47.647 24575 24588 I chromium: [INFO:SkFontMgr_android.cpp(163)] Requested font file /system/fonts/DroidSansFallback.ttf does not exist or cannot be opened.
	11-01 17:09:47.647 24575 24588 I chromium: 
	11-01 17:09:47.647 24575 24588 I chromium: [INFO:SkFontMgr_android.cpp(163)] Requested font file /system/fonts/MTLmr3m.ttf does not exist or cannot be opened.
	11-01 17:09:47.647 24575 24588 I chromium: 
	11-01 17:09:47.688  3840  3840 I ConfigService: onDestroy
	11-01 17:09:48.687  8222 24432 E chromium: [1101/170948:ERROR:socket.cc(357)] send: Broken pipe
	11-01 17:09:48.687  8222 24432 E chromium: [1101/170948:ERROR:socket.cc(334)] read: Bad file descriptor
	11-01 17:09:48.687  8222 24432 E chromium: [1101/170948:ERROR:command.cc(65)] Read() error, endpoint was unexpectedly closed.
	11-01 17:09:48.687  8222 24432 E chromium: [1101/170948:ERROR:socket.cc(357)] send: Bad file descriptor
	11-01 17:09:48.687  8222 24432 E chromium: [1101/170948:ERROR:device_listener.cc(102)] Host could not connect to server.
	11-01 17:09:48.688  8222 24432 E chromium: [1101/170948:ERROR:device_listener.cc(105)] Adb Control connection lost. Listener port: 38492
	11-01 17:09:48.690 24546 24546 I chromium: [INFO:CONSOLE(98)] "Uncaught CustomError: Error in protected function: Failed to load dataset.", source: http://map-test/tracked.js (98)
	11-01 17:09:52.021 24672 24672 D AndroidRuntime: >>>>>> START com.android.internal.os.RuntimeInit uid 0 <<<<<<
	11-01 17:09:52.026 24672 24672 D AndroidRuntime: CheckJNI is OFF
	11-01 17:09:52.061 24672 24672 D ICU     : No timezone override file found: /data/misc/zoneinfo/current/icu/icu_tzdata.dat
	11-01 17:09:52.122 24672 24672 I Radio-JNI: register_android_hardware_Radio DONE
	11-01 17:09:52.142 24672 24672 D AndroidRuntime: Calling main entry com.android.commands.uiautomator.Launcher
	11-01 17:09:53.225 24672 24672 I AccessibilityNodeInfoDumper: Skipping invisible child: android.view.accessibility.AccessibilityNodeInfo@8000b7d3; boundsInParent: Rect(0, 0 - 1, 5); boundsInScreen: Rect(1, 205 - 1, 210); packageName: org.chromium.chrome; className: android.widget.ImageView; text: null; error: null; maxTextLength: -1; contentDescription: null; viewIdResName: null; checkable: false; checked: false; focusable: false; focused: false; selected: false; clickable: false; longClickable: false; contextClickable: false; enabled: true; password: false; scrollable: false; actions: [AccessibilityAction: ACTION_SELECT - null, AccessibilityAction: ACTION_CLEAR_SELECTION - null, AccessibilityAction: ACTION_ACCESSIBILITY_FOCUS - null, AccessibilityAction: ACTION_UNKNOWN - null]
	11-01 17:09:53.225 24672 24672 I AccessibilityNodeInfoDumper: Skipping invisible child: android.view.accessibility.AccessibilityNodeInfo@8000ac90; boundsInParent: Rect(0, 0 - 0, 0); boundsInScreen: Rect(0, 1794 - 0, 1794); packageName: org.chromium.chrome; className: android.view.View; text: null; error: null; maxTextLength: -1; contentDescription: null; viewIdResName: org.chromium.chrome:id/menu_anchor_stub; checkable: false; checked: false; focusable: false; focused: false; selected: false; clickable: false; longClickable: false; contextClickable: false; enabled: true; password: false; scrollable: false; actions: [AccessibilityAction: ACTION_SELECT - null, AccessibilityAction: ACTION_CLEAR_SELECTION - null, AccessibilityAction: ACTION_ACCESSIBILITY_FOCUS - null, AccessibilityAction: ACTION_UNKNOWN - null]
	11-01 17:09:53.226 24672 24672 W AccessibilityNodeInfoDumper: Fetch time: 17ms
	11-01 17:09:53.227   945  4046 W WindowManager: Attempted to remove non-existing token: android.os.Binder@37a168f
	11-01 17:09:53.231 24672 24672 D AndroidRuntime: Shutting down VM
Traceback (most recent call last):
  RunBenchmark at /b/swarm_slave/w/irx8C1hz/third_party/catapult/telemetry/telemetry/internal/story_runner.py:343
    benchmark.ShouldTearDownStateAfterEachStorySetRun())
  Run at /b/swarm_slave/w/irx8C1hz/third_party/catapult/telemetry/telemetry/internal/story_runner.py:237
    state.TearDownState()
  traced_function at /b/swarm_slave/w/irx8C1hz/third_party/catapult/common/py_trace_event/py_trace_event/trace_event_impl/decorators.py:52
    return func(*args, **kwargs)
  TearDownState at /b/swarm_slave/w/irx8C1hz/third_party/catapult/telemetry/telemetry/page/shared_page_state.py:311
    self._StopBrowser()
  traced_function at /b/swarm_slave/w/irx8C1hz/third_party/catapult/common/py_trace_event/py_trace_event/trace_event_impl/decorators.py:52
    return func(*args, **kwargs)
  _StopBrowser at /b/swarm_slave/w/irx8C1hz/third_party/catapult/telemetry/telemetry/page/shared_page_state.py:317
    self._browser.Close()
  Close at /b/swarm_slave/w/irx8C1hz/third_party/catapult/telemetry/telemetry/internal/browser/browser.py:265
    self._browser_backend.Close()
  traced_function at /b/swarm_slave/w/irx8C1hz/third_party/catapult/common/py_trace_event/py_trace_event/trace_event_impl/decorators.py:52
    return func(*args, **kwargs)
  Close at /b/swarm_slave/w/irx8C1hz/third_party/catapult/telemetry/telemetry/internal/backends/chrome/android_browser_backend.py:227
    self.platform_backend.StopForwardingHost(self._port)
  StopForwardingHost at /b/swarm_slave/w/irx8C1hz/third_party/catapult/telemetry/telemetry/internal/platform/android_platform_backend.py:500
    self._device.adb.ForwardRemove('tcp:%d' % host_port)
  ForwardRemove at /b/swarm_slave/w/irx8C1hz/third_party/catapult/devil/devil/android/sdk/adb_wrapper.py:632
    retries)
  _RunDeviceAdbCmd at /b/swarm_slave/w/irx8C1hz/third_party/catapult/devil/devil/android/sdk/adb_wrapper.py:282
    check_error=check_error)
  timeout_retry_wrapper at /b/swarm_slave/w/irx8C1hz/third_party/catapult/devil/devil/android/decorators.py:57
    retry_if_func=retry_if_func)
  Run at /b/swarm_slave/w/irx8C1hz/third_party/catapult/devil/devil/utils/timeout_retry.py:159
    error_log_func=error_log_func)
  JoinAll at /b/swarm_slave/w/irx8C1hz/third_party/catapult/devil/devil/utils/reraiser_thread.py:186
    self._JoinAll(watcher, timeout)
  _JoinAll at /b/swarm_slave/w/irx8C1hz/third_party/catapult/devil/devil/utils/reraiser_thread.py:158
    thread.ReraiseIfException()
  run at /b/swarm_slave/w/irx8C1hz/third_party/catapult/devil/devil/utils/reraiser_thread.py:81
    self._ret = self._func(*self._args, **self._kwargs)
  <lambda> at /b/swarm_slave/w/irx8C1hz/third_party/catapult/devil/devil/utils/timeout_retry.py:152
    child_thread = reraiser_thread.ReraiserThread(lambda: func(*args, **kwargs),
  impl at /b/swarm_slave/w/irx8C1hz/third_party/catapult/devil/devil/android/decorators.py:47
    return f(*args, **kwargs)
  _RunAdbCmd at /b/swarm_slave/w/irx8C1hz/third_party/catapult/devil/devil/android/sdk/adb_wrapper.py:258
    args, output, status, device_serial)
AdbCommandFailedError: (device: 00e9e2595190c062) adb forward --remove tcp:37407: failed with exit status 1 and output:
- error: listener 'tcp:37407' not found

Locals:
  args          : ['forward', '--remove', 'tcp:37407']
  check_error   : True
  cls           : <class 'devil.android.sdk.adb_wrapper.AdbWrapper'>
  cpu_affinity  : None
  device_serial : '00e9e2595190c062'
  output        : "error: listener 'tcp:37407' not found\n"
  retries       : 2
  status        : 1
  timeout       : 30

 
Yeah, this is probably due to the adb roll. I'm sheriffing today and probably won't have a chance to look at it until later in the week. I can revert it if you'd like.

I need a "fun with adb" hotlist.


Labels: Hotlist-FunWithAdb
Reverting adb roll sounds like a good option. Either it will make the CQ
bot green, which we really need. Or, at least we'll know it's not the one
causing problems.

failing on Android, Nexus 5X in particular
Revert here: https://codereview.chromium.org/2464173002/

Once it lands, it'll likely take a couple of hours to roll into chromium.
Labels: OS-Android
maps_pixel_test is stable after the adb roll revert landed.

Comment 6 by kbr@chromium.org, Nov 2 2016

Status: Verified (was: Assigned)
Fantastic. Thanks Yuly for tracking this down and John for fixing it.

Sign in to add a comment