Dec 06 03:18:33.468 INFO testing cormackikkert/slot-in-smart-meter-server against try#6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468 for pr-56514 Dec 06 03:18:33.468 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-5/try#6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-5/pr-56514/try#6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468:/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 +6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468-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"` Dec 06 03:18:33.612 INFO [stdout] 3b9964cd1e58b7ff129d6f1bceb4a5722a5b47616a36f6fc4d04dc6ab71b4596 Dec 06 03:18:33.613 INFO running `"docker" "start" "-a" "3b9964cd1e58b7ff129d6f1bceb4a5722a5b47616a36f6fc4d04dc6ab71b4596"` Dec 06 03:18:34.064 INFO [stderr] usermod: no changes Dec 06 03:18:34.320 INFO [stderr] Compiling syn v0.14.9 Dec 06 03:18:34.320 INFO [stderr] Compiling influent v0.4.1 Dec 06 03:18:34.320 INFO [stderr] Compiling rocket v0.3.16 Dec 06 03:18:41.528 INFO [stderr] Compiling serde_derive v1.0.76 Dec 06 03:18:47.508 INFO [stderr] Compiling rocket_contrib v0.3.16 Dec 06 03:18:47.508 INFO [stderr] Compiling rocket_codegen v0.3.16 Dec 06 03:19:06.017 INFO [stderr] Compiling smart-meter-server v0.1.0 (/source) Dec 06 03:19:10.117 INFO [stderr] Finished dev [unoptimized + debuginfo] target(s) in 36.03s Dec 06 03:19:10.128 INFO [stderr] su: No module specific data is present Dec 06 03:19:10.516 INFO running `"docker" "inspect" "3b9964cd1e58b7ff129d6f1bceb4a5722a5b47616a36f6fc4d04dc6ab71b4596"` Dec 06 03:19:10.748 INFO running `"docker" "rm" "-f" "3b9964cd1e58b7ff129d6f1bceb4a5722a5b47616a36f6fc4d04dc6ab71b4596"` Dec 06 03:19:10.880 INFO [stdout] 3b9964cd1e58b7ff129d6f1bceb4a5722a5b47616a36f6fc4d04dc6ab71b4596 Dec 06 03:19:10.884 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-5/try#6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-5/pr-56514/try#6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468:/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 +6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468-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"` Dec 06 03:19:11.213 INFO [stdout] e7ff26f10b74070dd7e63a6a1f1911bc0ba07b1dfebe2dbf448a4455d3e0ba5b Dec 06 03:19:11.218 INFO running `"docker" "start" "-a" "e7ff26f10b74070dd7e63a6a1f1911bc0ba07b1dfebe2dbf448a4455d3e0ba5b"` Dec 06 03:19:11.622 INFO [stderr] usermod: no changes Dec 06 03:19:11.740 INFO [stderr] Compiling smart-meter-server v0.1.0 (/source) Dec 06 03:19:16.087 INFO [stderr] Finished dev [unoptimized + debuginfo] target(s) in 4.45s Dec 06 03:19:16.102 INFO [stderr] su: No module specific data is present Dec 06 03:19:16.621 INFO running `"docker" "inspect" "e7ff26f10b74070dd7e63a6a1f1911bc0ba07b1dfebe2dbf448a4455d3e0ba5b"` Dec 06 03:19:16.860 INFO running `"docker" "rm" "-f" "e7ff26f10b74070dd7e63a6a1f1911bc0ba07b1dfebe2dbf448a4455d3e0ba5b"` Dec 06 03:19:17.092 INFO [stdout] e7ff26f10b74070dd7e63a6a1f1911bc0ba07b1dfebe2dbf448a4455d3e0ba5b Dec 06 03:19:17.098 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-5/try#6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-5/pr-56514/try#6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468:/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 +6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468-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"` Dec 06 03:19:17.420 INFO [stdout] cd20f79a8b48654eebc0dfe1a58c19f5cdf49573d2a9b89bda125d11527045b2 Dec 06 03:19:17.426 INFO running `"docker" "start" "-a" "cd20f79a8b48654eebc0dfe1a58c19f5cdf49573d2a9b89bda125d11527045b2"` Dec 06 03:19:18.412 INFO [stderr] usermod: no changes Dec 06 03:19:18.616 INFO [stderr] Finished dev [unoptimized + debuginfo] target(s) in 0.16s Dec 06 03:19:18.623 INFO [stderr] Running /target/debug/deps/smart_meter_server-ceaf2a6ad80903c0 Dec 06 03:19:18.628 INFO [stdout] Dec 06 03:19:18.628 INFO [stdout] running 2 tests Dec 06 03:19:18.640 INFO [stdout] test tests::hello_world ... ok Dec 06 03:19:18.728 INFO [stdout] test tests::invalid_device_id ... FAILED Dec 06 03:19:18.728 INFO [stdout] Dec 06 03:19:18.728 INFO [stdout] failures: Dec 06 03:19:18.728 INFO [stdout] Dec 06 03:19:18.728 INFO [stdout] ---- tests::invalid_device_id stdout ---- Dec 06 03:19:18.728 INFO [stdout] Configured for development. Dec 06 03:19:18.728 INFO [stdout] => address: localhost Dec 06 03:19:18.728 INFO [stdout] => port: 8000 Dec 06 03:19:18.728 INFO [stdout] => log: normal Dec 06 03:19:18.728 INFO [stdout] => workers: 16 Dec 06 03:19:18.728 INFO [stdout] => secret key: generated Dec 06 03:19:18.728 INFO [stdout] => limits: forms = 32KiB Dec 06 03:19:18.728 INFO [stdout] => tls: disabled Dec 06 03:19:18.728 INFO [stdout] Mounting '/': Dec 06 03:19:18.728 INFO [stdout] => GET / Dec 06 03:19:18.728 INFO [stdout] => POST /dapi/reading application/json Dec 06 03:19:18.728 INFO [stdout] GET /dapi/put/0: Dec 06 03:19:18.728 INFO [stdout] => Error: No matching routes for GET /dapi/put/0. Dec 06 03:19:18.728 INFO [stdout] => Warning: Responding with 404 Not Found catcher. Dec 06 03:19:18.729 INFO [stdout] thread 'tests::invalid_device_id' panicked at 'assertion failed: `(left == right)` Dec 06 03:19:18.729 INFO [stdout] left: `Status { code: 404, reason: "Not Found" }`, Dec 06 03:19:18.729 INFO [stdout] right: `Status { code: 403, reason: "Forbidden" }`', src/tests.rs:17:2 Dec 06 03:19:18.729 INFO [stdout] stack backtrace: Dec 06 03:19:18.729 INFO [stdout] 0: 0x562c968697d3 - std::sys::unix::backtrace::tracing::imp::unwind_backtrace::h82c998a0e635a5c4 Dec 06 03:19:18.729 INFO [stdout] at src/libstd/sys/unix/backtrace/tracing/gcc_s.rs:49 Dec 06 03:19:18.729 INFO [stdout] 1: 0x562c96863aa8 - std::sys_common::backtrace::_print::h5fbc0bc3cf12d9bf Dec 06 03:19:18.729 INFO [stdout] at src/libstd/sys_common/backtrace.rs:71 Dec 06 03:19:18.729 INFO [stdout] 2: 0x562c96868362 - std::panicking::default_hook::{{closure}}::h42b81c3dd1a50e32 Dec 06 03:19:18.729 INFO [stdout] at src/libstd/sys_common/backtrace.rs:59 Dec 06 03:19:18.729 INFO [stdout] at src/libstd/panicking.rs:211 Dec 06 03:19:18.729 INFO [stdout] 3: 0x562c9686804c - std::panicking::default_hook::h6c8d8e1c12a669e5 Dec 06 03:19:18.729 INFO [stdout] at src/libstd/panicking.rs:221 Dec 06 03:19:18.729 INFO [stdout] 4: 0x562c96868a70 - std::panicking::rust_panic_with_hook::hce93a56e38c2b0aa Dec 06 03:19:18.729 INFO [stdout] at src/libstd/panicking.rs:491 Dec 06 03:19:18.729 INFO [stdout] 5: 0x562c968685f1 - std::panicking::continue_panic_fmt::hf3c774aec6124caa Dec 06 03:19:18.729 INFO [stdout] at src/libstd/panicking.rs:398 Dec 06 03:19:18.729 INFO [stdout] 6: 0x562c9686853e - std::panicking::begin_panic_fmt::h3605d603150d0c9a Dec 06 03:19:18.729 INFO [stdout] at src/libstd/panicking.rs:353 Dec 06 03:19:18.729 INFO [stdout] 7: 0x562c9652670f - smart_meter_server::tests::invalid_device_id::h2ca09a721b4cc001 Dec 06 03:19:18.729 INFO [stdout] at src/tests.rs:17 Dec 06 03:19:18.729 INFO [stdout] 8: 0x562c96525b89 - smart_meter_server::tests::invalid_device_id::{{closure}}::h6de7b9c8dea0e270 Dec 06 03:19:18.729 INFO [stdout] at src/tests.rs:14 Dec 06 03:19:18.729 INFO [stdout] 9: 0x562c9652b65d - core::ops::function::FnOnce::call_once::h50ba06bcfacb77f8 Dec 06 03:19:18.729 INFO [stdout] at /rustc/6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468/src/libcore/ops/function.rs:238 Dec 06 03:19:18.729 INFO [stdout] 10: 0x562c9653bdfe - >::call_box::h9ed1658cdce7f33f Dec 06 03:19:18.729 INFO [stdout] at src/libtest/lib.rs:1471 Dec 06 03:19:18.729 INFO [stdout] at /rustc/6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468/src/libcore/ops/function.rs:238 Dec 06 03:19:18.729 INFO [stdout] at /rustc/6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468/src/liballoc/boxed.rs:673 Dec 06 03:19:18.729 INFO [stdout] 11: 0x562c96877be9 - __rust_maybe_catch_panic Dec 06 03:19:18.729 INFO [stdout] at src/libpanic_unwind/lib.rs:102 Dec 06 03:19:18.729 INFO [stdout] 12: 0x562c96533cd3 - std::sys_common::backtrace::__rust_begin_short_backtrace::h018d03d6681412f5 Dec 06 03:19:18.729 INFO [stdout] at /rustc/6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468/src/libstd/panicking.rs:289 Dec 06 03:19:18.729 INFO [stdout] at /rustc/6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468/src/libstd/panic.rs:398 Dec 06 03:19:18.729 INFO [stdout] at src/libtest/lib.rs:1426 Dec 06 03:19:18.729 INFO [stdout] at /rustc/6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468/src/libstd/sys_common/backtrace.rs:136 Dec 06 03:19:18.729 INFO [stdout] 13: 0x562c96534c64 - std::panicking::try::do_call::hf8ab3f21dcfaa7a6 Dec 06 03:19:18.729 INFO [stdout] at /rustc/6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468/src/libstd/thread/mod.rs:477 Dec 06 03:19:18.729 INFO [stdout] at /rustc/6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468/src/libstd/panic.rs:319 Dec 06 03:19:18.729 INFO [stdout] at /rustc/6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468/src/libstd/panicking.rs:310 Dec 06 03:19:18.729 INFO [stdout] 14: 0x562c96877be9 - __rust_maybe_catch_panic Dec 06 03:19:18.729 INFO [stdout] at src/libpanic_unwind/lib.rs:102 Dec 06 03:19:18.729 INFO [stdout] 15: 0x562c9653bcdc - >::call_box::h6465cc998309e287 Dec 06 03:19:18.729 INFO [stdout] at /rustc/6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468/src/libstd/panicking.rs:289 Dec 06 03:19:18.729 INFO [stdout] at /rustc/6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468/src/libstd/panic.rs:398 Dec 06 03:19:18.729 INFO [stdout] at /rustc/6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468/src/libstd/thread/mod.rs:476 Dec 06 03:19:18.729 INFO [stdout] at /rustc/6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468/src/liballoc/boxed.rs:673 Dec 06 03:19:18.729 INFO [stdout] 16: 0x562c9686b8ad - std::sys::unix::thread::Thread::new::thread_start::h0fe9c527147fd5f5 Dec 06 03:19:18.729 INFO [stdout] at /rustc/6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468/src/liballoc/boxed.rs:683 Dec 06 03:19:18.729 INFO [stdout] at src/libstd/sys_common/thread.rs:24 Dec 06 03:19:18.729 INFO [stdout] at src/libstd/sys/unix/thread.rs:90 Dec 06 03:19:18.729 INFO [stdout] 17: 0x7fdeafbba6b9 - start_thread Dec 06 03:19:18.729 INFO [stdout] 18: 0x7fdeaf6da41c - clone Dec 06 03:19:18.729 INFO [stdout] 19: 0x0 - Dec 06 03:19:18.729 INFO [stdout] Dec 06 03:19:18.729 INFO [stdout] Dec 06 03:19:18.729 INFO [stdout] failures: Dec 06 03:19:18.729 INFO [stdout] tests::invalid_device_id Dec 06 03:19:18.729 INFO [stdout] Dec 06 03:19:18.729 INFO [stdout] test result: FAILED. 1 passed; 1 failed; 0 ignored; 0 measured; 0 filtered out Dec 06 03:19:18.729 INFO [stdout] Dec 06 03:19:18.733 INFO [stderr] error: test failed, to rerun pass '--bin smart-meter-server' Dec 06 03:19:18.734 INFO [stderr] su: No module specific data is present Dec 06 03:19:19.854 INFO running `"docker" "inspect" "cd20f79a8b48654eebc0dfe1a58c19f5cdf49573d2a9b89bda125d11527045b2"` Dec 06 03:19:20.174 INFO running `"docker" "rm" "-f" "cd20f79a8b48654eebc0dfe1a58c19f5cdf49573d2a9b89bda125d11527045b2"` Dec 06 03:19:20.532 INFO [stdout] cd20f79a8b48654eebc0dfe1a58c19f5cdf49573d2a9b89bda125d11527045b2