X-Git-Url: http://git.shadowcat.co.uk/gitweb/gitweb.cgi?a=blobdiff_plain;f=lib%2FObject%2FRemote%2FConnection.pm;h=4d46618c82c26cb9227dd0afa07c8a9af00a517e;hb=f8080c1c188fa6c4589ffcad8793e0cf7a8d4bdb;hp=da80bac8ae2f4b8e559cb512edb86a7c2d0b70c7;hpb=6163a5aa713c3e27a6c6cd4060e20b556dbef269;p=scpubgit%2FObject-Remote.git diff --git a/lib/Object/Remote/Connection.pm b/lib/Object/Remote/Connection.pm index da80bac..4d46618 100644 --- a/lib/Object/Remote/Connection.pm +++ b/lib/Object/Remote/Connection.pm @@ -6,38 +6,66 @@ use Object::Remote::Handle; use Object::Remote::CodeContainer; use Object::Remote::GlobProxy; use Object::Remote::GlobContainer; +use Object::Remote::Logging qw (:log :dlog); +use Object::Remote::Tied; use Object::Remote; use Symbol; use IO::Handle; use Module::Runtime qw(use_module); -use Scalar::Util qw(weaken blessed refaddr); +use Scalar::Util qw(weaken blessed refaddr openhandle); use JSON::PP qw(encode_json); use Moo; our $DEBUG = !!$ENV{OBJECT_REMOTE_DEBUG}; +#numbering each connection allows it to be +#tracked along with file handles in +#the logs +BEGIN { our $NEXT_CONNECTION_ID = 0 } +has _id => ( is => 'ro', required => 1, default => sub { our $NEXT_CONNECTION_ID++ } ); has send_to_fh => ( is => 'ro', required => 1, - trigger => sub { $_[1]->autoflush(1) }, + trigger => sub { + my $self = $_[0]; + $_[1]->autoflush(1); + Dlog_trace { my $id = $self->_id; "connection had send_to_fh set to $_" } $_[1]; + }, ); has read_channel => ( is => 'ro', required => 1, trigger => sub { my ($self, $ch) = @_; + my $id = $self->_id; + Dlog_trace { "trigger for read_channel has been invoked for connection $id; file handle is $_" } $ch->fh; weaken($self); $ch->on_line_call(sub { $self->_receive(@_) }); - $ch->on_close_call(sub { $self->on_close->done(@_) }); + $ch->on_close_call(sub { + log_trace { "invoking 'done' on on_close handler for connection id '$id'" }; + $self->on_close->done(@_); + }); }, ); +#TODO properly fix this bug - +#trigger can't ever be invoked with a default +#value and the on_close attribute is read only.... +#the future never gets the on_done handler +#installed +sub BUILD { + my ($self) = @_; + $self->on_close(CPS::Future->new); +} + has on_close => ( - is => 'ro', default => sub { CPS::Future->new }, - trigger => sub { + is => 'rw', default => sub { CPS::Future->new }, + trigger => sub { my ($self, $f) = @_; + Dlog_trace { "trigger for on_close has been invoked for connection $_" } $self->_id; weaken($self); $f->on_done(sub { - $self->_fail_outstanding("Connection lost: ".($f->get)[0]); + Dlog_trace { "failing all of the outstanding futures for connection $_" } $self->_id; + $self->_fail_outstanding("Connection lost: " . ($f->get)[0]); }); } ); @@ -58,6 +86,7 @@ has outstanding_futures => (is => 'ro', default => sub { {} }); sub _fail_outstanding { my ($self, $error) = @_; + Dlog_debug { "Failing outstanding futures with '$error' for connection $_" } $self->_id; my $outstanding = $self->outstanding_futures; $_->fail($error) for values %$outstanding; %$outstanding = (); @@ -74,6 +103,7 @@ has _json => ( sub _id_to_remote_object { my ($self, $id) = @_; + Dlog_trace { "fetching proxy for remote object with id '$id' for connection $_" } $self->_id; return bless({}, 'Object::Remote::Null') if $id eq 'NULL'; ( $self->remote_objects_by_id->{$id} @@ -108,7 +138,19 @@ sub _build__json { __local_object__ => sub { $self->local_objects_by_id->{$_[0]} } - ); + )->filter_json_single_key_object( + __remote_tied_hash__ => sub { + my %tied_hash; + tie %tied_hash, 'Object::Remote::Tied', $self->_id_to_remote_object(@_); + return \%tied_hash; + } + )->filter_json_single_key_object( + __remote_tied_array__ => sub { + my @tied_array; + tie @tied_array, 'Object::Remote::Tied', $self->_id_to_remote_object(@_); + return \@tied_array; + } + ); } BEGIN { @@ -122,6 +164,7 @@ BEGIN { sub new_from_spec { my ($class, $spec) = @_; return $spec if blessed $spec; + Dlog_debug { "creating a new connection from spec" }; foreach my $poss (do { our @Guess }) { if (my $conn = $poss->($spec)) { return $conn->maybe::start::connect; @@ -139,6 +182,7 @@ sub remote_object { sub connect { my ($self, $to) = @_; + Dlog_debug { "Creating connection to remote node '$to' for connection $_" } $self->_id; return await_future( $self->send_class_call(0, 'Object::Remote', connect => $to) ); @@ -147,11 +191,13 @@ sub connect { sub remote_sub { my ($self, $sub) = @_; my ($pkg, $name) = $sub =~ m/^(.*)::([^:]+)$/; + Dlog_debug { "Invoking remote sub '$sub' for connection $_" } $self->_id; return await_future($self->send_class_call(0, $pkg, can => $name)); } sub send_class_call { my ($self, $ctx, @call) = @_; + Dlog_trace { "Sending a class call for connection $_" } $self->_id; $self->send(call => class_call_handler => $ctx => call => @call); } @@ -175,12 +221,14 @@ sub new_class_call_handler { sub register_remote { my ($self, $remote) = @_; + Dlog_trace { my $i = $remote->id; "Registered a remote object with id of '$i' for connection $_" } $self->_id; weaken($self->remote_objects_by_id->{$remote->id} = $remote); return $remote; } sub send_free { my ($self, $id) = @_; + Dlog_trace { "sending request to free object '$id' for connection $_" } $self->_id; delete $self->remote_objects_by_id->{$id}; $self->_send([ free => $id ]); } @@ -215,8 +263,31 @@ sub send_discard { sub _send { my ($self, $to_send) = @_; - - print { $self->send_to_fh } $self->_serialize($to_send)."\n"; + my $fh = $self->send_to_fh; + Dlog_trace { "Starting to serialize data in argument to _send for connection $_" } $self->_id; + my $serialized = $self->_serialize($to_send)."\n"; + Dlog_trace { my $l = length($serialized); "serialization is completed; sending '$l' characters of serialized data to $_" } $fh; + #TODO this is very risky for deadlocks unless it's set to non-blocking and then with out extra + #logic it could easily do short-writes to the remote side - how about taking this entire buffer + #and having the run loop send it to the file handle so this doesn't block while the sending + #is happening? + my $ret; + eval { + local($SIG{PIPE}) = 'IGNORE'; + die "filehandle is not open" unless openhandle($fh); + log_trace { "file handle has passed openhandle() test; printing to it" }; + $ret = print $fh $serialized; + die "print was not successful: $!" unless defined $ret + }; + + if ($@) { + Dlog_debug { "exception encountered when trying to write to file handle $_: $@" } $fh; + my $error = $@; chomp($error); + $self->on_close->done("could not write to file handle: $error") unless $self->on_close->is_ready; + return; + } + + return $ret; } sub _serialize { @@ -257,9 +328,19 @@ sub _deobjectify { } } elsif (my $ref = ref($data)) { if ($ref eq 'HASH') { - return +{ map +($_ => $self->_deobjectify($data->{$_})), keys %$data }; + my $tied_to = tied(%$data); + if(defined($tied_to)) { + return +{__remote_tied_hash__ => $self->_local_object_to_id($tied_to)}; + } else { + return +{ map +($_ => $self->_deobjectify($data->{$_})), keys %$data }; + } } elsif ($ref eq 'ARRAY') { - return [ map $self->_deobjectify($_), @$data ]; + my $tied_to = tied(@$data); + if (defined($tied_to)) { + return +{__remote_tied_array__ => $self->_local_object_to_id($tied_to)}; + } else { + return [ map $self->_deobjectify($_), @$data ]; + } } elsif ($ref eq 'CODE') { my $id = $self->_local_object_to_id( Object::Remote::CodeContainer->new(code => $data) @@ -281,8 +362,10 @@ sub _deobjectify { sub _receive { my ($self, $flat) = @_; warn "$$ <<< $flat\n" if $DEBUG; + Dlog_trace { my $l = length($flat); "Starting to deserialize $l characters of data for connection $_" } $self->_id; my ($type, @rest) = eval { @{$self->_deserialize($flat)} } or do { warn "Deserialize failed for ${flat}: $@"; return }; + Dlog_trace { "deserialization complete for connection $_" } $self->_id; eval { $self->${\"receive_${type}"}(@rest); 1 } or do { warn "Receive failed for ${flat}: $@"; return }; return; @@ -290,6 +373,7 @@ sub _receive { sub receive_free { my ($self, $id) = @_; + Dlog_trace { "got a receive_free for object '$id' for connection $_" } $self->_id; delete $self->local_objects_by_id->{$id} or warn "Free: no such object $id"; return; @@ -297,6 +381,7 @@ sub receive_free { sub receive_call { my ($self, $future_id, $id, @rest) = @_; + Dlog_trace { "got a receive_call for object '$id' for connection $_" } $self->_id; my $future = $self->_id_to_remote_object($future_id); $future->{method} = 'call_discard_free'; my $local = $self->local_objects_by_id->{$id} @@ -306,12 +391,14 @@ sub receive_call { sub receive_call_free { my ($self, $future, $id, @rest) = @_; + Dlog_trace { "got a receive_call_free for object '$id' for connection $_" } $self->_id; $self->receive_call($future, $id, undef, @rest); $self->receive_free($id); } sub _invoke { my ($self, $future, $local, $ctx, $method, @args) = @_; + Dlog_trace { "got _invoke for a method named '$method' for connection $_" } $self->_id; if ($method =~ /^start::/) { my $f = $local->$method(@args); $f->on_done(sub { undef($f); $future->done(@_) });