Task 251460506

Name	Theory_3729131_1573395555.205328_0
Workunit	126295588
Created	10 Nov 2019, 14:19:18 UTC
Sent	10 Nov 2019, 20:41:09 UTC
Report deadline	11 Dec 2019, 20:41:09 UTC
Received	13 Nov 2019, 4:45:43 UTC
Server state	Over
Outcome	Success
Client state	Done
Exit status	0 (0x00000000)
Computer ID	10584191
Run time	21 hours 25 min 15 sec
CPU time	20 hours 39 min 43 sec
Validate state	Valid
Credit	834.62
Device peak FLOPS	4.68 GFLOPS
Application version	Theory Simulation v263.98 (vbox64_mt_mcore) x86_64-pc-linux-gnu
Peak working set size	110.65 MB
Peak swap size	3.44 GB
Peak disk usage	1.20 GB
Stderr output

<core_client_version>7.14.2</core_client_version>
<![CDATA[
<stderr_txt>
2019-11-11 16:17:19 (26446): vboxwrapper (7.7.26196): starting
2019-11-11 16:17:19 (26446): Feature: Checkpoint interval offset (584 seconds)
2019-11-11 16:17:19 (26446): Detected: VirtualBox VboxManage Interface (Version: 5.2.32)
2019-11-11 16:17:19 (26446): VBOX_JOB::parse(): unexpected text enable_screenshots_on_error/
2019-11-11 16:17:19 (26446): Detected: Minimum checkpoint interval (600.000000 seconds)
2019-11-11 16:17:19 (26446): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2019-11-11 16:17:19 (26446): Successfully copied 'init_data.xml' to the shared directory.
2019-11-11 16:17:19 (26446): Create VM. (boinc_59fad036ca53233c, slot#13)
2019-11-11 16:17:19 (26446): Setting Memory Size for VM. (1500MB)
2019-11-11 16:17:19 (26446): Setting CPU Count for VM. (1)
2019-11-11 16:17:19 (26446): Setting Chipset Options for VM.
2019-11-11 16:17:19 (26446): Setting Boot Options for VM.
2019-11-11 16:17:19 (26446): Setting Network Configuration for NAT.
2019-11-11 16:17:19 (26446): Enabling VM Network Access.
2019-11-11 16:17:19 (26446): Disabling USB Support for VM.
2019-11-11 16:17:20 (26446): Disabling COM Port Support for VM.
2019-11-11 16:17:20 (26446): Disabling LPT Port Support for VM.
2019-11-11 16:17:20 (26446): Disabling Audio Support for VM.
2019-11-11 16:17:20 (26446): Disabling Clipboard Support for VM.
2019-11-11 16:17:20 (26446): Disabling Drag and Drop Support for VM.
2019-11-11 16:17:20 (26446): Adding storage controller(s) to VM.
2019-11-11 16:17:20 (26446): Adding virtual disk drive to VM. (vm_image.vdi)
2019-11-11 16:17:20 (26446): Adding VirtualBox Guest Additions to VM.
2019-11-11 16:17:20 (26446): Adding network bandwidth throttle group to VM. (Defaulting to 1024GB)
2019-11-11 16:17:20 (26446): forwarding host port 48223 to guest port 80
2019-11-11 16:17:20 (26446): Enabling remote desktop for VM.
2019-11-11 16:17:20 (26446): Enabling shared directory for VM.
2019-11-11 16:17:21 (26446): Starting VM. (boinc_59fad036ca53233c, slot#13)
2019-11-11 16:17:22 (26446): Successfully started VM. (PID = '27024')
2019-11-11 16:17:22 (26446): Reporting VM Process ID to BOINC.
2019-11-11 16:17:22 (26446): Guest Log: BIOS: VirtualBox 5.2.32
2019-11-11 16:17:22 (26446): Guest Log: CPUID EDX: 0x078bfbff
2019-11-11 16:17:22 (26446): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63
2019-11-11 16:17:22 (26446): VM state change detected. (old = 'poweroff', new = 'running')
2019-11-11 16:17:22 (26446): Detected: Web Application Enabled (http://localhost:48223)
2019-11-11 16:17:22 (26446): Detected: Remote Desktop Enabled (localhost:58495)
2019-11-11 16:17:22 (26446): Preference change detected
2019-11-11 16:17:22 (26446): Setting CPU throttle for VM. (100%)
2019-11-11 16:17:22 (26446): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2019-11-11 16:17:24 (26446): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2019-11-11 16:17:24 (26446): Guest Log: BIOS: Booting from Hard Disk...
2019-11-11 16:17:26 (26446): Guest Log: BIOS: KBD: unsupported int 16h function 03
2019-11-11 16:17:26 (26446): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 
2019-11-11 16:17:43 (26446): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2019-11-11 16:17:43 (26446): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)
2019-11-11 16:18:09 (26446): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log
2019-11-11 16:18:09 (26446): Guest Log: 00:00:00.000181 main     Log opened 2019-11-11T16:18:09.040044000Z
2019-11-11 16:18:09 (26446): Guest Log: 00:00:00.000492 main     OS Product: Linux
2019-11-11 16:18:09 (26446): Guest Log: 00:00:00.000540 main     OS Release: 4.14.44-11.cernvm.x86_64
2019-11-11 16:18:09 (26446): Guest Log: 00:00:00.000570 main     OS Version: #1 SMP Mon May 28 16:49:00 CEST 2018
2019-11-11 16:18:09 (26446): Guest Log: 00:00:00.000610 main     Executable: /usr/share/vboxguest52/usr/sbin/VBoxService
2019-11-11 16:18:09 (26446): Guest Log: 00:00:00.000611 main     Process ID: 2961
2019-11-11 16:18:09 (26446): Guest Log: 00:00:00.000612 main     Package type: LINUX_64BITS_GENERIC
2019-11-11 16:18:09 (26446): Guest Log: 00:00:00.002142 main     5.2.6 r120293 started. Verbose level = 0
2019-11-11 16:18:28 (26446): Guest Log: [INFO] Mounting the shared directory
2019-11-11 16:18:28 (26446): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor
2019-11-11 16:18:28 (26446): Guest Log: [DEBUG] Testing network connection to cern.ch on port 80
2019-11-11 16:18:28 (26446): Guest Log: [DEBUG] Connection to cern.ch 80 port [tcp/http] succeeded!
2019-11-11 16:18:28 (26446): Guest Log: [DEBUG] 0
2019-11-11 16:18:28 (26446): Guest Log: [DEBUG] Testing VCCS connection to vccs.cern.ch on port 443
2019-11-11 16:18:28 (26446): Guest Log: [DEBUG] Connection to vccs.cern.ch 443 port [tcp/https] succeeded!
2019-11-11 16:18:28 (26446): Guest Log: [DEBUG] 0
2019-11-11 16:18:28 (26446): Guest Log: [DEBUG] Testing connection to Condor server on port 9618
2019-11-11 16:18:28 (26446): Guest Log: [DEBUG] Connection to vccondor01.cern.ch 9618 port [tcp/condor] succeeded!
2019-11-11 16:18:28 (26446): Guest Log: [DEBUG] 0
2019-11-11 16:19:31 (26446): Guest Log: [DEBUG] Probing CVMFS ...
2019-11-11 16:19:32 (26446): Guest Log: Probing /cvmfs/grid.cern.ch... OK
2019-11-11 16:19:33 (26446): 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 16:19:33 (26446): Guest Log: 2.4.4.0 3680 1 28364 10715 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 16:19:39 (26446): Guest Log: [INFO] Reading volunteer information
2019-11-11 16:19:39 (26446): Guest Log: [INFO] Volunteer: PRHumphrey (21541)
2019-11-11 16:19:39 (26446): Guest Log: [INFO] VMID: e5b01749-9626-457a-8945-16c64690aa2f
2019-11-11 16:19:39 (26446): Guest Log: [INFO] Requesting an X509 credential from LHC@home
2019-11-11 16:19:40 (26446): Guest Log: [INFO] Running the fast benchmark.
2019-11-11 16:20:31 (26446): Guest Log: [INFO] Machine performance 9.90 HEPSPEC06
2019-11-11 16:20:31 (26446): Guest Log: [INFO] Theory application starting. Check log files.
2019-11-11 16:20:31 (26446): Guest Log: [DEBUG] HTCondor ping
2019-11-11 16:20:31 (26446): Guest Log: [DEBUG] 0
2019-11-11 16:21:34 (26446): Guest Log: [INFO] New Job Starting in slot1
2019-11-11 16:21:34 (26446): Guest Log: [INFO] Condor JobID:  514589.73 in slot1
2019-11-11 16:21:39 (26446): Guest Log: [INFO] MCPlots JobID: 52038181 in slot1
2019-11-11 16:21:45 (26446): Guest Log: [INFO] ===> [runRivet] Mon Nov 11 16:21:34 GMT 2019 [boinc pp mb-inelastic 900 - - pythia6 6.427 dwt 100000 156]
2019-11-11 16:36:26 (26446): Guest Log: [INFO] Job finished in slot1 with 0.
2019-11-11 16:36:28 (26446): Guest Log: [INFO] New Job Starting in slot1
2019-11-11 16:36:29 (26446): Guest Log: [INFO] Condor JobID:  514802.8 in slot1
2019-11-11 16:36:34 (26446): Guest Log: [INFO] MCPlots JobID: 52071482 in slot1
2019-11-11 16:36:39 (26446): Guest Log: [INFO] ===> [runRivet] Mon Nov 11 16:36:28 GMT 2019 [boinc ppbar jets 1960 17 - herwig7 7.1.4 softTune 100000 156]
2019-11-11 17:15:16 (26446): VM state change detected. (old = 'running', new = 'paused')
2019-11-11 17:15:29 (26446): VM state change detected. (old = 'paused', new = 'running')
2019-11-11 17:43:30 (26446): VM state change detected. (old = 'running', new = 'paused')
2019-11-11 18:01:21 (26446): VM state change detected. (old = 'paused', new = 'running')
2019-11-11 18:14:41 (26446): Status Report: Job Duration: '129600.000000'
2019-11-11 18:14:41 (26446): Status Report: Elapsed Time: '6002.129880'
2019-11-11 18:14:41 (26446): Status Report: CPU Time: '5733.620000'
2019-11-11 19:54:41 (26446): Status Report: Job Duration: '129600.000000'
2019-11-11 19:54:41 (26446): Status Report: Elapsed Time: '12003.447067'
2019-11-11 19:54:41 (26446): Status Report: CPU Time: '11558.320000'
2019-11-11 20:16:02 (26446): Guest Log: [INFO] Job finished in slot1 with 0.
2019-11-11 20:16:05 (26446): Guest Log: [INFO] New Job Starting in slot1
2019-11-11 20:16:05 (26446): Guest Log: [INFO] Condor JobID:  514813.83 in slot1
2019-11-11 20:16:10 (26446): Guest Log: [INFO] MCPlots JobID: 52074290 in slot1
2019-11-11 20:16:15 (26446): Guest Log: [INFO] ===> [runRivet] Mon Nov 11 19:58:19 GMT 2019 [boinc pp jets 7000 40 - pythia6 6.428 z2 100000 157]
2019-11-11 21:34:42 (26446): Status Report: Job Duration: '129600.000000'
2019-11-11 21:34:42 (26446): Status Report: Elapsed Time: '18005.412836'
2019-11-11 21:34:42 (26446): Status Report: CPU Time: '17410.730000'
2019-11-11 22:45:00 (26446): VM state change detected. (old = 'running', new = 'paused')
2019-11-11 22:45:28 (26446): VM state change detected. (old = 'paused', new = 'running')
2019-11-11 23:15:14 (26446): Status Report: Job Duration: '129600.000000'
2019-11-11 23:15:14 (26446): Status Report: Elapsed Time: '24007.620714'
2019-11-11 23:15:14 (26446): Status Report: CPU Time: '23240.460000'
2019-11-11 23:26:45 (26446): Guest Log: [INFO] Job finished in slot1 with 0.
2019-11-11 23:26:52 (26446): Guest Log: [INFO] New Job Starting in slot1
2019-11-11 23:26:52 (26446): Guest Log: [INFO] Condor JobID:  514821.84 in slot1
2019-11-11 23:26:56 (26446): Guest Log: [INFO] MCPlots JobID: 52075288 in slot1
2019-11-11 23:26:59 (26446): Guest Log: [INFO] ===> [runRivet] Mon Nov 11 23:08:42 GMT 2019 [boinc pp zinclusive 7000 -,-,50,130 - pythia8 8.235 tune-2m 100000 157]
2019-11-12 00:09:52 (26446): VM state change detected. (old = 'running', new = 'paused')
2019-11-12 06:28:50 (26446): VM state change detected. (old = 'paused', new = 'running')
2019-11-12 06:28:54 (26446): Guest Log: 07:33:28.648957 timesync vgsvcTimeSyncWorker: Radical host time change: 22 748 247 000 000ns (HostNow=1 573 540 131 887 000 000 ns HostLast=1 573 517 383 640 000 000 ns)
2019-11-12 06:29:04 (26446): Guest Log: 07:33:38.652168 timesync vgsvcTimeSyncWorker: Radical guest time change: 23 833 511 923 000ns (GuestNow=1 573 540 141 890 326 000 ns GuestLast=1 573 516 308 378 403 000 ns fSetTimeLastLoop=true )
2019-11-12 07:14:08 (26446): Status Report: Job Duration: '129600.000000'
2019-11-12 07:14:08 (26446): Status Report: Elapsed Time: '30007.786506'
2019-11-12 07:14:08 (26446): Status Report: CPU Time: '29141.090000'
2019-11-12 08:54:01 (26446): Status Report: Job Duration: '129600.000000'
2019-11-12 08:54:01 (26446): Status Report: Elapsed Time: '36008.151256'
2019-11-12 08:54:01 (26446): Status Report: CPU Time: '34984.480000'
2019-11-12 09:27:17 (26446): VM state change detected. (old = 'running', new = 'paused')
sh: line 1:  8436 Segmentation fault      VBoxManage -q showvminfo "boinc_59fad036ca53233c" --machinereadable 2>&1
2019-11-12 09:31:24 (26446): ERROR: Vboxwrapper lost communication with VirtualBox, rescheduling task for a later time.
2019-11-12 09:31:24 (26446): Powering off VM.
sh: line 1:  8785 Segmentation fault      VBoxManage -q showvminfo "boinc_59fad036ca53233c" --machinereadable 2>&1
2019-11-12 15:01:50 (2768): vboxwrapper (7.7.26196): starting
2019-11-12 15:01:50 (2768): Feature: Checkpoint interval offset (515 seconds)
2019-11-12 15:01:50 (2768): Detected: VirtualBox VboxManage Interface (Version: 5.2.32)
2019-11-12 15:01:50 (2768): VBOX_JOB::parse(): unexpected text enable_screenshots_on_error/
2019-11-12 15:01:50 (2768): Detected: Minimum checkpoint interval (600.000000 seconds)
2019-11-12 15:01:50 (2768): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2019-11-12 15:01:51 (2768): Guest Log: BIOS: VirtualBox 5.2.32
2019-11-12 15:01:51 (2768): Guest Log: CPUID EDX: 0x078bfbff
2019-11-12 15:01:51 (2768): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63
2019-11-12 15:01:51 (2768): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2019-11-12 15:01:51 (2768): Guest Log: BIOS: Booting from Hard Disk...
2019-11-12 15:01:51 (2768): Guest Log: BIOS: KBD: unsupported int 16h function 03
2019-11-12 15:01:51 (2768): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 
2019-11-12 15:01:51 (2768): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2019-11-12 15:01:51 (2768): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)
2019-11-12 15:01:51 (2768): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log
2019-11-12 15:01:51 (2768): Guest Log: 00:00:00.000181 main     Log opened 2019-11-11T16:18:09.040044000Z
2019-11-12 15:01:51 (2768): Guest Log: 00:00:00.000492 main     OS Product: Linux
2019-11-12 15:01:51 (2768): Guest Log: 00:00:00.000540 main     OS Release: 4.14.44-11.cernvm.x86_64
2019-11-12 15:01:51 (2768): Guest Log: 00:00:00.000570 main     OS Version: #1 SMP Mon May 28 16:49:00 CEST 2018
2019-11-12 15:01:51 (2768): Guest Log: 00:00:00.000610 main     Executable: /usr/share/vboxguest52/usr/sbin/VBoxService
2019-11-12 15:01:51 (2768): Guest Log: 00:00:00.000611 main     Process ID: 2961
2019-11-12 15:01:51 (2768): Guest Log: 00:00:00.000612 main     Package type: LINUX_64BITS_GENERIC
2019-11-12 15:01:51 (2768): Guest Log: 00:00:00.002142 main     5.2.6 r120293 started. Verbose level = 0
2019-11-12 15:01:51 (2768): Guest Log: [INFO] Mounting the shared directory
2019-11-12 15:01:51 (2768): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor
2019-11-12 15:01:51 (2768): Guest Log: [DEBUG] Testing network connection to cern.ch on port 80
2019-11-12 15:01:51 (2768): Guest Log: [DEBUG] Connection to cern.ch 80 port [tcp/http] succeeded!
2019-11-12 15:01:51 (2768): Guest Log: [DEBUG] 0
2019-11-12 15:01:51 (2768): Guest Log: [DEBUG] Testing VCCS connection to vccs.cern.ch on port 443
2019-11-12 15:01:51 (2768): Guest Log: [DEBUG] Connection to vccs.cern.ch 443 port [tcp/https] succeeded!
2019-11-12 15:01:51 (2768): Guest Log: [DEBUG] 0
2019-11-12 15:01:51 (2768): Guest Log: [DEBUG] Testing connection to Condor server on port 9618
2019-11-12 15:01:51 (2768): Guest Log: [DEBUG] Connection to vccondor01.cern.ch 9618 port [tcp/condor] succeeded!
2019-11-12 15:01:51 (2768): Guest Log: [DEBUG] 0
2019-11-12 15:01:51 (2768): Guest Log: [DEBUG] Probing CVMFS ...
2019-11-12 15:01:51 (2768): Guest Log: Probing /cvmfs/grid.cern.ch... OK
2019-11-12 15:01:51 (2768): 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 15:01:51 (2768): Guest Log: 2.4.4.0 3680 1 28364 10715 3 1 318381 10240000 2 65024 0 3 100 0 0 http://s1cern-cvmfs.openhtc.io/cvmfs/grid.cern.ch DIRECT 1
2019-11-12 15:01:51 (2768): Guest Log: [INFO] Reading volunteer information
2019-11-12 15:01:51 (2768): Guest Log: [INFO] Volunteer: PRHumphrey (21541)
2019-11-12 15:01:51 (2768): Guest Log: [INFO] VMID: e5b01749-9626-457a-8945-16c64690aa2f
2019-11-12 15:01:51 (2768): Guest Log: [INFO] Requesting an X509 credential from LHC@home
2019-11-12 15:01:51 (2768): Guest Log: [INFO] Running the fast benchmark.
2019-11-12 15:01:51 (2768): Guest Log: [INFO] Machine performance 9.90 HEPSPEC06
2019-11-12 15:01:51 (2768): Guest Log: [INFO] Theory application starting. Check log files.
2019-11-12 15:01:51 (2768): Guest Log: [DEBUG] HTCondor ping
2019-11-12 15:01:51 (2768): Guest Log: [DEBUG] 0
2019-11-12 15:01:51 (2768): Guest Log: [INFO] New Job Starting in slot1
2019-11-12 15:01:51 (2768): Guest Log: [INFO] Condor JobID:  514589.73 in slot1
2019-11-12 15:01:51 (2768): Guest Log: [INFO] MCPlots JobID: 52038181 in slot1
2019-11-12 15:01:51 (2768): Guest Log: [INFO] ===> [runRivet] Mon Nov 11 16:21:34 GMT 2019 [boinc pp mb-inelastic 900 - - pythia6 6.427 dwt 100000 156]
2019-11-12 15:01:51 (2768): Guest Log: [INFO] Job finished in slot1 with 0.
2019-11-12 15:01:51 (2768): Guest Log: [INFO] New Job Starting in slot1
2019-11-12 15:01:51 (2768): Guest Log: [INFO] Condor JobID:  514802.8 in slot1
2019-11-12 15:01:51 (2768): Guest Log: [INFO] MCPlots JobID: 52071482 in slot1
2019-11-12 15:01:51 (2768): Guest Log: [INFO] ===> [runRivet] Mon Nov 11 16:36:28 GMT 2019 [boinc ppbar jets 1960 17 - herwig7 7.1.4 softTune 100000 156]
2019-11-12 15:01:51 (2768): Guest Log: [INFO] Job finished in slot1 with 0.
2019-11-12 15:01:51 (2768): Guest Log: [INFO] New Job Starting in slot1
2019-11-12 15:01:51 (2768): Guest Log: [INFO] Condor JobID:  514813.83 in slot1
2019-11-12 15:01:51 (2768): Guest Log: [INFO] MCPlots JobID: 52074290 in slot1
2019-11-12 15:01:51 (2768): Guest Log: [INFO] ===> [runRivet] Mon Nov 11 19:58:19 GMT 2019 [boinc pp jets 7000 40 - pythia6 6.428 z2 100000 157]
2019-11-12 15:01:51 (2768): Guest Log: [INFO] Job finished in slot1 with 0.
2019-11-12 15:01:51 (2768): Guest Log: [INFO] New Job Starting in slot1
2019-11-12 15:01:51 (2768): Guest Log: [INFO] Condor JobID:  514821.84 in slot1
2019-11-12 15:01:51 (2768): Guest Log: [INFO] MCPlots JobID: 52075288 in slot1
2019-11-12 15:01:51 (2768): Guest Log: [INFO] ===> [runRivet] Mon Nov 11 23:08:42 GMT 2019 [boinc pp zinclusive 7000 -,-,50,130 - pythia8 8.235 tune-2m 100000 157]
2019-11-12 15:01:51 (2768): Guest Log: 07:33:28.648957 timesync vgsvcTimeSyncWorker: Radical host time change: 22 748 247 000 000ns (HostNow=1 573 540 131 887 000 000 ns HostLast=1 573 517 383 640 000 000 ns)
2019-11-12 15:01:51 (2768): Guest Log: 07:33:38.652168 timesync vgsvcTimeSyncWorker: Radical guest time change: 23 833 511 923 000ns (GuestNow=1 573 540 141 890 326 000 ns GuestLast=1 573 516 308 378 403 000 ns fSetTimeLastLoop=true )
2019-11-12 15:01:51 (2768): Starting VM. (boinc_59fad036ca53233c, slot#13)
2019-11-12 15:01:52 (2768): Successfully started VM. (PID = '3065')
2019-11-12 15:01:52 (2768): Reporting VM Process ID to BOINC.
2019-11-12 15:01:52 (2768): VM state change detected. (old = 'poweroff', new = 'running')
2019-11-12 15:01:52 (2768): Detected: Web Application Enabled (http://localhost:48223)
2019-11-12 15:01:52 (2768): Detected: Remote Desktop Enabled (localhost:58495)
2019-11-12 15:01:52 (2768): Status Report: Job Duration: '129600.000000'
2019-11-12 15:01:52 (2768): Status Report: Elapsed Time: '38005.781377'
2019-11-12 15:01:52 (2768): Status Report: CPU Time: '36859.010000'
2019-11-12 15:01:52 (2768): Preference change detected
2019-11-12 15:01:52 (2768): Setting CPU throttle for VM. (100%)
2019-11-12 15:01:53 (2768): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2019-11-12 15:03:31 (2768): VM is no longer is a running state. It is in 'poweroff'.
2019-11-12 15:03:31 (2768): VM state change detected. (old = 'running', new = 'poweroff')
2019-11-12 15:03:31 (2768): Powering off VM.
2019-11-12 15:03:31 (2768): Deregistering VM. (boinc_59fad036ca53233c, slot#13)
2019-11-12 15:03:31 (2768): Removing network bandwidth throttle group from VM.
2019-11-12 15:03:31 (2768): Removing storage controller(s) from VM.
2019-11-12 15:03:31 (2768): Removing VM from VirtualBox.
2019-11-12 15:03:31 (2768): Removing virtual disk drive from VirtualBox.
2019-11-12 16:27:44 (28931): vboxwrapper (7.7.26196): starting
2019-11-12 16:27:44 (28931): Feature: Checkpoint interval offset (134 seconds)
2019-11-12 16:27:44 (28931): Detected: VirtualBox VboxManage Interface (Version: 5.2.32)
2019-11-12 16:27:45 (28931): VBOX_JOB::parse(): unexpected text enable_screenshots_on_error/
2019-11-12 16:27:45 (28931): Detected: Minimum checkpoint interval (600.000000 seconds)
2019-11-12 16:27:45 (28931): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2019-11-12 16:27:45 (28931): Create VM. (boinc_59fad036ca53233c, slot#13)
2019-11-12 16:27:45 (28931): Setting Memory Size for VM. (1500MB)
2019-11-12 16:27:45 (28931): Setting CPU Count for VM. (1)
2019-11-12 16:27:45 (28931): Setting Chipset Options for VM.
2019-11-12 16:27:45 (28931): Setting Boot Options for VM.
2019-11-12 16:27:45 (28931): Setting Network Configuration for NAT.
2019-11-12 16:27:45 (28931): Enabling VM Network Access.
2019-11-12 16:27:45 (28931): Disabling USB Support for VM.
2019-11-12 16:27:46 (28931): Disabling COM Port Support for VM.
2019-11-12 16:27:46 (28931): Disabling LPT Port Support for VM.
2019-11-12 16:27:46 (28931): Disabling Audio Support for VM.
2019-11-12 16:27:46 (28931): Disabling Clipboard Support for VM.
2019-11-12 16:27:46 (28931): Disabling Drag and Drop Support for VM.
2019-11-12 16:27:46 (28931): Adding storage controller(s) to VM.
2019-11-12 16:27:46 (28931): Adding virtual disk drive to VM. (vm_image.vdi)
2019-11-12 16:27:46 (28931): Adding VirtualBox Guest Additions to VM.
2019-11-12 16:27:46 (28931): Adding network bandwidth throttle group to VM. (Defaulting to 1024GB)
2019-11-12 16:27:46 (28931): forwarding host port 48223 to guest port 80
2019-11-12 16:27:46 (28931): Enabling remote desktop for VM.
2019-11-12 16:27:46 (28931): Enabling shared directory for VM.
2019-11-12 16:27:47 (28931): Starting VM. (boinc_59fad036ca53233c, slot#13)
2019-11-12 16:27:48 (28931): Successfully started VM. (PID = '29447')
2019-11-12 16:27:48 (28931): Reporting VM Process ID to BOINC.
2019-11-12 16:27:48 (28931): Guest Log: BIOS: VirtualBox 5.2.32
2019-11-12 16:27:48 (28931): Guest Log: CPUID EDX: 0x078bfbff
2019-11-12 16:27:48 (28931): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63
2019-11-12 16:27:48 (28931): VM state change detected. (old = 'poweroff', new = 'running')
2019-11-12 16:27:48 (28931): Detected: Web Application Enabled (http://localhost:48223)
2019-11-12 16:27:48 (28931): Detected: Remote Desktop Enabled (localhost:43435)
2019-11-12 16:27:48 (28931): Status Report: Job Duration: '129600.000000'
2019-11-12 16:27:48 (28931): Status Report: Elapsed Time: '38064.713644'
2019-11-12 16:27:48 (28931): Status Report: CPU Time: '36874.890000'
2019-11-12 16:27:48 (28931): Preference change detected
2019-11-12 16:27:48 (28931): Setting CPU throttle for VM. (100%)
2019-11-12 16:27:48 (28931): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2019-11-12 16:27:50 (28931): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2019-11-12 16:27:50 (28931): Guest Log: BIOS: Booting from Hard Disk...
2019-11-12 16:27:54 (28931): Guest Log: BIOS: KBD: unsupported int 16h function 03
2019-11-12 16:27:54 (28931): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 
2019-11-12 16:28:12 (28931): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2019-11-12 16:28:12 (28931): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)
2019-11-12 16:28:37 (28931): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log
2019-11-12 16:28:37 (28931): Guest Log: 00:00:00.000220 main     Log opened 2019-11-12T16:28:36.913255000Z
2019-11-12 16:28:37 (28931): Guest Log: 00:00:00.000432 main     OS Product: Linux
2019-11-12 16:28:37 (28931): Guest Log: 00:00:00.000486 main     OS Release: 4.14.44-11.cernvm.x86_64
2019-11-12 16:28:37 (28931): Guest Log: 00:00:00.000524 main     OS Version: #1 SMP Mon May 28 16:49:00 CEST 2018
2019-11-12 16:28:37 (28931): Guest Log: 00:00:00.000547 main     Executable: /usr/share/vboxguest52/usr/sbin/VBoxService
2019-11-12 16:28:37 (28931): Guest Log: 00:00:00.000548 main     Process ID: 2954
2019-11-12 16:28:37 (28931): Guest Log: 00:00:00.000549 main     Package type: LINUX_64BITS_GENERIC
2019-11-12 16:28:37 (28931): Guest Log: 00:00:00.002330 main     5.2.6 r120293 started. Verbose level = 0
2019-11-12 16:28:58 (28931): Guest Log: [INFO] Mounting the shared directory
2019-11-12 16:28:58 (28931): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor
2019-11-12 16:28:58 (28931): Guest Log: [DEBUG] Testing network connection to cern.ch on port 80
2019-11-12 16:28:58 (28931): Guest Log: [DEBUG] Connection to cern.ch 80 port [tcp/http] succeeded!
2019-11-12 16:28:58 (28931): Guest Log: [DEBUG] 0
2019-11-12 16:28:58 (28931): Guest Log: [DEBUG] Testing VCCS connection to vccs.cern.ch on port 443
2019-11-12 16:28:58 (28931): Guest Log: [DEBUG] Connection to vccs.cern.ch 443 port [tcp/https] succeeded!
2019-11-12 16:28:58 (28931): Guest Log: [DEBUG] 0
2019-11-12 16:28:58 (28931): Guest Log: [DEBUG] Testing connection to Condor server on port 9618
2019-11-12 16:28:58 (28931): Guest Log: [DEBUG] Connection to vccondor01.cern.ch 9618 port [tcp/condor] succeeded!
2019-11-12 16:28:58 (28931): Guest Log: [DEBUG] 0
2019-11-12 16:30:05 (28931): Guest Log: [DEBUG] Probing CVMFS ...
2019-11-12 16:30:05 (28931): Guest Log: Probing /cvmfs/grid.cern.ch... OK
2019-11-12 16:30:05 (28931): 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 16:30:05 (28931): Guest Log: 2.4.4.0 3673 1 25844 10725 3 1 319631 10240000 2 65024 0 3 100 0 0 http://s1cern-cvmfs.openhtc.io/cvmfs/grid.cern.ch DIRECT 1
2019-11-12 16:30:13 (28931): Guest Log: [INFO] Reading volunteer information
2019-11-12 16:30:13 (28931): Guest Log: [INFO] Volunteer: PRHumphrey (21541)
2019-11-12 16:30:13 (28931): Guest Log: [INFO] VMID: e5b01749-9626-457a-8945-16c64690aa2f
2019-11-12 16:30:13 (28931): Guest Log: [INFO] Requesting an X509 credential from LHC@home
2019-11-12 16:30:16 (28931): Guest Log: [INFO] Running the fast benchmark.
2019-11-12 16:31:05 (28931): Guest Log: [INFO] Machine performance 10.62 HEPSPEC06
2019-11-12 16:31:05 (28931): Guest Log: [INFO] Theory application starting. Check log files.
2019-11-12 16:31:05 (28931): Guest Log: [DEBUG] HTCondor ping
2019-11-12 16:31:07 (28931): Guest Log: [DEBUG] 0
2019-11-12 16:32:12 (28931): Guest Log: [INFO] New Job Starting in slot1
2019-11-12 16:32:12 (28931): Guest Log: [INFO] Condor JobID:  514855.21 in slot1
2019-11-12 16:32:17 (28931): Guest Log: [INFO] MCPlots JobID: 52079678 in slot1
2019-11-12 16:32:24 (28931): Guest Log: [INFO] ===> [runRivet] Tue Nov 12 16:32:10 GMT 2019 [boinc ppbar mb-nsd 900 - - pythia6 6.428 363 100000 157]
2019-11-12 16:51:09 (28931): Guest Log: [INFO] Job finished in slot1 with 0.
2019-11-12 16:51:13 (28931): Guest Log: [INFO] New Job Starting in slot1
2019-11-12 16:51:13 (28931): Guest Log: [INFO] Condor JobID:  514855.42 in slot1
2019-11-12 16:51:20 (28931): Guest Log: [INFO] MCPlots JobID: 52079723 in slot1
2019-11-12 16:51:23 (28931): Guest Log: [INFO] ===> [runRivet] Tue Nov 12 16:51:12 GMT 2019 [boinc pp jets 7000 150,-,2160 - pythia6 6.428 default 100000 157]
2019-11-12 17:35:21 (28931): VM state change detected. (old = 'running', new = 'paused')
2019-11-12 18:04:08 (28931): VM state change detected. (old = 'paused', new = 'running')
2019-11-12 18:11:55 (28931): Guest Log: [INFO] Job finished in slot1 with 0.
2019-11-12 18:12:01 (28931): Guest Log: [INFO] New Job Starting in slot1
2019-11-12 18:12:01 (28931): Guest Log: [INFO] Condor JobID:  514701.84 in slot1
2019-11-12 18:12:05 (28931): Guest Log: [INFO] MCPlots JobID: 52055424 in slot1
2019-11-12 18:12:12 (28931): Guest Log: [INFO] ===> [runRivet] Tue Nov 12 18:11:59 GMT 2019 [boinc pp ttbar 7000 - - herwig++ 2.5.2 LHC-UE-EE-3-7000 100000 156]
2019-11-12 18:36:40 (28931): Status Report: Job Duration: '129600.000000'
2019-11-12 18:36:40 (28931): Status Report: Elapsed Time: '44067.817872'
2019-11-12 18:36:40 (28931): Status Report: CPU Time: '42526.780000'
2019-11-12 20:16:19 (28931): Guest Log: [INFO] Job finished in slot1 with 0.
2019-11-12 20:16:27 (28931): Guest Log: [INFO] New Job Starting in slot1
2019-11-12 20:16:27 (28931): Guest Log: [INFO] Condor JobID:  514858.56 in slot1
2019-11-12 20:16:28 (28931): Guest Log: [INFO] MCPlots JobID: 52080114 in slot1
2019-11-12 20:16:33 (28931): Guest Log: [INFO] ===> [runRivet] Tue Nov 12 20:16:23 GMT 2019 [boinc pp jets 8000 180,-,3560 - pythia8 8.235 tune-A2m 100000 157]
2019-11-12 20:16:37 (28931): Status Report: Job Duration: '129600.000000'
2019-11-12 20:16:37 (28931): Status Report: Elapsed Time: '50068.908255'
2019-11-12 20:16:37 (28931): Status Report: CPU Time: '48308.320000'
2019-11-12 21:56:42 (28931): Status Report: Job Duration: '129600.000000'
2019-11-12 21:56:42 (28931): Status Report: Elapsed Time: '56072.310272'
2019-11-12 21:56:42 (28931): Status Report: CPU Time: '54118.910000'
2019-11-12 23:16:41 (28931): VM state change detected. (old = 'running', new = 'paused')
2019-11-12 23:16:59 (28931): VM state change detected. (old = 'paused', new = 'running')
2019-11-12 23:19:23 (28931): VM state change detected. (old = 'running', new = 'paused')
2019-11-12 23:19:42 (28931): VM state change detected. (old = 'paused', new = 'running')
2019-11-12 23:23:26 (28931): VM state change detected. (old = 'running', new = 'paused')
2019-11-12 23:24:25 (28931): VM state change detected. (old = 'paused', new = 'running')
2019-11-12 23:24:57 (28931): VM state change detected. (old = 'running', new = 'paused')
2019-11-12 23:25:16 (28931): VM state change detected. (old = 'paused', new = 'running')
2019-11-12 23:25:38 (28931): VM state change detected. (old = 'running', new = 'paused')
2019-11-12 23:25:56 (28931): VM state change detected. (old = 'paused', new = 'running')
2019-11-12 23:27:09 (28931): VM state change detected. (old = 'running', new = 'paused')
2019-11-12 23:27:29 (28931): VM state change detected. (old = 'paused', new = 'running')
2019-11-12 23:29:11 (28931): VM state change detected. (old = 'running', new = 'paused')
2019-11-12 23:29:49 (28931): VM state change detected. (old = 'paused', new = 'running')
2019-11-12 23:29:51 (28931): VM state change detected. (old = 'running', new = 'paused')
2019-11-12 23:31:02 (28931): VM state change detected. (old = 'paused', new = 'running')
2019-11-12 23:32:03 (28931): VM state change detected. (old = 'running', new = 'paused')
2019-11-12 23:32:25 (28931): VM state change detected. (old = 'paused', new = 'running')
2019-11-12 23:32:25 (28931): VM state change detected. (old = 'running', new = 'paused')
2019-11-12 23:33:01 (28931): VM state change detected. (old = 'paused', new = 'running')
2019-11-12 23:34:16 (28931): VM state change detected. (old = 'running', new = 'paused')
2019-11-12 23:34:55 (28931): VM state change detected. (old = 'paused', new = 'running')
2019-11-12 23:35:27 (28931): VM state change detected. (old = 'running', new = 'paused')
2019-11-12 23:35:44 (28931): VM state change detected. (old = 'paused', new = 'running')
2019-11-12 23:35:57 (28931): VM state change detected. (old = 'running', new = 'paused')
2019-11-12 23:36:38 (28931): VM state change detected. (old = 'paused', new = 'running')
2019-11-12 23:36:38 (28931): VM state change detected. (old = 'running', new = 'paused')
2019-11-12 23:37:06 (28931): VM state change detected. (old = 'paused', new = 'running')
2019-11-12 23:37:39 (28931): VM state change detected. (old = 'running', new = 'paused')
2019-11-12 23:37:57 (28931): VM state change detected. (old = 'paused', new = 'running')
2019-11-12 23:38:10 (28931): VM state change detected. (old = 'running', new = 'paused')
2019-11-12 23:38:56 (28931): VM state change detected. (old = 'paused', new = 'running')
2019-11-12 23:39:30 (28931): VM state change detected. (old = 'running', new = 'paused')
2019-11-12 23:39:48 (28931): VM state change detected. (old = 'paused', new = 'running')
2019-11-12 23:40:00 (28931): VM state change detected. (old = 'running', new = 'paused')
2019-11-12 23:40:18 (28931): VM state change detected. (old = 'paused', new = 'running')
2019-11-12 23:40:21 (28931): VM state change detected. (old = 'running', new = 'paused')
2019-11-12 23:40:39 (28931): VM state change detected. (old = 'paused', new = 'running')
2019-11-12 23:40:41 (28931): VM state change detected. (old = 'running', new = 'paused')
2019-11-12 23:41:01 (28931): VM state change detected. (old = 'paused', new = 'running')
2019-11-12 23:41:01 (28931): VM state change detected. (old = 'running', new = 'paused')
2019-11-12 23:41:49 (28931): VM state change detected. (old = 'paused', new = 'running')
2019-11-12 23:41:53 (28931): VM state change detected. (old = 'running', new = 'paused')
2019-11-12 23:43:36 (28931): VM state change detected. (old = 'paused', new = 'running')
2019-11-12 23:43:52 (28931): VM state change detected. (old = 'running', new = 'paused')
2019-11-12 23:44:29 (28931): VM state change detected. (old = 'paused', new = 'running')
2019-11-12 23:44:30 (28931): VM state change detected. (old = 'running', new = 'paused')
2019-11-12 23:45:08 (28931): VM state change detected. (old = 'paused', new = 'running')
2019-11-12 23:45:20 (28931): VM state change detected. (old = 'running', new = 'paused')
2019-11-12 23:45:37 (28931): VM state change detected. (old = 'paused', new = 'running')
2019-11-12 23:45:40 (28931): VM state change detected. (old = 'running', new = 'paused')
2019-11-12 23:45:59 (28931): VM state change detected. (old = 'paused', new = 'running')
2019-11-12 23:46:00 (28931): VM state change detected. (old = 'running', new = 'paused')
2019-11-12 23:48:40 (28931): VM state change detected. (old = 'paused', new = 'running')
2019-11-12 23:49:13 (28931): VM state change detected. (old = 'running', new = 'paused')
2019-11-12 23:50:03 (28931): VM state change detected. (old = 'paused', new = 'running')
2019-11-12 23:50:04 (28931): VM state change detected. (old = 'running', new = 'paused')
2019-11-12 23:50:22 (28931): VM state change detected. (old = 'paused', new = 'running')
2019-11-12 23:50:24 (28931): VM state change detected. (old = 'running', new = 'paused')
2019-11-12 23:59:49 (28931): VM state change detected. (old = 'paused', new = 'running')
2019-11-13 00:00:12 (28931): VM state change detected. (old = 'running', new = 'paused')
2019-11-13 00:00:29 (28931): VM state change detected. (old = 'paused', new = 'running')
2019-11-13 00:01:43 (28931): VM state change detected. (old = 'running', new = 'paused')
2019-11-13 00:02:01 (28931): VM state change detected. (old = 'paused', new = 'running')
2019-11-13 00:02:13 (28931): VM state change detected. (old = 'running', new = 'paused')
2019-11-13 00:02:42 (28931): VM state change detected. (old = 'paused', new = 'running')
2019-11-13 00:02:44 (28931): VM state change detected. (old = 'running', new = 'paused')
2019-11-13 00:03:33 (28931): VM state change detected. (old = 'paused', new = 'running')
2019-11-13 00:03:45 (28931): VM state change detected. (old = 'running', new = 'paused')
2019-11-13 00:04:14 (28931): VM state change detected. (old = 'paused', new = 'running')
2019-11-13 00:04:15 (28931): VM state change detected. (old = 'running', new = 'paused')
2019-11-13 00:08:50 (28931): VM state change detected. (old = 'paused', new = 'running')
2019-11-13 00:09:02 (28931): VM state change detected. (old = 'running', new = 'paused')
2019-11-13 00:09:21 (28931): VM state change detected. (old = 'paused', new = 'running')
2019-11-13 00:09:42 (28931): VM state change detected. (old = 'running', new = 'paused')
2019-11-13 00:10:12 (28931): VM state change detected. (old = 'paused', new = 'running')
2019-11-13 00:10:13 (28931): VM state change detected. (old = 'running', new = 'paused')
2019-11-13 00:11:53 (28931): VM state change detected. (old = 'paused', new = 'running')
2019-11-13 00:11:55 (28931): VM state change detected. (old = 'running', new = 'paused')
2019-11-13 00:12:15 (28931): VM state change detected. (old = 'paused', new = 'running')
2019-11-13 00:12:25 (28931): Status Report: Job Duration: '129600.000000'
2019-11-13 00:12:25 (28931): Status Report: Elapsed Time: '62073.061453'
2019-11-13 00:12:25 (28931): Status Report: CPU Time: '59952.090000'
2019-11-13 00:13:26 (28931): VM state change detected. (old = 'running', new = 'paused')
2019-11-13 00:18:07 (28931): VM state change detected. (old = 'paused', new = 'running')
2019-11-13 00:20:41 (28931): VM state change detected. (old = 'running', new = 'paused')
2019-11-13 00:22:14 (28931): VM state change detected. (old = 'paused', new = 'running')
2019-11-13 00:22:35 (28931): VM state change detected. (old = 'running', new = 'paused')
2019-11-13 00:24:26 (28931): VM state change detected. (old = 'paused', new = 'running')
2019-11-13 01:59:29 (28931): Status Report: Job Duration: '129600.000000'
2019-11-13 01:59:29 (28931): Status Report: Elapsed Time: '68073.557541'
2019-11-13 01:59:29 (28931): Status Report: CPU Time: '65852.970000'
2019-11-13 03:09:11 (28931): Guest Log: [INFO] Job finished in slot1 with 0.
2019-11-13 03:09:14 (28931): Guest Log: [INFO] New Job Starting in slot1
2019-11-13 03:09:14 (28931): Guest Log: [INFO] Condor JobID:  514864.62 in slot1
2019-11-13 03:09:19 (28931): Guest Log: [INFO] MCPlots JobID: 52081022 in slot1
2019-11-13 03:09:24 (28931): Guest Log: [INFO] ===> [runRivet] Wed Nov 13 02:52:08 GMT 2019 [boinc pp jets 7000 80,-,1360 - pythia6 6.428 361 100000 157]
2019-11-13 03:38:33 (28931): Status Report: Job Duration: '129600.000000'
2019-11-13 03:38:33 (28931): Status Report: Elapsed Time: '74074.510224'
2019-11-13 03:38:33 (28931): Status Report: CPU Time: '71771.050000'
2019-11-13 04:06:30 (28931): VM state change detected. (old = 'running', new = 'paused')
2019-11-13 04:20:17 (28931): VM state change detected. (old = 'paused', new = 'running')
2019-11-13 04:20:36 (28931): Guest Log: 10:26:24.712646 timesync vgsvcTimeSyncWorker: Radical guest time change: 1 863 450 669 000ns (GuestNow=1 573 618 835 721 019 000 ns GuestLast=1 573 616 972 270 350 000 ns fSetTimeLastLoop=true )
2019-11-13 04:35:27 (28931): Guest Log: [INFO] Job finished in slot1 with 0.
2019-11-13 04:45:29 (28931): Guest Log: [INFO] Condor exited with return value N/A.
2019-11-13 04:45:29 (28931): Guest Log: [INFO] Shutting Down.
2019-11-13 04:45:29 (28931): VM Completion File Detected.
2019-11-13 04:45:29 (28931): VM Completion Message: Condor exited with return value N/A.
.
2019-11-13 04:45:29 (28931): Powering off VM.
2019-11-13 04:45:29 (28931): Successfully stopped VM.
2019-11-13 04:45:29 (28931): Deregistering VM. (boinc_59fad036ca53233c, slot#13)
2019-11-13 04:45:29 (28931): Removing network bandwidth throttle group from VM.
2019-11-13 04:45:30 (28931): Removing storage controller(s) from VM.
2019-11-13 04:45:30 (28931): Removing VM from VirtualBox.
2019-11-13 04:45:30 (28931): Removing virtual disk drive from VirtualBox.
04:45:35 (28931): called boinc_finish(0)

</stderr_txt>
]]>