Dec 15 12:36:09.144 INFO testing google-appengine1_beta4-1.0.8+20181005 against master#bd47d6825bf4090517549d33cfef10d3300b4a75 for pr-56550
Dec 15 12:36:09.144 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-6/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-6/pr-56550/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/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 +bd47d6825bf4090517549d33cfef10d3300b4a75-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 12:36:09.363 INFO [stdout] 0d8d4a6d0272aa5b3de801410dd9ff0392e94cf32852f7fb51954176d0f02b44
Dec 15 12:36:09.365 INFO running `"docker" "start" "-a" "0d8d4a6d0272aa5b3de801410dd9ff0392e94cf32852f7fb51954176d0f02b44"`
Dec 15 12:36:09.874 INFO [stderr] usermod: no changes
Dec 15 12:36:10.025 INFO [stderr]    Compiling google-appengine1_beta4 v1.0.8+20181005 (/source)
Dec 15 12:36:19.452 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 9.56s
Dec 15 12:36:19.467 INFO [stderr] su: No module specific data is present
Dec 15 12:36:20.075 INFO running `"docker" "inspect" "0d8d4a6d0272aa5b3de801410dd9ff0392e94cf32852f7fb51954176d0f02b44"`
Dec 15 12:36:20.419 INFO running `"docker" "rm" "-f" "0d8d4a6d0272aa5b3de801410dd9ff0392e94cf32852f7fb51954176d0f02b44"`
Dec 15 12:36:20.778 INFO [stdout] 0d8d4a6d0272aa5b3de801410dd9ff0392e94cf32852f7fb51954176d0f02b44
Dec 15 12:36:20.791 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-6/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-6/pr-56550/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/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 +bd47d6825bf4090517549d33cfef10d3300b4a75-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 12:36:21.367 INFO [stdout] 6927c7f9de67f95ddc6be4e71eb555784fd08875591a524d692aee8be8478f5b
Dec 15 12:36:21.369 INFO running `"docker" "start" "-a" "6927c7f9de67f95ddc6be4e71eb555784fd08875591a524d692aee8be8478f5b"`
Dec 15 12:36:23.745 INFO [stderr] usermod: no changes
Dec 15 12:36:24.071 INFO [stderr]    Compiling google-appengine1_beta4 v1.0.8+20181005 (/source)
Dec 15 12:36:32.739 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 8.95s
Dec 15 12:36:32.759 INFO [stderr] su: No module specific data is present
Dec 15 12:36:33.960 INFO running `"docker" "inspect" "6927c7f9de67f95ddc6be4e71eb555784fd08875591a524d692aee8be8478f5b"`
Dec 15 12:36:34.371 INFO running `"docker" "rm" "-f" "6927c7f9de67f95ddc6be4e71eb555784fd08875591a524d692aee8be8478f5b"`
Dec 15 12:36:34.759 INFO [stdout] 6927c7f9de67f95ddc6be4e71eb555784fd08875591a524d692aee8be8478f5b
Dec 15 12:36:34.767 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-6/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-6/pr-56550/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/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 +bd47d6825bf4090517549d33cfef10d3300b4a75-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 12:36:35.161 INFO [stdout] 9da29a9c8c7bfcb3c0a7799964cc9bec7fa2045103f853ceafc00d17c4d0c2d1
Dec 15 12:36:35.164 INFO running `"docker" "start" "-a" "9da29a9c8c7bfcb3c0a7799964cc9bec7fa2045103f853ceafc00d17c4d0c2d1"`
Dec 15 12:36:37.419 INFO [stderr] usermod: no changes
Dec 15 12:36:37.620 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.18s
Dec 15 12:36:37.629 INFO [stderr]      Running /target/debug/deps/google_appengine1_beta4-efc263e7ef1723ba
Dec 15 12:36:37.631 INFO [stdout] 
Dec 15 12:36:37.631 INFO [stdout] running 0 tests
Dec 15 12:36:37.631 INFO [stdout] 
Dec 15 12:36:37.631 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 15 12:36:37.631 INFO [stdout] 
Dec 15 12:36:37.635 INFO [stderr]    Doc-tests google-appengine1_beta4
Dec 15 12:36:45.699 INFO [stdout] 
Dec 15 12:36:45.699 INFO [stdout] running 24 tests
Dec 15 12:36:45.699 INFO [stdout] test src/lib.rs -  (line 49) ... ignored
Dec 15 12:37:39.333 INFO [stdout] test src/lib.rs - AppGetCall (line 4151) ... ok
Dec 15 12:37:39.605 INFO [stdout] test src/lib.rs - AppLocationListCall (line 5479) ... ok
Dec 15 12:37:41.220 INFO [stdout] test src/lib.rs -  (line 88) ... ok
Dec 15 12:37:41.475 INFO [stdout] test src/lib.rs - AppModuleDeleteCall (line 4410) ... ok
Dec 15 12:37:42.490 INFO [stdout] test src/lib.rs - AppMethods (line 1410) ... ok
Dec 15 12:37:42.871 INFO [stdout] test src/lib.rs - AppLocationGetCall (line 5220) ... ok
Dec 15 12:37:43.116 INFO [stdout] test src/lib.rs - AppModuleGetCall (line 2199) ... ok
Dec 15 12:37:45.319 INFO [stdout] test src/lib.rs - AppCreateCall (line 3014) ... ok
Dec 15 12:38:39.343 INFO [stdout] test src/lib.rs - AppModuleListCall (line 2741) ... test src/lib.rs - AppModuleListCall (line 2741) has been running for over 60 seconds
Dec 15 12:38:39.623 INFO [stdout] test src/lib.rs - AppModulePatchCall (line 1885) ... test src/lib.rs - AppModulePatchCall (line 1885) has been running for over 60 seconds
Dec 15 12:38:39.747 INFO [stdout] test src/lib.rs - AppModulePatchCall (line 1885) ... ok
Dec 15 12:38:39.936 INFO [stdout] test src/lib.rs - AppModuleVersionGetCall (line 6924) ... ok
Dec 15 12:38:40.779 INFO [stdout] test src/lib.rs - AppModuleVersionCreateCall (line 6634) ... ok
Dec 15 12:38:41.487 INFO [stdout] test src/lib.rs - AppModuleVersionDeleteCall (line 6363) ... test src/lib.rs - AppModuleVersionDeleteCall (line 6363) has been running for over 60 seconds
Dec 15 12:38:42.883 INFO [stdout] test src/lib.rs - AppModuleVersionInstanceDebugCall (line 3837) ... test src/lib.rs - AppModuleVersionInstanceDebugCall (line 3837) has been running for over 60 seconds
Dec 15 12:38:43.123 INFO [stdout] test src/lib.rs - AppModuleVersionInstanceDeleteCall (line 3554) ... test src/lib.rs - AppModuleVersionInstanceDeleteCall (line 3554) has been running for over 60 seconds
Dec 15 12:38:43.949 INFO [stdout] test src/lib.rs - AppModuleListCall (line 2741) ... ok
Dec 15 12:38:45.323 INFO [stdout] test src/lib.rs - AppModuleVersionInstanceGetCall (line 2458) ... test src/lib.rs - AppModuleVersionInstanceGetCall (line 2458) has been running for over 60 seconds
Dec 15 12:38:46.632 INFO [stdout] test src/lib.rs - AppModuleVersionInstanceDebugCall (line 3837) ... ok
Dec 15 12:38:46.971 INFO [stdout] test src/lib.rs - AppModuleVersionDeleteCall (line 6363) ... ok
Dec 15 12:38:49.310 INFO [stdout] test src/lib.rs - AppModuleVersionInstanceGetCall (line 2458) ... ok
Dec 15 12:38:50.346 INFO [stdout] test src/lib.rs - AppModuleVersionInstanceDeleteCall (line 3554) ... ok
Dec 15 12:39:32.919 INFO [stdout] test src/lib.rs - AppModuleVersionInstanceListCall (line 3259) ... ok
Dec 15 12:39:34.292 INFO [stdout] test src/lib.rs - AppModuleVersionPatchCall (line 5766) ... ok
Dec 15 12:39:36.799 INFO [stdout] test src/lib.rs - AppModuleVersionListCall (line 7207) ... ok
Dec 15 12:39:39.463 INFO [stdout] test src/lib.rs - AppOperationGetCall (line 4961) ... ok
Dec 15 12:39:40.309 INFO [stdout] test src/lib.rs - AppPatchCall (line 4671) ... ok
Dec 15 12:39:40.430 INFO [stdout] test src/lib.rs - Appengine (line 283) ... ok
Dec 15 12:39:40.732 INFO [stdout] test src/lib.rs - AppOperationListCall (line 6080) ... ok
Dec 15 12:39:40.732 INFO [stdout] 
Dec 15 12:39:40.732 INFO [stdout] test result: ok. 23 passed; 0 failed; 1 ignored; 0 measured; 0 filtered out
Dec 15 12:39:40.732 INFO [stdout] 
Dec 15 12:39:40.767 INFO [stderr] su: No module specific data is present
Dec 15 12:39:41.980 INFO running `"docker" "inspect" "9da29a9c8c7bfcb3c0a7799964cc9bec7fa2045103f853ceafc00d17c4d0c2d1"`
Dec 15 12:39:42.245 INFO running `"docker" "rm" "-f" "9da29a9c8c7bfcb3c0a7799964cc9bec7fa2045103f853ceafc00d17c4d0c2d1"`
Dec 15 12:39:42.611 INFO [stdout] 9da29a9c8c7bfcb3c0a7799964cc9bec7fa2045103f853ceafc00d17c4d0c2d1