Dec 14 01:25:50.520 INFO testing bhase/raytracerchallenge against try#aa49d8ef14939ddec0e34b346b60174a5673d48f for pr-56550 Dec 14 01:25:50.520 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-4/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-4/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 14 01:25:51.044 INFO [stdout] 8bc9b90deb33fa9b8322c75781f147fc5cbe62cb775414aff286f549ae03ac92 Dec 14 01:25:51.050 INFO running `"docker" "start" "-a" "8bc9b90deb33fa9b8322c75781f147fc5cbe62cb775414aff286f549ae03ac92"` Dec 14 01:25:52.139 INFO [stderr] usermod: no changes Dec 14 01:25:52.267 INFO [stderr] Compiling raytracer_challenge v0.1.0 (/source) Dec 14 01:25:53.611 INFO [stderr] Finished dev [unoptimized + debuginfo] target(s) in 1.43s Dec 14 01:25:53.623 INFO [stderr] su: No module specific data is present Dec 14 01:25:54.160 INFO running `"docker" "inspect" "8bc9b90deb33fa9b8322c75781f147fc5cbe62cb775414aff286f549ae03ac92"` Dec 14 01:25:54.336 INFO running `"docker" "rm" "-f" "8bc9b90deb33fa9b8322c75781f147fc5cbe62cb775414aff286f549ae03ac92"` Dec 14 01:25:54.447 INFO [stdout] 8bc9b90deb33fa9b8322c75781f147fc5cbe62cb775414aff286f549ae03ac92 Dec 14 01:25:54.455 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-4/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-4/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 14 01:25:54.939 INFO [stdout] eed8a26d523c228774115e777bdf2533c8b64b3f18ad10b8729e48ae5ff58446 Dec 14 01:25:55.004 INFO running `"docker" "start" "-a" "eed8a26d523c228774115e777bdf2533c8b64b3f18ad10b8729e48ae5ff58446"` Dec 14 01:25:55.789 INFO [stderr] usermod: no changes Dec 14 01:25:55.986 INFO [stderr] Compiling pathdiff v0.1.0 Dec 14 01:25:55.990 INFO [stderr] Compiling clap v2.32.0 Dec 14 01:25:55.991 INFO [stderr] Compiling gherkin_rust v0.4.1 Dec 14 01:25:55.991 INFO [stderr] Compiling globset v0.4.2 Dec 14 01:26:04.036 INFO [stderr] Compiling ignore v0.4.4 Dec 14 01:26:15.791 INFO [stderr] Compiling globwalk v0.5.0 Dec 14 01:26:18.235 INFO [stderr] Compiling cucumber_rust v0.5.0 Dec 14 01:26:22.467 INFO [stderr] Compiling raytracer_challenge v0.1.0 (/source) Dec 14 01:26:29.989 INFO [stderr] Finished dev [unoptimized + debuginfo] target(s) in 34.17s Dec 14 01:26:30.015 INFO [stderr] su: No module specific data is present Dec 14 01:26:30.353 INFO running `"docker" "inspect" "eed8a26d523c228774115e777bdf2533c8b64b3f18ad10b8729e48ae5ff58446"` Dec 14 01:26:30.425 INFO running `"docker" "rm" "-f" "eed8a26d523c228774115e777bdf2533c8b64b3f18ad10b8729e48ae5ff58446"` Dec 14 01:26:30.504 INFO [stdout] eed8a26d523c228774115e777bdf2533c8b64b3f18ad10b8729e48ae5ff58446 Dec 14 01:26:30.505 INFO running `"docker" "create" "-v" "/mnt/big/crater/work/local/target-dirs/pr-56550/worker-4/try#aa49d8ef14939ddec0e34b346b60174a5673d48f:/target:rw,Z" "-v" "/mnt/big/crater/work/local/test-source/worker-4/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 14 01:26:30.691 INFO [stdout] 682b6d4e95a09676dbfb35e2a87d35cdb7e5f1759e242a955976b65ff0227fa3 Dec 14 01:26:30.693 INFO running `"docker" "start" "-a" "682b6d4e95a09676dbfb35e2a87d35cdb7e5f1759e242a955976b65ff0227fa3"` Dec 14 01:26:31.142 INFO [stderr] usermod: no changes Dec 14 01:26:31.253 INFO [stderr] Finished dev [unoptimized + debuginfo] target(s) in 0.09s Dec 14 01:26:31.269 INFO [stderr] Running /target/debug/deps/raytracer_challenge-02cdec067b26d85a Dec 14 01:26:31.271 INFO [stdout] Dec 14 01:26:31.271 INFO [stdout] running 0 tests Dec 14 01:26:31.271 INFO [stdout] Dec 14 01:26:31.271 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out Dec 14 01:26:31.271 INFO [stdout] Dec 14 01:26:31.271 INFO [stderr] Running /target/debug/deps/raytracer-2e5e27f318a35074 Dec 14 01:26:31.273 INFO [stdout] Dec 14 01:26:31.273 INFO [stdout] running 0 tests Dec 14 01:26:31.273 INFO [stdout] Dec 14 01:26:31.273 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out Dec 14 01:26:31.273 INFO [stdout] Dec 14 01:26:31.273 INFO [stderr] Running /target/debug/deps/cucumber-68960d9ca885d773 Dec 14 01:26:31.343 INFO [stdout] [Cucumber v0.5.0] Dec 14 01:26:31.343 INFO [stdout] Dec 14 01:26:31.403 INFO [stdout] Feature: Tuples, Vectors, and Points  features/tuples.feature:1:1 Dec 14 01:26:31.403 INFO [stdout]  Dec 14 01:26:31.403 INFO [stdout]  Scenario: A tuple with w=1.0 is a point  features/tuples.feature:3:11 Dec 14 01:26:31.403 INFO [stdout]  ✔ Given a := tuple(4.3, -4.2, 3.1, 1.0)  features/tuples.feature:4:3 Dec 14 01:26:31.403 INFO [stdout]  ✔ Then a.x = 4.3  features/tuples.feature:5:3 Dec 14 01:26:31.403 INFO [stdout]  ✔ And a.y = -4.2  features/tuples.feature:6:5 Dec 14 01:26:31.403 INFO [stdout]  ✔ And a.z = 3.1  features/tuples.feature:7:5 Dec 14 01:26:31.403 INFO [stdout]  ✔ And a.w = 1.0  features/tuples.feature:8:5 Dec 14 01:26:31.403 INFO [stdout]  ✔ And a is a point  features/tuples.feature:9:5 Dec 14 01:26:31.403 INFO [stdout]  ✔ And a is not a vector  features/tuples.feature:10:5 Dec 14 01:26:31.403 INFO [stdout]  Dec 14 01:26:31.403 INFO [stdout]  Scenario: A tuple with w=0 is a vector  features/tuples.feature:12:11 Dec 14 01:26:31.403 INFO [stdout]  ✔ Given a := tuple(4.3, -4.2, 3.1, 0.0)  features/tuples.feature:13:3 Dec 14 01:26:31.403 INFO [stdout]  ✔ Then a.x = 4.3  features/tuples.feature:14:3 Dec 14 01:26:31.403 INFO [stdout]  ✔ And a.y = -4.2  features/tuples.feature:15:5 Dec 14 01:26:31.403 INFO [stdout]  ✔ And a.z = 3.1  features/tuples.feature:16:5 Dec 14 01:26:31.403 INFO [stdout]  ✔ And a.w = 0.0  features/tuples.feature:17:5 Dec 14 01:26:31.403 INFO [stdout]  ✔ And a is not a point  features/tuples.feature:18:5 Dec 14 01:26:31.403 INFO [stdout]  ✔ And a is a vector  features/tuples.feature:19:5 Dec 14 01:26:31.403 INFO [stdout]  Dec 14 01:26:31.403 INFO [stdout]  Scenario: "point" describes tuples with w=1  features/tuples.feature:21:11 Dec 14 01:26:31.403 INFO [stdout]  ✔ Given p := point(4, -4, 3)  features/tuples.feature:22:3 Dec 14 01:26:31.403 INFO [stdout]  ✔ Then p = tuple(4, -4, 3, 1)  features/tuples.feature:23:3 Dec 14 01:26:31.403 INFO [stdout]  Dec 14 01:26:31.403 INFO [stdout]  Scenario: "vector" describes tuples with w=0  features/tuples.feature:25:11 Dec 14 01:26:31.403 INFO [stdout]  ✔ Given v := vector(4, -4, 3)  features/tuples.feature:26:3 Dec 14 01:26:31.403 INFO [stdout]  ✔ Then v = tuple(4, -4, 3, 0)  features/tuples.feature:27:3 Dec 14 01:26:31.403 INFO [stdout]  Dec 14 01:26:31.403 INFO [stdout]  Scenario: Adding two tuples  features/tuples.feature:29:11 Dec 14 01:26:31.403 INFO [stdout]  ✔ Given a1 := tuple(3, -2, 5, 1)  features/tuples.feature:30:3 Dec 14 01:26:31.403 INFO [stdout]  ✔ And a2 := tuple(-2, 3, 1, 0)  features/tuples.feature:31:5 Dec 14 01:26:31.403 INFO [stdout]  ✔ Then a1 + a2 = tuple(1, 1, 6, 1)  features/tuples.feature:32:4 Dec 14 01:26:31.403 INFO [stdout]  Dec 14 01:26:31.403 INFO [stdout]  Scenario: Subtracting two points  features/tuples.feature:34:11 Dec 14 01:26:31.403 INFO [stdout]  ✔ Given p1 := point(3, 2, 1)  features/tuples.feature:35:3 Dec 14 01:26:31.403 INFO [stdout]  ✔ And p2 := point(5, 6, 7)  features/tuples.feature:36:5 Dec 14 01:26:31.404 INFO [stdout]  ✔ Then p1 - p2 = vector(-2, -4, -6)  features/tuples.feature:37:3 Dec 14 01:26:31.404 INFO [stdout]  Dec 14 01:26:31.404 INFO [stdout]  Scenario: Subtracting a vector from a point  features/tuples.feature:39:11 Dec 14 01:26:31.404 INFO [stdout]  ✔ Given p := point(3, 2, 1)  features/tuples.feature:40:3 Dec 14 01:26:31.405 INFO [stdout]  ✔ And v := vector(5, 6, 7)  features/tuples.feature:41:5 Dec 14 01:26:31.406 INFO [stdout]  ✔ Then p - v = point(-2, -4, -6)  features/tuples.feature:42:3 Dec 14 01:26:31.407 INFO [stdout]  Dec 14 01:26:31.407 INFO [stdout]  Scenario: Subtracting two vectors  features/tuples.feature:44:11 Dec 14 01:26:31.407 INFO [stdout]  ✔ Given v1 := vector(3, 2, 1)  features/tuples.feature:45:3 Dec 14 01:26:31.407 INFO [stdout]  ✔ And v2 := vector(5, 6, 7)  features/tuples.feature:46:5 Dec 14 01:26:31.411 INFO [stdout]  ✔ Then v1 - v2 = vector(-2, -4, -6)  features/tuples.feature:47:3 Dec 14 01:26:31.411 INFO [stdout]  Dec 14 01:26:31.411 INFO [stdout]  Scenario: Subtracting a vector from the zero vector Dec 14 01:26:31.411 INFO [stdout]  features/tuples.feature:49:11 Dec 14 01:26:31.411 INFO [stdout]  ✔ Given zero := vector(0, 0, 0)  features/tuples.feature:50:3 Dec 14 01:26:31.411 INFO [stdout]  ✔ And v2 := vector(1, -2, 3)  features/tuples.feature:51:5 Dec 14 01:26:31.411 INFO [stdout]  ✔ Then zero - v2 = vector(-1, 2, -3)  features/tuples.feature:52:3 Dec 14 01:26:31.415 INFO [stdout]  Dec 14 01:26:31.415 INFO [stdout]  Scenario: Negating a tuple  features/tuples.feature:54:11 Dec 14 01:26:31.415 INFO [stdout]  ✔ Given a := tuple(1, -2, 3, -4)  features/tuples.feature:55:3 Dec 14 01:26:31.419 INFO [stdout]  ✔ Then -a = tuple(-1, 2, -3, 4)  features/tuples.feature:56:3 Dec 14 01:26:31.419 INFO [stdout]  Dec 14 01:26:31.419 INFO [stdout]  Scenario: Multiplying a tuple by a scalar  features/tuples.feature:58:11 Dec 14 01:26:31.419 INFO [stdout]  ✔ Given a := tuple(1, -2, 3, -4)  features/tuples.feature:59:3 Dec 14 01:26:31.423 INFO [stdout]  ✔ Then a * 3.5 = tuple(3.5, -7, 10.5, -14)  features/tuples.feature:60:3 Dec 14 01:26:31.423 INFO [stdout]  Dec 14 01:26:31.423 INFO [stdout]  Scenario: Multiplying a tuple by a fraction  features/tuples.feature:62:11 Dec 14 01:26:31.423 INFO [stdout]  ✔ Given a := tuple(1, -2, 3, -4)  features/tuples.feature:63:3 Dec 14 01:26:31.423 INFO [stdout]  ✔ Then a * 0.5 = tuple(0.5, -1, 1.5, -2)  features/tuples.feature:64:3 Dec 14 01:26:31.423 INFO [stdout]  Dec 14 01:26:31.423 INFO [stdout]  Scenario: Dividing a tuple by a scalar  features/tuples.feature:66:11 Dec 14 01:26:31.423 INFO [stdout]  ✔ Given a := tuple(1, -2, 3, -4)  features/tuples.feature:67:3 Dec 14 01:26:31.425 INFO [stdout]  ✔ Then a / 2 = tuple(0.5, -1, 1.5, -2)  features/tuples.feature:68:3 Dec 14 01:26:31.425 INFO [stdout]  Dec 14 01:26:31.425 INFO [stdout]  Scenario: Magnitude of vector(1, 0, 0)  features/tuples.feature:70:11 Dec 14 01:26:31.425 INFO [stdout]  ✔ Given v := vector(1, 0, 0)  features/tuples.feature:71:3 Dec 14 01:26:31.426 INFO [stdout]  ✔ Then magnitude(v) = 1  features/tuples.feature:72:3 Dec 14 01:26:31.426 INFO [stdout]  Dec 14 01:26:31.426 INFO [stdout]  Scenario: Magnitude of vector(0, 1, 0)  features/tuples.feature:74:11 Dec 14 01:26:31.426 INFO [stdout]  ✔ Given v := vector(0, 1, 0)  features/tuples.feature:75:3 Dec 14 01:26:31.427 INFO [stdout]  ✔ Then magnitude(v) = 1  features/tuples.feature:76:3 Dec 14 01:26:31.427 INFO [stdout]  Dec 14 01:26:31.427 INFO [stdout]  Scenario: Magnitude of vector(0, 0, 1)  features/tuples.feature:78:11 Dec 14 01:26:31.427 INFO [stdout]  ✔ Given v := vector(0, 0, 1)  features/tuples.feature:79:3 Dec 14 01:26:31.427 INFO [stdout]  ✔ Then magnitude(v) = 1  features/tuples.feature:80:3 Dec 14 01:26:31.427 INFO [stdout]  Dec 14 01:26:31.427 INFO [stdout]  Scenario: Magnitude of vector(1, 2, 3)  features/tuples.feature:82:11 Dec 14 01:26:31.427 INFO [stdout]  ✔ Given v := vector(1, 2, 3)  features/tuples.feature:83:3 Dec 14 01:26:31.427 INFO [stdout]  ✔ Then magnitude(v) = √14  features/tuples.feature:84:3 Dec 14 01:26:31.427 INFO [stdout]  Dec 14 01:26:31.427 INFO [stdout]  Scenario: Magnitude of vector(-1, -2, -3)  features/tuples.feature:86:11 Dec 14 01:26:31.428 INFO [stdout]  ✔ Given v := vector(-1, -2, -3)  features/tuples.feature:87:3 Dec 14 01:26:31.428 INFO [stdout]  ✔ Then magnitude(v) = √14  features/tuples.feature:88:3 Dec 14 01:26:31.428 INFO [stdout]  Dec 14 01:26:31.428 INFO [stdout]  Scenario: Normalizing vector(4, 0, 0) gives (1, 0, 0) Dec 14 01:26:31.428 INFO [stdout]  features/tuples.feature:90:11 Dec 14 01:26:31.428 INFO [stdout]  ✔ Given v := vector(4, 0, 0)  features/tuples.feature:91:3 Dec 14 01:26:31.431 INFO [stdout]  ✔ Then normalize(v) = vector(1, 0, 0)  features/tuples.feature:92:3 Dec 14 01:26:31.433 INFO [stdout]  Dec 14 01:26:31.433 INFO [stdout]  Scenario: Normalizing vector(1, 2, 3)  features/tuples.feature:94:11 Dec 14 01:26:31.433 INFO [stdout]  ✔ Given v := vector(1, 2, 3)  features/tuples.feature:95:3 Dec 14 01:26:31.434 INFO [stdout]  ✔ Then normalize(v) = approximately vector(0.26726, 0.53452, 0.80178) Dec 14 01:26:31.434 INFO [stdout]  features/tuples.feature:97:3 Dec 14 01:26:31.434 INFO [stdout]  Dec 14 01:26:31.434 INFO [stdout]  Scenario: The magnitude of a normalized vector  features/tuples.feature:99:11 Dec 14 01:26:31.439 INFO [stdout]  ✔ Given v := vector(1, 2, 3)  features/tuples.feature:100:3 Dec 14 01:26:31.439 INFO [stdout]  - When norm := normalize(v)  features/tuples.feature:101:3 Dec 14 01:26:31.439 INFO [stdout]  ⚡ Not yet implemented (skipped) Dec 14 01:26:31.439 INFO [stdout]  - Then magnitude(norm) = 1  features/tuples.feature:102:3 Dec 14 01:26:31.439 INFO [stdout]  ⚡ Not yet implemented (skipped) Dec 14 01:26:31.439 INFO [stdout] Dec 14 01:26:31.439 INFO [stdout]  Scenario: The dot product of two tuples  features/tuples.feature:104:11 Dec 14 01:26:31.439 INFO [stdout]  - Given a := vector(1, 2, 3)  features/tuples.feature:105:3 Dec 14 01:26:31.439 INFO [stdout]  ⚡ Not yet implemented (skipped) Dec 14 01:26:31.439 INFO [stdout]  - And b := vector(2, 3, 4)  features/tuples.feature:106:5 Dec 14 01:26:31.439 INFO [stdout]  ⚡ Not yet implemented (skipped) Dec 14 01:26:31.439 INFO [stdout]  - Then a dot b = 20  features/tuples.feature:107:3 Dec 14 01:26:31.439 INFO [stdout]  ⚡ Not yet implemented (skipped) Dec 14 01:26:31.439 INFO [stdout] Dec 14 01:26:31.439 INFO [stdout]  Scenario: Cross product of two vectors  features/tuples.feature:109:11 Dec 14 01:26:31.439 INFO [stdout]  - Given a := vector(1, 2, 3)  features/tuples.feature:110:3 Dec 14 01:26:31.439 INFO [stdout]  ⚡ Not yet implemented (skipped) Dec 14 01:26:31.439 INFO [stdout]  - And b := vector(2, 3, 4)  features/tuples.feature:111:5 Dec 14 01:26:31.439 INFO [stdout]  ⚡ Not yet implemented (skipped) Dec 14 01:26:31.439 INFO [stdout]  - Then a cross b = vector(-1, 2, -1)  features/tuples.feature:112:3 Dec 14 01:26:31.439 INFO [stdout]  ⚡ Not yet implemented (skipped) Dec 14 01:26:31.439 INFO [stdout]  - And b cross a = vector(1, -2, 1)  features/tuples.feature:113:5 Dec 14 01:26:31.439 INFO [stdout]  ⚡ Not yet implemented (skipped) Dec 14 01:26:31.439 INFO [stdout] Dec 14 01:26:31.439 INFO [stdout]  Scenario: Colors are (red, green, blue) tuples  features/tuples.feature:115:11 Dec 14 01:26:31.439 INFO [stdout]  - Given c := color(-0.5, 0.4, 1.7)  features/tuples.feature:116:3 Dec 14 01:26:31.439 INFO [stdout]  ⚡ Not yet implemented (skipped) Dec 14 01:26:31.439 INFO [stdout]  - Then c.red = -0.5  features/tuples.feature:117:3 Dec 14 01:26:31.439 INFO [stdout]  ⚡ Not yet implemented (skipped) Dec 14 01:26:31.439 INFO [stdout]  - And c.green = 0.4  features/tuples.feature:118:5 Dec 14 01:26:31.439 INFO [stdout]  ⚡ Not yet implemented (skipped) Dec 14 01:26:31.439 INFO [stdout]  - And c.blue = 1.7  features/tuples.feature:119:5 Dec 14 01:26:31.439 INFO [stdout]  ⚡ Not yet implemented (skipped) Dec 14 01:26:31.439 INFO [stdout] Dec 14 01:26:31.440 INFO [stdout]  Scenario: Adding colors  features/tuples.feature:121:11 Dec 14 01:26:31.440 INFO [stdout]  - Given c1 := color(0.9, 0.6, 0.75)  features/tuples.feature:122:3 Dec 14 01:26:31.440 INFO [stdout]  ⚡ Not yet implemented (skipped) Dec 14 01:26:31.440 INFO [stdout]  - And c2 := color(0.7, 0.1, 0.25)  features/tuples.feature:123:5 Dec 14 01:26:31.440 INFO [stdout]  ⚡ Not yet implemented (skipped) Dec 14 01:26:31.440 INFO [stdout]  - Then c1 + c2 = color(1.6, 0.7, 1.0)  features/tuples.feature:124:4 Dec 14 01:26:31.440 INFO [stdout]  ⚡ Not yet implemented (skipped) Dec 14 01:26:31.440 INFO [stdout] Dec 14 01:26:31.440 INFO [stdout]  Scenario: Subtracting colors  features/tuples.feature:126:11 Dec 14 01:26:31.440 INFO [stdout]  - Given c1 := color(0.9, 0.6, 0.75)  features/tuples.feature:127:3 Dec 14 01:26:31.440 INFO [stdout]  ⚡ Not yet implemented (skipped) Dec 14 01:26:31.440 INFO [stdout]  - And c2 := color(0.7, 0.1, 0.25)  features/tuples.feature:128:5 Dec 14 01:26:31.440 INFO [stdout]  ⚡ Not yet implemented (skipped) Dec 14 01:26:31.440 INFO [stdout]  - Then c1 - c2 = color(0.2, 0.5, 0.5)  features/tuples.feature:129:4 Dec 14 01:26:31.440 INFO [stdout]  ⚡ Not yet implemented (skipped) Dec 14 01:26:31.440 INFO [stdout] Dec 14 01:26:31.440 INFO [stdout]  Scenario: Multiplying a color by a scalar  features/tuples.feature:131:11 Dec 14 01:26:31.440 INFO [stdout]  - Given c := color(0.2, 0.3, 0.4)  features/tuples.feature:132:3 Dec 14 01:26:31.440 INFO [stdout]  ⚡ Not yet implemented (skipped) Dec 14 01:26:31.440 INFO [stdout]  - Then c * 2 = color(0.4, 0.6, 0.8)  features/tuples.feature:133:3 Dec 14 01:26:31.440 INFO [stdout]  ⚡ Not yet implemented (skipped) Dec 14 01:26:31.440 INFO [stdout] Dec 14 01:26:31.440 INFO [stdout]  Scenario: Multiplying colors  features/tuples.feature:135:11 Dec 14 01:26:31.440 INFO [stdout]  - Given c1 := color(1, 0.2, 0.4)  features/tuples.feature:136:3 Dec 14 01:26:31.440 INFO [stdout]  ⚡ Not yet implemented (skipped) Dec 14 01:26:31.440 INFO [stdout]  - And c2 := color(0.9, 1, 0.1)  features/tuples.feature:137:5 Dec 14 01:26:31.440 INFO [stdout]  ⚡ Not yet implemented (skipped) Dec 14 01:26:31.440 INFO [stdout]  - Then c1 * c2 = color(0.9, 0.2, 0.04)  features/tuples.feature:138:4 Dec 14 01:26:31.440 INFO [stdout]  ⚡ Not yet implemented (skipped) Dec 14 01:26:31.440 INFO [stdout] Dec 14 01:26:31.440 INFO [stdout]  Scenario: Reflecting a vector approaching at 45° Dec 14 01:26:31.440 INFO [stdout]  features/tuples.feature:140:11 Dec 14 01:26:31.440 INFO [stdout]  ✔ Given v := vector(1, -1, 0)  features/tuples.feature:141:3 Dec 14 01:26:31.440 INFO [stdout]  - And n := vector(0, 1, 0)  features/tuples.feature:142:5 Dec 14 01:26:31.440 INFO [stdout]  ⚡ Not yet implemented (skipped) Dec 14 01:26:31.440 INFO [stdout]  - When r := reflect(v, n)  features/tuples.feature:143:3 Dec 14 01:26:31.440 INFO [stdout]  ⚡ Not yet implemented (skipped) Dec 14 01:26:31.440 INFO [stdout]  - Then r = vector(1, 1, 0)  features/tuples.feature:144:3 Dec 14 01:26:31.440 INFO [stdout]  ⚡ Not yet implemented (skipped) Dec 14 01:26:31.440 INFO [stdout] Dec 14 01:26:31.440 INFO [stdout]  Scenario: Reflecting a vector off a slanted surface Dec 14 01:26:31.440 INFO [stdout]  features/tuples.feature:146:11 Dec 14 01:26:31.440 INFO [stdout]  ✔ Given v := vector(0, -1, 0)  features/tuples.feature:147:3 Dec 14 01:26:31.440 INFO [stdout]  - And n := vector(√2/2, √2/2, 0)  features/tuples.feature:148:5 Dec 14 01:26:31.440 INFO [stdout]  ⚡ Not yet implemented (skipped) Dec 14 01:26:31.440 INFO [stdout]  - When r := reflect(v, n)  features/tuples.feature:149:3 Dec 14 01:26:31.440 INFO [stdout]  ⚡ Not yet implemented (skipped) Dec 14 01:26:31.440 INFO [stdout]  - Then r = vector(1, 0, 0)  features/tuples.feature:150:3 Dec 14 01:26:31.440 INFO [stdout]  ⚡ Not yet implemented (skipped) Dec 14 01:26:31.440 INFO [stdout] Dec 14 01:26:31.440 INFO [stdout] 1 features Dec 14 01:26:31.440 INFO [stdout] 30 scenarios (10 skipped, 20 passed) Dec 14 01:26:31.440 INFO [stdout] 88 steps (30 skipped, 58 passed) Dec 14 01:26:31.440 INFO [stdout]  Dec 14 01:26:31.440 INFO [stderr] Doc-tests raytracer_challenge Dec 14 01:26:32.005 INFO [stdout] Dec 14 01:26:32.005 INFO [stdout] running 0 tests Dec 14 01:26:32.005 INFO [stdout] Dec 14 01:26:32.005 INFO [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out Dec 14 01:26:32.005 INFO [stdout] Dec 14 01:26:32.012 INFO [stderr] su: No module specific data is present Dec 14 01:26:32.309 INFO running `"docker" "inspect" "682b6d4e95a09676dbfb35e2a87d35cdb7e5f1759e242a955976b65ff0227fa3"` Dec 14 01:26:32.598 INFO running `"docker" "rm" "-f" "682b6d4e95a09676dbfb35e2a87d35cdb7e5f1759e242a955976b65ff0227fa3"` Dec 14 01:26:32.736 INFO [stdout] 682b6d4e95a09676dbfb35e2a87d35cdb7e5f1759e242a955976b65ff0227fa3