[pulseaudio-discuss] Bluetooth Headset Problem
Colin Guthrie
gmane at colin.guthr.ie
Sat Sep 3 07:16:24 PDT 2011
Hi,
I don't know off the top of my head, but CC'ing the resident BT experts
for their input!
Col
'Twas brillig, and krisztian.kocsis at optimaster.eu at 01/09/11 17:53 did
gyre and gimble:
> Hello!
>
> I'm trying to get a Samsung WEP150 headset working on an embedded Linux
> board but when I try to play something with bluetooth output then the
> player app hangs.
> Here is what I'm doing:
>
> 1. Start bluez
> /afc/sbin/bluetoothd -d -n
>
> bluetoothd[4776]: Bluetooth daemon 4.96
>
> bluetoothd[4776]: src/main.c:parse_config() parsing main.conf
>
> bluetoothd[4776]: src/main.c:parse_config() discovto=0
>
> bluetoothd[4776]: src/main.c:parse_config() pairto=0
>
> bluetoothd[4776]: src/main.c:parse_config() pageto=8192
>
> bluetoothd[4776]: src/main.c:parse_config() name=%h-%d
>
> bluetoothd[4776]: src/main.c:parse_config() class=0x000100
>
> bluetoothd[4776]: src/main.c:parse_config() discov_interval=30
>
> bluetoothd[4776]: src/main.c:parse_config() Key file does not have key
> 'DeviceID'
>
> bluetoothd[4776]: Starting SDP server
>
> bluetoothd[4776]: src/plugin.c:plugin_init() Loading builtin plugins
>
> bluetoothd[4776]: src/plugin.c:add_plugin() Loading audio plugin
>
> bluetoothd[4776]: src/plugin.c:add_plugin() Loading input plugin
>
> bluetoothd[4776]: src/plugin.c:add_plugin() Loading serial plugin
>
> bluetoothd[4776]: src/plugin.c:add_plugin() Loading network plugin
>
> bluetoothd[4776]: src/plugin.c:add_plugin() Loading service plugin
>
> bluetoothd[4776]: src/plugin.c:add_plugin() Loading hciops plugin
>
> bluetoothd[4776]: src/plugin.c:add_plugin() Loading mgmtops plugin
>
> bluetoothd[4776]: src/plugin.c:add_plugin() Loading formfactor plugin
>
> bluetoothd[4776]: src/plugin.c:add_plugin() Loading storage plugin
>
> bluetoothd[4776]: src/plugin.c:add_plugin() Loading adaptername plugin
>
> bluetoothd[4776]: src/plugin.c:plugin_init() Loading plugins
> /afc/lib/bluetooth/plugins
>
> bluetoothd[4776]: plugins/service.c:register_interface() path
> /org/bluez/4776/any
>
> bluetoothd[4776]: plugins/service.c:register_interface() Registered
> interface org.bluez.Service on path /org/bluez/4776/any
>
> bluetoothd[4776]: network/manager.c:read_config() Config options:
> Security=true
>
> bluetoothd[4776]: Failed to open control socket: Protocol not supported (93)
>
> bluetoothd[4776]: Can't init bnep module
>
> bluetoothd[4776]: Failed to init network plugin
>
> bluetoothd[4776]: Parsing /afc/etc/bluetooth/input.conf failed: No such
> file or directory
>
> bluetoothd[4776]: Parsing /afc/etc/bluetooth/audio.conf failed: No such
> file or directory
>
> bluetoothd[4776]: audio/unix.c:unix_init() Unix socket created: 8
>
> bluetoothd[4776]: plugins/hciops.c:hciops_init()
>
> bluetoothd[4776]: plugins/hciops.c:hciops_setup()
>
> bluetoothd[4776]: Failed to open RFKILL control device
>
> bluetoothd[4776]: src/main.c:main() Entering main loop
>
> bluetoothd[4776]: plugins/hciops.c:init_known_adapters()
>
> bluetoothd[4776]: plugins/hciops.c:init_device() hci0
>
> bluetoothd[4776]: Listening for HCI events on hci0
>
> bluetoothd[4776]: plugins/hciops.c:init_conn_list() hci0
>
> bluetoothd[4776]: HCI dev 0 up
>
> bluetoothd[4776]: plugins/hciops.c:device_devup_setup() hci0
>
> bluetoothd[4776]: plugins/hciops.c:read_local_version_complete() Got
> version for hci0
>
> bluetoothd[4776]: src/adapter.c:btd_adapter_ref() 0x200b3dc0: ref=1
>
> bluetoothd[4776]: plugins/hciops.c:hciops_read_bdaddr() hci0
>
> bluetoothd[4776]: src/sdpd-database.c:sdp_init_services_list()
>
> bluetoothd[4776]: plugins/hciops.c:hciops_add_uuid() hci0
>
> bluetoothd[4776]: plugins/hciops.c:update_service_classes() hci0 value 0
>
> bluetoothd[4776]: plugins/hciops.c:hciops_add_uuid() hci0
>
> bluetoothd[4776]: plugins/hciops.c:update_service_classes() hci0 value 0
>
> bluetoothd[4776]: plugins/service.c:register_interface() path
> /org/bluez/4776/hci0
>
> bluetoothd[4776]: plugins/service.c:register_interface() Registered
> interface org.bluez.Service on path /org/bluez/4776/hci0
>
> bluetoothd[4776]: serial/manager.c:proxy_probe() path /org/bluez/4776/hci0
>
> bluetoothd[4776]: src/adapter.c:btd_adapter_ref() 0x200b3dc0: ref=2
>
> bluetoothd[4776]: serial/proxy.c:proxy_register() Registered interface
> org.bluez.SerialProxyManager on path /org/bluez/4776/hci0
>
> bluetoothd[4776]: Parsing /afc/etc/bluetooth/serial.conf failed: No such
> file or directory
>
> bluetoothd[4776]: src/adapter.c:btd_adapter_ref() 0x200b3dc0: ref=3
>
> bluetoothd[4776]: audio/manager.c:headset_server_probe() path
> /org/bluez/4776/hci0
>
> bluetoothd[4776]: src/adapter.c:btd_adapter_ref() 0x200b3dc0: ref=4
>
> bluetoothd[4776]: audio/manager.c:audio_adapter_ref() 0x200b3f88: ref=1
>
> bluetoothd[4776]: audio/manager.c:state_changed() /org/bluez/4776/hci0
> powered on
>
> bluetoothd[4776]: audio/telephony.c:telephony_init()
>
> bluetoothd[4776]: audio/headset.c:telephony_ready_ind() Telephony plugin
> initialized
>
> bluetoothd[4776]: audio/headset.c:print_ag_features() HFP AG features:
> "Ability to reject a call" "Enhanced call status" "Extended Error Result
> Codes"
>
> bluetoothd[4776]: src/sdpd-service.c:add_record_to_server() Adding
> record with handle 0x10000
>
> bluetoothd[4776]: plugins/hciops..c:hciops_add_uuid() hci0
>
> bluetoothd[4776]: plugins/hciops.c:update_service_classes() hci0 value 0
>
> bluetoothd[4776]: src/sdpd-service.c:add_record_to_server() Record
> pattern UUID 00000003-0000-1000-8000-00805f9
>
> bluetoothd[4776]: src/sdpd-service.c:add_record_to_server() Record
> pattern UUID 00000100-0000-1000-8000-00805f9
>
> bluetoothd[4776]: src/sdpd-service.c:add_record_to_server() Record
> pattern UUID 00001002-0000-1000-8000-00805f9
>
> bluetoothd[4776]: src/sdpd-service.c:add_record_to_server() Record
> pattern UUID 00001108-0000-1000-8000-00805f9
>
> bluetoothd[4776]: src/sdpd-service.c:add_record_to_server() Record
> pattern UUID 00001112-0000-1000-8000-00805f9
>
> bluetoothd[4776]: src/sdpd-service.c:add_record_to_server() Record
> pattern UUID 00001203-0000-1000-8000-00805f9
>
> bluetoothd[4776]: src/sdpd-service.c:add_record_to_server() Adding
> record with handle 0x10001
>
> bluetoothd[4776]: plugins/hciops.c:hciops_add_uuid() hci0
>
> bluetoothd[4776]: plugins/hciops.c:update_service_classes() hci0 value 64
>
> bluetoothd[4776]: src/sdpd-service.c:add_record_to_server() Record
> pattern UUID 00000003-0000-1000-8000-00805f9
>
> bluetoothd[4776]: src/sdpd-service.c:add_record_to_server() Record
> pattern UUID 00000100-0000-1000-8000-00805f9
>
> bluetoothd[4776]: src/sdpd-service.c:add_record_to_server() Record
> pattern UUID 00001002-0000-1000-8000-00805f9
>
> bluetoothd[4776]: src/sdpd-service.c:add_record_to_server() Record
> pattern UUID 0000111e-0000-1000-8000-00805f9
>
> bluetoothd[4776]: src/sdpd-service.c:add_record_to_server() Record
> pattern UUID 0000111f-0000-1000-8000-00805f9
>
> bluetoothd[4776]: src/sdpd-service.c:add_record_to_server() Record
> pattern UUID 00001203-0000-1000-8000-00805f9
>
> bluetoothd[4776]: audio/manager.c:a2dp_server_probe() path
> /org/bluez/4776/hci0
>
> bluetoothd[4776]: audio/manager.c:audio_adapter_ref() 0x200b3f88: ref=2
>
> bluetoothd[4776]: audio/avdtp.c:avdtp_register_sep() SEP 0x200b5120
> registered: type:0 codec:0 seid:1
>
> bluetoothd[4776]: src/sdpd-service.c:add_record_to_server() Adding
> record with handle 0x10002
>
> bluetoothd[4776]: plugins/hciops.c:hciops_add_uuid() hci0
>
> bluetoothd[4776]: plugins/hciops.c:update_service_classes() hci0 value 72
>
> bluetoothd[4776]: src/sdpd-service.c:add_record_to_server() Record
> pattern UUID 00000019-0000-1000-8000-00805f9
>
> bluetoothd[4776]: src/sdpd-service.c:add_record_to_server() Record
> pattern UUID 00000100-0000-1000-8000-00805f9
>
> bluetoothd[4776]: src/sdpd-service.c:add_record_to_server() Record
> pattern UUID 00001002-0000-1000-8000-00805f9
>
> bluetoothd[4776]: src/sdpd-service.c:add_record_to_server() Record
> pattern UUID 0000110a-0000-1000-8000-00805f9
>
> bluetoothd[4776]: src/sdpd-service.c:add_record_to_server() Record
> pattern UUID 0000110d-0000-1000-8000-00805f9
>
> bluetoothd[4776]: audio/manager.c:avrcp_server_probe() path
> /org/bluez/4776/hci0
>
> bluetoothd[4776]: audio/manager.c:audio_adapter_ref() 0x200b3f88: ref=3
>
> bluetoothd[4776]: src/sdpd-service.c:add_record_to_server() Adding
> record with handle 0x10003
>
> bluetoothd[4776]: plugins/hciops.c:hciops_add_uuid() hci0
>
> bluetoothd[4776]: plugins/hciops.c:update_service_classes() hci0 value 72
>
> bluetoothd[4776]: src/sdpd-service.c:add_record_to_server() Record
> pattern UUID 00000017-0000-1000-8000-00805f9
>
> bluetoothd[4776]: src/sdpd-service.c:add_record_to_server() Record
> pattern UUID 00000100-0000-1000-8000-00805f9
>
> bluetoothd[4776]: src/sdpd-service.c:add_record_to_server() Record
> pattern UUID 00001002-0000-1000-8000-00805f9
>
> bluetoothd[4776]: src/sdpd-service.c:add_record_to_server() Record
> pattern UUID 0000110c-0000-1000-8000-00805f9
>
> bluetoothd[4776]: src/sdpd-service.c:add_record_to_server() Record
> pattern UUID 0000110e-0000-1000-8000-00805f9
>
> bluetoothd[4776]: src/sdpd-service.c:add_record_to_server() Adding
> record with handle 0x10004
>
> bluetoothd[4776]: plugins/hciops.c:hciops_add_uuid() hci0
>
> bluetoothd[4776]: plugins/hciops.c:update_service_classes() hci0 value 72
>
> bluetoothd[4776]: src/sdpd-service.c:add_record_to_server() Record
> pattern UUID 00000017-0000-1000-8000-00805f9
>
> bluetoothd[4776]: src/sdpd-service.c:add_record_to_server() Record
> pattern UUID 00000100-0000-1000-8000-00805f9
>
> bluetoothd[4776]: src/sdpd-service.c:add_record_to_server() Record
> pattern UUID 00001002-0000-1000-8000-00805f9
>
> bluetoothd[4776]: src/sdpd-service.c:add_record_to_server() Record
> pattern UUID 0000110e-0000-1000-8000-00805f9
>
> bluetoothd[4776]: plugins/adaptername.c:adaptername_probe() Setting name
> 'ISSCEDRBTA' for device 'hci0'
>
> bluetoothd[4776]: plugins/hciops.c:hciops_set_name() hci0, name ISSCEDRBTA
>
> bluetoothd[4776]: plugins/hciops.c:update_ext_inquiry_response() hci0
>
> bluetoothd[4776]: Could not get the contents of DMI chassis type
>
> bluetoothd[4776]: plugins/hciops.c:hciops_unblock_device() hci0 dba
> 00:00:00:00:00:00
>
> bluetoothd[4776]: Clearing blocked list failed: Invalid argument (22)
>
> bluetoothd[4776]: src/device.c:device_create() Creating device
> /org/bluez/4776/hci0/dev_00_07_A4_EE_8F_03
>
> bluetoothd[4776]: src/device.c:device_set_bonded() bonded 1
>
> bluetoothd[4776]: src/device.c:btd_device_ref() 0x200b6308: ref=1
>
> bluetoothd[4776]: src/device.c:device_set_temporary() temporary 0
>
> bluetoothd[4776]: src/device.c:device_probe_drivers() Probing drivers
> for 00:07:A4:EE:8F:03
>
> bluetoothd[4776]: serial/manager.c:serial_probe() path
> /org/bluez/4776/hci0/dev_00_07_A4_EE_8F_03:
> 00001101-0000-1000-8000-00805f9b34fb
>
> bluetoothd[4776]: serial/port.c:create_serial_device() Registered
> interface org.bluez.Serial on path
> /org/bluez/4776/hci0/dev_00_07_A4_EE_8F_03
>
> bluetoothd[4776]: serial/manager.c:serial_probe() path
> /org/bluez/4776/hci0/dev_00_07_A4_EE_8F_03:
> 00001108-0000-1000-8000-00805f9b34fb
>
> bluetoothd[4776]: serial/manager.c:serial_probe() path
> /org/bluez/4776/hci0/dev_00_07_A4_EE_8F_03:
> 0000111e-0000-1000-8000-00805f9b34fb
>
> bluetoothd[4776]: input/manager.c:headset_probe() path
> /org/bluez/4776/hci0/dev_00_07_A4_EE_8F_03
>
> bluetoothd[4776]: src/device.c:btd_device_ref() 0x200b6308: ref=2
>
> bluetoothd[4776]: input/device.c:input_device_new() Registered interface
> org.bluez.Input on path /org/bluez/4776/hci0/dev_00_07_A4_EE_8F_03
>
> bluetoothd[4776]: src/adapter.c:adapter_get_device() 00:07:A4:EE:8F:03
>
> bluetoothd[4776]: src/device.c:btd_device_ref() 0x200b6308: ref=3
>
> bluetoothd[4776]: audio/device.c:audio_device_register() Registered
> interface org.bluez.Audio on path /org/bluez/4776/hci0/dev_00_07_A4_EE_8F_03
>
> bluetoothd[4776]: audio/manager.c:handle_uuid() Found Headset record
>
> bluetoothd[4776]: audio/headset.c:headset_init() Registered interface
> org.bluez.Headset on path /org/bluez/4776/hci0/dev_00_07_A4_EE_8F_03
>
> bluetoothd[4776]: audio/manager.c:handle_uuid() Found Handsfree record
>
> bluetoothd[4776]: plugins/hciops.c:hciops_load_keys() hci0 keys 1
> debug_keys 0
>
> bluetoothd[4776]: plugins/hciops.c:hciops_get_conn_list() hci0
>
> bluetoothd[4776]: src/manager.c:btd_manager_register_adapter() Adapter
> /org/bluez/4776/hci0 registered
>
> bluetoothd[4776]: src/adapter.c:btd_adapter_ref() 0x200b3dc0: ref=5
>
> bluetoothd[4776]: plugins/hciops.c:hciops_set_name() hci0, name ISSCEDRBTA
>
> bluetoothd[4776]: plugins/hciops.c:update_ext_inquiry_response() hci0
>
> bluetoothd[4776]: plugins/hciops.c:hciops_set_dev_class() hci0 major 1
> minor 0
>
> bluetoothd[4776]: audio/manager.c:state_changed() /org/bluez/4776/hci0
> powered on
>
> bluetoothd[4776]: plugins/hciops.c:hciops_disable_cod_cache() hci0
> cache_enable 1
>
> bluetoothd[4776]: plugins/hciops.c:hciops_disable_cod_cache() hci0
> current_cod 0x000000 wanted_cod 0x480100
>
> bluetoothd[4776]: plugins/hciops.c:write_class() hci0 class 0x480100
>
> bluetoothd[4776]: Adapter /org/bluez/4776/hci0 has been enabled
>
> bluetoothd[4776]: plugins/hciops.c:hciops_set_discoverable() hci0
> discoverable 0
>
> bluetoothd[4776]: plugins/hciops.c:hciops_set_pairable() hci0 pairable 1
>
> bluetoothd[4776]: plugins/hciops.c:hciops_stop_inquiry() hci0
>
> bluetoothd[4776]: src/adapter.c:btd_adapter_unref() 0x200b3dc0: ref=4
>
> bluetoothd[4776]: plugins/hciops.c:update_ext_inquiry_response() hci0
>
> bluetoothd[4776]: plugins/hciops.c:read_local_name_complete() hci0 status 0
>
> bluetoothd[4776]: plugins/hciops.c:update_ext_inquiry_response() hci0
>
> bluetoothd[4776]: plugins/hciops.c:read_local_name_complete() hci0 status 0
>
> bluetoothd[4776]: plugins/hciops.c:update_ext_inquiry_response() hci0
>
> bluetoothd[4776]: plugins/hciops..c:read_scan_complete() hci0 status 0
>
> bluetoothd[4776]: src/adapter.c:adapter_mode_changed() old 0x00 new 0x02
>
> bluetoothd[4776]: src/adapter.c:adapter_set_limited_discoverable() FALSE
>
> bluetoothd[4776]: plugins/hciops.c:hciops_set_limited_discoverable()
> hci0 limited 0
>
> bluetoothd[4776]: src/adapter.c:set_mode_complete()
>
>
>
> 2. Connect to headset:
> dbus-send --system --print-reply --dest=org.bluez
> /org/bluez/4776/hci0/dev_00_07_A4_EE_8F_03 org.bluez.Headset.Connect
> method return sender=:1.45 -> dest=:1.46 reply_serial=2
>
> Debug from bluez:
>
> bluetoothd[4776]: audio/headset.c:headset_set_state() State changed
> /org/bluez/4776/hci0/dev_00_07_A4_EE_8F_03: HEADSET_STATE_DISCONNECTED
> -> HEADSET_STATE_CONNECTING
>
> bluetoothd[4776]: plugins/hciops.c:link_key_request() hci0 dba
> 00:07:A4:EE:8F:03
>
> bluetoothd[4776]: plugins/hciops.c:get_auth_info() hci0 dba
> 00:07:A4:EE:8F:03
>
> bluetoothd[4776]: plugins/hciops.c:link_key_request() kernel auth
> requirements = 0xff
>
> bluetoothd[4776]: plugins/hciops.c:link_key_request() Matching key found
>
> bluetoothd[4776]: plugins/hciops.c:link_key_request() link key type 0x00
>
> bluetoothd[4776]: plugins/hciops.c:conn_complete() status 0x00
>
> bluetoothd[4776]: src/adapter.c:adapter_get_device() 00:07:A4:EE:8F:03
>
> bluetoothd[4776]: plugins/hciops.c:bonding_complete() status 0x00
>
> bluetoothd[4776]: src/event.c:btd_event_bonding_complete() status 0x00
>
> bluetoothd[4776]: src/adapter.c:adapter_get_device() 00:07:A4:EE:8F:03
>
> bluetoothd[4776]: src/device.c:device_bonding_complete() bonding (nil)
> status 0x00
>
> bluetoothd[4776]: plugins/hciops.c:remote_features_information() hci0
> status 0
>
> bluetoothd[4776]: audio/headset.c:headset_set_channel() Discovered
> Handsfree service on channel 2
>
> bluetoothd[4776]: audio/headset.c:rfcomm_connect()
> /org/bluez/4776/hci0/dev_00_07_A4_EE_8F_03: Connecting to
> 00:07:A4:EE:8F:03 channel 2
>
> bluetoothd[4776]: audio/headset.c:headset_connect_cb()
> /org/bluez/4776/hci0/dev_00_07_A4_EE_8F_03: Connected to 00:07:A4:EE:8F:03
>
> bluetoothd[4776]: audio/headset.c:handle_event() Received AT+BRSF=26
>
> bluetoothd[4776]: audio/headset.c:print_hf_features() HFP HF features:
> "Call waiting and 3-way calling" "Voice recognition activation" "Remote
> volume control"
>
> bluetoothd[4776]: audio/headset.c:handle_event() Received AT+CIND=?
>
> bluetoothd[4776]: audio/headset.c:handle_event() Received AT+CIND?
>
> bluetoothd[4776]: audio/headset.c:handle_event() Received AT+CMER=3,0,0,1
>
> bluetoothd[4776]: audio/headset.c:event_reporting() Event reporting
> (CMER): mode=3, ind=1
>
> bluetoothd[4776]: audio/headset.c:hfp_slc_complete() HFP Service Level
> Connection established
>
> bluetoothd[4776]: audio/telephony.c:telephony_device_connected()
> telephony-dummy: device 0x200b7738 connected
>
> bluetoothd[4776]: audio/headset.c:headset_set_state() State changed
> /org/bluez/4776/hci0/dev_00_07_A4_EE_8F_03: HEADSET_STATE_CONNECTING ->
> HEADSET_STATE_CONNECTED
>
> bluetoothd[4776]: audio/headset.c:handle_event() Received AT+VGS=15
>
> bluetoothd[4776]: audio/headset.c:headset_set_gain() Ignoring no-change
> in speaker gain
>
>
>
> 3. Start pulseaudio:
> LD_LIBRARY_PATH=/afc/lib/pulse-0.9.23/modules /afc/bin/pulseaudio
> --system --high-priority --disallow-exit --log-target=stderr
> --use-pid-file --disable-shm -vvvvvvv
>
> W: main.c: Running in system mode, but --disallow-module-loading not set!
>
> N: main.c: Running in system mode, forcibly disabling exit idle time!
>
> I: main.c: setrlimit(RLIMIT_RTTIME, (1000000, 1000000)) failed: Invalid
> argument
>
> D: core-util.c: setpriority() worked.
>
> I: core-util.c: Successfully gained nice level -11.
>
> I: main.c: Found user 'pulse' (UID 110) and group 'pulse' (GID 115).
>
> I: main.c: Successfully dropped root privileges.
>
> I: main.c: This is PulseAudio 0.9.23
>
> D: main.c: Compilation host: powerpc-603e-linux-gnu
>
> D: main.c: Compilation CFLAGS: -pipe -g -O2 -mcpu=603e -Wall -W -Wextra
> -pipe -Wno-long-long -Winline -Wunsafe-loop-optimizations -Wundef
> -Wformat=2 -Wsign-compare -Wformat-security -Wmissing-include-dirs
> -Wformat-nonliteral -Wold-style-definition -Wpointer-arith -Winit-self
> -Wdeclaration-after-statement -Wfloat-equal -Wmissing-prototypes
> -Wstrict-prototypes -Wredundant-decls -Wmissing-declarations
> -Wmissing-noreturn -Wshadow -Wendif-labels -Wcast-align
> -Wstrict-aliasing=2 -Wwrite-strings -Wno-unused-parameter -ffast-math
> -Wp,-D_FORTIFY_SOURCE=2 -fno-common -fdiagnostics-show-option
>
> D: main.c: Running on host: Linux ppc 2.6.24.6.0.54000 #1 PREEMPT Wed
> Dec 1 12:42:48 WST 2010
>
> D: main.c: Found 1 CPUs.
>
> I: main.c: Page size is 4096 bytes
>
> D: main.c: Compiled with Valgrind support: no
>
> D: main.c: Running in valgrind mode: no
>
> D: main.c: Running in VM: no
>
> D: main.c: Optimized build: yes
>
> D: main.c: All asserts enabled.
>
> I: main.c: Machine ID is d63a8b34983dc07124730b71000003f9.
>
> I: main.c: Using runtime directory /afc/var/run/pulse.
>
> I: main.c: Using state directory /afc/var/lib/pulse.
>
> I: main.c: Using modules directory /afc/lib/pulse-0..9.23/modules.
>
> I: main.c: Running in system mode: yes
>
> W: main.c: OK, so you are running PA in system mode. Please note that
> you most likely shouldn't be doing that.
>
> W: main.c: If you do it nonetheless then it's your own fault if things
> don't work as expected.
>
> W: main.c: Please read
> http://pulseaudio.org/wiki/WhatIsWrongWithSystemMode for an explanation
> why system mode is usually a bad idea.
>
> I: main.c: Fresh high-resolution timers available! Bon appetit!
>
> W: shm.c: Failed to read /dev/shm/: No such file or directory
>
> D: memblock.c: Using private memory pool with 1024 slots of size 64.0
> KiB each, total size is 64.0 MiB, maximum usable slot size is 65496
>
> I: sink.c: Created sink 0 "null" with sample spec s16be 2ch 44100Hz and
> channel map front-left,front-right
>
> I: sink.c: device.description = "Null Output"
>
> I: sink.c: device.class = "abstract"
>
> I: sink.c: device.icon_name = "audio-card"
>
> I: source.c: Created source 0 "null.monitor" with sample spec s16be 2ch
> 44100Hz and channel map front-left,front-right
>
> I: source.c: device.description = "Monitor of Null Output"
>
> I: source.c: device.class = "monitor"
>
> I: source..c: device.icon_name = "audio-input-microphone"
>
> D: module-null-sink.c: Thread starting up
>
> I: module.c: Loaded "module-null-sink" (index: #0; argument: "").
>
> W: module.c: module-oss is deprecated: Please use module-alsa-card
> instead of module-oss!
>
> D: oss-util.c: capabilities: DUPLEX MMAP REALTIME TRIGGER
>
> I: module-oss.c: Hardware name is '(DUPLEX)'.
>
> I: module-oss.c: Device opened in O_RDWR mode.
>
> D: oss-util.c: Asking for 4 fragments of size 4096 (requested 4408)
>
> I: module-oss.c: Input -- 4 fragments of size 8192.
>
> I: module-oss.c: Output -- 4 fragments of size 8192.
>
> I: source.c: Created source 1 "input" with sample spec s16be 2ch 44100Hz
> and channel map front-left,front-right
>
> I: source.c: device.string = "/dev/dsp"
>
> I: source.c: device.api = "oss"
>
> I: source.c: device.description = "(DUPLEX)"
>
> I: source.c: device..access_mode = "serial"
>
> I: source.c: device..buffering.buffer_size = "32768"
>
> I: source.c: device.buffering.fragment_size = "8192"
>
> I: source.c: device.icon_name = "audio-input-microphone"
>
> I: sink.c: Created sink 1 "output" with sample spec s16be 2ch 44100Hz
> and channel map front-left,front-right
>
> I: sink.c: device.string = "/dev/dsp"
>
> I: sink.c: device.api = "oss"
>
> I: sink.c: device.description = "(DUPLEX)"
>
> I: sink.c: device.access_mode = "serial"
>
> I: sink.c: device.buffering.buffer_size = "32768"
>
> I: sink.c: device.buffering.fragment_size = "8192"
>
> I: sink.c: device.icon_name = "audio-card"
>
> I: source.c: Created source 2 "output.monitor" with sample spec s16be
> 2ch 44100Hz and channel map front-left,front-right
>
> I: source.c: device.description = "Monitor of (DUPLEX)"
>
> I: source.c: device.class = "monitor"
>
> I: source.c: device.icon_name = "audio-input-microphone"
>
> D: module-oss.c: Found hardware mixer track for playback.
>
> D: module-oss.c: Found hardware mixer track for recording.
>
> D: module-oss.c: Thread starting up
>
> D: core-util.c: SCHED_RR worked.
>
> I: core-util.c: Successfully enabled SCHED_RR scheduling for thread,
> with priority 5.
>
> D: oss-util.c: Read mixer settings: 0: 100% 1: 0%
>
> D: oss-util.c: Read mixer settings: 0: 0% 1: 0%
>
> D: module-oss.c: trigger
>
> D: module-oss.c: trigger: 2
>
> D: module-oss.c: trigger
>
> D: module-oss.c: trigger: 3
>
> I: module.c: Loaded "module-oss" (index: #1; argument: "sink_name=output
> source_name=input mmap=0").
>
> I: module.c: Loaded "module-native-protocol-unix" (index: #2; argument: "").
>
> I: module.c: Loaded "module-native-protocol-tcp" (index: #3; argument: "").
>
> D: dbus-util.c: Successfully connected to D-Bus system bus
> 61aa7b55130f0b3caf01712d00005a07 as :1.47
>
> D: bluetooth-util.c: dbus: interface=org.freedesktop.DBus,
> path=/org/freedesktop/DBus, member=NameAcquired
>
> D: bluetooth-util.c: Unknown Bluetooth minor device class 3
>
> I: card.c: Created 0 "bluez_card.00_07_A4_EE_8F_03"
>
> D: module-bluetooth-device.c: Connected to the bluetooth audio service
>
> D: module-bluetooth-device.c: Sending BT_REQUEST -> BT_GET_CAPABILITIES
>
> D: module-bluetooth-device.c: Trying to receive message from audio
> service...
>
> D: module-bluetooth-device.c: Received BT_RESPONSE <- BT_GET_CAPABILITIES
>
> D: module-bluetooth-device.c: Payload size is 9 6
>
> D: module-bluetooth-device.c: Sending BT_REQUEST -> BT_GET_CAPABILITIES
>
> D: module-bluetooth-device.c: Trying to receive message from audio
> service...
>
> D: module-bluetooth-device.c: Received BT_RESPONSE <- BT_GET_CAPABILITIES
>
> D: module-bluetooth-device.c: Payload size is 9 6
>
> D: module-bluetooth-device.c: Got device capabilities
>
> D: module-bluetooth-device.c: Sending BT_REQUEST -> BT_OPEN
>
> D: module-bluetooth-device.c: Trying to receive message from audio
> service...
>
> D: module-bluetooth-device.c: Received BT_RESPONSE <- BT_OPEN
>
> D: module-bluetooth-device.c: Sending BT_REQUEST -> BT_SET_CONFIGURATION
>
> D: module-bluetooth-device.c: Trying to receive message from audio
> service...
>
> D: module-bluetooth-device.c: Received BT_RESPONSE <- BT_SET_CONFIGURATION
>
> D: module-bluetooth-device.c: Connection to the device configured
>
> D: module-bluetooth-device.c: Got the stream socket
>
> I: sink.c: Created sink 2 "bto" with sample spec s16le 1ch 8000Hz and
> channel map mono
>
> I: sink.c: bluetooth.protocol = "sco"
>
> I: sink.c: device.intended_roles = "phone"
>
> I: sink.c: device.description = "Samsung WEP150"
>
> I: sink..c: device.string = "00:07:A4:EE:8F:03"
>
> I: sink.c: device.api = "bluez"
>
> I: sink.c: device.class = "sound"
>
> I: sink.c: device.bus = "bluetooth"
>
> I: sink.c: bluez..path = "/org/bluez/4776/hci0/dev_00_07_A4_EE_8F_03"
>
> I: sink.c: bluez.class = "0x20040c"
>
> I: sink.c: bluez.name = "Samsung WEP150"
>
> I: sink.c: device.icon_name = "audio-card-bluetooth"
>
> I: source.c: Created source 3 "bto.monitor" with sample spec s16le 1ch
> 8000Hz and channel map mono
>
> I: source.c: device.description = "Monitor of Samsung WEP150"
>
> I: source.c: device.class = "monitor"
>
> I: source.c: device.string = "00:07:A4:EE:8F:03"
>
> I: source.c: device.api = "bluez"
>
> I: source.c: device.bus = "bluetooth"
>
> I: source.c: bluez..path = "/org/bluez/4776/hci0/dev_00_07_A4_EE_8F_03"
>
> I: source.c: bluez.class = "0x20040c"
>
> I: source..c: bluez.name = "Samsung WEP150"
>
> I: source..c: device.icon_name = "audio-card-bluetooth"
>
> I: source.c: Created source 4 "bti" with sample spec s16le 1ch 8000Hz
> and channel map mono
>
> I: source.c: bluetooth.protocol = "hsp"
>
> I: source.c: device.intended_roles = "phone"
>
> I: source.c: device.description = "Samsung WEP150"
>
> I: source.c: device..string = "00:07:A4:EE:8F:03"
>
> I: source.c: device.api = "bluez"
>
> I: source.c: device.class = "sound"
>
> I: source.c: device.bus = "bluetooth"
>
> I: source.c: bluez.path = "/org/bluez/4776/hci0/dev_00_07_A4_EE_8F_03"
>
> I: source.c: bluez.class = "0x20040c"
>
> I: source.c: bluez.name = "Samsung WEP150"
>
> I: source.c: device.icon_name = "audio-card-bluetooth"
>
> D: module-bluetooth-device.c: IO Thread starting up
>
> D: core-util.c: SCHED_RR worked.
>
> I: core-util.c: Successfully enabled SCHED_RR scheduling for thread,
> with priority 5.
>
> D: module-bluetooth-device.c: Sending BT_REQUEST -> BT_START_STREAM
>
> D: module-bluetooth-device.c: Trying to receive message from audio
> service...
>
> D: module-bluetooth-device.c: Received BT_RESPONSE <- BT_START_STREAM
>
> D: module-bluetooth-device.c: Trying to receive message from audio
> service...
>
> D: module-bluetooth-device.c: Received BT_INDICATION <- BT_NEW_STREAM
>
> D: module-bluetooth-device.c: Stream properly set up, we're ready to roll!
>
> I: module.c: Loaded "module-bluetooth-device" (index: #4; argument:
> "profile=hsp address=00:07:A4:EE:8F:03 auto_connect=1 sink_name=bto
> source_name=bti").
>
> D: main.c: Got org.pulseaudio.Server!
>
> I: main.c: Daemon startup complete.
>
> D: bluetooth-util.c: dbus: interface=org.bluez.Headset,
> path=/org/bluez/4776/hci0/dev_00_07_A4_EE_8F_03, member=PropertyChanged
>
> D: module-bluetooth-device.c: dbus: interface=org.bluez.Headset,
> path=/org/bluez/4776/hci0/dev_00_07_A4_EE_8F_03, member=PropertyChanged
>
> D: bluetooth-util.c: dbus: interface=org.bluez.Headset,
> path=/org/bluez/4776/hci0/dev_00_07_A4_EE_8F_03, member=PropertyChanged
>
> D: module-bluetooth-device.c: dbus: interface=org.bluez.Headset,
> path=/org/bluez/4776/hci0/dev_00_07_A4_EE_8F_03, member=PropertyChanged
>
> D: bluetooth-util.c: dbus: interface=(null), path=(null), member=(null)
>
> D: module-bluetooth-device.c: dbus: interface=(null), path=(null),
> member=(null)
>
> D: bluetooth-util.c: dbus: interface=org.freedesktop.DBus,
> path=/org/freedesktop/DBus, member=NameAcquired
>
> D: module-bluetooth-device.c: dbus: interface=org.freedesktop.DBus,
> path=/org/freedesktop/DBus, member=NameAcquired
>
> D: bluetooth-util.c: dbus: interface=(null), path=(null), member=(null)
>
> D: module-bluetooth-device.c: dbus: interface=(null), path=(null),
> member=(null)
>
>
>
> 4. Play a WAV with paplay:
> paplay -p -v /afc/Noise.wav
>
> Opening a playback stream with sample specification 's16be 1ch 48000Hz'
> and channel map 'mono'.
>
> Connection established..
>
> Stream successfully created.
>
> Buffer metrics: maxlength=4194304, tlength=192000, prebuf=190082,
> minreq=1920
>
> Using sample spec 's16be 1ch 48000Hz', channel map 'mono'.
>
> Connected to device bto (2, not suspended).
>
> Time: 0.000 sec; Latency: 1407895 usec.
>
> Time: 0.000 sec; Latency: 1407895 usec.
>
> Time: 0.000 sec; Latency: 1407895 usec.
>
> Got signal, exiting.ency: 1407895 usec.
>
>
>
> Debug from Pulseaudio:
>
> I: client.c: Created 3 "Native client (UNIX socket client)"
>
> D: protocol-native.c: Protocol version: remote 16, local 16
>
> I: protocol-native.c: Got credentials: uid=0 gid=0 success=1
>
> D: protocol-native.c: SHM possible: no
>
> D: protocol-native.c: Negotiated SHM: no
>
> I: resampler.c: Using resampler 'speex-float-3'
>
> I: resampler.c: Using float32be as working format.
>
> I: resampler.c: Choosing speex quality setting 3.
>
> D: memblockq.c: memblockq requested: maxlength=33554432, tlength=0,
> base=2, prebuf=0, minreq=1 maxrewind=0
>
> D: memblockq.c: memblockq sanitized: maxlength=33554432,
> tlength=33554432, base=2, prebuf=0, minreq=2 maxrewind=0
>
> I: sink-input.c: Created input 3 "/afc/Noise.wav" on bto with sample
> spec s16be 1ch 48000Hz and channel map mono
>
> I: sink-input.c: media.format = "WAV (Microsoft)"
>
> I: sink-input.c: application.name = "paplay"
>
> I: sink-input.c: media.name = "/afc/Noise.wav"
>
> I: sink-input.c: native-protocol.peer = "UNIX socket client"
>
> I: sink-input.c: native-protocol..version = "16"
>
> I: sink-input.c: application.process.id = "4796"
>
> I: sink-input.c: application.process.user = "root"
>
> I: sink-input.c: application.process.host = "Viper"
>
> I: sink-input.c: application.process.binary = "pacat"
>
> I: sink-input.c: application.language = "C"
>
> I: sink-input.c: application.process.machine_id =
> "d63a8b34983dc07124730b71000003f9"
>
> I: protocol-native.c: Requested tlength=2000.00 ms, minreq=20.00 ms
>
> D: protocol-native.c: Traditional mode enabled, modifying sink usec only
> for compat with minreq.
>
> D: memblockq.c: memblockq requested: maxlength=4194304, tlength=192000,
> base=2, prebuf=190082, minreq=1920 maxrewind=0
>
> D: memblockq.c: memblockq sanitized: maxlength=4194304, tlength=192000,
> base=2, prebuf=190082, minreq=1920 maxrewind=0
>
> I: protocol-native.c: Final latency 2128.00 ms = 1960.00 ms + 2*20.00 ms
> + 128.00 ms
>
> D: protocol-native.c: Requesting rewind due to end of underrun.
>
> D: core.c: Hmm, no streams around, trying to vacuum.
>
> I: sink-input.c: Freeing input 3 "/afc/Noise.wav"
>
> I: client.c: Freed 3 "paplay"
>
> I: protocol-native.c: Connection died.
>
>
>
> Debug from bluez:
>
> bluetoothd[4776]: audio/headset.c:headset_set_state() State changed
> /org/bluez/4776/hci0/dev_00_07_A4_EE_8F_03: HEADSET_STATE_DISCONNECTED
> -> HEADSET_STATE_CONNECTING
>
> bluetoothd[4776]: plugins/hciops.c:link_key_request() hci0 dba
> 00:07:A4:EE:8F:03
>
> bluetoothd[4776]: plugins/hciops.c:get_auth_info() hci0 dba
> 00:07:A4:EE:8F:03
>
> bluetoothd[4776]: plugins/hciops.c:link_key_request() kernel auth
> requirements = 0xff
>
> bluetoothd[4776]: plugins/hciops.c:link_key_request() Matching key found
>
> bluetoothd[4776]: plugins/hciops.c:link_key_request() link key type 0x00
>
> bluetoothd[4776]: plugins/hciops.c:conn_complete() status 0x00
>
> bluetoothd[4776]: src/adapter.c:adapter_get_device() 00:07:A4:EE:8F:03
>
> bluetoothd[4776]: plugins/hciops.c:bonding_complete() status 0x00
>
> bluetoothd[4776]: src/event.c:btd_event_bonding_complete() status 0x00
>
> bluetoothd[4776]: src/adapter.c:adapter_get_device() 00:07:A4:EE:8F:03
>
> bluetoothd[4776]: src/device.c:device_bonding_complete() bonding (nil)
> status 0x00
>
> bluetoothd[4776]: plugins/hciops.c:remote_features_information() hci0
> status 0
>
> bluetoothd[4776]: audio/headset.c:headset_set_channel() Discovered
> Handsfree service on channel 2
>
> bluetoothd[4776]: audio/headset.c:rfcomm_connect()
> /org/bluez/4776/hci0/dev_00_07_A4_EE_8F_03: Connecting to
> 00:07:A4:EE:8F:03 channel 2
>
> bluetoothd[4776]: audio/headset.c:headset_connect_cb()
> /org/bluez/4776/hci0/dev_00_07_A4_EE_8F_03: Connected to 00:07:A4:EE:8F:03
>
> bluetoothd[4776]: audio/headset.c:handle_event() Received AT+BRSF=26
>
> bluetoothd[4776]: audio/headset.c:print_hf_features() HFP HF features:
> "Call waiting and 3-way calling" "Voice recognition activation" "Remote
> volume control"
>
> bluetoothd[4776]: audio/headset.c:handle_event() Received AT+CIND=?
>
> bluetoothd[4776]: audio/headset.c:handle_event() Received AT+CIND?
>
> bluetoothd[4776]: audio/headset.c:handle_event() Received AT+CMER=3,0,0,1
>
> bluetoothd[4776]: audio/headset.c:event_reporting() Event reporting
> (CMER): mode=3, ind=1
>
> bluetoothd[4776]: audio/headset.c:hfp_slc_complete() HFP Service Level
> Connection established
>
> bluetoothd[4776]: audio/telephony.c:telephony_device_connected()
> telephony-dummy: device 0x200b7738 connected
>
> bluetoothd[4776]: audio/headset.c:headset_set_state() State changed
> /org/bluez/4776/hci0/dev_00_07_A4_EE_8F_03: HEADSET_STATE_CONNECTING ->
> HEADSET_STATE_CONNECTED
>
> bluetoothd[4776]: audio/headset.c:handle_event() Received AT+VGS=15
>
> bluetoothd[4776]: audio/headset.c:headset_set_gain() Ignoring no-change
> in speaker gain
>
> bluetoothd[4776]: audio/unix.c:server_cb() Accepted new client
> connection on unix socket (fd=21)
>
> bluetoothd[4776]: audio/unix.c:client_cb() Audio API: BT_REQUEST <-
> BT_GET_CAPABILITIES
>
> bluetoothd[4776]: audio/unix.c:unix_ipc_sendmsg() Audio API: BT_RESPONSE
> -> BT_GET_CAPABILITIES
>
> bluetoothd[4776]: audio/unix.c:client_cb() Audio API: BT_REQUEST <-
> BT_GET_CAPABILITIES
>
> bluetoothd[4776]: audio/unix.c:unix_ipc_sendmsg() Audio API: BT_RESPONSE
> -> BT_GET_CAPABILITIES
>
> bluetoothd[4776]: audio/unix.c:client_cb() Audio API: BT_REQUEST <- BT_OPEN
>
> bluetoothd[4776]: audio/unix.c:handle_sco_open() open sco -
> object=/org/bluez/4776/hci0/dev_00_07_A4_EE_8F_03 source=ANY
> destination=ANY lock=readwrite
>
> bluetoothd[4776]: audio/unix.c:unix_ipc_sendmsg() Audio API: BT_RESPONSE
> -> BT_OPEN
>
> bluetoothd[4776]: audio/unix.c:client_cb() Audio API: BT_REQUEST <-
> BT_SET_CONFIGURATION
>
> bluetoothd[4776]: audio/unix.c:unix_ipc_sendmsg() Audio API: BT_RESPONSE
> -> BT_SET_CONFIGURATION
>
> bluetoothd[4776]: audio/unix.c:client_cb() Audio API: BT_REQUEST <-
> BT_START_STREAM
>
> bluetoothd[4776]: audio/headset.c:headset_set_state() State changed
> /org/bluez/4776/hci0/dev_00_07_A4_EE_8F_03: HEADSET_STATE_CONNECTED ->
> HEADSET_STATE_PLAY_IN_PROGRESS
>
> bluetoothd[4776]: audio/headset.c:sco_connect_cb() SCO socket opened for
> headset /org/bluez/4776/hci0/dev_00_07_A4_EE_8F_03
>
> bluetoothd[4776]: audio/headset.c:sco_connect_cb() SCO fd=23
>
> bluetoothd[4776]: audio/unix.c:unix_ipc_sendmsg() Audio API: BT_RESPONSE
> -> BT_START_STREAM
>
> bluetoothd[4776]: audio/unix.c:unix_ipc_sendmsg() Audio API:
> BT_INDICATION -> BT_NEW_STREAM
>
> bluetoothd[4776]: audio/headset.c:headset_set_state() State changed
> /org/bluez/4776/hci0/dev_00_07_A4_EE_8F_03:
> HEADSET_STATE_PLAY_IN_PROGRESS -> HEADSET_STATE_PLAYING
>
> bluetoothd[4776]: audio/headset.c:headset_set_gain() Ignoring no-change
> in speaker gain
>
> bluetoothd[4776]: audio/headset.c:headset_set_gain() Ignoring no-change
> in microphone gain
>
>
>
> After that I'v changed the resampler method to trivial. Now paplays
> returns with this:
>
> Opening a playback stream with sample specification 's16be 1ch 48000Hz'
> and channel map 'mono'.
>
> Connection established.
>
> Stream successfully created.
>
> Buffer metrics: maxlength=4194304, tlength=192000, prebuf=190082,
> minreq=1920
>
> Using sample spec 's16be 1ch 48000Hz', channel map 'mono'.
>
> Connected to device bto (2, not suspended).
>
> Failed to drain stream: Timeout95 usec.
>
> Playback stream drained.
>
> Draining connection to server.
>
>
>
> As you see paplay is unable to output audio data but I didn't see why?
> Do somebody know what is the problem?
>
> CPU: PowerPC 603e (No FPU)
> Linux: 2.6.24.6
> Glibc: 2.5
>
> Pulseaudio system.pa (no other config files):
>
> load-module module-null-sink
>
> load-module module-oss sink_name=output source_name=input mmap=0
>
> load-module module-native-protocol-unix
>
> load-module module-native-protocol-tcp
>
> # load-module module-stream-restore
>
> # load-module module-rescue-streams
>
> # load-module module-always-sink
>
> # load-module module-suspend-on-idle
>
> load-module module-bluetooth-device profile=hsp
> address=00:07:A4:EE:8F:03 auto_connect=1 sink_name=bto source_name=bti
>
> set-default-sink bto
>
> set-default-source input
>
>
>
> Thanks in advance!
>
> BR,
> Krisztian Kocsis
>
>
>
>
> ------------------------------------------------------------------------
> Message sent via Atmail Open - http://atmail.org/
>
>
> _______________________________________________
> pulseaudio-discuss mailing list
> pulseaudio-discuss at lists.freedesktop.org
> http://lists.freedesktop.org/mailman/listinfo/pulseaudio-discuss
--
Colin Guthrie
gmane(at)colin.guthr.ie
http://colin.guthr.ie/
Day Job:
Tribalogic Limited [http://www.tribalogic.net/]
Open Source:
Mageia Contributor [http://www.mageia.org/]
PulseAudio Hacker [http://www.pulseaudio.org/]
Trac Hacker [http://trac.edgewall.org/]
More information about the pulseaudio-discuss
mailing list