ViewVC Help
View File | Revision Log | Show Annotations | Download File
/cvs/deliantra/server/lib/cf.pm
(Generate patch)

Comparing deliantra/server/lib/cf.pm (file contents):
Revision 1.256 by root, Sat Apr 21 16:56:32 2007 UTC vs.
Revision 1.277 by root, Sun Jun 10 04:24:50 2007 UTC

… …
90our $LINK_MAP; # the special {link} map, which is always available 90our $LINK_MAP; # the special {link} map, which is always available
91 91
92# used to convert map paths into valid unix filenames by replacing / by ∕ 92# used to convert map paths into valid unix filenames by replacing / by ∕
93our $PATH_SEP = "∕"; # U+2215, chosen purely for visual reasons 93our $PATH_SEP = "∕"; # U+2215, chosen purely for visual reasons
94 94
95our $LOAD; # a number between 0 (idle) and 1 (too many objects)
96our $LOADAVG; # same thing, but with alpha-smoothing
97our $tick_start; # for load detecting purposes
98
95binmode STDOUT; 99binmode STDOUT;
96binmode STDERR; 100binmode STDERR;
97 101
98# read virtual server time, if available 102# read virtual server time, if available
99unless ($RUNTIME || !-e "$LOCALDIR/runtime") { 103unless ($RUNTIME || !-e "$LOCALDIR/runtime") {
… …
139 143
140=item $cf::TICK 144=item $cf::TICK
141 145
142The interval between server ticks, in seconds. 146The interval between server ticks, in seconds.
143 147
148=item $cf::LOADAVG
149
150The current CPU load on the server (alpha-smoothed), as a value between 0
151(none) and 1 (overloaded), indicating how much time is spent on processing
152objects per tick. Healthy values are < 0.5.
153
154=item $cf::LOAD
155
156The raw value load value from the last tick.
157
144=item %cf::CFG 158=item %cf::CFG
145 159
146Configuration for the server, loaded from C</etc/crossfire/config>, or 160Configuration for the server, loaded from C</etc/crossfire/config>, or
147from wherever your confdir points to. 161from wherever your confdir points to.
148 162
… …
173@safe::cf::global::ISA = @cf::global::ISA = 'cf::attachable'; 187@safe::cf::global::ISA = @cf::global::ISA = 'cf::attachable';
174@safe::cf::object::ISA = @cf::object::ISA = 'cf::attachable'; 188@safe::cf::object::ISA = @cf::object::ISA = 'cf::attachable';
175@safe::cf::player::ISA = @cf::player::ISA = 'cf::attachable'; 189@safe::cf::player::ISA = @cf::player::ISA = 'cf::attachable';
176@safe::cf::client::ISA = @cf::client::ISA = 'cf::attachable'; 190@safe::cf::client::ISA = @cf::client::ISA = 'cf::attachable';
177@safe::cf::map::ISA = @cf::map::ISA = 'cf::attachable'; 191@safe::cf::map::ISA = @cf::map::ISA = 'cf::attachable';
192@safe::cf::arch::ISA = @cf::arch::ISA = 'cf::object';
178@safe::cf::object::player::ISA = @cf::object::player::ISA = 'cf::object'; 193@safe::cf::object::player::ISA = @cf::object::player::ISA = 'cf::object'; # not really true (yet)
179 194
180# we bless all objects into (empty) derived classes to force a method lookup 195# we bless all objects into (empty) derived classes to force a method lookup
181# within the Safe compartment. 196# within the Safe compartment.
182for my $pkg (qw( 197for my $pkg (qw(
183 cf::global cf::attachable 198 cf::global cf::attachable
… …
318 333
319sub sync_job(&) { 334sub sync_job(&) {
320 my ($job) = @_; 335 my ($job) = @_;
321 336
322 if ($Coro::current == $Coro::main) { 337 if ($Coro::current == $Coro::main) {
338 my $time = Event::time;
339
323 # this is the main coro, too bad, we have to block 340 # this is the main coro, too bad, we have to block
324 # till the operation succeeds, freezing the server :/ 341 # till the operation succeeds, freezing the server :/
325 342
326 # TODO: use suspend/resume instead 343 # TODO: use suspend/resume instead
327 # (but this is cancel-safe) 344 # (but this is cancel-safe)
… …
338 355
339 while ($busy) { 356 while ($busy) {
340 Coro::cede or Event::one_event; 357 Coro::cede or Event::one_event;
341 } 358 }
342 359
360 $time = Event::time - $time;
361
362 LOG llevError | logBacktrace, Carp::longmess "long sync job"
363 if $time > $TICK * 0.5 && $TICK_WATCHER->is_active;
364
365 $tick_start += $time; # do not account sync jobs to server load
366
343 wantarray ? @res : $res[0] 367 wantarray ? @res : $res[0]
344 } else { 368 } else {
345 # we are in another coroutine, how wonderful, everything just works 369 # we are in another coroutine, how wonderful, everything just works
346 370
347 $job->() 371 $job->()
… …
367 391
368 $coro 392 $coro
369} 393}
370 394
371sub write_runtime { 395sub write_runtime {
396 my $runtime = "$LOCALDIR/runtime";
397
398 # first touch the runtime file to show we are still running:
399 # the fsync below can take a very very long time.
400
401 IO::AIO::aio_utime $runtime, undef, undef;
402
372 my $guard = cf::lock_acquire "write_runtime"; 403 my $guard = cf::lock_acquire "write_runtime";
373
374 my $runtime = "$LOCALDIR/runtime";
375 404
376 my $fh = aio_open "$runtime~", O_WRONLY | O_CREAT, 0644 405 my $fh = aio_open "$runtime~", O_WRONLY | O_CREAT, 0644
377 or return; 406 or return;
378 407
379 my $value = $cf::RUNTIME + 90 + 10; 408 my $value = $cf::RUNTIME + 90 + 10;
… …
385 414
386 # always fsync - this file is important 415 # always fsync - this file is important
387 aio_fsync $fh 416 aio_fsync $fh
388 and return; 417 and return;
389 418
419 # touch it again to show we are up-to-date
420 aio_utime $fh, undef, undef;
421
390 close $fh 422 close $fh
391 or return; 423 or return;
392 424
393 aio_rename "$runtime~", $runtime 425 aio_rename "$runtime~", $runtime
394 and return; 426 and return;
427
428 warn "runtime file written.\n";
395 429
396 1 430 1
397} 431}
398 432
399=item cf::datalog type => key => value, ... 433=item cf::datalog type => key => value, ...
… …
592 $registry = $CB_TYPE[$object_type] ||= []; 626 $registry = $CB_TYPE[$object_type] ||= [];
593 627
594 } elsif ($type eq "subtype") { 628 } elsif ($type eq "subtype") {
595 defined $object_type or Carp::croak "subtype specified without type"; 629 defined $object_type or Carp::croak "subtype specified without type";
596 my $object_subtype = shift @arg; 630 my $object_subtype = shift @arg;
597 $registry = $CB_TYPE[$object_type + $object_subtype * NUM_SUBTYPES] ||= []; 631 $registry = $CB_TYPE[$object_type + $object_subtype * NUM_TYPES] ||= [];
598 632
599 } elsif ($type eq "package") { 633 } elsif ($type eq "package") {
600 my $pkg = shift @arg; 634 my $pkg = shift @arg;
601 635
602 while (my ($name, $id) = each %cb_id) { 636 while (my ($name, $id) = each %cb_id) {
… …
643 if (ref $_[0]) { 677 if (ref $_[0]) {
644 _object_attach @_; 678 _object_attach @_;
645 } else { 679 } else {
646 _attach shift->_attach_registry, @_; 680 _attach shift->_attach_registry, @_;
647 } 681 }
682 _recalc_want;
648}; 683};
649 684
650# all those should be optimised 685# all those should be optimised
651sub cf::attachable::detach { 686sub cf::attachable::detach {
652 my ($obj, $name) = @_; 687 my ($obj, $name) = @_;
… …
655 delete $obj->{_attachment}{$name}; 690 delete $obj->{_attachment}{$name};
656 reattach ($obj); 691 reattach ($obj);
657 } else { 692 } else {
658 Carp::croak "cannot, currently, detach class attachments"; 693 Carp::croak "cannot, currently, detach class attachments";
659 } 694 }
695 _recalc_want;
660}; 696};
661 697
662sub cf::attachable::attached { 698sub cf::attachable::attached {
663 my ($obj, $name) = @_; 699 my ($obj, $name) = @_;
664 700
… …
837 or return; 873 or return;
838 $av = eval { (Storable::thaw $av)->{objs} }; 874 $av = eval { (Storable::thaw $av)->{objs} };
839 } 875 }
840 876
841 warn sprintf "loading %s (%d)\n", 877 warn sprintf "loading %s (%d)\n",
842 $filename, length $data, scalar @{$av || []};#d# 878 $filename, length $data, scalar @{$av || []};
843 return ($data, $av); 879 return ($data, $av);
844} 880}
845 881
846############################################################################# 882#############################################################################
847# command handling &c 883# command handling &c
… …
1269 my ($self, $merge) = @_; 1305 my ($self, $merge) = @_;
1270 1306
1271 # we have to keep some variables in memory intact 1307 # we have to keep some variables in memory intact
1272 local $self->{path}; 1308 local $self->{path};
1273 local $self->{load_path}; 1309 local $self->{load_path};
1274 local $self->{deny_save};
1275 local $self->{deny_reset};
1276 1310
1277 $self->SUPER::thawer_merge ($merge); 1311 $self->SUPER::thawer_merge ($merge);
1278} 1312}
1279 1313
1280sub normalise { 1314sub normalise {
… …
1380 1414
1381 $_->change_map_light ($change) 1415 $_->change_map_light ($change)
1382 for grep $_->outdoor, values %cf::MAP; 1416 for grep $_->outdoor, values %cf::MAP;
1383} 1417}
1384 1418
1419sub decay_objects {
1420 my ($self) = @_;
1421
1422 return if $self->{deny_reset};
1423
1424 $self->do_decay_objects;
1425}
1426
1385sub unlink_save { 1427sub unlink_save {
1386 my ($self) = @_; 1428 my ($self) = @_;
1387 1429
1388 utf8::encode (my $save = $self->save_path); 1430 utf8::encode (my $save = $self->save_path);
1389 IO::AIO::aioreq_pri 4; Coro::AIO::aio_unlink $save; 1431 IO::AIO::aioreq_pri 4; Coro::AIO::aio_unlink $save;
… …
1445 $self->load_header_orig 1487 $self->load_header_orig
1446 or return; 1488 or return;
1447 $self->prepare_orig; 1489 $self->prepare_orig;
1448 } 1490 }
1449 1491
1492 $self->{deny_reset} = 1
1493 if $self->no_reset;
1494
1450 $self->default_region (cf::region::find_by_path $self->{path}) 1495 $self->default_region (cf::region::find_by_path $self->{path})
1451 unless $self->default_region; 1496 unless $self->default_region;
1452 1497
1453 1 1498 1
1454} 1499}
… …
1469 $map->{last_save} = $cf::RUNTIME; 1514 $map->{last_save} = $cf::RUNTIME;
1470 1515
1471 $map->load_header 1516 $map->load_header
1472 or return; 1517 or return;
1473 1518
1474 if ($map->should_reset && 0) {#d#TODO# disabled, crashy (locking issue?) 1519 if ($map->should_reset) {#d#TODO# disabled, crashy (locking issue?)
1475 # doing this can freeze the server in a sync job, obviously 1520 # doing this can freeze the server in a sync job, obviously
1476 #$cf::WAIT_FOR_TICK->wait; 1521 #$cf::WAIT_FOR_TICK->wait;
1477 $map->reset; 1522 $map->reset;
1478 undef $guard; 1523 undef $guard;
1479 return find $path; 1524 return find $path;
… …
1535 Coro::cede; 1580 Coro::cede;
1536 $self->activate; 1581 $self->activate;
1537 } 1582 }
1538 1583
1539 $self->in_memory (cf::MAP_IN_MEMORY); 1584 $self->in_memory (cf::MAP_IN_MEMORY);
1540
1541 undef $guard;
1542 } 1585 }
1543 1586
1544 $self->post_load; 1587 $self->post_load;
1545} 1588}
1546 1589
1547sub customise_for { 1590sub customise_for {
1548 my ($self, $ob) = @_; 1591 my ($self, $ob) = @_;
1549 1592
1550 return find "~" . $ob->name . "/" . $self->{path} 1593 return find "~" . $ob->name . "/" . $self->{path}
1551 if $self->per_player; 1594 if $self->per_player;
1595
1596# return find "?party/" . $ob->name . "/" . $self->{path}
1597# if $self->per_party;
1552 1598
1553 $self 1599 $self
1554} 1600}
1555 1601
1556# find and load all maps in the 3x3 area around a map 1602# find and load all maps in the 3x3 area around a map
… …
1667 1713
1668sub reset_at { 1714sub reset_at {
1669 my ($self) = @_; 1715 my ($self) = @_;
1670 1716
1671 # TODO: safety, remove and allow resettable per-player maps 1717 # TODO: safety, remove and allow resettable per-player maps
1672 return 1e99 if $self->isa ("ext::map_per_player");#d#
1673 return 1e99 if $self->{deny_reset}; 1718 return 1e99 if $self->{deny_reset};
1674 1719
1675 my $time = $self->fixed_resettime ? $self->{instantiate_time} : $self->last_access; 1720 my $time = $self->fixed_resettime ? $self->{instantiate_time} : $self->last_access;
1676 my $to = List::Util::min $MAX_RESET, $self->reset_timeout || $DEFAULT_RESET; 1721 my $to = List::Util::min $MAX_RESET, $self->reset_timeout || $DEFAULT_RESET;
1677 1722
… …
1688 my ($self) = @_; 1733 my ($self) = @_;
1689 1734
1690 my $lock = cf::lock_acquire "map_data:$self->{path}"; 1735 my $lock = cf::lock_acquire "map_data:$self->{path}";
1691 1736
1692 return if $self->players; 1737 return if $self->players;
1693 return if $self->isa ("ext::map_per_player");#d#
1694 1738
1695 warn "resetting map ", $self->path;#d# 1739 warn "resetting map ", $self->path;
1696 1740
1697 $self->in_memory (cf::MAP_SWAPPED); 1741 $self->in_memory (cf::MAP_SWAPPED);
1698 1742
1699 # need to save uniques path 1743 # need to save uniques path
1700 unless ($self->{deny_save}) { 1744 unless ($self->{deny_save}) {
… …
1732 $cf::MAP{$self->path} = $self; 1776 $cf::MAP{$self->path} = $self;
1733 1777
1734 $self->reset; # polite request, might not happen 1778 $self->reset; # polite request, might not happen
1735} 1779}
1736 1780
1781=item $maps = cf::map::tmp_maps
1782
1783Returns an arrayref with all map paths of currently instantiated and saved
1784maps. May block.
1785
1786=cut
1787
1788sub tmp_maps() {
1789 [
1790 map {
1791 utf8::decode $_;
1792 /\.map$/
1793 ? normalise $_
1794 : ()
1795 } @{ aio_readdir $TMPDIR or [] }
1796 ]
1797}
1798
1799=item $maps = cf::map::random_maps
1800
1801Returns an arrayref with all map paths of currently instantiated and saved
1802random maps. May block.
1803
1804=cut
1805
1806sub random_maps() {
1807 [
1808 map {
1809 utf8::decode $_;
1810 /\.map$/
1811 ? normalise "?random/$_"
1812 : ()
1813 } @{ aio_readdir $RANDOMDIR or [] }
1814 ]
1815}
1816
1737=item cf::map::unique_maps 1817=item cf::map::unique_maps
1738 1818
1739Returns an arrayref of paths of all shared maps that have 1819Returns an arrayref of paths of all shared maps that have
1740instantiated unique items. May block. 1820instantiated unique items. May block.
1741 1821
1742=cut 1822=cut
1743 1823
1744sub unique_maps() { 1824sub unique_maps() {
1745 my $files = aio_readdir $UNIQUEDIR 1825 [
1746 or return; 1826 map {
1747
1748 my @paths;
1749
1750 for (@$files) {
1751 utf8::decode $_; 1827 utf8::decode $_;
1752 next if /\.pst$/; 1828 /\.map$/
1753 next unless /^$PATH_SEP/o; 1829 ? normalise $_
1754 1830 : ()
1755 push @paths, cf::map::normalise $_; 1831 } @{ aio_readdir $UNIQUEDIR or [] }
1756 } 1832 ]
1757
1758 \@paths
1759} 1833}
1760 1834
1761package cf; 1835package cf;
1762 1836
1763=back 1837=back
… …
1869 $self->deactivate_recursive; 1943 $self->deactivate_recursive;
1870 1944
1871 return if UNIVERSAL::isa $self->map, "ext::map_link"; 1945 return if UNIVERSAL::isa $self->map, "ext::map_link";
1872 1946
1873 $self->{_link_pos} ||= [$self->map->{path}, $self->x, $self->y] 1947 $self->{_link_pos} ||= [$self->map->{path}, $self->x, $self->y]
1874 if $self->map; 1948 if $self->map && $self->map->{path} ne "{link}";
1875 1949
1876 $self->enter_map ($LINK_MAP || link_map, 10, 10); 1950 $self->enter_map ($LINK_MAP || link_map, 10, 10);
1877} 1951}
1878 1952
1879sub cf::object::player::leave_link { 1953sub cf::object::player::leave_link {
1880 my ($self, $map, $x, $y) = @_; 1954 my ($self, $map, $x, $y) = @_;
1955
1956 return unless $self->contr->active;
1881 1957
1882 my $link_pos = delete $self->{_link_pos}; 1958 my $link_pos = delete $self->{_link_pos};
1883 1959
1884 unless ($map) { 1960 unless ($map) {
1885 # restore original map position 1961 # restore original map position
… …
1908 1984
1909 local $self->{_prev_pos} = $link_pos; # ugly hack for rent.ext 1985 local $self->{_prev_pos} = $link_pos; # ugly hack for rent.ext
1910 $self->enter_map ($map, $x, $y); 1986 $self->enter_map ($map, $x, $y);
1911} 1987}
1912 1988
1913cf::player->attach (
1914 on_logout => sub {
1915 my ($pl) = @_;
1916
1917 # abort map switching before logout
1918 if ($pl->ob->{_link_pos}) {
1919 cf::sync_job {
1920 $pl->ob->leave_link
1921 };
1922 }
1923 },
1924 on_login => sub {
1925 my ($pl) = @_;
1926
1927 # try to abort aborted map switching on player login :)
1928 # should happen only on crashes
1929 if ($pl->ob->{_link_pos}) {
1930 $pl->ob->enter_link;
1931 (async {
1932 $pl->ob->reply (undef,
1933 "There was an internal problem at your last logout, "
1934 . "the server will try to bring you to your intended destination in a second.",
1935 cf::NDI_RED);
1936 # we need this sleep as the login has a concurrent enter_exit running
1937 # and this sleep increases chances of the player not ending up in scorn
1938 Coro::Timer::sleep 1;
1939 $pl->ob->leave_link;
1940 })->prio (2);
1941 }
1942 },
1943);
1944
1945=item $player_object->goto ($path, $x, $y) 1989=item $player_object->goto ($path, $x, $y[, $check->($map)])
1946 1990
1991Moves the player to the given map-path and coordinates by first freezing
1992her, loading and preparing them map, calling the provided $check callback
1993that has to return the map if sucecssful, and then unfreezes the player on
1994the new (success) or old (failed) map position.
1995
1947=cut 1996=cut
1997
1998our $GOTOGEN;
1948 1999
1949sub cf::object::player::goto { 2000sub cf::object::player::goto {
1950 my ($self, $path, $x, $y) = @_; 2001 my ($self, $path, $x, $y, $check) = @_;
2002
2003 # do generation counting so two concurrent goto's will be executed in-order
2004 my $gen = $self->{_goto_generation} = ++$GOTOGEN;
1951 2005
1952 $self->enter_link; 2006 $self->enter_link;
1953 2007
1954 (async { 2008 (async {
1955 my $map = eval { 2009 my $map = eval {
1956 my $map = cf::map::find $path; 2010 my $map = cf::map::find $path;
2011
2012 if ($map) {
1957 $map = $map->customise_for ($self) if $map; 2013 $map = $map->customise_for ($self);
2014 $map = $check->($map) if $check && $map;
2015 } else {
2016 $self->message ("The exit to '$path' is closed", cf::NDI_UNIQUE | cf::NDI_RED);
2017 }
2018
1958 $map 2019 $map
2020 };
2021
2022 if ($@) {
2023 $self->message ("Something went wrong within the server, please report this incident!", cf::NDI_UNIQUE | cf::NDI_RED);
2024 LOG llevError | logBacktrace, Carp::longmess $@;
1959 } or 2025 }
1960 $self->message ("The exit to '$path' is closed", cf::NDI_UNIQUE | cf::NDI_RED);
1961 2026
2027 if ($gen == $self->{_goto_generation}) {
2028 delete $self->{_goto_generation};
1962 $self->leave_link ($map, $x, $y); 2029 $self->leave_link ($map, $x, $y);
2030 }
1963 })->prio (1); 2031 })->prio (1);
1964} 2032}
1965 2033
1966=item $player_object->enter_exit ($exit_object) 2034=item $player_object->enter_exit ($exit_object)
1967 2035
… …
2437 2505
2438 die $$res unless "ARRAY" eq ref $res; 2506 die $$res unless "ARRAY" eq ref $res;
2439 2507
2440 return wantarray ? @$res : $res->[-1]; 2508 return wantarray ? @$res : $res->[-1];
2441 } else { 2509 } else {
2510 reset_signals;
2442 local $SIG{__WARN__}; 2511 local $SIG{__WARN__};
2512 local $SIG{__DIE__};
2443 eval { 2513 eval {
2444 local $SIG{__DIE__};
2445 close $fh1; 2514 close $fh1;
2446 2515
2447 my @res = eval { $cb->(@args) }; 2516 my @res = eval { $cb->(@args) };
2448 syswrite $fh2, Coro::Storable::freeze +($@ ? \"$@" : \@res); 2517 syswrite $fh2, Coro::Storable::freeze +($@ ? \"$@" : \@res);
2449 }; 2518 };
2450 2519
2451 warn $@ if $@; 2520 warn $@ if $@;
2452 _exit 0; 2521 _exit 0;
2453 } 2522 }
2454} 2523}
2455
2456
2457 2524
2458############################################################################# 2525#############################################################################
2459# the server's init and main functions 2526# the server's init and main functions
2460 2527
2461sub load_facedata($) { 2528sub load_facedata($) {
… …
2533sub reload_resources { 2600sub reload_resources {
2534 warn "reloading resource files...\n"; 2601 warn "reloading resource files...\n";
2535 2602
2536 reload_regions; 2603 reload_regions;
2537 reload_facedata; 2604 reload_facedata;
2605 #reload_archetypes;#d#
2538 reload_archetypes; 2606 reload_archetypes;
2539 reload_treasures; 2607 reload_treasures;
2540 2608
2541 warn "finished reloading resource files\n"; 2609 warn "finished reloading resource files\n";
2542} 2610}
… …
2812 my $signal = new Coro::Signal; 2880 my $signal = new Coro::Signal;
2813 push @WAIT_FOR_TICK_BEGIN, $signal; 2881 push @WAIT_FOR_TICK_BEGIN, $signal;
2814 $signal->wait; 2882 $signal->wait;
2815} 2883}
2816 2884
2885 my $min = 1e6;#d#
2886 my $avg = 10;
2817$TICK_WATCHER = Event->timer ( 2887$TICK_WATCHER = Event->timer (
2818 reentrant => 0, 2888 reentrant => 0,
2819 parked => 1, 2889 parked => 1,
2820 prio => 0, 2890 prio => 0,
2821 at => $NEXT_TICK || $TICK, 2891 at => $NEXT_TICK || $TICK,
… …
2825 Carp::cluck "major BUG: server tick called outside of main coro, skipping it" 2895 Carp::cluck "major BUG: server tick called outside of main coro, skipping it"
2826 unless ++$bug_warning > 10; 2896 unless ++$bug_warning > 10;
2827 return; 2897 return;
2828 } 2898 }
2829 2899
2830 $NOW = Event::time; 2900 $NOW = $tick_start = Event::time;
2831 2901
2832 cf::server_tick; # one server iteration 2902 cf::server_tick; # one server iteration
2903
2904 0 && sync_job {#d#
2905 for(1..10) {
2906 my $t = Event::time;
2907 my $map = my $map = new_from_path cf::map "/tmp/x.map"
2908 or die;
2909
2910 $map->width (50);
2911 $map->height (50);
2912 $map->alloc;
2913 $map->_load_objects ("/tmp/x.map", 1);
2914 my $t = Event::time - $t;
2915
2916 #next unless $t < 0.0013;#d#
2917 if ($t < $min) {
2918 $min = $t;
2919 }
2920 $avg = $avg * 0.99 + $t * 0.01;
2921 }
2922 warn "XXXXXXXXXXXXXXXXXX min $min avg $avg\n";#d#
2923 exit 0;
2924 # 2007-05-22 02:33:04.569 min 0.00112509727478027 avg 0.0012259249572477
2925 };
2833 2926
2834 $RUNTIME += $TICK; 2927 $RUNTIME += $TICK;
2835 $NEXT_TICK += $TICK; 2928 $NEXT_TICK += $TICK;
2836 2929
2837 if ($NOW >= $NEXT_RUNTIME_WRITE) { 2930 if ($NOW >= $NEXT_RUNTIME_WRITE) {
… …
2843 } 2936 }
2844 2937
2845# my $AFTER = Event::time; 2938# my $AFTER = Event::time;
2846# warn $AFTER - $NOW;#d# 2939# warn $AFTER - $NOW;#d#
2847 2940
2941 if (my $sig = shift @WAIT_FOR_TICK_BEGIN) {
2942 $sig->send;
2943 }
2944 while (my $sig = shift @WAIT_FOR_TICK) {
2945 $sig->send;
2946 }
2947
2948 $NOW = Event::time;
2949
2848 # if we are delayed by four ticks or more, skip them all 2950 # if we are delayed by four ticks or more, skip them all
2849 $NEXT_TICK = Event::time if Event::time >= $NEXT_TICK + $TICK * 4; 2951 $NEXT_TICK = $NOW if $NOW >= $NEXT_TICK + $TICK * 4;
2850 2952
2851 $TICK_WATCHER->at ($NEXT_TICK); 2953 $TICK_WATCHER->at ($NEXT_TICK);
2852 $TICK_WATCHER->start; 2954 $TICK_WATCHER->start;
2853 2955
2854 if (my $sig = shift @WAIT_FOR_TICK_BEGIN) { 2956 $LOAD = ($NOW - $tick_start) / $TICK;
2855 $sig->send; 2957 $LOADAVG = $LOADAVG * 0.75 + $LOAD * 0.25;
2856 }
2857 while (my $sig = shift @WAIT_FOR_TICK) {
2858 $sig->send;
2859 }
2860 2958
2861 _post_tick; 2959 _post_tick;
2960
2961
2862 }, 2962 },
2863); 2963);
2864 2964
2865{ 2965{
2866 BDB::max_poll_time $TICK * 0.1; 2966 BDB::max_poll_time $TICK * 0.1;
… …
2925 prio => 6, 3025 prio => 6,
2926 cb => \&IO::AIO::poll_cb, 3026 cb => \&IO::AIO::poll_cb,
2927 ); 3027 );
2928} 3028}
2929 3029
3030my $_log_backtrace;
3031
3032sub _log_backtrace {
3033 my ($msg, @addr) = @_;
3034
3035 $msg =~ s/\n//;
3036
3037 # limit the # of concurrent backtraces
3038 if ($_log_backtrace < 2) {
3039 ++$_log_backtrace;
3040 async {
3041 my @bt = fork_call {
3042 @addr = map { sprintf "%x", $_ } @addr;
3043 my $self = (-f "/proc/$$/exe") ? "/proc/$$/exe" : $^X;
3044 open my $fh, "exec addr2line -C -f -i -e \Q$self\E @addr 2>&1 |"
3045 or die "addr2line: $!";
3046
3047 my @funcs;
3048 my @res = <$fh>;
3049 chomp for @res;
3050 while (@res) {
3051 my ($func, $line) = splice @res, 0, 2, ();
3052 push @funcs, "[$func] $line";
3053 }
3054
3055 @funcs
3056 };
3057
3058 LOG llevInfo, "[ABT] $msg\n";
3059 LOG llevInfo, "[ABT] $_\n" for @bt;
3060 --$_log_backtrace;
3061 };
3062 } else {
3063 LOG llevInfo, "[ABT] $msg\n";
3064 LOG llevInfo, "[ABT] [suppressed]\n";
3065 }
3066}
3067
2930# load additional modules 3068# load additional modules
2931use cf::pod; 3069use cf::pod;
2932 3070
2933END { cf::emergency_save } 3071END { cf::emergency_save }
2934 3072

Diff Legend

– Removed lines
+ Added lines
< Changed lines
> Changed lines