Name CMS_2574800_1677903878.388288_0
Workunit 2284020
Created 4 Mar 2023, 4:24:40 UTC
Sent 6 Mar 2023, 9:54:14 UTC
Report deadline 13 Mar 2023, 9:54:14 UTC
Received 6 Mar 2023, 21:57:00 UTC
Server state Over
Outcome Success
Client state Done
Exit status 0 (0x00000000)
Computer ID 4802
Run time 9 hours 5 min 38 sec
CPU time 9 hours 42 min 16 sec
Validate state Valid
Credit 341.16
Device peak FLOPS 5.21 GFLOPS
Application version CMS Simulation v60.70 (vbox64_mt_mcore_cms)
windows_x86_64
Peak working set size 81.51 MB
Peak swap size 80.77 MB
Peak disk usage 1.43 GB

Stderr output

<core_client_version>7.20.2</core_client_version>
<![CDATA[
<stderr_txt>
2023-03-06 02:54:20 (124548): Detected: vboxwrapper 26206
2023-03-06 02:54:20 (124548): Detected: BOINC client v7.20.2
2023-03-06 02:54:27 (124548): Detected: VirtualBox VboxManage Interface (Version: 6.1.34)
2023-03-06 02:54:28 (124548): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2023-03-06 02:54:28 (124548): Successfully copied 'init_data.xml' to the shared directory.
2023-03-06 02:54:30 (124548): Create VM. (boinc_9164b88c2f969348, slot#13)
2023-03-06 02:54:31 (124548): Setting Memory Size for VM. (1896MB)
2023-03-06 02:54:31 (124548): Setting CPU Count for VM. (1)
2023-03-06 02:54:34 (124548): Setting Chipset Options for VM.
2023-03-06 02:54:36 (124548): Setting Graphics Controller Options for VM.
2023-03-06 02:54:40 (124548): Setting Boot Options for VM.
2023-03-06 02:54:40 (124548): Setting Network Configuration for NAT.
2023-03-06 02:54:41 (124548): Enabling VM Network Access.
2023-03-06 02:54:41 (124548): Disabling USB Support for VM.
2023-03-06 02:54:41 (124548): Disabling COM Port Support for VM.
2023-03-06 02:54:41 (124548): Disabling LPT Port Support for VM.
2023-03-06 02:54:42 (124548): Disabling Audio Support for VM.
2023-03-06 02:54:42 (124548): Disabling Clipboard Support for VM.
2023-03-06 02:54:42 (124548): Disabling Drag and Drop Support for VM.
2023-03-06 02:54:43 (124548): Adding storage controller(s) to VM.
2023-03-06 02:54:43 (124548): Adding virtual disk drive to VM. (CMS_2022_09_07.vdi)
2023-03-06 02:54:52 (124548): Adding VirtualBox Guest Additions to VM.
2023-03-06 02:54:52 (124548): Adding network bandwidth throttle group to VM. (Defaulting to 1024GB)
2023-03-06 02:54:52 (124548): forwarding host port 60174 to guest port 80
2023-03-06 02:54:53 (124548): Enabling remote desktop for VM.
2023-03-06 02:54:53 (124548): Required extension pack not installed, remote desktop not enabled.
2023-03-06 02:54:53 (124548): Enabling shared directory for VM.
2023-03-06 02:54:54 (124548): Starting VM using VBoxManage interface. (boinc_9164b88c2f969348, slot#13)
2023-03-06 02:55:12 (124548): Successfully started VM. (PID = '126200')
2023-03-06 02:55:12 (124548): Reporting VM Process ID to BOINC.
2023-03-06 02:55:12 (124548): Guest Log: BIOS: VirtualBox 6.1.34
2023-03-06 02:55:12 (124548): Guest Log: CPUID EDX: 0x178bfbff
2023-03-06 02:55:12 (124548): Guest Log: BIOS: No PCI IDE controller, not probing IDE
2023-03-06 02:55:12 (124548): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors
2023-03-06 02:55:12 (124548): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2023-03-06 02:55:12 (124548): Guest Log: BIOS: Booting from Hard Disk...
2023-03-06 02:55:12 (124548): VM state change detected. (old = 'poweredoff', new = 'running')
2023-03-06 02:55:12 (124548): Detected: Web Application Enabled (http://localhost:60174)
2023-03-06 02:55:12 (124548): Preference change detected
2023-03-06 02:55:12 (124548): Setting CPU throttle for VM. (100%)
2023-03-06 02:55:14 (124548): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2023-03-06 02:55:14 (124548): Guest Log: BIOS: KBD: unsupported int 16h function 03
2023-03-06 02:55:14 (124548): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 
2023-03-06 02:55:47 (124548): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2023-03-06 02:55:47 (124548): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)
2023-03-06 02:55:50 (124548): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log
2023-03-06 02:55:50 (124548): Guest Log: 00:00:00.000119 main     Log opened 2023-03-06T09:55:49.446825000Z
2023-03-06 02:55:50 (124548): Guest Log: 00:00:00.000273 main     OS Product: Linux
2023-03-06 02:55:50 (124548): Guest Log: 00:00:00.000349 main     OS Release: 4.14.232-19.cernvm.x86_64
2023-03-06 02:55:50 (124548): Guest Log: 00:00:00.000415 main     OS Version: #1 SMP Fri Apr 30 17:12:25 CEST 2021
2023-03-06 02:55:50 (124548): Guest Log: 00:00:00.000483 main     Executable: /usr/sbin/VBoxService
2023-03-06 02:55:50 (124548): Guest Log: 00:00:00.000485 main     Process ID: 2168
2023-03-06 02:55:50 (124548): Guest Log: 00:00:00.000487 main     Package type: LINUX_64BITS_GENERIC
2023-03-06 02:55:50 (124548): Guest Log: 00:00:00.004081 main     5.2.6 r120293 started. Verbose level = 0
2023-03-06 02:56:15 (124548): Guest Log: [INFO] Mounting the shared directory
2023-03-06 02:56:15 (124548): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor
2023-03-06 02:56:15 (124548): Guest Log: [INFO] Sourcing essential functions from /cvmfs/grid.cern.ch
2023-03-06 02:56:15 (124548): Guest Log: [INFO] Testing connection to cern.ch
2023-03-06 02:56:17 (124548): Guest Log: [INFO] Testing connection to VCCS
2023-03-06 02:56:17 (124548): Guest Log: [INFO] Testing connection to HTCondor
2023-03-06 02:56:19 (124548): Guest Log: [INFO] Testing connection to WMAgent
2023-03-06 02:56:19 (124548): Guest Log: [INFO] Testing connection to EOSCMS
2023-03-06 02:56:22 (124548): Guest Log: [INFO] Testing connection to CMS-Factory
2023-03-06 02:56:22 (124548): Guest Log: [INFO] Testing connection to CMS-Frontier
2023-03-06 02:56:22 (124548): Guest Log: [INFO] Testing connection to Frontier
2023-03-06 02:56:31 (124548): Guest Log: [INFO] Could not find a local HTTP proxy
2023-03-06 02:56:31 (124548): Guest Log: [INFO] CVMFS and Frontier will have to use DIRECT connections
2023-03-06 02:56:31 (124548): Guest Log: [INFO] This makes the application less efficient
2023-03-06 02:56:32 (124548): Guest Log: [INFO] It also puts higher load on the project servers
2023-03-06 02:56:32 (124548): Guest Log: [INFO] Setting up a local HTTP proxy is highly recommended
2023-03-06 02:56:32 (124548): Guest Log: [INFO] Advice can be found in the project forum
2023-03-06 02:56:32 (124548): Guest Log: [INFO] Reloading and probing the CVMFS configuration
2023-03-06 02:56:37 (124548): Guest Log: [INFO] Probing /cvmfs/grid.cern.ch... OK
2023-03-06 02:56:47 (124548): Guest Log: [INFO] Probing /cvmfs/cms-ib.cern.ch... OK
2023-03-06 02:56:47 (124548): Guest Log: [INFO] Probing /cvmfs/oasis.opensciencegrid.org... OK
2023-03-06 02:56:47 (124548): Guest Log: [INFO] Probing /cvmfs/cms.cern.ch... OK
2023-03-06 02:56:47 (124548): Guest Log: [INFO] Probing /cvmfs/singularity.opensciencegrid.org... OK
2023-03-06 02:56:47 (124548): Guest Log: [INFO] Excerpt from "cvmfs_config stat": VERSION HOST PROXY
2023-03-06 02:56:47 (124548): Guest Log: [INFO] 2.7.2.0 http://s1cern-cvmfs.openhtc.io DIRECT
2023-03-06 02:56:47 (124548): Guest Log: [INFO] Environment HTTP proxy: not set
2023-03-06 02:56:47 (124548): Guest Log: [INFO] Reading volunteer information
2023-03-06 02:57:06 (124548): Guest Log: [INFO] Requesting an X509 credential from LHC@home
2023-03-06 02:57:06 (124548): Guest Log: [INFO] Requesting an X509 credential from vLHC@home-dev
2023-03-06 02:57:07 (124548): Guest Log: [INFO] CMS application starting. Check log files.
2023-03-06 02:57:09 (124548): Guest Log: [INFO] Requesting an idtoken from LHC@home
2023-03-06 02:57:09 (124548): Guest Log: [INFO] Requesting an idtoken from vLHC@home-dev
2023-03-06 05:29:10 (124548): Status Report: Job Duration: '64800.000000'
2023-03-06 05:29:10 (124548): Status Report: Elapsed Time: '6001.439436'
2023-03-06 05:29:10 (124548): Status Report: CPU Time: '7075.765625'
2023-03-06 06:21:08 (124548): Stopping VM.
2023-03-06 06:21:27 (124548): Successfully stopped VM.
2023-03-06 06:38:05 (122704): Detected: vboxwrapper 26206
2023-03-06 06:38:05 (122704): Detected: BOINC client v7.20.2
2023-03-06 06:38:17 (122704): Detected: VirtualBox VboxManage Interface (Version: 6.1.34)
2023-03-06 06:38:18 (122704): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2023-03-06 06:38:32 (122704): Guest Log: BIOS: VirtualBox 6.1.34
2023-03-06 06:38:32 (122704): Guest Log: CPUID EDX: 0x178bfbff
2023-03-06 06:38:32 (122704): Guest Log: BIOS: No PCI IDE controller, not probing IDE
2023-03-06 06:38:32 (122704): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors
2023-03-06 06:38:32 (122704): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2023-03-06 06:38:32 (122704): Guest Log: BIOS: Booting from Hard Disk...
2023-03-06 06:38:32 (122704): Guest Log: BIOS: KBD: unsupported int 16h function 03
2023-03-06 06:38:32 (122704): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 
2023-03-06 06:38:32 (122704): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2023-03-06 06:38:32 (122704): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)
2023-03-06 06:38:32 (122704): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log
2023-03-06 06:38:32 (122704): Guest Log: 00:00:00.000119 main     Log opened 2023-03-06T09:55:49.446825000Z
2023-03-06 06:38:32 (122704): Guest Log: 00:00:00.000273 main     OS Product: Linux
2023-03-06 06:38:32 (122704): Guest Log: 00:00:00.000349 main     OS Release: 4.14.232-19.cernvm.x86_64
2023-03-06 06:38:32 (122704): Guest Log: 00:00:00.000415 main     OS Version: #1 SMP Fri Apr 30 17:12:25 CEST 2021
2023-03-06 06:38:32 (122704): Guest Log: 00:00:00.000483 main     Executable: /usr/sbin/VBoxService
2023-03-06 06:38:32 (122704): Guest Log: 00:00:00.000485 main     Process ID: 2168
2023-03-06 06:38:32 (122704): Guest Log: 00:00:00.000487 main     Package type: LINUX_64BITS_GENERIC
2023-03-06 06:38:32 (122704): Guest Log: 00:00:00.004081 main     5.2.6 r120293 started. Verbose level = 0
2023-03-06 06:38:32 (122704): Guest Log: [INFO] Mounting the shared directory
2023-03-06 06:38:32 (122704): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor
2023-03-06 06:38:32 (122704): Guest Log: [INFO] Sourcing essential functions from /cvmfs/grid.cern.ch
2023-03-06 06:38:32 (122704): Guest Log: [INFO] Testing connection to cern.ch
2023-03-06 06:38:32 (122704): Guest Log: [INFO] Testing connection to VCCS
2023-03-06 06:38:32 (122704): Guest Log: [INFO] Testing connection to HTCondor
2023-03-06 06:38:32 (122704): Guest Log: [INFO] Testing connection to WMAgent
2023-03-06 06:38:32 (122704): Guest Log: [INFO] Testing connection to EOSCMS
2023-03-06 06:38:32 (122704): Guest Log: [INFO] Testing connection to CMS-Factory
2023-03-06 06:38:32 (122704): Guest Log: [INFO] Testing connection to CMS-Frontier
2023-03-06 06:38:32 (122704): Guest Log: [INFO] Testing connection to Frontier
2023-03-06 06:38:32 (122704): Guest Log: [INFO] Could not find a local HTTP proxy
2023-03-06 06:38:32 (122704): Guest Log: [INFO] CVMFS and Frontier will have to use DIRECT connections
2023-03-06 06:38:32 (122704): Guest Log: [INFO] This makes the application less efficient
2023-03-06 06:38:32 (122704): Guest Log: [INFO] It also puts higher load on the project servers
2023-03-06 06:38:32 (122704): Guest Log: [INFO] Setting up a local HTTP proxy is highly recommended
2023-03-06 06:38:32 (122704): Guest Log: [INFO] Advice can be found in the project forum
2023-03-06 06:38:32 (122704): Guest Log: [INFO] Reloading and probing the CVMFS configuration
2023-03-06 06:38:32 (122704): Guest Log: [INFO] Probing /cvmfs/grid.cern.ch... OK
2023-03-06 06:38:32 (122704): Guest Log: [INFO] Probing /cvmfs/cms-ib.cern.ch... OK
2023-03-06 06:38:32 (122704): Guest Log: [INFO] Probing /cvmfs/oasis.opensciencegrid.org... OK
2023-03-06 06:38:32 (122704): Guest Log: [INFO] Probing /cvmfs/cms.cern.ch... OK
2023-03-06 06:38:32 (122704): Guest Log: [INFO] Probing /cvmfs/singularity.opensciencegrid.org... OK
2023-03-06 06:38:32 (122704): Guest Log: [INFO] Excerpt from "cvmfs_config stat": VERSION HOST PROXY
2023-03-06 06:38:32 (122704): Guest Log: [INFO] 2.7.2.0 http://s1cern-cvmfs.openhtc.io DIRECT
2023-03-06 06:38:32 (122704): Guest Log: [INFO] Environment HTTP proxy: not set
2023-03-06 06:38:32 (122704): Guest Log: [INFO] Reading volunteer information
2023-03-06 06:38:32 (122704): Guest Log: [INFO] Requesting an X509 credential from LHC@home
2023-03-06 06:38:32 (122704): Guest Log: [INFO] Requesting an X509 credential from vLHC@home-dev
2023-03-06 06:38:32 (122704): Guest Log: [INFO] CMS application starting. Check log files.
2023-03-06 06:38:32 (122704): Guest Log: [INFO] Requesting an idtoken from LHC@home
2023-03-06 06:38:32 (122704): Guest Log: [INFO] Requesting an idtoken from vLHC@home-dev
2023-03-06 06:38:32 (122704): Starting VM using VBoxManage interface. (boinc_9164b88c2f969348, slot#13)
2023-03-06 06:38:32 (122704): Error in start VM for VM: -108
Command:
VBoxManage -q startvm "boinc_9164b88c2f969348" --type headless
Output:

2023-03-06 06:38:32 (122704): VM failed to start.
2023-03-06 06:38:32 (122704): Could not start 
2023-03-06 06:38:32 (122704): ERROR: VM failed to start
2023-03-06 06:38:32 (122704): Powering off VM.
2023-03-06 06:38:32 (122704): Deregistering VM. (boinc_9164b88c2f969348, slot#13)
2023-03-06 06:38:32 (122704): Removing network bandwidth throttle group from VM.
2023-03-06 06:38:33 (122704): Removing VM from VirtualBox.

    Hypervisor System Log:

03:40:35.898302          ERROR [COM]: aRC=VBOX_E_OBJECT_NOT_FOUND (0x80bb0001) aIID={85632c68-b5bb-4316-a900-5eb28d3413df} aComponent={SessionMachine} aText={No storage device attached to device slot 0 on port 1 of controller 'Hard Disk Controller'}, preserve=false aResultDetail=0
03:40:35.898714          ERROR [COM]: aRC=VBOX_E_OBJECT_NOT_FOUND (0x80bb0001) aIID={85632c68-b5bb-4316-a900-5eb28d3413df} aComponent={SessionMachine} aText={No storage device attached to device slot 0 on port 1 of controller 'Hard Disk Controller'}, preserve=false aResultDetail=0
03:40:35.951571          ERROR [COM]: aRC=E_FAIL (0x80004005) aIID={85632c68-b5bb-4316-a900-5eb28d3413df} aComponent={SessionMachine} aText={This machine does not have any snapshots}, preserve=false aResultDetail=0
03:40:46.137717          ERROR [COM]: aRC=VBOX_E_OBJECT_NOT_FOUND (0x80bb0001) aIID={85632c68-b5bb-4316-a900-5eb28d3413df} aComponent={SessionMachine} aText={No storage device attached to device slot 0 on port 1 of controller 'Hard Disk Controller'}, preserve=false aResultDetail=0
03:40:46.138087          ERROR [COM]: aRC=VBOX_E_OBJECT_NOT_FOUND (0x80bb0001) aIID={85632c68-b5bb-4316-a900-5eb28d3413df} aComponent={SessionMachine} aText={No storage device attached to device slot 0 on port 1 of controller 'Hard Disk Controller'}, preserve=false aResultDetail=0
03:40:46.161082          ERROR [COM]: aRC=E_FAIL (0x80004005) aIID={85632c68-b5bb-4316-a900-5eb28d3413df} aComponent={SessionMachine} aText={This machine does not have any snapshots}, preserve=false aResultDetail=0
03:40:58.855352          ERROR [COM]: aRC=VBOX_E_OBJECT_NOT_FOUND (0x80bb0001) aIID={85632c68-b5bb-4316-a900-5eb28d3413df} aComponent={SessionMachine} aText={No storage device attached to device slot 0 on port 1 of controller 'Hard Disk Controller'}, preserve=false aResultDetail=0
03:40:58.855686          ERROR [COM]: aRC=VBOX_E_OBJECT_NOT_FOUND (0x80bb0001) aIID={85632c68-b5bb-4316-a900-5eb28d3413df} aComponent={SessionMachine} aText={No storage device attached to device slot 0 on port 1 of controller 'Hard Disk Controller'}, preserve=false aResultDetail=0
03:40:58.878714          ERROR [COM]: aRC=E_FAIL (0x80004005) aIID={85632c68-b5bb-4316-a900-5eb28d3413df} aComponent={SessionMachine} aText={This machine does not have any snapshots}, preserve=false aResultDetail=0
03:41:13.838420          ERROR [COM]: aRC=VBOX_E_OBJECT_NOT_FOUND (0x80bb0001) aIID={85632c68-b5bb-4316-a900-5eb28d3413df} aComponent={SessionMachine} aText={No storage device attached to device slot 0 on port 1 of controller 'Hard Disk Controller'}, preserve=false aResultDetail=0
03:41:13.838864          ERROR [COM]: aRC=VBOX_E_OBJECT_NOT_FOUND (0x80bb0001) aIID={85632c68-b5bb-4316-a900-5eb28d3413df} aComponent={SessionMachine} aText={No storage device attached to device slot 0 on port 1 of controller 'Hard Disk Controller'}, preserve=false aResultDetail=0
03:41:13.863979          ERROR [COM]: aRC=E_FAIL (0x80004005) aIID={85632c68-b5bb-4316-a900-5eb28d3413df} aComponent={SessionMachine} aText={This machine does not have any snapshots}, preserve=false aResultDetail=0
03:41:40.204205          ERROR [COM]: aRC=VBOX_E_OBJECT_NOT_FOUND (0x80bb0001) aIID={85632c68-b5bb-4316-a900-5eb28d3413df} aComponent={SessionMachine} aText={No storage device attached to device slot 0 on port 1 of controller 'Hard Disk Controller'}, preserve=false aResultDetail=0
03:41:40.205980          ERROR [COM]: aRC=VBOX_E_OBJECT_NOT_FOUND (0x80bb0001) aIID={85632c68-b5bb-4316-a900-5eb28d3413df} aComponent={SessionMachine} aText={No storage device attached to device slot 0 on port 1 of controller 'Hard Disk Controller'}, preserve=false aResultDetail=0
03:41:40.269870          ERROR [COM]: aRC=E_FAIL (0x80004005) aIID={85632c68-b5bb-4316-a900-5eb28d3413df} aComponent={SessionMachine} aText={This machine does not have any snapshots}, preserve=false aResultDetail=0
03:41:46.477374          ERROR [COM]: aRC=VBOX_E_OBJECT_NOT_FOUND (0x80bb0001) aIID={85632c68-b5bb-4316-a900-5eb28d3413df} aComponent={SessionMachine} aText={No storage device attached to device slot 0 on port 1 of controller 'Hard Disk Controller'}, preserve=false aResultDetail=0
03:41:46.477727          ERROR [COM]: aRC=VBOX_E_OBJECT_NOT_FOUND (0x80bb0001) aIID={85632c68-b5bb-4316-a900-5eb28d3413df} aComponent={SessionMachine} aText={No storage device attached to device slot 0 on port 1 of controller 'Hard Disk Controller'}, preserve=false aResultDetail=0
03:41:46.506148          ERROR [COM]: aRC=E_FAIL (0x80004005) aIID={85632c68-b5bb-4316-a900-5eb28d3413df} aComponent={SessionMachine} aText={This machine does not have any snapshots}, preserve=false aResultDetail=0
03:42:03.814578          ERROR [COM]: aRC=VBOX_E_OBJECT_NOT_FOUND (0x80bb0001) aIID={85632c68-b5bb-4316-a900-5eb28d3413df} aComponent={SessionMachine} aText={No storage device attached to device slot 0 on port 1 of controller 'Hard Disk Controller'}, preserve=false aResultDetail=0
03:42:03.814896          ERROR [COM]: aRC=VBOX_E_OBJECT_NOT_FOUND (0x80bb0001) aIID={85632c68-b5bb-4316-a900-5eb28d3413df} aComponent={SessionMachine} aText={No storage device attached to device slot 0 on port 1 of controller 'Hard Disk Controller'}, preserve=false aResultDetail=0
03:42:03.838636          ERROR [COM]: aRC=E_FAIL (0x80004005) aIID={85632c68-b5bb-4316-a900-5eb28d3413df} aComponent={SessionMachine} aText={This machine does not have any snapshots}, preserve=false aResultDetail=0
03:42:48.206519          ERROR [COM]: aRC=VBOX_E_OBJECT_NOT_FOUND (0x80bb0001) aIID={85632c68-b5bb-4316-a900-5eb28d3413df} aComponent={SessionMachine} aText={No storage device attached to device slot 0 on port 1 of controller 'Hard Disk Controller'}, preserve=false aResultDetail=0
03:42:48.207326          ERROR [COM]: aRC=VBOX_E_OBJECT_NOT_FOUND (0x80bb0001) aIID={85632c68-b5bb-4316-a900-5eb28d3413df} aComponent={SessionMachine} aText={No storage device attached to device slot 0 on port 1 of controller 'Hard Disk Controller'}, preserve=false aResultDetail=0
03:42:48.364417          ERROR [COM]: aRC=E_FAIL (0x80004005) aIID={85632c68-b5bb-4316-a900-5eb28d3413df} aComponent={SessionMachine} aText={This machine does not have any snapshots}, preserve=false aResultDetail=0
03:43:01.915859          ERROR [COM]: aRC=VBOX_E_OBJECT_NOT_FOUND (0x80bb0001) aIID={85632c68-b5bb-4316-a900-5eb28d3413df} aComponent={SessionMachine} aText={No storage device attached to device slot 0 on port 1 of controller 'Hard Disk Controller'}, preserve=false aResultDetail=0
03:43:01.916259          ERROR [COM]: aRC=VBOX_E_OBJECT_NOT_FOUND (0x80bb0001) aIID={85632c68-b5bb-4316-a900-5eb28d3413df} aComponent={SessionMachine} aText={No storage device attached to device slot 0 on port 1 of controller 'Hard Disk Controller'}, preserve=false aResultDetail=0
03:43:01.941943          ERROR [COM]: aRC=E_FAIL (0x80004005) aIID={85632c68-b5bb-4316-a900-5eb28d3413df} aComponent={SessionMachine} aText={This machine does not have any snapshots}, preserve=false aResultDetail=0
03:43:30.234710          ERROR [COM]: aRC=VBOX_E_OBJECT_NOT_FOUND (0x80bb0001) aIID={85632c68-b5bb-4316-a900-5eb28d3413df} aComponent={SessionMachine} aText={No storage device attached to device slot 0 on port 2 of controller 'Hard Disk Controller'}, preserve=false aResultDetail=0
03:43:30.235020          ERROR [COM]: aRC=VBOX_E_OBJECT_NOT_FOUND (0x80bb0001) aIID={85632c68-b5bb-4316-a900-5eb28d3413df} aComponent={SessionMachine} aText={No storage device attached to device slot 0 on port 2 of controller 'Hard Disk Controller'}, preserve=false aResultDetail=0
03:43:30.255961          ERROR [COM]: aRC=E_FAIL (0x80004005) aIID={85632c68-b5bb-4316-a900-5eb28d3413df} aComponent={SessionMachine} aText={This machine does not have any snapshots}, preserve=false aResultDetail=0
03:43:46.770960 Watcher  Saving settings file "C:\ProgramData\BOINC\slots\18\boinc_5a22b5251ee2e041\boinc_5a22b5251ee2e041.vbox" with version "1.16-windows"

    VM Execution Log:

            0 ticks/call (           0 ticks,       0 times, max         0, min      -1)
03:26:24.133337 /PROF/CPU0/EM/NEMExecuteCalled          0 times
03:26:24.133346 /PROF/CPU0/EM/RAWTotal                  0 times
03:26:24.133353 /PROF/CPU0/EM/REMTotal                  0 times
03:26:24.133361 /PROF/CPU0/EM/RecordedExits      37881793 times
03:26:24.133368 /PROF/CPU0/EM/Total              33523622528504 ticks/call (33523622528504 ticks,       1 times, max 33523622528504, min 33523622528504)
03:26:24.133378 /PROF/CPU0/VM/Halt/Block           820876 ns/call (542967383316 ticks,  661448 times, max 521648950, min       1)
03:26:24.133386 /PROF/CPU0/VM/Halt/BlockInsomnia   281841 ns/call (133022777642 ticks,  471978 times, max 209547013, min       1)
03:26:24.133394 /PROF/CPU0/VM/Halt/BlockOnTime    1073162 ns/call ( 42475776462 ticks,   39580 times, max 204730192, min    1025)
03:26:24.133404 /PROF/CPU0/VM/Halt/BlockOverslept  1525444 ns/call (228648817134 ticks,  149890 times, max 519071036, min   50001)
03:26:24.133413 /PROF/CPU0/VM/Halt/R0HaltBlock   25095887 ns/call (  4065533750 ticks,     162 times, max 193756121, min    1671)
03:26:24.133422 /PROF/CPU0/VM/Halt/R0HaltBlockInsomnia 16133815 ns/call (  1080965632 ticks,      67 times, max  52975155, min    1671)
03:26:24.133431 /PROF/CPU0/VM/Halt/R0HaltBlockOnTime 16032914 ns/call (   593217819 ticks,      37 times, max  53595828, min 6163076)
03:26:24.133440 /PROF/CPU0/VM/Halt/R0HaltBlockOverslept 14240954 ns/call (   825975348 ticks,      58 times, max 184250865, min   52343)
03:26:24.133447 /PROF/CPU0/VM/Halt/R0HaltExec           0 times
03:26:24.133454 /PROF/CPU0/VM/Halt/R0HaltExec/FromBlock        0 times
03:26:24.133462 /PROF/CPU0/VM/Halt/R0HaltExec/FromSpin        0 times
03:26:24.133470 /PROF/CPU0/VM/Halt/R0HaltHistoryCounter   444703 times
03:26:24.133477 /PROF/CPU0/VM/Halt/R0HaltHistorySucceeded        0 times
03:26:24.133485 /PROF/CPU0/VM/Halt/R0HaltHistoryToRing3       34 times
03:26:24.133492 /PROF/CPU0/VM/Halt/R0HaltToR3      444703 times
03:26:24.133498 /PROF/CPU0/VM/Halt/R0HaltToR3/FromSpin        0 times
03:26:24.133503 /PROF/CPU0/VM/Halt/R0HaltToR3/Other   444508 times
03:26:24.133510 /PROF/CPU0/VM/Halt/R0HaltToR3/PendingFF       33 times
03:26:24.133516 /PROF/CPU0/VM/Halt/R0HaltToR3/PostWaitNoInt      158 times
03:26:24.133524 /PROF/CPU0/VM/Halt/R0HaltToR3/PostWaitPendingFF        4 times
03:26:24.133532 /PROF/CPU0/VM/Halt/R0HaltToR3/SmallDelta        0 times
03:26:24.133584 /PROF/CPU0/VM/Halt/Timers            3255 ns/call (  3757440723 ticks, 1154176 times, max 178629020, min       2)
03:26:24.133601 /PROF/CPU0/VM/Halt/Yield             5914 ns/call (     1389818 ticks,     235 times, max    175918, min    1798)
03:26:24.133612 /Public/NetAdapter/0/BytesReceived 233839966 bytes
03:26:24.133618 /Public/NetAdapter/0/BytesTransmitted  5157107 bytes
03:26:24.133625 /Public/NetAdapter/0/e1000              0 
03:26:24.133632 /Public/Storage/AHCI0/Port0/BytesRead 2096198144 bytes
03:26:24.133639 /Public/Storage/AHCI0/Port0/BytesWritten 864567808 bytes
03:26:24.133646 /Public/Storage/AHCI0/Port0/QueryBufAttempts        0 count
03:26:24.133652 /Public/Storage/AHCI0/Port0/QueryBufSuccess        0 count
03:26:24.133658 /Public/Storage/AHCI0/Port0/ReqsFlush     4788 count
03:26:24.133664 /Public/Storage/AHCI0/Port0/ReqsRead    52922 count
03:26:24.133671 /Public/Storage/AHCI0/Port0/ReqsSubmitted    81827 count
03:26:24.133679 /Public/Storage/AHCI0/Port0/ReqsSucceeded    81827 count
03:26:24.133685 /Public/Storage/AHCI0/Port0/ReqsWrite    24117 count
03:26:24.133692 /Public/Storage/AHCI0/Port1/BytesRead   321536 bytes
03:26:24.133698 /Public/Storage/AHCI0/Port1/QueryBufAttempts        0 count
03:26:24.133703 /Public/Storage/AHCI0/Port1/QueryBufSuccess        0 count
03:26:24.133710 /Public/Storage/AHCI0/Port1/ReqsRead       22 count
03:26:24.133772 /Public/Storage/AHCI0/Port1/ReqsSubmitted       22 count
03:26:24.133892 /Public/Storage/AHCI0/Port1/ReqsSucceeded       22 count
03:26:24.133905 /SELM/LoadHidSel/GstReadErrors          0 times
03:26:24.133912 /SELM/LoadHidSel/NoGoodGuest            0 times
03:26:24.133919 /TM/CPU/00/cNsExecuting          8646941776585 ns
03:26:24.134002 /TM/CPU/00/cNsHalted             547936475628 ns
03:26:24.134018 /TM/CPU/00/cNsOther              3166327656747 ns
03:26:24.134026 /TM/CPU/00/cNsTotal              12361205908960 ns
03:26:24.134032 /TM/CPU/00/cPeriodsExecuting     37881793 count
03:26:24.134040 /TM/CPU/00/cPeriodsHalted          443441 count
03:26:24.134046 /TM/CPU/00/pctExecuting                55 %
03:26:24.134052 /TM/CPU/00/pctHalted                    0 %
03:26:24.134059 /TM/CPU/00/pctOther                    44 %
03:26:24.134067 /TM/CPU/pctExecuting                   55 %
03:26:24.134074 /TM/CPU/pctHalted                       0 %
03:26:24.134082 /TM/CPU/pctOther                       44 %
03:26:24.134088 /TM/MaxHzHint                           0 Hz
03:26:24.134095 /TM/PIT/Handler                         0 ticks/call (           0 ticks,       0 times, max         0, min      -1)
03:26:24.134103 /TM/PIT/Irq                             0 times
03:26:24.134110 /TM/R0/1nsSteps                     13680 times
03:26:24.134140 /TM/R3/1nsSteps                     27414 times
03:26:24.134149 /TM/TSC/offCPU0                  2042553900760418 ticks
03:26:24.134157 /TM/VirtualSync/CurrentOffset     2295508 ns
03:26:24.134166 ********************* End of statistics **********************
03:26:24.146512 NAT: Zone(nm:mbuf_cluster, used:0)
03:26:24.147099 NAT: Zone(nm:mbuf_packet, used:0)
03:26:24.147126 NAT: Zone(nm:mbuf, used:1)
03:26:24.147207 NAT: Zone(nm:mbuf_jumbo_pagesize, used:0)
03:26:24.147933 NAT: Zone(nm:mbuf_jumbo_9k, used:0)
03:26:24.148107 NAT: Zone(nm:mbuf_jumbo_16k, used:0)
03:26:24.148250 NAT: Zone(nm:mbuf_ext_refcnt, used:0)
03:26:24.149483 E1000#0: Interrupt attempts: 340808
03:26:24.149504 E1000#0: Interrupts raised : 89821
03:26:24.149511 E1000#0: Interrupts lowered: 4768
03:26:24.149517 E1000#0: ICR outside ISR   : 0
03:26:24.149523 E1000#0: IMS raised ints   : 22574
03:26:24.149529 E1000#0: Interrupts skipped: 157645
03:26:24.149535 E1000#0: Masked interrupts : 93342
03:26:24.149541 E1000#0: Early interrupts  : 0
03:26:24.149548 E1000#0: Late interrupts   : 6829
03:26:24.149555 E1000#0: Lost interrupts   : 0
03:26:24.149561 E1000#0: Interrupts by RX  : 226991
03:26:24.149568 E1000#0: Interrupts by TX  : 50910
03:26:24.149574 E1000#0: Interrupts by ICS : 5974
03:26:24.149580 E1000#0: Interrupts by RDTR: 0
03:26:24.149587 E1000#0: Interrupts by RDMT: 0
03:26:24.149593 E1000#0: Interrupts by TXQE: 0
03:26:24.149599 E1000#0: TX int delay asked: 0
03:26:24.149606 E1000#0: TX delayed:         0
03:26:24.149613 E1000#0: TX delay expired:   0
03:26:24.149621 E1000#0: TX no report asked: 51154
03:26:24.149627 E1000#0: TX abs timer expd : 0
03:26:24.149635 E1000#0: TX int timer expd : 0
03:26:24.149641 E1000#0: RX abs timer expd : 0
03:26:24.149646 E1000#0: RX int timer expd : 0
03:26:24.149654 E1000#0: TX CTX descriptors: 50657
03:26:24.149661 E1000#0: TX DAT descriptors: 51137
03:26:24.149669 E1000#0: TX LEG descriptors: 270
03:26:24.149675 E1000#0: Received frames   : 226991
03:26:24.149682 E1000#0: Transmitted frames: 50910
03:26:24.149687 E1000#0: TX frames up to 1514: 50737
03:26:24.149694 E1000#0: TX frames up to 2962: 18
03:26:24.149700 E1000#0: TX frames up to 4410: 152
03:26:24.149707 E1000#0: TX frames up to 5858: 0
03:26:24.149714 E1000#0: TX frames up to 7306: 0
03:26:24.149721 E1000#0: TX frames up to 8754: 1
03:26:24.149728 E1000#0: TX frames up to 16384: 2
03:26:24.149734 E1000#0: TX frames up to 32768: 0
03:26:24.149740 E1000#0: Larger TX frames    : 0
03:26:24.149746 E1000#0: Max TX Delay        : 0
03:26:24.152683 GIM: KVM: Resetting MSRs
03:26:24.154980 Changing the VM state from 'DESTROYING' to 'TERMINATED'
03:26:24.157517 Console: Machine state changed to 'Saved'
03:26:24.158600 VBoxHeadless: processEventQueue: VERR_INTERRUPTED, termination requested
03:26:24.595761 VBoxHeadless: exiting

    VM Startup Log:


    VM Trace Log:

put:
6.1.34r150636

2023-03-06 06:38:17 (122704): 
Command: VBoxManage -q list systemproperties
Exit Code: 0
Output:
API version:                     6_1
Minimum guest RAM size:          4 Megabytes
Maximum guest RAM size:          2097152 Megabytes
Minimum video RAM size:          0 Megabytes
Maximum video RAM size:          256 Megabytes
Maximum guest monitor count:     64
Minimum guest CPU count:         1
Maximum guest CPU count:         32
Virtual disk limit (info):       2199022206976 Bytes
Maximum Serial Port count:       4
Maximum Parallel Port count:     2
Maximum Boot Position:           4
Maximum PIIX3 Network Adapter count:   8
Maximum ICH9 Network Adapter count:   36
Maximum PIIX3 IDE Controllers:   1
Maximum ICH9 IDE Controllers:    1
Maximum IDE Port count:          2
Maximum Devices per IDE Port:    2
Maximum PIIX3 SATA Controllers:  1
Maximum ICH9 SATA Controllers:   8
Maximum SATA Port count:         30
Maximum Devices per SATA Port:   1
Maximum PIIX3 SCSI Controllers:  1
Maximum ICH9 SCSI Controllers:   8
Maximum SCSI Port count:         16
Maximum Devices per SCSI Port:   1
Maximum SAS PIIX3 Controllers:   1
Maximum SAS ICH9 Controllers:    8
Maximum SAS Port count:          255
Maximum Devices per SAS Port:    1
Maximum NVMe PIIX3 Controllers:  1
Maximum NVMe ICH9 Controllers:   8
Maximum NVMe Port count:         255
Maximum Devices per NVMe Port:   1
Maximum virtio-scsi PIIX3 Controllers:  1
Maximum virtio-scsi ICH9 Controllers:   8
Maximum virtio-scsi Port count:         256
Maximum Devices per virtio-scsi Port:   1
Maximum PIIX3 Floppy Controllers:1
Maximum ICH9 Floppy Controllers: 1
Maximum Floppy Port count:       1
Maximum Devices per Floppy Port: 2
Default machine folder:          C:\Users\Michael\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:          
Log history count:               3
Default frontend:                
Default audio driver:            DirectSound
Autostart database path:         
Default Guest Additions ISO:     C:\Program Files\Oracle\VirtualBox/VBoxGuestAdditions.iso
Logging Level:                   all
Proxy Mode:                      System
Proxy URL:                       

2023-03-06 06:38:18 (122704): 
Command: VBoxManage -q list hostinfo 
Exit Code: 0
Output:
Host Information:

Host time: 2023-03-06T13:38:18.081000000Z
Processor online count: 12
Processor count: 12
Processor online core count: 6
Processor core count: 6
Processor supports HW virtualization: yes
Processor supports PAE: yes
Processor supports long mode: yes
Processor supports nested paging: yes
Processor supports unrestricted guest: yes
Processor supports nested HW virtualization: yes
Processor#0 speed: unknown
Processor#0 description: Intel(R) Core(TM) i7-10850H CPU @ 2.70GHz
Processor#1 speed: unknown
Processor#1 description: Intel(R) Core(TM) i7-10850H CPU @ 2.70GHz
Processor#2 speed: unknown
Processor#2 description: Intel(R) Core(TM) i7-10850H CPU @ 2.70GHz
Processor#3 speed: unknown
Processor#3 description: Intel(R) Core(TM) i7-10850H CPU @ 2.70GHz
Processor#4 speed: unknown
Processor#4 description: Intel(R) Core(TM) i7-10850H CPU @ 2.70GHz
Processor#5 speed: unknown
Processor#5 description: Intel(R) Core(TM) i7-10850H CPU @ 2.70GHz
Processor#6 speed: unknown
Processor#6 description: Intel(R) Core(TM) i7-10850H CPU @ 2.70GHz
Processor#7 speed: unknown
Processor#7 description: Intel(R) Core(TM) i7-10850H CPU @ 2.70GHz
Processor#8 speed: unknown
Processor#8 description: Intel(R) Core(TM) i7-10850H CPU @ 2.70GHz
Processor#9 speed: unknown
Processor#9 description: Intel(R) Core(TM) i7-10850H CPU @ 2.70GHz
Processor#10 speed: unknown
Processor#10 description: Intel(R) Core(TM) i7-10850H CPU @ 2.70GHz
Processor#11 speed: unknown
Processor#11 description: Intel(R) Core(TM) i7-10850H CPU @ 2.70GHz
Memory size: 16129 MByte
Memory available: 992 MByte
Operating system: Windows 10
Operating system version: 10.0.19044

2023-03-06 06:38:27 (122704): 
Command: VBoxManage -q showvminfo "boinc_9164b88c2f969348" --machinereadable 
Exit Code: 0
Output:
name="boinc_9164b88c2f969348"
groups="/"
ostype="Linux 2.6 / 3.x / 4.x (64-bit)"
UUID="aed37790-4150-496e-9623-b5d06b266a76"
CfgFile="C:\\ProgramData\\BOINC\\slots\\13\\boinc_9164b88c2f969348\\boinc_9164b88c2f969348.vbox"
SnapFldr="C:\\ProgramData\\BOINC\\slots\\13\\boinc_9164b88c2f969348\\Snapshots"
LogFldr="C:\\ProgramData\\BOINC\\slots\\13\\boinc_9164b88c2f969348\\Logs"
hardwareuuid="aed37790-4150-496e-9623-b5d06b266a76"
memory=1896
pagefusion="off"
vram=16
cpuexecutioncap=100
hpet="off"
cpu-profile="host"
chipset="piix3"
firmware="BIOS"
cpus=1
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
rtcuseutc="off"
hwvirtex="on"
nestedpaging="on"
largepages="on"
vtxvpid="on"
vtxux="on"
paravirtprovider="default"
effparavirtprovider="kvm"
VMState="saved"
VMStateChangeTime="2023-03-06T13:21:26.307000000"
VMStateFile="C:\ProgramData\BOINC\slots\13\boinc_9164b88c2f969348\Snapshots\2023-03-06T13-21-09-289391400Z.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\13\boinc_9164b88c2f969348\Snapshots\{3fb21e2a-79b0-407c-a47b-34aade3f93e0}.vdi"
"Hard Disk Controller-ImageUUID-0-0"="3fb21e2a-79b0-407c-a47b-34aade3f93e0"
"Hard Disk Controller-1-0"="C:\Program Files\Oracle\VirtualBox\VBoxGuestAdditions.iso"
"Hard Disk Controller-ImageUUID-1-0"="483d80b7-0b69-4be5-9bf6-75bf72f53bfe"
"Hard Disk Controller-tempeject"="off"
"Hard Disk Controller-IsEjected"="off"
"Hard Disk Controller-2-0"="none"
natnet1="nat"
macaddress1="08002750F56F"
cableconnected1="on"
nic1="nat"
nictype1="82540EM"
nicspeed1="0"
mtu="0"
sockSnd="64"
sockRcv="64"
tcpWndSnd="64"
tcpWndRcv="64"
Forwarding(0)="tcp_60174_80,tcp,127.0.0.1,60174,,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_9164b88c2f969348_net,Network,1099511627776
SharedFolderNameMachineMapping1="shared"
SharedFolderPathMachineMapping1="C:\\ProgramData\\BOINC\\slots\\13\\shared"
videocap="off"
videocapaudio="off"
capturescreens="0"
capturefilename="C:\\ProgramData\\BOINC\\slots\\13\\boinc_9164b88c2f969348\\boinc_9164b88c2f969348.webm"
captureres="1024x768"
capturevideorate=512
capturevideofps=25
captureopts=""
description="CMS_2574800_1677903878.388288_0"
GuestMemoryBalloon=0

2023-03-06 06:38:32 (122704): 
Command: VBoxManage -q startvm "boinc_9164b88c2f969348" --type headless
Exit Code: -108
Output:

2023-03-06 06:38:32 (122704): 
Command: VBoxManage -q snapshot "boinc_9164b88c2f969348" list 
Exit Code: -108
Output:

2023-03-06 06:38:33 (122704): 
Command: VBoxManage -q bandwidthctl "boinc_9164b88c2f969348" remove "boinc_9164b88c2f969348_net" 
Exit Code: -108
Output:

2023-03-06 06:38:34 (122704): 
Command: VBoxManage -q unregistervm "boinc_9164b88c2f969348" --delete 
Exit Code: -108
Output:

06:38:46 (122704): called boinc_finish(-108)
2023-03-06 07:04:59 (20140): Detected: vboxwrapper 26206
2023-03-06 07:04:59 (20140): Detected: BOINC client v7.20.2
2023-03-06 07:05:00 (20140): Detected: VirtualBox VboxManage Interface (Version: 6.1.34)
2023-03-06 07:05:00 (20140): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2023-03-06 07:05:01 (20140): Guest Log: BIOS: VirtualBox 6.1.34
2023-03-06 07:05:01 (20140): Guest Log: CPUID EDX: 0x178bfbff
2023-03-06 07:05:01 (20140): Guest Log: BIOS: No PCI IDE controller, not probing IDE
2023-03-06 07:05:01 (20140): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors
2023-03-06 07:05:01 (20140): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2023-03-06 07:05:01 (20140): Guest Log: BIOS: Booting from Hard Disk...
2023-03-06 07:05:01 (20140): Guest Log: BIOS: KBD: unsupported int 16h function 03
2023-03-06 07:05:01 (20140): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 
2023-03-06 07:05:01 (20140): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2023-03-06 07:05:01 (20140): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)
2023-03-06 07:05:01 (20140): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log
2023-03-06 07:05:01 (20140): Guest Log: 00:00:00.000119 main     Log opened 2023-03-06T09:55:49.446825000Z
2023-03-06 07:05:01 (20140): Guest Log: 00:00:00.000273 main     OS Product: Linux
2023-03-06 07:05:01 (20140): Guest Log: 00:00:00.000349 main     OS Release: 4.14.232-19.cernvm.x86_64
2023-03-06 07:05:01 (20140): Guest Log: 00:00:00.000415 main     OS Version: #1 SMP Fri Apr 30 17:12:25 CEST 2021
2023-03-06 07:05:01 (20140): Guest Log: 00:00:00.000483 main     Executable: /usr/sbin/VBoxService
2023-03-06 07:05:01 (20140): Guest Log: 00:00:00.000485 main     Process ID: 2168
2023-03-06 07:05:01 (20140): Guest Log: 00:00:00.000487 main     Package type: LINUX_64BITS_GENERIC
2023-03-06 07:05:01 (20140): Guest Log: 00:00:00.004081 main     5.2.6 r120293 started. Verbose level = 0
2023-03-06 07:05:01 (20140): Guest Log: [INFO] Mounting the shared directory
2023-03-06 07:05:01 (20140): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor
2023-03-06 07:05:01 (20140): Guest Log: [INFO] Sourcing essential functions from /cvmfs/grid.cern.ch
2023-03-06 07:05:01 (20140): Guest Log: [INFO] Testing connection to cern.ch
2023-03-06 07:05:01 (20140): Guest Log: [INFO] Testing connection to VCCS
2023-03-06 07:05:01 (20140): Guest Log: [INFO] Testing connection to HTCondor
2023-03-06 07:05:01 (20140): Guest Log: [INFO] Testing connection to WMAgent
2023-03-06 07:05:01 (20140): Guest Log: [INFO] Testing connection to EOSCMS
2023-03-06 07:05:01 (20140): Guest Log: [INFO] Testing connection to CMS-Factory
2023-03-06 07:05:01 (20140): Guest Log: [INFO] Testing connection to CMS-Frontier
2023-03-06 07:05:01 (20140): Guest Log: [INFO] Testing connection to Frontier
2023-03-06 07:05:01 (20140): Guest Log: [INFO] Could not find a local HTTP proxy
2023-03-06 07:05:01 (20140): Guest Log: [INFO] CVMFS and Frontier will have to use DIRECT connections
2023-03-06 07:05:01 (20140): Guest Log: [INFO] This makes the application less efficient
2023-03-06 07:05:01 (20140): Guest Log: [INFO] It also puts higher load on the project servers
2023-03-06 07:05:01 (20140): Guest Log: [INFO] Setting up a local HTTP proxy is highly recommended
2023-03-06 07:05:01 (20140): Guest Log: [INFO] Advice can be found in the project forum
2023-03-06 07:05:01 (20140): Guest Log: [INFO] Reloading and probing the CVMFS configuration
2023-03-06 07:05:01 (20140): Guest Log: [INFO] Probing /cvmfs/grid.cern.ch... OK
2023-03-06 07:05:01 (20140): Guest Log: [INFO] Probing /cvmfs/cms-ib.cern.ch... OK
2023-03-06 07:05:01 (20140): Guest Log: [INFO] Probing /cvmfs/oasis.opensciencegrid.org... OK
2023-03-06 07:05:01 (20140): Guest Log: [INFO] Probing /cvmfs/cms.cern.ch... OK
2023-03-06 07:05:01 (20140): Guest Log: [INFO] Probing /cvmfs/singularity.opensciencegrid.org... OK
2023-03-06 07:05:01 (20140): Guest Log: [INFO] Excerpt from "cvmfs_config stat": VERSION HOST PROXY
2023-03-06 07:05:01 (20140): Guest Log: [INFO] 2.7.2.0 http://s1cern-cvmfs.openhtc.io DIRECT
2023-03-06 07:05:01 (20140): Guest Log: [INFO] Environment HTTP proxy: not set
2023-03-06 07:05:01 (20140): Guest Log: [INFO] Reading volunteer information
2023-03-06 07:05:01 (20140): Guest Log: [INFO] Requesting an X509 credential from LHC@home
2023-03-06 07:05:01 (20140): Guest Log: [INFO] Requesting an X509 credential from vLHC@home-dev
2023-03-06 07:05:01 (20140): Guest Log: [INFO] CMS application starting. Check log files.
2023-03-06 07:05:01 (20140): Guest Log: [INFO] Requesting an idtoken from LHC@home
2023-03-06 07:05:01 (20140): Guest Log: [INFO] Requesting an idtoken from vLHC@home-dev
2023-03-06 07:05:01 (20140): Starting VM using VBoxManage interface. (boinc_9164b88c2f969348, slot#13)
2023-03-06 07:05:26 (20140): Successfully started VM. (PID = '31104')
2023-03-06 07:05:26 (20140): Reporting VM Process ID to BOINC.
2023-03-06 07:05:26 (20140): VM state change detected. (old = 'poweredoff', new = 'running')
2023-03-06 07:05:26 (20140): Detected: Web Application Enabled (http://localhost:60174)
2023-03-06 07:05:26 (20140): Status Report: Job Duration: '64800.000000'
2023-03-06 07:05:26 (20140): Status Report: Elapsed Time: '7968.620565'
2023-03-06 07:05:26 (20140): Status Report: CPU Time: '9663.812500'
2023-03-06 07:05:26 (20140): Preference change detected
2023-03-06 07:05:26 (20140): Setting CPU throttle for VM. (100%)
2023-03-06 07:05:27 (20140): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2023-03-06 07:05:28 (20140): Guest Log: 03:25:23.955282 timesync vgsvcTimeSyncWorker: Radical host time change: 2 664 235 000 000ns (HostNow=1 678 111 527 613 000 000 ns HostLast=1 678 108 863 378 000 000 ns)
2023-03-06 07:05:38 (20140): Guest Log: 03:25:33.959838 timesync vgsvcTimeSyncWorker: Radical guest time change: 2 664 243 772 000ns (GuestNow=1 678 111 537 623 908 000 ns GuestLast=1 678 108 873 380 136 000 ns fSetTimeLastLoop=true )
2023-03-06 09:13:34 (20140): Status Report: Job Duration: '64800.000000'
2023-03-06 09:13:34 (20140): Status Report: Elapsed Time: '13968.955629'
2023-03-06 09:13:34 (20140): Status Report: CPU Time: '16841.687500'
2023-03-06 11:23:52 (20140): Status Report: Job Duration: '64800.000000'
2023-03-06 11:23:52 (20140): Status Report: Elapsed Time: '19969.404232'
2023-03-06 11:23:52 (20140): Status Report: CPU Time: '24160.265625'
2023-03-06 13:34:05 (20140): Status Report: Job Duration: '64800.000000'
2023-03-06 13:34:05 (20140): Status Report: Elapsed Time: '25969.430761'
2023-03-06 13:34:05 (20140): Status Report: CPU Time: '31723.843750'
2023-03-06 14:56:10 (20140): Guest Log: [INFO] glidein exited with return value 0.
2023-03-06 14:56:10 (20140): Guest Log: [INFO] Shutting Down.
2023-03-06 14:56:10 (20140): VM Completion File Detected.
2023-03-06 14:56:10 (20140): VM Completion Message: glidein exited with return value 0.
.
2023-03-06 14:56:10 (20140): Powering off VM.
2023-03-06 14:56:11 (20140): Successfully stopped VM.
2023-03-06 14:56:11 (20140): Deregistering VM. (boinc_9164b88c2f969348, slot#13)
2023-03-06 14:56:12 (20140): Removing network bandwidth throttle group from VM.
2023-03-06 14:56:12 (20140): Removing VM from VirtualBox.
14:56:17 (20140): called boinc_finish(0)

</stderr_txt>
]]>


©2024 CERN