Stderr output

<core_client_version>7.14.2</core_client_version>
<![CDATA[
<stderr_txt>
2020-01-14 11:38:25 (2368): Detected: vboxwrapper 26197
2020-01-14 11:38:25 (2368): Detected: BOINC client v7.7
2020-01-14 11:38:27 (2368): Detected: VirtualBox VboxManage Interface (Version: 5.2.28)
2020-01-14 11:38:27 (2368): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2020-01-14 11:38:27 (2368): Successfully copied 'init_data.xml' to the shared directory.
2020-01-14 11:38:30 (2368): Create VM. (boinc_1e1f672efea05e48, slot#3)
2020-01-14 11:38:33 (2368): Setting Memory Size for VM. (1896MB)
2020-01-14 11:38:34 (2368): Setting CPU Count for VM. (1)
2020-01-14 11:38:35 (2368): Setting Chipset Options for VM.
2020-01-14 11:38:37 (2368): Setting Boot Options for VM.
2020-01-14 11:38:38 (2368): Setting Network Configuration for NAT.
2020-01-14 11:38:38 (2368): Enabling VM Network Access.
2020-01-14 11:38:39 (2368): Disabling USB Support for VM.
2020-01-14 11:38:40 (2368): Disabling COM Port Support for VM.
2020-01-14 11:38:40 (2368): Disabling LPT Port Support for VM.
2020-01-14 11:38:41 (2368): Disabling Audio Support for VM.
2020-01-14 11:38:42 (2368): Disabling Clipboard Support for VM.
2020-01-14 11:38:42 (2368): Disabling Drag and Drop Support for VM.
2020-01-14 11:38:43 (2368): Adding storage controller(s) to VM.
2020-01-14 11:38:44 (2368): Adding virtual disk drive to VM. (vm_image.vdi)
2020-01-14 11:38:44 (2368): Adding VirtualBox Guest Additions to VM.
2020-01-14 11:38:45 (2368): Adding network bandwidth throttle group to VM. (Defaulting to 1024GB)
2020-01-14 11:38:46 (2368): forwarding host port 52386 to guest port 80
2020-01-14 11:38:47 (2368): Enabling remote desktop for VM.
2020-01-14 11:38:48 (2368): Enabling shared directory for VM.
2020-01-14 11:38:49 (2368): Starting VM using VBoxManage interface. (boinc_1e1f672efea05e48, slot#3)
2020-01-14 11:39:07 (2368): Successfully started VM. (PID = '9852')
2020-01-14 11:39:07 (2368): Reporting VM Process ID to BOINC.
2020-01-14 11:39:07 (2368): Guest Log: BIOS: VirtualBox 5.2.28

2020-01-14 11:39:07 (2368): Guest Log: CPUID EDX: 0x078bfbff

2020-01-14 11:39:07 (2368): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63

2020-01-14 11:39:07 (2368): VM state change detected. (old = 'PoweredOff', new = 'Running')
2020-01-14 11:39:07 (2368): Detected: Web Application Enabled (http://localhost:52386)
2020-01-14 11:39:07 (2368): Detected: Remote Desktop Enabled (localhost:52387)
2020-01-14 11:39:07 (2368): Preference change detected
2020-01-14 11:39:07 (2368): Setting CPU throttle for VM. (100%)
2020-01-14 11:39:08 (2368): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 100 seconds) or (Vbox_job.xml: 600 seconds))
2020-01-14 11:39:09 (2368): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032

2020-01-14 11:39:09 (2368): Guest Log: BIOS: Booting from Hard Disk...

2020-01-14 11:39:12 (2368): Guest Log: BIOS: KBD: unsupported int 16h function 03

2020-01-14 11:39:12 (2368): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 

2020-01-14 11:40:06 (2368): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds

2020-01-14 11:40:06 (2368): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)

2020-01-14 11:40:46 (2368): Stopping VM.
2020-01-14 16:50:00 (1976): Detected: vboxwrapper 26197
2020-01-14 16:50:00 (1976): Detected: BOINC client v7.7
2020-01-14 16:50:01 (1976): Detected: VirtualBox VboxManage Interface (Version: 5.2.28)
2020-01-14 16:50:01 (1976): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2020-01-14 16:50:02 (1976): Starting VM using VBoxManage interface. (boinc_1e1f672efea05e48, slot#3)
2020-01-14 16:50:29 (1976): Successfully started VM. (PID = '9384')
2020-01-14 16:50:29 (1976): Reporting VM Process ID to BOINC.
2020-01-14 16:50:29 (1976): VM state change detected. (old = 'PoweredOff', new = 'Running')
2020-01-14 16:50:29 (1976): Detected: Web Application Enabled (http://localhost:52386)
2020-01-14 16:50:29 (1976): Detected: Remote Desktop Enabled (localhost:52387)
2020-01-14 16:50:29 (1976): Preference change detected
2020-01-14 16:50:29 (1976): Setting CPU throttle for VM. (100%)
2020-01-14 16:50:30 (1976): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 100 seconds) or (Vbox_job.xml: 600 seconds))
2020-01-14 16:51:16 (1976): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log

2020-01-14 16:51:16 (1976): Guest Log: 00:00:00.001147 main     Log opened 2020-01-15T00:51:14.451299000Z

2020-01-14 16:51:16 (1976): Guest Log: 00:00:00.002948 main     OS Product: Linux

2020-01-14 16:51:16 (1976): Guest Log: 00:00:00.005866 main     OS Release: 4.14.44-11.cernvm.x86_64

2020-01-14 16:51:16 (1976): Guest Log: 00:00:00.006430 main     OS Version: #1 SMP Mon May 28 16:49:00 CEST 2018

2020-01-14 16:51:16 (1976): Guest Log: 00:00:00.006980 main     Executable: /usr/share/vboxguest52/usr/sbin/VBoxService

2020-01-14 16:51:16 (1976): Guest Log: 00:00:00.006988 main     Process ID: 2960

2020-01-14 16:51:16 (1976): Guest Log: 00:00:00.006991 main     Package type: LINUX_64BITS_GENERIC

2020-01-14 16:51:16 (1976): Guest Log: 00:00:00.016721 main     5.2.6 r120293 started. Verbose level = 0

2020-01-14 16:53:19 (1976): Guest Log: [INFO] Mounting the shared directory

2020-01-14 16:53:19 (1976): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor

2020-01-14 16:53:20 (1976): Guest Log: [DEBUG] Testing network connection to cern.ch on port 80

2020-01-14 16:53:20 (1976): Guest Log: [DEBUG] Connection to cern.ch 80 port [tcp/http] succeeded!

2020-01-14 16:53:20 (1976): Guest Log: [DEBUG] 0

2020-01-14 16:53:21 (1976): Guest Log: [DEBUG] Testing VCCS connection to vccs.cern.ch on port 443

2020-01-14 16:53:21 (1976): Guest Log: [DEBUG] Connection to vccs.cern.ch 443 port [tcp/https] succeeded!

2020-01-14 16:53:21 (1976): Guest Log: [DEBUG] 0

2020-01-14 16:53:21 (1976): Guest Log: [DEBUG] Testing connection to Condor server on port 9618

2020-01-14 16:53:23 (1976): Guest Log: [DEBUG] Connection to vocms0840.cern.ch 9618 port [tcp/condor] succeeded!

2020-01-14 16:53:23 (1976): Guest Log: [DEBUG] 0

2020-01-14 16:54:51 (1976): Guest Log: [DEBUG] Probing CVMFS ...

2020-01-14 16:54:55 (1976): Guest Log: Probing /cvmfs/grid.cern.ch... OK

2020-01-14 16:54:59 (1976): 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

2020-01-14 16:54:59 (1976): Guest Log: 2.4.4.0 3701 1 25832 11235 3 1 1460701 10240001 2 65024 0 3 100 0 0 http://s1unl-cvmfs.openhtc.io/cvmfs/grid.cern.ch DIRECT 1

2020-01-14 17:01:09 (1976): Guest Log: [INFO] Reading volunteer information

2020-01-14 17:01:10 (1976): Guest Log: [INFO] Volunteer: Magic Quantum Mechanic (192)

2020-01-14 17:01:10 (1976): Guest Log: [INFO] VMID: c5ab4400-4ef6-44a9-aaed-bee78432355d

2020-01-14 17:01:11 (1976): Guest Log: [INFO] Requesting an X509 credential from LHC@home

2020-01-14 17:01:16 (1976): Guest Log: [INFO] Requesting an X509 credential from vLHC@home-dev

2020-01-14 17:01:22 (1976): Guest Log: [INFO] Running the fast benchmark.

2020-01-14 17:09:03 (1976): Guest Log: [INFO] Machine performance 1.15 HEPSPEC06

2020-01-14 17:09:03 (1976): Guest Log: [INFO] CMS application starting. Check log files.

2020-01-14 17:09:14 (1976): Guest Log: [DEBUG] HTCondor ping

2020-01-14 17:09:31 (1976): Guest Log: [DEBUG] 0

2020-01-14 18:31:17 (1976): Status Report: Job Duration: '64800.000000'
2020-01-14 18:31:17 (1976): Status Report: Elapsed Time: '6000.472200'
2020-01-14 18:31:17 (1976): Status Report: CPU Time: '2017.578125'
2020-01-14 20:12:50 (1976): Status Report: Job Duration: '64800.000000'
2020-01-14 20:12:50 (1976): Status Report: Elapsed Time: '12001.176516'
2020-01-14 20:12:50 (1976): Status Report: CPU Time: '4388.484375'
2020-01-14 21:45:32 (1976): Stopping VM.
2020-01-14 21:46:04 (1976): Error in stop VM for VM: -108
Command:
VBoxManage -q controlvm "boinc_1e1f672efea05e48" savestate
Output:
0%...10%...20%...30%...40%...50%...
2020-01-14 21:46:04 (1976): VM did not stop when requested.
2020-01-14 21:46:04 (1976): VM was NOT successfully terminated.
2020-01-14 21:54:03 (7068): Detected: vboxwrapper 26197
2020-01-14 21:54:03 (7068): Detected: BOINC client v7.7
2020-01-14 21:54:07 (7068): Detected: VirtualBox VboxManage Interface (Version: 5.2.28)
2020-01-14 21:54:08 (7068): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2020-01-14 21:54:09 (7068): Starting VM using VBoxManage interface. (boinc_1e1f672efea05e48, slot#3)
2020-01-14 21:54:27 (7068): Successfully started VM. (PID = '8240')
2020-01-14 21:54:27 (7068): Reporting VM Process ID to BOINC.
2020-01-14 21:54:27 (7068): Guest Log: BIOS: VirtualBox 5.2.28

2020-01-14 21:54:27 (7068): Guest Log: CPUID EDX: 0x078bfbff

2020-01-14 21:54:27 (7068): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63

2020-01-14 21:54:27 (7068): VM state change detected. (old = 'PoweredOff', new = 'Running')
2020-01-14 21:54:27 (7068): Detected: Web Application Enabled (http://localhost:52386)
2020-01-14 21:54:27 (7068): Detected: Remote Desktop Enabled (localhost:52387)
2020-01-14 21:54:27 (7068): Status Report: Job Duration: '64800.000000'
2020-01-14 21:54:27 (7068): Status Report: Elapsed Time: '17459.432497'
2020-01-14 21:54:27 (7068): Status Report: CPU Time: '9686.546875'
2020-01-14 21:54:27 (7068): Preference change detected
2020-01-14 21:54:27 (7068): Setting CPU throttle for VM. (100%)
2020-01-14 21:54:28 (7068): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 100 seconds) or (Vbox_job.xml: 600 seconds))
2020-01-14 21:54:29 (7068): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032

2020-01-14 21:54:29 (7068): Guest Log: BIOS: Booting from Hard Disk...

2020-01-14 21:54:33 (7068): Guest Log: BIOS: KBD: unsupported int 16h function 03

2020-01-14 21:54:33 (7068): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 

2020-01-14 21:55:43 (7068): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds

2020-01-14 21:55:43 (7068): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)

2020-01-14 21:56:54 (7068): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log

2020-01-14 21:56:54 (7068): Guest Log: 00:00:00.001148 main     Log opened 2020-01-15T05:56:52.219315000Z

2020-01-14 21:56:54 (7068): Guest Log: 00:00:00.005454 main     OS Product: Linux

2020-01-14 21:56:54 (7068): Guest Log: 00:00:00.005778 main     OS Release: 4.14.44-11.cernvm.x86_64

2020-01-14 21:56:54 (7068): Guest Log: 00:00:00.006442 main     OS Version: #1 SMP Mon May 28 16:49:00 CEST 2018

2020-01-14 21:56:54 (7068): Guest Log: 00:00:00.006736 main     Executable: /usr/share/vboxguest52/usr/sbin/VBoxService

2020-01-14 21:56:54 (7068): Guest Log: 00:00:00.006742 main     Process ID: 2903

2020-01-14 21:56:54 (7068): Guest Log: 00:00:00.006746 main     Package type: LINUX_64BITS_GENERIC

2020-01-14 21:56:54 (7068): Guest Log: 00:00:00.014355 main     5.2.6 r120293 started. Verbose level = 0

2020-01-14 21:58:24 (7068): Guest Log: [INFO] Mounting the shared directory

2020-01-14 21:58:24 (7068): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor

2020-01-14 21:58:25 (7068): Guest Log: [DEBUG] Testing network connection to cern.ch on port 80

2020-01-14 21:58:25 (7068): Guest Log: [DEBUG] Connection to cern.ch 80 port [tcp/http] succeeded!

2020-01-14 21:58:25 (7068): Guest Log: [DEBUG] 0

2020-01-14 21:58:25 (7068): Guest Log: [DEBUG] Testing VCCS connection to vccs.cern.ch on port 443

2020-01-14 21:58:26 (7068): Guest Log: [DEBUG] Connection to vccs.cern.ch 443 port [tcp/https] succeeded!

2020-01-14 21:58:26 (7068): Guest Log: [DEBUG] 0

2020-01-14 21:58:26 (7068): Guest Log: [DEBUG] Testing connection to Condor server on port 9618

2020-01-14 21:58:28 (7068): Guest Log: [DEBUG] Connection to vocms0840.cern.ch 9618 port [tcp/condor] succeeded!

2020-01-14 21:58:28 (7068): Guest Log: [DEBUG] 0

2020-01-14 21:59:53 (7068): Guest Log: [DEBUG] Probing CVMFS ...

2020-01-14 21:59:56 (7068): Guest Log: Probing /cvmfs/grid.cern.ch... OK

2020-01-14 22:00:01 (7068): 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

2020-01-14 22:00:01 (7068): Guest Log: 2.4.4.0 3624 1 25340 11237 3 1 2449082 10240001 2 65024 0 3 100 0 0 http://s1bnl-cvmfs.openhtc.io/cvmfs/grid.cern.ch DIRECT 1

2020-01-14 22:00:26 (7068): Guest Log: [INFO] Reading volunteer information

2020-01-14 22:00:26 (7068): Guest Log: [INFO] Volunteer: Magic Quantum Mechanic (192)

2020-01-14 22:00:27 (7068): Guest Log: [INFO] VMID: c5ab4400-4ef6-44a9-aaed-bee78432355d

2020-01-14 22:00:28 (7068): Guest Log: [INFO] Requesting an X509 credential from LHC@home

2020-01-14 22:00:32 (7068): Guest Log: [INFO] Requesting an X509 credential from vLHC@home-dev

2020-01-14 22:00:38 (7068): Guest Log: [INFO] Running the fast benchmark.

2020-01-14 22:08:10 (7068): Guest Log: [INFO] Machine performance 1.18 HEPSPEC06

2020-01-14 22:08:10 (7068): Guest Log: [INFO] CMS application starting. Check log files.

2020-01-14 22:08:17 (7068): Guest Log: [DEBUG] HTCondor ping

2020-01-14 22:08:41 (7068): Guest Log: [DEBUG] 0

2020-01-14 23:38:04 (7068): Status Report: Job Duration: '64800.000000'
2020-01-14 23:38:04 (7068): Status Report: Elapsed Time: '23460.371511'
2020-01-14 23:38:04 (7068): Status Report: CPU Time: '12270.109375'
2020-01-15 00:34:13 (7068): Stopping VM.
2020-01-15 00:35:08 (7068): Error in stop VM for VM: -182
Command:
VBoxManage -q controlvm "boinc_1e1f672efea05e48" savestate
Output:
0%...10%...20%...30%...40%...50%...60%...70%...
2020-01-15 00:35:08 (7068): VM did not stop when requested.
2020-01-15 00:35:08 (7068): VM was successfully terminated.
2020-01-15 00:35:11 (1064): Detected: vboxwrapper 26197
2020-01-15 00:35:11 (1064): Detected: BOINC client v7.7
2020-01-15 00:35:13 (1064): Detected: VirtualBox VboxManage Interface (Version: 5.2.28)
2020-01-15 00:35:15 (1064): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2020-01-15 00:35:17 (1064): Starting VM using VBoxManage interface. (boinc_1e1f672efea05e48, slot#3)
2020-01-15 00:35:48 (1064): Successfully started VM. (PID = '7668')
2020-01-15 00:35:48 (1064): Reporting VM Process ID to BOINC.
2020-01-15 00:35:49 (1064): Guest Log: BIOS: VirtualBox 5.2.28

2020-01-15 00:35:49 (1064): Guest Log: CPUID EDX: 0x078bfbff

2020-01-15 00:35:49 (1064): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63

2020-01-15 00:35:49 (1064): VM state change detected. (old = 'PoweredOff', new = 'Running')
2020-01-15 00:35:49 (1064): Detected: Web Application Enabled (http://localhost:52386)
2020-01-15 00:35:49 (1064): Detected: Remote Desktop Enabled (localhost:52387)
2020-01-15 00:35:49 (1064): Status Report: Job Duration: '64800.000000'
2020-01-15 00:35:49 (1064): Status Report: Elapsed Time: '26571.171350'
2020-01-15 00:35:49 (1064): Status Report: CPU Time: '14534.859375'
2020-01-15 00:35:49 (1064): Preference change detected
2020-01-15 00:35:49 (1064): Setting CPU throttle for VM. (100%)
2020-01-15 00:35:50 (1064): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 100 seconds) or (Vbox_job.xml: 600 seconds))
2020-01-15 00:35:50 (1064): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032

2020-01-15 00:35:50 (1064): Guest Log: BIOS: Booting from Hard Disk...

2020-01-15 00:35:54 (1064): Guest Log: BIOS: KBD: unsupported int 16h function 03

2020-01-15 00:35:54 (1064): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 

2020-01-15 00:37:00 (1064): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds

2020-01-15 00:37:00 (1064): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)

