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.523 by root, Sat Apr 17 02:39:46 2010 UTC vs.
Revision 1.541 by root, Tue May 4 23:33:16 2010 UTC

20# The authors can be reached via e-mail to <support@deliantra.net> 20# The authors can be reached via e-mail to <support@deliantra.net>
21# 21#
22 22
23package cf; 23package cf;
24 24
25use 5.10.0; 25use common::sense;
26use utf8;
27use strict qw(vars subs);
28 26
29use Symbol; 27use Symbol;
30use List::Util; 28use List::Util;
31use Socket; 29use Socket;
32use EV; 30use EV;
78# strictly for debugging 76# strictly for debugging
79$SIG{QUIT} = sub { Carp::cluck "SIGQUIT" }; 77$SIG{QUIT} = sub { Carp::cluck "SIGQUIT" };
80 78
81sub WF_AUTOCANCEL () { 1 } # automatically cancel this watcher on reload 79sub WF_AUTOCANCEL () { 1 } # automatically cancel this watcher on reload
82 80
81our @ORIG_INC;
82
83our %COMMAND = (); 83our %COMMAND = ();
84our %COMMAND_TIME = (); 84our %COMMAND_TIME = ();
85 85
86our @EXTS = (); # list of extension package names 86our @EXTS = (); # list of extension package names
87our %EXTCMD = (); 87our %EXTCMD = ();
106our $RANDOMDIR = "$LOCALDIR/random"; 106our $RANDOMDIR = "$LOCALDIR/random";
107our $BDBDIR = "$LOCALDIR/db"; 107our $BDBDIR = "$LOCALDIR/db";
108our $PIDFILE = "$LOCALDIR/pid"; 108our $PIDFILE = "$LOCALDIR/pid";
109our $RUNTIMEFILE = "$LOCALDIR/runtime"; 109our $RUNTIMEFILE = "$LOCALDIR/runtime";
110 110
111our %RESOURCE; 111our %RESOURCE; # unused
112 112
113our $OUTPUT_RATE_MIN = 4000; 113our $OUTPUT_RATE_MIN = 3000;
114our $OUTPUT_RATE_MAX = 100000; 114our $OUTPUT_RATE_MAX = 1000000;
115
116our $MAX_LINKS = 32; # how many chained exits to follow
117our $VERBOSE_IO = 1;
115 118
116our $TICK = MAX_TIME * 1e-6; # this is a CONSTANT(!) 119our $TICK = MAX_TIME * 1e-6; # this is a CONSTANT(!)
117our $NEXT_RUNTIME_WRITE; # when should the runtime file be written 120our $NEXT_RUNTIME_WRITE; # when should the runtime file be written
118our $NEXT_TICK; 121our $NEXT_TICK;
119our $USE_FSYNC = 1; # use fsync to write maps - default on 122our $USE_FSYNC = 1; # use fsync to write maps - default on
249 252
250=back 253=back
251 254
252=cut 255=cut
253 256
257sub error(@) { LOG llevError, join "", @_ }
258sub warn (@) { LOG llevWarn , join "", @_ }
259sub info (@) { LOG llevInfo , join "", @_ }
260sub debug(@) { LOG llevDebug, join "", @_ }
261sub trace(@) { LOG llevTrace, join "", @_ }
262
254$Coro::State::WARNHOOK = sub { 263$Coro::State::WARNHOOK = sub {
255 my $msg = join "", @_; 264 my $msg = join "", @_;
256 265
257 $msg .= "\n" 266 $msg .= "\n"
258 unless $msg =~ /\n$/; 267 unless $msg =~ /\n$/;
259 268
260 $msg =~ s/([\x00-\x08\x0b-\x1f])/sprintf "\\x%02x", ord $1/ge; 269 $msg =~ s/([\x00-\x08\x0b-\x1f])/sprintf "\\x%02x", ord $1/ge;
261 270
262 LOG llevError, $msg; 271 LOG llevWarn, $msg;
263}; 272};
264 273
265$Coro::State::DIEHOOK = sub { 274$Coro::State::DIEHOOK = sub {
266 return unless $^S eq 0; # "eq", not "==" 275 return unless $^S eq 0; # "eq", not "=="
267 276
268 warn Carp::longmess $_[0]; 277 error Carp::longmess $_[0];
269 278
270 if (in_main) {#d# 279 if (in_main) {#d#
271 warn "DIEHOOK called in main context, Coro bug?\n";#d# 280 error "DIEHOOK called in main context, Coro bug?\n";#d#
272 return;#d# 281 return;#d#
273 }#d# 282 }#d#
274 283
275 # kill coroutine otherwise 284 # kill coroutine otherwise
276 Coro::terminate 285 Coro::terminate
509=cut 518=cut
510 519
511sub sync_job(&) { 520sub sync_job(&) {
512 my ($job) = @_; 521 my ($job) = @_;
513 522
514 if ($Coro::current == $Coro::main) { 523 if (in_main) {
515 my $time = AE::time; 524 my $time = AE::time;
516 525
517 # this is the main coro, too bad, we have to block 526 # this is the main coro, too bad, we have to block
518 # till the operation succeeds, freezing the server :/ 527 # till the operation succeeds, freezing the server :/
519 528
520 LOG llevError, Carp::longmess "sync job";#d# 529 #LOG llevError, Carp::longmess "sync job";#d#
521 530
522 my $freeze_guard = freeze_mainloop; 531 my $freeze_guard = freeze_mainloop;
523 532
524 my $busy = 1; 533 my $busy = 1;
525 my @res; 534 my @res;
526 535
527 (async { 536 (async {
528 $Coro::current->desc ("sync job coro"); 537 $Coro::current->desc ("sync job coro");
529 @res = eval { $job->() }; 538 @res = eval { $job->() };
530 warn $@ if $@; 539 error $@ if $@;
531 undef $busy; 540 undef $busy;
532 })->prio (Coro::PRIO_MAX); 541 })->prio (Coro::PRIO_MAX);
533 542
534 while ($busy) { 543 while ($busy) {
535 if (Coro::nready) { 544 if (Coro::nready) {
648within each server. 657within each server.
649 658
650=cut 659=cut
651 660
652sub db_table($) { 661sub db_table($) {
662 cf::error "db_get called from main context"
663 if $Coro::current == $Coro::main;
664
653 my ($name) = @_; 665 my ($name) = @_;
654 my $db = BDB::db_create $DB_ENV; 666 my $db = BDB::db_create $DB_ENV;
655 667
656 eval { 668 eval {
657 $db->set_flags (BDB::CHKSUM); 669 $db->set_flags (BDB::CHKSUM);
667} 679}
668 680
669our $DB; 681our $DB;
670 682
671sub db_init { 683sub db_init {
672 cf::sync_job {
673 $DB ||= db_table "db"; 684 $DB ||= db_table "db";
674 };
675} 685}
676 686
677sub db_get($$) { 687sub db_get($$) {
678 my $key = "$_[0]/$_[1]"; 688 my $key = "$_[0]/$_[1]";
679 689
680 cf::sync_job { 690 cf::error "db_get called from main context"
691 if $Coro::current == $Coro::main;
692
681 BDB::db_get $DB, undef, $key, my $data; 693 BDB::db_get $DB, undef, $key, my $data;
682 694
683 $! ? () 695 $! ? ()
684 : $data 696 : $data
685 }
686} 697}
687 698
688sub db_put($$$) { 699sub db_put($$$) {
689 BDB::dbreq_pri 4; 700 BDB::dbreq_pri 4;
690 BDB::db_put $DB, undef, "$_[0]/$_[1]", $_[2], 0, sub { }; 701 BDB::db_put $DB, undef, "$_[0]/$_[1]", $_[2], 0, sub { };
746 757
747 my $t1 = Time::HiRes::time; 758 my $t1 = Time::HiRes::time;
748 my $data = $process->(\@data); 759 my $data = $process->(\@data);
749 my $t2 = Time::HiRes::time; 760 my $t2 = Time::HiRes::time;
750 761
751 warn "cache: '$id' processed in ", $t2 - $t1, "s\n"; 762 info "cache: '$id' processed in ", $t2 - $t1, "s\n";
752 763
753 db_put cache => "$id/data", $data; 764 db_put cache => "$id/data", $data;
754 db_put cache => "$id/md5" , $md5; 765 db_put cache => "$id/md5" , $md5;
755 db_put cache => "$id/meta", $meta; 766 db_put cache => "$id/meta", $meta;
756 767
766 777
767=cut 778=cut
768 779
769sub datalog($@) { 780sub datalog($@) {
770 my ($type, %kv) = @_; 781 my ($type, %kv) = @_;
771 warn "DATALOG ", JSON::XS->new->ascii->encode ({ %kv, type => $type }); 782 info "DATALOG ", JSON::XS->new->ascii->encode ({ %kv, type => $type });
772} 783}
773 784
774=back 785=back
775 786
776=cut 787=cut
971 982
972 } elsif (exists $cb_id{$type}) { 983 } elsif (exists $cb_id{$type}) {
973 _attach_cb $registry, $cb_id{$type}, $prio, shift @arg; 984 _attach_cb $registry, $cb_id{$type}, $prio, shift @arg;
974 985
975 } elsif (ref $type) { 986 } elsif (ref $type) {
976 warn "attaching objects not supported, ignoring.\n"; 987 error "attaching objects not supported, ignoring.\n";
977 988
978 } else { 989 } else {
979 shift @arg; 990 shift @arg;
980 warn "attach argument '$type' not supported, ignoring.\n"; 991 error "attach argument '$type' not supported, ignoring.\n";
981 } 992 }
982 } 993 }
983} 994}
984 995
985sub _object_attach { 996sub _object_attach {
995 _attach $registry, $klass, @attach; 1006 _attach $registry, $klass, @attach;
996 } 1007 }
997 1008
998 $obj->{$name} = \%arg; 1009 $obj->{$name} = \%arg;
999 } else { 1010 } else {
1000 warn "object uses attachment '$name' which is not available, postponing.\n"; 1011 info "object uses attachment '$name' which is not available, postponing.\n";
1001 } 1012 }
1002 1013
1003 $obj->{_attachment}{$name} = undef; 1014 $obj->{_attachment}{$name} = undef;
1004} 1015}
1005 1016
1064 1075
1065 for (@$callbacks) { 1076 for (@$callbacks) {
1066 eval { &{$_->[1]} }; 1077 eval { &{$_->[1]} };
1067 1078
1068 if ($@) { 1079 if ($@) {
1069 warn "$@";
1070 warn "... while processing $EVENT[$event][0](@_) event, skipping processing altogether.\n"; 1080 error "$@", "... while processing $EVENT[$event][0](@_) event, skipping processing altogether.\n";
1071 override; 1081 override;
1072 } 1082 }
1073 1083
1074 return 1 if $override; 1084 return 1 if $override;
1075 } 1085 }
1154 for (@$attach) { 1164 for (@$attach) {
1155 my ($klass, @attach) = @$_; 1165 my ($klass, @attach) = @$_;
1156 _attach $registry, $klass, @attach; 1166 _attach $registry, $klass, @attach;
1157 } 1167 }
1158 } else { 1168 } else {
1159 warn "object uses attachment '$name' that is not available, postponing.\n"; 1169 info "object uses attachment '$name' that is not available, postponing.\n";
1160 } 1170 }
1161 } 1171 }
1162} 1172}
1163 1173
1164cf::attachable->attach ( 1174cf::attachable->attach (
1191 my ($filename, $rdata, $objs) = @_; 1201 my ($filename, $rdata, $objs) = @_;
1192 1202
1193 sync_job { 1203 sync_job {
1194 if (length $$rdata) { 1204 if (length $$rdata) {
1195 utf8::decode (my $decname = $filename); 1205 utf8::decode (my $decname = $filename);
1196 warn sprintf "saving %s (%d,%d)\n", 1206 trace sprintf "saving %s (%d,%d)\n",
1197 $decname, length $$rdata, scalar @$objs; 1207 $decname, length $$rdata, scalar @$objs
1208 if $VERBOSE_IO;
1198 1209
1199 if (my $fh = aio_open "$filename~", O_WRONLY | O_CREAT, 0600) { 1210 if (my $fh = aio_open "$filename~", O_WRONLY | O_CREAT, 0600) {
1200 aio_chmod $fh, SAVE_MODE; 1211 aio_chmod $fh, SAVE_MODE;
1201 aio_write $fh, 0, (length $$rdata), $$rdata, 0; 1212 aio_write $fh, 0, (length $$rdata), $$rdata, 0;
1202 if ($cf::USE_FSYNC) { 1213 if ($cf::USE_FSYNC) {
1224 aio_rename "$filename~", $filename; 1235 aio_rename "$filename~", $filename;
1225 1236
1226 $filename =~ s%/[^/]+$%%; 1237 $filename =~ s%/[^/]+$%%;
1227 aio_pathsync $filename if $cf::USE_FSYNC; 1238 aio_pathsync $filename if $cf::USE_FSYNC;
1228 } else { 1239 } else {
1229 warn "unable to save objects: $filename~: $!\n"; 1240 error "unable to save objects: $filename~: $!\n";
1230 } 1241 }
1231 } else { 1242 } else {
1232 aio_unlink $filename; 1243 aio_unlink $filename;
1233 aio_unlink "$filename.pst"; 1244 aio_unlink "$filename.pst";
1234 } 1245 }
1258 my $st = eval { Coro::Storable::thaw $av }; 1269 my $st = eval { Coro::Storable::thaw $av };
1259 $av = $st->{objs}; 1270 $av = $st->{objs};
1260 } 1271 }
1261 1272
1262 utf8::decode (my $decname = $filename); 1273 utf8::decode (my $decname = $filename);
1263 warn sprintf "loading %s (%d,%d)\n", 1274 trace sprintf "loading %s (%d,%d)\n",
1264 $decname, length $data, scalar @{$av || []}; 1275 $decname, length $data, scalar @{$av || []}
1276 if $VERBOSE_IO;
1265 1277
1266 ($data, $av) 1278 ($data, $av)
1267} 1279}
1268 1280
1269=head2 COMMAND CALLBACKS 1281=head2 COMMAND CALLBACKS
1361 1373
1362 $pl->ext_reply ($reply, @reply) 1374 $pl->ext_reply ($reply, @reply)
1363 if $reply; 1375 if $reply;
1364 1376
1365 } else { 1377 } else {
1366 warn "player " . ($pl->ob->name) . " sent unparseable ext message: <$buf>\n"; 1378 error "player " . ($pl->ob->name) . " sent unparseable ext message: <$buf>\n";
1367 } 1379 }
1368 1380
1369 cf::override; 1381 cf::override;
1370 }, 1382 },
1371); 1383);
1382 1394
1383 $grp 1395 $grp
1384} 1396}
1385 1397
1386sub load_extensions { 1398sub load_extensions {
1399 info "loading extensions...";
1400
1387 cf::sync_job { 1401 cf::sync_job {
1388 my %todo; 1402 my %todo;
1389 1403
1390 for my $path (<$LIBDIR/*.ext>) { 1404 for my $path (<$LIBDIR/*.ext>) {
1391 next unless -r $path; 1405 next unless -r $path;
1409 1423
1410 $ext{meta} = { map { (split /=/, $_, 2)[0, 1] } split /\s+/, $1 } 1424 $ext{meta} = { map { (split /=/, $_, 2)[0, 1] } split /\s+/, $1 }
1411 if $source =~ /\A#!.*?perl.*?#\s*(.*)$/m; 1425 if $source =~ /\A#!.*?perl.*?#\s*(.*)$/m;
1412 1426
1413 $ext{source} = 1427 $ext{source} =
1414 "package $pkg; use 5.10.0; use strict 'vars', 'subs'; use utf8;\n" 1428 "package $pkg; use common::sense;\n"
1415 . "#line 1 \"$path\"\n{\n" 1429 . "#line 1 \"$path\"\n{\n"
1416 . $source 1430 . $source
1417 . "\n};\n1"; 1431 . "\n};\n1";
1418 1432
1419 $todo{$base} = \%ext; 1433 $todo{$base} = \%ext;
1431 for (split /,\s*/, $v->{meta}{depends}) { 1445 for (split /,\s*/, $v->{meta}{depends}) {
1432 next ext 1446 next ext
1433 unless exists $done{$_}; 1447 unless exists $done{$_};
1434 } 1448 }
1435 1449
1436 warn "... pass $pass, loading '$k' into '$v->{pkg}'\n"; 1450 trace "... pass $pass, loading '$k' into '$v->{pkg}'\n";
1437 1451
1438 my $active = eval $v->{source}; 1452 my $active = eval $v->{source};
1439 1453
1440 if (length $@) { 1454 if (length $@) {
1441 warn "$v->{path}: $@\n"; 1455 error "$v->{path}: $@\n";
1456 undef $@; # work around perl 5.10.0 utf-8 caching bug
1442 1457
1443 cf::cleanup "mandatory extension '$k' failed to load, exiting." 1458 cf::cleanup "mandatory extension '$k' failed to load, exiting."
1444 if exists $v->{meta}{mandatory}; 1459 if exists $v->{meta}{mandatory};
1445 1460
1446 warn "$v->{base}: optional extension cannot be loaded, skipping.\n"; 1461 warn "$v->{base}: optional extension cannot be loaded, skipping.\n";
1448 } else { 1463 } else {
1449 $done{$k} = delete $todo{$k}; 1464 $done{$k} = delete $todo{$k};
1450 push @EXTS, $v->{pkg}; 1465 push @EXTS, $v->{pkg};
1451 $progress = 1; 1466 $progress = 1;
1452 1467
1453 warn "$v->{base}: extension inactive.\n" 1468 info "$v->{base}: extension inactive.\n"
1454 unless $active; 1469 unless $active;
1455 } 1470 }
1456 } 1471 }
1457 1472
1458 unless ($progress) { 1473 unless ($progress) {
1630 $pl->password ("*"); # this should lock out the player until we have nuked the dir 1645 $pl->password ("*"); # this should lock out the player until we have nuked the dir
1631 1646
1632 $pl->invoke (cf::EVENT_PLAYER_LOGOUT, 1) if $pl->active; 1647 $pl->invoke (cf::EVENT_PLAYER_LOGOUT, 1) if $pl->active;
1633 $pl->deactivate; 1648 $pl->deactivate;
1634 my $killer = cf::arch::get "killer_quit"; $pl->killer ($killer); $killer->destroy; 1649 my $killer = cf::arch::get "killer_quit"; $pl->killer ($killer); $killer->destroy;
1635 $pl->ob->check_score;
1636 $pl->invoke (cf::EVENT_PLAYER_QUIT); 1650 $pl->invoke (cf::EVENT_PLAYER_QUIT);
1637 $pl->ns->destroy if $pl->ns; 1651 $pl->ns->destroy if $pl->ns;
1638 1652
1639 my $path = playerdir $pl; 1653 my $path = playerdir $pl;
1640 my $temp = "$path~$cf::RUNTIME~deleting~"; 1654 my $temp = "$path~$cf::RUNTIME~deleting~";
1835 1849
1836sub register { 1850sub register {
1837 my (undef, $regex, $prio) = @_; 1851 my (undef, $regex, $prio) = @_;
1838 my $pkg = caller; 1852 my $pkg = caller;
1839 1853
1840 no strict;
1841 push @{"$pkg\::ISA"}, __PACKAGE__; 1854 push @{"$pkg\::ISA"}, __PACKAGE__;
1842 1855
1843 $EXT_MAP{$pkg} = [$prio, qr<$regex>]; 1856 $EXT_MAP{$pkg} = [$prio, qr<$regex>];
1844} 1857}
1845 1858
1846# also paths starting with '/' 1859# also paths starting with '/'
1847$EXT_MAP{"cf::map"} = [0, qr{^(?=/)}]; 1860$EXT_MAP{"cf::map::wrap"} = [0, qr{^(?=/)}];
1848 1861
1849sub thawer_merge { 1862sub thawer_merge {
1850 my ($self, $merge) = @_; 1863 my ($self, $merge) = @_;
1851 1864
1852 # we have to keep some variables in memory intact 1865 # we have to keep some variables in memory intact
2162 or next; 2175 or next;
2163 $neigh = find $neigh, $map 2176 $neigh = find $neigh, $map
2164 or next; 2177 or next;
2165 $neigh->load; 2178 $neigh->load;
2166 2179
2180 # now find the diagonal neighbours
2167 push @neigh, 2181 push @neigh,
2168 [$neigh->tile_path (($_ + 3) % 4), $neigh], 2182 [$neigh->tile_path (($_ + 3) % 4), $neigh],
2169 [$neigh->tile_path (($_ + 1) % 4), $neigh]; 2183 [$neigh->tile_path (($_ + 1) % 4), $neigh];
2170 } 2184 }
2171 2185
2178} 2192}
2179 2193
2180sub find_sync { 2194sub find_sync {
2181 my ($path, $origin) = @_; 2195 my ($path, $origin) = @_;
2182 2196
2183 cf::sync_job { find $path, $origin } 2197 return cf::LOG cf::llevError | cf::logBacktrace, "do_find_sync"
2198 if $Coro::current == $Coro::main;
2199
2200 find $path, $origin
2184} 2201}
2185 2202
2186sub do_load_sync { 2203sub do_load_sync {
2187 my ($map) = @_; 2204 my ($map) = @_;
2188 2205
2189 cf::LOG cf::llevDebug | cf::logBacktrace, "do_load_sync" 2206 return cf::LOG cf::llevError | cf::logBacktrace, "do_load_sync"
2190 if $Coro::current == $Coro::main; 2207 if $Coro::current == $Coro::main;
2191 2208
2192 cf::sync_job { $map->load }; 2209 $map->load;
2193} 2210}
2194 2211
2195our %MAP_PREFETCH; 2212our %MAP_PREFETCH;
2196our $MAP_PREFETCHER = undef; 2213our $MAP_PREFETCHER = undef;
2197 2214
2309 2326
2310 my $lock = cf::lock_acquire "map_data:$self->{path}"; 2327 my $lock = cf::lock_acquire "map_data:$self->{path}";
2311 2328
2312 return if $self->players; 2329 return if $self->players;
2313 2330
2314 warn "resetting map ", $self->path, "\n"; 2331 cf::trace "resetting map ", $self->path, "\n";
2315 2332
2316 $self->in_memory (cf::MAP_SWAPPED); 2333 $self->in_memory (cf::MAP_SWAPPED);
2317 2334
2318 # need to save uniques path 2335 # need to save uniques path
2319 unless ($self->{deny_save}) { 2336 unless ($self->{deny_save}) {
2343 2360
2344 delete $cf::MAP{$self->path}; 2361 delete $cf::MAP{$self->path};
2345 2362
2346 $self->unlink_save; 2363 $self->unlink_save;
2347 2364
2348 bless $self, "cf::map"; 2365 bless $self, "cf::map::wrap";
2349 delete $self->{deny_reset}; 2366 delete $self->{deny_reset};
2350 $self->{deny_save} = 1; 2367 $self->{deny_save} = 1;
2351 $self->reset_timeout (1); 2368 $self->reset_timeout (1);
2352 $self->path ($self->{path} = "{nuke}/" . ($nuke_counter++)); 2369 $self->path ($self->{path} = "{nuke}/" . ($nuke_counter++));
2353 2370
2583 2600
2584Freezes the player and moves him/her to a special map (C<{link}>). 2601Freezes the player and moves him/her to a special map (C<{link}>).
2585 2602
2586The player should be reasonably safe there for short amounts of time (e.g. 2603The player should be reasonably safe there for short amounts of time (e.g.
2587for loading a map). You I<MUST> call C<leave_link> as soon as possible, 2604for loading a map). You I<MUST> call C<leave_link> as soon as possible,
2588though, as the palyer cannot control the character while it is on the link 2605though, as the player cannot control the character while it is on the link
2589map. 2606map.
2590 2607
2591Will never block. 2608Will never block.
2592 2609
2593=item $player_object->leave_link ($map, $x, $y) 2610=item $player_object->leave_link ($map, $x, $y)
2614sub cf::object::player::enter_link { 2631sub cf::object::player::enter_link {
2615 my ($self) = @_; 2632 my ($self) = @_;
2616 2633
2617 $self->deactivate_recursive; 2634 $self->deactivate_recursive;
2618 2635
2636 ++$self->{_link_recursion};
2637
2619 return if UNIVERSAL::isa $self->map, "ext::map_link"; 2638 return if UNIVERSAL::isa $self->map, "ext::map_link";
2620 2639
2621 $self->{_link_pos} ||= [$self->map->{path}, $self->x, $self->y] 2640 $self->{_link_pos} ||= [$self->map->{path}, $self->x, $self->y]
2622 if $self->map && $self->map->{path} ne "{link}"; 2641 if $self->map && $self->map->{path} ne "{link}";
2623 2642
2654 $map->load_neighbours; 2673 $map->load_neighbours;
2655 2674
2656 return unless $self->contr->active; 2675 return unless $self->contr->active;
2657 2676
2658 local $self->{_prev_pos} = $link_pos; # ugly hack for rent.ext 2677 local $self->{_prev_pos} = $link_pos; # ugly hack for rent.ext
2659 $self->enter_map ($map, $x, $y); 2678 if ($self->enter_map ($map, $x, $y)) {
2660 2679 # entering was successful
2680 delete $self->{_link_recursion};
2661 # only activate afterwards, to support waiting in hooks 2681 # only activate afterwards, to support waiting in hooks
2662 $self->activate_recursive; 2682 $self->activate_recursive;
2663} 2683 }
2664 2684
2685}
2686
2665=item $player_object->goto ($path, $x, $y[, $check->($map)[, $done->()]]) 2687=item $player_object->goto ($path, $x, $y[, $check->($map, $x, $y, $player)[, $done->($player)]])
2666 2688
2667Moves the player to the given map-path and coordinates by first freezing 2689Moves the player to the given map-path and coordinates by first freezing
2668her, loading and preparing them map, calling the provided $check callback 2690her, loading and preparing them map, calling the provided $check callback
2669that has to return the map if sucecssful, and then unfreezes the player on 2691that has to return the map if sucecssful, and then unfreezes the player on
2670the new (success) or old (failed) map position. In either case, $done will 2692the new (success) or old (failed) map position. In either case, $done will
2677 2699
2678our $GOTOGEN; 2700our $GOTOGEN;
2679 2701
2680sub cf::object::player::goto { 2702sub cf::object::player::goto {
2681 my ($self, $path, $x, $y, $check, $done) = @_; 2703 my ($self, $path, $x, $y, $check, $done) = @_;
2704
2705 if ($self->{_link_recursion} >= $MAX_LINKS) {
2706 error "FATAL: link recursion exceeded, ", $self->name, " goto $path $x $y, redirecting.";
2707 $self->failmsg ("Something went wrong inside the server - please contact an administrator!");
2708 ($path, $x, $y) = @$EMERGENCY_POSITION;
2709 }
2682 2710
2683 # do generation counting so two concurrent goto's will be executed in-order 2711 # do generation counting so two concurrent goto's will be executed in-order
2684 my $gen = $self->{_goto_generation} = ++$GOTOGEN; 2712 my $gen = $self->{_goto_generation} = ++$GOTOGEN;
2685 2713
2686 $self->enter_link; 2714 $self->enter_link;
2710 my $map = eval { 2738 my $map = eval {
2711 my $map = defined $path ? cf::map::find $path : undef; 2739 my $map = defined $path ? cf::map::find $path : undef;
2712 2740
2713 if ($map) { 2741 if ($map) {
2714 $map = $map->customise_for ($self); 2742 $map = $map->customise_for ($self);
2715 $map = $check->($map) if $check && $map; 2743 $map = $check->($map, $x, $y, $self) if $check && $map;
2716 } else { 2744 } else {
2717 $self->message ("The exit to '$path' is closed.", cf::NDI_UNIQUE | cf::NDI_RED); 2745 $self->message ("The exit to '$path' is closed.", cf::NDI_UNIQUE | cf::NDI_RED);
2718 } 2746 }
2719 2747
2720 $map 2748 $map
2728 if ($gen == $self->{_goto_generation}) { 2756 if ($gen == $self->{_goto_generation}) {
2729 delete $self->{_goto_generation}; 2757 delete $self->{_goto_generation};
2730 $self->leave_link ($map, $x, $y); 2758 $self->leave_link ($map, $x, $y);
2731 } 2759 }
2732 2760
2733 $done->() if $done; 2761 $done->($self) if $done;
2734 })->prio (1); 2762 })->prio (1);
2735} 2763}
2736 2764
2737=item $player_object->enter_exit ($exit_object) 2765=item $player_object->enter_exit ($exit_object)
2738 2766
2831 $self->message ("Something went wrong deep within the deliantra server. " 2859 $self->message ("Something went wrong deep within the deliantra server. "
2832 . "I'll try to bring you back to the map you were before. " 2860 . "I'll try to bring you back to the map you were before. "
2833 . "Please report this to the dungeon master!", 2861 . "Please report this to the dungeon master!",
2834 cf::NDI_UNIQUE | cf::NDI_RED); 2862 cf::NDI_UNIQUE | cf::NDI_RED);
2835 2863
2836 warn "ERROR in enter_exit: $@"; 2864 error "ERROR in enter_exit: $@";
2837 $self->leave_link; 2865 $self->leave_link;
2838 } 2866 }
2839 })->prio (1); 2867 })->prio (1);
2840} 2868}
2841 2869
3154 3182
3155 $ns->ext_reply ($reply, @reply) 3183 $ns->ext_reply ($reply, @reply)
3156 if $reply; 3184 if $reply;
3157 3185
3158 } else { 3186 } else {
3159 warn "client " . ($ns->pl ? $ns->pl->ob->name : $ns->host) . " sent unparseable exti message: <$buf>\n"; 3187 error "client " . ($ns->pl ? $ns->pl->ob->name : $ns->host) . " sent unparseable exti message: <$buf>\n";
3160 } 3188 }
3161 3189
3162 cf::override; 3190 cf::override;
3163 }, 3191 },
3164); 3192);
3245 decrease split destroy change_exp value msg lore send_msg)], 3273 decrease split destroy change_exp value msg lore send_msg)],
3246 ["cf::object::player" => qw(player)], 3274 ["cf::object::player" => qw(player)],
3247 ["cf::player" => qw(peaceful send_msg)], 3275 ["cf::player" => qw(peaceful send_msg)],
3248 ["cf::map" => qw(trigger)], 3276 ["cf::map" => qw(trigger)],
3249) { 3277) {
3250 no strict 'refs';
3251 my ($pkg, @funs) = @$_; 3278 my ($pkg, @funs) = @$_;
3252 *{"safe::$pkg\::$_"} = $safe_hole->wrap (\&{"$pkg\::$_"}) 3279 *{"safe::$pkg\::$_"} = $safe_hole->wrap (\&{"$pkg\::$_"})
3253 for @funs; 3280 for @funs;
3254} 3281}
3255 3282
3294 local @cf::_safe_eval_args = values %vars; 3321 local @cf::_safe_eval_args = values %vars;
3295 @res = wantarray ? eval eval : scalar eval $eval; 3322 @res = wantarray ? eval eval : scalar eval $eval;
3296 } 3323 }
3297 3324
3298 if ($@) { 3325 if ($@) {
3299 warn "$@"; 3326 warn "$@",
3300 warn "while executing safe code '$code'\n"; 3327 "while executing safe code '$code'\n",
3301 warn "with arguments " . (join " ", %vars) . "\n"; 3328 "with arguments " . (join " ", %vars) . "\n";
3302 } 3329 }
3303 3330
3304 wantarray ? @res : $res[0] 3331 wantarray ? @res : $res[0]
3305} 3332}
3306 3333
3331=cut 3358=cut
3332 3359
3333############################################################################# 3360#############################################################################
3334# the server's init and main functions 3361# the server's init and main functions
3335 3362
3363# async inc loader. yay.
3364sub inc_loader {
3365 my $mod = $_[1];
3366
3367 if (in_main && !tick_inhibit) {
3368 Carp::cluck "ERROR: attempted synchronous perl module load ($mod)";
3369 } else {
3370 debug "loading perl module $mod\n";
3371 }
3372
3373 # 1. find real file
3374 for my $dir (@ORIG_INC) {
3375 ref $dir and next;
3376 0 <= Coro::AIO::aio_load "$dir/$mod", my $data
3377 or next;
3378
3379 $data = "#line 1 $dir/$mod\n$data";
3380
3381 open my $fh, "<", \$data or die;
3382
3383 return $fh;
3384 }
3385
3386 ()
3387}
3388
3389sub init_inc {
3390 # save original @INC
3391 @ORIG_INC = ($LIBDIR, @INC) unless @ORIG_INC;
3392
3393 # make sure we can do scalar-opens
3394 open my $dummy, "<", \my $dummy2;
3395
3396 # execute some stuff so perl load's some of the core modules
3397 /Ü/ =~ /ü/i;
3398 eval { &Storable::nstore_fd };
3399
3400 @INC = (\&inc_loader, @ORIG_INC); # @ORIG_INC is needed for DynaLoader, AutoLoad etc.
3401
3402 debug "module loading will be asynchronous from this point on.";
3403}
3404
3336sub load_facedata($) { 3405sub load_facedata($) {
3337 my ($path) = @_; 3406 my ($path) = @_;
3338 3407
3339 # HACK to clear player env face cache, we need some signal framework 3408 # HACK to clear player env face cache, we need some signal framework
3340 # for this (global event?) 3409 # for this (global event?)
3341 %ext::player_env::MUSIC_FACE_CACHE = (); 3410 %ext::player_env::MUSIC_FACE_CACHE = ();
3342 3411
3343 my $enc = JSON::XS->new->utf8->canonical->relaxed; 3412 my $enc = JSON::XS->new->utf8->canonical->relaxed;
3344 3413
3345 warn "loading facedata from $path\n"; 3414 trace "loading facedata from $path\n";
3346 3415
3347 my $facedata; 3416 my $facedata;
3348 0 < aio_load $path, $facedata 3417 0 < aio_load $path, $facedata
3349 or die "$path: $!"; 3418 or die "$path: $!";
3350 3419
3384 3453
3385 if (my $smooth = cf::face::find $info->{smooth}) { 3454 if (my $smooth = cf::face::find $info->{smooth}) {
3386 cf::face::set_smooth $idx, $smooth; 3455 cf::face::set_smooth $idx, $smooth;
3387 cf::face::set_smoothlevel $idx, $info->{smoothlevel}; 3456 cf::face::set_smoothlevel $idx, $info->{smoothlevel};
3388 } else { 3457 } else {
3389 warn "smooth face '$info->{smooth}' not found for face '$face'"; 3458 error "smooth face '$info->{smooth}' not found for face '$face'";
3390 } 3459 }
3391 3460
3392 cf::cede_to_tick; 3461 cf::cede_to_tick;
3393 } 3462 }
3394 } 3463 }
3412 my $idx = (cf::face::find $name) || cf::face::alloc $name; 3481 my $idx = (cf::face::find $name) || cf::face::alloc $name;
3413 3482
3414 cf::face::set_data $idx, 0, $info->{data}, $info->{hash}; 3483 cf::face::set_data $idx, 0, $info->{data}, $info->{hash};
3415 cf::face::set_type $idx, $info->{type}; 3484 cf::face::set_type $idx, $info->{type};
3416 } else { 3485 } else {
3417 $RESOURCE{$name} = $info; 3486 $RESOURCE{$name} = $info; # unused
3418 } 3487 }
3419 3488
3420 cf::cede_to_tick; 3489 cf::cede_to_tick;
3421 } 3490 }
3422 } 3491 }
3423 3492
3424 cf::global->invoke (EVENT_GLOBAL_RESOURCE_UPDATE); 3493 cf::global->invoke (EVENT_GLOBAL_RESOURCE_UPDATE);
3425 3494
3426 1 3495 1
3427} 3496}
3428
3429cf::global->attach (on_resource_update => sub {
3430 if (my $soundconf = $RESOURCE{"res/sound.conf"}) {
3431 $soundconf = JSON::XS->new->utf8->relaxed->decode ($soundconf->{data});
3432
3433 for (0 .. SOUND_CAST_SPELL_0 - 1) {
3434 my $sound = $soundconf->{compat}[$_]
3435 or next;
3436
3437 my $face = cf::face::find "sound/$sound->[1]";
3438 cf::sound::set $sound->[0] => $face;
3439 cf::sound::old_sound_index $_, $face; # gcfclient-compat
3440 }
3441
3442 while (my ($k, $v) = each %{$soundconf->{event}}) {
3443 my $face = cf::face::find "sound/$v";
3444 cf::sound::set $k => $face;
3445 }
3446 }
3447});
3448 3497
3449register_exticmd fx_want => sub { 3498register_exticmd fx_want => sub {
3450 my ($ns, $want) = @_; 3499 my ($ns, $want) = @_;
3451 3500
3452 while (my ($k, $v) = each %$want) { 3501 while (my ($k, $v) = each %$want) {
3491sub reload_treasures { 3540sub reload_treasures {
3492 load_resource_file "$DATADIR/treasures" 3541 load_resource_file "$DATADIR/treasures"
3493 or die "unable to load treasurelists\n"; 3542 or die "unable to load treasurelists\n";
3494} 3543}
3495 3544
3545sub reload_sound {
3546 trace "loading sound config from $DATADIR/sound\n";
3547
3548 0 < Coro::AIO::aio_load "$DATADIR/sound", my $data
3549 or die "$DATADIR/sound $!";
3550
3551 my $soundconf = JSON::XS->new->utf8->relaxed->decode ($data);
3552
3553 for (0 .. SOUND_CAST_SPELL_0 - 1) {
3554 my $sound = $soundconf->{compat}[$_]
3555 or next;
3556
3557 my $face = cf::face::find "sound/$sound->[1]";
3558 cf::sound::set $sound->[0] => $face;
3559 cf::sound::old_sound_index $_, $face; # gcfclient-compat
3560 }
3561
3562 while (my ($k, $v) = each %{$soundconf->{event}}) {
3563 my $face = cf::face::find "sound/$v";
3564 cf::sound::set $k => $face;
3565 }
3566}
3567
3496sub reload_resources { 3568sub reload_resources {
3497 warn "reloading resource files...\n"; 3569 trace "reloading resource files...\n";
3498 3570
3499 reload_facedata; 3571 reload_facedata;
3572 reload_sound;
3500 reload_archetypes; 3573 reload_archetypes;
3501 reload_regions; 3574 reload_regions;
3502 reload_treasures; 3575 reload_treasures;
3503 3576
3504 warn "finished reloading resource files\n"; 3577 trace "finished reloading resource files\n";
3505} 3578}
3506 3579
3507sub reload_config { 3580sub reload_config {
3508 warn "reloading config file...\n"; 3581 trace "reloading config file...\n";
3509 3582
3510 open my $fh, "<:utf8", "$CONFDIR/config" 3583 open my $fh, "<:utf8", "$CONFDIR/config"
3511 or return; 3584 or return;
3512 3585
3513 local $/; 3586 local $/;
3514 *CFG = YAML::XS::Load scalar <$fh>; 3587 *CFG = YAML::XS::Load scalar <$fh>;
3515 3588
3516 $EMERGENCY_POSITION = $CFG{emergency_position} || ["/world/world_105_115", 5, 37]; 3589 $EMERGENCY_POSITION = $CFG{emergency_position} || ["/world/world_104_115", 49, 38];
3517 3590
3518 $cf::map::MAX_RESET = $CFG{map_max_reset} if exists $CFG{map_max_reset}; 3591 $cf::map::MAX_RESET = $CFG{map_max_reset} if exists $CFG{map_max_reset};
3519 $cf::map::DEFAULT_RESET = $CFG{map_default_reset} if exists $CFG{map_default_reset}; 3592 $cf::map::DEFAULT_RESET = $CFG{map_default_reset} if exists $CFG{map_default_reset};
3520 3593
3521 if (exists $CFG{mlockall}) { 3594 if (exists $CFG{mlockall}) {
3524 and die "WARNING: m(un)lockall failed: $!\n"; 3597 and die "WARNING: m(un)lockall failed: $!\n";
3525 }; 3598 };
3526 warn $@ if $@; 3599 warn $@ if $@;
3527 } 3600 }
3528 3601
3529 warn "finished reloading resource files\n"; 3602 trace "finished reloading resource files\n";
3530} 3603}
3531 3604
3532sub pidfile() { 3605sub pidfile() {
3533 sysopen my $fh, $PIDFILE, O_RDWR | O_CREAT 3606 sysopen my $fh, $PIDFILE, O_RDWR | O_CREAT
3534 or die "$PIDFILE: $!"; 3607 or die "$PIDFILE: $!";
3547 seek $fh, 0, 0; 3620 seek $fh, 0, 0;
3548 print $fh $$; 3621 print $fh $$;
3549} 3622}
3550 3623
3551sub main_loop { 3624sub main_loop {
3552 warn "EV::loop starting\n"; 3625 trace "EV::loop starting\n";
3553 if (1) { 3626 if (1) {
3554 EV::loop; 3627 EV::loop;
3555 } 3628 }
3556 warn "EV::loop returned\n"; 3629 trace "EV::loop returned\n";
3557 goto &main_loop unless $REALLY_UNLOOP; 3630 goto &main_loop unless $REALLY_UNLOOP;
3558} 3631}
3559 3632
3560sub main { 3633sub main {
3561 cf::init_globals; # initialise logging 3634 cf::init_globals; # initialise logging
3562 3635
3563 LOG llevInfo, "Welcome to Deliantra, v" . VERSION; 3636 LOG llevInfo, "Welcome to Deliantra, v" . VERSION;
3564 LOG llevInfo, "Copyright (C) 2005-2008 Marc Alexander Lehmann / Robin Redeker / the Deliantra team."; 3637 LOG llevInfo, "Copyright (C) 2005-2010 Marc Alexander Lehmann / Robin Redeker / the Deliantra team.";
3565 LOG llevInfo, "Copyright (C) 1994 Mark Wedel."; 3638 LOG llevInfo, "Copyright (C) 1994 Mark Wedel.";
3566 LOG llevInfo, "Copyright (C) 1992 Frank Tore Johansen."; 3639 LOG llevInfo, "Copyright (C) 1992 Frank Tore Johansen.";
3567 3640
3568 $Coro::current->prio (Coro::PRIO_MAX); # give the main loop max. priority 3641 $Coro::current->prio (Coro::PRIO_MAX); # give the main loop max. priority
3569 3642
3577 }; 3650 };
3578 3651
3579 evthread_start IO::AIO::poll_fileno; 3652 evthread_start IO::AIO::poll_fileno;
3580 3653
3581 cf::sync_job { 3654 cf::sync_job {
3655 init_inc;
3656
3582 cf::init_experience; 3657 cf::init_experience;
3583 cf::init_anim; 3658 cf::init_anim;
3584 cf::init_attackmess; 3659 cf::init_attackmess;
3585 cf::init_dynamic; 3660 cf::init_dynamic;
3586 3661
3609 3684
3610 (pop @POST_INIT)->(0) while @POST_INIT; 3685 (pop @POST_INIT)->(0) while @POST_INIT;
3611 }; 3686 };
3612 3687
3613 cf::object::thawer::errors_are_fatal 0; 3688 cf::object::thawer::errors_are_fatal 0;
3614 warn "parse errors in files are no longer fatal from this point on.\n"; 3689 info "parse errors in files are no longer fatal from this point on.\n";
3615 3690
3691 my $free_main; $free_main = EV::idle sub {
3692 undef $free_main;
3693 undef &main; # free gobs of memory :)
3694 };
3695
3616 main_loop; 3696 goto &main_loop;
3617} 3697}
3618 3698
3619############################################################################# 3699#############################################################################
3620# initialisation and cleanup 3700# initialisation and cleanup
3621 3701
3660 or return; 3740 or return;
3661 3741
3662 aio_rename "$RUNTIMEFILE~", $RUNTIMEFILE 3742 aio_rename "$RUNTIMEFILE~", $RUNTIMEFILE
3663 and return; 3743 and return;
3664 3744
3665 warn sprintf "runtime file written (%gs).\n", AE::time - $t0; 3745 trace sprintf "runtime file written (%gs).\n", AE::time - $t0;
3666 3746
3667 1 3747 1
3668} 3748}
3669 3749
3670our $uuid_lock; 3750our $uuid_lock;
3682 or return; 3762 or return;
3683 3763
3684 my $value = uuid_seq uuid_cur; 3764 my $value = uuid_seq uuid_cur;
3685 3765
3686 unless ($value) { 3766 unless ($value) {
3687 warn "cowardly refusing to write zero uuid value!\n"; 3767 info "cowardly refusing to write zero uuid value!\n";
3688 return; 3768 return;
3689 } 3769 }
3690 3770
3691 my $value = uuid_str $value + $uuid_skip; 3771 my $value = uuid_str $value + $uuid_skip;
3692 $uuid_skip = 0; 3772 $uuid_skip = 0;
3702 or return; 3782 or return;
3703 3783
3704 aio_rename "$uuid~", $uuid 3784 aio_rename "$uuid~", $uuid
3705 and return; 3785 and return;
3706 3786
3707 warn "uuid file written ($value).\n"; 3787 trace "uuid file written ($value).\n";
3708 3788
3709 1 3789 1
3710 3790
3711} 3791}
3712 3792
3718} 3798}
3719 3799
3720sub emergency_save() { 3800sub emergency_save() {
3721 my $freeze_guard = cf::freeze_mainloop; 3801 my $freeze_guard = cf::freeze_mainloop;
3722 3802
3723 warn "emergency_perl_save: enter\n"; 3803 info "emergency_perl_save: enter\n";
3804
3805 # this is a trade-off: we want to be very quick here, so
3806 # save all maps without fsync, and later call a global sync
3807 # (which in turn might be very very slow)
3808 local $USE_FSYNC = 0;
3724 3809
3725 cf::sync_job { 3810 cf::sync_job {
3726 # this is a trade-off: we want to be very quick here, so 3811 cf::write_runtime_sync; # external watchdog should not bark
3727 # save all maps without fsync, and later call a global sync
3728 # (which in turn might be very very slow)
3729 local $USE_FSYNC = 0;
3730 3812
3731 # use a peculiar iteration method to avoid tripping on perl 3813 # use a peculiar iteration method to avoid tripping on perl
3732 # refcount bugs in for. also avoids problems with players 3814 # refcount bugs in for. also avoids problems with players
3733 # and maps saved/destroyed asynchronously. 3815 # and maps saved/destroyed asynchronously.
3734 warn "emergency_perl_save: begin player save\n"; 3816 info "emergency_perl_save: begin player save\n";
3735 for my $login (keys %cf::PLAYER) { 3817 for my $login (keys %cf::PLAYER) {
3736 my $pl = $cf::PLAYER{$login} or next; 3818 my $pl = $cf::PLAYER{$login} or next;
3737 $pl->valid or next; 3819 $pl->valid or next;
3738 delete $pl->{unclean_save}; # not strictly necessary, but cannot hurt 3820 delete $pl->{unclean_save}; # not strictly necessary, but cannot hurt
3739 $pl->save; 3821 $pl->save;
3740 } 3822 }
3741 warn "emergency_perl_save: end player save\n"; 3823 info "emergency_perl_save: end player save\n";
3742 3824
3825 cf::write_runtime_sync; # external watchdog should not bark
3826
3743 warn "emergency_perl_save: begin map save\n"; 3827 info "emergency_perl_save: begin map save\n";
3744 for my $path (keys %cf::MAP) { 3828 for my $path (keys %cf::MAP) {
3745 my $map = $cf::MAP{$path} or next; 3829 my $map = $cf::MAP{$path} or next;
3746 $map->valid or next; 3830 $map->valid or next;
3747 $map->save; 3831 $map->save;
3748 } 3832 }
3749 warn "emergency_perl_save: end map save\n"; 3833 info "emergency_perl_save: end map save\n";
3750 3834
3835 cf::write_runtime_sync; # external watchdog should not bark
3836
3751 warn "emergency_perl_save: begin database checkpoint\n"; 3837 info "emergency_perl_save: begin database checkpoint\n";
3752 BDB::db_env_txn_checkpoint $DB_ENV; 3838 BDB::db_env_txn_checkpoint $DB_ENV;
3753 warn "emergency_perl_save: end database checkpoint\n"; 3839 info "emergency_perl_save: end database checkpoint\n";
3754 3840
3755 warn "emergency_perl_save: begin write uuid\n"; 3841 info "emergency_perl_save: begin write uuid\n";
3756 write_uuid_sync 1; 3842 write_uuid_sync 1;
3757 warn "emergency_perl_save: end write uuid\n"; 3843 info "emergency_perl_save: end write uuid\n";
3844
3845 cf::write_runtime_sync; # external watchdog should not bark
3846
3847 trace "emergency_perl_save: syncing database to disk";
3848 BDB::db_env_txn_checkpoint $DB_ENV;
3849
3850 info "emergency_perl_save: starting sync\n";
3851 IO::AIO::aio_sync sub {
3852 info "emergency_perl_save: finished sync\n";
3853 };
3854
3855 cf::write_runtime_sync; # external watchdog should not bark
3856
3857 trace "emergency_perl_save: flushing outstanding aio requests";
3858 while (IO::AIO::nreqs || BDB::nreqs) {
3859 Coro::EV::timer_once 0.01; # let the sync_job do it's thing
3860 }
3861
3862 cf::write_runtime_sync; # external watchdog should not bark
3758 }; 3863 };
3759 3864
3760 warn "emergency_perl_save: starting sync()\n";
3761 IO::AIO::aio_sync sub {
3762 warn "emergency_perl_save: finished sync()\n";
3763 };
3764
3765 warn "emergency_perl_save: leave\n"; 3865 info "emergency_perl_save: leave\n";
3766} 3866}
3767 3867
3768sub post_cleanup { 3868sub post_cleanup {
3769 my ($make_core) = @_; 3869 my ($make_core) = @_;
3770 3870
3871 IO::AIO::flush;
3872
3771 warn Carp::longmess "post_cleanup backtrace" 3873 error Carp::longmess "post_cleanup backtrace"
3772 if $make_core; 3874 if $make_core;
3773 3875
3774 my $fh = pidfile; 3876 my $fh = pidfile;
3775 unlink $PIDFILE if <$fh> == $$; 3877 unlink $PIDFILE if <$fh> == $$;
3776} 3878}
3801} 3903}
3802 3904
3803sub do_reload_perl() { 3905sub do_reload_perl() {
3804 # can/must only be called in main 3906 # can/must only be called in main
3805 if (in_main) { 3907 if (in_main) {
3806 warn "can only reload from main coroutine"; 3908 error "can only reload from main coroutine";
3807 return; 3909 return;
3808 } 3910 }
3809 3911
3810 return if $RELOAD++; 3912 return if $RELOAD++;
3811 3913
3812 my $t1 = AE::time; 3914 my $t1 = AE::time;
3813 3915
3814 while ($RELOAD) { 3916 while ($RELOAD) {
3815 warn "reloading..."; 3917 info "reloading...";
3816 3918
3817 warn "entering sync_job"; 3919 trace "entering sync_job";
3818 3920
3819 cf::sync_job { 3921 cf::sync_job {
3820 cf::write_runtime_sync; # external watchdog should not bark
3821 cf::emergency_save; 3922 cf::emergency_save;
3822 cf::write_runtime_sync; # external watchdog should not bark
3823 3923
3824 warn "syncing database to disk";
3825 BDB::db_env_txn_checkpoint $DB_ENV;
3826
3827 # if anything goes wrong in here, we should simply crash as we already saved
3828
3829 warn "flushing outstanding aio requests";
3830 while (IO::AIO::nreqs || BDB::nreqs) {
3831 Coro::EV::timer_once 0.01; # let the sync_job do it's thing
3832 }
3833
3834 warn "cancelling all extension coros"; 3924 trace "cancelling all extension coros";
3835 $_->cancel for values %EXT_CORO; 3925 $_->cancel for values %EXT_CORO;
3836 %EXT_CORO = (); 3926 %EXT_CORO = ();
3837 3927
3838 warn "removing commands"; 3928 trace "removing commands";
3839 %COMMAND = (); 3929 %COMMAND = ();
3840 3930
3841 warn "removing ext/exti commands"; 3931 trace "removing ext/exti commands";
3842 %EXTCMD = (); 3932 %EXTCMD = ();
3843 %EXTICMD = (); 3933 %EXTICMD = ();
3844 3934
3845 warn "unloading/nuking all extensions"; 3935 trace "unloading/nuking all extensions";
3846 for my $pkg (@EXTS) { 3936 for my $pkg (@EXTS) {
3847 warn "... unloading $pkg"; 3937 trace "... unloading $pkg";
3848 3938
3849 if (my $cb = $pkg->can ("unload")) { 3939 if (my $cb = $pkg->can ("unload")) {
3850 eval { 3940 eval {
3851 $cb->($pkg); 3941 $cb->($pkg);
3852 1 3942 1
3853 } or warn "$pkg unloaded, but with errors: $@"; 3943 } or error "$pkg unloaded, but with errors: $@";
3854 } 3944 }
3855 3945
3856 warn "... clearing $pkg"; 3946 trace "... clearing $pkg";
3857 clear_package $pkg; 3947 clear_package $pkg;
3858 } 3948 }
3859 3949
3860 warn "unloading all perl modules loaded from $LIBDIR"; 3950 trace "unloading all perl modules loaded from $LIBDIR";
3861 while (my ($k, $v) = each %INC) { 3951 while (my ($k, $v) = each %INC) {
3862 next unless $v =~ /^\Q$LIBDIR\E\/.*\.pm$/; 3952 next unless $v =~ /^\Q$LIBDIR\E\/.*\.pm$/;
3863 3953
3864 warn "... unloading $k"; 3954 trace "... unloading $k";
3865 delete $INC{$k}; 3955 delete $INC{$k};
3866 3956
3867 $k =~ s/\.pm$//; 3957 $k =~ s/\.pm$//;
3868 $k =~ s/\//::/g; 3958 $k =~ s/\//::/g;
3869 3959
3872 } 3962 }
3873 3963
3874 clear_package $k; 3964 clear_package $k;
3875 } 3965 }
3876 3966
3877 warn "getting rid of safe::, as good as possible"; 3967 trace "getting rid of safe::, as good as possible";
3878 clear_package "safe::$_" 3968 clear_package "safe::$_"
3879 for qw(cf::attachable cf::object cf::object::player cf::client cf::player cf::map cf::party cf::region); 3969 for qw(cf::attachable cf::object cf::object::player cf::client cf::player cf::map cf::party cf::region);
3880 3970
3881 warn "unloading cf.pm \"a bit\""; 3971 trace "unloading cf.pm \"a bit\"";
3882 delete $INC{"cf.pm"}; 3972 delete $INC{"cf.pm"};
3883 delete $INC{"cf/$_.pm"} for @EXTRA_MODULES; 3973 delete $INC{"cf/$_.pm"} for @EXTRA_MODULES;
3884 3974
3885 # don't, removes xs symbols, too, 3975 # don't, removes xs symbols, too,
3886 # and global variables created in xs 3976 # and global variables created in xs
3887 #clear_package __PACKAGE__; 3977 #clear_package __PACKAGE__;
3888 3978
3889 warn "unload completed, starting to reload now"; 3979 info "unload completed, starting to reload now";
3890 3980
3891 warn "reloading cf.pm"; 3981 trace "reloading cf.pm";
3892 require cf; 3982 require cf;
3893 cf::_connect_to_perl_1; 3983 cf::_connect_to_perl_1;
3894 3984
3895 warn "loading config and database again"; 3985 trace "loading config and database again";
3896 cf::reload_config; 3986 cf::reload_config;
3897 3987
3898 warn "loading extensions"; 3988 trace "loading extensions";
3899 cf::load_extensions; 3989 cf::load_extensions;
3900 3990
3901 if ($REATTACH_ON_RELOAD) { 3991 if ($REATTACH_ON_RELOAD) {
3902 warn "reattaching attachments to objects/players"; 3992 trace "reattaching attachments to objects/players";
3903 _global_reattach; # objects, sockets 3993 _global_reattach; # objects, sockets
3904 warn "reattaching attachments to maps"; 3994 trace "reattaching attachments to maps";
3905 reattach $_ for values %MAP; 3995 reattach $_ for values %MAP;
3906 warn "reattaching attachments to players"; 3996 trace "reattaching attachments to players";
3907 reattach $_ for values %PLAYER; 3997 reattach $_ for values %PLAYER;
3908 } 3998 }
3909 3999
3910 warn "running post_init jobs"; 4000 trace "running post_init jobs";
3911 (pop @POST_INIT)->(1) while @POST_INIT; 4001 (pop @POST_INIT)->(1) while @POST_INIT;
3912 4002
3913 warn "leaving sync_job"; 4003 trace "leaving sync_job";
3914 4004
3915 1 4005 1
3916 } or do { 4006 } or do {
3917 warn $@; 4007 error $@;
3918 cf::cleanup "error while reloading, exiting."; 4008 cf::cleanup "error while reloading, exiting.";
3919 }; 4009 };
3920 4010
3921 warn "reloaded"; 4011 info "reloaded";
3922 --$RELOAD; 4012 --$RELOAD;
3923 } 4013 }
3924 4014
3925 $t1 = AE::time - $t1; 4015 $t1 = AE::time - $t1;
3926 warn "reload completed in ${t1}s\n"; 4016 info "reload completed in ${t1}s\n";
3927}; 4017};
3928 4018
3929our $RELOAD_WATCHER; # used only during reload 4019our $RELOAD_WATCHER; # used only during reload
3930 4020
3931sub reload_perl() { 4021sub reload_perl() {
3952 reload_perl; 4042 reload_perl;
3953 }; 4043 };
3954 } 4044 }
3955}; 4045};
3956 4046
3957unshift @INC, $LIBDIR; 4047#############################################################################
3958 4048
3959my $bug_warning = 0; 4049my $bug_warning = 0;
3960 4050
3961our @WAIT_FOR_TICK; 4051our @WAIT_FOR_TICK;
3962our @WAIT_FOR_TICK_BEGIN; 4052our @WAIT_FOR_TICK_BEGIN;
3991 if ($NOW >= $NEXT_RUNTIME_WRITE) { 4081 if ($NOW >= $NEXT_RUNTIME_WRITE) {
3992 $NEXT_RUNTIME_WRITE = List::Util::max $NEXT_RUNTIME_WRITE + 10, $NOW + 5.; 4082 $NEXT_RUNTIME_WRITE = List::Util::max $NEXT_RUNTIME_WRITE + 10, $NOW + 5.;
3993 Coro::async_pool { 4083 Coro::async_pool {
3994 $Coro::current->{desc} = "runtime saver"; 4084 $Coro::current->{desc} = "runtime saver";
3995 write_runtime_sync 4085 write_runtime_sync
3996 or warn "ERROR: unable to write runtime file: $!"; 4086 or error "ERROR: unable to write runtime file: $!";
3997 }; 4087 };
3998 } 4088 }
3999 4089
4000 if (my $sig = shift @WAIT_FOR_TICK_BEGIN) { 4090 if (my $sig = shift @WAIT_FOR_TICK_BEGIN) {
4001 $sig->send; 4091 $sig->send;
4009 4099
4010 if (0) { 4100 if (0) {
4011 if ($NEXT_TICK) { 4101 if ($NEXT_TICK) {
4012 my $jitter = $TICK_START - $NEXT_TICK; 4102 my $jitter = $TICK_START - $NEXT_TICK;
4013 $JITTER = $JITTER * 0.75 + $jitter * 0.25; 4103 $JITTER = $JITTER * 0.75 + $jitter * 0.25;
4014 warn "jitter $JITTER\n";#d# 4104 debug "jitter $JITTER\n";#d#
4015 } 4105 }
4016 } 4106 }
4017} 4107}
4018 4108
4019{ 4109{

Diff Legend

Removed lines
+ Added lines
< Changed lines
> Changed lines