VM aborting while user running VB is inactive

Discussions related to using VirtualBox on Linux hosts.
Post Reply
Tor
Posts: 5
Joined: 15. Apr 2013, 00:47

VM aborting while user running VB is inactive

Post by Tor »

Aloha,

I'm having a problem with my Win XP virtual machine that I run under a less-used user on my Ubuntu 12.04 host aborting while I'm using my primary user account. No issues currently known when using the VM locally, but it will abort while being used remotely if the user running VirtualBox is inactive.

This problem occured with VB 4.0.12? that is in the 12.04 Repo, and still is an issue with 4.2.12 from the VB repository. Log of recent abort is attached; I'm not sure what other information may be helpful.
Attachments
Tor-2013-04-14-13-28-14.log
(59.18 KiB) Downloaded 17 times
mpack
Site Moderator
Posts: 39156
Joined: 4. Sep 2008, 17:09
Primary OS: MS Windows 10
VBox Version: PUEL
Guest OSses: Mostly XP

Re: VM aborting while user running VB is inactive

Post by mpack »

VBox.log wrote: 00:00:01.798745 Host RAM: 7459MB total, 1009MB available
...
00:00:02.173790 RamSize <integer> = 0x0000000060000000 (1 610 612 736, 1 536 MB)
Allocating more RAM than is available. I don't know if this is the cause, but it can't be helping.
Tor
Posts: 5
Joined: 15. Apr 2013, 00:47

Re: VM aborting while user running VB is inactive

Post by Tor »

Hmmm.... that run was done after the host system had been running a little while, and had loaded a large number of pictures to generate thumbnails, leading to something like 2GB cache. I've just started another session after a reboot of the host (sorry, I forgot to make a copy of "free -m" before a DisplayPort port issue on my MB caused the reboot) and will see how long it lasts.

By "inactive user" it might have been more clear to note that the aborts have occured with VB and the VM running on VT8 while using VT7 on the host console, and they have occured whether connected to the VM by RDP or not.
Tor
Posts: 5
Joined: 15. Apr 2013, 00:47

Re: VM aborting while user running VB is inactive

Post by Tor »

Well, that didn't last terribly long. About 7-8 minutes, unless I miss my guess. Log of the run attached in case it provides any useful info; free -m with VM running and after below.

Thanks for you help.

Machine running:

Code: Select all

~$ free
             total       used       free     shared    buffers     cached
Mem:          7459       4231       3227          0        191       1033
-/+ buffers/cache:       3006       4452
Swap:         4094          0       4094
After abort:

Code: Select all

$ free -m
             total       used       free     shared    buffers     cached
Mem:          7459       2418       5040          0        191       1045
-/+ buffers/cache:       1181       6277
Swap:         4094          0       4094
Attachments
Tor-2013-04-15-13-00-10.log
(61.03 KiB) Downloaded 20 times
Perryg
Site Moderator
Posts: 34369
Joined: 6. Sep 2008, 22:55
Primary OS: Linux other
VBox Version: OSE self-compiled
Guest OSses: *NIX

Re: VM aborting while user running VB is inactive

Post by Perryg »

Next time this happens look in the hosts syslog and see if it registers a segfault at about the same time as the abort.

Code: Select all

VirtualBox VM 4.2.12 r84980 linux.amd64 (Apr 12 2013 11:51:47) release log
00:00:02.001809   Oracle VM VirtualBox Extension Pack (Version: 4.2.10 r84104; VRDE Module: VBoxVRDP)
I am also surprised that it does not complain about the version mismatch. I would install the 4.2.12 ExtPack as well
Tor
Posts: 5
Joined: 15. Apr 2013, 00:47

Re: VM aborting while user running VB is inactive

Post by Tor »

Here is my host syslog spanning the time the VM stayed running - which does include a segfault. I'm reasonably technical, but not enough to mean anything beyond a problem. I've installed the latest ExtPack, restarted VB, and started the VM again.

Code: Select all

