17756: Move "no suitable instance type" reporting to dispatch lib.
[arvados.git] / services / crunch-dispatch-slurm / crunch-dispatch-slurm.go
1 // Copyright (C) The Arvados Authors. All rights reserved.
2 //
3 // SPDX-License-Identifier: AGPL-3.0
4
5 package main
6
7 // Dispatcher service for Crunch that submits containers to the slurm queue.
8
9 import (
10         "context"
11         "flag"
12         "fmt"
13         "log"
14         "math"
15         "os"
16         "regexp"
17         "strings"
18         "time"
19
20         "git.arvados.org/arvados.git/lib/config"
21         "git.arvados.org/arvados.git/lib/dispatchcloud"
22         "git.arvados.org/arvados.git/sdk/go/arvados"
23         "git.arvados.org/arvados.git/sdk/go/arvadosclient"
24         "git.arvados.org/arvados.git/sdk/go/dispatch"
25         "github.com/coreos/go-systemd/daemon"
26         "github.com/ghodss/yaml"
27         "github.com/sirupsen/logrus"
28 )
29
30 type logger interface {
31         dispatch.Logger
32         Fatalf(string, ...interface{})
33 }
34
35 const initialNiceValue int64 = 10000
36
37 var (
38         version = "dev"
39 )
40
41 type Dispatcher struct {
42         *dispatch.Dispatcher
43         logger  logrus.FieldLogger
44         cluster *arvados.Cluster
45         sqCheck *SqueueChecker
46         slurm   Slurm
47
48         Client arvados.Client
49 }
50
51 func main() {
52         logger := logrus.StandardLogger()
53         if os.Getenv("DEBUG") != "" {
54                 logger.SetLevel(logrus.DebugLevel)
55         }
56         logger.Formatter = &logrus.JSONFormatter{
57                 TimestampFormat: "2006-01-02T15:04:05.000000000Z07:00",
58         }
59         disp := &Dispatcher{logger: logger}
60         err := disp.Run(os.Args[0], os.Args[1:])
61         if err != nil {
62                 logrus.Fatalf("%s", err)
63         }
64 }
65
66 func (disp *Dispatcher) Run(prog string, args []string) error {
67         if err := disp.configure(prog, args); err != nil {
68                 return err
69         }
70         disp.setup()
71         return disp.run()
72 }
73
74 // configure() loads config files. Tests skip this.
75 func (disp *Dispatcher) configure(prog string, args []string) error {
76         if disp.logger == nil {
77                 disp.logger = logrus.StandardLogger()
78         }
79         flags := flag.NewFlagSet(prog, flag.ExitOnError)
80         flags.Usage = func() { usage(flags) }
81
82         loader := config.NewLoader(nil, disp.logger)
83         loader.SetupFlags(flags)
84
85         dumpConfig := flag.Bool(
86                 "dump-config",
87                 false,
88                 "write current configuration to stdout and exit")
89         getVersion := flags.Bool(
90                 "version",
91                 false,
92                 "Print version information and exit.")
93
94         args = loader.MungeLegacyConfigArgs(logrus.StandardLogger(), args, "-legacy-crunch-dispatch-slurm-config")
95
96         // Parse args; omit the first arg which is the command name
97         err := flags.Parse(args)
98
99         if err == flag.ErrHelp {
100                 return nil
101         }
102
103         // Print version information if requested
104         if *getVersion {
105                 fmt.Printf("crunch-dispatch-slurm %s\n", version)
106                 return nil
107         }
108
109         disp.logger.Printf("crunch-dispatch-slurm %s started", version)
110
111         cfg, err := loader.Load()
112         if err != nil {
113                 return err
114         }
115
116         if disp.cluster, err = cfg.GetCluster(""); err != nil {
117                 return fmt.Errorf("config error: %s", err)
118         }
119
120         disp.Client.APIHost = disp.cluster.Services.Controller.ExternalURL.Host
121         disp.Client.AuthToken = disp.cluster.SystemRootToken
122         disp.Client.Insecure = disp.cluster.TLS.Insecure
123
124         if disp.Client.APIHost != "" || disp.Client.AuthToken != "" {
125                 // Copy real configs into env vars so [a]
126                 // MakeArvadosClient() uses them, and [b] they get
127                 // propagated to crunch-run via SLURM.
128                 os.Setenv("ARVADOS_API_HOST", disp.Client.APIHost)
129                 os.Setenv("ARVADOS_API_TOKEN", disp.Client.AuthToken)
130                 os.Setenv("ARVADOS_API_HOST_INSECURE", "")
131                 if disp.Client.Insecure {
132                         os.Setenv("ARVADOS_API_HOST_INSECURE", "1")
133                 }
134                 os.Setenv("ARVADOS_EXTERNAL_CLIENT", "")
135                 for k, v := range disp.cluster.Containers.SLURM.SbatchEnvironmentVariables {
136                         os.Setenv(k, v)
137                 }
138         } else {
139                 disp.logger.Warnf("Client credentials missing from config, so falling back on environment variables (deprecated).")
140         }
141
142         if *dumpConfig {
143                 out, err := yaml.Marshal(cfg)
144                 if err != nil {
145                         return err
146                 }
147                 _, err = os.Stdout.Write(out)
148                 if err != nil {
149                         return err
150                 }
151         }
152
153         return nil
154 }
155
156 // setup() initializes private fields after configure().
157 func (disp *Dispatcher) setup() {
158         arv, err := arvadosclient.MakeArvadosClient()
159         if err != nil {
160                 disp.logger.Fatalf("Error making Arvados client: %v", err)
161         }
162         arv.Retries = 25
163
164         disp.slurm = NewSlurmCLI()
165         disp.sqCheck = &SqueueChecker{
166                 Logger:         disp.logger,
167                 Period:         time.Duration(disp.cluster.Containers.CloudVMs.PollInterval),
168                 PrioritySpread: disp.cluster.Containers.SLURM.PrioritySpread,
169                 Slurm:          disp.slurm,
170         }
171         disp.Dispatcher = &dispatch.Dispatcher{
172                 Arv:            arv,
173                 Logger:         disp.logger,
174                 BatchSize:      disp.cluster.API.MaxItemsPerResponse,
175                 RunContainer:   disp.runContainer,
176                 PollPeriod:     time.Duration(disp.cluster.Containers.CloudVMs.PollInterval),
177                 MinRetryPeriod: time.Duration(disp.cluster.Containers.MinRetryPeriod),
178         }
179 }
180
181 func (disp *Dispatcher) run() error {
182         defer disp.sqCheck.Stop()
183
184         if disp.cluster != nil && len(disp.cluster.InstanceTypes) > 0 {
185                 go SlurmNodeTypeFeatureKludge(disp.cluster)
186         }
187
188         if _, err := daemon.SdNotify(false, "READY=1"); err != nil {
189                 log.Printf("Error notifying init daemon: %v", err)
190         }
191         go disp.checkSqueueForOrphans()
192         return disp.Dispatcher.Run(context.Background())
193 }
194
195 var containerUuidPattern = regexp.MustCompile(`^[a-z0-9]{5}-dz642-[a-z0-9]{15}$`)
196
197 // Check the next squeue report, and invoke TrackContainer for all the
198 // containers in the report. This gives us a chance to cancel slurm
199 // jobs started by a previous dispatch process that never released
200 // their slurm allocations even though their container states are
201 // Cancelled or Complete. See https://dev.arvados.org/issues/10979
202 func (disp *Dispatcher) checkSqueueForOrphans() {
203         for _, uuid := range disp.sqCheck.All() {
204                 if !containerUuidPattern.MatchString(uuid) || !strings.HasPrefix(uuid, disp.cluster.ClusterID) {
205                         continue
206                 }
207                 err := disp.TrackContainer(uuid)
208                 if err != nil {
209                         log.Printf("checkSqueueForOrphans: TrackContainer(%s): %s", uuid, err)
210                 }
211         }
212 }
213
214 func (disp *Dispatcher) slurmConstraintArgs(container arvados.Container) []string {
215         mem := int64(math.Ceil(float64(container.RuntimeConstraints.RAM+
216                 container.RuntimeConstraints.KeepCacheRAM+
217                 int64(disp.cluster.Containers.ReserveExtraRAM)) / float64(1048576)))
218
219         disk := dispatchcloud.EstimateScratchSpace(&container)
220         disk = int64(math.Ceil(float64(disk) / float64(1048576)))
221         return []string{
222                 fmt.Sprintf("--mem=%d", mem),
223                 fmt.Sprintf("--cpus-per-task=%d", container.RuntimeConstraints.VCPUs),
224                 fmt.Sprintf("--tmp=%d", disk),
225         }
226 }
227
228 func (disp *Dispatcher) sbatchArgs(container arvados.Container) ([]string, error) {
229         var args []string
230         args = append(args, disp.cluster.Containers.SLURM.SbatchArgumentsList...)
231         args = append(args, "--job-name="+container.UUID, fmt.Sprintf("--nice=%d", initialNiceValue), "--no-requeue")
232
233         if disp.cluster == nil {
234                 // no instance types configured
235                 args = append(args, disp.slurmConstraintArgs(container)...)
236         } else if it, err := dispatchcloud.ChooseInstanceType(disp.cluster, &container); err == dispatchcloud.ErrInstanceTypesNotConfigured {
237                 // ditto
238                 args = append(args, disp.slurmConstraintArgs(container)...)
239         } else if err != nil {
240                 return nil, err
241         } else {
242                 // use instancetype constraint instead of slurm mem/cpu/tmp specs
243                 args = append(args, "--constraint=instancetype="+it.Name)
244         }
245
246         if len(container.SchedulingParameters.Partitions) > 0 {
247                 args = append(args, "--partition="+strings.Join(container.SchedulingParameters.Partitions, ","))
248         }
249
250         return args, nil
251 }
252
253 func (disp *Dispatcher) submit(container arvados.Container, crunchRunCommand []string) error {
254         // append() here avoids modifying crunchRunCommand's
255         // underlying array, which is shared with other goroutines.
256         crArgs := append([]string(nil), crunchRunCommand...)
257         crArgs = append(crArgs, container.UUID)
258         crScript := strings.NewReader(execScript(crArgs))
259
260         sbArgs, err := disp.sbatchArgs(container)
261         if err != nil {
262                 return err
263         }
264         log.Printf("running sbatch %+q", sbArgs)
265         return disp.slurm.Batch(crScript, sbArgs)
266 }
267
268 // Submit a container to the slurm queue (or resume monitoring if it's
269 // already in the queue).  Cancel the slurm job if the container's
270 // priority changes to zero or its state indicates it's no longer
271 // running.
272 func (disp *Dispatcher) runContainer(_ *dispatch.Dispatcher, ctr arvados.Container, status <-chan arvados.Container) error {
273         ctx, cancel := context.WithCancel(context.Background())
274         defer cancel()
275
276         if ctr.State == dispatch.Locked && !disp.sqCheck.HasUUID(ctr.UUID) {
277                 log.Printf("Submitting container %s to slurm", ctr.UUID)
278                 cmd := []string{disp.cluster.Containers.CrunchRunCommand}
279                 cmd = append(cmd, disp.cluster.Containers.CrunchRunArgumentsList...)
280                 err := disp.submit(ctr, cmd)
281                 if err != nil {
282                         return err
283                 }
284         }
285
286         log.Printf("Start monitoring container %v in state %q", ctr.UUID, ctr.State)
287         defer log.Printf("Done monitoring container %s", ctr.UUID)
288
289         // If the container disappears from the slurm queue, there is
290         // no point in waiting for further dispatch updates: just
291         // clean up and return.
292         go func(uuid string) {
293                 for ctx.Err() == nil && disp.sqCheck.HasUUID(uuid) {
294                 }
295                 cancel()
296         }(ctr.UUID)
297
298         for {
299                 select {
300                 case <-ctx.Done():
301                         // Disappeared from squeue
302                         if err := disp.Arv.Get("containers", ctr.UUID, nil, &ctr); err != nil {
303                                 log.Printf("error getting final container state for %s: %s", ctr.UUID, err)
304                         }
305                         switch ctr.State {
306                         case dispatch.Running:
307                                 disp.UpdateState(ctr.UUID, dispatch.Cancelled)
308                         case dispatch.Locked:
309                                 disp.Unlock(ctr.UUID)
310                         }
311                         return nil
312                 case updated, ok := <-status:
313                         if !ok {
314                                 log.Printf("container %s is done: cancel slurm job", ctr.UUID)
315                                 disp.scancel(ctr)
316                         } else if updated.Priority == 0 {
317                                 log.Printf("container %s has state %q, priority %d: cancel slurm job", ctr.UUID, updated.State, updated.Priority)
318                                 disp.scancel(ctr)
319                         } else {
320                                 p := int64(updated.Priority)
321                                 if p <= 1000 {
322                                         // API is providing
323                                         // user-assigned priority. If
324                                         // ctrs have equal priority,
325                                         // run the older one first.
326                                         p = int64(p)<<50 - (updated.CreatedAt.UnixNano() >> 14)
327                                 }
328                                 disp.sqCheck.SetPriority(ctr.UUID, p)
329                         }
330                 }
331         }
332 }
333 func (disp *Dispatcher) scancel(ctr arvados.Container) {
334         err := disp.slurm.Cancel(ctr.UUID)
335         if err != nil {
336                 log.Printf("scancel: %s", err)
337                 time.Sleep(time.Second)
338         } else if disp.sqCheck.HasUUID(ctr.UUID) {
339                 log.Printf("container %s is still in squeue after scancel", ctr.UUID)
340                 time.Sleep(time.Second)
341         }
342 }