Genymotion stuck booting with "Android" on screen

[John]

I'm running genymotion 2.4.  Been running this and a few other VMs with no problem.  However, today one of the VMs stopped booting.  When I look at the player log it shows:

May 4 16:28:36 [Genymotion Player] [Debug] [ADB] Use Genymotion Android tools: "C:/Program Files/Genymobile/Genymotion\tools\adb.exe"
May 4 16:28:36 [Genymotion Player] [Debug] Virtual device configured
May 4 16:28:36 [Genymotion Player] [Debug] Virtualization engine configured
May 4 16:28:36 [Genymotion Player] [Debug] No token found. Skipping activation
May 4 16:28:36 [Genymotion Player] [Debug] VBoxManage ("showvminfo", "GenM1") returns 0
May 4 16:28:36 [Genymotion Player] [Debug] Virtual Machine status: off
May 4 16:28:36 [Genymotion Player] [Debug] Start the device...
May 4 16:28:36 [Genymotion Player] [Debug] VBoxManage ("guestproperty", "set", "GenM1", "androvm_ip_management") returns 0
May 4 16:28:36 [Genymotion Player] [Debug] VBoxManage ("modifyvm", "GenM1", "--nic1", "hostonly") returns 0
May 4 16:28:36 [Genymotion Player] [Debug] VBoxManage ("modifyvm", "GenM1", "--hostonlyadapter1", "VirtualBox Host-Only Ethernet Adapter") returns 0
May 4 16:28:36 [Genymotion Player] [Debug] VBoxManage ("modifyvm", "GenM1", "--nictype1", "virtio") returns 0
May 4 16:28:36 [Genymotion Player] [Debug] VBoxManage ("modifyvm", "GenM1", "--cableconnected1", "on") returns 0
May 4 16:28:37 [Genymotion Player] [Debug] VBoxManage ("guestproperty", "set", "GenM1", "genymotion_vm_name", "GenM1") returns 0
May 4 16:28:37 [Genymotion Player] [Debug] VBoxManage ("showvminfo", "GenM1") returns 0
May 4 16:28:38 [Genymotion Player] [Debug] VBoxManage ("startvm", "GenM1", "--type", "headless") returns 0
May 4 16:28:38 [Genymotion Player] [Debug] VBoxManage ("showvminfo", "GenM1") returns 0
May 4 16:28:38 [Genymotion Player] [Debug] Virtual Machine started.
May 4 16:28:38 [Genymotion Player] [Debug] Waiting for an IP address...
May 4 16:28:38 [Genymotion Player] [Debug] VBoxManage ("guestproperty", "get", "GenM1", "androvm_ip_management") returns 0
May 4 16:28:39 [Genymotion Player] [Debug] VBoxManage ("guestproperty", "get", "GenM1", "androvm_ip_management") returns 0
May 4 16:28:40 [Genymotion Player] [Debug] VBoxManage ("guestproperty", "get", "GenM1", "androvm_ip_management") returns 0
May 4 16:28:41 [Genymotion Player] [Debug] VBoxManage ("guestproperty", "get", "GenM1", "androvm_ip_management") returns 0
May 4 16:28:42 [Genymotion Player] [Debug] VBoxManage ("guestproperty", "get", "GenM1", "androvm_ip_management") returns 0
May 4 16:28:43 [Genymotion Player] [Debug] VBoxManage ("guestproperty", "get", "GenM1", "androvm_ip_management") returns 0
May 4 16:28:43 [Genymotion Player] [Debug] Genymotion system started. Attributed IP address:  "192.168.56.101"
May 4 16:28:43 [Genymotion Player] [Debug] VBoxManage ("guestproperty", "get", "GenM1", "androvm_ip_management") returns 0
May 4 16:28:43 [Genymotion Player] [Warning] QPixmap::scaled: Pixmap is a null pixmap
May 4 16:28:43 [Genymotion Player] [Debug] VBoxManage ("guestproperty", "get", "GenM1", "androvm_ip_management") returns 0
May 4 16:28:44 [Genymotion Player] [Debug] Events Manager connecting to   QHostAddress( "192.168.56.101" )  : 22469
May 4 16:28:44 [Genymotion Player] [Debug] Events Manager connected
May 4 16:28:44 [Genymotion Player] [Debug] Starting Sensors Manager
May 4 16:28:44 [Genymotion Player] [Debug] Player running. Try to show window...
May 4 16:28:44 [Genymotion Player] [Debug] [ADB] Use Genymotion Android tools: "C:/Program Files/Genymobile/Genymotion\tools\adb.exe"
May 4 16:28:44 [Genymotion Player] [Debug] VBoxManage ("guestproperty", "get", "GenM1", "androvm_ip_management") returns 0
May 4 16:28:44 [Genymotion Player] [Debug] [ADB] Use Genymotion Android tools: "C:/Program Files/Genymobile/Genymotion\tools\adb.exe"
May 4 16:28:44 [Genymotion Player] [Debug] VBoxManage ("guestproperty", "get", "GenM1", "androvm_ip_management") returns 0
May 4 16:28:44 [Genymotion Player] [Debug] VBoxManage ("showvminfo", "GenM1") returns 0
May 4 16:28:44 [Genymotion Player] [Debug] VBoxManage ("guestproperty", "get", "GenM1", "androvm_ip_management") returns 0
May 4 16:28:44 [Genymotion Player] [Debug] [Adb][logcat] "C:/Users/John/AppData/Local/Genymobile/Genymotion/Genymobile/Genymotion/deployed/GenM1\logcat.txt" : "192.168.56.101"
May 4 16:28:44 [Genymotion Player] [Debug] Events Manager: requesting device capabilities
May 4 16:28:44 [Genymotion Player] [Debug] Received capabilities: "{"battery" : "on", "gps" : "on", "accelerometer" : "on", "camera" : "on", "screencast" : "on", "remotectl" : "on", "deviceid" : "on", "network" : "on", }"
May 4 16:28:44 [Genymotion Player] [Debug] Got ok from capabilities request
May 4 16:28:44 [Genymotion Player] [Debug] "accelerometer" : capability is: "on"
May 4 16:28:44 [Genymotion Player] [Debug] "battery" : capability is: "on"
May 4 16:28:44 [Genymotion Player] [Debug] "gps" : capability is: "on"
May 4 16:28:44 [Genymotion Player] [Debug] "screencast" : capability is: "on"
May 4 16:28:44 [Genymotion Player] [Debug] "remotectl" : capability is: "on"
May 4 16:28:44 [Genymotion Player] [Debug] "camera" : capability is: "on"
May 4 16:28:44 [Genymotion Player] [Debug] "deviceid" : capability is: "on"
May 4 16:28:44 [Genymotion Player] [Debug] "baseband" : capability not found on system
May 4 16:28:44 [Genymotion Player] [Debug] "network" : capability is: "on"
May 4 16:28:44 [Genymotion Player] [Debug] [GenymotionClient] Using persistant connection with virtual device
May 4 16:28:44 [Genymotion Player] [Debug] [compareVersions] System version: "2.3.0"
May 4 16:28:44 [Genymotion Player] [Debug] [compareVersions] Software version: "2.4.0"
May 4 16:28:44 [Genymotion Player] [Debug] [checkVersion] System version lower than software versions
May 4 16:28:49 [Genymotion Player] [Debug] [SensorManager] Connected
May 4 16:28:58 [Genymotion Player] [Debug] Signaling clipboard modification
May 4 16:28:58 [Genymotion Player] [Debug] Signaling clipboard modification


