[INFO] fetching crate si_trace_print 0.3.12...
[INFO] testing si_trace_print-0.3.12 against try#b83b707f97d809763b7861afa7638871f3339a33 for pr-145838-1
[INFO] extracting crate si_trace_print 0.3.12 into /workspace/builds/worker-5-tc2/source
[INFO] started tweaking crates.io crate si_trace_print 0.3.12
[INFO] finished tweaking crates.io crate si_trace_print 0.3.12
[INFO] tweaked toml for crates.io crate si_trace_print 0.3.12 written to /workspace/builds/worker-5-tc2/source/Cargo.toml
[INFO] validating manifest of crates.io crate si_trace_print 0.3.12 on toolchain b83b707f97d809763b7861afa7638871f3339a33
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+b83b707f97d809763b7861afa7638871f3339a33" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+b83b707f97d809763b7861afa7638871f3339a33" "generate-lockfile" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]     Updating crates.io index
[INFO] [stderr]      Locking 28 packages to latest compatible versions
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+b83b707f97d809763b7861afa7638871f3339a33" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr] warning: `edition` is set on library `si_trace_print` which is deprecated
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc2/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:7ad1b28ee6f5f7f699f6cf7015098d6ccdd96d6f2d78dd06228f5b4c9faf309c" "/opt/rustwide/cargo-home/bin/cargo" "+b83b707f97d809763b7861afa7638871f3339a33" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] 336c435475642178251fd5fb90b714b0b71971368583c43a3d393f01646a6d7f
[INFO] running `Command { std: "docker" "start" "-a" "336c435475642178251fd5fb90b714b0b71971368583c43a3d393f01646a6d7f", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "336c435475642178251fd5fb90b714b0b71971368583c43a3d393f01646a6d7f", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "336c435475642178251fd5fb90b714b0b71971368583c43a3d393f01646a6d7f", kill_on_drop: false }`
[INFO] [stdout] 336c435475642178251fd5fb90b714b0b71971368583c43a3d393f01646a6d7f
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc2/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:7ad1b28ee6f5f7f699f6cf7015098d6ccdd96d6f2d78dd06228f5b4c9faf309c" "/opt/rustwide/cargo-home/bin/cargo" "+b83b707f97d809763b7861afa7638871f3339a33" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 23fd68a101aceec9212ce9cdd3b32a6079b9dc4e2b8064c929be671d8a9049af
[INFO] running `Command { std: "docker" "start" "-a" "23fd68a101aceec9212ce9cdd3b32a6079b9dc4e2b8064c929be671d8a9049af", kill_on_drop: false }`
[INFO] [stderr] warning: `edition` is set on library `si_trace_print` which is deprecated
[INFO] [stderr]    Compiling unicode-xid v0.2.6
[INFO] [stderr]    Compiling memchr v2.7.5
[INFO] [stderr]    Compiling error-chain v0.10.0
[INFO] [stderr]    Compiling libc v0.2.175
[INFO] [stderr]    Compiling const_format_proc_macros v0.2.34
[INFO] [stderr]    Compiling mut_static v5.0.0
[INFO] [stderr]    Compiling object v0.36.7
[INFO] [stderr]    Compiling const_format v0.2.34
[INFO] [stderr]    Compiling backtrace v0.3.75
[INFO] [stderr]    Compiling si_trace_print v0.3.12 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 6.46s
[INFO] running `Command { std: "docker" "inspect" "23fd68a101aceec9212ce9cdd3b32a6079b9dc4e2b8064c929be671d8a9049af", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "23fd68a101aceec9212ce9cdd3b32a6079b9dc4e2b8064c929be671d8a9049af", kill_on_drop: false }`
[INFO] [stdout] 23fd68a101aceec9212ce9cdd3b32a6079b9dc4e2b8064c929be671d8a9049af
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc2/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:7ad1b28ee6f5f7f699f6cf7015098d6ccdd96d6f2d78dd06228f5b4c9faf309c" "/opt/rustwide/cargo-home/bin/cargo" "+b83b707f97d809763b7861afa7638871f3339a33" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 248a23c21fab2d8173593e1d285a16e5b8b22793fc44381898134f3cfb143f50
[INFO] running `Command { std: "docker" "start" "-a" "248a23c21fab2d8173593e1d285a16e5b8b22793fc44381898134f3cfb143f50", kill_on_drop: false }`
[INFO] [stderr] warning: `edition` is set on library `si_trace_print` which is deprecated
[INFO] [stderr]    Compiling si_trace_print v0.3.12 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 1.67s
[INFO] running `Command { std: "docker" "inspect" "248a23c21fab2d8173593e1d285a16e5b8b22793fc44381898134f3cfb143f50", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "248a23c21fab2d8173593e1d285a16e5b8b22793fc44381898134f3cfb143f50", kill_on_drop: false }`
[INFO] [stdout] 248a23c21fab2d8173593e1d285a16e5b8b22793fc44381898134f3cfb143f50
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-5-tc2/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:7ad1b28ee6f5f7f699f6cf7015098d6ccdd96d6f2d78dd06228f5b4c9faf309c" "/opt/rustwide/cargo-home/bin/cargo" "+b83b707f97d809763b7861afa7638871f3339a33" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] 494c606496fc9436146419425e098d90d51c9275e054cb4f58692bbd3c3095e3
[INFO] running `Command { std: "docker" "start" "-a" "494c606496fc9436146419425e098d90d51c9275e054cb4f58692bbd3c3095e3", kill_on_drop: false }`
[INFO] [stderr] warning: `edition` is set on library `si_trace_print` which is deprecated
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.05s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/si_trace_print-9335ef1c31e069b1)
[INFO] [stdout] 
[INFO] [stdout] running 41 tests
[INFO] [stdout] test function_name::tests::more_tests::test_function_name_plus0 ... ok
[INFO] [stdout] test function_name::tests::test_function_name ... ok
[INFO] [stdout] test function_name::tests::test_function_name_function_name_plus0 ... ok
[INFO] [stdout] test function_name::tests::test_function_name_plus0 ... ok
[INFO] [stdout] test function_name::tests::test_function_name_plus1 ... ok
[INFO] [stdout] test function_name::tests::test_function_name_plus2 ... ok
[INFO] [stdout] test printers::tests::test_de ... ok
[INFO] [stdout] test function_name::tests::more_tests::test_function_name_plus2 ... ok
[INFO] [stdout] test printers::tests::test_def1onxñ ... ok
[INFO] [stdout] test printers::tests::test_def2onxñ ... ok
[INFO] [stdout] test function_name::tests::more_tests::test_function_name_plus1 ... ok
[INFO] [stdout] test printers::tests::test_defonxñ ... ok
[INFO] [stdout] test printers::tests::test_dp ... ok
[INFO] [stdout] test printers::tests::test_dpf1onxñ ... ok
[INFO] [stdout] test printers::tests::test_deonxñ ... ok
[INFO] [stdout] test printers::tests::test_dpf2onxñ ... ok
[INFO] [stdout] test printers::tests::test_dpfonxñ ... ok
[INFO] [stdout] test printers::tests::test_dponxñ ... ok
[INFO] [stdout] test printers::tests::test_ef1onxñ ... ok
[INFO] [stdout] test printers::tests::test_e ... ok
[INFO] [stdout] test printers::tests::test_ef2onxñ ... ok
[INFO] [stdout] test printers::tests::test_efonxñ ... ok
[INFO] [stdout] test printers::tests::test_eonxñ ... ok
[INFO] [stdout] test printers::tests::test_p ... ok
[INFO] [stdout] test printers::tests::test_pf1onxñ ... ok
[INFO] [stdout] test printers::tests::test_pf2onxñ ... ok
[INFO] [stdout] test stack::tests::test_so ... ok
[INFO] [stdout] test printers::tests::test_pfonxñ ... ok
[INFO] [stdout] test function_name::tests::test_function_name_full ... ok
[INFO] [stdout] test stack::tests::test_sn ... ok
[INFO] [stdout] test stack::tests::test_stack_offset_a_b_c ... ok
[INFO] [stdout] test stack::tests::test_stack_offset_set_10 ... ok
[INFO] [stdout] test stack::tests::test_stack_offset_set_none ... ok
[INFO] [stdout] test stack::tests::test_stack_offset_set_none_999 ... ok
[INFO] [stdout] test stack::tests::test_sx ... ok
[INFO] [stdout] test stack::tests::test_sñ ... ok
[INFO] [stdout] test printers::tests::test_ponxñ ... ok
[INFO] [stdout] test stack::tests::test_stack_depth ... ok
[INFO] [stdout] test stack::tests::test_stack_offset_a_b ... ok
[INFO] [stdout] test stack::tests::test_stack_offset_set_multiple_threads ... ok
[INFO] [stdout] test printers::tests::test_multithreaded ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 41 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.13s
[INFO] [stdout] 
[INFO] [stderr]    Doc-tests si_trace_print
[INFO] [stdout] 
[INFO] [stdout] running 72 tests
[INFO] [stdout] test src/printers.rs - printers::def1o (line 2924) ... ok
[INFO] [stdout] test src/printers.rs - printers::def2x (line 3235) ... ok
[INFO] [stdout] test src/lib.rs - (line 156) ... ok
[INFO] [stdout] test src/printers.rs - printers::defn (line 2770) ... ok
[INFO] [stdout] test src/printers.rs - printers::def2ñ (line 3287) ... ok
[INFO] [stdout] test src/printers.rs - printers::defx (line 2819) ... ok
[INFO] [stdout] test src/printers.rs - printers::def1ñ (line 3078) ... ok
[INFO] [stdout] test src/lib.rs - (line 125) ... ok
[INFO] [stdout] test src/printers.rs - printers::defo (line 2720) ... ok
[INFO] [stdout] test src/lib.rs - (line 10) ... ok
[INFO] [stdout] test src/printers.rs - printers::deo (line 2519) ... ok
[INFO] [stdout] test src/printers.rs - printers::def2o (line 3133) ... ok
[INFO] [stdout] test src/printers.rs - printers::de (line 2475) ... ok
[INFO] [stdout] test src/printers.rs - printers::def1n (line 2975) ... ok
[INFO] [stdout] test src/printers.rs - printers::def1x (line 3026) ... ok
[INFO] [stdout] test src/printers.rs - printers::dex (line 2617) ... ok
[INFO] [stdout] test src/lib.rs - (line 46) ... ok
[INFO] [stdout] test src/printers.rs - printers::dpf1n (line 2110) ... ok
[INFO] [stdout] test src/printers.rs - printers::dpf1x (line 2161) ... ok
[INFO] [stdout] test src/printers.rs - printers::deñ (line 2667) ... ok
[INFO] [stdout] test src/printers.rs - printers::dpf1ñ (line 2213) ... ok
[INFO] [stdout] test src/printers.rs - printers::den (line 2568) ... ok
[INFO] [stdout] test src/printers.rs - printers::dpf2x (line 2370) ... ok
[INFO] [stdout] test src/printers.rs - printers::dp (line 1608) ... ok
[INFO] [stdout] test src/printers.rs - printers::defñ (line 2869) ... ok
[INFO] [stdout] test src/printers.rs - printers::def2n (line 3184) ... ok
[INFO] [stdout] test src/printers.rs - printers::dpf2n (line 2319) ... ok
[INFO] [stdout] test src/printers.rs - printers::dpf1o (line 2059) ... ok
[INFO] [stdout] test src/printers.rs - printers::dpf2ñ (line 2422) ... ok
[INFO] [stdout] test src/printers.rs - printers::dpfx (line 1954) ... ok
[INFO] [stdout] test src/printers.rs - printers::dpfn (line 1905) ... ok
[INFO] [stdout] test src/printers.rs - printers::dpo (line 1654) ... ok
[INFO] [stdout] test src/printers.rs - printers::dpf2o (line 2268) ... ok
[INFO] [stdout] test src/printers.rs - printers::ef1n (line 1287) ... ok
[INFO] [stdout] test src/printers.rs - printers::dpn (line 1703) ... ok
[INFO] [stdout] test src/printers.rs - printers::dpfñ (line 2004) ... ok
[INFO] [stdout] test src/printers.rs - printers::dpfo (line 1851) ... ok
[INFO] [stdout] test src/printers.rs - printers::ef2n (line 1472) ... ok
[INFO] [stdout] test src/printers.rs - printers::dpñ (line 1802) ... ok
[INFO] [stdout] test src/printers.rs - printers::ef1x (line 1332) ... ok
[INFO] [stdout] test src/printers.rs - printers::ef1ñ (line 1378) ... ok
[INFO] [stdout] test src/printers.rs - printers::ef1o (line 1242) ... ok
[INFO] [stdout] test src/printers.rs - printers::e (line 839) ... ok
[INFO] [stdout] test src/printers.rs - printers::ef2o (line 1427) ... ok
[INFO] [stdout] test src/printers.rs - printers::ef2ñ (line 1563) ... ok
[INFO] [stdout] test src/printers.rs - printers::ex (line 971) ... ok
[INFO] [stdout] test src/printers.rs - printers::dpx (line 1752) ... ok
[INFO] [stdout] test src/printers.rs - printers::efn (line 1106) ... ok
[INFO] [stdout] test src/printers.rs - printers::eo (line 881) ... ok
[INFO] [stdout] test src/printers.rs - printers::en (line 928) ... ok
[INFO] [stdout] test src/printers.rs - printers::ef2x (line 1517) ... ok
[INFO] [stdout] test src/printers.rs - printers::p (line 76) ... ok
[INFO] [stdout] test src/printers.rs - printers::pf2o (line 656) ... ok
[INFO] [stdout] test src/printers.rs - printers::efx (line 1149) ... ok
[INFO] [stdout] test src/printers.rs - printers::efo (line 1062) ... ok
[INFO] [stdout] test src/printers.rs - printers::pf1o (line 471) ... ok
[INFO] [stdout] test src/printers.rs - printers::efñ (line 1193) ... ok
[INFO] [stdout] test src/printers.rs - printers::pf1n (line 516) ... ok
[INFO] [stdout] test src/printers.rs - printers::eñ (line 1015) ... ok
[INFO] [stdout] test src/printers.rs - printers::pfn (line 335) ... ok
[INFO] [stdout] test src/printers.rs - printers::pf2n (line 701) ... ok
[INFO] [stdout] test src/printers.rs - printers::pf2ñ (line 792) ... ok
[INFO] [stdout] test src/printers.rs - printers::pf1x (line 561) ... ok
[INFO] [stdout] test src/printers.rs - printers::pf2x (line 746) ... ok
[INFO] [stdout] test src/printers.rs - printers::pf1ñ (line 607) ... ok
[INFO] [stdout] test src/printers.rs - printers::pfo (line 291) ... ok
[INFO] [stdout] test src/printers.rs - printers::pfñ (line 422) ... ok
[INFO] [stdout] test src/printers.rs - printers::pfx (line 378) ... ok
[INFO] [stdout] test src/printers.rs - printers::pn (line 161) ... ok
[INFO] [stdout] test src/printers.rs - printers::pñ (line 248) ... ok
[INFO] [stdout] test src/printers.rs - printers::px (line 204) ... ok
[INFO] [stdout] test src/printers.rs - printers::po (line 118) ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 72 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 4.63s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "494c606496fc9436146419425e098d90d51c9275e054cb4f58692bbd3c3095e3", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "494c606496fc9436146419425e098d90d51c9275e054cb4f58692bbd3c3095e3", kill_on_drop: false }`
[INFO] [stdout] 494c606496fc9436146419425e098d90d51c9275e054cb4f58692bbd3c3095e3