Task 2801841

Name	iQ7NDmzf5IvnShfckohDCDFpABFKDmABFKDmC5vKDmABFKDmeiXKOo_2
Workunit	1918260
Created	18 Aug 2019, 5:44:18 UTC
Sent	18 Aug 2019, 10:55:49 UTC
Report deadline	25 Aug 2019, 10:55:49 UTC
Received	19 Aug 2019, 17:23:51 UTC
Server state	Over
Outcome	Computation error
Client state	Compute error
Exit status	194 (0x000000C2) EXIT_ABORTED_BY_CLIENT
Computer ID	3886
Run time	1 hours 36 min 48 sec
CPU time	2 hours 55 min 8 sec
Validate state	Invalid
Credit	0.00
Device peak FLOPS	5.28 GFLOPS
Application version	ATLAS Simulation v0.60 (vbox64_mt_mcore_atlas) windows_x86_64
Peak working set size	95.96 MB
Peak swap size	130.95 MB
Peak disk usage	5.40 GB
Stderr output

<core_client_version>7.14.2</core_client_version>
<![CDATA[
<message>
finish file present too long</message>
<stderr_txt>
2019-08-18 13:47:00 (6676): vboxwrapper (7.9.26200): starting
2019-08-18 13:47:02 (6676): Feature: Checkpoint interval offset (399 seconds)
2019-08-18 13:47:02 (6676): Detected: VirtualBox COM Interface (Version: 5.2.30)
2019-08-18 13:47:02 (6676): Detected: Minimum checkpoint interval (900.000000 seconds)
2019-08-18 13:47:02 (6676): Successfully copied 'init_data.xml' to the shared directory.
2019-08-18 13:47:03 (6676): Create VM. (boinc_20f84a6872483073, slot#3)
2019-08-18 13:47:03 (6676): Setting Memory Size for VM. (4800MB)
2019-08-18 13:47:03 (6676): Setting CPU Count for VM. (2)
2019-08-18 13:47:03 (6676): Setting Chipset Options for VM.
2019-08-18 13:47:03 (6676): Setting Boot Options for VM.
2019-08-18 13:47:03 (6676): Enabling VM Network Access.
2019-08-18 13:47:03 (6676): Setting Network Configuration for NAT.
2019-08-18 13:47:03 (6676): Disabling USB Support for VM.
2019-08-18 13:47:03 (6676): Disabling COM Port Support for VM.
2019-08-18 13:47:03 (6676): Disabling LPT Port Support for VM.
2019-08-18 13:47:03 (6676): Disabling Audio Support for VM.
2019-08-18 13:47:03 (6676): Disabling Clipboard Support for VM.
2019-08-18 13:47:03 (6676): Disabling Drag and Drop Support for VM.
2019-08-18 13:47:03 (6676): Adding storage controller(s) to VM.
2019-08-18 13:47:03 (6676): Adding virtual disk drive to VM. (vm_image.vdi)
2019-08-18 13:47:03 (6676): Adding VirtualBox Guest Additions to VM.
2019-08-18 13:47:03 (6676): Adding network bandwidth throttle group to VM. (Defaulting to 1024GB)
2019-08-18 13:47:03 (6676): forwarding host port 49754 to guest port 80
2019-08-18 13:47:03 (6676): Enabling remote desktop for VM.
2019-08-18 13:47:03 (6676): Enabling shared directory for VM.
2019-08-18 13:47:03 (6676): Starting VM. (boinc_20f84a6872483073, slot#3)
2019-08-18 13:47:20 (6676): Guest Log: BIOS: VirtualBox 5.2.30

2019-08-18 13:47:20 (6676): Guest Log: CPUID EDX: 0x178bfbff

2019-08-18 13:47:20 (6676): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63

2019-08-18 13:47:20 (6676): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032

2019-08-18 13:47:20 (6676): Guest Log: BIOS: Booting from Hard Disk...

2019-08-18 13:47:20 (6676): Successfully started VM. (PID = '7464')
2019-08-18 13:47:20 (6676): Reporting VM Process ID to BOINC.
2019-08-18 13:47:25 (6676): Guest Log: BIOS: KBD: unsupported int 16h function 03

2019-08-18 13:47:25 (6676): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 

2019-08-18 13:47:25 (6676): VM state change detected. (old = 'poweroff', new = 'running')
2019-08-18 13:47:30 (6676): Detected: Web Application Enabled (http://localhost:49754)
2019-08-18 13:47:30 (6676): Detected: Remote Desktop Enabled (localhost:49755)
2019-08-18 13:47:35 (6676): Preference change detected
2019-08-18 13:47:35 (6676): Setting CPU throttle for VM. (100%)
2019-08-18 13:47:35 (6676): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 900 seconds))
2019-08-18 13:48:00 (6676): Guest Log: vboxguest: major 0, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)

2019-08-18 13:48:25 (6676): Guest Log: VBoxGuest: VBoxGuestCommonGuestCapsAcquire: pSession(0xffff88013d797210), OR(0x0), NOT(0xffffffff), flags(0x0)

2019-08-18 13:48:25 (6676): Guest Log: VBoxGuest: VBoxGuestCommonGuestCapsAcquire: pSession(0xffff88013d720a10), OR(0x0), NOT(0xffffffff), flags(0x0)

2019-08-18 13:48:25 (6676): Guest Log: VBoxGuest: VBoxGuestCommonGuestCapsAcquire: pSession(0xffff880143c79210), OR(0x0), NOT(0xffffffff), flags(0x0)

2019-08-18 13:48:26 (6676): Guest Log: VBoxGuest: VBoxGuestCommonGuestCapsAcquire: pSession(0xffff88013fd52210), OR(0x0), NOT(0xffffffff), flags(0x0)

2019-08-18 13:50:16 (6676): Guest Log: Copying input files into RunAtlas.

2019-08-18 13:50:26 (6676): Guest Log: Copied input files into RunAtlas.

2019-08-18 13:50:41 (6676): Guest Log: copied the webapp to /var/www

2019-08-18 13:50:41 (6676): Guest Log: This vm does not need to setup http proxy

2019-08-18 13:50:41 (6676): Guest Log: ATHENA_PROC_NUMBER=2

2019-08-18 13:50:41 (6676): Guest Log: Starting ATLAS job. (PandaID=4449203541 taskID=18722144)

2019-08-18 13:56:28 (6676): Stopping VM.
2019-08-18 13:56:48 (6676): Successfully stopped VM.
2019-08-18 13:59:54 (7392): vboxwrapper (7.9.26200): starting
2019-08-18 13:59:54 (7392): Feature: Checkpoint interval offset (442 seconds)
2019-08-18 13:59:54 (7392): Detected: VirtualBox COM Interface (Version: 5.2.30)
2019-08-18 13:59:54 (7392): Detected: Minimum checkpoint interval (900.000000 seconds)
2019-08-18 13:59:54 (7392): Guest Log: BIOS: VirtualBox 5.2.30

2019-08-18 13:59:54 (7392): Guest Log: CPUID EDX: 0x178bfbff

2019-08-18 13:59:54 (7392): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63

2019-08-18 13:59:54 (7392): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032

2019-08-18 13:59:54 (7392): Guest Log: BIOS: Booting from Hard Disk...

2019-08-18 13:59:54 (7392): Guest Log: BIOS: KBD: unsupported int 16h function 03

2019-08-18 13:59:54 (7392): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 

2019-08-18 13:59:54 (7392): Guest Log: vboxguest: major 0, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)

2019-08-18 13:59:54 (7392): Guest Log: VBoxGuest: VBoxGuestCommonGuestCapsAcquire: pSession(0xffff88013d797210), OR(0x0), NOT(0xffffffff), flags(0x0)

2019-08-18 13:59:54 (7392): Guest Log: VBoxGuest: VBoxGuestCommonGuestCapsAcquire: pSession(0xffff88013d720a10), OR(0x0), NOT(0xffffffff), flags(0x0)

2019-08-18 13:59:54 (7392): Guest Log: VBoxGuest: VBoxGuestCommonGuestCapsAcquire: pSession(0xffff880143c79210), OR(0x0), NOT(0xffffffff), flags(0x0)

2019-08-18 13:59:54 (7392): Guest Log: VBoxGuest: VBoxGuestCommonGuestCapsAcquire: pSession(0xffff88013fd52210), OR(0x0), NOT(0xffffffff), flags(0x0)

2019-08-18 13:59:54 (7392): Guest Log: Copying input files into RunAtlas.

2019-08-18 13:59:54 (7392): Guest Log: Copied input files into RunAtlas.

2019-08-18 13:59:54 (7392): Guest Log: copied the webapp to /var/www

2019-08-18 13:59:54 (7392): Guest Log: This vm does not need to setup http proxy

2019-08-18 13:59:54 (7392): Guest Log: ATHENA_PROC_NUMBER=2

2019-08-18 13:59:54 (7392): Guest Log: Starting ATLAS job. (PandaID=4449203541 taskID=18722144)

2019-08-18 13:59:54 (7392): Starting VM. (boinc_20f84a6872483073, slot#3)
2019-08-18 14:00:18 (7392): Successfully started VM. (PID = '1684')
2019-08-18 14:00:18 (7392): Reporting VM Process ID to BOINC.
2019-08-18 14:00:23 (7392): VM state change detected. (old = 'poweroff', new = 'running')
2019-08-18 14:00:28 (7392): Detected: Web Application Enabled (http://localhost:49754)
2019-08-18 14:00:28 (7392): Detected: Remote Desktop Enabled (localhost:49755)
2019-08-18 14:00:33 (7392): Preference change detected
2019-08-18 14:00:33 (7392): Setting CPU throttle for VM. (100%)
2019-08-18 14:00:33 (7392): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 900 seconds))
2019-08-18 14:03:04 (7392): Stopping VM.
2019-08-18 14:03:24 (7392): Successfully stopped VM.
2019-08-18 14:08:35 (9040): vboxwrapper (7.9.26200): starting
2019-08-18 14:08:39 (9040): Feature: Checkpoint interval offset (541 seconds)
2019-08-18 14:08:39 (9040): Detected: VirtualBox COM Interface (Version: 5.2.30)
2019-08-18 14:08:39 (9040): Detected: Minimum checkpoint interval (900.000000 seconds)
2019-08-18 14:08:39 (9040): Starting VM. (boinc_20f84a6872483073, slot#3)
2019-08-18 14:09:51 (9040): Successfully started VM. (PID = '4632')
2019-08-18 14:09:51 (9040): Reporting VM Process ID to BOINC.
2019-08-18 14:09:57 (9040): VM state change detected. (old = 'poweroff', new = 'running')
2019-08-18 14:10:03 (9040): Detected: Web Application Enabled (http://localhost:49754)
2019-08-18 14:10:03 (9040): Detected: Remote Desktop Enabled (localhost:49755)
2019-08-18 14:10:10 (9040): Preference change detected
2019-08-18 14:10:10 (9040): Setting CPU throttle for VM. (100%)
2019-08-18 14:10:22 (9040): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 900 seconds))
2019-08-18 14:14:45 (9040): Stopping VM.
2019-08-18 14:20:12 (5196): vboxwrapper (7.9.26200): starting
2019-08-18 14:20:12 (5196): Feature: Checkpoint interval offset (311 seconds)
2019-08-18 14:20:12 (5196): Detected: VirtualBox COM Interface (Version: 5.2.30)
2019-08-18 14:20:12 (5196): Detected: Minimum checkpoint interval (900.000000 seconds)
2019-08-18 14:20:12 (5196): Starting VM. (boinc_20f84a6872483073, slot#3)
2019-08-18 14:20:26 (5196): Guest Log: BIOS: VirtualBox 5.2.30

2019-08-18 14:20:26 (5196): Guest Log: CPUID EDX: 0x178bfbff

2019-08-18 14:20:26 (5196): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63

2019-08-18 14:20:26 (5196): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032

2019-08-18 14:20:26 (5196): Guest Log: BIOS: Booting from Hard Disk...

2019-08-18 14:20:26 (5196): Successfully started VM. (PID = '4364')
2019-08-18 14:20:26 (5196): Reporting VM Process ID to BOINC.
2019-08-18 14:20:31 (5196): Guest Log: BIOS: KBD: unsupported int 16h function 03

2019-08-18 14:20:31 (5196): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 

2019-08-18 14:20:31 (5196): VM state change detected. (old = 'poweroff', new = 'running')
2019-08-18 14:20:36 (5196): Detected: Web Application Enabled (http://localhost:49754)
2019-08-18 14:20:36 (5196): Detected: Remote Desktop Enabled (localhost:49755)
2019-08-18 14:20:41 (5196): Preference change detected
2019-08-18 14:20:41 (5196): Setting CPU throttle for VM. (100%)
2019-08-18 14:20:42 (5196): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 900 seconds))
2019-08-18 14:21:27 (5196): Guest Log: vboxguest: major 0, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)

