"Home has stopped" when sending voice message

GoogleCodeExporter commented 8 years ago

What steps will reproduce the problem?
1. "ok glass", "send a message to", "so-and-so", "this is a message"

What is the expected output? What do you see instead?
I get an exception card saying that "Home has stopped." The message isn't sent 
and I'm booted back to the clock.

What version of the product are you using? On what operating system?
V2 hardware, XE12

Please provide any additional information below.
Stacktrace follows:

01-02 12:00:26.523  11934-11934/? I/MainTimelineActivity﹕ Voice command 
triggered
01-02 12:00:26.531  11934-11934/? W/MainTimelineActivity﹕ Voice command not 
handled
01-02 12:00:26.531  11934-11934/? I/VoiceMenuDialog﹕ Voice command triggered
01-02 12:00:26.539  11934-11934/? I/HomeMenuItems﹕ Initiating glassware 
message to entity 
[entityGuid=entity_guid:api:823483604716/4517868215408959503_1002555206830595567
80].
01-02 12:00:26.539      196-946/? I/ActivityManager﹕ START 
{act=com.google.glass.ACTION_SEND_VOICE_MESSAGE 
cmp=com.google.glass.home/.voice.VoiceMessageActivity (has extras)} from pid 
11934
01-02 12:00:26.640      575-576/? D/dalvikvm﹕ GC_CONCURRENT freed 1483K, 32% 
free 13581K/19911K, paused 5ms+4ms
01-02 12:00:26.640      575-771/? I/UserEventService﹕ Logging user event: 
[action=SEND_MESSAGE_INITIATED, data=]
01-02 12:00:26.672      196-946/? D/dalvikvm﹕ GC_FOR_ALLOC freed 477K, 9% 
free 12771K/14023K, paused 95ms
01-02 12:00:26.672      196-241/? D/GlassConnectivityService﹕ 
sendStickyBroadcast: action=android.net.conn.CONNECTIVITY_CHANGE
01-02 12:00:26.687      363-363/? I/ConnectivityLogger﹕ stateChange from 
PROXY to PROXY adter 37023ms.
01-02 12:00:26.687      196-242/? D/Tethering﹕ 
MasterInitialState.processMessage what=3
01-02 12:00:26.687      363-363/? 
I/CompanionSocketServer/connectivityReceiver﹕ Received intent 
android.net.conn.CONNECTIVITY_CHANGE
01-02 12:00:26.687      196-241/? D/GlassConnectivityService﹕ 
sendStickyBroadcast: action=android.net.conn.CONNECTIVITY_CHANGE
01-02 12:00:26.695      363-363/? 
I/CompanionSocketServer/connectivityReceiver﹕ isTethered = false, isOnWifi = 
false
01-02 12:00:26.695      363-363/? I/NetworkSocketThread﹕ Closing 
WifiNetworkSocketThread-WIFI_MULTICAST
01-02 12:00:26.695      363-363/? I/CompanionServerThread﹕ Unblock 
WifiNetworkSocketThread-WIFI_MULTICAST
01-02 12:00:26.695      363-363/? I/ConnectivityChecker/receiver﹕ Network is 
connected, attempting ping.
01-02 12:00:26.703      196-242/? D/Tethering﹕ 
MasterInitialState.processMessage what=3
01-02 12:00:26.711  11934-11934/? I/MainTimelineActivity﹕ onPause: 41731c70
01-02 12:00:26.711  11934-11934/? I/VoiceMenuDialog﹕ Removing listener from 
VoiceService: VoiceMenuDialog
01-02 12:00:26.719      108-574/? D/audio_hw_primary﹕ adev_set_parameters:set 
allow_input_effects to 0
01-02 12:00:26.719      673-788/? I/RecognizerController﹕ startListening
01-02 12:00:26.719      673-788/? E/VoiceEngine﹕ Attempted to start reading 
from the microphone but it is already reading
01-02 12:00:26.734      363-363/? I/ConnectivityLogger﹕ stateChange from 
PROXY to PROXY adter 51ms.
01-02 12:00:26.734      363-363/? 
I/CompanionSocketServer/connectivityReceiver﹕ Received intent 
android.net.conn.CONNECTIVITY_CHANGE
01-02 12:00:26.742  11934-11934/? W/MainTimelineActivity﹕ Orientation sensors 
still running in onPause! Stopping them.
01-02 12:00:26.742      363-363/? 
I/CompanionSocketServer/connectivityReceiver﹕ isTethered = false, isOnWifi = 
false
01-02 12:00:26.742      363-363/? I/NetworkSocketThread﹕ Closing 
WifiNetworkSocketThread-WIFI_MULTICAST
01-02 12:00:26.742      363-363/? I/CompanionServerThread﹕ Unblock 
WifiNetworkSocketThread-WIFI_MULTICAST
01-02 12:00:26.742      363-363/? I/ConnectivityChecker/receiver﹕ Network is 
connected, attempting ping.
01-02 12:00:26.742  11934-11934/? I/MainTimelineActivity﹕ Removing listener 
from VoiceService: MainTimelineActivity
01-02 12:00:26.750      196-241/? D/GlassConnectivityService﹕ Inet[14]: 100
01-02 12:00:26.758  11206-11206/? D/sysproxy﹕ [T:59] Establishing a new TCP 
stream to: 74.125.198.99:443
01-02 12:00:26.758  11206-11206/? D/sysproxy﹕ [B] Queue length / size on 
stream open: 0 items / 0 bytes
01-02 12:00:26.765  11206-11206/? D/sysproxy﹕ [T:60] Establishing a new TCP 
stream to: 74.125.198.99:443
01-02 12:00:26.765  11206-11206/? D/sysproxy﹕ [B] Queue length / size on 
stream open: 0 items / 0 bytes
01-02 12:00:26.797      196-241/? D/GlassConnectivityService﹕ Inet[14]: 100
01-02 12:00:26.797      196-241/? D/GlassConnectivityService﹕ Inet: condition 
change already in flight.
01-02 12:00:26.805  11934-11934/? W/PitchHelper﹕ OrientationHelper was not 
started, but got call to stop.  Punting.
01-02 12:00:26.812      264-267/? D/dalvikvm﹕ GC_CONCURRENT freed 325K, 39% 
free 9735K/15943K, paused 2ms+3ms
01-02 12:00:26.836  11934-11934/? I/VoiceMessageActivity﹕ onCreate(null, 
41c8e4b8):
01-02 12:00:26.953  11934-11934/? D/dalvikvm﹕ GC_FOR_ALLOC freed 244K, 6% 
free 28833K/30471K, paused 97ms
01-02 12:00:26.961  11934-11934/? I/dalvikvm-heap﹕ Grow heap (frag case) to 
29.104MB for 921616-byte allocation
01-02 12:00:26.984      673-675/? D/dalvikvm﹕ GC_CONCURRENT freed 89K, 20% 
free 10774K/13383K, paused 3ms+13ms
01-02 12:00:27.031  11934-11944/? D/dalvikvm﹕ GC_FOR_ALLOC freed 5K, 6% free 
29728K/31431K, paused 59ms
01-02 12:00:27.117  11934-11934/? I/VoiceMessageActivity﹕ onStart: 41c8e4b8
01-02 12:00:27.125  11934-11934/? I/VoiceMessageActivity﹕ onResume: 41c8e4b8
01-02 12:00:27.125  11934-11934/? I/VoiceInputHelper﹕ Attaching listener to 
VoiceService: VoiceMessageActivity
01-02 12:00:27.133  11934-11934/? I/VoiceMessageActivity﹕ Setting 
wantAudioData: false
01-02 12:00:27.140     673-9055/? I/BroadcastingVoiceInputCallback﹕ 
Registered VoiceMessageActivity/voiceInputCallback
01-02 12:00:27.156      673-788/? I/RecognizerController﹕ 
attachVoiceInputCallback
01-02 12:00:27.195     673-1295/? D/dalvikvm﹕ GC_EXPLICIT freed 45K, 19% free 
10933K/13383K, paused 3ms+6ms
01-02 12:00:27.203      196-206/? I/AudioService﹕ AudioFocus  
requestAudioFocus() from 
android.media.AudioManager@417a28c8com.google.android.speech.audio.AudioControll
er$1@41768de8
01-02 12:00:27.203     673-1295/? D/RecognitionEngineStore﹕ Using embedded
01-02 12:00:27.203     673-1295/? D/RecognitionEngineStore﹕ Using network
01-02 12:00:27.250      196-222/? I/ActivityManager﹕ Displayed 
com.google.glass.home/.voice.VoiceMessageActivity: +500ms
01-02 12:00:27.250      196-241/? D/GlassConnectivityService﹕ Inet[14] 
committed: 100 -> 100
01-02 12:00:27.250      196-241/? D/GlassConnectivityService﹕ 
sendStickyBroadcast: action=android.net.conn.INET_CONDITION_ACTION
01-02 12:00:27.336  11934-11934/? D/OpenGLRenderer﹕ Flushing caches (mode 0)
01-02 12:00:27.422      575-771/? I/UserEventService﹕ Logging user event: 
[action=VOICE_INPUT_STARTED, data=|id=1388685627130|type=2|trigger=1|]
01-02 12:00:27.453      575-771/? I/UserEventService﹕ Logging user event: 
[action=DEFERRED_CONTENT_LOAD, data=|t=ei|l=163|]
01-02 12:00:28.062    673-12096/? I/VoiceSearchContainer﹕ Opening HTTP 
connection to: 
https://www.google.com/m/voice-search/up?pair=bb03e3b8-dce8-4397-b3e3-7762ba7e30
da
01-02 12:00:28.062    673-12098/? I/VoiceSearchContainer﹕ Opening HTTP 
connection to: 
https://www.google.com/m/voice-search/down?pair=bb03e3b8-dce8-4397-b3e3-7762ba7e
30da
01-02 12:00:28.070  11206-11206/? D/sysproxy﹕ [T:59] TCP connection broken, 
closing stream.
01-02 12:00:28.070  11206-11206/? D/sysproxy﹕ [T:59] Closed stream. RX/TX: 
593/3747
01-02 12:00:28.070  11206-11206/? D/sysproxy﹕ [T:60] TCP connection broken, 
closing stream.
01-02 12:00:28.070  11206-11206/? D/sysproxy﹕ [T:60] Closed stream. RX/TX: 
593/3747
01-02 12:00:28.078  11206-11206/? D/sysproxy﹕ [T:61] Establishing a new TCP 
stream to: 173.194.64.104:443
01-02 12:00:28.078  11206-11206/? D/sysproxy﹕ [B] Queue length / size on 
stream open: 0 items / 0 bytes
01-02 12:00:28.086      196-241/? D/GlassConnectivityService﹕ Inet[14]: 100
01-02 12:00:28.117      575-771/? I/UserEventService﹕ Logging user event: 
[action=CONNECTIVITY_NETWORK_REQUEST, 
data=|m=HEAD|s=true|l=1286|hs=204|ont=14|ons=2|fnt=14|fns=2|]
01-02 12:00:28.156      575-771/? I/UserEventService﹕ Logging user event: 
[action=CONNECTIVITY_NETWORK_REQUEST, 
data=|m=HEAD|s=true|l=1334|hs=204|ont=14|ons=2|fnt=14|fns=2|]
01-02 12:00:28.164  11206-11206/? W/sysproxy﹕ [B] Received spurious ACK 
packet for stream 59
01-02 12:00:28.164  11206-11206/? W/sysproxy﹕ [B] Received spurious ACK 
packet for stream 60
01-02 12:00:28.586      196-241/? D/GlassConnectivityService﹕ Inet[14] 
committed: 100 -> 100
01-02 12:00:28.586      196-241/? D/GlassConnectivityService﹕ 
sendStickyBroadcast: action=android.net.conn.INET_CONDITION_ACTION
01-02 12:00:29.195      673-675/? D/dalvikvm﹕ GC_CONCURRENT freed 480K, 19% 
free 10972K/13383K, paused 4ms+5ms
01-02 12:00:29.320      247-247/? I/wpa_supplicant﹕ wlan0: Trying to 
associate with 30:85:a9:39:6d:10 (SSID='Boombox' freq=2412 MHz)
01-02 12:00:29.617      247-247/? I/wpa_supplicant﹕ wlan0: Associated with 
30:85:a9:39:6d:10
01-02 12:00:29.961      575-771/? I/UserEventService﹕ Logging user event: 
[action=VOICE_INPUT_FIRST_RECOGNITION, 
data=|id=1388685627130|time=2792|type=2|trigger=1|]
01-02 12:00:30.265      196-532/? I/AudioService﹕ AudioFocus  
abandonAudioFocus() from 
android.media.AudioManager@417a28c8com.google.android.speech.audio.AudioControll
er$1@41768de8
01-02 12:00:30.273    673-12097/? D/dalvikvm﹕ threadid=34: thread exiting, 
not yet detached (count=0)
01-02 12:00:30.273    673-11317/? I/decoder﹕ INFO: recognition time wall: 
3.00241 sec user: 1.17969 sec sys: 0.171875 sec
01-02 12:00:30.336      108-193/? D/audio_hw_primary﹕ select_output_device: 
output_type: 1, base_headset_volume: 1
01-02 12:00:30.359      575-771/? I/UserEventService﹕ Logging user event: 
[action=VOICE_INPUT_END_OF_SPEECH, 
data=|id=1388685627130|time=3183|type=2|trigger=1|]
01-02 12:00:30.734  11934-11954/? W/dalvikvm﹕ threadid=17: thread exiting 
with uncaught exception (group=0x40db61f8)
01-02 12:00:30.734  11934-11954/? E/AndroidRuntime﹕ FATAL EXCEPTION: 
AsyncTask #4
    java.lang.NullPointerException
            at com.google.googlex.glass.common.proto.TimelineNano$TimelineItem.setCreator(TimelineNano.java:492)
            at com.google.glass.home.voice.SendMessageTimelineCreatorJob.populateForGlassware(SendMessageTimelineCreatorJob.java:353)
            at com.google.glass.home.voice.SendMessageTimelineCreatorJob.createTemporaryItem(SendMessageTimelineCreatorJob.java:147)
            at com.google.glass.timeline.TimelineItemCreatorJob.dispatchCreateTemporaryItem(TimelineItemCreatorJob.java:191)
            at com.google.glass.timeline.TimelineItemCreatorJob.run(TimelineItemCreatorJob.java:92)
            at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1076)
            at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:569)
            at java.lang.Thread.run(Thread.java:856)

