Nov 16 21:41:40.800 INFO testing kyren/luster against try#2e026d6e5d7621634147ad4c8074f1d964dbb1be for pr-55982
Nov 16 21:41:40.801 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-5/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-5/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 21:41:41.209 INFO [stdout] 35dd81ae87b14e4be157f82009814daf618e718a53976f6e94fb6165721ed7b3
Nov 16 21:41:41.211 INFO running `"docker" "start" "-a" "35dd81ae87b14e4be157f82009814daf618e718a53976f6e94fb6165721ed7b3"`
Nov 16 21:41:42.295 INFO [stderr] usermod: no changes
Nov 16 21:41:42.443 INFO [stderr]    Compiling syn v0.13.11
Nov 16 21:41:42.444 INFO [stderr]    Compiling failure v0.1.1
Nov 16 21:41:57.491 INFO [stderr]    Compiling synstructure v0.8.1
Nov 16 21:42:02.299 INFO [stderr]    Compiling gc-arena-derive v0.1.0 (/source/gc-arena/gc-arena-derive)
Nov 16 21:42:05.380 INFO [stderr]    Compiling gc-arena v0.1.0 (/source/gc-arena)
Nov 16 21:42:06.495 INFO [stderr]    Compiling luster v0.1.0 (/source)
Nov 16 21:42:18.735 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 36.42s
Nov 16 21:42:18.747 INFO [stderr] su: No module specific data is present
Nov 16 21:42:19.953 INFO running `"docker" "inspect" "35dd81ae87b14e4be157f82009814daf618e718a53976f6e94fb6165721ed7b3"`
Nov 16 21:42:20.329 INFO running `"docker" "rm" "-f" "35dd81ae87b14e4be157f82009814daf618e718a53976f6e94fb6165721ed7b3"`
Nov 16 21:42:20.711 INFO [stdout] 35dd81ae87b14e4be157f82009814daf618e718a53976f6e94fb6165721ed7b3
Nov 16 21:42:20.718 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-5/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-5/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 21:42:21.179 INFO [stdout] 084e6395e91b606ea6b34c8256c43e2b976975f439893a59cda7be964e2fc238
Nov 16 21:42:21.187 INFO running `"docker" "start" "-a" "084e6395e91b606ea6b34c8256c43e2b976975f439893a59cda7be964e2fc238"`
Nov 16 21:42:22.653 INFO [stderr] usermod: no changes
Nov 16 21:42:22.787 INFO [stderr]    Compiling luster v0.1.0 (/source)
Nov 16 21:42:26.199 INFO [stderr] warning: unused `std::result::Result` that must be used
Nov 16 21:42:26.200 INFO [stderr]   --> tests/suite.rs:26:17
Nov 16 21:42:26.200 INFO [stderr]    |
Nov 16 21:42:26.200 INFO [stderr] 26 |                 writeln!(stdout, "parsing file {:?}", path);
Nov 16 21:42:26.200 INFO [stderr]    |                 ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Nov 16 21:42:26.244 INFO [stderr]    |
Nov 16 21:42:26.244 INFO [stderr]    = note: #[warn(unused_must_use)] on by default
Nov 16 21:42:26.244 INFO [stderr]    = note: this `Result` may be an `Err` variant, which should be handled
Nov 16 21:42:26.244 INFO [stderr]    = note: this error originates in a macro outside of the current crate (in Nightly builds, run with -Z external-macro-backtrace for more info)
Nov 16 21:42:26.245 INFO [stderr] 
Nov 16 21:42:26.245 INFO [stderr] warning: unused `std::result::Result` that must be used
Nov 16 21:42:26.245 INFO [stderr]   --> tests/suite.rs:28:21
Nov 16 21:42:26.246 INFO [stderr]    |
Nov 16 21:42:26.246 INFO [stderr] 28 |                     writeln!(stdout, "error encountered: {:?}", err);
Nov 16 21:42:26.246 INFO [stderr]    |                     ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Nov 16 21:42:26.247 INFO [stderr]    |
Nov 16 21:42:26.247 INFO [stderr]    = note: this `Result` may be an `Err` variant, which should be handled
Nov 16 21:42:26.247 INFO [stderr]    = note: this error originates in a macro outside of the current crate (in Nightly builds, run with -Z external-macro-backtrace for more info)
Nov 16 21:42:26.248 INFO [stderr] 
Nov 16 21:42:26.248 INFO [stderr] warning: unused `std::result::Result` that must be used
Nov 16 21:42:26.248 INFO [stderr]   --> tests/suite.rs:33:13
Nov 16 21:42:26.248 INFO [stderr]    |
Nov 16 21:42:26.249 INFO [stderr] 33 |             writeln!(stdout, "skipping file {:?}", path);
Nov 16 21:42:26.249 INFO [stderr]    |             ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Nov 16 21:42:26.249 INFO [stderr]    |
Nov 16 21:42:26.250 INFO [stderr]    = note: this `Result` may be an `Err` variant, which should be handled
Nov 16 21:42:26.250 INFO [stderr]    = note: this error originates in a macro outside of the current crate (in Nightly builds, run with -Z external-macro-backtrace for more info)
Nov 16 21:42:26.250 INFO [stderr] 
Nov 16 21:42:36.779 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 14.09s
Nov 16 21:42:36.786 INFO [stderr] su: No module specific data is present
Nov 16 21:42:37.505 INFO running `"docker" "inspect" "084e6395e91b606ea6b34c8256c43e2b976975f439893a59cda7be964e2fc238"`
Nov 16 21:42:37.801 INFO running `"docker" "rm" "-f" "084e6395e91b606ea6b34c8256c43e2b976975f439893a59cda7be964e2fc238"`
Nov 16 21:42:38.067 INFO [stdout] 084e6395e91b606ea6b34c8256c43e2b976975f439893a59cda7be964e2fc238
Nov 16 21:42:38.073 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-5/try#2e026d6e5d7621634147ad4c8074f1d964dbb1be:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-5/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 21:42:38.399 INFO [stdout] 7e95ef84312c1d91cf7ed9f12ec58b6db570488e88f2a159845fe2f5b7ffa453
Nov 16 21:42:38.402 INFO running `"docker" "start" "-a" "7e95ef84312c1d91cf7ed9f12ec58b6db570488e88f2a159845fe2f5b7ffa453"`
Nov 16 21:42:39.733 INFO [stderr] usermod: no changes
Nov 16 21:42:39.851 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.07s
Nov 16 21:42:39.859 INFO [stderr]      Running /target/debug/deps/luster-907ce91e672fc5c0
Nov 16 21:42:39.860 INFO [stdout] 
Nov 16 21:42:39.860 INFO [stdout] running 8 tests
Nov 16 21:42:39.860 INFO [stdout] test tests::parser::test_function_call ... ok
Nov 16 21:42:39.860 INFO [stdout] test tests::lexer::words ... ok
Nov 16 21:42:39.861 INFO [stdout] test tests::lexer::ops ... ok
Nov 16 21:42:39.861 INFO [stdout] test tests::lexer::numerals ... ok
Nov 16 21:42:39.861 INFO [stdout] test tests::lexer::long_string ... ok
Nov 16 21:42:39.861 INFO [stdout] test tests::io::test_skip_prefix ... ok
Nov 16 21:42:39.862 INFO [stdout] test tests::lexer::short_string ... ok
Nov 16 21:42:39.862 INFO [stdout] test tests::lexer::comments ... ok
Nov 16 21:42:39.863 INFO [stdout] 
Nov 16 21:42:39.863 INFO [stdout] test result: ok. 8 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 16 21:42:39.863 INFO [stdout] 
Nov 16 21:42:39.864 INFO [stderr]      Running /target/debug/deps/compiler-6af63a9183469495
Nov 16 21:42:39.867 INFO [stdout] 
Nov 16 21:42:39.867 INFO [stdout] running 0 tests
Nov 16 21:42:39.867 INFO [stdout] 
Nov 16 21:42:39.868 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 16 21:42:39.868 INFO [stdout] 
Nov 16 21:42:39.871 INFO [stdout] 
Nov 16 21:42:39.872 INFO [stderr]      Running /target/debug/deps/interpreter-1e40cd4c717692aa
Nov 16 21:42:39.873 INFO [stdout] running 0 tests
Nov 16 21:42:39.873 INFO [stderr]      Running /target/debug/deps/basic-39914e0ff5b0cf55
Nov 16 21:42:39.873 INFO [stdout] 
Nov 16 21:42:39.873 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 16 21:42:39.874 INFO [stdout] 
Nov 16 21:42:39.876 INFO [stdout] 
Nov 16 21:42:39.876 INFO [stdout] running 3 tests
Nov 16 21:42:39.877 INFO [stdout] test test_assignment ... ok
Nov 16 21:42:39.877 INFO [stdout] test test_return ... ok
Nov 16 21:42:39.877 INFO [stdout] test test_local ... ok
Nov 16 21:42:39.878 INFO [stdout] 
Nov 16 21:42:39.878 INFO [stdout] test result: ok. 3 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 16 21:42:39.878 INFO [stdout] 
Nov 16 21:42:39.878 INFO [stdout] 
Nov 16 21:42:39.878 INFO [stdout] running 1 test
Nov 16 21:42:39.878 INFO [stderr]      Running /target/debug/deps/suite-5a31733a3e79ccc9
Nov 16 21:42:39.894 INFO [stdout] test test_suite ... ok
Nov 16 21:42:39.894 INFO [stdout] 
Nov 16 21:42:39.894 INFO [stdout] test result: ok. 1 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 16 21:42:39.894 INFO [stdout] 
Nov 16 21:42:39.895 INFO [stderr]      Running /target/debug/deps/upvalues-39e78a989befcbd5
Nov 16 21:42:39.895 INFO [stdout] 
Nov 16 21:42:39.895 INFO [stdout] running 3 tests
Nov 16 21:42:39.895 INFO [stdout] test test_upvalue ... ok
Nov 16 21:42:39.907 INFO [stdout] test test_upvalue_multi ... ok
Nov 16 21:42:39.907 INFO [stdout] test test_upvalue_outer ... ok
Nov 16 21:42:39.907 INFO [stdout] 
Nov 16 21:42:39.907 INFO [stdout] test result: ok. 3 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 16 21:42:39.907 INFO [stdout] 
Nov 16 21:42:39.907 INFO [stderr]    Doc-tests luster
Nov 16 21:42:40.915 INFO [stdout] 
Nov 16 21:42:40.915 INFO [stdout] running 0 tests
Nov 16 21:42:40.915 INFO [stdout] 
Nov 16 21:42:40.915 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 16 21:42:40.915 INFO [stdout] 
Nov 16 21:42:40.927 INFO [stderr] su: No module specific data is present
Nov 16 21:42:41.750 INFO running `"docker" "inspect" "7e95ef84312c1d91cf7ed9f12ec58b6db570488e88f2a159845fe2f5b7ffa453"`
Nov 16 21:42:42.055 INFO running `"docker" "rm" "-f" "7e95ef84312c1d91cf7ed9f12ec58b6db570488e88f2a159845fe2f5b7ffa453"`
Nov 16 21:42:42.367 INFO [stdout] 7e95ef84312c1d91cf7ed9f12ec58b6db570488e88f2a159845fe2f5b7ffa453