Task 2126075

Name	07221815_037_0
Workunit	1544633
Created	21 May 2019, 11:38:47 UTC
Sent	21 May 2019, 12:10:13 UTC
Report deadline	26 May 2019, 12:10:13 UTC
Received	22 May 2019, 12:42:32 UTC
Server state	Over
Outcome	Success
Client state	Done
Exit status	0 (0x00000000)
Computer ID	1802
Run time	5 min 30 sec
CPU time	4 min 14 sec
Validate state	Valid
Credit	2.31
Device peak FLOPS	3.92 GFLOPS
Application version	boinc2docker v1.12 (vbox64_mt) windows_x86_64
Peak working set size	89.94 MB
Peak swap size	100.23 MB
Peak disk usage	274.68 MB
Stderr output

<core_client_version>7.6.33</core_client_version>
<![CDATA[
<stderr_txt>
2019-05-22 14:01:58 (19292): vboxwrapper (7.9.26200): starting
2019-05-22 14:01:58 (19292): Feature: Checkpoint interval offset (554 seconds)
2019-05-22 14:01:58 (19292): Detected: VirtualBox COM Interface (Version: 5.2.8)
2019-05-22 14:01:58 (19292): Detected: Minimum checkpoint interval (600.000000 seconds)
2019-05-22 14:01:58 (19292): Create VM. (boinc_ccc04b876e30b403, slot#3)
2019-05-22 14:01:58 (19292): Updating drive controller type and model for desired configuration.
2019-05-22 14:02:00 (19292): Setting Memory Size for VM. (3072MB)
2019-05-22 14:02:00 (19292): Setting CPU Count for VM. (1)
2019-05-22 14:02:00 (19292): Setting Chipset Options for VM.
2019-05-22 14:02:00 (19292): Setting Boot Options for VM.
2019-05-22 14:02:01 (19292): Enabling VM Network Access.
2019-05-22 14:02:01 (19292): Setting Network Configuration for NAT.
2019-05-22 14:02:01 (19292): Disabling USB Support for VM.
2019-05-22 14:02:01 (19292): Disabling COM Port Support for VM.
2019-05-22 14:02:01 (19292): Disabling LPT Port Support for VM.
2019-05-22 14:02:01 (19292): Disabling Audio Support for VM.
2019-05-22 14:02:01 (19292): Disabling Clipboard Support for VM.
2019-05-22 14:02:01 (19292): Disabling Drag and Drop Support for VM.
2019-05-22 14:02:01 (19292): Adding storage controller(s) to VM.
2019-05-22 14:02:01 (19292): Adding virtual ISO 9660 disk drive to VM. (vm_isocontext.iso)
2019-05-22 14:02:01 (19292): Adding VirtualBox Guest Additions to VM.
2019-05-22 14:02:01 (19292): Adding network bandwidth throttle group to VM. (Defaulting to 1024GB)
2019-05-22 14:02:01 (19292): Enabling shared directory for VM.
2019-05-22 14:02:02 (19292): Starting VM. (boinc_ccc04b876e30b403, slot#3)
2019-05-22 14:02:26 (19292): Guest Log: BIOS: VirtualBox 5.2.8

2019-05-22 14:02:26 (19292): Guest Log: CPUID EDX: 0x078bfbff

2019-05-22 14:02:26 (19292): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032

2019-05-22 14:02:26 (19292): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=80

2019-05-22 14:02:26 (19292): Guest Log: BIOS: Boot from Hard Disk 0 failed

2019-05-22 14:02:26 (19292): Guest Log: BIOS: Boot : bseqnr=2, bootseq=0003

2019-05-22 14:02:26 (19292): Guest Log: BIOS: Booting from CD-ROM...

2019-05-22 14:02:26 (19292): Successfully started VM. (PID = '21376')
2019-05-22 14:02:26 (19292): Reporting VM Process ID to BOINC.
2019-05-22 14:02:31 (19292): Guest Log: BIOS: KBD: unsupported int 16h function 03

2019-05-22 14:02:31 (19292): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 

2019-05-22 14:02:31 (19292): VM state change detected. (old = 'poweroff', new = 'running')
2019-05-22 14:02:41 (19292): Preference change detected
2019-05-22 14:02:41 (19292): Setting CPU throttle for VM. (100%)
2019-05-22 14:02:42 (19292): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 180 seconds) or (Vbox_job.xml: 600 seconds))
2019-05-22 14:02:52 (19292): VM state change detected. (old = 'running', new = 'paused')
2019-05-22 14:03:02 (19292): VM state change detected. (old = 'paused', new = 'running')
2019-05-22 14:03:07 (19292): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds

2019-05-22 14:03:07 (19292): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)

2019-05-22 14:03:12 (19292): Guest Log: net.ipv4.ip_forward = 1

2019-05-22 14:03:12 (19292): Guest Log: sysctl: cannot stat /proc/sys/net/ipv6/conf/all/forwarding: No such file or directory

2019-05-22 14:03:12 (19292): Guest Log: sysctl: setting key "cannot stat %s": No such file or directory

2019-05-22 14:03:12 (19292): Guest Log: sysctl: "cannot stat %s" is an unknown key

2019-05-22 14:03:12 (19292): Guest Log: sysctl: setting key "cannot stat %s": No such file or directory

2019-05-22 14:03:12 (19292): Guest Log: Segmentation fault

2019-05-22 14:03:12 (19292): Guest Log: automount ...

2019-05-22 14:03:12 (19292): Guest Log: Is the disk unpartitioned?, test for the 'boot2docker format-me' string

2019-05-22 14:03:12 (19292): Guest Log: automount over.

2019-05-22 14:03:12 (19292): Guest Log: [1;32mSetting hostname to [1;35mboot2docker[0;39m [1;32mDone.[0;39m

2019-05-22 14:03:12 (19292): Guest Log: Wed May 22 14:02:58 UTC 2019 dhcp -------------------------------

2019-05-22 14:03:12 (19292): VM state change detected. (old = 'running', new = 'paused')
2019-05-22 14:03:22 (19292): VM state change detected. (old = 'paused', new = 'running')
2019-05-22 14:03:27 (19292): Guest Log: udevadm settle - timeout of 5 seconds reached, the event queue contains:

2019-05-22 14:03:27 (19292): Guest Log:   /sys/devices/LNXSYSTM:00/LNXSYBUS:00/PNP0A03:00/device:00/PNP0700:00 (1343)

2019-05-22 14:03:27 (19292): Guest Log: Wed May 22 14:03:04 UTC 2019 dhcp -------------------------------

2019-05-22 14:03:27 (19292): Guest Log: VBoxService 5.0.16 r105871 (verbosity: 0) linux.amd64 (Mar  4 2016 17:38:55) release log

2019-05-22 14:03:27 (19292): Guest Log: 00:00:00.003967 main     Log opened 2019-05-22T14:03:04.662054000Z

2019-05-22 14:03:27 (19292): Guest Log: VBoxService 5.0.16 r105871 (verbosity: 0) linux.amd64 (Mar  4 2016 17:38:55) release log

2019-05-22 14:03:27 (19292): Guest Log: 00:00:00.015105 main     OS Product: Linux

2019-05-22 14:03:27 (19292): Guest Log: 00:00:00.016156 main     OS Release: 4.1.19-boot2docker

2019-05-22 14:03:27 (19292): Guest Log: 00:00:00.017228 main     OS Version: #1 SMP Sun Apr 17 19:40:54 UTC 2016

2019-05-22 14:03:27 (19292): Guest Log: 00:00:00.018308 main     Executable: /sbin/VBoxService

2019-05-22 14:03:27 (19292): Guest Log: 00:00:00.018322 main     Process ID: 819

2019-05-22 14:03:27 (19292): Guest Log: 00:00:00.018326 main     Package type: LINUX_64BITS_GENERIC

2019-05-22 14:03:27 (19292): Guest Log: 00:0000:00:00.029902 main     5.0.16 r105871 started. Verbose level = 0

2019-05-22 14:03:27 (19292): Guest Log: :00.003967 main     Log opened 2019-05-22T14:03:04.662054000Z

2019-05-22 14:03:27 (19292): Guest Log: 00:00:00.015105 main     OS Product: Linux

2019-05-22 14:03:27 (19292): Guest Log: 00:00:00.016156 main     OS Release: 4.1.19-boot2docker

2019-05-22 14:03:27 (19292): Guest Log: 00:00:00.017228 main     OS Version: #1 SMP Sun Apr 1700:00:00.072891 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

2019-05-22 14:03:27 (19292): Guest Log: 00:00:00.072972 vminfo   Error: Unable to connect to system D-Bus (1/3): D-Bus not installed

2019-05-22 14:03:27 (19292): Guest Log:  19:40:54 UTC 2016

2019-05-22 14:03:27 (19292): Guest Log: 00:00:00.018308 main     Executable: /sbin/VBoxService

2019-05-22 14:03:27 (19292): Guest Log: 00:00:00.018322 main     Process ID: 819

2019-05-22 14:03:27 (19292): Guest Log: 00:00:00.018326 main     Package type: LINUX_64BITS_GENERIC

2019-05-22 14:03:27 (19292): Guest Log: 00:00:00.029902 main     5.0.16 r105871 started. Verbose level = 0

2019-05-22 14:03:27 (19292): Guest Log: Mounting BOINC shared/...

2019-05-22 14:03:27 (19292): Guest Log: -------------------

2019-05-22 14:03:27 (19292): Guest Log: Wed May 22 12:03:26 UTC 2019

2019-05-22 14:03:33 (19292): Guest Log: 00:00:05.074667 vminfo   Error: Unable to connect to system D-Bus (2/3): D-Bus not installed

2019-05-22 14:03:33 (19292): Guest Log: Wed May 22 12:03:31 UTC 2019

2019-05-22 14:03:33 (19292): Guest Log: 1: lo: <LOOPBACK,UP,LOWER_UP> mtu 65536 qdisc noqueue state UNKNOWN group default 

2019-05-22 14:03:33 (19292): Guest Log:     link/loopback 00:00:00:00:00:00 brd 00:00:00:00:00:00

2019-05-22 14:03:33 (19292): Guest Log:     inet 127.0.0.1/8 scope host lo

2019-05-22 14:03:33 (19292): Guest Log:        valid_lft forever preferred_lft forever

2019-05-22 14:03:33 (19292): Guest Log: 2: dummy0: <BROADCAST,NOARP> mtu 1500 qdisc noop state DOWN group default 

2019-05-22 14:03:33 (19292): Guest Log:     link/ether 52:e7:41:5b:e4:4a brd ff:ff:ff:ff:ff:ff

2019-05-22 14:03:33 (19292): Guest Log: 3: eth0: <BROADCAST,MULTICAST,UP,LOWER_UP> mtu 1500 qdisc pfifo_fast state UP group default qlen 1000

2019-05-22 14:03:33 (19292): Guest Log:     link/ether 08:00:27:87:f0:84 brd ff:ff:ff:ff:ff:ff

2019-05-22 14:03:33 (19292): Guest Log:     inet 10.0.2.15/24 brd 10.0.2.255 scope global eth0

2019-05-22 14:03:33 (19292): Guest Log:        valid_lft forever preferred_lft forever

2019-05-22 14:03:33 (19292): Guest Log: -------------------

2019-05-22 14:03:33 (19292): Guest Log: Linking /etc/docker to /var/lib/boot2docker for persistence

2019-05-22 14:03:33 (19292): Guest Log: Waiting for Docker daemon to start...

2019-05-22 14:03:33 (19292): Guest Log: REPOSITORY          TAG                 IMAGE ID            CREATED             SIZE

2019-05-22 14:03:33 (19292): Guest Log: Running boinc_app...

2019-05-22 14:03:33 (19292): Guest Log: Importing Docker image from BOINC...

2019-05-22 14:03:33 (19292): Guest Log: Filesystem                Size      Used Available Use% Mounted on

2019-05-22 14:03:33 (19292): Guest Log: tmpfs                     2.6G    164.1M      2.5G   6% /

2019-05-22 14:03:33 (19292): Guest Log: tmpfs                     1.5G         0      1.5G   0% /dev/shm

2019-05-22 14:03:33 (19292): Guest Log: cgroup                    1.5G         0      1.5G   0% /sys/fs/cgroup

2019-05-22 14:03:33 (19292): Guest Log: shared                  905.3G    187.8G    717.4G  21% /root/shared

2019-05-22 14:03:33 (19292): Guest Log: tmpfs                     2.6G    164.1M      2.5G   6% /var/lib/docker/aufs

2019-05-22 14:03:33 (19292): VM state change detected. (old = 'running', new = 'paused')
2019-05-22 14:03:43 (19292): VM state change detected. (old = 'paused', new = 'running')
2019-05-22 14:03:48 (19292): Guest Log: 00:00:10.078670 vminfo   Error: Unable to connect to system D-Bus (3/3): D-Bus not installed

2019-05-22 14:03:53 (19292): VM state change detected. (old = 'running', new = 'paused')
2019-05-22 14:04:03 (19292): VM state change detected. (old = 'paused', new = 'running')
2019-05-22 14:04:25 (19292): Guest Log: doing docker load...

2019-05-22 14:04:25 (19292): VM state change detected. (old = 'running', new = 'paused')
2019-05-22 14:04:35 (19292): VM state change detected. (old = 'paused', new = 'running')
2019-05-22 14:04:45 (19292): VM state change detected. (old = 'running', new = 'paused')
2019-05-22 14:05:00 (19292): VM state change detected. (old = 'paused', new = 'running')
2019-05-22 14:05:11 (19292): VM state change detected. (old = 'running', new = 'paused')
2019-05-22 14:05:21 (19292): VM state change detected. (old = 'paused', new = 'running')
2019-05-22 14:05:31 (19292): VM state change detected. (old = 'running', new = 'paused')
2019-05-22 14:05:41 (19292): VM state change detected. (old = 'paused', new = 'running')
2019-05-22 14:05:46 (19292): Guest Log: Filesystem                Size      Used Available Use% Mounted on

2019-05-22 14:05:46 (19292): Guest Log: tmpfs                     2.6G    774.3M      1.9G  29% /

2019-05-22 14:05:46 (19292): Guest Log: tmpfs                     1.5G         0      1.5G   0% /dev/shm

2019-05-22 14:05:46 (19292): Guest Log: cgroup                    1.5G         0      1.5G   0% /sys/fs/cgroup

2019-05-22 14:05:46 (19292): Guest Log: shared                  905.3G    187.6G    717.6G  21% /root/shared

2019-05-22 14:05:47 (19292): Guest Log: tmpfs                     2.6G    774.3M      1.9G  29% /var/lib/docker/aufs

2019-05-22 14:05:47 (19292): Guest Log:               total        used        free      shared  buff/cache   available

2019-05-22 14:05:47 (19292): Guest Log: Mem:           3007          49        2141         774         816        2142

2019-05-22 14:05:47 (19292): Guest Log: Swap:           702           0         702

2019-05-22 14:05:47 (19292): Guest Log: Building apps directory...

2019-05-22 14:05:52 (19292): VM state change detected. (old = 'running', new = 'paused')
2019-05-22 14:06:02 (19292): VM state change detected. (old = 'paused', new = 'running')
2019-05-22 14:06:12 (19292): VM state change detected. (old = 'running', new = 'paused')
2019-05-22 14:06:22 (19292): VM state change detected. (old = 'paused', new = 'running')
2019-05-22 14:06:32 (19292): VM state change detected. (old = 'running', new = 'paused')
2019-05-22 14:06:42 (19292): VM state change detected. (old = 'paused', new = 'running')
2019-05-22 14:06:57 (19292): VM state change detected. (old = 'running', new = 'paused')
2019-05-22 14:07:07 (19292): VM state change detected. (old = 'paused', new = 'running')
2019-05-22 14:07:17 (19292): VM state change detected. (old = 'running', new = 'paused')
2019-05-22 14:07:27 (19292): VM state change detected. (old = 'paused', new = 'running')
2019-05-22 14:07:38 (19292): VM state change detected. (old = 'running', new = 'paused')
2019-05-22 14:07:48 (19292): VM state change detected. (old = 'paused', new = 'running')
2019-05-22 14:07:58 (19292): VM state change detected. (old = 'running', new = 'paused')
2019-05-22 14:08:08 (19292): VM state change detected. (old = 'paused', new = 'running')
2019-05-22 14:08:13 (19292): Guest Log: Prerun diagnostics...

2019-05-22 14:08:13 (19292): Guest Log: REPOSITORY            TAG                 IMAGE ID            CREATED             SIZE

2019-05-22 14:08:13 (19292): Guest Log: nanohub_apps_octave   4                   e3b06620cce8        17 months ago       599.1 MB

2019-05-22 14:08:13 (19292): Guest Log: CONTAINER ID        IMAGE               COMMAND             CREATED             STATUS              PORTS               NAMES

2019-05-22 14:08:13 (19292): Guest Log: 610.2M	/var/lib/docker

2019-05-22 14:08:13 (19292): Guest Log:               total        used        free      shared  buff/cache   available

2019-05-22 14:08:13 (19292): Guest Log: Mem:           3007          50        2138         774         818        2141

2019-05-22 14:08:13 (19292): Guest Log: Swap:           702           0         702

2019-05-22 14:08:13 (19292): Guest Log: Filesystem                Size      Used Available Use% Mounted on

2019-05-22 14:08:13 (19292): Guest Log: tmpfs                     2.6G    774.3M      1.9G  29% /

2019-05-22 14:08:13 (19292): Guest Log: tmpfs                     1.5G         0      1.5G   0% /dev/shm

2019-05-22 14:08:13 (19292): Guest Log: cgroup                    1.5G         0      1.5G   0% /sys/fs/cgroup

2019-05-22 14:08:13 (19292): Guest Log: shared                  905.3G    187.7G    717.6G  21% /root/shared

2019-05-22 14:08:13 (19292): Guest Log: tmpfs                     2.6G    774.3M      1.9G  29% /var/lib/docker/aufs

2019-05-22 14:08:13 (19292): Guest Log: Running... 

2019-05-22 14:08:13 (19292): Guest Log: 07221815_037.boinc

2019-05-22 14:08:13 (19292): Guest Log: 07221815_037.sh

2019-05-22 14:08:18 (19292): VM state change detected. (old = 'running', new = 'paused')
2019-05-22 14:08:28 (19292): VM state change detected. (old = 'paused', new = 'running')
2019-05-22 14:08:38 (19292): VM state change detected. (old = 'running', new = 'paused')
2019-05-22 14:08:49 (19292): VM state change detected. (old = 'paused', new = 'running')
2019-05-22 14:08:59 (19292): VM state change detected. (old = 'running', new = 'paused')
2019-05-22 14:09:14 (19292): VM state change detected. (old = 'paused', new = 'running')
2019-05-22 14:09:20 (19292): VM state change detected. (old = 'running', new = 'paused')
2019-05-22 14:09:31 (19292): VM state change detected. (old = 'paused', new = 'running')
2019-05-22 14:09:41 (19292): VM state change detected. (old = 'running', new = 'paused')
2019-05-22 14:09:56 (19292): VM state change detected. (old = 'paused', new = 'running')
2019-05-22 14:10:07 (19292): VM state change detected. (old = 'running', new = 'paused')
2019-05-22 14:10:17 (19292): VM state change detected. (old = 'paused', new = 'running')
2019-05-22 14:10:27 (19292): VM state change detected. (old = 'running', new = 'paused')
2019-05-22 14:10:37 (19292): VM state change detected. (old = 'paused', new = 'running')
2019-05-22 14:10:47 (19292): VM state change detected. (old = 'running', new = 'paused')
2019-05-22 14:10:57 (19292): VM state change detected. (old = 'paused', new = 'running')
2019-05-22 14:11:07 (19292): VM state change detected. (old = 'running', new = 'paused')
2019-05-22 14:11:22 (19292): VM state change detected. (old = 'paused', new = 'running')
2019-05-22 14:11:43 (19292): VM state change detected. (old = 'running', new = 'paused')
2019-05-22 14:11:53 (19292): VM state change detected. (old = 'paused', new = 'running')
2019-05-22 14:12:03 (19292): VM state change detected. (old = 'running', new = 'paused')
2019-05-22 14:12:13 (19292): VM state change detected. (old = 'paused', new = 'running')
2019-05-22 14:12:18 (19292): Guest Log: boinc_app exited (0)

2019-05-22 14:12:18 (19292): Guest Log: Saving results...

2019-05-22 14:12:18 (19292): Guest Log: 07221815_037_output.tar.gz

2019-05-22 14:12:18 (19292): VM Completion File Detected.
2019-05-22 14:12:18 (19292): Powering off VM.
2019-05-22 14:12:21 (19292): Successfully stopped VM.
2019-05-22 14:12:26 (19292): Deregistering VM. (boinc_ccc04b876e30b403, slot#3)
2019-05-22 14:12:26 (19292): Removing virtual disk drive(s) from VM.
2019-05-22 14:12:26 (19292): Removing network bandwidth throttle group from VM.
2019-05-22 14:12:26 (19292): Removing storage controller(s) from VM.
2019-05-22 14:12:26 (19292): Removing VM from VirtualBox.
14:12:32 (19292): called boinc_finish(0)

</stderr_txt>
]]>