2019-08-18 14:22:22 (5196): Guest Log: VBoxGuest: VBoxGuestCommonGuestCapsAcquire: pSession(0xffff88013d7c7410), OR(0x0), NOT(0xffffffff), flags(0x0)

2019-08-18 14:22:22 (5196): Guest Log: VBoxGuest: VBoxGuestCommonGuestCapsAcquire: pSession(0xffff88013d7c7a10), OR(0x0), NOT(0xffffffff), flags(0x0)

2019-08-18 14:22:22 (5196): Guest Log: VBoxGuest: VBoxGuestCommonGuestCapsAcquire: pSession(0xffff88013d7c6010), OR(0x0), NOT(0xffffffff), flags(0x0)

2019-08-18 14:22:22 (5196): Guest Log: VBoxGuest: VBoxGuestCommonGuestCapsAcquire: pSession(0xffff88013d7c7610), OR(0x0), NOT(0xffffffff), flags(0x0)

2019-08-18 14:26:18 (5196): Guest Log: Copying input files into RunAtlas.

2019-08-18 14:27:48 (5196): Guest Log: Copied input files into RunAtlas.

2019-08-18 14:28:03 (5196): Guest Log: copied the webapp to /var/www

2019-08-18 14:28:03 (5196): Guest Log: This vm does not need to setup http proxy

