Task 2797606

Name	LcWNDmT6xFvnShfckohDCDFpABFKDmABFKDmpWGXDmABFKDmW0pFIn_0
Workunit	1914993
Created	8 Aug 2019, 13:57:58 UTC
Sent	8 Aug 2019, 14:05:44 UTC
Report deadline	15 Aug 2019, 14:05:44 UTC
Received	8 Aug 2019, 17:23:27 UTC
Server state	Over
Outcome	Computation error
Client state	Compute error
Exit status	194 (0x000000C2) EXIT_ABORTED_BY_CLIENT
Computer ID	3986
Run time	20 min 59 sec
CPU time	21 min 16 sec
Validate state	Invalid
Credit	0.00
Device peak FLOPS	36.18 GFLOPS
Application version	ATLAS Simulation v0.60 (vbox64_mt_mcore_atlas) windows_x86_64
Peak working set size	112.95 MB
Peak swap size	140.93 MB
Peak disk usage	1.98 GB
Stderr output

<core_client_version>7.14.2</core_client_version>
<![CDATA[
<message>
finish file present too long</message>
<stderr_txt>
2019-08-08 10:56:01 (7612): vboxwrapper (7.9.26200): starting
2019-08-08 10:56:01 (7612): Feature: Checkpoint interval offset (455 seconds)
2019-08-08 10:56:01 (7612): Detected: VirtualBox COM Interface (Version: 5.2.8)
2019-08-08 10:56:01 (7612): Detected: Minimum checkpoint interval (900.000000 seconds)
2019-08-08 10:56:01 (7612): Successfully copied 'init_data.xml' to the shared directory.
2019-08-08 10:56:01 (7612): Create VM. (boinc_f7ff39bc4494e8f3, slot#0)
2019-08-08 10:56:01 (7612): Setting Memory Size for VM. (10200MB)
2019-08-08 10:56:01 (7612): Setting CPU Count for VM. (8)
2019-08-08 10:56:01 (7612): Setting Chipset Options for VM.
2019-08-08 10:56:01 (7612): Setting Boot Options for VM.
2019-08-08 10:56:01 (7612): Enabling VM Network Access.
2019-08-08 10:56:01 (7612): Setting Network Configuration for NAT.
2019-08-08 10:56:01 (7612): Disabling USB Support for VM.
2019-08-08 10:56:01 (7612): Disabling COM Port Support for VM.
2019-08-08 10:56:01 (7612): Disabling LPT Port Support for VM.
2019-08-08 10:56:01 (7612): Disabling Audio Support for VM.
2019-08-08 10:56:01 (7612): Disabling Clipboard Support for VM.
2019-08-08 10:56:01 (7612): Disabling Drag and Drop Support for VM.
2019-08-08 10:56:01 (7612): Adding storage controller(s) to VM.
2019-08-08 10:56:01 (7612): Adding virtual disk drive to VM. (vm_image.vdi)
2019-08-08 10:56:02 (7612): Adding VirtualBox Guest Additions to VM.
2019-08-08 10:56:02 (7612): Adding network bandwidth throttle group to VM. (Defaulting to 1024GB)
2019-08-08 10:56:02 (7612): forwarding host port 56413 to guest port 80
2019-08-08 10:56:02 (7612): Enabling remote desktop for VM.
2019-08-08 10:56:02 (7612): Required extension pack not installed, remote desktop not enabled.
2019-08-08 10:56:02 (7612): Enabling shared directory for VM.
2019-08-08 10:56:02 (7612): Starting VM. (boinc_f7ff39bc4494e8f3, slot#0)
2019-08-08 10:56:11 (7612): Guest Log: BIOS: VirtualBox 5.2.8

2019-08-08 10:56:11 (7612): Guest Log: CPUID EDX: 0x178bfbff

2019-08-08 10:56:11 (7612): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63

2019-08-08 10:56:11 (7612): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032

2019-08-08 10:56:11 (7612): Guest Log: BIOS: Booting from Hard Disk...

2019-08-08 10:56:11 (7612): Guest Log: BIOS: KBD: unsupported int 16h function 03

2019-08-08 10:56:11 (7612): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 

2019-08-08 10:56:11 (7612): Successfully started VM. (PID = '8040')
2019-08-08 10:56:11 (7612): Reporting VM Process ID to BOINC.
2019-08-08 10:56:16 (7612): VM state change detected. (old = 'poweroff', new = 'running')
2019-08-08 10:56:21 (7612): Detected: Web Application Enabled (http://localhost:56413)
2019-08-08 10:56:26 (7612): Preference change detected
2019-08-08 10:56:26 (7612): Setting CPU throttle for VM. (100%)
2019-08-08 10:56:26 (7612): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 300 seconds) or (Vbox_job.xml: 900 seconds))
2019-08-08 10:56:51 (7612): Guest Log: vboxguest: major 0, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)

2019-08-08 10:57:31 (7612): Guest Log: VBoxGuest: VBoxGuestCommonGuestCapsAcquire: pSession(0xffff88028765ea10), OR(0x0), NOT(0xffffffff), flags(0x0)

2019-08-08 10:57:31 (7612): Guest Log: VBoxGuest: VBoxGuestCommonGuestCapsAcquire: pSession(0xffff88028765ec10), OR(0x0), NOT(0xffffffff), flags(0x0)

2019-08-08 10:57:31 (7612): Guest Log: VBoxGuest: VBoxGuestCommonGuestCapsAcquire: pSession(0xffff880288e64a10), OR(0x0), NOT(0xffffffff), flags(0x0)

2019-08-08 10:57:31 (7612): Guest Log: VBoxGuest: VBoxGuestCommonGuestCapsAcquire: pSession(0xffff88028a213a10), OR(0x0), NOT(0xffffffff), flags(0x0)

2019-08-08 10:58:06 (7612): Guest Log: Copying input files into RunAtlas.

2019-08-08 10:58:21 (7612): Guest Log: Copied input files into RunAtlas.

2019-08-08 10:58:46 (7612): Guest Log: copied the webapp to /var/www

2019-08-08 10:58:46 (7612): Guest Log: This vm does not need to setup http proxy

2019-08-08 10:58:46 (7612): Guest Log: ATHENA_PROC_NUMBER=8

2019-08-08 10:58:46 (7612): Guest Log: Starting ATLAS job. (PandaID=4437383278 taskID=18604976)

2019-08-08 11:19:01 (7612): VM state change detected. (old = 'running', new = 'aborted')
2019-08-08 11:19:01 (7612): Powering off VM.
2019-08-08 11:19:01 (7612): Deregistering VM. (boinc_f7ff39bc4494e8f3, slot#0)
2019-08-08 11:19:01 (7612): Removing virtual disk drive(s) from VM.
2019-08-08 11:19:01 (7612): Removing network bandwidth throttle group from VM.
2019-08-08 11:19:01 (7612): Removing storage controller(s) from VM.
2019-08-08 11:19:01 (7612): Removing VM from VirtualBox.
2019-08-08 11:19:06 (7612): VM Premature Shutdown Detected.
11:19:09 (7612): BOINC client no longer exists - exiting
11:19:09 (7612): timer handler: client dead, exiting

    Hypervisor System Log:

07:46:09.050525          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={85cd948e-a71f-4289-281e-0ca7ad48cd89} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
07:46:09.050525          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={85cd948e-a71f-4289-281e-0ca7ad48cd89} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
07:46:09.050525          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={85cd948e-a71f-4289-281e-0ca7ad48cd89} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
07:46:09.050525          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={85cd948e-a71f-4289-281e-0ca7ad48cd89} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
07:46:09.050525          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={85cd948e-a71f-4289-281e-0ca7ad48cd89} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
07:46:09.050525          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={85cd948e-a71f-4289-281e-0ca7ad48cd89} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
07:46:09.050525          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={85cd948e-a71f-4289-281e-0ca7ad48cd89} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
07:46:09.050525          Saving settings file "C:\Program Files\Boinc Data\slots\0\boinc_f7ff39bc4494e8f3\boinc_f7ff39bc4494e8f3.vbox" with version "1.16-windows"
07:46:09.066140          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={85cd948e-a71f-4289-281e-0ca7ad48cd89} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
07:46:09.066140          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={85cd948e-a71f-4289-281e-0ca7ad48cd89} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
07:46:09.066140          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={85cd948e-a71f-4289-281e-0ca7ad48cd89} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
07:46:09.066140          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={85cd948e-a71f-4289-281e-0ca7ad48cd89} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
07:46:09.066140          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={85cd948e-a71f-4289-281e-0ca7ad48cd89} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
07:46:09.066140          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={85cd948e-a71f-4289-281e-0ca7ad48cd89} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
07:46:09.066140          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={85cd948e-a71f-4289-281e-0ca7ad48cd89} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
07:46:09.066140          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={85cd948e-a71f-4289-281e-0ca7ad48cd89} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
07:46:09.066140          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={85cd948e-a71f-4289-281e-0ca7ad48cd89} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
07:46:09.066140          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={85cd948e-a71f-4289-281e-0ca7ad48cd89} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
07:46:09.066140          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={85cd948e-a71f-4289-281e-0ca7ad48cd89} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
07:46:09.066140          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={85cd948e-a71f-4289-281e-0ca7ad48cd89} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
07:46:09.066140          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={85cd948e-a71f-4289-281e-0ca7ad48cd89} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
07:46:09.066140          Saving settings file "C:\Program Files\Boinc Data\slots\0\boinc_f7ff39bc4494e8f3\boinc_f7ff39bc4494e8f3.vbox" with version "1.16-windows"
07:46:09.066140          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={85cd948e-a71f-4289-281e-0ca7ad48cd89} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
07:46:09.066140          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={85cd948e-a71f-4289-281e-0ca7ad48cd89} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
07:46:09.066140          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={85cd948e-a71f-4289-281e-0ca7ad48cd89} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
07:46:09.066140          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={85cd948e-a71f-4289-281e-0ca7ad48cd89} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
07:46:09.066140          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={85cd948e-a71f-4289-281e-0ca7ad48cd89} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
07:46:09.066140          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={85cd948e-a71f-4289-281e-0ca7ad48cd89} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
07:46:09.066140          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={85cd948e-a71f-4289-281e-0ca7ad48cd89} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
07:46:09.066140          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={85cd948e-a71f-4289-281e-0ca7ad48cd89} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
07:46:09.066140          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={85cd948e-a71f-4289-281e-0ca7ad48cd89} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
07:46:09.066140          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={85cd948e-a71f-4289-281e-0ca7ad48cd89} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
07:46:09.066140          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={85cd948e-a71f-4289-281e-0ca7ad48cd89} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
07:46:09.066140          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={85cd948e-a71f-4289-281e-0ca7ad48cd89} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
07:46:09.066140          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={85cd948e-a71f-4289-281e-0ca7ad48cd89} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
07:46:09.066140          Saving settings file "C:\Program Files\Boinc Data\slots\0\boinc_f7ff39bc4494e8f3\boinc_f7ff39bc4494e8f3.vbox" with version "1.16-windows"
07:46:09.081774          Saving settings file "C:\Users\Hewitt Smith\.VirtualBox\VirtualBox.xml" with version "1.12-windows"
07:46:09.081774          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={4afe423b-43e0-e9d0-82e8-ceb307940dda} aComponent={MediumWrap} aText={The object is not ready}, preserve=false aResultDetail=0
07:46:09.081774          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={4afe423b-43e0-e9d0-82e8-ceb307940dda} aComponent={MediumWrap} aText={The object is not ready}, preserve=false aResultDetail=0

    VM Execution Log:


    VM Startup Log:


    VM Trace Log:

11:19:11 (7612): called boinc_finish(194)
2019-08-08 11:22:04 (10852): vboxwrapper (7.9.26200): starting
2019-08-08 11:22:05 (10852): Feature: Checkpoint interval offset (49 seconds)
2019-08-08 11:22:05 (10852): Detected: VirtualBox COM Interface (Version: 5.2.8)
2019-08-08 11:22:05 (10852): Detected: Minimum checkpoint interval (900.000000 seconds)
2019-08-08 11:22:05 (10852): Create VM. (boinc_f7ff39bc4494e8f3, slot#0)
2019-08-08 11:22:05 (10852): Setting Memory Size for VM. (10200MB)
2019-08-08 11:22:05 (10852): Setting CPU Count for VM. (8)
2019-08-08 11:22:05 (10852): Setting Chipset Options for VM.
2019-08-08 11:22:05 (10852): Setting Boot Options for VM.
2019-08-08 11:22:05 (10852): Enabling VM Network Access.
2019-08-08 11:22:05 (10852): Setting Network Configuration for NAT.
2019-08-08 11:22:05 (10852): Disabling USB Support for VM.
2019-08-08 11:22:05 (10852): Disabling COM Port Support for VM.
2019-08-08 11:22:05 (10852): Disabling LPT Port Support for VM.
2019-08-08 11:22:05 (10852): Disabling Audio Support for VM.
2019-08-08 11:22:05 (10852): Disabling Clipboard Support for VM.
2019-08-08 11:22:05 (10852): Disabling Drag and Drop Support for VM.
2019-08-08 11:22:05 (10852): Adding storage controller(s) to VM.
2019-08-08 11:22:05 (10852): Adding virtual disk drive to VM. (vm_image.vdi)
2019-08-08 11:22:05 (10852): Adding VirtualBox Guest Additions to VM.
2019-08-08 11:22:05 (10852): Adding network bandwidth throttle group to VM. (Defaulting to 1024GB)
2019-08-08 11:22:05 (10852): forwarding host port 56413 to guest port 80
2019-08-08 11:22:05 (10852): Enabling remote desktop for VM.
2019-08-08 11:22:05 (10852): Required extension pack not installed, remote desktop not enabled.
2019-08-08 11:22:05 (10852): Enabling shared directory for VM.
2019-08-08 11:22:05 (10852): Starting VM. (boinc_f7ff39bc4494e8f3, slot#0)
2019-08-08 11:22:13 (10852): Guest Log: BIOS: VirtualBox 5.2.8

2019-08-08 11:22:13 (10852): Guest Log: CPUID EDX: 0x178bfbff

2019-08-08 11:22:13 (10852): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63

2019-08-08 11:22:13 (10852): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032

2019-08-08 11:22:13 (10852): Guest Log: BIOS: Booting from Hard Disk...

2019-08-08 11:22:13 (10852): Guest Log: BIOS: KBD: unsupported int 16h function 03

2019-08-08 11:22:13 (10852): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 

2019-08-08 11:22:13 (10852): Successfully started VM. (PID = '11116')
2019-08-08 11:22:13 (10852): Reporting VM Process ID to BOINC.
2019-08-08 11:22:18 (10852): VM state change detected. (old = 'poweroff', new = 'running')
2019-08-08 11:22:23 (10852): Detected: Web Application Enabled (http://localhost:56413)
2019-08-08 11:22:28 (10852): Powering off VM.
2019-08-08 11:22:29 (10852): Successfully stopped VM.
2019-08-08 11:22:34 (10852): Deregistering VM. (boinc_f7ff39bc4494e8f3, slot#0)
2019-08-08 11:22:34 (10852): Removing virtual disk drive(s) from VM.
2019-08-08 11:22:34 (10852): Removing network bandwidth throttle group from VM.
2019-08-08 11:22:34 (10852): Removing storage controller(s) from VM.
2019-08-08 11:22:34 (10852): Removing VM from VirtualBox.

</stderr_txt>
]]>
Development for LHC@home

Stderr output
