Dec 01 00:17:08.670 INFO testing tailhook/lithos against 1.30.1 for beta-1.31-5
Dec 01 00:17:08.670 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/beta-1.31-5/worker-1/1.30.1:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-1/beta-1.31-5/1.30.1:/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 +1.30.1 build --frozen" "-e" "CARGO_TARGET_DIR=/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/cargo-home" "-e" "RUSTUP_HOME=/rustup-home" "-m" "1536M" "--network" "none" "crater"`
Dec 01 00:17:09.023 INFO [stdout] a3b180680cc59b8b599ca88ec732943cd5675bbbefdb0dfc6c7a929f471d0596
Dec 01 00:17:09.028 INFO running `"docker" "start" "-a" "a3b180680cc59b8b599ca88ec732943cd5675bbbefdb0dfc6c7a929f471d0596"`
Dec 01 00:17:10.903 INFO [stderr] usermod: no changes
Dec 01 00:17:11.238 INFO [stderr]    Compiling proc-macro2 v0.4.12
Dec 01 00:17:11.291 INFO [stderr]    Compiling atomic v0.3.4
Dec 01 00:17:11.295 INFO [stderr]    Compiling rand v0.4.2
Dec 01 00:17:11.296 INFO [stderr]    Compiling unix_socket v0.5.0
Dec 01 00:17:11.296 INFO [stderr]    Compiling scan_dir v0.3.3
Dec 01 00:17:11.296 INFO [stderr]    Compiling ssh-keys v0.1.3
Dec 01 00:17:11.297 INFO [stderr]    Compiling num-traits v0.1.43
Dec 01 00:17:11.297 INFO [stderr]    Compiling backtrace-sys v0.1.23
Dec 01 00:17:12.603 INFO [stderr]    Compiling serde_str v0.1.0
Dec 01 00:17:12.761 INFO [stderr]    Compiling unshare v0.5.0
Dec 01 00:17:13.947 INFO [stderr]    Compiling libmount v0.1.11
Dec 01 00:17:14.376 INFO [stderr]    Compiling signal v0.6.0
Dec 01 00:17:17.215 INFO [stderr]    Compiling fern v0.4.4
Dec 01 00:17:17.228 INFO [stderr]    Compiling thread_local v0.3.5
Dec 01 00:17:17.268 INFO [stderr]    Compiling humannum v0.1.0
Dec 01 00:17:17.363 INFO [stderr]    Compiling backtrace v0.3.9
Dec 01 00:17:20.759 INFO [stderr]    Compiling libcantal v0.3.2
Dec 01 00:17:25.774 INFO [stderr]    Compiling syslog v3.3.0
Dec 01 00:17:25.815 INFO [stderr]    Compiling blake2 v0.7.1
Dec 01 00:17:25.883 INFO [stderr]    Compiling sha2 v0.7.1
Dec 01 00:17:26.696 INFO [stderr]    Compiling quire v0.4.1
Dec 01 00:17:26.783 INFO [stderr]    Compiling regex v1.0.2
Dec 01 00:17:32.119 INFO [stderr]    Compiling rand v0.3.22
Dec 01 00:17:33.527 INFO [stderr]    Compiling rust-crypto v0.2.36
Dec 01 00:17:39.043 INFO [stderr]    Compiling quote v0.6.6
Dec 01 00:17:41.659 INFO [stderr]    Compiling syn v0.14.8
Dec 01 00:17:51.260 INFO [stderr]    Compiling env_logger v0.5.12
Dec 01 00:18:06.391 INFO [stderr]    Compiling synstructure v0.9.0
Dec 01 00:18:06.392 INFO [stderr]    Compiling serde_derive v1.0.71
Dec 01 00:18:06.392 INFO [stderr]    Compiling structopt-derive v0.2.10
Dec 01 00:18:15.831 INFO [stderr]    Compiling failure_derive v0.1.2
Dec 01 00:18:16.848 INFO [stderr]    Compiling structopt v0.2.10
Dec 01 00:18:20.515 INFO [stderr]    Compiling failure v0.1.2
Dec 01 00:18:31.392 INFO [stderr]    Compiling ipnetwork v0.13.0
Dec 01 00:18:32.577 INFO [stderr]    Compiling lithos v0.18.4 (/source)
Dec 01 00:18:48.215 INFO [stderr] warning: unused `#[macro_use]` import
Dec 01 00:18:48.215 INFO [stderr]   --> src/bin/lithos_crypt.rs:10:1
Dec 01 00:18:48.215 INFO [stderr]    |
Dec 01 00:18:48.215 INFO [stderr] 10 | #[macro_use] extern crate structopt;
Dec 01 00:18:48.215 INFO [stderr]    | ^^^^^^^^^^^^
Dec 01 00:18:48.215 INFO [stderr]    |
Dec 01 00:18:48.215 INFO [stderr]    = note: #[warn(unused_imports)] on by default
Dec 01 00:18:48.215 INFO [stderr] 
Dec 01 00:19:32.907 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 2m 21s
Dec 01 00:19:32.930 INFO [stderr] su: No module specific data is present
Dec 01 00:19:33.987 INFO running `"docker" "inspect" "a3b180680cc59b8b599ca88ec732943cd5675bbbefdb0dfc6c7a929f471d0596"`
Dec 01 00:19:34.306 INFO running `"docker" "rm" "-f" "a3b180680cc59b8b599ca88ec732943cd5675bbbefdb0dfc6c7a929f471d0596"`
Dec 01 00:19:34.614 INFO [stdout] a3b180680cc59b8b599ca88ec732943cd5675bbbefdb0dfc6c7a929f471d0596
Dec 01 00:19:34.620 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/beta-1.31-5/worker-1/1.30.1:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-1/beta-1.31-5/1.30.1:/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 +1.30.1 test --frozen --no-run" "-e" "CARGO_TARGET_DIR=/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/cargo-home" "-e" "RUSTUP_HOME=/rustup-home" "-m" "1536M" "--network" "none" "crater"`
Dec 01 00:19:35.075 INFO [stdout] 3777ab83a4f56305fa6c87d2ec2d41ae74bbcb794f14c3eadc7d77fed8ac34c9
Dec 01 00:19:35.081 INFO running `"docker" "start" "-a" "3777ab83a4f56305fa6c87d2ec2d41ae74bbcb794f14c3eadc7d77fed8ac34c9"`
Dec 01 00:19:36.416 INFO [stderr] usermod: no changes
Dec 01 00:19:36.699 INFO [stderr]    Compiling lithos v0.18.4 (/source)
Dec 01 00:19:49.987 INFO [stderr] warning: unused `#[macro_use]` import
Dec 01 00:19:49.987 INFO [stderr]   --> src/bin/lithos_crypt.rs:10:1
Dec 01 00:19:49.987 INFO [stderr]    |
Dec 01 00:19:49.987 INFO [stderr] 10 | #[macro_use] extern crate structopt;
Dec 01 00:19:49.987 INFO [stderr]    | ^^^^^^^^^^^^
Dec 01 00:19:49.987 INFO [stderr]    |
Dec 01 00:19:49.988 INFO [stderr]    = note: #[warn(unused_imports)] on by default
Dec 01 00:19:49.988 INFO [stderr] 
Dec 01 00:19:57.058 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 20.60s
Dec 01 00:19:57.092 INFO [stderr] su: No module specific data is present
Dec 01 00:19:58.763 INFO running `"docker" "inspect" "3777ab83a4f56305fa6c87d2ec2d41ae74bbcb794f14c3eadc7d77fed8ac34c9"`
Dec 01 00:19:59.137 INFO running `"docker" "rm" "-f" "3777ab83a4f56305fa6c87d2ec2d41ae74bbcb794f14c3eadc7d77fed8ac34c9"`
Dec 01 00:19:59.447 INFO [stdout] 3777ab83a4f56305fa6c87d2ec2d41ae74bbcb794f14c3eadc7d77fed8ac34c9
Dec 01 00:19:59.451 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/beta-1.31-5/worker-1/1.30.1:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-1/beta-1.31-5/1.30.1:/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 +1.30.1 test --frozen" "-e" "CARGO_TARGET_DIR=/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=warn" "-e" "CARGO_HOME=/cargo-home" "-e" "RUSTUP_HOME=/rustup-home" "-m" "1536M" "--network" "none" "crater"`
Dec 01 00:19:59.852 INFO [stdout] 3762b7108f9d0e4c6a325213636e12a7b6c6e88071acf781c85b9123d9f5d1a6
Dec 01 00:19:59.855 INFO running `"docker" "start" "-a" "3762b7108f9d0e4c6a325213636e12a7b6c6e88071acf781c85b9123d9f5d1a6"`
Dec 01 00:20:01.851 INFO [stderr] usermod: no changes
Dec 01 00:20:02.059 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.18s
Dec 01 00:20:02.077 INFO [stderr]      Running /target/debug/deps/lithos-2d846c4783aecef7
Dec 01 00:20:02.087 INFO [stdout] 
Dec 01 00:20:02.088 INFO [stdout] running 16 tests
Dec 01 00:20:02.088 INFO [stdout] test child_config::test::dedeserialize_vars ... ok
Dec 01 00:20:02.088 INFO [stdout] test child_config::test::serialize_compat ... ok
Dec 01 00:20:02.089 INFO [stdout] test container_config::test::correct_name ... ok
Dec 01 00:20:02.089 INFO [stdout] test child_config::test::deserialize_compat ... ok
Dec 01 00:20:02.089 INFO [stdout] test container_config::test::just_var ... ok
Dec 01 00:20:02.095 INFO [stdout] test nacl::test::test_box_edwards_seal ... ok
Dec 01 00:20:02.103 INFO [stdout] test nacl::test::curve_roundtrip ... ok
Dec 01 00:20:02.103 INFO [stdout] test child_config::test::serialize_vars ... ok
Dec 01 00:20:02.104 INFO [stdout] test container_config::test::two_vars ... ok
Dec 01 00:20:02.104 INFO [stdout] test container_config::test::suffix ... ok
Dec 01 00:20:02.104 INFO [stdout] test container_config::test::prefix ... ok
Dec 01 00:20:02.104 INFO [stdout] test container_config::test::middle ... ok
Dec 01 00:20:02.115 INFO [stdout] test nacl::test::test_nacl_secretbox_vectors ... ok
Dec 01 00:20:02.116 INFO [stdout] test nacl::test::test_nacl_box_vectors ... ok
Dec 01 00:20:02.116 INFO [stdout] test nacl::test::test_box_seal ... ok
Dec 01 00:20:02.116 INFO [stdout] test nacl::test::curve_roundtrip2 ... ok
Dec 01 00:20:02.117 INFO [stdout] 
Dec 01 00:20:02.117 INFO [stdout] test result: ok. 16 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 01 00:20:02.117 INFO [stdout] 
Dec 01 00:20:02.118 INFO [stderr]      Running /target/debug/deps/lithos_check-0e5c5583dac7f934
Dec 01 00:20:02.131 INFO [stdout] 
Dec 01 00:20:02.132 INFO [stdout] running 0 tests
Dec 01 00:20:02.132 INFO [stdout] 
Dec 01 00:20:02.132 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 01 00:20:02.133 INFO [stdout] 
Dec 01 00:20:02.135 INFO [stdout] 
Dec 01 00:20:02.135 INFO [stderr]      Running /target/debug/deps/lithos_clean-02b9710880e881a2
Dec 01 00:20:02.136 INFO [stdout] running 0 tests
Dec 01 00:20:02.136 INFO [stderr]      Running /target/debug/deps/lithos_cmd-d3780f92eacb1b77
Dec 01 00:20:02.136 INFO [stdout] 
Dec 01 00:20:02.137 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 01 00:20:02.137 INFO [stdout] 
Dec 01 00:20:02.137 INFO [stdout] 
Dec 01 00:20:02.138 INFO [stdout] running 0 tests
Dec 01 00:20:02.138 INFO [stdout] 
Dec 01 00:20:02.139 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 01 00:20:02.139 INFO [stdout] 
Dec 01 00:20:02.145 INFO [stderr]      Running /target/debug/deps/lithos_crypt-1ae93d7c32c03da5
Dec 01 00:20:02.148 INFO [stderr]      Running /target/debug/deps/lithos_knot-6e886dfec5ad1c71
Dec 01 00:20:02.148 INFO [stdout] 
Dec 01 00:20:02.148 INFO [stderr]      Running /target/debug/deps/lithos_ps-0c3db1ecebc7f7b4
Dec 01 00:20:02.149 INFO [stdout] running 0 tests
Dec 01 00:20:02.149 INFO [stdout] 
Dec 01 00:20:02.149 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 01 00:20:02.150 INFO [stdout] 
Dec 01 00:20:02.150 INFO [stdout] 
Dec 01 00:20:02.150 INFO [stdout] running 0 tests
Dec 01 00:20:02.151 INFO [stdout] 
Dec 01 00:20:02.151 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 01 00:20:02.152 INFO [stdout] 
Dec 01 00:20:02.152 INFO [stdout] 
Dec 01 00:20:02.153 INFO [stdout] running 2 tests
Dec 01 00:20:02.153 INFO [stdout] test ascii::test::test_many_nodes ... ok
Dec 01 00:20:02.156 INFO [stdout] test ascii::test::test_one_node ... ok
Dec 01 00:20:02.156 INFO [stderr]      Running /target/debug/deps/lithos_switch-8439ddce920051a6
Dec 01 00:20:02.157 INFO [stdout] 
Dec 01 00:20:02.157 INFO [stdout] test result: ok. 2 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 01 00:20:02.157 INFO [stdout] 
Dec 01 00:20:02.163 INFO [stdout] 
Dec 01 00:20:02.164 INFO [stderr]      Running /target/debug/deps/lithos_tree-d4b3c5630eb0fc15
Dec 01 00:20:02.164 INFO [stdout] running 0 tests
Dec 01 00:20:02.164 INFO [stdout] 
Dec 01 00:20:02.165 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 01 00:20:02.165 INFO [stdout] 
Dec 01 00:20:02.168 INFO [stdout] 
Dec 01 00:20:02.169 INFO [stderr]    Doc-tests lithos
Dec 01 00:20:02.169 INFO [stdout] running 0 tests
Dec 01 00:20:02.169 INFO [stdout] 
Dec 01 00:20:02.170 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 01 00:20:02.170 INFO [stdout] 
Dec 01 00:20:05.201 INFO [stdout] 
Dec 01 00:20:05.201 INFO [stdout] running 0 tests
Dec 01 00:20:05.203 INFO [stdout] 
Dec 01 00:20:05.203 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 01 00:20:05.203 INFO [stdout] 
Dec 01 00:20:05.218 INFO [stderr] su: No module specific data is present
Dec 01 00:20:05.935 INFO running `"docker" "inspect" "3762b7108f9d0e4c6a325213636e12a7b6c6e88071acf781c85b9123d9f5d1a6"`
Dec 01 00:20:06.245 INFO running `"docker" "rm" "-f" "3762b7108f9d0e4c6a325213636e12a7b6c6e88071acf781c85b9123d9f5d1a6"`
Dec 01 00:20:06.523 INFO [stdout] 3762b7108f9d0e4c6a325213636e12a7b6c6e88071acf781c85b9123d9f5d1a6
