Name CMS_3637044_1749311135.625655_0
Workunit 232920465
Created 7 Jun 2025, 15:45:37 UTC
Sent 7 Jun 2025, 15:49:23 UTC
Report deadline 8 Jul 2025, 15:49:23 UTC
Received 8 Jun 2025, 0:05:55 UTC
Server state Over
Outcome Computation error
Client state Compute error
Exit status 194 (0x000000C2) EXIT_ABORTED_BY_CLIENT
Computer ID 10794690
Run time 4 hours 56 min 53 sec
CPU time 18 hours 24 min 3 sec
Validate state Invalid
Credit 0.00
Device peak FLOPS 15.70 GFLOPS
Application version CMS Simulation v70.91 (vbox64_mt_mcore_cms)
windows_x86_64
Peak working set size 128.99 MB
Peak swap size 638.88 MB
Peak disk usage 3.47 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>
2025-06-07 13:07:27 (40772): vboxwrapper version 26210
2025-06-07 13:07:27 (40772): BOINC client version: 8.0.2
2025-06-07 13:07:27 (40772): Detected: VirtualBox VboxManage Interface (Version: 7.0.6)
2025-06-07 13:07:28 (40772): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2025-06-07 13:07:28 (40772): Successfully copied 'init_data.xml' to the shared directory.
2025-06-07 13:07:28 (40772): Create VM. (boinc_be1737c6bfd9cbf9, slot#19)
2025-06-07 13:07:29 (40772): Setting Memory Size for VM. (4584MB)
2025-06-07 13:07:29 (40772): Setting CPU Count for VM. (4)
2025-06-07 13:07:29 (40772): Setting Chipset Options for VM.
2025-06-07 13:07:29 (40772): Setting Graphics Controller Options for VM. (Driver: VBoxVGA, 16MB)
2025-06-07 13:07:30 (40772): Setting Boot Options for VM.
2025-06-07 13:07:30 (40772): Setting Network Configuration for NAT. (Driver: virtio)
2025-06-07 13:07:30 (40772): Enabling VM Network Access.
2025-06-07 13:07:31 (40772): Disabling USB Support for VM.
2025-06-07 13:07:31 (40772): Disabling COM Port Support for VM.
2025-06-07 13:07:31 (40772): Disabling LPT Port Support for VM.
2025-06-07 13:07:31 (40772): Disabling Audio Support for VM.
2025-06-07 13:07:32 (40772): Disabling Clipboard Support for VM.
2025-06-07 13:07:32 (40772): Disabling Drag and Drop Support for VM.
2025-06-07 13:07:32 (40772): Adding storage controller(s) to VM.
2025-06-07 13:07:32 (40772): Adding virtual disk drive to VM. (CMS_2025_04_08_prod.vdi)
2025-06-07 13:07:34 (40772): Adding VirtualBox Guest Additions to VM.
2025-06-07 13:07:35 (40772): Adding network bandwidth throttle group to VM. (Defaulting to 1024GB)
2025-06-07 13:07:35 (40772): forwarding host port 63502 to guest port 80
2025-06-07 13:07:35 (40772): Enabling remote desktop for VM.
2025-06-07 13:07:35 (40772): Required extension pack not installed, remote desktop not enabled.
2025-06-07 13:07:35 (40772): Enabling shared directory for VM.
2025-06-07 13:07:36 (40772): Starting VM using VBoxManage interface. (boinc_be1737c6bfd9cbf9, slot#19)
2025-06-07 13:07:44 (40772): Successfully started VM. (PID = '36124')
2025-06-07 13:07:44 (40772): Reporting VM Process ID to BOINC.
2025-06-07 13:07:44 (40772): Guest Log: BIOS: VirtualBox 7.0.6
2025-06-07 13:07:44 (40772): Guest Log: CPUID EDX: 0x178bfbff
2025-06-07 13:07:44 (40772): Guest Log: BIOS: No PCI IDE controller, not probing IDE
2025-06-07 13:07:44 (40772): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors
2025-06-07 13:07:44 (40772): VM state change detected. (old = 'poweredoff', new = 'running')
2025-06-07 13:07:44 (40772): Detected: Web Application Enabled (http://localhost:63502)
2025-06-07 13:07:44 (40772): Preference change detected
2025-06-07 13:07:44 (40772): Setting CPU throttle for VM. (100%)
2025-06-07 13:07:44 (40772): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2025-06-07 13:07:46 (40772): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2025-06-07 13:07:46 (40772): Guest Log: BIOS: Booting from Hard Disk...
2025-06-07 13:07:49 (40772): Guest Log: BIOS: KBD: unsupported int 16h function 03
2025-06-07 13:07:49 (40772): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 
2025-06-07 13:08:17 (40772): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2025-06-07 13:08:17 (40772): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)
2025-06-07 13:08:18 (40772): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log
2025-06-07 13:08:18 (40772): Guest Log: 00:00:00.000474 main     Log opened 2025-06-07T17:08:19.445076000Z
2025-06-07 13:08:18 (40772): Guest Log: 00:00:00.000616 main     OS Product: Linux
2025-06-07 13:08:18 (40772): Guest Log: 00:00:00.000670 main     OS Release: 4.14.232-19.cernvm.x86_64
2025-06-07 13:08:18 (40772): Guest Log: 00:00:00.000721 main     OS Version: #1 SMP Fri Apr 30 17:12:25 CEST 2021
2025-06-07 13:08:18 (40772): Guest Log: 00:00:00.000769 main     Executable: /usr/sbin/VBoxService
2025-06-07 13:08:18 (40772): Guest Log: 00:00:00.000771 main     Process ID: 2287
2025-06-07 13:08:18 (40772): Guest Log: 00:00:00.000773 main     Package type: LINUX_64BITS_GENERIC
2025-06-07 13:08:18 (40772): Guest Log: 00:00:00.005485 main     5.2.6 r120293 started. Verbose level = 0
2025-06-07 13:08:41 (40772): Guest Log: [INFO] Mounting the shared directory
2025-06-07 13:08:41 (40772): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor
2025-06-07 13:08:41 (40772): Guest Log: [INFO] Sourcing essential functions from /cvmfs/grid.cern.ch
2025-06-07 13:08:42 (40772): Guest Log: [INFO] Testing connection to cern.ch
2025-06-07 13:08:42 (40772): Guest Log: [INFO] Testing connection to VCCS
2025-06-07 13:08:43 (40772): Guest Log: [INFO] Testing connection to HTCondor
2025-06-07 13:08:43 (40772): Guest Log: [INFO] Testing connection to WMAgent
2025-06-07 13:08:44 (40772): Guest Log: [INFO] Testing connection to EOSCMS
2025-06-07 13:08:45 (40772): Guest Log: [INFO] Testing connection to CMS-Factory
2025-06-07 13:08:45 (40772): Guest Log: [INFO] Testing connection to CMS-Frontier
2025-06-07 13:08:46 (40772): Guest Log: [INFO] Testing connection to Frontier
2025-06-07 13:08:46 (40772): Guest Log: [INFO] Testing connection to http://cms-frontier.openhtc.io:8080/FrontierProd/Frontier/
2025-06-07 13:08:47 (40772): Guest Log: [INFO] Could not find a local HTTP proxy
2025-06-07 13:08:47 (40772): Guest Log: [INFO] CVMFS and Frontier will have to use DIRECT connections
2025-06-07 13:08:47 (40772): Guest Log: [INFO] This makes the application less efficient
2025-06-07 13:08:47 (40772): Guest Log: [INFO] It also puts higher load on the project servers
2025-06-07 13:08:48 (40772): Guest Log: [INFO] Setting up a local HTTP proxy is highly recommended
2025-06-07 13:08:48 (40772): Guest Log: [INFO] Advice can be found in the project forum
2025-06-07 13:08:49 (40772): Guest Log: [INFO] Reloading and probing the CVMFS configuration
2025-06-07 13:08:59 (40772): Guest Log: [INFO] Probing /cvmfs/grid.cern.ch... OK
2025-06-07 13:09:04 (40772): Guest Log: [INFO] Probing /cvmfs/cms.cern.ch... OK
2025-06-07 13:09:06 (40772): Guest Log: [INFO] Probing /cvmfs/cms-ib.cern.ch... OK
2025-06-07 13:09:07 (40772): Guest Log: [INFO] Probing /cvmfs/oasis.opensciencegrid.org... OK
2025-06-07 13:09:07 (40772): Guest Log: [INFO] Probing /cvmfs/singularity.opensciencegrid.org... OK
2025-06-07 13:09:08 (40772): Guest Log: [INFO] Excerpt from "cvmfs_config stat": VERSION HOST PROXY
2025-06-07 13:09:09 (40772): Guest Log: [INFO] 2.7.2.0 http://s1ihep-cvmfs.openhtc.io:8080 DIRECT
2025-06-07 13:09:09 (40772): Guest Log: [INFO] Environment HTTP proxy: not set
2025-06-07 13:09:09 (40772): Guest Log: [INFO] Reading volunteer information
2025-06-07 13:11:50 (40772): Guest Log: [INFO] Using weak account key.
2025-06-07 13:11:50 (40772): Guest Log: [INFO] Requesting an X509 credential from LHC@home
2025-06-07 13:11:53 (40772): Guest Log: [INFO] Using weak account key.
2025-06-07 13:11:53 (40772): Guest Log: [INFO] Requesting an idtoken from LHC@home
2025-06-07 13:11:55 (40772): Guest Log: [INFO] CMS application starting. Check log files.
2025-06-07 14:48:25 (40772): Status Report: Job Duration: '64800.000000'
2025-06-07 14:48:25 (40772): Status Report: Elapsed Time: '6000.000000'
2025-06-07 14:48:25 (40772): Status Report: CPU Time: '20593.890625'
2025-06-07 16:29:07 (40772): Status Report: Job Duration: '64800.000000'
2025-06-07 16:29:07 (40772): Status Report: Elapsed Time: '12000.000000'
2025-06-07 16:29:07 (40772): Status Report: CPU Time: '44604.218750'
2025-06-07 17:50:10 (40772): Stopping VM.
2025-06-07 17:50:28 (40772): Successfully stopped VM.
2025-06-07 18:20:09 (41236): vboxwrapper version 26210
2025-06-07 18:20:09 (41236): BOINC client version: 8.0.2
2025-06-07 18:20:10 (41236): Detected: VirtualBox VboxManage Interface (Version: 7.0.6)
2025-06-07 18:20:11 (41236): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2025-06-07 18:20:11 (41236): Guest Log: BIOS: VirtualBox 7.0.6
2025-06-07 18:20:11 (41236): Guest Log: CPUID EDX: 0x178bfbff
2025-06-07 18:20:11 (41236): Guest Log: BIOS: No PCI IDE controller, not probing IDE
2025-06-07 18:20:11 (41236): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors
2025-06-07 18:20:11 (41236): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2025-06-07 18:20:11 (41236): Guest Log: BIOS: Booting from Hard Disk...
2025-06-07 18:20:11 (41236): Guest Log: BIOS: KBD: unsupported int 16h function 03
2025-06-07 18:20:11 (41236): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 
2025-06-07 18:20:11 (41236): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2025-06-07 18:20:11 (41236): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)
2025-06-07 18:20:11 (41236): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log
2025-06-07 18:20:11 (41236): Guest Log: 00:00:00.000474 main     Log opened 2025-06-07T17:08:19.445076000Z
2025-06-07 18:20:11 (41236): Guest Log: 00:00:00.000616 main     OS Product: Linux
2025-06-07 18:20:11 (41236): Guest Log: 00:00:00.000670 main     OS Release: 4.14.232-19.cernvm.x86_64
2025-06-07 18:20:11 (41236): Guest Log: 00:00:00.000721 main     OS Version: #1 SMP Fri Apr 30 17:12:25 CEST 2021
2025-06-07 18:20:11 (41236): Guest Log: 00:00:00.000769 main     Executable: /usr/sbin/VBoxService
2025-06-07 18:20:11 (41236): Guest Log: 00:00:00.000771 main     Process ID: 2287
2025-06-07 18:20:11 (41236): Guest Log: 00:00:00.000773 main     Package type: LINUX_64BITS_GENERIC
2025-06-07 18:20:11 (41236): Guest Log: 00:00:00.005485 main     5.2.6 r120293 started. Verbose level = 0
2025-06-07 18:20:11 (41236): Guest Log: [INFO] Mounting the shared directory
2025-06-07 18:20:11 (41236): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor
2025-06-07 18:20:11 (41236): Guest Log: [INFO] Sourcing essential functions from /cvmfs/grid.cern.ch
2025-06-07 18:20:11 (41236): Guest Log: [INFO] Testing connection to cern.ch
2025-06-07 18:20:11 (41236): Guest Log: [INFO] Testing connection to VCCS
2025-06-07 18:20:11 (41236): Guest Log: [INFO] Testing connection to HTCondor
2025-06-07 18:20:11 (41236): Guest Log: [INFO] Testing connection to WMAgent
2025-06-07 18:20:11 (41236): Guest Log: [INFO] Testing connection to EOSCMS
2025-06-07 18:20:11 (41236): Guest Log: [INFO] Testing connection to CMS-Factory
2025-06-07 18:20:11 (41236): Guest Log: [INFO] Testing connection to CMS-Frontier
2025-06-07 18:20:11 (41236): Guest Log: [INFO] Testing connection to Frontier
2025-06-07 18:20:11 (41236): Guest Log: [INFO] Testing connection to http://cms-frontier.openhtc.io:8080/FrontierProd/Frontier/
2025-06-07 18:20:11 (41236): Guest Log: [INFO] Could not find a local HTTP proxy
2025-06-07 18:20:11 (41236): Guest Log: [INFO] CVMFS and Frontier will have to use DIRECT connections
2025-06-07 18:20:11 (41236): Guest Log: [INFO] This makes the application less efficient
2025-06-07 18:20:11 (41236): Guest Log: [INFO] It also puts higher load on the project servers
2025-06-07 18:20:11 (41236): Guest Log: [INFO] Setting up a local HTTP proxy is highly recommended
2025-06-07 18:20:11 (41236): Guest Log: [INFO] Advice can be found in the project forum
2025-06-07 18:20:11 (41236): Guest Log: [INFO] Reloading and probing the CVMFS configuration
2025-06-07 18:20:11 (41236): Guest Log: [INFO] Probing /cvmfs/grid.cern.ch... OK
2025-06-07 18:20:11 (41236): Guest Log: [INFO] Probing /cvmfs/cms.cern.ch... OK
2025-06-07 18:20:11 (41236): Guest Log: [INFO] Probing /cvmfs/cms-ib.cern.ch... OK
2025-06-07 18:20:11 (41236): Guest Log: [INFO] Probing /cvmfs/oasis.opensciencegrid.org... OK
2025-06-07 18:20:11 (41236): Guest Log: [INFO] Probing /cvmfs/singularity.opensciencegrid.org... OK
2025-06-07 18:20:11 (41236): Guest Log: [INFO] Excerpt from "cvmfs_config stat": VERSION HOST PROXY
2025-06-07 18:20:11 (41236): Guest Log: [INFO] 2.7.2.0 http://s1ihep-cvmfs.openhtc.io:8080 DIRECT
2025-06-07 18:20:11 (41236): Guest Log: [INFO] Environment HTTP proxy: not set
2025-06-07 18:20:11 (41236): Guest Log: [INFO] Reading volunteer information
2025-06-07 18:20:11 (41236): Guest Log: [INFO] Using weak account key.
2025-06-07 18:20:11 (41236): Guest Log: [INFO] Requesting an X509 credential from LHC@home
2025-06-07 18:20:11 (41236): Guest Log: [INFO] Using weak account key.
2025-06-07 18:20:11 (41236): Guest Log: [INFO] Requesting an idtoken from LHC@home
2025-06-07 18:20:11 (41236): Guest Log: [INFO] CMS application starting. Check log files.
2025-06-07 18:20:11 (41236): Starting VM using VBoxManage interface. (boinc_be1737c6bfd9cbf9, slot#19)
2025-06-07 18:20:39 (41236): Successfully started VM. (PID = '39560')
2025-06-07 18:20:39 (41236): Reporting VM Process ID to BOINC.
2025-06-07 18:20:39 (41236): VM state change detected. (old = 'poweredoff', new = 'running')
2025-06-07 18:20:39 (41236): Detected: Web Application Enabled (http://localhost:63502)
2025-06-07 18:20:39 (41236): Status Report: Job Duration: '64800.000000'
2025-06-07 18:20:39 (41236): Status Report: Elapsed Time: '16822.000000'
2025-06-07 18:20:39 (41236): Status Report: CPU Time: '63903.453125'
2025-06-07 18:20:39 (41236): Preference change detected
2025-06-07 18:20:39 (41236): Setting CPU throttle for VM. (100%)
2025-06-07 18:20:39 (41236): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2025-06-07 18:20:45 (41236): Guest Log: 04:41:57.449712 timesync vgsvcTimeSyncWorker: Radical host time change: 1 837 315 000 000ns (HostNow=1 749 334 844 202 000 000 ns HostLast=1 749 333 006 887 000 000 ns)
2025-06-07 18:20:55 (41236): Guest Log: 04:42:07.455869 timesync vgsvcTimeSyncWorker: Radical guest time change: 1 837 314 477 000ns (GuestNow=1 749 334 854 208 421 000 ns GuestLast=1 749 333 016 893 944 000 ns fSetTimeLastLoop=true )
2025-06-07 18:29:35 (41236): Stopping VM.
2025-06-07 18:29:52 (41236): Successfully stopped VM.
2025-06-07 18:59:37 (35708): vboxwrapper version 26210
2025-06-07 18:59:37 (35708): BOINC client version: 8.0.2
2025-06-07 18:59:38 (35708): Detected: VirtualBox VboxManage Interface (Version: 7.0.6)
2025-06-07 18:59:38 (35708): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2025-06-07 18:59:38 (35708): Guest Log: 04:41:57.449712 timesync vgsvcTimeSyncWorker: Radical host time change: 1 837 315 000 000ns (HostNow=1 749 334 844 202 000 000 ns HostLast=1 749 333 006 887 000 000 ns)
2025-06-07 18:59:38 (35708): Guest Log: 04:42:07.455869 timesync vgsvcTimeSyncWorker: Radical guest time change: 1 837 314 477 000ns (GuestNow=1 749 334 854 208 421 000 ns GuestLast=1 749 333 016 893 944 000 ns fSetTimeLastLoop=true )
2025-06-07 18:59:38 (35708): Starting VM using VBoxManage interface. (boinc_be1737c6bfd9cbf9, slot#19)
2025-06-07 19:28:29 (35708): Error in start VM for VM: -2147467259
Command:
VBoxManage -q startvm "boinc_be1737c6bfd9cbf9" --type headless
Output:
VBoxManage.exe: error: The VM session was aborted
VBoxManage.exe: error: Details: code E_FAIL (0x80004005), component SessionMachine, interface ISession
Waiting for VM "boinc_be1737c6bfd9cbf9" to power on...

2025-06-07 19:28:29 (35708): VM failed to start.
2025-06-07 19:28:29 (35708): Could not start 
2025-06-07 19:28:29 (35708): ERROR: VM failed to start
2025-06-07 19:28:29 (35708): Powering off VM.
2025-06-07 19:28:29 (35708): Deregistering VM. (boinc_be1737c6bfd9cbf9, slot#19)
2025-06-07 19:28:29 (35708): Removing network bandwidth throttle group from VM.
2025-06-07 19:28:29 (35708): Removing VM from VirtualBox.

    Hypervisor System Log:

00:28:52.553245          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:28:52.553251          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:28:52.553258          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:28:52.553265          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:28:52.553272          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:28:52.553278          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:28:52.553285          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:28:52.553291          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:28:52.553298          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:28:52.553308          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:28:52.553318          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:28:52.553325          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:28:52.553332          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:28:52.553338          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:28:52.553345          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:28:52.553352          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:28:52.553358          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:28:52.553365          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:28:52.553371          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:28:52.553378          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:28:52.553384          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:28:52.553391          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:28:52.553397          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:28:52.553404          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:28:52.553410          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:28:52.553417          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:28:52.553423          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:28:52.553430          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:28:52.553438          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:28:52.553446          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:28:52.553453          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:28:52.553460          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:28:52.553466          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:28:52.553473          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:28:52.553629          Saving settings file "C:\Users\Loren\.VirtualBox\VirtualBox.xml" with version "1.12-windows"
00:28:52.557398          Finished saving settings file "C:\Users\Loren\.VirtualBox\VirtualBox.xml"
00:28:52.557563          Saving settings file "C:\Users\Loren\.VirtualBox\VirtualBox.xml" with version "1.12-windows"
00:28:52.561190          Finished saving settings file "C:\Users\Loren\.VirtualBox\VirtualBox.xml"
00:28:52.562153 DeleteVM Saving settings file "C:\Users\Loren\.VirtualBox\VirtualBox.xml" with version "1.12-windows"
00:28:52.566857 DeleteVM Finished saving settings file "C:\Users\Loren\.VirtualBox\VirtualBox.xml"

    VM Execution Log:


    VM Startup Log:


    VM Trace Log:

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

2025-06-07 18:59:38 (35708): 
Command: VBoxManage -q list hostinfo 
Exit Code: 0
Output:
Host Information:

Host time: 2025-06-07T22:59:38.236000000Z
Processor online count: 12
Processor count: 12
Processor online core count: 6
Processor core count: 6
Processor supports HW virtualization: yes
Processor supports PAE: yes
Processor supports long mode: yes
Processor supports nested paging: yes
Processor supports unrestricted guest: yes
Processor supports nested HW virtualization: no
Processor supports virt. vmsave/vmload: no
Processor#0 speed: unknown
Processor#0 description: Intel(R) Core(TM) i7-5820K CPU @ 3.30GHz
Processor#1 speed: unknown
Processor#1 description: Intel(R) Core(TM) i7-5820K CPU @ 3.30GHz
Processor#2 speed: unknown
Processor#2 description: Intel(R) Core(TM) i7-5820K CPU @ 3.30GHz
Processor#3 speed: unknown
Processor#3 description: Intel(R) Core(TM) i7-5820K CPU @ 3.30GHz
Processor#4 speed: unknown
Processor#4 description: Intel(R) Core(TM) i7-5820K CPU @ 3.30GHz
Processor#5 speed: unknown
Processor#5 description: Intel(R) Core(TM) i7-5820K CPU @ 3.30GHz
Processor#6 speed: unknown
Processor#6 description: Intel(R) Core(TM) i7-5820K CPU @ 3.30GHz
Processor#7 speed: unknown
Processor#7 description: Intel(R) Core(TM) i7-5820K CPU @ 3.30GHz
Processor#8 speed: unknown
Processor#8 description: Intel(R) Core(TM) i7-5820K CPU @ 3.30GHz
Processor#9 speed: unknown
Processor#9 description: Intel(R) Core(TM) i7-5820K CPU @ 3.30GHz
Processor#10 speed: unknown
Processor#10 description: Intel(R) Core(TM) i7-5820K CPU @ 3.30GHz
Processor#11 speed: unknown
Processor#11 description: Intel(R) Core(TM) i7-5820K CPU @ 3.30GHz
Memory size: 32690 MByte
Memory available: 24958 MByte
Operating system: Windows 10
Operating system version: 10.0.19045

2025-06-07 18:59:38 (35708): 
Command: VBoxManage -q showvminfo "boinc_be1737c6bfd9cbf9" --machinereadable 
Exit Code: 0
Output:
name="boinc_be1737c6bfd9cbf9"
Encryption:     disabled
groups="/"
ostype="Linux 2.6 / 3.x / 4.x / 5.x (64-bit)"
UUID="36f06731-9f14-4a67-87aa-286f2434ad26"
CfgFile="C:\\ProgramData\\BOINC\\slots\\19\\boinc_be1737c6bfd9cbf9\\boinc_be1737c6bfd9cbf9.vbox"
SnapFldr="C:\\ProgramData\\BOINC\\slots\\19\\boinc_be1737c6bfd9cbf9\\Snapshots"
LogFldr="C:\\ProgramData\\BOINC\\slots\\19\\boinc_be1737c6bfd9cbf9\\Logs"
hardwareuuid="36f06731-9f14-4a67-87aa-286f2434ad26"
memory=4584
pagefusion="off"
vram=16
cpuexecutioncap=100
hpet="off"
cpu-profile="host"
chipset="piix3"
firmware="BIOS"
cpus=4
pae="on"
longmode="on"
triplefaultreset="off"
apic="on"
x2apic="on"
nested-hw-virt="off"
cpuid-portability-level=0
bootmenu="messageandmenu"
boot1="disk"
boot2="dvd"
boot3="none"
boot4="none"
acpi="on"
ioapic="on"
biosapic="apic"
biossystemtimeoffset=0
BIOS NVRAM File="C:\\ProgramData\\BOINC\\slots\\19\\boinc_be1737c6bfd9cbf9\\boinc_be1737c6bfd9cbf9.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-06-07T22:29:51.000000000"
VMStateFile="C:\ProgramData\BOINC\slots\19\boinc_be1737c6bfd9cbf9\Snapshots\2025-06-07T22-29-36-940790800Z.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\\19\\boinc_be1737c6bfd9cbf9\\Snapshots/{7def0dee-4758-41bc-af22-eed765df0782}.vdi"
"Hard Disk Controller-ImageUUID-0-0"="7def0dee-4758-41bc-af22-eed765df0782"
"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"="e7244b4b-8b88-465f-9850-d0aee02568a0"
"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="080027DB95C0"
cableconnected1="on"
nic1="nat"
nictype1="virtio"
nicspeed1="0"
mtu="0"
sockSnd="64"
sockRcv="64"
tcpWndSnd="64"
tcpWndRcv="64"
Forwarding(0)="tcp_63502_80,tcp,127.0.0.1,63502,,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_be1737c6bfd9cbf9_net",Network,1099511627776
SharedFolderNameMachineMapping1="shared"
SharedFolderPathMachineMapping1="C:\\ProgramData\\BOINC\\slots\\19\\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\\19\\boinc_be1737c6bfd9cbf9\\boinc_be1737c6bfd9cbf9-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_3637044_1749311135.625655_0"
GuestMemoryBalloon=0

2025-06-07 19:28:29 (35708): 
Command: VBoxManage -q startvm "boinc_be1737c6bfd9cbf9" --type headless
Exit Code: -2147467259
Output:
VBoxManage.exe: error: The VM session was aborted
VBoxManage.exe: error: Details: code E_FAIL (0x80004005), component SessionMachine, interface ISession
Waiting for VM "boinc_be1737c6bfd9cbf9" to power on...

2025-06-07 19:28:29 (35708): 
Command: VBoxManage -q snapshot "boinc_be1737c6bfd9cbf9" list 
Exit Code: -108
Output:
This machine does not have any snapshots

2025-06-07 19:28:29 (35708): 
Command: VBoxManage -q bandwidthctl "boinc_be1737c6bfd9cbf9" remove "boinc_be1737c6bfd9cbf9_net" 
Exit Code: 0
Output:

2025-06-07 19:28:30 (35708): 
Command: VBoxManage -q unregistervm "boinc_be1737c6bfd9cbf9" --delete 
Exit Code: 0
Output:
0%...10%...20%...30%...40%...50%...60%...70%...80%...90%...100%

2025-06-07 19:28:40 (35708): called boinc_finish(-2147467259)
2025-06-07 19:58:40 (41568): vboxwrapper version 26210
2025-06-07 19:58:40 (41568): BOINC client version: 8.0.2
2025-06-07 19:58:41 (41568): Detected: VirtualBox VboxManage Interface (Version: 7.0.6)
2025-06-07 19:58:42 (41568): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2025-06-07 19:58:42 (41568): Create VM. (boinc_be1737c6bfd9cbf9, slot#19)
2025-06-07 19:58:43 (41568): Setting Memory Size for VM. (4584MB)
2025-06-07 19:58:43 (41568): Setting CPU Count for VM. (4)
2025-06-07 19:58:43 (41568): Setting Chipset Options for VM.
2025-06-07 19:58:43 (41568): Setting Graphics Controller Options for VM. (Driver: VBoxVGA, 16MB)
2025-06-07 19:58:44 (41568): Setting Boot Options for VM.
2025-06-07 19:58:44 (41568): Setting Network Configuration for NAT. (Driver: virtio)
2025-06-07 19:58:44 (41568): Enabling VM Network Access.
2025-06-07 19:58:45 (41568): Disabling USB Support for VM.
2025-06-07 19:58:45 (41568): Disabling COM Port Support for VM.
2025-06-07 19:58:45 (41568): Disabling LPT Port Support for VM.
2025-06-07 19:58:45 (41568): Disabling Audio Support for VM.
2025-06-07 19:58:46 (41568): Disabling Clipboard Support for VM.
2025-06-07 19:58:46 (41568): Disabling Drag and Drop Support for VM.
2025-06-07 19:58:46 (41568): Adding storage controller(s) to VM.
2025-06-07 19:58:46 (41568): Adding virtual disk drive to VM. (CMS_2025_04_08_prod.vdi)
2025-06-07 19:58:48 (41568): Adding VirtualBox Guest Additions to VM.
2025-06-07 19:58:49 (41568): Adding network bandwidth throttle group to VM. (Defaulting to 1024GB)
2025-06-07 19:58:49 (41568): forwarding host port 63502 to guest port 80
2025-06-07 19:58:49 (41568): Enabling remote desktop for VM.
2025-06-07 19:58:49 (41568): Required extension pack not installed, remote desktop not enabled.
2025-06-07 19:58:49 (41568): Enabling shared directory for VM.
2025-06-07 19:58:50 (41568): Starting VM using VBoxManage interface. (boinc_be1737c6bfd9cbf9, slot#19)
2025-06-07 19:58:58 (41568): Successfully started VM. (PID = '37116')
2025-06-07 19:58:58 (41568): Reporting VM Process ID to BOINC.
2025-06-07 19:58:58 (41568): Guest Log: BIOS: VirtualBox 7.0.6
2025-06-07 19:58:58 (41568): Guest Log: CPUID EDX: 0x178bfbff
2025-06-07 19:58:58 (41568): Guest Log: BIOS: No PCI IDE controller, not probing IDE
2025-06-07 19:58:58 (41568): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors
2025-06-07 19:58:58 (41568): VM state change detected. (old = 'poweredoff', new = 'running')
2025-06-07 19:58:58 (41568): Detected: Web Application Enabled (http://localhost:63502)
2025-06-07 19:58:58 (41568): Status Report: Job Duration: '64800.000000'
2025-06-07 19:58:58 (41568): Status Report: Elapsed Time: '17356.000000'
2025-06-07 19:58:58 (41568): Status Report: CPU Time: '66043.750000'
2025-06-07 19:58:58 (41568): Preference change detected
2025-06-07 19:58:58 (41568): Setting CPU throttle for VM. (100%)
2025-06-07 19:58:58 (41568): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2025-06-07 19:59:00 (41568): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2025-06-07 19:59:00 (41568): Guest Log: BIOS: Booting from Hard Disk...
2025-06-07 19:59:03 (41568): Guest Log: BIOS: KBD: unsupported int 16h function 03
2025-06-07 19:59:03 (41568): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 
2025-06-07 19:59:35 (41568): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2025-06-07 19:59:35 (41568): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)
2025-06-07 19:59:37 (41568): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log
2025-06-07 19:59:37 (41568): Guest Log: 00:00:00.000149 main     Log opened 2025-06-07T23:59:37.027878000Z
2025-06-07 19:59:37 (41568): Guest Log: 00:00:00.000283 main     OS Product: Linux
2025-06-07 19:59:37 (41568): Guest Log: 00:00:00.000329 main     OS Release: 4.14.232-19.cernvm.x86_64
2025-06-07 19:59:37 (41568): Guest Log: 00:00:00.000371 main     OS Version: #1 SMP Fri Apr 30 17:12:25 CEST 2021
2025-06-07 19:59:37 (41568): Guest Log: 00:00:00.000411 main     Executable: /usr/sbin/VBoxService
2025-06-07 19:59:37 (41568): Guest Log: 00:00:00.000413 main     Process ID: 2284
2025-06-07 19:59:37 (41568): Guest Log: 00:00:00.000415 main     Package type: LINUX_64BITS_GENERIC
2025-06-07 19:59:37 (41568): Guest Log: 00:00:00.001857 main     5.2.6 r120293 started. Verbose level = 0
2025-06-07 20:00:01 (41568): Guest Log: [INFO] Mounting the shared directory
2025-06-07 20:00:01 (41568): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor
2025-06-07 20:00:01 (41568): Guest Log: [INFO] Sourcing essential functions from /cvmfs/grid.cern.ch
2025-06-07 20:00:02 (41568): Guest Log: [INFO] Testing connection to cern.ch
2025-06-07 20:00:02 (41568): Guest Log: [INFO] Testing connection to VCCS
2025-06-07 20:00:03 (41568): Guest Log: [INFO] Testing connection to HTCondor
2025-06-07 20:00:03 (41568): Guest Log: [INFO] Testing connection to WMAgent
2025-06-07 20:00:04 (41568): Guest Log: [INFO] Testing connection to EOSCMS
2025-06-07 20:00:05 (41568): Guest Log: [INFO] Testing connection to CMS-Factory
2025-06-07 20:00:05 (41568): Guest Log: [INFO] Testing connection to CMS-Frontier
2025-06-07 20:00:06 (41568): Guest Log: [INFO] Testing connection to Frontier
2025-06-07 20:00:06 (41568): Guest Log: [INFO] Testing connection to http://cms-frontier.openhtc.io:8080/FrontierProd/Frontier/
2025-06-07 20:00:08 (41568): Guest Log: [INFO] Could not find a local HTTP proxy
2025-06-07 20:00:08 (41568): Guest Log: [INFO] CVMFS and Frontier will have to use DIRECT connections
2025-06-07 20:00:08 (41568): Guest Log: [INFO] This makes the application less efficient
2025-06-07 20:00:09 (41568): Guest Log: [INFO] It also puts higher load on the project servers
2025-06-07 20:00:09 (41568): Guest Log: [INFO] Setting up a local HTTP proxy is highly recommended
2025-06-07 20:00:09 (41568): Guest Log: [INFO] Advice can be found in the project forum
2025-06-07 20:00:09 (41568): Guest Log: [INFO] Reloading and probing the CVMFS configuration
2025-06-07 20:00:19 (41568): Guest Log: [INFO] Probing /cvmfs/grid.cern.ch... OK
2025-06-07 20:00:25 (41568): Guest Log: [INFO] Probing /cvmfs/cms-ib.cern.ch... OK
2025-06-07 20:00:26 (41568): Guest Log: [INFO] Probing /cvmfs/cms.cern.ch... OK
2025-06-07 20:00:27 (41568): Guest Log: [INFO] Probing /cvmfs/oasis.opensciencegrid.org... OK
2025-06-07 20:00:27 (41568): Guest Log: [INFO] Probing /cvmfs/singularity.opensciencegrid.org... OK
2025-06-07 20:00:29 (41568): Guest Log: [INFO] Excerpt from "cvmfs_config stat": VERSION HOST PROXY
2025-06-07 20:00:29 (41568): Guest Log: [INFO] 2.7.2.0 http://s1cern-cvmfs.openhtc.io DIRECT
2025-06-07 20:00:29 (41568): Guest Log: [INFO] Environment HTTP proxy: not set
2025-06-07 20:00:29 (41568): Guest Log: [INFO] Reading volunteer information
2025-06-07 20:01:10 (41568): Guest Log: [INFO] Using weak account key.
2025-06-07 20:01:10 (41568): Guest Log: [INFO] Requesting an X509 credential from LHC@home
2025-06-07 20:01:12 (41568): Guest Log: [INFO] Using weak account key.
2025-06-07 20:01:12 (41568): Guest Log: [INFO] Requesting an idtoken from LHC@home
2025-06-07 20:01:14 (41568): Guest Log: [INFO] CMS application starting. Check log files.
2025-06-07 20:03:49 (41568): Powering off VM.
2025-06-07 20:03:50 (41568): Successfully stopped VM.
2025-06-07 20:03:50 (41568): Deregistering VM. (boinc_be1737c6bfd9cbf9, slot#19)
2025-06-07 20:03:50 (41568): Removing network bandwidth throttle group from VM.
2025-06-07 20:03:50 (41568): Removing VM from VirtualBox.

    Hypervisor System Log:

00:05:09.609779          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:05:09.609794          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:05:09.609808          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:05:09.609822          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:05:09.609836          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:05:09.609850          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:05:09.609864          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:05:09.609878          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:05:09.609892          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:05:09.609906          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:05:09.609920          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:05:09.609934          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:05:09.609948          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:05:09.609968          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:05:09.609986          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:05:09.610000          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:05:09.610015          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:05:09.610029          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:05:09.610043          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:05:09.610057          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:05:09.610071          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:05:09.610085          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:05:09.610099          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:05:09.610116          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:05:09.610130          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:05:09.610144          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:05:09.610158          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:05:09.610172          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:05:09.610186          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:05:09.610200          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:05:09.610214          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:05:09.610228          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:05:09.610245          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:05:09.610262          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:05:09.610511          Saving settings file "C:\Users\Loren\.VirtualBox\VirtualBox.xml" with version "1.12-windows"
00:05:09.615165          Finished saving settings file "C:\Users\Loren\.VirtualBox\VirtualBox.xml"
00:05:09.615494          Saving settings file "C:\Users\Loren\.VirtualBox\VirtualBox.xml" with version "1.12-windows"
00:05:09.619869          Finished saving settings file "C:\Users\Loren\.VirtualBox\VirtualBox.xml"
00:05:09.621415 DeleteVM Saving settings file "C:\Users\Loren\.VirtualBox\VirtualBox.xml" with version "1.12-windows"
00:05:09.627914 DeleteVM Finished saving settings file "C:\Users\Loren\.VirtualBox\VirtualBox.xml"

    VM Execution Log:


    VM Startup Log:


    VM Trace Log:


teleporterpassword=""
tracing-enabled="off"
tracing-allow-vm-access="off"
tracing-config=""
autostart-enabled="off"
autostart-delay=0
defaultfrontend=""
vmprocpriority="default"
natnet1="nat"
macaddress1="080027A52822"
cableconnected1="on"
nic1="nat"
nictype1="82540EM"
nicspeed1="0"
mtu="0"
sockSnd="64"
sockRcv="64"
tcpWndSnd="64"
tcpWndRcv="64"
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="default"
audio_out="off"
audio_in="off"
clipboard="disabled"
draganddrop="disabled"
vrde="off"
usb="off"
ehci="off"
xhci="off"
recording_enabled="off"
recording_screens=1
 rec_screen0
rec_screen_enabled="on"
rec_screen_id=0
rec_screen_video_enabled="on"
rec_screen_audio_enabled="off"
rec_screen_dest="File"
rec_screen_dest_filename="C:\\ProgramData\\BOINC\\slots\\19\\boinc_be1737c6bfd9cbf9\\boinc_be1737c6bfd9cbf9-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_3637044_1749311135.625655_0"
GuestMemoryBalloon=0

2025-06-07 19:58:44 (41568): 
Command: VBoxManage -q modifyvm "boinc_be1737c6bfd9cbf9" --nic1 nat --nic-type1 "virtio" --cable-connected1 off --nat-dns-proxy1 on 
Exit Code: 0
Output:

2025-06-07 19:58:45 (41568): 
Command: VBoxManage -q modifyvm "boinc_be1737c6bfd9cbf9" --cable-connected1 on 
Exit Code: 0
Output:

2025-06-07 19:58:45 (41568): 
Command: VBoxManage -q modifyvm "boinc_be1737c6bfd9cbf9" --usb off 
Exit Code: 0
Output:

2025-06-07 19:58:45 (41568): 
Command: VBoxManage -q modifyvm "boinc_be1737c6bfd9cbf9" --uart1 off --uart2 off 
Exit Code: 0
Output:

2025-06-07 19:58:45 (41568): 
Command: VBoxManage -q modifyvm "boinc_be1737c6bfd9cbf9" --lpt1 off --lpt2 off 
Exit Code: 0
Output:

2025-06-07 19:58:46 (41568): 
Command: VBoxManage -q modifyvm "boinc_be1737c6bfd9cbf9" --audio-enabled off 
Exit Code: 0
Output:

2025-06-07 19:58:46 (41568): 
Command: VBoxManage -q modifyvm "boinc_be1737c6bfd9cbf9" --clipboard disabled 
Exit Code: 0
Output:

2025-06-07 19:58:46 (41568): 
Command: VBoxManage -q modifyvm "boinc_be1737c6bfd9cbf9" --draganddrop disabled 
Exit Code: 0
Output:

2025-06-07 19:58:46 (41568): 
Command: VBoxManage -q storagectl "boinc_be1737c6bfd9cbf9" --name "Hard Disk Controller" --add "sata" --controller "IntelAHCI" --hostiocache off --portcount 3
Exit Code: 0
Output:

2025-06-07 19:58:47 (41568): 
Command: VBoxManage -q showhdinfo "C:\ProgramData\BOINC/projects/lhcathome.cern.ch_lhcathome/CMS_2025_04_08_prod.vdi" 
Exit Code: 0
Output:
UUID:           fa49c4e2-ad29-47a5-b96a-3c89ce80d84c
Parent UUID:    base
State:          created
Type:           multiattach
Location:       C:\ProgramData\BOINC\projects\lhcathome.cern.ch_lhcathome\CMS_2025_04_08_prod.vdi
Storage format: VDI
Format variant: dynamic default
Capacity:       20480 MBytes
Size on disk:   3853 MBytes
Encryption:     disabled
Property:       AllocationBlockSize=1048576

2025-06-07 19:58:47 (41568): 
Command: VBoxManage -q storageattach "boinc_be1737c6bfd9cbf9" --storagectl "Hard Disk Controller" --port 0 --device 0 --type hdd --mtype multiattach --medium "C:\ProgramData\BOINC/projects/lhcathome.cern.ch_lhcathome/CMS_2025_04_08_prod.vdi" 
Exit Code: -2135228409
Output:
VBoxManage.exe: error: Cannot attach medium 'C:\ProgramData\BOINC\projects\lhcathome.cern.ch_lhcathome\CMS_2025_04_08_prod.vdi': the media type 'MultiAttach' can only be attached to machines that were created with VirtualBox 4.0 or later
VBoxManage.exe: error: Details: code VBOX_E_INVALID_OBJECT_STATE (0x80bb0007), component SessionMachine, interface IMachine, callee IUnknown
VBoxManage.exe: error: Context: "AttachDevice(Bstr(pszCtl).raw(), port, device, DeviceType_HardDisk, pMedium2Mount)" at line 785 of file VBoxManageStorageController.cpp

2025-06-07 19:58:47 (41568): 
Command: VBoxManage -q showhdinfo "C:\ProgramData\BOINC/projects/lhcathome.cern.ch_lhcathome/CMS_2025_04_08_prod.vdi" 
Exit Code: 0
Output:
UUID:           fa49c4e2-ad29-47a5-b96a-3c89ce80d84c
Parent UUID:    base
State:          created
Type:           multiattach
Location:       C:\ProgramData\BOINC\projects\lhcathome.cern.ch_lhcathome\CMS_2025_04_08_prod.vdi
Storage format: VDI
Format variant: dynamic default
Capacity:       20480 MBytes
Size on disk:   3853 MBytes
Encryption:     disabled
Property:       AllocationBlockSize=1048576

2025-06-07 19:58:47 (41568): 
Command: VBoxManage -q closemedium disk "C:\ProgramData\BOINC\projects\lhcathome.cern.ch_lhcathome\CMS_2025_04_08_prod.vdi" 
Exit Code: 0
Output:

2025-06-07 19:58:48 (41568): 
Command: VBoxManage -q showhdinfo "C:\ProgramData\BOINC/projects/lhcathome.cern.ch_lhcathome/CMS_2025_04_08_prod.vdi" 
Exit Code: 0
Output:
UUID:           fa49c4e2-ad29-47a5-b96a-3c89ce80d84c
Parent UUID:    base
State:          created
Type:           normal (base)
Location:       C:\ProgramData\BOINC\projects\lhcathome.cern.ch_lhcathome\CMS_2025_04_08_prod.vdi
Storage format: VDI
Format variant: dynamic default
Capacity:       20480 MBytes
Size on disk:   3853 MBytes
Encryption:     disabled
Property:       AllocationBlockSize=1048576

2025-06-07 19:58:48 (41568): 
Command: VBoxManage -q storageattach "boinc_be1737c6bfd9cbf9" --storagectl "Hard Disk Controller" --port 0 --device 0 --type hdd --medium "C:\ProgramData\BOINC/projects/lhcathome.cern.ch_lhcathome/CMS_2025_04_08_prod.vdi" 
Exit Code: 0
Output:

2025-06-07 19:58:48 (41568): 
Command: VBoxManage -q storageattach "boinc_be1737c6bfd9cbf9" --storagectl "Hard Disk Controller" --port 0 --device 0 --type hdd --medium none 
Exit Code: 0
Output:

2025-06-07 19:58:48 (41568): 
Command: VBoxManage -q storageattach "boinc_be1737c6bfd9cbf9" --storagectl "Hard Disk Controller" --port 0 --device 0 --type hdd --mtype multiattach --medium "C:\ProgramData\BOINC/projects/lhcathome.cern.ch_lhcathome/CMS_2025_04_08_prod.vdi" 
Exit Code: 0
Output:

2025-06-07 19:58:49 (41568): 
Command: VBoxManage -q storageattach "boinc_be1737c6bfd9cbf9" --storagectl "Hard Disk Controller" --port 1 --device 0 --type dvddrive --medium "C:\Program Files\Oracle\VirtualBox/VBoxGuestAdditions.iso" 
Exit Code: 0
Output:

2025-06-07 19:58:49 (41568): 
Command: VBoxManage -q bandwidthctl "boinc_be1737c6bfd9cbf9" add "boinc_be1737c6bfd9cbf9_net" --type network --limit 1024G 
Exit Code: 0
Output:

2025-06-07 19:58:49 (41568): 
Command: VBoxManage -q modifyvm "boinc_be1737c6bfd9cbf9" --natpf1 ",tcp,127.0.0.1,63502,,80" 
Exit Code: 0
Output:

2025-06-07 19:58:49 (41568): 
Command: VBoxManage -q list extpacks
Exit Code: 0
Output:
Extension Packs: 0

2025-06-07 19:58:50 (41568): 
Command: VBoxManage -q sharedfolder add "boinc_be1737c6bfd9cbf9" --name "shared" --hostpath "C:\ProgramData\BOINC\slots\19/shared"
Exit Code: 0
Output:

2025-06-07 19:58:57 (41568): 
Command: VBoxManage -q startvm "boinc_be1737c6bfd9cbf9" --type headless
Exit Code: 0
Output:
Waiting for VM "boinc_be1737c6bfd9cbf9" to power on...
VM "boinc_be1737c6bfd9cbf9" has been successfully started.

2025-06-07 19:58:58 (41568): 
Command: VBoxManage -q controlvm "boinc_be1737c6bfd9cbf9" cpuexecutioncap 100 
Exit Code: 0
Output:

2025-06-07 20:03:50 (41568): 
Command: VBoxManage -q controlvm "boinc_be1737c6bfd9cbf9" poweroff
Exit Code: 0
Output:
0%...10%...20%...30%...40%...50%...60%...70%...80%...90%...100%

2025-06-07 20:03:50 (41568): 
Command: VBoxManage -q snapshot "boinc_be1737c6bfd9cbf9" list 
Exit Code: -108
Output:
This machine does not have any snapshots

2025-06-07 20:03:50 (41568): 
Command: VBoxManage -q bandwidthctl "boinc_be1737c6bfd9cbf9" remove "boinc_be1737c6bfd9cbf9_net" 
Exit Code: 0
Output:

2025-06-07 20:03:51 (41568): 
Command: VBoxManage -q unregistervm "boinc_be1737c6bfd9cbf9" --delete 
Exit Code: 0
Output:
0%...10%...20%...30%...40%...50%...60%...70%...80%...90%...100%

2025-06-07 20:04:01 (41568): called boinc_finish(194)

</stderr_txt>
]]>


©2025 CERN