| Name | CMS_979628_1753056689.356523_0 |
| Workunit | 233701705 |
| Created | 21 Jul 2025, 0:11:33 UTC |
| Sent | 21 Jul 2025, 1:36:01 UTC |
| Report deadline | 21 Aug 2025, 1:36:01 UTC |
| Received | 23 Jul 2025, 21:18:35 UTC |
| Server state | Over |
| Outcome | Computation error |
| Client state | Compute error |
| Exit status | 194 (0x000000C2) EXIT_ABORTED_BY_CLIENT |
| Computer ID | 10681008 |
| Run time | 4 hours 22 min 48 sec |
| CPU time | 19 hours 14 min 27 sec |
| Validate state | Invalid |
| Credit | 0.00 |
| Device peak FLOPS | 18.07 GFLOPS |
| Application version | CMS Simulation v70.91 (vbox64_mt_mcore_cms) windows_x86_64 |
| Peak working set size | 87.83 MB |
| Peak swap size | 87.05 MB |
| Peak disk usage | 2.39 GB |
Stderr output
<core_client_version>8.0.2</core_client_version>
<![CDATA[
<message>
Process still present 5 min after writing finish file; aborting</message>
<stderr_txt>
(old = 'running', new = 'paused')
2025-07-21 19:31:53 (56580): VM state change detected. (old = 'paused', new = 'running')
2025-07-21 19:32:03 (56580): VM state change detected. (old = 'running', new = 'paused')
2025-07-21 19:32:23 (56580): VM state change detected. (old = 'paused', new = 'running')
2025-07-21 19:32:33 (56580): VM state change detected. (old = 'running', new = 'paused')
2025-07-21 19:32:53 (56580): VM state change detected. (old = 'paused', new = 'running')
2025-07-21 19:33:03 (56580): VM state change detected. (old = 'running', new = 'paused')
2025-07-21 19:33:23 (56580): VM state change detected. (old = 'paused', new = 'running')
2025-07-21 19:33:33 (56580): VM state change detected. (old = 'running', new = 'paused')
2025-07-21 19:33:53 (56580): VM state change detected. (old = 'paused', new = 'running')
2025-07-21 19:34:03 (56580): VM state change detected. (old = 'running', new = 'paused')
2025-07-21 19:34:23 (56580): VM state change detected. (old = 'paused', new = 'running')
2025-07-21 19:34:33 (56580): VM state change detected. (old = 'running', new = 'paused')
2025-07-21 19:34:53 (56580): VM state change detected. (old = 'paused', new = 'running')
2025-07-21 19:35:03 (56580): VM state change detected. (old = 'running', new = 'paused')
2025-07-21 19:35:23 (56580): VM state change detected. (old = 'paused', new = 'running')
2025-07-21 19:35:33 (56580): VM state change detected. (old = 'running', new = 'paused')
2025-07-21 19:35:53 (56580): VM state change detected. (old = 'paused', new = 'running')
2025-07-21 19:36:03 (56580): VM state change detected. (old = 'running', new = 'paused')
2025-07-21 19:36:23 (56580): VM state change detected. (old = 'paused', new = 'running')
2025-07-21 19:36:33 (56580): VM state change detected. (old = 'running', new = 'paused')
2025-07-21 19:36:53 (56580): VM state change detected. (old = 'paused', new = 'running')
2025-07-21 19:37:03 (56580): VM state change detected. (old = 'running', new = 'paused')
2025-07-21 19:37:23 (56580): VM state change detected. (old = 'paused', new = 'running')
2025-07-21 19:37:33 (56580): VM state change detected. (old = 'running', new = 'paused')
2025-07-21 19:37:53 (56580): VM state change detected. (old = 'paused', new = 'running')
2025-07-21 19:38:03 (56580): VM state change detected. (old = 'running', new = 'paused')
2025-07-21 19:38:24 (56580): VM state change detected. (old = 'paused', new = 'running')
2025-07-21 19:38:33 (56580): VM state change detected. (old = 'running', new = 'paused')
2025-07-21 19:38:53 (56580): VM state change detected. (old = 'paused', new = 'running')
2025-07-21 19:39:03 (56580): VM state change detected. (old = 'running', new = 'paused')
2025-07-21 19:39:24 (56580): VM state change detected. (old = 'paused', new = 'running')
2025-07-21 19:39:33 (56580): VM state change detected. (old = 'running', new = 'paused')
2025-07-21 19:39:53 (56580): VM state change detected. (old = 'paused', new = 'running')
2025-07-21 19:40:03 (56580): VM state change detected. (old = 'running', new = 'paused')
2025-07-21 19:40:24 (56580): VM state change detected. (old = 'paused', new = 'running')
2025-07-21 19:40:33 (56580): VM state change detected. (old = 'running', new = 'paused')
2025-07-21 19:40:53 (56580): VM state change detected. (old = 'paused', new = 'running')
2025-07-21 19:41:03 (56580): VM state change detected. (old = 'running', new = 'paused')
2025-07-21 19:41:24 (56580): VM state change detected. (old = 'paused', new = 'running')
2025-07-21 19:41:33 (56580): VM state change detected. (old = 'running', new = 'paused')
2025-07-21 19:41:53 (56580): VM state change detected. (old = 'paused', new = 'running')
2025-07-21 19:42:03 (56580): VM state change detected. (old = 'running', new = 'paused')
2025-07-21 19:42:24 (56580): VM state change detected. (old = 'paused', new = 'running')
2025-07-21 19:42:33 (56580): VM state change detected. (old = 'running', new = 'paused')
2025-07-21 19:42:53 (56580): VM state change detected. (old = 'paused', new = 'running')
2025-07-21 19:43:03 (56580): VM state change detected. (old = 'running', new = 'paused')
2025-07-21 19:43:24 (56580): VM state change detected. (old = 'paused', new = 'running')
2025-07-21 19:43:33 (56580): VM state change detected. (old = 'running', new = 'paused')
2025-07-21 19:43:53 (56580): VM state change detected. (old = 'paused', new = 'running')
2025-07-21 19:44:03 (56580): VM state change detected. (old = 'running', new = 'paused')
2025-07-21 19:44:24 (56580): VM state change detected. (old = 'paused', new = 'running')
2025-07-21 19:44:33 (56580): VM state change detected. (old = 'running', new = 'paused')
2025-07-21 19:44:53 (56580): VM state change detected. (old = 'paused', new = 'running')
2025-07-21 19:45:03 (56580): VM state change detected. (old = 'running', new = 'paused')
2025-07-21 19:45:24 (56580): VM state change detected. (old = 'paused', new = 'running')
2025-07-21 19:45:33 (56580): VM state change detected. (old = 'running', new = 'paused')
2025-07-21 19:45:53 (56580): VM state change detected. (old = 'paused', new = 'running')
2025-07-21 19:46:03 (56580): VM state change detected. (old = 'running', new = 'paused')
2025-07-21 19:46:24 (56580): VM state change detected. (old = 'paused', new = 'running')
2025-07-21 19:46:33 (56580): VM state change detected. (old = 'running', new = 'paused')
2025-07-21 19:46:53 (56580): VM state change detected. (old = 'paused', new = 'running')
2025-07-21 19:47:03 (56580): VM state change detected. (old = 'running', new = 'paused')
2025-07-21 19:47:24 (56580): VM state change detected. (old = 'paused', new = 'running')
2025-07-21 19:47:33 (56580): VM state change detected. (old = 'running', new = 'paused')
2025-07-21 19:47:53 (56580): VM state change detected. (old = 'paused', new = 'running')
2025-07-21 19:48:03 (56580): VM state change detected. (old = 'running', new = 'paused')
2025-07-21 19:48:24 (56580): VM state change detected. (old = 'paused', new = 'running')
2025-07-21 19:48:33 (56580): VM state change detected. (old = 'running', new = 'paused')
2025-07-21 19:48:53 (56580): VM state change detected. (old = 'paused', new = 'running')
2025-07-21 19:49:03 (56580): VM state change detected. (old = 'running', new = 'paused')
2025-07-21 19:49:24 (56580): VM state change detected. (old = 'paused', new = 'running')
2025-07-21 19:49:34 (56580): VM state change detected. (old = 'running', new = 'paused')
2025-07-21 19:49:54 (56580): VM state change detected. (old = 'paused', new = 'running')
2025-07-21 19:50:04 (56580): VM state change detected. (old = 'running', new = 'paused')
2025-07-21 19:50:25 (56580): VM state change detected. (old = 'paused', new = 'running')
2025-07-21 19:50:35 (56580): VM state change detected. (old = 'running', new = 'paused')
2025-07-21 19:50:55 (56580): VM state change detected. (old = 'paused', new = 'running')
2025-07-21 19:51:05 (56580): VM state change detected. (old = 'running', new = 'paused')
2025-07-21 19:51:25 (56580): VM state change detected. (old = 'paused', new = 'running')
2025-07-21 19:51:35 (56580): VM state change detected. (old = 'running', new = 'paused')
2025-07-21 19:51:55 (56580): VM state change detected. (old = 'paused', new = 'running')
2025-07-21 19:52:05 (56580): VM state change detected. (old = 'running', new = 'paused')
2025-07-21 19:52:25 (56580): VM state change detected. (old = 'paused', new = 'running')
2025-07-21 19:52:35 (56580): VM state change detected. (old = 'running', new = 'paused')
2025-07-21 19:52:55 (56580): VM state change detected. (old = 'paused', new = 'running')
2025-07-21 19:53:05 (56580): VM state change detected. (old = 'running', new = 'paused')
2025-07-21 19:53:25 (56580): VM state change detected. (old = 'paused', new = 'running')
2025-07-21 19:53:35 (56580): VM state change detected. (old = 'running', new = 'paused')
2025-07-21 19:53:55 (56580): VM state change detected. (old = 'paused', new = 'running')
2025-07-21 19:54:05 (56580): VM state change detected. (old = 'running', new = 'paused')
2025-07-21 19:54:25 (56580): VM state change detected. (old = 'paused', new = 'running')
2025-07-21 19:54:35 (56580): VM state change detected. (old = 'running', new = 'paused')
2025-07-21 19:54:55 (56580): VM state change detected. (old = 'paused', new = 'running')
2025-07-21 19:55:05 (56580): VM state change detected. (old = 'running', new = 'paused')
2025-07-21 19:55:25 (56580): VM state change detected. (old = 'paused', new = 'running')
2025-07-21 19:55:35 (56580): VM state change detected. (old = 'running', new = 'paused')
2025-07-21 19:55:55 (56580): VM state change detected. (old = 'paused', new = 'running')
2025-07-21 19:56:05 (56580): VM state change detected. (old = 'running', new = 'paused')
2025-07-21 19:56:25 (56580): VM state change detected. (old = 'paused', new = 'running')
2025-07-21 19:56:35 (56580): VM state change detected. (old = 'running', new = 'paused')
2025-07-21 19:56:55 (56580): VM state change detected. (old = 'paused', new = 'running')
2025-07-21 19:57:05 (56580): VM state change detected. (old = 'running', new = 'paused')
2025-07-21 19:57:25 (56580): VM state change detected. (old = 'paused', new = 'running')
2025-07-21 19:57:35 (56580): VM state change detected. (old = 'running', new = 'paused')
2025-07-21 19:57:55 (56580): VM state change detected. (old = 'paused', new = 'running')
2025-07-21 19:58:05 (56580): VM state change detected. (old = 'running', new = 'paused')
2025-07-21 19:58:25 (56580): VM state change detected. (old = 'paused', new = 'running')
2025-07-21 19:58:35 (56580): VM state change detected. (old = 'running', new = 'paused')
2025-07-21 19:58:55 (56580): VM state change detected. (old = 'paused', new = 'running')
2025-07-21 19:59:05 (56580): VM state change detected. (old = 'running', new = 'paused')
2025-07-21 19:59:25 (56580): VM state change detected. (old = 'paused', new = 'running')
2025-07-21 19:59:35 (56580): VM state change detected. (old = 'running', new = 'paused')
2025-07-21 19:59:36 (56580): VM state change detected. (old = 'paused', new = 'running')
2025-07-21 20:27:30 (56580): Status Report: Job Duration: '64800.000000'
2025-07-21 20:27:30 (56580): Status Report: Elapsed Time: '12000.000000'
2025-07-21 20:27:30 (56580): Status Report: CPU Time: '26852.640625'
2025-07-22 12:09:00 (56892): vboxwrapper version 26210
2025-07-22 12:09:00 (56892): BOINC client version: 8.0.2
2025-07-22 12:09:01 (56892): Detected: VirtualBox VboxManage Interface (Version: 7.0.6)
2025-07-22 12:09:01 (56892): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2025-07-22 12:09:02 (56892): Guest Log: BIOS: VirtualBox 7.0.6
2025-07-22 12:09:02 (56892): Guest Log: CPUID EDX: 0x178bfbff
2025-07-22 12:09:02 (56892): Guest Log: BIOS: No PCI IDE controller, not probing IDE
2025-07-22 12:09:02 (56892): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors
2025-07-22 12:09:02 (56892): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2025-07-22 12:09:02 (56892): Guest Log: BIOS: Booting from Hard Disk...
2025-07-22 12:09:02 (56892): Guest Log: BIOS: KBD: unsupported int 16h function 03
2025-07-22 12:09:02 (56892): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000
2025-07-22 12:09:02 (56892): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2025-07-22 12:09:02 (56892): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)
2025-07-22 12:09:02 (56892): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log
2025-07-22 12:09:02 (56892): Guest Log: 00:00:00.000106 main Log opened 2025-07-21T21:50:48.828395000Z
2025-07-22 12:09:02 (56892): Guest Log: 00:00:00.000220 main OS Product: Linux
2025-07-22 12:09:02 (56892): Guest Log: 00:00:00.000253 main OS Release: 4.14.232-19.cernvm.x86_64
2025-07-22 12:09:02 (56892): Guest Log: 00:00:00.000743 main OS Version: #1 SMP Fri Apr 30 17:12:25 CEST 2021
2025-07-22 12:09:02 (56892): Guest Log: 00:00:00.000890 main Executable: /usr/sbin/VBoxService
2025-07-22 12:09:02 (56892): Guest Log: 00:00:00.000890 main Process ID: 2291
2025-07-22 12:09:02 (56892): Guest Log: 00:00:00.000891 main Package type: LINUX_64BITS_GENERIC
2025-07-22 12:09:02 (56892): Guest Log: 00:00:00.053207 main 5.2.6 r120293 started. Verbose level = 0
2025-07-22 12:09:02 (56892): Guest Log: [INFO] Mounting the shared directory
2025-07-22 12:09:02 (56892): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor
2025-07-22 12:09:02 (56892): Guest Log: [INFO] Sourcing essential functions from /cvmfs/grid.cern.ch
2025-07-22 12:09:02 (56892): Guest Log: [INFO] Testing connection to cern.ch
2025-07-22 12:09:02 (56892): Guest Log: [INFO] Testing connection to VCCS
2025-07-22 12:09:02 (56892): Guest Log: [INFO] Testing connection to HTCondor
2025-07-22 12:09:02 (56892): Guest Log: [INFO] Testing connection to WMAgent
2025-07-22 12:09:02 (56892): Guest Log: [INFO] Testing connection to EOSCMS
2025-07-22 12:09:02 (56892): Guest Log: [INFO] Testing connection to CMS-Factory
2025-07-22 12:09:02 (56892): Guest Log: [INFO] Testing connection to CMS-Frontier
2025-07-22 12:09:02 (56892): Guest Log: [INFO] Testing connection to Frontier
2025-07-22 12:09:02 (56892): Guest Log: [INFO] Testing connection to http://cms-frontier.openhtc.io:8080/FrontierProd/Frontier/
2025-07-22 12:09:02 (56892): Guest Log: [INFO] Could not find a local HTTP proxy
2025-07-22 12:09:02 (56892): Guest Log: [INFO] CVMFS and Frontier will have to use DIRECT connections
2025-07-22 12:09:02 (56892): Guest Log: [INFO] This makes the application less efficient
2025-07-22 12:09:02 (56892): Guest Log: [INFO] It also puts higher load on the project servers
2025-07-22 12:09:02 (56892): Guest Log: [INFO] Setting up a local HTTP proxy is highly recommended
2025-07-22 12:09:02 (56892): Guest Log: [INFO] Advice can be found in the project forum
2025-07-22 12:09:02 (56892): Guest Log: [INFO] Reloading and probing the CVMFS configuration
2025-07-22 12:09:02 (56892): Guest Log: [INFO] Probing /cvmfs/grid.cern.ch... OK
2025-07-22 12:09:02 (56892): Guest Log: [INFO] Probing /cvmfs/cms.cern.ch... OK
2025-07-22 12:09:02 (56892): Guest Log: [INFO] Probing /cvmfs/oasis.opensciencegrid.org... OK
2025-07-22 12:09:02 (56892): Guest Log: [INFO] Probing /cvmfs/singularity.opensciencegrid.org... OK
2025-07-22 12:09:02 (56892): Guest Log: [INFO] Probing /cvmfs/cms-ib.cern.ch... OK
2025-07-22 12:09:02 (56892): Guest Log: [INFO] Excerpt from "cvmfs_config stat": VERSION HOST PROXY
2025-07-22 12:09:02 (56892): Guest Log: [INFO] 2.7.2.0 http://s1cern-cvmfs.openhtc.io DIRECT
2025-07-22 12:09:02 (56892): Guest Log: [INFO] Environment HTTP proxy: not set
2025-07-22 12:09:02 (56892): Guest Log: [INFO] Reading volunteer information
2025-07-22 12:09:02 (56892): Guest Log: [INFO] Requesting an X509 credential from LHC@home
2025-07-22 12:09:02 (56892): Guest Log: [INFO] Requesting an idtoken from LHC@home
2025-07-22 12:09:02 (56892): Guest Log: [INFO] CMS application starting. Check log files.
2025-07-22 12:09:02 (56892): Starting VM using VBoxManage interface. (boinc_10df463f464ed586, slot#8)
2025-07-22 12:09:08 (56892): Successfully started VM. (PID = '8284')
2025-07-22 12:09:08 (56892): Reporting VM Process ID to BOINC.
2025-07-22 12:09:08 (56892): Guest Log: BIOS: VirtualBox 7.0.6
2025-07-22 12:09:08 (56892): Guest Log: CPUID EDX: 0x178bfbff
2025-07-22 12:09:08 (56892): Guest Log: BIOS: No PCI IDE controller, not probing IDE
2025-07-22 12:09:08 (56892): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors
2025-07-22 12:09:08 (56892): VM state change detected. (old = 'poweredoff', new = 'running')
2025-07-22 12:09:08 (56892): Detected: Web Application Enabled (http://localhost:59679)
2025-07-22 12:09:08 (56892): Stopping VM.
2025-07-22 12:09:08 (56892): Successfully stopped VM.
2025-07-22 12:14:05 (57396): vboxwrapper version 26210
2025-07-22 12:14:05 (57396): BOINC client version: 8.0.2
2025-07-22 12:14:05 (57396): Detected: VirtualBox VboxManage Interface (Version: 7.0.6)
2025-07-22 12:14:05 (57396): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2025-07-22 12:14:06 (57396): Guest Log: BIOS: VirtualBox 7.0.6
2025-07-22 12:14:06 (57396): Guest Log: CPUID EDX: 0x178bfbff
2025-07-22 12:14:06 (57396): Guest Log: BIOS: No PCI IDE controller, not probing IDE
2025-07-22 12:14:06 (57396): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors
2025-07-22 12:14:06 (57396): Starting VM using VBoxManage interface. (boinc_10df463f464ed586, slot#8)
2025-07-22 12:14:12 (57396): Successfully started VM. (PID = '57372')
2025-07-22 12:14:12 (57396): Reporting VM Process ID to BOINC.
2025-07-22 12:14:12 (57396): VM state change detected. (old = 'poweredoff', new = 'running')
2025-07-22 12:14:12 (57396): Detected: Web Application Enabled (http://localhost:59679)
2025-07-22 12:14:12 (57396): Status Report: Job Duration: '64800.000000'
2025-07-22 12:14:12 (57396): Status Report: Elapsed Time: '16203.000000'
2025-07-22 12:14:12 (57396): Status Report: CPU Time: '36963.703125'
2025-07-22 12:14:12 (57396): Preference change detected
2025-07-22 12:14:12 (57396): Setting CPU throttle for VM. (50%)
2025-07-22 12:14:12 (57396): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2025-07-22 12:14:13 (57396): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2025-07-22 12:14:13 (57396): Guest Log: BIOS: Booting from Hard Disk...
2025-07-22 12:14:15 (57396): Guest Log: BIOS: KBD: unsupported int 16h function 03
2025-07-22 12:14:15 (57396): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000
2025-07-22 12:14:59 (57396): VM state change detected. (old = 'running', new = 'paused')
2025-07-22 12:15:20 (57396): VM state change detected. (old = 'paused', new = 'running')
2025-07-22 12:16:59 (57396): VM state change detected. (old = 'running', new = 'paused')
2025-07-22 12:17:20 (57396): VM state change detected. (old = 'paused', new = 'running')
2025-07-22 12:17:30 (57396): VM state change detected. (old = 'running', new = 'paused')
2025-07-22 12:17:50 (57396): VM state change detected. (old = 'paused', new = 'running')
2025-07-22 12:18:00 (57396): VM state change detected. (old = 'running', new = 'paused')
2025-07-22 12:18:20 (57396): VM state change detected. (old = 'paused', new = 'running')
2025-07-22 12:19:00 (57396): VM state change detected. (old = 'running', new = 'paused')
2025-07-22 12:19:20 (57396): VM state change detected. (old = 'paused', new = 'running')
2025-07-22 12:21:26 (57396): Stopping VM.
2025-07-22 12:21:27 (57396): Successfully stopped VM.
2025-07-22 12:38:10 (44648): vboxwrapper version 26210
2025-07-22 12:38:10 (44648): BOINC client version: 8.0.2
2025-07-22 12:38:11 (44648): Detected: VirtualBox VboxManage Interface (Version: 7.0.6)
2025-07-22 12:38:11 (44648): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2025-07-22 12:38:11 (44648): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2025-07-22 12:38:11 (44648): Guest Log: BIOS: Booting from Hard Disk...
2025-07-22 12:38:11 (44648): Guest Log: BIOS: KBD: unsupported int 16h function 03
2025-07-22 12:38:11 (44648): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000
2025-07-22 12:38:11 (44648): Starting VM using VBoxManage interface. (boinc_10df463f464ed586, slot#8)
2025-07-22 12:38:18 (44648): Successfully started VM. (PID = '50408')
2025-07-22 12:38:18 (44648): Reporting VM Process ID to BOINC.
2025-07-22 12:38:18 (44648): VM state change detected. (old = 'poweredoff', new = 'running')
2025-07-22 12:38:18 (44648): Detected: Web Application Enabled (http://localhost:59679)
2025-07-22 12:38:18 (44648): Stopping VM.
2025-07-22 12:38:18 (44648): Successfully stopped VM.
2025-07-22 16:30:04 (18164): vboxwrapper version 26210
2025-07-22 16:30:04 (18164): BOINC client version: 8.0.2
2025-07-22 16:30:05 (18164): Detected: VirtualBox VboxManage Interface (Version: 7.0.6)
2025-07-22 16:30:05 (18164): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2025-07-22 16:30:06 (18164): Starting VM using VBoxManage interface. (boinc_10df463f464ed586, slot#8)
2025-07-22 16:30:13 (18164): Successfully started VM. (PID = '12192')
2025-07-22 16:30:13 (18164): Reporting VM Process ID to BOINC.
2025-07-22 16:30:13 (18164): VM state change detected. (old = 'poweredoff', new = 'running')
2025-07-22 16:30:13 (18164): Detected: Web Application Enabled (http://localhost:59679)
2025-07-22 16:30:13 (18164): Stopping VM.
2025-07-22 16:30:13 (18164): Successfully stopped VM.
2025-07-22 16:35:09 (50288): vboxwrapper version 26210
2025-07-22 16:35:09 (50288): BOINC client version: 8.0.2
2025-07-22 16:35:09 (50288): Detected: VirtualBox VboxManage Interface (Version: 7.0.6)
2025-07-22 16:35:09 (50288): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2025-07-22 16:35:10 (50288): Starting VM using VBoxManage interface. (boinc_10df463f464ed586, slot#8)
2025-07-22 16:35:16 (50288): Successfully started VM. (PID = '1808')
2025-07-22 16:35:16 (50288): Reporting VM Process ID to BOINC.
2025-07-22 16:35:16 (50288): VM state change detected. (old = 'poweredoff', new = 'running')
2025-07-22 16:35:16 (50288): Detected: Web Application Enabled (http://localhost:59679)
2025-07-22 16:35:16 (50288): Status Report: Job Duration: '64800.000000'
2025-07-22 16:35:16 (50288): Status Report: Elapsed Time: '16530.000000'
2025-07-22 16:35:16 (50288): Status Report: CPU Time: '37169.359375'
2025-07-22 16:35:16 (50288): Preference change detected
2025-07-22 16:35:16 (50288): Setting CPU throttle for VM. (50%)
2025-07-22 16:35:16 (50288): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2025-07-22 16:35:25 (50288): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2025-07-22 16:35:25 (50288): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)
2025-07-22 16:35:26 (50288): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log
2025-07-22 16:35:26 (50288): Guest Log: 00:00:00.000064 main Log opened 2025-07-22T21:35:24.922425000Z
2025-07-22 16:35:26 (50288): Guest Log: 00:00:00.000120 main OS Product: Linux
2025-07-22 16:35:26 (50288): Guest Log: 00:00:00.000145 main OS Release: 4.14.232-19.cernvm.x86_64
2025-07-22 16:35:26 (50288): Guest Log: 00:00:00.000167 main OS Version: #1 SMP Fri Apr 30 17:12:25 CEST 2021
2025-07-22 16:35:26 (50288): Guest Log: 00:00:00.000187 main Executable: /usr/sbin/VBoxService
2025-07-22 16:35:26 (50288): Guest Log: 00:00:00.000188 main Process ID: 2287
2025-07-22 16:35:26 (50288): Guest Log: 00:00:00.000188 main Package type: LINUX_64BITS_GENERIC
2025-07-22 16:35:26 (50288): Guest Log: 00:00:00.001582 main 5.2.6 r120293 started. Verbose level = 0
2025-07-22 16:35:37 (50288): Guest Log: [INFO] Mounting the shared directory
2025-07-22 16:35:37 (50288): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor
2025-07-22 16:35:37 (50288): Guest Log: [INFO] Sourcing essential functions from /cvmfs/grid.cern.ch
2025-07-22 16:35:37 (50288): Guest Log: [INFO] Testing connection to cern.ch
2025-07-22 16:35:37 (50288): Guest Log: [INFO] Testing connection to VCCS
2025-07-22 16:35:38 (50288): Guest Log: [INFO] Testing connection to HTCondor
2025-07-22 16:35:38 (50288): Guest Log: [INFO] Testing connection to WMAgent
2025-07-22 16:35:38 (50288): Guest Log: [INFO] Testing connection to EOSCMS
2025-07-22 16:35:39 (50288): Guest Log: [INFO] Testing connection to CMS-Factory
2025-07-22 16:35:39 (50288): Guest Log: [INFO] Testing connection to CMS-Frontier
2025-07-22 16:35:40 (50288): Guest Log: [INFO] Testing connection to Frontier
2025-07-22 16:35:40 (50288): Guest Log: [INFO] Testing connection to http://cms-frontier.openhtc.io:8080/FrontierProd/Frontier/
2025-07-22 16:35:41 (50288): Guest Log: [INFO] Could not find a local HTTP proxy
2025-07-22 16:35:42 (50288): Guest Log: [INFO] CVMFS and Frontier will have to use DIRECT connections
2025-07-22 16:35:42 (50288): Guest Log: [INFO] This makes the application less efficient
2025-07-22 16:35:42 (50288): Guest Log: [INFO] It also puts higher load on the project servers
2025-07-22 16:35:42 (50288): Guest Log: [INFO] Setting up a local HTTP proxy is highly recommended
2025-07-22 16:35:42 (50288): Guest Log: [INFO] Advice can be found in the project forum
2025-07-22 16:35:42 (50288): Guest Log: [INFO] Reloading and probing the CVMFS configuration
2025-07-22 16:35:47 (50288): Guest Log: [INFO] Probing /cvmfs/grid.cern.ch... OK
2025-07-22 16:35:48 (50288): Guest Log: [INFO] Probing /cvmfs/cms.cern.ch... OK
2025-07-22 16:35:49 (50288): Guest Log: [INFO] Probing /cvmfs/singularity.opensciencegrid.org... OK
2025-07-22 16:35:50 (50288): Guest Log: [INFO] Probing /cvmfs/oasis.opensciencegrid.org... OK
2025-07-22 16:35:50 (50288): Guest Log: [INFO] Probing /cvmfs/cms-ib.cern.ch... OK
2025-07-22 16:35:50 (50288): Guest Log: [INFO] Excerpt from "cvmfs_config stat": VERSION HOST PROXY
2025-07-22 16:35:50 (50288): Guest Log: [INFO] 2.7.2.0 http://s1fnal-cvmfs.openhtc.io:8080 DIRECT
2025-07-22 16:35:50 (50288): Guest Log: [INFO] Environment HTTP proxy: not set
2025-07-22 16:35:50 (50288): Guest Log: [INFO] Reading volunteer information
2025-07-22 16:35:52 (50288): Guest Log: [INFO] Requesting an X509 credential from LHC@home
2025-07-22 16:35:54 (50288): Guest Log: [INFO] Requesting an idtoken from LHC@home
2025-07-22 16:35:54 (50288): Guest Log: [INFO] CMS application starting. Check log files.
2025-07-22 16:42:56 (50288): VM state change detected. (old = 'running', new = 'paused')
2025-07-22 16:43:17 (50288): VM state change detected. (old = 'paused', new = 'running')
2025-07-22 16:58:08 (50288): VM state change detected. (old = 'running', new = 'paused')
2025-07-22 16:58:28 (50288): VM state change detected. (old = 'paused', new = 'running')
2025-07-22 16:58:45 (50288): Stopping VM.
2025-07-22 16:58:56 (50288): Successfully stopped VM.
2025-07-22 17:04:42 (32232): vboxwrapper version 26210
2025-07-22 17:04:42 (32232): BOINC client version: 8.0.2
2025-07-22 17:04:42 (32232): Detected: VirtualBox VboxManage Interface (Version: 7.0.6)
2025-07-22 17:04:43 (32232): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2025-07-22 17:04:43 (32232): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2025-07-22 17:04:43 (32232): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)
2025-07-22 17:04:43 (32232): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log
2025-07-22 17:04:43 (32232): Guest Log: 00:00:00.000064 main Log opened 2025-07-22T21:35:24.922425000Z
2025-07-22 17:04:43 (32232): Guest Log: 00:00:00.000120 main OS Product: Linux
2025-07-22 17:04:43 (32232): Guest Log: 00:00:00.000145 main OS Release: 4.14.232-19.cernvm.x86_64
2025-07-22 17:04:43 (32232): Guest Log: 00:00:00.000167 main OS Version: #1 SMP Fri Apr 30 17:12:25 CEST 2021
2025-07-22 17:04:43 (32232): Guest Log: 00:00:00.000187 main Executable: /usr/sbin/VBoxService
2025-07-22 17:04:43 (32232): Guest Log: 00:00:00.000188 main Process ID: 2287
2025-07-22 17:04:43 (32232): Guest Log: 00:00:00.000188 main Package type: LINUX_64BITS_GENERIC
2025-07-22 17:04:43 (32232): Guest Log: 00:00:00.001582 main 5.2.6 r120293 started. Verbose level = 0
2025-07-22 17:04:43 (32232): Guest Log: [INFO] Mounting the shared directory
2025-07-22 17:04:43 (32232): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor
2025-07-22 17:04:43 (32232): Guest Log: [INFO] Sourcing essential functions from /cvmfs/grid.cern.ch
2025-07-22 17:04:43 (32232): Guest Log: [INFO] Testing connection to cern.ch
2025-07-22 17:04:43 (32232): Guest Log: [INFO] Testing connection to VCCS
2025-07-22 17:04:43 (32232): Guest Log: [INFO] Testing connection to HTCondor
2025-07-22 17:04:43 (32232): Guest Log: [INFO] Testing connection to WMAgent
2025-07-22 17:04:43 (32232): Guest Log: [INFO] Testing connection to EOSCMS
2025-07-22 17:04:43 (32232): Guest Log: [INFO] Testing connection to CMS-Factory
2025-07-22 17:04:43 (32232): Guest Log: [INFO] Testing connection to CMS-Frontier
2025-07-22 17:04:43 (32232): Guest Log: [INFO] Testing connection to Frontier
2025-07-22 17:04:43 (32232): Guest Log: [INFO] Testing connection to http://cms-frontier.openhtc.io:8080/FrontierProd/Frontier/
2025-07-22 17:04:43 (32232): Guest Log: [INFO] Could not find a local HTTP proxy
2025-07-22 17:04:43 (32232): Guest Log: [INFO] CVMFS and Frontier will have to use DIRECT connections
2025-07-22 17:04:43 (32232): Guest Log: [INFO] This makes the application less efficient
2025-07-22 17:04:43 (32232): Guest Log: [INFO] It also puts higher load on the project servers
2025-07-22 17:04:43 (32232): Guest Log: [INFO] Setting up a local HTTP proxy is highly recommended
2025-07-22 17:04:43 (32232): Guest Log: [INFO] Advice can be found in the project forum
2025-07-22 17:04:43 (32232): Guest Log: [INFO] Reloading and probing the CVMFS configuration
2025-07-22 17:04:43 (32232): Guest Log: [INFO] Probing /cvmfs/grid.cern.ch... OK
2025-07-22 17:04:43 (32232): Guest Log: [INFO] Probing /cvmfs/cms.cern.ch... OK
2025-07-22 17:04:43 (32232): Guest Log: [INFO] Probing /cvmfs/singularity.opensciencegrid.org... OK
2025-07-22 17:04:43 (32232): Guest Log: [INFO] Probing /cvmfs/oasis.opensciencegrid.org... OK
2025-07-22 17:04:43 (32232): Guest Log: [INFO] Probing /cvmfs/cms-ib.cern.ch... OK
2025-07-22 17:04:43 (32232): Guest Log: [INFO] Excerpt from "cvmfs_config stat": VERSION HOST PROXY
2025-07-22 17:04:43 (32232): Guest Log: [INFO] 2.7.2.0 http://s1fnal-cvmfs.openhtc.io:8080 DIRECT
2025-07-22 17:04:43 (32232): Guest Log: [INFO] Environment HTTP proxy: not set
2025-07-22 17:04:43 (32232): Guest Log: [INFO] Reading volunteer information
2025-07-22 17:04:43 (32232): Guest Log: [INFO] Requesting an X509 credential from LHC@home
2025-07-22 17:04:43 (32232): Guest Log: [INFO] Requesting an idtoken from LHC@home
2025-07-22 17:04:43 (32232): Guest Log: [INFO] CMS application starting. Check log files.
2025-07-22 17:04:43 (32232): Starting VM using VBoxManage interface. (boinc_10df463f464ed586, slot#8)
2025-07-22 17:12:07 (43636): vboxwrapper version 26210
2025-07-22 17:12:07 (43636): BOINC client version: 8.0.2
2025-07-22 17:12:08 (43636): Detected: VirtualBox VboxManage Interface (Version: 7.0.6)
2025-07-22 17:12:08 (43636): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2025-07-22 17:12:09 (43636): Starting VM using VBoxManage interface. (boinc_10df463f464ed586, slot#8)
2025-07-22 17:12:19 (43636): Successfully started VM. (PID = '39068')
2025-07-22 17:12:19 (43636): Reporting VM Process ID to BOINC.
2025-07-22 17:12:19 (43636): VM state change detected. (old = 'poweredoff', new = 'running')
2025-07-22 17:12:19 (43636): Detected: Web Application Enabled (http://localhost:59679)
2025-07-22 17:12:19 (43636): Stopping VM.
2025-07-22 17:12:30 (43636): Successfully stopped VM.
2025-07-22 17:17:12 (46816): vboxwrapper version 26210
2025-07-22 17:17:12 (46816): BOINC client version: 8.0.2
2025-07-22 17:17:12 (46816): Detected: VirtualBox VboxManage Interface (Version: 7.0.6)
2025-07-22 17:17:13 (46816): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2025-07-22 17:17:13 (46816): Starting VM using VBoxManage interface. (boinc_10df463f464ed586, slot#8)
2025-07-22 17:17:23 (46816): Successfully started VM. (PID = '40052')
2025-07-22 17:17:23 (46816): Reporting VM Process ID to BOINC.
2025-07-22 17:17:23 (46816): VM state change detected. (old = 'poweredoff', new = 'running')
2025-07-22 17:17:23 (46816): Detected: Web Application Enabled (http://localhost:59679)
2025-07-22 17:17:23 (46816): Status Report: Job Duration: '64800.000000'
2025-07-22 17:17:23 (46816): Status Report: Elapsed Time: '17895.000000'
2025-07-22 17:17:23 (46816): Status Report: CPU Time: '39743.437500'
2025-07-22 17:17:23 (46816): Preference change detected
2025-07-22 17:17:23 (46816): Setting CPU throttle for VM. (50%)
2025-07-22 17:17:24 (46816): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2025-07-22 17:58:20 (46816): VM state change detected. (old = 'running', new = 'paused')
2025-07-22 17:58:40 (46816): VM state change detected. (old = 'paused', new = 'running')
2025-07-22 18:29:02 (46816): VM state change detected. (old = 'running', new = 'paused')
2025-07-22 18:29:23 (46816): VM state change detected. (old = 'paused', new = 'running')
2025-07-22 18:58:10 (46816): Status Report: Job Duration: '64800.000000'
2025-07-22 18:58:10 (46816): Status Report: Elapsed Time: '23895.000000'
2025-07-22 18:58:10 (46816): Status Report: CPU Time: '53965.031250'
2025-07-22 20:38:14 (46816): Status Report: Job Duration: '64800.000000'
2025-07-22 20:38:14 (46816): Status Report: Elapsed Time: '29895.000000'
2025-07-22 20:38:14 (46816): Status Report: CPU Time: '68432.734375'
2025-07-22 20:43:54 (46816): Stopping VM.
2025-07-22 20:44:05 (46816): Successfully stopped VM.
2025-07-23 15:18:05 (18816): vboxwrapper version 26210
2025-07-23 15:18:05 (18816): BOINC client version: 8.0.2
2025-07-23 15:18:06 (18816): Detected: VirtualBox VboxManage Interface (Version: 7.0.6)
2025-07-23 15:18:06 (18816): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2025-07-23 15:18:07 (18816): Starting VM using VBoxManage interface. (boinc_10df463f464ed586, slot#8)
2025-07-23 15:18:12 (18816): Error in start VM for VM: -2147467259
Command:
VBoxManage -q startvm "boinc_10df463f464ed586" --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_10df463f464ed586" to power on...
2025-07-23 15:18:12 (18816): VM failed to start.
2025-07-23 15:18:12 (18816): Could not start
2025-07-23 15:18:12 (18816): ERROR: VM failed to start
2025-07-23 15:18:12 (18816): Powering off VM.
2025-07-23 15:18:12 (18816): Deregistering VM. (boinc_10df463f464ed586, slot#8)
2025-07-23 15:18:12 (18816): Removing network bandwidth throttle group from VM.
2025-07-23 15:18:13 (18816): Removing VM from VirtualBox.
Hypervisor System Log:
00:00:07.557198 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:07.557211 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:07.557221 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:07.557238 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:07.557257 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:07.557273 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:07.557288 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:07.557303 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:07.557316 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:07.557330 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:07.557345 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:07.557359 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:07.557372 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:07.557382 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:07.634657 Saving settings file "C:\ProgramData\BOINC\slots\13\boinc_79543471f7139f47\boinc_79543471f7139f47.vbox" with version "1.19-windows"
00:00:07.637607 Saving settings file "C:\ProgramData\BOINC\slots\1\boinc_7020698016f608eb\boinc_7020698016f608eb.vbox" with version "1.19-windows"
00:00:07.638561 Finished saving settings file "C:\ProgramData\BOINC\slots\13\boinc_79543471f7139f47\boinc_79543471f7139f47.vbox"
00:00:07.640208 SaveState Saving settings file "C:\ProgramData\BOINC\slots\13\boinc_79543471f7139f47\boinc_79543471f7139f47.vbox" with version "1.19-windows"
00:00:07.640785 Finished saving settings file "C:\ProgramData\BOINC\slots\1\boinc_7020698016f608eb\boinc_7020698016f608eb.vbox"
00:00:07.642908 SaveState Saving settings file "C:\ProgramData\BOINC\slots\1\boinc_7020698016f608eb\boinc_7020698016f608eb.vbox" with version "1.19-windows"
00:00:07.643627 SaveState Finished saving settings file "C:\ProgramData\BOINC\slots\13\boinc_79543471f7139f47\boinc_79543471f7139f47.vbox"
00:00:07.645027 SaveState Finished saving settings file "C:\ProgramData\BOINC\slots\1\boinc_7020698016f608eb\boinc_7020698016f608eb.vbox"
00:00:12.657811 main VirtualBox: object deletion starts
00:00:12.658911 main ERROR [COM]: aRC=VBOX_E_OBJECT_IN_USE (0x80bb000c) aIID={ad47ad09-787b-44ab-b343-a082a3f2dfb1} aComponent={MediumWrap} aText={Medium 'C:\ProgramData\BOINC\slots\2\boinc_bd91822b10045da3\Snapshots\{174614ff-7489-458b-b9f6-2a2414cd9e03}.vdi' cannot be closed because it is still attached to 1 virtual machines}, preserve=false aResultDetail=0
00:00:12.658955 main ERROR [COM]: aRC=VBOX_E_OBJECT_IN_USE (0x80bb000c) aIID={ad47ad09-787b-44ab-b343-a082a3f2dfb1} aComponent={MediumWrap} aText={Medium 'C:\ProgramData\BOINC\slots\6\boinc_51c8818454dccb7d\Snapshots\{a975aad7-20bd-4bea-aa84-976a6efa8a8a}.vdi' cannot be closed because it is still attached to 1 virtual machines}, preserve=false aResultDetail=0
00:00:12.658967 main ERROR [COM]: aRC=VBOX_E_OBJECT_IN_USE (0x80bb000c) aIID={ad47ad09-787b-44ab-b343-a082a3f2dfb1} aComponent={MediumWrap} aText={Medium 'C:\ProgramData\BOINC\slots\0\boinc_7b2216d8a7927b1e\Snapshots\{37ecf018-3fd7-4f01-8f8d-545ce26e048a}.vdi' cannot be closed because it is still attached to 1 virtual machines}, preserve=false aResultDetail=0
00:00:12.658976 main ERROR [COM]: aRC=VBOX_E_OBJECT_IN_USE (0x80bb000c) aIID={ad47ad09-787b-44ab-b343-a082a3f2dfb1} aComponent={MediumWrap} aText={Medium 'C:\ProgramData\BOINC\slots\7\boinc_cd7b5f13ad842b6f\Snapshots/{f021327d-b227-465f-b681-3530306816ec}.vdi' cannot be closed because it is still attached to 1 virtual machines}, preserve=false aResultDetail=0
00:00:12.658985 main ERROR [COM]: aRC=VBOX_E_OBJECT_IN_USE (0x80bb000c) aIID={ad47ad09-787b-44ab-b343-a082a3f2dfb1} aComponent={MediumWrap} aText={Cannot close medium 'C:\ProgramData\BOINC\projects\lhcathome.cern.ch_lhcathome\Theory_2025_07_03_prod.vdi' because it has 4 child media}, preserve=false aResultDetail=0
00:00:12.659515 main ERROR [COM]: aRC=VBOX_E_OBJECT_IN_USE (0x80bb000c) aIID={ad47ad09-787b-44ab-b343-a082a3f2dfb1} aComponent={MediumWrap} aText={Medium 'C:\ProgramData\BOINC\slots\13\boinc_79543471f7139f47\Snapshots/{de96721e-b0ee-4ad9-ad1e-bce2fc5b36dc}.vdi' cannot be closed because it is still attached to 1 virtual machines}, preserve=false aResultDetail=0
00:00:12.659529 main ERROR [COM]: aRC=VBOX_E_OBJECT_IN_USE (0x80bb000c) aIID={ad47ad09-787b-44ab-b343-a082a3f2dfb1} aComponent={MediumWrap} aText={Cannot close medium 'C:\ProgramData\BOINC\projects\lhcathome.cern.ch_lhcathome\CMS_2025_04_08_prod.vdi' because it has 1 child media}, preserve=false aResultDetail=0
00:00:12.660065 main ERROR [COM]: aRC=VBOX_E_OBJECT_IN_USE (0x80bb000c) aIID={ad47ad09-787b-44ab-b343-a082a3f2dfb1} aComponent={MediumWrap} aText={Medium 'C:\ProgramData\BOINC\slots\3\boinc_f50570f9fe30d410\Snapshots\{404fabf4-2195-43a2-935f-89eb73be426c}.vdi' cannot be closed because it is still attached to 1 virtual machines}, preserve=false aResultDetail=0
00:00:12.660079 main ERROR [COM]: aRC=VBOX_E_OBJECT_IN_USE (0x80bb000c) aIID={ad47ad09-787b-44ab-b343-a082a3f2dfb1} aComponent={MediumWrap} aText={Medium 'C:\ProgramData\BOINC\slots\1\boinc_7020698016f608eb\Snapshots/{4f710f1f-ed86-4304-a6be-f95d6e06f1df}.vdi' cannot be closed because it is still attached to 1 virtual machines}, preserve=false aResultDetail=0
00:00:12.660088 main ERROR [COM]: aRC=VBOX_E_OBJECT_IN_USE (0x80bb000c) aIID={ad47ad09-787b-44ab-b343-a082a3f2dfb1} aComponent={MediumWrap} aText={Cannot close medium 'C:\ProgramData\BOINC\projects\lhcathome.cern.ch_lhcathome\ATLAS_vbox_3.01_image.vdi' because it has 2 child media}, preserve=false aResultDetail=0
00:00:12.661468 main HostDnsMonitor: shutting down ...
00:00:12.661490 main HostDnsMonitor: shut down
00:00:12.662710 Watcher ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={7682d5eb-f00e-44f1-8ca2-99d08b1cd607} aComponent={VirtualBoxWrap} aText={The object is not ready}, preserve=false aResultDetail=0
00:00:12.663026 main VirtualBox: object deleted
VM Execution Log:
VM Startup Log:
VM Trace Log:
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-07-23 15:18:06 (18816):
Command: VBoxManage -q list hostinfo
Exit Code: 0
Output:
Host Information:
Host time: 2025-07-23T20:18:06.694000000Z
Processor online count: 20
Processor count: 20
Processor online core count: 10
Processor core count: 10
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: Intel(R) Core(TM) i9-10900F CPU @ 2.80GHz
Processor#1 speed: unknown
Processor#1 description: Intel(R) Core(TM) i9-10900F CPU @ 2.80GHz
Processor#2 speed: unknown
Processor#2 description: Intel(R) Core(TM) i9-10900F CPU @ 2.80GHz
Processor#3 speed: unknown
Processor#3 description: Intel(R) Core(TM) i9-10900F CPU @ 2.80GHz
Processor#4 speed: unknown
Processor#4 description: Intel(R) Core(TM) i9-10900F CPU @ 2.80GHz
Processor#5 speed: unknown
Processor#5 description: Intel(R) Core(TM) i9-10900F CPU @ 2.80GHz
Processor#6 speed: unknown
Processor#6 description: Intel(R) Core(TM) i9-10900F CPU @ 2.80GHz
Processor#7 speed: unknown
Processor#7 description: Intel(R) Core(TM) i9-10900F CPU @ 2.80GHz
Processor#8 speed: unknown
Processor#8 description: Intel(R) Core(TM) i9-10900F CPU @ 2.80GHz
Processor#9 speed: unknown
Processor#9 description: Intel(R) Core(TM) i9-10900F CPU @ 2.80GHz
Processor#10 speed: unknown
Processor#10 description: Intel(R) Core(TM) i9-10900F CPU @ 2.80GHz
Processor#11 speed: unknown
Processor#11 description: Intel(R) Core(TM) i9-10900F CPU @ 2.80GHz
Processor#12 speed: unknown
Processor#12 description: Intel(R) Core(TM) i9-10900F CPU @ 2.80GHz
Processor#13 speed: unknown
Processor#13 description: Intel(R) Core(TM) i9-10900F CPU @ 2.80GHz
Processor#14 speed: unknown
Processor#14 description: Intel(R) Core(TM) i9-10900F CPU @ 2.80GHz
Processor#15 speed: unknown
Processor#15 description: Intel(R) Core(TM) i9-10900F CPU @ 2.80GHz
Processor#16 speed: unknown
Processor#16 description: Intel(R) Core(TM) i9-10900F CPU @ 2.80GHz
Processor#17 speed: unknown
Processor#17 description: Intel(R) Core(TM) i9-10900F CPU @ 2.80GHz
Processor#18 speed: unknown
Processor#18 description: Intel(R) Core(TM) i9-10900F CPU @ 2.80GHz
Processor#19 speed: unknown
Processor#19 description: Intel(R) Core(TM) i9-10900F CPU @ 2.80GHz
Memory size: 130872 MByte
Memory available: 119008 MByte
Operating system: Windows 10
Operating system version: 10.0.19045
2025-07-23 15:18:07 (18816):
Command: VBoxManage -q showvminfo "boinc_10df463f464ed586" --machinereadable
Exit Code: 0
Output:
name="boinc_10df463f464ed586"
Encryption: disabled
groups="/"
ostype="Linux 2.6 / 3.x / 4.x / 5.x (64-bit)"
UUID="03219e3e-cf7e-4b9f-a646-799c08e8acdf"
CfgFile="C:\\ProgramData\\BOINC\\slots\\8\\boinc_10df463f464ed586\\boinc_10df463f464ed586.vbox"
SnapFldr="C:\\ProgramData\\BOINC\\slots\\8\\boinc_10df463f464ed586\\Snapshots"
LogFldr="C:\\ProgramData\\BOINC\\slots\\8\\boinc_10df463f464ed586\\Logs"
hardwareuuid="03219e3e-cf7e-4b9f-a646-799c08e8acdf"
memory=4584
pagefusion="off"
vram=16
cpuexecutioncap=50
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\\8\\boinc_10df463f464ed586\\boinc_10df463f464ed586.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-07-23T01:44:05.000000000"
VMStateFile="C:\ProgramData\BOINC\slots\8\boinc_10df463f464ed586\Snapshots\2025-07-23T01-43-54-610998600Z.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"="C:\\ProgramData\\BOINC\\slots\\8\\boinc_10df463f464ed586\\Snapshots\\{5f851b10-a89c-4bc8-ada6-01272e73fcd8}.vdi"
"Hard Disk Controller-ImageUUID-0-0"="5f851b10-a89c-4bc8-ada6-01272e73fcd8"
"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"="ed773174-5cc3-4174-9516-b18356a47c43"
"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="080027E658EE"
cableconnected1="on"
nic1="nat"
nictype1="virtio"
nicspeed1="0"
mtu="0"
sockSnd="64"
sockRcv="64"
tcpWndSnd="64"
tcpWndRcv="64"
Forwarding(0)="tcp_59679_80,tcp,127.0.0.1,59679,,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_10df463f464ed586_net",Network,1099511627776
SharedFolderNameMachineMapping1="shared"
SharedFolderPathMachineMapping1="C:\\ProgramData\\BOINC\\slots\\8\\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\\8\\boinc_10df463f464ed586\\boinc_10df463f464ed586-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_979628_1753056689.356523_0"
GuestMemoryBalloon=0
2025-07-23 15:18:12 (18816):
Command: VBoxManage -q startvm "boinc_10df463f464ed586" --type headless
Exit Code: -2147467259
Output:
VBoxManage.exe: error: Generic invalid state error. (VERR_INVALID_STATE)
VBoxManage.exe: error: Details: code E_FAIL (0x80004005), component ConsoleWrap, interface IConsole
Waiting for VM "boinc_10df463f464ed586" to power on...
2025-07-23 15:18:12 (18816):
Command: VBoxManage -q snapshot "boinc_10df463f464ed586" list
Exit Code: -108
Output:
This machine does not have any snapshots
2025-07-23 15:18:13 (18816):
Command: VBoxManage -q bandwidthctl "boinc_10df463f464ed586" remove "boinc_10df463f464ed586_net"
Exit Code: 0
Output:
VBoxManage.exe: error: Bandwidth groups cannot be deleted while the VM is running
2025-07-23 15:18:13 (18816):
Command: VBoxManage -q unregistervm "boinc_10df463f464ed586" --delete
Exit Code: 0
Output:
0%...10%...20%...30%...40%...50%...60%...70%...80%...90%...100%
2025-07-23 15:18:19 (18816): called boinc_finish(-2147467259)
2025-07-23 15:34:42 (26144): vboxwrapper version 26210
2025-07-23 15:34:42 (26144): BOINC client version: 8.0.2
2025-07-23 15:34:43 (26144): Detected: VirtualBox VboxManage Interface (Version: 7.0.6)
2025-07-23 15:34:43 (26144): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2025-07-23 15:34:43 (26144): Create VM. (boinc_10df463f464ed586, slot#8)
2025-07-23 15:34:44 (26144): Setting Memory Size for VM. (4584MB)
2025-07-23 15:34:44 (26144): Setting CPU Count for VM. (4)
2025-07-23 15:34:44 (26144): Setting Chipset Options for VM.
2025-07-23 15:34:45 (26144): Setting Graphics Controller Options for VM. (Driver: VBoxVGA, 16MB)
2025-07-23 15:34:45 (26144): Setting Boot Options for VM.
2025-07-23 15:34:45 (26144): Setting Network Configuration for NAT. (Driver: virtio)
2025-07-23 15:34:46 (26144): Enabling VM Network Access.
2025-07-23 15:34:46 (26144): Disabling USB Support for VM.
2025-07-23 15:34:46 (26144): Disabling COM Port Support for VM.
2025-07-23 15:34:47 (26144): Disabling LPT Port Support for VM.
2025-07-23 15:34:47 (26144): Disabling Audio Support for VM.
2025-07-23 15:34:47 (26144): Disabling Clipboard Support for VM.
2025-07-23 15:34:47 (26144): Disabling Drag and Drop Support for VM.
2025-07-23 15:34:48 (26144): Adding storage controller(s) to VM.
2025-07-23 15:34:48 (26144): Adding virtual disk drive to VM. (CMS_2025_04_08_prod.vdi)
2025-07-23 15:34:48 (26144): Adding VirtualBox Guest Additions to VM.
2025-07-23 15:34:49 (26144): Adding network bandwidth throttle group to VM. (Defaulting to 1024GB)
2025-07-23 15:34:49 (26144): forwarding host port 59679 to guest port 80
2025-07-23 15:34:49 (26144): Enabling remote desktop for VM.
2025-07-23 15:34:49 (26144): Required extension pack not installed, remote desktop not enabled.
2025-07-23 15:34:49 (26144): Enabling shared directory for VM.
2025-07-23 15:34:50 (26144): Starting VM using VBoxManage interface. (boinc_10df463f464ed586, slot#8)
2025-07-23 15:34:56 (26144): Successfully started VM. (PID = '9768')
2025-07-23 15:34:56 (26144): Reporting VM Process ID to BOINC.
2025-07-23 15:34:56 (26144): Guest Log: BIOS: VirtualBox 7.0.6
2025-07-23 15:34:56 (26144): Guest Log: CPUID EDX: 0x178bfbff
2025-07-23 15:34:56 (26144): Guest Log: BIOS: No PCI IDE controller, not probing IDE
2025-07-23 15:34:56 (26144): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors
2025-07-23 15:34:56 (26144): VM state change detected. (old = 'poweredoff', new = 'running')
2025-07-23 15:34:56 (26144): Detected: Web Application Enabled (http://localhost:59679)
2025-07-23 15:34:56 (26144): Status Report: Job Duration: '64800.000000'
2025-07-23 15:34:56 (26144): Status Report: Elapsed Time: '30235.000000'
2025-07-23 15:34:56 (26144): Status Report: CPU Time: '69252.218750'
2025-07-23 15:34:56 (26144): Preference change detected
2025-07-23 15:34:56 (26144): Setting CPU throttle for VM. (50%)
2025-07-23 15:34:56 (26144): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2025-07-23 15:34:58 (26144): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2025-07-23 15:34:58 (26144): Guest Log: BIOS: Booting from Hard Disk...
2025-07-23 15:35:01 (26144): Guest Log: BIOS: KBD: unsupported int 16h function 03
2025-07-23 15:35:01 (26144): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000
2025-07-23 15:35:22 (26144): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2025-07-23 15:35:22 (26144): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)
2025-07-23 15:35:23 (26144): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log
2025-07-23 15:35:23 (26144): Guest Log: 00:00:00.000119 main Log opened 2025-07-23T20:35:21.360647000Z
2025-07-23 15:35:23 (26144): Guest Log: 00:00:00.000212 main OS Product: Linux
2025-07-23 15:35:23 (26144): Guest Log: 00:00:00.000238 main OS Release: 4.14.232-19.cernvm.x86_64
2025-07-23 15:35:23 (26144): Guest Log: 00:00:00.000262 main OS Version: #1 SMP Fri Apr 30 17:12:25 CEST 2021
2025-07-23 15:35:23 (26144): Guest Log: 00:00:00.000285 main Executable: /usr/sbin/VBoxService
2025-07-23 15:35:23 (26144): Guest Log: 00:00:00.000286 main Process ID: 2294
2025-07-23 15:35:23 (26144): Guest Log: 00:00:00.000286 main Package type: LINUX_64BITS_GENERIC
2025-07-23 15:35:23 (26144): Guest Log: 00:00:00.000927 main 5.2.6 r120293 started. Verbose level = 0
2025-07-23 15:35:34 (26144): Guest Log: [INFO] Mounting the shared directory
2025-07-23 15:35:34 (26144): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor
2025-07-23 15:35:34 (26144): Guest Log: [INFO] Sourcing essential functions from /cvmfs/grid.cern.ch
2025-07-23 15:35:34 (26144): Guest Log: [INFO] Testing connection to cern.ch
2025-07-23 15:35:35 (26144): Guest Log: [INFO] Testing connection to VCCS
2025-07-23 15:35:35 (26144): Guest Log: [INFO] Testing connection to HTCondor
2025-07-23 15:35:35 (26144): Guest Log: [INFO] Testing connection to WMAgent
2025-07-23 15:35:36 (26144): Guest Log: [INFO] Testing connection to EOSCMS
2025-07-23 15:35:36 (26144): Guest Log: [INFO] Testing connection to CMS-Factory
2025-07-23 15:35:37 (26144): Guest Log: [INFO] Testing connection to CMS-Frontier
2025-07-23 15:35:37 (26144): Guest Log: [INFO] Testing connection to Frontier
2025-07-23 15:35:38 (26144): Guest Log: [INFO] Testing connection to http://cms-frontier.openhtc.io:8080/FrontierProd/Frontier/
2025-07-23 15:35:39 (26144): Guest Log: [INFO] Could not find a local HTTP proxy
2025-07-23 15:35:39 (26144): Guest Log: [INFO] CVMFS and Frontier will have to use DIRECT connections
2025-07-23 15:35:39 (26144): Guest Log: [INFO] This makes the application less efficient
2025-07-23 15:35:40 (26144): Guest Log: [INFO] It also puts higher load on the project servers
2025-07-23 15:35:40 (26144): Guest Log: [INFO] Setting up a local HTTP proxy is highly recommended
2025-07-23 15:35:40 (26144): Guest Log: [INFO] Advice can be found in the project forum
2025-07-23 15:35:41 (26144): Guest Log: [INFO] Reloading and probing the CVMFS configuration
2025-07-23 15:35:45 (26144): Guest Log: [INFO] Probing /cvmfs/grid.cern.ch... OK
2025-07-23 15:35:47 (26144): Guest Log: [INFO] Probing /cvmfs/cms-ib.cern.ch... OK
2025-07-23 15:35:47 (26144): Guest Log: [INFO] Probing /cvmfs/cms.cern.ch... OK
2025-07-23 15:35:48 (26144): Guest Log: [INFO] Probing /cvmfs/oasis.opensciencegrid.org... OK
2025-07-23 15:35:51 (26144): Guest Log: [INFO] Probing /cvmfs/singularity.opensciencegrid.org... OK
2025-07-23 15:35:51 (26144): Guest Log: [INFO] Excerpt from "cvmfs_config stat": VERSION HOST PROXY
2025-07-23 15:35:51 (26144): Guest Log: [INFO] 2.7.2.0 http://s1cern-cvmfs.openhtc.io DIRECT
2025-07-23 15:35:51 (26144): Guest Log: [INFO] Environment HTTP proxy: not set
2025-07-23 15:35:51 (26144): Guest Log: [INFO] Reading volunteer information
2025-07-23 15:36:39 (26144): Guest Log: [INFO] Requesting an X509 credential from LHC@home
2025-07-23 15:36:40 (26144): Guest Log: [INFO] Requesting an idtoken from LHC@home
2025-07-23 15:36:41 (26144): Guest Log: [INFO] CMS application starting. Check log files.
2025-07-23 15:36:45 (26144): Stopping VM.
2025-07-23 15:36:47 (26144): Successfully stopped VM.
2025-07-23 16:13:30 (18084): vboxwrapper version 26210
2025-07-23 16:13:30 (18084): BOINC client version: 8.0.2
2025-07-23 16:13:30 (18084): Detected: VirtualBox VboxManage Interface (Version: 7.0.6)
2025-07-23 16:13:31 (18084): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2025-07-23 16:13:31 (18084): Guest Log: BIOS: VirtualBox 7.0.6
2025-07-23 16:13:31 (18084): Guest Log: CPUID EDX: 0x178bfbff
2025-07-23 16:13:31 (18084): Guest Log: BIOS: No PCI IDE controller, not probing IDE
2025-07-23 16:13:31 (18084): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors
2025-07-23 16:13:31 (18084): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2025-07-23 16:13:31 (18084): Guest Log: BIOS: Booting from Hard Disk...
2025-07-23 16:13:31 (18084): Guest Log: BIOS: KBD: unsupported int 16h function 03
2025-07-23 16:13:31 (18084): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000
2025-07-23 16:13:31 (18084): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2025-07-23 16:13:31 (18084): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)
2025-07-23 16:13:31 (18084): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log
2025-07-23 16:13:31 (18084): Guest Log: 00:00:00.000119 main Log opened 2025-07-23T20:35:21.360647000Z
2025-07-23 16:13:31 (18084): Guest Log: 00:00:00.000212 main OS Product: Linux
2025-07-23 16:13:31 (18084): Guest Log: 00:00:00.000238 main OS Release: 4.14.232-19.cernvm.x86_64
2025-07-23 16:13:31 (18084): Guest Log: 00:00:00.000262 main OS Version: #1 SMP Fri Apr 30 17:12:25 CEST 2021
2025-07-23 16:13:31 (18084): Guest Log: 00:00:00.000285 main Executable: /usr/sbin/VBoxService
2025-07-23 16:13:31 (18084): Guest Log: 00:00:00.000286 main Process ID: 2294
2025-07-23 16:13:31 (18084): Guest Log: 00:00:00.000286 main Package type: LINUX_64BITS_GENERIC
2025-07-23 16:13:31 (18084): Guest Log: 00:00:00.000927 main 5.2.6 r120293 started. Verbose level = 0
2025-07-23 16:13:31 (18084): Guest Log: [INFO] Mounting the shared directory
2025-07-23 16:13:31 (18084): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor
2025-07-23 16:13:31 (18084): Guest Log: [INFO] Sourcing essential functions from /cvmfs/grid.cern.ch
2025-07-23 16:13:31 (18084): Guest Log: [INFO] Testing connection to cern.ch
2025-07-23 16:13:31 (18084): Guest Log: [INFO] Testing connection to VCCS
2025-07-23 16:13:31 (18084): Guest Log: [INFO] Testing connection to HTCondor
2025-07-23 16:13:31 (18084): Guest Log: [INFO] Testing connection to WMAgent
2025-07-23 16:13:31 (18084): Guest Log: [INFO] Testing connection to EOSCMS
2025-07-23 16:13:31 (18084): Guest Log: [INFO] Testing connection to CMS-Factory
2025-07-23 16:13:31 (18084): Guest Log: [INFO] Testing connection to CMS-Frontier
2025-07-23 16:13:31 (18084): Guest Log: [INFO] Testing connection to Frontier
2025-07-23 16:13:31 (18084): Guest Log: [INFO] Testing connection to http://cms-frontier.openhtc.io:8080/FrontierProd/Frontier/
2025-07-23 16:13:31 (18084): Guest Log: [INFO] Could not find a local HTTP proxy
2025-07-23 16:13:31 (18084): Guest Log: [INFO] CVMFS and Frontier will have to use DIRECT connections
2025-07-23 16:13:31 (18084): Guest Log: [INFO] This makes the application less efficient
2025-07-23 16:13:31 (18084): Guest Log: [INFO] It also puts higher load on the project servers
2025-07-23 16:13:31 (18084): Guest Log: [INFO] Setting up a local HTTP proxy is highly recommended
2025-07-23 16:13:31 (18084): Guest Log: [INFO] Advice can be found in the project forum
2025-07-23 16:13:31 (18084): Guest Log: [INFO] Reloading and probing the CVMFS configuration
2025-07-23 16:13:31 (18084): Guest Log: [INFO] Probing /cvmfs/grid.cern.ch... OK
2025-07-23 16:13:31 (18084): Guest Log: [INFO] Probing /cvmfs/cms-ib.cern.ch... OK
2025-07-23 16:13:31 (18084): Guest Log: [INFO] Probing /cvmfs/cms.cern.ch... OK
2025-07-23 16:13:31 (18084): Guest Log: [INFO] Probing /cvmfs/oasis.opensciencegrid.org... OK
2025-07-23 16:13:31 (18084): Guest Log: [INFO] Probing /cvmfs/singularity.opensciencegrid.org... OK
2025-07-23 16:13:31 (18084): Guest Log: [INFO] Excerpt from "cvmfs_config stat": VERSION HOST PROXY
2025-07-23 16:13:31 (18084): Guest Log: [INFO] 2.7.2.0 http://s1cern-cvmfs.openhtc.io DIRECT
2025-07-23 16:13:31 (18084): Guest Log: [INFO] Environment HTTP proxy: not set
2025-07-23 16:13:31 (18084): Guest Log: [INFO] Reading volunteer information
2025-07-23 16:13:31 (18084): Guest Log: [INFO] Requesting an X509 credential from LHC@home
2025-07-23 16:13:31 (18084): Guest Log: [INFO] Requesting an idtoken from LHC@home
2025-07-23 16:13:31 (18084): Guest Log: [INFO] CMS application starting. Check log files.
2025-07-23 16:13:31 (18084): Starting VM using VBoxManage interface. (boinc_10df463f464ed586, slot#8)
2025-07-23 16:13:38 (18084): Successfully started VM. (PID = '10112')
2025-07-23 16:13:38 (18084): Reporting VM Process ID to BOINC.
2025-07-23 16:13:38 (18084): VM state change detected. (old = 'poweredoff', new = 'running')
2025-07-23 16:13:38 (18084): Detected: Web Application Enabled (http://localhost:59679)
2025-07-23 16:13:38 (18084): Stopping VM.
2025-07-23 16:13:41 (18084): Successfully
©2025 CERN