Original issue reported on code.google.com by m...@cameroncurrie.net on 2 Jan 2014 at 6:14

GoogleCodeExporter commented 8 years ago

I should add that this still happens after rebooting the device. I'm 
essentially blocked from sending any messages.

Original comment by m...@cameroncurrie.net on 2 Jan 2014 at 6:23

GoogleCodeExporter commented 8 years ago

Hello,

Could you tell us to what kind of contact you are trying to send a message to? 
Is it a Contact you added through MyGlass or a Contact from Hangouts?

Thanks!
Alain

Original comment by ala...@google.com on 6 Jan 2014 at 7:09

Changed state: Pending
Added labels: Component-Other-API

GoogleCodeExporter commented 8 years ago

TLDR the problem only seems to occur when I try to message Hangout contacts.

After a little more testing, I find that I can send messages to contacts added 
through MyGlass that I don't have Hangout information for (e.g. SMS only). For 
one contact for whom I have cell phone and Hangout info, there are two entries 
in the list of available message recipients. When swiping through menus to 
select a recipient (as opposed to voice) I can distinguish between the two by 
their icon, and I'm only getting the crash when using Hangout to message the 
contact.

Original comment by m...@cameroncurrie.net on 7 Jan 2014 at 6:00

GoogleCodeExporter commented 8 years ago

