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/tmplPLtWT.json --task-output-dir /b/s/w/ir/tmp/t/tmpVdFTA0 --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/tmpRHiXhnmerge_script_log --merge-additional-args '[]' --summary-json-file /b/s/w/ir/tmp/t/tmpNVgoi3.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/tmp1EJNr1.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/tmplPLtWT.json', '--task-output-dir', '/b/s/w/ir/tmp/t/tmpVdFTA0', '--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/tmpRHiXhnmerge_script_log', '--merge-additional-args', '[]', '--summary-json-file', '/b/s/w/ir/tmp/t/tmpNVgoi3.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/tmp1EJNr1.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: 34197 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/8915706999700380896 LOGDOG_STREAM_PROJECT: dart LOGDOG_STREAM_SERVER_PATH: unix:/b/s/w/ir/tmp/ld.sock LOGNAME: chrome-bot LUCI_CONTEXT: /b/s/w/itqyG_un/luci_context.484064539 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-28-acwm SWARMING_EXTERNAL_BOT_SETUP: 1 SWARMING_HEADLESS: 1 SWARMING_SERVER: https://chromium-swarm.appspot.com SWARMING_TASK_ID: 4450bb8f2e4e5a11 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 16:55:50,008 - root: [DEBUG] Using task_output_dir: '/b/s/w/ir/tmp/t/tmpVdFTA0' 2019-04-19 16:55:50,009 - root: [WARNING] task_output_dir '/b/s/w/ir/tmp/t/tmpVdFTA0' already exists! 2019-04-19 16:55:50,009 - root: [WARNING] task_output_dir existing content: [] 2019-04-19 16:55:50,009 - 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/tmp1EJNr1.json -output-dir /b/s/w/ir/tmp/t/tmpVdFTA0 -task-summary-json /b/s/w/ir/tmp/t/tmpNVgoi3.json [D2019-04-19T16:55:50.016276-07:00 9409 0 auth.go:1265] Minting a new token {"key":"luci_ctx/4172c388cce33498e9d9cc63daee495a5c74f0f1f76d595284b62dba34d2e77e", "scopes":"https://www.googleapis.com/auth/userinfo.email"} [D2019-04-19T16:55:50.016528-07:00 9409 0 luci_ctx.go:138] POST http://127.0.0.1:42835/rpc/LuciLocalAuthService.GetOAuthToken {"key":"luci_ctx/4172c388cce33498e9d9cc63daee495a5c74f0f1f76d595284b62dba34d2e77e", "scopes":"https://www.googleapis.com/auth/userinfo.email"} [D2019-04-19T16:55:50.018574-07:00 9409 0 auth.go:1222] Token expires in 36m16.981455924s {"key":"luci_ctx/4172c388cce33498e9d9cc63daee495a5c74f0f1f76d595284b62dba34d2e77e", "scopes":"https://www.googleapis.com/auth/userinfo.email"} 4450c602bdb25910: 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-optcounter-linux-release-ia32(architecture: ia32, compiler: dartk, mode: release, runtime: vm, system: linux, builder-tag: optimization_counter_threshold, vm-options: [--optimization-counter-threshold=5, --random-seed=__RANDOM__], 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-optcounter-linux-release-ia32(architecture: ia32, compiler: dartk, mode: release, runtime: vm, system: linux, builder-tag: optimization_counter_threshold, vm-options: [--optimization-counter-threshold=5, --random-seed=__RANDOM__], dart2js-options: [], timeout: null, preview-dart-2) Suites tested: observatory_ui Total: 1425 tests * 121 tests will be skipped (34 skipped by design) * 2 tests are expected to be flaky but not crash * 1 tests are expected to flaky crash * 1270 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 release_ia32 service/get_source_report_test Expected: Pass Actual: RuntimeError --- Command "vm" (took 30.000346s): DART_CONFIGURATION=ReleaseIA32 out/ReleaseIA32/dart --optimization-counter-threshold=5 --random-seed=1309566640 --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/ReleaseIA32/dart --disable-service-auth-codes --profiler --optimization-counter-threshold=5 --random-seed=1309566640 --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:39485/ ** Signaled to run test queries on http://127.0.0.1:39485/ >testee>out> >testee>out> otherFunction < >testee>out> positive Loading VM... 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-optcounter-linux-release-ia32 service/get_source_report_test 386 out of 1304 completed Tests running for 5 minutes 914 out of 1304 completed Tests running for 10 minutes === Failure summary: FAILED: dartk-vm release_ia32 service/get_source_report_test Expected: Pass Actual: RuntimeError --- Command "vm" (took 30.000346s): DART_CONFIGURATION=ReleaseIA32 out/ReleaseIA32/dart --optimization-counter-threshold=5 --random-seed=1309566640 --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/ReleaseIA32/dart --disable-service-auth-codes --profiler --optimization-counter-threshold=5 --random-seed=1309566640 --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:39485/ ** Signaled to run test queries on http://127.0.0.1:39485/ >testee>out> >testee>out> otherFunction < >testee>out> positive Loading VM... 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-optcounter-linux-release-ia32 service/get_source_report_test === === 1 test failed === --- Total time: 14:14 --- 0:00:32.385727 - vm - dartk-vm release_ia32/service/dev_fs_spawn_test 0:00:31.126269 - vm - dartk-vm release_ia32/service/causal_async_star_stack_presence_test 0:00:30.744539 - vm - dartk-vm release_ia32/service/invoke_test 0:00:30.346300 - vm - dartk-vm release_ia32/service/get_source_report_test 0:00:30.303529 - vm - dartk-vm release_ia32/service/step_into_async_no_await_test 0:00:30.222684 - vm - dartk-vm release_ia32/service/set_library_debuggable_test 0:00:29.659554 - vm - dartk-vm release_ia32/service/instance_field_order_rpc_test 0:00:29.320516 - vm - dartk-vm release_ia32/service/issue_30555_test 0:00:29.063470 - vm - dartk-vm release_ia32/service/get_object_store_rpc_test 0:00:28.849876 - vm - dartk-vm release_ia32/service/set_library_debuggable_rpc_test 0:00:28.825749 - vm - dartk-vm release_ia32/service/evaluate_async_closure_test 0:00:28.743235 - vm - dartk-vm release_ia32/service/typed_data_test 0:00:28.647316 - vm - dartk-vm release_ia32/service/async_single_step_into_test 0:00:28.575575 - vm - dartk-vm release_ia32/service/pause_on_start_then_step_test 0:00:28.443735 - vm - dartk-vm release_ia32/service/next_through_for_each_loop_test 0:00:28.102356 - vm - dartk-vm release_ia32/service/eval_internal_class_test 0:00:28.070691 - vm - dartk-vm release_ia32/service/get_version_rpc_test 0:00:27.685709 - vm - dartk-vm release_ia32/service/external_service_disappear_test 0:00:27.173506 - vm - dartk-vm release_ia32/service/next_through_operator_bracket_test 0:00:25.951861 - vm - dartk-vm release_ia32/corelib_2/regexp/pcre_test INFO: Core dump archiving is activated INFO: No unexpected crashes recorded 2019-04-19 16:55:50,509 - root: [DEBUG] Contents of task_output_dir: ['/b/s/w/ir/tmp/t/tmpVdFTA0/4450c602bdb25910'] 2019-04-19 16:55:50,510 - root: [WARNING] Expected output.json file missing: set(['/b/s/w/ir/tmp/t/tmpVdFTA0/4450c602bdb25910/output.json']) Found: [] Expected: ['/b/s/w/ir/tmp/t/tmpVdFTA0/4450c602bdb25910/output.json'] 2019-04-19 16:55:50,510 - root: [WARNING] No shard json files found in task_output_dir: '/b/s/w/ir/tmp/t/tmpVdFTA0' Found ['/b/s/w/ir/tmp/t/tmpVdFTA0/4450c602bdb25910'] 2019-04-19 16:55:50,510 - root: [DEBUG] Found shard_json_files: ['/b/s/w/ir/tmp/t/tmpVdFTA0/4450c602bdb25910/output.json'] 2019-04-19 16:55:50,510 - 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/tmpNVgoi3.json --task-output-dir /b/s/w/ir/tmp/t/tmpVdFTA0 -o /b/s/w/ir/tmp/t/tmplPLtWT.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/tmpNVgoi3.json', '--task-output-dir', '/b/s/w/ir/tmp/t/tmpVdFTA0', '-o', '/b/s/w/ir/tmp/t/tmplPLtWT.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/tmpNVgoi3.json', '--task-output-dir', '/b/s/w/ir/tmp/t/tmpVdFTA0', '-o', '/b/s/w/ir/tmp/t/tmplPLtWT.json'] returned exit code 0