Back to build
Raw log | Switch to full mode | Login

adb logcat -d -v threadtime in dir /b/swarming/w/ir/k: allow_subannotations: False cmd: ['adb', 'logcat', '-d', '-v', 'threadtime'] env: {'ADB': '/b/swarming/w/ir/k/prebuilts/runtime/adb', 'ANDROID_BUILD_TOP': '/b/swarming/w/ir/k', 'ANDROID_PRODUCT_OUT': '/b/swarming/w/ir/k/out/target/product/silvermont', 'ART_BUILD_HOST_DEBUG': 'false', 'ART_HEAP_POISONING': 'false', 'ART_TEST_ANDROID_RUNTIME_ROOT': '/system', 'ART_TEST_CHROOT': '/data/local/art-test-chroot', 'ART_TEST_KEEP_GOING': 'true', 'ART_TEST_NO_SYNC': 'true', 'ART_TEST_RUN_TEST_2ND_ARCH': 'false', 'ART_USE_GENERATIONAL_CC': 'true', 'ART_USE_READ_BARRIER': 'true', 'LANG': 'en_US.UTF-8', 'PATH': '/b/swarming/w/ir/k/out/host/linux-x86/bin:/b/swarming/w/ir/k/prebuilts/jdk/jdk9/linux-x86/bin:/b/swarming/w/ir/k/prebuilts/runtime:%(PATH)s', 'SOONG_ALLOW_MISSING_DEPENDENCIES': 'true', 'TARGET_BUILD_TYPE': 'release', 'TARGET_BUILD_VARIANT': 'eng', 'TARGET_PRODUCT': 'silvermont', 'TEMPORARY_DISABLE_PATH_RESTRICTIONS': 'true', 'USE_DEX2OAT_DEBUG': 'false'} env_prefixes: {} env_suffixes: {} infra_step: False name_tokens: ('test speed-profile: adb logcat',) ok_ret: frozenset([0]) trigger_specs: () full environment: ADB: /b/swarming/w/ir/k/prebuilts/runtime/adb ADB_LIBUSB: 0 ANDROID_BUILD_TOP: /b/swarming/w/ir/k ANDROID_PRODUCT_OUT: /b/swarming/w/ir/k/out/target/product/silvermont ART_BUILD_HOST_DEBUG: false ART_HEAP_POISONING: false ART_TEST_ANDROID_RUNTIME_ROOT: /system ART_TEST_CHROOT: /data/local/art-test-chroot ART_TEST_KEEP_GOING: true ART_TEST_NO_SYNC: true ART_TEST_RUN_TEST_2ND_ARCH: false ART_USE_GENERATIONAL_CC: true ART_USE_READ_BARRIER: true BOTO_CONFIG: /b/swarming/w/ir/tmp/gsutil_task/.boto BUILDBUCKET_EXPERIMENTAL: TRUE CHROMIUM_REV: e41aeaed051c8cc401e0bce2a6d57dcc330808e6 CIPD_CACHE_DIR: /b/swarming/cipd_cache/cache CIPD_PROTOCOL: v2 DEBIAN_FRONTEND: noninteractive DEVSHELL_CLIENT_PORT: 36127 DOCKER_CONFIG: /b/swarming/w/ir/tmp/docker_cfg_task DOCKER_HOST_HOSTNAME: build347-a9.labs.chromium.org DOCKER_TMPDIR: /b/swarming/w/ir/tmp/docker_tmp_task GIT_CONFIG_NOSYSTEM: 1 GIT_TERMINAL_PROMPT: 0 HOME: /home/chrome-bot HOSTNAME: build347-a9--device3 INFRA_GIT_WRAPPER_HOME: /b/swarming/w/ir/tmp/git_home_task ISOLATED_CACHE_SIZE: 88041570304 LANG: en_US.UTF-8 LANGUAGE: en_US:en LC_ALL: en_US.UTF-8 LOGDOG_COORDINATOR_HOST: logs.chromium.org LOGDOG_STREAM_PREFIX: buildbucket/cr-buildbucket.appspot.com/8918012436446027328 LOGDOG_STREAM_PROJECT: art LOGDOG_STREAM_SERVER_PATH: unix:/b/swarming/w/ir/tmp/ld.sock LOGNAME: chrome-bot LUCI_CONTEXT: /b/swarming/w/itVKvM2L/luci_context.700733966 MAC_CHROMIUM_TMPDIR: /b/swarming/w/ir/tmp/t MAIL: /var/mail/chrome-bot NO_GCE_CHECK: False NUM_CONFIGURED_CONTAINERS: 3 PATH: /b/swarming/w/ir/k/out/host/linux-x86/bin:/b/swarming/w/ir/k/prebuilts/jdk/jdk9/linux-x86/bin:/b/swarming/w/ir/k/prebuilts/runtime:/b/swarming/w/ir/cipd_bin_packages:/b/swarming/w/ir/cipd_bin_packages/bin:/b/swarming/cipd_cache/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/games:/usr/local/games PWD: /b/swarming/w/ir/k PYTHONIOENCODING: UTF-8 PYTHONUNBUFFERED: 1 SHELL: /bin/bash SHLVL: 3 SOONG_ALLOW_MISSING_DEPENDENCIES: true SWARMING_BOT_ID: build347-a9--device3 SWARMING_HEADLESS: 1 SWARMING_SERVER: https://chromium-swarm.appspot.com SWARMING_TASK_ID: 43cdaf06459bd811 SWARM_URL: https://chromium-swarm.appspot.com/bot_code TARGET_BUILD_TYPE: release TARGET_BUILD_VARIANT: eng TARGET_PRODUCT: silvermont TEMP: /b/swarming/w/ir/tmp/t TEMPDIR: /b/swarming/w/ir/tmp/t TEMPORARY_DISABLE_PATH_RESTRICTIONS: true TMP: /b/swarming/w/ir/tmp/t TMPDIR: /b/swarming/w/ir/tmp/t USER: chrome-bot USE_DEX2OAT_DEBUG: false VPYTHON_VIRTUALENV_ROOT: /b/swarming/w/ir/cache/vpython _: /b/swarming/w/ir/cipd_bin_packages/vpython --------- beginning of main 03-25 18:25:34.280 5606 17544 I DeviceStateChecker: screenOn: true, isCharging: true 03-25 18:28:34.325 5606 17544 I DeviceStateChecker: screenOn: true, isCharging: true 03-25 18:29:58.759 4989 5052 I PlayCommon: [264] com.google.android.play.a.g.e(222): Preparing logs for uploading 03-25 18:29:58.779 4989 5052 W PlayCommon: [264] com.google.android.play.a.g.a(589): No account for auth token provided 03-25 18:29:58.780 4989 5052 I PlayCommon: [264] com.google.android.play.a.g.a(436): Connecting to server: https://play.googleapis.com/play/log?format=raw&proto_v2=true 03-25 18:29:58.785 4989 5052 E PlayCommon: [264] com.google.android.play.a.g.a(466): Failed to connect to server: java.net.UnknownHostException: Unable to resolve host "play.googleapis.com": No address associated with hostname 03-25 18:31:34.369 5606 17544 I DeviceStateChecker: screenOn: true, isCharging: true 03-25 18:32:15.664 4989 4989 W Finsky : [2] com.google.android.finsky.application.FinskyAppImpl.bx(1166): No account configured on this device. 03-25 18:32:15.672 4989 4989 I chatty : uid=10037(com.android.vending) identical 1 line 03-25 18:32:15.676 4989 4989 W Finsky : [2] com.google.android.finsky.application.FinskyAppImpl.bx(1166): No account configured on this device. 03-25 18:32:15.677 4989 4989 I Finsky : [2] com.google.android.finsky.hygiene.DailyHygiene$DailyHygieneService.onStartCommand(27): Beginning daily hygiene, foreground = false, reason = 7 03-25 18:32:15.680 4989 4989 W Finsky : [2] com.google.android.finsky.application.FinskyAppImpl.bx(1166): No account configured on this device. 03-25 18:32:15.681 4989 4989 W Finsky : [2] com.google.android.finsky.application.FinskyAppImpl.a(891): No account configured on this device. 03-25 18:32:15.682 4989 4989 I Finsky : [2] com.google.android.finsky.hygiene.DailyHygiene.a(162): Probe unauthenticated for daily hygiene pass 03-25 18:32:15.737 4989 4989 W Finsky : [2] com.google.android.finsky.hygiene.d.a(35): Self-update check failed with error: com.android.volley.NoConnectionError: java.net.UnknownHostException: Unable to resolve host "android.clients.google.com": No address associated with hostname 03-25 18:32:15.742 4989 4989 W Finsky : [2] com.google.android.finsky.application.FinskyAppImpl.bx(1166): No account configured on this device. 03-25 18:32:15.747 4989 4989 I chatty : uid=10037(com.android.vending) identical 3 lines 03-25 18:32:15.752 4989 4989 W Finsky : [2] com.google.android.finsky.application.FinskyAppImpl.bx(1166): No account configured on this device. 03-25 18:32:15.752 4989 4989 I Finsky : [2] com.google.android.finsky.hygiene.DailyHygiene.c(270): Logging device features 03-25 18:32:15.773 4989 4989 W Finsky : [2] com.google.android.finsky.application.FinskyAppImpl.bx(1166): No account configured on this device. 03-25 18:32:15.776 4989 4989 I Finsky : [2] com.google.android.finsky.datasync.CacheAndSyncScheduler.a(7): [Cache and Sync] mode not available for any accounts. 03-25 18:32:15.785 3164 1188 I EventLogChimeraService: Aggregate from 1553536935574 (log), 1553536935574 (data) 03-25 18:32:15.796 4989 4989 W Finsky : [2] com.google.android.finsky.application.FinskyAppImpl.bx(1166): No account configured on this device. 03-25 18:32:15.797 4989 4989 D Volley : [2] a.b: Cache cleared. 03-25 18:32:15.819 4989 4989 W Finsky : [2] com.google.android.finsky.application.FinskyAppImpl.bx(1166): No account configured on this device. 03-25 18:32:15.839 4989 4989 I chatty : uid=10037(com.android.vending) identical 1 line 03-25 18:32:15.841 4989 4989 W Finsky : [2] com.google.android.finsky.application.FinskyAppImpl.bx(1166): No account configured on this device. 03-25 18:32:15.841 4989 4989 W Settings: Setting install_non_market_apps has moved from android.provider.Settings.Global to android.provider.Settings.Secure, returning read-only value. 03-25 18:32:15.841 4989 4989 W Settings: Setting download_manager_max_bytes_over_mobile has moved from android.provider.Settings.Secure to android.provider.Settings.Global. 03-25 18:32:15.844 4989 4989 W Finsky : [2] com.google.android.finsky.application.FinskyAppImpl.bx(1166): No account configured on this device. 03-25 18:32:15.845 4989 4989 I Finsky : [2] com.google.android.finsky.hygiene.DailyHygiene.a(712): Scheduling new run in 888 minutes (failures=5) 03-25 18:32:15.851 4989 5266 W WearSignatureVerifier: No package com.google.android.wearable.app.cn 03-25 18:32:15.853 4989 5266 I chatty : uid=10037(com.android.vending) GAC_Executor[0] identical 2 lines 03-25 18:32:15.855 4989 5266 W WearSignatureVerifier: No package com.google.android.wearable.app.cn 03-25 18:32:15.861 4989 1191 W Finsky : [304] com.google.android.finsky.application.FinskyAppImpl.bx(1166): No account configured on this device. 03-25 18:32:15.873 2848 2848 I WearableService: Wearable Services not starting - Wear is not available on this device. 03-25 18:32:15.882 4989 4989 I Finsky : [2] com.google.android.finsky.verifier.impl.VerifyInstalledPackagesReceiver.a(31): Skipping verification because network inactive 03-25 18:32:15.886 4989 4989 I Finsky : [2] com.google.android.finsky.setup.VpaService.onStartCommand(59): VpaService is called for playsetupservice://startvpafordeferredsetupnotification 03-25 18:32:15.888 4989 1191 W Finsky : [304] com.google.android.finsky.application.FinskyAppImpl.bx(1166): No account configured on this device. 03-25 18:32:15.891 4989 4989 W Finsky : [2] com.google.android.finsky.application.FinskyAppImpl.bx(1166): No account configured on this device. 03-25 18:32:15.892 4989 4989 W Finsky : [2] com.google.android.finsky.application.FinskyAppImpl.a(891): No account configured on this device. 03-25 18:32:15.894 4989 4989 W Finsky : [2] com.google.android.finsky.application.FinskyAppImpl.bx(1166): No account configured on this device. 03-25 18:32:15.903 2848 2861 D WearableService: onGetService - Wear is not available on this device. 03-25 18:32:15.911 4989 4989 W WearSignatureVerifier: No package com.google.android.wearable.app.cn 03-25 18:32:15.912 4989 4989 E Finsky : [2] com.google.android.finsky.wear.bl.a(3): onConnectionFailed: ConnectionResult{statusCode=API_UNAVAILABLE, resolution=null, message=null} 03-25 18:32:15.913 4989 4989 W Finsky : [2] com.google.android.finsky.wear.aj.run(9): Dropping command=hygiene due to Gms not connected 03-25 18:32:15.919 4989 1192 I Finsky : [305] com.google.android.finsky.setup.h.call(20): Found VPA stub android.autoinstalls.config.google.nexus:1 03-25 18:32:15.936 4989 4989 W Finsky : [2] com.google.android.finsky.application.FinskyAppImpl.bx(1166): No account configured on this device. 03-25 18:32:15.937 4989 4989 W Finsky : [2] com.google.android.finsky.application.FinskyAppImpl.bx(1166): No account configured on this device. 03-25 18:32:15.939 4989 5211 W Finsky : [268] com.google.android.finsky.application.FinskyAppImpl.bx(1166): No account configured on this device. 03-25 18:32:15.940 4989 5211 W Finsky : [268] com.google.android.finsky.application.FinskyAppImpl.bx(1166): No account configured on this device. 03-25 18:32:15.965 4989 5213 E Finsky : [270] com.google.android.finsky.api.a.b.f(142): Unable to fetch checkin consistency token: empty token 03-25 18:32:16.056 4989 4989 W Finsky : [2] com.google.android.finsky.setup.cs.a(2): Failed to retrieve preloads: com.android.volley.NoConnectionError: java.net.UnknownHostException: Unable to resolve host "android.clients.google.com": No address associated with hostname 03-25 18:32:16.061 4989 4989 W Finsky : [2] com.google.android.finsky.application.FinskyAppImpl.bx(1166): No account configured on this device. 03-25 18:32:16.063 4989 4989 W Finsky : [2] com.google.android.finsky.application.FinskyAppImpl.bx(1166): No account configured on this device. 03-25 18:32:16.229 4989 5052 I PlayCommon: [264] com.google.android.play.a.g.e(222): Preparing logs for uploading 03-25 18:32:16.302 5182 5200 I Adreno : QUALCOMM build : 8e59954, I0be83d0d26 03-25 18:32:16.302 5182 5200 I Adreno : Build Date : 09/22/17 03-25 18:32:16.302 5182 5200 I Adreno : OpenGL ES Shader Compiler Version: EV031.21.02.00 03-25 18:32:16.302 5182 5200 I Adreno : Local Branch : O17A 03-25 18:32:16.302 5182 5200 I Adreno : Remote Branch : 03-25 18:32:16.302 5182 5200 I Adreno : Remote Branch : 03-25 18:32:16.302 5182 5200 I Adreno : Reconstruct Branch : 03-25 18:32:16.304 5182 5200 D vndksupport: Loading /vendor/lib64/hw/gralloc.msm8992.so from current namespace instead of sphal namespace. 03-25 18:32:16.311 5182 5200 I Adreno : PFP: 0x00000000, ME: 0x00000000 03-25 18:32:16.315 4989 5052 W PlayCommon: [264] com.google.android.play.a.g.a(589): No account for auth token provided 03-25 18:32:16.316 4989 5052 I PlayCommon: [264] com.google.android.play.a.g.a(436): Connecting to server: https://play.googleapis.com/play/log?format=raw&proto_v2=true 03-25 18:32:16.320 5182 5200 I zygote64: android::hardware::configstore::V1_0::ISurfaceFlingerConfigs::hasWideColorDisplay retrieved: 0 03-25 18:32:16.345 4989 5052 E PlayCommon: [264] com.google.android.play.a.g.a(466): Failed to connect to server: java.net.UnknownHostException: Unable to resolve host "play.googleapis.com": No address associated with hostname 03-25 18:32:20.919 2848 2848 I WearableService: Wearable Services stopping 03-25 18:32:30.755 4989 5235 W Finsky : [282] com.google.android.finsky.application.FinskyAppImpl.bx(1166): No account configured on this device. 03-25 18:32:30.957 4989 5235 I Finsky : [282] com.google.android.finsky.h.c.a(22): Completed 0 account content syncs with 0 successful. 03-25 18:32:30.958 4989 4989 I Finsky : [2] com.google.android.finsky.services.e.a(5): Installation state replication succeeded. 03-25 18:34:34.414 5606 17544 I DeviceStateChecker: screenOn: true, isCharging: true 03-25 18:34:59.170 4989 5052 I PlayCommon: [264] com.google.android.play.a.g.e(222): Preparing logs for uploading 03-25 18:34:59.190 4989 5052 W PlayCommon: [264] com.google.android.play.a.g.a(589): No account for auth token provided 03-25 18:34:59.190 4989 5052 I PlayCommon: [264] com.google.android.play.a.g.a(436): Connecting to server: https://play.googleapis.com/play/log?format=raw&proto_v2=true 03-25 18:34:59.197 4989 5052 E PlayCommon: [264] com.google.android.play.a.g.a(466): Failed to connect to server: java.net.UnknownHostException: Unable to resolve host "play.googleapis.com": No address associated with hostname 03-25 18:37:34.457 5606 17544 I DeviceStateChecker: screenOn: true, isCharging: true 03-25 18:37:39.541 799 935 I nanohub : osLog: [AR_CHRE] IDLE => ON 03-25 18:38:02.906 799 935 I nanohub : osLog: [AR_CHRE] still: 93 03-25 18:38:02.907 799 935 I nanohub : osLog: [AR_CHRE] ON => IDLE 03-25 18:38:29.012 799 935 I nanohub : osLog: [AR_CHRE] IDLE => ON 03-25 18:38:52.372 799 935 I nanohub : osLog: [AR_CHRE] still: 93 03-25 18:38:52.373 799 935 I nanohub : osLog: [AR_CHRE] ON => IDLE 03-25 18:39:59.552 4989 5052 I PlayCommon: [264] com.google.android.play.a.g.e(222): Preparing logs for uploading 03-25 18:39:59.570 4989 5052 W PlayCommon: [264] com.google.android.play.a.g.a(589): No account for auth token provided 03-25 18:39:59.570 4989 5052 I PlayCommon: [264] com.google.android.play.a.g.a(436): Connecting to server: https://play.googleapis.com/play/log?format=raw&proto_v2=true 03-25 18:39:59.574 4989 5052 E PlayCommon: [264] com.google.android.play.a.g.a(466): Failed to connect to server: java.net.UnknownHostException: Unable to resolve host "play.googleapis.com": No address associated with hostname 03-25 18:40:34.502 5606 17544 I DeviceStateChecker: screenOn: true, isCharging: true 03-25 18:43:34.546 5606 17544 I DeviceStateChecker: screenOn: true, isCharging: true 03-25 18:44:59.959 4989 5052 I PlayCommon: [264] com.google.android.play.a.g.e(222): Preparing logs for uploading 03-25 18:44:59.999 4989 5052 W PlayCommon: [264] com.google.android.play.a.g.a(589): No account for auth token provided 03-25 18:44:59.999 4989 5052 I PlayCommon: [264] com.google.android.play.a.g.a(436): Connecting to server: https://play.googleapis.com/play/log?format=raw&proto_v2=true 03-25 18:45:00.016 4989 5052 E PlayCommon: [264] com.google.android.play.a.g.a(466): Failed to connect to server: java.net.UnknownHostException: Unable to resolve host "play.googleapis.com": No address associated with hostname 03-25 18:46:34.590 5606 17544 I DeviceStateChecker: screenOn: true, isCharging: true 03-25 18:47:46.631 799 822 I WifiService: requestActivityInfo uid=1000 03-25 18:47:46.631 799 822 I WifiService: reportActivityInfo uid=1000 03-25 18:47:46.631 799 822 I WifiService: getSupportedFeatures uid=1000 --------- beginning of system 03-25 18:47:46.635 799 822 E BatteryExternalStatsWorker: no controller energy info supplied for wifi 03-25 18:47:46.635 799 822 E BatteryExternalStatsWorker: no controller energy info supplied for bluetooth 03-25 18:47:46.663 799 822 E BatteryExternalStatsWorker: modem info is invalid: ModemActivityInfo{ mTimestamp=27000216 mSleepTimeMs=26985166 mIdleTimeMs=-25185116 mTxTimeMs[]=[0, 0, 0, 0, 0] mRxTimeMs=0 mEnergyUsed=0}