Dec 15 13:00:53.294 INFO testing google-accesscontextmanager1_beta-1.0.8+20181010 against master#bd47d6825bf4090517549d33cfef10d3300b4a75 for pr-56550
Dec 15 13:00:53.294 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-7/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-7/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 13:00:53.762 INFO [stdout] 4567ed06516ec9992e4013521a4efce524d8d352da4aacc4bce44af961128818
Dec 15 13:00:53.763 INFO running `"docker" "start" "-a" "4567ed06516ec9992e4013521a4efce524d8d352da4aacc4bce44af961128818"`
Dec 15 13:00:55.425 INFO [stderr] usermod: no changes
Dec 15 13:00:55.743 INFO [stderr]    Compiling google-accesscontextmanager1_beta v1.0.8+20181010 (/source)
Dec 15 13:01:02.613 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 7.16s
Dec 15 13:01:02.631 INFO [stderr] su: No module specific data is present
Dec 15 13:01:03.731 INFO running `"docker" "inspect" "4567ed06516ec9992e4013521a4efce524d8d352da4aacc4bce44af961128818"`
Dec 15 13:01:04.081 INFO running `"docker" "rm" "-f" "4567ed06516ec9992e4013521a4efce524d8d352da4aacc4bce44af961128818"`
Dec 15 13:01:04.427 INFO [stdout] 4567ed06516ec9992e4013521a4efce524d8d352da4aacc4bce44af961128818
Dec 15 13:01:04.435 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-7/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-7/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 13:01:04.888 INFO [stdout] 29014399b69332fb9f6089067761f03b22c5621c45d0433d2338e2ab5f53137d
Dec 15 13:01:04.890 INFO running `"docker" "start" "-a" "29014399b69332fb9f6089067761f03b22c5621c45d0433d2338e2ab5f53137d"`
Dec 15 13:01:06.399 INFO [stderr] usermod: no changes
Dec 15 13:01:06.691 INFO [stderr]    Compiling google-accesscontextmanager1_beta v1.0.8+20181010 (/source)
Dec 15 13:01:12.993 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 6.56s
Dec 15 13:01:13.007 INFO [stderr] su: No module specific data is present
Dec 15 13:01:13.679 INFO running `"docker" "inspect" "29014399b69332fb9f6089067761f03b22c5621c45d0433d2338e2ab5f53137d"`
Dec 15 13:01:13.941 INFO running `"docker" "rm" "-f" "29014399b69332fb9f6089067761f03b22c5621c45d0433d2338e2ab5f53137d"`
Dec 15 13:01:14.242 INFO [stdout] 29014399b69332fb9f6089067761f03b22c5621c45d0433d2338e2ab5f53137d
Dec 15 13:01:14.245 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-7/master#bd47d6825bf4090517549d33cfef10d3300b4a75:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-7/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 13:01:14.668 INFO [stdout] fd3ca29e74907721be18e3d70eef7accd8f3d3ebe214b555729efb6dda1b68ab
Dec 15 13:01:14.670 INFO running `"docker" "start" "-a" "fd3ca29e74907721be18e3d70eef7accd8f3d3ebe214b555729efb6dda1b68ab"`
Dec 15 13:01:16.962 INFO [stderr] usermod: no changes
Dec 15 13:01:17.151 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.16s
Dec 15 13:01:17.163 INFO [stderr]      Running /target/debug/deps/google_accesscontextmanager1_beta-21211f5c09a512c6
Dec 15 13:01:17.163 INFO [stderr]    Doc-tests google-accesscontextmanager1_beta
Dec 15 13:01:17.163 INFO [stdout] 
Dec 15 13:01:17.163 INFO [stdout] running 0 tests
Dec 15 13:01:17.163 INFO [stdout] 
Dec 15 13:01:17.163 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 15 13:01:17.163 INFO [stdout] 
Dec 15 13:01:24.239 INFO [stdout] 
Dec 15 13:01:24.239 INFO [stdout] running 21 tests
Dec 15 13:01:24.240 INFO [stdout] test src/lib.rs -  (line 51) ... ignored
Dec 15 13:02:19.687 INFO [stdout] test src/lib.rs - AccessPolicyCreateCall (line 3028) ... ok
Dec 15 13:02:21.071 INFO [stdout] test src/lib.rs - AccessPolicyAccessLevelDeleteCall (line 4357) ... ok
Dec 15 13:02:23.523 INFO [stdout] test src/lib.rs - AccessContextManager (line 276) ... ok
Dec 15 13:02:24.247 INFO [stdout] test src/lib.rs - AccessPolicyAccessLevelGetCall (line 3783) ... test src/lib.rs - AccessPolicyAccessLevelGetCall (line 3783) has been running for over 60 seconds
Dec 15 13:02:24.248 INFO [stdout] test src/lib.rs - AccessPolicyAccessLevelCreateCall (line 1893) ... test src/lib.rs - AccessPolicyAccessLevelCreateCall (line 1893) has been running for over 60 seconds
Dec 15 13:02:24.248 INFO [stdout] test src/lib.rs - AccessPolicyAccessLevelListCall (line 1595) ... test src/lib.rs - AccessPolicyAccessLevelListCall (line 1595) has been running for over 60 seconds
Dec 15 13:02:24.248 INFO [stdout] test src/lib.rs - AccessPolicyAccessLevelPatchCall (line 2728) ... test src/lib.rs - AccessPolicyAccessLevelPatchCall (line 2728) has been running for over 60 seconds
Dec 15 13:02:24.248 INFO [stdout] test src/lib.rs -  (line 90) ... test src/lib.rs -  (line 90) has been running for over 60 seconds
Dec 15 13:02:25.064 INFO [stdout] test src/lib.rs - AccessPolicyAccessLevelListCall (line 1595) ... ok
Dec 15 13:02:25.456 INFO [stdout] test src/lib.rs - AccessPolicyAccessLevelGetCall (line 3783) ... ok
Dec 15 13:02:28.008 INFO [stdout] test src/lib.rs - AccessPolicyAccessLevelCreateCall (line 1893) ... ok
Dec 15 13:02:28.028 INFO [stdout] test src/lib.rs - AccessPolicyAccessLevelPatchCall (line 2728) ... ok
Dec 15 13:02:29.307 INFO [stdout] test src/lib.rs -  (line 90) ... ok
Dec 15 13:03:19.695 INFO [stdout] test src/lib.rs - AccessPolicyDeleteCall (line 5195) ... test src/lib.rs - AccessPolicyDeleteCall (line 5195) has been running for over 60 seconds
Dec 15 13:03:21.075 INFO [stdout] test src/lib.rs - AccessPolicyGetCall (line 3273) ... test src/lib.rs - AccessPolicyGetCall (line 3273) has been running for over 60 seconds
Dec 15 13:03:23.531 INFO [stdout] test src/lib.rs - AccessPolicyListCall (line 3527) ... test src/lib.rs - AccessPolicyListCall (line 3527) has been running for over 60 seconds
Dec 15 13:03:24.239 INFO [stdout] test src/lib.rs - AccessPolicyDeleteCall (line 5195) ... ok
Dec 15 13:03:25.067 INFO [stdout] test src/lib.rs - AccessPolicyMethods (line 958) ... test src/lib.rs - AccessPolicyMethods (line 958) has been running for over 60 seconds
Dec 15 13:03:25.463 INFO [stdout] test src/lib.rs - AccessPolicyPatchCall (line 4059) ... test src/lib.rs - AccessPolicyPatchCall (line 4059) has been running for over 60 seconds
Dec 15 13:03:25.951 INFO [stdout] test src/lib.rs - AccessPolicyGetCall (line 3273) ... ok
Dec 15 13:03:27.404 INFO [stdout] test src/lib.rs - AccessPolicyListCall (line 3527) ... ok
Dec 15 13:03:28.019 INFO [stdout] test src/lib.rs - AccessPolicyServicePerimeterCreateCall (line 2182) ... test src/lib.rs - AccessPolicyServicePerimeterCreateCall (line 2182) has been running for over 60 seconds
Dec 15 13:03:28.035 INFO [stdout] test src/lib.rs - AccessPolicyServicePerimeterDeleteCall (line 2470) ... test src/lib.rs - AccessPolicyServicePerimeterDeleteCall (line 2470) has been running for over 60 seconds
Dec 15 13:03:29.239 INFO [stdout] test src/lib.rs - AccessPolicyPatchCall (line 4059) ... ok
Dec 15 13:03:29.311 INFO [stdout] test src/lib.rs - AccessPolicyServicePerimeterGetCall (line 5449) ... test src/lib.rs - AccessPolicyServicePerimeterGetCall (line 5449) has been running for over 60 seconds
Dec 15 13:03:30.091 INFO [stdout] test src/lib.rs - AccessPolicyMethods (line 958) ... ok
Dec 15 13:03:30.986 INFO [stdout] test src/lib.rs - AccessPolicyServicePerimeterCreateCall (line 2182) ... ok
Dec 15 13:03:31.739 INFO [stdout] test src/lib.rs - AccessPolicyServicePerimeterDeleteCall (line 2470) ... ok
Dec 15 13:03:31.959 INFO [stdout] test src/lib.rs - AccessPolicyServicePerimeterGetCall (line 5449) ... ok
Dec 15 13:03:53.560 INFO [stdout] test src/lib.rs - OperationMethods (line 897) ... ok
Dec 15 13:03:55.367 INFO [stdout] test src/lib.rs - AccessPolicyServicePerimeterListCall (line 4612) ... ok
Dec 15 13:03:55.933 INFO [stdout] test src/lib.rs - OperationGetCall (line 1343) ... ok
Dec 15 13:03:56.175 INFO [stdout] test src/lib.rs - AccessPolicyServicePerimeterPatchCall (line 4896) ... ok
Dec 15 13:03:56.175 INFO [stdout] 
Dec 15 13:03:56.175 INFO [stdout] test result: ok. 20 passed; 0 failed; 1 ignored; 0 measured; 0 filtered out
Dec 15 13:03:56.175 INFO [stdout] 
Dec 15 13:03:56.223 INFO [stderr] su: No module specific data is present
Dec 15 13:03:57.232 INFO running `"docker" "inspect" "fd3ca29e74907721be18e3d70eef7accd8f3d3ebe214b555729efb6dda1b68ab"`
Dec 15 13:03:57.645 INFO running `"docker" "rm" "-f" "fd3ca29e74907721be18e3d70eef7accd8f3d3ebe214b555729efb6dda1b68ab"`
Dec 15 13:03:58.015 INFO [stdout] fd3ca29e74907721be18e3d70eef7accd8f3d3ebe214b555729efb6dda1b68ab