The Preview in VirtualBox shows some kind of repetive error.  But I can't read it since it's way too small.  Any help is appreciated.

[Julien Bolard]

Hi,

There might be more hint in the logcat.

Could you provide it?

--
You received this message because you are subscribed to the Google Groups "Genymotion Users" group.
To unsubscribe from this group and stop receiving emails from it, send an email to genymotion-use...@googlegroups.com.
To post to this group, send email to genymoti...@googlegroups.com.
For more options, visit https://groups.google.com/d/optout.

[John]

05-04 21:04:45.060 D/DHCP    (   66): --- dhcp ack (5) ---

05-04 21:04:45.060 D/DHCP    (   66): ip 192.168.56.101 gw 0.0.0.0 prefixLength 24

05-04 21:04:45.060 D/DHCP    (   66): server 192.168.56.100, lease 3600 seconds

05-04 21:04:45.060 D/DHCP    (   66): configuring eth0

05-04 21:04:45.068 D/NetUtils(   66): Don't create null default route on eth0

05-04 21:04:45.272 I/mediaserver(  123): ServiceManager: 0xb8667450

05-04 21:04:45.272 I/AudioFlinger(  123): Using default 3000 mSec as standby time.

05-04 21:04:45.276 I/CameraService(  123): CameraService started (pid=123)