I tried removing and re-adding the Hangouts glassware via MyGlass; I still get 
the crash.

Original comment by m...@cameroncurrie.net on 7 Jan 2014 at 6:02

GoogleCodeExporter commented 8 years ago

Original comment by ala...@google.com on 7 Jan 2014 at 9:06

Changed state: Accepted
Added labels: log-12435542

GoogleCodeExporter commented 8 years ago

Could you privately send me the e-mail address of the Glass user? This will 
help us track down the issue.

Thanks!
Alain

Original comment by ala...@google.com on 7 Jan 2014 at 11:31

Changed state: Pending

GoogleCodeExporter commented 8 years ago

Original comment by ala...@google.com on 5 Feb 2014 at 5:24

Changed state: Accepted

GoogleCodeExporter commented 8 years ago

Having this same exact issue, when messaging a contact (chosen as Hangout) it 
gives me a home has stopped error.  I switched the contact in myglass app to 
their email instead but then it says i must "enable hangouts" in myglass before 
I can message.

Tried removing and adding but nothing.

Original comment by marv...@gmail.com on 15 Feb 2014 at 1:06

GoogleCodeExporter commented 8 years ago

Hello,

After further investigation, it turns out that this issue happens when you 
create an alias for your account on Glass:
  * Main account has a username of "main.username@domain.com"
  * Alias and account on Glass has a username of "alias@domain.com"

To work around this issue, you can create a contact on google.com/contacts for 
"main.username@domain.com".

Best,
Alain

Original comment by ala...@google.com on 18 Feb 2014 at 4:48

GoogleCodeExporter commented 8 years ago

Alright, this has been fixed with XE16. Thanks for your help investigating this 
issue!

Original comment by ala...@google.com on 21 Apr 2014 at 3:58

Changed state: Fixed

nicolas2k / google-glass-api

"Home has stopped" when sending voice message #334