Name Theory_2773-2971502-442_0
Workunit 230107833
Created 2 Feb 2025, 13:21:11 UTC
Sent 2 Feb 2025, 13:31:19 UTC
Report deadline 13 Feb 2025, 13:31:19 UTC
Received 7 Feb 2025, 4:23:45 UTC
Server state Over
Outcome Computation error
Client state Compute error
Exit status -2147467259 (0x80004005) Unknown error code
Computer ID 10849835
Run time 41 min 4 sec
CPU time 19 min 28 sec
Validate state Invalid
Credit 0.00
Device peak FLOPS 3.57 GFLOPS
Application version Theory Simulation v300.60 (vbox64_theory)
windows_x86_64
Peak working set size 68.23 MB
Peak swap size 53.59 MB
Peak disk usage 1.85 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-02-06 19:10:49 (37168): vboxwrapper version 26208
2025-02-06 19:10:49 (37168): BOINC client version: 8.0.2
2025-02-06 19:10:51 (37168): Detected: VirtualBox VboxManage Interface (Version: 7.1.6)
2025-02-06 19:10:51 (37168): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2025-02-06 19:10:51 (37168): Successfully copied 'init_data.xml' to the shared directory.
2025-02-06 19:10:51 (37168): Successfully copied 'input' to the shared directory.
2025-02-06 19:10:51 (37168): Create VM. (boinc_112f30c3f212ae4d, slot#4)
2025-02-06 19:10:52 (37168): Setting Memory Size for VM. (630MB)
2025-02-06 19:10:52 (37168): Setting CPU Count for VM. (1)
2025-02-06 19:10:52 (37168): Setting Chipset Options for VM.
2025-02-06 19:10:53 (37168): Setting Graphics Controller Options for VM.
2025-02-06 19:10:53 (37168): Setting Boot Options for VM.
2025-02-06 19:10:53 (37168): Setting Network Configuration for NAT.
2025-02-06 19:10:54 (37168): Enabling VM Network Access.
2025-02-06 19:10:54 (37168): Disabling USB Support for VM.
2025-02-06 19:10:54 (37168): Disabling COM Port Support for VM.
2025-02-06 19:10:55 (37168): Disabling LPT Port Support for VM.
2025-02-06 19:10:55 (37168): Disabling Audio Support for VM.
2025-02-06 19:10:55 (37168): Disabling Clipboard Support for VM.
2025-02-06 19:10:55 (37168): Disabling Drag and Drop Support for VM.
2025-02-06 19:10:56 (37168): Adding storage controller(s) to VM.
2025-02-06 19:10:56 (37168): Adding virtual disk drive to VM. (Theory_2025_01_16_prod.vdi)
2025-02-06 19:10:58 (37168): Adding VirtualBox Guest Additions to VM.
2025-02-06 19:10:59 (37168): Adding network bandwidth throttle group to VM. (Defaulting to 1024GB)
2025-02-06 19:10:59 (37168): forwarding host port 52452 to guest port 80
2025-02-06 19:10:59 (37168): Enabling remote desktop for VM.
2025-02-06 19:10:59 (37168): Required extension pack not installed, remote desktop not enabled.
2025-02-06 19:10:59 (37168): Enabling shared directory for VM.
2025-02-06 19:11:00 (37168): Starting VM using VBoxManage interface. (boinc_112f30c3f212ae4d, slot#4)
2025-02-06 19:11:08 (37168): Successfully started VM. (PID = '36152')
2025-02-06 19:11:08 (37168): Reporting VM Process ID to BOINC.
2025-02-06 19:11:08 (37168): Guest Log: BIOS: VirtualBox 7.1.6
2025-02-06 19:11:08 (37168): Guest Log: CPUID EDX: 0x178bfbff
2025-02-06 19:11:08 (37168): Guest Log: BIOS: No PCI IDE controller, not probing IDE
2025-02-06 19:11:08 (37168): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors
2025-02-06 19:11:08 (37168): VM state change detected. (old = 'poweredoff', new = 'running')
2025-02-06 19:11:08 (37168): Detected: Web Application Enabled (http://localhost:52452)
2025-02-06 19:11:09 (37168): VM state change detected. (old = 'running', new = 'paused')
2025-02-06 19:11:20 (37168): Preference change detected
2025-02-06 19:11:20 (37168): Setting CPU throttle for VM. (40%)
2025-02-06 19:11:20 (37168): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2025-02-06 19:11:21 (37168): VM state change detected. (old = 'paused', new = 'running')
2025-02-06 19:11:22 (37168): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2025-02-06 19:11:22 (37168): Guest Log: BIOS: Booting from Hard Disk...
2025-02-06 19:11:25 (37168): Guest Log: BIOS: KBD: unsupported int 16h function 03
2025-02-06 19:11:25 (37168): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 
2025-02-06 19:12:15 (37168): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2025-02-06 19:12:15 (37168): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)
2025-02-06 19:12:20 (37168): Stopping VM.
2025-02-06 19:12:24 (37168): Successfully stopped VM.
2025-02-06 19:33:15 (35220): vboxwrapper version 26208
2025-02-06 19:33:15 (35220): BOINC client version: 8.0.2
2025-02-06 19:33:17 (35220): Detected: VirtualBox VboxManage Interface (Version: 7.1.6)
2025-02-06 19:33:17 (35220): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2025-02-06 19:33:18 (35220): Guest Log: BIOS: VirtualBox 7.1.6
2025-02-06 19:33:18 (35220): Guest Log: CPUID EDX: 0x178bfbff
2025-02-06 19:33:18 (35220): Guest Log: BIOS: No PCI IDE controller, not probing IDE
2025-02-06 19:33:18 (35220): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors
2025-02-06 19:33:18 (35220): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2025-02-06 19:33:18 (35220): Guest Log: BIOS: Booting from Hard Disk...
2025-02-06 19:33:18 (35220): Guest Log: BIOS: KBD: unsupported int 16h function 03
2025-02-06 19:33:18 (35220): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 
2025-02-06 19:33:18 (35220): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2025-02-06 19:33:18 (35220): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)
2025-02-06 19:33:18 (35220): Starting VM using VBoxManage interface. (boinc_112f30c3f212ae4d, slot#4)
2025-02-06 19:33:27 (35220): Successfully started VM. (PID = '35956')
2025-02-06 19:33:27 (35220): Reporting VM Process ID to BOINC.
2025-02-06 19:33:27 (35220): VM state change detected. (old = 'poweredoff', new = 'running')
2025-02-06 19:33:27 (35220): Detected: Web Application Enabled (http://localhost:52452)
2025-02-06 19:33:28 (35220): VM state change detected. (old = 'running', new = 'paused')
2025-02-06 19:33:42 (35220): Preference change detected
2025-02-06 19:33:42 (35220): Setting CPU throttle for VM. (40%)
2025-02-06 19:33:42 (35220): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2025-02-06 19:33:42 (35220): VM state change detected. (old = 'paused', new = 'running')
2025-02-06 19:33:48 (35220): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log
2025-02-06 19:33:48 (35220): Guest Log: 00:00:00.000217 main     Log opened 2025-02-07T01:12:28.557897000Z
2025-02-06 19:33:48 (35220): Guest Log: 00:00:00.000571 main     OS Product: Linux
2025-02-06 19:33:48 (35220): Guest Log: 00:00:00.000684 main     OS Release: 4.14.76-13.cernvm.x86_64
2025-02-06 19:33:48 (35220): Guest Log: 00:00:00.000757 main     OS Version: #1 SMP Tue Oct 16 18:26:15 CEST 2018
2025-02-06 19:33:48 (35220): Guest Log: 00:00:00.000826 main     Executable: /usr/sbin/VBoxService
2025-02-06 19:33:48 (35220): Guest Log: 00:00:00.000828 main     Process ID: 3249
2025-02-06 19:33:48 (35220): Guest Log: 00:00:00.000829 main     Package type: LINUX_64BITS_GENERIC
2025-02-06 19:33:48 (35220): Guest Log: 00:00:00.005744 main     5.2.6 r120293 started. Verbose level = 0
2025-02-06 19:33:52 (35220): VM state change detected. (old = 'running', new = 'paused')
2025-02-06 19:34:12 (35220): VM state change detected. (old = 'paused', new = 'running')
2025-02-06 19:34:22 (35220): VM state change detected. (old = 'running', new = 'paused')
2025-02-06 19:34:42 (35220): VM state change detected. (old = 'paused', new = 'running')
2025-02-06 19:35:24 (35220): Stopping VM.
2025-02-06 19:35:27 (35220): Successfully stopped VM.
2025-02-06 19:38:24 (41932): vboxwrapper version 26208
2025-02-06 19:38:24 (41932): BOINC client version: 8.0.2
2025-02-06 19:38:25 (41932): Detected: VirtualBox VboxManage Interface (Version: 7.1.6)
2025-02-06 19:38:25 (41932): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2025-02-06 19:38:26 (41932): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log
2025-02-06 19:38:26 (41932): Guest Log: 00:00:00.000217 main     Log opened 2025-02-07T01:12:28.557897000Z
2025-02-06 19:38:26 (41932): Guest Log: 00:00:00.000571 main     OS Product: Linux
2025-02-06 19:38:26 (41932): Guest Log: 00:00:00.000684 main     OS Release: 4.14.76-13.cernvm.x86_64
2025-02-06 19:38:26 (41932): Guest Log: 00:00:00.000757 main     OS Version: #1 SMP Tue Oct 16 18:26:15 CEST 2018
2025-02-06 19:38:26 (41932): Guest Log: 00:00:00.000826 main     Executable: /usr/sbin/VBoxService
2025-02-06 19:38:26 (41932): Guest Log: 00:00:00.000828 main     Process ID: 3249
2025-02-06 19:38:26 (41932): Guest Log: 00:00:00.000829 main     Package type: LINUX_64BITS_GENERIC
2025-02-06 19:38:26 (41932): Guest Log: 00:00:00.005744 main     5.2.6 r120293 started. Verbose level = 0
2025-02-06 19:38:26 (41932): Starting VM using VBoxManage interface. (boinc_112f30c3f212ae4d, slot#4)
2025-02-06 19:38:36 (41932): Successfully started VM. (PID = '6772')
2025-02-06 19:38:36 (41932): Reporting VM Process ID to BOINC.
2025-02-06 19:38:36 (41932): VM state change detected. (old = 'poweredoff', new = 'running')
2025-02-06 19:38:36 (41932): Detected: Web Application Enabled (http://localhost:52452)
2025-02-06 19:38:36 (41932): Preference change detected
2025-02-06 19:38:36 (41932): Setting CPU throttle for VM. (40%)
2025-02-06 19:38:36 (41932): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2025-02-06 19:38:52 (41932): Guest Log: 02:38:51 CET +01:00 2025-02-07: cranky: [INFO] Detected Theory App
2025-02-06 19:38:52 (41932): Guest Log: 02:38:51 CET +01:00 2025-02-07: cranky: [INFO] Checking CVMFS.
2025-02-06 19:38:56 (41932): Guest Log: Probing /cvmfs/sft.cern.ch... OK
2025-02-06 19:38:58 (41932): 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-02-06 19:38:58 (41932): Guest Log: 2.5.2.0 4163 4 25144 31689 0 1 279119 4096000 0 65024 0 0 n/a 5 1 http://s1unl-cvmfs.openhtc.io/cvmfs/sft.cern.ch DIRECT 1
2025-02-06 19:39:02 (41932): Guest Log: Probing /cvmfs/grid.cern.ch... OK
2025-02-06 19:39:05 (41932): 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-02-06 19:39:05 (41932): Guest Log: 2.5.2.0 4140 4 27536 26419 0 2 279119 4096000 0 65024 0 2 -100 10084 2736 http://s1bnl-cvmfs.openhtc.io/cvmfs/grid.cern.ch DIRECT 1
2025-02-06 19:39:09 (41932): Guest Log: Probing /cvmfs/cernvm-prod.cern.ch... OK
2025-02-06 19:39:12 (41932): 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-02-06 19:39:12 (41932): Guest Log: 2.5.2.0 4117 4 27244 272 0 1 279119 4096000 0 65024 0 0 n/a 4 2 http://s1fnal-cvmfs.openhtc.io/cvmfs/cernvm-prod.cern.ch DIRECT 1
2025-02-06 19:39:16 (41932): Guest Log: Probing /cvmfs/alice.cern.ch... OK
2025-02-06 19:39:19 (41932): 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-02-06 19:39:19 (41932): Guest Log: 2.5.2.0 4196 4 42524 21109 3 1 279119 4096000 0 65024 0 0 n/a 8809 885 http://s1cern-cvmfs.openhtc.io/cvmfs/alice.cern.ch DIRECT 1
2025-02-06 19:39:20 (41932): Guest Log: 02:39:19 CET +01:00 2025-02-07: cranky: [INFO] Checking runc.
2025-02-06 19:39:20 (41932): Guest Log: 02:39:19 CET +01:00 2025-02-07: cranky: [INFO] Creating the filesystem.
2025-02-06 19:39:20 (41932): Guest Log: 02:39:19 CET +01:00 2025-02-07: cranky: [INFO] Using /cvmfs/cernvm-prod.cern.ch/cvm4
2025-02-06 19:39:21 (41932): Guest Log: 02:39:20 CET +01:00 2025-02-07: cranky: [INFO] Updating config.json.
2025-02-06 19:39:21 (41932): Guest Log: 02:39:20 CET +01:00 2025-02-07: cranky: [INFO] Running Container 'runc'.
2025-02-06 19:39:33 (41932): Guest Log: job: htmld=/shared/html/job
2025-02-06 19:39:34 (41932): Guest Log: job: unpack exitcode=0
2025-02-06 19:39:34 (41932): Guest Log: INFO: activated the work-around for ld:
2025-02-06 19:39:34 (41932): Guest Log: lrwxrwxrwx 1 0 0 15 Feb  7 01:39 /tmp/tmp.MyymAER54W/ld -> /usr/bin/ld.bfd
2025-02-06 19:39:36 (41932): Guest Log: 02:39:35 CET +01:00 2025-02-07: cranky: [INFO] ===> [runRivet] Fri Feb  7 01:39:34 UTC 2025 [boinc pp jets 7000 25,-,760 - powheg-box r3744 pthard0 100000 442]
2025-02-06 19:39:54 (41932): VM state change detected. (old = 'running', new = 'paused')
2025-02-06 19:40:14 (41932): VM state change detected. (old = 'paused', new = 'running')
2025-02-06 19:40:44 (41932): VM state change detected. (old = 'running', new = 'paused')
2025-02-06 19:41:04 (41932): VM state change detected. (old = 'paused', new = 'running')
2025-02-06 19:41:24 (41932): VM state change detected. (old = 'running', new = 'paused')
2025-02-06 19:41:45 (41932): VM state change detected. (old = 'paused', new = 'running')
2025-02-06 19:42:25 (41932): VM state change detected. (old = 'running', new = 'paused')
2025-02-06 19:42:45 (41932): VM state change detected. (old = 'paused', new = 'running')
2025-02-06 19:42:55 (41932): VM state change detected. (old = 'running', new = 'paused')
2025-02-06 19:43:15 (41932): VM state change detected. (old = 'paused', new = 'running')
2025-02-06 19:43:25 (41932): VM state change detected. (old = 'running', new = 'paused')
2025-02-06 19:43:45 (41932): VM state change detected. (old = 'paused', new = 'running')
2025-02-06 19:43:55 (41932): VM state change detected. (old = 'running', new = 'paused')
2025-02-06 19:44:15 (41932): VM state change detected. (old = 'paused', new = 'running')
2025-02-06 19:44:25 (41932): VM state change detected. (old = 'running', new = 'paused')
2025-02-06 19:44:45 (41932): VM state change detected. (old = 'paused', new = 'running')
2025-02-06 19:46:05 (41932): VM state change detected. (old = 'running', new = 'paused')
2025-02-06 19:46:25 (41932): VM state change detected. (old = 'paused', new = 'running')
2025-02-06 19:46:35 (41932): VM state change detected. (old = 'running', new = 'paused')
2025-02-06 19:46:55 (41932): VM state change detected. (old = 'paused', new = 'running')
2025-02-06 19:47:05 (41932): VM state change detected. (old = 'running', new = 'paused')
2025-02-06 19:47:25 (41932): VM state change detected. (old = 'paused', new = 'running')
2025-02-06 19:47:45 (41932): VM state change detected. (old = 'running', new = 'paused')
2025-02-06 19:48:25 (41932): VM state change detected. (old = 'paused', new = 'running')
2025-02-06 19:48:36 (41932): VM state change detected. (old = 'running', new = 'paused')
2025-02-06 19:48:56 (41932): VM state change detected. (old = 'paused', new = 'running')
2025-02-06 19:49:06 (41932): VM state change detected. (old = 'running', new = 'paused')
2025-02-06 19:49:26 (41932): VM state change detected. (old = 'paused', new = 'running')
2025-02-06 19:49:46 (41932): VM state change detected. (old = 'running', new = 'paused')
2025-02-06 19:50:06 (41932): VM state change detected. (old = 'paused', new = 'running')
2025-02-06 19:50:16 (41932): VM state change detected. (old = 'running', new = 'paused')
2025-02-06 19:50:36 (41932): VM state change detected. (old = 'paused', new = 'running')
2025-02-06 19:50:56 (41932): VM state change detected. (old = 'running', new = 'paused')
2025-02-06 19:51:16 (41932): VM state change detected. (old = 'paused', new = 'running')
2025-02-06 19:51:26 (41932): VM state change detected. (old = 'running', new = 'paused')
2025-02-06 19:51:46 (41932): VM state change detected. (old = 'paused', new = 'running')
2025-02-06 19:51:56 (41932): VM state change detected. (old = 'running', new = 'paused')
2025-02-06 19:52:16 (41932): VM state change detected. (old = 'paused', new = 'running')
2025-02-06 19:52:36 (41932): VM state change detected. (old = 'running', new = 'paused')
2025-02-06 19:52:56 (41932): VM state change detected. (old = 'paused', new = 'running')
2025-02-06 19:53:06 (41932): VM state change detected. (old = 'running', new = 'paused')
2025-02-06 19:53:26 (41932): VM state change detected. (old = 'paused', new = 'running')
2025-02-06 19:53:36 (41932): VM state change detected. (old = 'running', new = 'paused')
2025-02-06 19:53:56 (41932): VM state change detected. (old = 'paused', new = 'running')
2025-02-06 19:54:16 (41932): VM state change detected. (old = 'running', new = 'paused')
2025-02-06 19:54:36 (41932): VM state change detected. (old = 'paused', new = 'running')
2025-02-06 19:54:46 (41932): VM state change detected. (old = 'running', new = 'paused')
2025-02-06 19:55:06 (41932): VM state change detected. (old = 'paused', new = 'running')
2025-02-06 19:55:56 (41932): VM state change detected. (old = 'running', new = 'paused')
2025-02-06 19:56:16 (41932): VM state change detected. (old = 'paused', new = 'running')
2025-02-06 19:56:26 (41932): VM state change detected. (old = 'running', new = 'paused')
2025-02-06 19:56:47 (41932): VM state change detected. (old = 'paused', new = 'running')
2025-02-06 19:57:07 (41932): VM state change detected. (old = 'running', new = 'paused')
2025-02-06 19:57:27 (41932): VM state change detected. (old = 'paused', new = 'running')
2025-02-06 19:57:47 (41932): VM state change detected. (old = 'running', new = 'paused')
2025-02-06 19:58:07 (41932): VM state change detected. (old = 'paused', new = 'running')
2025-02-06 19:58:17 (41932): VM state change detected. (old = 'running', new = 'paused')
2025-02-06 19:58:37 (41932): VM state change detected. (old = 'paused', new = 'running')
2025-02-06 19:58:57 (41932): VM state change detected. (old = 'running', new = 'paused')
2025-02-06 19:59:17 (41932): VM state change detected. (old = 'paused', new = 'running')
2025-02-06 19:59:27 (41932): VM state change detected. (old = 'running', new = 'paused')
2025-02-06 19:59:47 (41932): VM state change detected. (old = 'paused', new = 'running')
2025-02-06 20:00:17 (41932): VM state change detected. (old = 'running', new = 'paused')
2025-02-06 20:00:37 (41932): VM state change detected. (old = 'paused', new = 'running')
2025-02-06 20:00:47 (41932): VM state change detected. (old = 'running', new = 'paused')
2025-02-06 20:01:07 (41932): VM state change detected. (old = 'paused', new = 'running')
2025-02-06 20:01:17 (41932): VM state change detected. (old = 'running', new = 'paused')
2025-02-06 20:01:37 (41932): VM state change detected. (old = 'paused', new = 'running')
2025-02-06 20:01:48 (41932): VM state change detected. (old = 'running', new = 'paused')
2025-02-06 20:02:08 (41932): VM state change detected. (old = 'paused', new = 'running')
2025-02-06 20:02:18 (41932): VM state change detected. (old = 'running', new = 'paused')
2025-02-06 20:02:38 (41932): VM state change detected. (old = 'paused', new = 'running')
2025-02-06 20:02:58 (41932): VM state change detected. (old = 'running', new = 'paused')
2025-02-06 20:03:18 (41932): VM state change detected. (old = 'paused', new = 'running')
2025-02-06 20:03:28 (41932): VM state change detected. (old = 'running', new = 'paused')
2025-02-06 20:03:48 (41932): VM state change detected. (old = 'paused', new = 'running')
2025-02-06 20:04:28 (41932): VM state change detected. (old = 'running', new = 'paused')
2025-02-06 20:04:48 (41932): VM state change detected. (old = 'paused', new = 'running')
2025-02-06 20:05:08 (41932): VM state change detected. (old = 'running', new = 'paused')
2025-02-06 20:05:28 (41932): VM state change detected. (old = 'paused', new = 'running')
2025-02-06 20:05:38 (41932): VM state change detected. (old = 'running', new = 'paused')
2025-02-06 20:05:58 (41932): VM state change detected. (old = 'paused', new = 'running')
2025-02-06 20:06:08 (41932): VM state change detected. (old = 'running', new = 'paused')
2025-02-06 20:06:28 (41932): VM state change detected. (old = 'paused', new = 'running')
2025-02-06 20:06:38 (41932): VM state change detected. (old = 'running', new = 'paused')
2025-02-06 20:06:58 (41932): VM state change detected. (old = 'paused', new = 'running')
2025-02-06 20:08:30 (41932): Stopping VM.
2025-02-06 20:08:35 (41932): Successfully stopped VM.
2025-02-06 20:25:55 (40360): vboxwrapper version 26208
2025-02-06 20:25:55 (40360): BOINC client version: 8.0.2
2025-02-06 20:25:56 (40360): Detected: VirtualBox VboxManage Interface (Version: 7.1.6)
2025-02-06 20:25:57 (40360): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2025-02-06 20:25:57 (40360): Guest Log: 02:38:51 CET +01:00 2025-02-07: cranky: [INFO] Detected Theory App
2025-02-06 20:25:57 (40360): Guest Log: 02:38:51 CET +01:00 2025-02-07: cranky: [INFO] Checking CVMFS.
2025-02-06 20:25:57 (40360): Guest Log: Probing /cvmfs/sft.cern.ch... OK
2025-02-06 20:25:57 (40360): 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-02-06 20:25:57 (40360): Guest Log: 2.5.2.0 4163 4 25144 31689 0 1 279119 4096000 0 65024 0 0 n/a 5 1 http://s1unl-cvmfs.openhtc.io/cvmfs/sft.cern.ch DIRECT 1
2025-02-06 20:25:57 (40360): Guest Log: Probing /cvmfs/grid.cern.ch... OK
2025-02-06 20:25:57 (40360): 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-02-06 20:25:57 (40360): Guest Log: 2.5.2.0 4140 4 27536 26419 0 2 279119 4096000 0 65024 0 2 -100 10084 2736 http://s1bnl-cvmfs.openhtc.io/cvmfs/grid.cern.ch DIRECT 1
2025-02-06 20:25:57 (40360): Guest Log: Probing /cvmfs/cernvm-prod.cern.ch... OK
2025-02-06 20:25:57 (40360): 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-02-06 20:25:57 (40360): Guest Log: 2.5.2.0 4117 4 27244 272 0 1 279119 4096000 0 65024 0 0 n/a 4 2 http://s1fnal-cvmfs.openhtc.io/cvmfs/cernvm-prod.cern.ch DIRECT 1
2025-02-06 20:25:57 (40360): Guest Log: Probing /cvmfs/alice.cern.ch... OK
2025-02-06 20:25:57 (40360): 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-02-06 20:25:57 (40360): Guest Log: 2.5.2.0 4196 4 42524 21109 3 1 279119 4096000 0 65024 0 0 n/a 8809 885 http://s1cern-cvmfs.openhtc.io/cvmfs/alice.cern.ch DIRECT 1
2025-02-06 20:25:57 (40360): Guest Log: 02:39:19 CET +01:00 2025-02-07: cranky: [INFO] Checking runc.
2025-02-06 20:25:57 (40360): Guest Log: 02:39:19 CET +01:00 2025-02-07: cranky: [INFO] Creating the filesystem.
2025-02-06 20:25:57 (40360): Guest Log: 02:39:19 CET +01:00 2025-02-07: cranky: [INFO] Using /cvmfs/cernvm-prod.cern.ch/cvm4
2025-02-06 20:25:57 (40360): Guest Log: 02:39:20 CET +01:00 2025-02-07: cranky: [INFO] Updating config.json.
2025-02-06 20:25:57 (40360): Guest Log: 02:39:20 CET +01:00 2025-02-07: cranky: [INFO] Running Container 'runc'.
2025-02-06 20:25:57 (40360): Guest Log: job: htmld=/shared/html/job
2025-02-06 20:25:57 (40360): Guest Log: job: unpack exitcode=0
2025-02-06 20:25:57 (40360): Guest Log: INFO: activated the work-around for ld:
2025-02-06 20:25:57 (40360): Guest Log: lrwxrwxrwx 1 0 0 15 Feb  7 01:39 /tmp/tmp.MyymAER54W/ld -> /usr/bin/ld.bfd
2025-02-06 20:25:57 (40360): Guest Log: 02:39:35 CET +01:00 2025-02-07: cranky: [INFO] ===> [runRivet] Fri Feb  7 01:39:34 UTC 2025 [boinc pp jets 7000 25,-,760 - powheg-box r3744 pthard0 100000 442]
2025-02-06 20:25:57 (40360): Starting VM using VBoxManage interface. (boinc_112f30c3f212ae4d, slot#4)
2025-02-06 20:26:08 (40360): Successfully started VM. (PID = '38852')
2025-02-06 20:26:08 (40360): Reporting VM Process ID to BOINC.
2025-02-06 20:26:08 (40360): VM state change detected. (old = 'poweredoff', new = 'running')
2025-02-06 20:26:08 (40360): Detected: Web Application Enabled (http://localhost:52452)
2025-02-06 20:26:09 (40360): VM state change detected. (old = 'running', new = 'paused')
2025-02-06 20:26:28 (40360): Preference change detected
2025-02-06 20:26:28 (40360): Setting CPU throttle for VM. (40%)
2025-02-06 20:26:28 (40360): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2025-02-06 20:26:29 (40360): VM state change detected. (old = 'paused', new = 'running')
2025-02-06 20:26:39 (40360): VM state change detected. (old = 'running', new = 'paused')
2025-02-06 20:26:59 (40360): Guest Log: 00:16:21.562789 timesync vgsvcTimeSyncWorker: Radical guest time change: 1 968 281 651 000ns (GuestNow=1 738 895 198 699 843 000 ns GuestLast=1 738 893 230 418 192 000 ns fSetTimeLastLoop=true )
2025-02-06 20:26:59 (40360): VM state change detected. (old = 'paused', new = 'running')
2025-02-06 20:27:29 (40360): VM state change detected. (old = 'running', new = 'paused')
2025-02-06 20:27:49 (40360): VM state change detected. (old = 'paused', new = 'running')
2025-02-06 20:27:59 (40360): VM state change detected. (old = 'running', new = 'paused')
2025-02-06 20:28:19 (40360): VM state change detected. (old = 'paused', new = 'running')
2025-02-06 20:28:19 (40360): Stopping VM.
2025-02-06 20:28:23 (40360): Successfully stopped VM.
2025-02-06 20:31:03 (39108): vboxwrapper version 26208
2025-02-06 20:31:03 (39108): BOINC client version: 8.0.2
2025-02-06 20:31:05 (39108): Detected: VirtualBox VboxManage Interface (Version: 7.1.6)
2025-02-06 20:31:05 (39108): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2025-02-06 20:31:06 (39108): Guest Log: 00:16:21.562789 timesync vgsvcTimeSyncWorker: Radical guest time change: 1 968 281 651 000ns (GuestNow=1 738 895 198 699 843 000 ns GuestLast=1 738 893 230 418 192 000 ns fSetTimeLastLoop=true )
2025-02-06 20:31:06 (39108): Starting VM using VBoxManage interface. (boinc_112f30c3f212ae4d, slot#4)
2025-02-06 20:31:16 (39108): Successfully started VM. (PID = '8936')
2025-02-06 20:31:16 (39108): Reporting VM Process ID to BOINC.
2025-02-06 20:31:17 (39108): VM state change detected. (old = 'poweredoff', new = 'running')
2025-02-06 20:31:17 (39108): Detected: Web Application Enabled (http://localhost:52452)
2025-02-06 20:31:17 (39108): Preference change detected
2025-02-06 20:31:17 (39108): Setting CPU throttle for VM. (40%)
2025-02-06 20:31:17 (39108): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2025-02-06 20:32:11 (39108): VM state change detected. (old = 'running', new = 'paused')
2025-02-06 20:32:31 (39108): VM state change detected. (old = 'paused', new = 'running')
2025-02-06 20:33:11 (39108): VM state change detected. (old = 'running', new = 'paused')
2025-02-06 20:33:31 (39108): VM state change detected. (old = 'paused', new = 'running')
2025-02-06 20:33:41 (39108): VM state change detected. (old = 'running', new = 'paused')
2025-02-06 20:34:01 (39108): VM state change detected. (old = 'paused', new = 'running')
2025-02-06 20:34:11 (39108): VM state change detected. (old = 'running', new = 'paused')
2025-02-06 20:34:31 (39108): VM state change detected. (old = 'paused', new = 'running')
2025-02-06 20:34:41 (39108): VM state change detected. (old = 'running', new = 'paused')
2025-02-06 20:35:01 (39108): VM state change detected. (old = 'paused', new = 'running')
2025-02-06 20:35:11 (39108): VM state change detected. (old = 'running', new = 'paused')
2025-02-06 20:35:31 (39108): VM state change detected. (old = 'paused', new = 'running')
2025-02-06 20:35:41 (39108): VM state change detected. (old = 'running', new = 'paused')
2025-02-06 20:36:01 (39108): VM state change detected. (old = 'paused', new = 'running')
2025-02-06 20:36:11 (39108): VM state change detected. (old = 'running', new = 'paused')
2025-02-06 20:36:31 (39108): VM state change detected. (old = 'paused', new = 'running')
2025-02-06 20:36:42 (39108): VM state change detected. (old = 'running', new = 'paused')
2025-02-06 20:37:02 (39108): VM state change detected. (old = 'paused', new = 'running')
2025-02-06 20:37:12 (39108): VM state change detected. (old = 'running', new = 'paused')
2025-02-06 20:37:32 (39108): VM state change detected. (old = 'paused', new = 'running')
2025-02-06 20:37:42 (39108): VM state change detected. (old = 'running', new = 'paused')
2025-02-06 20:38:02 (39108): VM state change detected. (old = 'paused', new = 'running')
2025-02-06 20:38:12 (39108): VM state change detected. (old = 'running', new = 'paused')
2025-02-06 20:38:32 (39108): VM state change detected. (old = 'paused', new = 'running')
2025-02-06 20:38:42 (39108): VM state change detected. (old = 'running', new = 'paused')
2025-02-06 20:39:02 (39108): VM state change detected. (old = 'paused', new = 'running')
2025-02-06 20:39:12 (39108): VM state change detected. (old = 'running', new = 'paused')
2025-02-06 20:39:32 (39108): VM state change detected. (old = 'paused', new = 'running')
2025-02-06 20:39:42 (39108): VM state change detected. (old = 'running', new = 'paused')
2025-02-06 20:40:02 (39108): VM state change detected. (old = 'paused', new = 'running')
2025-02-06 20:40:12 (39108): VM state change detected. (old = 'running', new = 'paused')
2025-02-06 20:40:32 (39108): VM state change detected. (old = 'paused', new = 'running')
2025-02-06 20:40:42 (39108): VM state change detected. (old = 'running', new = 'paused')
2025-02-06 20:41:02 (39108): VM state change detected. (old = 'paused', new = 'running')
2025-02-06 20:41:12 (39108): VM state change detected. (old = 'running', new = 'paused')
2025-02-06 20:41:32 (39108): VM state change detected. (old = 'paused', new = 'running')
2025-02-06 20:42:12 (39108): VM state change detected. (old = 'running', new = 'paused')
2025-02-06 20:42:33 (39108): VM state change detected. (old = 'paused', new = 'running')
2025-02-06 20:42:43 (39108): VM state change detected. (old = 'running', new = 'paused')
2025-02-06 20:43:03 (39108): VM state change detected. (old = 'paused', new = 'running')
2025-02-06 20:43:13 (39108): VM state change detected. (old = 'running', new = 'paused')
2025-02-06 20:43:33 (39108): VM state change detected. (old = 'paused', new = 'running')
2025-02-06 20:46:03 (39108): VM state change detected. (old = 'running', new = 'paused')
2025-02-06 20:46:23 (39108): VM state change detected. (old = 'paused', new = 'running')
2025-02-06 20:46:33 (39108): VM state change detected. (old = 'running', new = 'paused')
2025-02-06 20:46:53 (39108): VM state change detected. (old = 'paused', new = 'running')
2025-02-06 20:47:03 (39108): VM state change detected. (old = 'running', new = 'paused')
2025-02-06 20:47:23 (39108): VM state change detected. (old = 'paused', new = 'running')
2025-02-06 20:48:23 (39108): VM state change detected. (old = 'running', new = 'paused')
2025-02-06 20:48:43 (39108): VM state change detected. (old = 'paused', new = 'running')
2025-02-06 20:48:54 (39108): VM state change detected. (old = 'running', new = 'paused')
2025-02-06 20:49:34 (39108): VM state change detected. (old = 'paused', new = 'running')
2025-02-06 20:49:44 (39108): VM state change detected. (old = 'running', new = 'paused')
2025-02-06 20:50:04 (39108): VM state change detected. (old = 'paused', new = 'running')
2025-02-06 20:50:14 (39108): VM state change detected. (old = 'running', new = 'paused')
2025-02-06 20:50:34 (39108): VM state change detected. (old = 'paused', new = 'running')
2025-02-06 20:50:44 (39108): VM state change detected. (old = 'running', new = 'paused')
2025-02-06 20:51:04 (39108): VM state change detected. (old = 'paused', new = 'running')
2025-02-06 20:51:14 (39108): VM state change detected. (old = 'running', new = 'paused')
2025-02-06 20:51:34 (39108): VM state change detected. (old = 'paused', new = 'running')
2025-02-06 20:51:44 (39108): VM state change detected. (old = 'running', new = 'paused')
2025-02-06 20:52:04 (39108): VM state change detected. (old = 'paused', new = 'running')
2025-02-06 20:52:14 (39108): VM state change detected. (old = 'running', new = 'paused')
2025-02-06 20:52:34 (39108): VM state change detected. (old = 'paused', new = 'running')
2025-02-06 20:52:34 (39108): Stopping VM.
2025-02-06 20:52:38 (39108): Successfully stopped VM.
2025-02-06 20:55:14 (13668): vboxwrapper version 26208
2025-02-06 20:55:14 (13668): BOINC client version: 8.0.2
2025-02-06 20:55:15 (13668): Detected: VirtualBox VboxManage Interface (Version: 7.1.6)
2025-02-06 20:55:16 (13668): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2025-02-06 20:55:16 (13668): Starting VM using VBoxManage interface. (boinc_112f30c3f212ae4d, slot#4)
2025-02-06 20:55:27 (13668): Successfully started VM. (PID = '33208')
2025-02-06 20:55:27 (13668): Reporting VM Process ID to BOINC.
2025-02-06 20:55:27 (13668): VM state change detected. (old = 'poweredoff', new = 'running')
2025-02-06 20:55:27 (13668): Detected: Web Application Enabled (http://localhost:52452)
2025-02-06 20:55:28 (13668): VM state change detected. (old = 'running', new = 'paused')
2025-02-06 20:55:45 (13668): Preference change detected
2025-02-06 20:55:45 (13668): Setting CPU throttle for VM. (40%)
2025-02-06 20:55:45 (13668): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2025-02-06 20:55:45 (13668): VM state change detected. (old = 'paused', new = 'running')
2025-02-06 20:55:55 (13668): VM state change detected. (old = 'running', new = 'paused')
2025-02-06 20:56:15 (13668): VM state change detected. (old = 'paused', new = 'running')
2025-02-06 20:56:25 (13668): VM state change detected. (old = 'running', new = 'paused')
2025-02-06 20:56:45 (13668): VM state change detected. (old = 'paused', new = 'running')
2025-02-06 20:56:55 (13668): VM state change detected. (old = 'running', new = 'paused')
2025-02-06 20:57:16 (13668): VM state change detected. (old = 'paused', new = 'running')
2025-02-06 20:57:37 (13668): VM state change detected. (old = 'running', new = 'paused')
2025-02-06 20:58:17 (13668): VM state change detected. (old = 'paused', new = 'running')
2025-02-06 20:58:27 (13668): VM state change detected. (old = 'running', new = 'paused')
2025-02-06 20:58:47 (13668): VM state change detected. (old = 'paused', new = 'running')
2025-02-06 20:58:57 (13668): VM state change detected. (old = 'running', new = 'paused')
2025-02-06 20:59:17 (13668): VM state change detected. (old = 'paused', new = 'running')
2025-02-06 20:59:27 (13668): VM state change detected. (old = 'running', new = 'paused')
2025-02-06 20:59:47 (13668): VM state change detected. (old = 'paused', new = 'running')
2025-02-06 21:00:07 (13668): VM state change detected. (old = 'running', new = 'paused')
2025-02-06 21:00:27 (13668): VM state change detected. (old = 'paused', new = 'running')
2025-02-06 21:00:37 (13668): VM state change detected. (old = 'running', new = 'paused')
2025-02-06 21:01:17 (13668): VM state change detected. (old = 'paused', new = 'running')
2025-02-06 21:01:27 (13668): VM state change detected. (old = 'running', new = 'paused')
2025-02-06 21:01:47 (13668): VM state change detected. (old = 'paused', new = 'running')
2025-02-06 21:01:57 (13668): VM state change detected. (old = 'running', new = 'paused')
2025-02-06 21:02:17 (13668): VM state change detected. (old = 'paused', new = 'running')
2025-02-06 21:02:47 (13668): VM state change detected. (old = 'running', new = 'paused')
2025-02-06 21:03:07 (13668): VM state change detected. (old = 'paused', new = 'running')
2025-02-06 21:03:17 (13668): VM state change detected. (old = 'running', new = 'paused')
2025-02-06 21:03:37 (13668): VM state change detected. (old = 'paused', new = 'running')
2025-02-06 21:03:47 (13668): VM state change detected. (old = 'running', new = 'paused')
2025-02-06 21:04:07 (13668): VM state change detected. (old = 'paused', new = 'running')
2025-02-06 21:04:37 (13668): VM state change detected. (old = 'running', new = 'paused')
2025-02-06 21:04:57 (13668): VM state change detected. (old = 'paused', new = 'running')
2025-02-06 21:05:57 (13668): VM state change detected. (old = 'running', new = 'paused')
2025-02-06 21:06:17 (13668): VM state change detected. (old = 'paused', new = 'running')
2025-02-06 21:06:27 (13668): VM state change detected. (old = 'running', new = 'paused')
2025-02-06 21:06:47 (13668): VM state change detected. (old = 'paused', new = 'running')
2025-02-06 21:06:57 (13668): VM state change detected. (old = 'running', new = 'paused')
2025-02-06 21:07:17 (13668): VM state change detected. (old = 'paused', new = 'running')
2025-02-06 21:09:47 (13668): VM state change detected. (old = 'running', new = 'paused')
2025-02-06 21:10:07 (13668): VM state change detected. (old = 'paused', new = 'running')
2025-02-06 21:10:17 (13668): VM state change detected. (old = 'running', new = 'paused')
2025-02-06 21:10:37 (13668): VM state change detected. (old = 'paused', new = 'running')
2025-02-06 21:10:47 (13668): VM state change detected. (old = 'running', new = 'paused')
2025-02-06 21:11:07 (13668): VM state change detected. (old = 'paused', new = 'running')
2025-02-06 21:12:58 (13668): VM state change detected. (old = 'running', new = 'paused')
2025-02-06 21:13:18 (13668): VM state change detected. (old = 'paused', new = 'running')
2025-02-06 21:13:28 (13668): VM state change detected. (old = 'running', new = 'paused')
2025-02-06 21:13:48 (13668): VM state change detected. (old = 'paused', new = 'running')
2025-02-06 21:13:58 (13668): VM state change detected. (old = 'running', new = 'paused')
2025-02-06 21:14:18 (13668): VM state change detected. (old = 'paused', new = 'running')
2025-02-06 21:15:59 (13668): VM state change detected. (old = 'running', new = 'paused')
2025-02-06 21:16:19 (13668): VM state change detected. (old = 'paused', new = 'running')
2025-02-06 21:16:29 (13668): VM state change detected. (old = 'running', new = 'paused')
2025-02-06 21:16:49 (13668): VM state change detected. (old = 'paused', new = 'running')
2025-02-06 21:16:59 (13668): VM state change detected. (old = 'running', new = 'paused')
2025-02-06 21:17:19 (13668): VM state change detected. (old = 'paused', new = 'running')
2025-02-06 21:17:29 (13668): VM state change detected. (old = 'running', new = 'paused')
2025-02-06 21:17:49 (13668): VM state change detected. (old = 'paused', new = 'running')
2025-02-06 21:18:09 (13668): VM state change detected. (old = 'running', new = 'paused')
2025-02-06 21:18:29 (13668): VM state change detected. (old = 'paused', new = 'running')
2025-02-06 21:18:39 (13668): VM state change detected. (old = 'running', new = 'paused')
2025-02-06 21:18:59 (13668): VM state change detected. (old = 'paused', new = 'running')
2025-02-06 21:19:09 (13668): VM state change detected. (old = 'running', new = 'paused')
2025-02-06 21:19:29 (13668): VM state change detected. (old = 'paused', new = 'running')
2025-02-06 21:19:45 (13668): Stopping VM.
2025-02-06 21:19:49 (13668): Successfully stopped VM.
2025-02-06 21:22:44 (23956): vboxwrapper version 26208
2025-02-06 21:22:44 (23956): BOINC client version: 8.0.2
2025-02-06 21:22:46 (23956): Detected: VirtualBox VboxManage Interface (Version: 7.1.6)
2025-02-06 21:22:46 (23956): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2025-02-06 21:22:46 (23956): Starting VM using VBoxManage interface. (boinc_112f30c3f212ae4d, slot#4)
2025-02-06 21:22:54 (23956): Error in start VM for VM: -2147467259
Command:
VBoxManage -q startvm "boinc_112f30c3f212ae4d" --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_112f30c3f212ae4d" to power on...

2025-02-06 21:22:54 (23956): VM failed to start.
2025-02-06 21:22:54 (23956): Could not start 
2025-02-06 21:22:54 (23956): ERROR: VM failed to start
2025-02-06 21:22:54 (23956): Powering off VM.
2025-02-06 21:22:54 (23956): Deregistering VM. (boinc_112f30c3f212ae4d, slot#4)
2025-02-06 21:22:54 (23956): Removing network bandwidth throttle group from VM.
2025-02-06 21:22:54 (23956): Removing VM from VirtualBox.

    Hypervisor System Log:

00:00:01.321751          ERROR [COM]: aRC=E_FAIL (0x80004005) aIID={bea3ef5c-de2f-4b74-aa3a-15d6249371a0} aComponent={RecordingSettingsWrap} aText={Recording not started}, preserve=false aResultDetail=0
00:00:01.323059          ERROR [COM]: aRC=E_FAIL (0x80004005) aIID={e36a5081-a82a-40bd-9e4e-42a44d6ce50f} aComponent={SessionMachine} aText={This machine does not have any snapshots}, preserve=false aResultDetail=0
00:00:01.540161          Platform architecture set to 'x86'
00:00:01.545764          ERROR [COM]: aRC=VBOX_E_OBJECT_NOT_FOUND (0x80bb0001) aIID={d644ad1e-c501-4fc7-9ab6-aa6d763bc540} aComponent={VirtualBoxWrap} aText={&#197;&#131;o extension pack providing a cryptographic support module could be found}, preserve=false aResultDetail=0
00:00:01.558919          ERROR [COM]: aRC=VBOX_E_OBJECT_NOT_FOUND (0x80bb0001) aIID={e36a5081-a82a-40bd-9e4e-42a44d6ce50f} aComponent={SessionMachine} aText={No storage device attached to device slot 0 on port 2 of controller 'Hard Disk Controller'}, preserve=false aResultDetail=0
00:00:01.559070          ERROR [COM]: aRC=VBOX_E_OBJECT_NOT_FOUND (0x80bb0001) aIID={e36a5081-a82a-40bd-9e4e-42a44d6ce50f} aComponent={SessionMachine} aText={No storage device attached to device slot 0 on port 2 of controller 'Hard Disk Controller'}, preserve=false aResultDetail=0
00:00:01.568111          WARNING [COM]: aRC=E_FAIL (0x80004005) aIID={d5dcece0-b202-4416-a138-03502784cc07} aComponent={HostWrap} aText={Could not load the Host USB Proxy Service (VERR_FILE_NOT_FOUND).  The service might not be installed on the host computer}, preserve=true aResultDetail=0
00:00:01.568267          WARNING [COM]: aRC=E_FAIL (0x80004005) aIID={d5dcece0-b202-4416-a138-03502784cc07} aComponent={HostWrap} aText={Could not load the Host USB Proxy Service (VERR_FILE_NOT_FOUND).  The service might not be installed on the host computer}, preserve=true aResultDetail=0
00:00:01.570600          ERROR [COM]: aRC=E_FAIL (0x80004005) aIID={bea3ef5c-de2f-4b74-aa3a-15d6249371a0} aComponent={RecordingSettingsWrap} aText={Recording not started}, preserve=false aResultDetail=0
00:00:01.571948          ERROR [COM]: aRC=E_FAIL (0x80004005) aIID={e36a5081-a82a-40bd-9e4e-42a44d6ce50f} aComponent={SessionMachine} aText={This machine does not have any snapshots}, preserve=false aResultDetail=0
00:00:01.586983          Platform architecture set to 'x86'
00:00:01.591765          ERROR [COM]: aRC=VBOX_E_OBJECT_NOT_FOUND (0x80bb0001) aIID={d644ad1e-c501-4fc7-9ab6-aa6d763bc540} aComponent={VirtualBoxWrap} aText={&#197;&#131;o extension pack providing a cryptographic support module could be found}, preserve=false aResultDetail=0
00:00:01.604875          ERROR [COM]: aRC=VBOX_E_OBJECT_NOT_FOUND (0x80bb0001) aIID={e36a5081-a82a-40bd-9e4e-42a44d6ce50f} aComponent={SessionMachine} aText={No storage device attached to device slot 0 on port 2 of controller 'Hard Disk Controller'}, preserve=false aResultDetail=0
00:00:01.605019          ERROR [COM]: aRC=VBOX_E_OBJECT_NOT_FOUND (0x80bb0001) aIID={e36a5081-a82a-40bd-9e4e-42a44d6ce50f} aComponent={SessionMachine} aText={No storage device attached to device slot 0 on port 2 of controller 'Hard Disk Controller'}, preserve=false aResultDetail=0
00:00:01.618085          WARNING [COM]: aRC=E_FAIL (0x80004005) aIID={d5dcece0-b202-4416-a138-03502784cc07} aComponent={HostWrap} aText={Could not load the Host USB Proxy Service (VERR_FILE_NOT_FOUND).  The service might not be installed on the host computer}, preserve=true aResultDetail=0
00:00:01.618271          WARNING [COM]: aRC=E_FAIL (0x80004005) aIID={d5dcece0-b202-4416-a138-03502784cc07} aComponent={HostWrap} aText={Could not load the Host USB Proxy Service (VERR_FILE_NOT_FOUND).  The service might not be installed on the host computer}, preserve=true aResultDetail=0
00:00:01.622252          ERROR [COM]: aRC=E_FAIL (0x80004005) aIID={bea3ef5c-de2f-4b74-aa3a-15d6249371a0} aComponent={RecordingSettingsWrap} aText={Recording not started}, preserve=false aResultDetail=0
00:00:01.625530          ERROR [COM]: aRC=E_FAIL (0x80004005) aIID={e36a5081-a82a-40bd-9e4e-42a44d6ce50f} aComponent={SessionMachine} aText={This machine does not have any snapshots}, preserve=false aResultDetail=0
00:00:01.843830          Launched VM: 2716944608 pid: 26544 (0x67b0) frontend: headless name: boinc_112f30c3f212ae4d
00:00:01.884046          Launched VM: 2759887968 pid: 38312 (0x95a8) frontend: headless name: boinc_ffe61954027aba29
00:00:06.883413          Platform architecture set to 'x86'
00:00:06.920622          Platform architecture set to 'x86'
00:00:07.769613          WARNING [COM]: aRC=E_FAIL (0x80004005) aIID={d5dcece0-b202-4416-a138-03502784cc07} aComponent={HostWrap} aText={Could not load the Host USB Proxy Service (VERR_FILE_NOT_FOUND).  The service might not be installed on the host computer}, preserve=true aResultDetail=0
00:00:07.772347          WARNING [COM]: aRC=E_FAIL (0x80004005) aIID={d5dcece0-b202-4416-a138-03502784cc07} aComponent={HostWrap} aText={Could not load the Host USB Proxy Service (VERR_FILE_NOT_FOUND).  The service might not be installed on the host computer}, preserve=true aResultDetail=0
00:00:09.305792          Saving settings file "C:\ProgramData\BOINC\slots\4\boinc_112f30c3f212ae4d\boinc_112f30c3f212ae4d.vbox" with version "1.19-windows"
00:00:09.316203          Finished saving settings file "C:\ProgramData\BOINC\slots\4\boinc_112f30c3f212ae4d\boinc_112f30c3f212ae4d.vbox"
00:00:09.468948          ERROR [COM]: aRC=VBOX_E_OBJECT_NOT_FOUND (0x80bb0001) aIID={7d510820-a678-4730-a862-818dcd3fbed0} aComponent={MediumWrap} aText={Property 'CRYPT/KeyId' does not exist}, preserve=false aResultDetail=0
00:00:09.470279          ERROR [COM]: aRC=VBOX_E_OBJECT_NOT_FOUND (0x80bb0001) aIID={7d510820-a678-4730-a862-818dcd3fbed0} aComponent={MediumWrap} aText={Property 'CRYPT/KeyId' does not exist}, preserve=false aResultDetail=0
00:00:09.471601          HostDnsMonitorProxy::GetDomainName: no domain set
00:00:09.471728          HostDnsMonitorProxy::GetNameServers:
00:00:09.471753            name server 1: 192.168.1.1
00:00:09.471877          HostDnsMonitorProxy::GetSearchStrings:
00:00:09.471909            no search string entries
00:00:09.533048          ERROR [COM]: aRC=E_FAIL (0x80004005) aIID={e36a5081-a82a-40bd-9e4e-42a44d6ce50f} aComponent={SessionMachine} aText={This machine does not have any snapshots}, preserve=false aResultDetail=0
00:00:09.690109          Platform architecture set to 'x86'
00:00:09.693066          Saving settings file "C:\ProgramData\BOINC\slots\4\boinc_112f30c3f212ae4d\boinc_112f30c3f212ae4d.vbox" with version "1.19-windows"
00:00:09.702806          Finished saving settings file "C:\ProgramData\BOINC\slots\4\boinc_112f30c3f212ae4d\boinc_112f30c3f212ae4d.vbox"
00:00:09.971931          Saving settings file "C:\Users\dm879\.VirtualBox\VirtualBox.xml" with version "1.12-windows"
00:00:09.980641          Finished saving settings file "C:\Users\dm879\.VirtualBox\VirtualBox.xml"
00:00:09.981051          Saving settings file "C:\ProgramData\BOINC\slots\5\boinc_ffe61954027aba29\boinc_ffe61954027aba29.vbox" with version "1.19-windows"
00:00:09.988874          Finished saving settings file "C:\ProgramData\BOINC\slots\5\boinc_ffe61954027aba29\boinc_ffe61954027aba29.vbox"
00:00:09.991196 DeleteVM Saving settings file "C:\ProgramData\BOINC\slots\5\boinc_ffe61954027aba29\boinc_ffe61954027aba29.vbox" with version "1.19-windows"
00:00:10.000692 DeleteVM Finished saving settings file "C:\ProgramData\BOINC\slots\5\boinc_ffe61954027aba29\boinc_ffe61954027aba29.vbox"
00:00:11.353367          Saving settings file "C:\ProgramData\BOINC\slots\5\boinc_ffe61954027aba29\boinc_ffe61954027aba29.vbox" with version "1.19-windows"
00:00:11.361214          Finished saving settings file "C:\ProgramData\BOINC\slots\5\boinc_ffe61954027aba29\boinc_ffe61954027aba29.vbox"
00:00:12.498544          Saving settings file "C:\ProgramData\BOINC\slots\5\boinc_ffe61954027aba29\boinc_ffe61954027aba29.vbox" with version "1.19-windows"
00:00:12.506646          Finished saving settings file "C:\ProgramData\BOINC\slots\5\boinc_ffe61954027aba29\boinc_ffe61954027aba29.vbox"

    VM Execution Log:


    VM Startup Log:


    VM Trace Log:

 Adapter count:   36
Maximum ICH9 IDE Controllers:   1
Maximum ICH9 SATA Controllers:  8
Maximum ICH9 SCSI Controllers:  8
Maximum ICH9 SAS Controllers:   8
Maximum ICH9 NVMe Controllers:  8
Maximum ICH9 virtio-scsi Controllers:  8
Maximum ICH9 Floppy Controllers:1

Supported platform architectures: x86

x86 platform properties:
Maximum Serial Port count:              4
Maximum Parallel Port count:            2
Maximum Boot Position:                  4
Maximum Floppy Port count:              1
Maximum Floppy Devices per Port:        2
Maximum virtio-scsi Port count:         256
Maximum virtio-scsi Devices per Port:   1
Maximum IDE Port count:                 2
Maximum IDE Devices per port:           2
Maximum SATA Port count:                30
Maximum SATA Device per port:          1
Maximum SCSI Port count:                16
Maximum SCSI Devices per port:          1
Maximum SAS Port count:                 255
Maximum SAS Devices per Port:           1
Maximum NVMe Port count:                255
Maximum NVMe Devices per Port:          1
Supported chipsets:                     PIIX3, ICH9
PIIX3 chipset properties:
Maximum PIIX3 Network Adapter count:   8
Maximum PIIX3 IDE Controllers:   1
Maximum PIIX3 SATA Controllers:  1
Maximum PIIX3 SCSI Controllers:  1
Maximum PIIX3 SAS Controllers:   1
Maximum PIIX3 NVMe Controllers:  1
Maximum PIIX3 virtio-scsi Controllers:  1
Maximum PIIX3 Floppy Controllers:1

ICH9 chipset properties:
Maximum ICH9 Network Adapter count:   36
Maximum ICH9 IDE Controllers:   1
Maximum ICH9 SATA Controllers:  8
Maximum ICH9 SCSI Controllers:  8
Maximum ICH9 SAS Controllers:   8
Maximum ICH9 NVMe Controllers:  8
Maximum ICH9 virtio-scsi Controllers:  8
Maximum ICH9 Floppy Controllers:1

2025-02-06 21:22:46 (23956): 
Command: VBoxManage -q list hostinfo 
Exit Code: 0
Output:
Host Information:

Host time: 2025-02-07T03:22:46.112000000Z
Processor online count: 8
Processor count: 8
Processor online core count: 4
Processor core count: 4
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: no
Processor supports virt. vmsave/vmload: no
Processor#0 speed: unknown
Processor#0 description: Intel(R) Core(TM) i7-3720QM CPU @ 2.60GHz
Processor#1 speed: unknown
Processor#1 description: Intel(R) Core(TM) i7-3720QM CPU @ 2.60GHz
Processor#2 speed: unknown
Processor#2 description: Intel(R) Core(TM) i7-3720QM CPU @ 2.60GHz
Processor#3 speed: unknown
Processor#3 description: Intel(R) Core(TM) i7-3720QM CPU @ 2.60GHz
Processor#4 speed: unknown
Processor#4 description: Intel(R) Core(TM) i7-3720QM CPU @ 2.60GHz
Processor#5 speed: unknown
Processor#5 description: Intel(R) Core(TM) i7-3720QM CPU @ 2.60GHz
Processor#6 speed: unknown
Processor#6 description: Intel(R) Core(TM) i7-3720QM CPU @ 2.60GHz
Processor#7 speed: unknown
Processor#7 description: Intel(R) Core(TM) i7-3720QM CPU @ 2.60GHz
Memory size: 32314 MByte
Memory available: 19131 MByte
Operating system: Windows 10
Operating system version: 10.0.19045

2025-02-06 21:22:46 (23956): 
Command: VBoxManage -q showvminfo "boinc_112f30c3f212ae4d" --machinereadable 
Exit Code: 0
Output:
name="boinc_112f30c3f212ae4d"
encryption="disabled"
groups="/"
platformArchitecture="x86"
ostype="Linux 2.6 / 3.x / 4.x / 5.x (64-bit)"
UUID="950d2ae8-cc08-4195-97dd-3b3b03bac4ad"
CfgFile="C:\\ProgramData\\BOINC\\slots\\4\\boinc_112f30c3f212ae4d\\boinc_112f30c3f212ae4d.vbox"
SnapFldr="C:\\ProgramData\\BOINC\\slots\\4\\boinc_112f30c3f212ae4d\\Snapshots"
LogFldr="C:\\ProgramData\\BOINC\\slots\\4\\boinc_112f30c3f212ae4d\\Logs"
hardwareuuid="950d2ae8-cc08-4195-97dd-3b3b03bac4ad"
memory=630
pagefusion="off"
vram=16
cpuexecutioncap=40
cpu-profile="host"
chipset="piix3"
firmware="BIOS"
cpus=1
hpet="off"
pae="off"
longmode="on"
triplefaultreset="off"
apic="on"
x2apic="on"
nested-hw-virt="off"
hwvirtex="on"
nestedpaging="on"
largepages="on"
vtxvpid="on"
vtxux="on"
virtvmsavevmload="on"
cpuid-portability-level=0
bootmenu="messageandmenu"
boot1="disk"
boot2="dvd"
boot3="none"
boot4="none"
acpi="on"
ioapic="on"
biosapic="apic"
biossystemtimeoffset=0
NvramFile="C:\\ProgramData\\BOINC\\slots\\4\\boinc_112f30c3f212ae4d\\boinc_112f30c3f212ae4d.nvram"
rtcuseutc="off"
iommu="none"
paravirtprovider="default"
effparavirtprovider="kvm"
VMState="saved"
VMStateChangeTime="2025-02-07T03:19:48.000000000"
VMStateFile="C:\ProgramData\BOINC\slots\4\boinc_112f30c3f212ae4d\Snapshots\2025-02-07T03-19-45-955446300Z.sav"
graphicscontroller="vboxvga"
monitorcount=1
accelerate3d="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\\4\\boinc_112f30c3f212ae4d\\Snapshots/{6a54c514-e891-431e-817d-3ea240427ebb}.vdi"
"Hard Disk Controller-ImageUUID-0-0"="6a54c514-e891-431e-817d-3ea240427ebb"
"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"="fcd7558d-e2ac-4b29-bff4-1e56529247e3"
"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="080027119349"
cableconnected1="on"
nic1="nat"
nictype1="82540EM"
nicspeed1="0"
mtu="0"
sockSnd="64"
sockRcv="64"
tcpWndSnd="64"
tcpWndRcv="64"
Forwarding(0)="tcp_52452_80,tcp,127.0.0.1,52452,,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"
clipboard_file_transfers="off"
draganddrop="disabled"
vrde="off"
usb="off"
ehci="off"
xhci="off"
BandwidthGroup0="boinc_112f30c3f212ae4d_net",Network,1099511627776
SharedFolderNameMachineMapping1="shared"
SharedFolderPathMachineMapping1="C:\\ProgramData\\BOINC\\slots\\4\\shared"
recording_started="off"
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\\4\\boinc_112f30c3f212ae4d\\boinc_112f30c3f212ae4d-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-2971502-442_0"
GuestMemoryBalloon=0

2025-02-06 21:22:54 (23956): 
Command: VBoxManage -q startvm "boinc_112f30c3f212ae4d" --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_112f30c3f212ae4d" to power on...

2025-02-06 21:22:54 (23956): 
Command: VBoxManage -q snapshot "boinc_112f30c3f212ae4d" list 
Exit Code: -108
Output:
This machine does not have any snapshots

2025-02-06 21:22:54 (23956): 
Command: VBoxManage -q bandwidthctl "boinc_112f30c3f212ae4d" remove "boinc_112f30c3f212ae4d_net" 
Exit Code: 0
Output:

2025-02-06 21:22:55 (23956): 
Command: VBoxManage -q unregistervm "boinc_112f30c3f212ae4d" --delete 
Exit Code: 0
Output:
0%...10%...20%...30%...40%...50%...60%...70%...80%...90%...100%

2025-02-06 21:23:05 (23956): called boinc_finish(-2147467259)

</stderr_txt>
]]>


©2025 CERN