Name CMS_3760325_1567005047.657241_0
Workunit 1926245
Created 28 Aug 2019, 15:10:51 UTC
Sent 29 Aug 2019, 18:39:33 UTC
Report deadline 5 Sep 2019, 18:39:33 UTC
Received 30 Aug 2019, 19:52:07 UTC
Server state Over
Outcome Computation error
Client state Compute error
Exit status 194 (0x000000C2) EXIT_ABORTED_BY_CLIENT
Computer ID 3925
Run time 1 hours 16 min 55 sec
CPU time 22 min 44 sec
Validate state Invalid
Credit 0.00
Device peak FLOPS 4.26 GFLOPS
Application version CMS Simulation v49.00 (vbox64_mt_mcore_cms)
windows_x86_64
Peak working set size 104.84 MB
Peak swap size 122.77 MB
Peak disk usage 3.04 GB

Stderr output

<core_client_version>7.14.2</core_client_version>
<![CDATA[
<message>
(unknown error) - exit code 194 (0xc2)</message>
<stderr_txt>
2019-08-29 18:50:40 (5692): Detected: vboxwrapper 26197
2019-08-29 18:50:40 (5692): Detected: BOINC client v7.7
2019-08-29 18:50:41 (5692): Detected: VirtualBox VboxManage Interface (Version: 6.0.8)
2019-08-29 18:50:41 (5692): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2019-08-29 18:50:41 (5692): Successfully copied 'init_data.xml' to the shared directory.
2019-08-29 18:50:42 (5692): Create VM. (boinc_6691db8307e03266, slot#1)
2019-08-29 18:50:43 (5692): Setting Memory Size for VM. (1896MB)
2019-08-29 18:50:44 (5692): Setting CPU Count for VM. (1)
2019-08-29 18:50:45 (5692): Setting Chipset Options for VM.
2019-08-29 18:50:45 (5692): Setting Boot Options for VM.
2019-08-29 18:50:46 (5692): Setting Network Configuration for NAT.
2019-08-29 18:50:47 (5692): Enabling VM Network Access.
2019-08-29 18:50:47 (5692): Disabling USB Support for VM.
2019-08-29 18:50:47 (5692): Disabling COM Port Support for VM.
2019-08-29 18:50:47 (5692): Disabling LPT Port Support for VM.
2019-08-29 18:50:48 (5692): Disabling Audio Support for VM.
2019-08-29 18:50:48 (5692): Disabling Clipboard Support for VM.
2019-08-29 18:50:49 (5692): Disabling Drag and Drop Support for VM.
2019-08-29 18:50:50 (5692): Adding storage controller(s) to VM.
2019-08-29 18:50:51 (5692): Adding virtual disk drive to VM. (vm_image.vdi)
2019-08-29 18:50:51 (5692): Adding VirtualBox Guest Additions to VM.
2019-08-29 18:50:52 (5692): Adding network bandwidth throttle group to VM. (Defaulting to 1024GB)
2019-08-29 18:50:52 (5692): forwarding host port 49805 to guest port 80
2019-08-29 18:50:53 (5692): Enabling remote desktop for VM.
2019-08-29 18:50:53 (5692): Enabling shared directory for VM.
2019-08-29 18:50:54 (5692): Starting VM using VBoxManage interface. (boinc_6691db8307e03266, slot#1)
2019-08-29 18:50:59 (5692): Successfully started VM. (PID = '2536')
2019-08-29 18:50:59 (5692): Reporting VM Process ID to BOINC.
2019-08-29 18:50:59 (5692): Guest Log: BIOS: VirtualBox 6.0.8

2019-08-29 18:50:59 (5692): Guest Log: CPUID EDX: 0x178bfbff

2019-08-29 18:50:59 (5692): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63

2019-08-29 18:50:59 (5692): VM state change detected. (old = 'PoweredOff', new = 'Running')
2019-08-29 18:50:59 (5692): Detected: Web Application Enabled (http://localhost:49805)
2019-08-29 18:50:59 (5692): Detected: Remote Desktop Enabled (localhost:49806)
2019-08-29 18:50:59 (5692): Preference change detected
2019-08-29 18:50:59 (5692): Setting CPU throttle for VM. (100%)
2019-08-29 18:50:59 (5692): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2019-08-29 18:51:01 (5692): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032

2019-08-29 18:51:01 (5692): Guest Log: BIOS: Booting from Hard Disk...

2019-08-29 18:51:03 (5692): Guest Log: BIOS: KBD: unsupported int 16h function 03

2019-08-29 18:51:03 (5692): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 

2019-08-29 18:51:22 (5692): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds

2019-08-29 18:51:22 (5692): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)

2019-08-29 18:51:54 (5692): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log

2019-08-29 18:51:54 (5692): Guest Log: 00:00:00.000199 main     Log opened 2019-08-29T18:51:52.685881000Z

2019-08-29 18:51:54 (5692): Guest Log: 00:00:00.000374 main     OS Product: Linux

2019-08-29 18:51:54 (5692): Guest Log: 00:00:00.000409 main     OS Release: 4.14.44-11.cernvm.x86_64

2019-08-29 18:51:54 (5692): Guest Log: 00:00:00.000441 main     OS Version: #1 SMP Mon May 28 16:49:00 CEST 2018

2019-08-29 18:51:54 (5692): Guest Log: 00:00:00.000494 main     Executable: /usr/share/vboxguest52/usr/sbin/VBoxService

2019-08-29 18:51:54 (5692): Guest Log: 00:00:00.000495 main     Process ID: 2967

2019-08-29 18:51:54 (5692): Guest Log: 00:00:00.000497 main     Package type: LINUX_64BITS_GENERIC

2019-08-29 18:51:54 (5692): Guest Log: 00:00:00.001545 main     5.2.6 r120293 started. Verbose level = 0

2019-08-29 18:52:04 (5692): Guest Log: 00:00:10.018753 timesync vgsvcTimeSyncWorker: Radical guest time change: -7 188 644 331 000ns (GuestNow=1 567 097 524 059 027 000 ns GuestLast=1 567 104 712 703 358 000 ns fSetTimeLastLoop=true )

2019-08-29 18:52:18 (5692): Guest Log: [INFO] Mounting the shared directory

2019-08-29 18:52:18 (5692): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor

2019-08-29 18:52:19 (5692): Guest Log: [DEBUG] Testing network connection to cern.ch on port 80

2019-08-29 18:52:19 (5692): Guest Log: [DEBUG] Connection to cern.ch 80 port [tcp/http] succeeded!

2019-08-29 18:52:19 (5692): Guest Log: [DEBUG] 0

2019-08-29 18:52:19 (5692): Guest Log: [DEBUG] Testing VCCS connection to vccs.cern.ch on port 443

2019-08-29 18:52:19 (5692): Guest Log: [DEBUG] Connection to vccs.cern.ch 443 port [tcp/https] succeeded!

2019-08-29 18:52:19 (5692): Guest Log: [DEBUG] 0

2019-08-29 18:52:19 (5692): Guest Log: [DEBUG] Testing connection to Condor server on port 9618

2019-08-29 18:52:19 (5692): Guest Log: [DEBUG] Connection to vccondor01.cern.ch 9618 port [tcp/condor] succeeded!

2019-08-29 18:52:19 (5692): Guest Log: [DEBUG] 0

2019-08-29 18:52:24 (5692): Guest Log: 00:00:30.020235 timesync vgsvcTimeSyncWorker: Radical guest time change: 7 209 649 246 000ns (GuestNow=1 567 104 743 709 501 000 ns GuestLast=1 567 097 534 060 255 000 ns fSetTimeLastLoop=false)

2019-08-29 18:52:34 (5692): Guest Log: 00:00:40.020565 timesync vgsvcTimeSyncWorker: Radical guest time change: -7 189 649 162 000ns (GuestNow=1 567 097 554 060 339 000 ns GuestLast=1 567 104 743 709 501 000 ns fSetTimeLastLoop=true )

2019-08-29 18:53:24 (5692): Guest Log: [DEBUG] Probing CVMFS ...

2019-08-29 18:53:26 (5692): Guest Log: Probing /cvmfs/grid.cern.ch... OK

2019-08-29 18:53:26 (5692): 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-08-29 18:53:26 (5692): Guest Log: 2.4.4.0 3706 307445734561825741 25912 10109 3 1 1454385 10240001 2 65024 0 3 100 0 0 http://s1cern-cvmfs.openhtc.io/cvmfs/grid.cern.ch DIRECT 1

2019-08-29 18:53:36 (5692): Guest Log: [INFO] Reading volunteer information

2019-08-29 18:53:36 (5692): Guest Log: [INFO] Volunteer: Rantanplan (569)

2019-08-29 18:53:36 (5692): Guest Log: [INFO] VMID: c5ab4400-4ef6-44a9-aaed-bee78432355d

2019-08-29 18:53:37 (5692): Guest Log: [INFO] Requesting an X509 credential from LHC@home

2019-08-29 18:53:37 (5692): Guest Log: [INFO] Requesting an X509 credential from vLHC@home-dev

2019-08-29 18:53:38 (5692): Guest Log: [INFO] Running the fast benchmark.

2019-08-29 18:56:28 (5692): Guest Log: [INFO] Machine performance 2.96 HEPSPEC06

2019-08-29 18:56:28 (5692): Guest Log: [INFO] CMS application starting. Check log files.

2019-08-29 18:56:29 (5692): Guest Log: [DEBUG] HTCondor ping

2019-08-29 18:56:30 (5692): Guest Log: [DEBUG] 0

2019-08-29 19:06:19 (5692): Stopping VM.
2019-08-29 19:06:19 (5692): Error in stop VM for VM: -108
Command:
VBoxManage -q controlvm "boinc_6691db8307e03266" savestate
Output:

2019-08-29 19:06:19 (5692): VM did not stop when requested.
2019-08-29 19:06:19 (5692): VM was successfully terminated.
2019-08-29 21:20:39 (6052): Detected: vboxwrapper 26197
2019-08-29 21:20:39 (6052): Detected: BOINC client v7.7
2019-08-29 21:20:41 (6052): Detected: VirtualBox VboxManage Interface (Version: 6.0.8)
2019-08-29 21:20:41 (6052): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2019-08-29 21:20:41 (6052): Starting VM using VBoxManage interface. (boinc_6691db8307e03266, slot#1)
2019-08-29 21:20:45 (6052): Successfully started VM. (PID = '6916')
2019-08-29 21:20:45 (6052): Reporting VM Process ID to BOINC.
2019-08-29 21:20:45 (6052): Guest Log: BIOS: VirtualBox 6.0.8

2019-08-29 21:20:45 (6052): Guest Log: CPUID EDX: 0x178bfbff

2019-08-29 21:20:45 (6052): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63

2019-08-29 21:20:45 (6052): VM state change detected. (old = 'PoweredOff', new = 'Running')
2019-08-29 21:20:45 (6052): Detected: Web Application Enabled (http://localhost:49805)
2019-08-29 21:20:45 (6052): Detected: Remote Desktop Enabled (localhost:49806)
2019-08-29 21:20:45 (6052): Preference change detected
2019-08-29 21:20:45 (6052): Setting CPU throttle for VM. (100%)
2019-08-29 21:20:46 (6052): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2019-08-29 21:20:47 (6052): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032

2019-08-29 21:20:47 (6052): Guest Log: BIOS: Booting from Hard Disk...

2019-08-29 21:20:49 (6052): Guest Log: BIOS: KBD: unsupported int 16h function 03

2019-08-29 21:20:49 (6052): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 

2019-08-29 21:21:08 (6052): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds

2019-08-29 21:21:08 (6052): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)

2019-08-29 21:21:38 (6052): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log

2019-08-29 21:21:38 (6052): Guest Log: 00:00:00.000244 main     Log opened 2019-08-29T19:21:37.708385000Z

2019-08-29 21:21:38 (6052): Guest Log: 00:00:00.000425 main     OS Product: Linux

2019-08-29 21:21:38 (6052): Guest Log: 00:00:00.000466 main     OS Release: 4.14.44-11.cernvm.x86_64

2019-08-29 21:21:38 (6052): Guest Log: 00:00:00.000500 main     OS Version: #1 SMP Mon May 28 16:49:00 CEST 2018

2019-08-29 21:21:38 (6052): Guest Log: 00:00:00.000533 main     Executable: /usr/share/vboxguest52/usr/sbin/VBoxService

2019-08-29 21:21:38 (6052): Guest Log: 00:00:00.000535 main     Process ID: 2906

2019-08-29 21:21:38 (6052): Guest Log: 00:00:00.000536 main     Package type: LINUX_64BITS_GENERIC

2019-08-29 21:21:38 (6052): Guest Log: 00:00:00.001712 main     5.2.6 r120293 started. Verbose level = 0

2019-08-29 21:22:03 (6052): Guest Log: [INFO] Mounting the shared directory

2019-08-29 21:22:04 (6052): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor

2019-08-29 21:22:04 (6052): Guest Log: [DEBUG] Testing network connection to cern.ch on port 80

2019-08-29 21:22:04 (6052): Guest Log: [DEBUG] Connection to cern.ch 80 port [tcp/http] succeeded!

2019-08-29 21:22:04 (6052): Guest Log: [DEBUG] 0

2019-08-29 21:22:04 (6052): Guest Log: [DEBUG] Testing VCCS connection to vccs.cern.ch on port 443

2019-08-29 21:22:04 (6052): Guest Log: [DEBUG] Connection to vccs.cern.ch 443 port [tcp/https] succeeded!

2019-08-29 21:22:04 (6052): Guest Log: [DEBUG] 0

2019-08-29 21:22:04 (6052): Guest Log: [DEBUG] Testing connection to Condor server on port 9618

2019-08-29 21:22:04 (6052): Guest Log: [DEBUG] Connection to vccondor01.cern.ch 9618 port [tcp/condor] succeeded!

2019-08-29 21:22:04 (6052): Guest Log: [DEBUG] 0

2019-08-29 21:23:07 (6052): Guest Log: [DEBUG] Probing CVMFS ...

2019-08-29 21:23:09 (6052): Guest Log: Probing /cvmfs/grid.cern.ch... OK

2019-08-29 21:23:10 (6052): 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-08-29 21:23:10 (6052): Guest Log: 2.4.4.0 3627 1 25800 10111 3 1 1747757 10240001 2 65024 0 3 100 0 0 http://s1cern-cvmfs.openhtc.io/cvmfs/grid.cern.ch DIRECT 1

2019-08-29 21:23:11 (6052): Guest Log: [INFO] Reading volunteer information

2019-08-29 21:23:11 (6052): Guest Log: [INFO] Volunteer: Rantanplan (569)

2019-08-29 21:23:11 (6052): Guest Log: [INFO] VMID: c5ab4400-4ef6-44a9-aaed-bee78432355d

2019-08-29 21:23:11 (6052): Guest Log: [INFO] Requesting an X509 credential from LHC@home

2019-08-29 21:23:12 (6052): Guest Log: [INFO] Requesting an X509 credential from vLHC@home-dev

2019-08-29 21:23:12 (6052): Guest Log: [INFO] Running the fast benchmark.

2019-08-29 21:26:07 (6052): Guest Log: [INFO] Machine performance 2.95 HEPSPEC06

2019-08-29 21:26:07 (6052): Guest Log: [INFO] CMS application starting. Check log files.

2019-08-29 21:26:08 (6052): Guest Log: [DEBUG] HTCondor ping

2019-08-29 21:26:09 (6052): Guest Log: [DEBUG] 0

2019-08-29 21:27:21 (6052): Stopping VM.
2019-08-29 21:27:21 (6052): Error in stop VM for VM: -108
Command:
VBoxManage -q controlvm "boinc_6691db8307e03266" savestate
Output:

2019-08-29 21:27:21 (6052): VM did not stop when requested.
2019-08-29 21:27:21 (6052): VM was successfully terminated.
2019-08-29 21:28:29 (6540): Detected: vboxwrapper 26197
2019-08-29 21:28:29 (6540): Detected: BOINC client v7.7
2019-08-29 21:28:30 (6540): Detected: VirtualBox VboxManage Interface (Version: 6.0.8)
2019-08-29 21:28:31 (6540): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2019-08-29 21:28:31 (6540): Starting VM using VBoxManage interface. (boinc_6691db8307e03266, slot#1)
2019-08-29 21:28:35 (6540): Successfully started VM. (PID = '6260')
2019-08-29 21:28:35 (6540): Reporting VM Process ID to BOINC.
2019-08-29 21:28:35 (6540): Guest Log: BIOS: VirtualBox 6.0.8

2019-08-29 21:28:35 (6540): Guest Log: CPUID EDX: 0x178bfbff

2019-08-29 21:28:35 (6540): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63

2019-08-29 21:28:35 (6540): VM state change detected. (old = 'PoweredOff', new = 'Running')
2019-08-29 21:28:35 (6540): Detected: Web Application Enabled (http://localhost:49805)
2019-08-29 21:28:35 (6540): Detected: Remote Desktop Enabled (localhost:49806)
2019-08-29 21:28:35 (6540): Preference change detected
2019-08-29 21:28:35 (6540): Setting CPU throttle for VM. (100%)
2019-08-29 21:28:35 (6540): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2019-08-29 21:28:37 (6540): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032

2019-08-29 21:28:37 (6540): Guest Log: BIOS: Booting from Hard Disk...

2019-08-29 21:28:39 (6540): Guest Log: BIOS: KBD: unsupported int 16h function 03

2019-08-29 21:28:39 (6540): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 

2019-08-29 21:28:49 (6540): Stopping VM.
2019-08-29 21:28:49 (6540): Error in stop VM for VM: -108
Command:
VBoxManage -q controlvm "boinc_6691db8307e03266" savestate
Output:

2019-08-29 21:28:49 (6540): VM did not stop when requested.
2019-08-29 21:28:49 (6540): VM was successfully terminated.
2019-08-29 21:30:07 (7092): Detected: vboxwrapper 26197
2019-08-29 21:30:07 (7092): Detected: BOINC client v7.7
2019-08-29 21:30:08 (7092): Detected: VirtualBox VboxManage Interface (Version: 6.0.8)
2019-08-29 21:30:08 (7092): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2019-08-29 21:30:08 (7092): Starting VM using VBoxManage interface. (boinc_6691db8307e03266, slot#1)
2019-08-29 21:30:12 (7092): Successfully started VM. (PID = '5880')
2019-08-29 21:30:12 (7092): Reporting VM Process ID to BOINC.
2019-08-29 21:30:12 (7092): Guest Log: BIOS: VirtualBox 6.0.8

2019-08-29 21:30:12 (7092): Guest Log: CPUID EDX: 0x178bfbff

2019-08-29 21:30:12 (7092): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63

2019-08-29 21:30:12 (7092): VM state change detected. (old = 'PoweredOff', new = 'Running')
2019-08-29 21:30:12 (7092): Detected: Web Application Enabled (http://localhost:49805)
2019-08-29 21:30:12 (7092): Detected: Remote Desktop Enabled (localhost:49806)
2019-08-29 21:30:12 (7092): Preference change detected
2019-08-29 21:30:12 (7092): Setting CPU throttle for VM. (100%)
2019-08-29 21:30:13 (7092): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2019-08-29 21:30:14 (7092): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032

2019-08-29 21:30:14 (7092): Guest Log: BIOS: Booting from Hard Disk...

2019-08-29 21:30:16 (7092): Guest Log: BIOS: KBD: unsupported int 16h function 03

2019-08-29 21:30:16 (7092): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 

2019-08-29 21:30:36 (7092): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds

2019-08-29 21:30:36 (7092): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)

2019-08-29 21:31:03 (7092): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log

2019-08-29 21:31:03 (7092): Guest Log: 00:00:00.000203 main     Log opened 2019-08-29T19:31:01.830559000Z

2019-08-29 21:31:03 (7092): Guest Log: 00:00:00.000537 main     OS Product: Linux

2019-08-29 21:31:03 (7092): Guest Log: 00:00:00.000576 main     OS Release: 4.14.44-11.cernvm.x86_64

2019-08-29 21:31:03 (7092): Guest Log: 00:00:00.000626 main     OS Version: #1 SMP Mon May 28 16:49:00 CEST 2018

2019-08-29 21:31:03 (7092): Guest Log: 00:00:00.000659 main     Executable: /usr/share/vboxguest52/usr/sbin/VBoxService

2019-08-29 21:31:03 (7092): Guest Log: 00:00:00.000661 main     Process ID: 2907

2019-08-29 21:31:03 (7092): Guest Log: 00:00:00.000662 main     Package type: LINUX_64BITS_GENERIC

2019-08-29 21:31:03 (7092): Guest Log: 00:00:00.001777 main     5.2.6 r120293 started. Verbose level = 0

2019-08-29 21:31:27 (7092): Guest Log: [INFO] Mounting the shared directory

2019-08-29 21:31:27 (7092): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor

2019-08-29 21:31:27 (7092): Guest Log: [DEBUG] Testing network connection to cern.ch on port 80

2019-08-29 21:31:27 (7092): Guest Log: [DEBUG] Connection to cern.ch 80 port [tcp/http] succeeded!

2019-08-29 21:31:27 (7092): Guest Log: [DEBUG] 0

2019-08-29 21:31:27 (7092): Guest Log: [DEBUG] Testing VCCS connection to vccs.cern.ch on port 443

2019-08-29 21:31:27 (7092): Guest Log: [DEBUG] Connection to vccs.cern.ch 443 port [tcp/https] succeeded!

2019-08-29 21:31:27 (7092): Guest Log: [DEBUG] 0

2019-08-29 21:31:27 (7092): Guest Log: [DEBUG] Testing connection to Condor server on port 9618

2019-08-29 21:31:27 (7092): Guest Log: [DEBUG] Connection to vccondor01.cern.ch 9618 port [tcp/condor] succeeded!

2019-08-29 21:31:27 (7092): Guest Log: [DEBUG] 0

2019-08-29 21:32:31 (7092): Guest Log: [DEBUG] Probing CVMFS ...

2019-08-29 21:32:32 (7092): Guest Log: Probing /cvmfs/grid.cern.ch... OK

2019-08-29 21:32:33 (7092): 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-08-29 21:32:33 (7092): Guest Log: 2.4.4.0 3626 1 25780 10111 3 1 1748086 10240001 2 65024 0 3 100 0 0 http://s1ral-cvmfs.openhtc.io/cvmfs/grid.cern.ch DIRECT 1

2019-08-29 21:32:33 (7092): Guest Log: [INFO] Reading volunteer information

2019-08-29 21:32:34 (7092): Guest Log: [INFO] Volunteer: Rantanplan (569)

2019-08-29 21:32:34 (7092): Guest Log: [INFO] VMID: c5ab4400-4ef6-44a9-aaed-bee78432355d

2019-08-29 21:32:34 (7092): Guest Log: [INFO] Requesting an X509 credential from LHC@home

2019-08-29 21:32:34 (7092): Guest Log: [INFO] Requesting an X509 credential from vLHC@home-dev

2019-08-29 21:32:35 (7092): Guest Log: [INFO] Running the fast benchmark.

2019-08-29 21:35:32 (7092): Guest Log: [INFO] Machine performance 2.85 HEPSPEC06

2019-08-29 21:35:32 (7092): Guest Log: [INFO] CMS application starting. Check log files.

2019-08-29 21:35:33 (7092): Guest Log: [DEBUG] HTCondor ping

2019-08-29 21:35:33 (7092): Guest Log: [DEBUG] 0

2019-08-29 21:36:09 (7092): Stopping VM.
2019-08-29 21:36:09 (7092): Error in stop VM for VM: -108
Command:
VBoxManage -q controlvm "boinc_6691db8307e03266" savestate
Output:

2019-08-29 21:36:09 (7092): VM did not stop when requested.
2019-08-29 21:36:09 (7092): VM was successfully terminated.
2019-08-29 21:37:18 (6604): Detected: vboxwrapper 26197
2019-08-29 21:37:18 (6604): Detected: BOINC client v7.7
2019-08-29 21:37:19 (6604): Detected: VirtualBox VboxManage Interface (Version: 6.0.8)
2019-08-29 21:37:19 (6604): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2019-08-29 21:37:20 (6604): Starting VM using VBoxManage interface. (boinc_6691db8307e03266, slot#1)
2019-08-29 21:37:24 (6604): Successfully started VM. (PID = '6944')
2019-08-29 21:37:24 (6604): Reporting VM Process ID to BOINC.
2019-08-29 21:37:24 (6604): Guest Log: BIOS: VirtualBox 6.0.8

2019-08-29 21:37:24 (6604): Guest Log: CPUID EDX: 0x178bfbff

2019-08-29 21:37:24 (6604): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63

2019-08-29 21:37:24 (6604): VM state change detected. (old = 'PoweredOff', new = 'Running')
2019-08-29 21:37:24 (6604): Detected: Web Application Enabled (http://localhost:49805)
2019-08-29 21:37:24 (6604): Detected: Remote Desktop Enabled (localhost:49806)
2019-08-29 21:37:24 (6604): Preference change detected
2019-08-29 21:37:24 (6604): Setting CPU throttle for VM. (100%)
2019-08-29 21:37:24 (6604): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2019-08-29 21:37:26 (6604): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032

2019-08-29 21:37:26 (6604): Guest Log: BIOS: Booting from Hard Disk...

2019-08-29 21:37:28 (6604): Guest Log: BIOS: KBD: unsupported int 16h function 03

2019-08-29 21:37:28 (6604): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 

2019-08-29 21:37:46 (6604): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds

2019-08-29 21:37:46 (6604): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)

2019-08-29 21:38:13 (6604): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log

2019-08-29 21:38:13 (6604): Guest Log: 00:00:00.000209 main     Log opened 2019-08-29T19:38:12.667662000Z

2019-08-29 21:38:13 (6604): Guest Log: 00:00:00.000391 main     OS Product: Linux

2019-08-29 21:38:13 (6604): Guest Log: 00:00:00.000450 main     OS Release: 4.14.44-11.cernvm.x86_64

2019-08-29 21:38:13 (6604): Guest Log: 00:00:00.000486 main     OS Version: #1 SMP Mon May 28 16:49:00 CEST 2018

2019-08-29 21:38:13 (6604): Guest Log: 00:00:00.000536 main     Executable: /usr/share/vboxguest52/usr/sbin/VBoxService

2019-08-29 21:38:13 (6604): Guest Log: 00:00:00.000537 main     Process ID: 2905

2019-08-29 21:38:13 (6604): Guest Log: 00:00:00.000538 main     Package type: LINUX_64BITS_GENERIC

2019-08-29 21:38:13 (6604): Guest Log: 00:00:00.001717 main     5.2.6 r120293 started. Verbose level = 0

2019-08-29 21:38:37 (6604): Guest Log: [INFO] Mounting the shared directory

2019-08-29 21:38:37 (6604): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor

2019-08-29 21:38:37 (6604): Guest Log: [DEBUG] Testing network connection to cern.ch on port 80

2019-08-29 21:38:37 (6604): Guest Log: [DEBUG] Connection to cern.ch 80 port [tcp/http] succeeded!

2019-08-29 21:38:37 (6604): Guest Log: [DEBUG] 0

2019-08-29 21:38:37 (6604): Guest Log: [DEBUG] Testing VCCS connection to vccs.cern.ch on port 443

2019-08-29 21:38:38 (6604): Guest Log: [DEBUG] Connection to vccs.cern.ch 443 port [tcp/https] succeeded!

2019-08-29 21:38:38 (6604): Guest Log: [DEBUG] 0

2019-08-29 21:38:38 (6604): Guest Log: [DEBUG] Testing connection to Condor server on port 9618

2019-08-29 21:38:38 (6604): Guest Log: [DEBUG] Connection to vccondor01.cern.ch 9618 port [tcp/condor] succeeded!

2019-08-29 21:38:38 (6604): Guest Log: [DEBUG] 0

2019-08-29 21:41:02 (5556): Detected: vboxwrapper 26197
2019-08-29 21:41:02 (5556): Detected: BOINC client v7.7
2019-08-29 21:41:04 (5556): Detected: VirtualBox VboxManage Interface (Version: 6.0.8)
2019-08-29 21:41:04 (5556): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2019-08-29 21:41:04 (5556): Starting VM using VBoxManage interface. (boinc_6691db8307e03266, slot#1)
2019-08-29 21:41:10 (5556): Successfully started VM. (PID = '7060')
2019-08-29 21:41:10 (5556): Reporting VM Process ID to BOINC.
2019-08-29 21:41:10 (5556): Guest Log: BIOS: VirtualBox 6.0.8

2019-08-29 21:41:10 (5556): Guest Log: CPUID EDX: 0x178bfbff

2019-08-29 21:41:10 (5556): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63

2019-08-29 21:41:10 (5556): VM state change detected. (old = 'PoweredOff', new = 'Running')
2019-08-29 21:41:10 (5556): Detected: Web Application Enabled (http://localhost:49805)
2019-08-29 21:41:10 (5556): Detected: Remote Desktop Enabled (localhost:49806)
2019-08-29 21:41:10 (5556): Preference change detected
2019-08-29 21:41:10 (5556): Setting CPU throttle for VM. (100%)
2019-08-29 21:41:10 (5556): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2019-08-29 21:41:12 (5556): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032

2019-08-29 21:41:12 (5556): Guest Log: BIOS: Booting from Hard Disk...

2019-08-29 21:41:14 (5556): Guest Log: BIOS: KBD: unsupported int 16h function 03

2019-08-29 21:41:14 (5556): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 

2019-08-29 21:41:32 (5556): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds

2019-08-29 21:41:32 (5556): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)

2019-08-29 21:42:01 (5556): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log

2019-08-29 21:42:01 (5556): Guest Log: 00:00:00.000204 main     Log opened 2019-08-29T19:41:59.678195000Z

2019-08-29 21:42:01 (5556): Guest Log: 00:00:00.000519 main     OS Product: Linux

2019-08-29 21:42:01 (5556): Guest Log: 00:00:00.000562 main     OS Release: 4.14.44-11.cernvm.x86_64

2019-08-29 21:42:01 (5556): Guest Log: 00:00:00.000595 main     OS Version: #1 SMP Mon May 28 16:49:00 CEST 2018

2019-08-29 21:42:01 (5556): Guest Log: 00:00:00.000627 main     Executable: /usr/share/vboxguest52/usr/sbin/VBoxService

2019-08-29 21:42:01 (5556): Guest Log: 00:00:00.000629 main     Process ID: 2901

2019-08-29 21:42:01 (5556): Guest Log: 00:00:00.000630 main     Package type: LINUX_64BITS_GENERIC

2019-08-29 21:42:01 (5556): Guest Log: 00:00:00.001661 main     5.2.6 r120293 started. Verbose level = 0

2019-08-29 21:42:25 (5556): Stopping VM.
2019-08-29 20:57:40 (5968): Detected: vboxwrapper 26197
2019-08-29 20:57:40 (5968): Detected: BOINC client v7.7
2019-08-29 20:57:42 (5968): Detected: VirtualBox VboxManage Interface (Version: 6.0.8)
2019-08-29 20:57:42 (5968): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2019-08-29 20:57:42 (5968): Starting VM using VBoxManage interface. (boinc_6691db8307e03266, slot#1)
2019-08-29 20:57:48 (5968): Successfully started VM. (PID = '4376')
2019-08-29 20:57:48 (5968): Reporting VM Process ID to BOINC.
2019-08-29 20:57:48 (5968): VM state change detected. (old = 'PoweredOff', new = 'Running')
2019-08-29 20:57:48 (5968): Detected: Web Application Enabled (http://localhost:49805)
2019-08-29 20:57:48 (5968): Detected: Remote Desktop Enabled (localhost:49806)
2019-08-29 20:57:48 (5968): Preference change detected
2019-08-29 20:57:48 (5968): Setting CPU throttle for VM. (100%)
2019-08-29 20:57:48 (5968): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2019-08-29 20:57:52 (5968): Guest Log: 00:00:30.019700 timesync vgsvcTimeSyncWorker: Radical host time change: -2 668 260 000 000ns (HostNow=1 567 105 072 017 000 000 ns HostLast=1 567 107 740 277 000 000 ns)

2019-08-29 20:58:02 (5968): Guest Log: 00:00:40.020111 timesync vgsvcTimeSyncWorker: Radical guest time change: -2 668 715 995 000ns (GuestNow=1 567 105 082 017 451 000 ns GuestLast=1 567 107 750 733 446 000 ns fSetTimeLastLoop=true )

2019-08-29 21:00:37 (5968): Stopping VM.
2019-08-29 21:00:37 (5968): Error in stop VM for VM: -108
Command:
VBoxManage -q controlvm "boinc_6691db8307e03266" savestate
Output:

2019-08-29 21:00:37 (5968): VM did not stop when requested.
2019-08-29 21:00:37 (5968): VM was successfully terminated.
2019-08-30 19:05:15 (844): Detected: vboxwrapper 26197
2019-08-30 19:05:15 (844): Detected: BOINC client v7.7
2019-08-30 19:05:16 (844): Detected: VirtualBox VboxManage Interface (Version: 6.0.8)
2019-08-30 19:05:16 (844): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2019-08-30 19:05:17 (844): Starting VM using VBoxManage interface. (boinc_6691db8307e03266, slot#1)
2019-08-30 19:05:21 (844): Successfully started VM. (PID = '1800')
2019-08-30 19:05:21 (844): Reporting VM Process ID to BOINC.
2019-08-30 19:05:21 (844): Guest Log: BIOS: VirtualBox 6.0.8

2019-08-30 19:05:21 (844): Guest Log: CPUID EDX: 0x178bfbff

2019-08-30 19:05:21 (844): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63

2019-08-30 19:05:21 (844): VM state change detected. (old = 'PoweredOff', new = 'Running')
2019-08-30 19:05:21 (844): Detected: Web Application Enabled (http://localhost:49805)
2019-08-30 19:05:21 (844): Detected: Remote Desktop Enabled (localhost:49806)
2019-08-30 19:05:21 (844): Preference change detected
2019-08-30 19:05:21 (844): Setting CPU throttle for VM. (100%)
2019-08-30 19:05:21 (844): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2019-08-30 19:05:23 (844): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032

2019-08-30 19:05:23 (844): Guest Log: BIOS: Booting from Hard Disk...

2019-08-30 19:05:25 (844): Guest Log: BIOS: KBD: unsupported int 16h function 03

2019-08-30 19:05:25 (844): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 

2019-08-30 19:05:46 (844): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds

2019-08-30 19:05:46 (844): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)

2019-08-30 19:06:17 (844): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log

2019-08-30 19:06:17 (844): Guest Log: 00:00:00.000201 main     Log opened 2019-08-30T19:06:17.372076000Z

2019-08-30 19:06:17 (844): Guest Log: 00:00:00.000456 main     OS Product: Linux

2019-08-30 19:06:17 (844): Guest Log: 00:00:00.000520 main     OS Release: 4.14.44-11.cernvm.x86_64

2019-08-30 19:06:17 (844): Guest Log: 00:00:00.000556 main     OS Version: #1 SMP Mon May 28 16:49:00 CEST 2018

2019-08-30 19:06:17 (844): Guest Log: 00:00:00.000589 main     Executable: /usr/share/vboxguest52/usr/sbin/VBoxService

2019-08-30 19:06:17 (844): Guest Log: 00:00:00.000591 main     Process ID: 2894

2019-08-30 19:06:17 (844): Guest Log: 00:00:00.000592 main     Package type: LINUX_64BITS_GENERIC

2019-08-30 19:06:17 (844): Guest Log: 00:00:00.001760 main     5.2.6 r120293 started. Verbose level = 0

2019-08-30 19:06:27 (844): Guest Log: 00:00:10.019866 timesync vgsvcTimeSyncWorker: Radical guest time change: -7 189 945 196 000ns (GuestNow=1 567 184 787 445 595 000 ns GuestLast=1 567 191 977 390 791 000 ns fSetTimeLastLoop=true )

2019-08-30 19:06:47 (844): Guest Log: 00:00:30.020513 timesync vgsvcTimeSyncWorker: Radical guest time change: 7 210 182 311 000ns (GuestNow=1 567 192 007 628 747 000 ns GuestLast=1 567 184 797 446 436 000 ns fSetTimeLastLoop=false)

2019-08-30 19:06:58 (844): Guest Log: 00:00:40.021069 timesync vgsvcTimeSyncWorker: Radical guest time change: -7 190 181 181 000ns (GuestNow=1 567 184 817 447 566 000 ns GuestLast=1 567 192 007 628 747 000 ns fSetTimeLastLoop=true )

2019-08-30 21:15:18 (844): Guest Log: 00:09:00.032090 timesync vgsvcTimeSyncWorker: Radical host time change: 7 210 180 000 000ns (HostNow=1 567 192 517 632 000 000 ns HostLast=1 567 185 307 452 000 000 ns)

2019-08-30 21:15:28 (844): Guest Log: 00:09:10.032234 timesync vgsvcTimeSyncWorker: Radical guest time change: 7 210 173 576 000ns (GuestNow=1 567 192 527 632 152 000 ns GuestLast=1 567 185 317 458 576 000 ns fSetTimeLastLoop=true )

2019-08-30 21:45:24 (844): VM Heartbeat file specified, but missing heartbeat.
2019-08-30 21:45:24 (844): Powering off VM.
2019-08-30 21:50:25 (844): VM did not power off when requested.
2019-08-30 21:50:25 (844): VM was successfully terminated.
2019-08-30 21:50:25 (844): Deregistering VM. (boinc_6691db8307e03266, slot#1)
2019-08-30 21:50:26 (844): Removing network bandwidth throttle group from VM.
2019-08-30 21:50:26 (844): Removing VM from VirtualBox.

    Hypervisor System Log:

00:00:00.288093            domain: fritz.box
00:00:00.288094            no search string entries
00:00:00.387547          VD: VDInit finished with VINF_SUCCESS
00:00:00.388475          ERROR [COM]: aRC=E_FAIL (0x80004005) aIID={5047460a-265d-4538-b23e-ddba5fb84976} aComponent={MachineWrap} aText={Runtime error opening 'C:\ProgramData\BOINC\slots\1\boinc_bf727cad4bf170c4\boinc_bf727cad4bf170c4.vbox' for reading: -103 (Path not found.).
00:00:00.388507          F:\tinderbox\win-6.0\src\VBox\Main\src-server\MachineImpl.cpp[752] (long __cdecl Machine::i_registeredInit(void))}, preserve=false aResultDetail=0
00:00:00.388885          ERROR [COM]: aRC=E_FAIL (0x80004005) aIID={5047460a-265d-4538-b23e-ddba5fb84976} aComponent={MachineWrap} aText={Runtime error opening 'C:\ProgramData\BOINC\slots\4\boinc_de8aa2d51d01859d\boinc_de8aa2d51d01859d.vbox' for reading: -103 (Path not found.).
00:00:00.388891          F:\tinderbox\win-6.0\src\VBox\Main\src-server\MachineImpl.cpp[752] (long __cdecl Machine::i_registeredInit(void))}, preserve=false aResultDetail=0
00:00:00.389221          ERROR [COM]: aRC=E_FAIL (0x80004005) aIID={5047460a-265d-4538-b23e-ddba5fb84976} aComponent={MachineWrap} aText={Runtime error opening 'C:\ProgramData\BOINC\slots\3\boinc_fab64ab3e613730b\boinc_fab64ab3e613730b.vbox' for reading: -103 (Path not found.).
00:00:00.389227          F:\tinderbox\win-6.0\src\VBox\Main\src-server\MachineImpl.cpp[752] (long __cdecl Machine::i_registeredInit(void))}, preserve=false aResultDetail=0
00:00:00.389521          ERROR [COM]: aRC=E_FAIL (0x80004005) aIID={5047460a-265d-4538-b23e-ddba5fb84976} aComponent={MachineWrap} aText={Runtime error opening 'C:\ProgramData\BOINC\slots\1\boinc_f5cf03ffb8bb7dea\boinc_f5cf03ffb8bb7dea.vbox' for reading: -103 (Path not found.).
00:00:00.389527          F:\tinderbox\win-6.0\src\VBox\Main\src-server\MachineImpl.cpp[752] (long __cdecl Machine::i_registeredInit(void))}, preserve=false aResultDetail=0
00:00:00.389831          ERROR [COM]: aRC=E_FAIL (0x80004005) aIID={5047460a-265d-4538-b23e-ddba5fb84976} aComponent={MachineWrap} aText={Runtime error opening 'C:\ProgramData\BOINC\slots\2\boinc_0771b4adef46732b\boinc_0771b4adef46732b.vbox' for reading: -103 (Path not found.).
00:00:00.389837          F:\tinderbox\win-6.0\src\VBox\Main\src-server\MachineImpl.cpp[752] (long __cdecl Machine::i_registeredInit(void))}, preserve=false aResultDetail=0
00:00:00.390128          ERROR [COM]: aRC=E_FAIL (0x80004005) aIID={5047460a-265d-4538-b23e-ddba5fb84976} aComponent={MachineWrap} aText={Runtime error opening 'C:\ProgramData\BOINC\slots\1\boinc_be8caf66dac62b50\boinc_be8caf66dac62b50.vbox' for reading: -103 (Path not found.).
00:00:00.390134          F:\tinderbox\win-6.0\src\VBox\Main\src-server\MachineImpl.cpp[752] (long __cdecl Machine::i_registeredInit(void))}, preserve=false aResultDetail=0
00:00:00.390634          Loading settings file "C:\ProgramData\BOINC\slots\1\boinc_6691db8307e03266\boinc_6691db8307e03266.vbox" with version "1.16-windows"
00:00:00.397494          OCI: Local config file 'C:\Users\B75_Pro_3\.VirtualBox\oci_config' does not exist
00:00:00.397580          OCI: Original config file 'C:\Users\B75_Pro_3\.oci\config' does not exist
00:00:00.397582          OCI: Reading profiles finished with status ERROR_SUCCESS
00:00:00.397587          ExtPack: Created cloud provider 'OCI' (hrc=ERROR_SUCCESS)
00:00:00.397615          VirtualBox: object created
00:00:00.405521          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={5047460a-265d-4538-b23e-ddba5fb84976} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:00:00.405557          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={5047460a-265d-4538-b23e-ddba5fb84976} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:00:00.405572          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={5047460a-265d-4538-b23e-ddba5fb84976} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:00:00.405584          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={5047460a-265d-4538-b23e-ddba5fb84976} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:00:00.405595          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={5047460a-265d-4538-b23e-ddba5fb84976} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:00:00.405607          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={5047460a-265d-4538-b23e-ddba5fb84976} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:00:00.408330          ERROR [COM]: aRC=E_FAIL (0x80004005) aIID={5047460a-265d-4538-b23e-ddba5fb84976} aComponent={SessionMachine} aText={This machine does not have any snapshots}, preserve=false aResultDetail=0
00:00:00.460778          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={5047460a-265d-4538-b23e-ddba5fb84976} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:00:00.460812          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={5047460a-265d-4538-b23e-ddba5fb84976} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:00:00.460826          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={5047460a-265d-4538-b23e-ddba5fb84976} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:00:00.460839          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={5047460a-265d-4538-b23e-ddba5fb84976} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:00:00.460851          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={5047460a-265d-4538-b23e-ddba5fb84976} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:00:00.460862          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={5047460a-265d-4538-b23e-ddba5fb84976} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:00:00.463122          Saving settings file "C:\ProgramData\BOINC\slots\1\boinc_6691db8307e03266\boinc_6691db8307e03266.vbox" with version "1.16-windows"
00:00:00.743040          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={5047460a-265d-4538-b23e-ddba5fb84976} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:00:00.743125          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={5047460a-265d-4538-b23e-ddba5fb84976} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:00:00.743143          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={5047460a-265d-4538-b23e-ddba5fb84976} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:00:00.743157          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={5047460a-265d-4538-b23e-ddba5fb84976} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:00:00.743169          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={5047460a-265d-4538-b23e-ddba5fb84976} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:00:00.743180          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={5047460a-265d-4538-b23e-ddba5fb84976} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:00:00.743808          Saving settings file "C:\Users\B75_Pro_3\.VirtualBox\VirtualBox.xml" with version "1.12-windows"
00:00:05.782574 main     VirtualBox: object deletion starts
00:00:05.784410 Watcher  ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={d0a0163f-e254-4e5b-a1f2-011cf991c38d} aComponent={VirtualBoxWrap} aText={The object is not ready}, preserve=false aResultDetail=0
00:00:05.784593 main     VirtualBox: object deleted

    VM Execution Log:


    VM Startup Log:


    VM Trace Log:


Maximum video RAM size:          256 Megabytes
Maximum guest monitor count:     64
Minimum guest CPU count:         1
Maximum guest CPU count:         32
Virtual disk limit (info):       2199022206976 Bytes
Maximum Serial Port count:       4
Maximum Parallel Port count:     2
Maximum Boot Position:           4
Maximum PIIX3 Network Adapter count:   8
Maximum ICH9 Network Adapter count:   36
Maximum PIIX3 IDE Controllers:   1
Maximum ICH9 IDE Controllers:    1
Maximum IDE Port count:          2
Maximum Devices per IDE Port:    2
Maximum PIIX3 SATA Controllers:  1
Maximum ICH9 SATA Controllers:   8
Maximum SATA Port count:         30
Maximum Devices per SATA Port:   1
Maximum PIIX3 SCSI Controllers:  1
Maximum ICH9 SCSI Controllers:   8
Maximum SCSI Port count:         16
Maximum Devices per SCSI Port:   1
Maximum SAS PIIX3 Controllers:   1
Maximum SAS ICH9 Controllers:    8
Maximum SAS Port count:          255
Maximum Devices per SAS Port:    1
Maximum NVMe PIIX3 Controllers:  1
Maximum NVMe ICH9 Controllers:   8
Maximum NVMe Port count:         255
Maximum Devices per NVMe Port:   1
Maximum PIIX3 Floppy Controllers:1
Maximum ICH9 Floppy Controllers: 1
Maximum Floppy Port count:       1
Maximum Devices per Floppy Port: 2
Default machine folder:          C:\Users\B75_Pro_3\VirtualBox VMs
Raw-mode Supported:              yes
Exclusive HW virtualization use: off
Default hard disk format:        VDI
VRDE auth library:               VBoxAuth
Webservice auth. library:        VBoxAuth
Remote desktop ExtPack:          Oracle VM VirtualBox Extension Pack
Log history count:               3
Default frontend:                
Default audio driver:            DirectSound
Autostart database path:         
Default Guest Additions ISO:     C:\Program Files\Oracle\VirtualBox/VBoxGuestAdditions.iso
Logging Level:                   all
Proxy Mode:                      System
Proxy URL:                       

2019-08-30 19:05:16 (844): 
Command: VBoxManage -q list hostinfo 
Exit Code: 0
Output:
Host Information:

Host time: 2019-08-30T17:05:16.743000000Z
Processor online count: 4
Processor count: 4
Processor online core count: 4
Processor core count: 4
Processor supports HW virtualization: yes
Processor supports PAE: yes
Processor supports long mode: yes
Processor supports nested paging: yes
Processor#0 speed: unknown
Processor#0 description: Intel(R) Core(TM) i5-3550 CPU @ 3.30GHz
Processor#1 speed: unknown
Processor#1 description: Intel(R) Core(TM) i5-3550 CPU @ 3.30GHz
Processor#2 speed: unknown
Processor#2 description: Intel(R) Core(TM) i5-3550 CPU @ 3.30GHz
Processor#3 speed: unknown
Processor#3 description: Intel(R) Core(TM) i5-3550 CPU @ 3.30GHz
Memory size: 15325 MByte
Memory available: 12906 MByte
Operating system: Windows 10
Operating system version: 10.0.17763

2019-08-30 19:05:17 (844): 
Command: VBoxManage -q showvminfo "boinc_6691db8307e03266" --machinereadable 
Exit Code: 0
Output:
name="boinc_6691db8307e03266"
groups="/"
ostype="Linux 2.6 / 3.x / 4.x (64-bit)"
UUID="2298242a-f32e-4ebe-b0a2-f4d3fd710771"
CfgFile="C:\\ProgramData\\BOINC\\slots\\1\\boinc_6691db8307e03266\\boinc_6691db8307e03266.vbox"
SnapFldr="C:\\ProgramData\\BOINC\\slots\\1\\boinc_6691db8307e03266\\Snapshots"
LogFldr="C:\\ProgramData\\BOINC\\slots\\1\\boinc_6691db8307e03266\\Logs"
hardwareuuid="2298242a-f32e-4ebe-b0a2-f4d3fd710771"
memory=1896
pagefusion="off"
vram=8
cpuexecutioncap=100
hpet="off"
cpu-profile="host"
chipset="piix3"
firmware="BIOS"
cpus=1
pae="on"
longmode="on"
triplefaultreset="off"
apic="on"
x2apic="on"
nested-hw-virt="off"
cpuid-portability-level=0
bootmenu="messageandmenu"
boot1="disk"
boot2="dvd"
boot3="none"
boot4="none"
acpi="on"
ioapic="on"
biosapic="apic"
biossystemtimeoffset=0
rtcuseutc="off"
hwvirtex="on"
nestedpaging="on"
largepages="on"
vtxvpid="on"
vtxux="on"
paravirtprovider="default"
effparavirtprovider="kvm"
VMState="aborted"
VMStateChangeTime="2019-08-29T19:00:35.000000000"
monitorcount=1
accelerate3d="off"
accelerate2dvideo="off"
teleporterenabled="off"
teleporterport=0
teleporteraddress=""
teleporterpassword=""
tracing-enabled="off"
tracing-allow-vm-access="off"
tracing-config=""
autostart-enabled="off"
autostart-delay=0
defaultfrontend=""
storagecontrollername0="Hard Disk Controller"
storagecontrollertype0="PIIX4"
storagecontrollerinstance0="0"
storagecontrollermaxportcount0="2"
storagecontrollerportcount0="2"
storagecontrollerbootable0="on"
"Hard Disk Controller-0-0"="C:\ProgramData\BOINC\slots\1\vm_image.vdi"
"Hard Disk Controller-ImageUUID-0-0"="e5471517-add3-4ffb-8777-b7d929f3594a"
"Hard Disk Controller-0-1"="none"
"Hard Disk Controller-1-0"="C:\Program Files\Oracle\VirtualBox\VBoxGuestAdditions.iso"
"Hard Disk Controller-ImageUUID-1-0"="74cc4e33-d72a-407e-91c9-b096775bf1e3"
"Hard Disk Controller-tempeject"="off"
"Hard Disk Controller-IsEjected"="off"
"Hard Disk Controller-1-1"="none"
natnet1="nat"
macaddress1="08002772D2DF"
cableconnected1="on"
nic1="nat"
nictype1="82540EM"
nicspeed1="0"
mtu="0"
sockSnd="64"
sockRcv="64"
tcpWndSnd="64"
tcpWndRcv="64"
Forwarding(0)="tcp_49805_80,tcp,127.0.0.1,49805,,80"
nic2="none"
nic3="none"
nic4="none"
nic5="none"
nic6="none"
nic7="none"
nic8="none"
hidpointing="ps2mouse"
hidkeyboard="ps2kbd"
uart1="off"
uart2="off"
uart3="off"
uart4="off"
lpt1="off"
lpt2="off"
audio="none"
audio_in="off"
audio_out="off"
clipboard="disabled"
draganddrop="disabled"
vrde="on"
vrdeport=-1
vrdeports="49806"
vrdeaddress=""
vrdeauthtype="null"
vrdemulticon="off"
vrdereusecon="off"
vrdevideochannel="off"
vrdeproperty[TCP/Ports]="49806"
vrdeproperty[TCP/Address]=<not set>
vrdeproperty[VideoChannel/Enabled]=<not set>
vrdeproperty[VideoChannel/Quality]=<not set>
vrdeproperty[VideoChannel/DownscaleProtection]=<not set>
vrdeproperty[Client/DisableDisplay]=<not set>
vrdeproperty[Client/DisableInput]=<not set>
vrdeproperty[Client/DisableAudio]=<not set>
vrdeproperty[Client/DisableUSB]=<not set>
vrdeproperty[Client/DisableClipboard]=<not set>
vrdeproperty[Client/DisableUpstreamAudio]=<not set>
vrdeproperty[Client/DisableRDPDR]=<not set>
vrdeproperty[H3DRedirect/Enabled]=<not set>
vrdeproperty[Security/Method]=<not set>
vrdeproperty[Security/ServerCertificate]=<not set>
vrdeproperty[Security/ServerPrivateKey]=<not set>
vrdeproperty[Security/CACertificate]=<not set>
vrdeproperty[Audio/RateCorrectionMode]=<not set>
vrdeproperty[Audio/LogPath]=<not set>
usb="off"
ehci="off"
xhci="off"
BandwidthGroup0=boinc_6691db8307e03266_net,Network,1099511627776
SharedFolderNameMachineMapping1="shared"
SharedFolderPathMachineMapping1="C:\\ProgramData\\BOINC\\slots\\1/shared"
videocap="off"
videocapaudio="off"
capturescreens="0"
capturefilename="C:\\ProgramData\\BOINC\\slots\\1\\boinc_6691db8307e03266\\boinc_6691db8307e03266.webm"
captureres="1024x768"
capturevideorate=512
capturevideofps=25
captureopts=""
description="CMS_3760325_1567005047.657241_0"
GuestMemoryBalloon=0

2019-08-30 19:05:20 (844): 
Command: VBoxManage -q startvm "boinc_6691db8307e03266" --type headless
Exit Code: 0
Output:
Waiting for VM "boinc_6691db8307e03266" to power on...
VM "boinc_6691db8307e03266" has been successfully started.

2019-08-30 19:05:21 (844): 
Command: VBoxManage -q controlvm "boinc_6691db8307e03266" cpuexecutioncap 100 
Exit Code: 0
Output:

2019-08-30 21:45:25 (844): 
Command: VBoxManage -q controlvm "boinc_6691db8307e03266" poweroff
Exit Code: 0
Output:
0%...10%...20%...30%...40%...50%...60%...70%...80%...90%...100%

2019-08-30 21:50:26 (844): 
Command: VBoxManage -q snapshot "boinc_6691db8307e03266" list 
Exit Code: -108
Output:
This machine does not have any snapshots

2019-08-30 21:50:26 (844): 
Command: VBoxManage -q bandwidthctl "boinc_6691db8307e03266" remove "boinc_6691db8307e03266_net" 
Exit Code: 0
Output:

2019-08-30 21:50:26 (844): 
Command: VBoxManage -q unregistervm "boinc_6691db8307e03266" --delete 
Exit Code: 0
Output:
0%...10%...20%...30%...40%...50%...60%...70%...80%...90%...100%

21:50:31 (844): called boinc_finish(194)

</stderr_txt>
]]>


©2024 CERN