Stderr output

<core_client_version>7.14.2</core_client_version>
<![CDATA[
<stderr_txt>
2019-11-08 10:46:33 (16436): Detected: vboxwrapper 26197
2019-11-08 10:46:33 (16436): Detected: BOINC client v7.7
2019-11-08 10:46:33 (16436): Detected: VirtualBox VboxManage Interface (Version: 6.0.14)
2019-11-08 10:46:34 (16436): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2019-11-08 10:46:34 (16436): Successfully copied 'init_data.xml' to the shared directory.
2019-11-08 10:46:35 (16436): Create VM. (boinc_e53bc93d869cbc0b, slot#4)
2019-11-08 10:46:36 (16436): Setting Memory Size for VM. (6750MB)
2019-11-08 10:46:36 (16436): Setting CPU Count for VM. (8)
2019-11-08 10:46:36 (16436): Setting Chipset Options for VM.
2019-11-08 10:46:36 (16436): Setting Boot Options for VM.
2019-11-08 10:46:37 (16436): Setting Network Configuration for NAT.
2019-11-08 10:46:37 (16436): Enabling VM Network Access.
2019-11-08 10:46:37 (16436): Disabling USB Support for VM.
2019-11-08 10:46:38 (16436): Disabling COM Port Support for VM.
2019-11-08 10:46:38 (16436): Disabling LPT Port Support for VM.
2019-11-08 10:46:38 (16436): Disabling Audio Support for VM.
2019-11-08 10:46:38 (16436): Disabling Clipboard Support for VM.
2019-11-08 10:46:39 (16436): Disabling Drag and Drop Support for VM.
2019-11-08 10:46:39 (16436): Adding storage controller(s) to VM.
2019-11-08 10:46:39 (16436): Adding virtual disk drive to VM. (vm_image.vdi)
2019-11-08 10:46:41 (16436): Adding VirtualBox Guest Additions to VM.
2019-11-08 10:46:43 (16436): Adding network bandwidth throttle group to VM. (Defaulting to 1024GB)
2019-11-08 10:46:43 (16436): forwarding host port 55317 to guest port 80
2019-11-08 10:46:44 (16436): Enabling remote desktop for VM.
2019-11-08 10:46:44 (16436): Enabling shared directory for VM.
2019-11-08 10:46:44 (16436): Starting VM using VBoxManage interface. (boinc_e53bc93d869cbc0b, slot#4)
2019-11-08 10:46:55 (16436): Successfully started VM. (PID = '11204')
2019-11-08 10:46:55 (16436): Reporting VM Process ID to BOINC.
2019-11-08 10:46:55 (16436): Guest Log: BIOS: VirtualBox 6.0.14

2019-11-08 10:46:55 (16436): Guest Log: CPUID EDX: 0x178bfbff

2019-11-08 10:46:55 (16436): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63

2019-11-08 10:46:55 (16436): VM state change detected. (old = 'PoweredOff', new = 'Running')
2019-11-08 10:46:55 (16436): Detected: Web Application Enabled (http://localhost:55317)
2019-11-08 10:46:55 (16436): Detected: Remote Desktop Enabled (localhost:55318)
2019-11-08 10:46:55 (16436): Preference change detected
2019-11-08 10:46:55 (16436): Setting CPU throttle for VM. (100%)
2019-11-08 10:46:55 (16436): Setting network throttle for VM. (1000KB)
2019-11-08 10:46:55 (16436): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2019-11-08 10:46:57 (16436): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032

2019-11-08 10:46:57 (16436): Guest Log: BIOS: Booting from Hard Disk...

2019-11-08 10:46:59 (16436): Guest Log: BIOS: KBD: unsupported int 16h function 03

2019-11-08 10:46:59 (16436): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 

2019-11-08 10:47:27 (16436): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds

2019-11-08 10:47:27 (16436): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)

2019-11-08 10:48:11 (16436): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log

2019-11-08 10:48:11 (16436): Guest Log: 00:00:00.000389 main     Log opened 2019-11-08T02:48:06.301986000Z

2019-11-08 10:48:11 (16436): Guest Log: 00:00:00.001478 main     OS Product: Linux

2019-11-08 10:48:11 (16436): Guest Log: 00:00:00.001685 main     OS Release: 4.14.44-11.cernvm.x86_64

2019-11-08 10:48:11 (16436): Guest Log: 00:00:00.001907 main     OS Version: #1 SMP Mon May 28 16:49:00 CEST 2018

2019-11-08 10:48:11 (16436): Guest Log: 00:00:00.002095 main     Executable: /usr/share/vboxguest52/usr/sbin/VBoxService

2019-11-08 10:48:11 (16436): Guest Log: 00:00:00.002097 main     Process ID: 3181

2019-11-08 10:48:11 (16436): Guest Log: 00:00:00.002098 main     Package type: LINUX_64BITS_GENERIC

2019-11-08 10:48:11 (16436): Guest Log: 00:00:00.003634 main     5.2.6 r120293 started. Verbose level = 0

2019-11-08 10:48:48 (16436): Guest Log: [INFO] Mounting the shared directory

2019-11-08 10:48:48 (16436): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor

2019-11-08 10:48:48 (16436): Guest Log: [DEBUG] Testing network connection to cern.ch on port 80

2019-11-08 10:48:49 (16436): Guest Log: [DEBUG] Connection to cern.ch 80 port [tcp/http] succeeded!

2019-11-08 10:48:49 (16436): Guest Log: [DEBUG] 0

2019-11-08 10:48:49 (16436): Guest Log: [DEBUG] Testing VCCS connection to vccs.cern.ch on port 443

2019-11-08 10:48:50 (16436): Guest Log: [DEBUG] Connection to vccs.cern.ch 443 port [tcp/https] succeeded!

2019-11-08 10:48:50 (16436): Guest Log: [DEBUG] 0

2019-11-08 10:48:50 (16436): Guest Log: [DEBUG] Testing connection to Condor server on port 9618

2019-11-08 10:48:51 (16436): Guest Log: [DEBUG] Connection to vccondor01.cern.ch 9618 port [tcp/condor] succeeded!

2019-11-08 10:48:51 (16436): Guest Log: [DEBUG] 0

2019-11-08 10:50:02 (16436): Guest Log: [DEBUG] Probing CVMFS ...

2019-11-08 10:50:04 (16436): Guest Log: Probing /cvmfs/grid.cern.ch... OK

2019-11-08 10:50:06 (16436): 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:50:06 (16436): Guest Log: 2.4.4.0 3899 1 27868 10687 3 1 318381 10240000 2 65024 0 3 100 0 0 http://s1asgc-cvmfs.openhtc.io:8080/cvmfs/grid.cern.ch DIRECT 1

2019-11-08 10:50:36 (16436): Guest Log: [INFO] Reading volunteer information

2019-11-08 10:50:36 (16436): Guest Log: [INFO] Volunteer: Alpha3031 (369691)

2019-11-08 10:50:37 (16436): Guest Log: [INFO] VMID: e5b01749-9626-457a-8945-16c64690aa2f

2019-11-08 10:50:37 (16436): Guest Log: [INFO] Requesting an X509 credential from LHC@home

2019-11-08 10:50:40 (16436): Guest Log: [INFO] Running the fast benchmark.

2019-11-08 11:13:08 (16436): Guest Log: [INFO] Machine performance 3.15 HEPSPEC06

2019-11-08 11:13:08 (16436): Guest Log: [INFO] Theory application starting. Check log files.

2019-11-08 11:13:09 (16436): Guest Log: [DEBUG] HTCondor ping

2019-11-08 11:13:13 (16436): Guest Log: [DEBUG] 0

2019-11-08 11:14:57 (16436): Guest Log: [INFO] New Job Starting in slot3

2019-11-08 11:14:57 (16436): Guest Log: [INFO] Condor JobID:  514444.11 in slot3

2019-11-08 11:15:00 (16436): Guest Log: [INFO] New Job Starting in slot1

2019-11-08 11:15:00 (16436): Guest Log: [INFO] Condor JobID:  514443.66 in slot1

2019-11-08 11:15:02 (16436): Guest Log: [INFO] MCPlots JobID: 52018998 in slot3

2019-11-08 11:15:05 (16436): Guest Log: [INFO] MCPlots JobID: 52018875 in slot1

2019-11-08 11:15:07 (16436): Guest Log: [INFO] ===> [runRivet] Fri Nov  8 04:14:53 CET 2019 [boinc ppbar mb-nsd 200 - - pythia8 8.235 tune-A2m 100000 155]

2019-11-08 11:15:11 (16436): Guest Log: [INFO] ===> [runRivet] Fri Nov  8 04:14:56 CET 2019 [boinc pp ttbar 7000 - - pythia6 6.428 p3 100000 155]

2019-11-08 11:35:12 (16436): Guest Log: [INFO] New Job Starting in slot4

2019-11-08 11:35:14 (16436): Guest Log: [INFO] Condor JobID:  514445.52 in slot4

2019-11-08 11:35:16 (16436): Guest Log: [INFO] New Job Starting in slot2

2019-11-08 11:35:17 (16436): Guest Log: [INFO] Condor JobID:  514445.51 in slot2

2019-11-08 11:35:23 (16436): Guest Log: [INFO] MCPlots JobID: 52019074 in slot4

2019-11-08 11:35:27 (16436): Guest Log: [INFO] MCPlots JobID: 52019086 in slot2

2019-11-08 11:35:31 (16436): Guest Log: [INFO] ===> [runRivet] Fri Nov  8 04:35:13 CET 2019 [boinc pp softqcdall 7000 - - pythia8 8.235 tune-4cx 100000 155]

2019-11-08 11:35:34 (16436): Guest Log: [INFO] ===> [runRivet] Fri Nov  8 04:35:16 CET 2019 [boinc pp mb-inelastic 900 - - pythia6 6.428 361 100000 155]

2019-11-08 11:55:46 (16436): Guest Log: [INFO] New Job Starting in slot7

2019-11-08 11:55:54 (16436): Guest Log: [INFO] New Job Starting in slot5

2019-11-08 11:56:14 (16436): Guest Log: [INFO] Condor JobID:  514447.1 in slot7

2019-11-08 11:56:21 (16436): Guest Log: [INFO] Condor JobID:  514446.76 in slot5

2019-11-08 11:57:57 (16436): Guest Log: [INFO] MCPlots JobID: 52019280 in slot7

2019-11-08 11:58:01 (16436): Guest Log: [INFO] MCPlots JobID: 52019153 in slot5

2019-11-08 11:58:42 (16436): Guest Log: [INFO] ===> [runRivet] Fri Nov  8 04:57:40 CET 2019 [boinc pp z1j 7000 125 - pythia6 6.428 395 100000 155]

2019-11-08 11:59:08 (16436): Guest Log: [INFO] ===> [runRivet] Fri Nov  8 04:57:29 CET 2019 [boinc ee zhad 133 - - pythia6 6.428 378 100000 155]

2019-11-08 12:19:25 (16436): Guest Log: [INFO] New Job Starting in slot8

2019-11-08 12:19:34 (16436): Guest Log: [INFO] New Job Starting in slot6

2019-11-08 12:21:01 (16436): Guest Log: [[IINNFFOO]]  CCoonnddoorr  JJoobbIIDD::    55114427424.74.66 9in  isnl ostl8o

2019-11-08 12:21:04 (16436): Guest Log: [[IINNFFOO]]  CCoonnddoorr  JJoobbIIDD::    55114427424.74.66 9in  isnl ostl8ot6

2019-11-08 12:27:00 (16436): Status Report: Job Duration: '129600.000000'
2019-11-08 12:27:00 (16436): Status Report: Elapsed Time: '6000.209179'
2019-11-08 12:27:00 (16436): Status Report: CPU Time: '17255.187500'
2019-11-08 12:28:57 (16436): Guest Log: [INFO] MCPlots JobID: 51994202 in slot8

2019-11-08 12:29:37 (16436): Guest Log: [INFO] MCPlots JobID: 52019315 in slot6

2019-11-08 12:31:46 (16436): Guest Log: [INFO] ===> [runRivet] Fri Nov  8 05:26:58 CET 2019 [boinc pp jets 7000 40,-,560 - pythia8 8.212 tune-monash13 100000 148]

2019-11-08 12:32:13 (16436): Guest Log: [INFO] ===> [runRivet] Fri Nov  8 05:26:50 CET 2019 [boinc pp ue 7000 - - pythia6 6.428 364 100000 155]

2019-11-08 12:36:06 (16436): Stopping VM.
2019-11-08 14:43:43 (14348): Detected: vboxwrapper 26197
2019-11-08 14:43:43 (14348): Detected: BOINC client v7.7
2019-11-08 14:43:45 (14348): Detected: VirtualBox VboxManage Interface (Version: 6.0.14)
2019-11-08 14:43:45 (14348): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2019-11-08 14:43:45 (14348): Starting VM using VBoxManage interface. (boinc_e53bc93d869cbc0b, slot#4)
2019-11-08 14:44:05 (14348): Successfully started VM. (PID = '13416')
2019-11-08 14:44:11 (14348): Reporting VM Process ID to BOINC.
2019-11-08 14:44:11 (14348): Guest Log: 01:48:06.045499 timesync vgsvcTimeSyncWorker: Radical host time change: 7 684 423 000 000ns (HostNow=1 573 195 451 478 000 000 ns HostLast=1 573 187 767 055 000 000 ns)

2019-11-08 14:44:11 (14348): VM state change detected. (old = 'PoweredOff', new = 'Running')
2019-11-08 14:44:11 (14348): Detected: Web Application Enabled (http://localhost:55317)
2019-11-08 14:44:11 (14348): Detected: Remote Desktop Enabled (localhost:55318)
2019-11-08 14:44:11 (14348): Status Report: Job Duration: '129600.000000'
2019-11-08 14:44:11 (14348): Status Report: Elapsed Time: '6546.209179'
2019-11-08 14:44:11 (14348): Status Report: CPU Time: '18915.296875'
2019-11-08 14:44:11 (14348): Preference change detected
2019-11-08 14:44:11 (14348): Setting CPU throttle for VM. (100%)
2019-11-08 14:44:12 (14348): Setting network throttle for VM. (1000KB)
2019-11-08 14:44:13 (14348): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2019-11-08 14:44:22 (14348): Guest Log: 01:48:16.071889 timesync vgsvcTimeSyncWorker: Radical guest time change: 7 688 642 869 000ns (GuestNow=1 573 195 461 504 955 000 ns GuestLast=1 573 187 772 862 086 000 ns fSetTimeLastLoop=true )

2019-11-08 14:51:46 (14348): VM state change detected. (old = 'Running', new = 'Paused')
2019-11-08 14:51:56 (14348): VM state change detected. (old = 'Paused', new = 'Running')
2019-11-08 14:53:06 (14348): VM state change detected. (old = 'Running', new = 'Paused')
2019-11-08 14:53:16 (14348): VM state change detected. (old = 'Paused', new = 'Running')
2019-11-08 14:54:16 (14348): VM state change detected. (old = 'Running', new = 'Paused')
2019-11-08 14:54:26 (14348): VM state change detected. (old = 'Paused', new = 'Running')
2019-11-08 14:54:46 (14348): VM state change detected. (old = 'Running', new = 'Paused')
2019-11-08 14:54:56 (14348): VM state change detected. (old = 'Paused', new = 'Running')
2019-11-08 15:00:27 (14348): VM state change detected. (old = 'Running', new = 'Paused')
2019-11-08 15:00:37 (14348): VM state change detected. (old = 'Paused', new = 'Running')
2019-11-08 15:01:37 (14348): VM state change detected. (old = 'Running', new = 'Paused')
2019-11-08 15:01:48 (14348): VM state change detected. (old = 'Paused', new = 'Running')
2019-11-08 15:21:40 (14348): VM state change detected. (old = 'Running', new = 'Paused')
2019-11-08 15:21:50 (14348): VM state change detected. (old = 'Paused', new = 'Running')
2019-11-08 15:22:10 (14348): VM state change detected. (old = 'Running', new = 'Paused')
2019-11-08 15:22:20 (14348): VM state change detected. (old = 'Paused', new = 'Running')
2019-11-08 15:23:50 (14348): VM state change detected. (old = 'Running', new = 'Paused')
2019-11-08 15:24:00 (14348): VM state change detected. (old = 'Paused', new = 'Running')
2019-11-08 15:36:42 (14348): VM state change detected. (old = 'Running', new = 'Paused')
2019-11-08 15:36:52 (14348): VM state change detected. (old = 'Paused', new = 'Running')
2019-11-08 15:37:42 (14348): VM state change detected. (old = 'Running', new = 'Paused')
2019-11-08 15:37:52 (14348): VM state change detected. (old = 'Paused', new = 'Running')
2019-11-08 15:44:13 (14348): Stopping VM.
2019-11-08 16:52:11 (2636): Detected: vboxwrapper 26197
2019-11-08 16:52:11 (2636): Detected: BOINC client v7.7
2019-11-08 16:52:13 (2636): Detected: VirtualBox VboxManage Interface (Version: 6.0.14)
2019-11-08 16:52:16 (2636): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2019-11-08 16:52:16 (2636): Starting VM using VBoxManage interface. (boinc_e53bc93d869cbc0b, slot#4)
2019-11-08 16:53:00 (2636): Successfully started VM. (PID = '10496')
2019-11-08 16:53:00 (2636): Reporting VM Process ID to BOINC.
2019-11-08 16:53:00 (2636): VM state change detected. (old = 'PoweredOff', new = 'Running')
2019-11-08 16:53:00 (2636): Detected: Web Application Enabled (http://localhost:55317)
2019-11-08 16:53:00 (2636): Detected: Remote Desktop Enabled (localhost:55318)
2019-11-08 16:53:00 (2636): Status Report: Job Duration: '129600.000000'
2019-11-08 16:53:00 (2636): Status Report: Elapsed Time: '10027.846222'
2019-11-08 16:53:00 (2636): Status Report: CPU Time: '32885.718750'
2019-11-08 16:53:00 (2636): Preference change detected
2019-11-08 16:53:00 (2636): Setting CPU throttle for VM. (100%)
2019-11-08 16:53:02 (2636): Setting network throttle for VM. (1000KB)
2019-11-08 16:53:02 (2636): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2019-11-08 16:53:03 (2636): Guest Log: 02:46:29.050196 timesync vgsvcTimeSyncWorker: Radical host time change: 4 135 164 000 000ns (HostNow=1 573 203 182 620 000 000 ns HostLast=1 573 199 047 456 000 000 ns)

2019-11-08 16:53:13 (2636): Guest Log: 02:46:39.200443 timesync vgsvcTimeSyncWorker: Radical guest time change: 4 238 312 621 000ns (GuestNow=1 573 203 192 783 064 000 ns GuestLast=1 573 198 954 470 443 000 ns fSetTimeLastLoop=true )

2019-11-08 17:10:00 (2636): VM state change detected. (old = 'Running', new = 'Paused')
2019-11-08 17:10:10 (2636): VM state change detected. (old = 'Paused', new = 'Running')
2019-11-08 17:18:30 (2636): VM state change detected. (old = 'Running', new = 'Paused')
2019-11-08 17:18:40 (2636): VM state change detected. (old = 'Paused', new = 'Running')
2019-11-08 17:52:43 (2636): Stopping VM.
2019-11-08 21:03:16 (11672): Detected: vboxwrapper 26197
2019-11-08 21:03:16 (11672): Detected: BOINC client v7.7
2019-11-08 21:03:18 (11672): Detected: VirtualBox VboxManage Interface (Version: 6.0.14)
2019-11-08 21:03:18 (11672): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2019-11-08 21:03:23 (11672): Starting VM using VBoxManage interface. (boinc_e53bc93d869cbc0b, slot#4)
2019-11-08 21:03:58 (11672): Successfully started VM. (PID = '13900')
2019-11-08 21:04:01 (11672): Reporting VM Process ID to BOINC.
2019-11-08 21:04:03 (11672): Guest Log: 03:45:52.351784 timesync vgsvcTimeSyncWorker: Radical host time change: 11 482 433 000 000ns (HostNow=1 573 218 238 194 000 000 ns HostLast=1 573 206 755 761 000 000 ns)

2019-11-08 21:04:04 (11672): VM state change detected. (old = 'PoweredOff', new = 'Running')
2019-11-08 21:04:04 (11672): Detected: Web Application Enabled (http://localhost:55317)
2019-11-08 21:04:04 (11672): Detected: Remote Desktop Enabled (localhost:55318)
2019-11-08 21:04:04 (11672): Status Report: Job Duration: '129600.000000'
2019-11-08 21:04:04 (11672): Status Report: Elapsed Time: '13585.709055'
2019-11-08 21:04:04 (11672): Status Report: CPU Time: '43537.359375'
2019-11-08 21:04:04 (11672): Preference change detected
2019-11-08 21:04:04 (11672): Setting CPU throttle for VM. (100%)
2019-11-08 21:04:10 (11672): Setting network throttle for VM. (1000KB)
2019-11-08 21:04:11 (11672): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2019-11-08 21:04:11 (11672): Guest Log: 03:46:02.458791 timesync vgsvcTimeSyncWorker: Radical guest time change: 11 502 419 827 000ns (GuestNow=1 573 218 248 327 631 000 ns GuestLast=1 573 206 745 907 804 000 ns fSetTimeLastLoop=true )

2019-11-08 22:44:09 (11672): Status Report: Job Duration: '129600.000000'
2019-11-08 22:44:09 (11672): Status Report: Elapsed Time: '19585.996372'
2019-11-08 22:44:09 (11672): Status Report: CPU Time: '55129.390625'
2019-11-09 00:24:13 (11672): Status Report: Job Duration: '129600.000000'
2019-11-09 00:24:13 (11672): Status Report: Elapsed Time: '25585.996372'
2019-11-09 00:24:13 (11672): Status Report: CPU Time: '66689.687500'
2019-11-09 02:04:18 (11672): Status Report: Job Duration: '129600.000000'
2019-11-09 02:04:18 (11672): Status Report: Elapsed Time: '31585.996372'
2019-11-09 02:04:18 (11672): Status Report: CPU Time: '78250.625000'
2019-11-09 03:44:22 (11672): Status Report: Job Duration: '129600.000000'
2019-11-09 03:44:22 (11672): Status Report: Elapsed Time: '37585.996372'
2019-11-09 03:44:22 (11672): Status Report: CPU Time: '89804.421875'
2019-11-09 05:24:27 (11672): Status Report: Job Duration: '129600.000000'
2019-11-09 05:24:27 (11672): Status Report: Elapsed Time: '43585.996372'
2019-11-09 05:24:27 (11672): Status Report: CPU Time: '101345.000000'
2019-11-09 05:51:56 (11672): Guest Log: [INFO] Job finished in slot3 with 0.

2019-11-09 07:04:32 (11672): Status Report: Job Duration: '129600.000000'
2019-11-09 07:04:32 (11672): Status Report: Elapsed Time: '49585.996372'
2019-11-09 07:04:32 (11672): Status Report: CPU Time: '112918.218750'
2019-11-09 08:44:36 (11672): Status Report: Job Duration: '129600.000000'
2019-11-09 08:44:36 (11672): Status Report: Elapsed Time: '55585.996372'
2019-11-09 08:44:36 (11672): Status Report: CPU Time: '124451.156250'
2019-11-09 10:24:41 (11672): Status Report: Job Duration: '129600.000000'
2019-11-09 10:24:42 (11672): Status Report: Elapsed Time: '61585.996372'
2019-11-09 10:24:42 (11672): Status Report: CPU Time: '136000.078125'
2019-11-09 12:04:46 (11672): Status Report: Job Duration: '129600.000000'
2019-11-09 12:04:46 (11672): Status Report: Elapsed Time: '67586.187479'
2019-11-09 12:04:46 (11672): Status Report: CPU Time: '147534.125000'
2019-11-09 13:44:50 (11672): Status Report: Job Duration: '129600.000000'
2019-11-09 13:44:50 (11672): Status Report: Elapsed Time: '73586.187479'
2019-11-09 13:44:50 (11672): Status Report: CPU Time: '159087.359375'
2019-11-09 15:24:50 (11672): Status Report: Job Duration: '129600.000000'
2019-11-09 15:24:50 (11672): Status Report: Elapsed Time: '79586.187479'
2019-11-09 15:24:50 (11672): Status Report: CPU Time: '170630.843750'
2019-11-09 15:52:10 (11672): Guest Log: [INFO] Job finished in slot4 with 0.

2019-11-09 16:13:50 (11672): Guest Log: [INFO] Job finished in slot1 with 0.

2019-11-09 16:53:05 (11672): Stopping VM.
2019-11-09 18:45:04 (12092): Detected: vboxwrapper 26197
2019-11-09 18:45:05 (12092): Detected: BOINC client v7.7
2019-11-09 18:45:09 (12092): Detected: VirtualBox VboxManage Interface (Version: 6.0.14)
2019-11-09 18:45:10 (12092): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2019-11-09 18:45:10 (12092): Starting VM using VBoxManage interface. (boinc_e53bc93d869cbc0b, slot#4)
2019-11-09 18:45:50 (12092): Successfully started VM. (PID = '7056')
2019-11-09 18:45:55 (12092): Reporting VM Process ID to BOINC.
2019-11-09 18:45:56 (12092): Guest Log: 23:35:10.262415 timesync vgsvcTimeSyncWorker: Radical host time change: 6 770 423 000 000ns (HostNow=1 573 296 353 076 000 000 ns HostLast=1 573 289 582 653 000 000 ns)

2019-11-09 18:45:57 (12092): VM state change detected. (old = 'PoweredOff', new = 'Running')
2019-11-09 18:45:57 (12092): Detected: Web Application Enabled (http://localhost:55317)
2019-11-09 18:45:57 (12092): Detected: Remote Desktop Enabled (localhost:55318)
2019-11-09 18:45:57 (12092): Status Report: Job Duration: '129600.000000'
2019-11-09 18:45:57 (12092): Status Report: Elapsed Time: '84876.187479'
2019-11-09 18:45:57 (12092): Status Report: CPU Time: '180811.921875'
2019-11-09 18:45:57 (12092): Preference change detected
2019-11-09 18:45:57 (12092): Setting CPU throttle for VM. (100%)
2019-11-09 18:45:58 (12092): Setting network throttle for VM. (1000KB)
2019-11-09 18:45:59 (12092): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2019-11-09 18:46:04 (12092): Guest Log: 23:35:20.307488 timesync vgsvcTimeSyncWorker: Radical guest time change: 6 770 759 653 000ns (GuestNow=1 573 296 363 132 940 000 ns GuestLast=1 573 289 592 373 287 000 ns fSetTimeLastLoop=true )

2019-11-09 18:54:58 (12092): Guest Log: [INFO] Job finished in slot7 with 0.

2019-11-09 18:56:21 (12092): Guest Log: [INFO] Job finished in slot6 with 0.

2019-11-09 18:56:52 (12092): Guest Log: [INFO] Job finished in slot2 with 0.

2019-11-09 19:42:48 (12092): VM state change detected. (old = 'Running', new = 'Paused')
2019-11-09 19:42:56 (12092): VM state change detected. (old = 'Paused', new = 'Running')
2019-11-09 20:10:48 (12092): VM state change detected. (old = 'Running', new = 'Paused')
2019-11-09 20:10:58 (12092): VM state change detected. (old = 'Paused', new = 'Running')
2019-11-09 20:14:02 (12092): Guest Log: [INFO] Job finished in slot8 with 0.

2019-11-09 20:26:25 (12092): Status Report: Job Duration: '129600.000000'
2019-11-09 20:26:25 (12092): Status Report: Elapsed Time: '90876.566370'
2019-11-09 20:26:25 (12092): Status Report: CPU Time: '196813.453125'
2019-11-09 20:29:10 (12092): VM state change detected. (old = 'Running', new = 'Paused')
2019-11-09 20:29:20 (12092): VM state change detected. (old = 'Paused', new = 'Running')
2019-11-09 20:50:26 (12092): Guest Log: [INFO] Job finished in slot5 with 0.

2019-11-10 16:43:02 (16052): Detected: vboxwrapper 26197
2019-11-10 16:43:02 (16052): Detected: BOINC client v7.7
2019-11-10 16:43:06 (16052): Detected: VirtualBox VboxManage Interface (Version: 6.0.14)
2019-11-10 16:43:06 (16052): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2019-11-10 16:43:07 (16052): Register VM. (boinc_e53bc93d869cbc0b, slot#4)
2019-11-10 16:43:07 (16052): Starting VM using VBoxManage interface. (boinc_e53bc93d869cbc0b, slot#4)
2019-11-10 16:43:19 (16052): Successfully started VM. (PID = '10476')
2019-11-10 16:43:19 (16052): Reporting VM Process ID to BOINC.
2019-11-10 16:43:19 (16052): Guest Log: BIOS: VirtualBox 6.0.14

2019-11-10 16:43:19 (16052): Guest Log: CPUID EDX: 0x178bfbff

2019-11-10 16:43:19 (16052): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63

2019-11-10 16:43:19 (16052): VM state change detected. (old = 'PoweredOff', new = 'Running')
2019-11-10 16:43:19 (16052): Detected: Web Application Enabled (http://localhost:55317)
2019-11-10 16:43:19 (16052): Detected: Remote Desktop Enabled (localhost:55318)
2019-11-10 16:43:19 (16052): Status Report: Job Duration: '129600.000000'
2019-11-10 16:43:19 (16052): Status Report: Elapsed Time: '92565.566370'
2019-11-10 16:43:19 (16052): Status Report: CPU Time: '198885.375000'
2019-11-10 16:43:19 (16052): Preference change detected
2019-11-10 16:43:19 (16052): Setting CPU throttle for VM. (100%)
2019-11-10 16:43:20 (16052): Setting network throttle for VM. (1000KB)
2019-11-10 16:43:21 (16052): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2019-11-10 16:43:22 (16052): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032

2019-11-10 16:43:22 (16052): Guest Log: BIOS: Booting from Hard Disk...

2019-11-10 16:43:23 (16052): VM state change detected. (old = 'Running', new = 'Paused')
2019-11-10 16:43:33 (16052): VM state change detected. (old = 'Paused', new = 'Running')
2019-11-10 16:43:35 (16052): Guest Log: BIOS: KBD: unsupported int 16h function 03

2019-11-10 16:43:35 (16052): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 

2019-11-10 16:44:03 (16052): VM state change detected. (old = 'Running', new = 'Paused')
2019-11-10 16:44:13 (16052): VM state change detected. (old = 'Paused', new = 'Running')
2019-11-10 16:44:49 (16052): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds

2019-11-10 16:44:49 (16052): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)

2019-11-10 16:45:33 (16052): VM state change detected. (old = 'Running', new = 'Paused')
2019-11-10 16:45:43 (16052): VM state change detected. (old = 'Paused', new = 'Running')
2019-11-10 16:46:43 (16052): VM state change detected. (old = 'Running', new = 'Paused')
2019-11-10 16:46:54 (16052): VM state change detected. (old = 'Paused', new = 'Running')
2019-11-10 16:47:05 (16052): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log

2019-11-10 16:47:05 (16052): Guest Log: 00:00:00.001585 main     Log opened 2019-11-10T08:46:52.909915000Z

2019-11-10 16:47:05 (16052): Guest Log: 00:00:00.003420 main     OS Product: Linux

2019-11-10 16:47:05 (16052): Guest Log: 00:00:00.003891 main     OS Release: 4.14.44-11.cernvm.x86_64

2019-11-10 16:47:05 (16052): Guest Log: 00:00:00.003975 main     OS Version: #1 SMP Mon May 28 16:49:00 CEST 2018

2019-11-10 16:47:05 (16052): Guest Log: 00:00:00.004033 main     Executable: /usr/share/vboxguest52/usr/sbin/VBoxService

2019-11-10 16:47:05 (16052): Guest Log: 00:00:00.004036 main     Process ID: 3135

2019-11-10 16:47:05 (16052): Guest Log: 00:00:00.004038 main     Package type: LINUX_64BITS_GENERIC

2019-11-10 16:47:05 (16052): Guest Log: 00:00:00.007195 main     5.2.6 r120293 started. Verbose level = 0

2019-11-10 16:47:34 (16052): VM state change detected. (old = 'Running', new = 'Paused')
2019-11-14 15:20:52 (14236): Detected: vboxwrapper 26197
2019-11-14 15:20:52 (14236): Detected: BOINC client v7.7
2019-11-14 15:21:00 (14236): Detected: VirtualBox VboxManage Interface (Version: 6.0.14)
2019-11-14 15:21:01 (14236): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2019-11-14 15:21:01 (14236): Starting VM using VBoxManage interface. (boinc_e53bc93d869cbc0b, slot#4)
2019-11-14 15:21:27 (14236): Successfully started VM. (PID = '11604')
2019-11-14 15:21:27 (14236): Reporting VM Process ID to BOINC.
2019-11-14 15:21:27 (14236): Guest Log: BIOS: VirtualBox 6.0.14

2019-11-14 15:21:27 (14236): Guest Log: CPUID EDX: 0x178bfbff

2019-11-14 15:21:27 (14236): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63

2019-11-14 15:21:27 (14236): VM state change detected. (old = 'PoweredOff', new = 'Running')
2019-11-14 15:21:27 (14236): Detected: Web Application Enabled (http://localhost:55317)
2019-11-14 15:21:27 (14236): Detected: Remote Desktop Enabled (localhost:55318)
2019-11-14 15:21:27 (14236): Status Report: Job Duration: '129600.000000'
2019-11-14 15:21:27 (14236): Status Report: Elapsed Time: '92757.684299'
2019-11-14 15:21:27 (14236): Status Report: CPU Time: '199132.453125'
2019-11-14 15:21:27 (14236): Preference change detected
2019-11-14 15:21:27 (14236): Setting CPU throttle for VM. (100%)
2019-11-14 15:21:28 (14236): Setting network throttle for VM. (1000KB)
2019-11-14 15:21:28 (14236): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2019-11-14 15:21:29 (14236): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032

2019-11-14 15:21:29 (14236): Guest Log: BIOS: Booting from Hard Disk...

2019-11-14 15:21:32 (14236): Guest Log: BIOS: KBD: unsupported int 16h function 03

2019-11-14 15:21:32 (14236): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 

2019-11-14 15:22:18 (14236): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds

2019-11-14 15:22:18 (14236): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)

2019-11-14 15:23:17 (14236): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log

2019-11-14 15:23:17 (14236): Guest Log: 00:00:00.000449 main     Log opened 2019-11-14T07:23:11.671082000Z

2019-11-14 15:23:17 (14236): Guest Log: 00:00:00.001753 main     OS Product: Linux

2019-11-14 15:23:17 (14236): Guest Log: 00:00:00.002042 main     OS Release: 4.14.44-11.cernvm.x86_64

2019-11-14 15:23:17 (14236): Guest Log: 00:00:00.002256 main     OS Version: #1 SMP Mon May 28 16:49:00 CEST 2018

2019-11-14 15:23:18 (14236): Guest Log: 00:00:00.002472 main     Executable: /usr/share/vboxguest52/usr/sbin/VBoxService

2019-11-14 15:23:18 (14236): Guest Log: 00:00:00.002474 main     Process ID: 3069

2019-11-14 15:23:18 (14236): Guest Log: 00:00:00.002475 main     Package type: LINUX_64BITS_GENERIC

2019-11-14 15:23:18 (14236): Guest Log: 00:00:00.004711 main     5.2.6 r120293 started. Verbose level = 0

2019-11-14 15:24:02 (14236): Guest Log: [INFO] Mounting the shared directory

2019-11-14 15:24:03 (14236): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor

2019-11-14 15:24:03 (14236): Guest Log: [DEBUG] Testing network connection to cern.ch on port 80

2019-11-14 15:24:04 (14236): Guest Log: [DEBUG] Connection to cern.ch 80 port [tcp/http] succeeded!

2019-11-14 15:24:04 (14236): Guest Log: [DEBUG] 0

2019-11-14 15:24:04 (14236): Guest Log: [DEBUG] Testing VCCS connection to vccs.cern.ch on port 443

2019-11-14 15:24:05 (14236): Guest Log: [DEBUG] Connection to vccs.cern.ch 443 port [tcp/https] succeeded!

2019-11-14 15:24:05 (14236): Guest Log: [DEBUG] 0

2019-11-14 15:24:05 (14236): Guest Log: [DEBUG] Testing connection to Condor server on port 9618

2019-11-14 15:24:06 (14236): Guest Log: [DEBUG] Connection to vccondor01.cern.ch 9618 port [tcp/condor] succeeded!

2019-11-14 15:24:07 (14236): Guest Log: [DEBUG] 0

2019-11-14 15:25:17 (14236): Guest Log: [DEBUG] Probing CVMFS ...

2019-11-14 15:25:20 (14236): Guest Log: Probing /cvmfs/grid.cern.ch... OK

2019-11-14 15:25:22 (14236): 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-14 15:25:22 (14236): Guest Log: 2.4.4.0 3752 1 27868 10737 3 1 529366 10240001 2 65024 0 3 100 0 0 http://s1unl-cvmfs.openhtc.io/cvmfs/grid.cern.ch DIRECT 1

2019-11-14 15:25:47 (14236): Guest Log: [INFO] Reading volunteer information

2019-11-14 15:25:48 (14236): Guest Log: [INFO] Volunteer: Alpha3031 (369691)

2019-11-14 15:25:48 (14236): Guest Log: [INFO] VMID: e5b01749-9626-457a-8945-16c64690aa2f

2019-11-14 15:25:49 (14236): Guest Log: [INFO] Requesting an X509 credential from LHC@home

2019-11-14 15:25:53 (14236): Guest Log: [INFO] Running the fast benchmark.

2019-11-14 15:43:01 (14236): Guest Log: [INFO] Machine performance 4.61 HEPSPEC06

2019-11-14 15:43:01 (14236): Guest Log: [INFO] Theory application starting. Check log files.

2019-11-14 15:43:02 (14236): Guest Log: [DEBUG] HTCondor ping

2019-11-14 15:43:07 (14236): Guest Log: [DEBUG] 0

2019-11-14 15:51:27 (14236): VM state change detected. (old = 'Running', new = 'Paused')
2019-11-14 15:51:37 (14236): VM state change detected. (old = 'Paused', new = 'Running')
2019-11-14 15:53:07 (14236): VM state change detected. (old = 'Running', new = 'Paused')
2019-11-14 15:53:17 (14236): VM state change detected. (old = 'Paused', new = 'Running')
2019-11-14 15:53:55 (14236): Guest Log: [INFO] Condor exited with return value N/A.

2019-11-14 15:53:56 (14236): Guest Log: [INFO] Shutting Down.

2019-11-14 15:53:57 (14236): VM Completion File Detected.
2019-11-14 15:53:57 (14236): VM Completion Message: Condor exited with return value N/A.
.
2019-11-14 15:53:57 (14236): Powering off VM.
2019-11-14 15:58:58 (14236): VM did not power off when requested.
2019-11-14 15:58:58 (14236): VM was successfully terminated.
2019-11-14 15:58:58 (14236): Deregistering VM. (boinc_e53bc93d869cbc0b, slot#4)
2019-11-14 15:58:59 (14236): Removing network bandwidth throttle group from VM.
2019-11-14 15:59:00 (14236): Removing VM from VirtualBox.
15:59:05 (14236): called boinc_finish(0)

</stderr_txt>
]]>

©2025 CERN