Dec 15 11:53:46.872 INFO testing google-datastore1_beta3-1.0.8+20181002 against try#aa49d8ef14939ddec0e34b346b60174a5673d48f for pr-56550 Dec 15 11:53:46.872 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-7/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-7/pr-56550/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/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 +aa49d8ef14939ddec0e34b346b60174a5673d48f-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 15 11:53:47.420 INFO [stdout] 1bd9c8897beecd6d4f7d0282f454f885bbb6eef7421e11e33a44ca61529402ba Dec 15 11:53:47.422 INFO running `"docker" "start" "-a" "1bd9c8897beecd6d4f7d0282f454f885bbb6eef7421e11e33a44ca61529402ba"` Dec 15 11:53:49.143 INFO [stderr] usermod: no changes Dec 15 11:53:49.352 INFO [stderr] Compiling google-datastore1_beta3 v1.0.8+20181002 (/source) Dec 15 11:53:57.876 INFO [stderr] Finished dev [unoptimized + debuginfo] target(s) in 8.71s Dec 15 11:53:57.888 INFO [stderr] su: No module specific data is present Dec 15 11:53:58.955 INFO running `"docker" "inspect" "1bd9c8897beecd6d4f7d0282f454f885bbb6eef7421e11e33a44ca61529402ba"` Dec 15 11:53:59.259 INFO running `"docker" "rm" "-f" "1bd9c8897beecd6d4f7d0282f454f885bbb6eef7421e11e33a44ca61529402ba"` Dec 15 11:53:59.579 INFO [stdout] 1bd9c8897beecd6d4f7d0282f454f885bbb6eef7421e11e33a44ca61529402ba Dec 15 11:53:59.584 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-7/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-7/pr-56550/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/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 +aa49d8ef14939ddec0e34b346b60174a5673d48f-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 15 11:53:59.975 INFO [stdout] b37c3029d3c0af3bdf6092cc9d04f34f8ebadb000750c7119b88e63e12b1f06d Dec 15 11:53:59.977 INFO running `"docker" "start" "-a" "b37c3029d3c0af3bdf6092cc9d04f34f8ebadb000750c7119b88e63e12b1f06d"` Dec 15 11:54:01.563 INFO [stderr] usermod: no changes Dec 15 11:54:01.787 INFO [stderr] Compiling google-datastore1_beta3 v1.0.8+20181002 (/source) Dec 15 11:54:09.492 INFO [stderr] Finished dev [unoptimized + debuginfo] target(s) in 7.91s Dec 15 11:54:09.507 INFO [stderr] su: No module specific data is present Dec 15 11:54:10.866 INFO running `"docker" "inspect" "b37c3029d3c0af3bdf6092cc9d04f34f8ebadb000750c7119b88e63e12b1f06d"` Dec 15 11:54:11.240 INFO running `"docker" "rm" "-f" "b37c3029d3c0af3bdf6092cc9d04f34f8ebadb000750c7119b88e63e12b1f06d"` Dec 15 11:54:11.675 INFO [stdout] b37c3029d3c0af3bdf6092cc9d04f34f8ebadb000750c7119b88e63e12b1f06d Dec 15 11:54:11.683 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-7/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-7/pr-56550/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/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 +aa49d8ef14939ddec0e34b346b60174a5673d48f-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 15 11:54:12.186 INFO [stdout] f5b1e2d8bf8cfb747563762cf5c331e50359624240b8c1300c496d4905731dba Dec 15 11:54:12.188 INFO running `"docker" "start" "-a" "f5b1e2d8bf8cfb747563762cf5c331e50359624240b8c1300c496d4905731dba"` Dec 15 11:54:14.086 INFO [stderr] usermod: no changes Dec 15 11:54:14.375 INFO [stderr] Finished dev [unoptimized + debuginfo] target(s) in 0.27s Dec 15 11:54:14.390 INFO [stderr] Running /target/debug/deps/google_datastore1_beta3-023bfc2e2f000ffd Dec 15 11:54:14.398 INFO [stdout] Dec 15 11:54:14.398 INFO [stdout] running 0 tests Dec 15 11:54:14.398 INFO [stdout] Dec 15 11:54:14.398 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out Dec 15 11:54:14.398 INFO [stdout] Dec 15 11:54:14.399 INFO [stderr] Doc-tests google-datastore1_beta3 Dec 15 11:54:22.005 INFO [stdout] Dec 15 11:54:22.005 INFO [stdout] running 11 tests Dec 15 11:54:22.035 INFO [stdout] test src/lib.rs - (line 49) ... ignored Dec 15 11:55:22.015 INFO [stdout] test src/lib.rs - Datastore (line 268) ... test src/lib.rs - Datastore (line 268) has been running for over 60 seconds Dec 15 11:55:22.015 INFO [stdout] test src/lib.rs - ProjectAllocateIdCall (line 2604) ... test src/lib.rs - ProjectAllocateIdCall (line 2604) has been running for over 60 seconds Dec 15 11:55:22.016 INFO [stdout] test src/lib.rs - (line 79) ... test src/lib.rs - (line 79) has been running for over 60 seconds Dec 15 11:55:22.043 INFO [stdout] test src/lib.rs - ProjectCommitCall (line 2325) ... test src/lib.rs - ProjectCommitCall (line 2325) has been running for over 60 seconds Dec 15 11:55:22.043 INFO [stdout] test src/lib.rs - ProjectMethods (line 1303) ... test src/lib.rs - ProjectMethods (line 1303) has been running for over 60 seconds Dec 15 11:55:22.043 INFO [stdout] test src/lib.rs - ProjectLookupCall (line 2046) ... test src/lib.rs - ProjectLookupCall (line 2046) has been running for over 60 seconds Dec 15 11:55:22.043 INFO [stdout] test src/lib.rs - ProjectReserveIdCall (line 1768) ... test src/lib.rs - ProjectReserveIdCall (line 1768) has been running for over 60 seconds Dec 15 11:55:22.043 INFO [stdout] test src/lib.rs - ProjectBeginTransactionCall (line 3160) ... test src/lib.rs - ProjectBeginTransactionCall (line 3160) has been running for over 60 seconds Dec 15 11:55:29.331 INFO [stdout] test src/lib.rs - (line 79) ... ok Dec 15 11:55:29.655 INFO [stdout] test src/lib.rs - ProjectAllocateIdCall (line 2604) ... ok Dec 15 11:55:29.943 INFO [stdout] test src/lib.rs - ProjectBeginTransactionCall (line 3160) ... ok Dec 15 11:55:30.085 INFO [stdout] test src/lib.rs - ProjectMethods (line 1303) ... ok Dec 15 11:55:30.299 INFO [stdout] test src/lib.rs - Datastore (line 268) ... ok Dec 15 11:55:30.344 INFO [stdout] test src/lib.rs - ProjectLookupCall (line 2046) ... ok Dec 15 11:55:30.371 INFO [stdout] test src/lib.rs - ProjectReserveIdCall (line 1768) ... ok Dec 15 11:55:30.442 INFO [stdout] test src/lib.rs - ProjectCommitCall (line 2325) ... ok Dec 15 11:55:46.175 INFO [stdout] test src/lib.rs - ProjectRollbackCall (line 2882) ... ok Dec 15 11:55:46.453 INFO [stdout] test src/lib.rs - ProjectRunQueryCall (line 1489) ... ok Dec 15 11:55:46.453 INFO [stdout] Dec 15 11:55:46.454 INFO [stdout] test result: ok. 10 passed; 0 failed; 1 ignored; 0 measured; 0 filtered out Dec 15 11:55:46.454 INFO [stdout] Dec 15 11:55:46.503 INFO [stderr] su: No module specific data is present Dec 15 11:55:47.727 INFO running `"docker" "inspect" "f5b1e2d8bf8cfb747563762cf5c331e50359624240b8c1300c496d4905731dba"` Dec 15 11:55:48.159 INFO running `"docker" "rm" "-f" "f5b1e2d8bf8cfb747563762cf5c331e50359624240b8c1300c496d4905731dba"` Dec 15 11:55:48.515 INFO [stdout] f5b1e2d8bf8cfb747563762cf5c331e50359624240b8c1300c496d4905731dba