Dec 02 16:08:39.296 INFO testing sonnerie-0.3.4 against 1.30.1 for beta-1.31-5
Dec 02 16:08:39.297 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/beta-1.31-5/worker-2/1.30.1:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-2/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 02 16:08:39.527 INFO [stdout] dc234fb25e131de6fb4339eddc331f25e1e38d2e52f729496039ee303c60a328
Dec 02 16:08:39.532 INFO running `"docker" "start" "-a" "dc234fb25e131de6fb4339eddc331f25e1e38d2e52f729496039ee303c60a328"`
Dec 02 16:08:40.598 INFO [stderr] usermod: no changes
Dec 02 16:08:40.799 INFO [stderr]    Compiling escape_string v0.1.1
Dec 02 16:08:40.811 INFO [stderr]    Compiling range v0.3.1
Dec 02 16:08:40.811 INFO [stderr]    Compiling intrusive-collections v0.7.8
Dec 02 16:08:40.825 INFO [stderr]    Compiling daemonize v0.3.0
Dec 02 16:08:40.825 INFO [stderr]    Compiling rusqlite v0.14.0
Dec 02 16:08:42.013 INFO [stderr]    Compiling sonnerie-api v0.3.0
Dec 02 16:08:45.348 INFO [stderr]    Compiling sonnerie v0.3.4 (/source)
Dec 02 16:08:55.163 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 14.53s
Dec 02 16:08:55.171 INFO [stderr] su: No module specific data is present
Dec 02 16:08:56.347 INFO running `"docker" "inspect" "dc234fb25e131de6fb4339eddc331f25e1e38d2e52f729496039ee303c60a328"`
Dec 02 16:08:56.622 INFO running `"docker" "rm" "-f" "dc234fb25e131de6fb4339eddc331f25e1e38d2e52f729496039ee303c60a328"`
Dec 02 16:08:56.867 INFO [stdout] dc234fb25e131de6fb4339eddc331f25e1e38d2e52f729496039ee303c60a328
Dec 02 16:08:56.873 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/beta-1.31-5/worker-2/1.30.1:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-2/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 02 16:08:57.411 INFO [stdout] cf670e329f613017eac1be77e268aaeebd81a22875452f269970718f3558ed4e
Dec 02 16:08:57.416 INFO running `"docker" "start" "-a" "cf670e329f613017eac1be77e268aaeebd81a22875452f269970718f3558ed4e"`
Dec 02 16:08:58.690 INFO [stderr] usermod: no changes
Dec 02 16:08:58.839 INFO [stderr]    Compiling sonnerie v0.3.4 (/source)
Dec 02 16:09:08.971 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 10.26s
Dec 02 16:09:08.980 INFO [stderr] su: No module specific data is present
Dec 02 16:09:09.990 INFO running `"docker" "inspect" "cf670e329f613017eac1be77e268aaeebd81a22875452f269970718f3558ed4e"`
Dec 02 16:09:10.299 INFO running `"docker" "rm" "-f" "cf670e329f613017eac1be77e268aaeebd81a22875452f269970718f3558ed4e"`
Dec 02 16:09:10.703 INFO [stdout] cf670e329f613017eac1be77e268aaeebd81a22875452f269970718f3558ed4e
Dec 02 16:09:10.711 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/beta-1.31-5/worker-2/1.30.1:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-2/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 02 16:09:11.287 INFO [stdout] 90900e5c670623ac80c29e11cdd50219303151470abc78381938e773c6a08212
Dec 02 16:09:11.289 INFO running `"docker" "start" "-a" "90900e5c670623ac80c29e11cdd50219303151470abc78381938e773c6a08212"`
Dec 02 16:09:12.926 INFO [stderr] usermod: no changes
Dec 02 16:09:13.107 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.14s
Dec 02 16:09:13.119 INFO [stderr]      Running /target/debug/deps/sonnerie-c73ce63464df421a
Dec 02 16:09:13.119 INFO [stdout] 
Dec 02 16:09:13.119 INFO [stdout] running 33 tests
Dec 02 16:09:13.203 INFO [stdout] test db::tests::backwards_two ... ok
Dec 02 16:09:13.255 INFO [stdout] test db::tests::dbmeta1 ... ok
Dec 02 16:09:13.279 INFO [stdout] test db::tests::backwards_break ... ok
Dec 02 16:09:13.295 INFO [stdout] test db::tests::blocks_exact_file ... ok
Dec 02 16:09:13.383 INFO [stdout] test db::tests::block_overflows ... ok
Dec 02 16:09:13.412 INFO [stdout] test db::tests::discard_disk_wal ... ok
Dec 02 16:09:13.462 INFO [stdout] test db::tests::duplicate_at_once ... ok
Dec 02 16:09:13.503 INFO [stdout] test db::tests::duplicate_seq ... ok
Dec 02 16:09:13.517 INFO [stdout] test db::tests::backwards_illegal ... ok
Dec 02 16:09:13.519 INFO [stdout] test db::tests::dump_some ... ok
Dec 02 16:09:13.551 INFO [stdout] test db::tests::erase_ranges2 ... ok
Dec 02 16:09:13.557 INFO [stdout] test db::tests::erase_ranges1 ... ok
Dec 02 16:09:13.611 INFO [stdout] test db::tests::erase_ranges4 ... ok
Dec 02 16:09:13.647 INFO [stdout] test db::tests::erase_ranges3 ... ok
Dec 02 16:09:13.675 INFO [stdout] test db::tests::erase_ranges5 ... ok
Dec 02 16:09:13.690 INFO [stdout] test db::tests::insertion_bulk ... ok
Dec 02 16:09:13.739 INFO [stdout] test db::tests::generation_increases ... ok
Dec 02 16:09:13.783 INFO [stdout] test db::tests::select_weird_ranges ... ok
Dec 02 16:09:13.875 INFO [stdout] test db::tests::restart_offset ... ok
Dec 02 16:09:13.911 INFO [stdout] test db::tests::save_disk_wal ... ok
Dec 02 16:09:13.995 INFO [stdout] test db::tests::two_series ... ok
Dec 02 16:09:14.003 INFO [stdout] test metadata::tests::timestamp_range ... ok
Dec 02 16:09:14.008 INFO [stdout] test wal::tests::rw1 ... ok
Dec 02 16:09:14.019 INFO [stdout] test wal::tests::rw2 ... ok
Dec 02 16:09:14.019 INFO [stdout] test db::tests::stored_offset ... ok
Dec 02 16:09:14.039 INFO [stdout] test wal::tests::rw3 ... ok
Dec 02 16:09:14.039 INFO [stdout] test wal::tests::wal_overlap ... ok
Dec 02 16:09:14.103 INFO [stdout] test db::tests::write_should_panic ... ok
Dec 02 16:09:14.111 INFO [stdout] test db::tests::two_tx ... ok
Dec 02 16:09:14.159 INFO [stdout] test db::tests::two_tx_reopen ... ok
Dec 02 16:09:14.923 INFO [stdout] test db::tests::read_direction_multi_block ... ok
Dec 02 16:10:02.347 INFO [stdout] test db::tests::boundary_crossing ... ok
Dec 02 16:10:13.131 INFO [stdout] test db::tests::boundary_crossing_bulk_load ... test db::tests::boundary_crossing_bulk_load has been running for over 60 seconds
Dec 02 16:15:13.134 ERRO error running command: no output for 300 seconds
Dec 02 16:15:13.134 INFO running `"docker" "inspect" "90900e5c670623ac80c29e11cdd50219303151470abc78381938e773c6a08212"`
Dec 02 16:15:13.515 INFO running `"docker" "rm" "-f" "90900e5c670623ac80c29e11cdd50219303151470abc78381938e773c6a08212"`
Dec 02 16:15:14.911 INFO [stdout] 90900e5c670623ac80c29e11cdd50219303151470abc78381938e773c6a08212