2019-08-18 14:28:08 (5196): Guest Log: ATHENA_PROC_NUMBER=2

2019-08-18 14:28:08 (5196): Guest Log: Starting ATLAS job. (PandaID=4449203541 taskID=18722144)

2019-08-18 14:32:06 (5196): Stopping VM.
2019-08-18 14:32:23 (5196): Successfully stopped VM.
2019-08-18 14:35:42 (7920): vboxwrapper (7.9.26200): starting
2019-08-18 14:35:42 (7920): Feature: Checkpoint interval offset (474 seconds)
2019-08-18 14:35:42 (7920): Detected: VirtualBox COM Interface (Version: 5.2.30)
2019-08-18 14:35:42 (7920): Detected: Minimum checkpoint interval (900.000000 seconds)
2019-08-18 14:35:42 (7920): Guest Log: BIOS: VirtualBox 5.2.30

2019-08-18 14:35:42 (7920): Guest Log: CPUID EDX: 0x178bfbff

2019-08-18 14:35:42 (7920): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63

2019-08-18 14:35:42 (7920): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032

2019-08-18 14:35:42 (7920): Guest Log: BIOS: Booting from Hard Disk...

2019-08-18 14:35:42 (7920): Guest Log: BIOS: KBD: unsupported int 16h function 03

