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\tmpvlz7om.json' --task-output-dir 'c:\b\s\w\ir\tmp\t\tmpzq7bj_' --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\tmp9kqqy8merge_script_log' --merge-additional-args '[]' --summary-json-file 'c:\b\s\w\ir\tmp\t\tmpw5b7lx.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\tmpgjhusa.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\\tmpvlz7om.json', '--task-output-dir', 'c:\\b\\s\\w\\ir\\tmp\\t\\tmpzq7bj_', '--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\\tmp9kqqy8merge_script_log', '--merge-additional-args', '[]', '--summary-json-file', 'c:\\b\\s\\w\\ir\\tmp\\t\\tmpw5b7lx.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\\tmpgjhusa.json'] env: {} env_prefixes: {'PATH': 'C:\\b\\s\\w\\ir\\cache\\swarming_client'} env_suffixes: {} infra_step: False name_tokens: ('vm tests_shard_1 on Windows',) ok_ret: ALL_OK step_test_data: gen_default_step_test_data(...) 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/8917076783508769008 LOGDOG_STREAM_PROJECT: dart LOGDOG_STREAM_SERVER_PATH: net.pipe:LUCILogDogKitchen_12256 LOGONSERVER: \\WIN10-DART-FEDC LUCI_CONTEXT: C:\b\s\w\it_12sba\luci_context.689341810 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-n3kg SWARMING_EXTERNAL_BOT_SETUP: 1 SWARMING_HEADLESS: 1 SWARMING_SERVER: https://chromium-swarm.appspot.com SWARMING_TASK_ID: 4402deb0b7c62511 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-04-04 14:00:21,279 - root: [DEBUG] Using task_output_dir: 'c:\\b\\s\\w\\ir\\tmp\\t\\tmpzq7bj_' 2019-04-04 14:00:21,279 - root: [WARNING] task_output_dir 'c:\\b\\s\\w\\ir\\tmp\\t\\tmpzq7bj_' already exists! 2019-04-04 14:00:21,279 - root: [WARNING] task_output_dir existing content: [] 2019-04-04 14:00:21,279 - 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\tmpgjhusa.json -output-dir c:\b\s\w\ir\tmp\t\tmpzq7bj_ -task-summary-json c:\b\s\w\ir\tmp\t\tmpw5b7lx.json [D2019-04-04T14:00:21.612530-07:00 9344 0 auth.go:1265] Minting a new token {"key":"luci_ctx/bc76a50dd2cb0a89b1ce949d40efec0eda66ff8e6a2ca300fa32ccaf40ec5fc3", "scopes":"https://www.googleapis.com/auth/userinfo.email"} [D2019-04-04T14:00:21.612530-07:00 9344 0 luci_ctx.go:138] POST http://127.0.0.1:52078/rpc/LuciLocalAuthService.GetOAuthToken {"key":"luci_ctx/bc76a50dd2cb0a89b1ce949d40efec0eda66ff8e6a2ca300fa32ccaf40ec5fc3", "scopes":"https://www.googleapis.com/auth/userinfo.email"} [D2019-04-04T14:00:21.614684-07:00 9344 0 auth.go:1222] Token expires in 3m21.3853155s {"key":"luci_ctx/bc76a50dd2cb0a89b1ce949d40efec0eda66ff8e6a2ca300fa32ccaf40ec5fc3", "scopes":"https://www.googleapis.com/auth/userinfo.email"} [D2019-04-04T14:00:22.826241-07:00 9344 0 collect.go:344] Waiting task_id: 4402f1a3ce603610 [D2019-04-04T14:00:24.029344-07:00 9344 0 collect.go:344] Waiting task_id: 4402f1a3ce603610 [D2019-04-04T14:00:25.419992-07:00 9344 0 collect.go:344] Waiting task_id: 4402f1a3ce603610 [D2019-04-04T14:00:26.763753-07:00 9344 0 collect.go:344] Waiting task_id: 4402f1a3ce603610 [D2019-04-04T14:00:28.419992-07:00 9344 0 collect.go:344] Waiting task_id: 4402f1a3ce603610 [D2019-04-04T14:00:29.794988-07:00 9344 0 collect.go:344] Waiting task_id: 4402f1a3ce603610 [D2019-04-04T14:00:31.279341-07:00 9344 0 collect.go:344] Waiting task_id: 4402f1a3ce603610 [D2019-04-04T14:00:32.763756-07:00 9344 0 collect.go:344] Waiting task_id: 4402f1a3ce603610 [D2019-04-04T14:00:34.388741-07:00 9344 0 collect.go:344] Waiting task_id: 4402f1a3ce603610 [D2019-04-04T14:00:36.029369-07:00 9344 0 collect.go:344] Waiting task_id: 4402f1a3ce603610 [D2019-04-04T14:00:37.623173-07:00 9344 0 collect.go:344] Waiting task_id: 4402f1a3ce603610 [D2019-04-04T14:00:39.248149-07:00 9344 0 collect.go:344] Waiting task_id: 4402f1a3ce603610 [D2019-04-04T14:00:40.904384-07:00 9344 0 collect.go:344] Waiting task_id: 4402f1a3ce603610 [D2019-04-04T14:00:42.685660-07:00 9344 0 collect.go:344] Waiting task_id: 4402f1a3ce603610 [D2019-04-04T14:00:44.654385-07:00 9344 0 collect.go:344] Waiting task_id: 4402f1a3ce603610 [D2019-04-04T14:00:46.513762-07:00 9344 0 collect.go:344] Waiting task_id: 4402f1a3ce603610 [D2019-04-04T14:00:48.544970-07:00 9344 0 collect.go:344] Waiting task_id: 4402f1a3ce603610 [D2019-04-04T14:00:50.545003-07:00 9344 0 collect.go:344] Waiting task_id: 4402f1a3ce603610 [D2019-04-04T14:00:52.576256-07:00 9344 0 collect.go:344] Waiting task_id: 4402f1a3ce603610 [D2019-04-04T14:00:54.701279-07:00 9344 0 collect.go:344] Waiting task_id: 4402f1a3ce603610 [D2019-04-04T14:00:56.904409-07:00 9344 0 collect.go:344] Waiting task_id: 4402f1a3ce603610 [D2019-04-04T14:00:59.170018-07:00 9344 0 collect.go:344] Waiting task_id: 4402f1a3ce603610 [D2019-04-04T14:01:01.576229-07:00 9344 0 collect.go:344] Waiting task_id: 4402f1a3ce603610 [D2019-04-04T14:01:03.998164-07:00 9344 0 collect.go:344] Waiting task_id: 4402f1a3ce603610 [D2019-04-04T14:01:06.623136-07:00 9344 0 collect.go:344] Waiting task_id: 4402f1a3ce603610 [D2019-04-04T14:01:09.248132-07:00 9344 0 collect.go:344] Waiting task_id: 4402f1a3ce603610 [D2019-04-04T14:01:12.076267-07:00 9344 0 collect.go:344] Waiting task_id: 4402f1a3ce603610 [D2019-04-04T14:01:14.951259-07:00 9344 0 collect.go:344] Waiting task_id: 4402f1a3ce603610 [D2019-04-04T14:01:17.826248-07:00 9344 0 collect.go:344] Waiting task_id: 4402f1a3ce603610 [D2019-04-04T14:01:20.904398-07:00 9344 0 collect.go:344] Waiting task_id: 4402f1a3ce603610 [D2019-04-04T14:01:20.904675-07:00 9344 0 auth.go:1274] Refreshing the token {"key":"luci_ctx/bc76a50dd2cb0a89b1ce949d40efec0eda66ff8e6a2ca300fa32ccaf40ec5fc3", "scopes":"https://www.googleapis.com/auth/userinfo.email"} [D2019-04-04T14:01:20.904675-07:00 9344 0 luci_ctx.go:138] POST http://127.0.0.1:52078/rpc/LuciLocalAuthService.GetOAuthToken {"key":"luci_ctx/bc76a50dd2cb0a89b1ce949d40efec0eda66ff8e6a2ca300fa32ccaf40ec5fc3", "scopes":"https://www.googleapis.com/auth/userinfo.email"} [D2019-04-04T14:01:20.982511-07:00 9344 0 auth.go:1222] Token expires in 58m26.017489s {"key":"luci_ctx/bc76a50dd2cb0a89b1ce949d40efec0eda66ff8e6a2ca300fa32ccaf40ec5fc3", "scopes":"https://www.googleapis.com/auth/userinfo.email"} [D2019-04-04T14:01:24.263771-07:00 9344 0 collect.go:344] Waiting task_id: 4402f1a3ce603610 [D2019-04-04T14:01:27.466901-07:00 9344 0 collect.go:344] Waiting task_id: 4402f1a3ce603610 [D2019-04-04T14:01:30.810659-07:00 9344 0 collect.go:344] Waiting task_id: 4402f1a3ce603610 [D2019-04-04T14:01:34.279414-07:00 9344 0 collect.go:344] Waiting task_id: 4402f1a3ce603610 [D2019-04-04T14:01:37.795022-07:00 9344 0 collect.go:344] Waiting task_id: 4402f1a3ce603610 [D2019-04-04T14:01:41.435676-07:00 9344 0 collect.go:344] Waiting task_id: 4402f1a3ce603610 [D2019-04-04T14:01:46.763806-07:00 9344 0 collect.go:344] Waiting task_id: 4402f1a3ce603610 [D2019-04-04T14:01:50.826273-07:00 9344 0 collect.go:344] Waiting task_id: 4402f1a3ce603610 [D2019-04-04T14:01:57.623169-07:00 9344 0 collect.go:344] Waiting task_id: 4402f1a3ce603610 [D2019-04-04T14:02:01.935678-07:00 9344 0 collect.go:344] Waiting task_id: 4402f1a3ce603610 [D2019-04-04T14:02:06.482567-07:00 9344 0 collect.go:344] Waiting task_id: 4402f1a3ce603610 [D2019-04-04T14:02:11.076295-07:00 9344 0 collect.go:344] Waiting task_id: 4402f1a3ce603610 [D2019-04-04T14:02:16.013886-07:00 9344 0 collect.go:344] Waiting task_id: 4402f1a3ce603610 [D2019-04-04T14:02:22.545095-07:00 9344 0 collect.go:344] Waiting task_id: 4402f1a3ce603610 [D2019-04-04T14:02:27.748167-07:00 9344 0 collect.go:344] Waiting task_id: 4402f1a3ce603610 [D2019-04-04T14:02:33.263786-07:00 9344 0 collect.go:344] Waiting task_id: 4402f1a3ce603610 [D2019-04-04T14:02:38.857498-07:00 9344 0 collect.go:344] Waiting task_id: 4402f1a3ce603610 [D2019-04-04T14:02:44.529430-07:00 9344 0 collect.go:344] Waiting task_id: 4402f1a3ce603610 [D2019-04-04T14:02:50.420028-07:00 9344 0 collect.go:344] Waiting task_id: 4402f1a3ce603610 [D2019-04-04T14:02:56.482556-07:00 9344 0 collect.go:344] Waiting task_id: 4402f1a3ce603610 [D2019-04-04T14:03:02.748200-07:00 9344 0 collect.go:344] Waiting task_id: 4402f1a3ce603610 [D2019-04-04T14:03:09.341927-07:00 9344 0 collect.go:344] Waiting task_id: 4402f1a3ce603610 [D2019-04-04T14:03:16.013810-07:00 9344 0 collect.go:344] Waiting task_id: 4402f1a3ce603610 [D2019-04-04T14:03:22.935671-07:00 9344 0 collect.go:344] Waiting task_id: 4402f1a3ce603610 [D2019-04-04T14:03:30.154448-07:00 9344 0 collect.go:344] Waiting task_id: 4402f1a3ce603610 [D2019-04-04T14:03:37.560676-07:00 9344 0 collect.go:344] Waiting task_id: 4402f1a3ce603610 [D2019-04-04T14:03:45.201287-07:00 9344 0 collect.go:344] Waiting task_id: 4402f1a3ce603610 [D2019-04-04T14:03:53.076289-07:00 9344 0 collect.go:344] Waiting task_id: 4402f1a3ce603610 [D2019-04-04T14:04:01.310693-07:00 9344 0 collect.go:344] Waiting task_id: 4402f1a3ce603610 [D2019-04-04T14:04:09.920044-07:00 9344 0 collect.go:344] Waiting task_id: 4402f1a3ce603610 [D2019-04-04T14:04:18.623176-07:00 9344 0 collect.go:344] Waiting task_id: 4402f1a3ce603610 [D2019-04-04T14:04:27.732546-07:00 9344 0 collect.go:344] Waiting task_id: 4402f1a3ce603610 [D2019-04-04T14:04:37.185702-07:00 9344 0 collect.go:344] Waiting task_id: 4402f1a3ce603610 [D2019-04-04T14:04:46.826417-07:00 9344 0 collect.go:344] Waiting task_id: 4402f1a3ce603610 [D2019-04-04T14:04:56.748198-07:00 9344 0 collect.go:344] Waiting task_id: 4402f1a3ce603610 [D2019-04-04T14:05:07.013812-07:00 9344 0 collect.go:344] Waiting task_id: 4402f1a3ce603610 [D2019-04-04T14:05:17.638840-07:00 9344 0 collect.go:344] Waiting task_id: 4402f1a3ce603610 [D2019-04-04T14:05:28.716968-07:00 9344 0 collect.go:344] Waiting task_id: 4402f1a3ce603610 [D2019-04-04T14:05:40.076346-07:00 9344 0 collect.go:344] Waiting task_id: 4402f1a3ce603610 [D2019-04-04T14:05:51.795081-07:00 9344 0 collect.go:344] Waiting task_id: 4402f1a3ce603610 [D2019-04-04T14:06:03.998231-07:00 9344 0 collect.go:344] Waiting task_id: 4402f1a3ce603610 [D2019-04-04T14:06:16.513860-07:00 9344 0 collect.go:344] Waiting task_id: 4402f1a3ce603610 [D2019-04-04T14:06:29.576364-07:00 9344 0 collect.go:344] Waiting task_id: 4402f1a3ce603610 [D2019-04-04T14:06:42.935759-07:00 9344 0 collect.go:344] Waiting task_id: 4402f1a3ce603610 [D2019-04-04T14:06:56.748252-07:00 9344 0 collect.go:344] Waiting task_id: 4402f1a3ce603610 [D2019-04-04T14:07:11.076383-07:00 9344 0 collect.go:344] Waiting task_id: 4402f1a3ce603610 [D2019-04-04T14:07:25.888955-07:00 9344 0 collect.go:344] Waiting task_id: 4402f1a3ce603610 [D2019-04-04T14:07:41.029500-07:00 9344 0 collect.go:344] Waiting task_id: 4402f1a3ce603610 [D2019-04-04T14:07:56.138875-07:00 9344 0 collect.go:344] Waiting task_id: 4402f1a3ce603610 [D2019-04-04T14:08:11.295139-07:00 9344 0 collect.go:344] Waiting task_id: 4402f1a3ce603610 [D2019-04-04T14:08:26.436082-07:00 9344 0 collect.go:344] Waiting task_id: 4402f1a3ce603610 [D2019-04-04T14:08:41.670133-07:00 9344 0 collect.go:344] Waiting task_id: 4402f1a3ce603610 [D2019-04-04T14:08:56.779517-07:00 9344 0 collect.go:344] Waiting task_id: 4402f1a3ce603610 [D2019-04-04T14:09:11.873276-07:00 9344 0 collect.go:344] Waiting task_id: 4402f1a3ce603610 [D2019-04-04T14:09:27.029529-07:00 9344 0 collect.go:344] Waiting task_id: 4402f1a3ce603610 [D2019-04-04T14:09:42.138897-07:00 9344 0 collect.go:344] Waiting task_id: 4402f1a3ce603610 [D2019-04-04T14:09:57.263915-07:00 9344 0 collect.go:344] Waiting task_id: 4402f1a3ce603610 [D2019-04-04T14:10:12.435822-07:00 9344 0 collect.go:344] Waiting task_id: 4402f1a3ce603610 [D2019-04-04T14:10:27.545199-07:00 9344 0 collect.go:344] Waiting task_id: 4402f1a3ce603610 [D2019-04-04T14:10:42.654584-07:00 9344 0 collect.go:344] Waiting task_id: 4402f1a3ce603610 [D2019-04-04T14:10:57.826471-07:00 9344 0 collect.go:344] Waiting task_id: 4402f1a3ce603610 [D2019-04-04T14:11:12.982716-07:00 9344 0 collect.go:344] Waiting task_id: 4402f1a3ce603610 [D2019-04-04T14:11:28.092087-07:00 9344 0 collect.go:344] Waiting task_id: 4402f1a3ce603610 [D2019-04-04T14:11:43.201469-07:00 9344 0 collect.go:344] Waiting task_id: 4402f1a3ce603610 [D2019-04-04T14:11:58.326480-07:00 9344 0 collect.go:344] Waiting task_id: 4402f1a3ce603610 [D2019-04-04T14:12:13.795198-07:00 9344 0 collect.go:344] Waiting task_id: 4402f1a3ce603610 [D2019-04-04T14:12:28.904609-07:00 9344 0 collect.go:344] Waiting task_id: 4402f1a3ce603610 [D2019-04-04T14:12:44.373442-07:00 9344 0 collect.go:344] Waiting task_id: 4402f1a3ce603610 [D2019-04-04T14:12:59.482739-07:00 9344 0 collect.go:344] Waiting task_id: 4402f1a3ce603610 [D2019-04-04T14:13:14.576463-07:00 9344 0 collect.go:344] Waiting task_id: 4402f1a3ce603610 [D2019-04-04T14:13:29.670235-07:00 9344 0 collect.go:344] Waiting task_id: 4402f1a3ce603610 [D2019-04-04T14:13:44.764005-07:00 9344 0 collect.go:344] Waiting task_id: 4402f1a3ce603610 [D2019-04-04T14:13:59.873366-07:00 9344 0 collect.go:344] Waiting task_id: 4402f1a3ce603610 [D2019-04-04T14:14:15.076504-07:00 9344 0 collect.go:344] Waiting task_id: 4402f1a3ce603610 [D2019-04-04T14:14:30.217143-07:00 9344 0 collect.go:344] Waiting task_id: 4402f1a3ce603610 [D2019-04-04T14:14:45.467134-07:00 9344 0 collect.go:344] Waiting task_id: 4402f1a3ce603610 [D2019-04-04T14:15:00.670345-07:00 9344 0 collect.go:344] Waiting task_id: 4402f1a3ce603610 [D2019-04-04T14:15:15.795324-07:00 9344 0 collect.go:344] Waiting task_id: 4402f1a3ce603610 [D2019-04-04T14:15:30.967172-07:00 9344 0 collect.go:344] Waiting task_id: 4402f1a3ce603610 [D2019-04-04T14:15:46.139192-07:00 9344 0 collect.go:344] Waiting task_id: 4402f1a3ce603610 [D2019-04-04T14:16:01.279691-07:00 9344 0 collect.go:344] Waiting task_id: 4402f1a3ce603610 [D2019-04-04T14:16:16.467179-07:00 9344 0 collect.go:344] Waiting task_id: 4402f1a3ce603610 [D2019-04-04T14:16:31.607809-07:00 9344 0 collect.go:344] Waiting task_id: 4402f1a3ce603610 [D2019-04-04T14:16:47.889059-07:00 9344 0 collect.go:344] Waiting task_id: 4402f1a3ce603610 [D2019-04-04T14:17:03.107822-07:00 9344 0 collect.go:344] Waiting task_id: 4402f1a3ce603610 [D2019-04-04T14:17:18.217200-07:00 9344 0 collect.go:344] Waiting task_id: 4402f1a3ce603610 [D2019-04-04T14:17:33.326580-07:00 9344 0 collect.go:344] Waiting task_id: 4402f1a3ce603610 [D2019-04-04T14:17:48.529798-07:00 9344 0 collect.go:344] Waiting task_id: 4402f1a3ce603610 [D2019-04-04T14:18:03.639105-07:00 9344 0 collect.go:344] Waiting task_id: 4402f1a3ce603610 [D2019-04-04T14:18:18.732829-07:00 9344 0 collect.go:344] Waiting task_id: 4402f1a3ce603610 [D2019-04-04T14:18:33.920358-07:00 9344 0 collect.go:344] Waiting task_id: 4402f1a3ce603610 [D2019-04-04T14:18:49.029725-07:00 9344 0 collect.go:344] Waiting task_id: 4402f1a3ce603610 [D2019-04-04T14:19:04.154728-07:00 9344 0 collect.go:344] Waiting task_id: 4402f1a3ce603610 [D2019-04-04T14:19:19.279713-07:00 9344 0 collect.go:344] Waiting task_id: 4402f1a3ce603610 [D2019-04-04T14:19:34.451607-07:00 9344 0 collect.go:344] Waiting task_id: 4402f1a3ce603610 [D2019-04-04T14:19:49.639126-07:00 9344 0 collect.go:344] Waiting task_id: 4402f1a3ce603610 [D2019-04-04T14:20:04.748537-07:00 9344 0 collect.go:344] Waiting task_id: 4402f1a3ce603610 [D2019-04-04T14:20:19.873529-07:00 9344 0 collect.go:344] Waiting task_id: 4402f1a3ce603610 [D2019-04-04T14:20:35.092257-07:00 9344 0 collect.go:344] Waiting task_id: 4402f1a3ce603610 [D2019-04-04T14:20:50.217287-07:00 9344 0 collect.go:344] Waiting task_id: 4402f1a3ce603610 [D2019-04-04T14:21:05.326634-07:00 9344 0 collect.go:344] Waiting task_id: 4402f1a3ce603610 [D2019-04-04T14:21:20.451682-07:00 9344 0 collect.go:344] Waiting task_id: 4402f1a3ce603610 [D2019-04-04T14:21:35.623517-07:00 9344 0 collect.go:344] Waiting task_id: 4402f1a3ce603610 [D2019-04-04T14:21:50.732899-07:00 9344 0 collect.go:344] Waiting task_id: 4402f1a3ce603610 [D2019-04-04T14:22:05.873540-07:00 9344 0 collect.go:344] Waiting task_id: 4402f1a3ce603610 [D2019-04-04T14:22:21.107934-07:00 9344 0 collect.go:344] Waiting task_id: 4402f1a3ce603610 [D2019-04-04T14:22:36.373553-07:00 9344 0 collect.go:344] Waiting task_id: 4402f1a3ce603610 [D2019-04-04T14:22:51.482942-07:00 9344 0 collect.go:344] Waiting task_id: 4402f1a3ce603610 [D2019-04-04T14:23:06.608030-07:00 9344 0 collect.go:344] Waiting task_id: 4402f1a3ce603610 [D2019-04-04T14:23:21.717338-07:00 9344 0 collect.go:344] Waiting task_id: 4402f1a3ce603610 [D2019-04-04T14:23:36.982942-07:00 9344 0 collect.go:344] Waiting task_id: 4402f1a3ce603610 [D2019-04-04T14:23:52.092327-07:00 9344 0 collect.go:344] Waiting task_id: 4402f1a3ce603610 [D2019-04-04T14:24:07.186077-07:00 9344 0 collect.go:344] Waiting task_id: 4402f1a3ce603610 [D2019-04-04T14:24:22.279783-07:00 9344 0 collect.go:344] Waiting task_id: 4402f1a3ce603610 [D2019-04-04T14:24:37.498559-07:00 9344 0 collect.go:344] Waiting task_id: 4402f1a3ce603610 [D2019-04-04T14:24:52.607974-07:00 9344 0 collect.go:344] Waiting task_id: 4402f1a3ce603610 [D2019-04-04T14:25:07.748621-07:00 9344 0 collect.go:344] Waiting task_id: 4402f1a3ce603610 [D2019-04-04T14:25:22.857968-07:00 9344 0 collect.go:344] Waiting task_id: 4402f1a3ce603610 [D2019-04-04T14:25:38.030225-07:00 9344 0 collect.go:344] Waiting task_id: 4402f1a3ce603610 [D2019-04-04T14:25:53.123608-07:00 9344 0 collect.go:344] Waiting task_id: 4402f1a3ce603610 [D2019-04-04T14:26:08.233024-07:00 9344 0 collect.go:344] Waiting task_id: 4402f1a3ce603610 [D2019-04-04T14:26:23.342385-07:00 9344 0 collect.go:344] Waiting task_id: 4402f1a3ce603610 [D2019-04-04T14:26:38.545501-07:00 9344 0 collect.go:344] Waiting task_id: 4402f1a3ce603610 [D2019-04-04T14:26:53.733010-07:00 9344 0 collect.go:344] Waiting task_id: 4402f1a3ce603610 [D2019-04-04T14:27:08.826731-07:00 9344 0 collect.go:344] Waiting task_id: 4402f1a3ce603610 [D2019-04-04T14:27:23.936146-07:00 9344 0 collect.go:344] Waiting task_id: 4402f1a3ce603610 [D2019-04-04T14:27:39.045489-07:00 9344 0 collect.go:344] Waiting task_id: 4402f1a3ce603610 [D2019-04-04T14:27:54.139367-07:00 9344 0 collect.go:344] Waiting task_id: 4402f1a3ce603610 [D2019-04-04T14:28:09.248726-07:00 9344 0 collect.go:344] Waiting task_id: 4402f1a3ce603610 [D2019-04-04T14:28:24.389354-07:00 9344 0 collect.go:344] Waiting task_id: 4402f1a3ce603610 [D2019-04-04T14:28:39.498673-07:00 9344 0 collect.go:344] Waiting task_id: 4402f1a3ce603610 [D2019-04-04T14:28:54.623679-07:00 9344 0 collect.go:344] Waiting task_id: 4402f1a3ce603610 [D2019-04-04T14:29:09.779959-07:00 9344 0 collect.go:344] Waiting task_id: 4402f1a3ce603610 [D2019-04-04T14:29:24.920554-07:00 9344 0 collect.go:344] Waiting task_id: 4402f1a3ce603610 [D2019-04-04T14:29:40.108039-07:00 9344 0 collect.go:344] Waiting task_id: 4402f1a3ce603610 [D2019-04-04T14:29:55.217419-07:00 9344 0 collect.go:344] Waiting task_id: 4402f1a3ce603610 [D2019-04-04T14:30:10.420608-07:00 9344 0 collect.go:344] Waiting task_id: 4402f1a3ce603610 [D2019-04-04T14:30:25.514335-07:00 9344 0 collect.go:344] Waiting task_id: 4402f1a3ce603610 [D2019-04-04T14:30:40.623757-07:00 9344 0 collect.go:344] Waiting task_id: 4402f1a3ce603610 [D2019-04-04T14:30:55.811196-07:00 9344 0 collect.go:344] Waiting task_id: 4402f1a3ce603610 [D2019-04-04T14:31:10.920575-07:00 9344 0 collect.go:344] Waiting task_id: 4402f1a3ce603610 4402f1a3ce603610: exit 0 10864 files remaining... 4166 files remaining... tools/testing/dart/main.dart:1: Warning: Interpreting this as package URI, 'package:test_dart/main.dart'. Test configurations: dartk-win-debug-x64(architecture: x64, compiler: dartk, mode: debug, runtime: vm, system: win, vm-options: [], dart2js-options: [], timeout: null, preview-dart-2) Suites tested: samples, standalone, standalone_2, corelib_2, language_2, vm, benchmark_smoke, utils, lib_2, analyze_library, service, kernel, ffi dartk-win-debug-x64(architecture: x64, compiler: dartk, mode: debug, runtime: vm, system: win, vm-options: [], dart2js-options: [], timeout: null, preview-dart-2) Suites tested: observatory_ui Total: 2298 tests * 87 tests will be skipped (63 skipped by design) * 0 tests are expected to be flaky but not crash * 12 tests are expected to flaky crash * 2160 tests are expected to pass * 0 tests are expected to fail that we won't fix * 32 tests are expected to fail that we should fix * 3 tests are expected to crash that we should fix * 0 tests are allowed to timeout * 4 could not be categorized or are in multiple categories FAILED: dartk-vm debug_x64 vm/dart/appjit_cha_deopt_test Expected: Pass Slow Actual: RuntimeError --- Command "vm" (took 01:25.000031s): set DART_CONFIGURATION=DebugX64 & set DART_SUPPRESS_WER=1 & set DART_CRASHPAD_HANDLER=C:\b\s\w\ir\out\DebugX64\crashpad_handler.exe & out\DebugX64\dart.exe --no-background-compilation --optimization-counter-threshold=100 --ignore-unrecognized-flags --packages=C:\b\s\w\ir\.packages C:\b\s\w\ir\runtime\tests\vm\dart\appjit_cha_deopt_test.dart exit code: 255 stdout: + out\DebugX64\dart.exe --no-background-compilation --optimization-counter-threshold=100 --ignore-unrecognized-flags --packages=C:\b\s\w\ir\.packages --snapshot=C:\b\s\w\itig3gnh\18d595e6-571e-11e9-87da-cf1a1cacd651\app.jit --snapshot-kind=app-jit C:\b\s\w\ir\runtime\tests\vm\dart\appjit_cha_deopt_test_body.dart --train Command stdout: OK(Trained) + out\DebugX64\dart.exe --no-background-compilation --optimization-counter-threshold=100 --ignore-unrecognized-flags --packages=C:\b\s\w\ir\.packages C:\b\s\w\itig3gnh\18d595e6-571e-11e9-87da-cf1a1cacd651\app.jit Command stderr: Missing root library running [RUN FROM SNAPSHOT] out\DebugX64\dart.exe --no-background-compilation --optimization-counter-threshold=100 --ignore-unrecognized-flags --packages=C:\b\s\w\ir\.packages C:\b\s\w\itig3gnh\18d595e6-571e-11e9-87da-cf1a1cacd651\app.jit: Command stderr: Missing root library stderr: Unhandled exception: Expect.fail('[RUN FROM SNAPSHOT] Process finished with non-zero exit code 255') #0 Expect._fail (package:expect/expect.dart:655:5) #1 Expect.fail (package:expect/expect.dart:272:5) #2 reportError (file:///C:/b/s/w/ir/runtime/tests/vm/dart/snapshot_test_helper.dart:35:10) #3 runBinary (file:///C:/b/s/w/ir/runtime/tests/vm/dart/snapshot_test_helper.dart:93:5) <asynchronous suspension> #4 runDart (file:///C:/b/s/w/ir/runtime/tests/vm/dart/snapshot_test_helper.dart:56:10) #5 runAppJitTest.<anonymous closure> (file:///C:/b/s/w/ir/runtime/tests/vm/dart/snapshot_test_helper.dart:166:29) <asynchronous suspension> #6 withTempDir (file:///C:/b/s/w/ir/runtime/tests/vm/dart/snapshot_test_helper.dart:102:14) <asynchronous suspension> #7 runAppJitTest (file:///C:/b/s/w/ir/runtime/tests/vm/dart/snapshot_test_helper.dart:155:9) <asynchronous suspension> #8 main (file:///C:/b/s/w/ir/runtime/tests/vm/dart/appjit_cha_deopt_test.dart:17:5) #9 _startIsolate.<anonymous closure> (dart:isolate-patch/isolate_patch.dart:300:19) #10 _RawReceivePortImpl._handleMessage (dart:isolate-patch/isolate_patch.dart:171:12) --- Re-run this test: python tools/test.py -n dartk-win-debug-x64 vm/dart/appjit_cha_deopt_test FAILED: dartk-vm debug_x64 language_2/function_propagation_test Expected: RuntimeError Actual: Pass --- Command "vm" (took 05.000732s): set DART_CONFIGURATION=DebugX64 & set DART_SUPPRESS_WER=1 & set DART_CRASHPAD_HANDLER=C:\b\s\w\ir\out\DebugX64\crashpad_handler.exe & out\DebugX64\dart.exe --no-background-compilation --ignore-unrecognized-flags --packages=C:\b\s\w\ir\.packages C:\b\s\w\ir\tests\language_2\function_propagation_test.dart exit code: 0 --- Re-run this test: python tools/test.py -n dartk-win-debug-x64 language_2/function_propagation_test 315 out of 2211 completed Tests running for 5 minutes 763 out of 2211 completed Tests running for 10 minutes 1191 out of 2211 completed Tests running for 15 minutes === Failure summary: FAILED: dartk-vm debug_x64 vm/dart/appjit_cha_deopt_test Expected: Pass Slow Actual: RuntimeError --- Command "vm" (took 01:25.000031s): set DART_CONFIGURATION=DebugX64 & set DART_SUPPRESS_WER=1 & set DART_CRASHPAD_HANDLER=C:\b\s\w\ir\out\DebugX64\crashpad_handler.exe & out\DebugX64\dart.exe --no-background-compilation --optimization-counter-threshold=100 --ignore-unrecognized-flags --packages=C:\b\s\w\ir\.packages C:\b\s\w\ir\runtime\tests\vm\dart\appjit_cha_deopt_test.dart exit code: 255 stdout: + out\DebugX64\dart.exe --no-background-compilation --optimization-counter-threshold=100 --ignore-unrecognized-flags --packages=C:\b\s\w\ir\.packages --snapshot=C:\b\s\w\itig3gnh\18d595e6-571e-11e9-87da-cf1a1cacd651\app.jit --snapshot-kind=app-jit C:\b\s\w\ir\runtime\tests\vm\dart\appjit_cha_deopt_test_body.dart --train Command stdout: OK(Trained) + out\DebugX64\dart.exe --no-background-compilation --optimization-counter-threshold=100 --ignore-unrecognized-flags --packages=C:\b\s\w\ir\.packages C:\b\s\w\itig3gnh\18d595e6-571e-11e9-87da-cf1a1cacd651\app.jit Command stderr: Missing root library running [RUN FROM SNAPSHOT] out\DebugX64\dart.exe --no-background-compilation --optimization-counter-threshold=100 --ignore-unrecognized-flags --packages=C:\b\s\w\ir\.packages C:\b\s\w\itig3gnh\18d595e6-571e-11e9-87da-cf1a1cacd651\app.jit: Command stderr: Missing root library stderr: Unhandled exception: Expect.fail('[RUN FROM SNAPSHOT] Process finished with non-zero exit code 255') #0 Expect._fail (package:expect/expect.dart:655:5) #1 Expect.fail (package:expect/expect.dart:272:5) #2 reportError (file:///C:/b/s/w/ir/runtime/tests/vm/dart/snapshot_test_helper.dart:35:10) #3 runBinary (file:///C:/b/s/w/ir/runtime/tests/vm/dart/snapshot_test_helper.dart:93:5) <asynchronous suspension> #4 runDart (file:///C:/b/s/w/ir/runtime/tests/vm/dart/snapshot_test_helper.dart:56:10) #5 runAppJitTest.<anonymous closure> (file:///C:/b/s/w/ir/runtime/tests/vm/dart/snapshot_test_helper.dart:166:29) <asynchronous suspension> #6 withTempDir (file:///C:/b/s/w/ir/runtime/tests/vm/dart/snapshot_test_helper.dart:102:14) <asynchronous suspension> #7 runAppJitTest (file:///C:/b/s/w/ir/runtime/tests/vm/dart/snapshot_test_helper.dart:155:9) <asynchronous suspension> #8 main (file:///C:/b/s/w/ir/runtime/tests/vm/dart/appjit_cha_deopt_test.dart:17:5) #9 _startIsolate.<anonymous closure> (dart:isolate-patch/isolate_patch.dart:300:19) #10 _RawReceivePortImpl._handleMessage (dart:isolate-patch/isolate_patch.dart:171:12) --- Re-run this test: python tools/test.py -n dartk-win-debug-x64 vm/dart/appjit_cha_deopt_test FAILED: dartk-vm debug_x64 language_2/function_propagation_test Expected: RuntimeError Actual: Pass --- Command "vm" (took 05.000732s): set DART_CONFIGURATION=DebugX64 & set DART_SUPPRESS_WER=1 & set DART_CRASHPAD_HANDLER=C:\b\s\w\ir\out\DebugX64\crashpad_handler.exe & out\DebugX64\dart.exe --no-background-compilation --ignore-unrecognized-flags --packages=C:\b\s\w\ir\.packages C:\b\s\w\ir\tests\language_2\function_propagation_test.dart exit code: 0 --- Re-run this test: python tools/test.py -n dartk-win-debug-x64 language_2/function_propagation_test === === 2 tests failed === --- Total time: 19:27 --- 0:01:25.031319 - vm - dartk-vm debug_x64/vm/dart/appjit_cha_deopt_test 0:01:17.826039 - vm - dartk-vm debug_x64/service/pause_on_unhandled_async_exceptions2_test/1 0:00:59.495946 - vm - dartk-vm debug_x64/vm/dart/kernel_determinism_test 0:00:56.265761 - vm - dartk-vm debug_x64/lib_2/mirrors/immutable_collections_test 0:00:52.642362 - run_vm_unittest - dartk-vm debug_x64/vm/cc/SNPrint_BadArgs 0:00:45.664881 - vm - dartk-vm debug_x64/vm/dart/reused_instructions_test 0:00:40.896166 - vm - dartk-vm debug_x64/service/object_graph_vm_test 0:00:39.953248 - vm - dartk-vm debug_x64/service/process_service_test 0:00:36.919782 - vm - dartk-vm debug_x64/service/dev_fs_test 0:00:36.843871 - vm - dartk-vm debug_x64/service/contexts_test 0:00:35.932832 - vm - dartk-vm debug_x64/service/kill_paused_test 0:00:35.921669 - vm - dartk-vm debug_x64/service/evaluate_in_async_activation_test 0:00:35.250110 - vm - dartk-vm debug_x64/service/dev_fs_http_put_test 0:00:35.077406 - vm - dartk-vm debug_x64/service/issue_27287_test 0:00:34.122893 - vm - dartk-vm debug_x64/service/pause_on_unhandled_async_exceptions2_test/0 0:00:33.982276 - vm - dartk-vm debug_x64/service/file_service_test 0:00:33.718792 - vm - dartk-vm debug_x64/service/get_heap_map_rpc_test 0:00:32.714045 - vm - dartk-vm debug_x64/service/implicit_getter_setter_test 0:00:31.781160 - vm - dartk-vm debug_x64/service/get_isolate_after_sync_error_test 0:00:31.776534 - vm - dartk-vm debug_x64/service/get_user_level_retaining_path_rpc_test INFO: Enabling coredump archiving into C:\b\s\w\ir\crashes INFO: Core dump archiving is activated INFO: No unexpected crashes recorded 2019-04-04 14:31:11,342 - root: [DEBUG] Contents of task_output_dir: ['c:\\b\\s\\w\\ir\\tmp\\t\\tmpzq7bj_\\4402f1a3ce603610'] 2019-04-04 14:31:11,342 - root: [WARNING] Expected output.json file missing: set(['c:\\b\\s\\w\\ir\\tmp\\t\\tmpzq7bj_\\4402f1a3ce603610\\output.json']) Found: [] Expected: ['c:\\b\\s\\w\\ir\\tmp\\t\\tmpzq7bj_\\4402f1a3ce603610\\output.json'] 2019-04-04 14:31:11,342 - root: [WARNING] No shard json files found in task_output_dir: 'c:\\b\\s\\w\\ir\\tmp\\t\\tmpzq7bj_' Found ['c:\\b\\s\\w\\ir\\tmp\\t\\tmpzq7bj_\\4402f1a3ce603610'] 2019-04-04 14:31:11,342 - root: [DEBUG] Found shard_json_files: ['c:\\b\\s\\w\\ir\\tmp\\t\\tmpzq7bj_\\4402f1a3ce603610\\output.json'] 2019-04-04 14:31:11,342 - 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\tmpw5b7lx.json --task-output-dir c:\b\s\w\ir\tmp\t\tmpzq7bj_ -o c:\b\s\w\ir\tmp\t\tmpvlz7om.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\\tmpw5b7lx.json', '--task-output-dir', 'c:\\b\\s\\w\\ir\\tmp\\t\\tmpzq7bj_', '-o', 'c:\\b\\s\\w\\ir\\tmp\\t\\tmpvlz7om.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\\tmpw5b7lx.json', '--task-output-dir', 'c:\\b\\s\\w\\ir\\tmp\\t\\tmpzq7bj_', '-o', 'c:\\b\\s\\w\\ir\\tmp\\t\\tmpvlz7om.json'] returned exit code 0