Name Theory_2914-4729044-18_1
Workunit 232860330
Created 5 Jun 2025, 9:16:36 UTC
Sent 5 Jun 2025, 19:39:13 UTC
Report deadline 16 Jun 2025, 19:39:13 UTC
Received 5 Jun 2025, 21:54:28 UTC
Server state Over
Outcome Computation error
Client state Compute error
Exit status 74 (0x0000004A) Unknown error code
Computer ID 10862163
Run time 1 hours 39 min 26 sec
CPU time 36 min 15 sec
Validate state Invalid
Credit 0.00
Device peak FLOPS 8.96 GFLOPS
Application version Theory Simulation v300.95 (vbox64_theory)
x86_64-pc-linux-gnu
Peak working set size 700.64 MB
Peak swap size 2.04 GB
Peak disk usage 1.74 GB

Stderr output

<core_client_version>8.0.2</core_client_version>
<![CDATA[
<message>
process exited with code 74 (0x4a, -182)</message>
<stderr_txt>
2025-06-05 22:13:37 (524910): vboxwrapper version 26210
2025-06-05 22:13:37 (524910): BOINC client version: 8.0.2
2025-06-05 22:13:37 (524910): Detected: VirtualBox VboxManage Interface (Version: 7.1.8)
2025-06-05 22:13:37 (524910): Detected: Heartbeat check (file: 'heartbeat' every 1800.000000 seconds)
2025-06-05 22:13:37 (524910): Successfully copied 'init_data.xml' to the shared directory.
2025-06-05 22:13:37 (524910): Successfully copied 'input' to the shared directory.
2025-06-05 22:13:37 (524910): Create VM. (boinc_8d6cd16a4aa5ee37, slot#0)
2025-06-05 22:13:39 (524910): Setting Memory Size for VM. (630MB)
2025-06-05 22:13:39 (524910): Setting CPU Count for VM. (1)
2025-06-05 22:13:39 (524910): Setting Chipset Options for VM.
2025-06-05 22:13:39 (524910): Setting Graphics Controller Options for VM. (Driver: VBoxVGA, 16MB)
2025-06-05 22:13:40 (524910): Setting Boot Options for VM.
2025-06-05 22:13:40 (524910): Setting Network Configuration for NAT. (Driver: virtio)
2025-06-05 22:13:40 (524910): Enabling VM Network Access.
2025-06-05 22:13:40 (524910): Disabling USB Support for VM.
2025-06-05 22:13:40 (524910): Disabling COM Port Support for VM.
2025-06-05 22:13:41 (524910): Disabling LPT Port Support for VM.
2025-06-05 22:13:41 (524910): Disabling Audio Support for VM.
2025-06-05 22:13:41 (524910): Disabling Clipboard Support for VM.
2025-06-05 22:13:41 (524910): Disabling Drag and Drop Support for VM.
2025-06-05 22:13:42 (524910): Adding storage controller(s) to VM.
2025-06-05 22:13:42 (524910): Adding virtual disk drive to VM. (Theory_2025_04_17_prod.vdi)
2025-06-05 22:13:42 (524910): Adding network bandwidth throttle group to VM. (Defaulting to 1024GB)
2025-06-05 22:13:42 (524910): forwarding host port 42691 to guest port 80
2025-06-05 22:13:43 (524910): Enabling remote desktop for VM.
2025-06-05 22:13:43 (524910): Enabling shared directory for VM.
2025-06-05 22:13:44 (524910): Starting VM using VBoxManage interface. (boinc_8d6cd16a4aa5ee37, slot#0)
2025-06-05 22:13:45 (524910): Successfully started VM. (PID = '525395')
2025-06-05 22:13:45 (524910): Reporting VM Process ID to BOINC.
2025-06-05 22:13:45 (524910): Guest Log: BIOS: VirtualBox 7.1.8
2025-06-05 22:13:45 (524910): Guest Log: CPUID EDX: 0x178bfbff
2025-06-05 22:13:45 (524910): Guest Log: BIOS: No PCI IDE controller, not probing IDE
2025-06-05 22:13:45 (524910): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000001400000 sectors
2025-06-05 22:13:45 (524910): VM state change detected. (old = 'poweredoff', new = 'running')
2025-06-05 22:13:45 (524910): Detected: Web Application Enabled (http://localhost:42691)
2025-06-05 22:13:45 (524910): Detected: Remote Desktop Enabled (localhost:39273)
2025-06-05 22:13:45 (524910): Preference change detected
2025-06-05 22:13:45 (524910): Setting CPU throttle for VM. (100%)
2025-06-05 22:13:45 (524910): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 300 seconds) or (Vbox_job.xml: 600 seconds))
2025-06-05 22:13:47 (524910): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2025-06-05 22:13:47 (524910): Guest Log: BIOS: Booting from Hard Disk...
2025-06-05 22:13:50 (524910): Guest Log: BIOS: KBD: unsupported int 16h function 03
2025-06-05 22:13:50 (524910): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 
2025-06-05 22:13:50 (524910): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=81
2025-06-05 22:13:50 (524910): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=81
2025-06-05 22:13:50 (524910): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=82
2025-06-05 22:13:50 (524910): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=82
2025-06-05 22:13:50 (524910): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=83
2025-06-05 22:13:50 (524910): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=83
2025-06-05 22:13:50 (524910): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=84
2025-06-05 22:13:50 (524910): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=84
2025-06-05 22:13:50 (524910): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=85
2025-06-05 22:13:50 (524910): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=85
2025-06-05 22:13:50 (524910): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=86
2025-06-05 22:13:50 (524910): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=86
2025-06-05 22:13:50 (524910): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=87
2025-06-05 22:13:50 (524910): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=87
2025-06-05 22:13:50 (524910): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=88
2025-06-05 22:13:50 (524910): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=88
2025-06-05 22:13:50 (524910): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=89
2025-06-05 22:13:50 (524910): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=89
2025-06-05 22:13:50 (524910): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8a
2025-06-05 22:13:50 (524910): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8a
2025-06-05 22:13:50 (524910): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8b
2025-06-05 22:13:50 (524910): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8b
2025-06-05 22:13:50 (524910): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8c
2025-06-05 22:13:50 (524910): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8c
2025-06-05 22:13:50 (524910): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8d
2025-06-05 22:13:50 (524910): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8d
2025-06-05 22:13:50 (524910): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8e
2025-06-05 22:13:50 (524910): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8e
2025-06-05 22:13:50 (524910): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8f
2025-06-05 22:13:50 (524910): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8f
2025-06-05 22:13:59 (524910): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2025-06-05 22:13:59 (524910): Guest Log: Host supports full mouse state reporting, switching to extended mouse integration protocol
2025-06-05 22:13:59 (524910): Guest Log: vboxguest: Successfully loaded version 7.1.6 r167084
2025-06-05 22:13:59 (524910): Guest Log: vboxguest: misc device minor 123, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)
2025-06-05 22:13:59 (524910): Guest Log: vboxsf: g_fHostFeatures=0x8000000f g_fSfFeatures=0x1 g_uSfLastFunction=29
2025-06-05 22:13:59 (524910): Guest Log: vboxsf: Successfully loaded version 7.1.6 r167084 on 5.14.0-503.14.1.el9_5.x86_64 (LINUX_VERSION_CODE=0x50e00)
2025-06-05 22:14:05 (524910): Guest Log: Got a proxy from the local BOINC client
2025-06-05 22:14:05 (524910): Guest Log: Will use it for CVMFS and Frontier
2025-06-05 22:14:05 (524910): Guest Log: Using custom CVMFS.
2025-06-05 22:14:05 (524910): Guest Log: Probing CVMFS repositories ...
2025-06-05 22:14:09 (524910): Guest Log: Probing /cvmfs/alice.cern.ch... OK
2025-06-05 22:14:09 (524910): Guest Log: Probing /cvmfs/cvmfs-config.cern.ch... OK
2025-06-05 22:14:09 (524910): Guest Log: Probing /cvmfs/grid.cern.ch... OK
2025-06-05 22:14:09 (524910): Guest Log: Probing /cvmfs/sft.cern.ch... OK
2025-06-05 22:14:09 (524910): Guest Log: Excerpt from "cvmfs_config stat":
2025-06-05 22:14:09 (524910): Guest Log: VERSION   HOST                            PROXY
2025-06-05 22:14:09 (524910): Guest Log: 2.12.7.0  http://s1cern-cvmfs.openhtc.io  http://192.168.101.210:3128
2025-06-05 22:14:09 (524910): Guest Log: Environment HTTP proxy: not set
2025-06-05 22:14:10 (524910): Guest Log: job: htmld=/var/www/lighttpd
2025-06-05 22:14:10 (524910): Guest Log: job: unpack exitcode=0
2025-06-05 22:37:08 (524910): Preference change detected
2025-06-05 22:37:08 (524910): Setting CPU throttle for VM. (100%)
2025-06-05 22:37:09 (524910): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 300 seconds) or (Vbox_job.xml: 600 seconds))
2025-06-05 23:52:45 (524910): VM Heartbeat file specified, but missing heartbeat.
2025-06-05 23:52:45 (524910): Capturing screenshot.
2025-06-05 23:52:45 (524910): vbm_popen popen failed (5).
2025-06-05 23:52:46 (524910): vbm_popen popen failed (5).
2025-06-05 23:52:47 (524910): vbm_popen popen failed (5).
2025-06-05 23:52:48 (524910): vbm_popen popen failed (5).
2025-06-05 23:52:49 (524910): vbm_popen popen failed (5).
2025-06-05 23:52:50 (524910): vbm_popen popen failed (5).
2025-06-05 23:52:50 (524910): Error in put scancode for VM: -182
Command:
VBoxManage -q controlvm "boinc_8d6cd16a4aa5ee37" keyboardputscancode 39
Output:

