What do you get from sacct -o jobid,elapsed,reason,exit -j 533900,533902
On Tue, May 12, 2020 at 4:12 PM Alastair Neil <ajneil.t...@gmail.com> wrote: > > The log is continuous and has all the messages logged by slurmd on the node > for all the jobs mentioned, below are the entries from the slurmctld log: > >> [2020-05-10T00:26:03.097] _slurm_rpc_kill_job: REQUEST_KILL_JOB JobId=533898 >> uid 1224431221 >> >> [2020-05-10T00:26:03.098] email msg to sshr...@masonlive.gmu.edu: Slurm >> Job_id=533898 Name=r18-relu-ent Ended, Run time 04:36:17, CANCELLED, >> ExitCode 0 >> [2020-05-10T00:26:03.098] job_signal: 9 of running JobId=533898 successful >> 0x8004 >> [2020-05-10T00:26:05.204] _job_complete: JobId=533902 WTERMSIG 9 >> [2020-05-10T00:26:05.204] email msg to sshr...@masonlive.gmu.edu: Slurm >> Job_id=533902 Name=r18-soft-ent Failed, Run time 04:30:39, FAILED >> [2020-05-10T00:26:05.205] _job_complete: JobId=533902 done >> [2020-05-10T00:26:05.210] _job_complete: JobId=533900 WTERMSIG 9 >> [2020-05-10T00:26:05.210] email msg to sshr...@masonlive.gmu.edu: Slurm >> Job_id=533900 Name=r18-soft Failed, Run time 04:32:51, FAILED >> [2020-05-10T00:26:05.215] _job_complete: JobId=533900 done > > > it is curious, that all the jobs were running on the same processor, perhaps > this is a cgroup related failure? > > On Tue, 12 May 2020 at 10:10, Steven Dick <kg4...@gmail.com> wrote: >> >> I see one job cancelled and two jobs failed. >> Your slurmd log is incomplete -- it doesn't show the two failed jobs >> exiting/failing, so the real error is not here. >> >> It might also be helpful to look through slurmctld's log starting from >> when the first job was canceled, looking at any messages mentioning >> the node or the two failed jobs. >> >> I've had nodes do strange things on job cancel. Last one I tracked >> down to the job epilog failing because it was NFS mounted and nfs was >> being slower than slurm liked, so it took the node offline and killed >> everything on it. >> >> On Mon, May 11, 2020 at 12:55 PM Alastair Neil <ajneil.t...@gmail.com> wrote: >> > >> > Hi there, >> > >> > We are using slurm 18.08 and had a weird occurrence over the weekend. A >> > user canceled one of his jobs using scancel, and two additional jobs of >> > the user running on the same node were killed concurrently. The jobs had >> > no dependency, but they were all allocated 1 gpu. I am curious to know why >> > this happened, and if this is a known bug is there a workaround to >> > prevent it happening? Any suggestions gratefully received. >> > >> > -Alastair >> > >> > FYI >> > The cancelled job (533898) has this at the end of the .err file: >> > >> >> slurmstepd: error: *** JOB 533898 ON NODE056 CANCELLED AT >> >> 2020-05-10T00:26:03 *** >> > >> > >> > both of the killed jobs (533900 and 533902) have this: >> > >> >> slurmstepd: error: get_exit_code task 0 died by signal >> > >> > >> > here is the slurmd log from the node and ths how-job output for each job: >> > >> >> [2020-05-09T19:49:46.735] _run_prolog: run job script took usec=4 >> >> [2020-05-09T19:49:46.735] _run_prolog: prolog with lock for job 533898 >> >> ran for 0 seconds >> >> [2020-05-09T19:49:46.754] ==================== >> >> [2020-05-09T19:49:46.754] batch_job:533898 job_mem:10240MB >> >> [2020-05-09T19:49:46.754] JobNode[0] CPU[0] Job alloc >> >> [2020-05-09T19:49:46.755] JobNode[0] CPU[1] Job alloc >> >> [2020-05-09T19:49:46.756] JobNode[0] CPU[2] Job alloc >> >> [2020-05-09T19:49:46.757] JobNode[0] CPU[3] Job alloc >> >> [2020-05-09T19:49:46.758] ==================== >> >> [2020-05-09T19:49:46.758] Launching batch job 533898 for UID 1224431221 >> >> [2020-05-09T19:53:14.060] _run_prolog: run job script took usec=3 >> >> [2020-05-09T19:53:14.060] _run_prolog: prolog with lock for job 533900 >> >> ran for 0 seconds >> >> [2020-05-09T19:53:14.080] ==================== >> >> [2020-05-09T19:53:14.080] batch_job:533900 job_mem:10240MB >> >> [2020-05-09T19:53:14.081] JobNode[0] CPU[4] Job alloc >> >> [2020-05-09T19:53:14.082] JobNode[0] CPU[5] Job alloc >> >> [2020-05-09T19:53:14.083] JobNode[0] CPU[6] Job alloc >> >> [2020-05-09T19:53:14.083] JobNode[0] CPU[7] Job alloc >> >> [2020-05-09T19:53:14.084] ==================== >> >> [2020-05-09T19:53:14.085] Launching batch job 533900 for UID 1224431221 >> >> [2020-05-09T19:55:26.283] _run_prolog: run job script took usec=21 >> >> [2020-05-09T19:55:26.284] _run_prolog: prolog with lock for job 533902 >> >> ran for 0 seconds >> >> [2020-05-09T19:55:26.304] ==================== >> >> [2020-05-09T19:55:26.304] batch_job:533902 job_mem:10240MB >> >> [2020-05-09T19:55:26.304] JobNode[0] CPU[8] Job alloc >> >> [2020-05-09T19:55:26.305] JobNode[0] CPU[9] Job alloc >> >> [2020-05-09T19:55:26.306] JobNode[0] CPU[10] Job alloc >> >> [2020-05-09T19:55:26.306] JobNode[0] CPU[11] Job alloc >> >> [2020-05-09T19:55:26.307] ==================== >> >> [2020-05-09T19:55:26.307] Launching batch job 533902 for UID 1224431221 >> >> [2020-05-10T00:26:03.127] [533898.extern] done with job >> >> [2020-05-10T00:26:03.975] [533898.batch] error: *** JOB 533898 ON NODE056 >> >> CANCELLED AT 2020-05-10T00:26:03 *** >> >> [2020-05-10T00:26:04.425] [533898.batch] sending >> >> REQUEST_COMPLETE_BATCH_SCRIPT, error:0 status 15 >> >> [2020-05-10T00:26:04.428] [533898.batch] done with job >> >> [2020-05-10T00:26:05.202] [533900.batch] error: get_exit_code task 0 died >> >> by signal >> >> [2020-05-10T00:26:05.202] [533902.batch] error: get_exit_code task 0 died >> >> by signal >> >> [2020-05-10T00:26:05.202] [533900.batch] sending >> >> REQUEST_COMPLETE_BATCH_SCRIPT, error:0 status 9 >> >> [2020-05-10T00:26:05.202] [533902.batch] sending >> >> REQUEST_COMPLETE_BATCH_SCRIPT, error:0 status 9 >> >> [2020-05-10T00:26:05.211] [533902.batch] done with job >> >> [2020-05-10T00:26:05.216] [533900.batch] done with job >> >> [2020-05-10T00:26:05.234] [533902.extern] done with job >> >> [2020-05-10T00:26:05.235] [533900.extern] done with job >> > >> > >> >> [root@node056 2020-05-10]# cat 533{898,900,902}/show-job.txt >> >> JobId=533898 JobName=r18-relu-ent >> >> UserId=sshres2(1224431221) GroupId=users(100) MCS_label=N/A >> >> Priority=19375 Nice=0 Account=csjkosecka QOS=csqos >> >> JobState=CANCELLED Reason=None Dependency=(null) >> >> Requeue=1 Restarts=0 BatchFlag=1 Reboot=0 ExitCode=0:15 >> >> RunTime=04:36:17 TimeLimit=5-00:00:00 TimeMin=N/A >> >> SubmitTime=2020-05-09T19:49:45 EligibleTime=2020-05-09T19:49:45 >> >> AccrueTime=2020-05-09T19:49:45 >> >> StartTime=2020-05-09T19:49:46 EndTime=2020-05-10T00:26:03 Deadline=N/A >> >> PreemptTime=None SuspendTime=None SecsPreSuspend=0 >> >> LastSchedEval=2020-05-09T19:49:46 >> >> Partition=gpuq AllocNode:Sid=ARGO-2:7221 >> >> ReqNodeList=(null) ExcNodeList=(null) >> >> NodeList=NODE056 >> >> BatchHost=NODE056 >> >> NumNodes=1 NumCPUs=4 NumTasks=0 CPUs/Task=4 ReqB:S:C:T=0:0:*:* >> >> TRES=cpu=4,mem=10G,node=1,billing=4,gres/gpu=1 >> >> Socks/Node=* NtasksPerN:B:S:C=0:0:*:* CoreSpec=* >> >> MinCPUsNode=4 MinMemoryNode=10G MinTmpDiskNode=0 >> >> Features=(null) DelayBoot=00:00:00 >> >> OverSubscribe=OK Contiguous=0 Licenses=(null) Network=(null) >> >> >> >> Command=/scratch/sshres2/workspace-scratch/cs747-project/command_resnet18_relu_ent.slurm >> >> WorkDir=/scratch/sshres2/workspace-scratch/cs747-project >> >> >> >> StdErr=/scratch/sshres2/workspace-scratch/cs747-project/logs_slurm/r18-relu-ent-533898.err >> >> StdIn=/dev/null >> >> >> >> StdOut=/scratch/sshres2/workspace-scratch/cs747-project/logs_slurm/r18-relu-ent-533898.out >> >> Power= >> >> TresPerNode=gpu:1 >> >> >> >> JobId=533900 JobName=r18-soft >> >> UserId=sshres2(1224431221) GroupId=users(100) MCS_label=N/A >> >> Priority=19375 Nice=0 Account=csjkosecka QOS=csqos >> >> JobState=FAILED Reason=JobLaunchFailure Dependency=(null) >> >> Requeue=1 Restarts=0 BatchFlag=1 Reboot=0 ExitCode=0:9 >> >> RunTime=04:32:51 TimeLimit=5-00:00:00 TimeMin=N/A >> >> SubmitTime=2020-05-09T19:53:13 EligibleTime=2020-05-09T19:53:13 >> >> AccrueTime=2020-05-09T19:53:13 >> >> StartTime=2020-05-09T19:53:14 EndTime=2020-05-10T00:26:05 Deadline=N/A >> >> PreemptTime=None SuspendTime=None SecsPreSuspend=0 >> >> LastSchedEval=2020-05-09T19:53:14 >> >> Partition=gpuq AllocNode:Sid=ARGO-2:7221 >> >> ReqNodeList=(null) ExcNodeList=(null) >> >> NodeList=NODE056 >> >> BatchHost=NODE056 >> >> NumNodes=1 NumCPUs=4 NumTasks=0 CPUs/Task=4 ReqB:S:C:T=0:0:*:* >> >> TRES=cpu=4,mem=10G,node=1,billing=4,gres/gpu=1 >> >> Socks/Node=* NtasksPerN:B:S:C=0:0:*:* CoreSpec=* >> >> MinCPUsNode=4 MinMemoryNode=10G MinTmpDiskNode=0 >> >> Features=(null) DelayBoot=00:00:00 >> >> OverSubscribe=OK Contiguous=0 Licenses=(null) Network=(null) >> >> >> >> Command=/scratch/sshres2/workspace-scratch/cs747-project/command_resnet18_soft.slurm >> >> WorkDir=/scratch/sshres2/workspace-scratch/cs747-project >> >> >> >> StdErr=/scratch/sshres2/workspace-scratch/cs747-project/logs_slurm/r18-soft-533900.err >> >> StdIn=/dev/null >> >> >> >> StdOut=/scratch/sshres2/workspace-scratch/cs747-project/logs_slurm/r18-soft-533900.out >> >> Power= >> >> TresPerNode=gpu:1 >> >> >> >> JobId=533902 JobName=r18-soft-ent >> >> UserId=sshres2(1224431221) GroupId=users(100) MCS_label=N/A >> >> Priority=19375 Nice=0 Account=csjkosecka QOS=csqos >> >> JobState=FAILED Reason=JobLaunchFailure Dependency=(null) >> >> Requeue=1 Restarts=0 BatchFlag=1 Reboot=0 ExitCode=0:9 >> >> RunTime=04:30:39 TimeLimit=5-00:00:00 TimeMin=N/A >> >> SubmitTime=2020-05-09T19:55:26 EligibleTime=2020-05-09T19:55:26 >> >> AccrueTime=2020-05-09T19:55:26 >> >> StartTime=2020-05-09T19:55:26 EndTime=2020-05-10T00:26:05 Deadline=N/A >> >> PreemptTime=None SuspendTime=None SecsPreSuspend=0 >> >> LastSchedEval=2020-05-09T19:55:26 >> >> Partition=gpuq AllocNode:Sid=ARGO-2:7221 >> >> ReqNodeList=(null) ExcNodeList=(null) >> >> NodeList=NODE056 >> >> BatchHost=NODE056 >> >> NumNodes=1 NumCPUs=4 NumTasks=0 CPUs/Task=4 ReqB:S:C:T=0:0:*:* >> >> TRES=cpu=4,mem=10G,node=1,billing=4,gres/gpu=1 >> >> Socks/Node=* NtasksPerN:B:S:C=0:0:*:* CoreSpec=* >> >> MinCPUsNode=4 MinMemoryNode=10G MinTmpDiskNode=0 >> >> Features=(null) DelayBoot=00:00:00 >> >> OverSubscribe=OK Contiguous=0 Licenses=(null) Network=(null) >> >> >> >> Command=/scratch/sshres2/workspace-scratch/cs747-project/command_resnet18_soft_ent.slurm >> >> WorkDir=/scratch/sshres2/workspace-scratch/cs747-project >> >> >> >> StdErr=/scratch/sshres2/workspace-scratch/cs747-project/logs_slurm/r18-soft-ent-533902.err >> >> StdIn=/dev/null >> >> >> >> StdOut=/scratch/sshres2/workspace-scratch/cs747-project/logs_slurm/r18-soft-ent-533902.out >> >> Power= >> >> TresPerNode=gpu:1 >> > >> > >> > >>