| Name | CMS_3945057_1741806011.230302_0 |
| Workunit | 230794231 |
| Created | 12 Mar 2025, 19:00:12 UTC |
| Sent | 12 Mar 2025, 20:34:49 UTC |
| Report deadline | 12 Apr 2025, 20:34:49 UTC |
| Received | 12 Mar 2025, 23:44:38 UTC |
| Server state | Over |
| Outcome | Computation error |
| Client state | Compute error |
| Exit status | -2147467259 (0x80004005) Unknown error code |
| Computer ID | 10671500 |
| Run time | 55 min 2 sec |
| CPU time | 5 hours 2 min 32 sec |
| Validate state | Invalid |
| Credit | 0.00 |
| Device peak FLOPS | 19.74 GFLOPS |
| Application version | CMS Simulation v70.60 (vbox64_mt_mcore_cms) windows_x86_64 |
| Peak working set size | 88.53 MB |
| Peak swap size | 90.59 MB |
| Peak disk usage | 1.50 GB |
Stderr output
<core_client_version>8.0.2</core_client_version>
<![CDATA[
<message>
Unspecified error
(0x80004005) - exit code 2147500037 (0x80004005)</message>
<stderr_txt>
onds)
2025-03-12 16:34:52 (47656): Successfully copied 'init_data.xml' to the shared directory.
2025-03-12 16:34:52 (47656): Create VM. (boinc_64ac692c5d3e9bbf, slot#0)
2025-03-12 16:34:53 (47656): Setting Memory Size for VM. (4584MB)
2025-03-12 16:34:53 (47656): Setting CPU Count for VM. (4)
2025-03-12 16:34:53 (47656): Setting Chipset Options for VM.
2025-03-12 16:34:54 (47656): Setting Graphics Controller Options for VM.
2025-03-12 16:34:54 (47656): Setting Boot Options for VM.
2025-03-12 16:34:54 (47656): Setting Network Configuration for NAT.
2025-03-12 16:34:54 (47656): Enabling VM Network Access.
2025-03-12 16:34:55 (47656): Disabling USB Support for VM.
2025-03-12 16:34:55 (47656): Disabling COM Port Support for VM.
2025-03-12 16:34:56 (47656): Disabling LPT Port Support for VM.
2025-03-12 16:34:56 (47656): Disabling Audio Support for VM.
2025-03-12 16:34:56 (47656): Disabling Clipboard Support for VM.
2025-03-12 16:34:56 (47656): Disabling Drag and Drop Support for VM.
2025-03-12 16:34:57 (47656): Adding storage controller(s) to VM.
2025-03-12 16:34:57 (47656): Adding virtual disk drive to VM. (CMS_2025_01_16_prod.vdi)
2025-03-12 16:35:00 (47656): Adding VirtualBox Guest Additions to VM.
2025-03-12 16:35:00 (47656): Adding network bandwidth throttle group to VM. (Defaulting to 1024GB)
2025-03-12 16:35:00 (47656): forwarding host port 64555 to guest port 80
2025-03-12 16:35:01 (47656): Enabling remote desktop for VM.
2025-03-12 16:35:01 (47656): Required extension pack not installed, remote desktop not enabled.
2025-03-12 16:35:01 (47656): Enabling shared directory for VM.
2025-03-12 16:35:01 (47656): Starting VM using VBoxManage interface. (boinc_64ac692c5d3e9bbf, slot#0)
2025-03-12 16:35:09 (47656): Successfully started VM. (PID = '9316')
2025-03-12 16:35:09 (47656): Reporting VM Process ID to BOINC.
2025-03-12 16:35:09 (47656): Guest Log: BIOS: VirtualBox 7.0.6
2025-03-12 16:35:09 (47656): Guest Log: CPUID EDX: 0x178bfbff
2025-03-12 16:35:09 (47656): Guest Log: BIOS: No PCI IDE controller, not probing IDE
2025-03-12 16:35:09 (47656): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors
2025-03-12 16:35:09 (47656): VM state change detected. (old = 'poweredoff', new = 'running')
2025-03-12 16:35:09 (47656): Detected: Web Application Enabled (http://localhost:64555)
2025-03-12 16:35:10 (47656): VM state change detected. (old = 'running', new = 'paused')
2025-03-12 16:35:27 (47656): Preference change detected
2025-03-12 16:35:27 (47656): Setting CPU throttle for VM. (80%)
2025-03-12 16:35:29 (47656): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2025-03-12 16:35:29 (47656): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2025-03-12 16:35:29 (47656): Guest Log: BIOS: Booting from Hard Disk...
2025-03-12 16:35:29 (47656): VM state change detected. (old = 'paused', new = 'running')
2025-03-12 16:35:32 (47656): Guest Log: BIOS: KBD: unsupported int 16h function 03
2025-03-12 16:35:32 (47656): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000
2025-03-12 16:35:38 (47656): VM state change detected. (old = 'running', new = 'paused')
2025-03-12 16:35:58 (47656): VM state change detected. (old = 'paused', new = 'running')
2025-03-12 16:36:22 (47656): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2025-03-12 16:36:22 (47656): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)
2025-03-12 16:36:23 (47656): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log
2025-03-12 16:36:23 (47656): Guest Log: 00:00:00.000945 main Log opened 2025-03-12T20:36:23.499931000Z
2025-03-12 16:36:23 (47656): Guest Log: 00:00:00.001369 main OS Product: Linux
2025-03-12 16:36:23 (47656): Guest Log: 00:00:00.001468 main OS Release: 4.14.232-19.cernvm.x86_64
2025-03-12 16:36:23 (47656): Guest Log: 00:00:00.001548 main OS Version: #1 SMP Fri Apr 30 17:12:25 CEST 2021
2025-03-12 16:36:23 (47656): Guest Log: 00:00:00.001630 main Executable: /usr/sbin/VBoxService
2025-03-12 16:36:23 (47656): Guest Log: 00:00:00.001632 main Process ID: 2289
2025-03-12 16:36:23 (47656): Guest Log: 00:00:00.001632 main Package type: LINUX_64BITS_GENERIC
2025-03-12 16:36:23 (47656): Guest Log: 00:00:00.002860 main 5.2.6 r120293 started. Verbose level = 0
2025-03-12 16:36:37 (47656): Guest Log: [INFO] Mounting the shared directory
2025-03-12 16:36:38 (47656): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor
2025-03-12 16:36:38 (47656): Guest Log: [INFO] Sourcing essential functions from /cvmfs/grid.cern.ch
2025-03-12 16:36:38 (47656): Guest Log: [INFO] Testing connection to cern.ch
2025-03-12 16:36:39 (47656): Guest Log: [INFO] Testing connection to VCCS
2025-03-12 16:36:39 (47656): Guest Log: [INFO] Testing connection to HTCondor
2025-03-12 16:36:40 (47656): Guest Log: [INFO] Testing connection to WMAgent
2025-03-12 16:36:40 (47656): Guest Log: [INFO] Testing connection to EOSCMS
2025-03-12 16:36:41 (47656): Guest Log: [INFO] Testing connection to CMS-Factory
2025-03-12 16:36:41 (47656): Guest Log: [INFO] Testing connection to CMS-Frontier
2025-03-12 16:36:42 (47656): Guest Log: [INFO] Testing connection to Frontier
2025-03-12 16:36:43 (47656): Guest Log: [INFO] Could not find a local HTTP proxy
2025-03-12 16:36:43 (47656): Guest Log: [INFO] CVMFS and Frontier will have to use DIRECT connections
2025-03-12 16:36:43 (47656): Guest Log: [INFO] This makes the application less efficient
2025-03-12 16:36:43 (47656): Guest Log: [INFO] It also puts higher load on the project servers
2025-03-12 16:36:43 (47656): Guest Log: [INFO] Setting up a local HTTP proxy is highly recommended
2025-03-12 16:36:43 (47656): Guest Log: [INFO] Advice can be found in the project forum
2025-03-12 16:36:44 (47656): Guest Log: [INFO] Reloading and probing the CVMFS configuration
2025-03-12 16:36:49 (47656): Guest Log: [INFO] Probing /cvmfs/grid.cern.ch... OK
2025-03-12 16:36:52 (47656): Guest Log: [INFO] Probing /cvmfs/cms-ib.cern.ch... OK
2025-03-12 16:36:52 (47656): Guest Log: [INFO] Probing /cvmfs/singularity.opensciencegrid.org... OK
2025-03-12 16:36:52 (47656): Guest Log: [INFO] Probing /cvmfs/oasis.opensciencegrid.org... OK
2025-03-12 16:36:53 (47656): Guest Log: [INFO] Probing /cvmfs/cms.cern.ch... OK
2025-03-12 16:36:54 (47656): Guest Log: [INFO] Excerpt from "cvmfs_config stat": VERSION HOST PROXY
2025-03-12 16:36:54 (47656): Guest Log: [INFO] 2.7.2.0 http://s1ral-cvmfs.openhtc.io DIRECT
2025-03-12 16:36:54 (47656): Guest Log: [INFO] Environment HTTP proxy: not set
2025-03-12 16:36:55 (47656): Guest Log: [INFO] Reading volunteer information
2025-03-12 16:37:34 (47656): Guest Log: [INFO] Requesting an X509 credential from LHC@home
2025-03-12 16:37:36 (47656): Guest Log: [INFO] Requesting an idtoken from LHC@home
2025-03-12 16:37:37 (47656): Guest Log: [INFO] CMS application starting. Check log files.
2025-03-12 16:49:40 (47656): VM state change detected. (old = 'running', new = 'paused')
2025-03-12 16:50:00 (47656): VM state change detected. (old = 'paused', new = 'running')
2025-03-12 16:50:10 (47656): VM state change detected. (old = 'running', new = 'paused')
2025-03-12 16:50:30 (47656): VM state change detected. (old = 'paused', new = 'running')
2025-03-12 16:50:40 (47656): VM state change detected. (old = 'running', new = 'paused')
2025-03-12 16:51:00 (47656): VM state change detected. (old = 'paused', new = 'running')
2025-03-12 16:51:10 (47656): VM state change detected. (old = 'running', new = 'paused')
2025-03-12 16:51:30 (47656): VM state change detected. (old = 'paused', new = 'running')
2025-03-12 16:51:40 (47656): VM state change detected. (old = 'running', new = 'paused')
2025-03-12 16:52:00 (47656): VM state change detected. (old = 'paused', new = 'running')
2025-03-12 16:52:10 (47656): VM state change detected. (old = 'running', new = 'paused')
2025-03-12 16:52:30 (47656): VM state change detected. (old = 'paused', new = 'running')
2025-03-12 16:52:41 (47656): VM state change detected. (old = 'running', new = 'paused')
2025-03-12 16:53:02 (47656): VM state change detected. (old = 'paused', new = 'running')
2025-03-12 16:53:21 (47656): VM state change detected. (old = 'running', new = 'paused')
2025-03-12 16:53:40 (47656): VM state change detected. (old = 'paused', new = 'running')
2025-03-12 16:53:51 (47656): VM state change detected. (old = 'running', new = 'paused')
2025-03-12 16:54:12 (47656): VM state change detected. (old = 'paused', new = 'running')
2025-03-12 16:54:42 (47656): VM state change detected. (old = 'running', new = 'paused')
2025-03-12 16:55:02 (47656): VM state change detected. (old = 'paused', new = 'running')
2025-03-12 16:55:22 (47656): VM state change detected. (old = 'running', new = 'paused')
2025-03-12 16:55:42 (47656): VM state change detected. (old = 'paused', new = 'running')
2025-03-12 16:56:02 (47656): VM state change detected. (old = 'running', new = 'paused')
2025-03-12 16:56:22 (47656): VM state change detected. (old = 'paused', new = 'running')
2025-03-12 16:56:42 (47656): VM state change detected. (old = 'running', new = 'paused')
2025-03-12 16:57:02 (47656): VM state change detected. (old = 'paused', new = 'running')
2025-03-12 16:57:12 (47656): VM state change detected. (old = 'running', new = 'paused')
2025-03-12 16:57:32 (47656): VM state change detected. (old = 'paused', new = 'running')
2025-03-12 16:57:52 (47656): VM state change detected. (old = 'running', new = 'paused')
2025-03-12 16:58:12 (47656): VM state change detected. (old = 'paused', new = 'running')
2025-03-12 16:58:32 (47656): VM state change detected. (old = 'running', new = 'paused')
2025-03-12 16:58:52 (47656): VM state change detected. (old = 'paused', new = 'running')
2025-03-12 16:59:02 (47656): VM state change detected. (old = 'running', new = 'paused')
2025-03-12 16:59:22 (47656): VM state change detected. (old = 'paused', new = 'running')
2025-03-12 16:59:42 (47656): VM state change detected. (old = 'running', new = 'paused')
2025-03-12 17:00:02 (47656): VM state change detected. (old = 'paused', new = 'running')
2025-03-12 17:00:22 (47656): VM state change detected. (old = 'running', new = 'paused')
2025-03-12 17:00:42 (47656): VM state change detected. (old = 'paused', new = 'running')
2025-03-12 17:01:03 (47656): VM state change detected. (old = 'running', new = 'paused')
2025-03-12 17:01:22 (47656): VM state change detected. (old = 'paused', new = 'running')
2025-03-12 17:01:32 (47656): VM state change detected. (old = 'running', new = 'paused')
2025-03-12 17:01:52 (47656): VM state change detected. (old = 'paused', new = 'running')
2025-03-12 17:02:12 (47656): VM state change detected. (old = 'running', new = 'paused')
2025-03-12 17:02:32 (47656): VM state change detected. (old = 'paused', new = 'running')
2025-03-12 17:02:52 (47656): VM state change detected. (old = 'running', new = 'paused')
2025-03-12 17:03:12 (47656): VM state change detected. (old = 'paused', new = 'running')
2025-03-12 17:03:22 (47656): VM state change detected. (old = 'running', new = 'paused')
2025-03-12 17:03:43 (47656): VM state change detected. (old = 'paused', new = 'running')
2025-03-12 17:04:03 (47656): VM state change detected. (old = 'running', new = 'paused')
2025-03-12 17:04:23 (47656): VM state change detected. (old = 'paused', new = 'running')
2025-03-12 17:04:33 (47656): VM state change detected. (old = 'running', new = 'paused')
2025-03-12 17:04:53 (47656): VM state change detected. (old = 'paused', new = 'running')
2025-03-12 17:05:13 (47656): VM state change detected. (old = 'running', new = 'paused')
2025-03-12 17:05:34 (47656): VM state change detected. (old = 'paused', new = 'running')
2025-03-12 17:05:54 (47656): VM state change detected. (old = 'running', new = 'paused')
2025-03-12 17:06:15 (47656): VM state change detected. (old = 'paused', new = 'running')
2025-03-12 17:06:34 (47656): VM state change detected. (old = 'running', new = 'paused')
2025-03-12 17:06:54 (47656): VM state change detected. (old = 'paused', new = 'running')
2025-03-12 17:07:14 (47656): VM state change detected. (old = 'running', new = 'paused')
2025-03-12 17:07:35 (47656): VM state change detected. (old = 'paused', new = 'running')
2025-03-12 17:07:54 (47656): VM state change detected. (old = 'running', new = 'paused')
2025-03-12 17:08:15 (47656): VM state change detected. (old = 'paused', new = 'running')
2025-03-12 17:08:35 (47656): VM state change detected. (old = 'running', new = 'paused')
2025-03-12 17:08:55 (47656): VM state change detected. (old = 'paused', new = 'running')
2025-03-12 17:09:15 (47656): VM state change detected. (old = 'running', new = 'paused')
2025-03-12 17:09:35 (47656): VM state change detected. (old = 'paused', new = 'running')
2025-03-12 17:09:55 (47656): VM state change detected. (old = 'running', new = 'paused')
2025-03-12 17:10:15 (47656): VM state change detected. (old = 'paused', new = 'running')
2025-03-12 17:10:25 (47656): VM state change detected. (old = 'running', new = 'paused')
2025-03-12 17:10:45 (47656): VM state change detected. (old = 'paused', new = 'running')
2025-03-12 17:10:55 (47656): VM state change detected. (old = 'running', new = 'paused')
2025-03-12 17:11:15 (47656): VM state change detected. (old = 'paused', new = 'running')
2025-03-12 17:11:25 (47656): VM state change detected. (old = 'running', new = 'paused')
2025-03-12 17:11:45 (47656): VM state change detected. (old = 'paused', new = 'running')
2025-03-12 17:12:05 (47656): VM state change detected. (old = 'running', new = 'paused')
2025-03-12 17:12:25 (47656): VM state change detected. (old = 'paused', new = 'running')
2025-03-12 17:12:35 (47656): VM state change detected. (old = 'running', new = 'paused')
2025-03-12 17:12:55 (47656): VM state change detected. (old = 'paused', new = 'running')
2025-03-12 17:13:16 (47656): VM state change detected. (old = 'running', new = 'paused')
2025-03-12 17:13:36 (47656): VM state change detected. (old = 'paused', new = 'running')
2025-03-12 17:13:56 (47656): VM state change detected. (old = 'running', new = 'paused')
2025-03-12 17:14:16 (47656): VM state change detected. (old = 'paused', new = 'running')
2025-03-12 17:14:36 (47656): VM state change detected. (old = 'running', new = 'paused')
2025-03-12 17:14:56 (47656): VM state change detected. (old = 'paused', new = 'running')
2025-03-12 17:15:06 (47656): VM state change detected. (old = 'running', new = 'paused')
2025-03-12 17:15:26 (47656): VM state change detected. (old = 'paused', new = 'running')
2025-03-12 17:15:46 (47656): VM state change detected. (old = 'running', new = 'paused')
2025-03-12 17:16:06 (47656): VM state change detected. (old = 'paused', new = 'running')
2025-03-12 17:16:16 (47656): VM state change detected. (old = 'running', new = 'paused')
2025-03-12 17:16:36 (47656): VM state change detected. (old = 'paused', new = 'running')
2025-03-12 17:16:56 (47656): VM state change detected. (old = 'running', new = 'paused')
2025-03-12 17:17:16 (47656): VM state change detected. (old = 'paused', new = 'running')
2025-03-12 17:17:36 (47656): VM state change detected. (old = 'running', new = 'paused')
2025-03-12 17:17:57 (47656): VM state change detected. (old = 'paused', new = 'running')
2025-03-12 17:18:16 (47656): VM state change detected. (old = 'running', new = 'paused')
2025-03-12 17:18:36 (47656): VM state change detected. (old = 'paused', new = 'running')
2025-03-12 17:18:56 (47656): VM state change detected. (old = 'running', new = 'paused')
2025-03-12 17:19:17 (47656): VM state change detected. (old = 'paused', new = 'running')
2025-03-12 17:19:37 (47656): VM state change detected. (old = 'running', new = 'paused')
2025-03-12 17:19:56 (47656): VM state change detected. (old = 'paused', new = 'running')
2025-03-12 17:20:07 (47656): VM state change detected. (old = 'running', new = 'paused')
2025-03-12 17:20:27 (47656): VM state change detected. (old = 'paused', new = 'running')
2025-03-12 17:20:47 (47656): VM state change detected. (old = 'running', new = 'paused')
2025-03-12 17:21:07 (47656): VM state change detected. (old = 'paused', new = 'running')
2025-03-12 17:21:27 (47656): VM state change detected. (old = 'running', new = 'paused')
2025-03-12 17:21:28 (47656): VM state change detected. (old = 'paused', new = 'running')
2025-03-12 17:24:00 (47656): VM state change detected. (old = 'running', new = 'paused')
2025-03-12 17:24:19 (47656): VM state change detected. (old = 'paused', new = 'running')
2025-03-12 17:24:29 (47656): VM state change detected. (old = 'running', new = 'paused')
2025-03-12 17:24:50 (47656): VM state change detected. (old = 'paused', new = 'running')
2025-03-12 17:25:10 (47656): VM state change detected. (old = 'running', new = 'paused')
2025-03-12 17:25:30 (47656): VM state change detected. (old = 'paused', new = 'running')
2025-03-12 17:25:50 (47656): VM state change detected. (old = 'running', new = 'paused')
2025-03-12 17:26:10 (47656): VM state change detected. (old = 'paused', new = 'running')
2025-03-12 17:26:30 (47656): VM state change detected. (old = 'running', new = 'paused')
2025-03-12 17:26:50 (47656): VM state change detected. (old = 'paused', new = 'running')
2025-03-12 17:27:09 (47656): VM state change detected. (old = 'running', new = 'paused')
2025-03-12 17:27:30 (47656): VM state change detected. (old = 'paused', new = 'running')
2025-03-12 17:27:59 (47656): VM state change detected. (old = 'running', new = 'paused')
2025-03-12 17:28:20 (47656): VM state change detected. (old = 'paused', new = 'running')
2025-03-12 17:28:50 (47656): VM state change detected. (old = 'running', new = 'paused')
2025-03-12 17:29:10 (47656): VM state change detected. (old = 'paused', new = 'running')
2025-03-12 17:29:30 (47656): VM state change detected. (old = 'running', new = 'paused')
2025-03-12 17:29:50 (47656): VM state change detected. (old = 'paused', new = 'running')
2025-03-12 17:30:11 (47656): VM state change detected. (old = 'running', new = 'paused')
2025-03-12 17:30:31 (47656): VM state change detected. (old = 'paused', new = 'running')
2025-03-12 17:30:41 (47656): VM state change detected. (old = 'running', new = 'paused')
2025-03-12 17:31:01 (47656): VM state change detected. (old = 'paused', new = 'running')
2025-03-12 17:31:11 (47656): VM state change detected. (old = 'running', new = 'paused')
2025-03-12 17:31:31 (47656): VM state change detected. (old = 'paused', new = 'running')
2025-03-12 17:31:41 (47656): VM state change detected. (old = 'running', new = 'paused')
2025-03-12 17:32:01 (47656): VM state change detected. (old = 'paused', new = 'running')
2025-03-12 17:32:21 (47656): VM state change detected. (old = 'running', new = 'paused')
2025-03-12 17:32:41 (47656): VM state change detected. (old = 'paused', new = 'running')
2025-03-12 17:32:51 (47656): VM state change detected. (old = 'running', new = 'paused')
2025-03-12 17:33:11 (47656): VM state change detected. (old = 'paused', new = 'running')
2025-03-12 17:33:21 (47656): VM state change detected. (old = 'running', new = 'paused')
2025-03-12 17:33:41 (47656): VM state change detected. (old = 'paused', new = 'running')
2025-03-12 17:33:51 (47656): VM state change detected. (old = 'running', new = 'paused')
2025-03-12 17:34:11 (47656): VM state change detected. (old = 'paused', new = 'running')
2025-03-12 17:34:21 (47656): VM state change detected. (old = 'running', new = 'paused')
2025-03-12 17:34:41 (47656): VM state change detected. (old = 'paused', new = 'running')
2025-03-12 17:34:51 (47656): VM state change detected. (old = 'running', new = 'paused')
2025-03-12 17:35:11 (47656): VM state change detected. (old = 'paused', new = 'running')
2025-03-12 17:35:21 (47656): VM state change detected. (old = 'running', new = 'paused')
2025-03-12 17:35:41 (47656): VM state change detected. (old = 'paused', new = 'running')
2025-03-12 17:35:51 (47656): VM state change detected. (old = 'running', new = 'paused')
2025-03-12 17:36:11 (47656): VM state change detected. (old = 'paused', new = 'running')
2025-03-12 17:36:21 (47656): VM state change detected. (old = 'running', new = 'paused')
2025-03-12 17:36:41 (47656): VM state change detected. (old = 'paused', new = 'running')
2025-03-12 17:36:51 (47656): VM state change detected. (old = 'running', new = 'paused')
2025-03-12 17:37:11 (47656): VM state change detected. (old = 'paused', new = 'running')
2025-03-12 17:37:21 (47656): VM state change detected. (old = 'running', new = 'paused')
2025-03-12 17:37:41 (47656): VM state change detected. (old = 'paused', new = 'running')
2025-03-12 17:37:51 (47656): VM state change detected. (old = 'running', new = 'paused')
2025-03-12 17:38:11 (47656): VM state change detected. (old = 'paused', new = 'running')
2025-03-12 17:38:21 (47656): VM state change detected. (old = 'running', new = 'paused')
2025-03-12 17:39:01 (47656): VM state change detected. (old = 'paused', new = 'running')
2025-03-12 17:39:12 (47656): VM state change detected. (old = 'running', new = 'paused')
2025-03-12 17:39:32 (47656): VM state change detected. (old = 'paused', new = 'running')
2025-03-12 17:39:42 (47656): VM state change detected. (old = 'running', new = 'paused')
2025-03-12 17:40:02 (47656): VM state change detected. (old = 'paused', new = 'running')
2025-03-12 17:40:12 (47656): VM state change detected. (old = 'running', new = 'paused')
2025-03-12 17:40:32 (47656): VM state change detected. (old = 'paused', new = 'running')
2025-03-12 17:40:42 (47656): VM state change detected. (old = 'running', new = 'paused')
2025-03-12 17:41:02 (47656): VM state change detected. (old = 'paused', new = 'running')
2025-03-12 17:41:12 (47656): VM state change detected. (old = 'running', new = 'paused')
2025-03-12 17:41:32 (47656): VM state change detected. (old = 'paused', new = 'running')
2025-03-12 17:41:52 (47656): VM state change detected. (old = 'running', new = 'paused')
2025-03-12 17:42:12 (47656): VM state change detected. (old = 'paused', new = 'running')
2025-03-12 17:42:22 (47656): VM state change detected. (old = 'running', new = 'paused')
2025-03-12 17:42:42 (47656): VM state change detected. (old = 'paused', new = 'running')
2025-03-12 17:42:52 (47656): VM state change detected. (old = 'running', new = 'paused')
2025-03-12 17:43:12 (47656): VM state change detected. (old = 'paused', new = 'running')
2025-03-12 17:43:22 (47656): VM state change detected. (old = 'running', new = 'paused')
2025-03-12 17:43:42 (47656): VM state change detected. (old = 'paused', new = 'running')
2025-03-12 17:43:52 (47656): VM state change detected. (old = 'running', new = 'paused')
2025-03-12 17:44:12 (47656): VM state change detected. (old = 'paused', new = 'running')
2025-03-12 17:44:23 (47656): VM state change detected. (old = 'running', new = 'paused')
2025-03-12 17:44:43 (47656): VM state change detected. (old = 'paused', new = 'running')
2025-03-12 17:44:53 (47656): VM state change detected. (old = 'running', new = 'paused')
2025-03-12 17:45:13 (47656): VM state change detected. (old = 'paused', new = 'running')
2025-03-12 17:45:23 (47656): VM state change detected. (old = 'running', new = 'paused')
2025-03-12 17:45:43 (47656): VM state change detected. (old = 'paused', new = 'running')
2025-03-12 17:45:53 (47656): VM state change detected. (old = 'running', new = 'paused')
2025-03-12 17:46:13 (47656): VM state change detected. (old = 'paused', new = 'running')
2025-03-12 17:46:23 (47656): VM state change detected. (old = 'running', new = 'paused')
2025-03-12 17:46:43 (47656): VM state change detected. (old = 'paused', new = 'running')
2025-03-12 17:46:53 (47656): VM state change detected. (old = 'running', new = 'paused')
2025-03-12 17:47:14 (47656): VM state change detected. (old = 'paused', new = 'running')
2025-03-12 17:47:23 (47656): VM state change detected. (old = 'running', new = 'paused')
2025-03-12 17:47:43 (47656): VM state change detected. (old = 'paused', new = 'running')
2025-03-12 17:47:53 (47656): VM state change detected. (old = 'running', new = 'paused')
2025-03-12 17:48:13 (47656): VM state change detected. (old = 'paused', new = 'running')
2025-03-12 17:48:23 (47656): VM state change detected. (old = 'running', new = 'paused')
2025-03-12 17:48:43 (47656): VM state change detected. (old = 'paused', new = 'running')
2025-03-12 17:48:53 (47656): VM state change detected. (old = 'running', new = 'paused')
2025-03-12 17:49:13 (47656): VM state change detected. (old = 'paused', new = 'running')
2025-03-12 17:49:23 (47656): VM state change detected. (old = 'running', new = 'paused')
2025-03-12 17:49:43 (47656): VM state change detected. (old = 'paused', new = 'running')
2025-03-12 17:49:53 (47656): VM state change detected. (old = 'running', new = 'paused')
2025-03-12 17:50:13 (47656): VM state change detected. (old = 'paused', new = 'running')
2025-03-12 17:50:23 (47656): VM state change detected. (old = 'running', new = 'paused')
2025-03-12 17:50:43 (47656): VM state change detected. (old = 'paused', new = 'running')
2025-03-12 17:50:53 (47656): VM state change detected. (old = 'running', new = 'paused')
2025-03-12 17:51:13 (47656): VM state change detected. (old = 'paused', new = 'running')
2025-03-12 17:51:23 (47656): VM state change detected. (old = 'running', new = 'paused')
2025-03-12 17:51:43 (47656): VM state change detected. (old = 'paused', new = 'running')
2025-03-12 17:51:54 (47656): VM state change detected. (old = 'running', new = 'paused')
2025-03-12 17:52:14 (47656): VM state change detected. (old = 'paused', new = 'running')
2025-03-12 17:52:24 (47656): VM state change detected. (old = 'running', new = 'paused')
2025-03-12 17:52:44 (47656): VM state change detected. (old = 'paused', new = 'running')
2025-03-12 17:52:54 (47656): VM state change detected. (old = 'running', new = 'paused')
2025-03-12 17:53:14 (47656): VM state change detected. (old = 'paused', new = 'running')
2025-03-12 17:53:24 (47656): VM state change detected. (old = 'running', new = 'paused')
2025-03-12 17:53:44 (47656): VM state change detected. (old = 'paused', new = 'running')
2025-03-12 17:53:54 (47656): VM state change detected. (old = 'running', new = 'paused')
2025-03-12 17:54:14 (47656): VM state change detected. (old = 'paused', new = 'running')
2025-03-12 17:54:24 (47656): VM state change detected. (old = 'running', new = 'paused')
2025-03-12 17:54:44 (47656): VM state change detected. (old = 'paused', new = 'running')
2025-03-12 17:54:54 (47656): VM state change detected. (old = 'running', new = 'paused')
2025-03-12 17:55:14 (47656): VM state change detected. (old = 'paused', new = 'running')
2025-03-12 17:55:24 (47656): VM state change detected. (old = 'running', new = 'paused')
2025-03-12 17:55:44 (47656): VM state change detected. (old = 'paused', new = 'running')
2025-03-12 17:55:54 (47656): VM state change detected. (old = 'running', new = 'paused')
2025-03-12 17:56:14 (47656): VM state change detected. (old = 'paused', new = 'running')
2025-03-12 17:56:19 (47656): Stopping VM.
2025-03-12 17:56:41 (47656): Successfully stopped VM.
2025-03-12 18:01:34 (44528): vboxwrapper version 26208
2025-03-12 18:01:34 (44528): BOINC client version: 8.0.2
2025-03-12 18:01:38 (44528): Detected: VirtualBox VboxManage Interface (Version: 7.0.6)
2025-03-12 18:01:39 (44528): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2025-03-12 18:01:39 (44528): Guest Log: BIOS: VirtualBox 7.0.6
2025-03-12 18:01:39 (44528): Guest Log: CPUID EDX: 0x178bfbff
2025-03-12 18:01:39 (44528): Guest Log: BIOS: No PCI IDE controller, not probing IDE
2025-03-12 18:01:39 (44528): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors
2025-03-12 18:01:39 (44528): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2025-03-12 18:01:39 (44528): Guest Log: BIOS: Booting from Hard Disk...
2025-03-12 18:01:39 (44528): Guest Log: BIOS: KBD: unsupported int 16h function 03
2025-03-12 18:01:39 (44528): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000
2025-03-12 18:01:39 (44528): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2025-03-12 18:01:39 (44528): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)
2025-03-12 18:01:39 (44528): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log
2025-03-12 18:01:39 (44528): Guest Log: 00:00:00.000945 main Log opened 2025-03-12T20:36:23.499931000Z
2025-03-12 18:01:39 (44528): Guest Log: 00:00:00.001369 main OS Product: Linux
2025-03-12 18:01:39 (44528): Guest Log: 00:00:00.001468 main OS Release: 4.14.232-19.cernvm.x86_64
2025-03-12 18:01:39 (44528): Guest Log: 00:00:00.001548 main OS Version: #1 SMP Fri Apr 30 17:12:25 CEST 2021
2025-03-12 18:01:39 (44528): Guest Log: 00:00:00.001630 main Executable: /usr/sbin/VBoxService
2025-03-12 18:01:39 (44528): Guest Log: 00:00:00.001632 main Process ID: 2289
2025-03-12 18:01:39 (44528): Guest Log: 00:00:00.001632 main Package type: LINUX_64BITS_GENERIC
2025-03-12 18:01:39 (44528): Guest Log: 00:00:00.002860 main 5.2.6 r120293 started. Verbose level = 0
2025-03-12 18:01:39 (44528): Guest Log: [INFO] Mounting the shared directory
2025-03-12 18:01:39 (44528): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor
2025-03-12 18:01:39 (44528): Guest Log: [INFO] Sourcing essential functions from /cvmfs/grid.cern.ch
2025-03-12 18:01:39 (44528): Guest Log: [INFO] Testing connection to cern.ch
2025-03-12 18:01:39 (44528): Guest Log: [INFO] Testing connection to VCCS
2025-03-12 18:01:39 (44528): Guest Log: [INFO] Testing connection to HTCondor
2025-03-12 18:01:39 (44528): Guest Log: [INFO] Testing connection to WMAgent
2025-03-12 18:01:39 (44528): Guest Log: [INFO] Testing connection to EOSCMS
2025-03-12 18:01:39 (44528): Guest Log: [INFO] Testing connection to CMS-Factory
2025-03-12 18:01:39 (44528): Guest Log: [INFO] Testing connection to CMS-Frontier
2025-03-12 18:01:39 (44528): Guest Log: [INFO] Testing connection to Frontier
2025-03-12 18:01:39 (44528): Guest Log: [INFO] Could not find a local HTTP proxy
2025-03-12 18:01:39 (44528): Guest Log: [INFO] CVMFS and Frontier will have to use DIRECT connections
2025-03-12 18:01:39 (44528): Guest Log: [INFO] This makes the application less efficient
2025-03-12 18:01:39 (44528): Guest Log: [INFO] It also puts higher load on the project servers
2025-03-12 18:01:39 (44528): Guest Log: [INFO] Setting up a local HTTP proxy is highly recommended
2025-03-12 18:01:39 (44528): Guest Log: [INFO] Advice can be found in the project forum
2025-03-12 18:01:39 (44528): Guest Log: [INFO] Reloading and probing the CVMFS configuration
2025-03-12 18:01:39 (44528): Guest Log: [INFO] Probing /cvmfs/grid.cern.ch... OK
2025-03-12 18:01:39 (44528): Guest Log: [INFO] Probing /cvmfs/cms-ib.cern.ch... OK
2025-03-12 18:01:39 (44528): Guest Log: [INFO] Probing /cvmfs/singularity.opensciencegrid.org... OK
2025-03-12 18:01:39 (44528): Guest Log: [INFO] Probing /cvmfs/oasis.opensciencegrid.org... OK
2025-03-12 18:01:39 (44528): Guest Log: [INFO] Probing /cvmfs/cms.cern.ch... OK
2025-03-12 18:01:39 (44528): Guest Log: [INFO] Excerpt from "cvmfs_config stat": VERSION HOST PROXY
2025-03-12 18:01:39 (44528): Guest Log: [INFO] 2.7.2.0 http://s1ral-cvmfs.openhtc.io DIRECT
2025-03-12 18:01:39 (44528): Guest Log: [INFO] Environment HTTP proxy: not set
2025-03-12 18:01:39 (44528): Guest Log: [INFO] Reading volunteer information
2025-03-12 18:01:39 (44528): Guest Log: [INFO] Requesting an X509 credential from LHC@home
2025-03-12 18:01:39 (44528): Guest Log: [INFO] Requesting an idtoken from LHC@home
2025-03-12 18:01:39 (44528): Guest Log: [INFO] CMS application starting. Check log files.
2025-03-12 18:01:39 (44528): Starting VM using VBoxManage interface. (boinc_64ac692c5d3e9bbf, slot#0)
2025-03-12 18:01:58 (44528): Successfully started VM. (PID = '44608')
2025-03-12 18:01:58 (44528): Reporting VM Process ID to BOINC.
2025-03-12 18:01:58 (44528): VM state change detected. (old = 'poweredoff', new = 'running')
2025-03-12 18:01:58 (44528): Detected: Web Application Enabled (http://localhost:64555)
2025-03-12 18:01:58 (44528): Preference change detected
2025-03-12 18:01:58 (44528): Setting CPU throttle for VM. (80%)
2025-03-12 18:01:59 (44528): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2025-03-12 18:02:09 (44528): VM state change detected. (old = 'running', new = 'paused')
2025-03-12 18:02:10 (44528): VM state change detected. (old = 'paused', new = 'running')
2025-03-12 18:03:09 (44528): VM state change detected. (old = 'running', new = 'paused')
2025-03-12 18:03:29 (44528): VM state change detected. (old = 'paused', new = 'running')
2025-03-12 18:03:39 (44528): VM state change detected. (old = 'running', new = 'paused')
2025-03-12 18:03:59 (44528): VM state change detected. (old = 'paused', new = 'running')
2025-03-12 18:04:09 (44528): VM state change detected. (old = 'running', new = 'paused')
2025-03-12 18:04:29 (44528): VM state change detected. (old = 'paused', new = 'running')
2025-03-12 18:04:39 (44528): VM state change detected. (old = 'running', new = 'paused')
2025-03-12 18:04:59 (44528): VM state change detected. (old = 'paused', new = 'running')
2025-03-12 18:05:09 (44528): VM state change detected. (old = 'running', new = 'paused')
2025-03-12 18:05:29 (44528): VM state change detected. (old = 'paused', new = 'running')
2025-03-12 18:05:39 (44528): VM state change detected. (old = 'running', new = 'paused')
2025-03-12 18:05:59 (44528): VM state change detected. (old = 'paused', new = 'running')
2025-03-12 18:06:09 (44528): VM state change detected. (old = 'running', new = 'paused')
2025-03-12 18:06:29 (44528): VM state change detected. (old = 'paused', new = 'running')
2025-03-12 18:06:39 (44528): VM state change detected. (old = 'running', new = 'paused')
2025-03-12 18:06:59 (44528): VM state change detected. (old = 'paused', new = 'running')
2025-03-12 18:07:09 (44528): VM state change detected. (old = 'running', new = 'paused')
2025-03-12 18:07:29 (44528): VM state change detected. (old = 'paused', new = 'running')
2025-03-12 18:07:39 (44528): VM state change detected. (old = 'running', new = 'paused')
2025-03-12 18:07:59 (44528): VM state change detected. (old = 'paused', new = 'running')
2025-03-12 18:08:09 (44528): VM state change detected. (old = 'running', new = 'paused')
2025-03-12 18:08:29 (44528): VM state change detected. (old = 'paused', new = 'running')
2025-03-12 18:08:40 (44528): VM state change detected. (old = 'running', new = 'paused')
2025-03-12 18:09:00 (44528): VM state change detected. (old = 'paused', new = 'running')
2025-03-12 18:09:10 (44528): VM state change detected. (old = 'running', new = 'paused')
2025-03-12 18:09:30 (44528): VM state change detected. (old = 'paused', new = 'running')
2025-03-12 18:09:40 (44528): VM state change detected. (old = 'running', new = 'paused')
2025-03-12 18:10:00 (44528): VM state change detected. (old = 'paused', new = 'running')
2025-03-12 18:10:10 (44528): VM state change detected. (old = 'running', new = 'paused')
2025-03-12 18:10:30 (44528): VM state change detected. (old = 'paused', new = 'running')
2025-03-12 18:10:40 (44528): VM state change detected. (old = 'running', new = 'paused')
2025-03-12 18:11:00 (44528): VM state change detected. (old = 'paused', new = 'running')
2025-03-12 18:11:10 (44528): VM state change detected. (old = 'running', new = 'paused')
2025-03-12 18:18:06 (44528): VM state change detected. (old = 'paused', new = 'running')
2025-03-12 18:18:21 (44528): VM state change detected. (old = 'running', new = 'paused')
2025-03-12 18:18:41 (44528): VM state change detected. (old = 'paused', new = 'running')
2025-03-12 18:19:02 (44528): VM state change detected. (old = 'running', new = 'paused')
2025-03-12 18:19:21 (44528): VM state change detected. (old = 'paused', new = 'running')
2025-03-12 18:19:31 (44528): VM state change detected. (old = 'running', new = 'paused')
2025-03-12 18:19:51 (44528): VM state change detected. (old = 'paused', new = 'running')
2025-03-12 18:20:01 (44528): VM state change detected. (old = 'running', new = 'paused')
2025-03-12 18:20:21 (44528): VM state change detected. (old = 'paused', new = 'running')
2025-03-12 18:20:31 (44528): VM state change detected. (old = 'running', new = 'paused')
2025-03-12 18:20:51 (44528): VM state change detected. (old = 'paused', new = 'running')
2025-03-12 18:21:01 (44528): VM state change detected. (old = 'running', new = 'paused')
2025-03-12 18:21:21 (44528): VM state change detected. (old = 'paused', new = 'running')
2025-03-12 18:21:31 (44528): VM state change detected. (old = 'running', new = 'paused')
2025-03-12 18:21:51 (44528): VM state change detected. (old = 'paused', new = 'running')
2025-03-12 18:22:01 (44528): VM state change detected. (old = 'running', new = 'paused')
2025-03-12 18:22:21 (44528): VM state change detected. (old = 'paused', new = 'running')
2025-03-12 18:22:31 (44528): VM state change detected. (old = 'running', new = 'paused')
2025-03-12 18:22:51 (44528): VM state change detected. (old = 'paused', new = 'running')
2025-03-12 18:23:01 (44528): VM state change detected. (old = 'running', new = 'paused')
2025-03-12 18:23:22 (44528): VM state change detected. (old = 'paused', new = 'running')
2025-03-12 18:23:32 (44528): VM state change detected. (old = 'running', new = 'paused')
2025-03-12 18:23:52 (44528): VM state change detected. (old = 'paused', new = 'running')
2025-03-12 18:24:02 (44528): VM state change detected. (old = 'running', new = 'paused')
2025-03-12 18:24:22 (44528): VM state change detected. (old = 'paused', new = 'running')
2025-03-12 18:24:33 (44528): VM state change detected. (old = 'running', new = 'paused')
2025-03-12 18:24:53 (44528): VM state change detected. (old = 'paused', new = 'running')
2025-03-12 18:25:03 (44528): VM state change detected. (old = 'running', new = 'paused')
2025-03-12 18:25:23 (44528): VM state change detected. (old = 'paused', new = 'running')
2025-03-12 18:25:33 (44528): VM state change detected. (old = 'running', new = 'paused')
2025-03-12 18:31:00 (44528): VM state change detected. (old = 'paused', new = 'running')
2025-03-12 18:31:13 (44528): VM state change detected. (old = 'running', new = 'paused')
2025-03-12 18:31:33 (44528): VM state change detected. (old = 'paused', new = 'running')
2025-03-12 18:31:43 (44528): VM state change detected. (old = 'running', new = 'paused')
2025-03-12 18:32:03 (44528): VM state change detected. (old = 'paused', new = 'running')
2025-03-12 18:32:13 (44528): VM state change detected. (old = 'running', new = 'paused')
2025-03-12 18:32:33 (44528): VM state change detected. (old = 'paused', new = 'running')
2025-03-12 18:32:43 (44528): VM state change detected. (old = 'running', new = 'paused')
2025-03-12 18:33:03 (44528): VM state change detected. (old = 'paused', new = 'running')
2025-03-12 18:33:13 (44528): VM state change detected. (old = 'running', new = 'paused')
2025-03-12 18:33:33 (44528): VM state change detected. (old = 'paused', new = 'running')
2025-03-12 18:33:43 (44528): VM state change detected. (old = 'running', new = 'paused')
2025-03-12 18:34:03 (44528): VM state change detected. (old = 'paused', new = 'running')
2025-03-12 18:34:13 (44528): VM state change detected. (old = 'running', new = 'paused')
2025-03-12 18:34:33 (44528): VM state change detected. (old = 'paused', new = 'running')
2025-03-12 18:34:43 (44528): VM state change detected. (old = 'running', new = 'paused')
2025-03-12 18:35:03 (44528): VM state change detected. (old = 'paused', new = 'running')
2025-03-12 18:35:14 (44528): VM state change detected. (old = 'running', new = 'paused')
2025-03-12 18:35:34 (44528): VM state change detected. (old = 'paused', new = 'running')
2025-03-12 18:35:54 (44528): VM state change detected. (old = 'running', new = 'paused')
2025-03-12 18:36:14 (44528): VM state change detected. (old = 'paused', new = 'running')
2025-03-12 18:36:34 (44528): VM state change detected. (old = 'running', new = 'paused')
2025-03-12 18:36:54 (44528): VM state change detected. (old = 'paused', new = 'running')
2025-03-12 18:37:14 (44528): VM state change detected. (old = 'running', new = 'paused')
2025-03-12 18:40:33 (44528): VM state change detected. (old = 'paused', new = 'running')
2025-03-12 18:40:44 (44528): VM state change detected. (old = 'running', new = 'paused')
2025-03-12 18:40:45 (44528): VM state change detected. (old = 'paused', new = 'running')
2025-03-12 19:21:42 (44528): VM state change detected. (old = 'running', new = 'paused')
2025-03-12 19:22:02 (44528): VM state change detected. (old = 'paused', new = 'running')
2025-03-12 19:22:13 (44528): VM state change detected. (old = 'running', new = 'paused')
2025-03-12 19:22:34 (44528): VM state change detected. (old = 'paused', new = 'running')
2025-03-12 19:22:44 (44528): VM state change detected. (old = 'running', new = 'paused')
2025-03-12 19:23:04 (44528): VM state change detected. (old = 'paused', new = 'running')
2025-03-12 19:23:14 (44528): VM state change detected. (old = 'running', new = 'paused')
2025-03-12 19:23:34 (44528): VM state change detected. (old = 'paused', new = 'running')
2025-03-12 19:23:44 (44528): VM state change detected. (old = 'running', new = 'paused')
2025-03-12 19:24:04 (44528): VM state change detected. (old = 'paused', new = 'running')
2025-03-12 19:24:14 (44528): VM state change detected. (old = 'running', new = 'paused')
2025-03-12 19:24:34 (44528): VM state change detected. (old = 'paused', new = 'running')
2025-03-12 19:24:44 (44528): VM state change detected. (old = 'running', new = 'paused')
2025-03-12 19:25:04 (44528): VM state change detected. (old = 'paused', new = 'running')
2025-03-12 19:25:14 (44528): VM state change detected. (old = 'running', new = 'paused')
2025-03-12 19:25:34 (44528): VM state change detected. (old = 'paused', new = 'running')
2025-03-12 19:25:44 (44528): VM state change detected. (old = 'running', new = 'paused')
2025-03-12 19:26:04 (44528): VM state change detected. (old = 'paused', new = 'running')
2025-03-12 19:26:14 (44528): VM state change detected. (old = 'running', new = 'paused')
2025-03-12 19:26:34 (44528): VM state change detected. (old = 'paused', new = 'running')
2025-03-12 19:26:44 (44528): VM state change detected. (old = 'running', new = 'paused')
2025-03-12 19:27:04 (44528): VM state change detected. (old = 'paused', new = 'running')
2025-03-12 19:27:14 (44528): VM state change detected. (old = 'running', new = 'paused')
2025-03-12 19:27:34 (44528): VM state change detected. (old = 'paused', new = 'running')
2025-03-12 19:27:44 (44528): VM state change detected. (old = 'running', new = 'paused')
2025-03-12 19:28:04 (44528): VM state change detected. (old = 'paused', new = 'running')
2025-03-12 19:28:14 (44528): VM state change detected. (old = 'running', new = 'paused')
2025-03-12 19:28:34 (44528): VM state change detected. (old = 'paused', new = 'running')
2025-03-12 19:28:44 (44528): VM state change detected. (old = 'running', new = 'paused')
2025-03-12 19:29:04 (44528): VM state change detected. (old = 'paused', new = 'running')
2025-03-12 19:29:14 (44528): VM state change detected. (old = 'running', new = 'paused')
2025-03-12 19:29:34 (44528): VM state change detected. (old = 'paused', new = 'running')
2025-03-12 19:29:44 (44528): VM state change detected. (old = 'running', new = 'paused')
2025-03-12 19:30:05 (44528): VM state change detected. (old = 'paused', new = 'running')
2025-03-12 19:30:15 (44528): VM state change detected. (old = 'running', new = 'paused')
2025-03-12 19:30:35 (44528): VM state change detected. (old = 'paused', new = 'running')
2025-03-12 19:30:45 (44528): VM state change detected. (old = 'running', new = 'paused')
2025-03-12 19:31:05 (44528): VM state change detected. (old = 'paused', new = 'running')
2025-03-12 19:31:15 (44528): VM state change detected. (old = 'running', new = 'paused')
2025-03-12 19:31:35 (44528): VM state change detected. (old = 'paused', new = 'running')
2025-03-12 19:31:45 (44528): VM state change detected. (old = 'running', new = 'paused')
2025-03-12 19:32:05 (44528): VM state change detected. (old = 'paused', new = 'running')
2025-03-12 19:32:25 (44528): VM state change detected. (old = 'running', new = 'paused')
2025-03-12 19:32:45 (44528): VM state change detected. (old = 'paused', new = 'running')
2025-03-12 19:32:55 (44528): VM state change detected. (old = 'running', new = 'paused')
2025-03-12 19:33:15 (44528): VM state change detected. (old = 'paused', new = 'running')
2025-03-12 19:33:25 (44528): VM state change detected. (old = 'running', new = 'paused')
2025-03-12 19:33:45 (44528): VM state change detected. (old = 'paused', new = 'running')
2025-03-12 19:33:56 (44528): VM state change detected. (old = 'running', new = 'paused')
2025-03-12 19:34:16 (44528): VM state change detected. (old = 'paused', new = 'running')
2025-03-12 19:34:26 (44528): VM state change detected. (old = 'running', new = 'paused')
2025-03-12 19:34:46 (44528): VM state change detected. (old = 'paused', new = 'running')
2025-03-12 19:34:56 (44528): VM state change detected. (old = 'running', new = 'paused')
2025-03-12 19:35:16 (44528): VM state change detected. (old = 'paused', new = 'running')
2025-03-12 19:35:26 (44528): VM state change detected. (old = 'running', new = 'paused')
2025-03-12 19:35:46 (44528): VM state change detected. (old = 'paused', new = 'running')
2025-03-12 19:35:56 (44528): VM state change detected. (old = 'running', new = 'paused')
2025-03-12 19:36:17 (44528): VM state change detected. (old = 'paused', new = 'running')
2025-03-12 19:36:36 (44528): VM state change detected. (old = 'running', new = 'paused')
2025-03-12 19:36:56 (44528): VM state change detected. (old = 'paused', new = 'running')
2025-03-12 19:36:59 (44528): Stopping VM.
2025-03-12 19:37:18 (44528): Successfully stopped VM.
2025-03-12 19:42:05 (10196): vboxwrapper version 26208
2025-03-12 19:42:05 (10196): BOINC client version: 8.0.2
2025-03-12 19:42:07 (10196): Detected: VirtualBox VboxManage Interface (Version: 7.0.6)
2025-03-12 19:42:07 (10196): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2025-03-12 19:42:07 (10196): Starting VM using VBoxManage interface. (boinc_64ac692c5d3e9bbf, slot#0)
2025-03-12 19:42:15 (10196): Error in start VM for VM: -2147467259
Command:
VBoxManage -q startvm "boinc_64ac692c5d3e9bbf" --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_64ac692c5d3e9bbf" to power on...
2025-03-12 19:42:15 (10196): VM failed to start.
2025-03-12 19:42:15 (10196): Could not start
2025-03-12 19:42:15 (10196): ERROR: VM failed to start
2025-03-12 19:42:15 (10196): Powering off VM.
2025-03-12 19:42:15 (10196): Deregistering VM. (boinc_64ac692c5d3e9bbf, slot#0)
2025-03-12 19:42:15 (10196): Removing network bandwidth throttle group from VM.
2025-03-12 19:42:16 (10196): Removing VM from VirtualBox.
Hypervisor System Log:
00:00:09.343682 Saving settings file "D:\data\BOINC\slots\17\boinc_041a8f4e76730c9a\boinc_041a8f4e76730c9a.vbox" with version "1.19-windows"
00:00:09.349353 ERROR [COM]: aRC=VBOX_E_OBJECT_NOT_FOUND (0x80bb0001) aIID={ad47ad09-787b-44ab-b343-a082a3f2dfb1} aComponent={MediumWrap} aText={Property 'CRYPT/KeyId' does not exist}, preserve=false aResultDetail=0
00:00:09.350332 ERROR [COM]: aRC=VBOX_E_OBJECT_NOT_FOUND (0x80bb0001) aIID={ad47ad09-787b-44ab-b343-a082a3f2dfb1} aComponent={MediumWrap} aText={Property 'CRYPT/KeyId' does not exist}, preserve=false aResultDetail=0
00:00:09.424178 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:09.424438 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:09.424698 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:09.428629 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:09.433472 Finished saving settings file "D:\data\BOINC\slots\17\boinc_041a8f4e76730c9a\boinc_041a8f4e76730c9a.vbox"
00:00:09.574061 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:09.574476 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:09.574859 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:09.580127 Saving settings file "D:\data\BOINC\slots\0\boinc_64ac692c5d3e9bbf\boinc_64ac692c5d3e9bbf.vbox" with version "1.19-windows"
00:00:09.636907 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:09.637174 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:09.637466 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:10.160278 Finished saving settings file "D:\data\BOINC\slots\0\boinc_64ac692c5d3e9bbf\boinc_64ac692c5d3e9bbf.vbox"
00:00:10.160956 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:10.161041 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:10.161084 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:10.161434 Saving settings file "C:\Users\Mark\.VirtualBox\VirtualBox.xml" with version "1.12-windows"
00:00:10.164824 Finished saving settings file "C:\Users\Mark\.VirtualBox\VirtualBox.xml"
00:00:10.165666 DeleteVM 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:10.165738 DeleteVM 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:10.165780 DeleteVM 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:10.166166 DeleteVM Saving settings file "D:\data\BOINC\slots\16\boinc_f7e848dca832b2ae\boinc_f7e848dca832b2ae.vbox" with version "1.19-windows"
00:00:10.240554 DeleteVM Finished saving settings file "D:\data\BOINC\slots\16\boinc_f7e848dca832b2ae\boinc_f7e848dca832b2ae.vbox"
00:00:10.298859 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:10.298946 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:10.299010 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:10.299470 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:10.299523 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:10.299572 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:10.299683 Saving settings file "C:\Users\Mark\.VirtualBox\VirtualBox.xml" with version "1.12-windows"
00:00:10.303025 Finished saving settings file "C:\Users\Mark\.VirtualBox\VirtualBox.xml"
00:00:10.303130 Saving settings file "C:\Users\Mark\.VirtualBox\VirtualBox.xml" with version "1.12-windows"
00:00:10.306075 Finished saving settings file "C:\Users\Mark\.VirtualBox\VirtualBox.xml"
00:00:10.306938 DeleteVM Saving settings file "C:\Users\Mark\.VirtualBox\VirtualBox.xml" with version "1.12-windows"
00:00:10.309825 DeleteVM Finished saving settings file "C:\Users\Mark\.VirtualBox\VirtualBox.xml"
00:00:10.542341 Saving settings file "D:\data\BOINC\slots\16\boinc_f7e848dca832b2ae\boinc_f7e848dca832b2ae.vbox" with version "1.19-windows"
00:00:10.610217 Finished saving settings file "D:\data\BOINC\slots\16\boinc_f7e848dca832b2ae\boinc_f7e848dca832b2ae.vbox"
00:00:11.744644 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:11.744850 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:11.744997 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:11.749612 Saving settings file "D:\data\BOINC\slots\16\boinc_f7e848dca832b2ae\boinc_f7e848dca832b2ae.vbox" with version "1.19-windows"
00:00:11.850277 Finished saving settings file "D:\data\BOINC\slots\16\boinc_f7e848dca832b2ae\boinc_f7e848dca832b2ae.vbox"
VM Execution Log:
VM Startup Log:
VM Trace Log:
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\Mark\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-03-12 19:42:07 (10196):
Command: VBoxManage -q list hostinfo
Exit Code: 0
Output:
Host Information:
Host time: 2025-03-12T23:42:07.239000000Z
Processor online count: 16
Processor count: 16
Processor online core count: 8
Processor core count: 8
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: yes
Processor#0 speed: unknown
Processor#0 description: AMD Ryzen 7 3700X 8-Core Processor
Processor#1 speed: unknown
Processor#1 description: AMD Ryzen 7 3700X 8-Core Processor
Processor#2 speed: unknown
Processor#2 description: AMD Ryzen 7 3700X 8-Core Processor
Processor#3 speed: unknown
Processor#3 description: AMD Ryzen 7 3700X 8-Core Processor
Processor#4 speed: unknown
Processor#4 description: AMD Ryzen 7 3700X 8-Core Processor
Processor#5 speed: unknown
Processor#5 description: AMD Ryzen 7 3700X 8-Core Processor
Processor#6 speed: unknown
Processor#6 description: AMD Ryzen 7 3700X 8-Core Processor
Processor#7 speed: unknown
Processor#7 description: AMD Ryzen 7 3700X 8-Core Processor
Processor#8 speed: unknown
Processor#8 description: AMD Ryzen 7 3700X 8-Core Processor
Processor#9 speed: unknown
Processor#9 description: AMD Ryzen 7 3700X 8-Core Processor
Processor#10 speed: unknown
Processor#10 description: AMD Ryzen 7 3700X 8-Core Processor
Processor#11 speed: unknown
Processor#11 description: AMD Ryzen 7 3700X 8-Core Processor
Processor#12 speed: unknown
Processor#12 description: AMD Ryzen 7 3700X 8-Core Processor
Processor#13 speed: unknown
Processor#13 description: AMD Ryzen 7 3700X 8-Core Processor
Processor#14 speed: unknown
Processor#14 description: AMD Ryzen 7 3700X 8-Core Processor
Processor#15 speed: unknown
Processor#15 description: AMD Ryzen 7 3700X 8-Core Processor
Memory size: 32702 MByte
Memory available: 19277 MByte
Operating system: Windows 10
Operating system version: 10.0.19045
2025-03-12 19:42:07 (10196):
Command: VBoxManage -q showvminfo "boinc_64ac692c5d3e9bbf" --machinereadable
Exit Code: 0
Output:
name="boinc_64ac692c5d3e9bbf"
Encryption: disabled
groups="/"
ostype="Linux 2.6 / 3.x / 4.x / 5.x (64-bit)"
UUID="ae66f59e-aa39-479d-aecb-88e7115579a4"
CfgFile="D:\\data\\BOINC\\slots\\0\\boinc_64ac692c5d3e9bbf\\boinc_64ac692c5d3e9bbf.vbox"
SnapFldr="D:\\data\\BOINC\\slots\\0\\boinc_64ac692c5d3e9bbf\\Snapshots"
LogFldr="D:\\data\\BOINC\\slots\\0\\boinc_64ac692c5d3e9bbf\\Logs"
hardwareuuid="ae66f59e-aa39-479d-aecb-88e7115579a4"
memory=4584
pagefusion="off"
vram=16
cpuexecutioncap=80
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="D:\\data\\BOINC\\slots\\0\\boinc_64ac692c5d3e9bbf\\boinc_64ac692c5d3e9bbf.nvram"
rtcuseutc="off"
hwvirtex="on"
nestedpaging="on"
largepages="on"
vtxvpid="on"
vtxux="on"
virtvmsavevmload="on"
iommu="none"
paravirtprovider="default"
effparavirtprovider="kvm"
VMState="saved"
VMStateChangeTime="2025-03-12T23:37:16.000000000"
VMStateFile="D:\data\BOINC\slots\0\boinc_64ac692c5d3e9bbf\Snapshots\2025-03-12T23-37-00-585573600Z.sav"
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"="D:\\data\\BOINC\\slots\\0\\boinc_64ac692c5d3e9bbf\\Snapshots/{d4f7696d-5884-4d2c-99a8-02198c8071f9}.vdi"
"Hard Disk Controller-ImageUUID-0-0"="d4f7696d-5884-4d2c-99a8-02198c8071f9"
"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"="1c762253-2f45-4992-ae2f-090523a6b2fe"
"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="080027860353"
cableconnected1="on"
nic1="nat"
nictype1="82540EM"
nicspeed1="0"
mtu="0"
sockSnd="64"
sockRcv="64"
tcpWndSnd="64"
tcpWndRcv="64"
Forwarding(0)="tcp_64555_80,tcp,127.0.0.1,64555,,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_64ac692c5d3e9bbf_net",Network,1099511627776
SharedFolderNameMachineMapping1="shared"
SharedFolderPathMachineMapping1="D:\\data\\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="D:\\data\\BOINC\\slots\\0\\boinc_64ac692c5d3e9bbf\\boinc_64ac692c5d3e9bbf-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_3945057_1741806011.230302_0"
GuestMemoryBalloon=0
2025-03-12 19:42:15 (10196):
Command: VBoxManage -q startv
©2025 CERN