2020-01-15 00:38:37 (1064): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log

2020-01-15 00:38:37 (1064): Guest Log: 00:00:00.001064 main     Log opened 2020-01-15T08:38:35.413858000Z

2020-01-15 00:38:37 (1064): Guest Log: 00:00:00.002492 main     OS Product: Linux

2020-01-15 00:38:37 (1064): Guest Log: 00:00:00.003082 main     OS Release: 4.14.44-11.cernvm.x86_64

2020-01-15 00:38:37 (1064): Guest Log: 00:00:00.003660 main     OS Version: #1 SMP Mon May 28 16:49:00 CEST 2018

2020-01-15 00:38:37 (1064): Guest Log: 00:00:00.003868 main     Executable: /usr/share/vboxguest52/usr/sbin/VBoxService

2020-01-15 00:38:37 (1064): Guest Log: 00:00:00.003874 main     Process ID: 2907

2020-01-15 00:38:37 (1064): Guest Log: 00:00:00.003878 main     Package type: LINUX_64BITS_GENERIC

2020-01-15 00:38:37 (1064): Guest Log: 00:00:00.010692 main     5.2.6 r120293 started. Verbose level = 0

2020-01-15 00:41:36 (1064): Guest Log: [INFO] Mounting the shared directory

2020-01-15 00:41:36 (1064): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor

