Nov 16 17:53:36.220 INFO testing npj/rust-scheme against try#2e026d6e5d7621634147ad4c8074f1d964dbb1be for pr-55982
Nov 16 17:53:36.220 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-4/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-4/pr-55982/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/source:ro,Z" "-v" "/mnt/big/crater/work/local/cargo-home:/cargo-home:ro,Z" "-v" "/mnt/big/crater/work/local/rustup-home:/rustup-home:ro,Z" "-e" "USER_ID=1000" "-e" "SOURCE_DIR=/source" "-e" "USER_ID=1000" "-e" "CMD=cargo +2e026d6e5d7621634147ad4c8074f1d964dbb1be-alt build --frozen" "-e" "CARGO_TARGET_DIR=/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/cargo-home" "-e" "RUSTUP_HOME=/rustup-home" "-m" "1536M" "--network" "none" "crater"`
Nov 16 17:53:36.781 INFO [stdout] f56503475a3ed64f2fab3c13fd74841d40897548d6c299ffd79f348343e53a66
Nov 16 17:53:36.784 INFO running `"docker" "start" "-a" "f56503475a3ed64f2fab3c13fd74841d40897548d6c299ffd79f348343e53a66"`
Nov 16 17:53:38.631 INFO [stderr] usermod: no changes
Nov 16 17:53:38.719 INFO [stderr]    Compiling scheme v0.1.0 (/source)
Nov 16 17:53:40.426 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 1.77s
Nov 16 17:53:40.433 INFO [stderr] su: No module specific data is present
Nov 16 17:53:41.780 INFO running `"docker" "inspect" "f56503475a3ed64f2fab3c13fd74841d40897548d6c299ffd79f348343e53a66"`
Nov 16 17:53:42.162 INFO running `"docker" "rm" "-f" "f56503475a3ed64f2fab3c13fd74841d40897548d6c299ffd79f348343e53a66"`
Nov 16 17:53:42.468 INFO [stdout] f56503475a3ed64f2fab3c13fd74841d40897548d6c299ffd79f348343e53a66
Nov 16 17:53:42.474 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-4/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-4/pr-55982/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/source:ro,Z" "-v" "/mnt/big/crater/work/local/cargo-home:/cargo-home:ro,Z" "-v" "/mnt/big/crater/work/local/rustup-home:/rustup-home:ro,Z" "-e" "USER_ID=1000" "-e" "SOURCE_DIR=/source" "-e" "USER_ID=1000" "-e" "CMD=cargo +2e026d6e5d7621634147ad4c8074f1d964dbb1be-alt test --frozen --no-run" "-e" "CARGO_TARGET_DIR=/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/cargo-home" "-e" "RUSTUP_HOME=/rustup-home" "-m" "1536M" "--network" "none" "crater"`
Nov 16 17:53:42.939 INFO [stdout] 2236a9815de2ef3c6223805d15de8cec87b4bc0ba8fddb1ea935d9a5976e8de9
Nov 16 17:53:42.942 INFO running `"docker" "start" "-a" "2236a9815de2ef3c6223805d15de8cec87b4bc0ba8fddb1ea935d9a5976e8de9"`
Nov 16 17:53:44.304 INFO [stderr] usermod: no changes
Nov 16 17:53:44.383 INFO [stderr]    Compiling scheme v0.1.0 (/source)
Nov 16 17:53:47.423 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 3.10s
Nov 16 17:53:47.426 INFO [stderr] su: No module specific data is present
Nov 16 17:53:48.459 INFO running `"docker" "inspect" "2236a9815de2ef3c6223805d15de8cec87b4bc0ba8fddb1ea935d9a5976e8de9"`
Nov 16 17:53:48.707 INFO running `"docker" "rm" "-f" "2236a9815de2ef3c6223805d15de8cec87b4bc0ba8fddb1ea935d9a5976e8de9"`
Nov 16 17:53:48.995 INFO [stdout] 2236a9815de2ef3c6223805d15de8cec87b4bc0ba8fddb1ea935d9a5976e8de9
Nov 16 17:53:49.001 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-4/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-4/pr-55982/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/source:ro,Z" "-v" "/mnt/big/crater/work/local/cargo-home:/cargo-home:ro,Z" "-v" "/mnt/big/crater/work/local/rustup-home:/rustup-home:ro,Z" "-e" "USER_ID=1000" "-e" "SOURCE_DIR=/source" "-e" "USER_ID=1000" "-e" "CMD=cargo +2e026d6e5d7621634147ad4c8074f1d964dbb1be-alt test --frozen" "-e" "CARGO_TARGET_DIR=/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/cargo-home" "-e" "RUSTUP_HOME=/rustup-home" "-m" "1536M" "--network" "none" "crater"`
Nov 16 17:53:49.519 INFO [stdout] bbb49eddbf0cdbe0f3bcc8077a410de8a9a4ce3e51d66c2ac7b9b66dd2328261
Nov 16 17:53:49.525 INFO running `"docker" "start" "-a" "bbb49eddbf0cdbe0f3bcc8077a410de8a9a4ce3e51d66c2ac7b9b66dd2328261"`
Nov 16 17:53:51.032 INFO [stderr] usermod: no changes
Nov 16 17:53:51.079 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.02s
Nov 16 17:53:51.080 INFO [stderr]      Running /target/debug/deps/scheme-16245641b0c9408b
Nov 16 17:53:51.083 INFO [stdout] 
Nov 16 17:53:51.083 INFO [stdout] running 38 tests
Nov 16 17:53:51.084 INFO [stdout] test lexer::io_lexer::tests::chr ... ok
Nov 16 17:53:51.084 INFO [stdout] test lexer::io_lexer::tests::get ... ok
Nov 16 17:53:51.084 INFO [stdout] test lexer::io_lexer::tests::line ... ok
Nov 16 17:53:51.084 INFO [stdout] test lexer::lexer::tests::error_end_nonempty ... ok
Nov 16 17:53:51.084 INFO [stdout] test lexer::lexer::tests::error_ident ... ok
Nov 16 17:53:51.084 INFO [stdout] test lexer::lexer::tests::error_end_empty ... ok
Nov 16 17:53:51.084 INFO [stdout] test lexer::io_lexer::tests::set_line ... ok
Nov 16 17:53:51.084 INFO [stdout] test lexer::io_lexer::tests::set_chr ... ok
Nov 16 17:53:51.084 INFO [stdout] test lexer::io_lexer::tests::peek ... ok
Nov 16 17:53:51.084 INFO [stdout] test lexer::lexer::tests::error_invalid ... ok
Nov 16 17:53:51.084 INFO [stdout] test lexer::lexer::tests::error_unterminated ... ok
Nov 16 17:53:51.084 INFO [stdout] test lexer::io_lexer::tests::new ... ok
Nov 16 17:53:51.087 INFO [stdout] test lexer::lexer::tests::error_unterminated_multiline ... ok
Nov 16 17:53:51.087 INFO [stdout] test lexer::lexer::tests::read_all ... ok
Nov 16 17:53:51.087 INFO [stdout] test lexer::lexer::tests::read_comment ... ok
Nov 16 17:53:51.087 INFO [stdout] test lexer::lexer::tests::read_float_digits_dot_digits ... ok
Nov 16 17:53:51.087 INFO [stdout] test lexer::lexer::tests::read_ident ... ok
Nov 16 17:53:51.087 INFO [stdout] test lexer::lexer::tests::read_float_dot ... ok
Nov 16 17:53:51.087 INFO [stdout] test lexer::lexer::tests::read_integer ... ok
Nov 16 17:53:51.087 INFO [stdout] test lexer::lexer::tests::read_float_dot_digits ... ok
Nov 16 17:53:51.087 INFO [stdout] test lexer::lexer::tests::read_float_dot_digits_trailing_zero ... ok
Nov 16 17:53:51.087 INFO [stdout] test lexer::lexer::tests::read_invalid_float_fractional ... ok
Nov 16 17:53:51.087 INFO [stdout] test lexer::lexer::tests::read_float_dot_zero ... ok
Nov 16 17:53:51.087 INFO [stdout] test lexer::lexer::tests::read_float_negative_dot_digits ... ok
Nov 16 17:53:51.087 INFO [stdout] test lexer::lexer::tests::read_invalid_float_whole ... ok
Nov 16 17:53:51.087 INFO [stdout] test lexer::lexer::tests::read_invalid_integer ... ok
Nov 16 17:53:51.087 INFO [stdout] test lexer::lexer::tests::read_lpar ... ok
Nov 16 17:53:51.087 INFO [stdout] test lexer::lexer::tests::read_negative_float_dot_digits ... ok
Nov 16 17:53:51.087 INFO [stdout] test lexer::lexer::tests::read_negative_integer ... ok
Nov 16 17:53:51.087 INFO [stdout] test lexer::lexer::tests::read_rpar ... ok
Nov 16 17:53:51.087 INFO [stdout] test lexer::lexer::tests::read_string ... ok
Nov 16 17:53:51.087 INFO [stdout] test lexer::string_lexer::tests::chr ... ok
Nov 16 17:53:51.087 INFO [stdout] test lexer::string_lexer::tests::get ... ok
Nov 16 17:53:51.087 INFO [stdout] test lexer::string_lexer::tests::line ... ok
Nov 16 17:53:51.087 INFO [stdout] test lexer::string_lexer::tests::new ... ok
Nov 16 17:53:51.087 INFO [stdout] test lexer::string_lexer::tests::peek ... ok
Nov 16 17:53:51.087 INFO [stdout] test lexer::string_lexer::tests::set_chr ... ok
Nov 16 17:53:51.087 INFO [stdout] test lexer::string_lexer::tests::set_line ... ok
Nov 16 17:53:51.087 INFO [stdout] 
Nov 16 17:53:51.087 INFO [stdout] test result: ok. 38 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 16 17:53:51.087 INFO [stdout] 
Nov 16 17:53:51.093 INFO [stdout] 
Nov 16 17:53:51.093 INFO [stdout] running 0 tests
Nov 16 17:53:51.093 INFO [stdout] 
Nov 16 17:53:51.093 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 16 17:53:51.093 INFO [stdout] 
Nov 16 17:53:51.093 INFO [stdout] 
Nov 16 17:53:51.093 INFO [stdout] running 0 tests
Nov 16 17:53:51.093 INFO [stdout] 
Nov 16 17:53:51.093 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 16 17:53:51.093 INFO [stdout] 
Nov 16 17:53:51.093 INFO [stderr]      Running /target/debug/deps/scheme-83dca9a912cca078
Nov 16 17:53:51.093 INFO [stderr]      Running /target/debug/deps/lexer-46dbc2d71cccaa8b
Nov 16 17:53:51.095 INFO [stderr]    Doc-tests scheme
Nov 16 17:53:51.578 INFO [stdout] 
Nov 16 17:53:51.578 INFO [stdout] running 0 tests
Nov 16 17:53:51.578 INFO [stdout] 
Nov 16 17:53:51.578 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 16 17:53:51.578 INFO [stdout] 
Nov 16 17:53:51.583 INFO [stderr] su: No module specific data is present
Nov 16 17:53:52.407 INFO running `"docker" "inspect" "bbb49eddbf0cdbe0f3bcc8077a410de8a9a4ce3e51d66c2ac7b9b66dd2328261"`
Nov 16 17:53:52.675 INFO running `"docker" "rm" "-f" "bbb49eddbf0cdbe0f3bcc8077a410de8a9a4ce3e51d66c2ac7b9b66dd2328261"`
Nov 16 17:53:53.049 INFO [stdout] bbb49eddbf0cdbe0f3bcc8077a410de8a9a4ce3e51d66c2ac7b9b66dd2328261