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

'C:\b\s\w\ir\cipd_bin_packages\python.exe' -u 'C:\b\s\w\ir\kitchen-checkout\build\scripts\tools\runit.py' --show-path --with-third-party-lib -- python 'C:\b\s\w\ir\kitchen-checkout\build\scripts\slave\recipe_modules\chromium_swarming\resources\collect_task.py' --verbose -o 'c:\b\s\w\ir\tmp\t\tmpjj5iz5.json' --task-output-dir 'c:\b\s\w\ir\tmp\t\tmpt0y2dr' --merge-script 'C:\b\s\w\ir\kitchen-checkout\build\scripts\slave\recipe_modules\chromium_swarming\resources\noop_merge.py' --merge-script-stdout-file 'c:\b\s\w\ir\tmp\t\tmpjady8emerge_script_log' --merge-additional-args '[]' --summary-json-file 'c:\b\s\w\ir\tmp\t\tmp9dcjch.json' -- swarming collect -server https://chromium-swarm.appspot.com -worker 50 -task-summary-python -task-output-stdout all -verbose -requests-json 'c:\b\s\w\ir\tmp\t\tmpgkexxr.json' in dir C:\b\s\w\ir\k: allow_subannotations: False cmd: ['C:\\b\\s\\w\\ir\\cipd_bin_packages\\python.exe', '-u', 'C:\\b\\s\\w\\ir\\kitchen-checkout\\build\\scripts\\tools\\runit.py', '--show-path', '--with-third-party-lib', '--', 'python', 'C:\\b\\s\\w\\ir\\kitchen-checkout\\build\\scripts\\slave\\recipe_modules\\chromium_swarming\\resources\\collect_task.py', '--verbose', '-o', 'c:\\b\\s\\w\\ir\\tmp\\t\\tmpjj5iz5.json', '--task-output-dir', 'c:\\b\\s\\w\\ir\\tmp\\t\\tmpt0y2dr', '--merge-script', 'C:\\b\\s\\w\\ir\\kitchen-checkout\\build\\scripts\\slave\\recipe_modules\\chromium_swarming\\resources\\noop_merge.py', '--merge-script-stdout-file', 'c:\\b\\s\\w\\ir\\tmp\\t\\tmpjady8emerge_script_log', '--merge-additional-args', '[]', '--summary-json-file', 'c:\\b\\s\\w\\ir\\tmp\\t\\tmp9dcjch.json', '--', 'swarming', 'collect', '-server', 'https://chromium-swarm.appspot.com', '-worker', '50', '-task-summary-python', '-task-output-stdout', 'all', '-verbose', '-requests-json', 'c:\\b\\s\\w\\ir\\tmp\\t\\tmpgkexxr.json'] env: {} env_prefixes: {'PATH': 'C:\\b\\s\\w\\ir\\cache\\swarming_client'} env_suffixes: {} infra_step: False name_tokens: ('analysis_server unit tests_shard_2 on Windows',) ok_ret: frozenset([0]) step_test_data: <lambda>(...) trigger_specs: () full environment: ALLUSERSPROFILE: C:\ProgramData APPDATA: C:\Users\chrome-bot\AppData\Roaming BOTO_CONFIG: C:\b\s\w\ir\tmp\gsutil_task\.boto BUILDBUCKET_EXPERIMENTAL: FALSE CIPD_CACHE_DIR: C:\b\s\cipd_cache\cache CIPD_EXE_SHIM: "C:\b\s\w\ir\cipd_bin_packages\vpython.exe" CIPD_PROTOCOL: v2 COMMONPROGRAMFILES: C:\Program Files\Common Files COMMONPROGRAMFILES(X86): C:\Program Files (x86)\Common Files COMMONPROGRAMW6432: C:\Program Files\Common Files COMPUTERNAME: WIN10-DART-FEDC COMSPEC: C:\Windows\system32\cmd.exe DOCKER_CONFIG: C:\b\s\w\ir\tmp\docker_cfg_task DOCKER_TMPDIR: C:\b\s\w\ir\tmp\docker_tmp_task FPS_BROWSER_APP_PROFILE_STRING: Internet Explorer FPS_BROWSER_USER_PROFILE_STRING: Default GIT_CONFIG_NOSYSTEM: 1 GIT_TERMINAL_PROMPT: 0 HOMEDRIVE: C: HOMEPATH: \Users\chrome-bot INFRA_GIT_WRAPPER_HOME: C:\b\s\w\ir\tmp\git_home_task LC_ALL: English_United States.UTF-8 LC_COLLATE: English_United States.UTF-8 LC_CTYPE: English_United States.UTF-8 LC_MONETARY: English_United States.UTF-8 LC_NUMERIC: English_United States.UTF-8 LC_TIME: English_United States.UTF-8 LOCALAPPDATA: C:\Users\chrome-bot\AppData\Local LOGDOG_COORDINATOR_HOST: logs.chromium.org LOGDOG_STREAM_PREFIX: buildbucket/cr-buildbucket.appspot.com/8918525025135228976 LOGDOG_STREAM_PROJECT: dart LOGDOG_STREAM_SERVER_PATH: net.pipe:LUCILogDogKitchen_3916 LOGONSERVER: \\WIN10-DART-FEDC LUCI_CONTEXT: C:\b\s\w\itxnw2ml\luci_context.749864098 MAC_CHROMIUM_TMPDIR: C:\b\s\w\ir\tmp\t NO_GCE_CHECK: False NUMBER_OF_PROCESSORS: 8 ONEDRIVE: C:\Users\chrome-bot\OneDrive OS: Windows_NT PATH: C:\b\s\w\ir\cache\swarming_client;C:\b\s\w\ir\cipd_bin_packages;C:\b\s\w\ir\cipd_bin_packages\bin;C:\b\s\cipd_cache\bin;C:\Windows\system32;C:\Windows;C:\Windows\System32\Wbem;C:\Windows\System32\WindowsPowerShell\v1.0\;C:\Program Files\Puppet Labs\Puppet\bin PATHEXT: .COM;.EXE;.BAT;.CMD;.VBS;.VBE;.JS;.JSE;.WSF;.WSH;.MSC PROCESSOR_ARCHITECTURE: AMD64 PROCESSOR_IDENTIFIER: Intel64 Family 6 Model 63 Stepping 0, GenuineIntel PROCESSOR_LEVEL: 6 PROCESSOR_REVISION: 3f00 PROGRAMDATA: C:\ProgramData PROGRAMFILES: C:\Program Files PROGRAMFILES(X86): C:\Program Files (x86) PROGRAMW6432: C:\Program Files PROMPT: $P$G PSMODULEPATH: C:\Program Files\WindowsPowerShell\Modules;C:\Windows\system32\WindowsPowerShell\v1.0\Modules PUBLIC: C:\Users\Public PYTHONIOENCODING: UTF-8 PYTHONUNBUFFERED: 1 SESSIONNAME: Console SWARMING_BOT_ID: win10-dart-fedce810-us-central1-c-41gb SWARMING_EXTERNAL_BOT_SETUP: 1 SWARMING_HEADLESS: 1 SWARMING_SERVER: https://chromium-swarm.appspot.com SWARMING_TASK_ID: 43b08be0b21afc11 SYSTEMDRIVE: C: SYSTEMROOT: C:\Windows TEMP: C:\b\s\w\ir\tmp\t TEMPDIR: C:\b\s\w\ir\tmp\t TMP: C:\b\s\w\ir\tmp\t TMPDIR: C:\b\s\w\ir\tmp\t USERDOMAIN: WIN10-DART-FEDC USERDOMAIN_ROAMINGPROFILE: WIN10-DART-FEDC USERNAME: chrome-bot USERPROFILE: C:\Users\chrome-bot VPYTHON_VIRTUALENV_ROOT: C:\b\s\w\ir\cache\vpython WINDIR: C:\Windows Set PYTHONPATH: C:\b\s\w\ir\kitchen-checkout\build\scripts;C:\b\s\w\ir\kitchen-checkout\build\site_config;C:\b\s\w\ir\kitchen-checkout\build\third_party;C:\b\s\w\ir\kitchen-checkout\build\third_party\buildbot_8_4p1;C:\b\s\w\ir\kitchen-checkout\build\third_party\buildbot_slave_8_4;C:\b\s\w\ir\kitchen-checkout\build\third_party\coverage-3.7.1;C:\b\s\w\ir\kitchen-checkout\build\third_party\decorator_3_3_1;C:\b\s\w\ir\kitchen-checkout\build\third_party\google_api_python_client;C:\b\s\w\ir\kitchen-checkout\build\third_party\httplib2\python2;C:\b\s\w\ir\kitchen-checkout\build\third_party\infra_libs;C:\b\s\w\ir\kitchen-checkout\build\third_party\jinja2;C:\b\s\w\ir\kitchen-checkout\build\third_party\markupsafe;C:\b\s\w\ir\kitchen-checkout\build\third_party\oauth2client;C:\b\s\w\ir\kitchen-checkout\build\third_party\pyasn1;C:\b\s\w\ir\kitchen-checkout\build\third_party\pyasn1-modules;C:\b\s\w\ir\kitchen-checkout\build\third_party\python-rsa;C:\b\s\w\ir\kitchen-checkout\build\third_party\requests_2_10_0;C:\b\s\w\ir\kitchen-checkout\build\third_party\setuptools-0.6c11;C:\b\s\w\ir\kitchen-checkout\build\third_party\sqlalchemy_0_7_1;C:\b\s\w\ir\kitchen-checkout\build\third_party\sqlalchemy_migrate_0_7_1;C:\b\s\w\ir\kitchen-checkout\build\third_party\tempita_0_5;C:\b\s\w\ir\kitchen-checkout\build\third_party\twisted_10_2;C:\b\s\w\ir\kitchen-checkout\build\third_party\uritemplate;C:\b\s\w\ir\kitchen-checkout\build\third_party\site-packages 2019-03-19 14:26:00,339 - root: [DEBUG] Using task_output_dir: 'c:\\b\\s\\w\\ir\\tmp\\t\\tmpt0y2dr' 2019-03-19 14:26:00,339 - root: [WARNING] task_output_dir 'c:\\b\\s\\w\\ir\\tmp\\t\\tmpt0y2dr' already exists! 2019-03-19 14:26:00,339 - root: [WARNING] task_output_dir existing content: [] 2019-03-19 14:26:00,339 - root: [INFO] collect_cmd: swarming collect -server https://chromium-swarm.appspot.com -worker 50 -task-summary-python -task-output-stdout all -verbose -requests-json c:\b\s\w\ir\tmp\t\tmpgkexxr.json -output-dir c:\b\s\w\ir\tmp\t\tmpt0y2dr -task-summary-json c:\b\s\w\ir\tmp\t\tmp9dcjch.json [D2019-03-19T14:26:00.361611-07:00 10020 0 auth.go:1265] Minting a new token {"key":"luci_ctx/63d9e72c9989d01e386d67ca1735be01689fb1f3b5dc7ec7196fc001ec78b03c", "scopes":"https://www.googleapis.com/auth/userinfo.email"} [D2019-03-19T14:26:00.361611-07:00 10020 0 luci_ctx.go:138] POST http://127.0.0.1:52073/rpc/LuciLocalAuthService.GetOAuthToken {"key":"luci_ctx/63d9e72c9989d01e386d67ca1735be01689fb1f3b5dc7ec7196fc001ec78b03c", "scopes":"https://www.googleapis.com/auth/userinfo.email"} [D2019-03-19T14:26:00.442810-07:00 10020 0 auth.go:1222] Token expires in 45m34.5581654s {"key":"luci_ctx/63d9e72c9989d01e386d67ca1735be01689fb1f3b5dc7ec7196fc001ec78b03c", "scopes":"https://www.googleapis.com/auth/userinfo.email"} [D2019-03-19T14:26:01.606536-07:00 10020 0 collect.go:344] Waiting task_id: 43b0950694824f10 [D2019-03-19T14:26:02.794029-07:00 10020 0 collect.go:344] Waiting task_id: 43b0950694824f10 [D2019-03-19T14:26:04.028419-07:00 10020 0 collect.go:344] Waiting task_id: 43b0950694824f10 [D2019-03-19T14:26:05.278416-07:00 10020 0 collect.go:344] Waiting task_id: 43b0950694824f10 [D2019-03-19T14:26:06.559678-07:00 10020 0 collect.go:344] Waiting task_id: 43b0950694824f10 [D2019-03-19T14:26:07.872221-07:00 10020 0 collect.go:344] Waiting task_id: 43b0950694824f10 [D2019-03-19T14:26:09.544063-07:00 10020 0 collect.go:344] Waiting task_id: 43b0950694824f10 [D2019-03-19T14:26:10.965918-07:00 10020 0 collect.go:344] Waiting task_id: 43b0950694824f10 [D2019-03-19T14:26:12.419040-07:00 10020 0 collect.go:344] Waiting task_id: 43b0950694824f10 [D2019-03-19T14:26:13.997173-07:00 10020 0 collect.go:344] Waiting task_id: 43b0950694824f10 [D2019-03-19T14:26:15.637796-07:00 10020 0 collect.go:344] Waiting task_id: 43b0950694824f10 [D2019-03-19T14:26:17.340934-07:00 10020 0 collect.go:344] Waiting task_id: 43b0950694824f10 [D2019-03-19T14:26:19.059691-07:00 10020 0 collect.go:344] Waiting task_id: 43b0950694824f10 [D2019-03-19T14:26:20.919041-07:00 10020 0 collect.go:344] Waiting task_id: 43b0950694824f10 [D2019-03-19T14:26:22.731550-07:00 10020 0 collect.go:344] Waiting task_id: 43b0950694824f10 [D2019-03-19T14:26:24.637804-07:00 10020 0 collect.go:344] Waiting task_id: 43b0950694824f10 [D2019-03-19T14:26:26.653424-07:00 10020 0 collect.go:344] Waiting task_id: 43b0950694824f10 [D2019-03-19T14:26:28.762809-07:00 10020 0 collect.go:344] Waiting task_id: 43b0950694824f10 [D2019-03-19T14:26:30.825326-07:00 10020 0 collect.go:344] Waiting task_id: 43b0950694824f10 [D2019-03-19T14:26:33.028493-07:00 10020 0 collect.go:344] Waiting task_id: 43b0950694824f10 [D2019-03-19T14:26:35.295184-07:00 10020 0 collect.go:344] Waiting task_id: 43b0950694824f10 [D2019-03-19T14:26:37.715955-07:00 10020 0 collect.go:344] Waiting task_id: 43b0950694824f10 [D2019-03-19T14:26:40.294100-07:00 10020 0 collect.go:344] Waiting task_id: 43b0950694824f10 [D2019-03-19T14:26:42.856566-07:00 10020 0 collect.go:344] Waiting task_id: 43b0950694824f10 [D2019-03-19T14:26:45.403459-07:00 10020 0 collect.go:344] Waiting task_id: 43b0950694824f10 [D2019-03-19T14:26:48.122230-07:00 10020 0 collect.go:344] Waiting task_id: 43b0950694824f10 [D2019-03-19T14:26:50.825319-07:00 10020 0 collect.go:344] Waiting task_id: 43b0950694824f10 [D2019-03-19T14:26:53.622201-07:00 10020 0 collect.go:344] Waiting task_id: 43b0950694824f10 [D2019-03-19T14:26:56.497205-07:00 10020 0 collect.go:344] Waiting task_id: 43b0950694824f10 [D2019-03-19T14:26:59.465949-07:00 10020 0 collect.go:344] Waiting task_id: 43b0950694824f10 [D2019-03-19T14:27:02.575322-07:00 10020 0 collect.go:344] Waiting task_id: 43b0950694824f10 [D2019-03-19T14:27:05.809701-07:00 10020 0 collect.go:344] Waiting task_id: 43b0950694824f10 [D2019-03-19T14:27:09.122230-07:00 10020 0 collect.go:344] Waiting task_id: 43b0950694824f10 [D2019-03-19T14:27:12.559719-07:00 10020 0 collect.go:344] Waiting task_id: 43b0950694824f10 [D2019-03-19T14:27:16.200366-07:00 10020 0 collect.go:344] Waiting task_id: 43b0950694824f10 [D2019-03-19T14:27:19.934736-07:00 10020 0 collect.go:344] Waiting task_id: 43b0950694824f10 [D2019-03-19T14:27:23.684728-07:00 10020 0 collect.go:344] Waiting task_id: 43b0950694824f10 [D2019-03-19T14:27:27.622234-07:00 10020 0 collect.go:344] Waiting task_id: 43b0950694824f10 [D2019-03-19T14:27:31.778504-07:00 10020 0 collect.go:344] Waiting task_id: 43b0950694824f10 [D2019-03-19T14:27:36.012874-07:00 10020 0 collect.go:344] Waiting task_id: 43b0950694824f10 [D2019-03-19T14:27:40.356609-07:00 10020 0 collect.go:344] Waiting task_id: 43b0950694824f10 [D2019-03-19T14:27:44.825377-07:00 10020 0 collect.go:344] Waiting task_id: 43b0950694824f10 [D2019-03-19T14:27:49.419126-07:00 10020 0 collect.go:344] Waiting task_id: 43b0950694824f10 [D2019-03-19T14:27:54.247249-07:00 10020 0 collect.go:344] Waiting task_id: 43b0950694824f10 [D2019-03-19T14:27:59.341006-07:00 10020 0 collect.go:344] Waiting task_id: 43b0950694824f10 [D2019-03-19T14:28:04.466049-07:00 10020 0 collect.go:344] Waiting task_id: 43b0950694824f10 [D2019-03-19T14:28:09.731631-07:00 10020 0 collect.go:344] Waiting task_id: 43b0950694824f10 [D2019-03-19T14:28:15.231661-07:00 10020 0 collect.go:344] Waiting task_id: 43b0950694824f10 [D2019-03-19T14:28:20.841016-07:00 10020 0 collect.go:344] Waiting task_id: 43b0950694824f10 [D2019-03-19T14:28:26.731662-07:00 10020 0 collect.go:344] Waiting task_id: 43b0950694824f10 [D2019-03-19T14:28:32.700413-07:00 10020 0 collect.go:344] Waiting task_id: 43b0950694824f10 [D2019-03-19T14:28:38.887905-07:00 10020 0 collect.go:344] Waiting task_id: 43b0950694824f10 [D2019-03-19T14:28:45.278617-07:00 10020 0 collect.go:344] Waiting task_id: 43b0950694824f10 [D2019-03-19T14:28:52.044242-07:00 10020 0 collect.go:344] Waiting task_id: 43b0950694824f10 [D2019-03-19T14:28:58.872290-07:00 10020 0 collect.go:344] Waiting task_id: 43b0950694824f10 [D2019-03-19T14:29:06.012968-07:00 10020 0 collect.go:344] Waiting task_id: 43b0950694824f10 [D2019-03-19T14:29:13.309811-07:00 10020 0 collect.go:344] Waiting task_id: 43b0950694824f10 [D2019-03-19T14:29:22.716061-07:00 10020 0 collect.go:344] Waiting task_id: 43b0950694824f10 [D2019-03-19T14:29:30.606730-07:00 10020 0 collect.go:344] Waiting task_id: 43b0950694824f10 43b0950694824f10: exit 0 8327 files remaining... 3961 files remaining... 207 files remaining... tools/testing/dart/main.dart:1: Warning: Interpreting this as package URI, 'package:test_dart/main.dart'. Test configuration: unittest-asserts-release-win(architecture: x64, compiler: dartk, mode: release, runtime: vm, system: win, vm-options: [], dart2js-options: [], timeout: 240, enable-asserts, preview-dart-2, use-sdk) Suites tested: pkg Total: 194 tests * 2 tests will be skipped (0 skipped by design) * 2 tests are expected to be flaky but not crash * 0 tests are expected to flaky crash * 190 tests are expected to pass * 0 tests are expected to fail that we won't fix * 0 tests are expected to fail that we should fix * 0 tests are expected to crash that we should fix * 0 tests are allowed to timeout * 0 could not be categorized or are in multiple categories 79 out of 192 completed Tests running for 5 minutes FAILED: dartk-vm release_x64 pkg/analysis_server/test/integration/lsp_server/server_test Expected: Pass Slow Actual: RuntimeError --- Command "vm" (took 02:58.000627s): set DART_CONFIGURATION=ReleaseX64 & set DART_SUPPRESS_WER=1 & out\ReleaseX64\dart-sdk\bin\dart.exe --enable_asserts --ignore-unrecognized-flags --packages=C:\b\s\w\ir\.packages C:\b\s\w\ir\pkg\analysis_server\test\integration\lsp_server\server_test.dart exit code: 255 stdout: 00:00 +0: ServerTest | test_diagnosticServer 00:30 +0 -1: ServerTest | test_diagnosticServer [E] TimeoutException after 0:00:30.000000: Test timed out after 30 seconds. package:test/src/backend/invoker.dart 332:28 Invoker._handleError.<fn> dart:async/zone.dart 1120:38 _rootRun dart:async/zone.dart 1021:19 _CustomZone.run package:test/src/backend/invoker.dart 330:10 Invoker._handleError package:test/src/backend/invoker.dart 283:9 Invoker.heartbeat.<fn>.<fn> dart:async/zone.dart 1124:13 _rootRun dart:async/zone.dart 1021:19 _CustomZone.run package:test/src/backend/invoker.dart 281:38 Invoker.heartbeat.<fn> package:stack_trace/src/stack_zone_specification.dart 209:15 StackZoneSpecification._run package:stack_trace/src/stack_zone_specification.dart 119:48 StackZoneSpecification._registerCallback.<fn> dart:async/zone.dart 1124:13 _rootRun dart:async/zone.dart 1021:19 _CustomZone.run dart:async/zone.dart 947:23 _CustomZone.bindCallback.<fn> dart:async/runtime/lib/timer_patch.dart 21:15 Timer._createTimer.<fn> dart:isolate/runtime/lib/timer_impl.dart 382:19 _Timer._runTimers dart:isolate/runtime/lib/timer_impl.dart 416:5 _Timer._handleMessage dart:isolate/runtime/lib/isolate_patch.dart 171:12 _RawReceivePortImpl._handleMessage ===== asynchronous gap =========================== dart:async/zone.dart 1045:19 _CustomZone.registerCallback dart:async/zone.dart 946:22 _CustomZone.bindCallback dart:async/zone.dart 1191:21 _rootCreateTimer dart:async/zone.dart 1088:19 _CustomZone.createTimer package:test/src/backend/invoker.dart 280:34 Invoker.heartbeat package:test/src/backend/invoker.dart 243:5 Invoker.waitForOutstandingCallbacks package:test/src/backend/declarer.dart 166:33 Declarer.test.<fn>.<fn> dart:async/zone.dart 1124:13 _rootRun dart:async/zone.dart 1021:19 _CustomZone.run dart:async/zone.dart 1516:10 _runZoned dart:async/zone.dart 1463:12 runZoned package:test/src/backend/declarer.dart 165:13 Declarer.test.<fn> ===== asynchronous gap =========================== dart:async/zone.dart 1045:19 _CustomZone.registerCallback dart:async/zone.dart 962:22 _CustomZone.bindCallbackGuarded dart:async/timer.dart 52:45 new Timer dart:async/timer.dart 87:9 Timer.run dart:async/future.dart 174:11 new Future package:test/src/backend/invoker.dart 402:11 Invoker._onRun.<fn>.<fn>.<fn> 00:30 +0 -1: ServerTest | test_exit_inintializedWithShutdown 01:00 +0 -2: ServerTest | test_exit_inintializedWithShutdown [E] TimeoutException after 0:00:30.000000: Test timed out after 30 seconds. package:test/src/backend/invoker.dart 332:28 Invoker._handleError.<fn> dart:async/zone.dart 1120:38 _rootRun dart:async/zone.dart 1021:19 _CustomZone.run package:test/src/backend/invoker.dart 330:10 Invoker._handleError package:test/src/backend/invoker.dart 283:9 Invoker.heartbeat.<fn>.<fn> dart:async/zone.dart 1124:13 _rootRun dart:async/zone.dart 1021:19 _CustomZone.run package:test/src/backend/invoker.dart 281:38 Invoker.heartbeat.<fn> package:stack_trace/src/stack_zone_specification.dart 209:15 StackZoneSpecification._run package:stack_trace/src/stack_zone_specification.dart 119:48 StackZoneSpecification._registerCallback.<fn> dart:async/zone.dart 1124:13 _rootRun dart:async/zone.dart 1021:19 _CustomZone.run dart:async/zone.dart 947:23 _CustomZone.bindCallback.<fn> dart:async/runtime/lib/timer_patch.dart 21:15 Timer._createTimer.<fn> dart:isolate/runtime/lib/timer_impl.dart 382:19 _Timer._runTimers dart:isolate/runtime/lib/timer_impl.dart 416:5 _Timer._handleMessage dart:isolate/runtime/lib/isolate_patch.dart 171:12 _RawReceivePortImpl._handleMessage ===== asynchronous gap =========================== dart:async/zone.dart 1045:19 _CustomZone.registerCallback dart:async/zone.dart 946:22 _CustomZone.bindCallback dart:async/zone.dart 1191:21 _rootCreateTimer dart:async/zone.dart 1088:19 _CustomZone.createTimer package:test/src/backend/invoker.dart 280:34 Invoker.heartbeat package:test/src/backend/invoker.dart 243:5 Invoker.waitForOutstandingCallbacks package:test/src/backend/declarer.dart 166:33 Declarer.test.<fn>.<fn> dart:async/zone.dart 1124:13 _rootRun dart:async/zone.dart 1021:19 _CustomZone.run dart:async/zone.dart 1516:10 _runZoned dart:async/zone.dart 1463:12 runZoned package:test/src/backend/declarer.dart 165:13 Declarer.test.<fn> ===== asynchronous gap =========================== dart:async/zone.dart 1045:19 _CustomZone.registerCallback dart:async/zone.dart 962:22 _CustomZone.bindCallbackGuarded dart:async/timer.dart 52:45 new Timer dart:async/timer.dart 87:9 Timer.run dart:async/future.dart 174:11 new Future package:test/src/backend/invoker.dart 402:11 Invoker._onRun.<fn>.<fn>.<fn> 01:00 +0 -2: ServerTest | test_exit_initializedWithoutShutdown 01:30 +0 -3: ServerTest | test_exit_initializedWithoutShutdown [E] TimeoutException after 0:00:30.000000: Test timed out after 30 seconds. package:test/src/backend/invoker.dart 332:28 Invoker._handleError.<fn> dart:async/zone.dart 1120:38 _rootRun dart:async/zone.dart 1021:19 _CustomZone.run package:test/src/backend/invoker.dart 330:10 Invoker._handleError package:test/src/backend/invoker.dart 283:9 Invoker.heartbeat.<fn>.<fn> dart:async/zone.dart 1124:13 _rootRun dart:async/zone.dart 1021:19 _CustomZone.run package:test/src/backend/invoker.dart 281:38 Invoker.heartbeat.<fn> package:stack_trace/src/stack_zone_specification.dart 209:15 StackZoneSpecification._run package:stack_trace/src/stack_zone_specification.dart 119:48 StackZoneSpecification._registerCallback.<fn> dart:async/zone.dart 1124:13 _rootRun dart:async/zone.dart 1021:19 _CustomZone.run dart:async/zone.dart 947:23 _CustomZone.bindCallback.<fn> dart:async/runtime/lib/timer_patch.dart 21:15 Timer._createTimer.<fn> dart:isolate/runtime/lib/timer_impl.dart 382:19 _Timer._runTimers dart:isolate/runtime/lib/timer_impl.dart 416:5 _Timer._handleMessage dart:isolate/runtime/lib/isolate_patch.dart 171:12 _RawReceivePortImpl._handleMessage ===== asynchronous gap =========================== dart:async/zone.dart 1045:19 _CustomZone.registerCallback dart:async/zone.dart 946:22 _CustomZone.bindCallback dart:async/zone.dart 1191:21 _rootCreateTimer dart:async/zone.dart 1088:19 _CustomZone.createTimer package:test/src/backend/invoker.dart 280:34 Invoker.heartbeat package:test/src/backend/invoker.dart 243:5 Invoker.waitForOutstandingCallbacks package:test/src/backend/declarer.dart 166:33 Declarer.test.<fn>.<fn> dart:async/zone.dart 1124:13 _rootRun dart:async/zone.dart 1021:19 _CustomZone.run dart:async/zone.dart 1516:10 _runZoned dart:async/zone.dart 1463:12 runZoned package:test/src/backend/declarer.dart 165:13 Declarer.test.<fn> ===== asynchronous gap =========================== dart:async/zone.dart 1045:19 _CustomZone.registerCallback dart:async/zone.dart 962:22 _CustomZone.bindCallbackGuarded dart:async/timer.dart 52:45 new Timer dart:async/timer.dart 87:9 Timer.run dart:async/future.dart 174:11 new Future package:test/src/backend/invoker.dart 402:11 Invoker._onRun.<fn>.<fn>.<fn> 01:30 +0 -3: ServerTest | test_exit_uninintializedWithShutdown 02:00 +0 -4: ServerTest | test_exit_uninintializedWithShutdown [E] TimeoutException after 0:00:30.000000: Test timed out after 30 seconds. package:test/src/backend/invoker.dart 332:28 Invoker._handleError.<fn> dart:async/zone.dart 1120:38 _rootRun dart:async/zone.dart 1021:19 _CustomZone.run package:test/src/backend/invoker.dart 330:10 Invoker._handleError package:test/src/backend/invoker.dart 283:9 Invoker.heartbeat.<fn>.<fn> dart:async/zone.dart 1124:13 _rootRun dart:async/zone.dart 1021:19 _CustomZone.run package:test/src/backend/invoker.dart 281:38 Invoker.heartbeat.<fn> package:stack_trace/src/stack_zone_specification.dart 209:15 StackZoneSpecification._run package:stack_trace/src/stack_zone_specification.dart 119:48 StackZoneSpecification._registerCallback.<fn> dart:async/zone.dart 1124:13 _rootRun dart:async/zone.dart 1021:19 _CustomZone.run dart:async/zone.dart 947:23 _CustomZone.bindCallback.<fn> dart:async/runtime/lib/timer_patch.dart 21:15 Timer._createTimer.<fn> dart:isolate/runtime/lib/timer_impl.dart 382:19 _Timer._runTimers dart:isolate/runtime/lib/timer_impl.dart 416:5 _Timer._handleMessage dart:isolate/runtime/lib/isolate_patch.dart 171:12 _RawReceivePortImpl._handleMessage ===== asynchronous gap =========================== dart:async/zone.dart 1045:19 _CustomZone.registerCallback dart:async/zone.dart 946:22 _CustomZone.bindCallback dart:async/zone.dart 1191:21 _rootCreateTimer dart:async/zone.dart 1088:19 _CustomZone.createTimer package:test/src/backend/invoker.dart 280:34 Invoker.heartbeat package:test/src/backend/invoker.dart 243:5 Invoker.waitForOutstandingCallbacks package:test/src/backend/declarer.dart 166:33 Declarer.test.<fn>.<fn> dart:async/zone.dart 1124:13 _rootRun dart:async/zone.dart 1021:19 _CustomZone.run dart:async/zone.dart 1516:10 _runZoned dart:async/zone.dart 1463:12 runZoned package:test/src/backend/declarer.dart 165:13 Declarer.test.<fn> ===== asynchronous gap =========================== dart:async/zone.dart 1045:19 _CustomZone.registerCallback dart:async/zone.dart 962:22 _CustomZone.bindCallbackGuarded dart:async/timer.dart 52:45 new Timer dart:async/timer.dart 87:9 Timer.run dart:async/future.dart 174:11 new Future package:test/src/backend/invoker.dart 402:11 Invoker._onRun.<fn>.<fn>.<fn> 02:00 +0 -4: ServerTest | test_exit_uninitializedWithoutShutdown 02:28 +1 -4: Some tests failed. stderr: Unhandled exception: Dummy exception to set exit code. #0 _rootHandleUncaughtError.<anonymous closure> (dart:async/zone.dart:1112:29) #1 _microtaskLoop (dart:async/schedule_microtask.dart:41:21) #2 _startMicrotaskLoop (dart:async/schedule_microtask.dart:50:5) #3 _Timer._runTimers (dart:isolate/runtime/lib/timer_impl.dart:391:30) #4 _Timer._handleMessage (dart:isolate/runtime/lib/timer_impl.dart:416:5) #5 _RawReceivePortImpl._handleMessage (dart:isolate/runtime/lib/isolate_patch.dart:171:12) --- Re-run this test: python tools/test.py -n unittest-asserts-release-win pkg/analysis_server/test/integration/lsp_server/server_test 157 out of 192 completed Tests running for 10 minutes --- Total time: 11:39 --- 0:04:12.041647 - vm - dartk-vm release_x64/pkg/analysis_server/test/src/plugin/plugin_manager_test 0:02:58.627389 - vm - dartk-vm release_x64/pkg/analysis_server/test/integration/lsp_server/server_test 0:01:50.624982 - vm - dartk-vm release_x64/pkg/analysis_server/test/benchmarks_test 0:00:51.499889 - vm - dartk-vm release_x64/pkg/analysis_server/test/services/completion/dart/imported_reference_contributor_test 0:00:47.667899 - vm - dartk-vm release_x64/pkg/analysis_server/test/edit/refactoring_test 0:00:46.434777 - vm - dartk-vm release_x64/pkg/analysis_server/test/services/completion/dart/type_member_contributor_test 0:00:44.417680 - vm - dartk-vm release_x64/pkg/analysis_server/test/services/completion/dart/local_constructor_contributor_test 0:00:41.985692 - vm - dartk-vm release_x64/pkg/analysis_server/test/integration/analysis/lint_test 0:00:41.406282 - vm - dartk-vm release_x64/pkg/analysis_server/test/services/refactoring/extract_method_test 0:00:41.315969 - vm - dartk-vm release_x64/pkg/analysis_server/test/integration/analysis/analysis_options_test 0:00:40.937479 - vm - dartk-vm release_x64/pkg/analysis_server/test/services/completion/statement/statement_completion_test 0:00:39.778852 - vm - dartk-vm release_x64/pkg/analysis_server/test/domain_edit_dartfix_test 0:00:39.306078 - vm - dartk-vm release_x64/pkg/analysis_server/test/analysis/notification_navigation_test 0:00:38.619998 - vm - dartk-vm release_x64/pkg/analysis_server/test/integration/edit/import_elements_test 0:00:38.350903 - vm - dartk-vm release_x64/pkg/analysis_server/test/integration/analysis/get_imported_elements_test 0:00:38.049742 - vm - dartk-vm release_x64/pkg/analysis_server/test/lsp/rename_test 0:00:37.843773 - vm - dartk-vm release_x64/pkg/analysis_server/test/services/refactoring/rename_class_member_test 0:00:37.472661 - vm - dartk-vm release_x64/pkg/analysis_server/test/lsp/document_highlights_test 0:00:36.760753 - vm - dartk-vm release_x64/pkg/analysis_server/test/lsp/document_symbols_test 0:00:36.036062 - vm - dartk-vm release_x64/pkg/analysis_server/test/lsp/server_test 2019-03-19 14:29:30,927 - root: [DEBUG] Contents of task_output_dir: ['c:\\b\\s\\w\\ir\\tmp\\t\\tmpt0y2dr\\43b0950694824f10'] 2019-03-19 14:29:30,927 - root: [WARNING] Expected output.json file missing: set(['c:\\b\\s\\w\\ir\\tmp\\t\\tmpt0y2dr\\43b0950694824f10\\output.json']) Found: [] Expected: ['c:\\b\\s\\w\\ir\\tmp\\t\\tmpt0y2dr\\43b0950694824f10\\output.json'] 2019-03-19 14:29:30,927 - root: [WARNING] No shard json files found in task_output_dir: 'c:\\b\\s\\w\\ir\\tmp\\t\\tmpt0y2dr' Found ['c:\\b\\s\\w\\ir\\tmp\\t\\tmpt0y2dr\\43b0950694824f10'] 2019-03-19 14:29:30,927 - root: [DEBUG] Found shard_json_files: ['c:\\b\\s\\w\\ir\\tmp\\t\\tmpt0y2dr\\43b0950694824f10\\output.json'] 2019-03-19 14:29:30,927 - root: [INFO] merge_cmd: C:\b\s\w\ir\cache\vpython\691c07\Scripts\python.exe C:\b\s\w\ir\kitchen-checkout\build\scripts\slave\recipe_modules\chromium_swarming\resources\noop_merge.py --summary-json c:\b\s\w\ir\tmp\t\tmp9dcjch.json --task-output-dir c:\b\s\w\ir\tmp\t\tmpt0y2dr -o c:\b\s\w\ir\tmp\t\tmpjj5iz5.json Running ['C:\\b\\s\\w\\ir\\cache\\vpython\\691c07\\Scripts\\python.exe', 'C:\\b\\s\\w\\ir\\kitchen-checkout\\build\\scripts\\slave\\recipe_modules\\chromium_swarming\\resources\\noop_merge.py', '--summary-json', 'c:\\b\\s\\w\\ir\\tmp\\t\\tmp9dcjch.json', '--task-output-dir', 'c:\\b\\s\\w\\ir\\tmp\\t\\tmpt0y2dr', '-o', 'c:\\b\\s\\w\\ir\\tmp\\t\\tmpjj5iz5.json'] in None (env: None) Command ['C:\\b\\s\\w\\ir\\cache\\vpython\\691c07\\Scripts\\python.exe', 'C:\\b\\s\\w\\ir\\kitchen-checkout\\build\\scripts\\slave\\recipe_modules\\chromium_swarming\\resources\\noop_merge.py', '--summary-json', 'c:\\b\\s\\w\\ir\\tmp\\t\\tmp9dcjch.json', '--task-output-dir', 'c:\\b\\s\\w\\ir\\tmp\\t\\tmpt0y2dr', '-o', 'c:\\b\\s\\w\\ir\\tmp\\t\\tmpjj5iz5.json'] returned exit code 0