src/service.cc

   1 #include <cstring>
   2 #include <cerrno>
   3 #include <sstream>
   4 #include <iterator>
   5 #include <memory>
   6 #include <cstddef>
   7
   8 #include <sys/types.h>
   9 #include <sys/stat.h>
  10 #include <sys/ioctl.h>
  11 #include <sys/un.h>
  12 #include <sys/socket.h>
  13 #include <fcntl.h>
  14 #include <unistd.h>
  15 #include <termios.h>
  16
  17 #include "service.h"
  18 #include "dinit-log.h"
  19 #include "dinit-socket.h"
  20 #include "dinit-util.h"
  21
  22 /*
  23  * service.cc - Service management.
  24  * See service.h for details.
  25  */
  26
  27 // from dinit.cc:
  28 void open_control_socket(bool report_ro_failure = true) noexcept;
  29 void setup_external_log() noexcept;
  30 extern eventloop_t eventLoop;
  31
  32 // Find the requested service by name
  33 static service_record * find_service(const std::list<service_record *> & records,
  34                                     const char *name) noexcept
  35 {
  36     using std::list;
  37     list<service_record *>::const_iterator i = records.begin();
  38     for ( ; i != records.end(); i++ ) {
  39         if (strcmp((*i)->get_service_name().c_str(), name) == 0) {
  40             return *i;
  41         }
  42     }
  43     return nullptr;
  44 }
  45
  46 service_record * service_set::find_service(const std::string &name) noexcept
  47 {
  48     return ::find_service(records, name.c_str());
  49 }
  50
  51 void service_set::stop_service(const std::string & name) noexcept
  52 {
  53     service_record *record = find_service(name);
  54     if (record != nullptr) {
  55         record->stop();
  56         process_queues();
  57     }
  58 }
  59
  60 // Called when a service has actually stopped; dependents have stopped already, unless this stop
  61 // is due to an unexpected process termination.
  62 void service_record::stopped() noexcept
  63 {
  64     if (onstart_flags.runs_on_console) {
  65         tcsetpgrp(0, getpgrp());
  66         discard_console_log_buffer();
  67         release_console();
  68     }
  69
  70     force_stop = false;
  71
  72     // If we are a soft dependency of another target, break the acquisition from that target now:
  73     for (auto & dependent : dependents) {
  74         if (dependent->dep_type != dependency_type::REGULAR) {
  75             if (dependent->holding_acq) {
  76                 dependent->holding_acq = false;
  77                 release();
  78             }
  79         }
  80     }
  81
  82     bool will_restart = (desired_state == service_state_t::STARTED)
  83             && services->get_auto_restart();
  84
  85     for (auto dependency : depends_on) {
  86         // we signal dependencies in case they are waiting for us to stop:
  87         dependency.get_to()->dependent_stopped();
  88     }
  89
  90     service_state = service_state_t::STOPPED;
  91
  92     if (will_restart) {
  93         // Desired state is "started".
  94         restarting = true;
  95         start(false);
  96     }
  97     else {
  98         if (socket_fd != -1) {
  99             close(socket_fd);
 100             socket_fd = -1;
 101         }
 102
 103         if (start_explicit) {
 104             start_explicit = false;
 105             release();
 106         }
 107         else if (required_by == 0) {
 108             services->service_inactive(this);
 109         }
 110     }
 111
 112     log_service_stopped(service_name);
 113     notify_listeners(service_event::STOPPED);
 114 }
 115
 116 dasynq::rearm service_child_watcher::status_change(eventloop_t &loop, pid_t child, int status) noexcept
 117 {
 118     base_process_service *sr = service;
 119
 120     sr->pid = -1;
 121     sr->exit_status = status;
 122
 123     // Ok, for a process service, any process death which we didn't rig
 124     // ourselves is a bit... unexpected. Probably, the child died because
 125     // we asked it to (sr->service_state == STOPPING). But even if
 126     // we didn't, there's not much we can do.
 127
 128     if (sr->waiting_for_execstat) {
 129         // We still don't have an exec() status from the forked child, wait for that
 130         // before doing any further processing.
 131         return rearm::NOOP; // hold watch reservation
 132     }
 133
 134     // Must stop watch now since handle_exit_status might result in re-launch:
 135     // (stop_watch instead of deregister, so that we hold watch reservation).
 136     stop_watch(loop);
 137
 138     if (sr->stop_timer_armed) {
 139         sr->restart_timer.stop_timer(loop);
 140         sr->stop_timer_armed = false;
 141     }
 142
 143     sr->handle_exit_status(status);
 144     return rearm::NOOP;
 145 }
 146
 147 bool service_record::do_auto_restart() noexcept
 148 {
 149     if (auto_restart) {
 150         return services->get_auto_restart();
 151     }
 152     return false;
 153 }
 154
 155 void service_record::emergency_stop() noexcept
 156 {
 157     if (! do_auto_restart() && start_explicit) {
 158         start_explicit = false;
 159         release();
 160     }
 161     forced_stop();
 162     stop_dependents();
 163     stopped();
 164 }
 165
 166 void process_service::handle_exit_status(int exit_status) noexcept
 167 {
 168     bool did_exit = WIFEXITED(exit_status);
 169     bool was_signalled = WIFSIGNALED(exit_status);
 170     restarting = false;
 171
 172     if (exit_status != 0 && service_state != service_state_t::STOPPING) {
 173         if (did_exit) {
 174             log(loglevel_t::ERROR, "Service ", service_name, " process terminated with exit code ",
 175                     WEXITSTATUS(exit_status));
 176         }
 177         else if (was_signalled) {
 178             log(loglevel_t::ERROR, "Service ", service_name, " terminated due to signal ",
 179                     WTERMSIG(exit_status));
 180         }
 181     }
 182
 183     if (service_state == service_state_t::STARTING) {
 184         if (did_exit && WEXITSTATUS(exit_status) == 0) {
 185             started();
 186         }
 187         else {
 188             failed_to_start();
 189         }
 190     }
 191     else if (service_state == service_state_t::STOPPING) {
 192         // We won't log a non-zero exit status or termination due to signal here -
 193         // we assume that the process died because we signalled it.
 194         stopped();
 195     }
 196     else if (smooth_recovery && service_state == service_state_t::STARTED
 197             && desired_state == service_state_t::STARTED) {
 198         do_smooth_recovery();
 199         return;
 200     }
 201     else {
 202         emergency_stop();
 203     }
 204     services->process_queues();
 205 }
 206
 207 void base_process_service::do_smooth_recovery() noexcept
 208 {
 209     if (! restart_ps_process()) {
 210         emergency_stop();
 211         services->process_queues();
 212     }
 213 }
 214
 215 void bgproc_service::handle_exit_status(int exit_status) noexcept
 216 {
 217     begin:
 218     bool did_exit = WIFEXITED(exit_status);
 219     bool was_signalled = WIFSIGNALED(exit_status);
 220
 221     if (exit_status != 0 && service_state != service_state_t::STOPPING) {
 222         if (did_exit) {
 223             log(loglevel_t::ERROR, "Service ", service_name, " process terminated with exit code ",
 224                     WEXITSTATUS(exit_status));
 225         }
 226         else if (was_signalled) {
 227             log(loglevel_t::ERROR, "Service ", service_name, " terminated due to signal ",
 228                     WTERMSIG(exit_status));
 229         }
 230     }
 231
 232     // This may be a "smooth recovery" where we are restarting the process while leaving the
 233     // service in the STARTED state.
 234     if (restarting && service_state == service_state_t::STARTED) {
 235         restarting = false;
 236         bool need_stop = false;
 237         if ((did_exit && WEXITSTATUS(exit_status) != 0) || was_signalled) {
 238             need_stop = true;
 239         }
 240         else {
 241             // We need to re-read the PID, since it has now changed.
 242             if (pid_file.length() != 0) {
 243                 auto pid_result = read_pid_file(&exit_status);
 244                 switch (pid_result) {
 245                     case pid_result_t::FAILED:
 246                         // Failed startup: no auto-restart.
 247                         need_stop = true;
 248                         break;
 249                     case pid_result_t::TERMINATED:
 250                         goto begin;
 251                     case pid_result_t::OK:
 252                         break;
 253                 }
 254             }
 255         }
 256
 257         if (need_stop) {
 258             // Failed startup: no auto-restart.
 259             emergency_stop();
 260             services->process_queues();
 261         }
 262
 263         return;
 264     }
 265
 266     restarting = false;
 267     if (service_state == service_state_t::STARTING) {
 268         // POSIX requires that if the process exited clearly with a status code of 0,
 269         // the exit status value will be 0:
 270         if (exit_status == 0) {
 271             auto pid_result = read_pid_file(&exit_status);
 272             switch (pid_result) {
 273                 case pid_result_t::FAILED:
 274                     // Failed startup: no auto-restart.
 275                     failed_to_start();
 276                     break;
 277                 case pid_result_t::TERMINATED:
 278                     // started, but immediately terminated
 279                     started();
 280                     goto begin;
 281                 case pid_result_t::OK:
 282                     started();
 283                     break;
 284             }
 285         }
 286         else {
 287             failed_to_start();
 288         }
 289     }
 290     else if (service_state == service_state_t::STOPPING) {
 291         // We won't log a non-zero exit status or termination due to signal here -
 292         // we assume that the process died because we signalled it.
 293         stopped();
 294     }
 295     else if (smooth_recovery && service_state == service_state_t::STARTED && desired_state == service_state_t::STARTED) {
 296         do_smooth_recovery();
 297         return;
 298     }
 299     else {
 300         // we must be STARTED
 301         if (! do_auto_restart() && start_explicit) {
 302             start_explicit = false;
 303             release();
 304         }
 305         forced_stop();
 306         stop_dependents();
 307         stopped();
 308     }
 309     services->process_queues();
 310 }
 311
 312 void scripted_service::handle_exit_status(int exit_status) noexcept
 313 {
 314     bool did_exit = WIFEXITED(exit_status);
 315     bool was_signalled = WIFSIGNALED(exit_status);
 316
 317     if (service_state == service_state_t::STOPPING) {
 318         if (did_exit && WEXITSTATUS(exit_status) == 0) {
 319             stopped();
 320         }
 321         else {
 322             // ??? failed to stop! Let's log it as info:
 323             if (did_exit) {
 324                 log(loglevel_t::INFO, "Service ", service_name, " stop command failed with exit code ",
 325                         WEXITSTATUS(exit_status));
 326             }
 327             else if (was_signalled) {
 328                 log(loglevel_t::INFO, "Serivice ", service_name, " stop command terminated due to signal ",
 329                         WTERMSIG(exit_status));
 330             }
 331             // Just assume that we stopped, so that any dependencies
 332             // can be stopped:
 333             stopped();
 334         }
 335         services->process_queues();
 336     }
 337     else { // STARTING
 338         if (exit_status == 0) {
 339             started();
 340         }
 341         else {
 342             // failed to start
 343             if (did_exit) {
 344                 log(loglevel_t::ERROR, "Service ", service_name, " command failed with exit code ",
 345                         WEXITSTATUS(exit_status));
 346             }
 347             else if (was_signalled) {
 348                 log(loglevel_t::ERROR, "Service ", service_name, " command terminated due to signal ",
 349                         WTERMSIG(exit_status));
 350             }
 351             failed_to_start();
 352         }
 353         services->process_queues();
 354     }
 355 }
 356
 357 rearm exec_status_pipe_watcher::fd_event(eventloop_t &loop, int fd, int flags) noexcept
 358 {
 359     base_process_service *sr = service;
 360     sr->waiting_for_execstat = false;
 361
 362     int exec_status;
 363     int r = read(get_watched_fd(), &exec_status, sizeof(int));
 364     deregister(loop);
 365     close(get_watched_fd());
 366
 367     if (r > 0) {
 368         // We read an errno code; exec() failed, and the service startup failed.
 369         if (sr->pid != -1) {
 370             sr->child_listener.deregister(eventLoop, sr->pid);
 371             sr->reserved_child_watch = false;
 372             if (sr->stop_timer_armed) {
 373                 sr->restart_timer.stop_timer(loop);
 374                 sr->stop_timer_armed = false;
 375             }
 376         }
 377         sr->pid = -1;
 378         log(loglevel_t::ERROR, sr->service_name, ": execution failed: ", strerror(exec_status));
 379         if (sr->service_state == service_state_t::STARTING) {
 380             sr->failed_to_start();
 381         }
 382         else if (sr->service_state == service_state_t::STOPPING) {
 383             // Must be a scripted service. We've logged the failure, but it's probably better
 384             // not to leave the service in STARTED state:
 385             sr->stopped();
 386         }
 387     }
 388     else {
 389         // exec() succeeded.
 390         if (sr->record_type == service_type::PROCESS) {
 391             // This could be a smooth recovery (state already STARTED). Even more, the process
 392             // might be stopped (and killed via a signal) during smooth recovery.  We don't to
 393             // process startup again in either case, so we check for state STARTING:
 394             if (sr->service_state == service_state_t::STARTING) {
 395                 sr->started();
 396             }
 397         }
 398
 399         if (sr->pid == -1) {
 400             // Somehow the process managed to complete before we even saw the status.
 401             sr->handle_exit_status(sr->exit_status);
 402         }
 403     }
 404
 405     sr->services->process_queues();
 406
 407     return rearm::REMOVED;
 408 }
 409
 410 void service_record::require() noexcept
 411 {
 412     if (required_by++ == 0) {
 413         prop_require = !prop_release;
 414         prop_release = false;
 415         services->add_prop_queue(this);
 416     }
 417 }
 418
 419 void service_record::release() noexcept
 420 {
 421     if (--required_by == 0) {
 422         desired_state = service_state_t::STOPPED;
 423
 424         // Can stop, and can release dependencies now. We don't need to issue a release if
 425         // the require was pending though:
 426         prop_release = !prop_require;
 427         prop_require = false;
 428         services->add_prop_queue(this);
 429
 430         if (service_state == service_state_t::STOPPED) {
 431             services->service_inactive(this);
 432         }
 433         else {
 434             do_stop();
 435         }
 436     }
 437 }
 438
 439 void service_record::release_dependencies() noexcept
 440 {
 441     for (auto & dependency : depends_on) {
 442         service_record * dep_to = dependency.get_to();
 443         if (dependency.holding_acq) {
 444             dep_to->release();
 445             dependency.holding_acq = false;
 446         }
 447     }
 448 }
 449
 450 void service_record::start(bool activate) noexcept
 451 {
 452     if (activate && ! start_explicit) {
 453         require();
 454         start_explicit = true;
 455     }
 456
 457     if (desired_state == service_state_t::STARTED && service_state != service_state_t::STOPPED) return;
 458
 459     bool was_active = service_state != service_state_t::STOPPED || desired_state != service_state_t::STOPPED;
 460     desired_state = service_state_t::STARTED;
 461
 462     if (service_state != service_state_t::STOPPED) {
 463         // We're already starting/started, or we are stopping and need to wait for
 464         // that the complete.
 465         if (service_state != service_state_t::STOPPING || ! can_interrupt_stop()) {
 466             return;
 467         }
 468         // We're STOPPING, and that can be interrupted. Our dependencies might be STOPPING,
 469         // but if so they are waiting (for us), so they too can be instantly returned to
 470         // STARTING state.
 471         notify_listeners(service_event::STOPCANCELLED);
 472     }
 473     else if (! was_active) {
 474         services->service_active(this);
 475     }
 476
 477     service_state = service_state_t::STARTING;
 478     waiting_for_deps = true;
 479
 480     if (start_check_dependencies()) {
 481         services->add_transition_queue(this);
 482     }
 483 }
 484
 485 void service_record::do_propagation() noexcept
 486 {
 487     if (prop_require) {
 488         // Need to require all our dependencies
 489         for (auto & dep : depends_on) {
 490             dep.get_to()->require();
 491             dep.holding_acq = true;
 492         }
 493         prop_require = false;
 494     }
 495
 496     if (prop_release) {
 497         release_dependencies();
 498         prop_release = false;
 499     }
 500
 501     if (prop_failure) {
 502         prop_failure = false;
 503         failed_to_start(true);
 504     }
 505
 506     if (prop_start) {
 507         prop_start = false;
 508         start(false);
 509     }
 510
 511     if (prop_stop) {
 512         prop_stop = false;
 513         do_stop();
 514     }
 515 }
 516
 517 void service_record::execute_transition() noexcept
 518 {
 519     // state is STARTED with restarting set true if we are running a smooth recovery.
 520     if (service_state == service_state_t::STARTING || (service_state == service_state_t::STARTED
 521             && restarting)) {
 522         if (check_deps_started()) {
 523             bool have_console = service_state == service_state_t::STARTED && onstart_flags.runs_on_console;
 524             all_deps_started(have_console);
 525         }
 526     }
 527     else if (service_state == service_state_t::STOPPING) {
 528         if (stop_check_dependents()) {
 529             all_deps_stopped();
 530         }
 531     }
 532 }
 533
 534 void service_record::do_start() noexcept
 535 {
 536     if (pinned_stopped) return;
 537
 538     if (service_state != service_state_t::STARTING) {
 539         return;
 540     }
 541
 542     service_state = service_state_t::STARTING;
 543
 544     waiting_for_deps = true;
 545
 546     // Ask dependencies to start, mark them as being waited on.
 547     if (check_deps_started()) {
 548         // Once all dependencies are started, we start properly:
 549         all_deps_started();
 550     }
 551 }
 552
 553 void service_record::dependencyStarted() noexcept
 554 {
 555     if ((service_state == service_state_t::STARTING || service_state == service_state_t::STARTED)
 556             && waiting_for_deps) {
 557         services->add_transition_queue(this);
 558     }
 559 }
 560
 561 bool service_record::start_check_dependencies() noexcept
 562 {
 563     bool all_deps_started = true;
 564
 565     for (auto & dep : depends_on) {
 566         service_record * to = dep.get_to();
 567         if (to->service_state != service_state_t::STARTED) {
 568             if (to->service_state != service_state_t::STARTING) {
 569                 to->prop_start = true;
 570                 services->add_prop_queue(to);
 571             }
 572             dep.waiting_on = true;
 573             all_deps_started = false;
 574         }
 575     }
 576
 577     return all_deps_started;
 578 }
 579
 580 bool service_record::check_deps_started() noexcept
 581 {
 582     for (auto & dep : depends_on) {
 583         if (dep.waiting_on) {
 584             return false;
 585         }
 586     }
 587
 588     return true;
 589 }
 590
 591 bool service_record::open_socket() noexcept
 592 {
 593     if (socket_path.empty() || socket_fd != -1) {
 594         // No socket, or already open
 595         return true;
 596     }
 597
 598     const char * saddrname = socket_path.c_str();
 599
 600     // Check the specified socket path
 601     struct stat stat_buf;
 602     if (stat(saddrname, &stat_buf) == 0) {
 603         if ((stat_buf.st_mode & S_IFSOCK) == 0) {
 604             // Not a socket
 605             log(loglevel_t::ERROR, service_name, ": Activation socket file exists (and is not a socket)");
 606             return false;
 607         }
 608     }
 609     else if (errno != ENOENT) {
 610         // Other error
 611         log(loglevel_t::ERROR, service_name, ": Error checking activation socket: ", strerror(errno));
 612         return false;
 613     }
 614
 615     // Remove stale socket file (if it exists).
 616     // We won't test the return from unlink - if it fails other than due to ENOENT, we should get an
 617     // error when we try to create the socket anyway.
 618     unlink(saddrname);
 619
 620     uint sockaddr_size = offsetof(struct sockaddr_un, sun_path) + socket_path.length() + 1;
 621     struct sockaddr_un * name = static_cast<sockaddr_un *>(malloc(sockaddr_size));
 622     if (name == nullptr) {
 623         log(loglevel_t::ERROR, service_name, ": Opening activation socket: out of memory");
 624         return false;
 625     }
 626
 627     name->sun_family = AF_UNIX;
 628     strcpy(name->sun_path, saddrname);
 629
 630     int sockfd = dinit_socket(AF_UNIX, SOCK_STREAM, 0, SOCK_NONBLOCK | SOCK_CLOEXEC);
 631     if (sockfd == -1) {
 632         log(loglevel_t::ERROR, service_name, ": Error creating activation socket: ", strerror(errno));
 633         free(name);
 634         return false;
 635     }
 636
 637     if (bind(sockfd, (struct sockaddr *) name, sockaddr_size) == -1) {
 638         log(loglevel_t::ERROR, service_name, ": Error binding activation socket: ", strerror(errno));
 639         close(sockfd);
 640         free(name);
 641         return false;
 642     }
 643
 644     free(name);
 645
 646     // POSIX (1003.1, 2013) says that fchown and fchmod don't necessarily work on sockets. We have to
 647     // use chown and chmod instead.
 648     if (chown(saddrname, socket_uid, socket_gid)) {
 649         log(loglevel_t::ERROR, service_name, ": Error setting activation socket owner/group: ", strerror(errno));
 650         close(sockfd);
 651         return false;
 652     }
 653
 654     if (chmod(saddrname, socket_perms) == -1) {
 655         log(loglevel_t::ERROR, service_name, ": Error setting activation socket permissions: ", strerror(errno));
 656         close(sockfd);
 657         return false;
 658     }
 659
 660     if (listen(sockfd, 128) == -1) { // 128 "seems reasonable".
 661         log(loglevel_t::ERROR, ": Error listening on activation socket: ", strerror(errno));
 662         close(sockfd);
 663         return false;
 664     }
 665
 666     socket_fd = sockfd;
 667     return true;
 668 }
 669
 670 void service_record::all_deps_started(bool has_console) noexcept
 671 {
 672     if (onstart_flags.starts_on_console && ! has_console) {
 673         waiting_for_deps = true;
 674         queue_for_console();
 675         return;
 676     }
 677
 678     waiting_for_deps = false;
 679
 680     // We overload can_interrupt_start to check whether there is any other
 681     // process (eg restart timer) that needs to finish before starting.
 682     if (can_interrupt_start()) {
 683         waiting_for_deps = true;
 684         return;
 685     }
 686
 687     if (! open_socket()) {
 688         failed_to_start();
 689     }
 690
 691     bool start_success = start_ps_process();
 692     if (! start_success) {
 693         failed_to_start();
 694     }
 695 }
 696
 697 void service_record::acquired_console() noexcept
 698 {
 699     if (service_state != service_state_t::STARTING) {
 700         // We got the console but no longer want it.
 701         release_console();
 702     }
 703     else if (check_deps_started()) {
 704         all_deps_started(true);
 705     }
 706     else {
 707         // We got the console but can't use it yet.
 708         release_console();
 709     }
 710 }
 711
 712 bgproc_service::pid_result_t
 713 bgproc_service::read_pid_file(int *exit_status) noexcept
 714 {
 715     const char *pid_file_c = pid_file.c_str();
 716     int fd = open(pid_file_c, O_CLOEXEC);
 717     if (fd == -1) {
 718         log(loglevel_t::ERROR, service_name, ": read pid file: ", strerror(errno));
 719         return pid_result_t::FAILED;
 720     }
 721
 722     char pidbuf[21]; // just enough to hold any 64-bit integer
 723     int r = ss_read(fd, pidbuf, 20);
 724     if (r < 0) {
 725         // Could not read from PID file
 726         log(loglevel_t::ERROR, service_name, ": could not read from pidfile; ", strerror(errno));
 727         close(fd);
 728         return pid_result_t::FAILED;
 729     }
 730
 731     close(fd);
 732     pidbuf[r] = 0; // store nul terminator
 733
 734     bool valid_pid = false;
 735     try {
 736         unsigned long long v = std::stoull(pidbuf, nullptr, 0);
 737         if (v <= std::numeric_limits<pid_t>::max()) {
 738             pid = (pid_t) v;
 739             valid_pid = true;
 740         }
 741     }
 742     catch (std::out_of_range &exc) {
 743         // Too large?
 744     }
 745     catch (std::invalid_argument &exc) {
 746         // Ok, so it doesn't look like a number: proceed...
 747     }
 748
 749     if (valid_pid) {
 750         pid_t wait_r = waitpid(pid, exit_status, WNOHANG);
 751         if (wait_r == -1 && errno == ECHILD) {
 752             // We can't track this child - check process exists:
 753             if (kill(pid, 0) == 0 || errno != ESRCH) {
 754                 tracking_child = false;
 755                 return pid_result_t::OK;
 756             }
 757             else {
 758                 log(loglevel_t::ERROR, service_name, ": pid read from pidfile (", pid, ") is not valid");
 759                 pid = -1;
 760                 return pid_result_t::FAILED;
 761             }
 762         }
 763         else if (wait_r == pid) {
 764             pid = -1;
 765             return pid_result_t::TERMINATED;
 766         }
 767         else if (wait_r == 0) {
 768             // We can track the child
 769             child_listener.add_reserved(eventLoop, pid, DEFAULT_PRIORITY - 10);
 770             tracking_child = true;
 771             reserved_child_watch = true;
 772             return pid_result_t::OK;
 773         }
 774     }
 775
 776     log(loglevel_t::ERROR, service_name, ": pid read from pidfile (", pid, ") is not valid");
 777     pid = -1;
 778     return pid_result_t::FAILED;
 779 }
 780
 781 void service_record::started() noexcept
 782 {
 783     if (onstart_flags.starts_on_console && ! onstart_flags.runs_on_console) {
 784         tcsetpgrp(0, getpgrp());
 785         release_console();
 786     }
 787
 788     log_service_started(service_name);
 789     service_state = service_state_t::STARTED;
 790     notify_listeners(service_event::STARTED);
 791
 792     if (onstart_flags.rw_ready) {
 793         open_control_socket();
 794     }
 795     if (onstart_flags.log_ready) {
 796         setup_external_log();
 797     }
 798
 799     if (force_stop || desired_state == service_state_t::STOPPED) {
 800         // We must now stop.
 801         do_stop();
 802         return;
 803     }
 804
 805     // Notify any dependents whose desired state is STARTED:
 806     for (auto dept : dependents) {
 807         dept->get_from()->dependencyStarted();
 808         dept->waiting_on = false;
 809     }
 810 }
 811
 812 void service_record::failed_to_start(bool depfailed) noexcept
 813 {
 814     if (!depfailed && onstart_flags.starts_on_console) {
 815         tcsetpgrp(0, getpgrp());
 816         release_console();
 817     }
 818
 819     log_service_failed(service_name);
 820     service_state = service_state_t::STOPPED;
 821     if (start_explicit) {
 822         start_explicit = false;
 823         release();
 824     }
 825     notify_listeners(service_event::FAILEDSTART);
 826
 827     // Cancel start of dependents:
 828     for (auto & dept : dependents) {
 829         switch (dept->dep_type) {
 830         case dependency_type::REGULAR:
 831         case dependency_type::MILESTONE:
 832             if (dept->get_from()->service_state == service_state_t::STARTING) {
 833                 dept->get_from()->prop_failure = true;
 834                 services->add_prop_queue(dept->get_from());
 835             }
 836             break;
 837         case dependency_type::WAITS_FOR:
 838         case dependency_type::SOFT:
 839             if (dept->waiting_on) {
 840                 dept->waiting_on = false;
 841                 dept->get_from()->dependencyStarted();
 842             }
 843             if (dept->holding_acq) {
 844                 dept->holding_acq = false;
 845                 release();
 846             }
 847         }
 848     }
 849 }
 850
 851 bool service_record::start_ps_process() noexcept
 852 {
 853     // default implementation: there is no process, so we are started.
 854     started();
 855     return true;
 856 }
 857
 858 bool base_process_service::start_ps_process() noexcept
 859 {
 860     if (restarting) {
 861         if (pid == -1) {
 862             return restart_ps_process();
 863         }
 864         return true;
 865     }
 866     else {
 867         eventLoop.get_time(restart_interval_time, clock_type::MONOTONIC);
 868         restart_interval_count = 0;
 869         return start_ps_process(exec_arg_parts, onstart_flags.starts_on_console);
 870     }
 871 }
 872
 873 bool base_process_service::start_ps_process(const std::vector<const char *> &cmd, bool on_console) noexcept
 874 {
 875     // In general, you can't tell whether fork/exec is successful. We use a pipe to communicate
 876     // success/failure from the child to the parent. The pipe is set CLOEXEC so a successful
 877     // exec closes the pipe, and the parent sees EOF. If the exec is unsuccessful, the errno
 878     // is written to the pipe, and the parent can read it.
 879
 880     eventLoop.get_time(last_start_time, clock_type::MONOTONIC);
 881
 882     int pipefd[2];
 883     if (pipe2(pipefd, O_CLOEXEC)) {
 884         log(loglevel_t::ERROR, service_name, ": can't create status check pipe: ", strerror(errno));
 885         return false;
 886     }
 887
 888     const char * logfile = this->logfile.c_str();
 889     if (*logfile == 0) {
 890         logfile = "/dev/null";
 891     }
 892
 893     bool child_status_registered = false;
 894     control_conn_t *control_conn = nullptr;
 895
 896     int control_socket[2] = {-1, -1};
 897     if (onstart_flags.pass_cs_fd) {
 898         if (dinit_socketpair(AF_UNIX, SOCK_STREAM, /* protocol */ 0, control_socket, SOCK_NONBLOCK)) {
 899             log(loglevel_t::ERROR, service_name, ": can't create control socket: ", strerror(errno));
 900             goto out_p;
 901         }
 902
 903         // Make the server side socket close-on-exec:
 904         int fdflags = fcntl(control_socket[0], F_GETFD);
 905         fcntl(control_socket[0], F_SETFD, fdflags | FD_CLOEXEC);
 906
 907         try {
 908             control_conn = new control_conn_t(&eventLoop, services, control_socket[0]);
 909         }
 910         catch (std::exception &exc) {
 911             log(loglevel_t::ERROR, service_name, ": can't launch process; out of memory");
 912             goto out_cs;
 913         }
 914     }
 915
 916     // Set up complete, now fork and exec:
 917
 918     pid_t forkpid;
 919
 920     try {
 921         child_status_listener.add_watch(eventLoop, pipefd[0], IN_EVENTS);
 922         child_status_registered = true;
 923
 924         // We specify a high priority (i.e. low priority value) so that process termination is
 925         // handled early. This means we have always recorded that the process is terminated by the
 926         // time that we handle events that might otherwise cause us to signal the process, so we
 927         // avoid sending a signal to an invalid (and possibly recycled) process ID.
 928         forkpid = child_listener.fork(eventLoop, reserved_child_watch, DEFAULT_PRIORITY - 10);
 929         reserved_child_watch = true;
 930     }
 931     catch (std::exception &e) {
 932         log(loglevel_t::ERROR, service_name, ": Could not fork: ", e.what());
 933         goto out_cs_h;
 934     }
 935
 936     if (forkpid == 0) {
 937         run_child_proc(cmd.data(), logfile, on_console, pipefd[1], control_socket[1]);
 938     }
 939     else {
 940         // Parent process
 941         close(pipefd[1]); // close the 'other end' fd
 942         if (control_socket[1] != -1) {
 943             close(control_socket[1]);
 944         }
 945         pid = forkpid;
 946
 947         waiting_for_execstat = true;
 948         return true;
 949     }
 950
 951     // Failure exit:
 952
 953     out_cs_h:
 954     if (child_status_registered) {
 955         child_status_listener.deregister(eventLoop);
 956     }
 957
 958     if (onstart_flags.pass_cs_fd) {
 959         delete control_conn;
 960
 961         out_cs:
 962         close(control_socket[0]);
 963         close(control_socket[1]);
 964     }
 965
 966     out_p:
 967     close(pipefd[0]);
 968     close(pipefd[1]);
 969
 970     return false;
 971 }
 972
 973 void service_record::run_child_proc(const char * const *args, const char *logfile, bool on_console,
 974         int wpipefd, int csfd) noexcept
 975 {
 976     // Child process. Must not allocate memory (or otherwise risk throwing any exception)
 977     // from here until exit().
 978
 979     // If the console already has a session leader, presumably it is us. On the other hand
 980     // if it has no session leader, and we don't create one, then control inputs such as
 981     // ^C will have no effect.
 982     bool do_set_ctty = (tcgetsid(0) == -1);
 983
 984     // Copy signal mask, but unmask signals that we masked on startup. For the moment, we'll
 985     // also block all signals, since apparently dup() can be interrupted (!!! really, POSIX??).
 986     sigset_t sigwait_set;
 987     sigset_t sigall_set;
 988     sigfillset(&sigall_set);
 989     sigprocmask(SIG_SETMASK, &sigall_set, &sigwait_set);
 990     sigdelset(&sigwait_set, SIGCHLD);
 991     sigdelset(&sigwait_set, SIGINT);
 992     sigdelset(&sigwait_set, SIGTERM);
 993     sigdelset(&sigwait_set, SIGQUIT);
 994
 995     constexpr int bufsz = ((CHAR_BIT * sizeof(pid_t)) / 3 + 2) + 11;
 996     // "LISTEN_PID=" - 11 characters; the expression above gives a conservative estimate
 997     // on the maxiumum number of bytes required for LISTEN=nnn, including nul terminator,
 998     // where nnn is a pid_t in decimal (i.e. one decimal digit is worth just over 3 bits).
 999     char nbuf[bufsz];
1000
1001     // "DINIT_CS_FD=" - 12 bytes. (we -1 from sizeof(int) in account of sign bit).
1002     constexpr int csenvbufsz = ((CHAR_BIT * sizeof(int) - 1) / 3 + 2) + 12;
1003     char csenvbuf[csenvbufsz];
1004
1005     int minfd = (socket_fd == -1) ? 3 : 4;
1006
1007     // Move wpipefd/csfd to another fd if necessary
1008     if (wpipefd < minfd) {
1009         wpipefd = fcntl(wpipefd, F_DUPFD_CLOEXEC, minfd);
1010         if (wpipefd == -1) goto failure_out;
1011     }
1012
1013     if (csfd != -1 && csfd < minfd) {
1014         csfd = fcntl(csfd, F_DUPFD, minfd);
1015         if (csfd == -1) goto failure_out;
1016     }
1017
1018     if (socket_fd != -1) {
1019
1020         if (dup2(socket_fd, 3) == -1) goto failure_out;
1021         if (socket_fd != 3) {
1022             close(socket_fd);
1023         }
1024
1025         if (putenv(const_cast<char *>("LISTEN_FDS=1"))) goto failure_out;
1026         snprintf(nbuf, bufsz, "LISTEN_PID=%jd", static_cast<intmax_t>(getpid()));
1027         if (putenv(nbuf)) goto failure_out;
1028     }
1029
1030     if (csfd != -1) {
1031         snprintf(csenvbuf, csenvbufsz, "DINIT_CS_FD=%d", csfd);
1032         if (putenv(csenvbuf)) goto failure_out;
1033     }
1034
1035     if (! on_console) {
1036         // Re-set stdin, stdout, stderr
1037         close(0); close(1); close(2);
1038
1039         if (open("/dev/null", O_RDONLY) == 0) {
1040             // stdin = 0. That's what we should have; proceed with opening
1041             // stdout and stderr.
1042             if (open(logfile, O_WRONLY | O_CREAT | O_APPEND, S_IRUSR | S_IWUSR) != 1) {
1043                 goto failure_out;
1044             }
1045             if (dup2(1, 2) != 2) {
1046                 goto failure_out;
1047             }
1048         }
1049         else goto failure_out;
1050
1051         // We have the option of creating a session and process group, or just a new process
1052         // group. If we just create a new process group, the child process cannot make itself
1053         // a session leader if it wants to do that (eg getty/login will generally want this).
1054         // If we do neither, and we are running with a controlling terminal, a ^C or similar
1055         // will also affect the child process (which probably isn't so bad, though since we
1056         // will handle the shutdown ourselves it's not necessary). Creating a new session
1057         // (and a new process group as part of that) seems like a safe bet, and has the
1058         // advantage of letting us signal the process as part of a process group.
1059         setsid();
1060     }
1061     else {
1062         // "run on console" - run as a foreground job on the terminal/console device
1063
1064         // if do_set_ctty is false, we are the session leader; we are probably running
1065         // as a user process. Don't create a new session leader in that case, and run
1066         // as part of the parent session. Otherwise, the new session cannot claim the
1067         // terminal as a controlling terminal (it is already claimed), meaning that it
1068         // will not see control signals from ^C etc.
1069
1070         if (do_set_ctty) {
1071             // Disable suspend (^Z) (and on some systems, delayed suspend / ^Y)
1072             signal(SIGTSTP, SIG_IGN);
1073
1074             // Become session leader
1075             setsid();
1076             ioctl(0, TIOCSCTTY, 0);
1077         }
1078         setpgid(0,0);
1079         tcsetpgrp(0, getpgrp());
1080     }
1081
1082     sigprocmask(SIG_SETMASK, &sigwait_set, nullptr);
1083
1084     execvp(args[0], const_cast<char **>(args));
1085
1086     // If we got here, the exec failed:
1087     failure_out:
1088     int exec_status = errno;
1089     write(wpipefd, &exec_status, sizeof(int));
1090     _exit(0);
1091 }
1092
1093 // Mark this and all dependent services as force-stopped.
1094 void service_record::forced_stop() noexcept
1095 {
1096     if (service_state != service_state_t::STOPPED) {
1097         force_stop = true;
1098         services->add_transition_queue(this);
1099     }
1100 }
1101
1102 void service_record::dependent_stopped() noexcept
1103 {
1104     if (service_state == service_state_t::STOPPING && waiting_for_deps) {
1105         services->add_transition_queue(this);
1106     }
1107 }
1108
1109 void service_record::stop(bool bring_down) noexcept
1110 {
1111     if (start_explicit) {
1112         start_explicit = false;
1113         release();
1114     }
1115
1116     if (bring_down) {
1117         do_stop();
1118     }
1119 }
1120
1121 void service_record::do_stop() noexcept
1122 {
1123     if (pinned_started) return;
1124
1125     if (start_explicit && ! do_auto_restart()) {
1126         start_explicit = false;
1127         release();
1128         if (required_by == 0) return; // release will re-call us anyway
1129     }
1130
1131     if (service_state != service_state_t::STARTED) {
1132         if (service_state == service_state_t::STARTING) {
1133             if (! can_interrupt_start()) {
1134                 // Well this is awkward: we're going to have to continue
1135                 // starting, but we don't want any dependents to think that
1136                 // they are still waiting to start.
1137                 // Make sure they remain stopped:
1138                 stop_dependents();
1139                 return;
1140             }
1141
1142             // We must have had desired_state == STARTED.
1143             notify_listeners(service_event::STARTCANCELLED);
1144
1145             interrupt_start();
1146
1147             // Reaching this point, we are starting interruptibly - so we
1148             // stop now (by falling through to below).
1149         }
1150         else {
1151             // If we're starting we need to wait for that to complete.
1152             // If we're already stopping/stopped there's nothing to do.
1153             return;
1154         }
1155     }
1156
1157     service_state = service_state_t::STOPPING;
1158     waiting_for_deps = true;
1159     if (stop_dependents()) {
1160         services->add_transition_queue(this);
1161     }
1162 }
1163
1164 bool service_record::stop_check_dependents() noexcept
1165 {
1166     bool all_deps_stopped = true;
1167     for (auto dept : dependents) {
1168         if (dept->dep_type == dependency_type::REGULAR && ! dept->get_from()->is_stopped()) {
1169             all_deps_stopped = false;
1170             break;
1171         }
1172     }
1173
1174     return all_deps_stopped;
1175 }
1176
1177 bool service_record::stop_dependents() noexcept
1178 {
1179     bool all_deps_stopped = true;
1180     for (auto dept : dependents) {
1181         if (dept->dep_type == dependency_type::REGULAR) {
1182             if (! dept->get_from()->is_stopped()) {
1183                 // Note we check *first* since if the dependent service is not stopped,
1184                 // 1. We will issue a stop to it shortly and
1185                 // 2. It will notify us when stopped, at which point the stop_check_dependents()
1186                 //    check is run anyway.
1187                 all_deps_stopped = false;
1188             }
1189
1190             if (force_stop) {
1191                 // If this service is to be forcefully stopped, dependents must also be.
1192                 dept->get_from()->forced_stop();
1193             }
1194
1195             dept->get_from()->prop_stop = true;
1196             services->add_prop_queue(dept->get_from());
1197         }
1198     }
1199
1200     return all_deps_stopped;
1201 }
1202
1203 // All dependents have stopped; we can stop now, too. Only called when STOPPING.
1204 void service_record::all_deps_stopped() noexcept
1205 {
1206     waiting_for_deps = false;
1207     stopped();
1208 }
1209
1210 void base_process_service::kill_pg(int signo) noexcept
1211 {
1212     pid_t pgid = getpgid(pid);
1213     if (pgid == -1) {
1214         // only should happen if pid is invalid, which should never happen...
1215         log(loglevel_t::ERROR, service_name, ": can't signal process: ", strerror(errno));
1216         return;
1217     }
1218     kill(-pgid, signo);
1219 }
1220
1221 void base_process_service::all_deps_stopped() noexcept
1222 {
1223     waiting_for_deps = false;
1224     if (pid != -1) {
1225         // The process is still kicking on - must actually kill it. We signal the process
1226         // group (-pid) rather than just the process as there's less risk then of creating
1227         // an orphaned process group:
1228         if (! onstart_flags.no_sigterm) {
1229             kill_pg(SIGTERM);
1230         }
1231         if (term_signal != -1) {
1232             kill_pg(term_signal);
1233         }
1234
1235         // In most cases, the rest is done in handle_exit_status.
1236         // If we are a BGPROCESS and the process is not our immediate child, however, that
1237         // won't work - check for this now:
1238         if (record_type == service_type::BGPROCESS && ! tracking_child) {
1239             stopped();
1240         }
1241         else if (stop_timeout != time_val(0,0)) {
1242             restart_timer.arm_timer_rel(eventLoop, stop_timeout);
1243             stop_timer_armed = true;
1244         }
1245     }
1246     else {
1247         // The process is already dead.
1248         stopped();
1249     }
1250 }
1251
1252 void scripted_service::all_deps_stopped() noexcept
1253 {
1254     waiting_for_deps = false;
1255     if (stop_command.length() == 0) {
1256         stopped();
1257     }
1258     else if (! start_ps_process(stop_arg_parts, false)) {
1259         // Couldn't execute stop script, but there's not much we can do:
1260         stopped();
1261     }
1262     else {
1263         // successfully started stop script: start kill timer:
1264         if (stop_timeout != time_val(0,0)) {
1265             restart_timer.arm_timer_rel(eventLoop, stop_timeout);
1266             stop_timer_armed = true;
1267         }
1268     }
1269 }
1270
1271 void service_record::unpin() noexcept
1272 {
1273     if (pinned_started) {
1274         pinned_started = false;
1275         if (desired_state == service_state_t::STOPPED || force_stop) {
1276             do_stop();
1277             services->process_queues();
1278         }
1279     }
1280     if (pinned_stopped) {
1281         pinned_stopped = false;
1282         if (desired_state == service_state_t::STARTED) {
1283             do_start();
1284             services->process_queues();
1285         }
1286     }
1287 }
1288
1289 void service_record::queue_for_console() noexcept
1290 {
1291     services->append_console_queue(this);
1292 }
1293
1294 void service_record::release_console() noexcept
1295 {
1296     services->pull_console_queue();
1297 }
1298
1299 void service_record::interrupt_start() noexcept
1300 {
1301     services->unqueue_console(this);
1302 }
1303
1304 void service_set::service_active(service_record *sr) noexcept
1305 {
1306     active_services++;
1307 }
1308
1309 void service_set::service_inactive(service_record *sr) noexcept
1310 {
1311     active_services--;
1312 }
1313
1314 base_process_service::base_process_service(service_set *sset, string name,
1315         service_type service_type_p, string &&command,
1316         std::list<std::pair<unsigned,unsigned>> &command_offsets,
1317         const std::list<prelim_dep> &deplist_p)
1318      : service_record(sset, name, service_type_p, std::move(command), command_offsets,
1319          deplist_p), child_listener(this), child_status_listener(this)
1320 {
1321     restart_interval_count = 0;
1322     restart_interval_time = {0, 0};
1323     restart_timer.service = this;
1324     restart_timer.add_timer(eventLoop);
1325
1326     // By default, allow a maximum of 3 restarts within 10.0 seconds:
1327     restart_interval.seconds() = 10;
1328     restart_interval.nseconds() = 0;
1329     max_restart_interval_count = 3;
1330
1331     waiting_restart_timer = false;
1332     reserved_child_watch = false;
1333     tracking_child = false;
1334     stop_timer_armed = false;
1335 }
1336
1337 void base_process_service::do_restart() noexcept
1338 {
1339     waiting_restart_timer = false;
1340     restart_interval_count++;
1341
1342     // We may be STARTING (regular restart) or STARTED ("smooth recovery"). This affects whether
1343     // the process should be granted access to the console:
1344     bool on_console = service_state == service_state_t::STARTING
1345             ? onstart_flags.starts_on_console : onstart_flags.runs_on_console;
1346
1347     if (service_state == service_state_t::STARTING) {
1348         // for a smooth recovery, we want to check dependencies are available before actually
1349         // starting:
1350         if (! check_deps_started()) {
1351             waiting_for_deps = true;
1352             return;
1353         }
1354     }
1355
1356     if (! start_ps_process(exec_arg_parts, on_console)) {
1357         restarting = false;
1358         if (service_state == service_state_t::STARTING) {
1359             failed_to_start();
1360         }
1361         else {
1362             desired_state = service_state_t::STOPPED;
1363             forced_stop();
1364         }
1365         services->process_queues();
1366     }
1367 }
1368
1369 bool base_process_service::restart_ps_process() noexcept
1370 {
1371     using time_val = dasynq::time_val;
1372
1373     time_val current_time;
1374     eventLoop.get_time(current_time, clock_type::MONOTONIC);
1375
1376     if (max_restart_interval_count != 0) {
1377         // Check whether we're still in the most recent restart check interval:
1378         time_val int_diff = current_time - restart_interval_time;
1379         if (int_diff < restart_interval) {
1380             if (restart_interval_count >= max_restart_interval_count) {
1381                 log(loglevel_t::ERROR, "Service ", service_name, " restarting too quickly; stopping.");
1382                 return false;
1383             }
1384         }
1385         else {
1386             restart_interval_time = current_time;
1387             restart_interval_count = 0;
1388         }
1389     }
1390
1391     // Check if enough time has lapsed since the prevous restart. If not, start a timer:
1392     time_val tdiff = current_time - last_start_time;
1393     if (restart_delay <= tdiff) {
1394         // > restart delay (normally 200ms)
1395         do_restart();
1396     }
1397     else {
1398         time_val timeout = restart_delay - tdiff;
1399         restart_timer.arm_timer_rel(eventLoop, timeout);
1400         waiting_restart_timer = true;
1401     }
1402     return true;
1403 }
1404
1405 void base_process_service::interrupt_start() noexcept
1406 {
1407     // overridden in subclasses
1408     if (waiting_restart_timer) {
1409         restart_timer.stop_timer(eventLoop);
1410         waiting_restart_timer = false;
1411     }
1412     service_record::interrupt_start();
1413 }
1414
1415 void base_process_service::kill_with_fire() noexcept
1416 {
1417     if (pid != -1) {
1418         log(loglevel_t::WARN, "Service ", service_name, "with pid ", pid, " exceeded allowed stop time; killing.");
1419         kill_pg(SIGKILL);
1420     }
1421 }
1422
1423 dasynq::rearm process_restart_timer::timer_expiry(eventloop_t &, int expiry_count)
1424 {
1425     if (service->service_state == service_state_t::STOPPING) {
1426         service->kill_with_fire();
1427         service->stop_timer_armed = false;
1428     }
1429     else {
1430         // STARTING / STARTED:
1431         service->do_restart();
1432     }
1433     return dasynq::rearm::DISARM;
1434 }