Task 293255
| Name | 06914837_71_0 |
| Workunit | 186143 |
| Created | 16 Nov 2018, 0:22:31 UTC |
| Sent | 16 Nov 2018, 1:07:10 UTC |
| Report deadline | 16 Nov 2018, 9:07:10 UTC |
| Received | 19 Nov 2018, 0:20:48 UTC |
| Server state | Over |
| Outcome | Success |
| Client state | Done |
| Exit status | 0 (0x00000000) |
| Computer ID | 524 |
| Run time | 1 min 47 sec |
| CPU time | |
| Validate state | Task was reported too late to validate |
| Credit | 0.00 |
| Device peak FLOPS | 3.39 GFLOPS |
| Application version | boinc2docker v1.11 (vbox64_mt) windows_x86_64 |
| Peak working set size | 75.71 MB |
| Peak swap size | 86.85 MB |
| Peak disk usage | 276.94 MB |
Stderr output
<core_client_version>7.12.1</core_client_version>
<![CDATA[
<stderr_txt>
2018-11-15 21:53:10 (9068): vboxwrapper (7.7.26197): starting
2018-11-15 22:05:35 (9068): Error creating VirtualBox instance! rc = 0x80080005
2018-11-15 22:45:36 (9068): Error in version check for VM: -182
Command:
VBoxManage -q --version
Output:
2018-11-15 22:45:36 (9068): Could not detect VM Hypervisor. Rescheduling execution for a later date.
Hypervisor System Log:
00:03:16.202598 ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={b2547866-a0a1-4391-8b86-6952d82efaa0} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:03:16.202598 ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={b2547866-a0a1-4391-8b86-6952d82efaa0} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:03:16.202598 ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={b2547866-a0a1-4391-8b86-6952d82efaa0} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:03:16.206587 ERROR [COM]: aRC=VBOX_E_OBJECT_IN_USE (0x80bb000c) aIID={4afe423b-43e0-e9d0-82e8-ceb307940dda} aComponent={MediumWrap} aText={Medium 'C:\Program Files\Oracle\VirtualBox\VBoxGuestAdditions.iso' cannot be closed because it is still attached to 1 virtual machines}, preserve=false aResultDetail=0
00:03:16.212764 ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={4afe423b-43e0-e9d0-82e8-ceb307940dda} aComponent={MediumWrap} aText={The object is not ready}, preserve=false aResultDetail=0
00:03:16.212764 ERROR [COM]: aRC=VBOX_E_OBJECT_IN_USE (0x80bb000c) aIID={4afe423b-43e0-e9d0-82e8-ceb307940dda} aComponent={MediumWrap} aText={Medium 'C:\Program Files\Oracle\VirtualBox\VBoxGuestAdditions.iso' cannot be closed because it is still attached to 1 virtual machines}, preserve=false aResultDetail=0
00:03:21.059187 ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={b2547866-a0a1-4391-8b86-6952d82efaa0} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:03:21.059187 ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={b2547866-a0a1-4391-8b86-6952d82efaa0} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:03:21.059187 ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={b2547866-a0a1-4391-8b86-6952d82efaa0} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:03:21.059187 ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={b2547866-a0a1-4391-8b86-6952d82efaa0} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:03:21.065157 ERROR [COM]: aRC=E_FAIL (0x80004005) aIID={b2547866-a0a1-4391-8b86-6952d82efaa0} aComponent={SessionMachine} aText={This machine does not have any snapshots}, preserve=false aResultDetail=0
00:03:21.067142 ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={b2547866-a0a1-4391-8b86-6952d82efaa0} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:03:21.067142 ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={b2547866-a0a1-4391-8b86-6952d82efaa0} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:03:21.067142 ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={b2547866-a0a1-4391-8b86-6952d82efaa0} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:03:21.067142 ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={b2547866-a0a1-4391-8b86-6952d82efaa0} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:03:21.068222 ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={b2547866-a0a1-4391-8b86-6952d82efaa0} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:03:21.068222 ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={b2547866-a0a1-4391-8b86-6952d82efaa0} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:03:21.068222 ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={b2547866-a0a1-4391-8b86-6952d82efaa0} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:03:21.068222 ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={b2547866-a0a1-4391-8b86-6952d82efaa0} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:03:21.075333 ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={b2547866-a0a1-4391-8b86-6952d82efaa0} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:03:21.075333 ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={b2547866-a0a1-4391-8b86-6952d82efaa0} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:03:21.075333 ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={b2547866-a0a1-4391-8b86-6952d82efaa0} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:03:21.075333 ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={b2547866-a0a1-4391-8b86-6952d82efaa0} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:03:21.080508 ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={b2547866-a0a1-4391-8b86-6952d82efaa0} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:03:21.080508 ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={b2547866-a0a1-4391-8b86-6952d82efaa0} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:03:21.080508 ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={b2547866-a0a1-4391-8b86-6952d82efaa0} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:03:21.080508 ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={b2547866-a0a1-4391-8b86-6952d82efaa0} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:03:21.086452 ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={4afe423b-43e0-e9d0-82e8-ceb307940dda} aComponent={MediumWrap} aText={The object is not ready}, preserve=false aResultDetail=0
00:03:21.086452 ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={4afe423b-43e0-e9d0-82e8-ceb307940dda} aComponent={MediumWrap} aText={The object is not ready}, preserve=false aResultDetail=0
00:10:57.342513 main VirtualBox: object deletion starts
00:10:57.344625 main ERROR [COM]: aRC=VBOX_E_OBJECT_IN_USE (0x80bb000c) aIID={4afe423b-43e0-e9d0-82e8-ceb307940dda} aComponent={MediumWrap} aText={Medium 'C:\ProgramData\BOINC\slots\1\USPEX_9744165289872471\Snapshots/{91d1707a-1701-4451-b729-c9e678c1214f}.vdi' cannot be closed because it is still attached to 1 virtual machines}, preserve=false aResultDetail=0
00:10:57.344625 main ERROR [COM]: aRC=VBOX_E_OBJECT_IN_USE (0x80bb000c) aIID={4afe423b-43e0-e9d0-82e8-ceb307940dda} aComponent={MediumWrap} aText={Medium 'C:\ProgramData\BOINC\slots\1\mainimage9744165289872471.vdi' cannot be closed because it is still attached to 1 virtual machines}, preserve=false aResultDetail=0
00:10:57.344625 main ERROR [COM]: aRC=VBOX_E_OBJECT_IN_USE (0x80bb000c) aIID={4afe423b-43e0-e9d0-82e8-ceb307940dda} aComponent={MediumWrap} aText={Medium 'C:\ProgramData\BOINC\slots\1\USPEX_9744165289872471\Snapshots/{5710cc2b-db22-4063-8ed0-a7385d05404d}.vdi' cannot be closed because it is still attached to 1 virtual machines}, preserve=false aResultDetail=0
00:10:57.344625 main ERROR [COM]: aRC=VBOX_E_OBJECT_IN_USE (0x80bb000c) aIID={4afe423b-43e0-e9d0-82e8-ceb307940dda} aComponent={MediumWrap} aText={Medium 'C:\ProgramData\BOINC\slots\1\deb_port9744165289872471.vdi' cannot be closed because it is still attached to 1 virtual machines}, preserve=false aResultDetail=0
00:10:57.356747 Watcher ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={0169423f-46b4-cde9-91af-1e9d5b6cd945} aComponent={VirtualBoxWrap} aText={The object is not ready}, preserve=false aResultDetail=0
00:10:57.357717 main VirtualBox: object deleted
VM Execution Log:
VM Startup Log:
VM Trace Log:
2018-11-15 22:16:11 (9068):
Command: VBoxManage -q --version
Exit Code: -182
Output:
2018-11-15 22:20:46 (9068):
Command: VBoxManage -q --version
Exit Code: -182
Output:
2018-11-15 22:23:46 (9068):
Command: VBoxManage -q --version
Exit Code: -182
Output:
2018-11-15 22:29:31 (9068):
Command: VBoxManage -q --version
Exit Code: -182
Output:
2018-11-15 22:37:46 (9068):
Command: VBoxManage -q --version
Exit Code: -182
Output:
2018-11-15 22:45:36 (9068):
Command: VBoxManage -q --version
Exit Code: -182
Output:
2018-11-16 19:06:00 (12396): vboxwrapper (7.7.26197): starting
2018-11-16 19:06:01 (12396): Feature: Checkpoint interval offset (141 seconds)
2018-11-16 19:06:01 (12396): Detected: VirtualBox COM Interface (Version: 5.1.26)
2018-11-16 19:06:01 (12396): Detected: Minimum checkpoint interval (600.000000 seconds)
2018-11-16 19:06:01 (12396): Create VM. (boinc_39f9b3a3fc9ff494, slot#3)
2018-11-16 19:06:01 (12396): Updating drive controller type and model for desired configuration.
2018-11-16 19:06:01 (12396): Setting Memory Size for VM. (3072MB)
2018-11-16 19:06:01 (12396): Setting CPU Count for VM. (1)
2018-11-16 19:06:01 (12396): Setting Chipset Options for VM.
2018-11-16 19:06:01 (12396): Setting Boot Options for VM.
2018-11-16 19:06:01 (12396): Enabling VM Network Access.
2018-11-16 19:06:01 (12396): Setting Network Configuration for NAT.
2018-11-16 19:06:01 (12396): Disabling USB Support for VM.
2018-11-16 19:06:01 (12396): Disabling COM Port Support for VM.
2018-11-16 19:06:01 (12396): Disabling LPT Port Support for VM.
2018-11-16 19:06:01 (12396): Disabling Audio Support for VM.
2018-11-16 19:06:01 (12396): Disabling Clipboard Support for VM.
2018-11-16 19:06:01 (12396): Disabling Drag and Drop Support for VM.
2018-11-16 19:06:01 (12396): Adding storage controller(s) to VM.
2018-11-16 19:06:01 (12396): Adding virtual ISO 9660 disk drive to VM. (vm_isocontext.iso)
2018-11-16 19:06:01 (12396): Adding VirtualBox Guest Additions to VM.
2018-11-16 19:06:01 (12396): Adding network bandwidth throttle group to VM. (Defaulting to 1024GB)
2018-11-16 19:06:01 (12396): Enabling shared directory for VM.
2018-11-16 19:06:01 (12396): Starting VM. (boinc_39f9b3a3fc9ff494, slot#3)
2018-11-16 19:06:18 (12396): Successfully started VM. (PID = '7028')
2018-11-16 19:06:20 (12396): Reporting VM Process ID to BOINC.
2018-11-16 19:06:32 (12396): VM state change detected. (old = 'poweroff', new = 'running')
2018-11-16 19:06:52 (12396): VM state change detected. (old = 'running', new = 'paused')
2018-11-18 18:18:40 (12396): Preference change detected
2018-11-18 18:18:40 (12396): Setting CPU throttle for VM. (75%)
2018-11-18 18:18:40 (12396): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2018-11-18 18:18:40 (12396): VM state change detected. (old = 'paused', new = 'running')
2018-11-18 18:18:51 (12396): VM state change detected. (old = 'running', new = 'paused')
2018-11-18 18:19:01 (12396): VM state change detected. (old = 'paused', new = 'running')
2018-11-18 18:20:01 (12396): VM state change detected. (old = 'running', new = 'paused')
2018-11-18 18:20:11 (12396): VM state change detected. (old = 'paused', new = 'running')
2018-11-18 18:20:21 (12396): VM Completion File Detected.
2018-11-18 18:20:21 (12396): Powering off VM.
2018-11-18 18:20:22 (12396): Successfully stopped VM.
2018-11-18 18:20:27 (12396): Deregistering VM. (boinc_39f9b3a3fc9ff494, slot#3)
2018-11-18 18:20:27 (12396): Removing virtual disk drive(s) from VM.
2018-11-18 18:20:27 (12396): Removing network bandwidth throttle group from VM.
2018-11-18 18:20:27 (12396): Removing storage controller(s) from VM.
2018-11-18 18:20:27 (12396): Removing VM from VirtualBox.
18:20:32 (12396): called boinc_finish(0)
</stderr_txt>
]]>
©2024 COPYRIGHT 2017-2018 NCN