Task 434669

Name	06987189_393_1
Workunit	246738
Created	14 Dec 2018, 16:22:18 UTC
Sent	14 Dec 2018, 16:22:21 UTC
Report deadline	15 Dec 2018, 16:22:21 UTC
Received	15 Dec 2018, 11:24:31 UTC
Server state	Over
Outcome	Computation error
Client state	Compute error
Exit status	197 (0x000000C5) EXIT_TIME_LIMIT_EXCEEDED
Computer ID	524
Run time	5 hours 17 min 53 sec
CPU time	4 hours 48 min 10 sec
Validate state	Invalid
Credit	0.00
Device peak FLOPS	3.50 GFLOPS
Application version	boinc2docker v1.12 (vbox64_mt) windows_x86_64
Peak working set size	78.24 MB
Peak swap size	88.25 MB
Peak disk usage	246.92 MB
Stderr output

<core_client_version>7.12.1</core_client_version>
<![CDATA[
<message>
exceeded elapsed time limit 19048.62 (86400.00G/4.54G)</message>
<stderr_txt>
2018-12-15 00:00:05 (18248): vboxwrapper (7.9.26200): starting
2018-12-15 00:00:05 (18248): Feature: Checkpoint interval offset (491 seconds)
2018-12-15 00:00:05 (18248): Detected: VirtualBox COM Interface (Version: 5.1.26)
2018-12-15 00:00:05 (18248): Detected: Minimum checkpoint interval (600.000000 seconds)
2018-12-15 00:00:05 (18248): Create VM. (boinc_464635fdfaffba81, slot#1)
2018-12-15 00:00:05 (18248): Updating drive controller type and model for desired configuration.
2018-12-15 00:00:05 (18248): Setting Memory Size for VM. (3072MB)
2018-12-15 00:00:05 (18248): Setting CPU Count for VM. (1)
2018-12-15 00:00:05 (18248): Setting Chipset Options for VM.
2018-12-15 00:00:05 (18248): Setting Boot Options for VM.
2018-12-15 00:00:05 (18248): Enabling VM Network Access.
2018-12-15 00:00:05 (18248): Setting Network Configuration for NAT.
2018-12-15 00:00:05 (18248): Disabling USB Support for VM.
2018-12-15 00:00:05 (18248): Disabling COM Port Support for VM.
2018-12-15 00:00:05 (18248): Disabling LPT Port Support for VM.
2018-12-15 00:00:05 (18248): Disabling Audio Support for VM.
2018-12-15 00:00:05 (18248): Disabling Clipboard Support for VM.
2018-12-15 00:00:05 (18248): Disabling Drag and Drop Support for VM.
2018-12-15 00:00:05 (18248): Adding storage controller(s) to VM.
2018-12-15 00:00:05 (18248): Adding virtual ISO 9660 disk drive to VM. (vm_isocontext.iso)
2018-12-15 00:00:05 (18248): Adding VirtualBox Guest Additions to VM.
2018-12-15 00:00:05 (18248): Adding network bandwidth throttle group to VM. (Defaulting to 1024GB)
2018-12-15 00:00:05 (18248): Enabling shared directory for VM.
2018-12-15 00:00:05 (18248): Starting VM. (boinc_464635fdfaffba81, slot#1)
2018-12-15 00:00:15 (18248): Guest Log: BIOS: VirtualBox 5.1.26

2018-12-15 00:00:15 (18248): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032

2018-12-15 00:00:15 (18248): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=80

2018-12-15 00:00:15 (18248): Guest Log: BIOS: Boot from Hard Disk 0 failed

2018-12-15 00:00:15 (18248): Guest Log: BIOS: Boot : bseqnr=2, bootseq=0003

2018-12-15 00:00:15 (18248): Guest Log: BIOS: Booting from CD-ROM...

2018-12-15 00:00:15 (18248): Guest Log: BIOS: KBD: unsupported int 16h function 03

2018-12-15 00:00:15 (18248): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 

2018-12-15 00:00:15 (18248): Successfully started VM. (PID = '20832')
2018-12-15 00:00:15 (18248): Reporting VM Process ID to BOINC.
2018-12-15 00:00:20 (18248): VM state change detected. (old = 'poweroff', new = 'running')
2018-12-15 00:00:30 (18248): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds

2018-12-15 00:00:30 (18248): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)

2018-12-15 00:00:30 (18248): Guest Log: net.ipv4.ip_forward = 1

2018-12-15 00:00:30 (18248): Guest Log: sysctl: cannot stat /proc/sys/net/ipv6/conf/all/forwarding: No such file or directory

2018-12-15 00:00:30 (18248): Guest Log: sysctl: setting key "cannot stat %s": No such file or directory

2018-12-15 00:00:30 (18248): Guest Log: sysctl: "cannot stat %s" is an unknown key

2018-12-15 00:00:30 (18248): Guest Log: sysctl: setting key "cannot stat %s": No such file or directory

2018-12-15 00:00:30 (18248): Guest Log: Segmentation fault

2018-12-15 00:00:30 (18248): Guest Log: automount ...

2018-12-15 00:00:30 (18248): Guest Log: Is the disk unpartitioned?, test for the 'boot2docker format-me' string

2018-12-15 00:00:30 (18248): Guest Log: automount over.

2018-12-15 00:00:30 (18248): Guest Log: [1;32mSetting hostname to [1;35mboot2docker[0;39m [1;32mDone.[0;39m

2018-12-15 00:00:30 (18248): Guest Log: Sat Dec 15 00:00:24 UTC 2018 dhcp -------------------------------

2018-12-15 00:00:30 (18248): Preference change detected
2018-12-15 00:00:30 (18248): Setting CPU throttle for VM. (75%)
2018-12-15 00:00:30 (18248): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2018-12-15 00:00:35 (18248): Guest Log: udevadm settle - timeout of 5 seconds reached, the event queue contains:

2018-12-15 00:00:35 (18248): Guest Log:   /sys/devices/LNXSYSTM:00/LNXSYBUS:00/PNP0A03:00/device:00/PNP0700:00 (1084)

2018-12-15 00:00:35 (18248): Guest Log:   /sys/devices/LNXSYSTM:00 (1310)

2018-12-15 00:00:35 (18248): Guest Log:   /sys/devices/LNXSYSTM:00/LNXCPU:00 (1311)

2018-12-15 00:00:35 (18248): Guest Log:   /sys/devices/LNXSYSTM:00/LNXPWRBN:00 (1312)

2018-12-15 00:00:35 (18248): Guest Log:   /sys/devices/LNXSYSTM:00/LNXPWRBN:00/input/input0 (1313)

2018-12-15 00:00:35 (18248): Guest Log:   /sys/devices/LNXSYSTM:00/LNXPWRBN:00/input/input0/event0 (1314)

2018-12-15 00:00:35 (18248): Guest Log:   /sys/devices/LNXSYSTM:00/LNXSLPBN:00 (1315)

2018-12-15 00:00:35 (18248): Guest Log:   /sys/devices/LNXSYSTM:00/LNXSLPBN:00/input/input1 (1316)

2018-12-15 00:00:35 (18248): Guest Log:   /sys/devices/LNXSYSTM:00/LNXSLPBN:00/input/input1/event1 (1317)

2018-12-15 00:00:35 (18248): Guest Log:   /sys/devices/LNXSYSTM:00/LNXSYBUS:00 (1318)

2018-12-15 00:00:35 (18248): Guest Log:   /sys/devices/LNXSYSTM:00/LNXSYBUS:00/PNP0A03:00 (1319)

2018-12-15 00:00:36 (18248): Guest Log:   /sys/devices/LNXSYSTM:00/LNXSYBUS:00/PNP0A03:00/ACPI0003:00 (1320)

2018-12-15 00:00:36 (18248): Guest Log:   /sys/devices/LNXSYSTM:00/LNXSYBUS:00/PNP0A03:00/ACPI0003:00/power_supply/AC (1321)

2018-12-15 00:00:36 (18248): Guest Log:   /sys/devices/LNXSYSTM:00/LNXSYBUS:00/PNP0A03:00/LNXVIDEO:00 (1322)

2018-12-15 00:00:36 (18248): Guest Log:   /sys/devices/LNXSYSTM:00/LNXSYBUS:00/PNP0A03:00/LNXVIDEO:00/device:01 (1323)

2018-12-15 00:00:36 (18248): Guest Log:   /sys/devices/LNXSYSTM:00/LNXSYBUS:00/PNP0A03:00/LNXVIDEO:00/input/input6 (1324)

2018-12-15 00:00:36 (18248): Guest Log:   /sys/devices/LNXSYSTM:00/LNXSYBUS:00/PNP0A03:00/LNXVIDEO:00/input/input6/event5 (1325)

2018-12-15 00:00:36 (18248): Guest Log:   /sys/devices/LNXSYSTM:00/LNXSYBUS:00/PNP0A03:00/PNP0400:00 (1326)

2018-12-15 00:00:36 (18248): Guest Log:   /sys/devices/LNXSYSTM:00/LNXSYBUS:00/PNP0A03:00/PNP0400:01 (1327)

2018-12-15 00:00:36 (18248): Guest Log:   /sys/devices/LNXSYSTM:00/LNXSYBUS:00/PNP0A03:00/PNP0501:00 (1328)

2018-12-15 00:00:36 (18248): Guest Log:   /sys/devices/LNXSYSTM:00/LNXSYBUS:00/PNP0A03:00/PNP0501:01 (1329)

2018-12-15 00:00:36 (18248): Guest Log:   /sys/devices/LNXSYSTM:00/LNXSYBUS:00/PNP0A03:00/PNP0501:02 (1330)

2018-12-15 00:00:36 (18248): Guest Log:   /sys/devices/LNXSYSTM:00/LNXSYBUS:00/PNP0A03:00/PNP0501:03 (1331)

2018-12-15 00:00:36 (18248): Guest Log:   /sys/devices/LNXSYSTM:00/LNXSYBUS:00/PNP0A03:00/PNP0C02:00 (1332)

2018-12-15 00:00:36 (18248): Guest Log:   /sys/devices/LNXSYSTM:00/LNXSYBUS:00/PNP0A03:00/PNP0C0A:00 (1333)

2018-12-15 00:00:36 (18248): Guest Log:   /sys/devices/LNXSYSTM:00/LNXSYBUS:00/PNP0A03:00/PNP0C0A:00/power_supply/BAT0 (1334)

2018-12-15 00:00:36 (18248): Guest Log:   /sys/devices/LNXSYSTM:00/LNXSYBUS:00/PNP0A03:00/PNP8390:00 (1335)

2018-12-15 00:00:36 (18248): Guest Log:   /sys/devices/LNXSYSTM:00/LNXSYBUS:00/PNP0A03:00/device:00 (1336)

2018-12-15 00:00:36 (18248): Guest Log:   /sys/devices/LNXSYSTM:00/LNXSYBUS:00/PNP0A03:00/device:00/APP0001:00 (1337)

2018-12-15 00:00:36 (18248): Guest Log:   /sys/devices/LNXSYSTM:00/LNXSYBUS:00/PNP0A03:00/device:00/PNP0000:00 (1338)

2018-12-15 00:00:36 (18248): Guest Log:   /sys/devices/LNXSYSTM:00/LNXSYBUS:00/PNP0A03:00/device:00/PNP0100:00 (1339)

2018-12-15 00:00:36 (18248): Guest Log:   /sys/devices/LNXSYSTM:00/LNXSYBUS:00/PNP0A03:00/device:00/PNP0103:00 (1340)

2018-12-15 00:00:36 (18248): Guest Log:   /sys/devices/LNXSYSTM:00/LNXSYBUS:00/PNP0A03:00/device:00/PNP0200:00 (1341)

2018-12-15 00:00:36 (18248): Guest Log:   /sys/devices/LNXSYSTM:00/LNXSYBUS:00/PNP0A03:00/device:00/PNP0303:00 (1342)

2018-12-15 00:00:36 (18248): Guest Log:   /sys/devices/LNXSYSTM:00/LNXSYBUS:00/PNP0A03:00/device:00/PNP0700:00 (1343)

2018-12-15 00:00:36 (18248): Guest Log:   /sys/devices/LNXSYSTM:00/LNXSYBUS:00/PNP0A03:00/device:00/PNP0B00:00 (1344)

2018-12-15 00:00:36 (18248): Guest Log:   /sys/devices/LNXSYSTM:00/LNXSYBUS:00/PNP0A03:00/device:00/PNP0F03:00 (1345)

2018-12-15 00:00:36 (18248): Guest Log:   /sys/devices/LNXSYSTM:00/LNXSYBUS:00/PNP0A03:00/device:02 (1346)

2018-12-15 00:00:36 (18248): Guest Log:   /sys/devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0F:00 (1347)

2018-12-15 00:00:36 (18248): Guest Log:   /sys/devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0F:01 (1348)

2018-12-15 00:00:36 (18248): Guest Log:   /sys/devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0F:02 (1349)

2018-12-15 00:00:36 (18248): Guest Log:   /sys/devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0F:03 (1350)

2018-12-15 00:00:36 (18248): Guest Log:   /sys/devices/LNXSYSTM:00/LNXSYBUS:01 (1351)

2018-12-15 00:00:36 (18248): Guest Log: Sat Dec 15 00:00:30 UTC 2018 dhcp -------------------------------

2018-12-15 00:00:36 (18248): Guest Log: VBoxService 5.0.16 r105871 (verbosity: 0) linux.amd64 (Mar  4 2016 17:38:55) release log

2018-12-15 00:00:36 (18248): Guest Log: 00:00:00.000083 main     Log opened 2018-12-15T00:00:31.140304000Z

2018-12-15 00:00:36 (18248): Guest Log: VBoxService 5.0.16 r105871 (verbosity: 0) linux.amd64 (Mar  4 2016 17:38:55) release log

2018-12-15 00:00:36 (18248): Guest Log: 00:00:00.000083 main     Log opened 2018-12-15T00:00:31.140304000Z

2018-12-15 00:00:36 (18248): Guest Log: 00:00:00.003837 main     OS Product: Linux

2018-12-15 00:00:36 (18248): Guest Log: 00:00:00.003897 main     OS Release: 4.1.19-boot2docker

2018-12-15 00:00:36 (18248): Guest Log: 00:00:00.003967 main     OS Version: #1 SMP Sun Apr 17 19:40:54 UTC 2016

2018-12-15 00:00:36 (18248): Guest Log: 00:00:00.004002 main     Executable: /sbin/VBoxService

2018-12-15 00:00:36 (18248): Guest Log: 00:00:00.004003 main     Process ID: 903

2018-12-15 00:00:36 (18248): Guest Log: 00:00:00.004004 main     Package type: LINUX_64BITS_GENERIC

2018-12-15 00:00:36 (18248): Guest Log: 00:00:00.003837 main     OS Product: Linux

2018-12-15 00:00:36 (18248): Guest Log: 00:00:00.003897 main     OS Release: 4.1.19-boot2docker

2018-12-15 00:00:36 (18248): Guest Log: 00:00:00.003967 main     OS Version: #1 SMP Sun Apr 17 19:40:54 UTC 2016

2018-12-15 00:00:36 (18248): Guest Log: 00:00:00.00:00:00.044672 main     5.0.16 r105871 started. Verbose level = 0

2018-12-15 00:00:36 (18248): Guest Log: 004002 main     Executable: /sbin/VBoxService

2018-12-15 00:00:36 (18248): Guest Log: 00:00:00.004003 main     Process ID: 903

2018-12-15 00:00:36 (18248): Guest Log: 00:00:00.004004 main     Pack00:00:00.050670 vminfo   rtldrNativeLoad: dlopen('libdbus-1.so.3', RTLD_NOW | RTLD_LOCAL) failed: libdbus-1.so.3: cannot open shared object file: No such file or directory

2018-12-15 00:00:36 (18248): Guest Log: 00:00:00.050743 vminfo   Error: Unable to connect to system D-Bus (1/3): D-Bus not installed

2018-12-15 00:00:36 (18248): Guest Log: age type: LINUX_64BITS_GENERIC

2018-12-15 00:00:36 (18248): Guest Log: 00:00:00.044672 main     5.0.16 r105871 started. Verbose level = 0

2018-12-15 00:00:36 (18248): Guest Log: Mounting BOINC shared/...

2018-12-15 00:00:36 (18248): Guest Log: -------------------

2018-12-15 00:00:36 (18248): Guest Log: Sat Dec 15 06:00:33 UTC 2018

2018-12-15 00:00:41 (18248): Guest Log: 00:00:05.051687 vminfo   Error: Unable to connect to system D-Bus (2/3): D-Bus not installed

2018-12-15 00:00:41 (18248): Guest Log: Sat Dec 15 06:00:38 UTC 2018

2018-12-15 00:00:41 (18248): Guest Log: 1: lo: <LOOPBACK,UP,LOWER_UP> mtu 65536 qdisc noqueue state UNKNOWN group default 

2018-12-15 00:00:41 (18248): Guest Log:     link/loopback 00:00:00:00:00:00 brd 00:00:00:00:00:00

2018-12-15 00:00:41 (18248): Guest Log:     inet 127.0.0.1/8 scope host lo

2018-12-15 00:00:41 (18248): Guest Log:        valid_lft forever preferred_lft forever

2018-12-15 00:00:41 (18248): Guest Log:     inet6 ::1/128 scope host 

2018-12-15 00:00:41 (18248): Guest Log:        valid_lft forever preferred_lft forever

2018-12-15 00:00:41 (18248): Guest Log: 2: dummy0: <BROADCAST,NOARP> mtu 1500 qdisc noop state DOWN group default 

2018-12-15 00:00:41 (18248): Guest Log:     link/ether a2:f2:24:9d:47:1e brd ff:ff:ff:ff:ff:ff

2018-12-15 00:00:41 (18248): Guest Log: 3: eth0: <BROADCAST,MULTICAST,UP,LOWER_UP> mtu 1500 qdisc pfifo_fast state UP group default qlen 1000

2018-12-15 00:00:41 (18248): Guest Log:     link/ether 08:00:27:19:ce:29 brd ff:ff:ff:ff:ff:ff

2018-12-15 00:00:41 (18248): Guest Log:     inet 10.0.2.15/24 brd 10.0.2.255 scope global eth0

2018-12-15 00:00:41 (18248): Guest Log:        valid_lft forever preferred_lft forever

2018-12-15 00:00:41 (18248): Guest Log:     inet6 fe80::a00:27ff:fe19:ce29/64 scope link tentative 

2018-12-15 00:00:41 (18248): Guest Log:        valid_lft forever preferred_lft forever

2018-12-15 00:00:41 (18248): Guest Log: -------------------

2018-12-15 00:00:41 (18248): Guest Log: Linking /etc/docker to /var/lib/boot2docker for persistence

2018-12-15 00:00:41 (18248): Guest Log: Waiting for Docker daemon to start...

2018-12-15 00:00:41 (18248): Guest Log: REPOSITORY          TAG                 IMAGE ID            CREATED             SIZE

2018-12-15 00:00:41 (18248): Guest Log: Running boinc_app...

2018-12-15 00:00:41 (18248): Guest Log: Importing Docker image from BOINC...

2018-12-15 00:00:41 (18248): Guest Log: Filesystem                Size      Used Available Use% Mounted on

2018-12-15 00:00:41 (18248): Guest Log: tmpfs                     2.6G    164.2M      2.5G   6% /

2018-12-15 00:00:41 (18248): Guest Log: tmpfs                     1.5G         0      1.5G   0% /dev/shm

2018-12-15 00:00:41 (18248): Guest Log: cgroup                    1.5G         0      1.5G   0% /sys/fs/cgroup

2018-12-15 00:00:41 (18248): Guest Log: shared                  255.6G     87.3G    168.3G  34% /root/shared

2018-12-15 00:00:41 (18248): Guest Log: tmpfs                     2.6G    164.2M      2.5G   6% /var/lib/docker/aufs

2018-12-15 00:00:46 (18248): Guest Log: 00:00:10.052961 vminfo   Error: Unable to connect to system D-Bus (3/3): D-Bus not installed

2018-12-15 00:00:56 (18248): Guest Log: doing docker load...

2018-12-15 00:01:11 (18248): Guest Log: Filesystem                Size      Used Available Use% Mounted on

2018-12-15 00:01:11 (18248): Guest Log: tmpfs                     2.6G    631.9M      2.0G  23% /

2018-12-15 00:01:11 (18248): Guest Log: tmpfs                     1.5G         0      1.5G   0% /dev/shm

2018-12-15 00:01:11 (18248): Guest Log: cgroup                    1.5G         0      1.5G   0% /sys/fs/cgroup

2018-12-15 00:01:11 (18248): Guest Log: shared                  255.6G     87.1G    168.5G  34% /root/shared

2018-12-15 00:01:11 (18248): Guest Log: tmpfs                     2.6G    631.9M      2.0G  23% /var/lib/docker/aufs

2018-12-15 00:01:11 (18248): Guest Log:               total        used        free      shared  buff/cache   available

2018-12-15 00:01:11 (18248): Guest Log: Mem:           3007          50        2287         631         669        2287

2018-12-15 00:01:11 (18248): Guest Log: Swap:           700           0         700

2018-12-15 00:01:11 (18248): Guest Log: Building apps directory...

2018-12-15 00:01:26 (18248): Guest Log: Prerun diagnostics...

2018-12-15 00:01:26 (18248): Guest Log: REPOSITORY          TAG                 IMAGE ID            CREATED             SIZE

2018-12-15 00:01:26 (18248): Guest Log: nanohub_apps_base   11                  42db2bf7db3d        12 months ago       458.1 MB

2018-12-15 00:01:26 (18248): Guest Log: CONTAINER ID        IMAGE               COMMAND             CREATED             STATUS              PORTS               NAMES

2018-12-15 00:01:26 (18248): Guest Log: 467.8M	/var/lib/docker

2018-12-15 00:01:26 (18248): Guest Log:               total        used        free      shared  buff/cache   available

2018-12-15 00:01:26 (18248): Guest Log: Mem:           3007          51        2285         631         670        2286

2018-12-15 00:01:26 (18248): Guest Log: Swap:           700           0         700

2018-12-15 00:01:26 (18248): Guest Log: Filesystem                Size      Used Available Use% Mounted on

2018-12-15 00:01:26 (18248): Guest Log: tmpfs                     2.6G    631.9M      2.0G  23% /

2018-12-15 00:01:26 (18248): Guest Log: tmpfs                     1.5G         0      1.5G   0% /dev/shm

2018-12-15 00:01:26 (18248): Guest Log: cgroup                    1.5G         0      1.5G   0% /sys/fs/cgroup

2018-12-15 00:01:26 (18248): Guest Log: shared                  255.6G     87.2G    168.4G  34% /root/shared

2018-12-15 00:01:26 (18248): Guest Log: tmpfs                     2.6G    631.9M      2.0G  23% /var/lib/docker/aufs

2018-12-15 00:01:26 (18248): Guest Log: Running... 

2018-12-15 00:01:26 (18248): Guest Log: 06987189_393.boinc

2018-12-15 00:01:26 (18248): Guest Log: 06987189_393.sh

2018-12-15 00:45:14 (18248): VM state change detected. (old = 'running', new = 'paused')
2018-12-15 00:45:34 (18248): VM state change detected. (old = 'paused', new = 'running')
2018-12-15 01:35:47 (18248): VM state change detected. (old = 'running', new = 'paused')
2018-12-15 01:36:37 (18248): VM state change detected. (old = 'paused', new = 'running')
2018-12-15 01:41:53 (18248): Status Report: Elapsed Time: '6002.095243'
2018-12-15 01:41:53 (18248): Status Report: CPU Time: '5445.859375'
2018-12-15 02:02:59 (18248): VM state change detected. (old = 'running', new = 'paused')
2018-12-15 02:03:19 (18248): VM state change detected. (old = 'paused', new = 'running')
2018-12-15 02:42:02 (18248): VM state change detected. (old = 'running', new = 'paused')
2018-12-15 02:42:22 (18248): VM state change detected. (old = 'paused', new = 'running')
2018-12-15 02:46:03 (18248): VM state change detected. (old = 'running', new = 'paused')
2018-12-15 02:46:43 (18248): VM state change detected. (old = 'paused', new = 'running')
2018-12-15 02:46:53 (18248): VM state change detected. (old = 'running', new = 'paused')
2018-12-15 02:47:33 (18248): VM state change detected. (old = 'paused', new = 'running')
2018-12-15 02:47:43 (18248): VM state change detected. (old = 'running', new = 'paused')
2018-12-15 02:48:03 (18248): VM state change detected. (old = 'paused', new = 'running')
2018-12-15 02:48:13 (18248): VM state change detected. (old = 'running', new = 'paused')
2018-12-15 02:48:53 (18248): VM state change detected. (old = 'paused', new = 'running')
2018-12-15 03:25:26 (18248): Status Report: Elapsed Time: '12004.563900'
2018-12-15 03:25:26 (18248): Status Report: CPU Time: '10922.906250'
2018-12-15 03:40:27 (18248): VM state change detected. (old = 'running', new = 'paused')
2018-12-15 03:40:47 (18248): VM state change detected. (old = 'paused', new = 'running')
2018-12-15 04:19:10 (18248): VM state change detected. (old = 'running', new = 'paused')
2018-12-15 04:19:20 (18248): VM state change detected. (old = 'paused', new = 'running')
2018-12-15 04:38:41 (18248): VM state change detected. (old = 'running', new = 'paused')
2018-12-15 04:39:01 (18248): VM state change detected. (old = 'paused', new = 'running')
2018-12-15 05:06:33 (18248): Status Report: Elapsed Time: '18006.668873'
2018-12-15 05:06:33 (18248): Status Report: CPU Time: '16385.281250'
2018-12-15 05:17:34 (18248): VM state change detected. (old = 'running', new = 'paused')
2018-12-15 05:17:44 (18248): VM state change detected. (old = 'paused', new = 'running')
2018-12-15 05:22:49 (18248): Powering off VM.
2018-12-15 05:22:51 (18248): Successfully stopped VM.
2018-12-15 05:22:56 (18248): Deregistering VM. (boinc_464635fdfaffba81, slot#1)
2018-12-15 05:22:56 (18248): Removing virtual disk drive(s) from VM.
2018-12-15 05:22:56 (18248): Removing network bandwidth throttle group from VM.
2018-12-15 05:22:56 (18248): Removing storage controller(s) from VM.
2018-12-15 05:22:56 (18248): Removing VM from VirtualBox.

    Hypervisor System Log:

64:07:44.246202 DeleteSnap ERROR [COM]: aRC=VBOX_E_INVALID_OBJECT_STATE (0x80bb0007) aIID={4afe423b-43e0-e9d0-82e8-ceb307940dda} aComponent={MediumWrap} aText={Medium 'C:\ProgramData\BOINC\slots\3\deb_port9744165289872471.vdi' is locked for reading by another task}, preserve=true  aResultDetail=0
64:17:29.034800 USBPROXY Getting USB descriptor failed with error 31
64:17:29.034800 USBPROXY Getting USB descriptor failed with error 31
64:27:56.381804 DeleteSnap ERROR [COM]: aRC=VBOX_E_INVALID_OBJECT_STATE (0x80bb0007) aIID={4afe423b-43e0-e9d0-82e8-ceb307940dda} aComponent={MediumWrap} aText={Medium 'C:\ProgramData\BOINC\slots\3\mainimage9744165289872471.vdi' is locked for reading by another task}, preserve=true  aResultDetail=0
64:27:56.381804 DeleteSnap ERROR [COM]: aRC=VBOX_E_INVALID_OBJECT_STATE (0x80bb0007) aIID={4afe423b-43e0-e9d0-82e8-ceb307940dda} aComponent={MediumWrap} aText={Medium 'C:\ProgramData\BOINC\slots\3\deb_port9744165289872471.vdi' is locked for reading by another task}, preserve=true  aResultDetail=0
64:47:05.173291 DeleteSnap ERROR [COM]: aRC=VBOX_E_INVALID_OBJECT_STATE (0x80bb0007) aIID={4afe423b-43e0-e9d0-82e8-ceb307940dda} aComponent={MediumWrap} aText={Medium 'C:\ProgramData\BOINC\slots\3\mainimage9744165289872471.vdi' is locked for reading by another task}, preserve=true  aResultDetail=0
64:47:05.173291 DeleteSnap ERROR [COM]: aRC=VBOX_E_INVALID_OBJECT_STATE (0x80bb0007) aIID={4afe423b-43e0-e9d0-82e8-ceb307940dda} aComponent={MediumWrap} aText={Medium 'C:\ProgramData\BOINC\slots\3\deb_port9744165289872471.vdi' is locked for reading by another task}, preserve=true  aResultDetail=0
65:03:45.333979          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
65:03:45.348620          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
65:03:45.355458          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={4afe423b-43e0-e9d0-82e8-ceb307940dda} aComponent={MediumWrap} aText={The object is not ready}, preserve=false aResultDetail=0
65:03:45.356429          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
65:03:54.910403          ERROR [COM]: aRC=VBOX_E_OBJECT_NOT_FOUND (0x80bb0001) aIID={0169423f-46b4-cde9-91af-1e9d5b6cd945} aComponent={VirtualBoxWrap} aText={Could not find a registered machine named 'boinc_83360ce82325e879'}, preserve=false aResultDetail=0
65:04:00.106613          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
65:06:15.467452 DeleteSnap ERROR [COM]: aRC=VBOX_E_INVALID_OBJECT_STATE (0x80bb0007) aIID={4afe423b-43e0-e9d0-82e8-ceb307940dda} aComponent={MediumWrap} aText={Medium 'C:\ProgramData\BOINC\slots\3\mainimage9744165289872471.vdi' is locked for reading by another task}, preserve=true  aResultDetail=0
65:06:15.467452 DeleteSnap ERROR [COM]: aRC=VBOX_E_INVALID_OBJECT_STATE (0x80bb0007) aIID={4afe423b-43e0-e9d0-82e8-ceb307940dda} aComponent={MediumWrap} aText={Medium 'C:\ProgramData\BOINC\slots\3\deb_port9744165289872471.vdi' is locked for reading by another task}, preserve=true  aResultDetail=0
65:25:51.699064 DeleteSnap ERROR [COM]: aRC=VBOX_E_INVALID_OBJECT_STATE (0x80bb0007) aIID={4afe423b-43e0-e9d0-82e8-ceb307940dda} aComponent={MediumWrap} aText={Medium 'C:\ProgramData\BOINC\slots\3\mainimage9744165289872471.vdi' is locked for reading by another task}, preserve=true  aResultDetail=0
65:25:51.700040 DeleteSnap ERROR [COM]: aRC=VBOX_E_INVALID_OBJECT_STATE (0x80bb0007) aIID={4afe423b-43e0-e9d0-82e8-ceb307940dda} aComponent={MediumWrap} aText={Medium 'C:\ProgramData\BOINC\slots\3\deb_port9744165289872471.vdi' is locked for reading by another task}, preserve=true  aResultDetail=0
65:45:00.690690 DeleteSnap ERROR [COM]: aRC=VBOX_E_INVALID_OBJECT_STATE (0x80bb0007) aIID={4afe423b-43e0-e9d0-82e8-ceb307940dda} aComponent={MediumWrap} aText={Medium 'C:\ProgramData\BOINC\slots\3\mainimage9744165289872471.vdi' is locked for reading by another task}, preserve=true  aResultDetail=0
65:45:00.691656 DeleteSnap ERROR [COM]: aRC=VBOX_E_INVALID_OBJECT_STATE (0x80bb0007) aIID={4afe423b-43e0-e9d0-82e8-ceb307940dda} aComponent={MediumWrap} aText={Medium 'C:\ProgramData\BOINC\slots\3\deb_port9744165289872471.vdi' is locked for reading by another task}, preserve=true  aResultDetail=0
65:45:38.175782 USBPROXY Getting USB descriptor failed with error 31
65:46:23.094261 USBPROXY Getting USB descriptor failed with error 31
65:46:23.094261 USBPROXY Getting USB descriptor failed with error 31
66:04:24.851296 DeleteSnap ERROR [COM]: aRC=VBOX_E_INVALID_OBJECT_STATE (0x80bb0007) aIID={4afe423b-43e0-e9d0-82e8-ceb307940dda} aComponent={MediumWrap} aText={Medium 'C:\ProgramData\BOINC\slots\3\mainimage9744165289872471.vdi' is locked for reading by another task}, preserve=true  aResultDetail=0
66:04:24.851296 DeleteSnap ERROR [COM]: aRC=VBOX_E_INVALID_OBJECT_STATE (0x80bb0007) aIID={4afe423b-43e0-e9d0-82e8-ceb307940dda} aComponent={MediumWrap} aText={Medium 'C:\ProgramData\BOINC\slots\3\deb_port9744165289872471.vdi' is locked for reading by another task}, preserve=true  aResultDetail=0
66:24:07.689784 DeleteSnap ERROR [COM]: aRC=VBOX_E_INVALID_OBJECT_STATE (0x80bb0007) aIID={4afe423b-43e0-e9d0-82e8-ceb307940dda} aComponent={MediumWrap} aText={Medium 'C:\ProgramData\BOINC\slots\3\mainimage9744165289872471.vdi' is locked for reading by another task}, preserve=true  aResultDetail=0
66:24:07.690747 DeleteSnap ERROR [COM]: aRC=VBOX_E_INVALID_OBJECT_STATE (0x80bb0007) aIID={4afe423b-43e0-e9d0-82e8-ceb307940dda} aComponent={MediumWrap} aText={Medium 'C:\ProgramData\BOINC\slots\3\deb_port9744165289872471.vdi' is locked for reading by another task}, preserve=true  aResultDetail=0
66:43:19.905850 DeleteSnap ERROR [COM]: aRC=VBOX_E_INVALID_OBJECT_STATE (0x80bb0007) aIID={4afe423b-43e0-e9d0-82e8-ceb307940dda} aComponent={MediumWrap} aText={Medium 'C:\ProgramData\BOINC\slots\3\mainimage9744165289872471.vdi' is locked for reading by another task}, preserve=true  aResultDetail=0
66:43:19.905850 DeleteSnap ERROR [COM]: aRC=VBOX_E_INVALID_OBJECT_STATE (0x80bb0007) aIID={4afe423b-43e0-e9d0-82e8-ceb307940dda} aComponent={MediumWrap} aText={Medium 'C:\ProgramData\BOINC\slots\3\deb_port9744165289872471.vdi' is locked for reading by another task}, preserve=true  aResultDetail=0
66:49:00.012269          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
66:49:00.024958          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
66:49:00.031802          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={4afe423b-43e0-e9d0-82e8-ceb307940dda} aComponent={MediumWrap} aText={The object is not ready}, preserve=false aResultDetail=0
66:49:00.032766          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

    VM Execution Log:


    VM Startup Log:


    VM Trace Log:

05:23:06 (18248): called boinc_finish(194)

</stderr_txt>
]]>