| Name | Theory_2390-1114462-46_1 |
| Workunit | 145051567 |
| Created | 16 Sep 2020, 6:51:51 UTC |
| Sent | 16 Sep 2020, 7:03:52 UTC |
| Report deadline | 27 Sep 2020, 7:03:52 UTC |
| Received | 28 Sep 2020, 13:28:50 UTC |
| Server state | Over |
| Outcome | Success |
| Client state | Done |
| Exit status | 0 (0x00000000) |
| Computer ID | 10653950 |
| Run time | 11 hours 27 min 57 sec |
| CPU time | 11 hours 13 min 22 sec |
| Validate state | Valid |
| Credit | 448.54 |
| Device peak FLOPS | 4.69 GFLOPS |
| Application version | Theory Simulation v300.06 (vbox64_theory) windows_x86_64 |
| Peak working set size | 58.51 MB |
| Peak swap size | 55.40 MB |
| Peak disk usage | 2.48 GB |
Stderr output
<core_client_version>7.16.11</core_client_version> <![CDATA[ <stderr_txt> 8784ee4e3, slot#7) 2020-09-16 15:49:01 (13688): Successfully started VM. (PID = '3976') 2020-09-16 15:49:01 (13688): Reporting VM Process ID to BOINC. 2020-09-16 15:49:01 (13688): VM state change detected. (old = 'PoweredOff', new = 'Running') 2020-09-16 15:49:01 (13688): Detected: Web Application Enabled (http://localhost:64856) 2020-09-16 15:49:01 (13688): Status Report: Job Duration: '864000.000000' 2020-09-16 15:49:01 (13688): Status Report: Elapsed Time: '13717.881782' 2020-09-16 15:49:01 (13688): Status Report: CPU Time: '14012.625000' 2020-09-16 15:49:01 (13688): Preference change detected 2020-09-16 15:49:01 (13688): Setting CPU throttle for VM. (100%) 2020-09-16 15:49:01 (13688): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2020-09-16 15:59:32 (13688): VM state change detected. (old = 'Running', new = 'Paused') 2020-09-16 15:59:32 (13688): Stopping VM. 2020-09-16 16:04:32 (8992): Detected: vboxwrapper 26197 2020-09-16 16:04:32 (8992): Detected: BOINC client v7.7 2020-09-16 16:04:32 (8992): Detected: VirtualBox VboxManage Interface (Version: 6.1.12) 2020-09-16 16:04:33 (8992): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2020-09-16 16:04:33 (8992): Starting VM using VBoxManage interface. (boinc_87dfd748784ee4e3, slot#7) 2020-09-16 16:04:38 (8992): Successfully started VM. (PID = '14980') 2020-09-16 16:04:38 (8992): Reporting VM Process ID to BOINC. 2020-09-16 16:04:38 (8992): VM state change detected. (old = 'PoweredOff', new = 'Running') 2020-09-16 16:04:38 (8992): Detected: Web Application Enabled (http://localhost:64856) 2020-09-16 16:04:39 (8992): Status Report: Job Duration: '864000.000000' 2020-09-16 16:04:39 (8992): Status Report: Elapsed Time: '14260.631967' 2020-09-16 16:04:39 (8992): Status Report: CPU Time: '14637.453125' 2020-09-16 16:04:39 (8992): Preference change detected 2020-09-16 16:04:39 (8992): Setting CPU throttle for VM. (100%) 2020-09-16 16:04:40 (8992): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2020-09-16 16:14:55 (8992): Stopping VM. 2020-09-16 16:19:54 (4112): Detected: vboxwrapper 26197 2020-09-16 16:19:54 (4112): Detected: BOINC client v7.7 2020-09-16 16:19:55 (4112): Detected: VirtualBox VboxManage Interface (Version: 6.1.12) 2020-09-16 16:19:55 (4112): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2020-09-16 16:19:55 (4112): Starting VM using VBoxManage interface. (boinc_87dfd748784ee4e3, slot#7) 2020-09-16 16:20:01 (4112): Successfully started VM. (PID = '8448') 2020-09-16 16:20:01 (4112): Reporting VM Process ID to BOINC. 2020-09-16 16:20:01 (4112): VM state change detected. (old = 'PoweredOff', new = 'Running') 2020-09-16 16:20:01 (4112): Detected: Web Application Enabled (http://localhost:64856) 2020-09-16 16:20:01 (4112): Status Report: Job Duration: '864000.000000' 2020-09-16 16:20:01 (4112): Status Report: Elapsed Time: '14847.578107' 2020-09-16 16:20:01 (4112): Status Report: CPU Time: '15251.718750' 2020-09-16 16:20:01 (4112): Preference change detected 2020-09-16 16:20:01 (4112): Setting CPU throttle for VM. (100%) 2020-09-16 16:20:01 (4112): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2020-09-16 16:35:24 (4112): VM state change detected. (old = 'Running', new = 'Paused') 2020-09-16 20:16:43 (3000): Detected: vboxwrapper 26197 2020-09-16 20:16:43 (3000): Detected: BOINC client v7.7 2020-09-16 20:16:44 (3000): Detected: VirtualBox VboxManage Interface (Version: 6.1.12) 2020-09-16 20:16:45 (3000): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2020-09-16 20:16:45 (3000): Starting VM using VBoxManage interface. (boinc_87dfd748784ee4e3, slot#7) 2020-09-16 20:16:48 (3000): Successfully started VM. (PID = '1748') 2020-09-16 20:16:48 (3000): Reporting VM Process ID to BOINC. 2020-09-16 20:16:48 (3000): Guest Log: BIOS: VirtualBox 6.1.12 2020-09-16 20:16:48 (3000): Guest Log: CPUID EDX: 0x178bfbff 2020-09-16 20:16:48 (3000): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63 2020-09-16 20:16:48 (3000): VM state change detected. (old = 'PoweredOff', new = 'Running') 2020-09-16 20:16:48 (3000): Detected: Web Application Enabled (http://localhost:64856) 2020-09-16 20:16:48 (3000): Status Report: Job Duration: '864000.000000' 2020-09-16 20:16:48 (3000): Status Report: Elapsed Time: '15724.578107' 2020-09-16 20:16:48 (3000): Status Report: CPU Time: '16148.765625' 2020-09-16 20:16:48 (3000): Preference change detected 2020-09-16 20:16:48 (3000): Setting CPU throttle for VM. (100%) 2020-09-16 20:16:49 (3000): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2020-09-16 20:16:50 (3000): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2020-09-16 20:16:50 (3000): Guest Log: BIOS: Booting from Hard Disk... 2020-09-16 20:16:52 (3000): Guest Log: BIOS: KBD: unsupported int 16h function 03 2020-09-16 20:16:52 (3000): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2020-09-16 20:16:53 (3000): VM state change detected. (old = 'Running', new = 'Paused') 2020-09-16 20:17:03 (3000): VM state change detected. (old = 'Paused', new = 'Running') 2020-09-16 20:17:19 (3000): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2020-09-16 20:17:19 (3000): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2020-09-16 20:17:22 (3000): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log 2020-09-16 20:17:22 (3000): Guest Log: 00:00:00.000079 main Log opened 2020-09-16T18:17:18.201138000Z 2020-09-16 20:17:22 (3000): Guest Log: 00:00:00.000171 main OS Product: Linux 2020-09-16 20:17:22 (3000): Guest Log: 00:00:00.000199 main OS Release: 4.14.76-13.cernvm.x86_64 2020-09-16 20:17:22 (3000): Guest Log: 00:00:00.000222 main OS Version: #1 SMP Tue Oct 16 18:26:15 CEST 2018 2020-09-16 20:17:22 (3000): Guest Log: 00:00:00.000253 main Executable: /usr/sbin/VBoxService 2020-09-16 20:17:22 (3000): Guest Log: 00:00:00.000254 main Process ID: 3209 2020-09-16 20:17:22 (3000): Guest Log: 00:00:00.000255 main Package type: LINUX_64BITS_GENERIC 2020-09-16 20:17:22 (3000): Guest Log: 00:00:00.002125 main 5.2.6 r120293 started. Verbose level = 0 2020-09-16 20:17:45 (3000): Guest Log: 20:17:41 CEST +02:00 2020-09-16: cranky: [INFO] Detected Theory App 2020-09-16 20:17:45 (3000): Guest Log: 20:17:41 CEST +02:00 2020-09-16: cranky: [INFO] Checking CVMFS. 2020-09-16 20:17:46 (3000): Guest Log: Probing /cvmfs/sft.cern.ch... OK 2020-09-16 20:17:46 (3000): Guest Log: VERSION PID UPTIME(M) MEM(K) REVISION EXPIRES(M) NOCATALOGS CACHEUSE(K) CACHEMAX(K) NOFDUSE NOFDMAX NOIOERR NOOPEN HITRATE(%) RX(K) SPEED(K/S) HOST PROXY ONLINE 2020-09-16 20:17:46 (3000): Guest Log: 2.5.2.0 4083 0 28384 18935 3 1 1293257 4096001 0 65024 0 0 n/a 5 11 http://s1cern-cvmfs.openhtc.io/cvmfs/sft.cern.ch DIRECT 1 2020-09-16 20:17:47 (3000): Guest Log: Probing /cvmfs/grid.cern.ch... OK 2020-09-16 20:17:48 (3000): Guest Log: VERSION PID UPTIME(M) MEM(K) REVISION EXPIRES(M) NOCATALOGS CACHEUSE(K) CACHEMAX(K) NOFDUSE NOFDMAX NOIOERR NOOPEN HITRATE(%) RX(K) SPEED(K/S) HOST PROXY ONLINE 2020-09-16 20:17:48 (3000): Guest Log: 2.5.2.0 4058 0 27584 13227 3 2 1293257 4096001 0 65024 0 2 0 4274 2047 http://s1cern-cvmfs.openhtc.io/cvmfs/grid.cern.ch DIRECT 1 2020-09-16 20:17:48 (3000): Guest Log: Probing /cvmfs/cernvm-prod.cern.ch... OK 2020-09-16 20:17:49 (3000): Guest Log: VERSION PID UPTIME(M) MEM(K) REVISION EXPIRES(M) NOCATALOGS CACHEUSE(K) CACHEMAX(K) NOFDUSE NOFDMAX NOIOERR NOOPEN HITRATE(%) RX(K) SPEED(K/S) HOST PROXY ONLINE 2020-09-16 20:17:49 (3000): Guest Log: 2.5.2.0 4036 0 27220 257 3 1 1293257 4096001 0 65024 0 0 n/a 4 5 http://s1bnl-cvmfs.openhtc.io/cvmfs/cernvm-prod.cern.ch DIRECT 1 2020-09-16 20:17:49 (3000): Guest Log: Probing /cvmfs/alice.cern.ch... OK 2020-09-16 20:17:50 (3000): Guest Log: VERSION PID UPTIME(M) MEM(K) REVISION EXPIRES(M) NOCATALOGS CACHEUSE(K) CACHEMAX(K) NOFDUSE NOFDMAX NOIOERR NOOPEN HITRATE(%) RX(K) SPEED(K/S) HOST PROXY ONLINE 2020-09-16 20:17:50 (3000): Guest Log: 2.5.2.0 4109 0 30060 7471 3 1 1293257 4096001 0 65024 0 0 n/a 4371 2420 http://s1asgc-cvmfs.openhtc.io:8080/cvmfs/alice.cern.ch DIRECT 1 2020-09-16 20:17:50 (3000): Guest Log: 20:17:46 CEST +02:00 2020-09-16: cranky: [INFO] Checking runc. 2020-09-16 20:17:50 (3000): Guest Log: 20:17:46 CEST +02:00 2020-09-16: cranky: [INFO] Creating the filesystem. 2020-09-16 20:17:50 (3000): Guest Log: 20:17:46 CEST +02:00 2020-09-16: cranky: [INFO] Using /cvmfs/cernvm-prod.cern.ch/cvm3 2020-09-16 20:17:51 (3000): Guest Log: 20:17:46 CEST +02:00 2020-09-16: cranky: [INFO] Updating config.json. 2020-09-16 20:17:51 (3000): Guest Log: 20:17:46 CEST +02:00 2020-09-16: cranky: [INFO] Running Container 'runc'. 2020-09-16 20:17:51 (3000): Guest Log: job: htmld=/shared/html/job 2020-09-16 20:17:51 (3000): Guest Log: job: unpack exitcode=0 2020-09-16 20:17:53 (3000): Guest Log: 20:17:48 CEST +02:00 2020-09-16: cranky: [INFO] ===> [runRivet] Wed Sep 16 18:17:47 UTC 2020 [boinc pp jets 7000 250 - pythia8 8.235 default-CD 100000 46] 2020-09-16 20:32:04 (3000): VM state change detected. (old = 'Running', new = 'Paused') 2020-09-16 20:32:04 (3000): Stopping VM. 2020-09-16 20:37:04 (1444): Detected: vboxwrapper 26197 2020-09-16 20:37:04 (1444): Detected: BOINC client v7.7 2020-09-16 20:37:04 (1444): Detected: VirtualBox VboxManage Interface (Version: 6.1.12) 2020-09-16 20:37:04 (1444): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2020-09-16 20:37:05 (1444): Starting VM using VBoxManage interface. (boinc_87dfd748784ee4e3, slot#7) 2020-09-16 20:37:11 (1444): Successfully started VM. (PID = '13592') 2020-09-16 20:37:11 (1444): Reporting VM Process ID to BOINC. 2020-09-16 20:37:11 (1444): VM state change detected. (old = 'PoweredOff', new = 'Running') 2020-09-16 20:37:11 (1444): Detected: Web Application Enabled (http://localhost:64856) 2020-09-16 20:37:11 (1444): Status Report: Job Duration: '864000.000000' 2020-09-16 20:37:11 (1444): Status Report: Elapsed Time: '16618.578107' 2020-09-16 20:37:11 (1444): Status Report: CPU Time: '16952.515625' 2020-09-16 20:37:11 (1444): Preference change detected 2020-09-16 20:37:11 (1444): Setting CPU throttle for VM. (100%) 2020-09-16 20:37:12 (1444): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2020-09-16 20:47:33 (1444): VM state change detected. (old = 'Running', new = 'Paused') 2020-09-16 20:47:40 (1444): Error in resume VM for VM: -2135228414 Command: VBoxManage -q controlvm "boinc_87dfd748784ee4e3" resume Output: VBoxManage.exe: error: Cannot resume the machine as it is not paused (machine state: Running) VBoxManage.exe: error: Details: code VBOX_E_INVALID_VM_STATE (0x80bb0002), component ConsoleWrap, interface IConsole, callee IUnknown VBoxManage.exe: error: Context: "Resume()" at line 410 of file VBoxManageControlVM.cpp 2020-09-16 20:47:40 (1444): VM state change detected. (old = 'Paused', new = 'Running') 2020-09-16 20:47:40 (1444): Stopping VM. 2020-09-16 20:52:34 (8024): Detected: vboxwrapper 26197 2020-09-16 20:52:34 (8024): Detected: BOINC client v7.7 2020-09-16 20:52:35 (8024): Detected: VirtualBox VboxManage Interface (Version: 6.1.12) 2020-09-16 20:52:35 (8024): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2020-09-16 20:52:35 (8024): Starting VM using VBoxManage interface. (boinc_87dfd748784ee4e3, slot#7) 2020-09-16 20:52:41 (8024): Successfully started VM. (PID = '12956') 2020-09-16 20:52:41 (8024): Reporting VM Process ID to BOINC. 2020-09-16 20:52:41 (8024): VM state change detected. (old = 'PoweredOff', new = 'Running') 2020-09-16 20:52:41 (8024): Detected: Web Application Enabled (http://localhost:64856) 2020-09-16 20:52:41 (8024): Status Report: Job Duration: '864000.000000' 2020-09-16 20:52:41 (8024): Status Report: Elapsed Time: '17220.420795' 2020-09-16 20:52:41 (8024): Status Report: CPU Time: '17577.781250' 2020-09-16 20:52:41 (8024): Preference change detected 2020-09-16 20:52:41 (8024): Setting CPU throttle for VM. (100%) 2020-09-16 20:52:41 (8024): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2020-09-16 21:03:04 (8024): VM state change detected. (old = 'Running', new = 'Paused') 2020-09-16 21:03:10 (8024): Error in resume VM for VM: -2135228414 Command: VBoxManage -q controlvm "boinc_87dfd748784ee4e3" resume Output: VBoxManage.exe: error: Cannot resume the machine as it is not paused (machine state: Running) VBoxManage.exe: error: Details: code VBOX_E_INVALID_VM_STATE (0x80bb0002), component ConsoleWrap, interface IConsole, callee IUnknown VBoxManage.exe: error: Context: "Resume()" at line 410 of file VBoxManageControlVM.cpp 2020-09-16 21:03:10 (8024): VM state change detected. (old = 'Paused', new = 'Running') 2020-09-16 21:03:10 (8024): Stopping VM. 2020-09-16 21:08:04 (15348): Detected: vboxwrapper 26197 2020-09-16 21:08:04 (15348): Detected: BOINC client v7.7 2020-09-16 21:08:04 (15348): Detected: VirtualBox VboxManage Interface (Version: 6.1.12) 2020-09-16 21:08:05 (15348): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2020-09-16 21:08:05 (15348): Starting VM using VBoxManage interface. (boinc_87dfd748784ee4e3, slot#7) 2020-09-16 21:08:10 (15348): Successfully started VM. (PID = '13240') 2020-09-16 21:08:10 (15348): Reporting VM Process ID to BOINC. 2020-09-16 21:08:10 (15348): VM state change detected. (old = 'PoweredOff', new = 'Running') 2020-09-16 21:08:10 (15348): Detected: Web Application Enabled (http://localhost:64856) 2020-09-16 21:08:10 (15348): Status Report: Job Duration: '864000.000000' 2020-09-16 21:08:10 (15348): Status Report: Elapsed Time: '17837.552953' 2020-09-16 21:08:10 (15348): Status Report: CPU Time: '18197.156250' 2020-09-16 21:08:10 (15348): Preference change detected 2020-09-16 21:08:10 (15348): Setting CPU throttle for VM. (100%) 2020-09-16 21:08:11 (15348): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2020-09-16 21:08:12 (15348): VM state change detected. (old = 'Running', new = 'Paused') 2020-09-16 21:08:22 (15348): VM state change detected. (old = 'Paused', new = 'Running') 2020-09-16 21:18:34 (15348): Stopping VM. 2020-09-16 21:23:34 (12464): Detected: vboxwrapper 26197 2020-09-16 21:23:34 (12464): Detected: BOINC client v7.7 2020-09-16 21:23:34 (12464): Detected: VirtualBox VboxManage Interface (Version: 6.1.12) 2020-09-16 21:23:34 (12464): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2020-09-16 21:23:35 (12464): Starting VM using VBoxManage interface. (boinc_87dfd748784ee4e3, slot#7) 2020-09-16 21:23:40 (12464): Successfully started VM. (PID = '1084') 2020-09-16 21:23:40 (12464): Reporting VM Process ID to BOINC. 2020-09-16 21:23:40 (12464): VM state change detected. (old = 'PoweredOff', new = 'Running') 2020-09-16 21:23:40 (12464): Detected: Web Application Enabled (http://localhost:64856) 2020-09-16 21:23:40 (12464): Status Report: Job Duration: '864000.000000' 2020-09-16 21:23:40 (12464): Status Report: Elapsed Time: '18355.552953' 2020-09-16 21:23:40 (12464): Status Report: CPU Time: '18804.468750' 2020-09-16 21:23:40 (12464): Preference change detected 2020-09-16 21:23:40 (12464): Setting CPU throttle for VM. (100%) 2020-09-16 21:23:40 (12464): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2020-09-16 21:34:06 (12464): Stopping VM. 2020-09-16 21:39:06 (14768): Detected: vboxwrapper 26197 2020-09-16 21:39:06 (14768): Detected: BOINC client v7.7 2020-09-16 21:39:07 (14768): Detected: VirtualBox VboxManage Interface (Version: 6.1.12) 2020-09-16 21:39:07 (14768): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2020-09-16 21:39:07 (14768): Starting VM using VBoxManage interface. (boinc_87dfd748784ee4e3, slot#7) 2020-09-16 21:39:13 (14768): Successfully started VM. (PID = '11160') 2020-09-16 21:39:13 (14768): Reporting VM Process ID to BOINC. 2020-09-16 21:39:13 (14768): VM state change detected. (old = 'PoweredOff', new = 'Running') 2020-09-16 21:39:13 (14768): Detected: Web Application Enabled (http://localhost:64856) 2020-09-16 21:39:13 (14768): Status Report: Job Duration: '864000.000000' 2020-09-16 21:39:13 (14768): Status Report: Elapsed Time: '18907.465955' 2020-09-16 21:39:13 (14768): Status Report: CPU Time: '19424.578125' 2020-09-16 21:39:13 (14768): Preference change detected 2020-09-16 21:39:13 (14768): Setting CPU throttle for VM. (100%) 2020-09-16 21:39:13 (14768): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2020-09-16 21:49:33 (14768): VM state change detected. (old = 'Running', new = 'Paused') 2020-09-16 21:49:40 (14768): Error in resume VM for VM: -2135228414 Command: VBoxManage -q controlvm "boinc_87dfd748784ee4e3" resume Output: VBoxManage.exe: error: Cannot resume the machine as it is not paused (machine state: Running) VBoxManage.exe: error: Details: code VBOX_E_INVALID_VM_STATE (0x80bb0002), component ConsoleWrap, interface IConsole, callee IUnknown VBoxManage.exe: error: Context: "Resume()" at line 410 of file VBoxManageControlVM.cpp 2020-09-16 21:49:40 (14768): VM state change detected. (old = 'Paused', new = 'Running') 2020-09-16 21:49:40 (14768): Stopping VM. 2020-09-16 21:54:34 (13396): Detected: vboxwrapper 26197 2020-09-16 21:54:34 (13396): Detected: BOINC client v7.7 2020-09-16 21:54:34 (13396): Detected: VirtualBox VboxManage Interface (Version: 6.1.12) 2020-09-16 21:54:34 (13396): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2020-09-16 21:54:35 (13396): Starting VM using VBoxManage interface. (boinc_87dfd748784ee4e3, slot#7) 2020-09-16 21:54:40 (13396): Successfully started VM. (PID = '5488') 2020-09-16 21:54:40 (13396): Reporting VM Process ID to BOINC. 2020-09-16 21:54:40 (13396): VM state change detected. (old = 'PoweredOff', new = 'Running') 2020-09-16 21:54:40 (13396): Detected: Web Application Enabled (http://localhost:64856) 2020-09-16 21:54:40 (13396): Status Report: Job Duration: '864000.000000' 2020-09-16 21:54:40 (13396): Status Report: Elapsed Time: '19470.231757' 2020-09-16 21:54:40 (13396): Status Report: CPU Time: '20055.078125' 2020-09-16 21:54:40 (13396): Preference change detected 2020-09-16 21:54:40 (13396): Setting CPU throttle for VM. (100%) 2020-09-16 21:54:42 (13396): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2020-09-16 22:05:04 (13396): Stopping VM. 2020-09-16 22:10:04 (16028): Detected: vboxwrapper 26197 2020-09-16 22:10:04 (16028): Detected: BOINC client v7.7 2020-09-16 22:10:04 (16028): Detected: VirtualBox VboxManage Interface (Version: 6.1.12) 2020-09-16 22:10:05 (16028): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2020-09-16 22:10:05 (16028): Starting VM using VBoxManage interface. (boinc_87dfd748784ee4e3, slot#7) 2020-09-16 22:10:11 (16028): Successfully started VM. (PID = '2552') 2020-09-16 22:10:11 (16028): Reporting VM Process ID to BOINC. 2020-09-16 22:10:11 (16028): VM state change detected. (old = 'PoweredOff', new = 'Running') 2020-09-16 22:10:11 (16028): Detected: Web Application Enabled (http://localhost:64856) 2020-09-16 22:10:11 (16028): Status Report: Job Duration: '864000.000000' 2020-09-16 22:10:11 (16028): Status Report: Elapsed Time: '20036.336985' 2020-09-16 22:10:11 (16028): Status Report: CPU Time: '20677.187500' 2020-09-16 22:10:11 (16028): Preference change detected 2020-09-16 22:10:11 (16028): Setting CPU throttle for VM. (100%) 2020-09-16 22:10:11 (16028): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2020-09-16 22:10:13 (16028): VM state change detected. (old = 'Running', new = 'Paused') 2020-09-16 22:10:23 (16028): VM state change detected. (old = 'Paused', new = 'Running') 2020-09-16 22:20:42 (16028): VM state change detected. (old = 'Running', new = 'Paused') 2020-09-16 22:20:42 (16028): Stopping VM. 2020-09-16 22:50:19 (10520): Detected: vboxwrapper 26197 2020-09-16 22:50:19 (10520): Detected: BOINC client v7.7 2020-09-16 22:50:20 (10520): Detected: VirtualBox VboxManage Interface (Version: 6.1.12) 2020-09-16 22:50:20 (10520): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2020-09-16 22:50:21 (10520): Starting VM using VBoxManage interface. (boinc_87dfd748784ee4e3, slot#7) 2020-09-16 22:50:27 (10520): Successfully started VM. (PID = '2992') 2020-09-16 22:50:27 (10520): Reporting VM Process ID to BOINC. 2020-09-16 22:50:27 (10520): VM state change detected. (old = 'PoweredOff', new = 'Running') 2020-09-16 22:50:27 (10520): Detected: Web Application Enabled (http://localhost:64856) 2020-09-16 22:50:28 (10520): VM state change detected. (old = 'Running', new = 'Paused') 2020-09-16 22:50:36 (10520): Status Report: Job Duration: '864000.000000' 2020-09-16 22:50:36 (10520): Status Report: Elapsed Time: '20613.336985' 2020-09-16 22:50:36 (10520): Status Report: CPU Time: '21298.453125' 2020-09-16 22:50:36 (10520): Preference change detected 2020-09-16 22:50:36 (10520): Setting CPU throttle for VM. (100%) 2020-09-16 22:50:36 (10520): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2020-09-16 22:50:37 (10520): VM state change detected. (old = 'Paused', new = 'Running') 2020-09-16 22:50:38 (10520): Guest Log: 01:27:41.838962 timesync vgsvcTimeSyncWorker: Radical host time change: 1 803 261 000 000ns (HostNow=1 600 289 437 965 000 000 ns HostLast=1 600 287 634 704 000 000 ns) 2020-09-16 22:50:48 (10520): Guest Log: 01:27:51.846852 timesync vgsvcTimeSyncWorker: Radical guest time change: 1 803 279 513 000ns (GuestNow=1 600 289 447 985 523 000 ns GuestLast=1 600 287 644 706 010 000 ns fSetTimeLastLoop=true ) 2020-09-16 23:11:35 (10520): VM state change detected. (old = 'Running', new = 'Paused') 2020-09-16 23:11:35 (10520): Stopping VM. 2020-09-17 03:11:39 (10520): VM did not stop when requested. 2020-09-17 03:11:39 (10520): VM was NOT successfully terminated. 2020-09-17 03:11:43 (1136): Detected: vboxwrapper 26197 2020-09-17 03:11:43 (1136): Detected: BOINC client v7.7 2020-09-17 03:11:44 (1136): Detected: VirtualBox VboxManage Interface (Version: 6.1.12) 2020-09-17 03:11:44 (1136): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2020-09-17 03:11:44 (1136): Starting VM using VBoxManage interface. (boinc_87dfd748784ee4e3, slot#7) 2020-09-17 03:11:50 (1136): Successfully started VM. (PID = '10700') 2020-09-17 03:11:50 (1136): Reporting VM Process ID to BOINC. 2020-09-17 03:11:50 (1136): VM state change detected. (old = 'PoweredOff', new = 'Running') 2020-09-17 03:11:50 (1136): Detected: Web Application Enabled (http://localhost:64856) 2020-09-17 03:11:51 (1136): VM state change detected. (old = 'Running', new = 'Paused') 2020-09-17 08:35:45 (1136): Status Report: Job Duration: '864000.000000' 2020-09-17 08:35:45 (1136): Status Report: Elapsed Time: '21812.087172' 2020-09-17 08:35:45 (1136): Status Report: CPU Time: '22550.125000' 2020-09-17 08:35:45 (1136): Preference change detected 2020-09-17 08:35:45 (1136): Setting CPU throttle for VM. (100%) 2020-09-17 08:35:45 (1136): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2020-09-17 08:35:46 (1136): VM state change detected. (old = 'Paused', new = 'Running') 2020-09-17 08:35:48 (1136): Guest Log: 01:48:42.247062 timesync vgsvcTimeSyncWorker: Radical host time change: 33 859 324 000 000ns (HostNow=1 600 324 547 709 000 000 ns HostLast=1 600 290 688 385 000 000 ns) 2020-09-17 08:35:58 (1136): Guest Log: 01:48:52.252946 timesync vgsvcTimeSyncWorker: Radical guest time change: 33 859 329 175 000ns (GuestNow=1 600 324 557 714 891 000 ns GuestLast=1 600 290 698 385 716 000 ns fSetTimeLastLoop=true ) 2020-09-17 09:01:58 (1136): VM state change detected. (old = 'Running', new = 'Paused') 2020-09-17 09:02:10 (1136): Error in resume VM for VM: -2135228414 Command: VBoxManage -q controlvm "boinc_87dfd748784ee4e3" resume Output: VBoxManage.exe: error: Cannot resume the machine as it is not paused (machine state: Running) VBoxManage.exe: error: Details: code VBOX_E_INVALID_VM_STATE (0x80bb0002), component ConsoleWrap, interface IConsole, callee IUnknown VBoxManage.exe: error: Context: "Resume()" at line 410 of file VBoxManageControlVM.cpp 2020-09-17 09:02:10 (1136): VM state change detected. (old = 'Paused', new = 'Running') 2020-09-17 09:02:10 (1136): Stopping VM. 2020-09-17 09:06:58 (2544): Detected: vboxwrapper 26197 2020-09-17 09:06:58 (2544): Detected: BOINC client v7.7 2020-09-17 09:06:59 (2544): Detected: VirtualBox VboxManage Interface (Version: 6.1.12) 2020-09-17 09:06:59 (2544): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2020-09-17 09:06:59 (2544): Starting VM using VBoxManage interface. (boinc_87dfd748784ee4e3, slot#7) 2020-09-17 09:07:05 (2544): Successfully started VM. (PID = '13784') 2020-09-17 09:07:05 (2544): Reporting VM Process ID to BOINC. 2020-09-17 09:07:05 (2544): VM state change detected. (old = 'PoweredOff', new = 'Running') 2020-09-17 09:07:05 (2544): Detected: Web Application Enabled (http://localhost:64856) 2020-09-17 09:07:05 (2544): Status Report: Job Duration: '864000.000000' 2020-09-17 09:07:05 (2544): Status Report: Elapsed Time: '23276.836382' 2020-09-17 09:07:05 (2544): Status Report: CPU Time: '24108.703125' 2020-09-17 09:07:05 (2544): Preference change detected 2020-09-17 09:07:05 (2544): Setting CPU throttle for VM. (100%) 2020-09-17 09:07:07 (2544): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2020-09-17 09:17:24 (2544): VM state change detected. (old = 'Running', new = 'Paused') 2020-09-17 09:17:31 (2544): Error in resume VM for VM: -2135228414 Command: VBoxManage -q controlvm "boinc_87dfd748784ee4e3" resume Output: VBoxManage.exe: error: Cannot resume the machine as it is not paused (machine state: Running) VBoxManage.exe: error: Details: code VBOX_E_INVALID_VM_STATE (0x80bb0002), component ConsoleWrap, interface IConsole, callee IUnknown VBoxManage.exe: error: Context: "Resume()" at line 410 of file VBoxManageControlVM.cpp 2020-09-17 09:17:31 (2544): VM state change detected. (old = 'Paused', new = 'Running') 2020-09-17 09:17:31 (2544): Stopping VM. 2020-09-17 09:22:25 (7936): Detected: vboxwrapper 26197 2020-09-17 09:22:25 (7936): Detected: BOINC client v7.7 2020-09-17 09:22:25 (7936): Detected: VirtualBox VboxManage Interface (Version: 6.1.12) 2020-09-17 09:22:26 (7936): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2020-09-17 09:22:26 (7936): Starting VM using VBoxManage interface. (boinc_87dfd748784ee4e3, slot#7) 2020-09-17 09:22:32 (7936): Successfully started VM. (PID = '3388') 2020-09-17 09:22:32 (7936): Reporting VM Process ID to BOINC. 2020-09-17 09:22:32 (7936): VM state change detected. (old = 'PoweredOff', new = 'Running') 2020-09-17 09:22:32 (7936): Detected: Web Application Enabled (http://localhost:64856) 2020-09-17 09:22:33 (7936): VM state change detected. (old = 'Running', new = 'Paused') 2020-09-17 09:22:43 (7936): Status Report: Job Duration: '864000.000000' 2020-09-17 09:22:43 (7936): Status Report: Elapsed Time: '23727.822983' 2020-09-17 09:22:43 (7936): Status Report: CPU Time: '24725.390625' 2020-09-17 09:22:43 (7936): Preference change detected 2020-09-17 09:22:43 (7936): Setting CPU throttle for VM. (100%) 2020-09-17 09:22:46 (7936): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2020-09-17 09:22:46 (7936): VM state change detected. (old = 'Paused', new = 'Running') 2020-09-17 09:32:56 (7936): VM state change detected. (old = 'Running', new = 'Paused') 2020-09-17 09:33:03 (7936): Error in resume VM for VM: -2135228414 Command: VBoxManage -q controlvm "boinc_87dfd748784ee4e3" resume Output: VBoxManage.exe: error: Cannot resume the machine as it is not paused (machine state: Running) VBoxManage.exe: error: Details: code VBOX_E_INVALID_VM_STATE (0x80bb0002), component ConsoleWrap, interface IConsole, callee IUnknown VBoxManage.exe: error: Context: "Resume()" at line 410 of file VBoxManageControlVM.cpp 2020-09-17 09:33:03 (7936): VM state change detected. (old = 'Paused', new = 'Running') 2020-09-17 09:33:03 (7936): Stopping VM. 2020-09-17 09:37:56 (12568): Detected: vboxwrapper 26197 2020-09-17 09:37:56 (12568): Detected: BOINC client v7.7 2020-09-17 09:37:57 (12568): Detected: VirtualBox VboxManage Interface (Version: 6.1.12) 2020-09-17 09:37:57 (12568): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2020-09-17 09:37:58 (12568): Starting VM using VBoxManage interface. (boinc_87dfd748784ee4e3, slot#7) 2020-09-17 09:38:03 (12568): Successfully started VM. (PID = '15856') 2020-09-17 09:38:03 (12568): Reporting VM Process ID to BOINC. 2020-09-17 09:38:03 (12568): VM state change detected. (old = 'PoweredOff', new = 'Running') 2020-09-17 09:38:03 (12568): Detected: Web Application Enabled (http://localhost:64856) 2020-09-17 09:38:03 (12568): Status Report: Job Duration: '864000.000000' 2020-09-17 09:38:03 (12568): Status Report: Elapsed Time: '24234.797116' 2020-09-17 09:38:03 (12568): Status Report: CPU Time: '25350.218750' 2020-09-17 09:38:03 (12568): Preference change detected 2020-09-17 09:38:03 (12568): Setting CPU throttle for VM. (100%) 2020-09-17 09:38:04 (12568): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2020-09-17 09:38:05 (12568): VM state change detected. (old = 'Running', new = 'Paused') 2020-09-17 09:38:15 (12568): VM state change detected. (old = 'Paused', new = 'Running') 2020-09-17 09:48:25 (12568): Stopping VM. 2020-09-17 09:53:25 (9440): Detected: vboxwrapper 26197 2020-09-17 09:53:25 (9440): Detected: BOINC client v7.7 2020-09-17 09:53:25 (9440): Detected: VirtualBox VboxManage Interface (Version: 6.1.12) 2020-09-17 09:53:26 (9440): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2020-09-17 09:53:26 (9440): Starting VM using VBoxManage interface. (boinc_87dfd748784ee4e3, slot#7) 2020-09-17 09:53:32 (9440): Successfully started VM. (PID = '12360') 2020-09-17 09:53:32 (9440): Reporting VM Process ID to BOINC. 2020-09-17 09:53:32 (9440): VM state change detected. (old = 'PoweredOff', new = 'Running') 2020-09-17 09:53:32 (9440): Detected: Web Application Enabled (http://localhost:64856) 2020-09-17 09:53:32 (9440): Status Report: Job Duration: '864000.000000' 2020-09-17 09:53:32 (9440): Status Report: Elapsed Time: '24788.797116' 2020-09-17 09:53:32 (9440): Status Report: CPU Time: '25960.187500' 2020-09-17 09:53:32 (9440): Preference change detected 2020-09-17 09:53:32 (9440): Setting CPU throttle for VM. (100%) 2020-09-17 09:53:32 (9440): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2020-09-17 10:03:55 (9440): Stopping VM. 2020-09-17 10:08:54 (3152): Detected: vboxwrapper 26197 2020-09-17 10:08:54 (3152): Detected: BOINC client v7.7 2020-09-17 10:08:55 (3152): Detected: VirtualBox VboxManage Interface (Version: 6.1.12) 2020-09-17 10:08:55 (3152): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2020-09-17 10:08:55 (3152): Starting VM using VBoxManage interface. (boinc_87dfd748784ee4e3, slot#7) 2020-09-17 10:09:04 (3152): Successfully started VM. (PID = '5984') 2020-09-17 10:09:04 (3152): Reporting VM Process ID to BOINC. 2020-09-17 10:09:04 (3152): VM state change detected. (old = 'PoweredOff', new = 'Running') 2020-09-17 10:09:04 (3152): Detected: Web Application Enabled (http://localhost:64856) 2020-09-17 10:09:04 (3152): Status Report: Job Duration: '864000.000000' 2020-09-17 10:09:04 (3152): Status Report: Elapsed Time: '25305.733720' 2020-09-17 10:09:04 (3152): Status Report: CPU Time: '26582.828125' 2020-09-17 10:09:04 (3152): Preference change detected 2020-09-17 10:09:04 (3152): Setting CPU throttle for VM. (100%) 2020-09-17 10:09:04 (3152): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2020-09-17 10:19:26 (3152): VM state change detected. (old = 'Running', new = 'Paused') 2020-09-17 14:19:34 (9196): Detected: vboxwrapper 26197 2020-09-17 14:19:34 (9196): Detected: BOINC client v7.7 2020-09-17 14:19:35 (9196): Detected: VirtualBox VboxManage Interface (Version: 6.1.12) 2020-09-17 14:19:35 (9196): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2020-09-17 14:19:36 (9196): Starting VM using VBoxManage interface. (boinc_87dfd748784ee4e3, slot#7) 2020-09-17 14:19:39 (9196): Successfully started VM. (PID = '1520') 2020-09-17 14:19:39 (9196): Reporting VM Process ID to BOINC. 2020-09-17 14:19:39 (9196): Guest Log: BIOS: VirtualBox 6.1.12 2020-09-17 14:19:39 (9196): Guest Log: CPUID EDX: 0x178bfbff 2020-09-17 14:19:39 (9196): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63 2020-09-17 14:19:39 (9196): VM state change detected. (old = 'PoweredOff', new = 'Running') 2020-09-17 14:19:39 (9196): Detected: Web Application Enabled (http://localhost:64856) 2020-09-17 14:19:39 (9196): Status Report: Job Duration: '864000.000000' 2020-09-17 14:19:39 (9196): Status Report: Elapsed Time: '25846.733720' 2020-09-17 14:19:39 (9196): Status Report: CPU Time: '27183.296875' 2020-09-17 14:19:39 (9196): Preference change detected 2020-09-17 14:19:39 (9196): Setting CPU throttle for VM. (100%) 2020-09-17 14:19:40 (9196): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2020-09-17 14:19:41 (9196): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2020-09-17 14:19:41 (9196): Guest Log: BIOS: Booting from Hard Disk... 2020-09-17 14:19:43 (9196): Guest Log: BIOS: KBD: unsupported int 16h function 03 2020-09-17 14:19:43 (9196): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2020-09-17 15:51:58 (9196): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2020-09-17 15:51:58 (9196): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2020-09-17 15:52:03 (9196): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log 2020-09-17 15:52:03 (9196): Guest Log: 00:00:00.000094 main Log opened 2020-09-17T12:20:22.786605000Z 2020-09-17 15:52:03 (9196): Guest Log: 00:00:00.000482 main OS Product: Linux 2020-09-17 15:52:03 (9196): Guest Log: 00:00:00.000514 main OS Release: 4.14.76-13.cernvm.x86_64 2020-09-17 15:52:03 (9196): Guest Log: 00:00:00.000538 main OS Version: #1 SMP Tue Oct 16 18:26:15 CEST 2018 2020-09-17 15:52:03 (9196): Guest Log: 00:00:00.000560 main Executable: /usr/sbin/VBoxService 2020-09-17 15:52:03 (9196): Guest Log: 00:00:00.000561 main Process ID: 3198 2020-09-17 15:52:03 (9196): Guest Log: 00:00:00.000562 main Package type: LINUX_64BITS_GENERIC 2020-09-17 15:52:03 (9196): Guest Log: 00:00:00.006131 main 5.2.6 r120293 started. Verbose level = 0 2020-09-17 15:52:12 (9196): Guest Log: 00:00:10.019201 timesync vgsvcTimeSyncWorker: Radical guest time change: 5 507 619 876 000ns (GuestNow=1 600 350 730 423 756 000 ns GuestLast=1 600 345 222 803 880 000 ns fSetTimeLastLoop=true ) 2020-09-17 15:52:26 (9196): Guest Log: 15:52:24 CEST +02:00 2020-09-17: cranky: [INFO] Detected Theory App 2020-09-17 15:52:26 (9196): Guest Log: 15:52:24 CEST +02:00 2020-09-17: cranky: [INFO] Checking CVMFS. 2020-09-17 15:52:26 (9196): Guest Log: Probing /cvmfs/sft.cern.ch... OK 2020-09-17 15:52:27 (9196): Guest Log: VERSION PID UPTIME(M) MEM(K) REVISION EXPIRES(M) NOCATALOGS CACHEUSE(K) CACHEMAX(K) NOFDUSE NOFDMAX NOIOERR NOOPEN HITRATE(%) RX(K) SPEED(K/S) HOST PROXY ONLINE 2020-09-17 15:52:27 (9196): Guest Log: 2.5.2.0 4045 0 28484 18953 3 1 1611982 4096001 0 65024 0 0 n/a 5 20 http://s1cern-cvmfs.openhtc.io/cvmfs/sft.cern.ch DIRECT 1 2020-09-17 15:52:28 (9196): Guest Log: Probing /cvmfs/grid.cern.ch... OK 2020-09-17 15:52:28 (9196): Guest Log: VERSION PID UPTIME(M) MEM(K) REVISION EXPIRES(M) NOCATALOGS CACHEUSE(K) CACHEMAX(K) NOFDUSE NOFDMAX NOIOERR NOOPEN HITRATE(%) RX(K) SPEED(K/S) HOST PROXY ONLINE 2020-09-17 15:52:28 (9196): Guest Log: 2.5.2.0 4094 0 27548 13235 3 2 1611982 4096001 0 65024 0 2 0 4273 3299 http://s1asgc-cvmfs.openhtc.io:8080/cvmfs/grid.cern.ch DIRECT 1 2020-09-17 15:52:29 (9196): Guest Log: Probing /cvmfs/cernvm-prod.cern.ch... OK 2020-09-17 15:52:30 (9196): Guest Log: VERSION PID UPTIME(M) MEM(K) REVISION EXPIRES(M) NOCATALOGS CACHEUSE(K) CACHEMAX(K) NOFDUSE NOFDMAX NOIOERR NOOPEN HITRATE(%) RX(K) SPEED(K/S) HOST PROXY ONLINE 2020-09-17 15:52:30 (9196): Guest Log: 2.5.2.0 4023 0 27228 258 3 1 1611982 4096001 0 65024 0 0 n/a 4 16 http://s1cern-cvmfs.openhtc.io/cvmfs/cernvm-prod.cern.ch DIRECT 1 2020-09-17 15:52:30 (9196): Guest Log: Probing /cvmfs/alice.cern.ch... OK 2020-09-17 15:52:31 (9196): Guest Log: VERSION PID UPTIME(M) MEM(K) REVISION EXPIRES(M) NOCATALOGS CACHEUSE(K) CACHEMAX(K) NOFDUSE NOFDMAX NOIOERR NOOPEN HITRATE(%) RX(K) SPEED(K/S) HOST PROXY ONLINE 2020-09-17 15:52:31 (9196): Guest Log: 2.5.2.0 4072 0 30100 7476 3 1 1611982 4096001 0 65024 0 0 n/a 4373 2274 http://s1asgc-cvmfs.openhtc.io:8080/cvmfs/alice.cern.ch DIRECT 1 2020-09-17 15:52:31 (9196): Guest Log: 15:52:29 CEST +02:00 2020-09-17: cranky: [INFO] Checking runc. 2020-09-17 15:52:31 (9196): Guest Log: 15:52:29 CEST +02:00 2020-09-17: cranky: [INFO] Creating the filesystem. 2020-09-17 15:52:31 (9196): Guest Log: 15:52:29 CEST +02:00 2020-09-17: cranky: [INFO] Using /cvmfs/cernvm-prod.cern.ch/cvm3 2020-09-17 15:52:31 (9196): Guest Log: 15:52:29 CEST +02:00 2020-09-17: cranky: [INFO] Updating config.json. 2020-09-17 15:52:31 (9196): Guest Log: 15:52:29 CEST +02:00 2020-09-17: cranky: [INFO] Running Container 'runc'. 2020-09-17 15:52:42 (9196): Guest Log: job: htmld=/shared/html/job 2020-09-17 15:52:42 (9196): Guest Log: job: unpack exitcode=0 2020-09-17 15:52:43 (9196): Guest Log: 15:52:41 CEST +02:00 2020-09-17: cranky: [INFO] ===> [runRivet] Thu Sep 17 13:52:40 UTC 2020 [boinc pp jets 7000 250 - pythia8 8.235 default-CD 100000 46] 2020-09-17 16:02:04 (9196): VM state change detected. (old = 'Running', new = 'Paused') 2020-09-17 16:02:14 (9196): VM state change detected. (old = 'Paused', new = 'Running') 2020-09-17 16:05:44 (9196): VM state change detected. (old = 'Running', new = 'Paused') 2020-09-17 16:05:57 (9196): VM state change detected. (old = 'Paused', new = 'Running') 2020-09-17 16:06:44 (9196): VM state change detected. (old = 'Running', new = 'Paused') 2020-09-17 16:06:56 (9196): VM state change detected. (old = 'Paused', new = 'Running') 2020-09-17 16:09:04 (9196): VM state change detected. (old = 'Running', new = 'Paused') 2020-09-17 16:09:15 (9196): VM state change detected. (old = 'Paused', new = 'Running') 2020-09-17 16:12:34 (9196): VM state change detected. (old = 'Running', new = 'Paused') 2020-09-17 16:12:47 (9196): VM state change detected. (old = 'Paused', new = 'Running') 2020-09-17 16:18:54 (9196): VM state change detected. (old = 'Running', new = 'Paused') 2020-09-17 16:19:05 (9196): VM state change detected. (old = 'Paused', new = 'Running') 2020-09-17 16:27:35 (9196): VM state change detected. (old = 'Running', new = 'Paused') 2020-09-17 16:27:45 (9196): VM state change detected. (old = 'Paused', new = 'Running') 2020-09-17 16:32:25 (9196): VM state change detected. (old = 'Running', new = 'Paused') 2020-09-17 16:32:35 (9196): VM state change detected. (old = 'Paused', new = 'Running') 2020-09-17 16:35:26 (9196): VM state change detected. (old = 'Running', new = 'Paused') 2020-09-17 16:35:36 (9196): VM state change detected. (old = 'Paused', new = 'Running') 2020-09-17 16:48:46 (9196): VM state change detected. (old = 'Running', new = 'Paused') 2020-09-17 16:48:56 (9196): VM state change detected. (old = 'Paused', new = 'Running') 2020-09-17 17:14:18 (9196): VM state change detected. (old = 'Running', new = 'Paused') 2020-09-17 17:14:28 (9196): VM state change detected. (old = 'Paused', new = 'Running') 2020-09-17 17:15:29 (9196): VM state change detected. (old = 'Running', new = 'Paused') 2020-09-17 17:15:45 (9196): VM state change detected. (old = 'Paused', new = 'Running') 2020-09-17 17:17:08 (9196): VM state change detected. (old = 'Running', new = 'Paused') 2020-09-17 17:17:20 (9196): VM state change detected. (old = 'Paused', new = 'Running') 2020-09-17 17:46:47 (9196): Status Report: Job Duration: '864000.000000' 2020-09-17 17:46:47 (9196): Status Report: Elapsed Time: '31847.102685' 2020-09-17 17:46:47 (9196): Status Report: CPU Time: '33769.328125' 2020-09-17 17:49:51 (9196): VM state change detected. (old = 'Running', new = 'Paused') 2020-09-17 17:50:03 (9196): VM state change detected. (old = 'Paused', new = 'Running') 2020-09-17 17:50:21 (9196): VM state change detected. (old = 'Running', new = 'Paused') 2020-09-17 17:50:31 (9196): VM state change detected. (old = 'Paused', new = 'Running') 2020-09-17 17:51:31 (9196): VM state change detected. (old = 'Running', new = 'Paused') 2020-09-17 17:51:41 (9196): VM state change detected. (old = 'Paused', new = 'Running') 2020-09-17 18:11:32 (9196): VM state change detected. (old = 'Running', new = 'Paused') 2020-09-17 18:11:42 (9196): VM state change detected. (old = 'Paused', new = 'Running') 2020-09-17 18:35:24 (9196): VM state change detected. (old = 'Running', new = 'Paused') 2020-09-17 18:35:34 (9196): VM state change detected. (old = 'Paused', new = 'Running') 2020-09-17 18:47:55 (9196): VM state change detected. (old = 'Running', new = 'Paused') 2020-09-17 18:48:07 (9196): VM state change detected. (old = 'Paused', new = 'Running') 2020-09-17 18:51:45 (9196): VM state change detected. (old = 'Running', new = 'Paused') 2020-09-17 18:51:57 (9196): VM state change detected. (old = 'Paused', new = 'Running') 2020-09-17 18:52:25 (9196): VM state change detected. (old = 'Running', new = 'Paused') 2020-09-17 18:52:35 (9196): VM state change detected. (old = 'Paused', new = 'Running') 2020-09-17 18:54:55 (9196): VM state change detected. (old = 'Running', new = 'Paused') 2020-09-17 18:55:14 (9196): VM state change detected. (old = 'Paused', new = 'Running') 2020-09-17 19:04:26 (9196): VM state change detected. (old = 'Running', new = 'Paused') 2020-09-17 19:05:46 (9196): VM state change detected. (old = 'Paused', new = 'Running') 2020-09-17 19:25:00 (9196): VM state change detected. (old = 'Running', new = 'Paused') 2020-09-17 19:25:08 (9196): VM state change detected. (old = 'Paused', new = 'Running') 2020-09-17 19:29:07 (9196): VM state change detected. (old = 'Running', new = 'Paused') 2020-09-17 19:29:17 (9196): VM state change detected. (old = 'Paused', new = 'Running') 2020-09-17 19:34:18 (9196): VM state change detected. (old = 'Running', new = 'Paused') 2020-09-17 19:34:29 (9196): VM state change detected. (old = 'Paused', new = 'Running') 2020-09-17 19:38:34 (9196): Status Report: Job Duration: '864000.000000' 2020-09-17 19:38:34 (9196): Status Report: Elapsed Time: '37847.539680' 2020-09-17 19:38:34 (9196): Status Report: CPU Time: '40163.765625' 2020-09-17 19:41:28 (9196): VM state change detected. (old = 'Running', new = 'Paused') 2020-09-17 19:41:38 (9196): VM state change detected. (old = 'Paused', new = 'Running') 2020-09-17 19:45:10 (16368): Detected: vboxwrapper 26197 2020-09-17 19:45:10 (16368): Detected: BOINC client v7.7 2020-09-17 19:45:11 (16368): Detected: VirtualBox VboxManage Interface (Version: 6.1.12) 2020-09-17 19:45:11 (16368): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2020-09-17 19:45:12 (16368): Starting VM using VBoxManage interface. (boinc_87dfd748784ee4e3, slot#7) 2020-09-17 19:45:43 (16368): Error in start VM for VM: -2135228409 Command: VBoxManage -q startvm "boinc_87dfd748784ee4e3" --type headless Output: VBoxManage.exe: error: The machine 'boinc_87dfd748784ee4e3' is already locked by a session (or being locked or unlocked) VBoxManage.exe: error: Details: code VBOX_E_INVALID_OBJECT_STATE (0x80bb0007), component MachineWrap, interface IMachine, callee IUnknown VBoxManage.exe: error: Context: "LaunchVMProcess(a->session, sessionType.raw(), ComSafeArrayAsInParam(aBstrEnv), progress.asOutParam())" at line 727 of file VBoxManageMisc.cpp Notes: Another VirtualBox management application has locked the session for this VM. BOINC cannot properly monitor this VM and so this job will be aborted. 2020-09-17 19:45:43 (16368): VM failed to start. 2020-09-17 19:45:43 (16368): Could not start 2020-09-17 19:45:43 (16368): ERROR: VM failed to start 2020-09-17 19:45:48 (16368): NOTE: VM session lock error encountered. BOINC will be notified that it needs to clean up the environment. This might be a temporary problem and so this job will be rescheduled for another time. 2020-09-17 20:17:38 (1012): Detected: vboxwrapper 26197 2020-09-17 20:17:38 (1012): Detected: BOINC client v7.7 2020-09-17 20:17:39 (1012): Detected: VirtualBox VboxManage Interface (Version: 6.1.12) 2020-09-17 20:17:40 (1012): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2020-09-17 20:17:40 (1012): ERROR: VM failed to start 2020-09-17 20:17:45 (1012): BOINC will be notified that it needs to clean up the environment. This is a temporary problem and so this job will be rescheduled for another time. 2020-09-18 19:54:34 (4468): Detected: vboxwrapper 26197 2020-09-18 19:54:34 (4468): Detected: BOINC client v7.7 2020-09-18 19:54:35 (4468): Detected: VirtualBox VboxManage Interface (Version: 6.1.12) 2020-09-18 19:54:35 (4468): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2020-09-18 19:54:36 (4468): Starting VM using VBoxManage interface. (boinc_87dfd748784ee4e3, slot#7) 2020-09-18 19:55:07 (4468): Error in start VM for VM: -2135228409 Command: VBoxManage -q startvm "boinc_87dfd748784ee4e3" --type headless Output: VBoxManage.exe: error: The machine 'boinc_87dfd748784ee4e3' is already locked by a session (or being locked or unlocked) VBoxManage.exe: error: Details: code VBOX_E_INVALID_OBJECT_STATE (0x80bb0007), component MachineWrap, interface IMachine, callee IUnknown VBoxManage.exe: error: Context: "LaunchVMProcess(a->session, sessionType.raw(), ComSafeArrayAsInParam(aBstrEnv), progress.asOutParam())" at line 727 of file VBoxManageMisc.cpp Notes: Another VirtualBox management application has locked the session for this VM. BOINC cannot properly monitor this VM and so this job will be aborted. 2020-09-18 19:55:07 (4468): VM failed to start. 2020-09-18 19:55:07 (4468): Could not start 2020-09-18 19:55:07 (4468): ERROR: VM failed to start 2020-09-18 19:55:12 (4468): NOTE: VM session lock error encountered. BOINC will be notified that it needs to clean up the environment. This might be a temporary problem and so this job will be rescheduled for another time. 2020-09-18 21:46:57 (11056): Detected: vboxwrapper 26197 2020-09-18 21:46:57 (11056): Detected: BOINC client v7.7 2020-09-18 21:46:58 (11056): Detected: VirtualBox VboxManage Interface (Version: 6.1.12) 2020-09-18 21:46:58 (11056): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2020-09-18 21:46:59 (11056): ERROR: VM failed to start 2020-09-18 21:47:04 (11056): BOINC will be notified that it needs to clean up the environment. This is a temporary problem and so this job will be rescheduled for another time. 2020-09-19 21:05:38 (10752): Detected: vboxwrapper 26197 2020-09-19 21:05:38 (10752): Detected: BOINC client v7.7 2020-09-19 21:05:39 (10752): Detected: VirtualBox VboxManage Interface (Version: 6.1.12) 2020-09-19 21:05:39 (10752): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2020-09-19 21:05:39 (10752): Starting VM using VBoxManage interface. (boinc_87dfd748784ee4e3, slot#7) 2020-09-19 21:06:11 (10752): Error in start VM for VM: -2135228409 Command: VBoxManage -q startvm "boinc_87dfd748784ee4e3" --type headless Output: VBoxManage.exe: error: The machine 'boinc_87dfd748784ee4e3' is already locked by a session (or being locked or unlocked) VBoxManage.exe: error: Details: code VBOX_E_INVALID_OBJECT_STATE (0x80bb0007), component MachineWrap, interface IMachine, callee IUnknown VBoxManage.exe: error: Context: "LaunchVMProcess(a->session, sessionType.raw(), ComSafeArrayAsInParam(aBstrEnv), progress.asOutParam())" at line 727 of file VBoxManageMisc.cpp Notes: Another VirtualBox management application has locked the session for this VM. BOINC cannot properly monitor this VM and so this job will be aborted. 2020-09-19 21:06:11 (10752): VM failed to start. 2020-09-19 21:06:11 (10752): Could not start 2020-09-19 21:06:11 (10752): ERROR: VM failed to start 2020-09-19 21:06:16 (10752): NOTE: VM session lock error encountered. BOINC will be notified that it needs to clean up the environment. This might be a temporary problem and so this job will be rescheduled for another time. 2020-09-20 21:14:56 (8248): Detected: vboxwrapper 26197 2020-09-20 21:14:56 (8248): Detected: BOINC client v7.7 2020-09-20 21:14:57 (8248): Detected: VirtualBox VboxManage Interface (Version: 6.1.12) 2020-09-20 21:14:57 (8248): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2020-09-20 21:14:57 (8248): Starting VM using VBoxManage interface. (boinc_87dfd748784ee4e3, slot#7) 2020-09-20 21:15:29 (8248): Error in start VM for VM: -2135228409 Command: VBoxManage -q startvm "boinc_87dfd748784ee4e3" --type headless Output: VBoxManage.exe: error: The machine 'boinc_87dfd748784ee4e3' is already locked by a session (or being locked or unlocked) VBoxManage.exe: error: Details: code VBOX_E_INVALID_OBJECT_STATE (0x80bb0007), component MachineWrap, interface IMachine, callee IUnknown VBoxManage.exe: error: Context: "LaunchVMProcess(a->session, sessionType.raw(), ComSafeArrayAsInParam(aBstrEnv), progress.asOutParam())" at line 727 of file VBoxManageMisc.cpp Notes: Another VirtualBox management application has locked the session for this VM. BOINC cannot properly monitor this VM and so this job will be aborted. 2020-09-20 21:15:29 (8248): VM failed to start. 2020-09-20 21:15:29 (8248): Could not start 2020-09-20 21:15:29 (8248): ERROR: VM failed to start 2020-09-20 21:15:34 (8248): NOTE: VM session lock error encountered. BOINC will be notified that it needs to clean up the environment. This might be a temporary problem and so this job will be rescheduled for another time. 2020-09-21 21:16:01 (11044): Detected: vboxwrapper 26197 2020-09-21 21:16:01 (11044): Detected: BOINC client v7.7 2020-09-21 21:16:02 (11044): Detected: VirtualBox VboxManage Interface (Version: 6.1.12) 2020-09-21 21:16:02 (11044): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2020-09-21 21:16:02 (11044): Starting VM using VBoxManage interface. (boinc_87dfd748784ee4e3, slot#7) 2020-09-21 21:16:34 (11044): Error in start VM for VM: -2135228409 Command: VBoxManage -q startvm "boinc_87dfd748784ee4e3" --type headless Output: VBoxManage.exe: error: The machine 'boinc_87dfd748784ee4e3' is already locked by a session (or being locked or unlocked) VBoxManage.exe: error: Details: code VBOX_E_INVALID_OBJECT_STATE (0x80bb0007), component MachineWrap, interface IMachine, callee IUnknown VBoxManage.exe: error: Context: "LaunchVMProcess(a->session, sessionType.raw(), ComSafeArrayAsInParam(aBstrEnv), progress.asOutParam())" at line 727 of file VBoxManageMisc.cpp Notes: Another VirtualBox management application has locked the session for this VM. BOINC cannot properly monitor this VM and so this job will be aborted. 2020-09-21 21:16:34 (11044): VM failed to start. 2020-09-21 21:16:34 (11044): Could not start 2020-09-21 21:16:34 (11044): ERROR: VM failed to start 2020-09-21 21:16:39 (11044): NOTE: VM session lock error encountered. BOINC will be notified that it needs to clean up the environment. This might be a temporary problem and so this job will be rescheduled for another time. 2020-09-22 21:17:06 (16176): Detected: vboxwrapper 26197 2020-09-22 21:17:06 (16176): Detected: BOINC client v7.7 2020-09-22 21:17:07 (16176): Detected: VirtualBox VboxManage Interface (Version: 6.1.12) 2020-09-22 21:17:07 (16176): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2020-09-22 21:17:07 (16176): Starting VM using VBoxManage interface. (boinc_87dfd748784ee4e3, slot#7) 2020-09-22 21:17:39 (16176): Error in start VM for VM: -2135228409 Command: VBoxManage -q startvm "boinc_87dfd748784ee4e3" --type headless Output: VBoxManage.exe: error: The machine 'boinc_87dfd748784ee4e3' is already locked by a session (or being locked or unlocked) VBoxManage.exe: error: Details: code VBOX_E_INVALID_OBJECT_STATE (0x80bb0007), component MachineWrap, interface IMachine, callee IUnknown VBoxManage.exe: error: Context: "LaunchVMProcess(a->session, sessionType.raw(), ComSafeArrayAsInParam(aBstrEnv), progress.asOutParam())" at line 727 of file VBoxManageMisc.cpp Notes: Another VirtualBox management application has locked the session for this VM. BOINC cannot properly monitor this VM and so this job will be aborted. 2020-09-22 21:17:39 (16176): VM failed to start. 2020-09-22 21:17:39 (16176): Could not start 2020-09-22 21:17:39 (16176): ERROR: VM failed to start 2020-09-22 21:17:44 (16176): NOTE: VM session lock error encountered. BOINC will be notified that it needs to clean up the environment. This might be a temporary problem and so this job will be rescheduled for another time. 2020-09-23 21:18:10 (16568): Detected: vboxwrapper 26197 2020-09-23 21:18:10 (16568): Detected: BOINC client v7.7 2020-09-23 21:18:11 (16568): Detected: VirtualBox VboxManage Interface (Version: 6.1.12) 2020-09-23 21:18:11 (16568): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2020-09-23 21:18:11 (16568): Starting VM using VBoxManage interface. (boinc_87dfd748784ee4e3, slot#7) 2020-09-23 21:18:43 (16568): Error in start VM for VM: -2135228409 Command: VBoxManage -q startvm "boinc_87dfd748784ee4e3" --type headless Output: VBoxManage.exe: error: The machine 'boinc_87dfd748784ee4e3' is already locked by a session (or being locked or unlocked) VBoxManage.exe: error: Details: code VBOX_E_INVALID_OBJECT_STATE (0x80bb0007), component MachineWrap, interface IMachine, callee IUnknown VBoxManage.exe: error: Context: "LaunchVMProcess(a->session, sessionType.raw(), ComSafeArrayAsInParam(aBstrEnv), progress.asOutParam())" at line 727 of file VBoxManageMisc.cpp Notes: Another VirtualBox management application has locked the session for this VM. BOINC cannot properly monitor this VM and so this job will be aborted. 2020-09-23 21:18:43 (16568): VM failed to start. 2020-09-23 21:18:43 (16568): Could not start 2020-09-23 21:18:43 (16568): ERROR: VM failed to start 2020-09-23 21:18:48 (16568): NOTE: VM session lock error encountered. BOINC will be notified that it needs to clean up the environment. This might be a temporary problem and so this job will be rescheduled for another time. 2020-09-24 21:44:45 (13580): Detected: vboxwrapper 26197 2020-09-24 21:44:45 (13580): Detected: BOINC client v7.7 2020-09-24 21:44:46 (13580): Detected: VirtualBox VboxManage Interface (Version: 6.1.12) 2020-09-24 21:44:46 (13580): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2020-09-24 21:44:47 (13580): Starting VM using VBoxManage interface. (boinc_87dfd748784ee4e3, slot#7) 2020-09-24 21:45:19 (13580): Error in start VM for VM: -2135228409 Command: VBoxManage -q startvm "boinc_87dfd748784ee4e3" --type headless Output: VBoxManage.exe: error: The machine 'boinc_87dfd748784ee4e3' is already locked by a session (or being locked or unlocked) VBoxManage.exe: error: Details: code VBOX_E_INVALID_OBJECT_STATE (0x80bb0007), component MachineWrap, interface IMachine, callee IUnknown VBoxManage.exe: error: Context: "LaunchVMProcess(a->session, sessionType.raw(), ComSafeArrayAsInParam(aBstrEnv), progress.asOutParam())" at line 727 of file VBoxManageMisc.cpp Notes: Another VirtualBox management application has locked the session for this VM. BOINC cannot properly monitor this VM and so this job will be aborted. 2020-09-24 21:45:19 (13580): VM failed to start. 2020-09-24 21:45:19 (13580): Could not start 2020-09-24 21:45:19 (13580): ERROR: VM failed to start 2020-09-24 21:45:24 (13580): NOTE: VM session lock error encountered. BOINC will be notified that it needs to clean up the environment. This might be a temporary problem and so this job will be rescheduled for another time. 2020-09-25 21:45:35 (12216): Detected: vboxwrapper 26197 2020-09-25 21:45:35 (12216): Detected: BOINC client v7.7 2020-09-25 21:45:35 (12216): Detected: VirtualBox VboxManage Interface (Version: 6.1.12) 2020-09-25 21:45:36 (12216): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2020-09-25 21:45:36 (12216): Starting VM using VBoxManage interface. (boinc_87dfd748784ee4e3, slot#7) 2020-09-25 21:46:07 (12216): Error in start VM for VM: -2135228409 Command: VBoxManage -q startvm "boinc_87dfd748784ee4e3" --type headless Output: VBoxManage.exe: error: The machine 'boinc_87dfd748784ee4e3' is already locked by a session (or being locked or unlocked) VBoxManage.exe: error: Details: code VBOX_E_INVALID_OBJECT_STATE (0x80bb0007), component MachineWrap, interface IMachine, callee IUnknown VBoxManage.exe: error: Context: "LaunchVMProcess(a->session, sessionType.raw(), ComSafeArrayAsInParam(aBstrEnv), progress.asOutParam())" at line 727 of file VBoxManageMisc.cpp Notes: Another VirtualBox management application has locked the session for this VM. BOINC cannot properly monitor this VM and so this job will be aborted. 2020-09-25 21:46:07 (12216): VM failed to start. 2020-09-25 21:46:07 (12216): Could not start 2020-09-25 21:46:07 (12216): ERROR: VM failed to start 2020-09-25 21:46:12 (12216): NOTE: VM session lock error encountered. BOINC will be notified that it needs to clean up the environment. This might be a temporary problem and so this job will be rescheduled for another time. 2020-09-27 01:13:40 (3556): Detected: vboxwrapper 26197 2020-09-27 01:13:40 (3556): Detected: BOINC client v7.7 2020-09-27 01:13:41 (3556): Detected: VirtualBox VboxManage Interface (Version: 6.1.12) 2020-09-27 01:13:41 (3556): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2020-09-27 01:13:42 (3556): Starting VM using VBoxManage interface. (boinc_87dfd748784ee4e3, slot#7) 2020-09-27 08:18:14 (3556): Error in start VM for VM: -2135228409 Command: VBoxManage -q startvm "boinc_87dfd748784ee4e3" --type headless Output: VBoxManage.exe: error: The machine 'boinc_87dfd748784ee4e3' is already locked by a session (or being locked or unlocked) VBoxManage.exe: error: Details: code VBOX_E_INVALID_OBJECT_STATE (0x80bb0007), component MachineWrap, interface IMachine, callee IUnknown VBoxManage.exe: error: Context: "LaunchVMProcess(a->session, sessionType.raw(), ComSafeArrayAsInParam(aBstrEnv), progress.asOutParam())" at line 727 of file VBoxManageMisc.cpp Notes: Another VirtualBox management application has locked the session for this VM. BOINC cannot properly monitor this VM and so this job will be aborted. 2020-09-27 08:18:14 (3556): VM failed to start. 2020-09-27 08:18:14 (3556): Could not start 2020-09-27 08:18:14 (3556): ERROR: VM failed to start 2020-09-27 08:18:19 (3556): NOTE: VM session lock error encountered. BOINC will be notified that it needs to clean up the environment. This might be a temporary problem and so this job will be rescheduled for another time. 2020-09-28 08:38:52 (7612): Detected: vboxwrapper 26197 2020-09-28 08:38:52 (7612): Detected: BOINC client v7.7 2020-09-28 08:38:53 (7612): Detected: VirtualBox VboxManage Interface (Version: 6.1.12) 2020-09-28 08:38:54 (7612): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2020-09-28 08:38:54 (7612): Starting VM using VBoxManage interface. (boinc_87dfd748784ee4e3, slot#7) 2020-09-28 08:39:25 (7612): Error in start VM for VM: -2135228409 Command: VBoxManage -q startvm "boinc_87dfd748784ee4e3" --type headless Output: VBoxManage.exe: error: The machine 'boinc_87dfd748784ee4e3' is already locked by a session (or being locked or unlocked) VBoxManage.exe: error: Details: code VBOX_E_INVALID_OBJECT_STATE (0x80bb0007), component MachineWrap, interface IMachine, callee IUnknown VBoxManage.exe: error: Context: "LaunchVMProcess(a->session, sessionType.raw(), ComSafeArrayAsInParam(aBstrEnv), progress.asOutParam())" at line 727 of file VBoxManageMisc.cpp Notes: Another VirtualBox management application has locked the session for this VM. BOINC cannot properly monitor this VM and so this job will be aborted. 2020-09-28 08:39:25 (7612): VM failed to start. 2020-09-28 08:39:25 (7612): Could not start 2020-09-28 08:39:25 (7612): ERROR: VM failed to start 2020-09-28 08:39:30 (7612): NOTE: VM session lock error encountered. BOINC will be notified that it needs to clean up the environment. This might be a temporary problem and so this job will be rescheduled for another time. 2020-09-28 15:23:00 (5760): Detected: vboxwrapper 26197 2020-09-28 15:23:00 (5760): Detected: BOINC client v7.7 2020-09-28 15:23:00 (5760): Detected: VirtualBox VboxManage Interface (Version: 6.1.12) 2020-09-28 15:23:01 (5760): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2020-09-28 15:23:01 (5760): Starting VM using VBoxManage interface. (boinc_87dfd748784ee4e3, slot#7) 2020-09-28 15:23:05 (5760): Successfully started VM. (PID = '14332') 2020-09-28 15:23:05 (5760): Reporting VM Process ID to BOINC. 2020-09-28 15:23:05 (5760): Guest Log: BIOS: VirtualBox 6.1.12 2020-09-28 15:23:05 (5760): Guest Log: CPUID EDX: 0x178bfbff 2020-09-28 15:23:05 (5760): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63 2020-09-28 15:23:05 (5760): VM state change detected. (old = 'PoweredOff', new = 'Running') 2020-09-28 15:23:05 (5760): Detected: Web Application Enabled (http://localhost:64856) 2020-09-28 15:23:05 (5760): VM Completion File Detected. 2020-09-28 15:23:05 (5760): VM Completion Message: Job Finished . 2020-09-28 15:23:05 (5760): Powering off VM. 2020-09-28 15:28:06 (5760): VM did not power off when requested. 2020-09-28 15:28:06 (5760): VM was successfully terminated. 2020-09-28 15:28:06 (5760): Deregistering VM. (boinc_87dfd748784ee4e3, slot#7) 2020-09-28 15:28:27 (5760): Removing network bandwidth throttle group from VM. 2020-09-28 15:28:27 (5760): Removing VM from VirtualBox. 15:28:33 (5760): called boinc_finish(0) </stderr_txt> ]]>
©2025 CERN