Task 11024358

Name	08397631_02_0
Workunit	8554617
Created	10 Jul 2021, 0:10:40 UTC
Sent	10 Jul 2021, 15:41:01 UTC
Report deadline	15 Jul 2021, 15:41:01 UTC
Received	12 Jul 2021, 20:47:36 UTC
Server state	Over
Outcome	Success
Client state	Done
Exit status	0 (0x00000000)
Computer ID	5018
Run time	5 min 1 sec
CPU time	2 min 40 sec
Validate state	Valid
Credit	1.41
Device peak FLOPS	1.74 GFLOPS
Application version	boinc2docker v1.14 (vbox64_mt) windows_x86_64
Peak working set size	65.19 MB
Peak swap size	64.17 MB
Peak disk usage	227.37 MB
Stderr output

<core_client_version>7.16.11</core_client_version>
<![CDATA[
<stderr_txt>
2021-07-12 22:28:35 (13324): Detected: vboxwrapper 26202
2021-07-12 22:28:35 (13324): Detected: BOINC client v7.16.11
2021-07-12 22:28:36 (13324): Detected: VirtualBox VboxManage Interface (Version: 6.1.10)
2021-07-12 22:28:37 (13324): Create VM. (boinc_78f7866d3244e562, slot#2)
2021-07-12 22:28:37 (13324): Updating drive controller type and model for desired configuration.
2021-07-12 22:28:41 (13324): Setting Memory Size for VM. (3072MB)
2021-07-12 22:28:41 (13324): Setting CPU Count for VM. (1)
2021-07-12 22:28:41 (13324): Setting Chipset Options for VM.
2021-07-12 22:28:42 (13324): Setting Boot Options for VM.
2021-07-12 22:28:42 (13324): Setting Network Configuration for NAT.
2021-07-12 22:28:43 (13324): Enabling VM Network Access.
2021-07-12 22:28:43 (13324): Disabling USB Support for VM.
2021-07-12 22:28:43 (13324): Disabling COM Port Support for VM.
2021-07-12 22:28:44 (13324): Disabling LPT Port Support for VM.
2021-07-12 22:28:44 (13324): Disabling Audio Support for VM.
2021-07-12 22:28:45 (13324): Disabling Clipboard Support for VM.
2021-07-12 22:28:45 (13324): Disabling Drag and Drop Support for VM.
2021-07-12 22:28:45 (13324): Adding storage controller(s) to VM.
2021-07-12 22:28:45 (13324): Adding virtual ISO 9660 disk drive to VM. (vm_isocontext.iso)
2021-07-12 22:28:46 (13324): Adding VirtualBox Guest Additions to VM.
2021-07-12 22:28:46 (13324): Adding network bandwidth throttle group to VM. (Defaulting to 1024GB)
2021-07-12 22:28:46 (13324): Enabling shared directory for VM.
2021-07-12 22:28:47 (13324): Starting VM using VBoxManage interface. (boinc_78f7866d3244e562, slot#2)
2021-07-12 22:28:58 (13324): Successfully started VM. (PID = '2804')
2021-07-12 22:28:58 (13324): Reporting VM Process ID to BOINC.
2021-07-12 22:28:58 (13324): Guest Log: BIOS: VirtualBox 6.1.10
2021-07-12 22:28:58 (13324): Guest Log: CPUID EDX: 0x178bfbff
2021-07-12 22:28:58 (13324): Guest Log: BIOS: No PCI IDE controller, not probing IDE
2021-07-12 22:28:58 (13324): VM state change detected. (old = 'poweredoff', new = 'running')
2021-07-12 22:28:59 (13324): VM state change detected. (old = 'running', new = 'paused')
2021-07-12 22:29:25 (13324): Preference change detected
2021-07-12 22:29:30 (13324): Setting CPU throttle for VM. (60%)
2021-07-12 22:29:38 (13324): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2021-07-12 22:29:38 (13324): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2021-07-12 22:29:38 (13324): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=80
2021-07-12 22:29:38 (13324): Guest Log: BIOS: Boot from Hard Disk 0 failed
2021-07-12 22:29:39 (13324): Guest Log: BIOS: Boot : bseqnr=2, bootseq=0003
2021-07-12 22:29:39 (13324): Guest Log: BIOS: Booting from CD-ROM...
2021-07-12 22:29:39 (13324): Guest Log: BIOS: KBD: unsupported int 16h function 03
2021-07-12 22:29:39 (13324): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 
2021-07-12 22:29:39 (13324): VM state change detected. (old = 'paused', new = 'running')
2021-07-12 22:29:40 (13324): VM state change detected. (old = 'running', new = 'paused')
2021-07-12 22:30:08 (13324): VM state change detected. (old = 'paused', new = 'running')
2021-07-12 22:30:18 (13324): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2021-07-12 22:30:18 (13324): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)
2021-07-12 22:30:20 (13324): Guest Log: net.ipv4.ip_forward = 1
2021-07-12 22:30:20 (13324): Guest Log: sysctl: cannot stat /proc/sys/net/ipv6/conf/all/forwarding: No such file or directory
2021-07-12 22:30:20 (13324): Guest Log: sysctl: setting key "cannot stat %s": No such file or directory
2021-07-12 22:30:20 (13324): Guest Log: sysctl: "cannot stat %s" is an unknown key
2021-07-12 22:30:20 (13324): Guest Log: sysctl: setting key "cannot stat %s": No such file or directory
2021-07-12 22:30:20 (13324): Guest Log: Segmentation fault
2021-07-12 22:30:21 (13324): Guest Log: automount ...
2021-07-12 22:30:26 (13324): Guest Log: Is the disk unpartitioned?, test for the 'boot2docker format-me' string
2021-07-12 22:30:26 (13324): Guest Log: automount over.
2021-07-12 22:30:26 (13324): Guest Log: [1;32mSetting hostname to [1;35mboot2docker[0;39m [1;32mDone.[0;39m
2021-07-12 22:30:26 (13324): Guest Log: Mon Jul 12 22:29:32 UTC 2021 dhcp -------------------------------
2021-07-12 22:30:26 (13324): Guest Log: udevadm settle - timeout of 5 seconds reached, the event queue contains:
2021-07-12 22:30:27 (13324): Guest Log:   /sys/devices/LNXSYSTM:00/LNXSYBUS:00/PNP0A03:00/device:00/PNP0700:00 (1351)
2021-07-12 22:30:27 (13324): Guest Log:   /sys/devices/pci0000:00/0000:00:0d.0/ata1/host0/target0:0:0/0:0:0:0/block/sr0 (1581)
2021-07-12 22:30:27 (13324): Guest Log:   /sys/devices/pci0000:00/0000:00:0d.0/ata3/host2/target2:0:0/2:0:0:0/block/sr1 (1582)
2021-07-12 22:30:27 (13324): Guest Log:   /sys/devices/pci0000:00/0000:00:0d.0/ata3/host2/target2:0:0/2:0:0:0/block/sr1 (1585)
2021-07-12 22:30:27 (13324): Guest Log:   /sys/devices/pci0000:00/0000:00:0d.0/ata1/host0/target0:0:0/0:0:0:0/block/sr0 (1586)
2021-07-12 22:30:27 (13324): Guest Log: Mon Jul 12 22:29:38 UTC 2021 dhcp -------------------------------
2021-07-12 22:30:28 (13324): Guest Log: VBoxService 5.0.16 r105871 (verbosity: 0) linux.amd64 (Mar  4 2016 17:38:55) release log
2021-07-12 22:30:28 (13324): Guest Log: 00:00:00.000176 main     Log opened 2021-07-12T22:29:39.099083000Z
2021-07-12 22:30:28 (13324): Guest Log: VBoxService 5.0.16 r105871 (verbosity: 0) linux.amd64 (Mar  4 2016 17:38:55) release log
2021-07-12 22:30:28 (13324): Guest Log: 00:00:00.000176 main     Log opened 2021-07-00:00:00.006066 main     OS Product: Linux
2021-07-12 22:30:28 (13324): Guest Log: 00:00:00.006235 main     OS Release: 4.1.19-boot2docker
2021-07-12 22:30:28 (13324): Guest Log: 00:00:00.006338 main     OS Version: #1 SMP Sun Apr 17 19:40:54 UTC 2016
2021-07-12 22:30:28 (13324): Guest Log: 00:00:00.006418 main     Executable: /sbin/VBoxService
2021-07-12 22:30:28 (13324): Guest Log: 00:00:00.006421 main     Process ID: 842
2021-07-12 22:30:28 (13324): Guest Log: 00:00:00.006423 main     Package type: LINUX_64BITS_GENERIC
2021-07-12 22:30:28 (13324): Guest Log: 12T22:29:39.099083000Z
2021-07-12 22:30:28 (13324): Guest Log: 00:00:00.006066 main     OS Product: Linux
2021-07-12 22:30:28 (13324): Guest Log: 00:00:00.006235 main     OS Release: 4.1.19-boot2docker
2021-07-12 22:30:28 (13324): Guest Log: 00:00:00.006338 main     OS Version: #1 SMP Sun Apr 17 19:40:54 UTC 2016
2021-07-12 22:30:28 (13324): Guest Log: 00:00:00.006418 main  00:00:00.029500 main     5.0.16 r105871 started. Verbose level = 0
2021-07-12 22:30:28 (13324): Guest Log: 00:00:00.036157 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
2021-07-12 22:30:28 (13324): Guest Log: 00:00:00.039348 vminfo   Error: Unable to connect to system D-Bus (1/3): D-Bus not installed
2021-07-12 22:30:28 (13324): Guest Log:    Executable: /sbin/VBoxService
2021-07-12 22:30:28 (13324): Guest Log: 00:00:00.006421 main     Process ID: 842
2021-07-12 22:30:28 (13324): Guest Log: 00:00:00.006423 main     Package type: LINUX_64BITS_GENERIC
2021-07-12 22:30:28 (13324): Guest Log: 00:00:00.029500 main     5.0.16 r105871 started. Verbose level = 0
2021-07-12 22:30:28 (13324): Guest Log: Mounting BOINC shared/...
2021-07-12 22:30:28 (13324): Guest Log: -------------------
2021-07-12 22:30:28 (13324): Guest Log: Mon Jul 12 20:30:27 UTC 2021
2021-07-12 22:30:33 (13324): Guest Log: 00:00:05.046220 vminfo   Error: Unable to connect to system D-Bus (2/3): D-Bus not installed
2021-07-12 22:30:33 (13324): Guest Log: Mon Jul 12 20:30:35 UTC 2021
2021-07-12 22:30:33 (13324): Guest Log: 1: lo: <LOOPBACK,UP,LOWER_UP> mtu 65536 qdisc noqueue state UNKNOWN group default 
2021-07-12 22:30:33 (13324): Guest Log:     link/loopback 00:00:00:00:00:00 brd 00:00:00:00:00:00
2021-07-12 22:30:33 (13324): Guest Log:     inet 127.0.0.1/8 scope host lo
2021-07-12 22:30:33 (13324): Guest Log:        valid_lft forever preferred_lft forever
2021-07-12 22:30:33 (13324): Guest Log:     inet6 ::1/128 scope host 
2021-07-12 22:30:33 (13324): Guest Log:        valid_lft forever preferred_lft forever
2021-07-12 22:30:33 (13324): Guest Log: 2: dummy0: <BROADCAST,NOARP> mtu 1500 qdisc noop state DOWN group default 
2021-07-12 22:30:33 (13324): Guest Log:     link/ether 9a:5c:8c:56:31:c7 brd ff:ff:ff:ff:ff:ff
2021-07-12 22:30:33 (13324): Guest Log: 3: eth0: <BROADCAST,MULTICAST,UP,LOWER_UP> mtu 1500 qdisc pfifo_fast state UP group default qlen 1000
2021-07-12 22:30:33 (13324): Guest Log:     link/ether 08:00:27:38:2b:be brd ff:ff:ff:ff:ff:ff
2021-07-12 22:30:33 (13324): Guest Log:     inet 10.0.2.15/24 brd 10.0.2.255 scope global eth0
2021-07-12 22:30:33 (13324): Guest Log:        valid_lft forever preferred_lft forever
2021-07-12 22:30:33 (13324): Guest Log:     inet6 fe80::a00:27ff:fe38:2bbe/64 scope link 
2021-07-12 22:30:33 (13324): Guest Log:        valid_lft forever preferred_lft forever
2021-07-12 22:30:33 (13324): Guest Log: -------------------
2021-07-12 22:30:33 (13324): Guest Log: Linking /etc/docker to /var/lib/boot2docker for persistence
2021-07-12 22:30:33 (13324): Guest Log: Waiting for Docker daemon to start...
2021-07-12 22:30:35 (13324): Guest Log: REPOSITORY          TAG                 IMAGE ID            CREATED             SIZE
2021-07-12 22:30:35 (13324): Guest Log: Running boinc_app...
2021-07-12 22:30:35 (13324): Guest Log: Importing Docker image from BOINC...
2021-07-12 22:30:35 (13324): Guest Log: Filesystem                Size      Used Available Use% Mounted on
2021-07-12 22:30:35 (13324): Guest Log: tmpfs                     2.6G    164.2M      2.5G   6% /
2021-07-12 22:30:35 (13324): Guest Log: tmpfs                     1.5G         0      1.5G   0% /dev/shm
2021-07-12 22:30:35 (13324): Guest Log: cgroup                    1.5G         0      1.5G   0% /sys/fs/cgroup
2021-07-12 22:30:35 (13324): Guest Log: shared                   97.7G     96.3G      1.4G  99% /root/shared
2021-07-12 22:30:35 (13324): Guest Log: tmpfs                     2.6G    164.2M      2.5G   6% /var/lib/docker/aufs
2021-07-12 22:30:37 (13324): Guest Log: 00:00:10.049563 vminfo   Error: Unable to connect to system D-Bus (3/3): D-Bus not installed
2021-07-12 22:31:26 (13324): Guest Log: doing docker load...
2021-07-12 22:31:46 (13324): VM state change detected. (old = 'running', new = 'paused')
2021-07-12 22:32:24 (13324): VM state change detected. (old = 'paused', new = 'running')
2021-07-12 22:32:37 (13324): VM state change detected. (old = 'running', new = 'paused')
2021-07-12 22:32:47 (13324): VM state change detected. (old = 'paused', new = 'running')
2021-07-12 22:34:12 (13324): Error in pause VM for VM: -2135228414
Command:
VBoxManage -q controlvm "boinc_78f7866d3244e562" pause
Output:
VBoxManage.exe: error: Already paused
VBoxManage.exe: error: Details: code VBOX_E_INVALID_VM_STATE (0x80bb0002), component ConsoleWrap, interface IConsole, callee IUnknown
VBoxManage.exe: error: Context: "Pause()" at line 406 of file VBoxManageControlVM.cpp

2021-07-12 22:34:13 (13324): Guest Log: Filesystem                Size      Used Available Use% Mounted on
2021-07-12 22:34:13 (13324): Guest Log: tmpfs                     2.6G    631.9M      2.0G  23% /
2021-07-12 22:34:13 (13324): Guest Log: tmpfs                     1.5G         0      1.5G   0% /dev/shm
2021-07-12 22:34:13 (13324): Guest Log: cgroup                    1.5G         0      1.5G   0% /sys/fs/cgroup
2021-07-12 22:34:13 (13324): Guest Log: shared                   97.7G     96.7G    996.7M  99% /root/shared
2021-07-12 22:34:13 (13324): Guest Log: tmpfs                     2.6G    631.9M      2.0G  23% /var/lib/docker/aufs
2021-07-12 22:34:13 (13324): Guest Log:               total        used        free      shared  buff/cache   available
2021-07-12 22:34:13 (13324): Guest Log: Mem:           3007          50        2287         631         669        2287
2021-07-12 22:34:13 (13324): Guest Log: Swap:           700           0         700
2021-07-12 22:34:13 (13324): Guest Log: Building apps directory...
2021-07-12 22:34:13 (13324): VM state change detected. (old = 'running', new = 'paused')
2021-07-12 22:34:41 (13324): VM state change detected. (old = 'paused', new = 'running')
2021-07-12 22:35:38 (13324): VM state change detected. (old = 'running', new = 'paused')
2021-07-12 22:35:58 (13324): VM state change detected. (old = 'paused', new = 'running')
2021-07-12 22:36:04 (13324): VM state change detected. (old = 'running', new = 'paused')
2021-07-12 22:36:46 (13324): VM state change detected. (old = 'paused', new = 'running')
2021-07-12 22:37:21 (13324): Guest Log: Prerun diagnostics...
2021-07-12 22:37:21 (13324): Guest Log: REPOSITORY          TAG                 IMAGE ID            CREATED             SIZE
2021-07-12 22:37:21 (13324): Guest Log: nanohub_apps_base   11                  42db2bf7db3d        3 years ago         458.1 MB
2021-07-12 22:37:21 (13324): Guest Log: CONTAINER ID        IMAGE               COMMAND             CREATED             STATUS              PORTS               NAMES
2021-07-12 22:37:21 (13324): Guest Log: 467.8M	/var/lib/docker
2021-07-12 22:37:21 (13324): Guest Log:               total        used        free      shared  buff/cache   available
2021-07-12 22:37:21 (13324): Guest Log: Mem:           3007          53        2282         631         670        2283
2021-07-12 22:37:21 (13324): Guest Log: Swap:           700           0         700
2021-07-12 22:37:21 (13324): Guest Log: Filesystem                Size      Used Available Use% Mounted on
2021-07-12 22:37:21 (13324): Guest Log: tmpfs                     2.6G    631.9M      2.0G  23% /
2021-07-12 22:37:21 (13324): Guest Log: tmpfs                     1.5G         0      1.5G   0% /dev/shm
2021-07-12 22:37:21 (13324): Guest Log: cgroup                    1.5G         0      1.5G   0% /sys/fs/cgroup
2021-07-12 22:37:21 (13324): Guest Log: shared                   97.7G     96.8G    826.8M  99% /root/shared
2021-07-12 22:37:21 (13324): Guest Log: tmpfs                     2.6G    631.9M      2.0G  23% /var/lib/docker/aufs
2021-07-12 22:37:21 (13324): Guest Log: Running... 
2021-07-12 22:37:22 (13324): Guest Log: 08397631_02.boinc
2021-07-12 22:37:22 (13324): Guest Log: 08397631_02.sh
2021-07-12 22:38:07 (13324): VM state change detected. (old = 'running', new = 'paused')
2021-07-12 22:38:44 (13324): Guest Log: boinc_app exited (0)
2021-07-12 22:38:44 (13324): Guest Log: Saving results...
2021-07-12 22:38:44 (13324): Guest Log: 08397631_02_output.tar.gz
2021-07-12 22:38:44 (13324): VM state change detected. (old = 'paused', new = 'running')
2021-07-12 22:38:44 (13324): VM Completion File Detected.
2021-07-12 22:38:44 (13324): Powering off VM.
2021-07-12 22:38:49 (13324): Successfully stopped VM.
2021-07-12 22:38:49 (13324): Deregistering VM. (boinc_78f7866d3244e562, slot#2)
2021-07-12 22:38:50 (13324): Removing network bandwidth throttle group from VM.
2021-07-12 22:38:52 (13324): Removing VM from VirtualBox.
2021-07-12 22:38:53 (13324): Removing virtual ISO 9660 disk from VirtualBox.
22:38:59 (13324): called boinc_finish(0)

</stderr_txt>
]]>