Name Theory_2773-2964403-284_1
Workunit 229822974
Created 18 Jan 2025, 10:00:46 UTC
Sent 18 Jan 2025, 13:42:43 UTC
Report deadline 29 Jan 2025, 13:42:43 UTC
Received 24 Jan 2025, 9:11:45 UTC
Server state Over
Outcome Computation error
Client state Compute error
Exit status -2147467259 (0x80004005) Unknown error code
Computer ID 10656357
Run time 4 hours 45 min 15 sec
CPU time 1 hours 20 min 9 sec
Validate state Invalid
Credit 0.00
Device peak FLOPS 5.30 GFLOPS
Application version Theory Simulation v300.60 (vbox64_theory)
windows_x86_64
Peak working set size 83.84 MB
Peak swap size 74.57 MB
Peak disk usage 1.95 GB

Stderr output

<core_client_version>8.0.2</core_client_version>
<![CDATA[
<message>
Unspecified error
 (0x80004005) - exit code 2147500037 (0x80004005)</message>
<stderr_txt>
2025-01-19 15:47:57 (9396): vboxwrapper version 26208
2025-01-19 15:47:57 (9396): BOINC client version: 8.0.2
2025-01-19 15:47:57 (9396): Detected: VirtualBox VboxManage Interface (Version: 7.0.6)
2025-01-19 15:47:58 (9396): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2025-01-19 15:47:58 (9396): Successfully copied 'init_data.xml' to the shared directory.
2025-01-19 15:47:58 (9396): Successfully copied 'input' to the shared directory.
2025-01-19 15:47:58 (9396): Create VM. (boinc_b7878523d63a7b2c, slot#1)
2025-01-19 15:47:59 (9396): Setting Memory Size for VM. (630MB)
2025-01-19 15:47:59 (9396): Setting CPU Count for VM. (1)
2025-01-19 15:47:59 (9396): Setting Chipset Options for VM.
2025-01-19 15:47:59 (9396): Setting Graphics Controller Options for VM.
2025-01-19 15:48:00 (9396): Setting Boot Options for VM.
2025-01-19 15:48:00 (9396): Setting Network Configuration for NAT.
2025-01-19 15:48:00 (9396): Enabling VM Network Access.
2025-01-19 15:48:00 (9396): Disabling USB Support for VM.
2025-01-19 15:48:01 (9396): Disabling COM Port Support for VM.
2025-01-19 15:48:01 (9396): Disabling LPT Port Support for VM.
2025-01-19 15:48:01 (9396): Disabling Audio Support for VM.
2025-01-19 15:48:02 (9396): Disabling Clipboard Support for VM.
2025-01-19 15:48:02 (9396): Disabling Drag and Drop Support for VM.
2025-01-19 15:48:02 (9396): Adding storage controller(s) to VM.
2025-01-19 15:48:02 (9396): Adding virtual disk drive to VM. (Theory_2025_01_16_prod.vdi)
2025-01-19 15:48:03 (9396): Adding VirtualBox Guest Additions to VM.
2025-01-19 15:48:03 (9396): Adding network bandwidth throttle group to VM. (Defaulting to 1024GB)
2025-01-19 15:48:04 (9396): forwarding host port 51555 to guest port 80
2025-01-19 15:48:04 (9396): Enabling remote desktop for VM.
2025-01-19 15:48:04 (9396): Required extension pack not installed, remote desktop not enabled.
2025-01-19 15:48:04 (9396): Enabling shared directory for VM.
2025-01-19 15:48:05 (9396): Starting VM using VBoxManage interface. (boinc_b7878523d63a7b2c, slot#1)
2025-01-19 15:48:10 (9396): Successfully started VM. (PID = '2572')
2025-01-19 15:48:10 (9396): Reporting VM Process ID to BOINC.
2025-01-19 15:48:10 (9396): Guest Log: BIOS: VirtualBox 7.0.6
2025-01-19 15:48:10 (9396): Guest Log: CPUID EDX: 0x178bfbff
2025-01-19 15:48:10 (9396): Guest Log: BIOS: No PCI IDE controller, not probing IDE
2025-01-19 15:48:10 (9396): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors
2025-01-19 15:48:10 (9396): VM state change detected. (old = 'poweredoff', new = 'running')
2025-01-19 15:48:10 (9396): Detected: Web Application Enabled (http://localhost:51555)
2025-01-19 15:48:10 (9396): Preference change detected
2025-01-19 15:48:10 (9396): Setting CPU throttle for VM. (25%)
2025-01-19 15:48:11 (9396): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2025-01-19 15:48:12 (9396): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2025-01-19 15:48:12 (9396): Guest Log: BIOS: Booting from Hard Disk...
2025-01-19 15:48:15 (9396): Guest Log: BIOS: KBD: unsupported int 16h function 03
2025-01-19 15:48:15 (9396): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 
2025-01-19 15:48:34 (9396): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2025-01-19 15:48:34 (9396): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)
2025-01-19 15:48:38 (9396): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log
2025-01-19 15:48:38 (9396): Guest Log: 00:00:00.000056 main     Log opened 2025-01-19T15:48:38.086410000Z
2025-01-19 15:48:38 (9396): Guest Log: 00:00:00.000149 main     OS Product: Linux
2025-01-19 15:48:38 (9396): Guest Log: 00:00:00.000177 main     OS Release: 4.14.76-13.cernvm.x86_64
2025-01-19 15:48:38 (9396): Guest Log: 00:00:00.000201 main     OS Version: #1 SMP Tue Oct 16 18:26:15 CEST 2018
2025-01-19 15:48:38 (9396): Guest Log: 00:00:00.000227 main     Executable: /usr/sbin/VBoxService
2025-01-19 15:48:38 (9396): Guest Log: 00:00:00.000228 main     Process ID: 3227
2025-01-19 15:48:38 (9396): Guest Log: 00:00:00.000228 main     Package type: LINUX_64BITS_GENERIC
2025-01-19 15:48:38 (9396): Guest Log: 00:00:00.001583 main     5.2.6 r120293 started. Verbose level = 0
2025-01-19 15:49:00 (9396): Guest Log: 16:48:59 CET +01:00 2025-01-19: cranky: [INFO] Detected Theory App
2025-01-19 15:49:00 (9396): Guest Log: 16:48:59 CET +01:00 2025-01-19: cranky: [INFO] Checking CVMFS.
2025-01-19 15:49:00 (9396): Guest Log: Probing /cvmfs/sft.cern.ch... OK
2025-01-19 15:49:01 (9396): Guest Log: VERSION PID UPTIME(M) MEM(K) REVISION EXPIRES(M) NOCATALOGS CACHEUSE(K) CACHEMAX(K) NOFDUSE NOFDMAX NOIOERR NOOPEN HITRATE(%) RX(K) SPEED(K/S) HOST PROXY ONLINE
2025-01-19 15:49:01 (9396): Guest Log: 2.5.2.0 4051 0 27204 31510 3 1 278907 4096000 0 65024 0 0 n/a 5 9 http://s1unl-cvmfs.openhtc.io/cvmfs/sft.cern.ch DIRECT 1
2025-01-19 15:49:01 (9396): Guest Log: Probing /cvmfs/grid.cern.ch... OK
2025-01-19 15:49:02 (9396): Guest Log: VERSION PID UPTIME(M) MEM(K) REVISION EXPIRES(M) NOCATALOGS CACHEUSE(K) CACHEMAX(K) NOFDUSE NOFDMAX NOIOERR NOOPEN HITRATE(%) RX(K) SPEED(K/S) HOST PROXY ONLINE
2025-01-19 15:49:02 (9396): Guest Log: 2.5.2.0 4097 0 25444 26265 3 2 278907 4096000 0 65024 0 2 -100 10085 3881 http://s1unl-cvmfs.openhtc.io/cvmfs/grid.cern.ch DIRECT 1
2025-01-19 15:49:02 (9396): Guest Log: Probing /cvmfs/cernvm-prod.cern.ch... OK
2025-01-19 15:49:03 (9396): Guest Log: VERSION PID UPTIME(M) MEM(K) REVISION EXPIRES(M) NOCATALOGS CACHEUSE(K) CACHEMAX(K) NOFDUSE NOFDMAX NOIOERR NOOPEN HITRATE(%) RX(K) SPEED(K/S) HOST PROXY ONLINE
2025-01-19 15:49:03 (9396): Guest Log: 2.5.2.0 4074 0 27224 272 3 1 278907 4096000 0 65024 0 0 n/a 4 2 http://s1ihep-cvmfs.openhtc.io/cvmfs/cernvm-prod.cern.ch DIRECT 1
2025-01-19 15:49:04 (9396): Guest Log: Probing /cvmfs/alice.cern.ch... OK
2025-01-19 15:49:04 (9396): Guest Log: VERSION PID UPTIME(M) MEM(K) REVISION EXPIRES(M) NOCATALOGS CACHEUSE(K) CACHEMAX(K) NOFDUSE NOFDMAX NOIOERR NOOPEN HITRATE(%) RX(K) SPEED(K/S) HOST PROXY ONLINE
2025-01-19 15:49:04 (9396): Guest Log: 2.5.2.0 4119 0 39652 20901 3 1 278907 4096000 0 65024 0 0 n/a 6578 1882 http://s1cern-cvmfs.openhtc.io/cvmfs/alice.cern.ch DIRECT 1
2025-01-19 15:49:04 (9396): Guest Log: 16:49:03 CET +01:00 2025-01-19: cranky: [INFO] Checking runc.
2025-01-19 15:49:04 (9396): Guest Log: 16:49:03 CET +01:00 2025-01-19: cranky: [INFO] Creating the filesystem.
2025-01-19 15:49:04 (9396): Guest Log: 16:49:03 CET +01:00 2025-01-19: cranky: [INFO] Using /cvmfs/cernvm-prod.cern.ch/cvm4
2025-01-19 15:49:04 (9396): Guest Log: 16:49:04 CET +01:00 2025-01-19: cranky: [INFO] Updating config.json.
2025-01-19 15:49:04 (9396): Guest Log: 16:49:04 CET +01:00 2025-01-19: cranky: [INFO] Running Container 'runc'.
2025-01-19 15:49:10 (9396): Guest Log: job: htmld=/shared/html/job
2025-01-19 15:49:11 (9396): Guest Log: job: unpack exitcode=0
2025-01-19 15:49:11 (9396): Guest Log: INFO: activated the work-around for ld:
2025-01-19 15:49:11 (9396): Guest Log: lrwxrwxrwx 1 0 0 15 Jan 19 15:49 /tmp/tmp.fWUH2Ydeoa/ld -> /usr/bin/ld.bfd
2025-01-19 15:49:12 (9396): Guest Log: 16:49:12 CET +01:00 2025-01-19: cranky: [INFO] ===> [runRivet] Sun Jan 19 15:49:11 UTC 2025 [boinc pp jets 7000 20,-,210 - powheg-box r3744 ptdef2 100000 284]
2025-01-19 15:49:55 (9396): VM state change detected. (old = 'running', new = 'paused')
2025-01-19 16:01:41 (9396): VM state change detected. (old = 'paused', new = 'running')
2025-01-19 16:03:49 (9396): VM state change detected. (old = 'running', new = 'paused')
2025-01-19 16:06:49 (9396): VM state change detected. (old = 'paused', new = 'running')
2025-01-19 16:58:07 (9396): VM state change detected. (old = 'running', new = 'paused')
2025-01-19 16:58:27 (9396): VM state change detected. (old = 'paused', new = 'running')
2025-01-19 17:00:57 (9396): VM state change detected. (old = 'running', new = 'paused')
2025-01-19 17:01:18 (9396): VM state change detected. (old = 'paused', new = 'running')
2025-01-19 17:07:20 (9396): Stopping VM.
2025-01-19 17:07:23 (9396): Successfully stopped VM.
2025-01-21 13:11:50 (23288): vboxwrapper version 26208
2025-01-21 13:11:50 (23288): BOINC client version: 8.0.2
2025-01-21 13:11:50 (23288): Detected: VirtualBox VboxManage Interface (Version: 7.0.6)
2025-01-21 13:11:51 (23288): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2025-01-21 13:11:51 (23288): Guest Log: BIOS: VirtualBox 7.0.6
2025-01-21 13:11:51 (23288): Guest Log: CPUID EDX: 0x178bfbff
2025-01-21 13:11:51 (23288): Guest Log: BIOS: No PCI IDE controller, not probing IDE
2025-01-21 13:11:51 (23288): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors
2025-01-21 13:11:51 (23288): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2025-01-21 13:11:51 (23288): Guest Log: BIOS: Booting from Hard Disk...
2025-01-21 13:11:51 (23288): Guest Log: BIOS: KBD: unsupported int 16h function 03
2025-01-21 13:11:51 (23288): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 
2025-01-21 13:11:51 (23288): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2025-01-21 13:11:51 (23288): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)
2025-01-21 13:11:51 (23288): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log
2025-01-21 13:11:51 (23288): Guest Log: 00:00:00.000056 main     Log opened 2025-01-19T15:48:38.086410000Z
2025-01-21 13:11:51 (23288): Guest Log: 00:00:00.000149 main     OS Product: Linux
2025-01-21 13:11:51 (23288): Guest Log: 00:00:00.000177 main     OS Release: 4.14.76-13.cernvm.x86_64
2025-01-21 13:11:51 (23288): Guest Log: 00:00:00.000201 main     OS Version: #1 SMP Tue Oct 16 18:26:15 CEST 2018
2025-01-21 13:11:51 (23288): Guest Log: 00:00:00.000227 main     Executable: /usr/sbin/VBoxService
2025-01-21 13:11:51 (23288): Guest Log: 00:00:00.000228 main     Process ID: 3227
2025-01-21 13:11:51 (23288): Guest Log: 00:00:00.000228 main     Package type: LINUX_64BITS_GENERIC
2025-01-21 13:11:51 (23288): Guest Log: 00:00:00.001583 main     5.2.6 r120293 started. Verbose level = 0
2025-01-21 13:11:51 (23288): Guest Log: 16:48:59 CET +01:00 2025-01-19: cranky: [INFO] Detected Theory App
2025-01-21 13:11:51 (23288): Guest Log: 16:48:59 CET +01:00 2025-01-19: cranky: [INFO] Checking CVMFS.
2025-01-21 13:11:51 (23288): Guest Log: Probing /cvmfs/sft.cern.ch... OK
2025-01-21 13:11:51 (23288): Guest Log: VERSION PID UPTIME(M) MEM(K) REVISION EXPIRES(M) NOCATALOGS CACHEUSE(K) CACHEMAX(K) NOFDUSE NOFDMAX NOIOERR NOOPEN HITRATE(%) RX(K) SPEED(K/S) HOST PROXY ONLINE
2025-01-21 13:11:51 (23288): Guest Log: 2.5.2.0 4051 0 27204 31510 3 1 278907 4096000 0 65024 0 0 n/a 5 9 http://s1unl-cvmfs.openhtc.io/cvmfs/sft.cern.ch DIRECT 1
2025-01-21 13:11:51 (23288): Guest Log: Probing /cvmfs/grid.cern.ch... OK
2025-01-21 13:11:51 (23288): Guest Log: VERSION PID UPTIME(M) MEM(K) REVISION EXPIRES(M) NOCATALOGS CACHEUSE(K) CACHEMAX(K) NOFDUSE NOFDMAX NOIOERR NOOPEN HITRATE(%) RX(K) SPEED(K/S) HOST PROXY ONLINE
2025-01-21 13:11:51 (23288): Guest Log: 2.5.2.0 4097 0 25444 26265 3 2 278907 4096000 0 65024 0 2 -100 10085 3881 http://s1unl-cvmfs.openhtc.io/cvmfs/grid.cern.ch DIRECT 1
2025-01-21 13:11:51 (23288): Guest Log: Probing /cvmfs/cernvm-prod.cern.ch... OK
2025-01-21 13:11:51 (23288): Guest Log: VERSION PID UPTIME(M) MEM(K) REVISION EXPIRES(M) NOCATALOGS CACHEUSE(K) CACHEMAX(K) NOFDUSE NOFDMAX NOIOERR NOOPEN HITRATE(%) RX(K) SPEED(K/S) HOST PROXY ONLINE
2025-01-21 13:11:51 (23288): Guest Log: 2.5.2.0 4074 0 27224 272 3 1 278907 4096000 0 65024 0 0 n/a 4 2 http://s1ihep-cvmfs.openhtc.io/cvmfs/cernvm-prod.cern.ch DIRECT 1
2025-01-21 13:11:51 (23288): Guest Log: Probing /cvmfs/alice.cern.ch... OK
2025-01-21 13:11:51 (23288): Guest Log: VERSION PID UPTIME(M) MEM(K) REVISION EXPIRES(M) NOCATALOGS CACHEUSE(K) CACHEMAX(K) NOFDUSE NOFDMAX NOIOERR NOOPEN HITRATE(%) RX(K) SPEED(K/S) HOST PROXY ONLINE
2025-01-21 13:11:51 (23288): Guest Log: 2.5.2.0 4119 0 39652 20901 3 1 278907 4096000 0 65024 0 0 n/a 6578 1882 http://s1cern-cvmfs.openhtc.io/cvmfs/alice.cern.ch DIRECT 1
2025-01-21 13:11:51 (23288): Guest Log: 16:49:03 CET +01:00 2025-01-19: cranky: [INFO] Checking runc.
2025-01-21 13:11:51 (23288): Guest Log: 16:49:03 CET +01:00 2025-01-19: cranky: [INFO] Creating the filesystem.
2025-01-21 13:11:51 (23288): Guest Log: 16:49:03 CET +01:00 2025-01-19: cranky: [INFO] Using /cvmfs/cernvm-prod.cern.ch/cvm4
2025-01-21 13:11:51 (23288): Guest Log: 16:49:04 CET +01:00 2025-01-19: cranky: [INFO] Updating config.json.
2025-01-21 13:11:51 (23288): Guest Log: 16:49:04 CET +01:00 2025-01-19: cranky: [INFO] Running Container 'runc'.
2025-01-21 13:11:51 (23288): Guest Log: job: htmld=/shared/html/job
2025-01-21 13:11:51 (23288): Guest Log: job: unpack exitcode=0
2025-01-21 13:11:51 (23288): Guest Log: INFO: activated the work-around for ld:
2025-01-21 13:11:51 (23288): Guest Log: lrwxrwxrwx 1 0 0 15 Jan 19 15:49 /tmp/tmp.fWUH2Ydeoa/ld -> /usr/bin/ld.bfd
2025-01-21 13:11:51 (23288): Guest Log: 16:49:12 CET +01:00 2025-01-19: cranky: [INFO] ===> [runRivet] Sun Jan 19 15:49:11 UTC 2025 [boinc pp jets 7000 20,-,210 - powheg-box r3744 ptdef2 100000 284]
2025-01-21 13:11:51 (23288): Starting VM using VBoxManage interface. (boinc_b7878523d63a7b2c, slot#1)
2025-01-21 13:11:59 (23288): Successfully started VM. (PID = '22060')
2025-01-21 13:11:59 (23288): Reporting VM Process ID to BOINC.
2025-01-21 13:11:59 (23288): VM state change detected. (old = 'poweredoff', new = 'running')
2025-01-21 13:11:59 (23288): Detected: Web Application Enabled (http://localhost:51555)
2025-01-21 13:11:59 (23288): Preference change detected
2025-01-21 13:11:59 (23288): Setting CPU throttle for VM. (25%)
2025-01-21 13:11:59 (23288): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2025-01-21 13:12:01 (23288): Guest Log: 01:03:19.886044 timesync vgsvcTimeSyncWorker: Radical host time change: 158 687 345 000 000ns (HostNow=1 737 465 120 426 000 000 ns HostLast=1 737 306 433 081 000 000 ns)
2025-01-21 13:12:10 (23288): VM state change detected. (old = 'running', new = 'paused')
2025-01-21 13:12:30 (23288): VM state change detected. (old = 'paused', new = 'running')
2025-01-21 13:12:31 (23288): Guest Log: 01:03:29.973196 timesync vgsvcTimeSyncWorker: Radical guest time change: 159 612 791 160 000ns (GuestNow=1 737 465 130 529 750 000 ns GuestLast=1 737 305 517 738 590 000 ns fSetTimeLastLoop=true )
2025-01-21 13:41:33 (23288): VM state change detected. (old = 'running', new = 'paused')
2025-01-21 13:41:53 (23288): VM state change detected. (old = 'paused', new = 'running')
2025-01-21 13:49:09 (23288): Status Report: Job Duration: '864000.000000'
2025-01-21 13:49:09 (23288): Status Report: Elapsed Time: '6000.000000'
2025-01-21 13:49:09 (23288): Status Report: CPU Time: '1663.328125'
2025-01-21 13:55:15 (23288): VM state change detected. (old = 'running', new = 'paused')
2025-01-21 13:55:35 (23288): VM state change detected. (old = 'paused', new = 'running')
2025-01-21 14:00:16 (23288): VM state change detected. (old = 'running', new = 'paused')
2025-01-21 14:00:36 (23288): VM state change detected. (old = 'paused', new = 'running')
2025-01-21 14:06:56 (23288): VM state change detected. (old = 'running', new = 'paused')
2025-01-21 14:07:16 (23288): VM state change detected. (old = 'paused', new = 'running')
2025-01-21 14:12:20 (23288): VM state change detected. (old = 'running', new = 'paused')
2025-01-21 17:06:55 (23288): Guest Log: 02:02:00.384881 timesync vgsvcTimeSyncWorker: Radical host time change: 10 485 264 000 000ns (HostNow=1 737 479 214 923 000 000 ns HostLast=1 737 468 729 659 000 000 ns)
2025-01-21 17:06:55 (23288): VM state change detected. (old = 'paused', new = 'running')
2025-01-21 17:07:05 (23288): Guest Log: 02:02:10.438294 timesync vgsvcTimeSyncWorker: Radical guest time change: 10 584 035 030 000ns (GuestNow=1 737 479 224 976 440 000 ns GuestLast=1 737 468 640 941 410 000 ns fSetTimeLastLoop=true )
2025-01-21 17:10:56 (23288): VM state change detected. (old = 'running', new = 'paused')
2025-01-21 17:11:16 (23288): VM state change detected. (old = 'paused', new = 'running')
2025-01-21 17:16:46 (23288): VM state change detected. (old = 'running', new = 'paused')
2025-01-21 17:17:06 (23288): VM state change detected. (old = 'paused', new = 'running')
2025-01-21 17:22:46 (23288): VM state change detected. (old = 'running', new = 'paused')
2025-01-21 17:23:06 (23288): VM state change detected. (old = 'paused', new = 'running')
2025-01-21 17:25:48 (23288): VM state change detected. (old = 'running', new = 'paused')
2025-01-21 17:26:08 (23288): VM state change detected. (old = 'paused', new = 'running')
2025-01-21 17:35:29 (23288): VM state change detected. (old = 'running', new = 'paused')
2025-01-21 18:35:29 (23288): Guest Log: 02:29:15.075633 timesync vgsvcTimeSyncWorker: Radical host time change: 3 609 616 000 000ns (HostNow=1 737 484 528 593 000 000 ns HostLast=1 737 480 918 977 000 000 ns)
2025-01-21 18:35:29 (23288): VM state change detected. (old = 'paused', new = 'running')
2025-01-21 18:35:35 (23288): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 09:50:45 (19152): vboxwrapper version 26208
2025-01-22 09:50:45 (19152): BOINC client version: 8.0.2
2025-01-22 09:50:45 (19152): Detected: VirtualBox VboxManage Interface (Version: 7.0.6)
2025-01-22 09:50:46 (19152): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2025-01-22 09:50:46 (19152): Guest Log: 01:03:19.886044 timesync vgsvcTimeSyncWorker: Radical host time change: 158 687 345 000 000ns (HostNow=1 737 465 120 426 000 000 ns HostLast=1 737 306 433 081 000 000 ns)
2025-01-22 09:50:46 (19152): Guest Log: 01:03:29.973196 timesync vgsvcTimeSyncWorker: Radical guest time change: 159 612 791 160 000ns (GuestNow=1 737 465 130 529 750 000 ns GuestLast=1 737 305 517 738 590 000 ns fSetTimeLastLoop=true )
2025-01-22 09:50:46 (19152): Guest Log: 02:02:00.384881 timesync vgsvcTimeSyncWorker: Radical host time change: 10 485 264 000 000ns (HostNow=1 737 479 214 923 000 000 ns HostLast=1 737 468 729 659 000 000 ns)
2025-01-22 09:50:46 (19152): Guest Log: 02:02:10.438294 timesync vgsvcTimeSyncWorker: Radical guest time change: 10 584 035 030 000ns (GuestNow=1 737 479 224 976 440 000 ns GuestLast=1 737 468 640 941 410 000 ns fSetTimeLastLoop=true )
2025-01-22 09:50:46 (19152): Guest Log: 02:29:15.075633 timesync vgsvcTimeSyncWorker: Radical host time change: 3 609 616 000 000ns (HostNow=1 737 484 528 593 000 000 ns HostLast=1 737 480 918 977 000 000 ns)
2025-01-22 09:50:46 (19152): Starting VM using VBoxManage interface. (boinc_b7878523d63a7b2c, slot#1)
2025-01-22 09:50:53 (19152): Successfully started VM. (PID = '15016')
2025-01-22 09:50:53 (19152): Reporting VM Process ID to BOINC.
2025-01-22 09:50:53 (19152): Guest Log: BIOS: VirtualBox 7.0.6
2025-01-22 09:50:53 (19152): Guest Log: CPUID EDX: 0x178bfbff
2025-01-22 09:50:53 (19152): Guest Log: BIOS: No PCI IDE controller, not probing IDE
2025-01-22 09:50:53 (19152): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors
2025-01-22 09:50:53 (19152): VM state change detected. (old = 'poweredoff', new = 'running')
2025-01-22 09:50:53 (19152): Detected: Web Application Enabled (http://localhost:51555)
2025-01-22 09:50:53 (19152): Status Report: Job Duration: '864000.000000'
2025-01-22 09:50:53 (19152): Status Report: Elapsed Time: '8951.000000'
2025-01-22 09:50:53 (19152): Status Report: CPU Time: '2466.843750'
2025-01-22 09:50:53 (19152): Preference change detected
2025-01-22 09:50:53 (19152): Setting CPU throttle for VM. (25%)
2025-01-22 09:50:53 (19152): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2025-01-22 09:50:55 (19152): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 09:51:16 (19152): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2025-01-22 09:51:16 (19152): Guest Log: BIOS: Booting from Hard Disk...
2025-01-22 09:51:16 (19152): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 09:51:18 (19152): Guest Log: BIOS: KBD: unsupported int 16h function 03
2025-01-22 09:51:18 (19152): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 
2025-01-22 09:51:38 (19152): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2025-01-22 09:51:38 (19152): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)
2025-01-22 09:51:43 (19152): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log
2025-01-22 09:51:43 (19152): Guest Log: 00:00:00.000044 main     Log opened 2025-01-22T09:51:41.994791000Z
2025-01-22 09:51:43 (19152): Guest Log: 00:00:00.000126 main     OS Product: Linux
2025-01-22 09:51:43 (19152): Guest Log: 00:00:00.000145 main     OS Release: 4.14.76-13.cernvm.x86_64
2025-01-22 09:51:43 (19152): Guest Log: 00:00:00.000167 main     OS Version: #1 SMP Tue Oct 16 18:26:15 CEST 2018
2025-01-22 09:51:43 (19152): Guest Log: 00:00:00.000182 main     Executable: /usr/sbin/VBoxService
2025-01-22 09:51:43 (19152): Guest Log: 00:00:00.000182 main     Process ID: 3220
2025-01-22 09:51:43 (19152): Guest Log: 00:00:00.000183 main     Package type: LINUX_64BITS_GENERIC
2025-01-22 09:51:43 (19152): Guest Log: 00:00:00.001218 main     5.2.6 r120293 started. Verbose level = 0
2025-01-22 09:52:04 (19152): Guest Log: 10:52:03 CET +01:00 2025-01-22: cranky: [INFO] Detected Theory App
2025-01-22 09:52:04 (19152): Guest Log: 10:52:03 CET +01:00 2025-01-22: cranky: [INFO] Checking CVMFS.
2025-01-22 09:52:05 (19152): Guest Log: Probing /cvmfs/sft.cern.ch... OK
2025-01-22 09:52:06 (19152): Guest Log: VERSION PID UPTIME(M) MEM(K) REVISION EXPIRES(M) NOCATALOGS CACHEUSE(K) CACHEMAX(K) NOFDUSE NOFDMAX NOIOERR NOOPEN HITRATE(%) RX(K) SPEED(K/S) HOST PROXY ONLINE
2025-01-22 09:52:06 (19152): Guest Log: 2.5.2.0 4096 0 28388 31539 3 1 1744519 4096001 0 65024 0 0 n/a 5 7 http://s1cern-cvmfs.openhtc.io/cvmfs/sft.cern.ch DIRECT 1
2025-01-22 09:52:06 (19152): Guest Log: Probing /cvmfs/grid.cern.ch... OK
2025-01-22 09:52:07 (19152): Guest Log: VERSION PID UPTIME(M) MEM(K) REVISION EXPIRES(M) NOCATALOGS CACHEUSE(K) CACHEMAX(K) NOFDUSE NOFDMAX NOIOERR NOOPEN HITRATE(%) RX(K) SPEED(K/S) HOST PROXY ONLINE
2025-01-22 09:52:07 (19152): Guest Log: 2.5.2.0 4072 0 27404 26287 3 2 1744519 4096001 0 65024 0 2 0 7947 4277 http://s1unl-cvmfs.openhtc.io/cvmfs/grid.cern.ch DIRECT 1
2025-01-22 09:52:08 (19152): Guest Log: Probing /cvmfs/cernvm-prod.cern.ch... OK
2025-01-22 09:52:08 (19152): Guest Log: VERSION PID UPTIME(M) MEM(K) REVISION EXPIRES(M) NOCATALOGS CACHEUSE(K) CACHEMAX(K) NOFDUSE NOFDMAX NOIOERR NOOPEN HITRATE(%) RX(K) SPEED(K/S) HOST PROXY ONLINE
2025-01-22 09:52:08 (19152): Guest Log: 2.5.2.0 4050 0 27212 272 3 1 1744519 4096001 0 65024 0 0 n/a 0 0 http://s1cern-cvmfs.openhtc.io/cvmfs/cernvm-prod.cern.ch DIRECT 1
2025-01-22 09:52:09 (19152): Guest Log: Probing /cvmfs/alice.cern.ch... OK
2025-01-22 09:52:10 (19152): Guest Log: VERSION PID UPTIME(M) MEM(K) REVISION EXPIRES(M) NOCATALOGS CACHEUSE(K) CACHEMAX(K) NOFDUSE NOFDMAX NOIOERR NOOPEN HITRATE(%) RX(K) SPEED(K/S) HOST PROXY ONLINE
2025-01-22 09:52:10 (19152): Guest Log: 2.5.2.0 4118 0 41684 20935 3 1 1744519 4096001 0 65024 0 0 n/a 6590 1987 http://s1cern-cvmfs.openhtc.io/cvmfs/alice.cern.ch DIRECT 1
2025-01-22 09:52:10 (19152): Guest Log: 10:52:08 CET +01:00 2025-01-22: cranky: [INFO] Checking runc.
2025-01-22 09:52:10 (19152): Guest Log: 10:52:09 CET +01:00 2025-01-22: cranky: [INFO] Creating the filesystem.
2025-01-22 09:52:10 (19152): Guest Log: 10:52:09 CET +01:00 2025-01-22: cranky: [INFO] Using /cvmfs/cernvm-prod.cern.ch/cvm4
2025-01-22 09:52:10 (19152): Guest Log: 10:52:09 CET +01:00 2025-01-22: cranky: [INFO] Updating config.json.
2025-01-22 09:52:10 (19152): Guest Log: 10:52:09 CET +01:00 2025-01-22: cranky: [INFO] Running Container 'runc'.
2025-01-22 09:52:10 (19152): Guest Log: job: htmld=/shared/html/job
2025-01-22 09:52:10 (19152): Guest Log: job: unpack exitcode=0
2025-01-22 09:52:10 (19152): Guest Log: INFO: activated the work-around for ld:
2025-01-22 09:52:10 (19152): Guest Log: lrwxrwxrwx 1 0 0 15 Jan 22 09:52 /tmp/tmp.Q7MGomrWV2/ld -> /usr/bin/ld.bfd
2025-01-22 09:52:12 (19152): Guest Log: 10:52:11 CET +01:00 2025-01-22: cranky: [INFO] ===> [runRivet] Wed Jan 22 09:52:09 UTC 2025 [boinc pp jets 7000 20,-,210 - powheg-box r3744 ptdef2 100000 284]
2025-01-22 10:12:36 (19152): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 13:14:56 (19152): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 13:15:05 (19152): Guest Log: 00:21:03.519440 timesync vgsvcTimeSyncWorker: Radical host time change: 10 949 931 000 000ns (HostNow=1 737 551 705 425 000 000 ns HostLast=1 737 540 755 494 000 000 ns)
2025-01-22 13:15:15 (19152): Guest Log: 00:21:13.526448 timesync vgsvcTimeSyncWorker: Radical guest time change: 10 949 922 919 000ns (GuestNow=1 737 551 715 433 057 000 ns GuestLast=1 737 540 765 510 138 000 ns fSetTimeLastLoop=true )
2025-01-22 13:15:16 (19152): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 13:15:36 (19152): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 14:15:43 (19152): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 16:52:09 (19152): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 16:52:10 (19152): Guest Log: 01:21:23.715369 timesync vgsvcTimeSyncWorker: Radical host time change: 9 396 504 000 000ns (HostNow=1 737 564 730 357 000 000 ns HostLast=1 737 555 333 853 000 000 ns)
2025-01-22 16:52:20 (19152): Guest Log: 01:21:33.737209 timesync vgsvcTimeSyncWorker: Radical guest time change: 9 414 756 889 000ns (GuestNow=1 737 564 740 378 848 000 ns GuestLast=1 737 555 325 621 959 000 ns fSetTimeLastLoop=true )
2025-01-22 16:52:28 (19152): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 16:52:49 (19152): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 17:10:52 (19152): Status Report: Job Duration: '864000.000000'
2025-01-22 17:10:52 (19152): Status Report: Elapsed Time: '14951.000000'
2025-01-22 17:10:52 (19152): Status Report: CPU Time: '4188.671875'
2025-01-22 17:18:52 (19152): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 17:19:13 (19152): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 17:19:42 (19152): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 17:20:03 (19152): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 17:35:28 (19152): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 20:09:27 (19152): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 20:09:30 (19152): Guest Log: 02:03:41.939249 timesync vgsvcTimeSyncWorker: Radical host time change: 9 249 465 000 000ns (HostNow=1 737 576 569 931 000 000 ns HostLast=1 737 567 320 466 000 000 ns)
2025-01-22 20:09:40 (19152): Guest Log: 02:03:51.947953 timesync vgsvcTimeSyncWorker: Radical guest time change: 9 311 358 838 000ns (GuestNow=1 737 576 579 939 714 000 ns GuestLast=1 737 567 268 580 876 000 ns fSetTimeLastLoop=true )
2025-01-22 20:09:46 (19152): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 20:10:06 (19152): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 20:13:06 (19152): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 20:13:27 (19152): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 20:20:53 (19152): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 20:47:30 (19152): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 20:48:17 (19152): VM state change detected. (old = 'running', new = 'paused')
2025-01-23 20:58:09 (26596): vboxwrapper version 26208
2025-01-23 20:58:09 (26596): BOINC client version: 8.0.2
2025-01-23 20:58:10 (26596): Detected: VirtualBox VboxManage Interface (Version: 7.0.6)
2025-01-23 20:58:10 (26596): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2025-01-23 20:58:11 (26596): Guest Log: BIOS: VirtualBox 7.0.6
2025-01-23 20:58:11 (26596): Guest Log: CPUID EDX: 0x178bfbff
2025-01-23 20:58:11 (26596): Guest Log: BIOS: No PCI IDE controller, not probing IDE
2025-01-23 20:58:11 (26596): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors
2025-01-23 20:58:11 (26596): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2025-01-23 20:58:11 (26596): Guest Log: BIOS: Booting from Hard Disk...
2025-01-23 20:58:11 (26596): Guest Log: BIOS: KBD: unsupported int 16h function 03
2025-01-23 20:58:11 (26596): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 
2025-01-23 20:58:11 (26596): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2025-01-23 20:58:11 (26596): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)
2025-01-23 20:58:11 (26596): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log
2025-01-23 20:58:11 (26596): Guest Log: 00:00:00.000044 main     Log opened 2025-01-22T09:51:41.994791000Z
2025-01-23 20:58:11 (26596): Guest Log: 00:00:00.000126 main     OS Product: Linux
2025-01-23 20:58:11 (26596): Guest Log: 00:00:00.000145 main     OS Release: 4.14.76-13.cernvm.x86_64
2025-01-23 20:58:11 (26596): Guest Log: 00:00:00.000167 main     OS Version: #1 SMP Tue Oct 16 18:26:15 CEST 2018
2025-01-23 20:58:11 (26596): Guest Log: 00:00:00.000182 main     Executable: /usr/sbin/VBoxService
2025-01-23 20:58:11 (26596): Guest Log: 00:00:00.000182 main     Process ID: 3220
2025-01-23 20:58:11 (26596): Guest Log: 00:00:00.000183 main     Package type: LINUX_64BITS_GENERIC
2025-01-23 20:58:11 (26596): Guest Log: 00:00:00.001218 main     5.2.6 r120293 started. Verbose level = 0
2025-01-23 20:58:11 (26596): Guest Log: 10:52:03 CET +01:00 2025-01-22: cranky: [INFO] Detected Theory App
2025-01-23 20:58:11 (26596): Guest Log: 10:52:03 CET +01:00 2025-01-22: cranky: [INFO] Checking CVMFS.
2025-01-23 20:58:11 (26596): Guest Log: Probing /cvmfs/sft.cern.ch... OK
2025-01-23 20:58:11 (26596): Guest Log: VERSION PID UPTIME(M) MEM(K) REVISION EXPIRES(M) NOCATALOGS CACHEUSE(K) CACHEMAX(K) NOFDUSE NOFDMAX NOIOERR NOOPEN HITRATE(%) RX(K) SPEED(K/S) HOST PROXY ONLINE
2025-01-23 20:58:11 (26596): Guest Log: 2.5.2.0 4096 0 28388 31539 3 1 1744519 4096001 0 65024 0 0 n/a 5 7 http://s1cern-cvmfs.openhtc.io/cvmfs/sft.cern.ch DIRECT 1
2025-01-23 20:58:11 (26596): Guest Log: Probing /cvmfs/grid.cern.ch... OK
2025-01-23 20:58:11 (26596): Guest Log: VERSION PID UPTIME(M) MEM(K) REVISION EXPIRES(M) NOCATALOGS CACHEUSE(K) CACHEMAX(K) NOFDUSE NOFDMAX NOIOERR NOOPEN HITRATE(%) RX(K) SPEED(K/S) HOST PROXY ONLINE
2025-01-23 20:58:11 (26596): Guest Log: 2.5.2.0 4072 0 27404 26287 3 2 1744519 4096001 0 65024 0 2 0 7947 4277 http://s1unl-cvmfs.openhtc.io/cvmfs/grid.cern.ch DIRECT 1
2025-01-23 20:58:11 (26596): Guest Log: Probing /cvmfs/cernvm-prod.cern.ch... OK
2025-01-23 20:58:11 (26596): Guest Log: VERSION PID UPTIME(M) MEM(K) REVISION EXPIRES(M) NOCATALOGS CACHEUSE(K) CACHEMAX(K) NOFDUSE NOFDMAX NOIOERR NOOPEN HITRATE(%) RX(K) SPEED(K/S) HOST PROXY ONLINE
2025-01-23 20:58:11 (26596): Guest Log: 2.5.2.0 4050 0 27212 272 3 1 1744519 4096001 0 65024 0 0 n/a 0 0 http://s1cern-cvmfs.openhtc.io/cvmfs/cernvm-prod.cern.ch DIRECT 1
2025-01-23 20:58:11 (26596): Guest Log: Probing /cvmfs/alice.cern.ch... OK
2025-01-23 20:58:11 (26596): Guest Log: VERSION PID UPTIME(M) MEM(K) REVISION EXPIRES(M) NOCATALOGS CACHEUSE(K) CACHEMAX(K) NOFDUSE NOFDMAX NOIOERR NOOPEN HITRATE(%) RX(K) SPEED(K/S) HOST PROXY ONLINE
2025-01-23 20:58:11 (26596): Guest Log: 2.5.2.0 4118 0 41684 20935 3 1 1744519 4096001 0 65024 0 0 n/a 6590 1987 http://s1cern-cvmfs.openhtc.io/cvmfs/alice.cern.ch DIRECT 1
2025-01-23 20:58:11 (26596): Guest Log: 10:52:08 CET +01:00 2025-01-22: cranky: [INFO] Checking runc.
2025-01-23 20:58:11 (26596): Guest Log: 10:52:09 CET +01:00 2025-01-22: cranky: [INFO] Creating the filesystem.
2025-01-23 20:58:11 (26596): Guest Log: 10:52:09 CET +01:00 2025-01-22: cranky: [INFO] Using /cvmfs/cernvm-prod.cern.ch/cvm4
2025-01-23 20:58:11 (26596): Guest Log: 10:52:09 CET +01:00 2025-01-22: cranky: [INFO] Updating config.json.
2025-01-23 20:58:11 (26596): Guest Log: 10:52:09 CET +01:00 2025-01-22: cranky: [INFO] Running Container 'runc'.
2025-01-23 20:58:11 (26596): Guest Log: job: htmld=/shared/html/job
2025-01-23 20:58:11 (26596): Guest Log: job: unpack exitcode=0
2025-01-23 20:58:11 (26596): Guest Log: INFO: activated the work-around for ld:
2025-01-23 20:58:11 (26596): Guest Log: lrwxrwxrwx 1 0 0 15 Jan 22 09:52 /tmp/tmp.Q7MGomrWV2/ld -> /usr/bin/ld.bfd
2025-01-23 20:58:11 (26596): Guest Log: 10:52:11 CET +01:00 2025-01-22: cranky: [INFO] ===> [runRivet] Wed Jan 22 09:52:09 UTC 2025 [boinc pp jets 7000 20,-,210 - powheg-box r3744 ptdef2 100000 284]
2025-01-23 20:58:11 (26596): Guest Log: 00:21:03.519440 timesync vgsvcTimeSyncWorker: Radical host time change: 10 949 931 000 000ns (HostNow=1 737 551 705 425 000 000 ns HostLast=1 737 540 755 494 000 000 ns)
2025-01-23 20:58:11 (26596): Guest Log: 00:21:13.526448 timesync vgsvcTimeSyncWorker: Radical guest time change: 10 949 922 919 000ns (GuestNow=1 737 551 715 433 057 000 ns GuestLast=1 737 540 765 510 138 000 ns fSetTimeLastLoop=true )
2025-01-23 20:58:11 (26596): Guest Log: 01:21:23.715369 timesync vgsvcTimeSyncWorker: Radical host time change: 9 396 504 000 000ns (HostNow=1 737 564 730 357 000 000 ns HostLast=1 737 555 333 853 000 000 ns)
2025-01-23 20:58:11 (26596): Guest Log: 01:21:33.737209 timesync vgsvcTimeSyncWorker: Radical guest time change: 9 414 756 889 000ns (GuestNow=1 737 564 740 378 848 000 ns GuestLast=1 737 555 325 621 959 000 ns fSetTimeLastLoop=true )
2025-01-23 20:58:11 (26596): Guest Log: 02:03:41.939249 timesync vgsvcTimeSyncWorker: Radical host time change: 9 249 465 000 000ns (HostNow=1 737 576 569 931 000 000 ns HostLast=1 737 567 320 466 000 000 ns)
2025-01-23 20:58:11 (26596): Guest Log: 02:03:51.947953 timesync vgsvcTimeSyncWorker: Radical guest time change: 9 311 358 838 000ns (GuestNow=1 737 576 579 939 714 000 ns GuestLast=1 737 567 268 580 876 000 ns fSetTimeLastLoop=true )
2025-01-23 20:58:11 (26596): Starting VM using VBoxManage interface. (boinc_b7878523d63a7b2c, slot#1)
2025-01-23 20:58:15 (26596): Error in start VM for VM: -2147467259
Command:
VBoxManage -q startvm "boinc_b7878523d63a7b2c" --type headless
Output:
VBoxManage.exe: error: Generic invalid state error. (VERR_INVALID_STATE)
VBoxManage.exe: error: Details: code E_FAIL (0x80004005), component ConsoleWrap, interface IConsole
Waiting for VM "boinc_b7878523d63a7b2c" to power on...

2025-01-23 20:58:15 (26596): VM failed to start.
2025-01-23 20:58:15 (26596): Could not start 
2025-01-23 20:58:15 (26596): ERROR: VM failed to start
2025-01-23 20:58:15 (26596): Powering off VM.
2025-01-23 20:58:15 (26596): Deregistering VM. (boinc_b7878523d63a7b2c, slot#1)
2025-01-23 20:58:15 (26596): Removing network bandwidth throttle group from VM.
2025-01-23 20:58:16 (26596): Removing VM from VirtualBox.

    Hypervisor System Log:

00:00:06.372514          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={300763af-5d6b-46e6-aa96-273eac15538a} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:00:06.372522          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={300763af-5d6b-46e6-aa96-273eac15538a} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:00:06.372529          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={300763af-5d6b-46e6-aa96-273eac15538a} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:00:06.372538          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={300763af-5d6b-46e6-aa96-273eac15538a} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:00:06.372545          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={300763af-5d6b-46e6-aa96-273eac15538a} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:00:06.372552          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={300763af-5d6b-46e6-aa96-273eac15538a} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:00:06.372560          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={300763af-5d6b-46e6-aa96-273eac15538a} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:00:06.372568          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={300763af-5d6b-46e6-aa96-273eac15538a} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:00:06.372576          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={300763af-5d6b-46e6-aa96-273eac15538a} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:00:06.372583          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={300763af-5d6b-46e6-aa96-273eac15538a} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:00:06.372590          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={300763af-5d6b-46e6-aa96-273eac15538a} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:00:06.372598          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={300763af-5d6b-46e6-aa96-273eac15538a} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:00:06.372605          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={300763af-5d6b-46e6-aa96-273eac15538a} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:00:06.372612          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={300763af-5d6b-46e6-aa96-273eac15538a} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:00:06.372619          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={300763af-5d6b-46e6-aa96-273eac15538a} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:00:06.372627          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={300763af-5d6b-46e6-aa96-273eac15538a} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:00:06.372634          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={300763af-5d6b-46e6-aa96-273eac15538a} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:00:06.372641          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={300763af-5d6b-46e6-aa96-273eac15538a} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:00:06.372649          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={300763af-5d6b-46e6-aa96-273eac15538a} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:00:06.372657          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={300763af-5d6b-46e6-aa96-273eac15538a} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:00:06.372667          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={300763af-5d6b-46e6-aa96-273eac15538a} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:00:06.372674          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={300763af-5d6b-46e6-aa96-273eac15538a} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:00:06.372682          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={300763af-5d6b-46e6-aa96-273eac15538a} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:00:06.372689          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={300763af-5d6b-46e6-aa96-273eac15538a} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:00:06.372696          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={300763af-5d6b-46e6-aa96-273eac15538a} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:00:06.372703          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={300763af-5d6b-46e6-aa96-273eac15538a} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:00:06.372711          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={300763af-5d6b-46e6-aa96-273eac15538a} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:00:06.372718          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={300763af-5d6b-46e6-aa96-273eac15538a} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:00:06.372725          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={300763af-5d6b-46e6-aa96-273eac15538a} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:00:06.372732          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={300763af-5d6b-46e6-aa96-273eac15538a} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:00:06.372743          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={300763af-5d6b-46e6-aa96-273eac15538a} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:00:06.372751          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={300763af-5d6b-46e6-aa96-273eac15538a} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:00:06.372759          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={300763af-5d6b-46e6-aa96-273eac15538a} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:00:06.372766          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={300763af-5d6b-46e6-aa96-273eac15538a} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:00:06.373012          Saving settings file "C:\Users\Chapman\.VirtualBox\VirtualBox.xml" with version "1.12-windows"
00:00:06.378481          Finished saving settings file "C:\Users\Chapman\.VirtualBox\VirtualBox.xml"
00:00:06.378919          Saving settings file "C:\Users\Chapman\.VirtualBox\VirtualBox.xml" with version "1.12-windows"
00:00:06.383771          Finished saving settings file "C:\Users\Chapman\.VirtualBox\VirtualBox.xml"
00:00:06.385354 DeleteVM Saving settings file "C:\Users\Chapman\.VirtualBox\VirtualBox.xml" with version "1.12-windows"
00:00:06.390899 DeleteVM Finished saving settings file "C:\Users\Chapman\.VirtualBox\VirtualBox.xml"

    VM Execution Log:


    VM Startup Log:


    VM Trace Log:


Maximum Devices per SATA Port:   1
Maximum PIIX3 SCSI Controllers:  1
Maximum ICH9 SCSI Controllers:   8
Maximum SCSI Port count:         16
Maximum Devices per SCSI Port:   1
Maximum SAS PIIX3 Controllers:   1
Maximum SAS ICH9 Controllers:    8
Maximum SAS Port count:          255
Maximum Devices per SAS Port:    1
Maximum NVMe PIIX3 Controllers:  1
Maximum NVMe ICH9 Controllers:   8
Maximum NVMe Port count:         255
Maximum Devices per NVMe Port:   1
Maximum virtio-scsi PIIX3 Controllers:  1
Maximum virtio-scsi ICH9 Controllers:   8
Maximum virtio-scsi Port count:         256
Maximum Devices per virtio-scsi Port:   1
Maximum PIIX3 Floppy Controllers:1
Maximum ICH9 Floppy Controllers: 1
Maximum Floppy Port count:       1
Maximum Devices per Floppy Port: 2
Default machine folder:          C:\Users\Chapman\VirtualBox VMs
Raw-mode Supported:              no
Exclusive HW virtualization use: off
Default hard disk format:        VDI
VRDE auth library:               VBoxAuth
Webservice auth. library:        VBoxAuth
Remote desktop ExtPack:          
VM encryption ExtPack:           
Log history count:               3
Default frontend:                
Default audio driver:            Windows Audio Session
Autostart database path:         
Default Guest Additions ISO:     C:\Program Files\Oracle\VirtualBox/VBoxGuestAdditions.iso
Logging Level:                   all
Proxy Mode:                      System
Proxy URL:                       
User language:                   C

2025-01-23 20:58:10 (26596): 
Command: VBoxManage -q list hostinfo 
Exit Code: 0
Output:
Host Information:

Host time: 2025-01-23T20:58:10.370000000Z
Processor online count: 12
Processor count: 12
Processor online core count: 6
Processor core count: 6
Processor supports HW virtualization: yes
Processor supports PAE: yes
Processor supports long mode: yes
Processor supports nested paging: yes
Processor supports unrestricted guest: yes
Processor supports nested HW virtualization: yes
Processor supports virt. vmsave/vmload: no
Processor#0 speed: unknown
Processor#0 description: 12th Gen Intel(R) Core(TM) i5-12400F
Processor#1 speed: unknown
Processor#1 description: 12th Gen Intel(R) Core(TM) i5-12400F
Processor#2 speed: unknown
Processor#2 description: 12th Gen Intel(R) Core(TM) i5-12400F
Processor#3 speed: unknown
Processor#3 description: 12th Gen Intel(R) Core(TM) i5-12400F
Processor#4 speed: unknown
Processor#4 description: 12th Gen Intel(R) Core(TM) i5-12400F
Processor#5 speed: unknown
Processor#5 description: 12th Gen Intel(R) Core(TM) i5-12400F
Processor#6 speed: unknown
Processor#6 description: 12th Gen Intel(R) Core(TM) i5-12400F
Processor#7 speed: unknown
Processor#7 description: 12th Gen Intel(R) Core(TM) i5-12400F
Processor#8 speed: unknown
Processor#8 description: 12th Gen Intel(R) Core(TM) i5-12400F
Processor#9 speed: unknown
Processor#9 description: 12th Gen Intel(R) Core(TM) i5-12400F
Processor#10 speed: unknown
Processor#10 description: 12th Gen Intel(R) Core(TM) i5-12400F
Processor#11 speed: unknown
Processor#11 description: 12th Gen Intel(R) Core(TM) i5-12400F
Memory size: 16237 MByte
Memory available: 8716 MByte
Operating system: Windows 11
Operating system version: 10.0.22631

2025-01-23 20:58:10 (26596): 
Command: VBoxManage -q showvminfo "boinc_b7878523d63a7b2c" --machinereadable 
Exit Code: 0
Output:
name="boinc_b7878523d63a7b2c"
Encryption:     disabled
groups="/"
ostype="Linux 2.6 / 3.x / 4.x / 5.x (64-bit)"
UUID="eb626e11-4913-49ef-b37c-4f95f97c8da8"
CfgFile="C:\\ProgramData\\BOINC\\slots\\1\\boinc_b7878523d63a7b2c\\boinc_b7878523d63a7b2c.vbox"
SnapFldr="C:\\ProgramData\\BOINC\\slots\\1\\boinc_b7878523d63a7b2c\\Snapshots"
LogFldr="C:\\ProgramData\\BOINC\\slots\\1\\boinc_b7878523d63a7b2c\\Logs"
hardwareuuid="eb626e11-4913-49ef-b37c-4f95f97c8da8"
memory=630
pagefusion="off"
vram=16
cpuexecutioncap=25
hpet="off"
cpu-profile="host"
chipset="piix3"
firmware="BIOS"
cpus=1
pae="on"
longmode="on"
triplefaultreset="off"
apic="on"
x2apic="on"
nested-hw-virt="off"
cpuid-portability-level=0
bootmenu="messageandmenu"
boot1="disk"
boot2="dvd"
boot3="none"
boot4="none"
acpi="on"
ioapic="on"
biosapic="apic"
biossystemtimeoffset=0
BIOS NVRAM File="C:\\ProgramData\\BOINC\\slots\\1\\boinc_b7878523d63a7b2c\\boinc_b7878523d63a7b2c.nvram"
rtcuseutc="off"
hwvirtex="on"
nestedpaging="on"
largepages="on"
vtxvpid="on"
vtxux="on"
virtvmsavevmload="on"
iommu="none"
paravirtprovider="default"
effparavirtprovider="kvm"
VMState="poweroff"
VMStateChangeTime="2025-01-22T09:50:52.000000000"
graphicscontroller="vboxvga"
monitorcount=1
accelerate3d="off"
accelerate2dvideo="off"
teleporterenabled="off"
teleporterport=0
teleporteraddress=""
teleporterpassword=""
tracing-enabled="off"
tracing-allow-vm-access="off"
tracing-config=""
autostart-enabled="off"
autostart-delay=0
defaultfrontend=""
vmprocpriority="default"
storagecontrollername0="Hard Disk Controller"
storagecontrollertype0="IntelAhci"
storagecontrollerinstance0="0"
storagecontrollermaxportcount0="30"
storagecontrollerportcount0="3"
storagecontrollerbootable0="on"
"Hard Disk Controller-0-0"="C:\\ProgramData\\BOINC\\slots\\1\\boinc_b7878523d63a7b2c\\Snapshots/{e49fa273-b28f-4bd4-9cc9-838939053c24}.vdi"
"Hard Disk Controller-ImageUUID-0-0"="e49fa273-b28f-4bd4-9cc9-838939053c24"
"Hard Disk Controller-nonrotational-0-0"="off"
"Hard Disk Controller-discard-0-0"="off"
"Hard Disk Controller-1-0"="C:\\Program Files\\Oracle\\VirtualBox\\VBoxGuestAdditions.iso"
"Hard Disk Controller-ImageUUID-1-0"="686da2ee-59a2-49d2-b0e1-4cfcad4d8691"
"Hard Disk Controller-tempeject-1-0"="off"
"Hard Disk Controller-IsEjected-1-0"="off"
"Hard Disk Controller-nonrotational-1-0"="off"
"Hard Disk Controller-discard-1-0"="off"
"Hard Disk Controller-2-0"="none"
natnet1="nat"
macaddress1="080027D04807"
cableconnected1="on"
nic1="nat"
nictype1="82540EM"
nicspeed1="0"
mtu="0"
sockSnd="64"
sockRcv="64"
tcpWndSnd="64"
tcpWndRcv="64"
Forwarding(0)="tcp_51555_80,tcp,127.0.0.1,51555,,80"
nic2="none"
nic3="none"
nic4="none"
nic5="none"
nic6="none"
nic7="none"
nic8="none"
hidpointing="ps2mouse"
hidkeyboard="ps2kbd"
uart1="off"
uart2="off"
uart3="off"
uart4="off"
lpt1="off"
lpt2="off"
audio="none"
audio_out="off"
audio_in="off"
clipboard="disabled"
draganddrop="disabled"
vrde="off"
usb="off"
ehci="off"
xhci="off"
BandwidthGroup0="boinc_b7878523d63a7b2c_net",Network,1099511627776
SharedFolderNameMachineMapping1="shared"
SharedFolderPathMachineMapping1="C:\\ProgramData\\BOINC\\slots\\1\\shared"
recording_enabled="off"
recording_screens=1
 rec_screen0
rec_screen_enabled="on"
rec_screen_id=0
rec_screen_video_enabled="on"
rec_screen_audio_enabled="off"
rec_screen_dest="File"
rec_screen_dest_filename="C:\\ProgramData\\BOINC\\slots\\1\\boinc_b7878523d63a7b2c\\boinc_b7878523d63a7b2c-screen0.webm"
rec_screen_opts="vc_enabled=true,ac_enabled=false,ac_profile=med"
rec_screen_video_res_xy="1024x768"
rec_screen_video_rate_kbps=512
rec_screen_video_fps=25
description="Theory_2773-2964403-284_1"
GuestMemoryBalloon=0

2025-01-23 20:58:15 (26596): 
Command: VBoxManage -q startvm "boinc_b7878523d63a7b2c" --type headless
Exit Code: -2147467259
Output:
VBoxManage.exe: error: Generic invalid state error. (VERR_INVALID_STATE)
VBoxManage.exe: error: Details: code E_FAIL (0x80004005), component ConsoleWrap, interface IConsole
Waiting for VM "boinc_b7878523d63a7b2c" to power on...

2025-01-23 20:58:15 (26596): 
Command: VBoxManage -q snapshot "boinc_b7878523d63a7b2c" list 
Exit Code: -108
Output:
This machine does not have any snapshots

2025-01-23 20:58:16 (26596): 
Command: VBoxManage -q bandwidthctl "boinc_b7878523d63a7b2c" remove "boinc_b7878523d63a7b2c_net" 
Exit Code: 0
Output:
VBoxManage.exe: error: Bandwidth groups cannot be deleted while the VM is running

2025-01-23 20:58:16 (26596): 
Command: VBoxManage -q unregistervm "boinc_b7878523d63a7b2c" --delete 
Exit Code: 0
Output:
0%...10%...20%...30%...40%...50%...60%...70%...80%...90%...100%

2025-01-23 20:58:26 (26596): called boinc_finish(-2147467259)

</stderr_txt>
]]>


©2025 CERN