Dec 07 14:42:34.254 INFO testing google-androidpublisher2-1.0.8+20181009 against try#6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468 for pr-56514
Dec 07 14:42:34.254 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-1/try#6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-1/pr-56514/try#6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468:/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 +6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468-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 14:42:34.696 INFO [stdout] 97954722803ad42797bca11db8fcb9b7b03dd3fcde5283d8ea48aa89d6d80e3d
Dec 07 14:42:34.698 INFO running `"docker" "start" "-a" "97954722803ad42797bca11db8fcb9b7b03dd3fcde5283d8ea48aa89d6d80e3d"`
Dec 07 14:42:37.367 INFO [stderr] usermod: no changes
Dec 07 14:42:37.589 INFO [stderr]    Compiling google-androidpublisher2 v1.0.8+20181009 (/source)
Dec 07 14:42:51.876 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 14.48s
Dec 07 14:42:51.884 INFO [stderr] su: No module specific data is present
Dec 07 14:42:52.848 INFO running `"docker" "inspect" "97954722803ad42797bca11db8fcb9b7b03dd3fcde5283d8ea48aa89d6d80e3d"`
Dec 07 14:42:53.264 INFO running `"docker" "rm" "-f" "97954722803ad42797bca11db8fcb9b7b03dd3fcde5283d8ea48aa89d6d80e3d"`
Dec 07 14:42:53.516 INFO [stdout] 97954722803ad42797bca11db8fcb9b7b03dd3fcde5283d8ea48aa89d6d80e3d
Dec 07 14:42:53.518 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-1/try#6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-1/pr-56514/try#6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468:/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 +6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468-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:42:53.952 INFO [stdout] 580dd194bb6a06baa6a243e38a865592348d49b7081bba4cf2eb8df47290392e
Dec 07 14:42:53.954 INFO running `"docker" "start" "-a" "580dd194bb6a06baa6a243e38a865592348d49b7081bba4cf2eb8df47290392e"`
Dec 07 14:42:56.052 INFO [stderr] usermod: no changes
Dec 07 14:42:56.350 INFO [stderr]    Compiling google-androidpublisher2 v1.0.8+20181009 (/source)
Dec 07 14:43:07.665 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 11.58s
Dec 07 14:43:07.680 INFO [stderr] su: No module specific data is present
Dec 07 14:43:08.778 INFO running `"docker" "inspect" "580dd194bb6a06baa6a243e38a865592348d49b7081bba4cf2eb8df47290392e"`
Dec 07 14:43:09.230 INFO running `"docker" "rm" "-f" "580dd194bb6a06baa6a243e38a865592348d49b7081bba4cf2eb8df47290392e"`
Dec 07 14:43:09.508 INFO [stdout] 580dd194bb6a06baa6a243e38a865592348d49b7081bba4cf2eb8df47290392e
Dec 07 14:43:09.510 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56514/worker-1/try#6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-1/pr-56514/try#6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468:/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 +6eb0fd3ac58f9b16bddb9924a17c3b6c156aa468-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:43:09.939 INFO [stdout] 7e95a138cb8c707f15a8786138326c5b3b7e1ff9e2e39e06504e7fdff93e4035
Dec 07 14:43:09.942 INFO running `"docker" "start" "-a" "7e95a138cb8c707f15a8786138326c5b3b7e1ff9e2e39e06504e7fdff93e4035"`
Dec 07 14:43:11.932 INFO [stderr] usermod: no changes
Dec 07 14:43:12.108 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.16s
Dec 07 14:43:12.140 INFO [stderr]      Running /target/debug/deps/google_androidpublisher2-539321cb86d94f4f
Dec 07 14:43:12.140 INFO [stdout] 
Dec 07 14:43:12.141 INFO [stdout] running 0 tests
Dec 07 14:43:12.141 INFO [stdout] 
Dec 07 14:43:12.141 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 07 14:43:12.141 INFO [stdout] 
Dec 07 14:43:12.141 INFO [stderr]    Doc-tests google-androidpublisher2
Dec 07 14:43:20.716 INFO [stdout] 
Dec 07 14:43:20.716 INFO [stdout] running 66 tests
Dec 07 14:43:20.803 INFO [stdout] test src/lib.rs -  (line 65) ... ignored
Dec 07 14:44:15.704 INFO [stdout] test src/lib.rs - EditApklistingDeleteallCall (line 8019) ... ok
Dec 07 14:44:20.720 INFO [stdout] test src/lib.rs - AndroidPublisher (line 284) ... test src/lib.rs - AndroidPublisher (line 284) has been running for over 60 seconds
Dec 07 14:44:20.720 INFO [stdout] test src/lib.rs -  (line 98) ... test src/lib.rs -  (line 98) has been running for over 60 seconds
Dec 07 14:44:20.736 INFO [stdout] test src/lib.rs - EditApkAddexternallyhostedCall (line 7733) ... test src/lib.rs - EditApkAddexternallyhostedCall (line 7733) has been running for over 60 seconds
Dec 07 14:44:20.736 INFO [stdout] test src/lib.rs - EditApkListCall (line 11215) ... test src/lib.rs - EditApkListCall (line 11215) has been running for over 60 seconds
Dec 07 14:44:20.744 INFO [stdout] test src/lib.rs - EditApkUploadCall (line 10543) ... test src/lib.rs - EditApkUploadCall (line 10543) has been running for over 60 seconds
Dec 07 14:44:20.760 INFO [stdout] test src/lib.rs - EditApklistingDeleteCall (line 7221) ... test src/lib.rs - EditApklistingDeleteCall (line 7221) has been running for over 60 seconds
Dec 07 14:44:20.804 INFO [stdout] test src/lib.rs - EditApklistingGetCall (line 16856) ... test src/lib.rs - EditApklistingGetCall (line 16856) has been running for over 60 seconds
Dec 07 14:44:20.936 INFO [stdout] test src/lib.rs -  (line 98) ... ok
Dec 07 14:44:21.712 INFO [stdout] test src/lib.rs - AndroidPublisher (line 284) ... ok
Dec 07 14:44:21.776 INFO [stdout] test src/lib.rs - EditApkListCall (line 11215) ... ok
Dec 07 14:44:22.375 INFO [stdout] test src/lib.rs - EditApkAddexternallyhostedCall (line 7733) ... ok
Dec 07 14:44:22.708 INFO [stdout] test src/lib.rs - EditApkUploadCall (line 10543) ... ok
Dec 07 14:44:24.525 INFO [stdout] test src/lib.rs - EditApklistingGetCall (line 16856) ... ok
Dec 07 14:44:25.625 INFO [stdout] test src/lib.rs - EditApklistingDeleteCall (line 7221) ... ok
Dec 07 14:45:11.968 INFO [stdout] test src/lib.rs - EditApklistingListCall (line 17431) ... ok
Dec 07 14:45:20.952 INFO [stdout] test src/lib.rs - EditApklistingPatchCall (line 11470) ... test src/lib.rs - EditApklistingPatchCall (line 11470) has been running for over 60 seconds
Dec 07 14:45:21.716 INFO [stdout] test src/lib.rs - EditApklistingUpdateCall (line 10907) ... test src/lib.rs - EditApklistingUpdateCall (line 10907) has been running for over 60 seconds
Dec 07 14:45:21.780 INFO [stdout] test src/lib.rs - EditBundleListCall (line 12045) ... test src/lib.rs - EditBundleListCall (line 12045) has been running for over 60 seconds
Dec 07 14:45:22.384 INFO [stdout] test src/lib.rs - EditBundleUploadCall (line 14786) ... test src/lib.rs - EditBundleUploadCall (line 14786) has been running for over 60 seconds
Dec 07 14:45:22.716 INFO [stdout] test src/lib.rs - EditCommitCall (line 13756) ... test src/lib.rs - EditCommitCall (line 13756) has been running for over 60 seconds
Dec 07 14:45:23.380 INFO [stdout] test src/lib.rs - EditDeobfuscationfileUploadCall (line 5883) ... ok
Dec 07 14:45:24.528 INFO [stdout] test src/lib.rs - EditDeleteCall (line 12300) ... test src/lib.rs - EditDeleteCall (line 12300) has been running for over 60 seconds
Dec 07 14:45:25.580 INFO [stdout] test src/lib.rs - EditBundleListCall (line 12045) ... ok
Dec 07 14:45:25.856 INFO [stdout] test src/lib.rs - EditBundleUploadCall (line 14786) ... ok
Dec 07 14:45:26.196 INFO [stdout] test src/lib.rs - EditApklistingPatchCall (line 11470) ... ok
Dec 07 14:45:26.705 INFO [stdout] test src/lib.rs - EditCommitCall (line 13756) ... ok
Dec 07 14:45:26.950 INFO [stdout] test src/lib.rs - EditApklistingUpdateCall (line 10907) ... ok
Dec 07 14:45:27.246 INFO [stdout] test src/lib.rs - EditDeleteCall (line 12300) ... ok
Dec 07 14:46:11.964 INFO [stdout] test src/lib.rs - EditDetailGetCall (line 6966) ... test src/lib.rs - EditDetailGetCall (line 6966) has been running for over 60 seconds
Dec 07 14:46:14.968 INFO [stdout] test src/lib.rs - EditDetailGetCall (line 6966) ... ok
Dec 07 14:46:23.396 INFO [stdout] test src/lib.rs - EditDetailPatchCall (line 16016) ... test src/lib.rs - EditDetailPatchCall (line 16016) has been running for over 60 seconds
Dec 07 14:46:25.580 INFO [stdout] test src/lib.rs - EditDetailUpdateCall (line 8275) ... test src/lib.rs - EditDetailUpdateCall (line 8275) has been running for over 60 seconds
Dec 07 14:46:25.856 INFO [stdout] test src/lib.rs - EditExpansionfileGetCall (line 15460) ... test src/lib.rs - EditExpansionfileGetCall (line 15460) has been running for over 60 seconds
Dec 07 14:46:25.947 INFO [stdout] test src/lib.rs - EditExpansionfileGetCall (line 15460) ... ok
Dec 07 14:46:26.216 INFO [stdout] test src/lib.rs - EditExpansionfilePatchCall (line 8828) ... test src/lib.rs - EditExpansionfilePatchCall (line 8828) has been running for over 60 seconds
Dec 07 14:46:26.708 INFO [stdout] test src/lib.rs - EditExpansionfileUpdateCall (line 6657) ... test src/lib.rs - EditExpansionfileUpdateCall (line 6657) has been running for over 60 seconds
Dec 07 14:46:26.956 INFO [stdout] test src/lib.rs - EditExpansionfileUploadCall (line 12544) ... test src/lib.rs - EditExpansionfileUploadCall (line 12544) has been running for over 60 seconds
Dec 07 14:46:27.116 INFO [stdout] test src/lib.rs - EditExpansionfilePatchCall (line 8828) ... ok
Dec 07 14:46:27.252 INFO [stdout] test src/lib.rs - EditGetCall (line 10011) ... test src/lib.rs - EditGetCall (line 10011) has been running for over 60 seconds
Dec 07 14:46:28.340 INFO [stdout] test src/lib.rs - EditDetailPatchCall (line 16016) ... ok
Dec 07 14:46:28.608 INFO [stdout] test src/lib.rs - EditGetCall (line 10011) ... ok
Dec 07 14:46:32.384 INFO [stdout] test src/lib.rs - EditExpansionfileUpdateCall (line 6657) ... ok
Dec 07 14:46:32.814 INFO [stdout] test src/lib.rs - EditExpansionfileUploadCall (line 12544) ... ok
Dec 07 14:46:33.392 INFO [stdout] test src/lib.rs - EditDetailUpdateCall (line 8275) ... ok
Dec 07 14:47:14.972 INFO [stdout] test src/lib.rs - EditImageDeleteCall (line 10266) ... test src/lib.rs - EditImageDeleteCall (line 10266) has been running for over 60 seconds
Dec 07 14:47:15.712 INFO [stdout] test src/lib.rs - EditImageDeleteCall (line 10266) ... ok
Dec 07 14:47:23.296 INFO [stdout] test src/lib.rs - EditImageListCall (line 9137) ... ok
Dec 07 14:47:24.352 INFO [stdout] test src/lib.rs - EditImageUploadCall (line 6270) ... ok
Dec 07 14:47:25.504 INFO [stdout] test src/lib.rs - EditImageDeleteallCall (line 15738) ... ok
Dec 07 14:47:28.620 INFO [stdout] test src/lib.rs - EditInsertCall (line 12931) ... test src/lib.rs - EditInsertCall (line 12931) has been running for over 60 seconds
Dec 07 14:47:29.390 INFO [stdout] test src/lib.rs - EditListingDeleteallCall (line 7489) ... ok
Dec 07 14:47:31.496 INFO [stdout] test src/lib.rs - EditListingDeleteCall (line 16600) ... ok
Dec 07 14:47:31.884 INFO [stdout] test src/lib.rs - EditInsertCall (line 12931) ... ok
Dec 07 14:47:33.404 INFO [stdout] test src/lib.rs - EditListingGetCall (line 11780) ... test src/lib.rs - EditListingGetCall (line 11780) has been running for over 60 seconds
Dec 07 14:47:33.697 INFO [stdout] test src/lib.rs - EditListingGetCall (line 11780) ... ok
Dec 07 14:48:11.572 INFO [stdout] test src/lib.rs - EditListingPatchCall (line 9713) ... ok
Dec 07 14:48:12.536 INFO [stdout] test src/lib.rs - EditListingListCall (line 13205) ... ok
Dec 07 14:48:19.489 INFO [stdout] test src/lib.rs - EditMethods (line 2004) ... ok
Dec 07 14:48:24.364 INFO [stdout] test src/lib.rs - EditListingUpdateCall (line 15162) ... test src/lib.rs - EditListingUpdateCall (line 15162) has been running for over 60 seconds
Dec 07 14:48:27.076 INFO [stdout] test src/lib.rs - EditListingUpdateCall (line 15162) ... ok
Dec 07 14:48:28.097 INFO [stdout] test src/lib.rs - EditTrackGetCall (line 8561) ... ok
Dec 07 14:48:29.236 INFO [stdout] test src/lib.rs - EditTesterGetCall (line 14264) ... ok
Dec 07 14:48:30.640 INFO [stdout] test src/lib.rs - EditTesterPatchCall (line 13458) ... ok
Dec 07 14:48:31.888 INFO [stdout] test src/lib.rs - EditTesterUpdateCall (line 17133) ... test src/lib.rs - EditTesterUpdateCall (line 17133) has been running for over 60 seconds
Dec 07 14:48:33.188 INFO [stdout] test src/lib.rs - EditTesterUpdateCall (line 17133) ... ok
Dec 07 14:49:11.568 INFO [stdout] test src/lib.rs - EditTrackListCall (line 14011) ... test src/lib.rs - EditTrackListCall (line 14011) has been running for over 60 seconds
Dec 07 14:49:12.536 INFO [stdout] test src/lib.rs - EditTrackPatchCall (line 16302) ... test src/lib.rs - EditTrackPatchCall (line 16302) has been running for over 60 seconds
Dec 07 14:49:16.158 INFO [stdout] test src/lib.rs - EditTrackListCall (line 14011) ... ok
Dec 07 14:49:16.448 INFO [stdout] test src/lib.rs - InappproductDeleteCall (line 18516) ... ok
Dec 07 14:49:17.441 INFO [stdout] test src/lib.rs - EditTrackPatchCall (line 16302) ... ok
Dec 07 14:49:19.496 INFO [stdout] test src/lib.rs - EditTrackUpdateCall (line 9415) ... test src/lib.rs - EditTrackUpdateCall (line 9415) has been running for over 60 seconds
Dec 07 14:49:19.616 INFO [stdout] test src/lib.rs - EditTrackUpdateCall (line 9415) ... ok
Dec 07 14:49:25.108 INFO [stdout] test src/lib.rs - InappproductListCall (line 17954) ... ok
Dec 07 14:49:27.084 INFO [stdout] test src/lib.rs - EditValidateCall (line 14531) ... test src/lib.rs - EditValidateCall (line 14531) has been running for over 60 seconds
Dec 07 14:49:28.341 INFO [stdout] test src/lib.rs - EditValidateCall (line 14531) ... ok
Dec 07 14:49:29.240 INFO [stdout] test src/lib.rs - InappproductGetCall (line 18760) ... test src/lib.rs - InappproductGetCall (line 18760) has been running for over 60 seconds
Dec 07 14:49:30.644 INFO [stdout] test src/lib.rs - InappproductInsertCall (line 18230) ... test src/lib.rs - InappproductInsertCall (line 18230) has been running for over 60 seconds
Dec 07 14:49:30.810 INFO [stdout] test src/lib.rs - InappproductInsertCall (line 18230) ... ok
Dec 07 14:49:31.137 INFO [stdout] test src/lib.rs - InappproductGetCall (line 18760) ... ok
Dec 07 14:50:15.940 INFO [stdout] test src/lib.rs - InappproductPatchCall (line 19312) ... ok
Dec 07 14:50:16.168 INFO [stdout] test src/lib.rs - InappproductMethods (line 2974) ... test src/lib.rs - InappproductMethods (line 2974) has been running for over 60 seconds
Dec 07 14:50:16.665 INFO [stdout] test src/lib.rs - InappproductUpdateCall (line 19014) ... ok
Dec 07 14:50:18.916 INFO [stdout] test src/lib.rs - OrderMethods (line 2912) ... ok
Dec 07 14:50:19.916 INFO [stdout] test src/lib.rs - InappproductMethods (line 2974) ... ok
Dec 07 14:50:23.012 INFO [stdout] test src/lib.rs - OrderRefundCall (line 17698) ... ok
Dec 07 14:50:28.356 INFO [stdout] test src/lib.rs - PurchaseMethods (line 1812) ... test src/lib.rs - PurchaseMethods (line 1812) has been running for over 60 seconds
Dec 07 14:50:29.231 INFO [stdout] test src/lib.rs - PurchaseProductGetCall (line 4239) ... ok
Dec 07 14:50:29.512 INFO [stdout] test src/lib.rs - PurchaseSubscriptionCancelCall (line 5073) ... ok
Dec 07 14:50:29.528 INFO [stdout] test src/lib.rs - PurchaseMethods (line 1812) ... ok
Dec 07 14:51:11.876 INFO [stdout] test src/lib.rs - PurchaseSubscriptionGetCall (line 4506) ... ok
Dec 07 14:51:12.280 INFO [stdout] test src/lib.rs - PurchaseSubscriptionRefundCall (line 5329) ... ok
Dec 07 14:51:12.856 INFO [stdout] test src/lib.rs - PurchaseSubscriptionDeferCall (line 5585) ... ok
Dec 07 14:51:18.003 INFO [stdout] test src/lib.rs - PurchaseSubscriptionRevokeCall (line 3983) ... ok
Dec 07 14:51:18.484 INFO [stdout] test src/lib.rs - ReviewGetCall (line 3431) ... ok
Dec 07 14:51:20.036 INFO [stdout] test src/lib.rs - PurchaseVoidedpurchaseListCall (line 4773) ... ok
Dec 07 14:51:20.608 INFO [stdout] test src/lib.rs - ReviewMethods (line 1708) ... ok
Dec 07 14:51:21.780 INFO [stdout] test src/lib.rs - ReviewListCall (line 3696) ... ok
Dec 07 14:51:27.911 INFO [stdout] test src/lib.rs - ReviewReplyCall (line 3146) ... ok
Dec 07 14:51:27.911 INFO [stdout] 
Dec 07 14:51:27.911 INFO [stdout] test result: ok. 65 passed; 0 failed; 1 ignored; 0 measured; 0 filtered out
Dec 07 14:51:27.911 INFO [stdout] 
Dec 07 14:51:27.954 INFO [stderr] su: No module specific data is present
Dec 07 14:51:29.271 INFO running `"docker" "inspect" "7e95a138cb8c707f15a8786138326c5b3b7e1ff9e2e39e06504e7fdff93e4035"`
Dec 07 14:51:29.628 INFO running `"docker" "rm" "-f" "7e95a138cb8c707f15a8786138326c5b3b7e1ff9e2e39e06504e7fdff93e4035"`
Dec 07 14:51:30.056 INFO [stdout] 7e95a138cb8c707f15a8786138326c5b3b7e1ff9e2e39e06504e7fdff93e4035