2020-01-15 00:41:38 (1064): Guest Log: [DEBUG] Testing network connection to cern.ch on port 80

2020-01-15 00:41:38 (1064): Guest Log: [DEBUG] Connection to cern.ch 80 port [tcp/http] succeeded!

2020-01-15 00:41:38 (1064): Guest Log: [DEBUG] 0

2020-01-15 00:41:38 (1064): Guest Log: [DEBUG] Testing VCCS connection to vccs.cern.ch on port 443

2020-01-15 00:41:39 (1064): Guest Log: [DEBUG] Connection to vccs.cern.ch 443 port [tcp/https] succeeded!

2020-01-15 00:41:39 (1064): Guest Log: [DEBUG] 0

2020-01-15 00:41:39 (1064): Guest Log: [DEBUG] Testing connection to Condor server on port 9618

2020-01-15 00:41:43 (1064): Guest Log: [DEBUG] Connection to vocms0840.cern.ch 9618 port [tcp/condor] succeeded!

2020-01-15 00:41:43 (1064): Guest Log: [DEBUG] 0

2020-01-15 00:43:09 (1064): Guest Log: [DEBUG] Probing CVMFS ...

2020-01-15 00:43:14 (1064): Guest Log: Probing /cvmfs/grid.cern.ch... OK

