Lots of error entries in VBoxSVC.log

[Reiner Brodbeck]

Looking into VBoxSVC.log I find lots of error entries.

When starting the VM Virtualbox Manager GUI, the first entries appear (time stamps 00:00:00 in attached file)

Then, related to time stamps beginning with 00:18:59 I executed the following commands, that are embedded in a script:

vboxmanage createvm --name AMHS-Tester --groups "/AMHS-CentOS-Eval" --ostype RedHat_64 --register --basefolder "E:\VMs\Eval-Testsuite\AMHS-CentOS-Eval\VMs"
vboxmanage modifyvm 5cb950aa-86e4-4f31-8a2b-9d0b580e3e4c --memory 3072 --boot1 dvd --boot2 disk --boot3 none --cpus 8 --vram 12 --audio pulse --usb on --usbehci on
vboxmanage createhd --filename "E:\VMs\Eval-Testsuite\VMs\AMHS-CentOS-Eval\AMHS-Tester\AMHS-Tester" --size 16384 --format VMDK --variant Split2G
vboxmanage storagectl 5cb950aa-86e4-4f31-8a2b-9d0b580e3e4c --name IDE-Controller --add ide
vboxmanage storageattach 5cb950aa-86e4-4f31-8a2b-9d0b580e3e4c --storagectl IDE-Controller --port 0 --device 0 --type dvddrive --medium "E:\VMs\Eval-Testsuite\AMHSTESTER.iso"
vboxmanage storageattach 5cb950aa-86e4-4f31-8a2b-9d0b580e3e4c --storagectl IDE-Controller --port 0 --device 1 --type dvddrive --medium "C:\Program Files\Oracle\VirtualBox\VBoxGuestAdditions.iso"
vboxmanage storagectl 5cb950aa-86e4-4f31-8a2b-9d0b580e3e4c --name SATA-Controller --add sata --portcount 1
vboxmanage storageattach 5cb950aa-86e4-4f31-8a2b-9d0b580e3e4c --storagectl SATA-Controller --port 0 --type hdd --medium "E:\VMs\Eval-Testsuite\VMs\AMHS-CentOS-Eval\AMHS-Tester\AMHS-Tester.vmdk"
vboxmanage modifyvm 5cb950aa-86e4-4f31-8a2b-9d0b580e3e4c --nic1 hostonly --hostonlyadapter1 "VirtualBox Host-Only Ethernet Adapter #2"
vboxmanage modifyvm 5cb950aa-86e4-4f31-8a2b-9d0b580e3e4c --nic2 natnetwork --nat-network2 NatAMHS
vboxmanage modifyvm 5cb950aa-86e4-4f31-8a2b-9d0b580e3e4c --nicpromisc2 allow-all
vboxmanage sharedfolder add 5cb950aa-86e4-4f31-8a2b-9d0b580e3e4c --name work --hostpath "E:\VMs\Eval-Testsuite\work" --automount
vboxmanage modifyvm 5cb950aa-86e4-4f31-8a2b-9d0b580e3e4c --clipboard bidirectional
vboxmanage modifyvm 5cb950aa-86e4-4f31-8a2b-9d0b580e3e4c --draganddrop bidirectional
vboxmanage modifyvm 5cb950aa-86e4-4f31-8a2b-9d0b580e3e4c --vcpfile "E:\VMs\Eval-Testsuite\work\AMHS-Tester.webm" --vcpwidth 1920 --vcpheight 1200
vboxmanage startvm 5cb950aa-86e4-4f31-8a2b-9d0b580e3e4c

And finally, starting at time stamp 00:18:59 the script checked the VM every five seconds using:

vboxmanage showvminfo 5cb950aa-86e4-4f31-8a2b-9d0b580e3e4c --machinereadable

The UUID is of course that of the newly created VM in the first command.

[Frank Mehnert]

Do you still get all these encryption error messages with VBox 5.0.2? I only get messages about mediums not attached to device slot X on port Y.

[Reiner Brodbeck]

Replying to frank:

Do you still get all these encryption error messages with VBox 5.0.2? I only get messages about mediums not attached to device slot X on port Y.

I checked VBox 5.0.2 today. The eror entries are still the same.

[Frank Batschulat (Oracle)]

Virtualbox 5.0 is long out of support. the oldest release we'd be chasing bugs in is 5.2.X.

If this still happens with 5.2 or 6.0.X then a new bug should be filed with corresponding details including host OS, guest OS and configuration of the failing VM.

[georgesovetov]

It's still the case for 6.1.2 and 6.1.4 on Windows 10 and Ubuntu 18.04.

After I run

VBoxManage showvminfo ft0-xenial-01

I see this in "C:\Users\gsovetov\.VirtualBox\VBoxSVC.log"

