| Name | Theory_2374221_1573138322.588383_0 |
| Workunit | 126185967 |
| Created | 7 Nov 2019, 14:52:06 UTC |
| Sent | 7 Nov 2019, 18:07:34 UTC |
| Report deadline | 8 Dec 2019, 18:07:34 UTC |
| Received | 11 Nov 2019, 19:15:00 UTC |
| Server state | Over |
| Outcome | Computation error |
| Client state | Compute error |
| Exit status | 1 (0x00000001) Unknown error code |
| Computer ID | 10608612 |
| Run time | 12 hours 20 min 3 sec |
| CPU time | 1 hours 13 min 41 sec |
| Priority | 0 |
| Validate state | Invalid |
| Credit | 0.00 |
| Device peak FLOPS | 13.12 GFLOPS |
| Application version | Theory Simulation v263.98 (vbox64_mt_mcore) windows_x86_64 |
| Peak working set size | 82.88 MB |
| Peak swap size | 93.70 MB |
| Peak disk usage | 1.34 GB |
Stderr output
<core_client_version>7.6.33</core_client_version> <![CDATA[ <message> Funci�n incorrecta. (0x1) - exit code 1 (0x1) </message> <stderr_txt> 2019-11-07 13:48:13 (8864): Detected: vboxwrapper 26197 2019-11-07 13:48:13 (8864): Detected: BOINC client v7.7 2019-11-07 13:48:15 (8864): Detected: VirtualBox VboxManage Interface (Version: 5.2.6) 2019-11-07 13:48:15 (8864): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2019-11-07 13:48:15 (8864): Successfully copied 'init_data.xml' to the shared directory. 2019-11-07 13:48:16 (8864): Create VM. (boinc_307da26f82b89cb5, slot#7) 2019-11-07 13:48:17 (8864): Setting Memory Size for VM. (3000MB) 2019-11-07 13:48:17 (8864): Setting CPU Count for VM. (3) 2019-11-07 13:48:18 (8864): Setting Chipset Options for VM. 2019-11-07 13:48:18 (8864): Setting Boot Options for VM. 2019-11-07 13:48:18 (8864): Setting Network Configuration for NAT. 2019-11-07 13:48:18 (8864): Enabling VM Network Access. 2019-11-07 13:48:19 (8864): Disabling USB Support for VM. 2019-11-07 13:48:19 (8864): Disabling COM Port Support for VM. 2019-11-07 13:48:19 (8864): Disabling LPT Port Support for VM. 2019-11-07 13:48:20 (8864): Disabling Audio Support for VM. 2019-11-07 13:48:20 (8864): Disabling Clipboard Support for VM. 2019-11-07 13:48:20 (8864): Disabling Drag and Drop Support for VM. 2019-11-07 13:48:21 (8864): Adding storage controller(s) to VM. 2019-11-07 13:48:21 (8864): Adding virtual disk drive to VM. (vm_image.vdi) 2019-11-07 13:48:21 (8864): Adding VirtualBox Guest Additions to VM. 2019-11-07 13:48:21 (8864): Adding network bandwidth throttle group to VM. (Defaulting to 1024GB) 2019-11-07 13:48:22 (8864): forwarding host port 58409 to guest port 80 2019-11-07 13:48:22 (8864): Enabling remote desktop for VM. 2019-11-07 13:48:22 (8864): Required extension pack not installed, remote desktop not enabled. 2019-11-07 13:48:22 (8864): Enabling shared directory for VM. 2019-11-07 13:48:23 (8864): Starting VM using VBoxManage interface. (boinc_307da26f82b89cb5, slot#7) 2019-11-07 13:48:30 (8864): Successfully started VM. (PID = '1240') 2019-11-07 13:48:30 (8864): Reporting VM Process ID to BOINC. 2019-11-07 13:48:30 (8864): Guest Log: BIOS: VirtualBox 5.2.6 2019-11-07 13:48:30 (8864): Guest Log: CPUID EDX: 0x178bfbff 2019-11-07 13:48:30 (8864): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63 2019-11-07 13:48:30 (8864): VM state change detected. (old = 'PoweredOff', new = 'Running') 2019-11-07 13:48:30 (8864): Detected: Web Application Enabled (http://localhost:58409) 2019-11-07 13:48:30 (8864): Preference change detected 2019-11-07 13:48:30 (8864): Setting CPU throttle for VM. (40%) 2019-11-07 13:48:30 (8864): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 180 seconds) or (Vbox_job.xml: 600 seconds)) 2019-11-07 13:48:32 (8864): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2019-11-07 13:48:32 (8864): Guest Log: BIOS: Booting from Hard Disk... 2019-11-07 13:48:35 (8864): Guest Log: BIOS: KBD: unsupported int 16h function 03 2019-11-07 13:48:35 (8864): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2019-11-07 13:48:40 (8864): Stopping VM. 2019-11-07 13:53:41 (12440): Detected: vboxwrapper 26197 2019-11-07 13:53:41 (12440): Detected: BOINC client v7.7 2019-11-07 13:53:42 (12440): Detected: VirtualBox VboxManage Interface (Version: 5.2.6) 2019-11-07 13:53:43 (12440): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2019-11-07 13:53:43 (12440): Starting VM using VBoxManage interface. (boinc_307da26f82b89cb5, slot#7) 2019-11-07 13:53:47 (12440): Successfully started VM. (PID = '4544') 2019-11-07 13:53:47 (12440): Reporting VM Process ID to BOINC. 2019-11-07 13:53:47 (12440): VM state change detected. (old = 'PoweredOff', new = 'Running') 2019-11-07 13:53:47 (12440): Detected: Web Application Enabled (http://localhost:58409) 2019-11-07 13:53:47 (12440): Preference change detected 2019-11-07 13:53:47 (12440): Setting CPU throttle for VM. (40%) 2019-11-07 13:53:47 (12440): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 180 seconds) or (Vbox_job.xml: 600 seconds)) 2019-11-07 13:54:30 (12440): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2019-11-07 13:54:30 (12440): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2019-11-07 13:55:43 (12440): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log 2019-11-07 13:55:43 (12440): Guest Log: 00:00:00.000231 main Log opened 2019-11-07T19:55:42.588830000Z 2019-11-07 13:55:43 (12440): Guest Log: 00:00:00.000558 main OS Product: Linux 2019-11-07 13:55:43 (12440): Guest Log: 00:00:00.000596 main OS Release: 4.14.44-11.cernvm.x86_64 2019-11-07 13:55:43 (12440): Guest Log: 00:00:00.000629 main OS Version: #1 SMP Mon May 28 16:49:00 CEST 2018 2019-11-07 13:55:43 (12440): Guest Log: 00:00:00.000659 main Executable: /usr/share/vboxguest52/usr/sbin/VBoxService 2019-11-07 13:55:43 (12440): Guest Log: 00:00:00.000661 main Process ID: 3028 2019-11-07 13:55:43 (12440): Guest Log: 00:00:00.000662 main Package type: LINUX_64BITS_GENERIC 2019-11-07 13:55:43 (12440): Guest Log: 00:00:00.055368 main 5.2.6 r120293 started. Verbose level = 0 2019-11-07 13:57:06 (12440): Guest Log: [INFO] Mounting the shared directory 2019-11-07 13:57:06 (12440): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor 2019-11-07 13:57:06 (12440): Guest Log: [DEBUG] Testing network connection to cern.ch on port 80 2019-11-07 13:57:07 (12440): Guest Log: [DEBUG] Connection to cern.ch 80 port [tcp/http] succeeded! 2019-11-07 13:57:07 (12440): Guest Log: [DEBUG] 0 2019-11-07 13:57:08 (12440): Guest Log: [DEBUG] Testing VCCS connection to vccs.cern.ch on port 443 2019-11-07 13:57:08 (12440): Guest Log: [DEBUG] Connection to vccs.cern.ch 443 port [tcp/https] succeeded! 2019-11-07 13:57:08 (12440): Guest Log: [DEBUG] 0 2019-11-07 13:57:08 (12440): Guest Log: [DEBUG] Testing connection to Condor server on port 9618 2019-11-07 13:57:09 (12440): Guest Log: [DEBUG] Connection to vccondor01.cern.ch 9618 port [tcp/condor] succeeded! 2019-11-07 13:57:09 (12440): Guest Log: [DEBUG] 0 2019-11-07 13:58:24 (12440): Guest Log: [DEBUG] Probing CVMFS ... 2019-11-07 13:58:33 (12440): Guest Log: Probing /cvmfs/grid.cern.ch... OK 2019-11-07 13:58:37 (12440): 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 2019-11-07 13:58:37 (12440): Guest Log: 2.4.4.0 3748 1 25824 10683 3 1 318381 10240000 2 65024 0 3 100 0 0 http://s1cern-cvmfs.openhtc.io/cvmfs/grid.cern.ch DIRECT 1 2019-11-07 13:58:53 (12440): Guest Log: [INFO] Reading volunteer information 2019-11-07 13:58:53 (12440): Guest Log: [INFO] Volunteer: CharityEngine2 (567714) 2019-11-07 13:58:54 (12440): Guest Log: [INFO] VMID: e5b01749-9626-457a-8945-16c64690aa2f 2019-11-07 13:58:55 (12440): Guest Log: [INFO] Requesting an X509 credential from LHC@home 2019-11-07 13:58:59 (12440): Guest Log: [INFO] Running the fast benchmark. 2019-11-07 14:06:51 (12440): Guest Log: [INFO] Machine performance 3.34 HEPSPEC06 2019-11-07 14:06:51 (12440): Guest Log: [INFO] Theory application starting. Check log files. 2019-11-07 14:06:53 (12440): Guest Log: [DEBUG] HTCondor ping 2019-11-07 14:06:58 (12440): Guest Log: [DEBUG] 0 2019-11-07 14:07:58 (12440): Guest Log: [[IINNFFOO]] NNeeww JJoobb SSttaarrttiinngg iinn sslloott12 2019-11-07 14:07:58 (12440): Guest Log: [[IINNFFOO]] NNeeww JJoobb SSttaarrttiinngg iinn sslloott12 2019-11-07 14:07:58 (12440): Guest Log: [INFO] Condor JobID: 514418.53 in slot1 2019-11-07 14:07:58 (12440): Guest Log: [INFO] Condor JobID: 514418.55 in slot2 2019-11-07 14:08:04 (12440): Guest Log: [INFO] MCPlots JobID: 52015992 in slot2 2019-11-07 14:08:04 (12440): Guest Log: [INFO] MCPlots JobID: 52015961 in slot1 2019-11-07 14:08:09 (12440): Guest Log: [[INIFNOF]O ]= ====>= > [runRivet] [Trhuun RNiov 7 2v1e:t0]7 :T5h9u CNEoTv 2 071 92 1[:b0o7inc: 5p9p CjEeTt s2 081090 0[ b1o5i0n,c- ,p2p3 6m0b --i herwig7n e7l.a1s.t4i cd e1f3a0u0l0t -1 0-0 0p0y0 t1h5i5a]8 2019-11-07 14:08:09 (12440): Guest Log: 235 tune-AU2loxx 100000 155] 2019-11-07 14:28:49 (12440): Guest Log: [INFO] New Job Starting in slot3 2019-11-07 14:28:52 (12440): Guest Log: [INFO] Condor JobID: 514419.82 in slot3 2019-11-07 14:29:02 (12440): Guest Log: [INFO] MCPlots JobID: 52016050 in slot3 2019-11-07 14:29:09 (12440): Guest Log: [INFO] ===> [runRivet] Thu Nov 7 21:28:55 CET 2019 [boinc pp w1j 7000 250 - pythia8 8.235 tune-AU2ct10 100000 155] 2019-11-07 15:08:00 (12440): Preference change detected 2019-11-07 15:08:00 (12440): Setting CPU throttle for VM. (40%) 2019-11-07 15:08:00 (12440): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 180 seconds) or (Vbox_job.xml: 600 seconds)) 2019-11-07 15:33:42 (12440): Status Report: Job Duration: '129600.000000' 2019-11-07 15:33:42 (12440): Status Report: Elapsed Time: '6000.000000' 2019-11-07 15:33:42 (12440): Status Report: CPU Time: '7594.609375' 2019-11-07 15:40:37 (12440): Preference change detected 2019-11-07 15:40:37 (12440): Setting CPU throttle for VM. (40%) 2019-11-07 15:40:38 (12440): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 180 seconds) or (Vbox_job.xml: 600 seconds)) 2019-11-07 16:14:09 (12440): VM state change detected. (old = 'Running', new = 'Paused') 2019-11-07 16:14:10 (12440): Stopping VM. 2019-11-07 16:19:17 (10700): Detected: vboxwrapper 26197 2019-11-07 16:19:17 (10700): Detected: BOINC client v7.7 2019-11-07 16:19:18 (10700): Detected: VirtualBox VboxManage Interface (Version: 5.2.6) 2019-11-07 16:19:19 (10700): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2019-11-07 16:19:19 (10700): Starting VM using VBoxManage interface. (boinc_307da26f82b89cb5, slot#7) 2019-11-07 16:19:40 (10700): Successfully started VM. (PID = '5172') 2019-11-07 16:19:40 (10700): Reporting VM Process ID to BOINC. 2019-11-07 16:19:40 (10700): VM state change detected. (old = 'PoweredOff', new = 'Running') 2019-11-07 16:19:40 (10700): Detected: Web Application Enabled (http://localhost:58409) 2019-11-07 16:19:40 (10700): Status Report: Job Duration: '129600.000000' 2019-11-07 16:19:40 (10700): Status Report: Elapsed Time: '8425.000000' 2019-11-07 16:19:40 (10700): Status Report: CPU Time: '10848.484375' 2019-11-07 16:19:40 (10700): Preference change detected 2019-11-07 16:19:40 (10700): Setting CPU throttle for VM. (40%) 2019-11-07 16:19:41 (10700): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 180 seconds) or (Vbox_job.xml: 600 seconds)) 2019-11-07 16:30:13 (10700): Stopping VM. 2019-11-07 16:40:21 (10520): Detected: vboxwrapper 26197 2019-11-07 16:40:21 (10520): Detected: BOINC client v7.7 2019-11-07 16:40:22 (10520): Detected: VirtualBox VboxManage Interface (Version: 5.2.6) 2019-11-07 16:40:22 (10520): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2019-11-07 16:40:22 (10520): Starting VM using VBoxManage interface. (boinc_307da26f82b89cb5, slot#7) 2019-11-07 16:40:40 (10520): Successfully started VM. (PID = '11160') 2019-11-07 16:40:40 (10520): Reporting VM Process ID to BOINC. 2019-11-07 16:40:40 (10520): VM state change detected. (old = 'PoweredOff', new = 'Running') 2019-11-07 16:40:40 (10520): Detected: Web Application Enabled (http://localhost:58409) 2019-11-07 16:40:40 (10520): Status Report: Job Duration: '129600.000000' 2019-11-07 16:40:40 (10520): Status Report: Elapsed Time: '9058.102551' 2019-11-07 16:40:40 (10520): Status Report: CPU Time: '11707.062500' 2019-11-07 16:40:40 (10520): Preference change detected 2019-11-07 16:40:40 (10520): Setting CPU throttle for VM. (40%) 2019-11-07 16:40:41 (10520): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 180 seconds) or (Vbox_job.xml: 600 seconds)) 2019-11-07 17:05:38 (10520): VM state change detected. (old = 'Running', new = 'Paused') 2019-11-07 17:05:46 (10520): Error in resume VM for VM: -2135228414 Command: VBoxManage -q controlvm "boinc_307da26f82b89cb5" resume Output: VBoxManage.exe: error: VM is paused due to host power management 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 2019-11-07 17:05:46 (10520): Stopping VM. 2019-11-07 17:10:45 (6936): Detected: vboxwrapper 26197 2019-11-07 17:10:45 (6936): Detected: BOINC client v7.7 2019-11-07 17:10:46 (6936): Detected: VirtualBox VboxManage Interface (Version: 5.2.6) 2019-11-07 17:10:47 (6936): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2019-11-07 17:10:47 (6936): Starting VM using VBoxManage interface. (boinc_307da26f82b89cb5, slot#7) 2019-11-07 17:11:07 (6936): Successfully started VM. (PID = '10748') 2019-11-07 17:11:07 (6936): Reporting VM Process ID to BOINC. 2019-11-07 17:11:07 (6936): VM state change detected. (old = 'PoweredOff', new = 'Running') 2019-11-07 17:11:07 (6936): Detected: Web Application Enabled (http://localhost:58409) 2019-11-07 17:11:07 (6936): Status Report: Job Duration: '129600.000000' 2019-11-07 17:11:07 (6936): Status Report: Elapsed Time: '10554.102551' 2019-11-07 17:11:07 (6936): Status Report: CPU Time: '13721.406250' 2019-11-07 17:11:07 (6936): Preference change detected 2019-11-07 17:11:07 (6936): Setting CPU throttle for VM. (40%) 2019-11-07 17:11:08 (6936): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 180 seconds) or (Vbox_job.xml: 600 seconds)) 2019-11-07 17:33:40 (6936): Preference change detected 2019-11-07 17:33:40 (6936): Setting CPU throttle for VM. (40%) 2019-11-07 17:33:41 (6936): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 180 seconds) or (Vbox_job.xml: 600 seconds)) 2019-11-07 17:36:06 (6936): VM state change detected. (old = 'Running', new = 'Paused') 2019-11-07 17:36:14 (6936): Error in resume VM for VM: -2135228414 Command: VBoxManage -q controlvm "boinc_307da26f82b89cb5" 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 2019-11-07 17:36:14 (6936): VM state change detected. (old = 'Paused', new = 'Running') 2019-11-07 17:36:14 (6936): Stopping VM. 2019-11-07 17:41:11 (11408): Detected: vboxwrapper 26197 2019-11-07 17:41:11 (11408): Detected: BOINC client v7.7 2019-11-07 17:41:12 (11408): Detected: VirtualBox VboxManage Interface (Version: 5.2.6) 2019-11-07 17:41:12 (11408): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2019-11-07 17:41:12 (11408): Starting VM using VBoxManage interface. (boinc_307da26f82b89cb5, slot#7) 2019-11-07 17:41:33 (11408): Successfully started VM. (PID = '15388') 2019-11-07 17:41:33 (11408): Reporting VM Process ID to BOINC. 2019-11-07 17:41:33 (11408): VM state change detected. (old = 'PoweredOff', new = 'Running') 2019-11-07 17:41:33 (11408): Detected: Web Application Enabled (http://localhost:58409) 2019-11-07 17:41:33 (11408): Status Report: Job Duration: '129600.000000' 2019-11-07 17:41:33 (11408): Status Report: Elapsed Time: '12052.102551' 2019-11-07 17:41:33 (11408): Status Report: CPU Time: '15736.640625' 2019-11-07 17:41:33 (11408): Preference change detected 2019-11-07 17:41:33 (11408): Setting CPU throttle for VM. (40%) 2019-11-07 17:41:34 (11408): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 180 seconds) or (Vbox_job.xml: 600 seconds)) 2019-11-07 18:07:07 (11408): VM state change detected. (old = 'Running', new = 'Paused') 2019-11-07 18:07:14 (11408): Error in resume VM for VM: -2135228414 Command: VBoxManage -q controlvm "boinc_307da26f82b89cb5" 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 2019-11-07 18:07:14 (11408): VM state change detected. (old = 'Paused', new = 'Running') 2019-11-07 18:07:14 (11408): Stopping VM. 2019-11-07 18:12:15 (14300): Detected: vboxwrapper 26197 2019-11-07 18:12:15 (14300): Detected: BOINC client v7.7 2019-11-07 18:12:18 (14300): Detected: VirtualBox VboxManage Interface (Version: 5.2.6) 2019-11-07 18:12:18 (14300): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2019-11-07 18:12:18 (14300): Starting VM using VBoxManage interface. (boinc_307da26f82b89cb5, slot#7) 2019-11-07 18:12:40 (14300): Successfully started VM. (PID = '16368') 2019-11-07 18:12:40 (14300): Reporting VM Process ID to BOINC. 2019-11-07 18:12:40 (14300): VM state change detected. (old = 'PoweredOff', new = 'Running') 2019-11-07 18:12:40 (14300): Detected: Web Application Enabled (http://localhost:58409) 2019-11-07 18:12:40 (14300): Status Report: Job Duration: '129600.000000' 2019-11-07 18:12:40 (14300): Status Report: Elapsed Time: '13585.102551' 2019-11-07 18:12:40 (14300): Status Report: CPU Time: '17804.781250' 2019-11-07 18:12:40 (14300): Preference change detected 2019-11-07 18:12:40 (14300): Setting CPU throttle for VM. (40%) 2019-11-07 18:12:41 (14300): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 180 seconds) or (Vbox_job.xml: 600 seconds)) 2019-11-07 18:37:37 (14300): VM state change detected. (old = 'Running', new = 'Paused') 2019-11-07 18:37:37 (14300): Stopping VM. 2019-11-07 18:42:41 (13744): Detected: vboxwrapper 26197 2019-11-07 18:42:41 (13744): Detected: BOINC client v7.7 2019-11-07 18:42:44 (13744): Detected: VirtualBox VboxManage Interface (Version: 5.2.6) 2019-11-07 18:42:44 (13744): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2019-11-07 18:42:44 (13744): Starting VM using VBoxManage interface. (boinc_307da26f82b89cb5, slot#7) 2019-11-07 18:43:03 (13744): Successfully started VM. (PID = '9704') 2019-11-07 18:43:03 (13744): Reporting VM Process ID to BOINC. 2019-11-07 18:43:03 (13744): VM state change detected. (old = 'PoweredOff', new = 'Running') 2019-11-07 18:43:03 (13744): Detected: Web Application Enabled (http://localhost:58409) 2019-11-07 18:43:04 (13744): Status Report: Job Duration: '129600.000000' 2019-11-07 18:43:04 (13744): Status Report: Elapsed Time: '15081.252907' 2019-11-07 18:43:04 (13744): Status Report: CPU Time: '19820.781250' 2019-11-07 18:43:04 (13744): Preference change detected 2019-11-07 18:43:04 (13744): Setting CPU throttle for VM. (40%) 2019-11-07 18:43:04 (13744): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 180 seconds) or (Vbox_job.xml: 600 seconds)) 2019-11-07 19:08:08 (13744): VM state change detected. (old = 'Running', new = 'Paused') 2019-11-07 19:08:08 (13744): Stopping VM. 2019-11-08 07:20:26 (13744): Error in stop VM for VM: -182 Command: VBoxManage -q controlvm "boinc_307da26f82b89cb5" savestate Output: 0%...10%...20%...30%...40%...50%...60%...70%...80%...90%... 2019-11-08 07:20:26 (13744): VM did not stop when requested. 2019-11-08 07:20:26 (13744): VM was successfully terminated. 2019-11-08 07:20:59 (15812): Detected: vboxwrapper 26197 2019-11-08 07:20:59 (15812): Detected: BOINC client v7.7 2019-11-08 07:21:00 (15812): Detected: VirtualBox VboxManage Interface (Version: 5.2.6) 2019-11-08 07:21:01 (15812): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2019-11-08 07:21:01 (15812): Starting VM using VBoxManage interface. (boinc_307da26f82b89cb5, slot#7) 2019-11-08 07:21:10 (15812): Successfully started VM. (PID = '6100') 2019-11-08 07:21:10 (15812): Reporting VM Process ID to BOINC. 2019-11-08 07:21:10 (15812): Guest Log: BIOS: VirtualBox 5.2.6 2019-11-08 07:21:10 (15812): Guest Log: CPUID EDX: 0x178bfbff 2019-11-08 07:21:10 (15812): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63 2019-11-08 07:21:10 (15812): VM state change detected. (old = 'PoweredOff', new = 'Running') 2019-11-08 07:21:10 (15812): Detected: Web Application Enabled (http://localhost:58409) 2019-11-08 07:21:10 (15812): Status Report: Job Duration: '129600.000000' 2019-11-08 07:21:10 (15812): Status Report: Elapsed Time: '16583.252907' 2019-11-08 07:21:10 (15812): Status Report: CPU Time: '21850.437500' 2019-11-08 07:21:10 (15812): Preference change detected 2019-11-08 07:21:10 (15812): Setting CPU throttle for VM. (40%) 2019-11-08 07:21:11 (15812): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 180 seconds) or (Vbox_job.xml: 600 seconds)) 2019-11-08 07:21:12 (15812): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2019-11-08 07:21:12 (15812): Guest Log: BIOS: Booting from Hard Disk... 2019-11-08 07:21:17 (15812): Guest Log: BIOS: KBD: unsupported int 16h function 03 2019-11-08 07:21:17 (15812): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2019-11-08 07:21:57 (15812): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2019-11-08 07:21:57 (15812): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2019-11-08 07:23:13 (15812): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log 2019-11-08 07:23:13 (15812): Guest Log: 00:00:00.000668 main Log opened 2019-11-08T13:23:12.178328000Z 2019-11-08 07:23:13 (15812): Guest Log: 00:00:00.001135 main OS Product: Linux 2019-11-08 07:23:13 (15812): Guest Log: 00:00:00.001206 main OS Release: 4.14.44-11.cernvm.x86_64 2019-11-08 07:23:13 (15812): Guest Log: 00:00:00.001265 main OS Version: #1 SMP Mon May 28 16:49:00 CEST 2018 2019-11-08 07:23:13 (15812): Guest Log: 00:00:00.001319 main Executable: /usr/share/vboxguest52/usr/sbin/VBoxService 2019-11-08 07:23:13 (15812): Guest Log: 00:00:00.001322 main Process ID: 2964 2019-11-08 07:23:13 (15812): Guest Log: 00:00:00.001324 main Package type: LINUX_64BITS_GENERIC 2019-11-08 07:23:13 (15812): Guest Log: 00:00:00.004095 main 5.2.6 r120293 started. Verbose level = 0 2019-11-08 07:24:32 (15812): Guest Log: [INFO] Mounting the shared directory 2019-11-08 07:24:33 (15812): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor 2019-11-08 07:24:33 (15812): Guest Log: [DEBUG] Testing network connection to cern.ch on port 80 2019-11-08 07:24:33 (15812): Guest Log: [DEBUG] Connection to cern.ch 80 port [tcp/http] succeeded! 2019-11-08 07:24:34 (15812): Guest Log: [DEBUG] 0 2019-11-08 07:24:34 (15812): Guest Log: [DEBUG] Testing VCCS connection to vccs.cern.ch on port 443 2019-11-08 07:24:35 (15812): Guest Log: [DEBUG] Connection to vccs.cern.ch 443 port [tcp/https] succeeded! 2019-11-08 07:24:35 (15812): Guest Log: [DEBUG] 0 2019-11-08 07:24:35 (15812): Guest Log: [DEBUG] Testing connection to Condor server on port 9618 2019-11-08 07:24:36 (15812): Guest Log: [DEBUG] Connection to vccondor01.cern.ch 9618 port [tcp/condor] succeeded! 2019-11-08 07:24:36 (15812): Guest Log: [DEBUG] 0 2019-11-08 07:25:52 (15812): Guest Log: [DEBUG] Probing CVMFS ... 2019-11-08 07:26:00 (15812): Guest Log: Probing /cvmfs/grid.cern.ch... OK 2019-11-08 07:26:04 (15812): 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 2019-11-08 07:26:04 (15812): Guest Log: 2.4.4.0 3660 1 25792 10689 3 1 610199 10240001 2 65024 0 3 100 0 0 http://s1fnal-cvmfs.openhtc.io/cvmfs/grid.cern.ch DIRECT 1 2019-11-08 07:26:10 (15812): Guest Log: [INFO] Reading volunteer information 2019-11-08 07:26:11 (15812): Guest Log: [INFO] Volunteer: CharityEngine2 (567714) 2019-11-08 07:26:11 (15812): Guest Log: [INFO] VMID: e5b01749-9626-457a-8945-16c64690aa2f 2019-11-08 07:26:12 (15812): Guest Log: [INFO] Requesting an X509 credential from LHC@home 2019-11-08 07:26:16 (15812): Guest Log: [INFO] Running the fast benchmark. 2019-11-08 07:29:53 (15812): Stopping VM. 2019-11-08 07:34:53 (7220): Detected: vboxwrapper 26197 2019-11-08 07:34:53 (7220): Detected: BOINC client v7.7 2019-11-08 07:34:54 (7220): Detected: VirtualBox VboxManage Interface (Version: 5.2.6) 2019-11-08 07:34:54 (7220): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2019-11-08 07:34:54 (7220): Starting VM using VBoxManage interface. (boinc_307da26f82b89cb5, slot#7) 2019-11-08 07:35:00 (7220): Successfully started VM. (PID = '4548') 2019-11-08 07:35:00 (7220): Reporting VM Process ID to BOINC. 2019-11-08 07:35:01 (7220): VM state change detected. (old = 'PoweredOff', new = 'Running') 2019-11-08 07:35:01 (7220): Detected: Web Application Enabled (http://localhost:58409) 2019-11-08 07:35:01 (7220): Status Report: Job Duration: '129600.000000' 2019-11-08 07:35:01 (7220): Status Report: Elapsed Time: '17105.252907' 2019-11-08 07:35:01 (7220): Status Report: CPU Time: '22268.453125' 2019-11-08 07:35:01 (7220): Preference change detected 2019-11-08 07:35:01 (7220): Setting CPU throttle for VM. (40%) 2019-11-08 07:35:01 (7220): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 180 seconds) or (Vbox_job.xml: 600 seconds)) 2019-11-08 07:37:17 (7220): Stopping VM. 2019-11-08 07:42:43 (1240): Detected: vboxwrapper 26197 2019-11-08 07:42:43 (1240): Detected: BOINC client v7.7 2019-11-08 07:42:44 (1240): Detected: VirtualBox VboxManage Interface (Version: 5.2.6) 2019-11-08 07:42:44 (1240): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2019-11-08 07:42:45 (1240): Starting VM using VBoxManage interface. (boinc_307da26f82b89cb5, slot#7) 2019-11-08 07:42:50 (1240): Successfully started VM. (PID = '9492') 2019-11-08 07:42:50 (1240): Reporting VM Process ID to BOINC. 2019-11-08 07:42:50 (1240): VM state change detected. (old = 'PoweredOff', new = 'Running') 2019-11-08 07:42:50 (1240): Detected: Web Application Enabled (http://localhost:58409) 2019-11-08 07:42:50 (1240): Status Report: Job Duration: '129600.000000' 2019-11-08 07:42:50 (1240): Status Report: Elapsed Time: '17241.252907' 2019-11-08 07:42:50 (1240): Status Report: CPU Time: '22448.609375' 2019-11-08 07:42:50 (1240): Preference change detected 2019-11-08 07:42:50 (1240): Setting CPU throttle for VM. (40%) 2019-11-08 07:42:51 (1240): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 180 seconds) or (Vbox_job.xml: 600 seconds)) 2019-11-08 07:44:45 (1240): Guest Log: [INFO] Machine performance 3.30 HEPSPEC06 2019-11-08 07:44:45 (1240): Guest Log: [INFO] Theory application starting. Check log files. 2019-11-08 07:44:47 (1240): Guest Log: [DEBUG] HTCondor ping 2019-11-08 07:44:50 (1240): Guest Log: [DEBUG] 0 2019-11-08 07:45:47 (1240): Guest Log: [INFO] New Job Starting in slot2 2019-11-08 07:45:48 (1240): Guest Log: [INFO] Condor JobID: 514494.25 in slot2 2019-11-08 07:45:48 (1240): Guest Log: [INFO] New Job Starting in slot1 2019-11-08 07:45:48 (1240): Guest Log: [INFO] Condor JobID: 514494.23 in slot1 2019-11-08 07:45:53 (1240): Guest Log: [INFO] MCPlots JobID: 52025531 in slot2 2019-11-08 07:45:53 (1240): Guest Log: [INFO] MCPlots JobID: 52025556 in slot1 2019-11-08 07:45:58 (1240): Guest Log: [INFO] ===> [runRivet] Fri Nov 8 14:45:48 CET 2019 [boinc pp jets 7000 65 - pythia6 6.428 dw 100000 156] 2019-11-08 07:45:59 (1240): Guest Log: [INFO] ===> [runRivet] Fri Nov 8 14:45:48 CET 2019 [boinc pp jets 7000 600 - pythia8 8.212 tune-4cx 100000 156] 2019-11-08 07:52:55 (1240): Stopping VM. 2019-11-08 07:57:58 (14168): Detected: vboxwrapper 26197 2019-11-08 07:57:58 (14168): Detected: BOINC client v7.7 2019-11-08 07:57:58 (14168): Detected: VirtualBox VboxManage Interface (Version: 5.2.6) 2019-11-08 07:57:59 (14168): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2019-11-08 07:57:59 (14168): Starting VM using VBoxManage interface. (boinc_307da26f82b89cb5, slot#7) 2019-11-08 07:58:11 (14168): Successfully started VM. (PID = '13180') 2019-11-08 07:58:11 (14168): Reporting VM Process ID to BOINC. 2019-11-08 07:58:11 (14168): VM state change detected. (old = 'PoweredOff', new = 'Running') 2019-11-08 07:58:11 (14168): Detected: Web Application Enabled (http://localhost:58409) 2019-11-08 07:58:11 (14168): Status Report: Job Duration: '129600.000000' 2019-11-08 07:58:11 (14168): Status Report: Elapsed Time: '17845.252907' 2019-11-08 07:58:11 (14168): Status Report: CPU Time: '23119.968750' 2019-11-08 07:58:11 (14168): Preference change detected 2019-11-08 07:58:11 (14168): Setting CPU throttle for VM. (40%) 2019-11-08 07:58:12 (14168): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 180 seconds) or (Vbox_job.xml: 600 seconds)) 2019-11-08 08:07:15 (14168): Guest Log: [INFO] New Job Starting in slot3 2019-11-08 08:07:35 (14168): Guest Log: [INFO] Condor JobID: 514496.26 in slot3 2019-11-08 08:07:58 (14168): Guest Log: [INFO] MCPlots JobID: 52025958 in slot3 2019-11-08 08:08:04 (14168): Guest Log: [INFO] ===> [runRivet] Fri Nov 8 15:07:50 CET 2019 [boinc pp jets 7000 40 - pythia6 6.427 a 100000 156] 2019-11-08 08:16:43 (14168): Stopping VM. 2019-11-08 08:35:35 (8748): Detected: vboxwrapper 26197 2019-11-08 08:35:35 (8748): Detected: BOINC client v7.7 2019-11-08 08:35:36 (8748): Detected: VirtualBox VboxManage Interface (Version: 5.2.6) 2019-11-08 08:35:36 (8748): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2019-11-08 08:35:36 (8748): Starting VM using VBoxManage interface. (boinc_307da26f82b89cb5, slot#7) 2019-11-08 08:35:45 (8748): Successfully started VM. (PID = '6120') 2019-11-08 08:35:45 (8748): Reporting VM Process ID to BOINC. 2019-11-08 08:35:45 (8748): VM state change detected. (old = 'PoweredOff', new = 'Running') 2019-11-08 08:35:45 (8748): Detected: Web Application Enabled (http://localhost:58409) 2019-11-08 08:35:45 (8748): Status Report: Job Duration: '129600.000000' 2019-11-08 08:35:45 (8748): Status Report: Elapsed Time: '18956.252907' 2019-11-08 08:35:45 (8748): Status Report: CPU Time: '24606.390625' 2019-11-08 08:35:45 (8748): Preference change detected 2019-11-08 08:35:45 (8748): Setting CPU throttle for VM. (40%) 2019-11-08 08:35:45 (8748): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 180 seconds) or (Vbox_job.xml: 600 seconds)) 2019-11-08 08:40:32 (8748): Stopping VM. 2019-11-08 08:49:31 (10392): Detected: vboxwrapper 26197 2019-11-08 08:49:31 (10392): Detected: BOINC client v7.7 2019-11-08 08:49:31 (10392): Detected: VirtualBox VboxManage Interface (Version: 5.2.6) 2019-11-08 08:49:32 (10392): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2019-11-08 08:49:32 (10392): Starting VM using VBoxManage interface. (boinc_307da26f82b89cb5, slot#7) 2019-11-08 08:49:41 (10392): Successfully started VM. (PID = '2164') 2019-11-08 08:49:41 (10392): Reporting VM Process ID to BOINC. 2019-11-08 08:49:41 (10392): VM state change detected. (old = 'PoweredOff', new = 'Running') 2019-11-08 08:49:41 (10392): Detected: Web Application Enabled (http://localhost:58409) 2019-11-08 08:49:41 (10392): Status Report: Job Duration: '129600.000000' 2019-11-08 08:49:41 (10392): Status Report: Elapsed Time: '19243.252907' 2019-11-08 08:49:41 (10392): Status Report: CPU Time: '24987.968750' 2019-11-08 08:49:41 (10392): Preference change detected 2019-11-08 08:49:41 (10392): Setting CPU throttle for VM. (40%) 2019-11-08 08:49:41 (10392): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 180 seconds) or (Vbox_job.xml: 600 seconds)) 2019-11-08 10:23:46 (10392): Preference change detected 2019-11-08 10:23:46 (10392): Setting CPU throttle for VM. (40%) 2019-11-08 10:23:46 (10392): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 180 seconds) or (Vbox_job.xml: 600 seconds)) 2019-11-08 10:24:26 (10392): Preference change detected 2019-11-08 10:24:26 (10392): Setting CPU throttle for VM. (40%) 2019-11-08 10:24:26 (10392): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 180 seconds) or (Vbox_job.xml: 600 seconds)) 2019-11-08 10:25:00 (10392): Preference change detected 2019-11-08 10:25:00 (10392): Setting CPU throttle for VM. (40%) 2019-11-08 10:25:00 (10392): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 180 seconds) or (Vbox_job.xml: 600 seconds)) 2019-11-08 10:25:13 (10392): Preference change detected 2019-11-08 10:25:13 (10392): Setting CPU throttle for VM. (40%) 2019-11-08 10:25:13 (10392): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 180 seconds) or (Vbox_job.xml: 600 seconds)) 2019-11-08 10:26:18 (10392): Preference change detected 2019-11-08 10:26:18 (10392): Setting CPU throttle for VM. (40%) 2019-11-08 10:26:19 (10392): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 180 seconds) or (Vbox_job.xml: 600 seconds)) 2019-11-08 10:26:57 (10392): Preference change detected 2019-11-08 10:26:57 (10392): Setting CPU throttle for VM. (40%) 2019-11-08 10:26:58 (10392): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 180 seconds) or (Vbox_job.xml: 600 seconds)) 2019-11-08 10:29:45 (10392): Status Report: Job Duration: '129600.000000' 2019-11-08 10:29:45 (10392): Status Report: Elapsed Time: '25243.252907' 2019-11-08 10:29:45 (10392): Status Report: CPU Time: '33060.078125' 2019-11-08 12:05:38 (10392): VM state change detected. (old = 'Running', new = 'Paused') 2019-11-08 12:05:47 (10392): Error in resume VM for VM: -2135228414 Command: VBoxManage -q controlvm "boinc_307da26f82b89cb5" 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 2019-11-08 12:05:47 (10392): VM state change detected. (old = 'Paused', new = 'Running') 2019-11-08 12:05:47 (10392): Stopping VM. 2019-11-08 12:10:42 (14320): Detected: vboxwrapper 26197 2019-11-08 12:10:42 (14320): Detected: BOINC client v7.7 2019-11-08 12:10:44 (14320): Detected: VirtualBox VboxManage Interface (Version: 5.2.6) 2019-11-08 12:10:44 (14320): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2019-11-08 12:10:44 (14320): Starting VM using VBoxManage interface. (boinc_307da26f82b89cb5, slot#7) 2019-11-08 12:10:59 (14320): Successfully started VM. (PID = '7812') 2019-11-08 12:10:59 (14320): Reporting VM Process ID to BOINC. 2019-11-08 12:10:59 (14320): VM state change detected. (old = 'PoweredOff', new = 'Running') 2019-11-08 12:10:59 (14320): Detected: Web Application Enabled (http://localhost:58409) 2019-11-08 12:10:59 (14320): Status Report: Job Duration: '129600.000000' 2019-11-08 12:10:59 (14320): Status Report: Elapsed Time: '30990.252907' 2019-11-08 12:10:59 (14320): Status Report: CPU Time: '40782.593750' 2019-11-08 12:10:59 (14320): Preference change detected 2019-11-08 12:10:59 (14320): Setting CPU throttle for VM. (40%) 2019-11-08 12:11:00 (14320): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 180 seconds) or (Vbox_job.xml: 600 seconds)) 2019-11-08 12:36:07 (14320): VM state change detected. (old = 'Running', new = 'Paused') 2019-11-08 12:36:14 (14320): Error in resume VM for VM: -2135228414 Command: VBoxManage -q controlvm "boinc_307da26f82b89cb5" 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 2019-11-08 12:36:14 (14320): VM state change detected. (old = 'Paused', new = 'Running') 2019-11-08 12:36:14 (14320): Stopping VM. 2019-11-08 12:41:07 (5880): Detected: vboxwrapper 26197 2019-11-08 12:41:07 (5880): Detected: BOINC client v7.7 2019-11-08 12:41:09 (5880): Detected: VirtualBox VboxManage Interface (Version: 5.2.6) 2019-11-08 12:41:09 (5880): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2019-11-08 12:41:09 (5880): Starting VM using VBoxManage interface. (boinc_307da26f82b89cb5, slot#7) 2019-11-08 12:41:20 (5880): Successfully started VM. (PID = '1524') 2019-11-08 12:41:20 (5880): Reporting VM Process ID to BOINC. 2019-11-08 12:41:20 (5880): VM state change detected. (old = 'PoweredOff', new = 'Running') 2019-11-08 12:41:20 (5880): Detected: Web Application Enabled (http://localhost:58409) 2019-11-08 12:41:20 (5880): Status Report: Job Duration: '129600.000000' 2019-11-08 12:41:20 (5880): Status Report: Elapsed Time: '32497.252907' 2019-11-08 12:41:20 (5880): Status Report: CPU Time: '42809.531250' 2019-11-08 12:41:20 (5880): Preference change detected 2019-11-08 12:41:20 (5880): Setting CPU throttle for VM. (40%) 2019-11-08 12:41:21 (5880): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 180 seconds) or (Vbox_job.xml: 600 seconds)) 2019-11-08 13:06:37 (5880): VM state change detected. (old = 'Running', new = 'Paused') 2019-11-08 13:06:37 (5880): Stopping VM. 2019-11-08 13:11:37 (4088): Detected: vboxwrapper 26197 2019-11-08 13:11:37 (4088): Detected: BOINC client v7.7 2019-11-08 13:11:38 (4088): Detected: VirtualBox VboxManage Interface (Version: 5.2.6) 2019-11-08 13:11:39 (4088): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2019-11-08 13:11:39 (4088): Starting VM using VBoxManage interface. (boinc_307da26f82b89cb5, slot#7) 2019-11-08 13:11:50 (4088): Successfully started VM. (PID = '13548') 2019-11-08 13:11:50 (4088): Reporting VM Process ID to BOINC. 2019-11-08 13:11:50 (4088): VM state change detected. (old = 'PoweredOff', new = 'Running') 2019-11-08 13:11:50 (4088): Detected: Web Application Enabled (http://localhost:58409) 2019-11-08 13:11:50 (4088): Status Report: Job Duration: '129600.000000' 2019-11-08 13:11:50 (4088): Status Report: Elapsed Time: '34013.587839' 2019-11-08 13:11:50 (4088): Status Report: CPU Time: '44849.125000' 2019-11-08 13:11:50 (4088): Preference change detected 2019-11-08 13:11:50 (4088): Setting CPU throttle for VM. (40%) 2019-11-08 13:11:52 (4088): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 180 seconds) or (Vbox_job.xml: 600 seconds)) 2019-11-08 13:37:07 (4088): VM state change detected. (old = 'Running', new = 'Paused') 2019-11-08 13:37:14 (4088): Error in resume VM for VM: -2135228414 Command: VBoxManage -q controlvm "boinc_307da26f82b89cb5" 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 2019-11-08 13:37:14 (4088): VM state change detected. (old = 'Paused', new = 'Running') 2019-11-08 13:37:14 (4088): Stopping VM. 2019-11-08 13:42:07 (10864): Detected: vboxwrapper 26197 2019-11-08 13:42:07 (10864): Detected: BOINC client v7.7 2019-11-08 13:42:08 (10864): Detected: VirtualBox VboxManage Interface (Version: 5.2.6) 2019-11-08 13:42:08 (10864): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2019-11-08 13:42:09 (10864): Starting VM using VBoxManage interface. (boinc_307da26f82b89cb5, slot#7) 2019-11-08 13:42:19 (10864): Successfully started VM. (PID = '11104') 2019-11-08 13:42:19 (10864): Reporting VM Process ID to BOINC. 2019-11-08 13:42:19 (10864): VM state change detected. (old = 'PoweredOff', new = 'Running') 2019-11-08 13:42:19 (10864): Detected: Web Application Enabled (http://localhost:58409) 2019-11-08 13:42:19 (10864): Status Report: Job Duration: '129600.000000' 2019-11-08 13:42:19 (10864): Status Report: Elapsed Time: '35528.947155' 2019-11-08 13:42:19 (10864): Status Report: CPU Time: '46888.859375' 2019-11-08 13:42:19 (10864): Preference change detected 2019-11-08 13:42:19 (10864): Setting CPU throttle for VM. (40%) 2019-11-08 13:42:20 (10864): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 180 seconds) or (Vbox_job.xml: 600 seconds)) 2019-11-08 13:45:30 (10864): Stopping VM. 2019-11-08 13:50:31 (1408): Detected: vboxwrapper 26197 2019-11-08 13:50:31 (1408): Detected: BOINC client v7.7 2019-11-08 13:50:32 (1408): Detected: VirtualBox VboxManage Interface (Version: 5.2.6) 2019-11-08 13:50:33 (1408): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2019-11-08 13:50:33 (1408): Starting VM using VBoxManage interface. (boinc_307da26f82b89cb5, slot#7) 2019-11-08 13:50:46 (1408): Successfully started VM. (PID = '9964') 2019-11-08 13:50:46 (1408): Reporting VM Process ID to BOINC. 2019-11-08 13:50:46 (1408): VM state change detected. (old = 'PoweredOff', new = 'Running') 2019-11-08 13:50:46 (1408): Detected: Web Application Enabled (http://localhost:58409) 2019-11-08 13:50:46 (1408): Status Report: Job Duration: '129600.000000' 2019-11-08 13:50:46 (1408): Status Report: Elapsed Time: '35720.014618' 2019-11-08 13:50:46 (1408): Status Report: CPU Time: '47152.750000' 2019-11-08 13:50:46 (1408): Preference change detected 2019-11-08 13:50:46 (1408): Setting CPU throttle for VM. (40%) 2019-11-08 13:50:47 (1408): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 180 seconds) or (Vbox_job.xml: 600 seconds)) 2019-11-08 13:51:55 (1408): Stopping VM. 2019-11-08 14:07:47 (15372): Detected: vboxwrapper 26197 2019-11-08 14:07:47 (15372): Detected: BOINC client v7.7 2019-11-08 14:07:48 (15372): Detected: VirtualBox VboxManage Interface (Version: 5.2.6) 2019-11-08 14:07:48 (15372): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2019-11-08 14:07:48 (15372): Starting VM using VBoxManage interface. (boinc_307da26f82b89cb5, slot#7) 2019-11-08 14:08:01 (15372): Successfully started VM. (PID = '4980') 2019-11-08 14:08:01 (15372): Reporting VM Process ID to BOINC. 2019-11-08 14:08:01 (15372): VM state change detected. (old = 'PoweredOff', new = 'Running') 2019-11-08 14:08:01 (15372): Detected: Web Application Enabled (http://localhost:58409) 2019-11-08 14:08:01 (15372): Status Report: Job Duration: '129600.000000' 2019-11-08 14:08:01 (15372): Status Report: Elapsed Time: '35789.014618' 2019-11-08 14:08:01 (15372): Status Report: CPU Time: '47241.671875' 2019-11-08 14:08:01 (15372): Preference change detected 2019-11-08 14:08:01 (15372): Setting CPU throttle for VM. (40%) 2019-11-08 14:08:01 (15372): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 180 seconds) or (Vbox_job.xml: 600 seconds)) 2019-11-08 14:33:07 (15372): VM state change detected. (old = 'Running', new = 'Paused') 2019-11-08 14:33:07 (15372): Stopping VM. 2019-11-08 14:38:08 (11404): Detected: vboxwrapper 26197 2019-11-08 14:38:08 (11404): Detected: BOINC client v7.7 2019-11-08 14:38:09 (11404): Detected: VirtualBox VboxManage Interface (Version: 5.2.6) 2019-11-08 14:38:09 (11404): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2019-11-08 14:38:09 (11404): Starting VM using VBoxManage interface. (boinc_307da26f82b89cb5, slot#7) 2019-11-08 14:38:20 (11404): Successfully started VM. (PID = '3716') 2019-11-08 14:38:20 (11404): Reporting VM Process ID to BOINC. 2019-11-08 14:38:20 (11404): VM state change detected. (old = 'PoweredOff', new = 'Running') 2019-11-08 14:38:20 (11404): Detected: Web Application Enabled (http://localhost:58409) 2019-11-08 14:38:20 (11404): Status Report: Job Duration: '129600.000000' 2019-11-08 14:38:20 (11404): Status Report: Elapsed Time: '37294.014618' 2019-11-08 14:38:20 (11404): Status Report: CPU Time: '49268.656250' 2019-11-08 14:38:20 (11404): Preference change detected 2019-11-08 14:38:20 (11404): Setting CPU throttle for VM. (40%) 2019-11-08 14:38:21 (11404): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 180 seconds) or (Vbox_job.xml: 600 seconds)) 2019-11-08 14:51:26 (11404): Stopping VM. 2019-11-08 14:57:23 (5828): Detected: vboxwrapper 26197 2019-11-08 14:57:23 (5828): Detected: BOINC client v7.7 2019-11-08 14:57:24 (5828): Detected: VirtualBox VboxManage Interface (Version: 5.2.6) 2019-11-08 14:57:25 (5828): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2019-11-08 14:57:25 (5828): Starting VM using VBoxManage interface. (boinc_307da26f82b89cb5, slot#7) 2019-11-08 14:57:35 (5828): Successfully started VM. (PID = '15828') 2019-11-08 14:57:35 (5828): Reporting VM Process ID to BOINC. 2019-11-08 14:57:35 (5828): VM state change detected. (old = 'PoweredOff', new = 'Running') 2019-11-08 14:57:35 (5828): Detected: Web Application Enabled (http://localhost:58409) 2019-11-08 14:57:35 (5828): Status Report: Job Duration: '129600.000000' 2019-11-08 14:57:35 (5828): Status Report: Elapsed Time: '38079.014618' 2019-11-08 14:57:35 (5828): Status Report: CPU Time: '50327.640625' 2019-11-08 14:57:35 (5828): Preference change detected 2019-11-08 14:57:35 (5828): Setting CPU throttle for VM. (40%) 2019-11-08 14:57:36 (5828): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 180 seconds) or (Vbox_job.xml: 600 seconds)) 2019-11-08 15:00:16 (5828): Stopping VM. 2019-11-08 15:05:52 (13020): Detected: vboxwrapper 26197 2019-11-08 15:05:52 (13020): Detected: BOINC client v7.7 2019-11-08 15:05:53 (13020): Detected: VirtualBox VboxManage Interface (Version: 5.2.6) 2019-11-08 15:05:54 (13020): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2019-11-08 15:05:54 (13020): Starting VM using VBoxManage interface. (boinc_307da26f82b89cb5, slot#7) 2019-11-08 15:06:16 (13020): Successfully started VM. (PID = '2172') 2019-11-08 15:06:16 (13020): Reporting VM Process ID to BOINC. 2019-11-08 15:06:16 (13020): VM state change detected. (old = 'PoweredOff', new = 'Running') 2019-11-08 15:06:16 (13020): Detected: Web Application Enabled (http://localhost:58409) 2019-11-08 15:06:16 (13020): Status Report: Job Duration: '129600.000000' 2019-11-08 15:06:16 (13020): Status Report: Elapsed Time: '38240.014618' 2019-11-08 15:06:16 (13020): Status Report: CPU Time: '50551.500000' 2019-11-08 15:06:16 (13020): Preference change detected 2019-11-08 15:06:16 (13020): Setting CPU throttle for VM. (40%) 2019-11-08 15:06:17 (13020): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 180 seconds) or (Vbox_job.xml: 600 seconds)) 2019-11-08 15:27:06 (13020): Preference change detected 2019-11-08 15:27:06 (13020): Setting CPU throttle for VM. (40%) 2019-11-08 15:27:07 (13020): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 180 seconds) or (Vbox_job.xml: 600 seconds)) 2019-11-08 15:31:04 (13020): Preference change detected 2019-11-08 15:31:04 (13020): Setting CPU throttle for VM. (40%) 2019-11-08 15:31:05 (13020): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 180 seconds) or (Vbox_job.xml: 600 seconds)) 2019-11-08 16:46:11 (8700): Detected: vboxwrapper 26197 2019-11-08 16:46:11 (8700): Detected: BOINC client v7.7 2019-11-08 16:46:13 (8700): Detected: VirtualBox VboxManage Interface (Version: 5.2.6) 2019-11-08 16:46:13 (8700): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2019-11-08 16:46:13 (8700): Register VM. (boinc_307da26f82b89cb5, slot#7) 2019-11-08 16:46:14 (8700): Starting VM using VBoxManage interface. (boinc_307da26f82b89cb5, slot#7) 2019-11-08 16:46:19 (8700): Successfully started VM. (PID = '10804') 2019-11-08 16:46:19 (8700): Reporting VM Process ID to BOINC. 2019-11-08 16:46:19 (8700): Guest Log: BIOS: VirtualBox 5.2.6 2019-11-08 16:46:19 (8700): Guest Log: CPUID EDX: 0x178bfbff 2019-11-08 16:46:19 (8700): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63 2019-11-08 16:46:19 (8700): VM state change detected. (old = 'PoweredOff', new = 'Running') 2019-11-08 16:46:19 (8700): Preference change detected 2019-11-08 16:46:19 (8700): Setting CPU throttle for VM. (40%) 2019-11-08 16:46:19 (8700): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 180 seconds) or (Vbox_job.xml: 600 seconds)) 2019-11-08 16:46:21 (8700): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2019-11-08 16:46:21 (8700): Guest Log: BIOS: Booting from Hard Disk... 2019-11-08 16:46:25 (8700): Guest Log: BIOS: KBD: unsupported int 16h function 03 2019-11-08 16:46:25 (8700): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2019-11-08 16:47:08 (8700): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2019-11-08 16:47:08 (8700): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2019-11-08 16:48:04 (8700): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log 2019-11-08 16:48:04 (8700): Guest Log: 00:00:00.000336 main Log opened 2019-11-08T22:48:02.751510000Z 2019-11-08 16:48:04 (8700): Guest Log: 00:00:00.000670 main OS Product: Linux 2019-11-08 16:48:04 (8700): Guest Log: 00:00:00.000709 main OS Release: 4.14.44-11.cernvm.x86_64 2019-11-08 16:48:04 (8700): Guest Log: 00:00:00.000740 main OS Version: #1 SMP Mon May 28 16:49:00 CEST 2018 2019-11-08 16:48:04 (8700): Guest Log: 00:00:00.000769 main Executable: /usr/share/vboxguest52/usr/sbin/VBoxService 2019-11-08 16:48:04 (8700): Guest Log: 00:00:00.000770 main Process ID: 2965 2019-11-08 16:48:04 (8700): Guest Log: 00:00:00.000771 main Package type: LINUX_64BITS_GENERIC 2019-11-08 16:48:04 (8700): Guest Log: 00:00:00.049658 main 5.2.6 r120293 started. Verbose level = 0 2019-11-08 16:49:04 (8700): Guest Log: [INFO] Mounting the shared directory 2019-11-08 16:49:04 (8700): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor 2019-11-08 16:49:04 (8700): Guest Log: [DEBUG] Testing network connection to cern.ch on port 80 2019-11-08 16:49:05 (8700): Guest Log: [DEBUG] Connection to cern.ch 80 port [tcp/http] succeeded! 2019-11-08 16:49:05 (8700): Guest Log: [DEBUG] 0 2019-11-08 16:49:05 (8700): Guest Log: [DEBUG] Testing VCCS connection to vccs.cern.ch on port 443 2019-11-08 16:49:06 (8700): Guest Log: [DEBUG] Connection to vccs.cern.ch 443 port [tcp/https] succeeded! 2019-11-08 16:49:06 (8700): Guest Log: [DEBUG] 0 2019-11-08 16:49:06 (8700): Guest Log: [DEBUG] Testing connection to Condor server on port 9618 2019-11-08 16:49:06 (8700): Guest Log: [DEBUG] Connection to vccondor01.cern.ch 9618 port [tcp/condor] succeeded! 2019-11-08 16:49:07 (8700): Guest Log: [DEBUG] 0 2019-11-08 16:50:18 (8700): Guest Log: [DEBUG] Probing CVMFS ... 2019-11-08 16:50:24 (8700): Guest Log: Probing /cvmfs/grid.cern.ch... OK 2019-11-08 16:50:26 (8700): 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 2019-11-08 16:50:26 (8700): Guest Log: 2.4.4.0 3661 1 27808 10693 3 1 728707 10240001 2 65024 0 3 100 0 0 http://s1fnal-cvmfs.openhtc.io/cvmfs/grid.cern.ch DIRECT 1 2019-11-08 16:50:30 (8700): Guest Log: [INFO] Reading volunteer information 2019-11-08 16:50:30 (8700): Guest Log: [INFO] Volunteer: CharityEngine2 (567714) 2019-11-08 16:50:30 (8700): Guest Log: [INFO] VMID: e5b01749-9626-457a-8945-16c64690aa2f 2019-11-08 16:50:31 (8700): Guest Log: [INFO] Requesting an X509 credential from LHC@home 2019-11-08 16:50:34 (8700): Guest Log: [INFO] Running the fast benchmark. 2019-11-08 16:58:19 (8700): Guest Log: [INFO] Machine performance 3.33 HEPSPEC06 2019-11-08 16:58:19 (8700): Guest Log: [INFO] Theory application starting. Check log files. 2019-11-08 16:58:21 (8700): Guest Log: [DEBUG] HTCondor ping 2019-11-08 16:58:23 (8700): Guest Log: [DEBUG] 0 2019-11-08 16:59:29 (8700): Guest Log: [[IINNFFOO]] NNeeww JJoobb SSttaarrttiinngg iinn sslloott21 2019-11-08 16:59:29 (8700): Guest Log: [[IINNFFOO]] NNeeww JJoobb SSttaarrttiinngg iinn sslloott21 2019-11-08 16:59:29 (8700): Guest Log: [INNFFOO]] CCoonnddoorr JJoobbIIDD:: 55114454444..3485 iin slsloot12 2019-11-08 16:59:30 (8700): Guest Log: [INNFFOO]] CCoonnddoorr JJoobbIIDD:: 55114454444..3485 iin slsloot12 2019-11-08 16:59:36 (8700): Guest Log: [INFO] MCPlots JobID: 52032308 in slot1 2019-11-08 16:59:36 (8700): Guest Log: [INFO] MCPlots JobID: 52032344 in slot2 2019-11-08 16:59:41 (8700): Guest Log: [INFO] ===> [runRivet] Fri Nov 8 23:59:30 CET 2019 [boinc pp jets 7000 20,-,210 - herwig++ 2.6.0 LHC-UE-EE-SCR-CTEQ6L1 100000 156] 2019-11-08 16:59:42 (8700): Guest Log: [INFO] ===> [runRivet] Fri Nov 8 23:59:30 CET 2019 [boinc pp jets 7000 350 - pythia6 6.428 dw 100000 156] 2019-11-08 17:19:39 (8700): Guest Log: [INFO] New Job Starting in slot3 2019-11-08 17:19:40 (8700): Guest Log: [INFO] Condor JobID: 514546.31 in slot3 2019-11-08 17:19:51 (8700): Guest Log: [INFO] MCPlots JobID: 52032623 in slot3 2019-11-08 17:20:01 (8700): Guest Log: [INFO] ===> [runRivet] Sat Nov 9 00:19:44 CET 2019 [boinc pp jets 13000 250,-,4160 - pythia6 6.426 default 100000 156] 2019-11-08 17:43:42 (8700): Stopping VM. 2019-11-08 17:51:29 (4360): Detected: vboxwrapper 26197 2019-11-08 17:51:29 (4360): Detected: BOINC client v7.7 2019-11-08 17:51:30 (4360): Detected: VirtualBox VboxManage Interface (Version: 5.2.6) 2019-11-08 17:51:30 (4360): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2019-11-08 17:51:31 (4360): Starting VM using VBoxManage interface. (boinc_307da26f82b89cb5, slot#7) 2019-11-08 17:51:46 (4360): Successfully started VM. (PID = '8856') 2019-11-08 17:51:46 (4360): Reporting VM Process ID to BOINC. 2019-11-08 17:51:46 (4360): VM state change detected. (old = 'PoweredOff', new = 'Running') 2019-11-08 17:51:46 (4360): Preference change detected 2019-11-08 17:51:46 (4360): Setting CPU throttle for VM. (40%) 2019-11-08 17:51:50 (4360): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 180 seconds) or (Vbox_job.xml: 600 seconds)) 2019-11-08 17:53:01 (4360): Stopping VM. 2019-11-11 12:57:18 (4484): Detected: vboxwrapper 26197 2019-11-11 12:57:18 (4484): Detected: BOINC client v7.7 2019-11-11 12:57:20 (4484): Detected: VirtualBox VboxManage Interface (Version: 5.2.6) 2019-11-11 12:57:20 (4484): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2019-11-11 12:57:20 (4484): Starting VM using VBoxManage interface. (boinc_307da26f82b89cb5, slot#7) 2019-11-11 12:57:35 (4484): Successfully started VM. (PID = '8244') 2019-11-11 12:57:35 (4484): Reporting VM Process ID to BOINC. 2019-11-11 12:57:35 (4484): Guest Log: 00:56:59.256432 timesync vgsvcTimeSyncWorker: Radical host time change: 241 482 329 000 000ns (HostNow=1 573 498 654 932 000 000 ns HostLast=1 573 257 172 603 000 000 ns) 2019-11-11 12:57:35 (4484): VM state change detected. (old = 'PoweredOff', new = 'Running') 2019-11-11 12:57:35 (4484): Preference change detected 2019-11-11 12:57:35 (4484): Setting CPU throttle for VM. (40%) 2019-11-11 12:57:36 (4484): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 180 seconds) or (Vbox_job.xml: 600 seconds)) 2019-11-11 12:57:45 (4484): Guest Log: 00:57:09.399579 timesync vgsvcTimeSyncWorker: Radical guest time change: 241 482 451 056 000ns (GuestNow=1 573 498 665 082 858 000 ns GuestLast=1 573 257 182 631 802 000 ns fSetTimeLastLoop=true ) 2019-11-11 13:08:41 (4484): Guest Log: [ERROR] Condor ended after 245421 seconds. 2019-11-11 13:08:41 (4484): Guest Log: [INFO] Shutting Down. 2019-11-11 13:08:41 (4484): VM Completion File Detected. 2019-11-11 13:08:41 (4484): VM Completion Message: Condor ended after 245421 seconds. . 2019-11-11 13:08:41 (4484): Powering off VM. 2019-11-11 13:13:43 (4484): VM did not power off when requested. 2019-11-11 13:13:43 (4484): VM was successfully terminated. 2019-11-11 13:13:43 (4484): Deregistering VM. (boinc_307da26f82b89cb5, slot#7) 2019-11-11 13:13:43 (4484): Removing network bandwidth throttle group from VM. 2019-11-11 13:13:44 (4484): Removing VM from VirtualBox. 13:13:49 (4484): called boinc_finish(1) </stderr_txt> ]]>
©2026 CERN