Dec 15 12:39:30.048 INFO testing google-androidpublisher2-1.0.8+20181009 against try#aa49d8ef14939ddec0e34b346b60174a5673d48f for pr-56550
Dec 15 12:39:30.049 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-5/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-5/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 12:39:30.520 INFO [stdout] a6156bada8307e9e6e69b1d0b4bd6481db3f47a31ebe41ce639ae4914d7dcac0
Dec 15 12:39:30.522 INFO running `"docker" "start" "-a" "a6156bada8307e9e6e69b1d0b4bd6481db3f47a31ebe41ce639ae4914d7dcac0"`
Dec 15 12:39:33.142 INFO [stderr] usermod: no changes
Dec 15 12:39:33.482 INFO [stderr]    Compiling google-androidpublisher2 v1.0.8+20181009 (/source)
Dec 15 12:39:46.464 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 13.30s
Dec 15 12:39:46.475 INFO [stderr] su: No module specific data is present
Dec 15 12:39:47.611 INFO running `"docker" "inspect" "a6156bada8307e9e6e69b1d0b4bd6481db3f47a31ebe41ce639ae4914d7dcac0"`
Dec 15 12:39:47.971 INFO running `"docker" "rm" "-f" "a6156bada8307e9e6e69b1d0b4bd6481db3f47a31ebe41ce639ae4914d7dcac0"`
Dec 15 12:39:48.347 INFO [stdout] a6156bada8307e9e6e69b1d0b4bd6481db3f47a31ebe41ce639ae4914d7dcac0
Dec 15 12:39:48.355 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-5/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-5/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 12:39:48.771 INFO [stdout] a66b3223cebf063be2cc7c9e9db1b69cbb07708e809f51a9c95f45ecb611640e
Dec 15 12:39:48.773 INFO running `"docker" "start" "-a" "a66b3223cebf063be2cc7c9e9db1b69cbb07708e809f51a9c95f45ecb611640e"`
Dec 15 12:39:51.198 INFO [stderr] usermod: no changes
Dec 15 12:39:51.475 INFO [stderr]    Compiling google-androidpublisher2 v1.0.8+20181009 (/source)
Dec 15 12:40:02.828 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 11.59s
Dec 15 12:40:02.840 INFO [stderr] su: No module specific data is present
Dec 15 12:40:03.714 INFO running `"docker" "inspect" "a66b3223cebf063be2cc7c9e9db1b69cbb07708e809f51a9c95f45ecb611640e"`
Dec 15 12:40:04.071 INFO running `"docker" "rm" "-f" "a66b3223cebf063be2cc7c9e9db1b69cbb07708e809f51a9c95f45ecb611640e"`
Dec 15 12:40:04.451 INFO [stdout] a66b3223cebf063be2cc7c9e9db1b69cbb07708e809f51a9c95f45ecb611640e
Dec 15 12:40:04.457 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-5/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-5/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 12:40:04.949 INFO [stdout] 7f2a67ec20701035857fbed67da161515f0999c0160062c7897fb4104705f693
Dec 15 12:40:04.957 INFO running `"docker" "start" "-a" "7f2a67ec20701035857fbed67da161515f0999c0160062c7897fb4104705f693"`
Dec 15 12:40:06.115 INFO [stderr] usermod: no changes
Dec 15 12:40:06.295 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.16s
Dec 15 12:40:06.311 INFO [stderr]      Running /target/debug/deps/google_androidpublisher2-722a974868fa883d
Dec 15 12:40:06.319 INFO [stderr]    Doc-tests google-androidpublisher2
Dec 15 12:40:06.319 INFO [stdout] 
Dec 15 12:40:06.319 INFO [stdout] running 0 tests
Dec 15 12:40:06.319 INFO [stdout] 
Dec 15 12:40:06.319 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 15 12:40:06.319 INFO [stdout] 
Dec 15 12:40:14.683 INFO [stdout] 
Dec 15 12:40:14.683 INFO [stdout] running 66 tests
Dec 15 12:40:14.683 INFO [stdout] test src/lib.rs -  (line 65) ... ignored
Dec 15 12:41:14.147 INFO [stdout] test src/lib.rs - EditApkUploadCall (line 10543) ... ok
Dec 15 12:41:14.287 INFO [stdout] test src/lib.rs -  (line 98) ... ok
Dec 15 12:41:14.699 INFO [stdout] test src/lib.rs - EditApkAddexternallyhostedCall (line 7733) ... test src/lib.rs - EditApkAddexternallyhostedCall (line 7733) has been running for over 60 seconds
Dec 15 12:41:14.699 INFO [stdout] test src/lib.rs - EditApklistingDeleteCall (line 7221) ... test src/lib.rs - EditApklistingDeleteCall (line 7221) has been running for over 60 seconds
Dec 15 12:41:14.699 INFO [stdout] test src/lib.rs - EditApkListCall (line 11215) ... test src/lib.rs - EditApkListCall (line 11215) has been running for over 60 seconds
Dec 15 12:41:14.699 INFO [stdout] test src/lib.rs - EditApklistingGetCall (line 16856) ... test src/lib.rs - EditApklistingGetCall (line 16856) has been running for over 60 seconds
Dec 15 12:41:14.699 INFO [stdout] test src/lib.rs - EditApklistingDeleteallCall (line 8019) ... test src/lib.rs - EditApklistingDeleteallCall (line 8019) has been running for over 60 seconds
Dec 15 12:41:14.699 INFO [stdout] test src/lib.rs - AndroidPublisher (line 284) ... test src/lib.rs - AndroidPublisher (line 284) has been running for over 60 seconds
Dec 15 12:41:14.795 INFO [stdout] test src/lib.rs - EditApklistingDeleteallCall (line 8019) ... ok
Dec 15 12:41:15.775 INFO [stdout] test src/lib.rs - EditApklistingDeleteCall (line 7221) ... ok
Dec 15 12:41:16.220 INFO [stdout] test src/lib.rs - EditApklistingGetCall (line 16856) ... ok
Dec 15 12:41:18.095 INFO [stdout] test src/lib.rs - EditApkListCall (line 11215) ... ok
Dec 15 12:41:19.347 INFO [stdout] test src/lib.rs - EditApkAddexternallyhostedCall (line 7733) ... ok
Dec 15 12:41:19.443 INFO [stdout] test src/lib.rs - AndroidPublisher (line 284) ... ok
Dec 15 12:42:11.026 INFO [stdout] test src/lib.rs - EditApklistingListCall (line 17431) ... ok
Dec 15 12:42:14.028 INFO [stdout] test src/lib.rs - EditApklistingPatchCall (line 11470) ... ok
Dec 15 12:42:14.792 INFO [stdout] test src/lib.rs - EditApklistingUpdateCall (line 10907) ... test src/lib.rs - EditApklistingUpdateCall (line 10907) has been running for over 60 seconds
Dec 15 12:42:15.779 INFO [stdout] test src/lib.rs - EditBundleListCall (line 12045) ... test src/lib.rs - EditBundleListCall (line 12045) has been running for over 60 seconds
Dec 15 12:42:16.227 INFO [stdout] test src/lib.rs - EditBundleUploadCall (line 14786) ... test src/lib.rs - EditBundleUploadCall (line 14786) has been running for over 60 seconds
Dec 15 12:42:16.450 INFO [stdout] test src/lib.rs - EditDeobfuscationfileUploadCall (line 5883) ... ok
Dec 15 12:42:18.099 INFO [stdout] test src/lib.rs - EditCommitCall (line 13756) ... test src/lib.rs - EditCommitCall (line 13756) has been running for over 60 seconds
Dec 15 12:42:19.351 INFO [stdout] test src/lib.rs - EditDeleteCall (line 12300) ... test src/lib.rs - EditDeleteCall (line 12300) has been running for over 60 seconds
Dec 15 12:42:19.716 INFO [stdout] test src/lib.rs - EditApklistingUpdateCall (line 10907) ... ok
Dec 15 12:42:21.027 INFO [stdout] test src/lib.rs - EditBundleListCall (line 12045) ... ok
Dec 15 12:42:22.275 INFO [stdout] test src/lib.rs - EditCommitCall (line 13756) ... ok
Dec 15 12:42:22.436 INFO [stdout] test src/lib.rs - EditBundleUploadCall (line 14786) ... ok
Dec 15 12:42:24.195 INFO [stdout] test src/lib.rs - EditDeleteCall (line 12300) ... ok
Dec 15 12:43:11.023 INFO [stdout] test src/lib.rs - EditDetailGetCall (line 6966) ... test src/lib.rs - EditDetailGetCall (line 6966) has been running for over 60 seconds
Dec 15 12:43:14.031 INFO [stdout] test src/lib.rs - EditDetailPatchCall (line 16016) ... test src/lib.rs - EditDetailPatchCall (line 16016) has been running for over 60 seconds
Dec 15 12:43:16.299 INFO [stdout] test src/lib.rs - EditDetailGetCall (line 6966) ... ok
Dec 15 12:43:16.455 INFO [stdout] test src/lib.rs - EditDetailUpdateCall (line 8275) ... test src/lib.rs - EditDetailUpdateCall (line 8275) has been running for over 60 seconds
Dec 15 12:43:19.723 INFO [stdout] test src/lib.rs - EditExpansionfileGetCall (line 15460) ... test src/lib.rs - EditExpansionfileGetCall (line 15460) has been running for over 60 seconds
Dec 15 12:43:20.583 INFO [stdout] test src/lib.rs - EditDetailPatchCall (line 16016) ... ok
Dec 15 12:43:20.839 INFO [stdout] test src/lib.rs - EditDetailUpdateCall (line 8275) ... ok
Dec 15 12:43:21.043 INFO [stdout] test src/lib.rs - EditExpansionfilePatchCall (line 8828) ... test src/lib.rs - EditExpansionfilePatchCall (line 8828) has been running for over 60 seconds
Dec 15 12:43:22.287 INFO [stdout] test src/lib.rs - EditExpansionfileUpdateCall (line 6657) ... test src/lib.rs - EditExpansionfileUpdateCall (line 6657) has been running for over 60 seconds
Dec 15 12:43:22.459 INFO [stdout] test src/lib.rs - EditExpansionfileUploadCall (line 12544) ... test src/lib.rs - EditExpansionfileUploadCall (line 12544) has been running for over 60 seconds
Dec 15 12:43:23.023 INFO [stdout] test src/lib.rs - EditExpansionfileGetCall (line 15460) ... ok
Dec 15 12:43:24.199 INFO [stdout] test src/lib.rs - EditGetCall (line 10011) ... test src/lib.rs - EditGetCall (line 10011) has been running for over 60 seconds
Dec 15 12:43:25.015 INFO [stdout] test src/lib.rs - EditExpansionfileUploadCall (line 12544) ... ok
Dec 15 12:43:26.245 INFO [stdout] test src/lib.rs - EditExpansionfilePatchCall (line 8828) ... ok
Dec 15 12:43:27.147 INFO [stdout] test src/lib.rs - EditGetCall (line 10011) ... ok
Dec 15 12:43:27.707 INFO [stdout] test src/lib.rs - EditExpansionfileUpdateCall (line 6657) ... ok
Dec 15 12:44:14.327 INFO [stdout] test src/lib.rs - EditImageDeleteallCall (line 15738) ... ok
Dec 15 12:44:14.863 INFO [stdout] test src/lib.rs - EditImageListCall (line 9137) ... ok
Dec 15 12:44:16.303 INFO [stdout] test src/lib.rs - EditImageDeleteCall (line 10266) ... test src/lib.rs - EditImageDeleteCall (line 10266) has been running for over 60 seconds
Dec 15 12:44:16.401 INFO [stdout] test src/lib.rs - EditImageDeleteCall (line 10266) ... ok
Dec 15 12:44:23.035 INFO [stdout] test src/lib.rs - EditImageUploadCall (line 6270) ... test src/lib.rs - EditImageUploadCall (line 6270) has been running for over 60 seconds
Dec 15 12:44:25.023 INFO [stdout] test src/lib.rs - EditInsertCall (line 12931) ... test src/lib.rs - EditInsertCall (line 12931) has been running for over 60 seconds
Dec 15 12:44:25.159 INFO [stdout] test src/lib.rs - EditImageUploadCall (line 6270) ... ok
Dec 15 12:44:26.247 INFO [stdout] test src/lib.rs - EditListingDeleteCall (line 16600) ... test src/lib.rs - EditListingDeleteCall (line 16600) has been running for over 60 seconds
Dec 15 12:44:27.151 INFO [stdout] test src/lib.rs - EditListingDeleteallCall (line 7489) ... test src/lib.rs - EditListingDeleteallCall (line 7489) has been running for over 60 seconds
Dec 15 12:44:27.631 INFO [stdout] test src/lib.rs - EditListingDeleteCall (line 16600) ... ok
Dec 15 12:44:27.711 INFO [stdout] test src/lib.rs - EditListingGetCall (line 11780) ... test src/lib.rs - EditListingGetCall (line 11780) has been running for over 60 seconds
Dec 15 12:44:28.779 INFO [stdout] test src/lib.rs - EditInsertCall (line 12931) ... ok
Dec 15 12:44:30.279 INFO [stdout] test src/lib.rs - EditListingDeleteallCall (line 7489) ... ok
Dec 15 12:44:31.191 INFO [stdout] test src/lib.rs - EditListingGetCall (line 11780) ... ok
Dec 15 12:45:13.967 INFO [stdout] test src/lib.rs - EditListingPatchCall (line 9713) ... ok
Dec 15 12:45:14.327 INFO [stdout] test src/lib.rs - EditListingListCall (line 13205) ... test src/lib.rs - EditListingListCall (line 13205) has been running for over 60 seconds
Dec 15 12:45:16.407 INFO [stdout] test src/lib.rs - EditListingUpdateCall (line 15162) ... test src/lib.rs - EditListingUpdateCall (line 15162) has been running for over 60 seconds
Dec 15 12:45:16.623 INFO [stdout] test src/lib.rs - EditListingListCall (line 13205) ... ok
Dec 15 12:45:19.479 INFO [stdout] test src/lib.rs - EditListingUpdateCall (line 15162) ... ok
Dec 15 12:45:23.736 INFO [stdout] test src/lib.rs - EditTesterGetCall (line 14264) ... ok
Dec 15 12:45:24.303 INFO [stdout] test src/lib.rs - EditMethods (line 2004) ... ok
Dec 15 12:45:28.779 INFO [stdout] test src/lib.rs - EditTesterPatchCall (line 13458) ... test src/lib.rs - EditTesterPatchCall (line 13458) has been running for over 60 seconds
Dec 15 12:45:30.106 INFO [stdout] test src/lib.rs - EditTrackGetCall (line 8561) ... ok
Dec 15 12:45:30.287 INFO [stdout] test src/lib.rs - EditTesterUpdateCall (line 17133) ... test src/lib.rs - EditTesterUpdateCall (line 17133) has been running for over 60 seconds
Dec 15 12:45:30.827 INFO [stdout] test src/lib.rs - EditTesterPatchCall (line 13458) ... ok
Dec 15 12:45:32.531 INFO [stdout] test src/lib.rs - EditTesterUpdateCall (line 17133) ... ok
Dec 15 12:46:12.819 INFO [stdout] test src/lib.rs - EditTrackListCall (line 14011) ... ok
Dec 15 12:46:15.103 INFO [stdout] test src/lib.rs - EditTrackPatchCall (line 16302) ... ok
Dec 15 12:46:18.460 INFO [stdout] test src/lib.rs - EditTrackUpdateCall (line 9415) ... ok
Dec 15 12:46:22.707 INFO [stdout] test src/lib.rs - EditValidateCall (line 14531) ... ok
Dec 15 12:46:24.306 INFO [stdout] test src/lib.rs - InappproductDeleteCall (line 18516) ... test src/lib.rs - InappproductDeleteCall (line 18516) has been running for over 60 seconds
Dec 15 12:46:25.159 INFO [stdout] test src/lib.rs - InappproductDeleteCall (line 18516) ... ok
Dec 15 12:46:27.479 INFO [stdout] test src/lib.rs - InappproductInsertCall (line 18230) ... ok
Dec 15 12:46:30.107 INFO [stdout] test src/lib.rs - InappproductGetCall (line 18760) ... test src/lib.rs - InappproductGetCall (line 18760) has been running for over 60 seconds
Dec 15 12:46:30.139 INFO [stdout] test src/lib.rs - InappproductGetCall (line 18760) ... ok
Dec 15 12:46:32.532 INFO [stdout] test src/lib.rs - InappproductListCall (line 17954) ... test src/lib.rs - InappproductListCall (line 17954) has been running for over 60 seconds
Dec 15 12:46:34.209 INFO [stdout] test src/lib.rs - InappproductListCall (line 17954) ... ok
Dec 15 12:47:06.007 INFO [stdout] test src/lib.rs - InappproductMethods (line 2974) ... ok
Dec 15 12:47:08.659 INFO [stdout] test src/lib.rs - InappproductPatchCall (line 19312) ... ok
Dec 15 12:47:10.835 INFO [stdout] test src/lib.rs - InappproductUpdateCall (line 19014) ... ok
Dec 15 12:47:12.079 INFO [stdout] test src/lib.rs - OrderMethods (line 2912) ... ok
Dec 15 12:47:18.539 INFO [stdout] test src/lib.rs - OrderRefundCall (line 17698) ... ok
Dec 15 12:47:21.151 INFO [stdout] test src/lib.rs - PurchaseProductGetCall (line 4239) ... ok
Dec 15 12:47:22.967 INFO [stdout] test src/lib.rs - PurchaseSubscriptionCancelCall (line 5073) ... ok
Dec 15 12:47:23.015 INFO [stdout] test src/lib.rs - PurchaseMethods (line 1812) ... ok
Dec 15 12:48:01.756 INFO [stdout] test src/lib.rs - PurchaseSubscriptionDeferCall (line 5585) ... ok
Dec 15 12:48:07.451 INFO [stdout] test src/lib.rs - PurchaseSubscriptionGetCall (line 4506) ... ok
Dec 15 12:48:09.987 INFO [stdout] test src/lib.rs - PurchaseSubscriptionRefundCall (line 5329) ... ok
Dec 15 12:48:10.859 INFO [stdout] test src/lib.rs - PurchaseSubscriptionRevokeCall (line 3983) ... ok
Dec 15 12:48:11.595 INFO [stdout] test src/lib.rs - PurchaseVoidedpurchaseListCall (line 4773) ... ok
Dec 15 12:48:16.115 INFO [stdout] test src/lib.rs - ReviewMethods (line 1708) ... ok
Dec 15 12:48:16.663 INFO [stdout] test src/lib.rs - ReviewGetCall (line 3431) ... ok
Dec 15 12:48:17.157 INFO [stdout] test src/lib.rs - ReviewListCall (line 3696) ... ok
Dec 15 12:48:23.924 INFO [stdout] test src/lib.rs - ReviewReplyCall (line 3146) ... ok
Dec 15 12:48:23.924 INFO [stdout] 
Dec 15 12:48:23.924 INFO [stdout] test result: ok. 65 passed; 0 failed; 1 ignored; 0 measured; 0 filtered out
Dec 15 12:48:23.924 INFO [stdout] 
Dec 15 12:48:23.965 INFO [stderr] su: No module specific data is present
Dec 15 12:48:25.491 INFO running `"docker" "inspect" "7f2a67ec20701035857fbed67da161515f0999c0160062c7897fb4104705f693"`
Dec 15 12:48:25.825 INFO running `"docker" "rm" "-f" "7f2a67ec20701035857fbed67da161515f0999c0160062c7897fb4104705f693"`
Dec 15 12:48:26.199 INFO [stdout] 7f2a67ec20701035857fbed67da161515f0999c0160062c7897fb4104705f693