[INFO] updating cached repository https://github.com/scampi/falcon
[INFO] running `"git" "-c" "credential.helper=" "-c" "credential.helper=/big/crater/work/cargo-home/bin/git-credential-null" "-c" "remote.origin.fetch=refs/heads/*:refs/heads/*" "fetch" "origin" "--force" "--prune"`
[INFO] running `"git" "rev-parse" "HEAD"`
[INFO] [stdout] a0cfc078d782d89ef5523957b8cc4a12e11ef9bf
[INFO] testing scampi/falcon against 1.38.0 for beta-1.39-1
[INFO] running `"git" "clone" "work/cache/git-repos/https%3A%2F%2Fgithub.com%2Fscampi%2Ffalcon" "work/builds/worker-6/source"`
[INFO] [stderr] Cloning into 'work/builds/worker-6/source'...
[INFO] [stderr] done.
[INFO] validating manifest of git repo https://github.com/scampi/falcon on toolchain 1.38.0
[INFO] running `"/big/crater/work/cargo-home/bin/cargo" "+1.38.0" "read-manifest" "--manifest-path" "Cargo.toml"`
[INFO] started tweaking git repo https://github.com/scampi/falcon
[INFO] finished tweaking git repo https://github.com/scampi/falcon
[INFO] tweaked toml for git repo https://github.com/scampi/falcon written to work/builds/worker-6/source/Cargo.toml
[INFO] crate git repo https://github.com/scampi/falcon already has a lockfile, it will not be regenerated
[INFO] running `"/big/crater/work/cargo-home/bin/cargo" "+1.38.0" "fetch" "--locked" "--manifest-path" "Cargo.toml"`
[INFO] running `"docker" "create" "-v" "/big/crater/work/builds/worker-6/target:/opt/rustwide/target:rw,Z" "-v" "/big/crater/work/builds/worker-6/source:/opt/rustwide/workdir:ro,Z" "-v" "/big/crater/work/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/big/crater/work/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "MAP_USER_ID=1000" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--network" "none" "rustops/crates-build-env" "/opt/rustwide/cargo-home/bin/cargo" "+1.38.0" "build" "--frozen"`
[INFO] [stdout] b3b0f6f07ae0637a8c5d7e7bd2d838bec075d47b754310ca3fa4b57b71ebc864
[INFO] running `"docker" "start" "-a" "b3b0f6f07ae0637a8c5d7e7bd2d838bec075d47b754310ca3fa4b57b71ebc864"`
[INFO] [stderr]    Compiling byteorder v1.2.7
[INFO] [stderr]    Compiling exitcode v1.1.2
[INFO] [stderr]    Compiling getrandom v0.1.9
[INFO] [stderr]    Compiling atty v0.2.11
[INFO] [stderr]    Compiling backtrace-sys v0.1.28
[INFO] [stderr]    Compiling syn v1.0.5
[INFO] [stderr]    Compiling backtrace v0.3.13
[INFO] [stderr]    Compiling clap v2.33.0
[INFO] [stderr]    Compiling rand_core v0.5.0
[INFO] [stderr]    Compiling combine v3.8.1
[INFO] [stderr]    Compiling failure v0.1.5
[INFO] [stderr]    Compiling rand_chacha v0.2.1
[INFO] [stderr]    Compiling rand v0.7.0
[INFO] [stderr]    Compiling proc-macro-error v0.2.6
[INFO] [stderr]    Compiling structopt-derive v0.3.1
[INFO] [stderr]    Compiling structopt v0.3.1
[INFO] [stderr]    Compiling falcon v0.1.0 (/opt/rustwide/workdir)
[INFO] [stderr] warning: unused import: `Parser`
[INFO] [stderr]   --> src/parser/program.rs:18:9
[INFO] [stderr]    |
[INFO] [stderr] 18 |         Parser,
[INFO] [stderr]    |         ^^^^^^
[INFO] [stderr]    |
[INFO] [stderr]    = note: `#[warn(unused_imports)]` on by default
[INFO] [stderr] 
[INFO] [stderr] warning: unused import: `Parser`
[INFO] [stderr]   --> src/parser/stmt.rs:17:9
[INFO] [stderr]    |
[INFO] [stderr] 17 |         Parser,
[INFO] [stderr]    |         ^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: variant is never constructed: `Exit`
[INFO] [stderr]   --> src/interpreter/stmt.rs:17:5
[INFO] [stderr]    |
[INFO] [stderr] 17 |     Exit(isize),
[INFO] [stderr]    |     ^^^^^^^^^^^
[INFO] [stderr]    |
[INFO] [stderr]    = note: `#[warn(dead_code)]` on by default
[INFO] [stderr] 
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 34.95s
[INFO] running `"docker" "inspect" "b3b0f6f07ae0637a8c5d7e7bd2d838bec075d47b754310ca3fa4b57b71ebc864"`
[INFO] running `"docker" "rm" "-f" "b3b0f6f07ae0637a8c5d7e7bd2d838bec075d47b754310ca3fa4b57b71ebc864"`
[INFO] [stdout] b3b0f6f07ae0637a8c5d7e7bd2d838bec075d47b754310ca3fa4b57b71ebc864
[INFO] running `"docker" "create" "-v" "/big/crater/work/builds/worker-6/target:/opt/rustwide/target:rw,Z" "-v" "/big/crater/work/builds/worker-6/source:/opt/rustwide/workdir:ro,Z" "-v" "/big/crater/work/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/big/crater/work/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "MAP_USER_ID=1000" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--network" "none" "rustops/crates-build-env" "/opt/rustwide/cargo-home/bin/cargo" "+1.38.0" "test" "--frozen" "--no-run"`
[INFO] [stdout] 800216fd4271154e28ff51a63841c539a7eaa9931cfdce51f28949c6610e7218
[INFO] running `"docker" "start" "-a" "800216fd4271154e28ff51a63841c539a7eaa9931cfdce51f28949c6610e7218"`
[INFO] [stderr]    Compiling escargot v0.4.0
[INFO] [stderr]    Compiling predicates v1.0.1
[INFO] [stderr]    Compiling log v0.4.8
[INFO] [stderr]    Compiling serde_derive v1.0.98
[INFO] [stderr]    Compiling tempfile v3.1.0
[INFO] [stderr]    Compiling serde v1.0.98
[INFO] [stderr]    Compiling serde_json v1.0.40
[INFO] [stderr]    Compiling assert_cmd v0.11.1
[INFO] [stderr]    Compiling falcon v0.1.0 (/opt/rustwide/workdir)
[INFO] [stderr] warning: method is never used: `stderr`
[INFO] [stderr]   --> tests/common.rs:38:5
[INFO] [stderr]    |
[INFO] [stderr] 38 |     pub fn stderr(mut self, stderr: &'a str) -> Self {
[INFO] [stderr]    |     ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
[INFO] [stderr]    |
[INFO] [stderr]    = note: `#[warn(dead_code)]` on by default
[INFO] [stderr] 
[INFO] [stderr] warning: method is never used: `should_fail`
[INFO] [stderr]   --> tests/common.rs:43:5
[INFO] [stderr]    |
[INFO] [stderr] 43 |     pub fn should_fail(mut self) -> Self {
[INFO] [stderr]    |     ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
[INFO] [stderr] 
[INFO] [stderr] warning: variant is never constructed: `Exit`
[INFO] [stderr]   --> src/interpreter/stmt.rs:17:5
[INFO] [stderr]    |
[INFO] [stderr] 17 |     Exit(isize),
[INFO] [stderr]    |     ^^^^^^^^^^^
[INFO] [stderr]    |
[INFO] [stderr]    = note: `#[warn(dead_code)]` on by default
[INFO] [stderr] 
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 1m 04s
[INFO] running `"docker" "inspect" "800216fd4271154e28ff51a63841c539a7eaa9931cfdce51f28949c6610e7218"`
[INFO] running `"docker" "rm" "-f" "800216fd4271154e28ff51a63841c539a7eaa9931cfdce51f28949c6610e7218"`
[INFO] [stdout] 800216fd4271154e28ff51a63841c539a7eaa9931cfdce51f28949c6610e7218
[INFO] running `"docker" "create" "-v" "/big/crater/work/builds/worker-6/target:/opt/rustwide/target:rw,Z" "-v" "/big/crater/work/builds/worker-6/source:/opt/rustwide/workdir:ro,Z" "-v" "/big/crater/work/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/big/crater/work/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "MAP_USER_ID=1000" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--network" "none" "rustops/crates-build-env" "/opt/rustwide/cargo-home/bin/cargo" "+1.38.0" "test" "--frozen"`
[INFO] [stdout] 392d9d45208a512d4f0e59749991110e5aec8879449e10ef93f66879a08510b4
[INFO] running `"docker" "start" "-a" "392d9d45208a512d4f0e59749991110e5aec8879449e10ef93f66879a08510b4"`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 1.09s
[INFO] [stderr]      Running /opt/rustwide/target/debug/deps/falcon-346015ec9bb8db9e
[INFO] [stdout] 
[INFO] [stdout] running 97 tests
[INFO] [stdout] test interpreter::expr::tests::concat ... ok
[INFO] [stdout] test interpreter::expr::tests::preincrement ... ok
[INFO] [stdout] test interpreter::expr::tests::predecrement ... ok
[INFO] [stdout] test interpreter::expr::tests::assignment_brackets_lvalue ... ok
[INFO] [stdout] test interpreter::expr::tests::postdecrement ... ok
[INFO] [stdout] test interpreter::expr::tests::record_count ... ok
[INFO] [stdout] test interpreter::expr::tests::comparison ... ok
[INFO] [stdout] test interpreter::stmt::formatting::tests::conversions ... ok
[INFO] [stdout] test interpreter::functions::builtins::substr::tests::simple ... ok
[INFO] [stdout] test interpreter::stmt::formatting::tests::exponent_conversion ... ok
[INFO] [stdout] test interpreter::stmt::formatting::tests::exponent_or_float_conversion ... ok
[INFO] [stdout] test interpreter::stmt::formatting::tests::string_conversion ... ok
[INFO] [stdout] test interpreter::expr::tests::match ... ok
[INFO] [stdout] test interpreter::stmt::formatting::tests::float_conversion ... ok
[INFO] [stdout] test interpreter::expr::tests::arithmetic ... ok
[INFO] [stdout] test interpreter::expr::tests::logical_operation ... ok
[INFO] [stdout] test interpreter::stmt::formatting::tests::signed_decimal_conversion ... ok
[INFO] [stdout] test interpreter::expr::tests::scalar_array_misuse ... ok
[INFO] [stdout] test interpreter::expr::tests::regexp ... ok
[INFO] [stdout] test interpreter::expr::tests::conditional ... ok
[INFO] [stdout] test interpreter::expr::tests::postincrement ... ok
[INFO] [stdout] test interpreter::expr::tests::var_lvalue ... ok
[INFO] [stdout] test interpreter::expr::tests::assignment_dollar_lvalue ... ok
[INFO] [stdout] test interpreter::expr::tests::array_lvalue ... ok
[INFO] [stdout] test interpreter::tests::assign_array ... ok
[INFO] [stdout] test interpreter::expr::tests::assignment_name_lvalue ... ok
[INFO] [stdout] test interpreter::stmt::tests::block ... ok
[INFO] [stdout] test interpreter::stmt::tests::print ... ok
[INFO] [stdout] test interpreter::stmt::tests::for ... ok
[INFO] [stdout] test interpreter::stmt::tests::if_else ... ok
[INFO] [stdout] test interpreter::expr::tests::field_lvalue ... ok
[INFO] [stdout] test interpreter::stmt::tests::while ... ok
[INFO] [stdout] test interpreter::stmt::tests::delete ... ok
[INFO] [stdout] test interpreter::stmt::tests::break ... ok
[INFO] [stdout] test interpreter::stmt::tests::for_in ... ok
[INFO] [stdout] test interpreter::tests::multiple_whitespaces ... ok
[INFO] [stdout] test interpreter::tests::expr_pattern ... ok
[INFO] [stdout] test interpreter::tests::function_calls_array_references ... ok
[INFO] [stdout] test interpreter::stmt::tests::delete_subsep ... ok
[INFO] [stdout] test parser::expr::tests::concat ... ok
[INFO] [stdout] test interpreter::tests::function_calls_array_references_delete ... ok
[INFO] [stdout] test interpreter::tests::use_scalar_with_for_in ... ok
[INFO] [stdout] test parser::expr::tests::div ... ok
[INFO] [stdout] test interpreter::tests::function_calls_array_keys ... ok
[INFO] [stdout] test parser::expr::tests::addition ... ok
[INFO] [stdout] test interpreter::tests::function_calls_local_array ... ok
[INFO] [stdout] test parser::expr::tests::comparison ... ok
[INFO] [stdout] test parser::expr::tests::assignment ... ok
[INFO] [stdout] test interpreter::tests::range_pattern ... ok
[INFO] [stdout] test interpreter::stmt::tests::continue ... ok
[INFO] [stdout] test parser::expr::tests::in_array ... ok
[INFO] [stdout] test parser::expr::tests::mix_add_sub ... ok
[INFO] [stdout] test parser::expr::tests::mix_div_pow ... ok
[INFO] [stdout] test parser::expr::tests::mul ... ok
[INFO] [stdout] test parser::expr::tests::modulo ... ok
[INFO] [stdout] test parser::expr::tests::grouping ... ok
[INFO] [stdout] test parser::expr::tests::match ... ok
[INFO] [stdout] test parser::expr::tests::conditional ... ok
[INFO] [stdout] test parser::expr::tests::function_call ... ok
[INFO] [stdout] test parser::expr::tests::post_increment_decrement ... ok
[INFO] [stdout] test parser::expr::tests::mix_div_mul ... ok
[INFO] [stdout] test parser::expr::tests::mix_mul_pow ... ok
[INFO] [stdout] test parser::expr::tests::non_match ... ok
[INFO] [stdout] test parser::expr::tests::pre_increment_decrement ... ok
[INFO] [stdout] test parser::expr::tests::string ... ok
[INFO] [stdout] test parser::expr::tests::logical_operators ... ok
[INFO] [stdout] test parser::expr::tests::syntax_error ... ok
[INFO] [stdout] test parser::expr::tests::substraction ... ok
[INFO] [stdout] test parser::expr::tests::leaves ... ok
[INFO] [stdout] test parser::expr::tests::unary_plus ... ok
[INFO] [stdout] test parser::expr::tests::pow ... ok
[INFO] [stdout] test interpreter::tests::invalid_function_call ... ok
[INFO] [stdout] test parser::program::tests::function_def ... ok
[INFO] [stdout] test interpreter::tests::custom_fs_value ... ok
[INFO] [stdout] test parser::stmt::tests::for_in ... ok
[INFO] [stdout] test parser::stmt::tests::delete ... ok
[INFO] [stdout] test parser::expr::tests::regexp ... ok
[INFO] [stdout] test interpreter::tests::special_patterns ... ok
[INFO] [stdout] test parser::util::tests::not_valid_name ... ok
[INFO] [stdout] test parser::expr::tests::lvalue ... ok
[INFO] [stdout] test parser::util::tests::regexp ... ok
[INFO] [stdout] test parser::util::tests::string ... ok
[INFO] [stdout] test parser::util::tests::valid_name ... ok
[INFO] [stdout] test parser::expr::tests::unary_minus ... ok
[INFO] [stdout] test parser::program::tests::pattern_action ... ok
[INFO] [stdout] test parser::program::tests::program ... ok
[INFO] [stdout] test parser::stmt::tests::while ... ok
[INFO] [stdout] test parser::util::tests::comment ... ok
[INFO] [stdout] test parser::util::tests::space ... ok
[INFO] [stdout] test parser::stmt::tests::exit_return ... ok
[INFO] [stdout] test interpreter::tests::custom_functions_arrays ... ok
[INFO] [stdout] test parser::stmt::tests::for ... ok
[INFO] [stdout] test parser::stmt::tests::block ... ok
[INFO] [stdout] test parser::stmt::tests::if_else ... ok
[INFO] [stdout] test parser::stmt::tests::do_while ... ok
[INFO] [stdout] test parser::stmt::tests::print_stmt ... ok
[INFO] [stdout] test interpreter::tests::custom_functions_scalar ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 97 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
[INFO] [stdout] 
[INFO] [stderr]      Running /opt/rustwide/target/debug/deps/builtin-f127bef663d73caa
[INFO] [stdout] 
[INFO] [stdout] running 10 tests
[INFO] [stdout] test toupper_tolower ... ok
[INFO] [stdout] test printf_arg_list_not_evaluated ... ok
[INFO] [stdout] test substr_arg_list_not_evaluated ... ok
[INFO] [stdout] test length_too_many_args ... ok
[INFO] [stdout] test index_substr ... ok
[INFO] [stdout] test sin_cos ... ok
[INFO] [stdout] test sub_arg_list_not_evaluated ... ok
[INFO] [stdout] test rand ... ok
[INFO] [stdout] test sub ... ok
[INFO] [stdout] test split ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 10 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
[INFO] [stdout] 
[INFO] [stderr]      Running /opt/rustwide/target/debug/deps/common-0a7bec45612a4fa1
[INFO] [stdout] 
[INFO] [stdout] running 0 tests
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
[INFO] [stdout] 
[INFO] [stderr]      Running /opt/rustwide/target/debug/deps/print-c7f689c959b1d894
[INFO] [stdout] 
[INFO] [stdout] running 3 tests
[INFO] [stdout] test append_redirection ... ok
[INFO] [stdout] test truncate_redirection ... ok
[INFO] [stdout] test escaped_characters ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 3 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
[INFO] [stdout] 
[INFO] running `"docker" "inspect" "392d9d45208a512d4f0e59749991110e5aec8879449e10ef93f66879a08510b4"`
[INFO] running `"docker" "rm" "-f" "392d9d45208a512d4f0e59749991110e5aec8879449e10ef93f66879a08510b4"`
[INFO] [stdout] 392d9d45208a512d4f0e59749991110e5aec8879449e10ef93f66879a08510b4