2020-01-15 00:43:21 (1064): 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

2020-01-15 00:43:21 (1064): Guest Log: 2.4.4.0 3634 2 27876 11239 3 1 2476354 10240000 2 65024 0 3 100 0 0 http://s1unl-cvmfs.openhtc.io/cvmfs/grid.cern.ch DIRECT 1

2020-01-15 00:43:53 (1064): Guest Log: [INFO] Reading volunteer information

2020-01-15 00:43:55 (1064): Guest Log: [INFO] Volunteer: Magic Quantum Mechanic (192)

2020-01-15 00:43:55 (1064): Guest Log: [INFO] VMID: c5ab4400-4ef6-44a9-aaed-bee78432355d

2020-01-15 00:43:57 (1064): Guest Log: [INFO] Requesting an X509 credential from LHC@home

2020-01-15 00:44:05 (1064): Guest Log: [INFO] Requesting an X509 credential from vLHC@home-dev

2020-01-15 00:44:42 (1064): Guest Log: [INFO] Running the fast benchmark.

2020-01-15 00:55:27 (1064): Guest Log: [INFO] Machine performance 0.92 HEPSPEC06

2020-01-15 00:55:27 (1064): Guest Log: [INFO] CMS application starting. Check log files.

2020-01-15 00:55:34 (1064): Guest Log: [DEBUG] HTCondor ping

