Task 6511351

Name	07530320_044_1
Workunit	5317458
Created	16 Oct 2019, 17:31:01 UTC
Sent	16 Oct 2019, 17:33:44 UTC
Report deadline	21 Oct 2019, 17:33:44 UTC
Received	16 Oct 2019, 19:20:29 UTC
Server state	Over
Outcome	Computation error
Client state	Compute error
Exit status	194 (0x000000C2) EXIT_ABORTED_BY_CLIENT
Computer ID	3201
Run time	14 sec
CPU time
Validate state	Invalid
Credit	0.00
Device peak FLOPS	2.92 GFLOPS
Application version	boinc2docker v1.12 (vbox64_mt) windows_x86_64
Peak working set size	8.41 MB
Peak swap size	4.63 MB
Peak disk usage	230.60 MB
Stderr output

<core_client_version>7.6.33</core_client_version>
<![CDATA[
<message>
finish file present too long
</message>
<stderr_txt>
2019-10-16 20:24:35 (2280): vboxwrapper (7.9.26200): starting
2019-10-16 20:24:35 (2280): Feature: Checkpoint interval offset (137 seconds)
2019-10-16 20:24:35 (2280): Detected: VirtualBox COM Interface (Version: 5.1.14)
2019-10-16 20:24:35 (2280): Detected: Minimum checkpoint interval (600.000000 seconds)
2019-10-16 20:24:35 (2280): Create VM. (boinc_a2dee945b4ec0073, slot#1)
2019-10-16 20:24:35 (2280): Updating drive controller type and model for desired configuration.
2019-10-16 20:24:35 (2280): Setting Memory Size for VM. (3072MB)
2019-10-16 20:24:35 (2280): Setting CPU Count for VM. (1)
2019-10-16 20:24:35 (2280): Setting Chipset Options for VM.
2019-10-16 20:24:35 (2280): Setting Boot Options for VM.
2019-10-16 20:24:35 (2280): Enabling VM Network Access.
2019-10-16 20:24:35 (2280): Setting Network Configuration for NAT.
2019-10-16 20:24:35 (2280): Disabling USB Support for VM.
2019-10-16 20:24:35 (2280): Disabling COM Port Support for VM.
2019-10-16 20:24:35 (2280): Disabling LPT Port Support for VM.
2019-10-16 20:24:35 (2280): Disabling Audio Support for VM.
2019-10-16 20:24:35 (2280): Disabling Clipboard Support for VM.
2019-10-16 20:24:35 (2280): Disabling Drag and Drop Support for VM.
2019-10-16 20:24:35 (2280): Adding storage controller(s) to VM.
2019-10-16 20:24:35 (2280): Adding virtual ISO 9660 disk drive to VM. (vm_isocontext.iso)
2019-10-16 20:24:35 (2280): Adding VirtualBox Guest Additions to VM.
2019-10-16 20:24:35 (2280): Error 0x80bb0001 in vbox51::VBOX_VM::create_vm (c:\users\david\documents\boinc_git\boinc\samples\vboxwrapper\vbox_mscom_impl.cpp:643)
2019-10-16 20:24:35 (2280): Error Source     : VirtualBoxWrap
2019-10-16 20:24:35 (2280): Error Description: Cannot register the DVD image 'C:\Program Files\Oracle\VirtualBox/VBoxGuestAdditions.iso' {abdc8fad-e48c-48e9-97af-f12bb4f6af80} because a CD/DVD image 'C:\Program Files\Oracle\VirtualBox/VBoxGuestAdditions.iso' with UUID {0794489d-d898-46dc-8bbb-21363b206857} already exists
2019-10-16 20:24:36 (2280): Could not create VM
2019-10-16 20:24:36 (2280): Powering off VM.
2019-10-16 20:24:36 (2280): Deregistering VM. (boinc_a2dee945b4ec0073, slot#1)
2019-10-16 20:24:36 (2280): Removing virtual disk drive(s) from VM.
2019-10-16 20:24:36 (2280): Removing network bandwidth throttle group from VM.
2019-10-16 20:24:36 (2280): Removing storage controller(s) from VM.
2019-10-16 20:24:36 (2280): Removing VM from VirtualBox.

    Hypervisor System Log:

03:24:21.233721          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={b2547866-a0a1-4391-8b86-6952d82efaa0} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
03:24:21.233721          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={b2547866-a0a1-4391-8b86-6952d82efaa0} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
03:24:21.233721          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={b2547866-a0a1-4391-8b86-6952d82efaa0} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
03:24:21.233721          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={b2547866-a0a1-4391-8b86-6952d82efaa0} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
03:24:21.233721          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={b2547866-a0a1-4391-8b86-6952d82efaa0} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
03:24:21.890000          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={b2547866-a0a1-4391-8b86-6952d82efaa0} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
03:24:21.890000          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={b2547866-a0a1-4391-8b86-6952d82efaa0} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
03:24:21.890000          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={b2547866-a0a1-4391-8b86-6952d82efaa0} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
03:24:21.890000          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={b2547866-a0a1-4391-8b86-6952d82efaa0} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
03:24:21.890000          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={b2547866-a0a1-4391-8b86-6952d82efaa0} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
03:24:21.890000          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={b2547866-a0a1-4391-8b86-6952d82efaa0} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
03:24:21.890000          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={b2547866-a0a1-4391-8b86-6952d82efaa0} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
03:24:21.890000          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
03:24:21.905630          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={b2547866-a0a1-4391-8b86-6952d82efaa0} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
03:24:21.905630          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={b2547866-a0a1-4391-8b86-6952d82efaa0} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
03:24:21.905630          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={b2547866-a0a1-4391-8b86-6952d82efaa0} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
03:24:21.905630          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={b2547866-a0a1-4391-8b86-6952d82efaa0} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
03:24:21.905630          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={b2547866-a0a1-4391-8b86-6952d82efaa0} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
03:24:21.905630          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={b2547866-a0a1-4391-8b86-6952d82efaa0} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
03:24:21.905630          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={b2547866-a0a1-4391-8b86-6952d82efaa0} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
03:24:21.905630          ERROR [COM]: aRC=VBOX_E_OBJECT_NOT_FOUND (0x80bb0001) aIID={48c7f4c0-c9d6-4742-957c-a6fd52e8c4ae} aComponent={BandwidthControlWrap} aText={Could not find a bandwidth group named 'boinc_a2dee945b4ec0073_net'}, preserve=false aResultDetail=0
03:24:22.124404          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={b2547866-a0a1-4391-8b86-6952d82efaa0} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
03:24:22.124404          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={b2547866-a0a1-4391-8b86-6952d82efaa0} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
03:24:22.124404          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={b2547866-a0a1-4391-8b86-6952d82efaa0} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
03:24:22.124404          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={b2547866-a0a1-4391-8b86-6952d82efaa0} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
03:24:22.124404          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={b2547866-a0a1-4391-8b86-6952d82efaa0} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
03:24:22.124404          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={b2547866-a0a1-4391-8b86-6952d82efaa0} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
03:24:22.124404          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={b2547866-a0a1-4391-8b86-6952d82efaa0} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
03:24:22.249415          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={4afe423b-43e0-e9d0-82e8-ceb307940dda} aComponent={MediumWrap} aText={The object is not ready}, preserve=false aResultDetail=0
03:24:31.737012          ERROR [COM]: aRC=VBOX_E_INVALID_OBJECT_STATE (0x80bb0007) aIID={b2547866-a0a1-4391-8b86-6952d82efaa0} aComponent={MachineWrap} aText={The given session is busy}, preserve=false aResultDetail=0
03:24:31.737991          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={b2547866-a0a1-4391-8b86-6952d82efaa0} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
03:24:31.737991          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={b2547866-a0a1-4391-8b86-6952d82efaa0} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
03:24:31.737991          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={b2547866-a0a1-4391-8b86-6952d82efaa0} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
03:24:31.737991          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={b2547866-a0a1-4391-8b86-6952d82efaa0} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
03:24:31.737991          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={b2547866-a0a1-4391-8b86-6952d82efaa0} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
03:24:31.737991          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={b2547866-a0a1-4391-8b86-6952d82efaa0} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
03:24:31.737991          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={b2547866-a0a1-4391-8b86-6952d82efaa0} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0

    VM Execution Log:


    VM Startup Log:


    VM Trace Log:

20:24:46 (2280): called boinc_finish(-2135228415)
2019-10-16 20:27:51 (8936): vboxwrapper (7.9.26200): starting
2019-10-16 20:27:51 (8936): Feature: Checkpoint interval offset (535 seconds)
2019-10-16 20:27:51 (8936): Detected: VirtualBox COM Interface (Version: 5.1.14)
2019-10-16 20:27:51 (8936): Detected: Minimum checkpoint interval (600.000000 seconds)
2019-10-16 20:27:51 (8936): Create VM. (boinc_a2dee945b4ec0073, slot#1)
2019-10-16 20:27:51 (8936): Updating drive controller type and model for desired configuration.
2019-10-16 20:27:51 (8936): Setting Memory Size for VM. (3072MB)
2019-10-16 20:27:51 (8936): Setting CPU Count for VM. (1)
2019-10-16 20:27:51 (8936): Setting Chipset Options for VM.
2019-10-16 20:27:51 (8936): Setting Boot Options for VM.
2019-10-16 20:27:51 (8936): Enabling VM Network Access.
2019-10-16 20:27:51 (8936): Setting Network Configuration for NAT.
2019-10-16 20:27:51 (8936): Disabling USB Support for VM.
2019-10-16 20:27:51 (8936): Disabling COM Port Support for VM.
2019-10-16 20:27:51 (8936): Disabling LPT Port Support for VM.
2019-10-16 20:27:51 (8936): Disabling Audio Support for VM.
2019-10-16 20:27:51 (8936): Disabling Clipboard Support for VM.
2019-10-16 20:27:51 (8936): Disabling Drag and Drop Support for VM.
2019-10-16 20:27:51 (8936): Adding storage controller(s) to VM.
2019-10-16 20:27:51 (8936): Adding virtual ISO 9660 disk drive to VM. (vm_isocontext.iso)
2019-10-16 20:27:51 (8936): Adding VirtualBox Guest Additions to VM.
2019-10-16 20:27:51 (8936): Adding network bandwidth throttle group to VM. (Defaulting to 1024GB)
2019-10-16 20:27:51 (8936): Enabling shared directory for VM.
2019-10-16 20:27:51 (8936): Starting VM. (boinc_a2dee945b4ec0073, slot#1)
2019-10-16 20:28:01 (8936): Guest Log: BIOS: VirtualBox 5.1.14

2019-10-16 20:28:01 (8936): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032

2019-10-16 20:28:01 (8936): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=80

2019-10-16 20:28:01 (8936): Guest Log: BIOS: Boot from Hard Disk 0 failed

2019-10-16 20:28:01 (8936): Guest Log: BIOS: Boot : bseqnr=2, bootseq=0003

2019-10-16 20:28:01 (8936): Guest Log: BIOS: Booting from CD-ROM...

2019-10-16 20:28:01 (8936): Successfully started VM. (PID = '3268')
2019-10-16 20:28:01 (8936): Reporting VM Process ID to BOINC.
2019-10-16 20:28:06 (8936): Guest Log: BIOS: KBD: unsupported int 16h function 03

2019-10-16 20:28:06 (8936): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 

2019-10-16 20:28:06 (8936): VM state change detected. (old = 'poweroff', new = 'running')
2019-10-16 20:28:17 (8936): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds

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

2019-10-16 20:28:17 (8936): Guest Log: net.ipv4.ip_forward = 1

2019-10-16 20:28:17 (8936): Guest Log: sysctl: cannot stat /proc/sys/net/ipv6/conf/all/forwarding: No such file or directory

2019-10-16 20:28:17 (8936): Guest Log: sysctl: setting key "cannot stat %s": No such file or directory

2019-10-16 20:28:17 (8936): Guest Log: sysctl: "cannot stat %s" is an unknown key

2019-10-16 20:28:17 (8936): Guest Log: sysctl: setting key "cannot stat %s": No such file or directory

2019-10-16 20:28:17 (8936): Guest Log: Segmentation fault

2019-10-16 20:28:17 (8936): Guest Log: automount ...

2019-10-16 20:28:17 (8936): Guest Log: Is the disk unpartitioned?, test for the 'boot2docker format-me' string

2019-10-16 20:28:17 (8936): Guest Log: automount over.

2019-10-16 20:28:17 (8936): Guest Log: [1;32mSetting hostname to [1;35mboot2docker[0;39m [1;32mDone.[0;39m

2019-10-16 20:28:17 (8936): Guest Log: Wed Oct 16 20:28:13 UTC 2019 dhcp -------------------------------

2019-10-16 20:28:17 (8936): Powering off VM.
2019-10-16 20:28:18 (8936): Successfully stopped VM.
2019-10-16 20:28:23 (8936): Deregistering VM. (boinc_a2dee945b4ec0073, slot#1)
2019-10-16 20:28:23 (8936): Removing virtual disk drive(s) from VM.
2019-10-16 20:28:23 (8936): Removing network bandwidth throttle group from VM.
2019-10-16 20:28:23 (8936): Removing storage controller(s) from VM.
2019-10-16 20:28:23 (8936): Removing VM from VirtualBox.

</stderr_txt>
]]>