Sep 21 13:09:56.962 INFO checking axpy-0.3.0 against master#f7f4c500b46603386e940f116b469c7adc043a6d for pr-54394
Sep 21 13:09:56.962 INFO running: cargo +f7f4c500b46603386e940f116b469c7adc043a6d-alt check --frozen --all --all-targets
Sep 21 13:09:56.962 INFO running `"docker" "create" "-v" "/home/ec2-user/crater/./work/local/test-source/worker-0/pr-54394/master#f7f4c500b46603386e940f116b469c7adc043a6d:/source:ro,Z" "-v" "/home/ec2-user/crater/./work/local/target-dirs/pr-54394/worker-0/master#f7f4c500b46603386e940f116b469c7adc043a6d:/target:rw,Z" "-v" "/home/ec2-user/crater/./work/local/cargo-home:/cargo-home:ro,Z" "-v" "/home/ec2-user/crater/./work/local/rustup-home:/rustup-home:ro,Z" "-e" "USER_ID=1000" "-e" "CMD=cargo +f7f4c500b46603386e940f116b469c7adc043a6d-alt check --frozen --all --all-targets" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-m" "1536M" "crater"`
Sep 21 13:09:57.211 INFO blam! 3ea5f1c3b9e21b777a05e2dc24a00fd373e3fa8df65e1951fc1ec664fa97c82b
Sep 21 13:09:57.213 INFO running `"docker" "start" "-a" "3ea5f1c3b9e21b777a05e2dc24a00fd373e3fa8df65e1951fc1ec664fa97c82b"`
Sep 21 13:09:58.414 INFO kablam! usermod: no changes
Sep 21 13:09:58.466 INFO kablam!     Checking axpy v0.3.0 (/source)
Sep 21 13:09:59.404 INFO kablam! note: trace_macro
Sep 21 13:09:59.405 INFO kablam!   --> tests/trace.rs:20:5
Sep 21 13:09:59.405 INFO kablam!    |
Sep 21 13:09:59.405 INFO kablam! 20 |     axpy![z = 2.*z - x + 3. * y];
Sep 21 13:09:59.405 INFO kablam!    |     ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Sep 21 13:09:59.406 INFO kablam!    |
Sep 21 13:09:59.406 INFO kablam!    = note: expanding `axpy! { z = 2. * z - x + 3. * y }`
Sep 21 13:09:59.406 INFO kablam!    = note: to `axpy ! [ ! z = (  ) 2. * z - x + 3. * y + . ]`
Sep 21 13:09:59.406 INFO kablam!    = note: expanding `axpy! { ! z = (  ) 2. * z - x + 3. * y + . }`
Sep 21 13:09:59.407 INFO kablam!    = note: to `axpy ! [ ! z = ( 2. * z ) - x + 3. * y + . ]`
Sep 21 13:09:59.407 INFO kablam!    = note: expanding `axpy! { ! z = ( 2. * z ) - x + 3. * y + . }`
Sep 21 13:09:59.407 INFO kablam!    = note: to `axpy ! [ ! z = ( 2. * z 0 - x ) + 3. * y + . ]`
Sep 21 13:09:59.408 INFO kablam!    = note: expanding `axpy! { ! z = ( 2. * z 0 - x ) + 3. * y + . }`
Sep 21 13:09:59.408 INFO kablam!    = note: to `axpy ! [ ! z = ( 2. * z 0 - x 3. * y ) + . ]`
Sep 21 13:09:59.408 INFO kablam!    = note: expanding `axpy! { ! z = ( 2. * z 0 - x 3. * y ) + . }`
Sep 21 13:09:59.408 INFO kablam!    = note: to `for ( car , cdr ) in axpy ! [ @ z ; z . iter_mut (  ) ; 2. * z 0 - x 3. * y ]
Sep 21 13:09:59.409 INFO kablam!            { * car = axpy ! [ # z ; car ; cdr ; (  ) 2. * z 0 - x 3. * y ] ; }`
Sep 21 13:09:59.409 INFO kablam!    = note: expanding `axpy! { @ z ; z . iter_mut (  ) ; 2. * z 0 - x 3. * y }`
Sep 21 13:09:59.409 INFO kablam!    = note: to `{
Sep 21 13:09:59.409 INFO kablam!            macro_rules ! eval {
Sep 21 13:09:59.410 INFO kablam!            ( z z ) => { axpy ! [ @ z ; z.iter_mut() ; 0 - x 3. * y ] } ; ( z z ) => {
Sep 21 13:09:59.410 INFO kablam!            z.iter_mut() . zip ( axpy ! [ @ z ; z . iter (  ) ; 0 - x 3. * y ] ) } ; }
Sep 21 13:09:59.410 INFO kablam!            eval ! ( z z ) }`
Sep 21 13:09:59.410 INFO kablam!    = note: expanding `eval! { z z }`
Sep 21 13:09:59.411 INFO kablam!    = note: to `axpy ! [ @ z ; z.iter_mut() ; 0 - x 3. * y ]`
Sep 21 13:09:59.411 INFO kablam!    = note: expanding `axpy! { @ z ; z.iter_mut() ; 0 - x 3. * y }`
Sep 21 13:09:59.411 INFO kablam!    = note: to `{
Sep 21 13:09:59.411 INFO kablam!            macro_rules ! eval {
Sep 21 13:09:59.412 INFO kablam!            ( z z ) => { axpy ! [ @ z ; z.iter_mut() ; 3. * y ] } ; ( x z ) => {
Sep 21 13:09:59.412 INFO kablam!            z.iter_mut() . zip ( axpy ! [ @ z ; x . iter (  ) ; 3. * y ] ) } ; } eval ! (
Sep 21 13:09:59.412 INFO kablam!            x z ) }`
Sep 21 13:09:59.412 INFO kablam!    = note: expanding `eval! { x z }`
Sep 21 13:09:59.413 INFO kablam!    = note: to `z.iter_mut() . zip ( axpy ! [ @ z ; x . iter (  ) ; 3. * y ] )`
Sep 21 13:09:59.413 INFO kablam!    = note: expanding `axpy! { @ z ; x . iter (  ) ; 3. * y }`
Sep 21 13:09:59.413 INFO kablam!    = note: to `{
Sep 21 13:09:59.413 INFO kablam!            macro_rules ! eval {
Sep 21 13:09:59.414 INFO kablam!            ( z z ) => { axpy ! [ @ z ; x.iter() ; ] } ; ( y z ) => {
Sep 21 13:09:59.414 INFO kablam!            x.iter() . zip ( axpy ! [ @ z ; y . iter (  ) ; ] ) } ; } eval ! ( y z ) }`
Sep 21 13:09:59.414 INFO kablam!    = note: expanding `eval! { y z }`
Sep 21 13:09:59.415 INFO kablam!    = note: to `x.iter() . zip ( axpy ! [ @ z ; y . iter (  ) ; ] )`
Sep 21 13:09:59.415 INFO kablam!    = note: expanding `axpy! { @ z ; y . iter (  ) ; }`
Sep 21 13:09:59.415 INFO kablam!    = note: to `y.iter() . map ( | x | ( x , ) )`
Sep 21 13:09:59.415 INFO kablam!    = note: expanding `axpy! { # z ; car ; cdr ; (  ) 2. * z 0 - x 3. * y }`
Sep 21 13:09:59.415 INFO kablam!    = note: to `{
Sep 21 13:09:59.415 INFO kablam!            macro_rules ! eval {
Sep 21 13:09:59.415 INFO kablam!            ( z z ) => { axpy ! [ # z ; car ; cdr ; ( + 2. * * car ) 0 - x 3. * y ] } ; (
Sep 21 13:09:59.415 INFO kablam!            z z ) => { axpy ! [ # z ; car ; cdr . 1 ; ( + 2. * * cdr . 0 ) 0 - x 3. * y ]
Sep 21 13:09:59.415 INFO kablam!            } ; } eval ! ( z z ) }`
Sep 21 13:09:59.415 INFO kablam!    = note: expanding `eval! { z z }`
Sep 21 13:09:59.416 INFO kablam!    = note: to `axpy ! [ # z ; car ; cdr ; ( + 2. * * car ) 0 - x 3. * y ]`
Sep 21 13:09:59.416 INFO kablam!    = note: expanding `axpy! { # z ; car ; cdr ; ( + 2. * * car ) 0 - x 3. * y }`
Sep 21 13:09:59.416 INFO kablam!    = note: to `{
Sep 21 13:09:59.416 INFO kablam!            macro_rules ! eval {
Sep 21 13:09:59.416 INFO kablam!            ( z z ) => { axpy ! [ # z ; car ; cdr ; ( + 2. * * car + - * car ) 3. * y ] }
Sep 21 13:09:59.416 INFO kablam!            ; ( x z ) => {
Sep 21 13:09:59.416 INFO kablam!            axpy ! [ # z ; car ; cdr . 1 ; ( + 2. * * car + - * cdr . 0 ) 3. * y ] } ; }
Sep 21 13:09:59.417 INFO kablam!            eval ! ( x z ) }`
Sep 21 13:09:59.417 INFO kablam!    = note: expanding `eval! { x z }`
Sep 21 13:09:59.417 INFO kablam!    = note: to `axpy ! [ # z ; car ; cdr . 1 ; ( + 2. * * car + - * cdr . 0 ) 3. * y ]`
Sep 21 13:09:59.417 INFO kablam!    = note: expanding `axpy! { # z ; car ; cdr . 1 ; ( + 2. * * car + - * cdr . 0 ) 3. * y }`
Sep 21 13:09:59.417 INFO kablam!    = note: to `{
Sep 21 13:09:59.417 INFO kablam!            macro_rules ! eval {
Sep 21 13:09:59.417 INFO kablam!            ( z z ) => {
Sep 21 13:09:59.418 INFO kablam!            axpy ! [ # z ; car ; cdr.1 ; ( + 2. * * car + - * cdr . 0 + 3. * * car ) ] } ;
Sep 21 13:09:59.418 INFO kablam!            ( y z ) => {
Sep 21 13:09:59.418 INFO kablam!            axpy ! [
Sep 21 13:09:59.418 INFO kablam!            # z ; car ; cdr.1 . 1 ; ( + 2. * * car + - * cdr . 0 + 3. * * cdr.1 . 0 ) ] }
Sep 21 13:09:59.418 INFO kablam!            ; } eval ! ( y z ) }`
Sep 21 13:09:59.418 INFO kablam!    = note: expanding `eval! { y z }`
Sep 21 13:09:59.419 INFO kablam!    = note: to `axpy ! [
Sep 21 13:09:59.419 INFO kablam!            # z ; car ; cdr.1 . 1 ; ( + 2. * * car + - * cdr . 0 + 3. * * cdr.1 . 0 ) ]`
Sep 21 13:09:59.419 INFO kablam!    = note: expanding `axpy! { # z ; car ; cdr.1 . 1 ; ( + 2. * * car + - * cdr . 0 + 3. * * cdr.1 . 0 ) }`
Sep 21 13:09:59.419 INFO kablam!    = note: to `2. * * car + - * cdr . 0 + 3. * * cdr.1 . 0`
Sep 21 13:09:59.419 INFO kablam! 
Sep 21 13:09:59.419 INFO kablam! note: trace_macro
Sep 21 13:09:59.419 INFO kablam!   --> tests/trace.rs:11:5
Sep 21 13:09:59.420 INFO kablam!    |
Sep 21 13:09:59.420 INFO kablam! 11 |     axpy![z = x + y];
Sep 21 13:09:59.420 INFO kablam!    |     ^^^^^^^^^^^^^^^^^
Sep 21 13:09:59.420 INFO kablam!    |
Sep 21 13:09:59.420 INFO kablam!    = note: expanding `axpy! { z = x + y }`
Sep 21 13:09:59.420 INFO kablam!    = note: to `axpy ! [ ! z = (  ) x + y + . ]`
Sep 21 13:09:59.421 INFO kablam!    = note: expanding `axpy! { ! z = (  ) x + y + . }`
Sep 21 13:09:59.421 INFO kablam!    = note: to `axpy ! [ ! z = ( 0 + x ) + y + . ]`
Sep 21 13:09:59.421 INFO kablam!    = note: expanding `axpy! { ! z = ( 0 + x ) + y + . }`
Sep 21 13:09:59.421 INFO kablam!    = note: to `axpy ! [ ! z = ( 0 + x 0 + y ) + . ]`
Sep 21 13:09:59.421 INFO kablam!    = note: expanding `axpy! { ! z = ( 0 + x 0 + y ) + . }`
Sep 21 13:09:59.421 INFO kablam!    = note: to `for ( car , cdr ) in axpy ! [ @ z ; z . iter_mut (  ) ; 0 + x 0 + y ] {
Sep 21 13:09:59.422 INFO kablam!            * car = axpy ! [ # z ; car ; cdr ; (  ) 0 + x 0 + y ] ; }`
Sep 21 13:09:59.422 INFO kablam!    = note: expanding `axpy! { @ z ; z . iter_mut (  ) ; 0 + x 0 + y }`
Sep 21 13:09:59.422 INFO kablam!    = note: to `{
Sep 21 13:09:59.422 INFO kablam!            macro_rules ! eval {
Sep 21 13:09:59.422 INFO kablam!            ( z z ) => { axpy ! [ @ z ; z.iter_mut() ; 0 + y ] } ; ( x z ) => {
Sep 21 13:09:59.422 INFO kablam!            z.iter_mut() . zip ( axpy ! [ @ z ; x . iter (  ) ; 0 + y ] ) } ; } eval ! (
Sep 21 13:09:59.423 INFO kablam!            x z ) }`
Sep 21 13:09:59.423 INFO kablam!    = note: expanding `eval! { x z }`
Sep 21 13:09:59.423 INFO kablam!    = note: to `z.iter_mut() . zip ( axpy ! [ @ z ; x . iter (  ) ; 0 + y ] )`
Sep 21 13:09:59.423 INFO kablam!    = note: expanding `axpy! { @ z ; x . iter (  ) ; 0 + y }`
Sep 21 13:09:59.423 INFO kablam!    = note: to `{
Sep 21 13:09:59.423 INFO kablam!            macro_rules ! eval {
Sep 21 13:09:59.424 INFO kablam!            ( z z ) => { axpy ! [ @ z ; x.iter() ; ] } ; ( y z ) => {
Sep 21 13:09:59.424 INFO kablam!            x.iter() . zip ( axpy ! [ @ z ; y . iter (  ) ; ] ) } ; } eval ! ( y z ) }`
Sep 21 13:09:59.424 INFO kablam!    = note: expanding `eval! { y z }`
Sep 21 13:09:59.424 INFO kablam!    = note: to `x.iter() . zip ( axpy ! [ @ z ; y . iter (  ) ; ] )`
Sep 21 13:09:59.424 INFO kablam!    = note: expanding `axpy! { @ z ; y . iter (  ) ; }`
Sep 21 13:09:59.424 INFO kablam!    = note: to `y.iter() . map ( | x | ( x , ) )`
Sep 21 13:09:59.425 INFO kablam!    = note: expanding `axpy! { # z ; car ; cdr ; (  ) 0 + x 0 + y }`
Sep 21 13:09:59.425 INFO kablam!    = note: to `{
Sep 21 13:09:59.425 INFO kablam!            macro_rules ! eval {
Sep 21 13:09:59.425 INFO kablam!            ( z z ) => { axpy ! [ # z ; car ; cdr ; ( + * car ) 0 + y ] } ; ( x z ) => {
Sep 21 13:09:59.425 INFO kablam!            axpy ! [ # z ; car ; cdr . 1 ; ( + * cdr . 0 ) 0 + y ] } ; } eval ! ( x z ) }`
Sep 21 13:09:59.425 INFO kablam!    = note: expanding `eval! { x z }`
Sep 21 13:09:59.426 INFO kablam!    = note: to `axpy ! [ # z ; car ; cdr . 1 ; ( + * cdr . 0 ) 0 + y ]`
Sep 21 13:09:59.426 INFO kablam!    = note: expanding `axpy! { # z ; car ; cdr . 1 ; ( + * cdr . 0 ) 0 + y }`
Sep 21 13:09:59.426 INFO kablam!    = note: to `{
Sep 21 13:09:59.426 INFO kablam!            macro_rules ! eval {
Sep 21 13:09:59.426 INFO kablam!            ( z z ) => { axpy ! [ # z ; car ; cdr.1 ; ( + * cdr . 0 + * car ) ] } ; ( y z
Sep 21 13:09:59.426 INFO kablam!            ) => { axpy ! [ # z ; car ; cdr.1 . 1 ; ( + * cdr . 0 + * cdr.1 . 0 ) ] } ; }
Sep 21 13:09:59.427 INFO kablam!            eval ! ( y z ) }`
Sep 21 13:09:59.427 INFO kablam!    = note: expanding `eval! { y z }`
Sep 21 13:09:59.427 INFO kablam!    = note: to `axpy ! [ # z ; car ; cdr.1 . 1 ; ( + * cdr . 0 + * cdr.1 . 0 ) ]`
Sep 21 13:09:59.427 INFO kablam!    = note: expanding `axpy! { # z ; car ; cdr.1 . 1 ; ( + * cdr . 0 + * cdr.1 . 0 ) }`
Sep 21 13:09:59.427 INFO kablam!    = note: to `* cdr . 0 + * cdr.1 . 0`
Sep 21 13:09:59.427 INFO kablam! 
Sep 21 13:09:59.427 INFO kablam! note: trace_macro
Sep 21 13:09:59.428 INFO kablam!   --> tests/trace.rs:12:5
Sep 21 13:09:59.428 INFO kablam!    |
Sep 21 13:09:59.428 INFO kablam! 12 |     assert_eq!(z, [5, 5, 5, 5]);
Sep 21 13:09:59.428 INFO kablam!    |     ^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Sep 21 13:09:59.428 INFO kablam!    |
Sep 21 13:09:59.428 INFO kablam!    = note: expanding `assert_eq! { z , [ 5 , 5 , 5 , 5 ] }`
Sep 21 13:09:59.428 INFO kablam!    = note: to `{
Sep 21 13:09:59.429 INFO kablam!            match ( & z , & [5, 5, 5, 5] ) {
Sep 21 13:09:59.429 INFO kablam!            ( left_val , right_val ) => {
Sep 21 13:09:59.429 INFO kablam!            if ! ( * left_val == * right_val ) {
Sep 21 13:09:59.429 INFO kablam!            panic ! (
Sep 21 13:09:59.429 INFO kablam!            r#"assertion failed: `(left == right)`
Sep 21 13:09:59.429 INFO kablam!              left: `{:?}`,
Sep 21 13:09:59.430 INFO kablam!             right: `{:?}`"# ,
Sep 21 13:09:59.430 INFO kablam!            left_val , right_val ) } } } }`
Sep 21 13:09:59.430 INFO kablam!    = note: expanding `panic! { r#"assertion failed: `(left == right)`
Sep 21 13:09:59.430 INFO kablam!              left: `{:?}`,
Sep 21 13:09:59.430 INFO kablam!             right: `{:?}`"# ,
Sep 21 13:09:59.430 INFO kablam!            left_val , right_val }`
Sep 21 13:09:59.431 INFO kablam!    = note: to `{
Sep 21 13:09:59.431 INFO kablam!            $crate :: rt :: begin_panic_fmt (
Sep 21 13:09:59.431 INFO kablam!            & format_args ! (
Sep 21 13:09:59.431 INFO kablam!            r#"assertion failed: `(left == right)`
Sep 21 13:09:59.431 INFO kablam!              left: `{:?}`,
Sep 21 13:09:59.431 INFO kablam!             right: `{:?}`"# ,
Sep 21 13:09:59.431 INFO kablam!            left_val , right_val ) , & (
Sep 21 13:09:59.432 INFO kablam!            file ! (  ) , line ! (  ) , __rust_unstable_column ! (  ) ) ) }`
Sep 21 13:09:59.432 INFO kablam! 
Sep 21 13:09:59.432 INFO kablam! note: trace_macro
Sep 21 13:09:59.432 INFO kablam!   --> tests/trace.rs:21:5
Sep 21 13:09:59.432 INFO kablam!    |
Sep 21 13:09:59.432 INFO kablam! 21 |     assert_eq!(z, [31f64, 207., 2003., 19999.]);
Sep 21 13:09:59.432 INFO kablam!    |     ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
Sep 21 13:09:59.433 INFO kablam!    |
Sep 21 13:09:59.433 INFO kablam!    = note: expanding `assert_eq! { z , [ 31f64 , 207. , 2003. , 19999. ] }`
Sep 21 13:09:59.433 INFO kablam!    = note: to `{
Sep 21 13:09:59.433 INFO kablam!            match ( & z , & [31f64, 207., 2003., 19999.] ) {
Sep 21 13:09:59.433 INFO kablam!            ( left_val , right_val ) => {
Sep 21 13:09:59.433 INFO kablam!            if ! ( * left_val == * right_val ) {
Sep 21 13:09:59.433 INFO kablam!            panic ! (
Sep 21 13:09:59.434 INFO kablam!            r#"assertion failed: `(left == right)`
Sep 21 13:09:59.434 INFO kablam!              left: `{:?}`,
Sep 21 13:09:59.434 INFO kablam!             right: `{:?}`"# ,
Sep 21 13:09:59.434 INFO kablam!            left_val , right_val ) } } } }`
Sep 21 13:09:59.434 INFO kablam!    = note: expanding `panic! { r#"assertion failed: `(left == right)`
Sep 21 13:09:59.434 INFO kablam!              left: `{:?}`,
Sep 21 13:09:59.435 INFO kablam!             right: `{:?}`"# ,
Sep 21 13:09:59.435 INFO kablam!            left_val , right_val }`
Sep 21 13:09:59.435 INFO kablam!    = note: to `{
Sep 21 13:09:59.435 INFO kablam!            $crate :: rt :: begin_panic_fmt (
Sep 21 13:09:59.435 INFO kablam!            & format_args ! (
Sep 21 13:09:59.435 INFO kablam!            r#"assertion failed: `(left == right)`
Sep 21 13:09:59.436 INFO kablam!              left: `{:?}`,
Sep 21 13:09:59.436 INFO kablam!             right: `{:?}`"# ,
Sep 21 13:09:59.436 INFO kablam!            left_val , right_val ) , & (
Sep 21 13:09:59.436 INFO kablam!            file ! (  ) , line ! (  ) , __rust_unstable_column ! (  ) ) ) }`
Sep 21 13:09:59.436 INFO kablam! 
Sep 21 13:09:59.598 INFO kablam!     Finished dev [unoptimized + debuginfo] target(s) in 1.16s
Sep 21 13:09:59.598 INFO kablam! su: No module specific data is present
Sep 21 13:10:01.143 INFO running `"docker" "rm" "-f" "3ea5f1c3b9e21b777a05e2dc24a00fd373e3fa8df65e1951fc1ec664fa97c82b"`
Sep 21 13:10:01.287 INFO blam! 3ea5f1c3b9e21b777a05e2dc24a00fd373e3fa8df65e1951fc1ec664fa97c82b