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/tmpHAY7_s.json --task-output-dir /b/s/w/ir/tmp/t/tmp8QXvrQ --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/tmp3wU0Ntmerge_script_log --merge-additional-args '[]' --summary-json-file /b/s/w/ir/tmp/t/tmpCVr4kS.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/tmp9qEt6m.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/tmpHAY7_s.json', '--task-output-dir', '/b/s/w/ir/tmp/t/tmp8QXvrQ', '--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/tmp3wU0Ntmerge_script_log', '--merge-additional-args', '[]', '--summary-json-file', '/b/s/w/ir/tmp/t/tmpCVr4kS.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/tmp9qEt6m.json'] env: {} env_prefixes: {'PATH': '/b/s/w/ir/cache/swarming_client'} env_suffixes: {} infra_step: False name_tokens: ('vm tests_shard_3',) 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: 33473 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/8915731851208569424 LOGDOG_STREAM_PROJECT: dart LOGDOG_STREAM_SERVER_PATH: unix:/b/s/w/ir/tmp/ld.sock LOGNAME: chrome-bot LUCI_CONTEXT: /b/s/w/itO1Cu7w/luci_context.655520950 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-95-qlew SWARMING_EXTERNAL_BOT_SETUP: 1 SWARMING_HEADLESS: 1 SWARMING_SERVER: https://chromium-swarm.appspot.com SWARMING_TASK_ID: 444f51f9d0d46411 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-19 10:31:53,565 - root: [DEBUG] Using task_output_dir: '/b/s/w/ir/tmp/t/tmp8QXvrQ' 2019-04-19 10:31:53,565 - root: [WARNING] task_output_dir '/b/s/w/ir/tmp/t/tmp8QXvrQ' already exists! 2019-04-19 10:31:53,565 - root: [WARNING] task_output_dir existing content: [] 2019-04-19 10:31:53,565 - 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/tmp9qEt6m.json -output-dir /b/s/w/ir/tmp/t/tmp8QXvrQ -task-summary-json /b/s/w/ir/tmp/t/tmpCVr4kS.json [D2019-04-19T10:31:53.571108-07:00 7374 0 auth.go:1265] Minting a new token {"key":"luci_ctx/e086eaba617450bb9dd40cd72cbf871918f8a6d1b963c3032763fe4d6d891182", "scopes":"https://www.googleapis.com/auth/userinfo.email"} [D2019-04-19T10:31:53.571210-07:00 7374 0 luci_ctx.go:138] POST http://127.0.0.1:34497/rpc/LuciLocalAuthService.GetOAuthToken {"key":"luci_ctx/e086eaba617450bb9dd40cd72cbf871918f8a6d1b963c3032763fe4d6d891182", "scopes":"https://www.googleapis.com/auth/userinfo.email"} [D2019-04-19T10:31:53.573009-07:00 7374 0 auth.go:1222] Token expires in 28m0.427008674s {"key":"luci_ctx/e086eaba617450bb9dd40cd72cbf871918f8a6d1b963c3032763fe4d6d891182", "scopes":"https://www.googleapis.com/auth/userinfo.email"} 444f619d277ca610: 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-ia32(architecture: ia32, 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-ia32(architecture: ia32, compiler: dartk, mode: debug, runtime: vm, system: linux, vm-options: [], dart2js-options: [], timeout: null, preview-dart-2) Suites tested: observatory_ui Total: 863 tests * 87 tests will be skipped (40 skipped by design) * 3 tests are expected to be flaky but not crash * 0 tests are expected to flaky crash * 719 tests are expected to pass * 0 tests are expected to fail that we won't fix * 23 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 * 31 could not be categorized or are in multiple categories 162 out of 776 completed Tests running for 5 minutes 506 out of 776 completed Tests running for 10 minutes 752 out of 776 completed Tests running for 15 minutes FAILED: dartk-vm debug_ia32 standalone_2/io/dart_std_io_pipe_test/05/1 Expected: Timeout Pass Actual: RuntimeError --- Command "vm" (took 42.000780s): DART_CONFIGURATION=DebugIA32 out/DebugIA32/dart --no-background-compilation --short_socket_read --ignore-unrecognized-flags --packages=/b/s/w/ir/.packages /b/s/w/ir/out/DebugIA32/generated_tests/standalone_2/io/dart_std_io_pipe_test_05.dart exit code: 255 stderr: Unhandled exception: Expect.equals(expected: <Hello\x0AHello\x0A>, actual: <HelHellolo\x0A\x0A>) fails. #0 Expect._fail (package:expect/expect.dart:655:5) #1 Expect.equals (package:expect/expect.dart:123:7) #2 checkFileContent (file:///b/s/w/ir/out/DebugIA32/generated_tests/standalone_2/io/dart_std_io_pipe_test_05.dart:28:10) #3 test.<anonymous closure>.<anonymous closure> (file:///b/s/w/ir/out/DebugIA32/generated_tests/standalone_2/io/dart_std_io_pipe_test_05.dart:78:11) #4 _RootZone.runUnary (dart:async/zone.dart:1379:54) #5 _FutureListener.handleValue (dart:async/future_impl.dart:126:18) #6 Future._propagateToListeners.handleValueCallback (dart:async/future_impl.dart:639:45) #7 Future._propagateToListeners (dart:async/future_impl.dart:668:32) #8 Future._completeWithValue (dart:async/future_impl.dart:483:5) #9 Future._asyncComplete.<anonymous closure> (dart:async/future_impl.dart:513:7) #10 _microtaskLoop (dart:async/schedule_microtask.dart:41:21) #11 _startMicrotaskLoop (dart:async/schedule_microtask.dart:50:5) #12 _runPendingImmediateCallback (dart:isolate-patch/isolate_patch.dart:115:13) #13 _RawReceivePortImpl._handleMessage (dart:isolate-patch/isolate_patch.dart:172:5) --- Re-run this test: python tools/test.py -n dartk-linux-debug-ia32 standalone_2/io/dart_std_io_pipe_test/05/1 FAILED: dartk-vm debug_ia32 standalone_2/io/dart_std_io_pipe_test/05/3 Expected: Timeout Pass Actual: RuntimeError --- Command "vm" (took 42.000028s): DART_CONFIGURATION=DebugIA32 out/DebugIA32/dart --no-background-compilation --short_socket_read --short_socket_write --ignore-unrecognized-flags --packages=/b/s/w/ir/.packages /b/s/w/ir/out/DebugIA32/generated_tests/standalone_2/io/dart_std_io_pipe_test_05.dart exit code: 255 stderr: Unhandled exception: Expect.equals(expected: <Hello\x0AHello\x0A>, actual: <HelHellolo\x0A\x0A>) fails. #0 Expect._fail (package:expect/expect.dart:655:5) #1 Expect.equals (package:expect/expect.dart:123:7) #2 checkFileContent (file:///b/s/w/ir/out/DebugIA32/generated_tests/standalone_2/io/dart_std_io_pipe_test_05.dart:28:10) #3 test.<anonymous closure>.<anonymous closure> (file:///b/s/w/ir/out/DebugIA32/generated_tests/standalone_2/io/dart_std_io_pipe_test_05.dart:78:11) #4 _RootZone.runUnary (dart:async/zone.dart:1379:54) #5 _FutureListener.handleValue (dart:async/future_impl.dart:126:18) #6 Future._propagateToListeners.handleValueCallback (dart:async/future_impl.dart:639:45) #7 Future._propagateToListeners (dart:async/future_impl.dart:668:32) #8 Future._completeWithValue (dart:async/future_impl.dart:483:5) #9 Future._asyncComplete.<anonymous closure> (dart:async/future_impl.dart:513:7) #10 _microtaskLoop (dart:async/schedule_microtask.dart:41:21) #11 _startMicrotaskLoop (dart:async/schedule_microtask.dart:50:5) #12 _runPendingImmediateCallback (dart:isolate-patch/isolate_patch.dart:115:13) #13 _RawReceivePortImpl._handleMessage (dart:isolate-patch/isolate_patch.dart:172:5) --- Re-run this test: python tools/test.py -n dartk-linux-debug-ia32 standalone_2/io/dart_std_io_pipe_test/05/3 === Failure summary: FAILED: dartk-vm debug_ia32 standalone_2/io/dart_std_io_pipe_test/05/1 Expected: Timeout Pass Actual: RuntimeError --- Command "vm" (took 42.000780s): DART_CONFIGURATION=DebugIA32 out/DebugIA32/dart --no-background-compilation --short_socket_read --ignore-unrecognized-flags --packages=/b/s/w/ir/.packages /b/s/w/ir/out/DebugIA32/generated_tests/standalone_2/io/dart_std_io_pipe_test_05.dart exit code: 255 stderr: Unhandled exception: Expect.equals(expected: <Hello\x0AHello\x0A>, actual: <HelHellolo\x0A\x0A>) fails. #0 Expect._fail (package:expect/expect.dart:655:5) #1 Expect.equals (package:expect/expect.dart:123:7) #2 checkFileContent (file:///b/s/w/ir/out/DebugIA32/generated_tests/standalone_2/io/dart_std_io_pipe_test_05.dart:28:10) #3 test.<anonymous closure>.<anonymous closure> (file:///b/s/w/ir/out/DebugIA32/generated_tests/standalone_2/io/dart_std_io_pipe_test_05.dart:78:11) #4 _RootZone.runUnary (dart:async/zone.dart:1379:54) #5 _FutureListener.handleValue (dart:async/future_impl.dart:126:18) #6 Future._propagateToListeners.handleValueCallback (dart:async/future_impl.dart:639:45) #7 Future._propagateToListeners (dart:async/future_impl.dart:668:32) #8 Future._completeWithValue (dart:async/future_impl.dart:483:5) #9 Future._asyncComplete.<anonymous closure> (dart:async/future_impl.dart:513:7) #10 _microtaskLoop (dart:async/schedule_microtask.dart:41:21) #11 _startMicrotaskLoop (dart:async/schedule_microtask.dart:50:5) #12 _runPendingImmediateCallback (dart:isolate-patch/isolate_patch.dart:115:13) #13 _RawReceivePortImpl._handleMessage (dart:isolate-patch/isolate_patch.dart:172:5) --- Re-run this test: python tools/test.py -n dartk-linux-debug-ia32 standalone_2/io/dart_std_io_pipe_test/05/1 FAILED: dartk-vm debug_ia32 standalone_2/io/dart_std_io_pipe_test/05/3 Expected: Timeout Pass Actual: RuntimeError --- Command "vm" (took 42.000028s): DART_CONFIGURATION=DebugIA32 out/DebugIA32/dart --no-background-compilation --short_socket_read --short_socket_write --ignore-unrecognized-flags --packages=/b/s/w/ir/.packages /b/s/w/ir/out/DebugIA32/generated_tests/standalone_2/io/dart_std_io_pipe_test_05.dart exit code: 255 stderr: Unhandled exception: Expect.equals(expected: <Hello\x0AHello\x0A>, actual: <HelHellolo\x0A\x0A>) fails. #0 Expect._fail (package:expect/expect.dart:655:5) #1 Expect.equals (package:expect/expect.dart:123:7) #2 checkFileContent (file:///b/s/w/ir/out/DebugIA32/generated_tests/standalone_2/io/dart_std_io_pipe_test_05.dart:28:10) #3 test.<anonymous closure>.<anonymous closure> (file:///b/s/w/ir/out/DebugIA32/generated_tests/standalone_2/io/dart_std_io_pipe_test_05.dart:78:11) #4 _RootZone.runUnary (dart:async/zone.dart:1379:54) #5 _FutureListener.handleValue (dart:async/future_impl.dart:126:18) #6 Future._propagateToListeners.handleValueCallback (dart:async/future_impl.dart:639:45) #7 Future._propagateToListeners (dart:async/future_impl.dart:668:32) #8 Future._completeWithValue (dart:async/future_impl.dart:483:5) #9 Future._asyncComplete.<anonymous closure> (dart:async/future_impl.dart:513:7) #10 _microtaskLoop (dart:async/schedule_microtask.dart:41:21) #11 _startMicrotaskLoop (dart:async/schedule_microtask.dart:50:5) #12 _runPendingImmediateCallback (dart:isolate-patch/isolate_patch.dart:115:13) #13 _RawReceivePortImpl._handleMessage (dart:isolate-patch/isolate_patch.dart:172:5) --- Re-run this test: python tools/test.py -n dartk-linux-debug-ia32 standalone_2/io/dart_std_io_pipe_test/05/3 === === 2 tests failed === --- Total time: 16:44 --- 0:03:02.280202 - vm - dartk-vm debug_ia32/service/coverage_optimized_function_test 0:01:48.820506 - vm - dartk-vm debug_ia32/standalone_2/io/process_sync_test 0:00:52.935240 - vm - dartk-vm debug_ia32/language_2/arithmetic_test 0:00:52.869617 - vm - dartk-vm debug_ia32/standalone_2/io/dart_std_io_pipe_test/01/1 0:00:52.762209 - vm - dartk-vm debug_ia32/standalone_2/io/dart_std_io_pipe_test/01/0 0:00:52.761041 - vm - dartk-vm debug_ia32/vm/dart/byte_array_optimized_test 0:00:52.704338 - vm - dartk-vm debug_ia32/standalone_2/io/dart_std_io_pipe_test/01/2 0:00:52.673445 - vm - dartk-vm debug_ia32/standalone_2/io/dart_std_io_pipe_test/02/1 0:00:52.562576 - vm - dartk-vm debug_ia32/standalone_2/io/dart_std_io_pipe_test/02/0 0:00:52.485930 - vm - dartk-vm debug_ia32/standalone_2/io/dart_std_io_pipe_test/02/2 0:00:52.346249 - vm - dartk-vm debug_ia32/standalone_2/io/dart_std_io_pipe_test/01/3 0:00:51.479704 - vm - dartk-vm debug_ia32/lib_2/math/double_pow_test 0:00:49.687118 - vm - dartk-vm debug_ia32/language_2/vm/modtruncdiv_int_test 0:00:48.731846 - vm - dartk-vm debug_ia32/language_2/inline_test_context_test 0:00:47.753827 - vm - dartk-vm debug_ia32/language_2/vm/shift_special_cases_test 0:00:47.328690 - vm - dartk-vm debug_ia32/vm/dart/regress32597_2_test 0:00:47.197025 - vm - dartk-vm debug_ia32/language_2/deopt_lazy_finalization_test 0:00:46.096194 - vm - dartk-vm debug_ia32/corelib_2/integer_arith_vm_test/none/2 0:00:45.734219 - vm - dartk-vm debug_ia32/language_2/vm/optimized_testsmi_test 0:00:45.562431 - vm - dartk-vm debug_ia32/lib_2/typed_data/float32x4_sign_mask_test INFO: Core dump archiving is activated INFO: No unexpected crashes recorded 2019-04-19 10:31:54,118 - root: [DEBUG] Contents of task_output_dir: ['/b/s/w/ir/tmp/t/tmp8QXvrQ/444f619d277ca610'] 2019-04-19 10:31:54,118 - root: [WARNING] Expected output.json file missing: set(['/b/s/w/ir/tmp/t/tmp8QXvrQ/444f619d277ca610/output.json']) Found: [] Expected: ['/b/s/w/ir/tmp/t/tmp8QXvrQ/444f619d277ca610/output.json'] 2019-04-19 10:31:54,118 - root: [WARNING] No shard json files found in task_output_dir: '/b/s/w/ir/tmp/t/tmp8QXvrQ' Found ['/b/s/w/ir/tmp/t/tmp8QXvrQ/444f619d277ca610'] 2019-04-19 10:31:54,118 - root: [DEBUG] Found shard_json_files: ['/b/s/w/ir/tmp/t/tmp8QXvrQ/444f619d277ca610/output.json'] 2019-04-19 10:31:54,118 - 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/tmpCVr4kS.json --task-output-dir /b/s/w/ir/tmp/t/tmp8QXvrQ -o /b/s/w/ir/tmp/t/tmpHAY7_s.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/tmpCVr4kS.json', '--task-output-dir', '/b/s/w/ir/tmp/t/tmp8QXvrQ', '-o', '/b/s/w/ir/tmp/t/tmpHAY7_s.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/tmpCVr4kS.json', '--task-output-dir', '/b/s/w/ir/tmp/t/tmp8QXvrQ', '-o', '/b/s/w/ir/tmp/t/tmpHAY7_s.json'] returned exit code 0