2019-08-18 14:35:42 (7920): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 

2019-08-18 14:35:42 (7920): Guest Log: vboxguest: major 0, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)

2019-08-18 14:35:42 (7920): Guest Log: VBoxGuest: VBoxGuestCommonGuestCapsAcquire: pSession(0xffff88013d7c7410), OR(0x0), NOT(0xffffffff), flags(0x0)

2019-08-18 14:35:42 (7920): Guest Log: VBoxGuest: VBoxGuestCommonGuestCapsAcquire: pSession(0xffff88013d7c7a10), OR(0x0), NOT(0xffffffff), flags(0x0)

2019-08-18 14:35:42 (7920): Guest Log: VBoxGuest: VBoxGuestCommonGuestCapsAcquire: pSession(0xffff88013d7c6010), OR(0x0), NOT(0xffffffff), flags(0x0)

2019-08-18 14:35:42 (7920): Guest Log: VBoxGuest: VBoxGuestCommonGuestCapsAcquire: pSession(0xffff88013d7c7610), OR(0x0), NOT(0xffffffff), flags(0x0)

2019-08-18 14:35:42 (7920): Guest Log: Copying input files into RunAtlas.

2019-08-18 14:35:42 (7920): Guest Log: Copied input files into RunAtlas.

2019-08-18 14:35:42 (7920): Guest Log: copied the webapp to /var/www

2019-08-18 14:35:42 (7920): Guest Log: This vm does not need to setup http proxy

2019-08-18 14:35:42 (7920): Guest Log: ATHENA_PROC_NUMBER=2

2019-08-18 14:35:42 (7920): Guest Log: Starting ATLAS job. (PandaID=4449203541 taskID=18722144)