2020-01-15 00:55:51 (1064): Guest Log: [DEBUG] 0

2020-01-15 02:21:14 (1064): Status Report: Job Duration: '64800.000000'
2020-01-15 02:21:14 (1064): Status Report: Elapsed Time: '32572.164363'
2020-01-15 02:21:14 (1064): Status Report: CPU Time: '18817.593750'
2020-01-15 03:47:03 (1064): Stopping VM.
2020-01-15 03:47:52 (1064): Error in stop VM for VM: -182
Command:
VBoxManage -q controlvm "boinc_1e1f672efea05e48" savestate
Output:
0%...10%...20%...30%...40%...50%...60%...70%...
2020-01-15 03:47:52 (1064): VM did not stop when requested.
2020-01-15 03:47:52 (1064): VM was successfully terminated.
2020-01-15 03:59:48 (8820): Detected: vboxwrapper 26197
2020-01-15 03:59:48 (8820): Detected: BOINC client v7.7
2020-01-15 03:59:53 (8820): Detected: VirtualBox VboxManage Interface (Version: 5.2.28)
2020-01-15 03:59:54 (8820): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2020-01-15 03:59:56 (8820): Starting VM using VBoxManage interface. (boinc_1e1f672efea05e48, slot#3)
2020-01-15 04:00:18 (8820): Successfully started VM. (PID = '7008')
2020-01-15 04:00:18 (8820): Reporting VM Process ID to BOINC.
2020-01-15 04:00:18 (8820): Guest Log: BIOS: VirtualBox 5.2.28

2020-01-15 04:00:18 (8820): Guest Log: CPUID EDX: 0x078bfbff

2020-01-15 04:00:18 (8820): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63

2020-01-15 04:00:18 (8820): VM state change detected. (old = 'PoweredOff', new = 'Running')
2020-01-15 04:00:18 (8820): Detected: Web Application Enabled (http://localhost:52386)
2020-01-15 04:00:18 (8820): Detected: Remote Desktop Enabled (localhost:52387)
2020-01-15 04:00:18 (8820): Status Report: Job Duration: '64800.000000'
2020-01-15 04:00:18 (8820): Status Report: Elapsed Time: '37066.970586'
2020-01-15 04:00:18 (8820): Status Report: CPU Time: '23337.281250'
2020-01-15 04:00:18 (8820): Preference change detected
2020-01-15 04:00:18 (8820): Setting CPU throttle for VM. (100%)
2020-01-15 04:00:21 (8820): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 100 seconds) or (Vbox_job.xml: 600 seconds))
2020-01-15 04:00:21 (8820): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032