05-04 21:04:45.424 I/installd(  124): installd firing up

05-04 21:04:45.480 V/EmulatedCamera_GenyCamera(  123): Initialize:

05-04 21:04:45.480 V/EmulatedCamera_GenyCamera(  123):    initializing back camera on local srv port 24801

05-04 21:04:45.480 E/EmulatedCamera_GenyClient(  123): connectClient: Unable to connect to the camera service port 24801: Connection refused

05-04 21:04:45.480 V/EmulatedCamera_Device(  123): EmulatedCameraDevice destructor

05-04 21:04:45.480 V/EmulatedCamera_GenyCamera(  123): Initialize:

05-04 21:04:45.480 V/EmulatedCamera_GenyCamera(  123):    initializing front camera on local srv port 24811

05-04 21:04:45.480 E/EmulatedCamera_GenyClient(  123): connectClient: Unable to connect to the camera service port 24811: Connection refused

05-04 21:04:45.480 V/EmulatedCamera_Device(  123): EmulatedCameraDevice destructor

05-04 21:04:45.480 I/CameraService(  123): Loaded "Emulated Camera Module" camera module

05-04 21:04:45.484 I/AudioPolicyManagerBase(  123): loadAudioPolicyConfig() loaded /system/etc/audio_policy.conf

05-04 21:04:45.488 I/AudioFlinger(  123): loadHwModule() Loaded primary audio interface from Genymotion audio HW HAL (audio) handle 1

05-04 21:04:45.488 I/AudioFlinger(  123): HAL output buffer size 512 frames, normal mix buffer size 1024 frames

05-04 21:04:45.488 I/genymotion_audio(  123): Starting pcm server

05-04 21:04:45.488 I/genymotion_audio(  123): out sampling rate 44100

05-04 21:04:45.492 I/AudioMixer(  123): found effect "Multichannel Downmix To Stereo" from The Android Open Source Project

05-04 21:04:45.492 E/MonoPipe(  123): Failed to fetch local time frequency when constructing a MonoPipe (res = -32).  getNextWriteTimestamp calls will be non-functional

05-04 21:04:45.512 D/local_opengl(  113): Starting local_opengl

05-04 21:04:45.516 E/vinput-seamless(  112): found PS2 device

05-04 21:04:45.516 E/vinput-seamless(  112): found seamless mouse device

05-04 21:04:45.528 I/Vold    (  110): Vold 2.1 (the revenge) firing up

05-04 21:04:45.536 I/Netd    (  117): Netd 1.0 starting

05-04 21:04:45.536 W/InterfaceController(  117): Warning (dlopen failed: library "/system/lib/libnetcmdiface.so" not found) while opening the net interface command library

05-04 21:04:45.568 I/DEBUG   (  118): debuggerd: Sep 24 2014 22:59:06

05-04 21:04:45.580 I/SurfaceFlinger(  120): SurfaceFlinger is starting

05-04 21:04:45.580 I/SurfaceFlinger(  120): SurfaceFlinger's main thread ready to run. Initializing graphics H/W...

05-04 21:04:45.596 D/libEGL  (  120): loaded /system/lib/egl/libEGL_genymotion.so

05-04 21:04:45.636 E/eglCodecCommon(  120): TcpStream::connect() - connect() errno=111

05-04 21:04:45.636 E/        (  120): Failed to connect to host (TcpStream)!!!

05-04 21:04:45.636 E/EGL_genymotion(  120): Failed to establish connection with the host

05-04 21:04:45.636 E/eglCodecCommon(  120): TcpStream::connect() - connect() errno=111

05-04 21:04:45.636 E/        (  120): Failed to connect to host (TcpStream)!!!

05-04 21:04:45.636 E/EGL_genymotion(  120): Failed to establish connection with the host

..... repeats a bunch of times ....

05-04 21:04:45.640 D/AndroidRuntime(  121): >>>>>> AndroidRuntime START com.android.internal.os.ZygoteInit <<<<<<

05-04 21:04:45.640 D/AndroidRuntime(  121): CheckJNI is OFF


.... more of previous error from TcpStream....