2019-08-18 14:35:42 (7920): Starting VM. (boinc_20f84a6872483073, slot#3)
2019-08-18 14:36:02 (7920): Successfully started VM. (PID = '6596')
2019-08-18 14:36:02 (7920): Reporting VM Process ID to BOINC.
2019-08-18 14:36:07 (7920): VM state change detected. (old = 'poweroff', new = 'running')
2019-08-18 14:36:12 (7920): Detected: Web Application Enabled (http://localhost:49754)
2019-08-18 14:36:12 (7920): Detected: Remote Desktop Enabled (localhost:49755)
2019-08-18 14:36:17 (7920): Preference change detected
2019-08-18 14:36:17 (7920): Setting CPU throttle for VM. (100%)
2019-08-18 14:36:18 (7920): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 900 seconds))
2019-08-18 14:40:09 (7920): Stopping VM.
2019-08-18 14:40:27 (7920): Successfully stopped VM.
2019-08-18 14:51:34 (5908): vboxwrapper (7.9.26200): starting
2019-08-18 14:51:34 (5908): Feature: Checkpoint interval offset (353 seconds)
2019-08-18 14:51:34 (5908): Detected: VirtualBox COM Interface (Version: 5.2.30)
2019-08-18 14:51:34 (5908): Detected: Minimum checkpoint interval (900.000000 seconds)
2019-08-18 14:51:34 (5908): Starting VM. (boinc_20f84a6872483073, slot#3)
2019-08-18 14:52:00 (5908): Successfully started VM. (PID = '8096')
2019-08-18 14:52:00 (5908): Reporting VM Process ID to BOINC.
2019-08-18 14:52:05 (5908): VM state change detected. (old = 'poweroff', new = 'running')
2019-08-18 14:52:11 (5908): Detected: Web Application Enabled (http://localhost:49754)
2019-08-18 14:52:11 (5908): Detected: Remote Desktop Enabled (localhost:49755)
2019-08-18 14:52:16 (5908): Preference change detected
2019-08-18 14:52:16 (5908): Setting CPU throttle for VM. (100%)
2019-08-18 14:52:16 (5908): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 900 seconds))
2019-08-18 14:59:26 (5908): Stopping VM.
2019-08-18 14:59:58 (5908): Successfully stopped VM.
2019-08-18 15:06:08 (9884): vboxwrapper (7.9.26200): starting
2019-08-18 15:06:08 (9884): Feature: Checkpoint interval offset (591 seconds)
2019-08-18 15:06:08 (9884): Detected: VirtualBox COM Interface (Version: 5.2.30)
2019-08-18 15:06:08 (9884): Detected: Minimum checkpoint interval (900.000000 seconds)
2019-08-18 15:06:08 (9884): Starting VM. (boinc_20f84a6872483073, slot#3)
2019-08-18 15:06:30 (9884): Successfully started VM. (PID = '6784')
2019-08-18 15:06:30 (9884): Reporting VM Process ID to BOINC.
2019-08-18 15:06:35 (9884): VM state change detected. (old = 'poweroff', new = 'running')
2019-08-18 15:06:40 (9884): Detected: Web Application Enabled (http://localhost:49754)
2019-08-18 15:06:40 (9884): Detected: Remote Desktop Enabled (localhost:49755)
2019-08-18 15:06:45 (9884): Preference change detected
2019-08-18 15:06:45 (9884): Setting CPU throttle for VM. (100%)
2019-08-18 15:06:45 (9884): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 900 seconds))
2019-08-18 15:08:46 (9884): Stopping VM.
2019-08-18 15:09:12 (9884): Successfully stopped VM.
2019-08-18 15:11:37 (10696): vboxwrapper (7.9.26200): starting
2019-08-18 15:11:37 (10696): Feature: Checkpoint interval offset (40 seconds)
2019-08-18 15:11:37 (10696): Detected: VirtualBox COM Interface (Version: 5.2.30)
2019-08-18 15:11:37 (10696): Detected: Minimum checkpoint interval (900.000000 seconds)
2019-08-18 15:11:37 (10696): Starting VM. (boinc_20f84a6872483073, slot#3)
2019-08-18 15:12:02 (10696): Successfully started VM. (PID = '9752')
2019-08-18 15:12:02 (10696): Reporting VM Process ID to BOINC.
2019-08-18 15:12:07 (10696): VM state change detected. (old = 'poweroff', new = 'running')
2019-08-18 15:12:12 (10696): Detected: Web Application Enabled (http://localhost:49754)
2019-08-18 15:12:12 (10696): Detected: Remote Desktop Enabled (localhost:49755)
2019-08-18 15:12:17 (10696): Preference change detected
2019-08-18 15:12:17 (10696): Setting CPU throttle for VM. (100%)
2019-08-18 15:12:17 (10696): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 900 seconds))
2019-08-18 15:42:56 (10696): VM state change detected. (old = 'running', new = 'paused')
2019-08-18 16:08:23 (10696): Stopping VM.
2019-08-18 16:08:24 (10696): Error 0x80070005 in vbox52::VBOX_VM::stop (c:\users\david\documents\boinc_git\boinc\samples\vboxwrapper\vbox_mscom_impl.cpp:1452)
2019-08-18 16:08:24 (10696): Error Source     : SessionMachine
2019-08-18 16:08:24 (10696): Error Description: The object is not ready
2019-08-18 21:50:36 (10448): vboxwrapper (7.9.26200): starting
2019-08-18 21:50:36 (10448): Feature: Checkpoint interval offset (25 seconds)
2019-08-18 21:50:36 (10448): Detected: VirtualBox COM Interface (Version: 5.2.30)
2019-08-18 21:50:36 (10448): Detected: Minimum checkpoint interval (900.000000 seconds)
2019-08-18 21:50:36 (10448): Starting VM. (boinc_20f84a6872483073, slot#3)
2019-08-18 21:50:47 (10448): Guest Log: BIOS: VirtualBox 5.2.30

2019-08-18 21:50:47 (10448): Guest Log: CPUID EDX: 0x178bfbff

2019-08-18 21:50:47 (10448): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63

2019-08-18 21:50:47 (10448): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032

2019-08-18 21:50:47 (10448): Guest Log: BIOS: Booting from Hard Disk...

2019-08-18 21:50:47 (10448): Successfully started VM. (PID = '10836')
2019-08-18 21:50:47 (10448): Reporting VM Process ID to BOINC.
2019-08-18 21:50:52 (10448): Guest Log: BIOS: KBD: unsupported int 16h function 03

2019-08-18 21:50:52 (10448): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 

2019-08-18 21:50:52 (10448): VM state change detected. (old = 'poweroff', new = 'running')
2019-08-18 21:50:57 (10448): Detected: Web Application Enabled (http://localhost:49754)
2019-08-18 21:50:57 (10448): Detected: Remote Desktop Enabled (localhost:49755)
2019-08-18 21:51:02 (10448): Preference change detected
2019-08-18 21:51:02 (10448): Setting CPU throttle for VM. (100%)
2019-08-18 21:51:02 (10448): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 900 seconds))
2019-08-18 21:51:22 (10448): Guest Log: vboxguest: major 0, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)

2019-08-18 21:51:52 (10448): Guest Log: VBoxGuest: VBoxGuestCommonGuestCapsAcquire: pSession(0xffff88013ea8ea10), OR(0x0), NOT(0xffffffff), flags(0x0)

