Nov 16 11:37:12.806 INFO testing tailhook/lithos against master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c for pr-55982
Nov 16 11:37:12.807 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-6/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-6/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 16 11:37:13.188 INFO [stdout] b1443cea3cbb5d1ee92dba16836911919e7af31dc16e2a02860550368201786a
Nov 16 11:37:13.190 INFO running `"docker" "start" "-a" "b1443cea3cbb5d1ee92dba16836911919e7af31dc16e2a02860550368201786a"`
Nov 16 11:37:14.935 INFO [stderr] usermod: no changes
Nov 16 11:37:15.255 INFO [stderr]    Compiling proc-macro2 v0.4.12
Nov 16 11:37:15.299 INFO [stderr]    Compiling atomic v0.3.4
Nov 16 11:37:15.308 INFO [stderr]    Compiling rand v0.4.2
Nov 16 11:37:15.309 INFO [stderr]    Compiling log v0.4.3
Nov 16 11:37:15.309 INFO [stderr]    Compiling unix_socket v0.5.0
Nov 16 11:37:15.311 INFO [stderr]    Compiling base64 v0.9.2
Nov 16 11:37:15.311 INFO [stderr]    Compiling scan_dir v0.3.3
Nov 16 11:37:15.312 INFO [stderr]    Compiling nix v0.11.0
Nov 16 11:37:17.118 INFO [stderr]    Compiling backtrace-sys v0.1.23
Nov 16 11:37:19.676 INFO [stderr]    Compiling serde_json v1.0.24
Nov 16 11:37:19.678 INFO [stderr]    Compiling serde_str v0.1.0
Nov 16 11:37:19.688 INFO [stderr]    Compiling thread_local v0.3.5
Nov 16 11:37:19.713 INFO [stderr]    Compiling humannum v0.1.0
Nov 16 11:37:19.723 INFO [stderr]    Compiling backtrace v0.3.9
Nov 16 11:37:19.895 INFO [stderr]    Compiling ssh-keys v0.1.3
Nov 16 11:37:21.261 INFO [stderr]    Compiling log v0.3.9
Nov 16 11:37:22.476 INFO [stderr]    Compiling digest v0.7.5
Nov 16 11:37:26.364 INFO [stderr]    Compiling quire v0.4.1
Nov 16 11:37:26.376 INFO [stderr]    Compiling blake2 v0.7.1
Nov 16 11:37:26.397 INFO [stderr]    Compiling sha2 v0.7.1
Nov 16 11:37:26.516 INFO [stderr]    Compiling regex v1.0.2
Nov 16 11:37:34.651 INFO [stderr]    Compiling syslog v3.3.0
Nov 16 11:37:34.655 INFO [stderr]    Compiling fern v0.4.4
Nov 16 11:37:37.024 INFO [stderr]    Compiling rand v0.3.22
Nov 16 11:37:51.359 INFO [stderr]    Compiling rust-crypto v0.2.36
Nov 16 11:37:51.440 INFO [stderr]    Compiling quote v0.6.6
Nov 16 11:37:51.744 INFO [stderr]    Compiling libcantal v0.3.2
Nov 16 11:38:01.536 INFO [stderr]    Compiling syn v0.14.8
Nov 16 11:38:09.089 INFO [stderr]    Compiling env_logger v0.5.12
Nov 16 11:38:12.753 INFO [stderr]    Compiling unshare v0.5.0
Nov 16 11:38:12.760 INFO [stderr]    Compiling signal v0.6.0
Nov 16 11:38:12.762 INFO [stderr]    Compiling libmount v0.1.11
Nov 16 11:38:34.511 INFO [stderr]    Compiling synstructure v0.9.0
Nov 16 11:38:34.523 INFO [stderr]    Compiling structopt-derive v0.2.10
Nov 16 11:38:34.524 INFO [stderr]    Compiling serde_derive v1.0.71
Nov 16 11:38:41.579 INFO [stderr]    Compiling failure_derive v0.1.2
Nov 16 11:38:44.979 INFO [stderr]    Compiling structopt v0.2.10
Nov 16 11:38:46.547 INFO [stderr]    Compiling failure v0.1.2
Nov 16 11:38:58.243 INFO [stderr]    Compiling ipnetwork v0.13.0
Nov 16 11:38:59.491 INFO [stderr]    Compiling lithos v0.18.4 (/source)
Nov 16 11:39:15.491 INFO [stderr] warning: unused `#[macro_use]` import
Nov 16 11:39:15.491 INFO [stderr]   --> src/bin/lithos_crypt.rs:10:1
Nov 16 11:39:15.491 INFO [stderr]    |
Nov 16 11:39:15.491 INFO [stderr] 10 | #[macro_use] extern crate structopt;
Nov 16 11:39:15.491 INFO [stderr]    | ^^^^^^^^^^^^
Nov 16 11:39:15.491 INFO [stderr]    |
Nov 16 11:39:15.491 INFO [stderr]    = note: #[warn(unused_imports)] on by default
Nov 16 11:39:15.491 INFO [stderr] 
Nov 16 11:40:00.027 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 2m 45s
Nov 16 11:40:00.059 INFO [stderr] su: No module specific data is present
Nov 16 11:40:00.655 INFO running `"docker" "inspect" "b1443cea3cbb5d1ee92dba16836911919e7af31dc16e2a02860550368201786a"`
Nov 16 11:40:00.895 INFO running `"docker" "rm" "-f" "b1443cea3cbb5d1ee92dba16836911919e7af31dc16e2a02860550368201786a"`
Nov 16 11:40:01.059 INFO [stdout] b1443cea3cbb5d1ee92dba16836911919e7af31dc16e2a02860550368201786a
Nov 16 11:40:01.067 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-6/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-6/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 16 11:40:01.611 INFO [stdout] f5830843ba1bbd1ddef21de84d3543de1924d51cee910926ebad024535a53335
Nov 16 11:40:01.617 INFO running `"docker" "start" "-a" "f5830843ba1bbd1ddef21de84d3543de1924d51cee910926ebad024535a53335"`
Nov 16 11:40:02.767 INFO [stderr] usermod: no changes
Nov 16 11:40:03.143 INFO [stderr]    Compiling lithos v0.18.4 (/source)
Nov 16 11:40:07.467 INFO [stderr] warning: unused `#[macro_use]` import
Nov 16 11:40:07.468 INFO [stderr]   --> src/bin/lithos_crypt.rs:10:1
Nov 16 11:40:07.469 INFO [stderr]    |
Nov 16 11:40:07.470 INFO [stderr] 10 | #[macro_use] extern crate structopt;
Nov 16 11:40:07.470 INFO [stderr]    | ^^^^^^^^^^^^
Nov 16 11:40:07.470 INFO [stderr]    |
Nov 16 11:40:07.471 INFO [stderr]    = note: #[warn(unused_imports)] on by default
Nov 16 11:40:07.471 INFO [stderr] 
Nov 16 11:40:22.401 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 19.60s
Nov 16 11:40:22.432 INFO [stderr] su: No module specific data is present
Nov 16 11:40:23.631 INFO running `"docker" "inspect" "f5830843ba1bbd1ddef21de84d3543de1924d51cee910926ebad024535a53335"`
Nov 16 11:40:23.871 INFO running `"docker" "rm" "-f" "f5830843ba1bbd1ddef21de84d3543de1924d51cee910926ebad024535a53335"`
Nov 16 11:40:24.132 INFO [stdout] f5830843ba1bbd1ddef21de84d3543de1924d51cee910926ebad024535a53335
Nov 16 11:40:24.139 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-55982/worker-6/master#6b9b97bd9b704f85f0184f7a213cc4d62bd9654c:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-6/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 16 11:40:24.600 INFO [stdout] 8034bfb7498000384db544549bf36612969a4d454e443ff88b4bf0b13f897894
Nov 16 11:40:24.603 INFO running `"docker" "start" "-a" "8034bfb7498000384db544549bf36612969a4d454e443ff88b4bf0b13f897894"`
Nov 16 11:40:25.990 INFO [stderr] usermod: no changes
Nov 16 11:40:26.260 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.23s
Nov 16 11:40:26.267 INFO [stderr]      Running /target/debug/deps/lithos-7ff247c144bac0fc
Nov 16 11:40:26.283 INFO [stdout] 
Nov 16 11:40:26.283 INFO [stdout] running 16 tests
Nov 16 11:40:26.296 INFO [stdout] test container_config::test::correct_name ... ok
Nov 16 11:40:26.297 INFO [stdout] test container_config::test::just_var ... ok
Nov 16 11:40:26.297 INFO [stdout] test container_config::test::prefix ... ok
Nov 16 11:40:26.297 INFO [stdout] test container_config::test::middle ... ok
Nov 16 11:40:26.298 INFO [stdout] test child_config::test::serialize_compat ... ok
Nov 16 11:40:26.298 INFO [stdout] test child_config::test::serialize_vars ... ok
Nov 16 11:40:26.298 INFO [stdout] test child_config::test::deserialize_compat ... ok
Nov 16 11:40:26.299 INFO [stdout] test child_config::test::dedeserialize_vars ... ok
Nov 16 11:40:26.307 INFO [stdout] test container_config::test::two_vars ... ok
Nov 16 11:40:26.307 INFO [stdout] test container_config::test::suffix ... ok
Nov 16 11:40:26.308 INFO [stdout] test nacl::test::curve_roundtrip2 ... ok
Nov 16 11:40:26.308 INFO [stdout] test nacl::test::test_box_edwards_seal ... ok
Nov 16 11:40:26.327 INFO [stdout] test nacl::test::test_box_seal ... ok
Nov 16 11:40:26.328 INFO [stdout] test nacl::test::curve_roundtrip ... ok
Nov 16 11:40:26.328 INFO [stdout] test nacl::test::test_nacl_secretbox_vectors ... ok
Nov 16 11:40:26.328 INFO [stdout] test nacl::test::test_nacl_box_vectors ... ok
Nov 16 11:40:26.329 INFO [stdout] 
Nov 16 11:40:26.329 INFO [stdout] test result: ok. 16 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 16 11:40:26.329 INFO [stdout] 
Nov 16 11:40:26.343 INFO [stdout] 
Nov 16 11:40:26.344 INFO [stderr]      Running /target/debug/deps/lithos_check-24fc543249fd9af5
Nov 16 11:40:26.344 INFO [stdout] running 0 tests
Nov 16 11:40:26.344 INFO [stderr]      Running /target/debug/deps/lithos_clean-6580fd6ea680bcbb
Nov 16 11:40:26.345 INFO [stdout] 
Nov 16 11:40:26.345 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 16 11:40:26.345 INFO [stdout] 
Nov 16 11:40:26.346 INFO [stdout] 
Nov 16 11:40:26.346 INFO [stdout] running 0 tests
Nov 16 11:40:26.346 INFO [stdout] 
Nov 16 11:40:26.347 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 16 11:40:26.347 INFO [stdout] 
Nov 16 11:40:26.347 INFO [stderr]      Running /target/debug/deps/lithos_cmd-4d6b81c1cfec9a07
Nov 16 11:40:26.355 INFO [stderr]      Running /target/debug/deps/lithos_crypt-837c4502d61bffa2
Nov 16 11:40:26.355 INFO [stdout] 
Nov 16 11:40:26.355 INFO [stdout] running 0 tests
Nov 16 11:40:26.355 INFO [stdout] 
Nov 16 11:40:26.355 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 16 11:40:26.355 INFO [stdout] 
Nov 16 11:40:26.359 INFO [stdout] 
Nov 16 11:40:26.359 INFO [stderr]      Running /target/debug/deps/lithos_knot-9a5fd9b4ce4ce943
Nov 16 11:40:26.359 INFO [stdout] running 0 tests
Nov 16 11:40:26.359 INFO [stdout] 
Nov 16 11:40:26.359 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 16 11:40:26.359 INFO [stdout] 
Nov 16 11:40:26.375 INFO [stdout] 
Nov 16 11:40:26.375 INFO [stderr]      Running /target/debug/deps/lithos_ps-1e4bf2d90da2c234
Nov 16 11:40:26.375 INFO [stdout] running 0 tests
Nov 16 11:40:26.375 INFO [stdout] 
Nov 16 11:40:26.375 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 16 11:40:26.375 INFO [stdout] 
Nov 16 11:40:26.382 INFO [stdout] 
Nov 16 11:40:26.382 INFO [stdout] running 2 tests
Nov 16 11:40:26.384 INFO [stdout] test ascii::test::test_many_nodes ... ok
Nov 16 11:40:26.384 INFO [stdout] test ascii::test::test_one_node ... ok
Nov 16 11:40:26.384 INFO [stdout] 
Nov 16 11:40:26.384 INFO [stdout] test result: ok. 2 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 16 11:40:26.384 INFO [stdout] 
Nov 16 11:40:26.384 INFO [stderr]      Running /target/debug/deps/lithos_switch-c4f981aa07b26f1a
Nov 16 11:40:26.388 INFO [stdout] 
Nov 16 11:40:26.388 INFO [stdout] running 0 tests
Nov 16 11:40:26.388 INFO [stdout] 
Nov 16 11:40:26.388 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 16 11:40:26.388 INFO [stdout] 
Nov 16 11:40:26.392 INFO [stderr]      Running /target/debug/deps/lithos_tree-8395bf48804d4d05
Nov 16 11:40:26.395 INFO [stdout] 
Nov 16 11:40:26.395 INFO [stdout] running 0 tests
Nov 16 11:40:26.395 INFO [stdout] 
Nov 16 11:40:26.395 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 16 11:40:26.395 INFO [stdout] 
Nov 16 11:40:26.399 INFO [stderr]    Doc-tests lithos
Nov 16 11:40:28.935 INFO [stdout] 
Nov 16 11:40:28.935 INFO [stdout] running 0 tests
Nov 16 11:40:28.935 INFO [stdout] 
Nov 16 11:40:28.935 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Nov 16 11:40:28.935 INFO [stdout] 
Nov 16 11:40:28.945 INFO [stderr] su: No module specific data is present
Nov 16 11:40:29.578 INFO running `"docker" "inspect" "8034bfb7498000384db544549bf36612969a4d454e443ff88b4bf0b13f897894"`
Nov 16 11:40:29.803 INFO running `"docker" "rm" "-f" "8034bfb7498000384db544549bf36612969a4d454e443ff88b4bf0b13f897894"`
Nov 16 11:40:30.051 INFO [stdout] 8034bfb7498000384db544549bf36612969a4d454e443ff88b4bf0b13f897894