2020-01-15 04:00:21 (8820): Guest Log: BIOS: Booting from Hard Disk...

2020-01-15 04:00:24 (8820): Guest Log: BIOS: KBD: unsupported int 16h function 03

2020-01-15 04:00:24 (8820): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 

2020-01-15 04:01:23 (8820): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds

2020-01-15 04:01:27 (8820): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)

2020-01-15 04:02:40 (8820): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log

2020-01-15 04:02:40 (8820): Guest Log: 00:00:00.002196 main     Log opened 2020-01-15T12:02:38.290272000Z

2020-01-15 04:02:40 (8820): Guest Log: 00:00:00.004331 main     OS Product: Linux

2020-01-15 04:02:40 (8820): Guest Log: 00:00:00.004939 main     OS Release: 4.14.44-11.cernvm.x86_64

2020-01-15 04:02:40 (8820): Guest Log: 00:00:00.005241 main     OS Version: #1 SMP Mon May 28 16:49:00 CEST 2018

2020-01-15 04:02:40 (8820): Guest Log: 00:00:00.005845 main     Executable: /usr/share/vboxguest52/usr/sbin/VBoxService

2020-01-15 04:02:40 (8820): Guest Log: 00:00:00.005853 main     Process ID: 2906

2020-01-15 04:02:40 (8820): Guest Log: 00:00:00.005858 main     Package type: LINUX_64BITS_GENERIC