00:01:58.061381          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 'SATA'}, preserve=false aResultDetail=0
00:01:58.061567          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 'SATA'}, preserve=false aResultDetail=0
00:01:58.061726          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 'SATA'}, preserve=false aResultDetail=0
00:01:58.061859          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 'SATA'}, preserve=false aResultDetail=0
00:01:58.061990          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 3 of controller 'SATA'}, preserve=false aResultDetail=0
00:01:58.062119          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 3 of controller 'SATA'}, preserve=false aResultDetail=0
00:01:58.062392          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 0 of controller 'Floppy'}, preserve=false aResultDetail=0
00:01:58.062485          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 0 of controller 'Floppy'}, preserve=false aResultDetail=0
00:01:58.062614          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 1 on port 0 of controller 'Floppy'}, preserve=false aResultDetail=0
00:01:58.062742          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 1 on port 0 of controller 'Floppy'}, preserve=false aResultDetail=0
00:01:58.063006          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 0 of controller 'USB'}, preserve=false aResultDetail=0
00:01:58.063096          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 0 of controller 'USB'}, preserve=false aResultDetail=0
00:01:58.063231          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 'USB'}, preserve=false aResultDetail=0
00:01:58.063375          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 'USB'}, preserve=false aResultDetail=0
00:01:58.063498          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 'USB'}, preserve=false aResultDetail=0
00:01:58.063722          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 'USB'}, preserve=false aResultDetail=0
00:01:58.063849          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 3 of controller 'USB'}, preserve=false aResultDetail=0
00:01:58.064045          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 3 of controller 'USB'}, preserve=false aResultDetail=0
00:01:58.064175          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 4 of controller 'USB'}, preserve=false aResultDetail=0
00:01:58.064299          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 4 of controller 'USB'}, preserve=false aResultDetail=0
00:01:58.064427          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 5 of controller 'USB'}, preserve=false aResultDetail=0
00:01:58.064548          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 5 of controller 'USB'}, preserve=false aResultDetail=0
00:01:58.064670          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 6 of controller 'USB'}, preserve=false aResultDetail=0
00:01:58.064793          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 6 of controller 'USB'}, preserve=false aResultDetail=0
00:01:58.064915          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 7 of controller 'USB'}, preserve=false aResultDetail=0
00:01:58.065035          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 7 of controller 'USB'}, preserve=false aResultDetail=0
00:01:58.331318          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

[arudnev]

Are you sure the VM "AMHS-Tester" has mentioned UID? If you create a VM and modify it in one script you can't rely on UID. I'd use instead:

vboxmanage createvm --name AMHS-Tester --ostype RedHat_64 --register --basefolder "E:\SPECIAL\VirtualBoxes\test2" vboxmanage modifyvm AMHS-Tester --memory 3072 --boot1 dvd --boot2 disk --boot3 none --cpus 8 --vram 12 --usb on --usbehci on

[arudnev]

Following script does successfully work on 6.1.14

vboxmanage createvm --name AMHS-Tester --ostype RedHat_64 --register --basefolder "E:\SPECIAL\VirtualBoxes\test2"

vboxmanage modifyvm AMHS-Tester --memory 3072 --boot1 dvd --boot2 disk --boot3 none --cpus 8 --vram 12 --usb on --usbehci on

vboxmanage createhd --filename "E:\SPECIAL\VirtualBoxes\test2\AMHS-Tester" --size 16384 --format VMDK --variant Split2G

vboxmanage storagectl AMHS-Tester --name IDE-Controller --add ide

vboxmanage storageattach AMHS-Tester --storagectl IDE-Controller --port 0 --device 0 --type dvddrive --medium "E:\SPECIAL\VirtualBoxes\test2_media\AMHSTESTER.iso"

vboxmanage storageattach AMHS-Tester --storagectl IDE-Controller --port 0 --device 1 --type dvddrive --medium "E:\SPECIAL\VirtualBoxes\test2_media\VBoxGuestAdditions.iso"

vboxmanage storagectl AMHS-Tester --name SATA-Controller --add sata --portcount 1

vboxmanage storageattach AMHS-Tester --storagectl SATA-Controller --port 0 --type hdd --medium "E:\SPECIAL\VirtualBoxes\test2\AMHS-Tester.vmdk"

vboxmanage modifyvm AMHS-Tester --nic1 hostonly --hostonlyadapter1 "VirtualBox Host-Only Ethernet Adapter #2"

vboxmanage modifyvm AMHS-Tester --nic2 natnetwork --nat-network2 NatAMHS

vboxmanage modifyvm AMHS-Tester --nicpromisc2 allow-all

vboxmanage sharedfolder add AMHS-Tester --name work --hostpath "E:\SPECIAL\VirtualBoxes\test2\work" --automount

vboxmanage modifyvm AMHS-Tester --clipboard bidirectional

vboxmanage modifyvm AMHS-Tester --draganddrop bidirectional

rem vboxmanage modifyvm AMHS-Tester --vcpfile "E:\VMs\Eval-Testsuite\work\AMHS-Tester.webm" --vcpwidth 1920 --vcpheight 1200

rem vboxmanage startvm AMHS-Tester

vboxmanage showvminfo AMHS-Tester