2019-08-18 21:51:52 (10448): Guest Log: VBoxGuest: VBoxGuestCommonGuestCapsAcquire: pSession(0xffff88013ee0c410), OR(0x0), NOT(0xffffffff), flags(0x0)

2019-08-18 21:51:52 (10448): Guest Log: VBoxGuest: VBoxGuestCommonGuestCapsAcquire: pSession(0xffff88013ee0c410), OR(0x0), NOT(0xffffffff), flags(0x0)

2019-08-18 21:51:52 (10448): Guest Log: VBoxGuest: VBoxGuestCommonGuestCapsAcquire: pSession(0xffff880140158e10), OR(0x0), NOT(0xffffffff), flags(0x0)

2019-08-18 21:54:23 (10448): Guest Log: Copying input files into RunAtlas.

2019-08-18 21:54:38 (10448): Guest Log: Copied input files into RunAtlas.

2019-08-18 21:54:48 (10448): Guest Log: copied the webapp to /var/www

2019-08-18 21:54:48 (10448): Guest Log: This vm does not need to setup http proxy

2019-08-18 21:54:48 (10448): Guest Log: ATHENA_PROC_NUMBER=2

2019-08-18 21:54:48 (10448): Guest Log: Starting ATLAS job. (PandaID=4449203541 taskID=18722144)