2020-01-15 04:02:40 (8820): Guest Log: 00:00:00.013830 main     5.2.6 r120293 started. Verbose level = 0

2020-01-15 04:04:32 (8820): Guest Log: [INFO] Mounting the shared directory

2020-01-15 04:04:32 (8820): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor

2020-01-15 04:04:33 (8820): Guest Log: [DEBUG] Testing network connection to cern.ch on port 80

2020-01-15 04:04:33 (8820): Guest Log: [DEBUG] Connection to cern.ch 80 port [tcp/http] succeeded!

2020-01-15 04:04:34 (8820): Guest Log: [DEBUG] 0

2020-01-15 04:04:34 (8820): Guest Log: [DEBUG] Testing VCCS connection to vccs.cern.ch on port 443

2020-01-15 04:04:34 (8820): Guest Log: [DEBUG] Connection to vccs.cern.ch 443 port [tcp/https] succeeded!

2020-01-15 04:04:34 (8820): Guest Log: [DEBUG] 0

2020-01-15 04:04:35 (8820): Guest Log: [DEBUG] Testing connection to Condor server on port 9618

2020-01-15 04:04:36 (8820): Guest Log: [DEBUG] Connection to vocms0840.cern.ch 9618 port [tcp/condor] succeeded!

2020-01-15 04:04:36 (8820): Guest Log: [DEBUG] 0

