Task 6584907

Name	07526548_109_1
Workunit	5181119
Created	18 Oct 2019, 8:58:43 UTC
Sent	18 Oct 2019, 9:38:04 UTC
Report deadline	23 Oct 2019, 9:38:04 UTC
Received	18 Oct 2019, 14:00:44 UTC
Server state	Over
Outcome	Validate error
Client state	Done
Exit status	0 (0x00000000)
Computer ID	3162
Run time	10 min 25 sec
CPU time	6 min 47 sec
Validate state	Invalid
Credit	0.00
Device peak FLOPS	2.21 GFLOPS
Application version	boinc2docker v1.12 (vbox64_mt) x86_64-pc-linux-gnu
Peak working set size	237.56 MB
Peak swap size	3.93 GB
Peak disk usage	499.01 MB
Stderr output

<core_client_version>7.9.2</core_client_version>
<![CDATA[
<stderr_txt>
2019-10-18 08:47:23 (5226): vboxwrapper (7.7.26197): starting
2019-10-18 08:47:24 (5226): Feature: Checkpoint interval offset (523 seconds)
2019-10-18 08:47:24 (5226): Detected: VirtualBox VboxManage Interface (Version: 5.2.32)
2019-10-18 08:47:24 (5226): Detected: Minimum checkpoint interval (600.000000 seconds)
2019-10-18 08:47:24 (5226): Create VM. (boinc_08c811e22feccfa4, slot#9)
2019-10-18 08:47:24 (5226): Updating drive controller type and model for desired configuration.
2019-10-18 08:47:25 (5226): Setting Memory Size for VM. (3072MB)
2019-10-18 08:47:25 (5226): Setting CPU Count for VM. (1)
2019-10-18 08:47:25 (5226): Setting Chipset Options for VM.
2019-10-18 08:47:25 (5226): Setting Boot Options for VM.
2019-10-18 08:47:25 (5226): Setting Network Configuration for NAT.
2019-10-18 08:47:26 (5226): Enabling VM Network Access.
2019-10-18 08:47:26 (5226): Disabling USB Support for VM.
2019-10-18 08:47:26 (5226): Disabling COM Port Support for VM.
2019-10-18 08:47:26 (5226): Disabling LPT Port Support for VM.
2019-10-18 08:47:27 (5226): Disabling Audio Support for VM.
2019-10-18 08:47:27 (5226): Disabling Clipboard Support for VM.
2019-10-18 08:47:27 (5226): Disabling Drag and Drop Support for VM.
2019-10-18 08:47:27 (5226): Adding storage controller(s) to VM.
2019-10-18 08:47:27 (5226): Adding virtual ISO 9660 disk drive to VM. (vm_isocontext.iso)
2019-10-18 08:47:28 (5226): Adding VirtualBox Guest Additions to VM.
2019-10-18 08:47:28 (5226): Adding network bandwidth throttle group to VM. (Defaulting to 1024GB)
2019-10-18 08:47:28 (5226): Enabling shared directory for VM.
2019-10-18 08:47:28 (5226): Starting VM. (boinc_08c811e22feccfa4, slot#9)
2019-10-18 08:47:30 (5226): Successfully started VM. (PID = '6818')
2019-10-18 08:47:30 (5226): Reporting VM Process ID to BOINC.
2019-10-18 08:47:30 (5226): Guest Log: BIOS: VirtualBox 5.2.32
2019-10-18 08:47:30 (5226): Guest Log: CPUID EDX: 0x078bfbff
2019-10-18 08:47:31 (5226): VM state change detected. (old = 'poweroff', new = 'running')
2019-10-18 08:47:31 (5226): Preference change detected
2019-10-18 08:47:31 (5226): Setting CPU throttle for VM. (100%)
2019-10-18 08:47:31 (5226): Setting checkpoint interval to 3000 seconds. (Higher value of (Preference: 3000 seconds) or (Vbox_job.xml: 600 seconds))
2019-10-18 08:47:32 (5226): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2019-10-18 08:47:32 (5226): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=80
2019-10-18 08:47:32 (5226): Guest Log: BIOS: Boot from Hard Disk 0 failed
2019-10-18 08:47:32 (5226): Guest Log: BIOS: Boot : bseqnr=2, bootseq=0003
2019-10-18 08:47:32 (5226): Guest Log: BIOS: Booting from CD-ROM...
2019-10-18 08:47:32 (5226): Guest Log: BIOS: KBD: unsupported int 16h function 03
2019-10-18 08:47:32 (5226): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 
2019-10-18 08:47:48 (5226): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2019-10-18 08:47:48 (5226): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)
2019-10-18 08:48:07 (5226): Guest Log: net.ipv4.ip_forward = 1
2019-10-18 08:48:07 (5226): Guest Log: sysctl: cannot stat /proc/sys/net/ipv6/conf/all/forwarding: No such file or directory
2019-10-18 08:48:07 (5226): Guest Log: sysctl: setting key "cannot stat %s": No such file or directory
2019-10-18 08:48:07 (5226): Guest Log: sysctl: "cannot stat %s" is an unknown key
2019-10-18 08:48:07 (5226): Guest Log: sysctl: setting key "cannot stat %s": No such file or directory
2019-10-18 08:48:07 (5226): Guest Log: Segmentation fault
2019-10-18 08:48:07 (5226): Guest Log: automount ...
2019-10-18 08:48:08 (5226): Guest Log: Is the disk unpartitioned?, test for the 'boot2docker format-me' string
2019-10-18 08:48:08 (5226): Guest Log: automount over.
2019-10-18 08:48:08 (5226): Guest Log: [1;32mSetting hostname to [1;35mboot2docker[0;39m [1;32mDone.[0;39m
2019-10-18 08:48:08 (5226): Guest Log: Fri Oct 18 08:48:06 UTC 2019 dhcp -------------------------------
2019-10-18 08:48:12 (5226): Guest Log: udevadm settle - timeout of 5 seconds reached, the event queue contains:
2019-10-18 08:48:12 (5226): Guest Log:   /sys/devices/pci0000:00/0000:00:0d.0/ata1/host0/target0:0:0/0:0:0:0/block/sr0 (1107)
2019-10-18 08:48:13 (5226): Guest Log:   /sys/devices/LNXSYSTM:00/LNXSYBUS:00/PNP0A03:00/device:00/PNP0700:00 (1338)
2019-10-18 08:48:13 (5226): Guest Log:   /sys/devices/pci0000:00/0000:00:0d.0 (1358)
2019-10-18 08:48:13 (5226): Guest Log:   /sys/devices/pci0000:00/0000:00:0d.0/ata1/ata_port/ata1 (1359)
2019-10-18 08:48:13 (5226): Guest Log:   /sys/devices/pci0000:00/0000:00:0d.0/ata1/host0 (1360)
2019-10-18 08:48:13 (5226): Guest Log:   /sys/devices/pci0000:00/0000:00:0d.0/ata1/host0/scsi_host/host0 (1361)
2019-10-18 08:48:13 (5226): Guest Log:   /sys/devices/pci0000:00/0000:00:0d.0/ata1/host0/target0:0:0 (1362)
2019-10-18 08:48:13 (5226): Guest Log:   /sys/devices/pci0000:00/0000:00:0d.0/ata1/host0/target0:0:0/0:0:0:0 (1363)
2019-10-18 08:48:13 (5226): Guest Log:   /sys/devices/pci0000:00/0000:00:0d.0/ata1/host0/target0:0:0/0:0:0:0/block/sr0 (1364)
2019-10-18 08:48:13 (5226): Guest Log:   /sys/devices/pci0000:00/0000:00:0d.0/ata1/host0/target0:0:0/0:0:0:0/bsg/0:0:0:0 (1365)
2019-10-18 08:48:13 (5226): Guest Log:   /sys/devices/pci0000:00/0000:00:0d.0/ata1/host0/target0:0:0/0:0:0:0/scsi_device/0:0:0:0 (1366)
2019-10-18 08:48:13 (5226): Guest Log:   /sys/devices/pci0000:00/0000:00:0d.0/ata1/host0/target0:0:0/0:0:0:0/scsi_generic/sg0 (1367)
2019-10-18 08:48:13 (5226): Guest Log:   /sys/devices/pci0000:00/0000:00:0d.0/ata1/link1/ata_link/link1 (1368)
2019-10-18 08:48:13 (5226): Guest Log:   /sys/devices/pci0000:00/0000:00:0d.0/ata1/link1/dev1.0/ata_device/dev1.0 (1369)
2019-10-18 08:48:13 (5226): Guest Log:   /sys/devices/pci0000:00/0000:00:0d.0/ata2/ata_port/ata2 (1370)
2019-10-18 08:48:13 (5226): Guest Log:   /sys/devices/pci0000:00/0000:00:0d.0/ata2/host1 (1371)
2019-10-18 08:48:13 (5226): Guest Log:   /sys/devices/pci0000:00/0000:00:0d.0/ata2/host1/scsi_host/host1 (1372)
2019-10-18 08:48:13 (5226): Guest Log:   /sys/devices/pci0000:00/0000:00:0d.0/ata2/link2/ata_link/link2 (1373)
2019-10-18 08:48:13 (5226): Guest Log:   /sys/devices/pci0000:00/0000:00:0d.0/ata2/link2/dev2.0/ata_device/dev2.0 (1374)
2019-10-18 08:48:13 (5226): Guest Log:   /sys/devices/pci0000:00/0000:00:0d.0/ata3/ata_port/ata3 (1375)
2019-10-18 08:48:13 (5226): Guest Log:   /sys/devices/pci0000:00/0000:00:0d.0/ata3/host2 (1376)
2019-10-18 08:48:13 (5226): Guest Log:   /sys/devices/pci0000:00/0000:00:0d.0/ata3/host2/scsi_host/host2 (1377)
2019-10-18 08:48:13 (5226): Guest Log:   /sys/devices/pci0000:00/0000:00:0d.0/ata3/host2/target2:0:0 (1378)
2019-10-18 08:48:13 (5226): Guest Log:   /sys/devices/pci0000:00/0000:00:0d.0/ata3/host2/target2:0:0/2:0:0:0 (1379)
2019-10-18 08:48:13 (5226): Guest Log:   /sys/devices/pci0000:00/0000:00:0d.0/ata3/host2/target2:0:0/2:0:0:0/block/sr1 (1380)
2019-10-18 08:48:13 (5226): Guest Log:   /sys/devices/pci0000:00/0000:00:0d.0/ata3/host2/target2:0:0/2:0:0:0/bsg/2:0:0:0 (1381)
2019-10-18 08:48:13 (5226): Guest Log:   /sys/devices/pci0000:00/0000:00:0d.0/ata3/host2/target2:0:0/2:0:0:0/scsi_device/2:0:0:0 (1382)
2019-10-18 08:48:13 (5226): Guest Log:   /sys/devices/pci0000:00/0000:00:0d.0/ata3/host2/target2:0:0/2:0:0:0/scsi_generic/sg1 (1383)
2019-10-18 08:48:13 (5226): Guest Log:   /sys/devices/pci0000:00/0000:00:0d.0/ata3/link3/ata_link/link3 (1384)
2019-10-18 08:48:13 (5226): Guest Log:   /sys/devices/pci0000:00/0000:00:0d.0/ata3/link3/dev3.0/ata_device/dev3.0 (1385)
2019-10-18 08:48:13 (5226): Guest Log:   /sys/devices/pci0000:00/0000:00:0d.0/ata1/host0/target0:0:0/0:0:0:0/block/sr0 (1565)
2019-10-18 08:48:13 (5226): Guest Log:   /sys/devices/pci0000:00/0000:00:0d.0/ata3/host2/target2:0:0/2:0:0:0/block/sr1 (1566)
2019-10-18 08:48:14 (5226): Guest Log: Fri Oct 18 08:48:12 UTC 2019 dhcp -------------------------------
2019-10-18 08:48:14 (5226): Guest Log: VBoxService 5.0.16 r105871 (verbosity: 0) linux.amd64 (Mar  4 2016 17:38:55) release log
2019-10-18 08:48:14 (5226): Guest Log: 00:00:00.000209 main     Log opened 2019-10-18T08:48:12.470924000Z
2019-10-18 08:48:14 (5226): Guest Log: VBoxService 5.0.16 r105871 (verbosity: 0) linux.amd64 (Mar  4 2016 17:38:55) release log
2019-10-18 08:48:14 (5226): Guest Log: 00:00:00.000209 main     Log opened 2019-10-18T08:48:12.470924000Z
2019-10-18 08:48:14 (5226): Guest Log: 00:00:00.005115 main     OS Product: Linux
2019-10-18 08:48:14 (5226): Guest Log: 00:00:00.005206 main     OS Release: 4.1.19-boot2docker
2019-10-18 08:48:14 (5226): Guest Log: 00:00:00.005268 main     OS Version: #1 SMP Sun Apr 17 19:40:54 UTC 2016
2019-10-18 08:48:14 (5226): Guest Log: 00:00:00.005321 main     Executable: /sbin/VBoxService
2019-10-18 08:48:14 (5226): Guest Log: 00:00:00.005330 main     Process ID: 809
2019-10-18 08:48:14 (5226): Guest Log: 00:00:00.005331 main     Package type: LINUX_64BITS_GENERIC
2019-10-18 08:48:14 (5226): Guest Log: 00:00:00.005115 main     OS Product: Linux
2019-10-18 08:48:14 (5226): Guest Log: 00:00:00.005206 main     OS Release: 4.1.19-boot2docker
2019-10-18 08:48:14 (5226): Guest Log: 00:00:00.005268 main     OS Version: #1 SMP Sun Apr 17 19:40:54 UTC 2016
2019-10-18 08:48:14 (5226): Guest Log: 00:00:00.005321 main     Executable: /sbin/VBoxService
2019-10-18 08:48:14 (5226): Guest Log: 00:00:00.005330 main     Process ID: 809
2019-10-18 08:48:14 (5226): Guest Log: 00:00:00.005331 main     Package type: LINUX_64BITS_GENERIC
2019-10-18 08:48:14 (5226): Guest Log: 00:00:00.053012 main     5.0.16 r105871 started. Verbose level = 0
2019-10-18 08:48:14 (5226): Guest Log: 00:00:00.053012 main     5.0.16 r105871 started. Verbose level = 0
2019-10-18 08:48:14 (5226): Guest Log: 00:00:00.105194 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-10-18 08:48:14 (5226): Guest Log: 00:00:00.105292 vminfo   Error: Unable to connect to system D-Bus (1/3): D-Bus not installed
2019-10-18 08:48:14 (5226): Guest Log: Mounting BOINC shared/...
2019-10-18 08:48:14 (5226): Guest Log: -------------------
2019-10-18 08:48:14 (5226): Guest Log: Fri Oct 18 13:48:14 UTC 2019
2019-10-18 08:48:19 (5226): Guest Log: 00:00:05.121299 vminfo   Error: Unable to connect to system D-Bus (2/3): D-Bus not installed
2019-10-18 08:48:19 (5226): Guest Log: Fri Oct 18 13:50:49 UTC 2019
2019-10-18 08:48:19 (5226): Guest Log: 1: lo: <LOOPBACK,UP,LOWER_UP> mtu 65536 qdisc noqueue state UNKNOWN group default 
2019-10-18 08:48:19 (5226): Guest Log:     link/loopback 00:00:00:00:00:00 brd 00:00:00:00:00:00
2019-10-18 08:48:19 (5226): Guest Log:     inet 127.0.0.1/8 scope host lo
2019-10-18 08:48:19 (5226): Guest Log:        valid_lft forever preferred_lft forever
2019-10-18 08:48:19 (5226): Guest Log:     inet6 ::1/128 scope host 
2019-10-18 08:48:19 (5226): Guest Log:        valid_lft forever preferred_lft forever
2019-10-18 08:48:19 (5226): Guest Log: 2: dummy0: <BROADCAST,NOARP> mtu 1500 qdisc noop state DOWN group default 
2019-10-18 08:48:19 (5226): Guest Log:     link/ether a6:06:ed:b4:93:86 brd ff:ff:ff:ff:ff:ff
2019-10-18 08:48:19 (5226): Guest Log: 3: eth0: <BROADCAST,MULTICAST,UP,LOWER_UP> mtu 1500 qdisc pfifo_fast state UP group default qlen 1000
2019-10-18 08:48:19 (5226): Guest Log:     link/ether 08:00:27:fd:9a:fa brd ff:ff:ff:ff:ff:ff
2019-10-18 08:48:19 (5226): Guest Log:     inet 10.0.2.15/24 brd 10.0.2.255 scope global eth0
2019-10-18 08:48:19 (5226): Guest Log:        valid_lft forever preferred_lft forever
2019-10-18 08:48:19 (5226): Guest Log:     inet6 fe80::a00:27ff:fefd:9afa/64 scope link 
2019-10-18 08:48:19 (5226): Guest Log:        valid_lft forever preferred_lft forever
2019-10-18 08:48:19 (5226): Guest Log: -------------------
2019-10-18 08:48:19 (5226): Guest Log: Linking /etc/docker to /var/lib/boot2docker for persistence
2019-10-18 08:48:19 (5226): Guest Log: Waiting for Docker daemon to start...
2019-10-18 08:48:21 (5226): Guest Log: REPOSITORY          TAG                 IMAGE ID            CREATED             SIZE
2019-10-18 08:48:21 (5226): Guest Log: Running boinc_app...
2019-10-18 08:48:21 (5226): Guest Log: Importing Docker image from BOINC...
2019-10-18 08:48:21 (5226): Guest Log: Filesystem                Size      Used Available Use% Mounted on
2019-10-18 08:48:21 (5226): Guest Log: tmpfs                     2.6G    164.2M      2.5G   6% /
2019-10-18 08:48:21 (5226): Guest Log: tmpfs                     1.5G         0      1.5G   0% /dev/shm
2019-10-18 08:48:21 (5226): Guest Log: cgroup                    1.5G         0      1.5G   0% /sys/fs/cgroup
2019-10-18 08:48:21 (5226): Guest Log: shared                   61.2G     18.5G     42.7G  30% /root/shared
2019-10-18 08:48:21 (5226): Guest Log: tmpfs                     2.6G    164.2M      2.5G   6% /var/lib/docker/aufs
2019-10-18 08:48:24 (5226): Guest Log: 00:00:10.480316 vminfo   Error: Unable to connect to system D-Bus (3/3): D-Bus not installed
2019-10-18 08:48:34 (5226): Guest Log: doing docker load...
2019-10-18 08:49:00 (5226): Guest Log: Filesystem                Size      Used Available Use% Mounted on
2019-10-18 08:49:00 (5226): Guest Log: tmpfs                     2.6G    663.1M      2.0G  24% /
2019-10-18 08:49:00 (5226): Guest Log: tmpfs                     1.5G         0      1.5G   0% /dev/shm
2019-10-18 08:49:00 (5226): Guest Log: cgroup                    1.5G         0      1.5G   0% /sys/fs/cgroup
2019-10-18 08:49:00 (5226): Guest Log: shared                   61.2G     18.6G     42.6G  30% /root/shared
2019-10-18 08:49:00 (5226): Guest Log: tmpfs                     2.6G    663.1M      2.0G  24% /var/lib/docker/aufs
2019-10-18 08:49:00 (5226): Guest Log:               total        used        free      shared  buff/cache   available
2019-10-18 08:49:00 (5226): Guest Log: Mem:           3007          50        2255         663         701        2255
2019-10-18 08:49:00 (5226): Guest Log: Swap:           701           0         701
2019-10-18 08:49:00 (5226): Guest Log: Building apps directory...
2019-10-18 08:53:00 (5226): Guest Log: Prerun diagnostics...
2019-10-18 08:53:00 (5226): Guest Log: REPOSITORY                    TAG                 IMAGE ID            CREATED             SIZE
2019-10-18 08:53:00 (5226): Guest Log: nanohub_apps_share64_matlab   4                   32c863520615        22 months ago       488.2 MB
2019-10-18 08:53:00 (5226): Guest Log: CONTAINER ID        IMAGE               COMMAND             CREATED             STATUS              PORTS               NAMES
2019-10-18 08:53:00 (5226): Guest Log: 499.0M	/var/lib/docker
2019-10-18 08:53:00 (5226): Guest Log:               total        used        free      shared  buff/cache   available
2019-10-18 08:53:00 (5226): Guest Log: Mem:           3007          53        2240         663         713        2250
2019-10-18 08:53:00 (5226): Guest Log: Swap:           701           0         701
2019-10-18 08:53:00 (5226): Guest Log: Filesystem                Size      Used Available Use% Mounted on
2019-10-18 08:53:00 (5226): Guest Log: tmpfs                     2.6G    663.1M      2.0G  24% /
2019-10-18 08:53:00 (5226): Guest Log: tmpfs                     1.5G         0      1.5G   0% /dev/shm
2019-10-18 08:53:00 (5226): Guest Log: cgroup                    1.5G         0      1.5G   0% /sys/fs/cgroup
2019-10-18 08:53:00 (5226): Guest Log: shared                   61.2G     28.0G     33.2G  46% /root/shared
2019-10-18 08:53:00 (5226): Guest Log: tmpfs                     2.6G    663.1M      2.0G  24% /var/lib/docker/aufs
2019-10-18 08:53:00 (5226): Guest Log: Running... 
2019-10-18 08:53:01 (5226): Guest Log: 07526548_109.boinc
2019-10-18 08:53:01 (5226): Guest Log: 07526548_109.sh
2019-10-18 08:57:32 (5226): Guest Log: boinc_app exited (0)
2019-10-18 08:57:32 (5226): Guest Log: Saving results...
2019-10-18 08:57:32 (5226): Guest Log: 07526548_109_output.tar.gz
2019-10-18 08:57:33 (5226): VM Completion File Detected.
2019-10-18 08:57:33 (5226): Powering off VM.
2019-10-18 08:57:38 (5226): Successfully stopped VM.
2019-10-18 08:57:38 (5226): Deregistering VM. (boinc_08c811e22feccfa4, slot#9)
2019-10-18 08:57:38 (5226): Removing network bandwidth throttle group from VM.
2019-10-18 08:57:43 (5226): Removing storage controller(s) from VM.
2019-10-18 08:57:49 (5226): Removing VM from VirtualBox.
2019-10-18 08:57:52 (5226): Removing virtual ISO 9660 disk from VirtualBox.
08:57:57 (5226): called boinc_finish(0)

</stderr_txt>
]]>