[INFO] crate gcode 0.5.0 is already in cache
[INFO] testing gcode-0.5.0 against 1.38.0 for beta-1.39-1
[INFO] extracting crate gcode 0.5.0 into work/builds/worker-5/source
[INFO] validating manifest of crates.io crate gcode 0.5.0 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 crates.io crate gcode 0.5.0
[INFO] finished tweaking crates.io crate gcode 0.5.0
[INFO] tweaked toml for crates.io crate gcode 0.5.0 written to work/builds/worker-5/source/Cargo.toml
[INFO] running `"/big/crater/work/cargo-home/bin/cargo" "+1.38.0" "generate-lockfile" "--manifest-path" "Cargo.toml" "-Zno-index-update"`
[INFO] running `"/big/crater/work/cargo-home/bin/cargo" "+1.38.0" "fetch" "--locked" "--manifest-path" "Cargo.toml"`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] running `"docker" "create" "-v" "/big/crater/work/builds/worker-5/target:/opt/rustwide/target:rw,Z" "-v" "/big/crater/work/builds/worker-5/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] 951af98f9c2ab10d8ba5adb44f38886b11543b067ea77a1d8f38778fbcdb4618
[INFO] running `"docker" "start" "-a" "951af98f9c2ab10d8ba5adb44f38886b11543b067ea77a1d8f38778fbcdb4618"`
[INFO] [stderr]    Compiling gcode v0.5.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.51s
[INFO] running `"docker" "inspect" "951af98f9c2ab10d8ba5adb44f38886b11543b067ea77a1d8f38778fbcdb4618"`
[INFO] running `"docker" "rm" "-f" "951af98f9c2ab10d8ba5adb44f38886b11543b067ea77a1d8f38778fbcdb4618"`
[INFO] [stdout] 951af98f9c2ab10d8ba5adb44f38886b11543b067ea77a1d8f38778fbcdb4618
[INFO] running `"docker" "create" "-v" "/big/crater/work/builds/worker-5/target:/opt/rustwide/target:rw,Z" "-v" "/big/crater/work/builds/worker-5/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] c6f6f3f836b6feb546473bb37b08c1dc596a94fa761a58a6fb8b421b9baf58fc
[INFO] running `"docker" "start" "-a" "c6f6f3f836b6feb546473bb37b08c1dc596a94fa761a58a6fb8b421b9baf58fc"`
[INFO] [stderr]    Compiling gcode v0.5.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 1.18s
[INFO] running `"docker" "inspect" "c6f6f3f836b6feb546473bb37b08c1dc596a94fa761a58a6fb8b421b9baf58fc"`
[INFO] running `"docker" "rm" "-f" "c6f6f3f836b6feb546473bb37b08c1dc596a94fa761a58a6fb8b421b9baf58fc"`
[INFO] [stdout] c6f6f3f836b6feb546473bb37b08c1dc596a94fa761a58a6fb8b421b9baf58fc
[INFO] running `"docker" "create" "-v" "/big/crater/work/builds/worker-5/target:/opt/rustwide/target:rw,Z" "-v" "/big/crater/work/builds/worker-5/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] 54f1f5143aee14e2382138b9cb1e7844472214b020919f9fdf7874509d281b18
[INFO] running `"docker" "start" "-a" "54f1f5143aee14e2382138b9cb1e7844472214b020919f9fdf7874509d281b18"`
[INFO] [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.01s
[INFO] [stderr]      Running /opt/rustwide/target/debug/deps/gcode-811539c0077d97dc
[INFO] [stdout] 
[INFO] [stdout] running 21 tests
[INFO] [stdout] test gcode::tests::correct_major_number ... ok
[INFO] [stdout] test gcode::tests::correct_minor_number ... ok
[INFO] [stdout] test gcode::tests::get_argument_values ... ok
[INFO] [stdout] test lexer::tests::negative_number ... ok
[INFO] [stdout] test lexer::tests::normal_number ... ok
[INFO] [stdout] test lexer::tests::skip_whitespace ... ok
[INFO] [stdout] test lexer::tests::take_while_works_as_expected ... ok
[INFO] [stdout] test lexer::tests::tokenize_a_letter ... ok
[INFO] [stdout] test lexer::tests::tokenize_a_parens_comment ... ok
[INFO] [stdout] test lexer::tests::tokenize_a_semicolon_comment ... ok
[INFO] [stdout] test lexer::tests::unclosed_parens_are_garbage ... ok
[INFO] [stdout] test lines::tests::line_numbers ... ok
[INFO] [stdout] test lines::tests::line_numbers_after_the_start_are_an_error ... ok
[INFO] [stdout] test lines::tests::parse_command_with_arguments ... ok
[INFO] [stdout] test lines::tests::multiple_commands_on_the_same_line ... ok
[INFO] [stdout] test lines::tests::parse_g90 ... ok
[INFO] [stdout] test lines::tests::we_can_parse_a_comment ... ok
[INFO] [stdout] test words::tests::numbers_are_garbage_if_they_dont_have_a_letter_in_front ... ok
[INFO] [stdout] test words::tests::pass_comments_through ... ok
[INFO] [stdout] test words::tests::recognise_a_valid_word ... ok
[INFO] [stdout] test words::tests::pass_garbage_through ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 21 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
[INFO] [stdout] 
[INFO] [stderr]      Running /opt/rustwide/target/debug/deps/smoke_test-1b84d247bd4d21b0
[INFO] [stdout] 
[INFO] [stdout] running 6 tests
[INFO] [stdout] test expected_program_2_output ... ignored
[INFO] [stdout] test program_1 ... ok
[INFO] [stdout] test program_2 ... ok
[INFO] [stdout] test program_3 ... ok
[INFO] [stdout] test pi_octcat ... ok
[INFO] [stdout] test pi_rustlogo ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 5 passed; 0 failed; 1 ignored; 0 measured; 0 filtered out
[INFO] [stdout] 
[INFO] [stderr]    Doc-tests gcode
[INFO] [stdout] 
[INFO] [stdout] running 1 test
[INFO] [stdout] test src/gcode.rs - gcode::GCode::value_for (line 108) ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
[INFO] [stdout] 
[INFO] running `"docker" "inspect" "54f1f5143aee14e2382138b9cb1e7844472214b020919f9fdf7874509d281b18"`
[INFO] running `"docker" "rm" "-f" "54f1f5143aee14e2382138b9cb1e7844472214b020919f9fdf7874509d281b18"`
[INFO] [stdout] 54f1f5143aee14e2382138b9cb1e7844472214b020919f9fdf7874509d281b18