2020-01-15 04:05:57 (8820): Guest Log: [DEBUG] Probing CVMFS ...

2020-01-15 04:06:02 (8820): Guest Log: Probing /cvmfs/grid.cern.ch... OK

2020-01-15 04:06:06 (8820): 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

2020-01-15 04:06:06 (8820): Guest Log: 2.4.4.0 3627 1 25540 11239 3 1 2486090 10240000 2 65024 0 3 100 0 0 http://s1unl-cvmfs.openhtc.io/cvmfs/grid.cern.ch DIRECT 1

2020-01-15 04:06:14 (8820): Guest Log: [INFO] Reading volunteer information

2020-01-15 04:06:16 (8820): Guest Log: [INFO] Volunteer: Magic Quantum Mechanic (192)

2020-01-15 04:06:16 (8820): Guest Log: [INFO] VMID: c5ab4400-4ef6-44a9-aaed-bee78432355d

2020-01-15 04:06:18 (8820): Guest Log: [INFO] Requesting an X509 credential from LHC@home

2020-01-15 04:06:22 (8820): Guest Log: [INFO] Requesting an X509 credential from vLHC@home-dev

2020-01-15 04:06:29 (8820): Guest Log: [INFO] Running the fast benchmark.

2020-01-15 04:14:47 (8820): Guest Log: [INFO] Machine performance 1.13 HEPSPEC06

2020-01-15 04:14:47 (8820): Guest Log: [INFO] CMS application starting. Check log files.

2020-01-15 04:14:55 (8820): Guest Log: [DEBUG] HTCondor ping

2020-01-15 04:15:07 (8820): Guest Log: [DEBUG] 0

2020-01-15 05:41:20 (8820): Status Report: Job Duration: '64800.000000'
2020-01-15 05:41:20 (8820): Status Report: Elapsed Time: '43067.373887'
2020-01-15 05:41:21 (8820): Status Report: CPU Time: '29230.375000'
2020-01-15 07:21:29 (8820): Status Report: Job Duration: '64800.000000'
2020-01-15 07:21:29 (8820): Status Report: Elapsed Time: '49067.373887'
2020-01-15 07:21:29 (8820): Status Report: CPU Time: '35216.765625'
2020-01-15 09:01:42 (8820): Status Report: Job Duration: '64800.000000'
2020-01-15 09:01:42 (8820): Status Report: Elapsed Time: '55067.373887'
2020-01-15 09:01:42 (8820): Status Report: CPU Time: '41206.781250'
2020-01-15 10:41:51 (8820): Status Report: Job Duration: '64800.000000'
2020-01-15 10:41:51 (8820): Status Report: Elapsed Time: '61067.373887'
2020-01-15 10:41:51 (8820): Status Report: CPU Time: '47192.187500'
2020-01-15 11:44:09 (8820): Powering off VM.
2020-01-15 11:49:12 (8820): VM did not power off when requested.
2020-01-15 11:49:12 (8820): VM was successfully terminated.
2020-01-15 11:49:12 (8820): Deregistering VM. (boinc_1e1f672efea05e48, slot#3)
2020-01-15 11:49:24 (8820): Removing network bandwidth throttle group from VM.
2020-01-15 11:49:28 (8820): Removing VM from VirtualBox.
11:49:38 (8820): called boinc_finish(0)

</stderr_txt>
]]>

©2024 CERN