| Name | Theory_267811_1572761347.709699_0 |
| Workunit | 125991007 |
| Created | 3 Nov 2019, 6:09:12 UTC |
| Sent | 3 Nov 2019, 12:17:27 UTC |
| Report deadline | 4 Dec 2019, 12:17:27 UTC |
| Received | 29 Nov 2019, 14:10:26 UTC |
| Server state | Over |
| Outcome | Success |
| Client state | Done |
| Exit status | 0 (0x00000000) |
| Computer ID | 10504105 |
| Run time | 1 days 15 hours 11 min 1 sec |
| CPU time | 5 days 21 hours 49 min 44 sec |
| Validate state | Valid |
| Credit | 4,029.97 |
| Device peak FLOPS | 12.34 GFLOPS |
| Application version | Theory Simulation v263.98 (vbox64_mt_mcore) windows_x86_64 |
| Peak working set size | 83.78 MB |
| Peak swap size | 98.67 MB |
| Peak disk usage | 1.84 GB |
Stderr output
<core_client_version>7.14.2</core_client_version> <![CDATA[ <stderr_txt> 0000 seconds) 2019-11-07 11:26:44 (13232): Starting VM using VBoxManage interface. (boinc_d88e59e995146365, slot#6) 2019-11-07 11:26:55 (13232): Successfully started VM. (PID = '2604') 2019-11-07 11:26:55 (13232): Reporting VM Process ID to BOINC. 2019-11-07 11:26:55 (13232): Guest Log: BIOS: VirtualBox 5.2.8 2019-11-07 11:26:55 (13232): Guest Log: CPUID EDX: 0x178bfbff 2019-11-07 11:26:55 (13232): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63 2019-11-07 11:26:55 (13232): VM state change detected. (old = 'PoweredOff', new = 'Running') 2019-11-07 11:26:55 (13232): Detected: Web Application Enabled (http://localhost:64165) 2019-11-07 11:26:55 (13232): Status Report: Job Duration: '129600.000000' 2019-11-07 11:26:55 (13232): Status Report: Elapsed Time: '11728.590588' 2019-11-07 11:26:55 (13232): Status Report: CPU Time: '46634.890625' 2019-11-07 11:26:55 (13232): Preference change detected 2019-11-07 11:26:55 (13232): Setting CPU throttle for VM. (100%) 2019-11-07 11:26:56 (13232): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 600 seconds) or (Vbox_job.xml: 600 seconds)) 2019-11-07 11:26:58 (13232): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2019-11-07 11:26:58 (13232): Guest Log: BIOS: Booting from Hard Disk... 2019-11-07 11:27:02 (13232): Guest Log: BIOS: KBD: unsupported int 16h function 03 2019-11-07 11:27:02 (13232): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2019-11-07 11:27:37 (13232): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2019-11-07 11:27:37 (13232): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2019-11-07 11:28:51 (13232): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log 2019-11-07 11:28:51 (13232): Guest Log: 00:00:00.000579 main Log opened 2019-11-07T10:28:51.097110000Z 2019-11-07 11:28:51 (13232): Guest Log: 00:00:00.000843 main OS Product: Linux 2019-11-07 11:28:51 (13232): Guest Log: 00:00:00.000952 main OS Release: 4.14.44-11.cernvm.x86_64 2019-11-07 11:28:51 (13232): Guest Log: 00:00:00.001190 main OS Version: #1 SMP Mon May 28 16:49:00 CEST 2018 2019-11-07 11:28:51 (13232): Guest Log: 00:00:00.001317 main Executable: /usr/share/vboxguest52/usr/sbin/VBoxService 2019-11-07 11:28:51 (13232): Guest Log: 00:00:00.001321 main Process ID: 3003 2019-11-07 11:28:51 (13232): Guest Log: 00:00:00.001323 main Package type: LINUX_64BITS_GENERIC 2019-11-07 11:28:51 (13232): Guest Log: 00:00:00.004954 main 5.2.6 r120293 started. Verbose level = 0 2019-11-07 11:29:45 (13232): Guest Log: [INFO] Mounting the shared directory 2019-11-07 11:29:45 (13232): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor 2019-11-07 11:29:45 (13232): Guest Log: [DEBUG] Testing network connection to cern.ch on port 80 2019-11-07 11:29:45 (13232): Guest Log: [DEBUG] Connection to cern.ch 80 port [tcp/http] succeeded! 2019-11-07 11:29:45 (13232): Guest Log: [DEBUG] 0 2019-11-07 11:29:45 (13232): Guest Log: [DEBUG] Testing VCCS connection to vccs.cern.ch on port 443 2019-11-07 11:29:45 (13232): Guest Log: [DEBUG] Connection to vccs.cern.ch 443 port [tcp/https] succeeded! 2019-11-07 11:29:46 (13232): Guest Log: [DEBUG] 0 2019-11-07 11:29:46 (13232): Guest Log: [DEBUG] Testing connection to Condor server on port 9618 2019-11-07 11:29:46 (13232): Guest Log: [DEBUG] Connection to vccondor01.cern.ch 9618 port [tcp/condor] succeeded! 2019-11-07 11:29:46 (13232): Guest Log: [DEBUG] 0 2019-11-07 11:30:56 (13232): Guest Log: [DEBUG] Probing CVMFS ... 2019-11-07 11:31:01 (13232): Guest Log: Probing /cvmfs/grid.cern.ch... OK 2019-11-07 11:31:03 (13232): 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 11:31:03 (13232): Guest Log: 2.4.4.0 3697 1 26020 10681 3 1 370087 10240000 2 65024 0 3 100 0 0 http://s1cern-cvmfs.openhtc.io/cvmfs/grid.cern.ch DIRECT 1 2019-11-07 11:31:12 (13232): Guest Log: [INFO] Reading volunteer information 2019-11-07 11:31:12 (13232): Guest Log: [INFO] Volunteer: bhm5 (5326) 2019-11-07 11:31:12 (13232): Guest Log: [INFO] VMID: e5b01749-9626-457a-8945-16c64690aa2f 2019-11-07 11:31:12 (13232): Guest Log: [INFO] Requesting an X509 credential from LHC@home 2019-11-07 11:31:14 (13232): Guest Log: [INFO] Running the fast benchmark. 2019-11-07 11:36:23 (13232): Guest Log: [INFO] Machine performance 6.54 HEPSPEC06 2019-11-07 11:36:23 (13232): Guest Log: [INFO] Theory application starting. Check log files. 2019-11-07 11:36:24 (13232): Guest Log: [DEBUG] HTCondor ping 2019-11-07 11:36:27 (13232): Guest Log: [DEBUG] 0 2019-11-07 11:37:38 (13232): Guest Log: [INFO] New Job Starting in slot1 2019-11-07 11:37:39 (13232): Guest Log: [INFO] Condor JobID: 514383.97 in slot1 2019-11-07 11:37:39 (13232): Guest Log: [INFO] New Job Starting in slot2 2019-11-07 11:37:40 (13232): Guest Log: [INFO] Condor JobID: 514383.98 in slot2 2019-11-07 11:37:49 (13232): Guest Log: [INFO] MCPlots JobID: 52011565 in slot1 2019-11-07 11:37:49 (13232): Guest Log: [INFO] MCPlots JobID: 52011584 in slot2 2019-11-07 11:37:52 (13232): Guest Log: [INFO] ===> [runRivet] Thu Nov 7 11:37:41 CET 2019 [boinc pp z1j 7000 150 - pythia6 6.428 349 100000 155] 2019-11-07 11:37:52 (13232): Guest Log: [INFO] ===> [runRivet] Thu Nov 7 11:37:42 CET 2019 [boinc pp zinclusive 7000 20,-,50,200 - pythia6 6.428 p0 100000 155] 2019-11-07 11:57:35 (13232): Guest Log: [INFO] New Job Starting in slot3 2019-11-07 11:57:36 (13232): Guest Log: [INFO] New Job Starting in slot4 2019-11-07 11:57:39 (13232): Guest Log: [INFO] Condor JobID: 514385.2 in slot3 2019-11-07 11:57:42 (13232): Guest Log: [INFO] Condor JobID: 514385.4 in slot4 2019-11-07 11:57:54 (13232): Guest Log: [INFO] MCPlots JobID: 52011896 in slot3 2019-11-07 11:57:54 (13232): Guest Log: [INFO] MCPlots JobID: 52011841 in slot4 2019-11-07 11:58:02 (13232): Guest Log: [INFO] ===> [runRivet] Thu Nov 7 11:57:45 CET 2019 [boinc ee zhad 206 - - pythia8 8.235 tune-fischer1 100000 155] 2019-11-07 11:58:03 (13232): Guest Log: [INFO] ===> [runRivet] Thu Nov 7 11:57:46 CET 2019 [boinc ppbar jets 1960 17 - pythia8 8.235 tune-4cx 100000 155] 2019-11-07 13:16:50 (13232): Status Report: Job Duration: '129600.000000' 2019-11-07 13:16:50 (13232): Status Report: Elapsed Time: '17729.562979' 2019-11-07 13:16:50 (13232): Status Report: CPU Time: '68307.687500' 2019-11-07 14:38:01 (13232): Guest Log: [INFO] Job finished in slot3 with 0. 2019-11-07 14:38:06 (13232): Guest Log: [INFO] New Job Starting in slot3 2019-11-07 14:38:07 (13232): Guest Log: [INFO] Condor JobID: 514033.48 in slot3 2019-11-07 14:38:15 (13232): Guest Log: [INFO] MCPlots JobID: 51963139 in slot3 2019-11-07 14:38:19 (13232): Guest Log: [INFO] ===> [runRivet] Thu Nov 7 14:38:09 CET 2019 [boinc pp jets 7000 600 - pythia8 8.235 fischerPP1 100000 148] 2019-11-07 15:03:52 (13232): Status Report: Job Duration: '129600.000000' 2019-11-07 15:03:52 (13232): Status Report: Elapsed Time: '23738.423836' 2019-11-07 15:03:52 (13232): Status Report: CPU Time: '92252.453125' 2019-11-07 16:52:41 (13232): Status Report: Job Duration: '129600.000000' 2019-11-07 16:52:41 (13232): Status Report: Elapsed Time: '29739.272013' 2019-11-07 16:52:41 (13232): Status Report: CPU Time: '115904.578125' 2019-11-07 18:39:15 (13232): Status Report: Job Duration: '129600.000000' 2019-11-07 18:39:15 (13232): Status Report: Elapsed Time: '35739.763726' 2019-11-07 18:39:15 (13232): Status Report: CPU Time: '139024.171875' 2019-11-07 19:12:56 (13232): Guest Log: [INFO] Job finished in slot2 with 0. 2019-11-07 19:13:32 (13232): Guest Log: [INFO] New Job Starting in slot2 2019-11-07 19:13:41 (13232): Guest Log: [INFO] Condor JobID: 514231.60 in slot2 2019-11-07 19:13:48 (13232): Guest Log: [INFO] MCPlots JobID: 51988543 in slot2 2019-11-07 19:13:48 (13232): Guest Log: [INFO] ===> [runRivet] Thu Nov 7 19:13:14 CET 2019 [boinc pp ttbar 7000 - - pythia6 6.428 374 100000 148] 2019-11-07 19:25:31 (13232): Stopping VM. 2019-11-07 19:25:32 (13232): Error in stop VM for VM: -108 Command: VBoxManage -q controlvm "boinc_d88e59e995146365" savestate Output: 2019-11-07 19:25:32 (13232): VM did not stop when requested. 2019-11-07 19:25:32 (13232): VM was NOT successfully terminated. 2019-11-08 10:26:40 (21876): Detected: vboxwrapper 26197 2019-11-08 10:26:40 (21876): Detected: BOINC client v7.7 2019-11-08 10:26:51 (21876): Detected: VirtualBox VboxManage Interface (Version: 5.2.8) 2019-11-08 10:26:51 (21876): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2019-11-08 10:26:53 (21876): Starting VM using VBoxManage interface. (boinc_d88e59e995146365, slot#6) 2019-11-08 10:27:05 (21876): Successfully started VM. (PID = '20648') 2019-11-08 10:27:05 (21876): Reporting VM Process ID to BOINC. 2019-11-08 10:27:05 (21876): Guest Log: BIOS: VirtualBox 5.2.8 2019-11-08 10:27:05 (21876): Guest Log: CPUID EDX: 0x178bfbff 2019-11-08 10:27:05 (21876): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63 2019-11-08 10:27:05 (21876): VM state change detected. (old = 'PoweredOff', new = 'Running') 2019-11-08 10:27:05 (21876): Detected: Web Application Enabled (http://localhost:64165) 2019-11-08 10:27:05 (21876): Status Report: Job Duration: '129600.000000' 2019-11-08 10:27:05 (21876): Status Report: Elapsed Time: '38294.364502' 2019-11-08 10:27:05 (21876): Status Report: CPU Time: '149436.921875' 2019-11-08 10:27:05 (21876): Preference change detected 2019-11-08 10:27:05 (21876): Setting CPU throttle for VM. (100%) 2019-11-08 10:27:06 (21876): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 600 seconds) or (Vbox_job.xml: 600 seconds)) 2019-11-08 10:27:07 (21876): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2019-11-08 10:27:07 (21876): Guest Log: BIOS: Booting from Hard Disk... 2019-11-08 10:27:10 (21876): Guest Log: BIOS: KBD: unsupported int 16h function 03 2019-11-08 10:27:10 (21876): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2019-11-08 10:27:46 (21876): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2019-11-08 10:27:46 (21876): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2019-11-08 10:28:54 (21876): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log 2019-11-08 10:28:54 (21876): Guest Log: 00:00:00.000347 main Log opened 2019-11-08T09:28:55.324398000Z 2019-11-08 10:28:54 (21876): Guest Log: 00:00:00.000641 main OS Product: Linux 2019-11-08 10:28:54 (21876): Guest Log: 00:00:00.000714 main OS Release: 4.14.44-11.cernvm.x86_64 2019-11-08 10:28:54 (21876): Guest Log: 00:00:00.000881 main OS Version: #1 SMP Mon May 28 16:49:00 CEST 2018 2019-11-08 10:28:54 (21876): Guest Log: 00:00:00.000948 main Executable: /usr/share/vboxguest52/usr/sbin/VBoxService 2019-11-08 10:28:54 (21876): Guest Log: 00:00:00.000951 main Process ID: 3015 2019-11-08 10:28:54 (21876): Guest Log: 00:00:00.000952 main Package type: LINUX_64BITS_GENERIC 2019-11-08 10:28:54 (21876): Guest Log: 00:00:00.003341 main 5.2.6 r120293 started. Verbose level = 0 2019-11-08 10:29:47 (21876): Guest Log: [INFO] Mounting the shared directory 2019-11-08 10:29:48 (21876): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor 2019-11-08 10:29:48 (21876): Guest Log: [DEBUG] Testing network connection to cern.ch on port 80 2019-11-08 10:29:49 (21876): Guest Log: [DEBUG] Connection to cern.ch 80 port [tcp/http] succeeded! 2019-11-08 10:29:49 (21876): Guest Log: [DEBUG] 0 2019-11-08 10:29:49 (21876): Guest Log: [DEBUG] Testing VCCS connection to vccs.cern.ch on port 443 2019-11-08 10:29:49 (21876): Guest Log: [DEBUG] Connection to vccs.cern.ch 443 port [tcp/https] succeeded! 2019-11-08 10:29:49 (21876): Guest Log: [DEBUG] 0 2019-11-08 10:29:49 (21876): Guest Log: [DEBUG] Testing connection to Condor server on port 9618 2019-11-08 10:29:50 (21876): Guest Log: [DEBUG] Connection to vccondor01.cern.ch 9618 port [tcp/condor] succeeded! 2019-11-08 10:29:50 (21876): Guest Log: [DEBUG] 0 2019-11-08 10:31:00 (21876): Guest Log: [DEBUG] Probing CVMFS ... 2019-11-08 10:31:04 (21876): Guest Log: Probing /cvmfs/grid.cern.ch... OK 2019-11-08 10:31:06 (21876): 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 10:31:06 (21876): Guest Log: 2.4.4.0 3709 1 25772 10689 3 1 478194 10240001 2 65024 0 3 100 0 0 http://s1ral-cvmfs.openhtc.io/cvmfs/grid.cern.ch DIRECT 1 2019-11-08 10:31:13 (21876): Guest Log: [INFO] Reading volunteer information 2019-11-08 10:31:14 (21876): Guest Log: [INFO] Volunteer: bhm5 (5326) 2019-11-08 10:31:14 (21876): Guest Log: [INFO] VMID: e5b01749-9626-457a-8945-16c64690aa2f 2019-11-08 10:31:15 (21876): Guest Log: [INFO] Requesting an X509 credential from LHC@home 2019-11-08 10:31:17 (21876): Guest Log: [INFO] Running the fast benchmark. 2019-11-08 10:37:25 (21876): Guest Log: [INFO] Machine performance 5.63 HEPSPEC06 2019-11-08 10:37:25 (21876): Guest Log: [INFO] Theory application starting. Check log files. 2019-11-08 10:37:26 (21876): Guest Log: [DEBUG] HTCondor ping 2019-11-08 10:37:30 (21876): Guest Log: [DEBUG] 0 2019-11-08 10:37:54 (21876): Guest Log: [INFO] New Job Starting in slot2 2019-11-08 10:37:54 (21876): Guest Log: [INFO] New Job Starting in slot1 2019-11-08 10:37:55 (21876): Guest Log: [INFO] Condor JobID: 514472.7 in slot2 2019-11-08 10:37:55 (21876): Guest Log: [INFO] Condor JobID: 514472.6 in slot1 2019-11-08 10:38:01 (21876): Guest Log: [INFO] MCPlots JobID: 52022705 in slot2 2019-11-08 10:38:02 (21876): Guest Log: [INFO] MCPlots JobID: 52022724 in slot1 2019-11-08 10:38:07 (21876): Guest Log: [INFO] ===> [runRivet] Fri Nov 8 10:37:59 CET 2019 [boinc ppbar jets 1960 90 - pythia6 6.427 346 100000 156] 2019-11-08 10:38:07 (21876): Guest Log: [INFO] ===> [runRivet] Fri Nov 8 10:37:59 CET 2019 [boinc ppbar jets 1960 17 - pythia8 8.205 default-noFsr 100000 156] 2019-11-08 10:58:59 (21876): Guest Log: [INFO] New Job Starting in slot3 2019-11-08 10:59:03 (21876): Guest Log: [INFO] New Job Starting in slot4 2019-11-08 10:59:03 (21876): Guest Log: [INFO] Condor JobID: 514473.41 in slot3 2019-11-08 10:59:06 (21876): Guest Log: [INFO] Condor JobID: 514473.49 in slot4 2019-11-08 10:59:23 (21876): Guest Log: [INFO] MCPlots JobID: 52022774 in slot3 2019-11-08 10:59:34 (21876): Guest Log: [INFO] MCPlots JobID: 52022769 in slot4 2019-11-08 10:59:39 (21876): Guest Log: [INFO] ===> [runRivet] Fri Nov 8 10:59:12 CET 2019 [boinc pp jets 8000 250,-,4160 - herwig++ 2.6.0 default 100000 156] 2019-11-08 10:59:47 (21876): Guest Log: [INFO] ===> [runRivet] Fri Nov 8 10:59:16 CET 2019 [boinc pp w1j 7000 125 - herwig7 7.0.2 UE-MMHT 100000 156] 2019-11-08 12:16:26 (21876): Status Report: Job Duration: '129600.000000' 2019-11-08 12:16:26 (21876): Status Report: Elapsed Time: '44295.305262' 2019-11-08 12:16:26 (21876): Status Report: CPU Time: '171404.093750' 2019-11-08 13:44:56 (21876): VM state change detected. (old = 'Running', new = 'Paused') 2019-11-08 14:47:10 (21876): Error in resume VM for VM: -182 Command: VBoxManage -q controlvm "boinc_d88e59e995146365" resume Output: 2019-11-08 14:47:11 (21876): Guest Log: 03:16:09.514637 timesync vgsvcTimeSyncWorker: Radical host time change: 3 444 120 000 000ns (HostNow=1 573 220 529 154 000 000 ns HostLast=1 573 217 085 034 000 000 ns) 2019-11-08 14:47:11 (21876): Guest Log: 03:16:19.515453 timesync vgsvcTimeSyncWorker: Radical guest time change: 3 433 962 258 000ns (GuestNow=1 573 220 539 155 819 000 ns GuestLast=1 573 217 105 193 561 000 ns fSetTimeLastLoop=true ) 2019-11-08 14:47:11 (21876): VM state change detected. (old = 'Paused', new = 'Running') 2019-11-08 15:11:30 (21876): Status Report: Job Duration: '129600.000000' 2019-11-08 15:11:31 (21876): Status Report: Elapsed Time: '50295.949730' 2019-11-08 15:11:31 (21876): Status Report: CPU Time: '197781.171875' 2019-11-08 15:12:18 (21876): Guest Log: [INFO] Job finished in slot1 with 0. 2019-11-08 15:12:25 (21876): Guest Log: [INFO] New Job Starting in slot1 2019-11-08 15:12:25 (21876): Guest Log: [INFO] Condor JobID: 514497.30 in slot1 2019-11-08 15:12:32 (21876): Guest Log: [INFO] MCPlots JobID: 52026091 in slot1 2019-11-08 15:12:38 (21876): Guest Log: [INFO] ===> [runRivet] Fri Nov 8 15:12:29 CET 2019 [boinc pp jets 7000 - - pythia8 8.226 tune-AZ 100000 156] 2019-11-08 17:02:49 (21876): Status Report: Job Duration: '129600.000000' 2019-11-08 17:02:54 (21876): Status Report: Elapsed Time: '56296.162554' 2019-11-08 17:02:54 (21876): Status Report: CPU Time: '222627.062500' 2019-11-08 18:25:45 (21876): Guest Log: [INFO] Job finished in slot2 with 0. 2019-11-08 18:26:07 (21876): Guest Log: [INFO] New Job Starting in slot2 2019-11-08 18:26:14 (21876): Guest Log: [INFO] Condor JobID: 514515.29 in slot2 2019-11-08 18:26:41 (21876): Guest Log: [INFO] MCPlots JobID: 52028333 in slot2 2019-11-08 18:26:53 (21876): Guest Log: [INFO] ===> [runRivet] Fri Nov 8 18:26:37 CET 2019 [boinc pp jets 7000 100 - pythia6 6.425 z2-lep 100000 156] 2019-11-08 18:55:01 (21876): Status Report: Job Duration: '129600.000000' 2019-11-08 18:55:01 (21876): Status Report: Elapsed Time: '62303.416014' 2019-11-08 18:55:01 (21876): Status Report: CPU Time: '247366.609375' 2019-11-08 19:29:08 (21876): Stopping VM. 2019-11-08 19:29:08 (21876): Error in stop VM for VM: -108 Command: VBoxManage -q controlvm "boinc_d88e59e995146365" savestate Output: 2019-11-08 19:29:08 (21876): VM did not stop when requested. 2019-11-08 19:29:08 (21876): VM was NOT successfully terminated. 2019-11-09 08:14:05 (22132): Detected: vboxwrapper 26197 2019-11-09 08:14:05 (22132): Detected: BOINC client v7.7 2019-11-09 08:14:18 (22132): Detected: VirtualBox VboxManage Interface (Version: 5.2.8) 2019-11-09 08:14:18 (22132): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2019-11-09 08:14:20 (22132): Starting VM using VBoxManage interface. (boinc_d88e59e995146365, slot#6) 2019-11-09 08:14:36 (22132): Successfully started VM. (PID = '17772') 2019-11-09 08:14:36 (22132): Reporting VM Process ID to BOINC. 2019-11-09 08:14:36 (22132): Guest Log: BIOS: VirtualBox 5.2.8 2019-11-09 08:14:36 (22132): Guest Log: CPUID EDX: 0x178bfbff 2019-11-09 08:14:36 (22132): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63 2019-11-09 08:14:36 (22132): VM state change detected. (old = 'PoweredOff', new = 'Running') 2019-11-09 08:14:36 (22132): Detected: Web Application Enabled (http://localhost:64165) 2019-11-09 08:14:36 (22132): Status Report: Job Duration: '129600.000000' 2019-11-09 08:14:36 (22132): Status Report: Elapsed Time: '64116.718412' 2019-11-09 08:14:36 (22132): Status Report: CPU Time: '255061.703125' 2019-11-09 08:14:36 (22132): Preference change detected 2019-11-09 08:14:36 (22132): Setting CPU throttle for VM. (100%) 2019-11-09 08:14:37 (22132): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 600 seconds) or (Vbox_job.xml: 600 seconds)) 2019-11-09 08:14:38 (22132): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2019-11-09 08:14:38 (22132): Guest Log: BIOS: Booting from Hard Disk... 2019-11-09 08:14:41 (22132): Guest Log: BIOS: KBD: unsupported int 16h function 03 2019-11-09 08:14:41 (22132): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2019-11-09 08:15:24 (22132): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2019-11-09 08:15:24 (22132): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2019-11-09 08:16:34 (22132): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log 2019-11-09 08:16:34 (22132): Guest Log: 00:00:00.000770 main Log opened 2019-11-09T07:16:35.547134000Z 2019-11-09 08:16:34 (22132): Guest Log: 00:00:00.001295 main OS Product: Linux 2019-11-09 08:16:34 (22132): Guest Log: 00:00:00.001437 main OS Release: 4.14.44-11.cernvm.x86_64 2019-11-09 08:16:34 (22132): Guest Log: 00:00:00.001514 main OS Version: #1 SMP Mon May 28 16:49:00 CEST 2018 2019-11-09 08:16:34 (22132): Guest Log: 00:00:00.001708 main Executable: /usr/share/vboxguest52/usr/sbin/VBoxService 2019-11-09 08:16:34 (22132): Guest Log: 00:00:00.001712 main Process ID: 3001 2019-11-09 08:16:34 (22132): Guest Log: 00:00:00.001714 main Package type: LINUX_64BITS_GENERIC 2019-11-09 08:16:34 (22132): Guest Log: 00:00:00.005391 main 5.2.6 r120293 started. Verbose level = 0 2019-11-09 08:17:38 (22132): Guest Log: [INFO] Mounting the shared directory 2019-11-09 08:17:38 (22132): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor 2019-11-09 08:17:38 (22132): Guest Log: [DEBUG] Testing network connection to cern.ch on port 80 2019-11-09 08:17:39 (22132): Guest Log: [DEBUG] Connection to cern.ch 80 port [tcp/http] succeeded! 2019-11-09 08:17:39 (22132): Guest Log: [DEBUG] 0 2019-11-09 08:17:39 (22132): Guest Log: [DEBUG] Testing VCCS connection to vccs.cern.ch on port 443 2019-11-09 08:17:40 (22132): Guest Log: [DEBUG] Connection to vccs.cern.ch 443 port [tcp/https] succeeded! 2019-11-09 08:17:40 (22132): Guest Log: [DEBUG] 0 2019-11-09 08:17:40 (22132): Guest Log: [DEBUG] Testing connection to Condor server on port 9618 2019-11-09 08:17:40 (22132): Guest Log: [DEBUG] Connection to vccondor01.cern.ch 9618 port [tcp/condor] succeeded! 2019-11-09 08:17:40 (22132): Guest Log: [DEBUG] 0 2019-11-09 08:18:51 (22132): Guest Log: [DEBUG] Probing CVMFS ... 2019-11-09 08:18:55 (22132): Guest Log: Probing /cvmfs/grid.cern.ch... OK 2019-11-09 08:18:58 (22132): 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-09 08:18:58 (22132): Guest Log: 2.4.4.0 3695 1 27840 10695 3 1 800713 10240000 2 65024 0 3 100 0 0 http://s1cern-cvmfs.openhtc.io/cvmfs/grid.cern.ch DIRECT 1 2019-11-09 08:19:09 (22132): Guest Log: [INFO] Reading volunteer information 2019-11-09 08:19:09 (22132): Guest Log: [INFO] Volunteer: bhm5 (5326) 2019-11-09 08:19:11 (22132): Guest Log: [INFO] VMID: e5b01749-9626-457a-8945-16c64690aa2f 2019-11-09 08:19:11 (22132): Guest Log: [INFO] Requesting an X509 credential from LHC@home 2019-11-09 08:19:15 (22132): Guest Log: [INFO] Running the fast benchmark. 2019-11-09 08:26:08 (22132): Guest Log: [INFO] Machine performance 5.40 HEPSPEC06 2019-11-09 08:26:08 (22132): Guest Log: [INFO] Theory application starting. Check log files. 2019-11-09 08:26:10 (22132): Guest Log: [DEBUG] HTCondor ping 2019-11-09 08:26:13 (22132): Guest Log: [DEBUG] 0 2019-11-09 08:27:33 (22132): Guest Log: [INFO] New Job Starting in slot2 2019-11-09 08:27:33 (22132): Guest Log: [INFO] New Job Starting in slot1 2019-11-09 08:27:33 (22132): Guest Log: [INFO] Condor JobID: 514577.79 in slot2 2019-11-09 08:27:33 (22132): Guest Log: [INFO] Condor JobID: 514577.77 in slot1 2019-11-09 08:27:38 (22132): Guest Log: [INFO] MCPlots JobID: 52036441 in slot2 2019-11-09 08:27:38 (22132): Guest Log: [INFO] MCPlots JobID: 52036480 in slot1 2019-11-09 08:27:48 (22132): Guest Log: [INFO] ===> [runRivet] Sat Nov 9 08:27:36 CET 2019 [boinc pp w1j 7000 250 - pythia8 8.186 early 100000 156] 2019-11-09 08:27:48 (22132): Guest Log: [INFO] ===> [runRivet] Sat Nov 9 08:27:36 CET 2019 [boinc pp ue 7000 - - pythia8 8.235 default 100000 156] 2019-11-09 08:42:17 (22132): Stopping VM. 2019-11-09 08:42:18 (22132): Error in stop VM for VM: -108 Command: VBoxManage -q controlvm "boinc_d88e59e995146365" savestate Output: 2019-11-09 08:42:18 (22132): VM did not stop when requested. 2019-11-09 08:42:18 (22132): VM was NOT successfully terminated. 2019-11-09 14:45:01 (19272): Detected: vboxwrapper 26197 2019-11-09 14:45:01 (19272): Detected: BOINC client v7.7 2019-11-09 14:45:11 (19272): Detected: VirtualBox VboxManage Interface (Version: 5.2.8) 2019-11-09 14:45:11 (19272): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2019-11-09 14:45:12 (19272): Starting VM using VBoxManage interface. (boinc_d88e59e995146365, slot#6) 2019-11-09 14:45:25 (19272): Successfully started VM. (PID = '20932') 2019-11-09 14:45:25 (19272): Reporting VM Process ID to BOINC. 2019-11-09 14:45:25 (19272): Guest Log: BIOS: VirtualBox 5.2.8 2019-11-09 14:45:25 (19272): Guest Log: CPUID EDX: 0x178bfbff 2019-11-09 14:45:25 (19272): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63 2019-11-09 14:45:25 (19272): VM state change detected. (old = 'PoweredOff', new = 'Running') 2019-11-09 14:45:25 (19272): Detected: Web Application Enabled (http://localhost:64165) 2019-11-09 14:45:25 (19272): Status Report: Job Duration: '129600.000000' 2019-11-09 14:45:25 (19272): Status Report: Elapsed Time: '65570.051504' 2019-11-09 14:45:25 (19272): Status Report: CPU Time: '258899.000000' 2019-11-09 14:45:25 (19272): Preference change detected 2019-11-09 14:45:25 (19272): Setting CPU throttle for VM. (100%) 2019-11-09 14:45:26 (19272): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 600 seconds) or (Vbox_job.xml: 600 seconds)) 2019-11-09 14:45:27 (19272): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2019-11-09 14:45:27 (19272): Guest Log: BIOS: Booting from Hard Disk... 2019-11-09 14:45:31 (19272): Guest Log: BIOS: KBD: unsupported int 16h function 03 2019-11-09 14:45:31 (19272): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2019-11-09 14:46:07 (19272): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2019-11-09 14:46:07 (19272): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2019-11-09 14:47:08 (19272): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log 2019-11-09 14:47:08 (19272): Guest Log: 00:00:00.000684 main Log opened 2019-11-09T13:47:10.123636000Z 2019-11-09 14:47:08 (19272): Guest Log: 00:00:00.001304 main OS Product: Linux 2019-11-09 14:47:08 (19272): Guest Log: 00:00:00.001427 main OS Release: 4.14.44-11.cernvm.x86_64 2019-11-09 14:47:08 (19272): Guest Log: 00:00:00.001558 main OS Version: #1 SMP Mon May 28 16:49:00 CEST 2018 2019-11-09 14:47:08 (19272): Guest Log: 00:00:00.001636 main Executable: /usr/share/vboxguest52/usr/sbin/VBoxService 2019-11-09 14:47:08 (19272): Guest Log: 00:00:00.001639 main Process ID: 3011 2019-11-09 14:47:08 (19272): Guest Log: 00:00:00.001640 main Package type: LINUX_64BITS_GENERIC 2019-11-09 14:47:08 (19272): Guest Log: 00:00:00.004873 main 5.2.6 r120293 started. Verbose level = 0 2019-11-09 14:47:52 (19272): Guest Log: [INFO] Mounting the shared directory 2019-11-09 14:47:52 (19272): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor 2019-11-09 14:47:52 (19272): Guest Log: [DEBUG] Testing network connection to cern.ch on port 80 2019-11-09 14:47:53 (19272): Guest Log: [DEBUG] Connection to cern.ch 80 port [tcp/http] succeeded! 2019-11-09 14:47:53 (19272): Guest Log: [DEBUG] 0 2019-11-09 14:47:53 (19272): Guest Log: [DEBUG] Testing VCCS connection to vccs.cern.ch on port 443 2019-11-09 14:47:53 (19272): Guest Log: [DEBUG] Connection to vccs.cern.ch 443 port [tcp/https] succeeded! 2019-11-09 14:47:53 (19272): Guest Log: [DEBUG] 0 2019-11-09 14:47:54 (19272): Guest Log: [DEBUG] Testing connection to Condor server on port 9618 2019-11-09 14:47:54 (19272): Guest Log: [DEBUG] Connection to vccondor01.cern.ch 9618 port [tcp/condor] succeeded! 2019-11-09 14:47:54 (19272): Guest Log: [DEBUG] 0 2019-11-09 14:49:02 (19272): Guest Log: [DEBUG] Probing CVMFS ... 2019-11-09 14:49:05 (19272): Guest Log: Probing /cvmfs/grid.cern.ch... OK 2019-11-09 14:49:09 (19272): 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-09 14:49:09 (19272): Guest Log: 2.4.4.0 3705 1 26072 10697 3 1 814184 10240001 2 65024 0 3 100 0 0 http://s1cern-cvmfs.openhtc.io/cvmfs/grid.cern.ch DIRECT 1 2019-11-09 14:49:13 (19272): Guest Log: [INFO] Reading volunteer information 2019-11-09 14:49:13 (19272): Guest Log: [INFO] Volunteer: bhm5 (5326) 2019-11-09 14:49:13 (19272): Guest Log: [INFO] VMID: e5b01749-9626-457a-8945-16c64690aa2f 2019-11-09 14:49:14 (19272): Guest Log: [INFO] Requesting an X509 credential from LHC@home 2019-11-09 14:49:16 (19272): Guest Log: [INFO] Running the fast benchmark. 2019-11-09 14:54:41 (19272): Guest Log: [INFO] Machine performance 6.04 HEPSPEC06 2019-11-09 14:54:42 (19272): Guest Log: [INFO] Theory application starting. Check log files. 2019-11-09 14:54:44 (19272): Guest Log: [DEBUG] HTCondor ping 2019-11-09 14:54:47 (19272): Guest Log: [DEBUG] 0 2019-11-09 14:56:02 (19272): Guest Log: [INFO] New Job Starting in slot2 2019-11-09 14:56:02 (19272): Guest Log: [INFO] Condor JobID: 514600.16 in slot2 2019-11-09 14:56:02 (19272): Guest Log: [INFO] New Job Starting in slot1 2019-11-09 14:56:02 (19272): Guest Log: [INFO] Condor JobID: 514600.14 in slot1 2019-11-09 14:56:07 (19272): Guest Log: [INFO] MCPlots JobID: 52039773 in slot2 2019-11-09 14:56:08 (19272): Guest Log: [INFO] MCPlots JobID: 52039787 in slot1 2019-11-09 14:56:13 (19272): Guest Log: [INFO] ===> [runRivet] Sat Nov 9 14:56:05 CET 2019 [boinc ppbar ue 1800 - - pythia6 6.428 psoft 100000 156] 2019-11-09 14:56:14 (19272): Guest Log: [INFO] ===> [runRivet] Sat Nov 9 14:56:05 CET 2019 [boinc ppbar mb-inelastic 630 - - pythia6 6.427 default 100000 156] 2019-11-09 15:16:04 (19272): Guest Log: [INFO] New Job Starting in slot4 2019-11-09 15:16:06 (19272): Guest Log: [INFO] New Job Starting in slot3 2019-11-09 15:16:12 (19272): Guest Log: [INFO] Condor JobID: 514601.36 in slot4 2019-11-09 15:16:13 (19272): Guest Log: [INFO] Condor JobID: 514601.34 in slot3 2019-11-09 15:16:31 (19272): Guest Log: [INFO] MCPlots JobID: 52039977 in slot3 2019-11-09 15:16:34 (19272): Guest Log: [INFO] MCPlots JobID: 52039898 in slot4 2019-11-09 15:16:42 (19272): Guest Log: [INFO] ===> [runRivet] Sat Nov 9 15:16:29 CET 2019 [boinc pp jets 7000 150 - pythia6 6.428 393 100000 156] 2019-11-09 15:16:42 (19272): Guest Log: [INFO] ===> [runRivet] Sat Nov 9 15:16:27 CET 2019 [boinc pp jets 7000 150,-,2360 - pythia8 8.212 tune-AU2m 100000 156] 2019-11-09 15:58:52 (19272): Guest Log: [INFO] Job finished in slot1 with 0. 2019-11-09 15:58:55 (19272): Guest Log: [INFO] New Job Starting in slot1 2019-11-09 15:58:56 (19272): Guest Log: [INFO] Condor JobID: 514603.67 in slot1 2019-11-09 15:59:03 (19272): Guest Log: [INFO] MCPlots JobID: 52040218 in slot1 2019-11-09 15:59:09 (19272): Guest Log: [INFO] ===> [runRivet] Sat Nov 9 15:59:00 CET 2019 [boinc pp jets 8000 800 - pythia6 6.425 357 100000 156] 2019-11-09 16:37:25 (19272): Status Report: Job Duration: '129600.000000' 2019-11-09 16:37:25 (19272): Status Report: Elapsed Time: '71570.248932' 2019-11-09 16:37:25 (19272): Status Report: CPU Time: '281999.625000' 2019-11-09 16:43:59 (19272): Guest Log: [INFO] Job finished in slot2 with 0. 2019-11-09 16:44:07 (19272): Guest Log: [INFO] New Job Starting in slot2 2019-11-09 16:44:12 (19272): Guest Log: [INFO] Condor JobID: 514606.147 in slot2 2019-11-09 16:44:19 (19272): Guest Log: [INFO] MCPlots JobID: 52040744 in slot2 2019-11-09 16:44:30 (19272): Guest Log: [INFO] ===> [runRivet] Sat Nov 9 16:44:13 CET 2019 [boinc pp ue 7000 - - pythia6 6.424 pnocr 100000 156] 2019-11-09 18:25:30 (19272): Status Report: Job Duration: '129600.000000' 2019-11-09 18:25:30 (19272): Status Report: Elapsed Time: '77571.775278' 2019-11-09 18:25:30 (19272): Status Report: CPU Time: '305399.218750' 2019-11-09 19:19:34 (19272): Stopping VM. 2019-11-10 06:53:56 (3800): Detected: vboxwrapper 26197 2019-11-10 06:53:56 (3800): Detected: BOINC client v7.7 2019-11-10 06:54:08 (3800): Detected: VirtualBox VboxManage Interface (Version: Unknown) 2019-11-10 06:54:09 (3800): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2019-11-10 06:54:11 (3800): Starting VM using VBoxManage interface. (boinc_d88e59e995146365, slot#6) 2019-11-10 06:54:28 (3800): Successfully started VM. (PID = '21444') 2019-11-10 06:54:28 (3800): Reporting VM Process ID to BOINC. 2019-11-10 06:54:28 (3800): Guest Log: BIOS: VirtualBox 5.2.8 2019-11-10 06:54:28 (3800): Guest Log: CPUID EDX: 0x178bfbff 2019-11-10 06:54:28 (3800): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63 2019-11-10 06:54:28 (3800): VM state change detected. (old = 'PoweredOff', new = 'Running') 2019-11-10 06:54:28 (3800): Detected: Web Application Enabled (http://localhost:64165) 2019-11-10 06:54:28 (3800): Status Report: Job Duration: '129600.000000' 2019-11-10 06:54:28 (3800): Status Report: Elapsed Time: '80484.557003' 2019-11-10 06:54:28 (3800): Status Report: CPU Time: '317492.031250' 2019-11-10 06:54:28 (3800): Preference change detected 2019-11-10 06:54:28 (3800): Setting CPU throttle for VM. (100%) 2019-11-10 06:54:28 (3800): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 600 seconds) or (Vbox_job.xml: 600 seconds)) 2019-11-10 06:54:30 (3800): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2019-11-10 06:54:30 (3800): Guest Log: BIOS: Booting from Hard Disk... 2019-11-10 06:54:34 (3800): Guest Log: BIOS: KBD: unsupported int 16h function 03 2019-11-10 06:54:34 (3800): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2019-11-10 06:55:29 (3800): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2019-11-10 06:55:29 (3800): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2019-11-10 06:56:29 (3800): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log 2019-11-10 06:56:29 (3800): Guest Log: 00:00:00.001032 main Log opened 2019-11-10T05:56:30.179086000Z 2019-11-10 06:56:29 (3800): Guest Log: 00:00:00.001646 main OS Product: Linux 2019-11-10 06:56:29 (3800): Guest Log: 00:00:00.001848 main OS Release: 4.14.44-11.cernvm.x86_64 2019-11-10 06:56:29 (3800): Guest Log: 00:00:00.001996 main OS Version: #1 SMP Mon May 28 16:49:00 CEST 2018 2019-11-10 06:56:29 (3800): Guest Log: 00:00:00.002282 main Executable: /usr/share/vboxguest52/usr/sbin/VBoxService 2019-11-10 06:56:29 (3800): Guest Log: 00:00:00.002288 main Process ID: 3010 2019-11-10 06:56:29 (3800): Guest Log: 00:00:00.002291 main Package type: LINUX_64BITS_GENERIC 2019-11-10 06:56:29 (3800): Guest Log: 00:00:00.006226 main 5.2.6 r120293 started. Verbose level = 0 2019-11-10 06:57:22 (3800): Guest Log: [INFO] Mounting the shared directory 2019-11-10 06:57:23 (3800): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor 2019-11-10 06:57:23 (3800): Guest Log: [DEBUG] Testing network connection to cern.ch on port 80 2019-11-10 06:57:23 (3800): Guest Log: [DEBUG] Connection to cern.ch 80 port [tcp/http] succeeded! 2019-11-10 06:57:24 (3800): Guest Log: [DEBUG] 0 2019-11-10 06:57:24 (3800): Guest Log: [DEBUG] Testing VCCS connection to vccs.cern.ch on port 443 2019-11-10 06:57:24 (3800): Guest Log: [DEBUG] Connection to vccs.cern.ch 443 port [tcp/https] succeeded! 2019-11-10 06:57:24 (3800): Guest Log: [DEBUG] 0 2019-11-10 06:57:25 (3800): Guest Log: [DEBUG] Testing connection to Condor server on port 9618 2019-11-10 06:57:25 (3800): Guest Log: [DEBUG] Connection to vccondor01.cern.ch 9618 port [tcp/condor] succeeded! 2019-11-10 06:57:25 (3800): Guest Log: [DEBUG] 0 2019-11-10 06:58:33 (3800): Guest Log: [DEBUG] Probing CVMFS ... 2019-11-10 06:58:37 (3800): Guest Log: Probing /cvmfs/grid.cern.ch... OK 2019-11-10 06:58:39 (3800): 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-10 06:58:39 (3800): Guest Log: 2.4.4.0 3704 1 28412 10703 3 1 962305 10240000 2 65024 0 3 100 0 0 http://s1cern-cvmfs.openhtc.io/cvmfs/grid.cern.ch DIRECT 1 2019-11-10 06:58:45 (3800): Guest Log: [INFO] Reading volunteer information 2019-11-10 06:58:47 (3800): Guest Log: [INFO] Volunteer: bhm5 (5326) 2019-11-10 06:58:47 (3800): Guest Log: [INFO] VMID: e5b01749-9626-457a-8945-16c64690aa2f 2019-11-10 06:58:47 (3800): Guest Log: [INFO] Requesting an X509 credential from LHC@home 2019-11-10 06:58:49 (3800): Guest Log: [INFO] Running the fast benchmark. 2019-11-10 07:04:23 (3800): Guest Log: [INFO] Machine performance 6.22 HEPSPEC06 2019-11-10 07:04:23 (3800): Guest Log: [INFO] Theory application starting. Check log files. 2019-11-10 07:04:26 (3800): Guest Log: [DEBUG] HTCondor ping 2019-11-10 07:04:28 (3800): Guest Log: [DEBUG] 0 2019-11-10 07:05:44 (3800): Guest Log: [INFO] New Job Starting in slot1 2019-11-10 07:05:44 (3800): Guest Log: [INFO] Condor JobID: 514665.55 in slot1 2019-11-10 07:05:45 (3800): Guest Log: [INFO] New Job Starting in slot2 2019-11-10 07:05:45 (3800): Guest Log: [INFO] Condor JobID: 514665.57 in slot2 2019-11-10 07:05:50 (3800): Guest Log: [INFO] MCPlots JobID: 52050521 in slot1 2019-11-10 07:05:51 (3800): Guest Log: [INFO] MCPlots JobID: 52050513 in slot2 2019-11-10 07:05:55 (3800): Guest Log: [INFO] ===> [runRivet] Sun Nov 10 07:05:48 CET 2019 [boinc pp jets 7000 80,-,1160 - pythia8 8.212 tune-4c 100000 156] 2019-11-10 07:05:56 (3800): Guest Log: [INFO] ===> [runRivet] Sun Nov 10 07:05:49 CET 2019 [boinc pp jets 7000 80,-,1360 - pythia8 8.235 default-MBR 100000 156] 2019-11-10 07:25:49 (3800): Guest Log: [INFO] New Job Starting in slot3 2019-11-10 07:25:53 (3800): Guest Log: [INFO] New Job Starting in slot4 2019-11-10 07:25:54 (3800): Guest Log: [INFO] Condor JobID: 514667.73 in slot3 2019-11-10 07:26:02 (3800): Guest Log: [INFO] Condor JobID: 514667.75 in slot4 2019-11-10 07:26:03 (3800): Guest Log: [INFO] MCPlots JobID: 52050908 in slot3 2019-11-10 07:26:04 (3800): Guest Log: [INFO] MCPlots JobID: 52050845 in slot4 2019-11-10 07:26:16 (3800): Guest Log: [INFO] ===> [runRivet] Sun Nov 10 07:26:01 CET 2019 [boinc pp jets 8000 150,-,1860 - pythia8 8.186 tune-1 100000 156] 2019-11-10 07:26:16 (3800): Guest Log: [INFO] ===> [runRivet] Sun Nov 10 07:26:02 CET 2019 [boinc pp jets 8000 150,-,2360 - pythia6 6.426 pro-q2o 100000 156] 2019-11-10 08:43:29 (3800): Status Report: Job Duration: '129600.000000' 2019-11-10 08:43:29 (3800): Status Report: Elapsed Time: '86485.389545' 2019-11-10 08:43:29 (3800): Status Report: CPU Time: '338991.765625' 2019-11-10 08:55:43 (3800): Stopping VM. 2019-11-10 08:55:45 (3800): Error in stop VM for VM: -108 Command: VBoxManage -q controlvm "boinc_d88e59e995146365" savestate Output: 2019-11-10 08:55:45 (3800): VM did not stop when requested. 2019-11-10 08:55:45 (3800): VM was NOT successfully terminated. 2019-11-10 09:49:31 (13688): Detected: vboxwrapper 26197 2019-11-10 09:49:32 (13688): Detected: BOINC client v7.7 2019-11-10 09:49:42 (13688): Detected: VirtualBox VboxManage Interface (Version: 5.2.8) 2019-11-10 09:49:42 (13688): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2019-11-10 09:49:43 (13688): Starting VM using VBoxManage interface. (boinc_d88e59e995146365, slot#6) 2019-11-10 09:50:01 (13688): Successfully started VM. (PID = '12456') 2019-11-10 09:50:01 (13688): Reporting VM Process ID to BOINC. 2019-11-10 09:50:01 (13688): Guest Log: BIOS: VirtualBox 5.2.8 2019-11-10 09:50:01 (13688): Guest Log: CPUID EDX: 0x178bfbff 2019-11-10 09:50:01 (13688): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63 2019-11-10 09:50:01 (13688): VM state change detected. (old = 'PoweredOff', new = 'Running') 2019-11-10 09:50:01 (13688): Detected: Web Application Enabled (http://localhost:64165) 2019-11-10 09:50:01 (13688): Status Report: Job Duration: '129600.000000' 2019-11-10 09:50:01 (13688): Status Report: Elapsed Time: '87187.033071' 2019-11-10 09:50:01 (13688): Status Report: CPU Time: '341477.937500' 2019-11-10 09:50:01 (13688): Preference change detected 2019-11-10 09:50:01 (13688): Setting CPU throttle for VM. (100%) 2019-11-10 09:50:01 (13688): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 600 seconds) or (Vbox_job.xml: 600 seconds)) 2019-11-10 09:50:03 (13688): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2019-11-10 09:50:03 (13688): Guest Log: BIOS: Booting from Hard Disk... 2019-11-10 09:50:08 (13688): Guest Log: BIOS: KBD: unsupported int 16h function 03 2019-11-10 09:50:08 (13688): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2019-11-10 09:50:58 (13688): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2019-11-10 09:50:58 (13688): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2019-11-10 09:52:08 (13688): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log 2019-11-10 09:52:08 (13688): Guest Log: 00:00:00.000872 main Log opened 2019-11-10T08:52:11.032034000Z 2019-11-10 09:52:08 (13688): Guest Log: 00:00:00.001525 main OS Product: Linux 2019-11-10 09:52:08 (13688): Guest Log: 00:00:00.001758 main OS Release: 4.14.44-11.cernvm.x86_64 2019-11-10 09:52:08 (13688): Guest Log: 00:00:00.002265 main OS Version: #1 SMP Mon May 28 16:49:00 CEST 2018 2019-11-10 09:52:08 (13688): Guest Log: 00:00:00.002382 main Executable: /usr/share/vboxguest52/usr/sbin/VBoxService 2019-11-10 09:52:08 (13688): Guest Log: 00:00:00.002385 main Process ID: 3022 2019-11-10 09:52:08 (13688): Guest Log: 00:00:00.002387 main Package type: LINUX_64BITS_GENERIC 2019-11-10 09:52:08 (13688): Guest Log: 00:00:00.005389 main 5.2.6 r120293 started. Verbose level = 0 2019-11-10 09:52:50 (13688): Guest Log: [INFO] Mounting the shared directory 2019-11-10 09:52:50 (13688): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor 2019-11-10 09:52:50 (13688): Guest Log: [DEBUG] Testing network connection to cern.ch on port 80 2019-11-10 09:52:51 (13688): Guest Log: [DEBUG] Connection to cern.ch 80 port [tcp/http] succeeded! 2019-11-10 09:52:51 (13688): Guest Log: [DEBUG] 0 2019-11-10 09:52:51 (13688): Guest Log: [DEBUG] Testing VCCS connection to vccs.cern.ch on port 443 2019-11-10 09:52:52 (13688): Guest Log: [DEBUG] Connection to vccs.cern.ch 443 port [tcp/https] succeeded! 2019-11-10 09:52:52 (13688): Guest Log: [DEBUG] 0 2019-11-10 09:52:52 (13688): Guest Log: [DEBUG] Testing connection to Condor server on port 9618 2019-11-10 09:52:52 (13688): Guest Log: [DEBUG] Connection to vccondor01.cern.ch 9618 port [tcp/condor] succeeded! 2019-11-10 09:52:52 (13688): Guest Log: [DEBUG] 0 2019-11-10 09:54:03 (13688): Guest Log: [DEBUG] Probing CVMFS ... 2019-11-10 09:54:11 (13688): Guest Log: Probing /cvmfs/grid.cern.ch... OK 2019-11-10 09:54:16 (13688): 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-10 09:54:16 (13688): Guest Log: 2.4.4.0 3716 1 28296 10705 3 1 970812 10240000 2 65024 0 3 100 0 0 http://s1ral-cvmfs.openhtc.io/cvmfs/grid.cern.ch DIRECT 1 2019-11-10 09:54:22 (13688): Guest Log: [INFO] Reading volunteer information 2019-11-10 09:54:23 (13688): Guest Log: [INFO] Volunteer: bhm5 (5326) 2019-11-10 09:54:24 (13688): Guest Log: [INFO] VMID: e5b01749-9626-457a-8945-16c64690aa2f 2019-11-10 09:54:25 (13688): Guest Log: [INFO] Requesting an X509 credential from LHC@home 2019-11-10 09:54:29 (13688): Guest Log: [INFO] Running the fast benchmark. 2019-11-10 10:00:29 (13688): Guest Log: [INFO] Machine performance 6.15 HEPSPEC06 2019-11-10 10:00:29 (13688): Guest Log: [INFO] Theory application starting. Check log files. 2019-11-10 10:00:33 (13688): Guest Log: [DEBUG] HTCondor ping 2019-11-10 10:00:36 (13688): Guest Log: [DEBUG] 0 2019-11-10 10:01:38 (13688): Guest Log: [INFO] New Job Starting in slot1 2019-11-10 10:01:39 (13688): Guest Log: [INFO] New Job Starting in slot2 2019-11-10 10:01:39 (13688): Guest Log: [INFO] Condor JobID: 514679.64 in slot1 2019-11-10 10:01:39 (13688): Guest Log: [INFO] Condor JobID: 514679.67 in slot2 2019-11-10 10:01:45 (13688): Guest Log: [INFO] MCPlots JobID: 52052536 in slot1 2019-11-10 10:01:45 (13688): Guest Log: [INFO] MCPlots JobID: 52052481 in slot2 2019-11-10 10:01:50 (13688): Guest Log: [INFO] ===> [runRivet] Sun Nov 10 10:01:44 CET 2019 [boinc pp softqcdall 7000 - - pythia8 8.186 default-noFsr 100000 156] 2019-11-10 10:01:51 (13688): Guest Log: [INFO] ===> [runRivet] Sun Nov 10 10:01:44 CET 2019 [boinc pp ue 200 4 - pythia8 8.212 tune-4c 100000 156] 2019-11-10 10:21:47 (13688): Guest Log: [INFO] New Job Starting in slot4 2019-11-10 10:21:50 (13688): Guest Log: [INFO] New Job Starting in slot3 2019-11-10 10:21:56 (13688): Guest Log: [INFO] Condor JobID: 514680.82 in slot4 2019-11-10 10:21:58 (13688): Guest Log: [INFO] Condor JobID: 514680.72 in slot3 2019-11-10 10:22:12 (13688): Guest Log: [INFO] MCPlots JobID: 52052660 in slot3 2019-11-10 10:22:16 (13688): Guest Log: [INFO] MCPlots JobID: 52052671 in slot4 2019-11-10 10:22:18 (13688): Guest Log: [INFO] ===> [runRivet] Sun Nov 10 10:22:13 CET 2019 [boinc pp mb-nsd 7000 - - pythia8 8.176 tune-4cx 100000 156] 2019-11-10 10:22:24 (13688): Guest Log: [INFO] ===> [runRivet] Sun Nov 10 10:22:13 CET 2019 [boinc pp w1j 7000 125 - pythia8 8.165 default 100000 156] 2019-11-10 11:07:52 (13688): Guest Log: [INFO] Job finished in slot2 with 0. 2019-11-10 11:08:15 (13688): Guest Log: [INFO] New Job Starting in slot2 2019-11-10 11:08:16 (13688): Guest Log: [INFO] Condor JobID: 514684.23 in slot2 2019-11-10 11:08:39 (13688): Guest Log: [INFO] MCPlots JobID: 52053100 in slot2 2019-11-10 11:08:53 (13688): Guest Log: [INFO] ===> [runRivet] Sun Nov 10 11:08:36 CET 2019 [boinc pp jets 7000 10 - pythia6 6.427 360 100000 156] 2019-11-10 11:34:08 (13688): Guest Log: [INFO] Job finished in slot1 with 0. 2019-11-10 11:34:17 (13688): Guest Log: [INFO] New Job Starting in slot1 2019-11-10 11:34:17 (13688): Guest Log: [INFO] Condor JobID: 514686.37 in slot1 2019-11-10 11:34:23 (13688): Guest Log: [INFO] MCPlots JobID: 52053372 in slot1 2019-11-10 11:34:30 (13688): Guest Log: [INFO] ===> [runRivet] Sun Nov 10 11:34:23 CET 2019 [boinc pp jets 8000 250,-,4160 - pythia8 8.180 default-CD 100000 156] 2019-11-10 11:39:11 (13688): Status Report: Job Duration: '129600.000000' 2019-11-10 11:39:12 (13688): Status Report: Elapsed Time: '93187.185296' 2019-11-10 11:39:15 (13688): Status Report: CPU Time: '363808.359375' 2019-11-10 13:27:35 (13688): Status Report: Job Duration: '129600.000000' 2019-11-10 13:27:35 (13688): Status Report: Elapsed Time: '99187.809232' 2019-11-10 13:27:35 (13688): Status Report: CPU Time: '387467.656250' 2019-11-10 15:15:00 (13688): Status Report: Job Duration: '129600.000000' 2019-11-10 15:15:00 (13688): Status Report: Elapsed Time: '105190.173231' 2019-11-10 15:15:00 (13688): Status Report: CPU Time: '411443.437500' 2019-11-10 16:09:39 (13688): Guest Log: [INFO] Job finished in slot3 with 0. 2019-11-10 16:09:47 (13688): Guest Log: [INFO] New Job Starting in slot3 2019-11-10 16:09:48 (13688): Guest Log: [INFO] Condor JobID: 514705.68 in slot3 2019-11-10 16:09:54 (13688): Guest Log: [INFO] MCPlots JobID: 52056012 in slot3 2019-11-10 16:10:01 (13688): Guest Log: [INFO] ===> [runRivet] Sun Nov 10 16:09:54 CET 2019 [boinc pp mb-inelastic 200 - - pythia8 8.186 tune-4c 100000 156] 2019-11-10 17:04:14 (13688): Status Report: Job Duration: '129600.000000' 2019-11-10 17:04:14 (13688): Status Report: Elapsed Time: '111190.558032' 2019-11-10 17:04:14 (13688): Status Report: CPU Time: '435821.953125' 2019-11-10 17:05:49 (13688): Guest Log: [INFO] Job finished in slot3 with 0. 2019-11-10 17:05:57 (13688): Guest Log: [INFO] New Job Starting in slot3 2019-11-10 17:06:01 (13688): Guest Log: [INFO] Condor JobID: 514709.70 in slot3 2019-11-10 17:06:06 (13688): Guest Log: [INFO] MCPlots JobID: 52056615 in slot3 2019-11-10 17:06:15 (13688): Guest Log: [INFO] ===> [runRivet] Sun Nov 10 17:06:05 CET 2019 [boinc pp mb-inelastic 13000 - - pythia6 6.428 352 100000 156] 2019-11-10 17:45:37 (13688): Guest Log: [INFO] Job finished in slot2 with 0. 2019-11-10 17:45:44 (13688): Guest Log: [INFO] New Job Starting in slot2 2019-11-10 17:45:44 (13688): Guest Log: [INFO] Condor JobID: 514713.8 in slot2 2019-11-10 17:45:52 (13688): Guest Log: [INFO] MCPlots JobID: 52057224 in slot2 2019-11-10 17:45:59 (13688): Guest Log: [INFO] ===> [runRivet] Sun Nov 10 17:45:50 CET 2019 [boinc ee zhad 43.6 - - pythia8 8.176 default 100000 156] 2019-11-10 18:25:53 (13688): Guest Log: [INFO] Job finished in slot2 with 0. 2019-11-10 18:26:06 (13688): Guest Log: [INFO] New Job Starting in slot2 2019-11-10 18:26:13 (13688): Guest Log: [INFO] Condor JobID: 514716.24 in slot2 2019-11-10 18:26:31 (13688): Guest Log: [INFO] MCPlots JobID: 52057652 in slot2 2019-11-10 18:26:45 (13688): Guest Log: [INFO] ===> [runRivet] Sun Nov 10 18:26:22 CET 2019 [boinc pp mb-inelastic 13000 - - pythia8 8.235 tune-AZ 100000 156] 2019-11-10 18:59:45 (13688): Status Report: Job Duration: '129600.000000' 2019-11-10 18:59:45 (13688): Status Report: Elapsed Time: '117191.442605' 2019-11-10 18:59:45 (13688): Status Report: CPU Time: '461756.000000' 2019-11-10 19:22:19 (13688): Stopping VM. 2019-11-10 19:22:20 (13688): Error in stop VM for VM: -108 Command: VBoxManage -q controlvm "boinc_d88e59e995146365" savestate Output: 2019-11-10 19:22:20 (13688): VM did not stop when requested. 2019-11-10 19:22:20 (13688): VM was NOT successfully terminated. 2019-11-11 07:35:45 (4236): Detected: vboxwrapper 26197 2019-11-11 07:35:45 (4236): Detected: BOINC client v7.7 2019-11-11 07:35:54 (4236): Detected: VirtualBox VboxManage Interface (Version: 5.2.8) 2019-11-11 07:35:55 (4236): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2019-11-11 07:35:56 (4236): Starting VM using VBoxManage interface. (boinc_d88e59e995146365, slot#6) 2019-11-11 07:36:12 (4236): Successfully started VM. (PID = '3656') 2019-11-11 07:36:12 (4236): Reporting VM Process ID to BOINC. 2019-11-11 07:36:12 (4236): Guest Log: BIOS: VirtualBox 5.2.8 2019-11-11 07:36:12 (4236): Guest Log: CPUID EDX: 0x178bfbff 2019-11-11 07:36:12 (4236): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63 2019-11-11 07:36:12 (4236): VM state change detected. (old = 'PoweredOff', new = 'Running') 2019-11-11 07:36:12 (4236): Detected: Web Application Enabled (http://localhost:64165) 2019-11-11 07:36:12 (4236): Status Report: Job Duration: '129600.000000' 2019-11-11 07:36:12 (4236): Status Report: Elapsed Time: '118397.791381' 2019-11-11 07:36:12 (4236): Status Report: CPU Time: '466856.640625' 2019-11-11 07:36:12 (4236): Preference change detected 2019-11-11 07:36:12 (4236): Setting CPU throttle for VM. (100%) 2019-11-11 07:36:13 (4236): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 600 seconds) or (Vbox_job.xml: 600 seconds)) 2019-11-11 07:36:14 (4236): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2019-11-11 07:36:14 (4236): Guest Log: BIOS: Booting from Hard Disk... 2019-11-11 07:36:19 (4236): Guest Log: BIOS: KBD: unsupported int 16h function 03 2019-11-11 07:36:19 (4236): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2019-11-11 07:37:23 (4236): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2019-11-11 07:37:23 (4236): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2019-11-11 07:38:31 (4236): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log 2019-11-11 07:38:31 (4236): Guest Log: 00:00:00.001419 main Log opened 2019-11-11T06:38:34.557608000Z 2019-11-11 07:38:31 (4236): Guest Log: 00:00:00.002586 main OS Product: Linux 2019-11-11 07:38:31 (4236): Guest Log: 00:00:00.002790 main OS Release: 4.14.44-11.cernvm.x86_64 2019-11-11 07:38:31 (4236): Guest Log: 00:00:00.002931 main OS Version: #1 SMP Mon May 28 16:49:00 CEST 2018 2019-11-11 07:38:31 (4236): Guest Log: 00:00:00.003054 main Executable: /usr/share/vboxguest52/usr/sbin/VBoxService 2019-11-11 07:38:31 (4236): Guest Log: 00:00:00.003059 main Process ID: 3013 2019-11-11 07:38:31 (4236): Guest Log: 00:00:00.003061 main Package type: LINUX_64BITS_GENERIC 2019-11-11 07:38:31 (4236): Guest Log: 00:00:00.006721 main 5.2.6 r120293 started. Verbose level = 0 2019-11-11 07:39:29 (4236): Guest Log: [INFO] Mounting the shared directory 2019-11-11 07:39:29 (4236): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor 2019-11-11 07:39:30 (4236): Guest Log: [DEBUG] Testing network connection to cern.ch on port 80 2019-11-11 07:39:30 (4236): Guest Log: [DEBUG] Connection to cern.ch 80 port [tcp/http] succeeded! 2019-11-11 07:39:30 (4236): Guest Log: [DEBUG] 0 2019-11-11 07:39:30 (4236): Guest Log: [DEBUG] Testing VCCS connection to vccs.cern.ch on port 443 2019-11-11 07:39:31 (4236): Guest Log: [DEBUG] Connection to vccs.cern.ch 443 port [tcp/https] succeeded! 2019-11-11 07:39:31 (4236): Guest Log: [DEBUG] 0 2019-11-11 07:39:31 (4236): Guest Log: [DEBUG] Testing connection to Condor server on port 9618 2019-11-11 07:39:31 (4236): Guest Log: [DEBUG] Connection to vccondor01.cern.ch 9618 port [tcp/condor] succeeded! 2019-11-11 07:39:32 (4236): Guest Log: [DEBUG] 0 2019-11-11 07:40:42 (4236): Guest Log: [DEBUG] Probing CVMFS ... 2019-11-11 07:40:46 (4236): Guest Log: Probing /cvmfs/grid.cern.ch... OK 2019-11-11 07:40:48 (4236): 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-11 07:40:48 (4236): Guest Log: 2.4.4.0 3707 1 25788 10711 3 1 1001404 10240001 2 65024 0 3 100 0 0 http://s1cern-cvmfs.openhtc.io/cvmfs/grid.cern.ch DIRECT 1 2019-11-11 07:40:54 (4236): Guest Log: [INFO] Reading volunteer information 2019-11-11 07:40:54 (4236): Guest Log: [INFO] Volunteer: bhm5 (5326) 2019-11-11 07:40:55 (4236): Guest Log: [INFO] VMID: e5b01749-9626-457a-8945-16c64690aa2f 2019-11-11 07:40:55 (4236): Guest Log: [INFO] Requesting an X509 credential from LHC@home 2019-11-11 07:40:58 (4236): Guest Log: [INFO] Running the fast benchmark. 2019-11-11 07:46:53 (4236): Guest Log: [INFO] Machine performance 6.15 HEPSPEC06 2019-11-11 07:46:53 (4236): Guest Log: [INFO] Theory application starting. Check log files. 2019-11-11 07:46:55 (4236): Guest Log: [DEBUG] HTCondor ping 2019-11-11 07:46:58 (4236): Guest Log: [DEBUG] 0 2019-11-11 07:47:33 (4236): Guest Log: [INFO] New Job Starting in slot1 2019-11-11 07:47:33 (4236): Guest Log: [INFO] New Job Starting in slot2 2019-11-11 07:47:33 (4236): Guest Log: [INFO] Condor JobID: 514764.22 in slot1 2019-11-11 07:47:33 (4236): Guest Log: [INFO] Condor JobID: 514764.23 in slot2 2019-11-11 07:47:38 (4236): Guest Log: [INFO] MCPlots JobID: 52065682 in slot1 2019-11-11 07:47:39 (4236): Guest Log: [INFO] MCPlots JobID: 52065665 in slot2 2019-11-11 07:47:44 (4236): Guest Log: [INFO] ===> [runRivet] Mon Nov 11 07:47:38 CET 2019 [boinc ppbar mb-inelastic 200 - - pythia8 8.212 tune-2m 100000 156] 2019-11-11 07:47:44 (4236): Guest Log: [INFO] ===> [runRivet] Mon Nov 11 07:47:38 CET 2019 [boinc ppbar mb-inelastic 200 - - sherpa 1.3.1 default 100000 156] 2019-11-11 08:07:39 (4236): Guest Log: [INFO] New Job Starting in slot3 2019-11-11 08:07:39 (4236): Guest Log: [INFO] New Job Starting in slot4 2019-11-11 08:07:46 (4236): Guest Log: [INFO] Condor JobID: 514765.6 in slot3 2019-11-11 08:07:46 (4236): Guest Log: [INFO] Condor JobID: 514765.8 in slot4 2019-11-11 08:07:51 (4236): Guest Log: [INFO] MCPlots JobID: 52065783 in slot4 2019-11-11 08:07:58 (4236): Guest Log: [INFO] MCPlots JobID: 52065804 in slot3 2019-11-11 08:08:03 (4236): Guest Log: [INFO] ===> [runRivet] Mon Nov 11 08:07:52 CET 2019 [boinc ppbar jets 1960 90 - pythia8 8.226 early 100000 156] 2019-11-11 08:08:06 (4236): Guest Log: [INFO] ===> [runRivet] Mon Nov 11 08:07:52 CET 2019 [boinc ppbar jets 1960 17 - pythia8 8.230 default-noFsr 100000 156] 2019-11-11 08:54:21 (4236): Guest Log: [INFO] Job finished in slot1 with 0. 2019-11-11 08:54:27 (4236): Guest Log: [INFO] New Job Starting in slot1 2019-11-11 08:54:28 (4236): Guest Log: [INFO] Condor JobID: 514768.51 in slot1 2019-11-11 08:54:35 (4236): Guest Log: [INFO] MCPlots JobID: 52066213 in slot1 2019-11-11 08:54:41 (4236): Guest Log: [INFO] ===> [runRivet] Mon Nov 11 08:54:35 CET 2019 [boinc pp jets 7000 - - pythia8 8.201 default-noRap 100000 156] 2019-11-11 09:37:31 (4236): Status Report: Job Duration: '129600.000000' 2019-11-11 09:37:31 (4236): Status Report: Elapsed Time: '124409.926368' 2019-11-11 09:37:31 (4236): Status Report: CPU Time: '492210.250000' 2019-11-11 11:09:54 (4236): VM state change detected. (old = 'Running', new = 'Paused') 2019-11-29 14:31:21 (7484): Detected: vboxwrapper 26197 2019-11-29 14:31:21 (7484): Detected: BOINC client v7.7 2019-11-29 14:31:22 (7484): Detected: VirtualBox VboxManage Interface (Version: 5.2.8) 2019-11-29 14:31:23 (7484): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2019-11-29 14:31:23 (7484): Starting VM using VBoxManage interface. (boinc_d88e59e995146365, slot#6) 2019-11-29 14:31:31 (7484): Successfully started VM. (PID = '12548') 2019-11-29 14:31:31 (7484): Reporting VM Process ID to BOINC. 2019-11-29 14:31:31 (7484): Guest Log: BIOS: VirtualBox 5.2.8 2019-11-29 14:31:31 (7484): Guest Log: CPUID EDX: 0x178bfbff 2019-11-29 14:31:31 (7484): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63 2019-11-29 14:31:31 (7484): VM state change detected. (old = 'PoweredOff', new = 'Running') 2019-11-29 14:31:31 (7484): Detected: Web Application Enabled (http://localhost:64165) 2019-11-29 14:31:31 (7484): Status Report: Job Duration: '129600.000000' 2019-11-29 14:31:31 (7484): Status Report: Elapsed Time: '128415.770375' 2019-11-29 14:31:31 (7484): Status Report: CPU Time: '509173.171875' 2019-11-29 14:31:31 (7484): Preference change detected 2019-11-29 14:31:31 (7484): Setting CPU throttle for VM. (100%) 2019-11-29 14:31:32 (7484): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 600 seconds) or (Vbox_job.xml: 600 seconds)) 2019-11-29 14:31:33 (7484): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2019-11-29 14:31:33 (7484): Guest Log: BIOS: Booting from Hard Disk... 2019-11-29 14:31:36 (7484): Guest Log: BIOS: KBD: unsupported int 16h function 03 2019-11-29 14:31:36 (7484): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2019-11-29 14:32:10 (7484): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2019-11-29 14:32:10 (7484): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2019-11-29 14:33:11 (7484): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log 2019-11-29 14:33:11 (7484): Guest Log: 00:00:00.000789 main Log opened 2019-11-29T13:33:08.675391000Z 2019-11-29 14:33:11 (7484): Guest Log: 00:00:00.001472 main OS Product: Linux 2019-11-29 14:33:11 (7484): Guest Log: 00:00:00.001620 main OS Release: 4.14.44-11.cernvm.x86_64 2019-11-29 14:33:11 (7484): Guest Log: 00:00:00.001710 main OS Version: #1 SMP Mon May 28 16:49:00 CEST 2018 2019-11-29 14:33:11 (7484): Guest Log: 00:00:00.001923 main Executable: /usr/share/vboxguest52/usr/sbin/VBoxService 2019-11-29 14:33:11 (7484): Guest Log: 00:00:00.001927 main Process ID: 3011 2019-11-29 14:33:11 (7484): Guest Log: 00:00:00.001930 main Package type: LINUX_64BITS_GENERIC 2019-11-29 14:33:11 (7484): Guest Log: 00:00:00.006426 main 5.2.6 r120293 started. Verbose level = 0 2019-11-29 14:33:53 (7484): Guest Log: [INFO] Mounting the shared directory 2019-11-29 14:33:53 (7484): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor 2019-11-29 14:33:53 (7484): Guest Log: [DEBUG] Testing network connection to cern.ch on port 80 2019-11-29 14:33:53 (7484): Guest Log: [DEBUG] Connection to cern.ch 80 port [tcp/http] succeeded! 2019-11-29 14:33:54 (7484): Guest Log: [DEBUG] 0 2019-11-29 14:33:54 (7484): Guest Log: [DEBUG] Testing VCCS connection to vccs.cern.ch on port 443 2019-11-29 14:33:54 (7484): Guest Log: [DEBUG] Connection to vccs.cern.ch 443 port [tcp/https] succeeded! 2019-11-29 14:33:54 (7484): Guest Log: [DEBUG] 0 2019-11-29 14:33:54 (7484): Guest Log: [DEBUG] Testing connection to Condor server on port 9618 2019-11-29 14:33:55 (7484): Guest Log: [DEBUG] Connection to vccondor01.cern.ch 9618 port [tcp/condor] succeeded! 2019-11-29 14:33:55 (7484): Guest Log: [DEBUG] 0 2019-11-29 14:35:03 (7484): Guest Log: [DEBUG] Probing CVMFS ... 2019-11-29 14:35:06 (7484): Guest Log: Probing /cvmfs/grid.cern.ch... OK 2019-11-29 14:35:08 (7484): 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-29 14:35:08 (7484): Guest Log: 2.4.4.0 3705 1 27804 10861 3 1 1061728 10240001 2 65024 0 3 100 0 0 http://s1cern-cvmfs.openhtc.io/cvmfs/grid.cern.ch DIRECT 1 2019-11-29 14:35:18 (7484): Guest Log: [INFO] Reading volunteer information 2019-11-29 14:35:18 (7484): Guest Log: [INFO] Volunteer: bhm5 (5326) 2019-11-29 14:35:18 (7484): Guest Log: [INFO] VMID: e5b01749-9626-457a-8945-16c64690aa2f 2019-11-29 14:35:19 (7484): Guest Log: [INFO] Requesting an X509 credential from LHC@home 2019-11-29 14:35:26 (7484): Guest Log: [INFO] Running the fast benchmark. 2019-11-29 14:40:51 (7484): Guest Log: [INFO] Machine performance 6.51 HEPSPEC06 2019-11-29 14:40:51 (7484): Guest Log: [INFO] Theory application starting. Check log files. 2019-11-29 14:40:53 (7484): Guest Log: [DEBUG] HTCondor ping 2019-11-29 14:40:57 (7484): Guest Log: [DEBUG] 0 2019-11-29 14:44:44 (7484): VM state change detected. (old = 'Running', new = 'Paused') 2019-11-29 14:58:40 (7484): VM state change detected. (old = 'Paused', new = 'Running') 2019-11-29 15:03:18 (7484): VM state change detected. (old = 'Running', new = 'Paused') 2019-11-29 15:03:27 (7484): VM state change detected. (old = 'Paused', new = 'Running') 2019-11-29 15:05:10 (7484): Guest Log: [INFO] Condor exited with return value N/A. 2019-11-29 15:05:11 (7484): Guest Log: [INFO] Shutting Down. 2019-11-29 15:05:11 (7484): VM Completion File Detected. 2019-11-29 15:05:11 (7484): VM Completion Message: Condor exited with return value N/A. . 2019-11-29 15:05:11 (7484): Powering off VM. 2019-11-29 15:10:13 (7484): VM did not power off when requested. 2019-11-29 15:10:13 (7484): VM was successfully terminated. 2019-11-29 15:10:13 (7484): Deregistering VM. (boinc_d88e59e995146365, slot#6) 2019-11-29 15:10:14 (7484): Removing network bandwidth throttle group from VM. 2019-11-29 15:10:14 (7484): Removing VM from VirtualBox. 15:10:20 (7484): called boinc_finish(0) </stderr_txt> ]]>
©2025 CERN