2019-08-18 22:20:11 (10448): Status Report: Elapsed Time: '6002.605211'
2019-08-18 22:20:11 (10448): Status Report: CPU Time: '8251.156250'
2019-08-18 22:39:59 (10448): VM state change detected. (old = 'running', new = 'aborted')
2019-08-18 22:39:59 (10448): Powering off VM.
2019-08-18 22:39:59 (10448): Deregistering VM. (boinc_20f84a6872483073, slot#3)
2019-08-18 22:39:59 (10448): Removing virtual disk drive(s) from VM.
2019-08-18 22:39:59 (10448): Removing network bandwidth throttle group from VM.
2019-08-18 22:39:59 (10448): Removing storage controller(s) from VM.
2019-08-18 22:40:00 (10448): Removing VM from VirtualBox.
2019-08-18 22:40:06 (10448): VM Premature Shutdown Detected.
22:40:10 (10448): BOINC client no longer exists - exiting
22:40:10 (10448): timer handler: client dead, exiting

    Hypervisor System Log:

06:22:31.097343          ERROR [COM]: aRC=VBOX_E_INVALID_OBJECT_STATE (0x80bb0007) aIID={4afe423b-43e0-e9d0-82e8-ceb307940dda} aComponent={MediumWrap} aText={Medium 'C:\Program Files\Oracle\VirtualBox\VBoxGuestAdditions.iso' is locked for reading by another task}, preserve=false aResultDetail=0
06:22:45.604145          ERROR [COM]: aRC=VBOX_E_OBJECT_NOT_FOUND (0x80bb0001) aIID={9570b9d5-f1a1-448a-10c5-e12f5285adad} aComponent={VirtualBoxWrap} aText={Could not find a registered machine named 'boinc_6abb95c803bd682f'}, preserve=false aResultDetail=0
06:22:45.658835          Saving settings file "X:\Users\rat\BOINC-DATA\slots\6\boinc_6abb95c803bd682f\boinc_6abb95c803bd682f.vbox" with version "1.16-windows"
06:22:45.876135          Saving settings file "C:\Users\rat\.VirtualBox\VirtualBox.xml" with version "1.12-windows"
06:22:45.958170          ERROR [COM]: aRC=E_FAIL (0x80004005) aIID={85cd948e-a71f-4289-281e-0ca7ad48cd89} aComponent={MachineWrap} aText={This machine does not have any snapshots}, preserve=false aResultDetail=0
06:22:46.037765          Saving settings file "X:\Users\rat\BOINC-DATA\slots\6\boinc_6abb95c803bd682f\boinc_6abb95c803bd682f.vbox" with version "1.16-windows"
06:22:51.797415          ERROR [COM]: aRC=VBOX_E_INVALID_OBJECT_STATE (0x80bb0007) aIID={85cd948e-a71f-4289-281e-0ca7ad48cd89} aComponent={MachineWrap} aText={The given session is busy}, preserve=false aResultDetail=0
06:23:31.700884          Saving settings file "X:\Users\rat\BOINC-DATA\slots\6\boinc_6abb95c803bd682f\boinc_6abb95c803bd682f.vbox" with version "1.16-windows"
06:25:06.356405          Saving settings file "X:\Users\rat\VirtualBox VMs\VISTA\VISTA.vbox" with version "1.14-windows"
06:25:07.001954 SaveState Saving settings file "X:\Users\rat\VirtualBox VMs\VISTA\VISTA.vbox" with version "1.14-windows"
06:25:08.281336          Saving settings file "X:\Users\rat\VirtualBox VMs\VISTA\VISTA.vbox" with version "1.14-windows"
06:25:45.656769          Saving settings file "X:\Users\rat\BOINC-DATA\slots\6\boinc_6abb95c803bd682f\boinc_6abb95c803bd682f.vbox" with version "1.16-windows"
06:25:52.169393          ERROR [COM]: aRC=E_FAIL (0x80004005) aIID={85cd948e-a71f-4289-281e-0ca7ad48cd89} aComponent={SessionMachine} aText={This machine does not have any snapshots}, preserve=false aResultDetail=0
06:25:52.187460          Saving settings file "X:\Users\rat\BOINC-DATA\slots\6\boinc_6abb95c803bd682f\boinc_6abb95c803bd682f.vbox" with version "1.16-windows"
06:25:52.239221          Saving settings file "X:\Users\rat\BOINC-DATA\slots\6\boinc_6abb95c803bd682f\boinc_6abb95c803bd682f.vbox" with version "1.16-windows"
06:25:52.305632          ERROR [COM]: aRC=VBOX_E_INVALID_OBJECT_STATE (0x80bb0007) aIID={4afe423b-43e0-e9d0-82e8-ceb307940dda} aComponent={MediumWrap} aText={Medium 'C:\Program Files\Oracle\VirtualBox\VBoxGuestAdditions.iso' is locked for reading by another task}, preserve=false aResultDetail=0
06:25:52.309050          Saving settings file "C:\Users\rat\.VirtualBox\VirtualBox.xml" with version "1.12-windows"
06:25:52.388645          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={4afe423b-43e0-e9d0-82e8-ceb307940dda} aComponent={MediumWrap} aText={The object is not ready}, preserve=false aResultDetail=0
06:25:52.388645          ERROR [COM]: aRC=VBOX_E_INVALID_OBJECT_STATE (0x80bb0007) aIID={4afe423b-43e0-e9d0-82e8-ceb307940dda} aComponent={MediumWrap} aText={Medium 'C:\Program Files\Oracle\VirtualBox\VBoxGuestAdditions.iso' is locked for reading by another task}, preserve=false aResultDetail=0
06:26:03.640342          ERROR [COM]: aRC=VBOX_E_OBJECT_NOT_FOUND (0x80bb0001) aIID={9570b9d5-f1a1-448a-10c5-e12f5285adad} aComponent={VirtualBoxWrap} aText={Could not find a registered machine named 'boinc_6cff36012bb8f0cf'}, preserve=false aResultDetail=0
06:26:03.653527          Saving settings file "X:\Users\rat\BOINC-DATA\slots\6\boinc_6cff36012bb8f0cf\boinc_6cff36012bb8f0cf.vbox" with version "1.16-windows"
06:26:03.688685          Saving settings file "C:\Users\rat\.VirtualBox\VirtualBox.xml" with version "1.12-windows"
06:26:03.774628          Saving settings file "X:\Users\rat\BOINC-DATA\slots\6\boinc_6cff36012bb8f0cf\boinc_6cff36012bb8f0cf.vbox" with version "1.16-windows"
06:26:09.260817          ERROR [COM]: aRC=VBOX_E_INVALID_OBJECT_STATE (0x80bb0007) aIID={85cd948e-a71f-4289-281e-0ca7ad48cd89} aComponent={MachineWrap} aText={The given session is busy}, preserve=false aResultDetail=0
06:26:29.830000          Saving settings file "X:\Users\rat\BOINC-DATA\slots\6\boinc_6cff36012bb8f0cf\boinc_6cff36012bb8f0cf.vbox" with version "1.16-windows"
06:26:51.106256 Watcher  Saving settings file "X:\Users\rat\BOINC-DATA\slots\6\boinc_6cff36012bb8f0cf\boinc_6cff36012bb8f0cf.vbox" with version "1.16-windows"
06:26:51.433913 Watcher  Saving settings file "X:\Users\rat\BOINC-DATA\slots\3\boinc_20f84a6872483073\boinc_20f84a6872483073.vbox" with version "1.16-windows"
06:26:52.224491 Watcher  Reaper: Pid 10592 (2960) exited normally: 1073807364 (0x40010004)
06:26:52.226446          ERROR [COM]: aRC=E_FAIL (0x80004005) aIID={85cd948e-a71f-4289-281e-0ca7ad48cd89} aComponent={SessionMachine} aText={This machine does not have any snapshots}, preserve=false aResultDetail=0
06:26:52.233280          Saving settings file "X:\Users\rat\BOINC-DATA\slots\6\boinc_6cff36012bb8f0cf\boinc_6cff36012bb8f0cf.vbox" with version "1.16-windows"
06:26:52.463768          ERROR [COM]: aRC=E_FAIL (0x80004005) aIID={85cd948e-a71f-4289-281e-0ca7ad48cd89} aComponent={SessionMachine} aText={This machine does not have any snapshots}, preserve=false aResultDetail=0
06:26:53.016532          Saving settings file "X:\Users\rat\BOINC-DATA\slots\3\boinc_20f84a6872483073\boinc_20f84a6872483073.vbox" with version "1.16-windows"
06:26:53.563453          Saving settings file "X:\Users\rat\BOINC-DATA\slots\6\boinc_6cff36012bb8f0cf\boinc_6cff36012bb8f0cf.vbox" with version "1.16-windows"
06:26:53.625947          Saving settings file "X:\Users\rat\BOINC-DATA\slots\3\boinc_20f84a6872483073\boinc_20f84a6872483073.vbox" with version "1.16-windows"
06:26:54.016596          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 4 virtual machines}, preserve=false aResultDetail=0
06:26:54.094727          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 4 virtual machines}, preserve=false aResultDetail=0
06:26:54.094727          Saving settings file "C:\Users\rat\.VirtualBox\VirtualBox.xml" with version "1.12-windows"
06:26:54.438499          Saving settings file "C:\Users\rat\.VirtualBox\VirtualBox.xml" with version "1.12-windows"
06:26:54.438499          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={4afe423b-43e0-e9d0-82e8-ceb307940dda} aComponent={MediumWrap} aText={The object is not ready}, preserve=false aResultDetail=0
06:26:54.454126          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 4 virtual machines}, preserve=false aResultDetail=0
06:26:54.704140          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={4afe423b-43e0-e9d0-82e8-ceb307940dda} aComponent={MediumWrap} aText={The object is not ready}, preserve=false aResultDetail=0
06:26:54.704140          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 4 virtual machines}, preserve=false aResultDetail=0
06:26:59.110181 Watcher  Reaper: Pid 10076 (275c) exited normally: 1073807364 (0x40010004)

    VM Execution Log:


    VM Startup Log:


    VM Trace Log:

