2 # The RBN connection system
4 # Copyright (c) 2020 Dirk Koopman G1TLH
21 use Math::Round qw(nearest nearest_floor);
23 use Time::HiRes qw(gettimeofday);
70 our $DATA_VERSION = 1;
72 our @ISA = qw(DXChannel);
74 our $startup_delay = 5*60; # don't send anything out until this timer has expired
75 # this is to allow the feed to "warm up" with duplicates
76 # so that the "big rush" doesn't happen.
78 our $minspottime = 30*60; # the time between respots of a callsign - if a call is
79 # still being spotted (on the same freq) and it has been
80 # spotted before, it's spotted again after this time
81 # until the next minspottime has passed.
83 our $beacontime = 5*60; # same as minspottime, but for beacons (and shorter)
85 our $dwelltime = 10; # the amount of time to wait for duplicates before issuing
86 # a spot to the user (no doubt waiting with bated breath).
88 our $limbotime = 5*60; # if there are fewer than $minqual candidates and $dwelltime
89 # has expired then allow this spot to live a bit longer. It may
90 # simply be that it is not in standard spot coverage. (ask G4PIQ
93 our $filterdef = $Spot::filterdef; # we use the same filter as the Spot system. Can't think why :-).
95 my $spots; # the GLOBAL spot cache
97 my %runtime; # how long each channel has been running
99 our $cachefn = localdata('rbn_cache');
100 our $cache_valid = 4*60; # The cache file is considered valid if it is not more than this old
102 our $maxqrgdiff = 10; # the maximum
103 our $minqual = 2; # the minimum quality we will accept for output
104 our $maxqual = 9; # if there is enough quality, then short circuit any remaining dwelltime.
107 my $noinrush = 0; # override the inrushpreventor if set
108 our $maxdeviants = 5; # the number of deviant QRGs to record for skimmer records
117 $spots = {VERSION=>$DATA_VERSION};
119 if (defined $DB::VERSION) {
128 my $self = DXChannel::alloc(@_);
130 # routing, this must go out here to prevent race condx
137 $self->{nouser} = {};
139 $self->{noraw10} = 0;
140 $self->{nospot10} = 0;
141 $self->{nouser10} = {};
142 $self->{norbn10} = 0;
143 $self->{nospothour} = 0;
144 $self->{nouserhour} = {};
145 $self->{norbnhour} = 0;
146 $self->{norawhour} = 0;
148 $self->{lasttime} = $main::systime;
149 $self->{minspottime} = $minspottime;
150 $self->{beacontime} = $beacontime;
151 $self->{showstats} = 0;
152 $self->{pingint} = 0;
153 $self->{nopings} = 0;
161 my ($self, $line, $sort) = @_;
162 my $user = $self->{user};
163 my $call = $self->{call};
164 my $name = $user->{name};
167 my $host = $self->{conn}->peerhost;
169 $self->{hostname} = $host;
171 $self->{name} = $name ? $name : $call;
172 $self->state('prompt'); # a bit of room for further expansion, passwords etc
173 $self->{lang} = $user->lang || $main::lang || 'en';
174 if ($line =~ /host=/) {
175 my ($h) = $line =~ /host=(\d+\.\d+\.\d+\.\d+)/;
176 $line =~ s/\s*host=\d+\.\d+\.\d+\.\d+// if $h;
178 ($h) = $line =~ /host=([\da..fA..F:]+)/;
179 $line =~ s/\s*host=[\da..fA..F:]+// if $h;
183 $self->{hostname} = $h;
186 $self->{width} = 80 unless $self->{width} && $self->{width} > 80;
187 $self->{consort} = $line; # save the connection type
189 LogDbg('DXCommand', "$call connected from $self->{hostname}");
191 # set some necessary flags on the user if they are connecting
192 $self->{registered} = 1;
193 # sort out privilege reduction
198 $nossid =~ s/-\d+$//;
200 $self->{inrbnfilter} = Filter::read_in('rbn', $call, 1)
201 || Filter::read_in('rbn', 'node_default', 1);
203 # clean up qra locators
204 my $qra = $user->qra;
205 $qra = undef if ($qra && !DXBearing::is_qra($qra));
207 my $lat = $user->lat;
208 my $long = $user->long;
209 $user->qra(DXBearing::lltoqra($lat, $long)) if (defined $lat && defined $long);
212 # if we have been running and stopped for a while
213 # if the cache is warm enough don't operate the inrush preventor
214 $self->{inrushpreventor} = exists $runtime{$call} && $runtime{$call} > $startup_delay || $noinrush ? 0 : $main::systime + $startup_delay;
215 dbg("RBN: noinrush: $noinrush, setting inrushpreventor on $self->{call} to $self->{inrushpreventor}");
218 my @queue; # the queue of spots ready to send
225 my $dbgrbn = isdbg('rbn');
227 # remove leading and trailing spaces
234 my $now = $main::systime;
237 dbg "RBN:RAW,$line" if isdbg('rbnraw');
238 return unless $line=~/^DX\s+de/;
240 my (undef, undef, $origin, $qrg, $call, $mode, $s, $m, $spd, $u, $sort, $t, $tx) = split /[:\s]+/, $line;
242 # fix up FT8 spots from 7001
243 $t = $u, $u = '' if !$t && is_ztime($u);
244 $t = $sort, $sort = '' if !$t && is_ztime($sort);
245 my $qra = $spd, $spd = '' if is_qra($spd);
248 # is this anything like a callsign?
249 unless (is_callsign($call)) {
250 dbg("RBN: ERROR $call from $origin on $qrg is invalid, dumped");
254 # remove all extraneous crap from the origin - just leave the base callsign
255 $origin = basecall($origin);
257 # is this callsign in badspotter list?
258 if ($DXProt::badspotter->in($origin) || $DXProt::badnode->in($origin)) {
259 dbg("RBN: ERROR $origin is a bad spotter/node, dumped");
264 unless ($qrg =~ /^\d+\.\d{1,2}$/) {
265 dbg("RBN: ERROR qrg $qrg from $origin invalid, dumped");
272 dbg qq{RBN:input decode or:$origin qr:$qrg ca:$call mo:$mode s:$s m:$m sp:$spd u:$u sort:$sort t:$t tx:$tx qra:$qra} if $dbgrbn && isdbg('rbn');
276 ++$self->{norawhour};
282 # fix up times for things like 'NXDXF B' etc
283 if ($tx && is_ztime($t)) {
292 if ($sort && $sort eq 'NCDXF') {
296 if ($sort && $sort eq 'BEACON') {
299 if ($mode =~ /^PSK/) {
302 if ($mode eq 'RTTY') {
306 # The main de-duping key is [call, $frequency], but we probe a bit around that frequency to find a
307 # range of concurrent frequencies that might be in play.
309 # The key to this is deducing the true callsign by "majority voting" (the greater the number of spotters
310 # the more effective this is) together with some lexical analsys probably in conjuction with DXSpider
311 # data sources (for singleton spots) to then generate a "centre" from and to zone (whatever that will mean if it isn't the usual one)
312 # and some heuristical "Kwalitee" rating given distance from the zone centres of spotter, recipient user
313 # and spotted. A map can be generated once per user and spotter as they are essentially mostly static.
314 # The spotted will only get a coarse position unless other info is available. Programs that parse
315 # DX bulletins and the online data online databases could be be used and then cached.
317 # Obviously users have to opt in to receiving RBN spots and other users will simply be passed over and
320 # Clearly this will only work in the 'mojo' branch of DXSpider where it is possible to pass off external
321 # data requests to ephemeral or semi resident forked processes that do any grunt work and the main
322 # process to just the standard "message passing" which has been shown to be able to sustain over 5000
323 # per second (limited by the test program's output and network speed, rather than DXSpider's handling).
326 my $nqrg = nearest(1, $qrg * 10); # normalised to nearest Khz
327 my $sp = "$call|$nqrg"; # hopefully the skimmers will be calibrated at least this well!
330 my $cand = $spots->{$sp};
333 for ($i = $nqrg; !$cand && $i <= $nqrg+$search; $i += 1) {
335 $cand = $spots->{$new}, last if exists $spots->{$new};
338 my $diff = $i - $nqrg;
339 dbg(qq{RBN: QRG Diff using $new (+$diff) for $sp for qrg $qrg}) if (isdbg('rbnqrg') || ($dbgrbn && isdbg('rbn')));
345 for ($i = $nqrg; !$cand && $i >= $nqrg-$search; $i -= 1) {
347 $cand = $spots->{$new}, last if exists $spots->{$new};
350 my $diff = $nqrg - $i;
351 dbg(qq{RBN: QRG Diff using $new (-$diff) for $sp for qrg $qrg}) if (isdbg('rbnqrg') || ($dbgrbn && isdbg('rbn')));
356 # if we have one and there is only one slot and that slot's time isn't expired for respot then return
358 if ($cand && ref $cand) {
359 if (@$cand <= CData) {
360 if ($self->{minspottime} > 0 && $now - $cand->[CTime] < $self->{minspottime}) {
361 dbg("RBN: key: '$sp' call: $call qrg: $qrg DUPE \@ ". atime(int $cand->[CTime])) if $dbgrbn && isdbg('rbn');
365 dbg("RBN: key: '$sp' RESPOTTING call: $call qrg: $qrg last seen \@ ". atime(int $cand->[CTime])) if $dbgrbn && isdbg('rbn');
366 $cand->[CTime] = $now;
370 # otherwise we have a spot being built up at the moment
372 dbg("RBN: key '$sp' = '$cand' not ref");
375 # new spot / frequency
376 $spots->{$sp} = $cand = [$now, 0];
377 dbg("RBN: key: '$sp' call: $call qrg: $qrg NEW" . ($respot ? ' RESPOT' : '')) if $dbgrbn && isdbg('rbn');
380 # add me to the display queue unless we are waiting for initial in rush to finish
381 return unless $noinrush || $self->{inrushpreventor} < $main::systime;
383 # build up a new record and store it in the buildup
384 # deal with the unix time
385 my ($hh,$mm) = $t =~ /(\d\d)(\d\d)Z$/;
386 my $utz = $hh*3600 + $mm*60 + $main::systime_daystart; # possible issue with late spot from previous day
387 $utz -= 86400 if $utz > $now+3600; # too far ahead, drag it back one day
389 # create record and add into the buildup
390 my $r = [$origin, nearest(.1, $qrg), $call, $mode, $s, $t, $utz, $respot, $u];
391 my @s = Spot::prepare($r->[RQrg], $r->[RCall], $r->[RUtz], '', $r->[ROrigin]);
393 dbg("RBN: ERROR invalid prefix/callsign $call from $origin-# on $qrg, dumped");
397 if ($self->{inrbnfilter}) {
398 my ($want, undef) = $self->{inrbnfilter}->it($s);
401 $r->[RSpotData] = \@s;
403 ++$self->{queue}->{$sp};# unless @$cand>= CData; # queue the KEY (not the record)
405 dbg("RBN: key: '$sp' ADD RECORD call: $call qrg: $qrg origin: $origin respot: $respot") if $dbgrbn && isdbg('rbn');
410 dbg "RBN:DATA,$line" if $dbgrbn && isdbg('rbn');
414 # we should get the spot record minus the time, so just an array of record (arrays)
423 ++$self->{norbnhour};
425 # $r = [$origin, $qrg, $call, $mode, $s, $utz, $respot];
427 my $mode = $cand->[CData]->[RMode]; # as all the modes will be the same;
429 my @dxchan = DXChannel::get_all();
431 foreach my $dxchan (@dxchan) {
432 next unless $dxchan->is_user;
433 my $user = $dxchan->{user};
434 next unless $user && $user->wantrbn;
436 # does this user want this sort of spot at all?
438 ++$want if $user->wantbeacon && $mode =~ /^BCN|DXF/;
439 ++$want if $user->wantcw && $mode =~ /^CW/;
440 ++$want if $user->wantrtty && $mode =~ /^RTT/;
441 ++$want if $user->wantpsk && $mode =~ /^PSK|FSK|MSK/;
442 ++$want if $user->wantft && $mode =~ /^FT/;
444 dbg(sprintf("RBN: spot selection for $dxchan->{call} mode: '$mode' want: $want flags rbn:%d ft:%d bcn:%d cw:%d psk:%d rtty:%d",
451 )) if isdbg('rbnll');
453 # send one spot to one user out of the ones that we have
454 $self->dx_spot($dxchan, $quality, $cand) if $want;
464 my $call = $dxchan->{call};
465 my $seeme = $dxchan->user->rbnseeme();
466 my $strength = 100; # because it could if we talk about FTx
472 ++$self->{nousers}->{$call};
473 ++$self->{nousers10}->{$call};
474 ++$self->{nousershour}->{$call};
477 my $rf = $dxchan->{rbnfilter} || $dxchan->{spotsfilter};
480 foreach my $r (@$cand) {
481 # $r = [$origin, $qrg, $call, $mode, $s, $t, $utz, $respot, $qra];
482 # Spot::prepare($qrg, $call, $utz, $comment, $origin);
483 next unless $r && ref $r;
485 $qra = $r->[RQra] if !$qra && $r->[RQra] && is_qra($r->[RQra]);
487 $comment = sprintf "%-3s %2ddB $quality", $r->[RMode], $r->[RStrength];
488 my $s = $r->[RSpotData]; # the prepared spot
489 $s->[SComment] = $comment; # apply new generated comment
491 ++$zone{$s->[SZone]}; # save the spotter's zone
493 # if the 'see me' flag is set, then show all the spots without further adornment (see set/rbnseeme for more info)
495 send_final($dxchan, $s);
499 # save the lowest strength one
500 if ($r->[RStrength] < $strength) {
501 $strength = $r->[RStrength];
503 dbg("RBN: STRENGTH spot: $s->[SCall] qrg: $s->[SQrg] origin: $s->[SOrigin] dB: $r->[RStrength] < $strength") if isdbg 'rbnll';
507 my ($want, undef) = $rf->it($s);
508 dbg("RBN: FILTERING for $call spot: $s->[SCall] qrg: $s->[SQrg] origin: $s->[SOrigin] dB: $r->[RStrength] com: '$s->[SComment]' want: " . ($want ? 'YES':'NO')) if isdbg 'rbnll';
515 $saver = $filtered; # if nothing passed the filter's lips then $saver == $filtered == undef !
520 # create a zone list of spotters
521 delete $zone{$saver->[SZone]}; # remove this spotter's zone (leaving all the other zones)
522 my $z = join ',', sort {$a <=> $b} keys %zone;
524 # alter spot data accordingly
525 $saver->[SComment] .= " Z:$z" if $z;
527 send_final($dxchan, $saver);
531 ++$self->{nospothour};
534 my $user = DXUser::get_current($saver->[SCall]) || DXUser->new($saver->[SCall]);
535 unless ($user->qra && is_qra($user->qra)) {
537 dbg("RBN: update qra on $saver->[SCall] to $qra");
548 my $call = $dxchan->{call};
551 dbg("RBN: SENDING to $call spot: $saver->[SCall] qrg: $saver->[SQrg] origin: $saver->[SOrigin] $saver->[SComment]") if isdbg 'rbnll';
552 if ($dxchan->{ve7cc}) {
553 my $call = $saver->[SOrigin];
554 $saver->[SOrigin] .= '-#';
555 $buf = VE7CC::dx_spot($dxchan, @$saver);
556 $saver->[SOrigin] = $call;
558 my $call = $saver->[SOrigin];
559 $saver->[SOrigin] = substr($call, 0, 6);
560 $saver->[SOrigin] .= '-#';
561 $buf = $dxchan->format_dx_spot(@$saver);
562 $saver->[SOrigin] = $call;
564 $dxchan->local_send('N', $buf);
570 my $rbnskim = isdbg('rbnskim');
572 foreach my $dxchan (DXChannel::get_all()) {
573 next unless $dxchan->is_rbn;
575 # At this point we run the queue to see if anything can be sent onwards to the punter
576 my $now = $main::systime;
577 my $ta = [gettimeofday];
580 # now run the waiting queue which just contains KEYS ($call|$qrg)
581 foreach my $sp (keys %{$dxchan->{queue}}) {
582 my $cand = $spots->{$sp};
585 unless ($cand && $cand->[CTime]) {
586 dbg "RBN Cand $sp " . ($cand ? 'def' : 'undef') . " [CTime] " . ($cand->[CTime] ? 'def' : 'undef') . " dwell $dwelltime";
587 delete $spots->{$sp};
588 delete $dxchan->{queue}->{$sp}; # remove
592 my $ctime = $cand->[CTime];
593 my $quality = @$cand - CData;
594 my $dwellsecs = $now - $ctime;
595 if ($quality >= $maxqual || $dwellsecs >= $dwelltime || $dwellsecs >= $limbotime) {
596 # we have a candidate, create qualitee value(s);
597 unless (@$cand > CData) {
598 dbg "RBN: QUEUE key '$sp' MISSING RECORDS, IGNORED" . dd($cand) if isdbg 'rbnqueue';
599 delete $spots->{$sp}; # don't remember it either - this means that a spot HAS to come in with sufficient spotters to be processed.
600 delete $dxchan->{queue}->{$sp};
603 dbg "RBN: QUEUE PROCESSING key: '$sp' $now >= $cand->[CTime]" if isdbg 'rbnqueue';
604 my $spotters = $quality;
606 # dump it and remove it from the queue if it is of unadequate quality, but only if it is no longer in Limbo and can be reasonably passed on to its demise
607 my $r = $cand->[CData];
608 if ($dwellsecs > $limbotime && $quality < $minqual) {
609 if ( $rbnskim && isdbg('rbnskim')) {
612 my $lastin = difft($ctime, $now, 2);
613 my $s = "RBN:SKIM time in Limbo exceeded DUMPED (lastin: $lastin Q:$quality < Q:$minqual) key: '$sp' = $r->[RCall] on $r->[RQrg] by $r->[ROrigin] \@ $r->[RTime] route: $dxchan->{call}";
617 delete $spots->{$sp}; # don't remember it either - this means that a spot HAS to come in with sufficient spotters to be processed.
618 delete $dxchan->{queue}->{$sp};
622 # we have a possible removal from Limbo, check for more than one skimmer and reset the quality if required
623 # DOES THIS TEST CAUSE RACES?
624 if (!$r->[Respot] && $quality >= $minqual && $dwellsecs > $dwelltime+1) {
626 # because we don't need to check for repeats by the same skimmer in the normal case, we do here
629 foreach my $wr (@$cand) {
631 push @origin, $wr->[ROrigin];
632 if (exists $seen{$wr->[ROrigin]}) {
635 $seen{$wr->[ROrigin]} = $wr;
637 # reset the quality to ignore dupes
639 $quality = keys %seen;
640 if ($quality >= $minqual) {
641 if ( $rbnskim && isdbg('rbnskim')) {
642 my $lastin = difft($ctime, $now, 2);
643 my $sk = join ' ', keys %seen;
644 my $or = join ' ', @origin;
645 my $s = "RBN:SKIM promoted from Limbo - key: '$sp' (lastin: $lastin Q now: $quality was $oq skimmers now: $sk";
646 $s .= " was $or" if $or ne $sk;
650 } elsif ($oq != $quality) {
651 if ( $rbnskim && isdbg('rbnskim')) {
652 my $lastin = difft($ctime, $now, 2);
653 my $sk = join ' ', keys %seen;
654 my $or = join ' ', @origin;
655 my $s = "RBN:SKIM quality reset key: '$sp' (lastin: $lastin Q now: $quality was $oq skimmers now: $sk was: $or)";
659 my @ncand = (@$cand[CTime, CQual], values %seen);
660 $spots->{$sp} = \@ncand;
664 # we now kick this spot into Limbo
665 if ($quality < $minqual) {
669 $quality = 9 if $quality > 9;
670 $cand->[CQual] = $quality if $quality > $cand->[CQual];
672 # this scores each candidate according to its skimmer's QRG score (i.e. how often it agrees with its peers)
673 # what happens is hash of all QRGs in candidates are incremented by that skimmer's reputation for "accuracy"
674 # or, more exactly, past agreement with the consensus. This score can be from -5 -> +5.
680 foreach $r (@$cand) {
682 if (exists $seen{$r->[ROrigin]}) {
686 $seen{$r->[ROrigin]} = 1;
687 $band ||= int $r->[RQrg] / 1000;
688 $sk = "SKIM|$r->[ROrigin]|$band"; # thus only once per set of candidates
689 $skimmer = $spots->{$sk};
691 $skimmer = $spots->{$sk} = [1, 0, 0, $now, []]; # this first time, this new skimmer gets the benefit of the doubt on frequency.
692 dbg("RBN:SKIM new slot $sk " . $json->encode($skimmer)) if $rbnskim && isdbg('rbnskim');
694 $qrg{$r->[RQrg]} += ($skimmer->[DScore] || 1);
697 # determine the most likely qrg and then set it - NOTE (-)ve votes, generated by the skimmer scoring system above, are ignored
702 while (my ($k, $votes) = each %qrg) {
710 # Ignore possible spots with 0 QRG score - as determined by the skimmer scoring system above - as they are likely to be wrong
712 if ( $rbnskim && isdbg('rbnskim')) {
714 while (my ($k, $v) = (each %qrg)) {
719 foreach $r (@$cand) {
720 next unless $r && ref $r;
721 dbg "RBN:SKIM cand $i QRG likely wrong from '$sp' = $r->[RCall] on $r->[RQrg] by $r->[ROrigin] \@ $r->[RTime] (qrgs: $keys c: $c) route: $dxchan->{call}, ignored";
725 delete $spots->{$sp}; # get rid
726 delete $dxchan->{queue}->{$sp};
730 # detemine and spit out the deviants. Then adjust the scores according to whether it is a deviant or good
731 # NOTE: deviant nodes can become good (or less bad), and good nodes bad (or less good) on each spot that
732 # they generate. This is based solely on each skimmer's agreement (or not) with the "consensus" score generated
733 # above ($qrg). The resultant score + good + bad is stored per band and will be used the next time a spot
734 # appears on this band from each skimmer.
735 foreach $r (@$cand) {
736 next unless $r && ref $r;
737 my $diff = $c > 1 ? nearest(.1, $r->[RQrg] - $qrg) : 0;
738 $sk = "SKIM|$r->[ROrigin]|$band";
739 $skimmer = $spots->{$sk};
741 ++$skimmer->[DBad] if $skimmer->[DBad] < $maxdeviants;
742 --$skimmer->[DGood] if $skimmer->[DGood] > 0;
743 push @deviant, sprintf("$r->[ROrigin]:%+.1f", $diff);
744 push @{$skimmer->[DEviants]}, $diff;
745 shift @{$skimmer->[DEviants]} while @{$skimmer->[DEviants]} > $maxdeviants;
747 ++$skimmer->[DGood] if $skimmer->[DGood] < $maxdeviants;
748 --$skimmer->[DBad] if $skimmer->[DBad] > 0;
749 shift @{$skimmer->[DEviants]};
751 $skimmer->[DScore] = $skimmer->[DGood] - $skimmer->[DBad];
752 if ($rbnskim && isdbg('rbnskim')) {
753 my $lastin = difft($skimmer->[DLastin], $now, 2);
754 my $difflist = join(', ', @{$skimmer->[DEviants]});
755 $difflist = " band qrg diffs: $difflist" if $difflist;
756 dbg("RBN:SKIM key $sp slot $sk $r->[RQrg] - $qrg = $diff Skimmer score: $skimmer->[DGood] - $skimmer->[DBad] = $skimmer->[DScore] lastseen:$lastin ago$difflist");
758 $skimmer->[DLastin] = $now;
759 $r->[RSpotData]->[SQrg] = $qrg if $qrg && $c > 1; # set all the QRGs to the agreed value
762 $qrg = (sprintf "%.1f", $qrg)+0;
765 my $squality = "Q:$cand->[CQual]";
766 $squality .= '*' if $c > 1;
767 $squality .= '+' if $r->[Respot];
769 if (isdbg('progress')) {
770 my $rt = difft($ctime, $now, 2);
771 my $s = "RBN: SPOT key: '$sp' = $r->[RCall] on $r->[RQrg] by $r->[ROrigin] \@ $r->[RTime] $squality route: $dxchan->{call} dwell:$rt";
773 $s .= " QRGScore: $mv Deviants: $td/$spotters";
774 $s .= ' (' . join(', ', sort @deviant) . ')' if $td;
778 # finally send it out to any waiting public
779 send_dx_spot($dxchan, $squality, $cand);
781 # clear out the data and make this now just "spotted", but no further action required until respot time
782 dbg "RBN: QUEUE key '$sp' cleared" if isdbg 'rbn';
784 delete $dxchan->{queue}->{$sp};
786 # calculate new sp (which will be 70% likely the same as the old one)
787 # we do this to cope with the fact that the first spotter may well be "wrongly calibrated" giving a qrg that disagrees with the majority.
788 # and we want to store the key that corresponds to majority opinion.
789 my $nqrg = nearest(1, $qrg * 10); # normalised to nearest Khz
790 my $nsp = "$r->[RCall]|$nqrg";
792 dbg("RBN:SKIM CHANGE KEY sp '$sp' -> '$nsp' for storage") if $rbnskim && isdbg('rbnskim');
793 delete $spots->{$sp};
794 $spots->{$nsp} = [$now, $cand->[CQual]];
796 $spots->{$sp} = [$now, $cand->[CQual]];
800 dbg sprintf("RBN: QUEUE key: '$sp' SEND time not yet reached %.1f secs left", $cand->[CTime] + $dwelltime - $now) if isdbg 'rbnqueue';
803 if (isdbg('rbntimer')) {
804 my $diff = _diffus($ta);
805 dbg "RBN: TIMER process queue for call: $dxchan->{call} $items spots $diff uS";
812 foreach my $dxchan (DXChannel::get_all()) {
813 next unless $dxchan->is_rbn;
814 dbg "RBN:STATS minute $dxchan->{call} raw: $dxchan->{noraw} retrieved spots: $dxchan->{norbn} delivered: $dxchan->{nospot} after filtering to users: " . scalar keys %{$dxchan->{nousers}} if isdbg('rbnstats');
815 if ($dxchan->{noraw} == 0 && $dxchan->{lasttime} > 60) {
816 LogDbg('RBN', "RBN: no input from $dxchan->{call}, disconnecting");
819 $dxchan->{noraw} = $dxchan->{norbn} = $dxchan->{nospot} = 0; $dxchan->{nousers} = {};
820 $runtime{$dxchan->{call}} += 60;
823 # save the spot cache
824 write_cache() unless $main::systime + $startup_delay < $main::systime;;
831 while (my ($k,$cand) = each %{$spots}) {
832 next if $k eq 'VERSION';
833 next if $k =~ /^O\|/;
834 next if $k =~ /^SKIM\|/;
836 if ($main::systime - $cand->[CTime] > $minspottime*2) {
844 dbg "RBN:STATS spot cache remain: $count removed: $removed"; # if isdbg('rbn');
845 foreach my $dxchan (DXChannel::get_all()) {
846 next unless $dxchan->is_rbn;
847 my $nq = keys %{$dxchan->{queue}};
848 my $pc = $dxchan->{noraw10} ? sprintf("%.1f%%",$dxchan->{norbn10}*100/$dxchan->{noraw10}) : '0.0%';
849 dbg "RBN:STATS 10-minute $dxchan->{call} queue: $nq raw: $dxchan->{noraw10} retrieved spots: $dxchan->{norbn10} ($pc) delivered: $dxchan->{nospot10} after filtering to users: " . scalar keys %{$dxchan->{nousers10}};
850 $dxchan->{noraw10} = $dxchan->{norbn10} = $dxchan->{nospot10} = 0; $dxchan->{nousers10} = {};
856 foreach my $dxchan (DXChannel::get_all()) {
857 next unless $dxchan->is_rbn;
858 my $nq = keys %{$dxchan->{queue}};
859 my $pc = $dxchan->{norawhour} ? sprintf("%.1f%%",$dxchan->{norbnhour}*100/$dxchan->{norawhour}) : '0.0%';
860 dbg "RBN:STATS hour $dxchan->{call} queue: $nq raw: $dxchan->{norawhour} retrieved spots: $dxchan->{norbnhour} ($pc) delivered: $dxchan->{nospothour} after filtering to users: " . scalar keys %{$dxchan->{nousershour}};
861 $dxchan->{norawhour} = $dxchan->{norbnhour} = $dxchan->{nospothour} = 0; $dxchan->{nousershour} = {};
872 my $ta = [ gettimeofday ];
873 $json->indent(1)->canonical(1) if isdbg 'rbncache';
874 my $s = eval {$json->encode($spots)};
876 my $fh = IO::File->new(">$cachefn") or confess("writing $cachefn $!");
880 dbg("RBN:Write_cache error '$@'");
883 $json->indent(0)->canonical(0);
884 my $diff = _diffms($ta);
885 my $size = sprintf('%.3fKB', (length($s) / 1000));
886 dbg("RBN:WRITE_CACHE size: $size time to write: $diff mS");
892 my $mt = (stat($cachefn))[9];
893 my $t = $main::systime - $mt || 1;
894 my $p = difft($mt, 2);
895 if ($t < $cache_valid) {
896 dbg("RBN:check_cache '$cachefn' spot cache exists, created $p ago and not too old");
897 my $fh = IO::File->new($cachefn);
902 dbg("RBN:check_cache cache read size " . length $s);
905 dbg("RBN:check_cache file read error $!");
909 eval {$spots = $json->decode($s)};
910 if ($spots && ref $spots) {
911 if (exists $spots->{VERSION} && $spots->{VERSION} == $DATA_VERSION) {
912 # now clean out anything that has spot build ups in progress
913 while (my ($k, $cand) = each %$spots) {
914 next if $k eq 'VERSION';
915 next if $k =~ /^O\|/;
916 next if $k =~ /^SKIM\|/;
917 if (@$cand > CData) {
918 $spots->{$k} = [$cand->[CTime], $cand->[CQual]];
921 dbg("RBN:check_cache spot cache restored");
925 dbg("RBN::checkcache error decoding $@");
928 my $d = difft($main::systime-$cache_valid);
929 dbg("RBN::checkcache '$cachefn' created $p ago is too old (> $d), ignored");
932 dbg("RBN:check_cache '$cachefn' spot cache not present");