Apr 15 12:57:13 kSheyna kernel: [16007.619024] warning: `VirtualBox' uses 32-bi
t capabilities (legacy support in use)
Apr 15 12:57:31 kSheyna rtkit-daemon[2488]: Successfully made thread 4967 of pr
ocess 4967 (n/a) owned by '1001' high priority at nice level -11.
Apr 15 12:57:31 kSheyna rtkit-daemon[2488]: Supervising 5 threads of 2 processe
s of 2 users.
Apr 15 12:57:31 kSheyna rtkit-daemon[2488]: Successfully made thread 4968 of pr
ocess 4967 (n/a) owned by '1001' RT at priority 5.
Apr 15 12:57:31 kSheyna rtkit-daemon[2488]: Supervising 6 threads of 2 processes of 2 users.
Apr 15 12:57:31 kSheyna rtkit-daemon[2488]: Successfully made thread 4969 of process 4967 (n/a) owned by '1001' RT at priority 5.
Apr 15 12:57:31 kSheyna rtkit-daemon[2488]: Supervising 7 threads of 2 processes of 2 users.
Apr 15 12:57:31 kSheyna rtkit-daemon[2488]: Successfully made thread 4970 of process 4967 (n/a) owned by '1001' RT at priority 5.
Apr 15 12:57:31 kSheyna rtkit-daemon[2488]: Supervising 8 threads of 2 processes of 2 users.
Apr 15 12:57:33 kSheyna acpid: client 3018[0:0] has disconnected
Apr 15 12:57:33 kSheyna acpid: client 4606[0:0] has disconnected
Apr 15 12:57:33 kSheyna acpid: client connected from 3018[0:0]
Apr 15 12:57:33 kSheyna acpid: 1 client rule loaded
Apr 15 12:57:48 kSheyna acpid: client 3018[0:0] has disconnected
Apr 15 12:57:48 kSheyna acpid: client connected from 4606[0:0]
Apr 15 12:57:48 kSheyna acpid: 1 client rule loaded
Apr 15 12:57:51 kSheyna acpid: client 4606[0:0] has disconnected
Apr 15 12:57:51 kSheyna acpid: client connected from 3018[0:0]
Apr 15 12:57:51 kSheyna acpid: 1 client rule loaded
Apr 15 12:57:54 kSheyna acpid: client 3018[0:0] has disconnected
Apr 15 12:57:54 kSheyna acpid: client connected from 4606[0:0]
Apr 15 12:57:54 kSheyna acpid: 1 client rule loaded
Apr 15 12:58:16 kSheyna acpid: client 4606[0:0] has disconnected
Apr 15 12:58:16 kSheyna acpid: client connected from 3018[0:0]
Apr 15 12:58:16 kSheyna acpid: 1 client rule loaded
Apr 15 12:58:39 kSheyna acpid: client 3018[0:0] has disconnected
Apr 15 12:58:39 kSheyna acpid: client connected from 4606[0:0]
Apr 15 12:58:39 kSheyna acpid: 1 client rule loaded
Apr 15 12:58:59 kSheyna acpid: client 4606[0:0] has disconnected
Apr 15 12:58:59 kSheyna acpid: client connected from 3018[0:0]
Apr 15 12:58:59 kSheyna acpid: 1 client rule loaded
Apr 15 13:00:02 kSheyna acpid: client 3018[0:0] has disconnected
Apr 15 13:00:02 kSheyna acpid: client connected from 4606[0:0]
Apr 15 13:00:02 kSheyna acpid: 1 client rule loaded
Apr 15 13:00:12 kSheyna acpid: client 4606[0:0] has disconnected
Apr 15 13:00:12 kSheyna acpid: client connected from 3018[0:0]
Apr 15 13:00:12 kSheyna acpid: 1 client rule loaded
Apr 15 13:05:10 kSheyna acpid: client 3018[0:0] has disconnected
Apr 15 13:05:10 kSheyna acpid: client connected from 3018[0:0]
Apr 15 13:05:10 kSheyna acpid: 1 client rule loaded
Apr 15 13:06:23 kSheyna kernel: [16558.406166] show_signal_msg: 30 callbacks suppressed
Apr 15 13:06:23 kSheyna kernel: [16558.406177] EMT[4944]: segfault at 8 ip 00007f3be8f66a88 sp 00007f3bcd98b9b0 error 6 in VirtualBox.so[7f3be8c40000+666000]
Apr 15 13:06:37 kSheyna acpid: client 3018[0:0] has disconnected
Apr 15 13:06:37 kSheyna acpid: client connected from 4606[0:0]
Apr 15 13:06:37 kSheyna acpid: 1 client rule loaded
Perryg
Site Moderator
Posts: 34369
Joined: 6. Sep 2008, 22:55
Primary OS: Linux other
VBox Version: OSE self-compiled
Guest OSses: *NIX

Re: VM aborting while user running VB is inactive

Post by Perryg »

This deserves a ticket being posted at bugtracker
Explain everything that we found so far here and you might want to read https://www.virtualbox.org/wiki/Core_dump just in case they want one.
Tor
Posts: 5
Joined: 15. Apr 2013, 00:47

Re: VM aborting while user running VB is inactive

Post by Tor »

Thanks Perry and mpack. For reference, it is bug #11724.

I've also seen a just started VM (WXP) have trouble opening a program via double click on the desktop icon from a remote RDP connection with Linux remote. Not sure this is even VB related, as I haven't yet bothered to try fixing the issue. When/if I get something more clear to go on I'll post separately, unless you recognize this off the top of your head.
Last edited by noteirak on 16. Apr 2013, 07:54, edited 1 time in total.
Reason: Added ticket link
Post Reply