22:40:11 (10448): called boinc_finish(194)
2019-08-19 18:23:23 (8068): vboxwrapper (7.9.26200): starting
2019-08-19 18:23:27 (8068): Feature: Checkpoint interval offset (483 seconds)
2019-08-19 18:23:27 (8068): Detected: VirtualBox COM Interface (Version: 5.2.30)
2019-08-19 18:23:27 (8068): Detected: Minimum checkpoint interval (900.000000 seconds)
2019-08-19 18:23:27 (8068): Create VM. (boinc_20f84a6872483073, slot#3)
2019-08-19 18:23:28 (8068): Setting Memory Size for VM. (4800MB)
2019-08-19 18:23:28 (8068): Setting CPU Count for VM. (2)
2019-08-19 18:23:28 (8068): Setting Chipset Options for VM.
2019-08-19 18:23:28 (8068): Setting Boot Options for VM.
2019-08-19 18:23:28 (8068): Enabling VM Network Access.
2019-08-19 18:23:28 (8068): Setting Network Configuration for NAT.
2019-08-19 18:23:28 (8068): Disabling USB Support for VM.
2019-08-19 18:23:28 (8068): Disabling COM Port Support for VM.
2019-08-19 18:23:28 (8068): Disabling LPT Port Support for VM.
2019-08-19 18:23:28 (8068): Disabling Audio Support for VM.
2019-08-19 18:23:28 (8068): Disabling Clipboard Support for VM.
2019-08-19 18:23:28 (8068): Disabling Drag and Drop Support for VM.
2019-08-19 18:23:28 (8068): Adding storage controller(s) to VM.
2019-08-19 18:23:28 (8068): Adding virtual disk drive to VM. (vm_image.vdi)
2019-08-19 18:23:28 (8068): Adding VirtualBox Guest Additions to VM.
2019-08-19 18:23:28 (8068): Adding network bandwidth throttle group to VM. (Defaulting to 1024GB)
2019-08-19 18:23:28 (8068): forwarding host port 49754 to guest port 80
2019-08-19 18:23:28 (8068): Enabling remote desktop for VM.
2019-08-19 18:23:28 (8068): Enabling shared directory for VM.
2019-08-19 18:23:28 (8068): Starting VM. (boinc_20f84a6872483073, slot#3)
2019-08-19 18:23:45 (8068): Guest Log: BIOS: VirtualBox 5.2.30

2019-08-19 18:23:45 (8068): Guest Log: CPUID EDX: 0x178bfbff

2019-08-19 18:23:45 (8068): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63

2019-08-19 18:23:45 (8068): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032

2019-08-19 18:23:45 (8068): Guest Log: BIOS: Booting from Hard Disk...

2019-08-19 18:23:45 (8068): Successfully started VM. (PID = '5376')
2019-08-19 18:23:45 (8068): Reporting VM Process ID to BOINC.
2019-08-19 18:23:50 (8068): Guest Log: BIOS: KBD: unsupported int 16h function 03

2019-08-19 18:23:50 (8068): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 

2019-08-19 18:23:50 (8068): VM state change detected. (old = 'poweroff', new = 'running')
2019-08-19 18:23:55 (8068): Detected: Web Application Enabled (http://localhost:49754)
2019-08-19 18:23:55 (8068): Detected: Remote Desktop Enabled (localhost:59661)

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

Stderr output