05-04 21:04:45.648 D/libEGL  (  120): loaded /system/lib/egl/libGLESv2_genymotion.so

... more TcpStream ...

05-04 21:04:45.664 W/libEGL  (  120): eglInitialize(0xb6ba9040) failed (EGL_SUCCESS)

05-04 21:04:45.736 E/eglCodecCommon(  120): TcpStream::connect() - connect() errno=111

05-04 21:04:45.736 E/        (  120): Failed to connect to host (TcpStream)!!!

05-04 21:04:45.736 E/gralloc_vbox86(  120): gralloc: Failed to get host connection

05-04 21:04:45.736 E/SurfaceFlinger(  120): hwcomposer module not found

05-04 21:04:45.736 E/SurfaceFlinger(  120): ERROR: failed to open framebuffer (I/O error), aborting

05-04 21:04:45.796 D/AndroidRuntime(  149):

05-04 21:04:45.796 D/AndroidRuntime(  149): >>>>>> AndroidRuntime START com.android.internal.os.ZygoteInit <<<<<<

05-04 21:04:45.796 D/AndroidRuntime(  149): CheckJNI is OFF

05-04 21:04:45.900 D/dalvikvm(  149): Trying to load lib libjavacore.so 0x0

05-04 21:04:45.908 D/dalvikvm(  149): Added shared lib libjavacore.so 0x0

05-04 21:04:45.944 D/dalvikvm(  149): Trying to load lib libnativehelper.so 0x0

05-04 21:04:45.944 D/dalvikvm(  149): Added shared lib libnativehelper.so 0x0

05-04 21:04:45.984 W/dalvikvm(  149): PR_SET_NO_NEW_PRIVS failed. Is your kernel compiled correctly?: Invalid argument

05-04 21:04:46.288 I/SamplingProfilerIntegration(  149): Profiling disabled.

05-04 21:04:46.304 I/Zygote  (  149): Preloading classes...

05-04 21:04:46.304 D/dalvikvm(  149): GC_EXPLICIT freed 36K, 9% free 428K/468K, paused 0ms+0ms, total 0ms

05-04 21:04:46.308 D/dalvikvm(  149): GC_EXPLICIT freed 4K, 5% free 498K/520K, paused 0ms+0ms, total 0ms

05-04 21:04:46.312 D/dalvikvm(  149): Note: class Landroid/app/ActivityManagerNative; has 163 unimplemented (abstract) methods

05-04 21:04:46.312 D/dalvikvm(  149): GC_EXPLICIT freed 22K, 5% free 529K/556K, paused 0ms+0ms, total 0ms

05-04 21:04:46.324 D/dalvikvm(  149): GC_EXPLICIT freed 12K, 3% free 587K/604K, paused 1ms+0ms, total 10ms

05-04 21:04:46.324 D/dalvikvm(  149): GC_EXPLICIT freed 25K, 5% free 618K/648K, paused 0ms+1ms, total 1ms

05-04 21:04:46.328 D/dalvikvm(  149): GC_EXPLICIT freed 27K, 5% free 645K/676K, paused 0ms+0ms, total 0ms

05-04 21:04:46.456 D/dalvikvm(  149): GC_EXPLICIT freed 80K, 11% free 777K/864K, paused 0ms+0ms, total 1ms

05-04 21:04:46.640 D/dalvikvm(  149): GC_EXPLICIT freed 29K, 7% free 803K/864K, paused 0ms+0ms, total 0ms

05-04 21:04:46.648 D/TextLayoutCache(  149): Using debug level = 0 - Debug Enabled = 0

05-04 21:04:46.688 I/dalvikvm(  149): threadid=1: recursive native library load attempt (/system/lib/libmedia_jni.so)

05-04 21:04:46.688 D/MtpDeviceJNI(  149): register_android_mtp_MtpDevice

05-04 21:04:46.688 I/dalvikvm(  149): threadid=1: recursive native library load attempt (/system/lib/libmedia_jni.so)

05-04 21:04:46.688 I/dalvikvm(  149): threadid=1: recursive native library load attempt (/system/lib/libmedia_jni.so)

05-04 21:04:46.688 I/dalvikvm(  149): threadid=1: recursive native library load attempt (/system/lib/libmedia_jni.so)

