Comments (4)
My hunch here is what's happening is that the headunit process is crashing and then isn't restarted until the next true boot. Unfortunately the code which displays the log is broken, but if you can repro and copy off the /tmp/mnt/data/headunit.log file and post it might help.
A hacky workaround would be to modify the headunit_wrapper script to re-launch the process if it crashes, but ideally the code should be fixed to handle the events it's getting from the car correctly.
from headunit.
Below is headunit.log. It's the entire file but you'll see a line of asterisks that I added before starting reproducing the error (turning on the car, AA runs OK, turn off the car and ON again to see the error).
The missing plugins warnings and errors at the beginning of the log is something I also saw in the install log.
Hope it helps. Let me know if you need anything else.
uname:
sysname: Linux
release: 3.0.35
version: #1 SMP PREEMPT Sun Mar 15 10:12:10 IST 2015
machine: armv7l
libprotoversion: 2.6.1
libusb_get_version:
version: 1.0.9.0
rc:
describe:
openssl version: OpenSSL 1.0.2h 3 May 2016 (0x1000208f)
(gst-plugin-scanner:3230): GStreamer-WARNING **: Failed to load plugin '/usr/lib/gstreamer-0.10/libmfw_gst_mpeg2dec.so': lib_mpeg2_dec_arm11_elinux.so.2.2.0: cannot open shared object file: No such file or directory
(gst-plugin-scanner:3230): GStreamer-WARNING **: Failed to load plugin '/usr/lib/gstreamer-0.10/libmfw_gst_h264dec.so': lib_H264_dec_arm11_elinux.so.2.6.1: cannot open shared object file: No such file or directory
(gst-plugin-scanner:3230): GStreamer-CRITICAL **: gst_pad_template_new: assertion `caps != NULL' failed
(gst-plugin-scanner:3230): GStreamer-CRITICAL **: gst_element_class_add_pad_template: assertion `GST_IS_PAD_TEMPLATE (templ)' failed
(gst-plugin-scanner:3230): GStreamer-WARNING **: Failed to load plugin '/usr/lib/gstreamer-0.10/libmfw_gst_mpeg4aspdec.so': lib_MPEG4ASP_dec_arm11_elinux.so.1.2.1: cannot open shared object file: No such file or directory
�[1;34mMAX resolution 800x480
�[0mLooping
DBus::Glib::BusDispatcher attached
Making debug connections
snd_asoundlib_version: 1.0.24.1
dumpState({"pretty":false,"svc":"SRCS"})
{"HMI":{},"APP":["22.VR.SYSVR..NotPlaying","21.Media.AHA..NotPlaying","20.Media.Pandora..NotPlaying","19.Media.Stitcher..NotPlaying","18.Media.TV..NotPlaying","9.Media.LM..NotPlaying","1.Media.AUX..NotPlaying","15.MedAlert.BTHFALERT..NotPlaying","3.Media.DAB..NotPlaying","2.Media.CD..NotPlaying","5.Media.AM..NotPlaying","4.Media.XM..NotPlaying","7.LowAlert.TA..NotPlaying","6.Media.FM.gained.playing","14.Telephony.BTHF..NotPlaying","8.Media.HAR..NotPlaying","16.Media.USB..NotPlaying","17.Media.DVD..NotPlaying","13.Media.BTMUSIC..NotPlaying","12.InfoUser.RINGTONEVOL..NotPlaying","11.InfoMix.NAVIVOL..NotPlaying","10.InfoUser.BTHFVOL..NotPlaying"]}
Found stream SYSVR session id 22
Found stream AHA session id 21
Found stream Pandora session id 20
Found stream Stitcher session id 19
Found stream TV session id 18
Found stream LM session id 9
Found stream AUX session id 1
Found stream BTHFALERT session id 15
Found stream DAB session id 3
Found stream CD session id 2
Found stream AM session id 5
Found stream XM session id 4
Found stream TA session id 7
Found stream FM session id 6
Found stream BTHF session id 14
Found stream HAR session id 8
Found stream USB session id 16
Found stream DVD session id 17
Found stream BTMUSIC session id 13
Found stream RINGTONEVOL session id 12
Found stream NAVIVOL session id 11
Found stream BTHFVOL session id 10
W: /mnt/e/gittest/headunit/hu/hu_usb.cpp:377: Start : Opening device 0x1d6b : 0x0002
W: /mnt/e/gittest/headunit/hu/hu_usb.cpp:377: Start : Opening device 0x1d6b : 0x0002
W: /mnt/e/gittest/headunit/hu/hu_usb.cpp:377: Start : Opening device 0x0424 : 0x2640
W: /mnt/e/gittest/headunit/hu/hu_usb.cpp:377: Start : Opening device 0x0424 : 0x4040
W: /mnt/e/gittest/headunit/hu/hu_usb.cpp:437: Start : Nothing found, waiting
W: /mnt/e/gittest/headunit/hu/hu_uti.cpp:371: wait_for_device_connection : udev device removeed | node:/dev/bus/usb/002/003, subsystem:usb, devtype:usb_device
W: /mnt/e/gittest/headunit/hu/hu_uti.cpp:371: wait_for_device_connection : udev device removeed | node:/dev/bus/usb/002/002, subsystem:usb, devtype:usb_device
W: /mnt/e/gittest/headunit/hu/hu_uti.cpp:371: wait_for_device_connection : udev device added | node:/dev/bus/usb/002/004, subsystem:usb, devtype:usb_device
W: /mnt/e/gittest/headunit/hu/hu_usb.cpp:377: Start : Opening device 0x1d6b : 0x0002
W: /mnt/e/gittest/headunit/hu/hu_usb.cpp:377: Start : Opening device 0x1d6b : 0x0002
W: /mnt/e/gittest/headunit/hu/hu_usb.cpp:377: Start : Opening device 0x0424 : 0x2640
W: /mnt/e/gittest/headunit/hu/hu_usb.cpp:437: Start : Nothing found, waiting
W: /mnt/e/gittest/headunit/hu/hu_uti.cpp:371: wait_for_device_connection : udev device added | node:/dev/bus/usb/002/005, subsystem:usb, devtype:usb_device
W: /mnt/e/gittest/headunit/hu/hu_usb.cpp:377: Start : Opening device 0x1d6b : 0x0002
W: /mnt/e/gittest/headunit/hu/hu_usb.cpp:377: Start : Opening device 0x1d6b : 0x0002
W: /mnt/e/gittest/headunit/hu/hu_usb.cpp:377: Start : Opening device 0x0424 : 0x2640
W: /mnt/e/gittest/headunit/hu/hu_usb.cpp:377: Start : Opening device 0x0424 : 0x4040
W: /mnt/e/gittest/headunit/hu/hu_usb.cpp:437: Start : Nothing found, waiting
**********************************************************************************************************
W: /mnt/e/gittest/headunit/hu/hu_uti.cpp:371: wait_for_device_connection : udev device added | node:/dev/bus/usb/002/006, subsystem:usb, devtype:usb_device
W: /mnt/e/gittest/headunit/hu/hu_usb.cpp:377: Start : Opening device 0x1d6b : 0x0002
W: /mnt/e/gittest/headunit/hu/hu_usb.cpp:377: Start : Opening device 0x1d6b : 0x0002
W: /mnt/e/gittest/headunit/hu/hu_usb.cpp:377: Start : Opening device 0x0424 : 0x2640
W: /mnt/e/gittest/headunit/hu/hu_usb.cpp:377: Start : Opening device 0x0424 : 0x4040
W: /mnt/e/gittest/headunit/hu/hu_usb.cpp:377: Start : Opening device 0x04e8 : 0x6860
W: /mnt/e/gittest/headunit/hu/hu_usb.cpp:394: Start : Device 0x04e8 : 0x6860 responded with protocol ver 2
W: /mnt/e/gittest/headunit/hu/hu_usb.cpp:428: Start : Wating for the device to reconnect
W: /mnt/e/gittest/headunit/hu/hu_uti.cpp:371: wait_for_device_connection : udev device removeed | node:/dev/bus/usb/002/006, subsystem:usb, devtype:usb_device
W: /mnt/e/gittest/headunit/hu/hu_uti.cpp:371: wait_for_device_connection : udev device added | node:/dev/bus/usb/002/007, subsystem:usb, devtype:usb_device
W: /mnt/e/gittest/headunit/hu/hu_usb.cpp:449: Start : Found OAP Device
E: /mnt/e/gittest/headunit/hu/hu_usb.cpp:453: Start : Error libusb_claim_interface usb_err: -5 (Entity not found)
E: /mnt/e/gittest/headunit/hu/hu_usb.cpp:191: Stop : Done libusb_release_interface usb_err: -5 (Entity not found)
E: main.cpp:166: main : Something bad happened
DBus::Glib::BusDispatcher attached
Making debug connections
snd_asoundlib_version: 1.0.24.1
dumpState({"pretty":false,"svc":"SRCS"})
{"HMI":{},"APP":["26.InfoUser.SMS..NotPlaying","25.HighAlert.BTECAALERT..NotPlaying","24.MP911.BTECA..NotPlaying","23.InfoUser.PHONEBOOK..NotPlaying","22.VR.SYSVR..NotPlaying","21.Media.AHA..NotPlaying","20.Media.Pandora..NotPlaying","19.Media.Stitcher..NotPlaying","18.Media.TV..NotPlaying","9.Media.LM..NotPlaying","1.Media.AUX..NotPlaying","15.MedAlert.BTHFALERT..NotPlaying","3.Media.DAB..NotPlaying","2.Media.CD..NotPlaying","5.Media.AM..NotPlaying","4.Media.XM..NotPlaying","7.LowAlert.TA..NotPlaying","6.Media.FM.gained.playing","14.Telephony.BTHF..NotPlaying","8.Media.HAR..NotPlaying","16.Media.USB..NotPlaying","17.Media.DVD..NotPlaying","13.Media.BTMUSIC..NotPlaying","12.InfoUser.RINGTONEVOL..NotPlaying","11.InfoMix.NAVIVOL..NotPlaying","10.InfoUser.BTHFVOL..NotPlaying"]}
Found stream SMS session id 26
Found stream BTECAALERT session id 25
Found stream BTECA session id 24
Found stream PHONEBOOK session id 23
Found stream SYSVR session id 22
Found stream AHA session id 21
Found stream Pandora session id 20
Found stream Stitcher session id 19
Found stream TV session id 18
Found stream LM session id 9
Found stream AUX session id 1
Found stream BTHFALERT session id 15
Found stream DAB session id 3
Found stream CD session id 2
Found stream AM session id 5
Found stream XM session id 4
Found stream TA session id 7
Found stream FM session id 6
Found stream BTHF session id 14
Found stream HAR session id 8
Found stream USB session id 16
Found stream DVD session id 17
Found stream BTMUSIC session id 13
Found stream RINGTONEVOL session id 12
Found stream NAVIVOL session id 11
Found stream BTHFVOL session id 10
W: /mnt/e/gittest/headunit/hu/hu_usb.cpp:449: Start : Found OAP Device
W: /mnt/e/gittest/headunit/hu/hu_usb.cpp:457: Start : OK libusb_claim_interface usb_err: 0 (Success)
W: /mnt/e/gittest/headunit/hu/hu_usb.cpp:471: Start : Done get_config_descriptor config: 0x65c378 num_int: 2
W: /mnt/e/gittest/headunit/hu/hu_usb.cpp:496: Start : iusb_ep_in: 0x81
W: /mnt/e/gittest/headunit/hu/hu_usb.cpp:503: Start : iusb_ep_out: 0x02
W: /mnt/e/gittest/headunit/hu/hu_ssl.cpp:210: hu_ssl_begin_handshake : SSL_do_handshake() ret: -1
W: /mnt/e/gittest/headunit/hu/hu_ssl.cpp:66: send_ssl_handshake_packet : BIO_read() HS client req ret: 307
W: /mnt/e/gittest/headunit/hu/hu_ssl.cpp:233: hu_handle_SSLHandshake : BIO_write() server rsp ret: 2310
W: /mnt/e/gittest/headunit/hu/hu_ssl.cpp:236: hu_handle_SSLHandshake : SSL_do_handshake() ret: -1
W: /mnt/e/gittest/headunit/hu/hu_ssl.cpp:66: send_ssl_handshake_packet : BIO_read() HS client req ret: 1224
W: /mnt/e/gittest/headunit/hu/hu_ssl.cpp:233: hu_handle_SSLHandshake : BIO_write() server rsp ret: 51
W: /mnt/e/gittest/headunit/hu/hu_ssl.cpp:236: hu_handle_SSLHandshake : SSL_do_handshake() ret: 1
W: /mnt/e/gittest/headunit/hu/hu_ssl.cpp:262: hu_handle_SSLHandshake : SET: iaap_state: 2 (hu_STATE_STARTED)
W: /mnt/e/gittest/headunit/hu/hu_aap.cpp:1124: hu_aap_start : Starting HU thread
Starting Android Auto...
GPS thread started...Nightmode service connection established.
Bluetooth MAC: FC:35:E6:7C:1E:A2
W: /mnt/e/gittest/headunit/hu/hu_aap.cpp:546: hu_handle_ServiceDiscoveryRequest : Found BT address FC:35:E6:7C:1E:A2. Exposing Bluetooth service
W: /mnt/e/gittest/headunit/hu/hu_aap.cpp:631: hu_handle_AudioFocusRequest : AudioFocusRequest Focus Request CTR: 4
�[1;32mMFW_GST_ISINK_PLUGIN 3.0.5 build on Jun 10 2015 16:30:48.
�[0m�[1;32mvpudec versions :)
�[0m�[1;32m plugin: 3.0.5
�[0m�[1;32m wrapper: 1.0.28(VPUWRAPPER_ARM_LINUX Build on Jun 10 2015 16:26:09)
�[0m�[1;32m vpulib: 5.4.10
�[0m�[1;32m firmware: 2.1.8.34588
�[0mE: /mnt/e/gittest/headunit/hu/hu_aap.cpp:922: iaap_msg_process : Unknown chan: 8
hwbuf allocator zone(577536) created
�[1;34mVS0 created. in fmt[NV12] win(0,0-800,480:800x480) out win(0,-20-800,500:800x520)
�[0m�[1;34mset deinterlace mode 0
�[0mE: gps/mzd_gps.cpp:64: process_gps : GPS parse error: GPS Data Bad Format [$GPGSV] :: Checksum is invalid!.
W: /mnt/e/gittest/headunit/hu/hu_aap.cpp:631: hu_handle_AudioFocusRequest : AudioFocusRequest Focus Request CTR: 1
requestAudioFocus({"sessionId":16})
{}
AudioManagerClient::Notify signalName=audioFocusChangeEvent payload={"streamName":"FM","streamModeName":"FM","newFocus":"lost","destination":"Cabin","focusType":"permanent","streamType":"Media"}
Found audio sessionId 6 for stream FM
AudioManagerClient::Notify signalName=audioFocusChangeEvent payload={"streamName":"USB","streamModeName":"USB","newFocus":"gained","destination":"Cabin","focusType":"permanent","streamType":"Media"}
Found audio sessionId 16 for stream USB
E: /mnt/e/gittest/headunit/hu/hu_usb.cpp:103: Write : Failed: libusb_submit_transfer: -4 (No such device (it may have been disconnected))
E: /mnt/e/gittest/headunit/hu/hu_aap.cpp:144: hu_aap_tra_send : Error ihu_tra_send() error so stop Transport & AAP ret: -1 len: 39
E: /mnt/e/gittest/headunit/hu/hu_usb.cpp:103: Write : Failed: libusb_submit_transfer: -4 (No such device (it may have been disconnected))
E: /mnt/e/gittest/headunit/hu/hu_aap.cpp:144: hu_aap_tra_send : Error ihu_tra_send() error so stop Transport & AAP ret: -1 len: 37
E: /mnt/e/gittest/headunit/hu/hu_usb.cpp:103: Write : Failed: libusb_submit_transfer: -4 (No such device (it may have been disconnected))
E: /mnt/e/gittest/headunit/hu/hu_aap.cpp:144: hu_aap_tra_send : Error ihu_tra_send() error so stop Transport & AAP ret: -1 len: 37
E: /mnt/e/gittest/headunit/hu/hu_usb.cpp:103: Write : Failed: libusb_submit_transfer: -4 (No such device (it may have been disconnected))
E: /mnt/e/gittest/headunit/hu/hu_aap.cpp:144: hu_aap_tra_send : Error ihu_tra_send() error so stop Transport & AAP ret: -1 len: 37
E: /mnt/e/gittest/headunit/hu/hu_usb.cpp:103: Write : Failed: libusb_submit_transfer: -4 (No such device (it may have been disconnected))
E: /mnt/e/gittest/headunit/hu/hu_aap.cpp:144: hu_aap_tra_send : Error ihu_tra_send() error so stop Transport & AAP ret: -1 len: 37
E: /mnt/e/gittest/headunit/hu/hu_usb.cpp:103: Write : Failed: libusb_submit_transfer: -4 (No such device (it may have been disconnected))
E: /mnt/e/gittest/headunit/hu/hu_aap.cpp:144: hu_aap_tra_send : Error ihu_tra_send() error so stop Transport & AAP ret: -1 len: 37
from headunit.
Thanks! So just for confirm: This log (past the ****s) is from you connecting the phone when the car UI is on, but the engine is not started? Then you start the engine and AA freezes? (probably where all the usb errors are at the bottom).
It seems like we don't handle USB errors other than disconnects very well and the code could be deadlocking. Perhaps the USB connections are reset when the engine starts? I've noticed the audio cuts out even with the stock SW.
from headunit.
So there are two ways to get to the error.
A) Turn on car, plug phone, AA starts, turn car off and back on, plug phone, AA doesn't launch and error appears if you try to launch it manually.
B) Start the car on accessory mode, plug phone, AA starts, start car, AA freezes and if you try to reconnect the phone, AA doesn't launch and error appears if you try to launch it manually
The log is from A). Here's exactly what I did step by step:
- Turned on the car to accessory mode and connected it to my wifi
- Connected to the car though FTP and downloaded headunit.log for the first time and that log ended right above the ****s
- Went back to the car and plugged my phone, AA launched and worked fine.
- Turned off the car (I was in accessory mode)
- Unplugged the phone
- Turned accessory mode back on
- Plugged the phone, waited and nothing happened on the car
- Tried to launch AA manually on the car and I see the error _StartContextReady: Can't connect to headunit process
- Went back to my computer and downloaded headunit.log again and everything after the ***s was new.
I really never started the engine in this particular test as it seems to not matter at all as I just went back to the car and did the same steps 1 to 7, got the error, and then turned on the car and the error was still there. I also tried to unplug and re-plug the phone and a few other things such as shutting down the engine and turning it back on, without success.
I feels that once I get the error the only way to get AA running again is to reboot the headunit or turn off the car and wait 30 mins or whatever the car takes to get the headunit to sleep.
from headunit.
Related Issues (20)
- Should I update the readme.md HOT 1
- AA Focus Lost on (Certain) Calls HOT 2
- Audio only heard when music playing on V1.11+ HOT 15
- Need coding help on Videofocus detection at main.cpp HOT 1
- Alternate Phone Gateway IP retrieval for AA Wifi Access HOT 1
- Debugging Connection Refusal to Mazda AIO HOT 1
- HUD directions HOT 5
- Wireless AA over CMU hosted access point HOT 6
- Latest Google AA version 5.0.500224 causing restarts with Headunit AA_v1.12 HOT 58
- hud shim layer for OEM AA HOT 1
- Can't compile using instructions in Wiki tab HOT 9
- Installed New AA 1.12. No disolay HOT 3
- AA restarts frequently HOT 3
- AA issue: Can't connect to headunit process HOT 4
- V1.13 Installer Download HOT 3
- Enhancement: Make Nav HUD a setting that can be turned On/Off HOT 2
- Android Auto with Speedometer installed causes rotary control problems HOT 3
- Audio buffers and lags during video-intensive AA usage HOT 2
- Wireless setup not working HOT 4
- No sound on Mazda Connect HOT 2
Recommend Projects
-
React
A declarative, efficient, and flexible JavaScript library for building user interfaces.
-
Vue.js
🖖 Vue.js is a progressive, incrementally-adoptable JavaScript framework for building UI on the web.
-
Typescript
TypeScript is a superset of JavaScript that compiles to clean JavaScript output.
-
TensorFlow
An Open Source Machine Learning Framework for Everyone
-
Django
The Web framework for perfectionists with deadlines.
-
Laravel
A PHP framework for web artisans
-
D3
Bring data to life with SVG, Canvas and HTML. 📊📈🎉
-
Recommend Topics
-
javascript
JavaScript (JS) is a lightweight interpreted programming language with first-class functions.
-
web
Some thing interesting about web. New door for the world.
-
server
A server is a program made to process requests and deliver data to clients.
-
Machine learning
Machine learning is a way of modeling and interpreting data that allows a piece of software to respond intelligently.
-
Visualization
Some thing interesting about visualization, use data art
-
Game
Some thing interesting about game, make everyone happy.
Recommend Org
-
Facebook
We are working to build community through open source technology. NB: members must have two-factor auth.
-
Microsoft
Open source projects and samples from Microsoft.
-
Google
Google ❤️ Open Source for everyone.
-
Alibaba
Alibaba Open Source for everyone
-
D3
Data-Driven Documents codes.
-
Tencent
China tencent open source team.
from headunit.