2025-06-05 23:52:51 (524910): vbm_popen popen failed (5).
2025-06-05 23:52:52 (524910): vbm_popen popen failed (5).
2025-06-05 23:52:53 (524910): vbm_popen popen failed (5).
2025-06-05 23:52:54 (524910): vbm_popen popen failed (5).
2025-06-05 23:52:55 (524910): vbm_popen popen failed (5).
2025-06-05 23:52:56 (524910): vbm_popen popen failed (5).
2025-06-05 23:52:56 (524910): Error in capture screenshot for VM: -182
Command:
VBoxManage -q controlvm "boinc_8d6cd16a4aa5ee37" screenshotpng "/var/lib/boinc3/slots/0/vbox_screenshot.png"
Output:

2025-06-05 23:52:56 (524910): Powering off VM.
2025-06-05 23:52:56 (524910): vbm_popen popen failed (5).
2025-06-05 23:52:56 (524910): Error in poweroff VM for VM: -108
Command:
VBoxManage -q controlvm "boinc_8d6cd16a4aa5ee37" poweroff
Output:

2025-06-05 23:52:56 (524910): VM did not power off when requested.
2025-06-05 23:52:56 (524910): VM was successfully terminated.
2025-06-05 23:52:56 (524910): Deregistering VM. (boinc_8d6cd16a4aa5ee37, slot#0)
2025-06-05 23:52:56 (524910): vbm_popen popen failed (5).
2025-06-05 23:52:56 (524910): Removing network bandwidth throttle group from VM.
2025-06-05 23:52:56 (524910): vbm_popen popen failed (5).
2025-06-05 23:52:56 (524910): Removing VM from VirtualBox.
2025-06-05 23:52:56 (524910): vbm_popen popen failed (5).

    Hypervisor System Log:

00:00:00.225508 DCon01   Platform architecture set to 'x86'
00:00:00.225787 DCon01   Loading settings file "/var/lib/boinc3/slots/0/boinc_ce576acf57cf5cc5/boinc_ce576acf57cf5cc5.vbox" with version "1.19-linux"
00:00:00.225924 DCon01   Platform architecture set to 'x86'
00:00:00.243271 DCon01   OCI: Local config file '/var/lib/boinc3/projects/VirtualBox/oci_config' does not exist
00:00:00.243293 DCon01   OCI: Original config file '/var/lib/boinc/.oci/config' does not exist
00:00:00.243296 DCon01   OCI: Reading profiles finished with status NS_OK
00:00:00.243301 DCon01   ExtPack: Created cloud provider 'OCI' (hrc=NS_OK)
00:00:00.243340 DCon01   VirtualBox: object created
00:00:00.599956 DCon02   ERROR [COM]: aRC=NS_ERROR_FAILURE (0x80004005) aIID={925084b0-625f-422f-a67d-0ede1880a56c} aComponent={SystemPropertiesWrap} aText={Cannot determine default Guest Additions ISO location. Most likely they are not available}, preserve=false aResultDetail=0
00:00:03.126617 DCon01   Platform architecture set to 'x86'
00:00:03.416894 DCon01   ERROR [COM]: aRC=VBOX_E_NOT_SUPPORTED (0x80bb0009) aIID={e36a5081-a82a-40bd-9e4e-42a44d6ce50f} aComponent={SessionMachine} aText={This VM is not encrypted}, preserve=false aResultDetail=0
00:00:03.630136 DCon01   ERROR [COM]: aRC=VBOX_E_OBJECT_NOT_FOUND (0x80bb0001) aIID={e36a5081-a82a-40bd-9e4e-42a44d6ce50f} aComponent={SessionMachine} aText={No storage device attached to device slot 0 on port 1 of controller 'Hard Disk Controller'}, preserve=false aResultDetail=0
00:00:03.630372 DCon01   ERROR [COM]: aRC=VBOX_E_OBJECT_NOT_FOUND (0x80bb0001) aIID={e36a5081-a82a-40bd-9e4e-42a44d6ce50f} aComponent={SessionMachine} aText={No storage device attached to device slot 0 on port 1 of controller 'Hard Disk Controller'}, preserve=false aResultDetail=0
00:00:03.630605 DCon01   ERROR [COM]: aRC=VBOX_E_OBJECT_NOT_FOUND (0x80bb0001) aIID={e36a5081-a82a-40bd-9e4e-42a44d6ce50f} aComponent={SessionMachine} aText={No storage device attached to device slot 0 on port 2 of controller 'Hard Disk Controller'}, preserve=false aResultDetail=0
00:00:03.630807 DCon01   ERROR [COM]: aRC=VBOX_E_OBJECT_NOT_FOUND (0x80bb0001) aIID={e36a5081-a82a-40bd-9e4e-42a44d6ce50f} aComponent={SessionMachine} aText={No storage device attached to device slot 0 on port 2 of controller 'Hard Disk Controller'}, preserve=false aResultDetail=0
00:00:03.644862 DCon01   ERROR [COM]: aRC=NS_ERROR_FAILURE (0x80004005) aIID={bea3ef5c-de2f-4b74-aa3a-15d6249371a0} aComponent={RecordingSettingsWrap} aText={Recording not started}, preserve=false aResultDetail=0
00:00:03.646697 DCon01   ERROR [COM]: aRC=NS_ERROR_FAILURE (0x80004005) aIID={e36a5081-a82a-40bd-9e4e-42a44d6ce50f} aComponent={SessionMachine} aText={This machine does not have any snapshots}, preserve=false aResultDetail=0
00:00:04.159950 DCon03   Platform architecture set to 'x86'
00:00:04.359933 DCon03   ERROR [COM]: aRC=VBOX_E_NOT_SUPPORTED (0x80bb0009) aIID={e36a5081-a82a-40bd-9e4e-42a44d6ce50f} aComponent={SessionMachine} aText={This VM is not encrypted}, preserve=false aResultDetail=0
00:00:04.682415 DCon01   ERROR [COM]: aRC=VBOX_E_OBJECT_NOT_FOUND (0x80bb0001) aIID={e36a5081-a82a-40bd-9e4e-42a44d6ce50f} aComponent={SessionMachine} aText={No storage device attached to device slot 0 on port 1 of controller 'Hard Disk Controller'}, preserve=false aResultDetail=0
00:00:04.682667 DCon04   ERROR [COM]: aRC=VBOX_E_OBJECT_NOT_FOUND (0x80bb0001) aIID={e36a5081-a82a-40bd-9e4e-42a44d6ce50f} aComponent={SessionMachine} aText={No storage device attached to device slot 0 on port 1 of controller 'Hard Disk Controller'}, preserve=false aResultDetail=0
00:00:04.682904 DCon01   ERROR [COM]: aRC=VBOX_E_OBJECT_NOT_FOUND (0x80bb0001) aIID={e36a5081-a82a-40bd-9e4e-42a44d6ce50f} aComponent={SessionMachine} aText={No storage device attached to device slot 0 on port 2 of controller 'Hard Disk Controller'}, preserve=false aResultDetail=0
00:00:04.683126 DCon04   ERROR [COM]: aRC=VBOX_E_OBJECT_NOT_FOUND (0x80bb0001) aIID={e36a5081-a82a-40bd-9e4e-42a44d6ce50f} aComponent={SessionMachine} aText={No storage device attached to device slot 0 on port 2 of controller 'Hard Disk Controller'}, preserve=false aResultDetail=0
00:00:04.874866 DCon01   ERROR [COM]: aRC=NS_ERROR_FAILURE (0x80004005) aIID={bea3ef5c-de2f-4b74-aa3a-15d6249371a0} aComponent={RecordingSettingsWrap} aText={Recording not started}, preserve=false aResultDetail=0
00:00:04.920012 DCon01   ERROR [COM]: aRC=NS_ERROR_FAILURE (0x80004005) aIID={e36a5081-a82a-40bd-9e4e-42a44d6ce50f} aComponent={SessionMachine} aText={This machine does not have any snapshots}, preserve=false aResultDetail=0
00:00:05.706598 DCon05   Launched VM: 134225376 pid: 959833 (0xea559) frontend: headless name: boinc_ce576acf57cf5cc5
00:00:06.046669 DCon04   Platform architecture set to 'x86'
00:00:07.926602 DCon06   ERROR [COM]: aRC=VBOX_E_OBJECT_NOT_FOUND (0x80bb0001) aIID={7d510820-a678-4730-a862-818dcd3fbed0} aComponent={MediumWrap} aText={Property 'CRYPT/KeyId' does not exist}, preserve=false aResultDetail=0
00:00:08.146629 DCon07   HostDnsMonitorProxy::GetDomainName: lan
00:00:08.159964 DCon07   HostDnsMonitorProxy::GetNameServers:
00:00:08.160003 DCon07     name server 1: 192.168.101.202
00:00:08.160007 DCon07     name server 2: 192.168.101.50
00:00:08.160009 DCon07     name server 3: 2a02:1210:9618:2300:def5:1bff:fe73:4440
00:00:08.173296 DCon07   HostDnsMonitorProxy::GetSearchStrings:
00:00:08.173312 DCon07     search string 1: lan
00:00:08.173315 DCon07     search string 2: home
00:00:17.219258 DCon07   Saving settings file "/var/lib/boinc3/slots/0/boinc_ce576acf57cf5cc5/boinc_ce576acf57cf5cc5.vbox" with version "1.19-linux"
00:00:17.284566 DCon07   Finished saving settings file "/var/lib/boinc3/slots/0/boinc_ce576acf57cf5cc5/boinc_ce576acf57cf5cc5.vbox"
00:00:19.120136 DCon01   Saving settings file "/var/lib/boinc3/slots/0/boinc_ce576acf57cf5cc5/boinc_ce576acf57cf5cc5.vbox" with version "1.19-linux"
00:00:19.166835 DCon01   Finished saving settings file "/var/lib/boinc3/slots/0/boinc_ce576acf57cf5cc5/boinc_ce576acf57cf5cc5.vbox"
00:09:28.597720 DCon02   Saving settings file "/var/lib/boinc3/slots/0/boinc_ce576acf57cf5cc5/boinc_ce576acf57cf5cc5.vbox" with version "1.19-linux"
00:09:28.647160 DCon02   Finished saving settings file "/var/lib/boinc3/slots/0/boinc_ce576acf57cf5cc5/boinc_ce576acf57cf5cc5.vbox"
00:09:28.763748 DCon08   Platform architecture set to 'x86'
00:09:28.765062 DCon08   ERROR [COM]: aRC=NS_ERROR_FAILURE (0x80004005) aIID={e36a5081-a82a-40bd-9e4e-42a44d6ce50f} aComponent={SessionMachine} aText={This machine does not have any snapshots}, preserve=false aResultDetail=0
00:09:28.827268 DCon02   Platform architecture set to 'x86'
00:09:28.828865 DCon02   Saving settings file "/var/lib/boinc3/slots/0/boinc_ce576acf57cf5cc5/boinc_ce576acf57cf5cc5.vbox" with version "1.19-linux"
00:09:28.887139 DCon02   Finished saving settings file "/var/lib/boinc3/slots/0/boinc_ce576acf57cf5cc5/boinc_ce576acf57cf5cc5.vbox"
00:09:28.959259 DCon01   Saving settings file "/var/lib/boinc3/projects/VirtualBox/VirtualBox.xml" with version "1.12-linux"
00:09:29.029598 DCon01   Finished saving settings file "/var/lib/boinc3/projects/VirtualBox/VirtualBox.xml"
00:09:29.029701 DCon01   Saving settings file "/var/lib/boinc3/projects/VirtualBox/VirtualBox.xml" with version "1.12-linux"
00:09:29.088024 DCon01   Finished saving settings file "/var/lib/boinc3/projects/VirtualBox/VirtualBox.xml"
00:09:29.088650 DeleteVM Saving settings file "/var/lib/boinc3/projects/VirtualBox/VirtualBox.xml" with version "1.12-linux"
00:09:29.196031 DeleteVM Finished saving settings file "/var/lib/boinc3/projects/VirtualBox/VirtualBox.xml"
00:09:34.227661 main     VirtualBox: object deletion starts
00:09:34.228020 main     HostDnsMonitor: shutting down ...
00:09:34.233255 main     HostDnsMonitor: shut down
00:09:34.251551 Watcher  ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={d644ad1e-c501-4fc7-9ab6-aa6d763bc540} aComponent={VirtualBoxWrap} aText={The object is not ready}, preserve=false aResultDetail=0
00:09:34.251661 main     VirtualBox: object deleted

    VM Execution Log:

01:02:56.054808 AHCI#0P0: Read at offset 1419759616 (4096 bytes left) returned rc=VERR_DEV_IO_ERROR
01:02:56.066603 AHCI#0P0: Read at offset 1419759616 (4096 bytes left) returned rc=VERR_DEV_IO_ERROR
01:02:56.096415 AHCI#0P0: Read at offset 1419759616 (4096 bytes left) returned rc=VERR_DEV_IO_ERROR
01:02:56.148728 AHCI#0P0: Read at offset 1419759616 (4096 bytes left) returned rc=VERR_DEV_IO_ERROR
01:02:56.177166 AHCI#0P0: Read at offset 1419759616 (4096 bytes left) returned rc=VERR_DEV_IO_ERROR
01:02:56.193068 AHCI#0P0: Read at offset 1434910720 (4096 bytes left) returned rc=VERR_DEV_IO_ERROR
01:02:56.206974 AHCI#0P0: Read at offset 1434910720 (4096 bytes left) returned rc=VERR_DEV_IO_ERROR
01:02:56.217140 AHCI#0P0: Read at offset 1434910720 (4096 bytes left) returned rc=VERR_DEV_IO_ERROR
01:02:56.244538 AHCI#0P0: Read at offset 1434910720 (4096 bytes left) returned rc=VERR_DEV_IO_ERROR
01:02:56.298280 AHCI#0P0: Read at offset 1434910720 (4096 bytes left) returned rc=VERR_DEV_IO_ERROR
01:02:56.326949 AHCI#0P0: Read at offset 1434910720 (4096 bytes left) returned rc=VERR_DEV_IO_ERROR
01:02:56.345211 AHCI#0P0: Read at offset 1434910720 (4096 bytes left) returned rc=VERR_DEV_IO_ERROR
01:02:56.408539 AHCI#0P0: Read at offset 1434910720 (4096 bytes left) returned rc=VERR_DEV_IO_ERROR
01:02:56.449797 AHCI#0P0: Read at offset 1434910720 (4096 bytes left) returned rc=VERR_DEV_IO_ERROR
01:02:56.548859 AHCI#0P0: Read at offset 1434910720 (4096 bytes left) returned rc=VERR_DEV_IO_ERROR
01:02:56.586726 AHCI#0P0: Read at offset 1434910720 (4096 bytes left) returned rc=VERR_DEV_IO_ERROR
01:02:56.597131 AHCI#0P0: Read at offset 1419759616 (4096 bytes left) returned rc=VERR_DEV_IO_ERROR
01:02:56.607714 AHCI#0P0: Read at offset 1434910720 (4096 bytes left) returned rc=VERR_DEV_IO_ERROR
01:02:56.621753 AHCI#0P0: Read at offset 1419759616 (4096 bytes left) returned rc=VERR_DEV_IO_ERROR
01:02:56.631762 AHCI#0P0: Read at offset 1434910720 (4096 bytes left) returned rc=VERR_DEV_IO_ERROR
01:02:56.641779 AHCI#0P0: Read at offset 1419759616 (4096 bytes left) returned rc=VERR_DEV_IO_ERROR
01:02:56.651796 AHCI#0P0: Read at offset 1434910720 (4096 bytes left) returned rc=VERR_DEV_IO_ERROR
01:02:56.661787 AHCI#0P0: Read at offset 1419759616 (4096 bytes left) returned rc=VERR_DEV_IO_ERROR
01:02:56.672854 AHCI#0P0: Read at offset 1434910720 (4096 bytes left) returned rc=VERR_DEV_IO_ERROR
01:02:56.682691 AHCI#0P0: Read at offset 1419759616 (4096 bytes left) returned rc=VERR_DEV_IO_ERROR
01:02:56.692645 AHCI#0P0: Read at offset 1434910720 (4096 bytes left) returned rc=VERR_DEV_IO_ERROR
01:02:56.702701 AHCI#0P0: Read at offset 1419759616 (4096 bytes left) returned rc=VERR_DEV_IO_ERROR
01:02:56.714980 AHCI#0P0: Read at offset 1434910720 (4096 bytes left) returned rc=VERR_DEV_IO_ERROR
01:02:56.790065 AHCI#0P0: Read at offset 1434910720 (4096 bytes left) returned rc=VERR_DEV_IO_ERROR
01:02:56.905582 AHCI#0P0: Read at offset 1434910720 (4096 bytes left) returned rc=VERR_DEV_IO_ERROR
01:02:56.928315 AHCI#0P0: Read at offset 1434910720 (4096 bytes left) returned rc=VERR_DEV_IO_ERROR
01:02:56.940708 AHCI#0P0: Read at offset 1419759616 (4096 bytes left) returned rc=VERR_DEV_IO_ERROR
01:02:56.951008 AHCI#0P0: Read at offset 1434910720 (4096 bytes left) returned rc=VERR_DEV_IO_ERROR
01:02:56.963854 AHCI#0P0: Read at offset 1419759616 (4096 bytes left) returned rc=VERR_DEV_IO_ERROR
01:02:56.973843 AHCI#0P0: Read at offset 1434910720 (4096 bytes left) returned rc=VERR_DEV_IO_ERROR
01:02:56.983782 AHCI#0P0: Read at offset 1419759616 (4096 bytes left) returned rc=VERR_DEV_IO_ERROR
01:02:56.993822 AHCI#0P0: Read at offset 1434910720 (4096 bytes left) returned rc=VERR_DEV_IO_ERROR
01:02:57.004862 AHCI#0P0: Read at offset 1419759616 (4096 bytes left) returned rc=VERR_DEV_IO_ERROR
01:02:57.014810 AHCI#0P0: Read at offset 1434910720 (4096 bytes left) returned rc=VERR_DEV_IO_ERROR
01:02:57.028471 AHCI#0P0: Read at offset 1419759616 (4096 bytes left) returned rc=VERR_DEV_IO_ERROR
01:02:57.038960 AHCI#0P0: Read at offset 1434910720 (4096 bytes left) returned rc=VERR_DEV_IO_ERROR
01:02:57.048981 AHCI#0P0: Read at offset 1419759616 (4096 bytes left) returned rc=VERR_DEV_IO_ERROR
01:02:57.064021 AHCI#0P0: Read at offset 1434910720 (4096 bytes left) returned rc=VERR_DEV_IO_ERROR
01:02:57.074900 AHCI#0P0: Read at offset 1434910720 (4096 bytes left) returned rc=VERR_DEV_IO_ERROR
01:02:57.101337 AHCI#0P0: Read at offset 1434910720 (4096 bytes left) returned rc=VERR_DEV_IO_ERROR
01:02:57.112839 AHCI#0P0: Read at offset 1434910720 (4096 bytes left) returned rc=VERR_DEV_IO_ERROR
01:02:57.134790 AHCI#0P0: Read at offset 1434910720 (4096 bytes left) returned rc=VERR_DEV_IO_ERROR
01:02:57.162018 AHCI#0P0: Read at offset 1434910720 (4096 bytes left) returned rc=VERR_DEV_IO_ERROR
01:02:57.174295 AHCI#0P0: Read at offset 1434910720 (4096 bytes left) returned rc=VERR_DEV_IO_ERROR
01:02:57.186612 AHCI#0P0: Read at offset 1434910720 (4096 bytes left) returned rc=VERR_DEV_IO_ERROR
01:02:57.197272 AHCI#0P0: Read at offset 1419759616 (4096 bytes left) returned rc=VERR_DEV_IO_ERROR
01:02:57.209805 AHCI#0P0: Read at offset 1434910720 (4096 bytes left) returned rc=VERR_DEV_IO_ERROR
01:02:57.220077 AHCI#0P0: Read at offset 1419759616 (4096 bytes left) returned rc=VERR_DEV_IO_ERROR
01:02:57.229918 AHCI#0P0: Read at offset 1434910720 (4096 bytes left) returned rc=VERR_DEV_IO_ERROR
01:02:57.239924 AHCI#0P0: Read at offset 1419759616 (4096 bytes left) returned rc=VERR_DEV_IO_ERROR
01:02:57.248313 AHCI#0P0: Read at offset 1434910720 (4096 bytes left) returned rc=VERR_DEV_IO_ERROR
01:02:57.264602 AHCI#0P0: Read at offset 1419759616 (4096 bytes left) returned rc=VERR_DEV_IO_ERROR
01:02:57.275297 AHCI#0P0: Read at offset 1419759616 (4096 bytes left) returned rc=VERR_DEV_IO_ERROR
01:02:57.288693 AHCI#0P0: Read at offset 1419759616 (4096 bytes left) returned rc=VERR_DEV_IO_ERROR
01:02:57.414547 AHCI#0P0: Read at offset 1434910720 (4096 bytes left) returned rc=VERR_DEV_IO_ERROR
01:02:57.429389 AHCI#0P0: Read at offset 1434910720 (4096 bytes left) returned rc=VERR_DEV_IO_ERROR
01:02:57.440298 AHCI#0P0: Read at offset 1434910720 (4096 bytes left) returned rc=VERR_DEV_IO_ERROR
01:02:57.462568 AHCI#0P0: Read at offset 1434910720 (4096 bytes left) returned rc=VERR_DEV_IO_ERROR
01:02:57.474474 AHCI#0P0: Read at offset 1434910720 (4096 bytes left) returned rc=VERR_DEV_IO_ERROR
01:02:57.511163 AHCI#0P0: Read at offset 1434910720 (4096 bytes left) returned rc=VERR_DEV_IO_ERROR
01:02:57.554202 AHCI#0P0: Read at offset 1434910720 (4096 bytes left) returned rc=VERR_DEV_IO_ERROR
01:02:57.591269 AHCI#0P0: Read at offset 1434910720 (4096 bytes left) returned rc=VERR_DEV_IO_ERROR
01:02:57.643872 AHCI#0P0: Read at offset 1434910720 (4096 bytes left) returned rc=VERR_DEV_IO_ERROR
01:02:57.654686 AHCI#0P0: Read at offset 1434910720 (4096 bytes left) returned rc=VERR_DEV_IO_ERROR
01:02:57.676900 AHCI#0P0: Read at offset 1434910720 (4096 bytes left) returned rc=VERR_DEV_IO_ERROR
01:02:57.751580 AHCI#0P0: Read at offset 1434910720 (4096 bytes left) returned rc=VERR_DEV_IO_ERROR
01:02:57.765507 AHCI#0P0: Read at offset 1419759616 (4096 bytes left) returned rc=VERR_DEV_IO_ERROR
01:02:57.775792 AHCI#0P0: Read at offset 1434910720 (4096 bytes left) returned rc=VERR_DEV_IO_ERROR
01:02:57.785470 AHCI#0P0: Read at offset 1419759616 (4096 bytes left) returned rc=VERR_DEV_IO_ERROR
01:02:57.795825 AHCI#0P0: Read at offset 1434910720 (4096 bytes left) returned rc=VERR_DEV_IO_ERROR
01:02:57.805569 AHCI#0P0: Read at offset 1419759616 (4096 bytes left) returned rc=VERR_DEV_IO_ERROR
01:02:57.815864 AHCI#0P0: Read at offset 1434910720 (4096 bytes left) returned rc=VERR_DEV_IO_ERROR
01:02:57.825212 AHCI#0P0: Read at offset 1419759616 (4096 bytes left) returned rc=VERR_DEV_IO_ERROR
01:02:57.836076 AHCI#0P0: Read at offset 1434910720 (4096 bytes left) returned rc=VERR_DEV_IO_ERROR
01:02:57.845502 AHCI#0P0: Read at offset 1419759616 (4096 bytes left) returned rc=VERR_DEV_IO_ERROR
01:06:55.199390 VMMDev: vmmDevHeartbeatFlatlinedTimer: Guest seems to be unresponsive. Last heartbeat received 4 seconds ago

    VM Startup Log:


    VM Trace Log:

nested-hw-virt="off"
hwvirtex="on"
nestedpaging="on"
largepages="off"
vtxvpid="on"
vtxux="on"
virtvmsavevmload="on"
cpuid-portability-level=0
bootmenu="messageandmenu"
boot1="disk"
boot2="dvd"
boot3="none"
boot4="none"
acpi="on"
ioapic="on"
biosapic="apic"
biossystemtimeoffset=0
NvramFile="/var/lib/boinc3/slots/0/boinc_8d6cd16a4aa5ee37/boinc_8d6cd16a4aa5ee37.nvram"
rtcuseutc="on"
iommu="none"
paravirtprovider="default"
effparavirtprovider="kvm"
VMState="poweroff"
VMStateChangeTime="2025-06-05T20:13:37.803000000"
graphicscontroller="vboxvga"
monitorcount=1
accelerate3d="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"
natnet1="nat"
macaddress1="0800274A940D"
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"
clipboard_file_transfers="off"
draganddrop="disabled"
vrde="off"
usb="off"
ehci="off"
xhci="off"
recording_started="off"
recording_enabled="off"
recording_screens=1
 rec_screen0
rec_screen_enabled="on"
rec_screen_id=0
rec_screen_video_enabled="on"
rec_screen_dest="File"
rec_screen_dest_filename="/var/lib/boinc3/slots/0/boinc_8d6cd16a4aa5ee37/boinc_8d6cd16a4aa5ee37-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="Theory_2914-4729044-18_1"
GuestMemoryBalloon=0

2025-06-05 22:13:40 (524910): 
Command: VBoxManage -q modifyvm "boinc_8d6cd16a4aa5ee37" --nic1 nat --nic-type1 "virtio" --cable-connected1 off --nat-dns-proxy1 on 
Exit Code: 0
Output:

2025-06-05 22:13:40 (524910): 
Command: VBoxManage -q modifyvm "boinc_8d6cd16a4aa5ee37" --cable-connected1 on 
Exit Code: 0
Output:

2025-06-05 22:13:40 (524910): 
Command: VBoxManage -q modifyvm "boinc_8d6cd16a4aa5ee37" --usb off 
Exit Code: 0
Output:

2025-06-05 22:13:41 (524910): 
Command: VBoxManage -q modifyvm "boinc_8d6cd16a4aa5ee37" --uart1 off --uart2 off 
Exit Code: 0
Output:

2025-06-05 22:13:41 (524910): 
Command: VBoxManage -q modifyvm "boinc_8d6cd16a4aa5ee37" --lpt1 off --lpt2 off 
Exit Code: 0
Output:

2025-06-05 22:13:41 (524910): 
Command: VBoxManage -q modifyvm "boinc_8d6cd16a4aa5ee37" --audio-enabled off 
Exit Code: 0
Output:

2025-06-05 22:13:41 (524910): 
Command: VBoxManage -q modifyvm "boinc_8d6cd16a4aa5ee37" --clipboard disabled 
Exit Code: 0
Output:

2025-06-05 22:13:42 (524910): 
Command: VBoxManage -q modifyvm "boinc_8d6cd16a4aa5ee37" --draganddrop disabled 
Exit Code: 0
Output:

2025-06-05 22:13:42 (524910): 
Command: VBoxManage -q storagectl "boinc_8d6cd16a4aa5ee37" --name "Hard Disk Controller" --add "sata" --controller "IntelAHCI" --hostiocache off --portcount 3
Exit Code: 0
Output:

2025-06-05 22:13:42 (524910): 
Command: VBoxManage -q showhdinfo "/var/lib/boinc3/projects/lhcathome.cern.ch_lhcathome/Theory_2025_04_17_prod.vdi" 
Exit Code: 0
Output:
UUID:           0fbd7468-9e39-4fc1-ac14-e3aa44168716
Parent UUID:    base
State:          locked read
Type:           multiattach
Location:       /var/lib/boinc3/projects/lhcathome.cern.ch_lhcathome/Theory_2025_04_17_prod.vdi
Storage format: VDI
Format variant: dynamic default
Capacity:       10240 MBytes
Size on disk:   2451 MBytes
Encryption:     disabled
Property:       AllocationBlockSize=1048576
Child UUIDs:    67998f17-a91d-4a64-b990-f22cf7452cc7

2025-06-05 22:13:42 (524910): 
Command: VBoxManage -q storageattach "boinc_8d6cd16a4aa5ee37" --storagectl "Hard Disk Controller" --port 0 --device 0 --type hdd --mtype multiattach --medium "/var/lib/boinc3/projects/lhcathome.cern.ch_lhcathome/Theory_2025_04_17_prod.vdi" 
Exit Code: 0
Output:

2025-06-05 22:13:42 (524910): 
Command: VBoxManage -q bandwidthctl "boinc_8d6cd16a4aa5ee37" add "boinc_8d6cd16a4aa5ee37_net" --type network --limit 1024G 
Exit Code: 0
Output:

2025-06-05 22:13:43 (524910): 
Command: VBoxManage -q modifyvm "boinc_8d6cd16a4aa5ee37" --natpf1 ",tcp,127.0.0.1,42691,,80" 
Exit Code: 0
Output:

2025-06-05 22:13:43 (524910): 
Command: VBoxManage -q list extpacks
Exit Code: 0
Output:
Extension Packs: 1
Pack no. 0:   Oracle VirtualBox Extension Pack
Version:        7.1.8
Revision:       168469
Edition:        
Description:    Oracle Cloud Infrastructure integration, Host Webcam, VirtualBox RDP, PXE ROM, Disk Encryption, NVMe, full VM encryption.
VRDE Module:    VBoxVRDP
Crypto Module:  VBoxPuelCrypto
Usable:         true
Why unusable:   

2025-06-05 22:13:43 (524910): 
Command: VBoxManage -q modifyvm "boinc_8d6cd16a4aa5ee37" --vrde on --vrdeextpack default --vrdeauthlibrary default --vrdeauthtype null --vrdeport 39273 --vrde-property "Security/Method=RDP" 
Exit Code: 0
Output:

2025-06-05 22:13:43 (524910): 
Command: VBoxManage -q sharedfolder add "boinc_8d6cd16a4aa5ee37" --name "shared" --hostpath "/var/lib/boinc3/slots/0/shared"
Exit Code: 0
Output:

2025-06-05 22:13:44 (524910): 
Command: VBoxManage -q startvm "boinc_8d6cd16a4aa5ee37" --type headless
Exit Code: 0
Output:
Waiting for VM "boinc_8d6cd16a4aa5ee37" to power on...
VM "boinc_8d6cd16a4aa5ee37" has been successfully started.

2025-06-05 22:13:45 (524910): 
Command: VBoxManage -q controlvm "boinc_8d6cd16a4aa5ee37" cpuexecutioncap 100 
Exit Code: 0
Output:

2025-06-05 22:37:09 (524910): 
Command: VBoxManage -q controlvm "boinc_8d6cd16a4aa5ee37" cpuexecutioncap 100 
Exit Code: 0
Output:

2025-06-05 23:52:45 (524910): 
Command: VBoxManage -q controlvm "boinc_8d6cd16a4aa5ee37" keyboardputscancode 39
Exit Code: -108
Output:

2025-06-05 23:52:46 (524910): 
Command: VBoxManage -q controlvm "boinc_8d6cd16a4aa5ee37" keyboardputscancode 39
Exit Code: -108
Output:

2025-06-05 23:52:47 (524910): 
Command: VBoxManage -q controlvm "boinc_8d6cd16a4aa5ee37" keyboardputscancode 39
Exit Code: -108
Output:

2025-06-05 23:52:48 (524910): 
Command: VBoxManage -q controlvm "boinc_8d6cd16a4aa5ee37" keyboardputscancode 39
Exit Code: -108
Output:

2025-06-05 23:52:49 (524910): 
Command: VBoxManage -q controlvm "boinc_8d6cd16a4aa5ee37" keyboardputscancode 39
Exit Code: -108
Output:

2025-06-05 23:52:50 (524910): 
Command: VBoxManage -q controlvm "boinc_8d6cd16a4aa5ee37" keyboardputscancode 39
Exit Code: -108
Output:

2025-06-05 23:52:51 (524910): 
Command: VBoxManage -q controlvm "boinc_8d6cd16a4aa5ee37" screenshotpng "/var/lib/boinc3/slots/0/vbox_screenshot.png"
Exit Code: -108
Output:

2025-06-05 23:52:52 (524910): 
Command: VBoxManage -q controlvm "boinc_8d6cd16a4aa5ee37" screenshotpng "/var/lib/boinc3/slots/0/vbox_screenshot.png"
Exit Code: -108
Output:

2025-06-05 23:52:53 (524910): 
Command: VBoxManage -q controlvm "boinc_8d6cd16a4aa5ee37" screenshotpng "/var/lib/boinc3/slots/0/vbox_screenshot.png"
Exit Code: -108
Output:

2025-06-05 23:52:54 (524910): 
Command: VBoxManage -q controlvm "boinc_8d6cd16a4aa5ee37" screenshotpng "/var/lib/boinc3/slots/0/vbox_screenshot.png"
Exit Code: -108
Output:

2025-06-05 23:52:55 (524910): 
Command: VBoxManage -q controlvm "boinc_8d6cd16a4aa5ee37" screenshotpng "/var/lib/boinc3/slots/0/vbox_screenshot.png"
Exit Code: -108
Output:

2025-06-05 23:52:56 (524910): 
Command: VBoxManage -q controlvm "boinc_8d6cd16a4aa5ee37" screenshotpng "/var/lib/boinc3/slots/0/vbox_screenshot.png"
Exit Code: -108
Output:

2025-06-05 23:52:56 (524910): 
Command: VBoxManage -q controlvm "boinc_8d6cd16a4aa5ee37" poweroff
Exit Code: -108
Output:

2025-06-05 23:52:56 (524910): 
Command: VBoxManage -q snapshot "boinc_8d6cd16a4aa5ee37" list 
Exit Code: -108
Output:

2025-06-05 23:52:56 (524910): 
Command: VBoxManage -q bandwidthctl "boinc_8d6cd16a4aa5ee37" remove "boinc_8d6cd16a4aa5ee37_net" 
Exit Code: -108
Output:

2025-06-05 23:52:56 (524910): 
Command: VBoxManage -q unregistervm "boinc_8d6cd16a4aa5ee37" --delete 
Exit Code: -108
Output:

2025-06-05 23:53:01 (524910): called boinc_finish(-182)

</stderr_txt>
]]>


©2025 CERN