Task 251469287

Name	Theory_3942136_1573434574.062279_0
Workunit	126300082
Created	11 Nov 2019, 1:09:36 UTC
Sent	11 Nov 2019, 3:06:24 UTC
Report deadline	12 Dec 2019, 3:06:24 UTC
Received	13 Nov 2019, 18:20:34 UTC
Server state	Over
Outcome	Success
Client state	Done
Exit status	0 (0x00000000)
Computer ID	10318807
Run time	1 days 3 hours 18 min 8 sec
CPU time	23 hours 11 min 16 sec
Validate state	Valid
Credit	569.03
Device peak FLOPS	2.50 GFLOPS
Application version	Theory Simulation v263.98 (vbox64_mt_mcore) x86_64-pc-linux-gnu
Peak working set size	517.32 MB
Peak swap size	2.77 GB
Peak disk usage	1.04 GB
Stderr output

<core_client_version>7.14.2</core_client_version>
<![CDATA[
<stderr_txt>
2019-11-11 04:06:29 (17653): vboxwrapper (7.7.26196): starting
2019-11-11 04:06:30 (17653): Feature: Checkpoint interval offset (124 seconds)
2019-11-11 04:06:30 (17653): Detected: VirtualBox VboxManage Interface (Version: 6.0.14)
2019-11-11 04:06:30 (17653): VBOX_JOB::parse(): unexpected text enable_screenshots_on_error/
2019-11-11 04:06:30 (17653): Detected: Minimum checkpoint interval (600.000000 seconds)
2019-11-11 04:06:30 (17653): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2019-11-11 04:06:30 (17653): Successfully copied 'init_data.xml' to the shared directory.
2019-11-11 04:06:31 (17653): Create VM. (boinc_1e35d54d5294aeed, slot#0)
2019-11-11 04:06:32 (17653): Setting Memory Size for VM. (1500MB)
2019-11-11 04:06:33 (17653): Setting CPU Count for VM. (1)
2019-11-11 04:06:33 (17653): Setting Chipset Options for VM.
2019-11-11 04:06:34 (17653): Setting Boot Options for VM.
2019-11-11 04:06:35 (17653): Setting Network Configuration for NAT.
2019-11-11 04:06:35 (17653): Enabling VM Network Access.
2019-11-11 04:06:36 (17653): Disabling USB Support for VM.
2019-11-11 04:06:36 (17653): Disabling COM Port Support for VM.
2019-11-11 04:06:37 (17653): Disabling LPT Port Support for VM.
2019-11-11 04:06:38 (17653): Disabling Audio Support for VM.
2019-11-11 04:06:38 (17653): Disabling Clipboard Support for VM.
2019-11-11 04:06:39 (17653): Disabling Drag and Drop Support for VM.
2019-11-11 04:06:39 (17653): Adding storage controller(s) to VM.
2019-11-11 04:06:40 (17653): Adding virtual disk drive to VM. (vm_image.vdi)
2019-11-11 04:06:40 (17653): Adding network bandwidth throttle group to VM. (Defaulting to 1024GB)
2019-11-11 04:06:41 (17653): forwarding host port 34125 to guest port 80
2019-11-11 04:06:41 (17653): Enabling remote desktop for VM.
2019-11-11 04:06:42 (17653): Required extension pack not installed, remote desktop not enabled.
2019-11-11 04:06:42 (17653): Enabling shared directory for VM.
2019-11-11 04:06:43 (17653): Starting VM. (boinc_1e35d54d5294aeed, slot#0)
2019-11-11 04:06:44 (17653): Successfully started VM. (PID = '18299')
2019-11-11 04:06:44 (17653): Reporting VM Process ID to BOINC.
2019-11-11 04:06:45 (17653): Guest Log: BIOS: VirtualBox 6.0.13
2019-11-11 04:06:45 (17653): Guest Log: CPUID EDX: 0x178bfbff
2019-11-11 04:06:45 (17653): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63
2019-11-11 04:06:45 (17653): VM state change detected. (old = 'poweroff', new = 'running')
2019-11-11 04:06:45 (17653): Detected: Web Application Enabled (http://localhost:34125)
2019-11-11 04:06:45 (17653): Preference change detected
2019-11-11 04:06:45 (17653): Setting CPU throttle for VM. (100%)
2019-11-11 04:06:45 (17653): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2019-11-11 04:06:46 (17653): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2019-11-11 04:06:46 (17653): Guest Log: BIOS: Booting from Hard Disk...
2019-11-11 04:06:50 (17653): Guest Log: BIOS: KBD: unsupported int 16h function 03
2019-11-11 04:06:50 (17653): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 
2019-11-11 04:07:15 (17653): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2019-11-11 04:07:15 (17653): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)
2019-11-11 04:08:31 (17653): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log
2019-11-11 04:08:31 (17653): Guest Log: 00:00:00.001754 main     Log opened 2019-11-11T03:08:29.776141000Z
2019-11-11 04:08:31 (17653): Guest Log: 00:00:00.002503 main     OS Product: Linux
2019-11-11 04:08:31 (17653): Guest Log: 00:00:00.002604 main     OS Release: 4.14.44-11.cernvm.x86_64
2019-11-11 04:08:31 (17653): Guest Log: 00:00:00.002635 main     OS Version: #1 SMP Mon May 28 16:49:00 CEST 2018
2019-11-11 04:08:31 (17653): Guest Log: 00:00:00.003519 main     Executable: /usr/share/vboxguest52/usr/sbin/VBoxService
2019-11-11 04:08:31 (17653): Guest Log: 00:00:00.003526 main     Process ID: 2900
2019-11-11 04:08:31 (17653): Guest Log: 00:00:00.003530 main     Package type: LINUX_64BITS_GENERIC
2019-11-11 04:08:31 (17653): Guest Log: 00:00:00.012471 main     5.2.6 r120293 started. Verbose level = 0
2019-11-11 04:09:23 (17653): Guest Log: [INFO] Mounting the shared directory
2019-11-11 04:09:23 (17653): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor
2019-11-11 04:09:23 (17653): Guest Log: [DEBUG] Testing network connection to cern.ch on port 80
2019-11-11 04:09:25 (17653): Guest Log: [DEBUG] Connection to cern.ch 80 port [tcp/http] succeeded!
2019-11-11 04:09:25 (17653): Guest Log: [DEBUG] 0
2019-11-11 04:09:25 (17653): Guest Log: [DEBUG] Testing VCCS connection to vccs.cern.ch on port 443
2019-11-11 04:09:25 (17653): Guest Log: [DEBUG] Connection to vccs.cern.ch 443 port [tcp/https] succeeded!
2019-11-11 04:09:25 (17653): Guest Log: [DEBUG] 0
2019-11-11 04:09:25 (17653): Guest Log: [DEBUG] Testing connection to Condor server on port 9618
2019-11-11 04:09:27 (17653): Guest Log: [DEBUG] Connection to vccondor01.cern.ch 9618 port [tcp/condor] succeeded!
2019-11-11 04:09:27 (17653): Guest Log: [DEBUG] 0
2019-11-11 04:10:37 (17653): Guest Log: [DEBUG] Probing CVMFS ...
2019-11-11 04:10:41 (17653): Guest Log: Probing /cvmfs/grid.cern.ch... OK
2019-11-11 04:10:44 (17653): 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 04:10:44 (17653): Guest Log: 2.4.4.0 3607 1 27872 10711 3 1 318381 10240000 2 65024 0 3 100 0 0 http://s1cern-cvmfs.openhtc.io/cvmfs/grid.cern.ch DIRECT 1
2019-11-11 04:10:54 (17653): Guest Log: [INFO] Reading volunteer information
2019-11-11 04:10:54 (17653): Guest Log: [INFO] Volunteer: Saturn911 (245526)
2019-11-11 04:10:54 (17653): Guest Log: [INFO] VMID: e5b01749-9626-457a-8945-16c64690aa2f
2019-11-11 04:10:56 (17653): Guest Log: [INFO] Requesting an X509 credential from LHC@home
2019-11-11 04:11:00 (17653): Guest Log: [INFO] Running the fast benchmark.
2019-11-11 04:13:28 (17653): Guest Log: [INFO] Machine performance 3.61 HEPSPEC06
2019-11-11 04:13:28 (17653): Guest Log: [INFO] Theory application starting. Check log files.
2019-11-11 04:13:32 (17653): Guest Log: [DEBUG] HTCondor ping
2019-11-11 04:13:33 (17653): Guest Log: [DEBUG] 0
2019-11-11 04:14:36 (17653): Guest Log: [INFO] New Job Starting in slot1
2019-11-11 04:14:36 (17653): Guest Log: [INFO] Condor JobID:  514749.30 in slot1
2019-11-11 04:14:41 (17653): Guest Log: [INFO] MCPlots JobID: 52063610 in slot1
2019-11-11 04:14:47 (17653): Guest Log: [INFO] ===> [runRivet] Mon Nov 11 04:14:36 CET 2019 [boinc pp jets 7000 25,-,760 - pythia8 8.230 tune-4cx 100000 156]
2019-11-11 05:46:43 (17653): Status Report: Job Duration: '129600.000000'
2019-11-11 05:46:43 (17653): Status Report: Elapsed Time: '6001.031953'
2019-11-11 05:46:43 (17653): Status Report: CPU Time: '5019.670000'
2019-11-11 17:27:54 (4225): vboxwrapper (7.7.26196): starting
2019-11-11 17:27:57 (4225): Feature: Checkpoint interval offset (7 seconds)
2019-11-11 17:27:57 (4225): Detected: VirtualBox VboxManage Interface (Version: 6.0.14)
2019-11-11 17:27:57 (4225): VBOX_JOB::parse(): unexpected text enable_screenshots_on_error/
2019-11-11 17:27:57 (4225): Detected: Minimum checkpoint interval (600.000000 seconds)
2019-11-11 17:27:57 (4225): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2019-11-11 17:27:58 (4225): Guest Log: BIOS: VirtualBox 6.0.13
2019-11-11 17:27:58 (4225): Guest Log: CPUID EDX: 0x178bfbff
2019-11-11 17:27:58 (4225): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63
2019-11-11 17:27:58 (4225): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2019-11-11 17:27:58 (4225): Guest Log: BIOS: Booting from Hard Disk...
2019-11-11 17:27:58 (4225): Guest Log: BIOS: KBD: unsupported int 16h function 03
2019-11-11 17:27:58 (4225): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 
2019-11-11 17:27:58 (4225): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2019-11-11 17:27:58 (4225): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)
2019-11-11 17:27:58 (4225): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log
2019-11-11 17:27:58 (4225): Guest Log: 00:00:00.001754 main     Log opened 2019-11-11T03:08:29.776141000Z
2019-11-11 17:27:58 (4225): Guest Log: 00:00:00.002503 main     OS Product: Linux
2019-11-11 17:27:58 (4225): Guest Log: 00:00:00.002604 main     OS Release: 4.14.44-11.cernvm.x86_64
2019-11-11 17:27:58 (4225): Guest Log: 00:00:00.002635 main     OS Version: #1 SMP Mon May 28 16:49:00 CEST 2018
2019-11-11 17:27:58 (4225): Guest Log: 00:00:00.003519 main     Executable: /usr/share/vboxguest52/usr/sbin/VBoxService
2019-11-11 17:27:58 (4225): Guest Log: 00:00:00.003526 main     Process ID: 2900
2019-11-11 17:27:58 (4225): Guest Log: 00:00:00.003530 main     Package type: LINUX_64BITS_GENERIC
2019-11-11 17:27:58 (4225): Guest Log: 00:00:00.012471 main     5.2.6 r120293 started. Verbose level = 0
2019-11-11 17:27:58 (4225): Guest Log: [INFO] Mounting the shared directory
2019-11-11 17:27:58 (4225): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor
2019-11-11 17:27:58 (4225): Guest Log: [DEBUG] Testing network connection to cern.ch on port 80
2019-11-11 17:27:58 (4225): Guest Log: [DEBUG] Connection to cern.ch 80 port [tcp/http] succeeded!
2019-11-11 17:27:58 (4225): Guest Log: [DEBUG] 0
2019-11-11 17:27:58 (4225): Guest Log: [DEBUG] Testing VCCS connection to vccs.cern.ch on port 443
2019-11-11 17:27:58 (4225): Guest Log: [DEBUG] Connection to vccs.cern.ch 443 port [tcp/https] succeeded!
2019-11-11 17:27:58 (4225): Guest Log: [DEBUG] 0
2019-11-11 17:27:58 (4225): Guest Log: [DEBUG] Testing connection to Condor server on port 9618
2019-11-11 17:27:58 (4225): Guest Log: [DEBUG] Connection to vccondor01.cern.ch 9618 port [tcp/condor] succeeded!
2019-11-11 17:27:58 (4225): Guest Log: [DEBUG] 0
2019-11-11 17:27:58 (4225): Guest Log: [DEBUG] Probing CVMFS ...
2019-11-11 17:27:58 (4225): Guest Log: Probing /cvmfs/grid.cern.ch... OK
2019-11-11 17:27:58 (4225): 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 17:27:58 (4225): Guest Log: 2.4.4.0 3607 1 27872 10711 3 1 318381 10240000 2 65024 0 3 100 0 0 http://s1cern-cvmfs.openhtc.io/cvmfs/grid.cern.ch DIRECT 1
2019-11-11 17:27:58 (4225): Guest Log: [INFO] Reading volunteer information
2019-11-11 17:27:58 (4225): Guest Log: [INFO] Volunteer: Saturn911 (245526)
2019-11-11 17:27:58 (4225): Guest Log: [INFO] VMID: e5b01749-9626-457a-8945-16c64690aa2f
2019-11-11 17:27:58 (4225): Guest Log: [INFO] Requesting an X509 credential from LHC@home
2019-11-11 17:27:58 (4225): Guest Log: [INFO] Running the fast benchmark.
2019-11-11 17:27:58 (4225): Guest Log: [INFO] Machine performance 3.61 HEPSPEC06
2019-11-11 17:27:58 (4225): Guest Log: [INFO] Theory application starting. Check log files.
2019-11-11 17:27:58 (4225): Guest Log: [DEBUG] HTCondor ping
2019-11-11 17:27:58 (4225): Guest Log: [DEBUG] 0
2019-11-11 17:27:58 (4225): Guest Log: [INFO] New Job Starting in slot1
2019-11-11 17:27:58 (4225): Guest Log: [INFO] Condor JobID:  514749.30 in slot1
2019-11-11 17:27:58 (4225): Guest Log: [INFO] MCPlots JobID: 52063610 in slot1
2019-11-11 17:27:58 (4225): Guest Log: [INFO] ===> [runRivet] Mon Nov 11 04:14:36 CET 2019 [boinc pp jets 7000 25,-,760 - pythia8 8.230 tune-4cx 100000 156]
2019-11-11 17:28:02 (4225): 
    BOINC will be notified that it needs to clean up the environment.
    This is a temporary problem and so this job will be rescheduled for another time.

2019-11-11 17:36:43 (4197): vboxwrapper (7.7.26196): starting
2019-11-11 17:36:46 (4197): Feature: Checkpoint interval offset (134 seconds)
2019-11-11 17:36:46 (4197): Detected: VirtualBox VboxManage Interface (Version: 6.0.14)
2019-11-11 17:36:46 (4197): VBOX_JOB::parse(): unexpected text enable_screenshots_on_error/
2019-11-11 17:36:46 (4197): Detected: Minimum checkpoint interval (600.000000 seconds)
2019-11-11 17:36:46 (4197): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2019-11-11 17:36:47 (4197): Guest Log: BIOS: VirtualBox 6.0.13
2019-11-11 17:36:47 (4197): Guest Log: CPUID EDX: 0x178bfbff
2019-11-11 17:36:47 (4197): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63
2019-11-11 17:36:47 (4197): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2019-11-11 17:36:47 (4197): Guest Log: BIOS: Booting from Hard Disk...
2019-11-11 17:36:47 (4197): Guest Log: BIOS: KBD: unsupported int 16h function 03
2019-11-11 17:36:47 (4197): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 
2019-11-11 17:36:47 (4197): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2019-11-11 17:36:47 (4197): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)
2019-11-11 17:36:47 (4197): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log
2019-11-11 17:36:47 (4197): Guest Log: 00:00:00.001754 main     Log opened 2019-11-11T03:08:29.776141000Z
2019-11-11 17:36:47 (4197): Guest Log: 00:00:00.002503 main     OS Product: Linux
2019-11-11 17:36:47 (4197): Guest Log: 00:00:00.002604 main     OS Release: 4.14.44-11.cernvm.x86_64
2019-11-11 17:36:47 (4197): Guest Log: 00:00:00.002635 main     OS Version: #1 SMP Mon May 28 16:49:00 CEST 2018
2019-11-11 17:36:47 (4197): Guest Log: 00:00:00.003519 main     Executable: /usr/share/vboxguest52/usr/sbin/VBoxService
2019-11-11 17:36:47 (4197): Guest Log: 00:00:00.003526 main     Process ID: 2900
2019-11-11 17:36:47 (4197): Guest Log: 00:00:00.003530 main     Package type: LINUX_64BITS_GENERIC
2019-11-11 17:36:47 (4197): Guest Log: 00:00:00.012471 main     5.2.6 r120293 started. Verbose level = 0
2019-11-11 17:36:47 (4197): Guest Log: [INFO] Mounting the shared directory
2019-11-11 17:36:47 (4197): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor
2019-11-11 17:36:47 (4197): Guest Log: [DEBUG] Testing network connection to cern.ch on port 80
2019-11-11 17:36:47 (4197): Guest Log: [DEBUG] Connection to cern.ch 80 port [tcp/http] succeeded!
2019-11-11 17:36:47 (4197): Guest Log: [DEBUG] 0
2019-11-11 17:36:47 (4197): Guest Log: [DEBUG] Testing VCCS connection to vccs.cern.ch on port 443
2019-11-11 17:36:47 (4197): Guest Log: [DEBUG] Connection to vccs.cern.ch 443 port [tcp/https] succeeded!
2019-11-11 17:36:47 (4197): Guest Log: [DEBUG] 0
2019-11-11 17:36:47 (4197): Guest Log: [DEBUG] Testing connection to Condor server on port 9618
2019-11-11 17:36:47 (4197): Guest Log: [DEBUG] Connection to vccondor01.cern.ch 9618 port [tcp/condor] succeeded!
2019-11-11 17:36:47 (4197): Guest Log: [DEBUG] 0
2019-11-11 17:36:47 (4197): Guest Log: [DEBUG] Probing CVMFS ...
2019-11-11 17:36:47 (4197): Guest Log: Probing /cvmfs/grid.cern.ch... OK
2019-11-11 17:36:47 (4197): 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 17:36:47 (4197): Guest Log: 2.4.4.0 3607 1 27872 10711 3 1 318381 10240000 2 65024 0 3 100 0 0 http://s1cern-cvmfs.openhtc.io/cvmfs/grid.cern.ch DIRECT 1
2019-11-11 17:36:47 (4197): Guest Log: [INFO] Reading volunteer information
2019-11-11 17:36:47 (4197): Guest Log: [INFO] Volunteer: Saturn911 (245526)
2019-11-11 17:36:47 (4197): Guest Log: [INFO] VMID: e5b01749-9626-457a-8945-16c64690aa2f
2019-11-11 17:36:47 (4197): Guest Log: [INFO] Requesting an X509 credential from LHC@home
2019-11-11 17:36:47 (4197): Guest Log: [INFO] Running the fast benchmark.
2019-11-11 17:36:47 (4197): Guest Log: [INFO] Machine performance 3.61 HEPSPEC06
2019-11-11 17:36:47 (4197): Guest Log: [INFO] Theory application starting. Check log files.
2019-11-11 17:36:47 (4197): Guest Log: [DEBUG] HTCondor ping
2019-11-11 17:36:47 (4197): Guest Log: [DEBUG] 0
2019-11-11 17:36:47 (4197): Guest Log: [INFO] New Job Starting in slot1
2019-11-11 17:36:47 (4197): Guest Log: [INFO] Condor JobID:  514749.30 in slot1
2019-11-11 17:36:47 (4197): Guest Log: [INFO] MCPlots JobID: 52063610 in slot1
2019-11-11 17:36:47 (4197): Guest Log: [INFO] ===> [runRivet] Mon Nov 11 04:14:36 CET 2019 [boinc pp jets 7000 25,-,760 - pythia8 8.230 tune-4cx 100000 156]
2019-11-11 17:36:47 (4197): Starting VM. (boinc_1e35d54d5294aeed, slot#0)
2019-11-11 17:36:49 (4197): Successfully started VM. (PID = '4409')
2019-11-11 17:36:49 (4197): Reporting VM Process ID to BOINC.
2019-11-11 17:36:50 (4197): VM state change detected. (old = 'poweroff', new = 'running')
2019-11-11 17:36:50 (4197): Detected: Web Application Enabled (http://localhost:34125)
2019-11-11 17:36:51 (4197): Status Report: Job Duration: '129600.000000'
2019-11-11 17:36:51 (4197): Status Report: Elapsed Time: '8935.187733'
2019-11-11 17:36:51 (4197): Status Report: CPU Time: '7625.860000'
2019-11-11 17:36:51 (4197): Preference change detected
2019-11-11 17:36:51 (4197): Setting CPU throttle for VM. (100%)
2019-11-11 17:36:51 (4197): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2019-11-11 19:16:47 (4197): Status Report: Job Duration: '129600.000000'
2019-11-11 19:16:47 (4197): Status Report: Elapsed Time: '14936.485205'
2019-11-11 19:16:47 (4197): Status Report: CPU Time: '12653.700000'
2019-11-11 20:56:44 (4197): Status Report: Job Duration: '129600.000000'
2019-11-11 20:56:44 (4197): Status Report: Elapsed Time: '20937.794138'
2019-11-11 20:56:44 (4197): Status Report: CPU Time: '17784.850000'
2019-11-11 21:11:23 (4197): Guest Log: [INFO] Job finished in slot1 with 0.
2019-11-11 21:11:27 (4197): Guest Log: [INFO] New Job Starting in slot1
2019-11-11 21:11:29 (4197): Guest Log: [INFO] Condor JobID:  514813.78 in slot1
2019-11-11 21:11:36 (4197): Guest Log: [INFO] MCPlots JobID: 52074201 in slot1
2019-11-11 21:11:41 (4197): Guest Log: [INFO] ===> [runRivet] Mon Nov 11 21:11:28 CET 2019 [boinc pp jets 7000 25,-,760 - pythia8 8.235 fischerPP2 100000 157]
2019-11-11 22:36:41 (4197): Status Report: Job Duration: '129600.000000'
2019-11-11 22:36:41 (4197): Status Report: Elapsed Time: '26938.752221'
2019-11-11 22:36:41 (4197): Status Report: CPU Time: '22900.300000'
2019-11-12 00:16:36 (4197): Status Report: Job Duration: '129600.000000'
2019-11-12 00:16:36 (4197): Status Report: Elapsed Time: '32938.992150'
2019-11-12 00:16:36 (4197): Status Report: CPU Time: '28010.330000'
2019-11-12 01:56:34 (4197): Status Report: Job Duration: '129600.000000'
2019-11-12 01:56:34 (4197): Status Report: Elapsed Time: '38939.126321'
2019-11-12 01:56:34 (4197): Status Report: CPU Time: '33148.130000'
2019-11-12 03:36:34 (4197): Status Report: Job Duration: '129600.000000'
2019-11-12 03:36:34 (4197): Status Report: Elapsed Time: '44941.411402'
2019-11-12 03:36:34 (4197): Status Report: CPU Time: '38305.310000'
2019-11-12 05:16:31 (4197): Status Report: Job Duration: '129600.000000'
2019-11-12 05:16:31 (4197): Status Report: Elapsed Time: '50943.259672'
2019-11-12 05:16:31 (4197): Status Report: CPU Time: '43435.670000'
2019-11-12 19:02:49 (4184): vboxwrapper (7.7.26196): starting
2019-11-12 19:02:51 (4184): Feature: Checkpoint interval offset (192 seconds)
2019-11-12 19:02:51 (4184): Detected: VirtualBox VboxManage Interface (Version: 6.0.14)
2019-11-12 19:02:52 (4184): VBOX_JOB::parse(): unexpected text enable_screenshots_on_error/
2019-11-12 19:02:52 (4184): Detected: Minimum checkpoint interval (600.000000 seconds)
2019-11-12 19:02:52 (4184): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2019-11-12 19:02:53 (4184): Guest Log: BIOS: VirtualBox 6.0.13
2019-11-12 19:02:53 (4184): Guest Log: CPUID EDX: 0x178bfbff
2019-11-12 19:02:53 (4184): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63
2019-11-12 19:02:53 (4184): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2019-11-12 19:02:53 (4184): Guest Log: BIOS: Booting from Hard Disk...
2019-11-12 19:02:53 (4184): Guest Log: BIOS: KBD: unsupported int 16h function 03
2019-11-12 19:02:53 (4184): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 
2019-11-12 19:02:53 (4184): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2019-11-12 19:02:53 (4184): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)
2019-11-12 19:02:53 (4184): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log
2019-11-12 19:02:53 (4184): Guest Log: 00:00:00.002050 main     Log opened 2019-11-11T16:38:54.455393000Z
2019-11-12 19:02:53 (4184): Guest Log: 00:00:00.004188 main     OS Product: Linux
2019-11-12 19:02:53 (4184): Guest Log: 00:00:00.004340 main     OS Release: 4.14.44-11.cernvm.x86_64
2019-11-12 19:02:53 (4184): Guest Log: 00:00:00.004742 main     OS Version: #1 SMP Mon May 28 16:49:00 CEST 2018
2019-11-12 19:02:53 (4184): Guest Log: 00:00:00.004812 main     Executable: /usr/share/vboxguest52/usr/sbin/VBoxService
2019-11-12 19:02:53 (4184): Guest Log: 00:00:00.004817 main     Process ID: 2864
2019-11-12 19:02:53 (4184): Guest Log: 00:00:00.004822 main     Package type: LINUX_64BITS_GENERIC
2019-11-12 19:02:53 (4184): Guest Log: 00:00:00.008663 main     5.2.6 r120293 started. Verbose level = 0
2019-11-12 19:02:53 (4184): Guest Log: [INFO] Mounting the shared directory
2019-11-12 19:02:53 (4184): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor
2019-11-12 19:02:53 (4184): Guest Log: [DEBUG] Testing network connection to cern.ch on port 80
2019-11-12 19:02:53 (4184): Guest Log: [DEBUG] Connection to cern.ch 80 port [tcp/http] succeeded!
2019-11-12 19:02:53 (4184): Guest Log: [DEBUG] 0
2019-11-12 19:02:53 (4184): Guest Log: [DEBUG] Testing VCCS connection to vccs.cern.ch on port 443
2019-11-12 19:02:53 (4184): Guest Log: [DEBUG] Connection to vccs.cern.ch 443 port [tcp/https] succeeded!
2019-11-12 19:02:53 (4184): Guest Log: [DEBUG] 0
2019-11-12 19:02:53 (4184): Guest Log: [DEBUG] Testing connection to Condor server on port 9618
2019-11-12 19:02:53 (4184): Guest Log: [DEBUG] Connection to vccondor01.cern.ch 9618 port [tcp/condor] succeeded!
2019-11-12 19:02:53 (4184): Guest Log: [DEBUG] 0
2019-11-12 19:02:53 (4184): Guest Log: [DEBUG] Probing CVMFS ...
2019-11-12 19:02:53 (4184): Guest Log: Probing /cvmfs/grid.cern.ch... OK
2019-11-12 19:02:53 (4184): 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-12 19:02:53 (4184): Guest Log: 2.4.4.0 3547 1 27828 10715 3 1 429244 10240001 2 65024 0 3 100 0 0 http://s1cern-cvmfs.openhtc.io/cvmfs/grid.cern.ch DIRECT 1
2019-11-12 19:02:53 (4184): Guest Log: [INFO] Reading volunteer information
2019-11-12 19:02:53 (4184): Guest Log: [INFO] Volunteer: Saturn911 (245526)
2019-11-12 19:02:53 (4184): Guest Log: [INFO] VMID: e5b01749-9626-457a-8945-16c64690aa2f
2019-11-12 19:02:53 (4184): Guest Log: [INFO] Requesting an X509 credential from LHC@home
2019-11-12 19:02:53 (4184): Guest Log: [INFO] Running the fast benchmark.
2019-11-12 19:02:53 (4184): Guest Log: [INFO] Machine performance 3.25 HEPSPEC06
2019-11-12 19:02:53 (4184): Guest Log: [INFO] Theory application starting. Check log files.
2019-11-12 19:02:53 (4184): Guest Log: [DEBUG] HTCondor ping
2019-11-12 19:02:53 (4184): Guest Log: [DEBUG] 0
2019-11-12 19:02:53 (4184): Guest Log: [INFO] New Job Starting in slot1
2019-11-12 19:02:53 (4184): Guest Log: [INFO] Condor JobID:  514802.43 in slot1
2019-11-12 19:02:53 (4184): Guest Log: [INFO] MCPlots JobID: 52071463 in slot1
2019-11-12 19:02:53 (4184): Guest Log: [INFO] ===> [runRivet] Mon Nov 11 17:44:37 CET 2019 [boinc pp jets 7000 150,-,2160 - pythia6 6.428 dwt 100000 156]
2019-11-12 19:02:53 (4184): Guest Log: [INFO] Job finished in slot1 with 0.
2019-11-12 19:02:53 (4184): Guest Log: [INFO] New Job Starting in slot1
2019-11-12 19:02:53 (4184): Guest Log: [INFO] Condor JobID:  514813.78 in slot1
2019-11-12 19:02:53 (4184): Guest Log: [INFO] MCPlots JobID: 52074201 in slot1
2019-11-12 19:02:53 (4184): Guest Log: [INFO] ===> [runRivet] Mon Nov 11 21:11:28 CET 2019 [boinc pp jets 7000 25,-,760 - pythia8 8.235 fischerPP2 100000 157]
2019-11-12 19:02:53 (4184): Starting VM. (boinc_1e35d54d5294aeed, slot#0)
2019-11-12 19:02:55 (4184): Successfully started VM. (PID = '4397')
2019-11-12 19:02:55 (4184): Reporting VM Process ID to BOINC.
2019-11-12 19:02:56 (4184): VM state change detected. (old = 'poweroff', new = 'running')
2019-11-12 19:02:56 (4184): Detected: Web Application Enabled (http://localhost:34125)
2019-11-12 19:02:56 (4184): Status Report: Job Duration: '129600.000000'
2019-11-12 19:02:56 (4184): Status Report: Elapsed Time: '55694.533830'
2019-11-12 19:02:56 (4184): Status Report: CPU Time: '47530.530000'
2019-11-12 19:02:56 (4184): Preference change detected
2019-11-12 19:02:56 (4184): Setting CPU throttle for VM. (100%)
2019-11-12 19:02:57 (4184): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2019-11-12 20:42:51 (4184): Status Report: Job Duration: '129600.000000'
2019-11-12 20:42:51 (4184): Status Report: Elapsed Time: '61694.608123'
2019-11-12 20:42:51 (4184): Status Report: CPU Time: '52533.580000'
2019-11-12 22:22:48 (4184): Status Report: Job Duration: '129600.000000'
2019-11-12 22:22:48 (4184): Status Report: Elapsed Time: '67696.399620'
2019-11-12 22:22:48 (4184): Status Report: CPU Time: '57672.430000'
2019-11-13 00:02:47 (4184): Status Report: Job Duration: '129600.000000'
2019-11-13 00:02:47 (4184): Status Report: Elapsed Time: '73697.538388'
2019-11-13 00:02:47 (4184): Status Report: CPU Time: '62839.120000'
2019-11-13 01:42:43 (4184): Status Report: Job Duration: '129600.000000'
2019-11-13 01:42:43 (4184): Status Report: Elapsed Time: '79697.964671'
2019-11-13 01:42:43 (4184): Status Report: CPU Time: '67999.090000'
2019-11-13 03:22:40 (4184): Status Report: Job Duration: '129600.000000'
2019-11-13 03:22:40 (4184): Status Report: Elapsed Time: '85698.807109'
2019-11-13 03:22:40 (4184): Status Report: CPU Time: '73155.630000'
2019-11-13 05:02:37 (4184): Status Report: Job Duration: '129600.000000'
2019-11-13 05:02:37 (4184): Status Report: Elapsed Time: '91698.838515'
2019-11-13 05:02:37 (4184): Status Report: CPU Time: '78305.490000'
2019-11-13 19:02:53 (4182): vboxwrapper (7.7.26196): starting
2019-11-13 19:02:56 (4182): Feature: Checkpoint interval offset (443 seconds)
2019-11-13 19:02:56 (4182): Detected: VirtualBox VboxManage Interface (Version: 6.0.14)
2019-11-13 19:02:56 (4182): VBOX_JOB::parse(): unexpected text enable_screenshots_on_error/
2019-11-13 19:02:56 (4182): Detected: Minimum checkpoint interval (600.000000 seconds)
2019-11-13 19:02:56 (4182): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2019-11-13 19:02:57 (4182): Guest Log: BIOS: VirtualBox 6.0.13
2019-11-13 19:02:57 (4182): Guest Log: CPUID EDX: 0x178bfbff
2019-11-13 19:02:57 (4182): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63
2019-11-13 19:02:57 (4182): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2019-11-13 19:02:57 (4182): Guest Log: BIOS: Booting from Hard Disk...
2019-11-13 19:02:57 (4182): Guest Log: BIOS: KBD: unsupported int 16h function 03
2019-11-13 19:02:57 (4182): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 
2019-11-13 19:02:57 (4182): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2019-11-13 19:02:57 (4182): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)
2019-11-13 19:02:57 (4182): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log
2019-11-13 19:02:57 (4182): Guest Log: 00:00:00.002294 main     Log opened 2019-11-12T18:05:06.200483000Z
2019-11-13 19:02:57 (4182): Guest Log: 00:00:00.004253 main     OS Product: Linux
2019-11-13 19:02:57 (4182): Guest Log: 00:00:00.004390 main     OS Release: 4.14.44-11.cernvm.x86_64
2019-11-13 19:02:57 (4182): Guest Log: 00:00:00.004429 main     OS Version: #1 SMP Mon May 28 16:49:00 CEST 2018
2019-11-13 19:02:57 (4182): Guest Log: 00:00:00.004473 main     Executable: /usr/share/vboxguest52/usr/sbin/VBoxService
2019-11-13 19:02:57 (4182): Guest Log: 00:00:00.004478 main     Process ID: 2863
2019-11-13 19:02:57 (4182): Guest Log: 00:00:00.004483 main     Package type: LINUX_64BITS_GENERIC
2019-11-13 19:02:57 (4182): Guest Log: 00:00:00.007150 main     5.2.6 r120293 started. Verbose level = 0
2019-11-13 19:02:57 (4182): Guest Log: [INFO] Mounting the shared directory
2019-11-13 19:02:57 (4182): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor
2019-11-13 19:02:57 (4182): Guest Log: [DEBUG] Testing network connection to cern.ch on port 80
2019-11-13 19:02:57 (4182): Guest Log: [DEBUG] Connection to cern.ch 80 port [tcp/http] succeeded!
2019-11-13 19:02:57 (4182): Guest Log: [DEBUG] 0
2019-11-13 19:02:57 (4182): Guest Log: [DEBUG] Testing VCCS connection to vccs.cern.ch on port 443
2019-11-13 19:02:57 (4182): Guest Log: [DEBUG] Connection to vccs.cern.ch 443 port [tcp/https] succeeded!
2019-11-13 19:02:57 (4182): Guest Log: [DEBUG] 0
2019-11-13 19:02:57 (4182): Guest Log: [DEBUG] Testing connection to Condor server on port 9618
2019-11-13 19:02:57 (4182): Guest Log: [DEBUG] Connection to vccondor01.cern.ch 9618 port [tcp/condor] succeeded!
2019-11-13 19:02:57 (4182): Guest Log: [DEBUG] 0
2019-11-13 19:02:57 (4182): Guest Log: [DEBUG] Probing CVMFS ...
2019-11-13 19:02:57 (4182): Guest Log: Probing /cvmfs/grid.cern.ch... OK
2019-11-13 19:02:57 (4182): 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-13 19:02:57 (4182): Guest Log: 2.4.4.0 3546 1 27836 10725 3 1 447926 10240001 2 65024 0 3 100 0 0 http://s1cern-cvmfs.openhtc.io/cvmfs/grid.cern.ch DIRECT 1
2019-11-13 19:02:57 (4182): Guest Log: [INFO] Reading volunteer information
2019-11-13 19:02:57 (4182): Guest Log: [INFO] Volunteer: Saturn911 (245526)
2019-11-13 19:02:57 (4182): Guest Log: [INFO] VMID: e5b01749-9626-457a-8945-16c64690aa2f
2019-11-13 19:02:57 (4182): Guest Log: [INFO] Requesting an X509 credential from LHC@home
2019-11-13 19:02:57 (4182): Guest Log: [INFO] Running the fast benchmark.
2019-11-13 19:02:57 (4182): Guest Log: [INFO] Machine performance 3.38 HEPSPEC06
2019-11-13 19:02:57 (4182): Guest Log: [INFO] Theory application starting. Check log files.
2019-11-13 19:02:57 (4182): Guest Log: [DEBUG] HTCondor ping
2019-11-13 19:02:57 (4182): Guest Log: [DEBUG] 0
2019-11-13 19:02:57 (4182): Guest Log: [INFO] New Job Starting in slot1
2019-11-13 19:02:57 (4182): Guest Log: [INFO] Condor JobID:  514856.82 in slot1
2019-11-13 19:02:57 (4182): Guest Log: [INFO] MCPlots JobID: 52079845 in slot1
2019-11-13 19:02:57 (4182): Guest Log: [INFO] ===> [runRivet] Tue Nov 12 19:11:13 CET 2019 [boinc pp zinclusive 7000 20,-,50,200 - pythia8 8.235 tune-AZ 100000 157]
2019-11-13 19:02:57 (4182): Starting VM. (boinc_1e35d54d5294aeed, slot#0)
2019-11-13 19:02:59 (4182): Successfully started VM. (PID = '4391')
2019-11-13 19:02:59 (4182): Reporting VM Process ID to BOINC.
2019-11-13 19:03:00 (4182): VM state change detected. (old = 'poweroff', new = 'running')
2019-11-13 19:03:00 (4182): Detected: Web Application Enabled (http://localhost:34125)
2019-11-13 19:03:01 (4182): Status Report: Job Duration: '129600.000000'
2019-11-13 19:03:01 (4182): Status Report: Elapsed Time: '97258.626731'
2019-11-13 19:03:01 (4182): Status Report: CPU Time: '83100.760000'
2019-11-13 19:03:01 (4182): Preference change detected
2019-11-13 19:03:01 (4182): Setting CPU throttle for VM. (100%)
2019-11-13 19:03:01 (4182): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2019-11-13 19:20:22 (4182): Guest Log: [INFO] Condor exited with return value N/A.
2019-11-13 19:20:22 (4182): Guest Log: [INFO] Shutting Down.
2019-11-13 19:20:22 (4182): VM Completion File Detected.
2019-11-13 19:20:22 (4182): VM Completion Message: Condor exited with return value N/A.
.
2019-11-13 19:20:22 (4182): Powering off VM.
2019-11-13 19:20:23 (4182): Successfully stopped VM.
2019-11-13 19:20:23 (4182): Deregistering VM. (boinc_1e35d54d5294aeed, slot#0)
2019-11-13 19:20:23 (4182): Removing network bandwidth throttle group from VM.
2019-11-13 19:20:23 (4182): Removing storage controller(s) from VM.
2019-11-13 19:20:23 (4182): Removing VM from VirtualBox.
2019-11-13 19:20:24 (4182): Removing virtual disk drive from VirtualBox.
19:20:29 (4182): called boinc_finish(0)

</stderr_txt>
]]>