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

python -u /b/s/w/ir/kitchen-checkout/build/scripts/tools/runit.py --show-path --with-third-party-lib -- python /b/s/w/ir/kitchen-checkout/build/scripts/slave/recipe_modules/chromium_swarming/resources/collect_task.py --verbose -o /b/s/w/ir/tmp/t/tmpQwLPg7.json --task-output-dir /b/s/w/ir/tmp/t/tmpjJBq_2 --merge-script /b/s/w/ir/kitchen-checkout/build/scripts/slave/recipe_modules/chromium_swarming/resources/noop_merge.py --merge-script-stdout-file /b/s/w/ir/tmp/t/tmpDpjkI7merge_script_log --merge-additional-args '[]' --summary-json-file /b/s/w/ir/tmp/t/tmpyniah6.json -- swarming collect -server https://chromium-swarm.appspot.com -worker 50 -task-summary-python -task-output-stdout all -verbose -requests-json /b/s/w/ir/tmp/t/tmpCDdBOs.json in dir /b/s/w/ir/k: allow_subannotations: False cmd: ['python', '-u', '/b/s/w/ir/kitchen-checkout/build/scripts/tools/runit.py', '--show-path', '--with-third-party-lib', '--', 'python', '/b/s/w/ir/kitchen-checkout/build/scripts/slave/recipe_modules/chromium_swarming/resources/collect_task.py', '--verbose', '-o', '/b/s/w/ir/tmp/t/tmpQwLPg7.json', '--task-output-dir', '/b/s/w/ir/tmp/t/tmpjJBq_2', '--merge-script', '/b/s/w/ir/kitchen-checkout/build/scripts/slave/recipe_modules/chromium_swarming/resources/noop_merge.py', '--merge-script-stdout-file', '/b/s/w/ir/tmp/t/tmpDpjkI7merge_script_log', '--merge-additional-args', '[]', '--summary-json-file', '/b/s/w/ir/tmp/t/tmpyniah6.json', '--', 'swarming', 'collect', '-server', 'https://chromium-swarm.appspot.com', '-worker', '50', '-task-summary-python', '-task-output-stdout', 'all', '-verbose', '-requests-json', '/b/s/w/ir/tmp/t/tmpCDdBOs.json'] env: {} env_prefixes: {'PATH': '/b/s/w/ir/cache/swarming_client'} env_suffixes: {} infra_step: False name_tokens: ('vm tests_shard_8',) ok_ret: ALL_OK step_test_data: gen_default_step_test_data(...) trigger_specs: () full environment: BOTO_CONFIG: /b/s/w/ir/tmp/gsutil_task/.boto BUILDBUCKET_EXPERIMENTAL: FALSE CIPD_CACHE_DIR: /b/s/cipd_cache/cache CIPD_PROTOCOL: v2 DEVSHELL_CLIENT_PORT: 34947 DOCKER_CONFIG: /b/s/w/ir/tmp/docker_cfg_task DOCKER_TMPDIR: /b/s/w/ir/tmp/docker_tmp_task GIT_CONFIG_NOSYSTEM: 1 GIT_TERMINAL_PROMPT: 0 HOME: /home/chrome-bot INFRA_GIT_WRAPPER_HOME: /b/s/w/ir/tmp/git_home_task LANG: en_US.UTF-8 LOGDOG_COORDINATOR_HOST: logs.chromium.org LOGDOG_STREAM_PREFIX: buildbucket/cr-buildbucket.appspot.com/8915652264294068064 LOGDOG_STREAM_PROJECT: dart LOGDOG_STREAM_SERVER_PATH: unix:/b/s/w/ir/tmp/ld.sock LOGNAME: chrome-bot LUCI_CONTEXT: /b/s/w/itCnADkR/luci_context.587714171 MAC_CHROMIUM_TMPDIR: /b/s/w/ir/tmp/t NO_GCE_CHECK: False PATH: /b/s/w/ir/cache/swarming_client:/b/s/w/ir/cipd_bin_packages:/b/s/w/ir/cipd_bin_packages/bin:/b/s/cipd_cache/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin PWD: /b/s/w/ir/k PYTHONIOENCODING: UTF-8 PYTHONUNBUFFERED: 1 SHELL: /bin/bash SHLVL: 1 SWARMING_BOT_ID: luci-dart-try-xenial-12-dyej SWARMING_EXTERNAL_BOT_SETUP: 1 SWARMING_HEADLESS: 1 SWARMING_SERVER: https://chromium-swarm.appspot.com SWARMING_TASK_ID: 4453d80f7c34ef11 TEMP: /b/s/w/ir/tmp/t TEMPDIR: /b/s/w/ir/tmp/t TMP: /b/s/w/ir/tmp/t TMPDIR: /b/s/w/ir/tmp/t USER: chrome-bot VPYTHON_VIRTUALENV_ROOT: /b/s/w/ir/cache/vpython _: /b/s/w/ir/cipd_bin_packages/vpython Set PYTHONPATH: /b/s/w/ir/kitchen-checkout/build/scripts:/b/s/w/ir/kitchen-checkout/build/site_config:/b/s/w/ir/kitchen-checkout/build/third_party:/b/s/w/ir/kitchen-checkout/build/third_party/buildbot_8_4p1:/b/s/w/ir/kitchen-checkout/build/third_party/buildbot_slave_8_4:/b/s/w/ir/kitchen-checkout/build/third_party/coverage-3.7.1:/b/s/w/ir/kitchen-checkout/build/third_party/decorator_3_3_1:/b/s/w/ir/kitchen-checkout/build/third_party/google_api_python_client:/b/s/w/ir/kitchen-checkout/build/third_party/httplib2/python2:/b/s/w/ir/kitchen-checkout/build/third_party/infra_libs:/b/s/w/ir/kitchen-checkout/build/third_party/jinja2:/b/s/w/ir/kitchen-checkout/build/third_party/markupsafe:/b/s/w/ir/kitchen-checkout/build/third_party/oauth2client:/b/s/w/ir/kitchen-checkout/build/third_party/pyasn1:/b/s/w/ir/kitchen-checkout/build/third_party/pyasn1-modules:/b/s/w/ir/kitchen-checkout/build/third_party/python-rsa:/b/s/w/ir/kitchen-checkout/build/third_party/requests_2_10_0:/b/s/w/ir/kitchen-checkout/build/third_party/setuptools-0.6c11:/b/s/w/ir/kitchen-checkout/build/third_party/sqlalchemy_0_7_1:/b/s/w/ir/kitchen-checkout/build/third_party/sqlalchemy_migrate_0_7_1:/b/s/w/ir/kitchen-checkout/build/third_party/tempita_0_5:/b/s/w/ir/kitchen-checkout/build/third_party/twisted_10_2:/b/s/w/ir/kitchen-checkout/build/third_party/uritemplate:/b/s/w/ir/kitchen-checkout/build/third_party/site-packages 2019-04-20 07:10:57,101 - root: [DEBUG] Using task_output_dir: '/b/s/w/ir/tmp/t/tmpjJBq_2' 2019-04-20 07:10:57,101 - root: [WARNING] task_output_dir '/b/s/w/ir/tmp/t/tmpjJBq_2' already exists! 2019-04-20 07:10:57,101 - root: [WARNING] task_output_dir existing content: [] 2019-04-20 07:10:57,101 - root: [INFO] collect_cmd: swarming collect -server https://chromium-swarm.appspot.com -worker 50 -task-summary-python -task-output-stdout all -verbose -requests-json /b/s/w/ir/tmp/t/tmpCDdBOs.json -output-dir /b/s/w/ir/tmp/t/tmpjJBq_2 -task-summary-json /b/s/w/ir/tmp/t/tmpyniah6.json [D2019-04-20T07:10:57.108259-07:00 7420 0 auth.go:1265] Minting a new token {"key":"luci_ctx/2a9f5e64b8380de766443fb9b1a46effd318d73d8af7872bf1869ca157b193fa", "scopes":"https://www.googleapis.com/auth/userinfo.email"} [D2019-04-20T07:10:57.108359-07:00 7420 0 luci_ctx.go:138] POST http://127.0.0.1:33951/rpc/LuciLocalAuthService.GetOAuthToken {"key":"luci_ctx/2a9f5e64b8380de766443fb9b1a46effd318d73d8af7872bf1869ca157b193fa", "scopes":"https://www.googleapis.com/auth/userinfo.email"} [D2019-04-20T07:10:57.110814-07:00 7420 0 auth.go:1222] Token expires in 43m24.889212983s {"key":"luci_ctx/2a9f5e64b8380de766443fb9b1a46effd318d73d8af7872bf1869ca157b193fa", "scopes":"https://www.googleapis.com/auth/userinfo.email"} 4453dc6c96e31910: exit 0 /b/s/swarming_bot.1.zip/third_party/requests/__init__.py:83: RequestsDependencyWarning: Old version of cryptography ([1, 2, 3]) may cause slowdown. tools/testing/dart/main.dart:1: Warning: Interpreting this as package URI, 'package:test_dart/main.dart'. Test configurations: dartk-linux-debug-x64(architecture: x64, compiler: dartk, mode: debug, runtime: vm, system: linux, 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-linux-debug-x64(architecture: x64, compiler: dartk, mode: debug, runtime: vm, system: linux, vm-options: [], dart2js-options: [], timeout: null, preview-dart-2) Suites tested: observatory_ui Total: 1425 tests * 118 tests will be skipped (32 skipped by design) * 1 tests are expected to be flaky but not crash * 0 tests are expected to flaky crash * 1275 tests are expected to pass * 1 tests are expected to fail that we won't fix * 19 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 * 11 could not be categorized or are in multiple categories FAILED: dartk-vm debug_x64 service/get_source_report_test Expected: Pass Actual: RuntimeError --- Command "vm" (took 15.000024s): DART_CONFIGURATION=DebugX64 out/DebugX64/dart --no-background-compilation --ignore-unrecognized-flags --packages=/b/s/w/ir/.packages /b/s/w/ir/runtime/observatory/tests/service/get_source_report_test.dart exit code: 255 stdout: ** Launching SERVICE_TEST_TESTEE=true out/DebugX64/dart --disable-service-auth-codes --profiler --no-background-compilation --ignore-unrecognized-flags --packages=/b/s/w/ir/.packages --enable-vm-service:0 /b/s/w/ir/runtime/observatory/tests/service/get_source_report_test.dart >testee>out> Observatory listening on http://127.0.0.1:45669/ ** Signaled to run test queries on http://127.0.0.1:45669/ >testee>out> Loading VM... >testee>out> otherFunction < >testee>out> positive Done loading VM Running get_source_report_test.dart [1/2] Paused with PauseBreakpoint Running get_source_report_test.dart [2/2] ** Killing script Unexpected exception in service tests: Expected: true Actual: <false> #0 DefaultFailureHandler.fail (package:unittest/src/matcher/expect.dart:117:5) #1 DefaultFailureHandler.failMatch (package:unittest/src/matcher/expect.dart:121:5) #2 expect (package:unittest/src/matcher/expect.dart:95:20) #3 tests.<anonymous closure> (file:///b/s/w/ir/runtime/observatory/tests/service/get_source_report_test.dart:94:5) <asynchronous suspension> #4 _ServiceTesterRunner.run.<anonymous closure>.<anonymous closure> (file:///b/s/w/ir/runtime/observatory/tests/service/test_helper.dart:334:23) <asynchronous suspension> #5 _rootRunUnary (dart:async/zone.dart:1132:38) #6 _CustomZone.runUnary (dart:async/zone.dart:1029:19) #7 _FutureListener.handleValue (dart:async/future_impl.dart:126:18) #8 Future._propagateToListeners.handleValueCallback (dart:async/future_impl.dart:639:45) #9 Future._propagateToListeners (dart:async/future_impl.dart:668:32) #10 Future._completeWithValue (dart:async/future_impl.dart:483:5) #11 Future._asyncComplete.<anonymous closure> (dart:async/future_impl.dart:513:7) #12 _rootRun (dart:async/zone.dart:1124:13) #13 _CustomZone.run (dart:async/zone.dart:1021:19) #14 _CustomZone.runGuarded (dart:async/zone.dart:923:7) #15 _CustomZone.bindCallbackGuarded.<anonymous closure> (dart:async/zone.dart:963:23) #16 _microtaskLoop (dart:async/schedule_microtask.dart:41:21) #17 _startMicrotaskLoop (dart:async/schedule_microtask.dart:50:5) #18 _runPendingImmediateCallback (dart:isolate-patch/isolate_patch.dart:115:13) #19 _RawReceivePortImpl._handleMessage (dart:isolate-patch/isolate_patch.dart:172:5) stderr: Unhandled exception: Expected: true Actual: <false> #0 DefaultFailureHandler.fail (package:unittest/src/matcher/expect.dart:117:5) #1 DefaultFailureHandler.failMatch (package:unittest/src/matcher/expect.dart:121:5) #2 expect (package:unittest/src/matcher/expect.dart:95:20) #3 tests.<anonymous closure> (file:///b/s/w/ir/runtime/observatory/tests/service/get_source_report_test.dart:94:5) <asynchronous suspension> #4 _ServiceTesterRunner.run.<anonymous closure>.<anonymous closure> (file:///b/s/w/ir/runtime/observatory/tests/service/test_helper.dart:334:23) <asynchronous suspension> #5 _rootRunUnary (dart:async/zone.dart:1132:38) #6 _CustomZone.runUnary (dart:async/zone.dart:1029:19) #7 _FutureListener.handleValue (dart:async/future_impl.dart:126:18) #8 Future._propagateToListeners.handleValueCallback (dart:async/future_impl.dart:639:45) #9 Future._propagateToListeners (dart:async/future_impl.dart:668:32) #10 Future._completeWithValue (dart:async/future_impl.dart:483:5) #11 Future._asyncComplete.<anonymous closure> (dart:async/future_impl.dart:513:7) #12 _rootRun (dart:async/zone.dart:1124:13) #13 _CustomZone.run (dart:async/zone.dart:1021:19) #14 _CustomZone.runGuarded (dart:async/zone.dart:923:7) #15 _CustomZone.bindCallbackGuarded.<anonymous closure> (dart:async/zone.dart:963:23) #16 _microtaskLoop (dart:async/schedule_microtask.dart:41:21) #17 _startMicrotaskLoop (dart:async/schedule_microtask.dart:50:5) #18 _runPendingImmediateCallback (dart:isolate-patch/isolate_patch.dart:115:13) #19 _RawReceivePortImpl._handleMessage (dart:isolate-patch/isolate_patch.dart:172:5) --- Re-run this test: python tools/test.py -n dartk-linux-debug-x64 service/get_source_report_test 812 out of 1307 completed Tests running for 5 minutes === Failure summary: FAILED: dartk-vm debug_x64 service/get_source_report_test Expected: Pass Actual: RuntimeError --- Command "vm" (took 15.000024s): DART_CONFIGURATION=DebugX64 out/DebugX64/dart --no-background-compilation --ignore-unrecognized-flags --packages=/b/s/w/ir/.packages /b/s/w/ir/runtime/observatory/tests/service/get_source_report_test.dart exit code: 255 stdout: ** Launching SERVICE_TEST_TESTEE=true out/DebugX64/dart --disable-service-auth-codes --profiler --no-background-compilation --ignore-unrecognized-flags --packages=/b/s/w/ir/.packages --enable-vm-service:0 /b/s/w/ir/runtime/observatory/tests/service/get_source_report_test.dart >testee>out> Observatory listening on http://127.0.0.1:45669/ ** Signaled to run test queries on http://127.0.0.1:45669/ >testee>out> Loading VM... >testee>out> otherFunction < >testee>out> positive Done loading VM Running get_source_report_test.dart [1/2] Paused with PauseBreakpoint Running get_source_report_test.dart [2/2] ** Killing script Unexpected exception in service tests: Expected: true Actual: <false> #0 DefaultFailureHandler.fail (package:unittest/src/matcher/expect.dart:117:5) #1 DefaultFailureHandler.failMatch (package:unittest/src/matcher/expect.dart:121:5) #2 expect (package:unittest/src/matcher/expect.dart:95:20) #3 tests.<anonymous closure> (file:///b/s/w/ir/runtime/observatory/tests/service/get_source_report_test.dart:94:5) <asynchronous suspension> #4 _ServiceTesterRunner.run.<anonymous closure>.<anonymous closure> (file:///b/s/w/ir/runtime/observatory/tests/service/test_helper.dart:334:23) <asynchronous suspension> #5 _rootRunUnary (dart:async/zone.dart:1132:38) #6 _CustomZone.runUnary (dart:async/zone.dart:1029:19) #7 _FutureListener.handleValue (dart:async/future_impl.dart:126:18) #8 Future._propagateToListeners.handleValueCallback (dart:async/future_impl.dart:639:45) #9 Future._propagateToListeners (dart:async/future_impl.dart:668:32) #10 Future._completeWithValue (dart:async/future_impl.dart:483:5) #11 Future._asyncComplete.<anonymous closure> (dart:async/future_impl.dart:513:7) #12 _rootRun (dart:async/zone.dart:1124:13) #13 _CustomZone.run (dart:async/zone.dart:1021:19) #14 _CustomZone.runGuarded (dart:async/zone.dart:923:7) #15 _CustomZone.bindCallbackGuarded.<anonymous closure> (dart:async/zone.dart:963:23) #16 _microtaskLoop (dart:async/schedule_microtask.dart:41:21) #17 _startMicrotaskLoop (dart:async/schedule_microtask.dart:50:5) #18 _runPendingImmediateCallback (dart:isolate-patch/isolate_patch.dart:115:13) #19 _RawReceivePortImpl._handleMessage (dart:isolate-patch/isolate_patch.dart:172:5) stderr: Unhandled exception: Expected: true Actual: <false> #0 DefaultFailureHandler.fail (package:unittest/src/matcher/expect.dart:117:5) #1 DefaultFailureHandler.failMatch (package:unittest/src/matcher/expect.dart:121:5) #2 expect (package:unittest/src/matcher/expect.dart:95:20) #3 tests.<anonymous closure> (file:///b/s/w/ir/runtime/observatory/tests/service/get_source_report_test.dart:94:5) <asynchronous suspension> #4 _ServiceTesterRunner.run.<anonymous closure>.<anonymous closure> (file:///b/s/w/ir/runtime/observatory/tests/service/test_helper.dart:334:23) <asynchronous suspension> #5 _rootRunUnary (dart:async/zone.dart:1132:38) #6 _CustomZone.runUnary (dart:async/zone.dart:1029:19) #7 _FutureListener.handleValue (dart:async/future_impl.dart:126:18) #8 Future._propagateToListeners.handleValueCallback (dart:async/future_impl.dart:639:45) #9 Future._propagateToListeners (dart:async/future_impl.dart:668:32) #10 Future._completeWithValue (dart:async/future_impl.dart:483:5) #11 Future._asyncComplete.<anonymous closure> (dart:async/future_impl.dart:513:7) #12 _rootRun (dart:async/zone.dart:1124:13) #13 _CustomZone.run (dart:async/zone.dart:1021:19) #14 _CustomZone.runGuarded (dart:async/zone.dart:923:7) #15 _CustomZone.bindCallbackGuarded.<anonymous closure> (dart:async/zone.dart:963:23) #16 _microtaskLoop (dart:async/schedule_microtask.dart:41:21) #17 _startMicrotaskLoop (dart:async/schedule_microtask.dart:50:5) #18 _runPendingImmediateCallback (dart:isolate-patch/isolate_patch.dart:115:13) #19 _RawReceivePortImpl._handleMessage (dart:isolate-patch/isolate_patch.dart:172:5) --- Re-run this test: python tools/test.py -n dartk-linux-debug-x64 service/get_source_report_test === === 1 test failed === --- Total time: 07:52 --- 0:00:18.122381 - vm - dartk-vm debug_x64/service/dev_fs_spawn_test 0:00:16.952605 - vm - dartk-vm debug_x64/service/set_library_debuggable_test 0:00:16.132622 - vm - dartk-vm debug_x64/service/external_service_disappear_test 0:00:16.115182 - vm - dartk-vm debug_x64/service/eval_internal_class_test 0:00:15.635703 - vm - dartk-vm debug_x64/service/step_into_async_no_await_test 0:00:15.379861 - vm - dartk-vm debug_x64/service/typed_data_test 0:00:15.268655 - vm - dartk-vm debug_x64/service/causal_async_star_stack_presence_test 0:00:15.128872 - vm - dartk-vm debug_x64/service/set_library_debuggable_rpc_test 0:00:15.120132 - vm - dartk-vm debug_x64/service/invoke_test 0:00:15.115604 - vm - dartk-vm debug_x64/corelib_2/regexp/pcre_test 0:00:15.024746 - vm - dartk-vm debug_x64/service/get_source_report_test 0:00:15.016723 - vm - dartk-vm debug_x64/service/issue_30555_test 0:00:14.984969 - vm - dartk-vm debug_x64/service/async_single_step_into_test 0:00:14.858250 - vm - dartk-vm debug_x64/service/get_object_store_rpc_test 0:00:14.619601 - vm - dartk-vm debug_x64/service/next_through_operator_bracket_test 0:00:14.525772 - vm - dartk-vm debug_x64/service/instance_field_order_rpc_test 0:00:14.499328 - vm - dartk-vm debug_x64/service/next_through_for_each_loop_test 0:00:14.464008 - vm - dartk-vm debug_x64/service/evaluate_async_closure_test 0:00:13.956960 - vm - dartk-vm debug_x64/service/get_version_rpc_test 0:00:13.111744 - vm - dartk-vm debug_x64/service/pause_on_start_then_step_test INFO: Core dump archiving is activated INFO: No unexpected crashes recorded 2019-04-20 07:10:57,545 - root: [DEBUG] Contents of task_output_dir: ['/b/s/w/ir/tmp/t/tmpjJBq_2/4453dc6c96e31910'] 2019-04-20 07:10:57,546 - root: [WARNING] Expected output.json file missing: set(['/b/s/w/ir/tmp/t/tmpjJBq_2/4453dc6c96e31910/output.json']) Found: [] Expected: ['/b/s/w/ir/tmp/t/tmpjJBq_2/4453dc6c96e31910/output.json'] 2019-04-20 07:10:57,546 - root: [WARNING] No shard json files found in task_output_dir: '/b/s/w/ir/tmp/t/tmpjJBq_2' Found ['/b/s/w/ir/tmp/t/tmpjJBq_2/4453dc6c96e31910'] 2019-04-20 07:10:57,546 - root: [DEBUG] Found shard_json_files: ['/b/s/w/ir/tmp/t/tmpjJBq_2/4453dc6c96e31910/output.json'] 2019-04-20 07:10:57,546 - root: [INFO] merge_cmd: /b/s/w/ir/cache/vpython/f6423e/bin/python /b/s/w/ir/kitchen-checkout/build/scripts/slave/recipe_modules/chromium_swarming/resources/noop_merge.py --summary-json /b/s/w/ir/tmp/t/tmpyniah6.json --task-output-dir /b/s/w/ir/tmp/t/tmpjJBq_2 -o /b/s/w/ir/tmp/t/tmpQwLPg7.json Running ['/b/s/w/ir/cache/vpython/f6423e/bin/python', '/b/s/w/ir/kitchen-checkout/build/scripts/slave/recipe_modules/chromium_swarming/resources/noop_merge.py', '--summary-json', '/b/s/w/ir/tmp/t/tmpyniah6.json', '--task-output-dir', '/b/s/w/ir/tmp/t/tmpjJBq_2', '-o', '/b/s/w/ir/tmp/t/tmpQwLPg7.json'] in None (env: None) Command ['/b/s/w/ir/cache/vpython/f6423e/bin/python', '/b/s/w/ir/kitchen-checkout/build/scripts/slave/recipe_modules/chromium_swarming/resources/noop_merge.py', '--summary-json', '/b/s/w/ir/tmp/t/tmpyniah6.json', '--task-output-dir', '/b/s/w/ir/tmp/t/tmpjJBq_2', '-o', '/b/s/w/ir/tmp/t/tmpQwLPg7.json'] returned exit code 0