Dec 07 13:59:47.445 INFO testing google-datastore1_beta3-1.0.8+20181002 against master#906deae0790bd18681b937fe9a141a3c26cf1855 for pr-56514
Dec 07 13:59:47.445 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-4/master#906deae0790bd18681b937fe9a141a3c26cf1855:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-4/pr-56514/master#906deae0790bd18681b937fe9a141a3c26cf1855:/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 +906deae0790bd18681b937fe9a141a3c26cf1855-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 07 13:59:47.872 INFO [stdout] eeb7e3bd0594b802d749a22efb5e45f9c1108e7e3fbe5e8333ef096991b4b917
Dec 07 13:59:47.875 INFO running `"docker" "start" "-a" "eeb7e3bd0594b802d749a22efb5e45f9c1108e7e3fbe5e8333ef096991b4b917"`
Dec 07 13:59:49.535 INFO [stderr] usermod: no changes
Dec 07 13:59:49.805 INFO [stderr]    Compiling google-datastore1_beta3 v1.0.8+20181002 (/source)
Dec 07 13:59:57.820 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 8.26s
Dec 07 13:59:57.841 INFO [stderr] su: No module specific data is present
Dec 07 13:59:59.220 INFO running `"docker" "inspect" "eeb7e3bd0594b802d749a22efb5e45f9c1108e7e3fbe5e8333ef096991b4b917"`
Dec 07 13:59:59.524 INFO running `"docker" "rm" "-f" "eeb7e3bd0594b802d749a22efb5e45f9c1108e7e3fbe5e8333ef096991b4b917"`
Dec 07 13:59:59.876 INFO [stdout] eeb7e3bd0594b802d749a22efb5e45f9c1108e7e3fbe5e8333ef096991b4b917
Dec 07 13:59:59.884 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-4/master#906deae0790bd18681b937fe9a141a3c26cf1855:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-4/pr-56514/master#906deae0790bd18681b937fe9a141a3c26cf1855:/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 +906deae0790bd18681b937fe9a141a3c26cf1855-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 07 14:00:00.356 INFO [stdout] c34a123686f26d17cea916847fb3eef96d6cf5e20f4e343c0dec1248860e648a
Dec 07 14:00:00.358 INFO running `"docker" "start" "-a" "c34a123686f26d17cea916847fb3eef96d6cf5e20f4e343c0dec1248860e648a"`
Dec 07 14:00:02.571 INFO [stderr] usermod: no changes
Dec 07 14:00:02.812 INFO [stderr]    Compiling google-datastore1_beta3 v1.0.8+20181002 (/source)
Dec 07 14:00:10.186 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 7.59s
Dec 07 14:00:10.198 INFO [stderr] su: No module specific data is present
Dec 07 14:00:11.328 INFO running `"docker" "inspect" "c34a123686f26d17cea916847fb3eef96d6cf5e20f4e343c0dec1248860e648a"`
Dec 07 14:00:11.654 INFO running `"docker" "rm" "-f" "c34a123686f26d17cea916847fb3eef96d6cf5e20f4e343c0dec1248860e648a"`
Dec 07 14:00:11.912 INFO [stdout] c34a123686f26d17cea916847fb3eef96d6cf5e20f4e343c0dec1248860e648a
Dec 07 14:00:11.914 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-4/master#906deae0790bd18681b937fe9a141a3c26cf1855:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-4/pr-56514/master#906deae0790bd18681b937fe9a141a3c26cf1855:/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 +906deae0790bd18681b937fe9a141a3c26cf1855-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 07 14:00:12.322 INFO [stdout] b4df4661d5164b04a0cf213fff4eb63d34321ff8b5760a0bc17a236c02fb6a19
Dec 07 14:00:12.324 INFO running `"docker" "start" "-a" "b4df4661d5164b04a0cf213fff4eb63d34321ff8b5760a0bc17a236c02fb6a19"`
Dec 07 14:00:14.703 INFO [stderr] usermod: no changes
Dec 07 14:00:14.931 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.20s
Dec 07 14:00:14.962 INFO [stderr]      Running /target/debug/deps/google_datastore1_beta3-52b96729e18f7856
Dec 07 14:00:14.965 INFO [stdout] 
Dec 07 14:00:14.965 INFO [stdout] running 0 tests
Dec 07 14:00:14.965 INFO [stdout] 
Dec 07 14:00:14.966 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 07 14:00:14.966 INFO [stdout] 
Dec 07 14:00:14.966 INFO [stderr]    Doc-tests google-datastore1_beta3
Dec 07 14:00:22.339 INFO [stdout] 
Dec 07 14:00:22.339 INFO [stdout] running 11 tests
Dec 07 14:00:22.368 INFO [stdout] test src/lib.rs -  (line 49) ... ignored
Dec 07 14:01:22.339 INFO [stdout] test src/lib.rs -  (line 79) ... test src/lib.rs -  (line 79) has been running for over 60 seconds
Dec 07 14:01:22.339 INFO [stdout] test src/lib.rs - Datastore (line 268) ... test src/lib.rs - Datastore (line 268) has been running for over 60 seconds
Dec 07 14:01:22.348 INFO [stdout] test src/lib.rs - ProjectAllocateIdCall (line 2604) ... test src/lib.rs - ProjectAllocateIdCall (line 2604) has been running for over 60 seconds
Dec 07 14:01:22.349 INFO [stdout] test src/lib.rs - ProjectCommitCall (line 2325) ... test src/lib.rs - ProjectCommitCall (line 2325) has been running for over 60 seconds
Dec 07 14:01:22.349 INFO [stdout] test src/lib.rs - ProjectBeginTransactionCall (line 3160) ... test src/lib.rs - ProjectBeginTransactionCall (line 3160) has been running for over 60 seconds
Dec 07 14:01:22.364 INFO [stdout] test src/lib.rs - ProjectMethods (line 1303) ... test src/lib.rs - ProjectMethods (line 1303) has been running for over 60 seconds
Dec 07 14:01:22.365 INFO [stdout] test src/lib.rs - ProjectLookupCall (line 2046) ... test src/lib.rs - ProjectLookupCall (line 2046) has been running for over 60 seconds
Dec 07 14:01:22.372 INFO [stdout] test src/lib.rs - ProjectReserveIdCall (line 1768) ... test src/lib.rs - ProjectReserveIdCall (line 1768) has been running for over 60 seconds
Dec 07 14:01:22.906 INFO [stdout] test src/lib.rs - ProjectCommitCall (line 2325) ... ok
Dec 07 14:01:27.144 INFO [stdout] test src/lib.rs - ProjectMethods (line 1303) ... ok
Dec 07 14:01:27.656 INFO [stdout] test src/lib.rs - ProjectReserveIdCall (line 1768) ... ok
Dec 07 14:01:27.810 INFO [stdout] test src/lib.rs - ProjectLookupCall (line 2046) ... ok
Dec 07 14:01:28.788 INFO [stdout] test src/lib.rs - ProjectAllocateIdCall (line 2604) ... ok
Dec 07 14:01:29.156 INFO [stdout] test src/lib.rs -  (line 79) ... ok
Dec 07 14:01:29.588 INFO [stdout] test src/lib.rs - Datastore (line 268) ... ok
Dec 07 14:01:29.589 INFO [stdout] test src/lib.rs - ProjectBeginTransactionCall (line 3160) ... ok
Dec 07 14:01:41.232 INFO [stdout] test src/lib.rs - ProjectRollbackCall (line 2882) ... ok
Dec 07 14:01:42.044 INFO [stdout] test src/lib.rs - ProjectRunQueryCall (line 1489) ... ok
Dec 07 14:01:42.044 INFO [stdout] 
Dec 07 14:01:42.044 INFO [stdout] test result: ok. 10 passed; 0 failed; 1 ignored; 0 measured; 0 filtered out
Dec 07 14:01:42.044 INFO [stdout] 
Dec 07 14:01:42.100 INFO [stderr] su: No module specific data is present
Dec 07 14:01:43.024 INFO running `"docker" "inspect" "b4df4661d5164b04a0cf213fff4eb63d34321ff8b5760a0bc17a236c02fb6a19"`
Dec 07 14:01:43.278 INFO running `"docker" "rm" "-f" "b4df4661d5164b04a0cf213fff4eb63d34321ff8b5760a0bc17a236c02fb6a19"`
Dec 07 14:01:43.626 INFO [stdout] b4df4661d5164b04a0cf213fff4eb63d34321ff8b5760a0bc17a236c02fb6a19