X-Git-Url: http://wagnertech.de/git?a=blobdiff_plain;f=SL%2FLXDebug.pm;h=047d2b0b611e6000442fb9192f355c263fd8cb84;hb=5df2b57a097f66f6cecba0aa577c7aaba3422ab6;hp=d1abcd0fbf5a6272419bc0896c05c8241d46f2a3;hpb=4dbb09950c9f5596646537c12d991c99086fe7c1;p=kivitendo-erp.git diff --git a/SL/LXDebug.pm b/SL/LXDebug.pm index d1abcd0fb..047d2b0b6 100644 --- a/SL/LXDebug.pm +++ b/SL/LXDebug.pm @@ -1,39 +1,46 @@ package LXDebug; -use constant { - NONE => 0, - INFO => 1, - DEBUG1 => 2, - DEBUG2 => 3, - - FILE_TARGET => 0, - STDERR_TARGET => 1 - }; +use constant NONE => 0; +use constant INFO => 1; +use constant DEBUG1 => 1 << 1; +use constant DEBUG2 => 1 << 2; +use constant QUERY => 1 << 3; +use constant TRACE => 1 << 4; +use constant BACKTRACE_ON_ERROR => 1 << 5; +use constant ALL => (1 << 6) - 1; +use constant DEVEL => INFO | QUERY | TRACE | BACKTRACE_ON_ERROR; + +use constant FILE_TARGET => 0; +use constant STDERR_TARGET => 1; use POSIX qw(strftime); +use YAML; + my $data_dumper_available; +our $global_level; +our $watch_form; + BEGIN { eval("use Data::Dumper"); $data_dumper_available = $@ ? 0 : 1; - $global_level = NONE; - $global_trace_subs = 0; + $global_level = NONE; + $watch_form = 0; } sub new { my $type = shift; my $self = {}; - $self->{"calldepth"} = 0; - $self->{"file"} = "/tmp/lx-office-debug.log"; - $self->{"target"} = FILE_TARGET; - $self->{"level"} = 0; - $self->{"trace_subs"} = 0; + $self->{"calldepth"} = 0; + $self->{"file"} = "/tmp/lx-office-debug.log"; + $self->{"target"} = FILE_TARGET; + $self->{"level"} = 0; while ($_[0]) { - $self->{$_[0]} = $_[1]; + $self->{ $_[0] } = $_[1]; shift; shift; } @@ -45,7 +52,7 @@ sub set_target { my ($self, $target, $file) = @_; if ((FILE_TARGET == $target) && $file) { - $self->{"file"} = $file; + $self->{"file"} = $file; $self->{"target"} = FILE_TARGET; } elsif (STDERR_TARGET == $target) { @@ -54,82 +61,141 @@ sub set_target { } sub enter_sub { - my ($self) = @_; + my ($self, $level) = @_; + $level *= 1; - if (!$self->{"trace_subs"} && !$global_trace_subs) { - return; - } + return 1 unless ($global_level & TRACE); # ignore if traces aren't active + return 1 if $level && !($global_level & $level); # ignore if level of trace isn't active my ($package, $filename, $line, $subroutine) = caller(1); my ($dummy1, $self_filename, $self_line) = caller(0); - my $indent = " " x $self->{"calldepth"}; - $self->{"calldepth"} += 1; + my $indent = " " x $self->{"calldepth"}++; if (!defined($package)) { - $self->_write("enter_sub", $indent . "top-level?\n"); + $self->_write('sub' . $level, $indent . "\\ top-level?\n"); } else { - $self->_write("enter_sub", $indent . "${subroutine} in " . - "${self_filename}:${self_line} called from " . - "${filename}:${line}\n"); + $self->_write('sub' . $level, $indent + . "\\ ${subroutine} in " + . "${self_filename}:${self_line} called from " + . "${filename}:${line}\n"); } + return 1; } sub leave_sub { - my ($self) = @_; + my ($self, $level) = @_; + $level *= 1; - if (!$self->{"trace_subs"} && !$global_trace_subs) { - return; - } + return 1 unless ($global_level & TRACE); # ignore if traces aren't active + return 1 if $level && !($global_level & $level); # ignore if level of trace isn't active my ($package, $filename, $line, $subroutine) = caller(1); my ($dummy1, $self_filename, $self_line) = caller(0); - $self->{"calldepth"} -= 1; - my $indent = " " x $self->{"calldepth"}; + my $indent = " " x --$self->{"calldepth"}; if (!defined($package)) { - $self->_write("leave_sub", $indent . "top-level?\n"); + $self->_write('sub' . $level, $indent . "/ top-level?\n"); } else { - $self->_write("leave_sub", $indent . "${subroutine} in " . - "${self_filename}:${self_line}\n"); + $self->_write('sub' . $level, $indent . "/ ${subroutine} in " . "${self_filename}:${self_line}\n"); } + return 1; } -sub message { - my ($self, $level, $message) = @_; - my ($log_level) = $self->{"level"}; +sub show_backtrace { + my ($self, $force) = @_; - if ($global_level && ($global_level > $log_level)) { - $log_level = $global_level; - } + return 1 unless ($force || ($global_level & BACKTRACE_ON_ERROR)); - if ($log_level >= $level) { - $self->_write(INFO == $level ? "info" : - DEBUG1 == $level ? "debug1" : "debug2", - $message); + $self->message(BACKTRACE_ON_ERROR, "Starting full caller dump:"); + my $level = 0; + while (my ($dummy, $filename, $line, $subroutine) = caller $level) { + $self->message(BACKTRACE_ON_ERROR, " ${subroutine} from ${filename}:${line}"); + $level++; } + + return 1; +} + +sub message { + my ($self, $level, $message) = @_; + + $self->_write(level2string($level), $message) if (($self->{"level"} | $global_level) & $level || !$level); } sub dump { my ($self, $level, $name, $variable) = @_; if ($data_dumper_available) { - $self->message($level, "dumping ${name}:\n" . Dumper($variable)); + my $password; + if ($variable && ('Form' eq ref $variable) && defined $variable->{password}) { + $password = $variable->{password}; + $variable->{password} = 'X' x 8; + } + + my $dumper = Data::Dumper->new([$variable]); + $dumper->Sortkeys(1); + $self->message($level, "dumping ${name}:\n" . $dumper->Dump()); + + $variable->{password} = $password if (defined $password); + + # Data::Dumper does not reset the iterator belonging to this hash + # if 'Sortkeys' is true. Therefore clear the iterator manually. + # See "perldoc -f each". + if ($variable && (('HASH' eq ref $variable) || ('Form' eq ref $variable))) { + keys %{ $variable }; + } + } else { - $self->message($level, "dumping ${name}: Data::Dumper not available; " . - "variable cannot be dumped"); + $self->message($level, + "dumping ${name}: Data::Dumper not available; " + . "variable cannot be dumped"); + } +} + +sub dump_yaml { + my ($self, $level, $name, $variable) = @_; + + $self->message($level, "dumping ${name}:\n" . YAML::Dump($variable)); +} + +sub dump_sql_result { + my ($self, $level, $prefix, $results) = @_; + + if (!$results || !scalar @{ $results }) { + $self->message($level, "Empty result set"); + return; } + + my %column_lengths = map { $_, length $_ } keys %{ $results->[0] }; + + foreach my $row (@{ $results }) { + map { $column_lengths{$_} = length $row->{$_} if (length $row->{$_} > $column_lengths{$_}) } keys %{ $row }; + } + + my @sorted_names = sort keys %column_lengths; + my $format = join '|', map { '%' . $column_lengths{$_} . 's' } @sorted_names; + + $prefix .= ' ' if $prefix; + + $self->message($level, $prefix . sprintf($format, @sorted_names)); + $self->message($level, $prefix . join('+', map { '-' x $column_lengths{$_} } @sorted_names)); + + foreach my $row (@{ $results }) { + $self->message($level, $prefix . sprintf($format, map { $row->{$_} } @sorted_names)); + } + $self->message($level, $prefix . sprintf('(%d row%s)', scalar @{ $results }, scalar @{ $results } > 1 ? 's' : '')); } sub enable_sub_tracing { my ($self) = @_; - $self->{"trace_subs"} = 1; + $self->{level} | TRACE; } sub disable_sub_tracing { my ($self) = @_; - $self->{"trace_subs"} = 1; + $self->{level} & ~ TRACE; } sub _write { @@ -139,8 +205,8 @@ sub _write { chomp($message); - if ((FILE_TARGET == $self->{"target"}) && - open(FILE, ">>" . $self->{"file"})) { + if ((FILE_TARGET == $self->{"target"}) + && open(FILE, ">>" . $self->{"file"})) { print(FILE "${date}${message}\n"); close(FILE); @@ -149,4 +215,9 @@ sub _write { } } +sub level2string { + # use $_[0] as a bit mask and return levelstrings separated by / + join '/', qw(info debug1 debug2 query trace error_call_trace)[ grep { (reverse split //, sprintf "%05b", $_[0])[$_] } 0..5 ] +} + 1;