05-04 21:04:46.688 D/dalvikvm(  149): GC_EXPLICIT freed 23K, 4% free 834K/864K, paused 0ms+0ms, total 0ms

05-04 21:04:46.724 D/dalvikvm(  149): GC_EXPLICIT freed 24K, 4% free 872K/900K, paused 0ms+0ms, total 0ms

05-04 21:04:46.744 D/dalvikvm(  149): GC_EXPLICIT freed 20K, 3% free 906K/928K, paused 0ms+0ms, total 0ms


.... more GC_EXPLICITS...

05-04 21:04:47.864 I/dalvikvm(  149): System server process 328 has been created

05-04 21:04:47.872 I/Zygote  (  149): Accepting command socket connections

05-04 21:04:47.928 I/Genymotion(  328): overriding Battery service paths with fake ones

05-04 21:04:47.932 I/sysproc (  328): Entered system_init()

05-04 21:04:47.932 I/sysproc (  328): ServiceManager: 0xb95e7938

05-04 21:04:47.932 D/SensorService(  328): nuSensorService starting...

05-04 21:04:47.932 I/SensorService(  328): Genymotion Accelerometer

05-04 21:04:47.932 I/sysproc (  328): System server: starting Android runtime.

05-04 21:04:47.932 I/sysproc (  328): System server: starting Android services.

05-04 21:04:47.932 I/SystemServer(  328): Entered the Android system server!

05-04 21:04:47.940 I/sysproc (  328): System server: entering thread pool.

05-04 21:04:47.940 D/SensorService(  328): nuSensorService thread starting...

05-04 21:04:47.940 I/SystemServer(  328): Enabled StrictMode logging for UI Looper

05-04 21:04:47.948 I/installd(  124): new connection

05-04 21:04:47.948 I/SystemServer(  328): Waiting for installd to be ready.

05-04 21:04:47.948 I/Installer(  328): connecting...

05-04 21:04:47.948 I/SystemServer(  328): Power Manager

05-04 21:04:47.948 I/SystemServer(  328): Enabled StrictMode logging for WM Looper

05-04 21:04:47.948 I/SystemServer(  328): Activity Manager

05-04 21:04:47.960 D/MDnsDS  (  117): MDnsSdListener::Hander starting up

05-04 21:04:47.960 D/MDnsDS  (  117): MDnsSdListener starting to monitor

05-04 21:04:47.960 D/MDnsDS  (  117): Going to poll with pollCount 1

05-04 21:04:47.960 I/ActivityManager(  328): Memory class: 96

05-04 21:04:47.980 D/dalvikvm(  328): GC_CONCURRENT freed 185K, 3% free 8987K/9200K, paused 8ms+0ms, total 10ms

05-04 21:04:47.984 W/BatteryStats(  328): Error writing battery statistics

05-04 21:04:47.984 W/BatteryStats(  328): java.io.FileNotFoundException: /data/system/batterystats.bin.tmp: open failed: EROFS (Read-only file system)

05-04 21:04:47.984 W/BatteryStats(  328):     at libcore.io.IoBridge.open(IoBridge.java:409)

05-04 21:04:47.984 W/BatteryStats(  328):     at java.io.FileOutputStream.<init>(FileOutputStream.java:88)

05-04 21:04:47.984 W/BatteryStats(  328):     at java.io.FileOutputStream.<init>(FileOutputStream.java:73)

05-04 21:04:47.984 W/BatteryStats(  328):     at com.android.internal.os.BatteryStatsImpl.commitPendingDataToDisk(BatteryStatsImpl.java:5093)

05-04 21:04:47.984 W/BatteryStats(  328):     at com.android.internal.os.BatteryStatsImpl$1.run(BatteryStatsImpl.java:5073)

05-04 21:04:47.984 W/BatteryStats(  328): Caused by: libcore.io.ErrnoException: open failed: EROFS (Read-only file system)

05-04 21:04:47.984 W/BatteryStats(  328):     at libcore.io.Posix.open(Native Method)

05-04 21:04:47.984 W/BatteryStats(  328):     at libcore.io.BlockGuardOs.open(BlockGuardOs.java:110)

05-04 21:04:47.984 W/BatteryStats(  328):     at libcore.io.IoBridge.open(IoBridge.java:393)

05-04 21:04:47.984 W/BatteryStats(  328):     ... 4 more


Lots more lines.. not sure if I have shown enough.