Dec 14 05:01:00.436 INFO testing TurboCartPig/aengine against master#bd47d6825bf4090517549d33cfef10d3300b4a75 for pr-56550
Dec 14 05:01:00.436 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 14 05:01:00.745 INFO [stdout] 8431212171c889e40ffafbf976656f5c2525796a59f1dab08f0c78ae4a404c4c
Dec 14 05:01:00.746 INFO running `"docker" "start" "-a" "8431212171c889e40ffafbf976656f5c2525796a59f1dab08f0c78ae4a404c4c"`
Dec 14 05:01:01.412 INFO [stderr] usermod: no changes
Dec 14 05:01:01.677 INFO [stderr]    Compiling slog v2.0.6
Dec 14 05:01:01.677 INFO [stderr]    Compiling take_mut v0.1.3
Dec 14 05:01:01.677 INFO [stderr]    Compiling android_glue v0.2.3
Dec 14 05:01:01.677 INFO [stderr]    Compiling thread-id v3.1.0
Dec 14 05:01:01.677 INFO [stderr]    Compiling isatty v0.1.3
Dec 14 05:01:01.678 INFO [stderr]    Compiling cgmath v0.14.1
Dec 14 05:01:01.678 INFO [stderr]    Compiling aengine v0.1.0 (/source)
Dec 14 05:01:01.678 INFO [stderr]    Compiling chrono v0.3.0
Dec 14 05:01:03.031 INFO [stderr]    Compiling winit v0.6.4
Dec 14 05:01:04.228 INFO [stderr]    Compiling thread_local v0.3.3
Dec 14 05:01:08.391 INFO [stderr]    Compiling slog-async v2.0.1
Dec 14 05:01:16.035 INFO [stderr]    Compiling slog-term v2.0.1
Dec 14 05:01:22.195 INFO [stderr]    Compiling glutin v0.8.1
Dec 14 05:01:32.127 INFO [stderr] warning: unused import: `Duration`
Dec 14 05:01:32.127 INFO [stderr]  --> src/time.rs:2:17
Dec 14 05:01:32.127 INFO [stderr]   |
Dec 14 05:01:32.127 INFO [stderr] 2 | use std::time::{Duration, Instant};
Dec 14 05:01:32.127 INFO [stderr]   |                 ^^^^^^^^
Dec 14 05:01:32.127 INFO [stderr]   |
Dec 14 05:01:32.127 INFO [stderr]   = note: #[warn(unused_imports)] on by default
Dec 14 05:01:32.127 INFO [stderr] 
Dec 14 05:01:32.151 INFO [stderr] warning: unused import: `renderer::get_gl_error`
Dec 14 05:01:32.151 INFO [stderr]  --> src/renderer/shader.rs:7:5
Dec 14 05:01:32.151 INFO [stderr]   |
Dec 14 05:01:32.151 INFO [stderr] 7 | use renderer::get_gl_error;
Dec 14 05:01:32.151 INFO [stderr]   |     ^^^^^^^^^^^^^^^^^^^^^^
Dec 14 05:01:32.151 INFO [stderr] 
Dec 14 05:01:33.731 INFO [stderr] warning: unused variable: `delta_time`
Dec 14 05:01:33.731 INFO [stderr]   --> src/renderer/mod.rs:97:30
Dec 14 05:01:33.731 INFO [stderr]    |
Dec 14 05:01:33.731 INFO [stderr] 97 |     pub fn render(&mut self, delta_time: f64) {
Dec 14 05:01:33.731 INFO [stderr]    |                              ^^^^^^^^^^ help: consider using `_delta_time` instead
Dec 14 05:01:33.731 INFO [stderr]    |
Dec 14 05:01:33.731 INFO [stderr]    = note: #[warn(unused_variables)] on by default
Dec 14 05:01:33.731 INFO [stderr] 
Dec 14 05:01:33.775 INFO [stderr] warning: variable does not need to be mutable
Dec 14 05:01:33.775 INFO [stderr]  --> /target/debug/build/aengine-e0a47a91224f906f/out/gl_bindings.rs:9:23
Dec 14 05:01:33.775 INFO [stderr]   |
Dec 14 05:01:33.775 INFO [stderr] 9 |         fn metaloadfn(mut loadfn: &mut FnMut(&str) -> *const __gl_imports::raw::c_void,
Dec 14 05:01:33.775 INFO [stderr]   |                       ----^^^^^^
Dec 14 05:01:33.775 INFO [stderr]   |                       |
Dec 14 05:01:33.775 INFO [stderr]   |                       help: remove this `mut`
Dec 14 05:01:33.775 INFO [stderr]   |
Dec 14 05:01:33.775 INFO [stderr]   = note: #[warn(unused_mut)] on by default
Dec 14 05:01:33.775 INFO [stderr] 
Dec 14 05:01:34.399 INFO [stderr] warning: field is never used: `init_time`
Dec 14 05:01:34.399 INFO [stderr]  --> src/time.rs:8:5
Dec 14 05:01:34.399 INFO [stderr]   |
Dec 14 05:01:34.399 INFO [stderr] 8 |     init_time: Instant,
Dec 14 05:01:34.399 INFO [stderr]   |     ^^^^^^^^^^^^^^^^^^
Dec 14 05:01:34.399 INFO [stderr]   |
Dec 14 05:01:34.399 INFO [stderr]   = note: #[warn(dead_code)] on by default
Dec 14 05:01:34.399 INFO [stderr] 
Dec 14 05:01:34.407 INFO [stderr] warning: type alias is never used: `VertexBufferObject`
Dec 14 05:01:34.407 INFO [stderr]   --> src/renderer/mod.rs:10:1
Dec 14 05:01:34.407 INFO [stderr]    |
Dec 14 05:01:34.407 INFO [stderr] 10 | type VertexBufferObject = gl::types::GLuint;
Dec 14 05:01:34.407 INFO [stderr]    | ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Dec 14 05:01:34.407 INFO [stderr] 
Dec 14 05:01:34.407 INFO [stderr] warning: type alias is never used: `VertexArrayObject`
Dec 14 05:01:34.407 INFO [stderr]   --> src/renderer/mod.rs:11:1
Dec 14 05:01:34.407 INFO [stderr]    |
Dec 14 05:01:34.407 INFO [stderr] 11 | type VertexArrayObject = gl::types::GLuint;
Dec 14 05:01:34.407 INFO [stderr]    | ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Dec 14 05:01:34.407 INFO [stderr] 
Dec 14 05:01:34.407 INFO [stderr] warning: type alias is never used: `ElementBufferObject`
Dec 14 05:01:34.407 INFO [stderr]   --> src/renderer/mod.rs:12:1
Dec 14 05:01:34.407 INFO [stderr]    |
Dec 14 05:01:34.407 INFO [stderr] 12 | type ElementBufferObject = gl::types::GLuint;
Dec 14 05:01:34.407 INFO [stderr]    | ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Dec 14 05:01:34.407 INFO [stderr] 
Dec 14 05:01:34.407 INFO [stderr] warning: field is never used: `program`
Dec 14 05:01:34.407 INFO [stderr]   --> src/renderer/mod.rs:60:5
Dec 14 05:01:34.407 INFO [stderr]    |
Dec 14 05:01:34.407 INFO [stderr] 60 |     program: shader::Program,
Dec 14 05:01:34.407 INFO [stderr]    |     ^^^^^^^^^^^^^^^^^^^^^^^^
Dec 14 05:01:34.407 INFO [stderr] 
Dec 14 05:01:34.407 INFO [stderr] warning: field is never used: `window`
Dec 14 05:01:34.407 INFO [stderr]   --> src/main.rs:27:5
Dec 14 05:01:34.407 INFO [stderr]    |
Dec 14 05:01:34.407 INFO [stderr] 27 |     window: Rc<glutin::Window>,
Dec 14 05:01:34.407 INFO [stderr]    |     ^^^^^^^^^^^^^^^^^^^^^^^^^^
Dec 14 05:01:34.407 INFO [stderr] 
Dec 14 05:01:41.025 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 39.58s
Dec 14 05:01:41.039 INFO [stderr] su: No module specific data is present
Dec 14 05:01:41.817 INFO running `"docker" "inspect" "8431212171c889e40ffafbf976656f5c2525796a59f1dab08f0c78ae4a404c4c"`
Dec 14 05:01:42.058 INFO running `"docker" "rm" "-f" "8431212171c889e40ffafbf976656f5c2525796a59f1dab08f0c78ae4a404c4c"`
Dec 14 05:01:42.371 INFO [stdout] 8431212171c889e40ffafbf976656f5c2525796a59f1dab08f0c78ae4a404c4c
Dec 14 05:01:42.379 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 14 05:01:42.743 INFO [stdout] 716f57f0d54fae9c51112da5e4bdb2796e2db0f99f2c98a763b896484b632b85
Dec 14 05:01:42.747 INFO running `"docker" "start" "-a" "716f57f0d54fae9c51112da5e4bdb2796e2db0f99f2c98a763b896484b632b85"`
Dec 14 05:01:44.223 INFO [stderr] usermod: no changes
Dec 14 05:01:44.436 INFO [stderr]    Compiling aengine v0.1.0 (/source)
Dec 14 05:01:47.143 INFO [stderr] warning: unused import: `Duration`
Dec 14 05:01:47.143 INFO [stderr]  --> src/time.rs:2:17
Dec 14 05:01:47.143 INFO [stderr]   |
Dec 14 05:01:47.143 INFO [stderr] 2 | use std::time::{Duration, Instant};
Dec 14 05:01:47.143 INFO [stderr]   |                 ^^^^^^^^
Dec 14 05:01:47.143 INFO [stderr]   |
Dec 14 05:01:47.143 INFO [stderr]   = note: #[warn(unused_imports)] on by default
Dec 14 05:01:47.143 INFO [stderr] 
Dec 14 05:01:47.167 INFO [stderr] warning: unused import: `renderer::get_gl_error`
Dec 14 05:01:47.167 INFO [stderr]  --> src/renderer/shader.rs:7:5
Dec 14 05:01:47.167 INFO [stderr]   |
Dec 14 05:01:47.167 INFO [stderr] 7 | use renderer::get_gl_error;
Dec 14 05:01:47.167 INFO [stderr]   |     ^^^^^^^^^^^^^^^^^^^^^^
Dec 14 05:01:47.167 INFO [stderr] 
Dec 14 05:01:48.731 INFO [stderr] warning: unused variable: `delta_time`
Dec 14 05:01:48.731 INFO [stderr]   --> src/renderer/mod.rs:97:30
Dec 14 05:01:48.731 INFO [stderr]    |
Dec 14 05:01:48.731 INFO [stderr] 97 |     pub fn render(&mut self, delta_time: f64) {
Dec 14 05:01:48.731 INFO [stderr]    |                              ^^^^^^^^^^ help: consider using `_delta_time` instead
Dec 14 05:01:48.731 INFO [stderr]    |
Dec 14 05:01:48.731 INFO [stderr]    = note: #[warn(unused_variables)] on by default
Dec 14 05:01:48.731 INFO [stderr] 
Dec 14 05:01:48.775 INFO [stderr] warning: variable does not need to be mutable
Dec 14 05:01:48.775 INFO [stderr]  --> /target/debug/build/aengine-e0a47a91224f906f/out/gl_bindings.rs:9:23
Dec 14 05:01:48.775 INFO [stderr]   |
Dec 14 05:01:48.775 INFO [stderr] 9 |         fn metaloadfn(mut loadfn: &mut FnMut(&str) -> *const __gl_imports::raw::c_void,
Dec 14 05:01:48.775 INFO [stderr]   |                       ----^^^^^^
Dec 14 05:01:48.775 INFO [stderr]   |                       |
Dec 14 05:01:48.775 INFO [stderr]   |                       help: remove this `mut`
Dec 14 05:01:48.775 INFO [stderr]   |
Dec 14 05:01:48.775 INFO [stderr]   = note: #[warn(unused_mut)] on by default
Dec 14 05:01:48.775 INFO [stderr] 
Dec 14 05:01:49.415 INFO [stderr] warning: field is never used: `init_time`
Dec 14 05:01:49.415 INFO [stderr]  --> src/time.rs:8:5
Dec 14 05:01:49.415 INFO [stderr]   |
Dec 14 05:01:49.415 INFO [stderr] 8 |     init_time: Instant,
Dec 14 05:01:49.415 INFO [stderr]   |     ^^^^^^^^^^^^^^^^^^
Dec 14 05:01:49.415 INFO [stderr]   |
Dec 14 05:01:49.415 INFO [stderr]   = note: #[warn(dead_code)] on by default
Dec 14 05:01:49.415 INFO [stderr] 
Dec 14 05:01:49.419 INFO [stderr] warning: type alias is never used: `VertexBufferObject`
Dec 14 05:01:49.419 INFO [stderr]   --> src/renderer/mod.rs:10:1
Dec 14 05:01:49.419 INFO [stderr]    |
Dec 14 05:01:49.419 INFO [stderr] 10 | type VertexBufferObject = gl::types::GLuint;
Dec 14 05:01:49.419 INFO [stderr]    | ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Dec 14 05:01:49.419 INFO [stderr] 
Dec 14 05:01:49.419 INFO [stderr] warning: type alias is never used: `VertexArrayObject`
Dec 14 05:01:49.419 INFO [stderr]   --> src/renderer/mod.rs:11:1
Dec 14 05:01:49.419 INFO [stderr]    |
Dec 14 05:01:49.419 INFO [stderr] 11 | type VertexArrayObject = gl::types::GLuint;
Dec 14 05:01:49.419 INFO [stderr]    | ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Dec 14 05:01:49.419 INFO [stderr] 
Dec 14 05:01:49.419 INFO [stderr] warning: type alias is never used: `ElementBufferObject`
Dec 14 05:01:49.419 INFO [stderr]   --> src/renderer/mod.rs:12:1
Dec 14 05:01:49.419 INFO [stderr]    |
Dec 14 05:01:49.419 INFO [stderr] 12 | type ElementBufferObject = gl::types::GLuint;
Dec 14 05:01:49.419 INFO [stderr]    | ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Dec 14 05:01:49.419 INFO [stderr] 
Dec 14 05:01:49.419 INFO [stderr] warning: field is never used: `program`
Dec 14 05:01:49.419 INFO [stderr]   --> src/renderer/mod.rs:60:5
Dec 14 05:01:49.419 INFO [stderr]    |
Dec 14 05:01:49.419 INFO [stderr] 60 |     program: shader::Program,
Dec 14 05:01:49.419 INFO [stderr]    |     ^^^^^^^^^^^^^^^^^^^^^^^^
Dec 14 05:01:49.419 INFO [stderr] 
Dec 14 05:01:49.419 INFO [stderr] warning: field is never used: `window`
Dec 14 05:01:49.419 INFO [stderr]   --> src/main.rs:27:5
Dec 14 05:01:49.419 INFO [stderr]    |
Dec 14 05:01:49.419 INFO [stderr] 27 |     window: Rc<glutin::Window>,
Dec 14 05:01:49.419 INFO [stderr]    |     ^^^^^^^^^^^^^^^^^^^^^^^^^^
Dec 14 05:01:49.419 INFO [stderr] 
Dec 14 05:01:50.338 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 6.08s
Dec 14 05:01:50.342 INFO [stderr] su: No module specific data is present
Dec 14 05:01:50.935 INFO running `"docker" "inspect" "716f57f0d54fae9c51112da5e4bdb2796e2db0f99f2c98a763b896484b632b85"`
Dec 14 05:01:51.288 INFO running `"docker" "rm" "-f" "716f57f0d54fae9c51112da5e4bdb2796e2db0f99f2c98a763b896484b632b85"`
Dec 14 05:01:51.575 INFO [stdout] 716f57f0d54fae9c51112da5e4bdb2796e2db0f99f2c98a763b896484b632b85
Dec 14 05:01:51.577 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 14 05:01:52.218 INFO [stdout] 88bef1db6c2ea8e7ff91a8ad0db99a60ec21fc3769c4994c60c8b73e4f99d2c0
Dec 14 05:01:52.221 INFO running `"docker" "start" "-a" "88bef1db6c2ea8e7ff91a8ad0db99a60ec21fc3769c4994c60c8b73e4f99d2c0"`
Dec 14 05:01:54.642 INFO [stderr] usermod: no changes
Dec 14 05:01:54.863 INFO [stderr]     Finished dev [unoptimized + debuginfo] target(s) in 0.17s
Dec 14 05:01:54.871 INFO [stderr]      Running /target/debug/deps/aengine-61e48bff1f4aa5c8
Dec 14 05:01:54.873 INFO [stdout] 
Dec 14 05:01:54.873 INFO [stdout] running 0 tests
Dec 14 05:01:54.873 INFO [stdout] 
Dec 14 05:01:54.873 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out
Dec 14 05:01:54.873 INFO [stdout] 
Dec 14 05:01:54.877 INFO [stderr] su: No module specific data is present
Dec 14 05:01:56.111 INFO running `"docker" "inspect" "88bef1db6c2ea8e7ff91a8ad0db99a60ec21fc3769c4994c60c8b73e4f99d2c0"`
Dec 14 05:01:56.509 INFO running `"docker" "rm" "-f" "88bef1db6c2ea8e7ff91a8ad0db99a60ec21fc3769c4994c60c8b73e4f99d2c0"`
Dec 14 05:01:56.803 INFO [stdout] 88bef1db6c2ea8e7ff91a8ad0db99a60ec21fc3769c4994c60c8b73e4f99d2c0