| Name | Theory_2922-4847237-252_0 |
| Workunit | 234650457 |
| Created | 9 Sep 2025, 20:24:19 UTC |
| Sent | 10 Sep 2025, 6:49:43 UTC |
| Report deadline | 21 Sep 2025, 6:49:43 UTC |
| Received | 23 Sep 2025, 0:15:28 UTC |
| Server state | Over |
| Outcome | Success |
| Client state | Done |
| Exit status | 0 (0x00000000) |
| Computer ID | 10868386 |
| Run time | 11 hours 47 min 50 sec |
| CPU time | 1 hours 47 min 39 sec |
| Validate state | Valid |
| Credit | 480.31 |
| Device peak FLOPS | 4.89 GFLOPS |
| Application version | Theory Simulation v301.00 (vbox64_theory) windows_x86_64 |
| Peak working set size | 80.56 MB |
| Peak swap size | 81.20 MB |
| Peak disk usage | 1.18 GB |
Stderr output
<core_client_version>7.24.1</core_client_version>
<![CDATA[
<stderr_txt>
2025-09-10 13:05:18 (20808): vboxwrapper version 26210
2025-09-10 13:05:18 (20808): BOINC client version: 7.24.1
2025-09-10 13:05:18 (20808): Detected: VirtualBox VboxManage Interface (Version: 7.0.6)
2025-09-10 13:05:19 (20808): Detected: Heartbeat check (file: 'heartbeat' every 1800.000000 seconds)
2025-09-10 13:05:19 (20808): Successfully copied 'init_data.xml' to the shared directory.
2025-09-10 13:05:19 (20808): Successfully copied 'input' to the shared directory.
2025-09-10 13:05:19 (20808): Create VM. (boinc_b9d9a43ecdc55f50, slot#5)
2025-09-10 13:05:19 (20808): Setting Memory Size for VM. (1024MB)
2025-09-10 13:05:20 (20808): Setting CPU Count for VM. (1)
2025-09-10 13:05:20 (20808): Setting Chipset Options for VM.
2025-09-10 13:05:20 (20808): Setting Graphics Controller Options for VM. (Driver: VBoxVGA, 16MB)
2025-09-10 13:05:20 (20808): Setting Boot Options for VM.
2025-09-10 13:05:21 (20808): Setting Network Configuration for NAT. (Driver: virtio)
2025-09-10 13:05:21 (20808): Enabling VM Network Access.
2025-09-10 13:05:21 (20808): Disabling USB Support for VM.
2025-09-10 13:05:22 (20808): Disabling COM Port Support for VM.
2025-09-10 13:05:22 (20808): Disabling LPT Port Support for VM.
2025-09-10 13:05:22 (20808): Disabling Audio Support for VM.
2025-09-10 13:05:22 (20808): Disabling Clipboard Support for VM.
2025-09-10 13:05:23 (20808): Disabling Drag and Drop Support for VM.
2025-09-10 13:05:23 (20808): Adding storage controller(s) to VM.
2025-09-10 13:05:23 (20808): Adding virtual disk drive to VM. (Theory_2025_08_13_prod.vdi)
2025-09-10 13:05:24 (20808): Adding VirtualBox Guest Additions to VM.
2025-09-10 13:05:24 (20808): Adding network bandwidth throttle group to VM. (Defaulting to 1024GB)
2025-09-10 13:05:24 (20808): forwarding host port 63861 to guest port 80
2025-09-10 13:05:25 (20808): Enabling remote desktop for VM.
2025-09-10 13:05:25 (20808): Required extension pack not installed, remote desktop not enabled.
2025-09-10 13:05:25 (20808): Enabling shared directory for VM.
2025-09-10 13:05:25 (20808): Starting VM using VBoxManage interface. (boinc_b9d9a43ecdc55f50, slot#5)
2025-09-10 13:05:31 (20808): Successfully started VM. (PID = '12160')
2025-09-10 13:05:31 (20808): Reporting VM Process ID to BOINC.
2025-09-10 13:05:31 (20808): Guest Log: BIOS: VirtualBox 7.0.6
2025-09-10 13:05:31 (20808): Guest Log: CPUID EDX: 0x178bfbff
2025-09-10 13:05:31 (20808): Guest Log: BIOS: No PCI IDE controller, not probing IDE
2025-09-10 13:05:31 (20808): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000001400000 sectors
2025-09-10 13:05:31 (20808): VM state change detected. (old = 'poweredoff', new = 'running')
2025-09-10 13:05:31 (20808): Detected: Web Application Enabled (http://localhost:63861)
2025-09-10 13:05:31 (20808): Preference change detected
2025-09-10 13:05:31 (20808): Setting CPU throttle for VM. (10%)
2025-09-10 13:05:31 (20808): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2025-09-10 13:05:33 (20808): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2025-09-10 13:05:33 (20808): Guest Log: BIOS: Booting from Hard Disk...
2025-09-10 13:05:56 (20808): Guest Log: BIOS: KBD: unsupported int 16h function 03
2025-09-10 13:05:56 (20808): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000
2025-09-10 13:05:56 (20808): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=81
2025-09-10 13:05:56 (20808): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=81
2025-09-10 13:05:56 (20808): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=82
2025-09-10 13:05:56 (20808): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=82
2025-09-10 13:05:56 (20808): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=83
2025-09-10 13:05:56 (20808): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=83
2025-09-10 13:05:56 (20808): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=84
2025-09-10 13:05:56 (20808): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=84
2025-09-10 13:05:56 (20808): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=85
2025-09-10 13:05:56 (20808): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=85
2025-09-10 13:05:56 (20808): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=86
2025-09-10 13:05:56 (20808): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=86
2025-09-10 13:05:56 (20808): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=87
2025-09-10 13:05:56 (20808): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=87
2025-09-10 13:05:56 (20808): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=88
2025-09-10 13:05:56 (20808): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=88
2025-09-10 13:05:56 (20808): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=89
2025-09-10 13:05:56 (20808): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=89
2025-09-10 13:05:56 (20808): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8a
2025-09-10 13:05:56 (20808): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8a
2025-09-10 13:05:56 (20808): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8b
2025-09-10 13:05:56 (20808): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8b
2025-09-10 13:05:56 (20808): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8c
2025-09-10 13:05:56 (20808): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8c
2025-09-10 13:05:56 (20808): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8d
2025-09-10 13:05:56 (20808): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8d
2025-09-10 13:05:56 (20808): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8e
2025-09-10 13:05:56 (20808): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8e
2025-09-10 13:05:56 (20808): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8f
2025-09-10 13:05:56 (20808): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8f
2025-09-10 13:06:37 (20808): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2025-09-10 13:06:37 (20808): Guest Log: Host supports full mouse state reporting, switching to extended mouse integration protocol
2025-09-10 13:06:39 (20808): Guest Log: vboxguest: Successfully loaded version 7.1.6 r167084
2025-09-10 13:06:39 (20808): Guest Log: vboxguest: misc device minor 123, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)
2025-09-10 13:06:40 (20808): Guest Log: vboxsf: g_fHostFeatures=0x8000000f g_fSfFeatures=0x1 g_uSfLastFunction=29
2025-09-10 13:06:40 (20808): Guest Log: vboxsf: Successfully loaded version 7.1.6 r167084 on 5.14.0-570.12.1.el9_6.x86_64 (LINUX_VERSION_CODE=0x50e00)
2025-09-10 13:07:05 (20808): Guest Log: Could not download a wpad.dat from lhchomeproxy.{cern.ch|fnal.gov}
2025-09-10 13:07:05 (20808): Guest Log: Could not find a local HTTP proxy
2025-09-10 13:07:05 (20808): Guest Log: CVMFS and Frontier will have to use DIRECT connections
2025-09-10 13:07:05 (20808): Guest Log: This makes the application less efficient
2025-09-10 13:07:05 (20808): Guest Log: It also puts higher load on the project servers
2025-09-10 13:07:05 (20808): Guest Log: Setting up a local HTTP proxy is highly recommended
2025-09-10 13:07:05 (20808): Guest Log: Advice can be found in the project forum
2025-09-10 13:07:05 (20808): Guest Log: Using custom CVMFS.
2025-09-10 13:07:06 (20808): Guest Log: Probing CVMFS repositories ...
2025-09-10 13:07:26 (20808): Guest Log: Probing /cvmfs/alice.cern.ch... OK
2025-09-10 13:07:26 (20808): Guest Log: Probing /cvmfs/cvmfs-config.cern.ch... OK
2025-09-10 13:07:26 (20808): Guest Log: Probing /cvmfs/grid.cern.ch... OK
2025-09-10 13:07:26 (20808): Guest Log: Probing /cvmfs/sft.cern.ch... OK
2025-09-10 13:07:27 (20808): Guest Log: Excerpt from "cvmfs_config stat":
2025-09-10 13:07:27 (20808): Guest Log: VERSION HOST PROXY
2025-09-10 13:07:27 (20808): Guest Log: 2.13.1.0 http://s1ral-cvmfs.openhtc.io DIRECT
2025-09-10 13:07:27 (20808): Guest Log: ******************************************************************
2025-09-10 13:07:27 (20808): Guest Log: IMPORTANT HINT(S)!
2025-09-10 13:07:27 (20808): Guest Log: ******************************************************************
2025-09-10 13:07:27 (20808): Guest Log: CVMFS server: http://s1ral-cvmfs.openhtc.io
2025-09-10 13:07:27 (20808): Guest Log: CVMFS proxy: DIRECT
2025-09-10 13:07:27 (20808): Guest Log: No local HTTP proxy found.
2025-09-10 13:07:27 (20808): Guest Log: With this setup concurrently running containers can't share
2025-09-10 13:07:27 (20808): Guest Log: a common CVMFS cache. A local HTTP proxy is therefore
2025-09-10 13:07:27 (20808): Guest Log: highly recommended.
2025-09-10 13:07:27 (20808): Guest Log: More info how to configure a local HTTP proxy:
2025-09-10 13:07:27 (20808): Guest Log: https://lhcathome.cern.ch/lhcathome/forum_thread.php?id=5473
2025-09-10 13:07:27 (20808): Guest Log: https://lhcathome.cern.ch/lhcathome/forum_thread.php?id=5474
2025-09-10 13:07:27 (20808): Guest Log: ******************************************************************
2025-09-10 13:07:28 (20808): Guest Log: Environment HTTP proxy: not set
2025-09-10 13:07:30 (20808): Guest Log: job: htmld=/var/www/lighttpd
2025-09-10 13:07:31 (20808): Guest Log: job: unpack exitcode=0
2025-09-10 13:07:43 (20808): Stopping VM.
2025-09-10 13:07:51 (20808): Successfully stopped VM.
2025-09-10 13:10:45 (2868): vboxwrapper version 26210
2025-09-10 13:10:45 (2868): BOINC client version: 7.24.1
2025-09-10 13:10:45 (2868): Detected: VirtualBox VboxManage Interface (Version: 7.0.6)
2025-09-10 13:10:46 (2868): Detected: Heartbeat check (file: 'heartbeat' every 1800.000000 seconds)
2025-09-10 13:10:46 (2868): Guest Log: BIOS: VirtualBox 7.0.6
2025-09-10 13:10:46 (2868): Guest Log: CPUID EDX: 0x178bfbff
2025-09-10 13:10:46 (2868): Guest Log: BIOS: No PCI IDE controller, not probing IDE
2025-09-10 13:10:46 (2868): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000001400000 sectors
2025-09-10 13:10:46 (2868): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2025-09-10 13:10:46 (2868): Guest Log: BIOS: Booting from Hard Disk...
2025-09-10 13:10:46 (2868): Guest Log: BIOS: KBD: unsupported int 16h function 03
2025-09-10 13:10:46 (2868): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000
2025-09-10 13:10:46 (2868): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=81
2025-09-10 13:10:46 (2868): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=81
2025-09-10 13:10:46 (2868): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=82
2025-09-10 13:10:46 (2868): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=82
2025-09-10 13:10:46 (2868): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=83
2025-09-10 13:10:46 (2868): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=83
2025-09-10 13:10:46 (2868): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=84
2025-09-10 13:10:46 (2868): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=84
2025-09-10 13:10:46 (2868): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=85
2025-09-10 13:10:46 (2868): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=85
2025-09-10 13:10:46 (2868): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=86
2025-09-10 13:10:46 (2868): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=86
2025-09-10 13:10:46 (2868): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=87
2025-09-10 13:10:46 (2868): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=87
2025-09-10 13:10:46 (2868): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=88
2025-09-10 13:10:46 (2868): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=88
2025-09-10 13:10:46 (2868): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=89
2025-09-10 13:10:46 (2868): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=89
2025-09-10 13:10:46 (2868): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8a
2025-09-10 13:10:46 (2868): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8a
2025-09-10 13:10:46 (2868): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8b
2025-09-10 13:10:46 (2868): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8b
2025-09-10 13:10:46 (2868): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8c
2025-09-10 13:10:46 (2868): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8c
2025-09-10 13:10:46 (2868): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8d
2025-09-10 13:10:46 (2868): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8d
2025-09-10 13:10:46 (2868): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8e
2025-09-10 13:10:46 (2868): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8e
2025-09-10 13:10:46 (2868): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8f
2025-09-10 13:10:46 (2868): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2025-09-10 13:10:46 (2868): Guest Log: Host supports full mouse state reporting, switching to extended mouse integration protocol
2025-09-10 13:10:46 (2868): Guest Log: vboxguest: Successfully loaded version 7.1.6 r167084
2025-09-10 13:10:46 (2868): Guest Log: vboxguest: misc device minor 123, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)
2025-09-10 13:10:46 (2868): Guest Log: vboxsf: g_fHostFeatures=0x8000000f g_fSfFeatures=0x1 g_uSfLastFunction=29
2025-09-10 13:10:46 (2868): Guest Log: vboxsf: Successfully loaded version 7.1.6 r167084 on 5.14.0-570.12.1.el9_6.x86_64 (LINUX_VERSION_CODE=0x50e00)
2025-09-10 13:10:46 (2868): Guest Log: Could not download a wpad.dat from lhchomeproxy.{cern.ch|fnal.gov}
2025-09-10 13:10:46 (2868): Guest Log: Could not find a local HTTP proxy
2025-09-10 13:10:46 (2868): Guest Log: CVMFS and Frontier will have to use DIRECT connections
2025-09-10 13:10:46 (2868): Guest Log: This makes the application less efficient
2025-09-10 13:10:46 (2868): Guest Log: It also puts higher load on the project servers
2025-09-10 13:10:46 (2868): Guest Log: Setting up a local HTTP proxy is highly recommended
2025-09-10 13:10:46 (2868): Guest Log: Advice can be found in the project forum
2025-09-10 13:10:46 (2868): Guest Log: Using custom CVMFS.
2025-09-10 13:10:46 (2868): Guest Log: Probing CVMFS repositories ...
2025-09-10 13:10:46 (2868): Guest Log: Probing /cvmfs/alice.cern.ch... OK
2025-09-10 13:10:46 (2868): Guest Log: Probing /cvmfs/cvmfs-config.cern.ch... OK
2025-09-10 13:10:46 (2868): Guest Log: Probing /cvmfs/grid.cern.ch... OK
2025-09-10 13:10:46 (2868): Guest Log: Probing /cvmfs/sft.cern.ch... OK
2025-09-10 13:10:46 (2868): Guest Log: Excerpt from "cvmfs_config stat":
2025-09-10 13:10:46 (2868): Guest Log: VERSION HOST PROXY
2025-09-10 13:10:46 (2868): Guest Log: 2.13.1.0 http://s1ral-cvmfs.openhtc.io DIRECT
2025-09-10 13:10:46 (2868): Guest Log: ******************************************************************
2025-09-10 13:10:46 (2868): Guest Log: IMPORTANT HINT(S)!
2025-09-10 13:10:46 (2868): Guest Log: ******************************************************************
2025-09-10 13:10:46 (2868): Guest Log: CVMFS server: http://s1ral-cvmfs.openhtc.io
2025-09-10 13:10:46 (2868): Guest Log: CVMFS proxy: DIRECT
2025-09-10 13:10:46 (2868): Guest Log: No local HTTP proxy found.
2025-09-10 13:10:46 (2868): Guest Log: With this setup concurrently running containers can't share
2025-09-10 13:10:46 (2868): Guest Log: a common CVMFS cache. A local HTTP proxy is therefore
2025-09-10 13:10:46 (2868): Guest Log: highly recommended.
2025-09-10 13:10:46 (2868): Guest Log: More info how to configure a local HTTP proxy:
2025-09-10 13:10:46 (2868): Guest Log: https://lhcathome.cern.ch/lhcathome/forum_thread.php?id=5473
2025-09-10 13:10:46 (2868): Guest Log: https://lhcathome.cern.ch/lhcathome/forum_thread.php?id=5474
2025-09-10 13:10:46 (2868): Guest Log: ******************************************************************
2025-09-10 13:10:46 (2868): Guest Log: Environment HTTP proxy: not set
2025-09-10 13:10:46 (2868): Guest Log: job: htmld=/var/www/lighttpd
2025-09-10 13:10:46 (2868): Guest Log: job: unpack exitcode=0
2025-09-10 13:10:46 (2868): Starting VM using VBoxManage interface. (boinc_b9d9a43ecdc55f50, slot#5)
2025-09-10 13:10:55 (2868): Successfully started VM. (PID = '28508')
2025-09-10 13:10:55 (2868): Reporting VM Process ID to BOINC.
2025-09-10 13:10:55 (2868): VM state change detected. (old = 'poweredoff', new = 'running')
2025-09-10 13:10:55 (2868): Detected: Web Application Enabled (http://localhost:63861)
2025-09-10 13:10:55 (2868): Preference change detected
2025-09-10 13:10:55 (2868): Setting CPU throttle for VM. (10%)
2025-09-10 13:10:55 (2868): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2025-09-10 13:12:14 (2868): VM state change detected. (old = 'running', new = 'paused')
2025-09-10 13:12:34 (2868): VM state change detected. (old = 'paused', new = 'running')
2025-09-10 13:17:38 (2868): Stopping VM.
2025-09-10 13:17:50 (2868): Successfully stopped VM.
2025-09-10 13:20:38 (28464): vboxwrapper version 26210
2025-09-10 13:20:38 (28464): BOINC client version: 7.24.1
2025-09-10 13:20:39 (28464): Detected: VirtualBox VboxManage Interface (Version: 7.0.6)
2025-09-10 13:20:39 (28464): Detected: Heartbeat check (file: 'heartbeat' every 1800.000000 seconds)
2025-09-10 13:20:40 (28464): Starting VM using VBoxManage interface. (boinc_b9d9a43ecdc55f50, slot#5)
2025-09-10 13:20:49 (28464): Successfully started VM. (PID = '14892')
2025-09-10 13:20:49 (28464): Reporting VM Process ID to BOINC.
2025-09-10 13:20:49 (28464): VM state change detected. (old = 'poweredoff', new = 'running')
2025-09-10 13:20:49 (28464): Detected: Web Application Enabled (http://localhost:63861)
2025-09-10 13:20:49 (28464): Preference change detected
2025-09-10 13:20:49 (28464): Setting CPU throttle for VM. (10%)
2025-09-10 13:20:50 (28464): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2025-09-10 13:24:37 (28464): VM state change detected. (old = 'running', new = 'paused')
2025-09-10 13:24:57 (28464): VM state change detected. (old = 'paused', new = 'running')
2025-09-10 13:33:47 (28464): VM state change detected. (old = 'running', new = 'paused')
2025-09-10 13:34:07 (28464): VM state change detected. (old = 'paused', new = 'running')
2025-09-10 13:42:47 (28464): VM state change detected. (old = 'running', new = 'paused')
2025-09-10 13:43:07 (28464): VM state change detected. (old = 'paused', new = 'running')
2025-09-10 13:51:29 (28464): VM state change detected. (old = 'running', new = 'paused')
2025-09-10 13:51:49 (28464): VM state change detected. (old = 'paused', new = 'running')
2025-09-10 13:59:39 (28464): VM state change detected. (old = 'running', new = 'paused')
2025-09-10 13:59:59 (28464): VM state change detected. (old = 'paused', new = 'running')
2025-09-10 14:07:50 (28464): VM state change detected. (old = 'running', new = 'paused')
2025-09-10 14:08:10 (28464): VM state change detected. (old = 'paused', new = 'running')
2025-09-10 14:14:43 (28464): Stopping VM.
2025-09-10 14:15:07 (28464): Successfully stopped VM.
2025-09-10 14:18:05 (28288): vboxwrapper version 26210
2025-09-10 14:18:05 (28288): BOINC client version: 7.24.1
2025-09-10 14:18:06 (28288): Detected: VirtualBox VboxManage Interface (Version: 7.0.6)
2025-09-10 14:18:06 (28288): Detected: Heartbeat check (file: 'heartbeat' every 1800.000000 seconds)
2025-09-10 14:18:07 (28288): Starting VM using VBoxManage interface. (boinc_b9d9a43ecdc55f50, slot#5)
2025-09-10 14:18:18 (28288): Successfully started VM. (PID = '26664')
2025-09-10 14:18:18 (28288): Reporting VM Process ID to BOINC.
2025-09-10 14:18:18 (28288): VM state change detected. (old = 'poweredoff', new = 'running')
2025-09-10 14:18:18 (28288): Detected: Web Application Enabled (http://localhost:63861)
2025-09-10 14:18:18 (28288): Preference change detected
2025-09-10 14:18:18 (28288): Setting CPU throttle for VM. (10%)
2025-09-10 14:18:19 (28288): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2025-09-10 14:20:54 (28288): VM state change detected. (old = 'running', new = 'paused')
2025-09-10 14:21:15 (28288): VM state change detected. (old = 'paused', new = 'running')
2025-09-10 14:30:04 (28288): VM state change detected. (old = 'running', new = 'paused')
2025-09-10 14:30:25 (28288): VM state change detected. (old = 'paused', new = 'running')
2025-09-10 14:38:55 (28288): VM state change detected. (old = 'running', new = 'paused')
2025-09-10 14:38:56 (28288): VM state change detected. (old = 'paused', new = 'running')
2025-09-10 14:45:22 (28288): Stopping VM.
2025-09-10 14:45:38 (28288): Successfully stopped VM.
2025-09-17 11:43:48 (18116): vboxwrapper version 26210
2025-09-17 11:43:48 (18116): BOINC client version: 7.24.1
2025-09-17 11:43:48 (18116): Detected: VirtualBox VboxManage Interface (Version: 7.0.6)
2025-09-17 11:43:49 (18116): Detected: Heartbeat check (file: 'heartbeat' every 1800.000000 seconds)
2025-09-17 11:43:49 (18116): Starting VM using VBoxManage interface. (boinc_b9d9a43ecdc55f50, slot#5)
2025-09-17 11:44:01 (18116): Successfully started VM. (PID = '16848')
2025-09-17 11:44:01 (18116): Reporting VM Process ID to BOINC.
2025-09-17 11:44:01 (18116): VM state change detected. (old = 'poweredoff', new = 'running')
2025-09-17 11:44:01 (18116): Detected: Web Application Enabled (http://localhost:63861)
2025-09-17 11:44:01 (18116): Preference change detected
2025-09-17 11:44:01 (18116): Setting CPU throttle for VM. (10%)
2025-09-17 11:44:01 (18116): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2025-09-17 11:45:12 (18116): Stopping VM.
2025-09-17 11:45:16 (18116): Successfully stopped VM.
2025-09-17 11:50:19 (12420): vboxwrapper version 26210
2025-09-17 11:50:19 (12420): BOINC client version: 7.24.1
2025-09-17 11:50:19 (12420): Detected: VirtualBox VboxManage Interface (Version: 7.0.6)
2025-09-17 11:50:20 (12420): Detected: Heartbeat check (file: 'heartbeat' every 1800.000000 seconds)
2025-09-17 11:50:20 (12420): Starting VM using VBoxManage interface. (boinc_b9d9a43ecdc55f50, slot#5)
2025-09-17 11:50:30 (12420): Successfully started VM. (PID = '9676')
2025-09-17 11:50:30 (12420): Reporting VM Process ID to BOINC.
2025-09-17 11:50:30 (12420): VM state change detected. (old = 'poweredoff', new = 'running')
2025-09-17 11:50:30 (12420): Detected: Web Application Enabled (http://localhost:63861)
2025-09-17 11:50:30 (12420): Preference change detected
2025-09-17 11:50:30 (12420): Setting CPU throttle for VM. (10%)
2025-09-17 11:50:31 (12420): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2025-09-17 11:52:53 (12420): Stopping VM.
2025-09-17 11:53:06 (12420): Successfully stopped VM.
2025-09-17 11:56:00 (11088): vboxwrapper version 26210
2025-09-17 11:56:00 (11088): BOINC client version: 7.24.1
2025-09-17 11:56:00 (11088): Detected: VirtualBox VboxManage Interface (Version: 7.0.6)
2025-09-17 11:56:01 (11088): Detected: Heartbeat check (file: 'heartbeat' every 1800.000000 seconds)
2025-09-17 11:56:02 (11088): Starting VM using VBoxManage interface. (boinc_b9d9a43ecdc55f50, slot#5)
2025-09-17 11:56:15 (11088): Successfully started VM. (PID = '10148')
2025-09-17 11:56:15 (11088): Reporting VM Process ID to BOINC.
2025-09-17 11:56:15 (11088): VM state change detected. (old = 'poweredoff', new = 'running')
2025-09-17 11:56:15 (11088): Detected: Web Application Enabled (http://localhost:63861)
2025-09-17 11:56:15 (11088): Preference change detected
2025-09-17 11:56:15 (11088): Setting CPU throttle for VM. (10%)
2025-09-17 11:56:16 (11088): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2025-09-17 12:06:08 (11088): Status Report: Elapsed Time: '6000.000000'
2025-09-17 12:06:08 (11088): Status Report: CPU Time: '954.750000'
2025-09-17 13:26:57 (11088): VM state change detected. (old = 'running', new = 'paused')
2025-09-17 13:27:17 (11088): VM state change detected. (old = 'paused', new = 'running')
2025-09-17 13:39:57 (11088): VM state change detected. (old = 'running', new = 'paused')
2025-09-17 13:40:17 (11088): VM state change detected. (old = 'paused', new = 'running')
2025-09-17 13:44:38 (11088): VM state change detected. (old = 'running', new = 'paused')
2025-09-17 13:44:58 (11088): VM state change detected. (old = 'paused', new = 'running')
2025-09-17 13:47:17 (11088): Status Report: Elapsed Time: '12000.000000'
2025-09-17 13:47:17 (11088): Status Report: CPU Time: '1873.734375'
2025-09-17 13:53:39 (11088): VM state change detected. (old = 'running', new = 'paused')
2025-09-17 13:53:59 (11088): VM state change detected. (old = 'paused', new = 'running')
2025-09-17 14:06:10 (11088): VM state change detected. (old = 'running', new = 'paused')
2025-09-17 14:06:30 (11088): VM state change detected. (old = 'paused', new = 'running')
2025-09-17 14:08:30 (11088): VM state change detected. (old = 'running', new = 'paused')
2025-09-17 14:08:50 (11088): VM state change detected. (old = 'paused', new = 'running')
2025-09-17 14:15:10 (11088): VM state change detected. (old = 'running', new = 'paused')
2025-09-17 14:15:31 (11088): VM state change detected. (old = 'paused', new = 'running')
2025-09-17 14:15:47 (11088): Stopping VM.
2025-09-17 14:15:51 (11088): Successfully stopped VM.
2025-09-17 14:18:48 (6268): vboxwrapper version 26210
2025-09-17 14:18:48 (6268): BOINC client version: 7.24.1
2025-09-17 14:18:48 (6268): Detected: VirtualBox VboxManage Interface (Version: 7.0.6)
2025-09-17 14:18:48 (6268): Detected: Heartbeat check (file: 'heartbeat' every 1800.000000 seconds)
2025-09-17 14:18:49 (6268): Starting VM using VBoxManage interface. (boinc_b9d9a43ecdc55f50, slot#5)
2025-09-17 14:18:57 (6268): Successfully started VM. (PID = '7072')
2025-09-17 14:18:57 (6268): Reporting VM Process ID to BOINC.
2025-09-17 14:18:57 (6268): VM state change detected. (old = 'poweredoff', new = 'running')
2025-09-17 14:18:57 (6268): Detected: Web Application Enabled (http://localhost:63861)
2025-09-17 14:18:57 (6268): Status Report: Elapsed Time: '13624.000000'
2025-09-17 14:18:57 (6268): Status Report: CPU Time: '2122.593750'
2025-09-17 14:18:57 (6268): Preference change detected
2025-09-17 14:18:57 (6268): Setting CPU throttle for VM. (10%)
2025-09-17 14:18:58 (6268): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2025-09-17 14:27:33 (6268): VM state change detected. (old = 'running', new = 'paused')
2025-09-17 14:27:53 (6268): VM state change detected. (old = 'paused', new = 'running')
2025-09-17 14:34:53 (6268): VM state change detected. (old = 'running', new = 'paused')
2025-09-17 14:35:13 (6268): VM state change detected. (old = 'paused', new = 'running')
2025-09-17 14:47:05 (6268): VM state change detected. (old = 'running', new = 'paused')
2025-09-17 14:47:25 (6268): VM state change detected. (old = 'paused', new = 'running')
2025-09-17 14:57:15 (6268): VM state change detected. (old = 'running', new = 'paused')
2025-09-17 14:57:35 (6268): VM state change detected. (old = 'paused', new = 'running')
2025-09-17 15:00:56 (6268): VM state change detected. (old = 'running', new = 'paused')
2025-09-17 15:01:16 (6268): VM state change detected. (old = 'paused', new = 'running')
2025-09-17 15:09:06 (6268): VM state change detected. (old = 'running', new = 'paused')
2025-09-17 15:09:26 (6268): VM state change detected. (old = 'paused', new = 'running')
2025-09-17 15:14:57 (6268): VM state change detected. (old = 'running', new = 'paused')
2025-09-17 15:15:17 (6268): VM state change detected. (old = 'paused', new = 'running')
2025-09-17 15:16:27 (6268): VM state change detected. (old = 'running', new = 'paused')
2025-09-17 15:16:47 (6268): VM state change detected. (old = 'paused', new = 'running')
2025-09-17 15:20:07 (6268): VM state change detected. (old = 'running', new = 'paused')
2025-09-17 15:20:27 (6268): VM state change detected. (old = 'paused', new = 'running')
2025-09-17 15:20:48 (6268): VM state change detected. (old = 'running', new = 'paused')
2025-09-17 15:21:08 (6268): VM state change detected. (old = 'paused', new = 'running')
2025-09-17 15:31:08 (6268): VM state change detected. (old = 'running', new = 'paused')
2025-09-17 15:31:29 (6268): VM state change detected. (old = 'paused', new = 'running')
2025-09-17 15:35:59 (6268): VM state change detected. (old = 'running', new = 'paused')
2025-09-17 15:36:19 (6268): VM state change detected. (old = 'paused', new = 'running')
2025-09-17 15:41:30 (6268): VM state change detected. (old = 'running', new = 'paused')
2025-09-17 15:41:50 (6268): VM state change detected. (old = 'paused', new = 'running')
2025-09-17 15:45:40 (6268): VM state change detected. (old = 'running', new = 'paused')
2025-09-17 15:46:00 (6268): VM state change detected. (old = 'paused', new = 'running')
2025-09-17 15:51:40 (6268): VM state change detected. (old = 'running', new = 'paused')
2025-09-17 15:52:00 (6268): VM state change detected. (old = 'paused', new = 'running')
2025-09-17 15:56:10 (6268): VM state change detected. (old = 'running', new = 'paused')
2025-09-17 15:56:30 (6268): VM state change detected. (old = 'paused', new = 'running')
2025-09-17 15:57:31 (6268): VM state change detected. (old = 'running', new = 'paused')
2025-09-17 15:57:51 (6268): VM state change detected. (old = 'paused', new = 'running')
2025-09-17 16:02:52 (6268): VM state change detected. (old = 'running', new = 'paused')
2025-09-17 16:03:12 (6268): VM state change detected. (old = 'paused', new = 'running')
2025-09-17 16:05:22 (6268): Status Report: Elapsed Time: '19624.000000'
2025-09-17 16:05:22 (6268): Status Report: CPU Time: '3045.765625'
2025-09-17 16:10:23 (6268): VM state change detected. (old = 'running', new = 'paused')
2025-09-17 16:10:43 (6268): VM state change detected. (old = 'paused', new = 'running')
2025-09-17 16:14:33 (6268): VM state change detected. (old = 'running', new = 'paused')
2025-09-17 16:14:53 (6268): VM state change detected. (old = 'paused', new = 'running')
2025-09-17 16:17:53 (6268): VM state change detected. (old = 'running', new = 'paused')
2025-09-17 16:18:13 (6268): VM state change detected. (old = 'paused', new = 'running')
2025-09-17 16:21:33 (6268): VM state change detected. (old = 'running', new = 'paused')
2025-09-17 16:21:53 (6268): VM state change detected. (old = 'paused', new = 'running')
2025-09-17 16:25:44 (6268): VM state change detected. (old = 'running', new = 'paused')
2025-09-17 16:26:04 (6268): VM state change detected. (old = 'paused', new = 'running')
2025-09-17 16:26:54 (6268): VM state change detected. (old = 'running', new = 'paused')
2025-09-17 16:27:14 (6268): VM state change detected. (old = 'paused', new = 'running')
2025-09-17 16:27:44 (6268): VM state change detected. (old = 'running', new = 'paused')
2025-09-17 16:28:04 (6268): VM state change detected. (old = 'paused', new = 'running')
2025-09-17 16:36:34 (6268): VM state change detected. (old = 'running', new = 'paused')
2025-09-17 16:36:54 (6268): VM state change detected. (old = 'paused', new = 'running')
2025-09-17 16:42:04 (6268): VM state change detected. (old = 'running', new = 'paused')
2025-09-17 16:42:24 (6268): VM state change detected. (old = 'paused', new = 'running')
2025-09-17 16:46:36 (6268): VM state change detected. (old = 'running', new = 'paused')
2025-09-17 16:46:57 (6268): VM state change detected. (old = 'paused', new = 'running')
2025-09-17 16:53:37 (6268): VM state change detected. (old = 'running', new = 'paused')
2025-09-17 16:53:38 (6268): VM state change detected. (old = 'paused', new = 'running')
2025-09-17 17:49:00 (6268): Status Report: Elapsed Time: '25624.000000'
2025-09-17 17:49:00 (6268): Status Report: CPU Time: '3962.421875'
2025-09-17 18:00:12 (6268): Stopping VM.
2025-09-17 18:00:59 (6268): Error in stop VM for VM: -182
Command:
VBoxManage -q controlvm "boinc_b9d9a43ecdc55f50" savestate
Output:
0%...10%...20%...30%...40%...50%...60%...70%...80%...90%...100%
2025-09-17 18:00:59 (6268): VM did not stop when requested.
2025-09-17 18:00:59 (6268): VM was NOT successfully terminated.
2025-09-17 18:03:11 (15460): vboxwrapper version 26210
2025-09-17 18:03:11 (15460): BOINC client version: 7.24.1
2025-09-17 18:03:12 (15460): Detected: VirtualBox VboxManage Interface (Version: 7.0.6)
2025-09-17 18:03:12 (15460): Detected: Heartbeat check (file: 'heartbeat' every 1800.000000 seconds)
2025-09-17 18:03:12 (15460): Starting VM using VBoxManage interface. (boinc_b9d9a43ecdc55f50, slot#5)
2025-09-17 20:45:33 (17804): vboxwrapper version 26210
2025-09-17 20:45:33 (17804): BOINC client version: 7.24.1
2025-09-17 20:45:34 (17804): Detected: VirtualBox VboxManage Interface (Version: 7.0.6)
2025-09-17 20:45:34 (17804): Detected: Heartbeat check (file: 'heartbeat' every 1800.000000 seconds)
2025-09-17 20:45:39 (17804): VM was running
2025-09-17 20:45:39 (17804): Powering off VM.
2025-09-17 20:45:40 (17804): Error in poweroff VM for VM: -2135228414
Command:
VBoxManage -q controlvm "boinc_b9d9a43ecdc55f50" poweroff
Output:
VBoxManage.exe: error: Invalid machine state: Restoring (must be Running, Paused or Stuck)
VBoxManage.exe: error: Details: code VBOX_E_INVALID_VM_STATE (0x80bb0002), component ConsoleWrap, interface IConsole, callee IUnknown
VBoxManage.exe: error: Context: "PowerDown(progress.asOutParam())" at line 604 of file VBoxManageControlVM.cpp
2025-09-17 20:45:40 (17804): VM did not power off when requested.
2025-09-17 20:45:40 (17804): VM was NOT successfully terminated.
2025-09-17 20:45:40 (17804): Could not stop running VM
2025-09-17 20:45:40 (17804): ERROR: VM failed to start
2025-09-17 20:45:45 (17804):
NOTE: VM was already running.
BOINC will be notified that it needs to clean up the environment.
This might be a temporary problem and so this job will be rescheduled for another time.
2025-09-18 21:19:36 (16752): vboxwrapper version 26210
2025-09-18 21:19:36 (16752): BOINC client version: 7.24.1
2025-09-18 21:19:37 (16752): Detected: VirtualBox VboxManage Interface (Version: 7.0.6)
2025-09-18 21:19:37 (16752): Detected: Heartbeat check (file: 'heartbeat' every 1800.000000 seconds)
2025-09-18 21:19:43 (16752): VM was running
2025-09-18 21:19:43 (16752): Powering off VM.
2025-09-18 21:19:43 (16752): Error in poweroff VM for VM: -2135228414
Command:
VBoxManage -q controlvm "boinc_b9d9a43ecdc55f50" poweroff
Output:
VBoxManage.exe: error: Invalid machine state: Restoring (must be Running, Paused or Stuck)
VBoxManage.exe: error: Details: code VBOX_E_INVALID_VM_STATE (0x80bb0002), component ConsoleWrap, interface IConsole, callee IUnknown
VBoxManage.exe: error: Context: "PowerDown(progress.asOutParam())" at line 604 of file VBoxManageControlVM.cpp
2025-09-18 21:19:43 (16752): VM did not power off when requested.
2025-09-18 21:19:43 (16752): VM was NOT successfully terminated.
2025-09-18 21:19:43 (16752): Could not stop running VM
2025-09-18 21:19:43 (16752): ERROR: VM failed to start
2025-09-18 21:19:48 (16752):
NOTE: VM was already running.
BOINC will be notified that it needs to clean up the environment.
This might be a temporary problem and so this job will be rescheduled for another time.
2025-09-19 21:25:21 (14332): vboxwrapper version 26210
2025-09-19 21:25:21 (14332): BOINC client version: 7.24.1
2025-09-19 21:25:22 (14332): Detected: VirtualBox VboxManage Interface (Version: 7.0.6)
2025-09-19 21:25:22 (14332): Detected: Heartbeat check (file: 'heartbeat' every 1800.000000 seconds)
2025-09-19 21:25:27 (14332): VM was running
2025-09-19 21:25:27 (14332): Powering off VM.
2025-09-19 21:25:28 (14332): Error in poweroff VM for VM: -2135228414
Command:
VBoxManage -q controlvm "boinc_b9d9a43ecdc55f50" poweroff
Output:
VBoxManage.exe: error: Invalid machine state: Restoring (must be Running, Paused or Stuck)
VBoxManage.exe: error: Details: code VBOX_E_INVALID_VM_STATE (0x80bb0002), component ConsoleWrap, interface IConsole, callee IUnknown
VBoxManage.exe: error: Context: "PowerDown(progress.asOutParam())" at line 604 of file VBoxManageControlVM.cpp
2025-09-19 21:25:28 (14332): VM did not power off when requested.
2025-09-19 21:25:28 (14332): VM was NOT successfully terminated.
2025-09-19 21:25:28 (14332): Could not stop running VM
2025-09-19 21:25:28 (14332): ERROR: VM failed to start
2025-09-19 21:25:33 (14332):
NOTE: VM was already running.
BOINC will be notified that it needs to clean up the environment.
This might be a temporary problem and so this job will be rescheduled for another time.
2025-09-19 21:25:43 (10572): vboxwrapper version 26210
2025-09-19 21:25:43 (10572): BOINC client version: 7.24.1
2025-09-19 21:25:44 (10572): Detected: VirtualBox VboxManage Interface (Version: 7.0.6)
2025-09-19 21:25:44 (10572): Detected: Heartbeat check (file: 'heartbeat' every 1800.000000 seconds)
2025-09-19 21:25:50 (10572): VM was running
2025-09-19 21:25:50 (10572): Powering off VM.
2025-09-19 21:25:50 (10572): Error in poweroff VM for VM: -2135228414
Command:
VBoxManage -q controlvm "boinc_b9d9a43ecdc55f50" poweroff
Output:
VBoxManage.exe: error: Invalid machine state: Restoring (must be Running, Paused or Stuck)
VBoxManage.exe: error: Details: code VBOX_E_INVALID_VM_STATE (0x80bb0002), component ConsoleWrap, interface IConsole, callee IUnknown
VBoxManage.exe: error: Context: "PowerDown(progress.asOutParam())" at line 604 of file VBoxManageControlVM.cpp
2025-09-19 21:25:50 (10572): VM did not power off when requested.
2025-09-19 21:25:50 (10572): VM was NOT successfully terminated.
2025-09-19 21:25:50 (10572): Could not stop running VM
2025-09-19 21:25:50 (10572): ERROR: VM failed to start
2025-09-19 21:25:55 (10572):
NOTE: VM was already running.
BOINC will be notified that it needs to clean up the environment.
This might be a temporary problem and so this job will be rescheduled for another time.
2025-09-20 21:26:12 (1868): vboxwrapper version 26210
2025-09-20 21:26:12 (1868): BOINC client version: 7.24.1
2025-09-20 21:26:12 (1868): Detected: VirtualBox VboxManage Interface (Version: 7.0.6)
2025-09-20 21:26:12 (1868): Detected: Heartbeat check (file: 'heartbeat' every 1800.000000 seconds)
2025-09-20 21:26:18 (1868): VM was running
2025-09-20 21:26:18 (1868): Powering off VM.
2025-09-20 21:26:18 (1868): Error in poweroff VM for VM: -2135228414
Command:
VBoxManage -q controlvm "boinc_b9d9a43ecdc55f50" poweroff
Output:
VBoxManage.exe: error: Invalid machine state: Restoring (must be Running, Paused or Stuck)
VBoxManage.exe: error: Details: code VBOX_E_INVALID_VM_STATE (0x80bb0002), component ConsoleWrap, interface IConsole, callee IUnknown
VBoxManage.exe: error: Context: "PowerDown(progress.asOutParam())" at line 604 of file VBoxManageControlVM.cpp
2025-09-20 21:26:18 (1868): VM did not power off when requested.
2025-09-20 21:26:18 (1868): VM was NOT successfully terminated.
2025-09-20 21:26:18 (1868): Could not stop running VM
2025-09-20 21:26:18 (1868): ERROR: VM failed to start
2025-09-20 21:26:23 (1868):
NOTE: VM was already running.
BOINC will be notified that it needs to clean up the environment.
This might be a temporary problem and so this job will be rescheduled for another time.
2025-09-20 21:26:36 (6044): vboxwrapper version 26210
2025-09-20 21:26:36 (6044): BOINC client version: 7.24.1
2025-09-20 21:26:36 (6044): Detected: VirtualBox VboxManage Interface (Version: 7.0.6)
2025-09-20 21:26:36 (6044): Detected: Heartbeat check (file: 'heartbeat' every 1800.000000 seconds)
2025-09-20 21:26:42 (6044): VM was running
2025-09-20 21:26:42 (6044): Powering off VM.
2025-09-20 21:26:42 (6044): Error in poweroff VM for VM: -2135228414
Command:
VBoxManage -q controlvm "boinc_b9d9a43ecdc55f50" poweroff
Output:
VBoxManage.exe: error: Invalid machine state: Restoring (must be Running, Paused or Stuck)
VBoxManage.exe: error: Details: code VBOX_E_INVALID_VM_STATE (0x80bb0002), component ConsoleWrap, interface IConsole, callee IUnknown
VBoxManage.exe: error: Context: "PowerDown(progress.asOutParam())" at line 604 of file VBoxManageControlVM.cpp
2025-09-20 21:26:42 (6044): VM did not power off when requested.
2025-09-20 21:26:42 (6044): VM was NOT successfully terminated.
2025-09-20 21:26:42 (6044): Could not stop running VM
2025-09-20 21:26:42 (6044): ERROR: VM failed to start
2025-09-20 21:26:47 (6044):
NOTE: VM was already running.
BOINC will be notified that it needs to clean up the environment.
This might be a temporary problem and so this job will be rescheduled for another time.
2025-09-21 21:26:35 (3036): vboxwrapper version 26210
2025-09-21 21:26:35 (3036): BOINC client version: 7.24.1
2025-09-21 21:26:36 (3036): Detected: VirtualBox VboxManage Interface (Version: 7.0.6)
2025-09-21 21:26:36 (3036): Detected: Heartbeat check (file: 'heartbeat' every 1800.000000 seconds)
2025-09-21 21:26:42 (3036): VM was running
2025-09-21 21:26:42 (3036): Powering off VM.
2025-09-21 21:26:42 (3036): Error in poweroff VM for VM: -2135228414
Command:
VBoxManage -q controlvm "boinc_b9d9a43ecdc55f50" poweroff
Output:
VBoxManage.exe: error: Invalid machine state: Restoring (must be Running, Paused or Stuck)
VBoxManage.exe: error: Details: code VBOX_E_INVALID_VM_STATE (0x80bb0002), component ConsoleWrap, interface IConsole, callee IUnknown
VBoxManage.exe: error: Context: "PowerDown(progress.asOutParam())" at line 604 of file VBoxManageControlVM.cpp
2025-09-21 21:26:42 (3036): VM did not power off when requested.
2025-09-21 21:26:42 (3036): VM was NOT successfully terminated.
2025-09-21 21:26:42 (3036): Could not stop running VM
2025-09-21 21:26:42 (3036): ERROR: VM failed to start
2025-09-21 21:26:47 (3036):
NOTE: VM was already running.
BOINC will be notified that it needs to clean up the environment.
This might be a temporary problem and so this job will be rescheduled for another time.
2025-09-22 21:27:09 (16628): vboxwrapper version 26210
2025-09-22 21:27:09 (16628): BOINC client version: 7.24.1
2025-09-22 21:27:11 (16628): Detected: VirtualBox VboxManage Interface (Version: 7.0.6)
2025-09-22 21:27:11 (16628): Detected: Heartbeat check (file: 'heartbeat' every 1800.000000 seconds)
2025-09-22 21:27:11 (16628): Starting VM using VBoxManage interface. (boinc_b9d9a43ecdc55f50, slot#5)
2025-09-22 21:27:24 (16628): Successfully started VM. (PID = '19224')
2025-09-22 21:27:24 (16628): Reporting VM Process ID to BOINC.
2025-09-22 21:27:24 (16628): VM state change detected. (old = 'poweredoff', new = 'running')
2025-09-22 21:27:24 (16628): Detected: Web Application Enabled (http://localhost:63861)
2025-09-22 21:27:24 (16628): Status Report: Elapsed Time: '26296.000000'
2025-09-22 21:27:24 (16628): Status Report: CPU Time: '4064.906250'
2025-09-22 21:27:24 (16628): Preference change detected
2025-09-22 21:27:24 (16628): Setting CPU throttle for VM. (10%)
2025-09-22 21:27:25 (16628): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2025-09-22 21:27:43 (16628): VM state change detected. (old = 'running', new = 'paused')
2025-09-22 21:28:03 (16628): VM state change detected. (old = 'paused', new = 'running')
2025-09-22 21:30:53 (16628): VM state change detected. (old = 'running', new = 'paused')
2025-09-22 21:31:14 (16628): VM state change detected. (old = 'paused', new = 'running')
2025-09-22 21:32:04 (16628): VM state change detected. (old = 'running', new = 'paused')
2025-09-22 21:32:24 (16628): VM state change detected. (old = 'paused', new = 'running')
2025-09-22 21:32:44 (16628): VM state change detected. (old = 'running', new = 'paused')
2025-09-22 21:33:04 (16628): VM state change detected. (old = 'paused', new = 'running')
2025-09-22 21:35:54 (16628): VM state change detected. (old = 'running', new = 'paused')
2025-09-22 21:36:14 (16628): VM state change detected. (old = 'paused', new = 'running')
2025-09-22 21:40:44 (16628): VM state change detected. (old = 'running', new = 'paused')
2025-09-22 21:41:04 (16628): VM state change detected. (old = 'paused', new = 'running')
2025-09-22 21:47:25 (16628): VM state change detected. (old = 'running', new = 'paused')
2025-09-22 21:47:46 (16628): VM state change detected. (old = 'paused', new = 'running')
2025-09-22 21:49:25 (16628): VM state change detected. (old = 'running', new = 'paused')
2025-09-22 21:49:46 (16628): VM state change detected. (old = 'paused', new = 'running')
2025-09-22 21:52:35 (16628): VM state change detected. (old = 'running', new = 'paused')
2025-09-22 21:55:52 (16628): VM state change detected. (old = 'paused', new = 'running')
2025-09-22 21:57:46 (16628): VM state change detected. (old = 'running', new = 'paused')
2025-09-22 21:58:06 (16628): VM state change detected. (old = 'paused', new = 'running')
2025-09-22 21:58:36 (16628): VM state change detected. (old = 'running', new = 'paused')
2025-09-22 21:58:57 (16628): VM state change detected. (old = 'paused', new = 'running')
2025-09-22 21:59:37 (16628): VM state change detected. (old = 'running', new = 'paused')
2025-09-22 21:59:57 (16628): VM state change detected. (old = 'paused', new = 'running')
2025-09-22 22:01:27 (16628): VM state change detected. (old = 'running', new = 'paused')
2025-09-22 22:01:47 (16628): VM state change detected. (old = 'paused', new = 'running')
2025-09-22 22:03:17 (16628): VM state change detected. (old = 'running', new = 'paused')
2025-09-22 22:03:37 (16628): VM state change detected. (old = 'paused', new = 'running')
2025-09-22 22:12:38 (16628): VM state change detected. (old = 'running', new = 'paused')
2025-09-22 22:12:58 (16628): VM state change detected. (old = 'paused', new = 'running')
2025-09-22 22:13:28 (16628): VM state change detected. (old = 'running', new = 'paused')
2025-09-22 22:13:48 (16628): VM state change detected. (old = 'paused', new = 'running')
2025-09-22 22:22:39 (16628): VM state change detected. (old = 'running', new = 'paused')
2025-09-22 22:22:59 (16628): VM state change detected. (old = 'paused', new = 'running')
2025-09-22 22:25:49 (16628): VM state change detected. (old = 'running', new = 'paused')
2025-09-22 22:26:09 (16628): VM state change detected. (old = 'paused', new = 'running')
2025-09-22 22:29:49 (16628): VM state change detected. (old = 'running', new = 'paused')
2025-09-22 22:30:09 (16628): VM state change detected. (old = 'paused', new = 'running')
2025-09-22 22:36:21 (16628): VM state change detected. (old = 'running', new = 'paused')
2025-09-22 22:36:41 (16628): VM state change detected. (old = 'paused', new = 'running')
2025-09-22 22:42:21 (16628): VM state change detected. (old = 'running', new = 'paused')
2025-09-22 22:42:41 (16628): VM state change detected. (old = 'paused', new = 'running')
2025-09-22 22:44:21 (16628): VM state change detected. (old = 'running', new = 'paused')
2025-09-22 22:44:41 (16628): VM state change detected. (old = 'paused', new = 'running')
2025-09-22 22:47:11 (16628): VM state change detected. (old = 'running', new = 'paused')
2025-09-22 22:47:31 (16628): VM state change detected. (old = 'paused', new = 'running')
2025-09-22 22:49:33 (16628): VM state change detected. (old = 'running', new = 'paused')
2025-09-22 22:49:53 (16628): VM state change detected. (old = 'paused', new = 'running')
2025-09-22 22:52:13 (16628): VM state change detected. (old = 'running', new = 'paused')
2025-09-22 22:52:33 (16628): VM state change detected. (old = 'paused', new = 'running')
2025-09-22 22:54:03 (16628): VM state change detected. (old = 'running', new = 'paused')
2025-09-22 22:54:23 (16628): VM state change detected. (old = 'paused', new = 'running')
2025-09-22 22:57:43 (16628): VM state change detected. (old = 'running', new = 'paused')
2025-09-22 22:58:03 (16628): VM state change detected. (old = 'paused', new = 'running')
2025-09-22 23:00:53 (16628): VM state change detected. (old = 'running', new = 'paused')
2025-09-22 23:01:14 (16628): VM state change detected. (old = 'paused', new = 'running')
2025-09-22 23:09:35 (16628): VM state change detected. (old = 'running', new = 'paused')
2025-09-22 23:09:55 (16628): VM state change detected. (old = 'paused', new = 'running')
2025-09-22 23:17:45 (16628): VM state change detected. (old = 'running', new = 'paused')
2025-09-22 23:17:46 (16628): VM state change detected. (old = 'paused', new = 'running')
2025-09-22 23:18:45 (16628): VM state change detected. (old = 'running', new = 'paused')
2025-09-22 23:19:05 (16628): VM state change detected. (old = 'paused', new = 'running')
2025-09-22 23:21:02 (16628): Status Report: Elapsed Time: '32296.000000'
2025-09-22 23:21:02 (16628): Status Report: CPU Time: '4997.687500'
2025-09-22 23:26:16 (16628): VM state change detected. (old = 'running', new = 'paused')
2025-09-22 23:26:36 (16628): VM state change detected. (old = 'paused', new = 'running')
2025-09-22 23:37:37 (16628): VM state change detected. (old = 'running', new = 'paused')
2025-09-22 23:37:57 (16628): VM state change detected. (old = 'paused', new = 'running')
2025-09-22 23:38:47 (16628): VM state change detected. (old = 'running', new = 'paused')
2025-09-22 23:39:07 (16628): VM state change detected. (old = 'paused', new = 'running')
2025-09-22 23:47:38 (16628): VM state change detected. (old = 'running', new = 'paused')
2025-09-22 23:47:58 (16628): VM state change detected. (old = 'paused', new = 'running')
2025-09-22 23:48:48 (16628): VM state change detected. (old = 'running', new = 'paused')
2025-09-22 23:49:08 (16628): VM state change detected. (old = 'paused', new = 'running')
2025-09-22 23:56:49 (16628): VM state change detected. (old = 'running', new = 'paused')
2025-09-22 23:57:09 (16628): VM state change detected. (old = 'paused', new = 'running')
2025-09-23 00:05:30 (16628): VM state change detected. (old = 'running', new = 'paused')
2025-09-23 00:05:50 (16628): VM state change detected. (old = 'paused', new = 'running')
2025-09-23 00:17:01 (16628): VM state change detected. (old = 'running', new = 'paused')
2025-09-23 00:17:22 (16628): VM state change detected. (old = 'paused', new = 'running')
2025-09-23 00:31:32 (16628): VM state change detected. (old = 'running', new = 'paused')
2025-09-23 00:31:52 (16628): VM state change detected. (old = 'paused', new = 'running')
2025-09-23 01:04:18 (16628): Status Report: Elapsed Time: '38296.000000'
2025-09-23 01:04:18 (16628): Status Report: CPU Time: '5920.187500'
2025-09-23 01:44:09 (16628): VM state change detected. (old = 'running', new = 'paused')
2025-09-23 01:44:29 (16628): VM state change detected. (old = 'paused', new = 'running')
2025-09-23 02:02:39 (16628): Guest Log: job: run exitcode=0
2025-09-23 02:02:39 (16628): Guest Log: job: diskusage=10204
2025-09-23 02:02:39 (16628): Guest Log: job: logsize=60 k
2025-09-23 02:02:39 (16628): Guest Log: job: times=
2025-09-23 02:02:39 (16628): Guest Log: 0m0.026s 0m0.075s
2025-09-23 02:02:39 (16628): Guest Log: 665m50.089s 18m52.200s
2025-09-23 02:02:40 (16628): Guest Log: job: cpuusage=41082
2025-09-23 02:02:41 (16628): Guest Log: Job Finished
2025-09-23 02:02:41 (16628): Guest Log: boinc_shutdown called with exit code 0
2025-09-23 02:02:41 (16628): Guest Log: sd_delay: 813
2025-09-23 02:02:41 (16628): Guest Log: ETA: 2025-09-10 23:58:54 UTC
2025-09-23 02:15:12 (16628): VM Completion File Detected.
2025-09-23 02:15:12 (16628): Powering off VM.
2025-09-23 02:15:13 (16628): Successfully stopped VM.
2025-09-23 02:15:13 (16628): Deregistering VM. (boinc_b9d9a43ecdc55f50, slot#5)
2025-09-23 02:15:13 (16628): Removing network bandwidth throttle group from VM.
2025-09-23 02:15:13 (16628): Removing VM from VirtualBox.
2025-09-23 02:15:18 (16628): called boinc_finish(0)
</stderr_txt>
]]>
©2025 CERN