Nov 17 06:06:27.096 INFO testing cormackikkert/slot-in-smart-meter-server against master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c for pr-55982
Nov 17 06:06:27.098 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-0/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-0/pr-55982/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/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 +6b9b97bd9b704f85f0184f7a213cc4d62bd9654c-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 17 06:06:27.621 INFO [stdout] 4de90148d0dbf9f3ec4f4485e413ac52fd5ff77d4e521513fc492827d729f8d2
Nov 17 06:06:27.624 INFO running `"docker" "start" "-a" "4de90148d0dbf9f3ec4f4485e413ac52fd5ff77d4e521513fc492827d729f8d2"`
Nov 17 06:06:29.602 INFO [stderr] usermod: no changes
Nov 17 06:06:29.920 INFO [stderr]    Compiling serde v1.0.76
Nov 17 06:06:29.921 INFO [stderr]    Compiling proc-macro2 v0.4.17
Nov 17 06:06:29.927 INFO [stderr]    Compiling untrusted v0.5.1
Nov 17 06:06:29.928 INFO [stderr]    Compiling pear v0.0.20
Nov 17 06:06:29.935 INFO [stderr]    Compiling ordermap v0.2.13
Nov 17 06:06:29.935 INFO [stderr]    Compiling state v0.4.1
Nov 17 06:06:29.936 INFO [stderr]    Compiling isatty v0.1.8
Nov 17 06:06:29.937 INFO [stderr]    Compiling pear_codegen v0.0.20
Nov 17 06:06:31.941 INFO [stderr]    Compiling rocket v0.3.16
Nov 17 06:06:32.192 INFO [stderr]    Compiling rocket_codegen v0.3.16
Nov 17 06:06:32.279 INFO [stderr]    Compiling base64 v0.9.2
Nov 17 06:06:33.383 INFO [stderr]    Compiling influent v0.4.1
Nov 17 06:06:33.707 INFO [stderr]    Compiling rayon v0.7.1
Nov 17 06:06:41.640 INFO [stderr]    Compiling ring v0.11.0
Nov 17 06:06:41.660 INFO [stderr]    Compiling quote v0.6.8
Nov 17 06:06:43.923 INFO [stderr]    Compiling syn v0.14.9
Nov 17 06:06:58.183 INFO [stderr]    Compiling serde_derive v1.0.76
Nov 17 06:06:59.123 INFO [stderr]    Compiling cookie v0.9.2
Nov 17 06:07:01.480 INFO [stderr]    Compiling toml v0.4.6
Nov 17 06:07:01.480 INFO [stderr]    Compiling serde_json v1.0.26
Nov 17 06:07:19.087 INFO [stderr]    Compiling rocket_contrib v0.3.16
Nov 17 06:07:34.027 INFO [stderr]    Compiling smart-meter-server v0.1.0 (/source)
Nov 17 06:07:38.147 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 1m 08s
Nov 17 06:07:38.152 INFO [stderr] su: No module specific data is present
Nov 17 06:07:39.273 INFO running `"docker" "inspect" "4de90148d0dbf9f3ec4f4485e413ac52fd5ff77d4e521513fc492827d729f8d2"`
Nov 17 06:07:39.549 INFO running `"docker" "rm" "-f" "4de90148d0dbf9f3ec4f4485e413ac52fd5ff77d4e521513fc492827d729f8d2"`
Nov 17 06:07:39.897 INFO [stdout] 4de90148d0dbf9f3ec4f4485e413ac52fd5ff77d4e521513fc492827d729f8d2
Nov 17 06:07:39.902 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-0/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-0/pr-55982/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/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 +6b9b97bd9b704f85f0184f7a213cc4d62bd9654c-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 17 06:07:40.367 INFO [stdout] 5d272c68c2445d0fc0709634cb5c44b4b16e1998b9d09169fc025fb0eebf3d69
Nov 17 06:07:40.369 INFO running `"docker" "start" "-a" "5d272c68c2445d0fc0709634cb5c44b4b16e1998b9d09169fc025fb0eebf3d69"`
Nov 17 06:07:42.442 INFO [stderr] usermod: no changes
Nov 17 06:07:42.635 INFO [stderr]    Compiling smart-meter-server v0.1.0 (/source)
Nov 17 06:07:46.503 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 4.03s
Nov 17 06:07:46.514 INFO [stderr] su: No module specific data is present
Nov 17 06:07:47.491 INFO running `"docker" "inspect" "5d272c68c2445d0fc0709634cb5c44b4b16e1998b9d09169fc025fb0eebf3d69"`
Nov 17 06:07:47.755 INFO running `"docker" "rm" "-f" "5d272c68c2445d0fc0709634cb5c44b4b16e1998b9d09169fc025fb0eebf3d69"`
Nov 17 06:07:48.107 INFO [stdout] 5d272c68c2445d0fc0709634cb5c44b4b16e1998b9d09169fc025fb0eebf3d69
Nov 17 06:07:48.109 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-0/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-0/pr-55982/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/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 +6b9b97bd9b704f85f0184f7a213cc4d62bd9654c-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 17 06:07:48.621 INFO [stdout] 1777ecb10e083824373e210fb67f325129210b1e1d680365cf0ed05a6699c25f
Nov 17 06:07:48.623 INFO running `"docker" "start" "-a" "1777ecb10e083824373e210fb67f325129210b1e1d680365cf0ed05a6699c25f"`
Nov 17 06:07:50.347 INFO [stderr] usermod: no changes
Nov 17 06:07:50.543 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.17s
Nov 17 06:07:50.547 INFO [stderr]      Running /target/debug/deps/smart_meter_server-a9c4f6ecb7c0a982
Nov 17 06:07:50.556 INFO [stdout] 
Nov 17 06:07:50.556 INFO [stdout] running 2 tests
Nov 17 06:07:50.557 INFO [stdout] test tests::hello_world ... ok
Nov 17 06:07:50.723 INFO [stdout] test tests::invalid_device_id ... FAILED
Nov 17 06:07:50.724 INFO [stdout] 
Nov 17 06:07:50.724 INFO [stdout] failures:
Nov 17 06:07:50.724 INFO [stdout] 
Nov 17 06:07:50.724 INFO [stdout] ---- tests::invalid_device_id stdout ----
Nov 17 06:07:50.724 INFO [stdout] Configured for development.
Nov 17 06:07:50.724 INFO [stdout]     => address: localhost
Nov 17 06:07:50.724 INFO [stdout]     => port: 8000
Nov 17 06:07:50.724 INFO [stdout]     => log: normal
Nov 17 06:07:50.724 INFO [stdout]     => workers: 16
Nov 17 06:07:50.724 INFO [stdout]     => secret key: generated
Nov 17 06:07:50.724 INFO [stdout]     => limits: forms = 32KiB
Nov 17 06:07:50.724 INFO [stdout]     => tls: disabled
Nov 17 06:07:50.724 INFO [stdout] Mounting '/':
Nov 17 06:07:50.724 INFO [stdout]     => GET /
Nov 17 06:07:50.724 INFO [stdout]     => POST /dapi/reading application/json
Nov 17 06:07:50.725 INFO [stdout] GET /dapi/put/0:
Nov 17 06:07:50.725 INFO [stdout]     => Error: No matching routes for GET /dapi/put/0.
Nov 17 06:07:50.725 INFO [stdout]     => Warning: Responding with 404 Not Found catcher.
Nov 17 06:07:50.725 INFO [stdout] thread 'tests::invalid_device_id' panicked at 'assertion failed: `(left == right)`
Nov 17 06:07:50.725 INFO [stdout]   left: `Status { code: 404, reason: "Not Found" }`,
Nov 17 06:07:50.725 INFO [stdout]  right: `Status { code: 403, reason: "Forbidden" }`', src/tests.rs:17:2
Nov 17 06:07:50.725 INFO [stdout] stack backtrace:
Nov 17 06:07:50.725 INFO [stdout]    0:     0x555779e0bf93 - std::sys::unix::backtrace::tracing::imp::unwind_backtrace::h1a944b80a560daa8
Nov 17 06:07:50.725 INFO [stdout]                                at libstd/sys/unix/backtrace/tracing/gcc_s.rs:49
Nov 17 06:07:50.725 INFO [stdout]    1:     0x555779e062e8 - std::sys_common::backtrace::_print::h18f735b4c3a49bdb
Nov 17 06:07:50.725 INFO [stdout]                                at libstd/sys_common/backtrace.rs:71
Nov 17 06:07:50.725 INFO [stdout]    2:     0x555779e0ab34 - std::panicking::default_hook::{{closure}}::h97ab3548a215c097
Nov 17 06:07:50.725 INFO [stdout]                                at libstd/sys_common/backtrace.rs:59
Nov 17 06:07:50.725 INFO [stdout]                                at libstd/panicking.rs:211
Nov 17 06:07:50.725 INFO [stdout]    3:     0x555779e0a81c - std::panicking::default_hook::h98c2a01ef734e4b0
Nov 17 06:07:50.725 INFO [stdout]                                at libstd/panicking.rs:221
Nov 17 06:07:50.725 INFO [stdout]    4:     0x555779e0b240 - std::panicking::rust_panic_with_hook::hb4b3f28eb79ea752
Nov 17 06:07:50.725 INFO [stdout]                                at libstd/panicking.rs:476
Nov 17 06:07:50.725 INFO [stdout]    5:     0x555779e0adc1 - std::panicking::continue_panic_fmt::h61fd5a7b1a268752
Nov 17 06:07:50.725 INFO [stdout]                                at libstd/panicking.rs:390
Nov 17 06:07:50.725 INFO [stdout]    6:     0x555779e0ad0e - std::panicking::begin_panic_fmt::hfa6f19d29682fcb6
Nov 17 06:07:50.725 INFO [stdout]                                at libstd/panicking.rs:345
Nov 17 06:07:50.725 INFO [stdout]    7:     0x555779ac8594 - smart_meter_server::tests::invalid_device_id::hd24134a97f3b2ac6
Nov 17 06:07:50.725 INFO [stdout]                                at src/tests.rs:17
Nov 17 06:07:50.725 INFO [stdout]    8:     0x555779ac7a09 - smart_meter_server::tests::invalid_device_id::{{closure}}::h11948867228f9e42
Nov 17 06:07:50.725 INFO [stdout]                                at src/tests.rs:14
Nov 17 06:07:50.725 INFO [stdout]    9:     0x555779acf34d - core::ops::function::FnOnce::call_once::h40b735d06043020c
Nov 17 06:07:50.725 INFO [stdout]                                at /rustc/6b9b97bd9b704f85f0184f7a213cc4d62bd9654c/src/libcore/ops/function.rs:238
Nov 17 06:07:50.725 INFO [stdout]   10:     0x555779addb3e - <F as alloc::boxed::FnBox<A>>::call_box::h9dcb7fc9b8bb4240
Nov 17 06:07:50.725 INFO [stdout]                                at libtest/lib.rs:1471
Nov 17 06:07:50.725 INFO [stdout]                                at /rustc/6b9b97bd9b704f85f0184f7a213cc4d62bd9654c/src/libcore/ops/function.rs:238
Nov 17 06:07:50.725 INFO [stdout]                                at /rustc/6b9b97bd9b704f85f0184f7a213cc4d62bd9654c/src/liballoc/boxed.rs:673
Nov 17 06:07:50.725 INFO [stdout]   11:     0x555779e1a4f9 - __rust_maybe_catch_panic
Nov 17 06:07:50.725 INFO [stdout]                                at libpanic_unwind/lib.rs:102
Nov 17 06:07:50.725 INFO [stdout]   12:     0x555779ad5ba3 - std::sys_common::backtrace::__rust_begin_short_backtrace::h89ea8afe71e36f86
Nov 17 06:07:50.725 INFO [stdout]                                at /rustc/6b9b97bd9b704f85f0184f7a213cc4d62bd9654c/src/libstd/panicking.rs:289
Nov 17 06:07:50.725 INFO [stdout]                                at /rustc/6b9b97bd9b704f85f0184f7a213cc4d62bd9654c/src/libstd/panic.rs:398
Nov 17 06:07:50.725 INFO [stdout]                                at libtest/lib.rs:1426
Nov 17 06:07:50.725 INFO [stdout]                                at /rustc/6b9b97bd9b704f85f0184f7a213cc4d62bd9654c/src/libstd/sys_common/backtrace.rs:136
Nov 17 06:07:50.725 INFO [stdout]   13:     0x555779ad6a54 - std::panicking::try::do_call::h4132042e0cbea3ae
Nov 17 06:07:50.725 INFO [stdout]                                at /rustc/6b9b97bd9b704f85f0184f7a213cc4d62bd9654c/src/libstd/thread/mod.rs:477
Nov 17 06:07:50.725 INFO [stdout]                                at /rustc/6b9b97bd9b704f85f0184f7a213cc4d62bd9654c/src/libstd/panic.rs:319
Nov 17 06:07:50.725 INFO [stdout]                                at /rustc/6b9b97bd9b704f85f0184f7a213cc4d62bd9654c/src/libstd/panicking.rs:310
Nov 17 06:07:50.725 INFO [stdout]   14:     0x555779e1a4f9 - __rust_maybe_catch_panic
Nov 17 06:07:50.725 INFO [stdout]                                at libpanic_unwind/lib.rs:102
Nov 17 06:07:50.725 INFO [stdout]   15:     0x555779addc6c - <F as alloc::boxed::FnBox<A>>::call_box::hab7f616f05880bf6
Nov 17 06:07:50.725 INFO [stdout]                                at /rustc/6b9b97bd9b704f85f0184f7a213cc4d62bd9654c/src/libstd/panicking.rs:289
Nov 17 06:07:50.725 INFO [stdout]                                at /rustc/6b9b97bd9b704f85f0184f7a213cc4d62bd9654c/src/libstd/panic.rs:398
Nov 17 06:07:50.725 INFO [stdout]                                at /rustc/6b9b97bd9b704f85f0184f7a213cc4d62bd9654c/src/libstd/thread/mod.rs:476
Nov 17 06:07:50.725 INFO [stdout]                                at /rustc/6b9b97bd9b704f85f0184f7a213cc4d62bd9654c/src/liballoc/boxed.rs:673
Nov 17 06:07:50.725 INFO [stdout]   16:     0x555779e0e09d - std::sys::unix::thread::Thread::new::thread_start::h5f8d67158a1ca038
Nov 17 06:07:50.725 INFO [stdout]                                at /rustc/6b9b97bd9b704f85f0184f7a213cc4d62bd9654c/src/liballoc/boxed.rs:683
Nov 17 06:07:50.725 INFO [stdout]                                at libstd/sys_common/thread.rs:24
Nov 17 06:07:50.725 INFO [stdout]                                at libstd/sys/unix/thread.rs:90
Nov 17 06:07:50.725 INFO [stdout]   17:     0x7f75e14446b9 - start_thread
Nov 17 06:07:50.725 INFO [stdout]   18:     0x7f75e0f6441c - clone
Nov 17 06:07:50.725 INFO [stdout]   19:                0x0 - <unknown>
Nov 17 06:07:50.725 INFO [stdout] 
Nov 17 06:07:50.725 INFO [stdout] 
Nov 17 06:07:50.725 INFO [stdout] failures:
Nov 17 06:07:50.726 INFO [stdout]     tests::invalid_device_id
Nov 17 06:07:50.726 INFO [stdout] 
Nov 17 06:07:50.726 INFO [stdout] test result: FAILED. 1 passed; 1 failed; 0 ignored; 0 measured; 0 filtered out
Nov 17 06:07:50.726 INFO [stdout] 
Nov 17 06:07:50.729 INFO [stderr] error: test failed, to rerun pass '--bin smart-meter-server'
Nov 17 06:07:50.733 INFO [stderr] su: No module specific data is present
Nov 17 06:07:52.144 INFO running `"docker" "inspect" "1777ecb10e083824373e210fb67f325129210b1e1d680365cf0ed05a6699c25f"`
Nov 17 06:07:52.413 INFO running `"docker" "rm" "-f" "1777ecb10e083824373e210fb67f325129210b1e1d680365cf0ed05a6699c25f"`
Nov 17 06:07:52.687 INFO [stdout] 1777ecb10e083824373e210fb67f325129210b1e1d680365cf0ed05a6699c25f