Attachment 92308 Details for Bug 73752 – bluetoothd debug output

bluetoothd debug output

file_73752.txt (text/plain), 11.20 KB, created by Sebastian Thaler on 2014-01-17 21:38:18 UTC

(hide)

Description:

Filename:

MIME Type:

Creator: Sebastian Thaler

Created: 2014-01-17 21:38:18 UTC

Size: 11.20 KB

patch

obsolete

>Jan 17 21:37:31 phantom bluetoothd[1190]: profiles/audio/transport.c:transport_set_state() State changed /org/bluez/hci0/dev_00_1B_66_02_37_72/fd3: TRANSPORT_STATE_ACTIVE -> TRANSPORT_STATE_SUSPENDING
>Jan 17 21:37:31 phantom bluetoothd[1190]: profiles/audio/avdtp.c:avdtp_ref() 0x2140530: ref=3
>Jan 17 21:37:31 phantom bluetoothd[1190]: profiles/audio/a2dp.c:setup_ref() 0x2104870: ref=1
>Jan 17 21:37:31 phantom bluetoothd[1190]: profiles/audio/transport.c:media_request_create() Request created: method=Release id=20
>Jan 17 21:37:31 phantom bluetoothd[1190]: profiles/audio/transport.c:media_owner_add() Owner :1.56 Request Release
>Jan 17 21:37:31 phantom bluetoothd[1190]: profiles/audio/avdtp.c:session_cb()
>Jan 17 21:37:31 phantom bluetoothd[1190]: profiles/audio/avdtp.c:avdtp_parse_resp() SUSPEND request succeeded
>Jan 17 21:37:31 phantom bluetoothd[1190]: profiles/audio/avdtp.c:avdtp_sep_set_state() stream state changed: STREAMING -> OPEN
>Jan 17 21:37:31 phantom bluetoothd[1190]: profiles/audio/sink.c:sink_set_state() State changed /org/bluez/hci0/dev_00_1B_66_02_37_72: SINK_STATE_PLAYING -> SINK_STATE_CONNECTED
>Jan 17 21:37:31 phantom bluetoothd[1190]: profiles/audio/transport.c:transport_update_playing() /org/bluez/hci0/dev_00_1B_66_02_37_72/fd3 State=TRANSPORT_STATE_SUSPENDING Playing=0
>Jan 17 21:37:31 phantom bluetoothd[1190]: profiles/audio/a2dp.c:suspend_cfm() Source 0x213a9b0: Suspend_Cfm
>Jan 17 21:37:31 phantom bluetoothd[1190]: profiles/audio/transport.c:media_request_reply() Request Release Reply Success
>Jan 17 21:37:31 phantom bluetoothd[1190]: profiles/audio/transport.c:media_owner_remove() Owner :1.56 Request Release
>Jan 17 21:37:31 phantom bluetoothd[1190]: profiles/audio/a2dp.c:a2dp_sep_unlock() SEP 0x213a9b0 unlocked
>Jan 17 21:37:31 phantom bluetoothd[1190]: profiles/audio/transport.c:transport_set_state() State changed /org/bluez/hci0/dev_00_1B_66_02_37_72/fd3: TRANSPORT_STATE_SUSPENDING -> TRANSPORT_STATE_IDLE
>Jan 17 21:37:31 phantom bluetoothd[1190]: profiles/audio/transport.c:media_transport_remove_owner() Transport /org/bluez/hci0/dev_00_1B_66_02_37_72/fd3 Owner :1.56
>Jan 17 21:37:31 phantom bluetoothd[1190]: profiles/audio/transport.c:media_owner_free() Owner :1.56
>Jan 17 21:37:31 phantom bluetoothd[1190]: profiles/audio/a2dp.c:setup_unref() 0x2104870: ref=0
>Jan 17 21:37:31 phantom bluetoothd[1190]: profiles/audio/a2dp.c:setup_free() 0x2104870
>Jan 17 21:37:31 phantom bluetoothd[1190]: profiles/audio/avdtp.c:avdtp_unref() 0x2140530: ref=2
>Jan 17 21:37:32 phantom bluetoothd[1190]: profiles/audio/transport.c:media_owner_create() Owner created: sender=:1.56
>Jan 17 21:37:32 phantom bluetoothd[1190]: profiles/audio/a2dp.c:a2dp_sep_lock() SEP 0x213a9b0 locked
>Jan 17 21:37:32 phantom bluetoothd[1190]: profiles/audio/avdtp.c:avdtp_ref() 0x2140530: ref=3
>Jan 17 21:37:32 phantom bluetoothd[1190]: profiles/audio/a2dp.c:setup_ref() 0x213c700: ref=1
>Jan 17 21:37:32 phantom bluetoothd[1190]: profiles/audio/transport.c:transport_set_state() State changed /org/bluez/hci0/dev_00_1B_66_02_37_72/fd3: TRANSPORT_STATE_IDLE -> TRANSPORT_STATE_REQUESTING
>Jan 17 21:37:32 phantom bluetoothd[1190]: profiles/audio/transport.c:media_request_create() Request created: method=Acquire id=21
>Jan 17 21:37:32 phantom bluetoothd[1190]: profiles/audio/transport.c:media_owner_add() Owner :1.56 Request Acquire
>Jan 17 21:37:32 phantom bluetoothd[1190]: profiles/audio/transport.c:media_transport_set_owner() Transport /org/bluez/hci0/dev_00_1B_66_02_37_72/fd3 Owner :1.56
>Jan 17 21:37:32 phantom bluetoothd[1190]: profiles/audio/avdtp.c:session_cb()
>Jan 17 21:37:32 phantom bluetoothd[1190]: profiles/audio/avdtp.c:avdtp_parse_resp() START request succeeded
>Jan 17 21:37:32 phantom bluetoothd[1190]: profiles/audio/a2dp.c:start_cfm() Source 0x213a9b0: Start_Cfm
>Jan 17 21:37:32 phantom bluetoothd[1190]: profiles/audio/transport.c:media_owner_remove() Owner :1.56 Request Acquire
>Jan 17 21:37:32 phantom bluetoothd[1190]: profiles/audio/transport.c:transport_set_state() State changed /org/bluez/hci0/dev_00_1B_66_02_37_72/fd3: TRANSPORT_STATE_REQUESTING -> TRANSPORT_STATE_ACTIVE
>Jan 17 21:37:32 phantom bluetoothd[1190]: profiles/audio/a2dp.c:setup_unref() 0x213c700: ref=0
>Jan 17 21:37:32 phantom bluetoothd[1190]: profiles/audio/a2dp.c:setup_free() 0x213c700
>Jan 17 21:37:32 phantom bluetoothd[1190]: profiles/audio/avdtp.c:avdtp_unref() 0x2140530: ref=2
>Jan 17 21:37:32 phantom bluetoothd[1190]: profiles/audio/avdtp.c:avdtp_sep_set_state() stream state changed: OPEN -> STREAMING
>Jan 17 21:37:32 phantom bluetoothd[1190]: profiles/audio/sink.c:sink_set_state() State changed /org/bluez/hci0/dev_00_1B_66_02_37_72: SINK_STATE_CONNECTED -> SINK_STATE_PLAYING
>Jan 17 21:37:32 phantom bluetoothd[1190]: profiles/audio/transport.c:transport_update_playing() /org/bluez/hci0/dev_00_1B_66_02_37_72/fd3 State=TRANSPORT_STATE_ACTIVE Playing=1
>Jan 17 21:37:45 phantom bluetoothd[1190]: profiles/audio/transport.c:transport_set_state() State changed /org/bluez/hci0/dev_00_1B_66_02_37_72/fd3: TRANSPORT_STATE_ACTIVE -> TRANSPORT_STATE_SUSPENDING
>Jan 17 21:37:45 phantom bluetoothd[1190]: profiles/audio/avdtp.c:avdtp_ref() 0x2140530: ref=3
>Jan 17 21:37:45 phantom bluetoothd[1190]: profiles/audio/a2dp.c:setup_ref() 0x2104870: ref=1
>Jan 17 21:37:45 phantom bluetoothd[1190]: profiles/audio/transport.c:media_request_create() Request created: method=Release id=22
>Jan 17 21:37:45 phantom bluetoothd[1190]: profiles/audio/transport.c:media_owner_add() Owner :1.56 Request Release
>Jan 17 21:37:51 phantom bluetoothd[1190]: Suspend: Connection timed out (110)
>Jan 17 21:37:51 phantom bluetoothd[1190]: profiles/audio/a2dp.c:suspend_cfm() Source 0x213a9b0: Suspend_Cfm
>Jan 17 21:37:51 phantom bluetoothd[1190]: profiles/audio/transport.c:media_request_reply() Request Release Reply Success
>Jan 17 21:37:51 phantom bluetoothd[1190]: profiles/audio/transport.c:media_owner_remove() Owner :1.56 Request Release
>Jan 17 21:37:51 phantom bluetoothd[1190]: profiles/audio/a2dp.c:a2dp_sep_unlock() SEP 0x213a9b0 unlocked
>Jan 17 21:37:51 phantom bluetoothd[1190]: profiles/audio/avdtp.c:send_request() Unable to send requests while aborting
>Jan 17 21:37:51 phantom bluetoothd[1190]: profiles/audio/transport.c:transport_set_state() State changed /org/bluez/hci0/dev_00_1B_66_02_37_72/fd3: TRANSPORT_STATE_SUSPENDING -> TRANSPORT_STATE_IDLE
>Jan 17 21:37:51 phantom bluetoothd[1190]: profiles/audio/transport.c:media_transport_remove_owner() Transport /org/bluez/hci0/dev_00_1B_66_02_37_72/fd3 Owner :1.56
>Jan 17 21:37:51 phantom bluetoothd[1190]: profiles/audio/transport.c:media_owner_free() Owner :1.56
>Jan 17 21:37:51 phantom bluetoothd[1190]: profiles/audio/a2dp.c:setup_unref() 0x2104870: ref=0
>Jan 17 21:37:51 phantom bluetoothd[1190]: profiles/audio/a2dp.c:setup_free() 0x2104870
>Jan 17 21:37:51 phantom bluetoothd[1190]: profiles/audio/avdtp.c:avdtp_unref() 0x2140530: ref=2
>Jan 17 21:37:53 phantom bluetoothd[1190]: Abort: Connection timed out (110)
>Jan 17 21:37:53 phantom bluetoothd[1190]: profiles/audio/avdtp.c:connection_lost() Disconnected from 00:1B:66:02:37:72
>Jan 17 21:37:53 phantom bluetoothd[1190]: profiles/audio/a2dp.c:abort_cfm() Source 0x213a9b0: Abort_Cfm
>Jan 17 21:37:53 phantom bluetoothd[1190]: profiles/audio/avdtp.c:avdtp_sep_set_state() stream state changed: STREAMING -> IDLE
>Jan 17 21:37:53 phantom bluetoothd[1190]: profiles/audio/avdtp.c:avdtp_unref() 0x2140530: ref=1
>Jan 17 21:37:53 phantom bluetoothd[1190]: src/service.c:change_state() 0x2139790: device 00:1B:66:02:37:72 profile a2dp-sink state changed: connected -> disconnected (0)
>Jan 17 21:37:53 phantom bluetoothd[1190]: plugins/policy.c:policy_disconnect() /org/bluez/hci0/dev_00_1B_66_02_37_72 profile avrcp-controller
>Jan 17 21:37:53 phantom bluetoothd[1190]: src/service.c:change_state() 0x21430a0: device 00:1B:66:02:37:72 profile avrcp-controller state changed: connecting -> disconnecting (0)
>Jan 17 21:37:53 phantom bluetoothd[1190]: profiles/audio/avrcp.c:avrcp_disconnect() path /org/bluez/hci0/dev_00_1B_66_02_37_72
>Jan 17 21:37:53 phantom bluetoothd[1190]: src/service.c:change_state() 0x21430a0: device 00:1B:66:02:37:72 profile avrcp-controller state changed: disconnecting -> disconnected (0)
>Jan 17 21:37:53 phantom bluetoothd[1190]: profiles/audio/avdtp.c:avdtp_unref() 0x2140530: ref=0
>Jan 17 21:37:53 phantom bluetoothd[1190]: profiles/audio/sink.c:sink_set_state() State changed /org/bluez/hci0/dev_00_1B_66_02_37_72: SINK_STATE_PLAYING -> SINK_STATE_DISCONNECTED
>Jan 17 21:37:53 phantom bluetoothd[1190]: profiles/audio/avdtp.c:avdtp_free() 0x2140530
>Jan 17 21:37:53 phantom dbus[391]: [system] Rejected send message, 3 matched rules; type="method_return", sender=":1.56" (uid=1000 pid=1394 comm="pulseaudio -v --start ") interface="(unset)" member="(unset)" error name="(unset)" requested_reply="0" destination=":1.43" (uid=0 pid=1190 comm="/usr/lib/bluetooth/bluetoothd ")
>Jan 17 21:37:53 phantom dbus-daemon[391]: dbus[391]: [system] Rejected send message, 3 matched rules; type="method_return", sender=":1.56" (uid=1000 pid=1394 comm="pulseaudio -v --start ") interface="(unset)" member="(unset)" error name="(unset)" requested_reply="0" destination=":1.43" (uid=0 pid=1190 comm="/usr/lib/bluetooth/bluetoothd ")
>Jan 17 21:38:35 phantom bluetoothd[1190]: src/adapter.c:dev_disconnected() Device 00:1B:66:02:37:72 disconnected, reason 2
>Jan 17 21:38:35 phantom bluetoothd[1190]: src/adapter.c:adapter_remove_connection()
>Jan 17 21:38:35 phantom bluetoothd[1190]: src/adapter.c:bonding_attempt_complete() hci0 bdaddr 00:1B:66:02:37:72 type 0 status 0xe
>Jan 17 21:38:35 phantom bluetoothd[1190]: src/device.c:device_bonding_complete() bonding (nil) status 0x0e
>Jan 17 21:38:35 phantom bluetoothd[1190]: src/device.c:device_bonding_failed() status 14
>Jan 17 21:38:35 phantom bluetoothd[1190]: src/adapter.c:resume_discovery()
>Jan 17 21:38:41 phantom bluetoothd[1190]: src/adapter.c:connected_callback() hci0 device 00:1B:66:02:37:72 connected eir_len 25
>Jan 17 21:38:41 phantom bluetoothd[1190]: profiles/audio/avdtp.c:avdtp_confirm_cb() AVDTP: incoming connect from 00:1B:66:02:37:72
>Jan 17 21:38:41 phantom bluetoothd[1190]: profiles/audio/sink.c:sink_set_state() State changed /org/bluez/hci0/dev_00_1B_66_02_37_72: SINK_STATE_DISCONNECTED -> SINK_STATE_CONNECTING
>Jan 17 21:38:41 phantom bluetoothd[1190]: profiles/audio/avdtp.c:session_cb()
>Jan 17 21:38:41 phantom bluetoothd[1190]: profiles/audio/avdtp.c:connection_lost() Disconnected from 00:1B:66:02:37:72
>Jan 17 21:38:41 phantom bluetoothd[1190]: profiles/audio/sink.c:sink_set_state() State changed /org/bluez/hci0/dev_00_1B_66_02_37_72: SINK_STATE_CONNECTING -> SINK_STATE_DISCONNECTED
>Jan 17 21:38:41 phantom bluetoothd[1190]: profiles/audio/avdtp.c:avdtp_free() 0x213f250
>Jan 17 21:38:41 phantom bluetoothd[1190]: src/adapter.c:dev_disconnected() Device 00:1B:66:02:37:72 disconnected, reason 3
>Jan 17 21:38:41 phantom bluetoothd[1190]: src/adapter.c:adapter_remove_connection()
>Jan 17 21:38:41 phantom bluetoothd[1190]: src/adapter.c:bonding_attempt_complete() hci0 bdaddr 00:1B:66:02:37:72 type 0 status 0xe
>Jan 17 21:38:41 phantom bluetoothd[1190]: src/device.c:device_bonding_complete() bonding (nil) status 0x0e
>Jan 17 21:38:41 phantom bluetoothd[1190]: src/device.c:device_bonding_failed() status 14
>Jan 17 21:38:41 phantom bluetoothd[1190]: src/adapter.c:resume_discovery()

Actions: View

Attachments on bug 73752: 92307 | 92308 | 92521 | 92524

Use of freedesktop.org services, including Bugzilla, is subject to our Code of Conduct. How we collect and use information is described in our Privacy Policy.