| Name | CMS_111216_1749580166.287368_0 |
| Workunit | 232972672 |
| Created | 10 Jun 2025, 18:29:28 UTC |
| Sent | 10 Jun 2025, 19:29:31 UTC |
| Report deadline | 11 Jul 2025, 19:29:31 UTC |
| Received | 12 Jun 2025, 10:16:40 UTC |
| Server state | Over |
| Outcome | Computation error |
| Client state | Compute error |
| Exit status | -2147467259 (0x80004005) Unknown error code |
| Computer ID | 10871187 |
| Run time | 38 min 14 sec |
| CPU time | 2 min 30 sec |
| Validate state | Invalid |
| Credit | 0.00 |
| Device peak FLOPS | 21.17 GFLOPS |
| Application version | CMS Simulation v70.91 (vbox64_mt_mcore_cms) windows_x86_64 |
| Peak working set size | 87.17 MB |
| Peak swap size | 83.08 MB |
| Peak disk usage | 818.37 MB |
Stderr output
<core_client_version>8.0.2</core_client_version>
<![CDATA[
<message>
δָ���Ĵ���
(0x80004005) - exit code 2147500037 (0x80004005)</message>
<stderr_txt>
2025-06-11 22:49:46 (16688): vboxwrapper version 26210
2025-06-11 22:49:46 (16688): BOINC client version: 8.0.2
2025-06-11 22:49:47 (16688): Detected: VirtualBox VboxManage Interface (Version: 7.0.6)
2025-06-11 22:49:47 (16688): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2025-06-11 22:49:47 (16688): Successfully copied 'init_data.xml' to the shared directory.
2025-06-11 22:49:47 (16688): Create VM. (boinc_2c677c05a0d16e66, slot#0)
2025-06-11 22:49:48 (16688): Setting Memory Size for VM. (4584MB)
2025-06-11 22:49:48 (16688): Setting CPU Count for VM. (4)
2025-06-11 22:49:48 (16688): Setting Chipset Options for VM.
2025-06-11 22:49:49 (16688): Setting Graphics Controller Options for VM. (Driver: VBoxVGA, 16MB)
2025-06-11 22:49:49 (16688): Setting Boot Options for VM.
2025-06-11 22:49:50 (16688): Setting Network Configuration for NAT. (Driver: virtio)
2025-06-11 22:49:50 (16688): Enabling VM Network Access.
2025-06-11 22:49:50 (16688): Disabling USB Support for VM.
2025-06-11 22:49:50 (16688): Disabling COM Port Support for VM.
2025-06-11 22:49:51 (16688): Disabling LPT Port Support for VM.
2025-06-11 22:49:51 (16688): Disabling Audio Support for VM.
2025-06-11 22:49:51 (16688): Disabling Clipboard Support for VM.
2025-06-11 22:49:52 (16688): Disabling Drag and Drop Support for VM.
2025-06-11 22:49:52 (16688): Adding storage controller(s) to VM.
2025-06-11 22:49:52 (16688): Adding virtual disk drive to VM. (CMS_2025_04_08_prod.vdi)
2025-06-11 22:49:54 (16688): Adding VirtualBox Guest Additions to VM.
2025-06-11 22:49:55 (16688): Adding network bandwidth throttle group to VM. (Defaulting to 1024GB)
2025-06-11 22:49:55 (16688): forwarding host port 50117 to guest port 80
2025-06-11 22:49:55 (16688): Enabling remote desktop for VM.
2025-06-11 22:49:56 (16688): Required extension pack not installed, remote desktop not enabled.
2025-06-11 22:49:56 (16688): Enabling shared directory for VM.
2025-06-11 22:49:56 (16688): Starting VM using VBoxManage interface. (boinc_2c677c05a0d16e66, slot#0)
2025-06-11 22:50:01 (16688): Successfully started VM. (PID = '15220')
2025-06-11 22:50:01 (16688): Reporting VM Process ID to BOINC.
2025-06-11 22:50:01 (16688): Guest Log: BIOS: VirtualBox 7.0.6
2025-06-11 22:50:01 (16688): Guest Log: CPUID EDX: 0x178bfbff
2025-06-11 22:50:01 (16688): Guest Log: BIOS: No PCI IDE controller, not probing IDE
2025-06-11 22:50:01 (16688): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors
2025-06-11 22:50:01 (16688): VM state change detected. (old = 'poweredoff', new = 'running')
2025-06-11 22:50:01 (16688): Detected: Web Application Enabled (http://localhost:50117)
2025-06-11 22:50:02 (16688): VM state change detected. (old = 'running', new = 'paused')
2025-06-11 22:50:37 (16688): Preference change detected
2025-06-11 22:50:37 (16688): Setting CPU throttle for VM. (100%)
2025-06-11 22:50:37 (16688): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 180 seconds) or (Vbox_job.xml: 600 seconds))
2025-06-11 22:50:37 (16688): VM state change detected. (old = 'paused', new = 'running')
2025-06-11 22:50:38 (16688): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2025-06-11 22:50:38 (16688): Guest Log: BIOS: Booting from Hard Disk...
2025-06-11 22:50:40 (16688): Guest Log: BIOS: KBD: unsupported int 16h function 03
2025-06-11 22:50:40 (16688): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000
2025-06-11 22:50:47 (16688): VM state change detected. (old = 'running', new = 'paused')
2025-06-11 22:51:27 (16688): VM state change detected. (old = 'paused', new = 'running')
2025-06-11 22:51:37 (16688): VM state change detected. (old = 'running', new = 'paused')
2025-06-11 22:51:58 (16688): VM state change detected. (old = 'paused', new = 'running')
2025-06-11 22:52:08 (16688): VM state change detected. (old = 'running', new = 'paused')
2025-06-11 22:52:48 (16688): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2025-06-11 22:52:48 (16688): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)
2025-06-11 22:52:48 (16688): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log
2025-06-11 22:52:48 (16688): Guest Log: 00:00:00.000065 main Log opened 2025-06-11T14:52:08.673692000Z
2025-06-11 22:52:48 (16688): Guest Log: 00:00:00.000129 main OS Product: Linux
2025-06-11 22:52:48 (16688): Guest Log: 00:00:00.000143 main OS Release: 4.14.232-19.cernvm.x86_64
2025-06-11 22:52:48 (16688): Guest Log: 00:00:00.000156 main OS Version: #1 SMP Fri Apr 30 17:12:25 CEST 2021
2025-06-11 22:52:48 (16688): Guest Log: 00:00:00.000168 main Executable: /usr/sbin/VBoxService
2025-06-11 22:52:48 (16688): Guest Log: 00:00:00.000168 main Process ID: 2287
2025-06-11 22:52:48 (16688): Guest Log: 00:00:00.000168 main Package type: LINUX_64BITS_GENERIC
2025-06-11 22:52:48 (16688): Guest Log: 00:00:00.001628 main 5.2.6 r120293 started. Verbose level = 0
2025-06-11 22:52:48 (16688): VM state change detected. (old = 'paused', new = 'running')
2025-06-11 22:52:58 (16688): VM state change detected. (old = 'running', new = 'paused')
2025-06-11 22:53:18 (16688): VM state change detected. (old = 'paused', new = 'running')
2025-06-11 22:53:26 (16688): Guest Log: [INFO] Mounting the shared directory
2025-06-11 22:53:26 (16688): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor
2025-06-11 22:53:26 (16688): Guest Log: [INFO] Sourcing essential functions from /cvmfs/grid.cern.ch
2025-06-11 22:53:27 (16688): Guest Log: [INFO] Testing connection to cern.ch
2025-06-11 22:53:28 (16688): VM state change detected. (old = 'running', new = 'paused')
2025-06-11 22:53:48 (16688): Guest Log: [INFO] Testing connection to VCCS
2025-06-11 22:53:48 (16688): VM state change detected. (old = 'paused', new = 'running')
2025-06-11 22:53:49 (16688): Guest Log: [INFO] Testing connection to HTCondor
2025-06-11 22:53:49 (16688): Guest Log: [INFO] Testing connection to WMAgent
2025-06-11 22:53:50 (16688): Guest Log: [INFO] Testing connection to EOSCMS
2025-06-11 22:53:50 (16688): Guest Log: [INFO] Testing connection to CMS-Factory
2025-06-11 22:53:51 (16688): Guest Log: [INFO] Testing connection to CMS-Frontier
2025-06-11 22:53:52 (16688): Guest Log: [INFO] Testing connection to Frontier
2025-06-11 22:53:53 (16688): Guest Log: [INFO] Testing connection to http://cms-frontier.openhtc.io:8080/FrontierProd/Frontier/
2025-06-11 22:53:55 (16688): Guest Log: [INFO] Could not find a local HTTP proxy
2025-06-11 22:53:55 (16688): Guest Log: [INFO] CVMFS and Frontier will have to use DIRECT connections
2025-06-11 22:53:55 (16688): Guest Log: [INFO] This makes the application less efficient
2025-06-11 22:53:55 (16688): Guest Log: [INFO] It also puts higher load on the project servers
2025-06-11 22:53:55 (16688): Guest Log: [INFO] Setting up a local HTTP proxy is highly recommended
2025-06-11 22:53:55 (16688): Guest Log: [INFO] Advice can be found in the project forum
2025-06-11 22:53:58 (16688): VM state change detected. (old = 'running', new = 'paused')
2025-06-11 22:54:18 (16688): Guest Log: [INFO] Reloading and probing the CVMFS configuration
2025-06-11 22:54:18 (16688): VM state change detected. (old = 'paused', new = 'running')
2025-06-11 22:54:26 (16688): Guest Log: [INFO] Probing /cvmfs/grid.cern.ch... OK
2025-06-11 22:54:28 (16688): VM state change detected. (old = 'running', new = 'paused')
2025-06-11 22:54:48 (16688): Guest Log: [INFO] Probing /cvmfs/cms.cern.ch... OK
2025-06-11 22:54:48 (16688): VM state change detected. (old = 'paused', new = 'running')
2025-06-11 22:54:50 (16688): Guest Log: [INFO] Probing /cvmfs/oasis.opensciencegrid.org... OK
2025-06-11 22:54:51 (16688): Guest Log: [INFO] Probing /cvmfs/cms-ib.cern.ch... OK
2025-06-11 22:54:54 (16688): Guest Log: [INFO] Probing /cvmfs/singularity.opensciencegrid.org... OK
2025-06-11 22:54:55 (16688): Guest Log: [INFO] Excerpt from "cvmfs_config stat": VERSION HOST PROXY
2025-06-11 22:54:55 (16688): Guest Log: [INFO] 2.7.2.0 http://s1ral-cvmfs.openhtc.io DIRECT
2025-06-11 22:54:55 (16688): Guest Log: [INFO] Environment HTTP proxy: not set
2025-06-11 22:54:55 (16688): Guest Log: [INFO] Reading volunteer information
2025-06-11 22:54:58 (16688): VM state change detected. (old = 'running', new = 'paused')
2025-06-11 22:55:18 (16688): VM state change detected. (old = 'paused', new = 'running')
2025-06-11 22:55:38 (16688): VM state change detected. (old = 'running', new = 'paused')
2025-06-11 22:55:58 (16688): VM state change detected. (old = 'paused', new = 'running')
2025-06-11 22:56:08 (16688): VM state change detected. (old = 'running', new = 'paused')
2025-06-11 22:56:28 (16688): VM state change detected. (old = 'paused', new = 'running')
2025-06-11 22:56:38 (16688): VM state change detected. (old = 'running', new = 'paused')
2025-06-11 22:57:38 (16688): VM state change detected. (old = 'paused', new = 'running')
2025-06-11 22:57:48 (16688): VM state change detected. (old = 'running', new = 'paused')
2025-06-11 22:58:08 (16688): VM state change detected. (old = 'paused', new = 'running')
2025-06-11 22:58:18 (16688): VM state change detected. (old = 'running', new = 'paused')
2025-06-11 22:58:38 (16688): VM state change detected. (old = 'paused', new = 'running')
2025-06-11 22:58:48 (16688): VM state change detected. (old = 'running', new = 'paused')
2025-06-11 22:59:08 (16688): VM state change detected. (old = 'paused', new = 'running')
2025-06-11 22:59:18 (16688): VM state change detected. (old = 'running', new = 'paused')
2025-06-11 22:59:38 (16688): VM state change detected. (old = 'paused', new = 'running')
2025-06-11 22:59:48 (16688): VM state change detected. (old = 'running', new = 'paused')
2025-06-11 23:00:48 (16688): VM state change detected. (old = 'paused', new = 'running')
2025-06-11 23:00:58 (16688): VM state change detected. (old = 'running', new = 'paused')
2025-06-11 23:01:18 (16688): VM state change detected. (old = 'paused', new = 'running')
2025-06-11 23:01:28 (16688): VM state change detected. (old = 'running', new = 'paused')
2025-06-11 23:07:48 (16688): VM state change detected. (old = 'paused', new = 'running')
2025-06-11 23:07:58 (16688): VM state change detected. (old = 'running', new = 'paused')
2025-06-11 23:08:18 (16688): VM state change detected. (old = 'paused', new = 'running')
2025-06-11 23:08:20 (16688): Guest Log: [INFO] Using weak account key.
2025-06-11 23:08:20 (16688): Guest Log: [INFO] Requesting an X509 credential from LHC@home
2025-06-11 23:08:22 (16688): Guest Log: [INFO] Using weak account key.
2025-06-11 23:08:22 (16688): Guest Log: [INFO] Requesting an idtoken from LHC@home
2025-06-11 23:08:28 (16688): VM state change detected. (old = 'running', new = 'paused')
2025-06-11 23:08:48 (16688): VM state change detected. (old = 'paused', new = 'running')
2025-06-11 23:08:49 (16688): Guest Log: [INFO] CMS application starting. Check log files.
2025-06-11 23:08:58 (16688): VM state change detected. (old = 'running', new = 'paused')
2025-06-11 23:09:18 (16688): VM state change detected. (old = 'paused', new = 'running')
2025-06-11 23:09:28 (16688): VM state change detected. (old = 'running', new = 'paused')
2025-06-11 23:09:48 (16688): VM state change detected. (old = 'paused', new = 'running')
2025-06-11 23:09:58 (16688): VM state change detected. (old = 'running', new = 'paused')
2025-06-11 23:10:18 (16688): VM state change detected. (old = 'paused', new = 'running')
2025-06-11 23:10:28 (16688): VM state change detected. (old = 'running', new = 'paused')
2025-06-11 23:10:48 (16688): VM state change detected. (old = 'paused', new = 'running')
2025-06-11 23:11:08 (16688): VM state change detected. (old = 'running', new = 'paused')
2025-06-11 23:11:28 (16688): VM state change detected. (old = 'paused', new = 'running')
2025-06-11 23:11:38 (16688): VM state change detected. (old = 'running', new = 'paused')
2025-06-11 23:12:38 (16688): VM state change detected. (old = 'paused', new = 'running')
2025-06-11 23:12:48 (16688): VM state change detected. (old = 'running', new = 'paused')
2025-06-11 23:13:08 (16688): VM state change detected. (old = 'paused', new = 'running')
2025-06-11 23:13:18 (16688): VM state change detected. (old = 'running', new = 'paused')
2025-06-11 23:13:38 (16688): VM state change detected. (old = 'paused', new = 'running')
2025-06-11 23:13:49 (16688): VM state change detected. (old = 'running', new = 'paused')
2025-06-11 23:14:29 (16688): VM state change detected. (old = 'paused', new = 'running')
2025-06-11 23:14:39 (16688): VM state change detected. (old = 'running', new = 'paused')
2025-06-11 23:15:19 (16688): VM state change detected. (old = 'paused', new = 'running')
2025-06-11 23:15:29 (16688): VM state change detected. (old = 'running', new = 'paused')
2025-06-11 23:16:09 (16688): VM state change detected. (old = 'paused', new = 'running')
2025-06-11 23:16:19 (16688): VM state change detected. (old = 'running', new = 'paused')
2025-06-11 23:16:39 (16688): VM state change detected. (old = 'paused', new = 'running')
2025-06-11 23:16:49 (16688): VM state change detected. (old = 'running', new = 'paused')
2025-06-11 23:17:09 (16688): VM state change detected. (old = 'paused', new = 'running')
2025-06-11 23:17:19 (16688): VM state change detected. (old = 'running', new = 'paused')
2025-06-11 23:17:39 (16688): VM state change detected. (old = 'paused', new = 'running')
2025-06-11 23:17:49 (16688): VM state change detected. (old = 'running', new = 'paused')
2025-06-11 23:18:10 (16688): VM state change detected. (old = 'paused', new = 'running')
2025-06-11 23:18:19 (16688): VM state change detected. (old = 'running', new = 'paused')
2025-06-11 23:18:40 (16688): VM state change detected. (old = 'paused', new = 'running')
2025-06-11 23:18:49 (16688): VM state change detected. (old = 'running', new = 'paused')
2025-06-11 23:19:10 (16688): VM state change detected. (old = 'paused', new = 'running')
2025-06-11 23:19:19 (16688): VM state change detected. (old = 'running', new = 'paused')
2025-06-11 23:19:40 (16688): VM state change detected. (old = 'paused', new = 'running')
2025-06-11 23:19:50 (16688): VM state change detected. (old = 'running', new = 'paused')
2025-06-11 23:20:10 (16688): VM state change detected. (old = 'paused', new = 'running')
2025-06-11 23:20:20 (16688): VM state change detected. (old = 'running', new = 'paused')
2025-06-11 23:20:59 (16688): VM state change detected. (old = 'paused', new = 'running')
2025-06-11 23:21:10 (16688): VM state change detected. (old = 'running', new = 'paused')
2025-06-11 23:21:29 (16688): VM state change detected. (old = 'paused', new = 'running')
2025-06-11 23:21:40 (16688): VM state change detected. (old = 'running', new = 'paused')
2025-06-11 23:22:20 (16688): VM state change detected. (old = 'paused', new = 'running')
2025-06-11 23:22:30 (16688): VM state change detected. (old = 'running', new = 'paused')
2025-06-11 23:23:10 (16688): VM state change detected. (old = 'paused', new = 'running')
2025-06-11 23:23:20 (16688): VM state change detected. (old = 'running', new = 'paused')
2025-06-11 23:24:40 (16688): VM state change detected. (old = 'paused', new = 'running')
2025-06-11 23:24:50 (16688): VM state change detected. (old = 'running', new = 'paused')
2025-06-11 23:25:30 (16688): VM state change detected. (old = 'paused', new = 'running')
2025-06-11 23:25:40 (16688): VM state change detected. (old = 'running', new = 'paused')
2025-06-11 23:26:00 (16688): VM state change detected. (old = 'paused', new = 'running')
2025-06-11 23:26:10 (16688): VM state change detected. (old = 'running', new = 'paused')
2025-06-11 23:26:30 (16688): VM state change detected. (old = 'paused', new = 'running')
2025-06-11 23:26:40 (16688): VM state change detected. (old = 'running', new = 'paused')
2025-06-11 23:27:00 (16688): VM state change detected. (old = 'paused', new = 'running')
2025-06-11 23:27:10 (16688): VM state change detected. (old = 'running', new = 'paused')
2025-06-11 23:27:30 (16688): VM state change detected. (old = 'paused', new = 'running')
2025-06-11 23:27:40 (16688): VM state change detected. (old = 'running', new = 'paused')
2025-06-11 23:28:00 (16688): VM state change detected. (old = 'paused', new = 'running')
2025-06-11 23:28:10 (16688): VM state change detected. (old = 'running', new = 'paused')
2025-06-11 23:56:51 (16688): VM state change detected. (old = 'paused', new = 'running')
2025-06-11 23:57:01 (16688): VM state change detected. (old = 'running', new = 'paused')
2025-06-12 00:01:21 (16688): Guest Log: 00:08:30.381341 timesync vgsvcTimeSyncWorker: Radical guest time change: 2 150 832 557 000ns (GuestNow=1 749 657 420 789 295 000 ns GuestLast=1 749 655 269 956 738 000 ns fSetTimeLastLoop=true )
2025-06-12 00:01:21 (16688): VM state change detected. (old = 'paused', new = 'running')
2025-06-12 00:01:31 (16688): VM state change detected. (old = 'running', new = 'paused')
2025-06-12 00:04:31 (16688): VM state change detected. (old = 'paused', new = 'running')
2025-06-12 00:04:41 (16688): VM state change detected. (old = 'running', new = 'paused')
2025-06-12 00:06:22 (16688): VM state change detected. (old = 'paused', new = 'running')
2025-06-12 00:06:31 (16688): VM state change detected. (old = 'running', new = 'paused')
2025-06-12 00:06:52 (16688): VM state change detected. (old = 'paused', new = 'running')
2025-06-12 00:07:02 (16688): VM state change detected. (old = 'running', new = 'paused')
2025-06-12 00:09:02 (16688): VM state change detected. (old = 'paused', new = 'running')
2025-06-12 00:09:12 (16688): VM state change detected. (old = 'running', new = 'paused')
2025-06-12 00:09:32 (16688): VM state change detected. (old = 'paused', new = 'running')
2025-06-12 00:09:42 (16688): VM state change detected. (old = 'running', new = 'paused')
2025-06-12 00:12:02 (16688): VM state change detected. (old = 'paused', new = 'running')
2025-06-12 00:12:12 (16688): VM state change detected. (old = 'running', new = 'paused')
2025-06-12 00:12:32 (16688): VM state change detected. (old = 'paused', new = 'running')
2025-06-12 00:12:42 (16688): VM state change detected. (old = 'running', new = 'paused')
2025-06-12 00:13:42 (16688): VM state change detected. (old = 'paused', new = 'running')
2025-06-12 00:13:52 (16688): VM state change detected. (old = 'running', new = 'paused')
2025-06-12 00:18:12 (16688): VM state change detected. (old = 'paused', new = 'running')
2025-06-12 00:18:22 (16688): VM state change detected. (old = 'running', new = 'paused')
2025-06-12 00:18:42 (16688): VM state change detected. (old = 'paused', new = 'running')
2025-06-12 00:18:53 (16688): VM state change detected. (old = 'running', new = 'paused')
2025-06-12 00:19:33 (16688): VM state change detected. (old = 'paused', new = 'running')
2025-06-12 00:19:43 (16688): VM state change detected. (old = 'running', new = 'paused')
2025-06-12 00:20:23 (16688): VM state change detected. (old = 'paused', new = 'running')
2025-06-12 00:20:33 (16688): VM state change detected. (old = 'running', new = 'paused')
2025-06-12 00:22:13 (16688): VM state change detected. (old = 'paused', new = 'running')
2025-06-12 00:22:23 (16688): VM state change detected. (old = 'running', new = 'paused')
2025-06-12 00:25:23 (16688): VM state change detected. (old = 'paused', new = 'running')
2025-06-12 00:25:33 (16688): VM state change detected. (old = 'running', new = 'paused')
2025-06-12 00:28:33 (16688): VM state change detected. (old = 'paused', new = 'running')
2025-06-12 00:28:43 (16688): VM state change detected. (old = 'running', new = 'paused')
2025-06-12 00:31:03 (16688): VM state change detected. (old = 'paused', new = 'running')
2025-06-12 00:31:13 (16688): VM state change detected. (old = 'running', new = 'paused')
2025-06-12 00:31:53 (16688): VM state change detected. (old = 'paused', new = 'running')
2025-06-12 00:32:03 (16688): VM state change detected. (old = 'running', new = 'paused')
2025-06-12 00:32:23 (16688): VM state change detected. (old = 'paused', new = 'running')
2025-06-12 00:32:33 (16688): VM state change detected. (old = 'running', new = 'paused')
2025-06-12 00:37:53 (16688): VM state change detected. (old = 'paused', new = 'running')
2025-06-12 00:38:03 (16688): VM state change detected. (old = 'running', new = 'paused')
2025-06-12 00:38:23 (16688): VM state change detected. (old = 'paused', new = 'running')
2025-06-12 00:38:33 (16688): VM state change detected. (old = 'running', new = 'paused')
2025-06-12 00:38:53 (16688): VM state change detected. (old = 'paused', new = 'running')
2025-06-12 00:39:03 (16688): VM state change detected. (old = 'running', new = 'paused')
2025-06-12 00:39:43 (16688): VM state change detected. (old = 'paused', new = 'running')
2025-06-12 00:39:53 (16688): VM state change detected. (old = 'running', new = 'paused')
2025-06-12 00:42:33 (16688): VM state change detected. (old = 'paused', new = 'running')
2025-06-12 00:42:43 (16688): VM state change detected. (old = 'running', new = 'paused')
2025-06-12 00:43:23 (16688): VM state change detected. (old = 'paused', new = 'running')
2025-06-12 00:43:34 (16688): VM state change detected. (old = 'running', new = 'paused')
2025-06-12 00:45:34 (16688): VM state change detected. (old = 'paused', new = 'running')
2025-06-12 00:45:44 (16688): VM state change detected. (old = 'running', new = 'paused')
2025-06-12 00:46:04 (16688): VM state change detected. (old = 'paused', new = 'running')
2025-06-12 00:46:14 (16688): VM state change detected. (old = 'running', new = 'paused')
2025-06-12 00:48:34 (16688): VM state change detected. (old = 'paused', new = 'running')
2025-06-12 00:48:44 (16688): VM state change detected. (old = 'running', new = 'paused')
2025-06-12 00:52:44 (16688): VM state change detected. (old = 'paused', new = 'running')
2025-06-12 00:52:54 (16688): VM state change detected. (old = 'running', new = 'paused')
2025-06-12 00:53:34 (16688): VM state change detected. (old = 'paused', new = 'running')
2025-06-12 00:53:44 (16688): VM state change detected. (old = 'running', new = 'paused')
2025-06-12 00:59:04 (16688): VM state change detected. (old = 'paused', new = 'running')
2025-06-12 00:59:14 (16688): VM state change detected. (old = 'running', new = 'paused')
2025-06-12 01:01:54 (16688): VM state change detected. (old = 'paused', new = 'running')
2025-06-12 01:02:04 (16688): VM state change detected. (old = 'running', new = 'paused')
2025-06-12 01:02:44 (16688): VM state change detected. (old = 'paused', new = 'running')
2025-06-12 01:02:54 (16688): VM state change detected. (old = 'running', new = 'paused')
2025-06-12 01:03:34 (16688): VM state change detected. (old = 'paused', new = 'running')
2025-06-12 01:03:44 (16688): VM state change detected. (old = 'running', new = 'paused')
2025-06-12 01:05:04 (16688): VM state change detected. (old = 'paused', new = 'running')
2025-06-12 01:05:14 (16688): VM state change detected. (old = 'running', new = 'paused')
2025-06-12 01:05:54 (16688): VM state change detected. (old = 'paused', new = 'running')
2025-06-12 01:06:04 (16688): VM state change detected. (old = 'running', new = 'paused')
2025-06-12 01:11:45 (16688): VM state change detected. (old = 'paused', new = 'running')
2025-06-12 01:11:55 (16688): VM state change detected. (old = 'running', new = 'paused')
2025-06-12 01:12:35 (16688): VM state change detected. (old = 'paused', new = 'running')
2025-06-12 01:12:45 (16688): VM state change detected. (old = 'running', new = 'paused')
2025-06-12 01:13:25 (16688): VM state change detected. (old = 'paused', new = 'running')
2025-06-12 01:13:35 (16688): VM state change detected. (old = 'running', new = 'paused')
2025-06-12 01:13:55 (16688): VM state change detected. (old = 'paused', new = 'running')
2025-06-12 01:14:05 (16688): VM state change detected. (old = 'running', new = 'paused')
2025-06-12 01:15:25 (16688): VM state change detected. (old = 'paused', new = 'running')
2025-06-12 01:15:35 (16688): VM state change detected. (old = 'running', new = 'paused')
2025-06-12 01:31:36 (16688): VM state change detected. (old = 'paused', new = 'running')
2025-06-12 01:31:46 (16688): VM state change detected. (old = 'running', new = 'paused')
2025-06-12 01:32:06 (16688): VM state change detected. (old = 'paused', new = 'running')
2025-06-12 01:32:16 (16688): VM state change detected. (old = 'running', new = 'paused')
2025-06-12 01:32:36 (16688): VM state change detected. (old = 'paused', new = 'running')
2025-06-12 01:32:46 (16688): VM state change detected. (old = 'running', new = 'paused')
2025-06-12 01:37:06 (16688): VM state change detected. (old = 'paused', new = 'running')
2025-06-12 01:37:16 (16688): VM state change detected. (old = 'running', new = 'paused')
2025-06-12 01:41:16 (16688): VM state change detected. (old = 'paused', new = 'running')
2025-06-12 01:41:26 (16688): VM state change detected. (old = 'running', new = 'paused')
2025-06-12 01:42:06 (16688): VM state change detected. (old = 'paused', new = 'running')
2025-06-12 01:42:16 (16688): VM state change detected. (old = 'running', new = 'paused')
2025-06-12 01:42:36 (16688): VM state change detected. (old = 'paused', new = 'running')
2025-06-12 01:42:46 (16688): VM state change detected. (old = 'running', new = 'paused')
2025-06-12 01:43:06 (16688): VM state change detected. (old = 'paused', new = 'running')
2025-06-12 01:43:16 (16688): VM state change detected. (old = 'running', new = 'paused')
2025-06-12 01:43:36 (16688): VM state change detected. (old = 'paused', new = 'running')
2025-06-12 01:43:46 (16688): VM state change detected. (old = 'running', new = 'paused')
2025-06-12 01:44:06 (16688): VM state change detected. (old = 'paused', new = 'running')
2025-06-12 01:44:16 (16688): VM state change detected. (old = 'running', new = 'paused')
2025-06-12 01:44:36 (16688): VM state change detected. (old = 'paused', new = 'running')
2025-06-12 01:47:26 (16688): VM state change detected. (old = 'running', new = 'paused')
2025-06-12 01:47:46 (16688): VM state change detected. (old = 'paused', new = 'running')
2025-06-12 01:47:56 (16688): VM state change detected. (old = 'running', new = 'paused')
2025-06-12 01:48:16 (16688): VM state change detected. (old = 'paused', new = 'running')
2025-06-12 01:50:46 (16688): VM state change detected. (old = 'running', new = 'paused')
2025-06-12 01:51:06 (16688): VM state change detected. (old = 'paused', new = 'running')
2025-06-12 01:51:16 (16688): VM state change detected. (old = 'running', new = 'paused')
2025-06-12 01:51:36 (16688): VM state change detected. (old = 'paused', new = 'running')
2025-06-12 01:51:47 (16688): VM state change detected. (old = 'running', new = 'paused')
2025-06-12 01:52:07 (16688): VM state change detected. (old = 'paused', new = 'running')
2025-06-12 01:52:17 (16688): VM state change detected. (old = 'running', new = 'paused')
2025-06-12 01:52:37 (16688): VM state change detected. (old = 'paused', new = 'running')
2025-06-12 01:52:47 (16688): VM state change detected. (old = 'running', new = 'paused')
2025-06-12 01:53:07 (16688): VM state change detected. (old = 'paused', new = 'running')
2025-06-12 01:53:27 (16688): VM state change detected. (old = 'running', new = 'paused')
2025-06-12 01:54:27 (16688): VM state change detected. (old = 'paused', new = 'running')
2025-06-12 01:54:37 (16688): VM state change detected. (old = 'running', new = 'paused')
2025-06-12 01:55:17 (16688): VM state change detected. (old = 'paused', new = 'running')
2025-06-12 01:55:47 (16688): VM state change detected. (old = 'running', new = 'paused')
2025-06-12 01:56:07 (16688): VM state change detected. (old = 'paused', new = 'running')
2025-06-12 01:56:17 (16688): VM state change detected. (old = 'running', new = 'paused')
2025-06-12 01:56:37 (16688): VM state change detected. (old = 'paused', new = 'running')
2025-06-12 01:56:47 (16688): VM state change detected. (old = 'running', new = 'paused')
2025-06-12 01:57:27 (16688): VM state change detected. (old = 'paused', new = 'running')
2025-06-12 01:57:47 (16688): VM state change detected. (old = 'running', new = 'paused')
2025-06-12 01:58:27 (16688): VM state change detected. (old = 'paused', new = 'running')
2025-06-12 01:58:37 (16688): VM state change detected. (old = 'running', new = 'paused')
2025-06-12 01:59:17 (16688): VM state change detected. (old = 'paused', new = 'running')
2025-06-12 01:59:47 (16688): VM state change detected. (old = 'running', new = 'paused')
2025-06-12 02:00:07 (16688): VM state change detected. (old = 'paused', new = 'running')
2025-06-12 02:00:17 (16688): VM state change detected. (old = 'running', new = 'paused')
2025-06-12 02:00:37 (16688): VM state change detected. (old = 'paused', new = 'running')
2025-06-12 02:00:47 (16688): VM state change detected. (old = 'running', new = 'paused')
2025-06-12 02:01:08 (16688): VM state change detected. (old = 'paused', new = 'running')
2025-06-12 02:01:18 (16688): VM state change detected. (old = 'running', new = 'paused')
2025-06-12 02:01:38 (16688): VM state change detected. (old = 'paused', new = 'running')
2025-06-12 02:01:48 (16688): VM state change detected. (old = 'running', new = 'paused')
2025-06-12 02:02:08 (16688): VM state change detected. (old = 'paused', new = 'running')
2025-06-12 02:02:18 (16688): VM state change detected. (old = 'running', new = 'paused')
2025-06-12 02:02:38 (16688): VM state change detected. (old = 'paused', new = 'running')
2025-06-12 02:02:48 (16688): VM state change detected. (old = 'running', new = 'paused')
2025-06-12 02:03:08 (16688): VM state change detected. (old = 'paused', new = 'running')
2025-06-12 02:04:08 (16688): VM state change detected. (old = 'running', new = 'paused')
2025-06-12 02:04:28 (16688): VM state change detected. (old = 'paused', new = 'running')
2025-06-12 02:04:48 (16688): VM state change detected. (old = 'running', new = 'paused')
2025-06-12 02:05:08 (16688): VM state change detected. (old = 'paused', new = 'running')
2025-06-12 02:05:38 (16688): VM state change detected. (old = 'running', new = 'paused')
2025-06-12 02:05:58 (16688): VM state change detected. (old = 'paused', new = 'running')
2025-06-12 02:06:48 (16688): VM state change detected. (old = 'running', new = 'paused')
2025-06-12 02:07:08 (16688): VM state change detected. (old = 'paused', new = 'running')
2025-06-12 02:07:28 (16688): VM state change detected. (old = 'running', new = 'paused')
2025-06-12 02:07:48 (16688): VM state change detected. (old = 'paused', new = 'running')
2025-06-12 02:08:08 (16688): VM state change detected. (old = 'running', new = 'paused')
2025-06-12 02:08:28 (16688): VM state change detected. (old = 'paused', new = 'running')
2025-06-12 02:08:38 (16688): VM state change detected. (old = 'running', new = 'paused')
2025-06-12 02:08:58 (16688): VM state change detected. (old = 'paused', new = 'running')
2025-06-12 02:10:28 (16688): VM state change detected. (old = 'running', new = 'paused')
2025-06-12 02:10:48 (16688): VM state change detected. (old = 'paused', new = 'running')
2025-06-12 02:10:58 (16688): VM state change detected. (old = 'running', new = 'paused')
2025-06-12 02:11:18 (16688): VM state change detected. (old = 'paused', new = 'running')
2025-06-12 02:11:28 (16688): VM state change detected. (old = 'running', new = 'paused')
2025-06-12 02:11:48 (16688): VM state change detected. (old = 'paused', new = 'running')
2025-06-12 02:12:08 (16688): VM state change detected. (old = 'running', new = 'paused')
2025-06-12 02:12:28 (16688): VM state change detected. (old = 'paused', new = 'running')
2025-06-12 02:12:38 (16688): VM state change detected. (old = 'running', new = 'paused')
2025-06-12 02:21:38 (16688): VM state change detected. (old = 'paused', new = 'running')
2025-06-12 02:21:48 (16688): VM state change detected. (old = 'running', new = 'paused')
2025-06-12 02:22:28 (16688): VM state change detected. (old = 'paused', new = 'running')
2025-06-12 02:22:38 (16688): VM state change detected. (old = 'running', new = 'paused')
2025-06-12 02:22:59 (16688): VM state change detected. (old = 'paused', new = 'running')
2025-06-12 02:23:09 (16688): VM state change detected. (old = 'running', new = 'paused')
2025-06-12 02:23:29 (16688): VM state change detected. (old = 'paused', new = 'running')
2025-06-12 02:23:39 (16688): VM state change detected. (old = 'running', new = 'paused')
2025-06-12 02:23:59 (16688): VM state change detected. (old = 'paused', new = 'running')
2025-06-12 02:24:09 (16688): VM state change detected. (old = 'running', new = 'paused')
2025-06-12 02:29:09 (16688): VM state change detected. (old = 'paused', new = 'running')
2025-06-12 02:29:19 (16688): VM state change detected. (old = 'running', new = 'paused')
2025-06-12 02:31:19 (16688): VM state change detected. (old = 'paused', new = 'running')
2025-06-12 02:31:29 (16688): VM state change detected. (old = 'running', new = 'paused')
2025-06-12 02:31:49 (16688): VM state change detected. (old = 'paused', new = 'running')
2025-06-12 02:31:59 (16688): VM state change detected. (old = 'running', new = 'paused')
2025-06-12 02:32:19 (16688): VM state change detected. (old = 'paused', new = 'running')
2025-06-12 02:32:29 (16688): VM state change detected. (old = 'running', new = 'paused')
2025-06-12 02:38:10 (16688): VM state change detected. (old = 'paused', new = 'running')
2025-06-12 02:38:20 (16688): VM state change detected. (old = 'running', new = 'paused')
2025-06-12 02:39:40 (16688): VM state change detected. (old = 'paused', new = 'running')
2025-06-12 02:39:50 (16688): VM state change detected. (old = 'running', new = 'paused')
2025-06-12 02:40:50 (16688): VM state change detected. (old = 'paused', new = 'running')
2025-06-12 02:41:00 (16688): VM state change detected. (old = 'running', new = 'paused')
2025-06-12 02:41:20 (16688): VM state change detected. (old = 'paused', new = 'running')
2025-06-12 02:41:40 (16688): VM state change detected. (old = 'running', new = 'paused')
2025-06-12 02:42:00 (16688): VM state change detected. (old = 'paused', new = 'running')
2025-06-12 02:42:10 (16688): VM state change detected. (old = 'running', new = 'paused')
2025-06-12 02:44:30 (16688): VM state change detected. (old = 'paused', new = 'running')
2025-06-12 02:44:40 (16688): VM state change detected. (old = 'running', new = 'paused')
2025-06-12 02:45:00 (16688): VM state change detected. (old = 'paused', new = 'running')
2025-06-12 02:45:10 (16688): VM state change detected. (old = 'running', new = 'paused')
2025-06-12 02:45:30 (16688): VM state change detected. (old = 'paused', new = 'running')
2025-06-12 02:45:40 (16688): VM state change detected. (old = 'running', new = 'paused')
2025-06-12 02:47:00 (16688): VM state change detected. (old = 'paused', new = 'running')
2025-06-12 02:47:10 (16688): VM state change detected. (old = 'running', new = 'paused')
2025-06-12 02:47:50 (16688): VM state change detected. (old = 'paused', new = 'running')
2025-06-12 02:48:00 (16688): VM state change detected. (old = 'running', new = 'paused')
2025-06-12 02:49:20 (16688): VM state change detected. (old = 'paused', new = 'running')
2025-06-12 02:49:30 (16688): VM state change detected. (old = 'running', new = 'paused')
2025-06-12 02:52:30 (16688): VM state change detected. (old = 'paused', new = 'running')
2025-06-12 02:52:40 (16688): VM state change detected. (old = 'running', new = 'paused')
2025-06-12 03:02:01 (16688): VM state change detected. (old = 'paused', new = 'running')
2025-06-12 03:02:11 (16688): VM state change detected. (old = 'running', new = 'paused')
2025-06-12 03:03:51 (16688): VM state change detected. (old = 'paused', new = 'running')
2025-06-12 03:04:01 (16688): VM state change detected. (old = 'running', new = 'paused')
2025-06-12 03:07:41 (16688): VM state change detected. (old = 'paused', new = 'running')
2025-06-12 03:07:51 (16688): VM state change detected. (old = 'running', new = 'paused')
2025-06-12 03:09:11 (16688): VM state change detected. (old = 'paused', new = 'running')
2025-06-12 03:09:21 (16688): VM state change detected. (old = 'running', new = 'paused')
2025-06-12 03:09:41 (16688): VM state change detected. (old = 'paused', new = 'running')
2025-06-12 03:09:51 (16688): VM state change detected. (old = 'running', new = 'paused')
2025-06-12 03:10:51 (16688): VM state change detected. (old = 'paused', new = 'running')
2025-06-12 03:11:01 (16688): VM state change detected. (old = 'running', new = 'paused')
2025-06-12 03:20:01 (16688): VM state change detected. (old = 'paused', new = 'running')
2025-06-12 03:20:11 (16688): VM state change detected. (old = 'running', new = 'paused')
2025-06-12 03:22:32 (16688): VM state change detected. (old = 'paused', new = 'running')
2025-06-12 03:22:42 (16688): VM state change detected. (old = 'running', new = 'paused')
2025-06-12 03:23:02 (16688): VM state change detected. (old = 'paused', new = 'running')
2025-06-12 03:23:12 (16688): VM state change detected. (old = 'running', new = 'paused')
2025-06-12 18:14:24 (16716): vboxwrapper version 26210
2025-06-12 18:14:24 (16716): BOINC client version: 8.0.2
2025-06-12 18:14:25 (16716): Detected: VirtualBox VboxManage Interface (Version: 7.0.6)
2025-06-12 18:14:25 (16716): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2025-06-12 18:14:26 (16716): Guest Log: BIOS: VirtualBox 7.0.6
2025-06-12 18:14:26 (16716): Guest Log: CPUID EDX: 0x178bfbff
2025-06-12 18:14:26 (16716): Guest Log: BIOS: No PCI IDE controller, not probing IDE
2025-06-12 18:14:26 (16716): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors
2025-06-12 18:14:26 (16716): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2025-06-12 18:14:26 (16716): Guest Log: BIOS: Booting from Hard Disk...
2025-06-12 18:14:26 (16716): Guest Log: BIOS: KBD: unsupported int 16h function 03
2025-06-12 18:14:26 (16716): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000
2025-06-12 18:14:26 (16716): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2025-06-12 18:14:26 (16716): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)
2025-06-12 18:14:26 (16716): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log
2025-06-12 18:14:26 (16716): Guest Log: 00:00:00.000065 main Log opened 2025-06-11T14:52:08.673692000Z
2025-06-12 18:14:26 (16716): Guest Log: 00:00:00.000129 main OS Product: Linux
2025-06-12 18:14:26 (16716): Guest Log: 00:00:00.000143 main OS Release: 4.14.232-19.cernvm.x86_64
2025-06-12 18:14:26 (16716): Guest Log: 00:00:00.000156 main OS Version: #1 SMP Fri Apr 30 17:12:25 CEST 2021
2025-06-12 18:14:26 (16716): Guest Log: 00:00:00.000168 main Executable: /usr/sbin/VBoxService
2025-06-12 18:14:26 (16716): Guest Log: 00:00:00.000168 main Process ID: 2287
2025-06-12 18:14:26 (16716): Guest Log: 00:00:00.000168 main Package type: LINUX_64BITS_GENERIC
2025-06-12 18:14:26 (16716): Guest Log: 00:00:00.001628 main 5.2.6 r120293 started. Verbose level = 0
2025-06-12 18:14:26 (16716): Guest Log: [INFO] Mounting the shared directory
2025-06-12 18:14:26 (16716): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor
2025-06-12 18:14:26 (16716): Guest Log: [INFO] Sourcing essential functions from /cvmfs/grid.cern.ch
2025-06-12 18:14:26 (16716): Guest Log: [INFO] Testing connection to cern.ch
2025-06-12 18:14:26 (16716): Guest Log: [INFO] Testing connection to VCCS
2025-06-12 18:14:26 (16716): Guest Log: [INFO] Testing connection to HTCondor
2025-06-12 18:14:26 (16716): Guest Log: [INFO] Testing connection to WMAgent
2025-06-12 18:14:26 (16716): Guest Log: [INFO] Testing connection to EOSCMS
2025-06-12 18:14:26 (16716): Guest Log: [INFO] Testing connection to CMS-Factory
2025-06-12 18:14:26 (16716): Guest Log: [INFO] Testing connection to CMS-Frontier
2025-06-12 18:14:26 (16716): Guest Log: [INFO] Testing connection to Frontier
2025-06-12 18:14:26 (16716): Guest Log: [INFO] Testing connection to http://cms-frontier.openhtc.io:8080/FrontierProd/Frontier/
2025-06-12 18:14:26 (16716): Guest Log: [INFO] Could not find a local HTTP proxy
2025-06-12 18:14:26 (16716): Guest Log: [INFO] CVMFS and Frontier will have to use DIRECT connections
2025-06-12 18:14:26 (16716): Guest Log: [INFO] This makes the application less efficient
2025-06-12 18:14:26 (16716): Guest Log: [INFO] It also puts higher load on the project servers
2025-06-12 18:14:26 (16716): Guest Log: [INFO] Setting up a local HTTP proxy is highly recommended
2025-06-12 18:14:26 (16716): Guest Log: [INFO] Advice can be found in the project forum
2025-06-12 18:14:26 (16716): Guest Log: [INFO] Reloading and probing the CVMFS configuration
2025-06-12 18:14:26 (16716): Guest Log: [INFO] Probing /cvmfs/grid.cern.ch... OK
2025-06-12 18:14:26 (16716): Guest Log: [INFO] Probing /cvmfs/cms.cern.ch... OK
2025-06-12 18:14:26 (16716): Guest Log: [INFO] Probing /cvmfs/oasis.opensciencegrid.org... OK
2025-06-12 18:14:26 (16716): Guest Log: [INFO] Probing /cvmfs/cms-ib.cern.ch... OK
2025-06-12 18:14:26 (16716): Guest Log: [INFO] Probing /cvmfs/singularity.opensciencegrid.org... OK
2025-06-12 18:14:26 (16716): Guest Log: [INFO] Excerpt from "cvmfs_config stat": VERSION HOST PROXY
2025-06-12 18:14:26 (16716): Guest Log: [INFO] 2.7.2.0 http://s1ral-cvmfs.openhtc.io DIRECT
2025-06-12 18:14:26 (16716): Guest Log: [INFO] Environment HTTP proxy: not set
2025-06-12 18:14:26 (16716): Guest Log: [INFO] Reading volunteer information
2025-06-12 18:14:26 (16716): Guest Log: [INFO] Using weak account key.
2025-06-12 18:14:26 (16716): Guest Log: [INFO] Requesting an X509 credential from LHC@home
2025-06-12 18:14:26 (16716): Guest Log: [INFO] Using weak account key.
2025-06-12 18:14:26 (16716): Guest Log: [INFO] Requesting an idtoken from LHC@home
2025-06-12 18:14:26 (16716): Guest Log: [INFO] CMS application starting. Check log files.
2025-06-12 18:14:26 (16716): Guest Log: 00:08:30.381341 timesync vgsvcTimeSyncWorker: Radical guest time change: 2 150 832 557 000ns (GuestNow=1 749 657 420 789 295 000 ns GuestLast=1 749 655 269 956 738 000 ns fSetTimeLastLoop=true )
2025-06-12 18:14:26 (16716): Starting VM using VBoxManage interface. (boinc_2c677c05a0d16e66, slot#0)
2025-06-12 18:14:41 (16716): Error in start VM for VM: -2147467259
Command:
VBoxManage -q startvm "boinc_2c677c05a0d16e66" --type headless
Output:
VBoxManage.exe: error: The VM session was aborted
VBoxManage.exe: error: Details: code E_FAIL (0x80004005), component SessionMachine, interface ISession
Waiting for VM "boinc_2c677c05a0d16e66" to power on...
2025-06-12 18:14:41 (16716): VM failed to start.
2025-06-12 18:14:41 (16716): Could not start
2025-06-12 18:14:41 (16716): ERROR: VM failed to start
2025-06-12 18:14:41 (16716): Powering off VM.
2025-06-12 18:14:41 (16716): Deregistering VM. (boinc_2c677c05a0d16e66, slot#0)
2025-06-12 18:14:42 (16716): Removing network bandwidth throttle group from VM.
2025-06-12 18:14:42 (16716): Removing VM from VirtualBox.
Hypervisor System Log:
00:00:17.390978 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:17.390982 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:17.390986 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:17.390990 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:17.390994 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:17.392538 ERROR [COM]: aRC=E_FAIL (0x80004005) aIID={300763af-5d6b-46e6-aa96-273eac15538a} aComponent={SessionMachine} aText={This machine does not have any snapshots}, preserve=false aResultDetail=0
00:00:17.587403 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:17.587426 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:17.587434 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:17.587441 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:17.587447 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:17.587452 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:17.587458 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:17.587465 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:17.587471 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:17.589296 Saving settings file "C:\ProgramData\BOINC\slots\0\boinc_2c677c05a0d16e66\boinc_2c677c05a0d16e66.vbox" with version "1.19-windows"
00:00:17.592293 Finished saving settings file "C:\ProgramData\BOINC\slots\0\boinc_2c677c05a0d16e66\boinc_2c677c05a0d16e66.vbox"
00:00:17.931291 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:17.931317 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:17.931326 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:17.931333 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:17.931339 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:17.931346 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:17.931352 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:17.931359 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:17.931366 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:17.931762 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:17.931789 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:17.931796 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:17.931802 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:17.931807 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:17.931813 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:17.931819 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:17.931824 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:17.931830 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:17.931990 Saving settings file "C:\Users\ybcxc\.VirtualBox\VirtualBox.xml" with version "1.12-windows"
00:00:17.934923 Finished saving settings file "C:\Users\ybcxc\.VirtualBox\VirtualBox.xml"
00:00:17.935076 Saving settings file "C:\Users\ybcxc\.VirtualBox\VirtualBox.xml" with version "1.12-windows"
00:00:17.938474 Finished saving settings file "C:\Users\ybcxc\.VirtualBox\VirtualBox.xml"
00:00:17.940049 DeleteVM Saving settings file "C:\Users\ybcxc\.VirtualBox\VirtualBox.xml" with version "1.12-windows"
00:00:17.944060 DeleteVM Finished saving settings file "C:\Users\ybcxc\.VirtualBox\VirtualBox.xml"
VM Execution Log:
VM Startup Log:
VM Trace Log:
IIX3 SATA Controllers: 1
Maximum ICH9 SATA Controllers: 8
Maximum SATA Port count: 30
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\ybcxc\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-06-12 18:14:25 (16716):
Command: VBoxManage -q list hostinfo
Exit Code: 0
Output:
Host Information:
Host time: 2025-06-12T10:14:25.701000000Z
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: 32621 MByte
Memory available: 27207 MByte
Operating system: Windows 10
Operating system version: 10.0.19045
2025-06-12 18:14:26 (16716):
Command: VBoxManage -q showvminfo "boinc_2c677c05a0d16e66" --machinereadable
Exit Code: 0
Output:
name="boinc_2c677c05a0d16e66"
Encryption: disabled
groups="/"
ostype="Linux 2.6 / 3.x / 4.x / 5.x (64-bit)"
UUID="e6f90385-64c5-4ee3-b91f-08c2ea0bbfc6"
CfgFile="C:\\ProgramData\\BOINC\\slots\\0\\boinc_2c677c05a0d16e66\\boinc_2c677c05a0d16e66.vbox"
SnapFldr="C:\\ProgramData\\BOINC\\slots\\0\\boinc_2c677c05a0d16e66\\Snapshots"
LogFldr="C:\\ProgramData\\BOINC\\slots\\0\\boinc_2c677c05a0d16e66\\Logs"
hardwareuuid="e6f90385-64c5-4ee3-b91f-08c2ea0bbfc6"
memory=4584
pagefusion="off"
vram=16
cpuexecutioncap=100
hpet="off"
cpu-profile="host"
chipset="piix3"
firmware="BIOS"
cpus=4
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\\0\\boinc_2c677c05a0d16e66\\boinc_2c677c05a0d16e66.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-06-11T14:50:37.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\\0\\boinc_2c677c05a0d16e66\\Snapshots/{5b647dec-d802-49cb-8c5c-76008ca1094f}.vdi"
"Hard Disk Controller-ImageUUID-0-0"="5b647dec-d802-49cb-8c5c-76008ca1094f"
"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"="ffd7a96f-e76d-4a95-a1c7-fc2faa147582"
"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="080027FB5F01"
cableconnected1="on"
nic1="nat"
nictype1="virtio"
nicspeed1="0"
mtu="0"
sockSnd="64"
sockRcv="64"
tcpWndSnd="64"
tcpWndRcv="64"
Forwarding(0)="tcp_50117_80,tcp,127.0.0.1,50117,,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_2c677c05a0d16e66_net",Network,1099511627776
SharedFolderNameMachineMapping1="shared"
SharedFolderPathMachineMapping1="C:\\ProgramData\\BOINC\\slots\\0\\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\\0\\boinc_2c677c05a0d16e66\\boinc_2c677c05a0d16e66-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="CMS_111216_1749580166.287368_0"
GuestMemoryBalloon=0
2025-06-12 18:14:41 (16716):
Command: VBoxManage -q startvm "boinc_2c677c05a0d16e66" --type headless
Exit Code: -2147467259
Output:
VBoxManage.exe: error: The VM session was aborted
VBoxManage.exe: error: Details: code E_FAIL (0x80004005), component SessionMachine, interface ISession
Waiting for VM "boinc_2c677c05a0d16e66" to power on...
2025-06-12 18:14:42 (16716):
Command: VBoxManage -q snapshot "boinc_2c677c05a0d16e66" list
Exit Code: -108
Output:
This machine does not have any snapshots
2025-06-12 18:14:42 (16716):
Command: VBoxManage -q bandwidthctl "boinc_2c677c05a0d16e66" remove "boinc_2c677c05a0d16e66_net"
Exit Code: 0
Output:
2025-06-12 18:14:42 (16716):
Command: VBoxManage -q unregistervm "boinc_2c677c05a0d16e66" --delete
Exit Code: 0
Output:
0%...10%...20%...30%...40%...50%...60%...70%...80%...90%...100%
2025-06-12 18:14:53 (16716): called boinc_finish(-2147467259)
</stderr_txt>
]]>
©2025 CERN