t/storage/debug.t

   1 use strict;
   2 use warnings;
   3 no warnings 'once';
   4
   5 use Test::More;
   6 use Test::Exception;
   7 use lib qw(t/lib);
   8 use DBICTest;
   9 use DBIC::DebugObj;
  10 use DBIC::SqlMakerTest;
  11 use Path::Class qw/file/;
  12
  13 BEGIN { delete @ENV{qw(DBIC_TRACE DBIC_TRACE_PROFILE DBICTEST_SQLITE_USE_FILE)} }
  14
  15 my $schema = DBICTest->init_schema();
  16
  17 my $lfn = file("t/var/sql-$$.log");
  18 unlink $lfn or die $!
  19   if -e $lfn;
  20
  21 # make sure we are testing the vanilla debugger and not ::PrettyPrint
  22 $schema->storage->debugobj(DBIx::Class::Storage::Statistics->new);
  23
  24 ok ( $schema->storage->debug(1), 'debug' );
  25 $schema->storage->debugfh($lfn->openw);
  26 $schema->storage->debugfh->autoflush(1);
  27 $schema->resultset('CD')->count;
  28
  29 my @loglines = $lfn->slurp;
  30 is (@loglines, 1, 'one line of log');
  31 like($loglines[0], qr/^SELECT COUNT/, 'File log via debugfh success');
  32
  33 $schema->storage->debugfh(undef);
  34
  35 {
  36   local $ENV{DBIC_TRACE} = "=$lfn";
  37   unlink $lfn;
  38
  39   $schema->resultset('CD')->count;
  40
  41   my $schema2 = DBICTest->init_schema(no_deploy => 1);
  42   $schema2->storage->_do_query('SELECT 1'); # _do_query() logs via standard mechanisms
  43
  44   my @loglines = $lfn->slurp;
  45   is(@loglines, 2, '2 lines of log');
  46   like($loglines[0], qr/^SELECT COUNT/, 'Env log from schema1 success');
  47   like($loglines[1], qr/^SELECT 1:/, 'Env log from schema2 success');
  48
  49   $schema->storage->debugobj->debugfh(undef)
  50 }
  51
  52 END {
  53   unlink $lfn;
  54 }
  55
  56 open(STDERRCOPY, '>&STDERR');
  57 close(STDERR);
  58 dies_ok {
  59   $schema->resultset('CD')->search({})->count;
  60 } 'Died on closed FH';
  61
  62 open(STDERR, '>&STDERRCOPY');
  63
  64 # test trace output correctness for bind params
  65 {
  66     my ($sql, @bind);
  67     $schema->storage->debugobj(DBIC::DebugObj->new(\$sql, \@bind));
  68
  69     my @cds = $schema->resultset('CD')->search( { artist => 1, cdid => { -between => [ 1, 3 ] }, } );
  70     is_same_sql_bind(
  71         $sql, \@bind,
  72         "SELECT me.cdid, me.artist, me.title, me.year, me.genreid, me.single_track FROM cd me WHERE ( artist = ? AND (cdid BETWEEN ? AND ?) )",
  73         [qw/'1' '1' '3'/],
  74         'got correct SQL with all bind parameters (debugcb)'
  75     );
  76
  77     @cds = $schema->resultset('CD')->search( { artist => 1, cdid => { -between => [ 1, 3 ] }, } );
  78     is_same_sql_bind(
  79         $sql, \@bind,
  80         "SELECT me.cdid, me.artist, me.title, me.year, me.genreid, me.single_track FROM cd me WHERE ( artist = ? AND (cdid BETWEEN ? AND ?) )", ["'1'", "'1'", "'3'"],
  81         'got correct SQL with all bind parameters (debugobj)'
  82     );
  83 }
  84
  85 done_testing;