Bluetooth no longer working after fresh install

charleszimm

@BuZz I gave that a shot prior to trying to reaching out on here, but I just ran a quick test in Windows mode. Similar error in the Setup script:

"An error occurred connecting to the bluetooth device (Creating device failed: org.bluez.ErrorConnectionAttemptFailed: Page Timeout)"

psyke83

@charleszimm

I think you're comfortable with using the terminal, so could you try reverting RetroPie-Setup to just before my recent major bluetooth changes and retry the same procedure (remove & register via the script only)?

You need to test before commit 12cb7eb1bc9d810e98adbc8ec7f9a8369ed1f25e, so:

git checkout 12cb7eb1bc9d810e98adbc8ec7f9a8369ed1f25e^

To go back:

git checkout master

Thanks.

psyke83

@charleszimm said in Bluetooth no longer working after fresh install:

(Creating device failed: org.bluez.ErrorConnectionAttemptFailed: Page Timeout)

I also did a quick google of the error in conjunction with those controllers, and it does suggest that @buzz is correct that the boot method is related to your issue. See: https://www.reddit.com/r/RetroPie/comments/8pxe5d/help_with_8bitdo_n30_pro_bluetooth_gamepad/

Please keep us informed as to your results as we need to know if the recent Bluetooth changes need any more fixes.

charleszimm

@psyke83 I should probably state at this point that I'm a Linux sys admin...but I'm also a Linux sys admin that doesn't do a lot with GitHub. Don't I need a branch or a repo for that command to work? When I run git checkout, I get this:

pi@theaterretropie:~ $ git checkout 12cb7eb1bc9d810e98adbc8ec7f9a8369ed1f25e
fatal: Not a git repository (or any of the parent directories): .git

Do I need to clone it first?

Also the boot mode and security type make no difference. I followed the link from Reddit and that just brings its back to the 8bitdo wiki page on the RetroPie GitHub. Those steps were tried (and remember originally didn't work because of the "Searching..." hang).

psyke83

@charleszimm

No need to clone a new copy - simply make sure that you're in the same directory as the existing RetroPie-Setup script:

cd ~/RetroPie-Setup
git checkout 12cb7eb1bc9d810e98adbc8ec7f9a8369ed1f25e^

Note that you omitted the caret to signify the commit preceding the commit specified, so make sure to include it (since you want to test the script right before that commit).

charleszimm

@psyke83 Sorry for the delay. Here's the response:

pi@theaterretropie:~/RetroPie-Setup $ pwd
/home/pi/RetroPie-Setup
pi@theaterretropie:~/RetroPie-Setup $ git checkout 12cb7eb1bc9d810e98adbc8ec7f9a8369ed1f25e^
error: pathspec '12cb7eb1bc9d810e98adbc8ec7f9a8369ed1f25e^' did not match any file(s) known to git.

psyke83

@charleszimm said in Bluetooth no longer working after fresh install:

git checkout 12cb7eb1bc9d810e98adbc8ec7f9a8369ed1f25e^

Huh that's odd. Try to fetch origin before checkout:

git fetch origin

I just tried a fresh clone of the repo and was able to checkout that commit without any problem (on my Pi and laptop).

charleszimm

I keep getting flagged as spam but tried the git fetch origin and then the commit point but same message. I recloned the entire RetroPie-Setup from GitHub and tried it again and got the same error.

psyke83

@charleszimm

Not sure what's going on there, sorry. Perhaps the caret is causing issues somehow, so it might help to specify another commit that precedes the change. Try:

git checkout 2c9fa79a1ae41c2988d21bd179c33ce515e29245

charleszimm

@psyke83 said in Bluetooth no longer working after fresh install:

git checkout 2c9fa79a1ae41c2988d21bd179c33ce515e29245

Nope.

pi@theaterretropie:~/RetroPie-Setup $ git checkout 2c9fa79a1ae41c2988d21bd179c33ce515e29245
fatal: reference is not a tree: 2c9fa79a1ae41c2988d21bd179c33ce515e29245

psyke83

@charleszimm said in Bluetooth no longer working after fresh install:

@psyke83 said in Bluetooth no longer working after fresh install:

git checkout 2c9fa79a1ae41c2988d21bd179c33ce515e29245

Nope.

pi@theaterretropie:~/RetroPie-Setup $ git checkout 2c9fa79a1ae41c2988d21bd179c33ce515e29245
fatal: reference is not a tree: 2c9fa79a1ae41c2988d21bd179c33ce515e29245

Very odd. Did you clone from a forked repository instead of the official one? What's the output of git remote -v in that folder?

P.S. You should encapsulate code via the code tag icon in the editor to avoid the spam filter (and to keep the text tidy).

charleszimm

@psyke83 Oh yeah good point. It was more of a laziness thing on my part I won't lie. :-)

pi@theaterretropie:~/RetroPie-Setup $ git remote -v
origin	https://github.com/RetroPie/RetroPie-Setup.git (fetch)
origin	https://github.com/RetroPie/RetroPie-Setup.git (push)

psyke83

@charleszimm said in Bluetooth no longer working after fresh install:

@psyke83 Oh yeah good point. It was more of a laziness thing on my part I won't lie. :-)
pi@theaterretropie:~/RetroPie-Setup $ git remote -v
origin	https://github.com/RetroPie/RetroPie-Setup.git (fetch)
origin	https://github.com/RetroPie/RetroPie-Setup.git (push)

Really bizarre. The only possibility I can think of is that you somehow have a shallow copy of the repository, so it doesn't include the history of commits up to what we need.

Make sure you're on the master branch, then try to force the whole history to be downloaded:

git checkout master
git pull --unshallow

You can see what the oldest commit is via git log --reverse - in my case, it shows the very first commit to the repository from 2012.

psyke83

Ah yes that makes complete sense! Our instructions will have you clone a shallow copy (--depth=1): https://github.com/RetroPie/RetroPie-Setup/blob/master/README.md

Forcing an unshallow will fix the issue.

charleszimm

@psyke83 Hey that worked!

HEAD is now at 179e2f37... Merge pull request #2591 from cmitu/dolphin-build

When I go into the Setup script, the last commit is now listed as three weeks ago along with the HEAD number. I cleaned out the entire registered Bluetooth device list in bluetoothctl. Let me do some testing and get back to you.

charleszimm

@charleszimm Hung at the Searching... loop. That's what we expected to see, right?

psyke83

@charleszimm said in Bluetooth no longer working after fresh install:

@charleszimm Hung at the Searching... loop. That's what we expected to see, right?

Maybe, yes. To bypass that, make sure to remove any devices that are causing the Connected: yes/no messages to loop in bluetoothctl before selecting the "Register" menu option.

It might be OK to run a bluetoothctl session in a separate shell if you want to monitor what's happening in the Bluetooth stack at the same time as you're running the script.

charleszimm

@psyke83 Okay I lied. It didn't hang but it takes about roughly 2 minutes before it completed searching. I left the Searching... screen up in the SSH session, went to grab a drink, came back, and the results were there.

I was able to connect the controller without problems in Switch mode through the setup script without any problems (which that was always how I had my SN30 Pro setup, even back when I was running Jessie). Restarted the Pi and was able to reconnect the controller without any problems.

So what has changed between the commits?

Bluetooth.service still gives some weird messages that don't leave me warm and fuzzy however.

pi@theaterretropie:~ $ systemctl status bluetooth.service
● bluetooth.service - Bluetooth service
   Loaded: loaded (/lib/systemd/system/bluetooth.service; enabled; vendor preset: enabled)
   Active: active (running) since Wed 2019-02-20 13:20:59 EST; 2min 38s ago
     Docs: man:bluetoothd(8)
 Main PID: 515 (bluetoothd)
   Status: "Running"
   CGroup: /system.slice/bluetooth.service
           └─515 /usr/lib/bluetooth/bluetoothd

Feb 20 13:20:59 theaterretropie bluetoothd[515]: Starting SDP server
Feb 20 13:20:59 theaterretropie bluetoothd[515]: Bluetooth management interface 1.14 initialized
Feb 20 13:20:59 theaterretropie bluetoothd[515]: Failed to obtain handles for "Service Changed" characteristic
Feb 20 13:20:59 theaterretropie bluetoothd[515]: setsockopt(L2CAP_OPTIONS): Invalid argument (22)
Feb 20 13:20:59 theaterretropie bluetoothd[515]: avrcp-controller: Protocol not supported (93)
Feb 20 13:20:59 theaterretropie bluetoothd[515]: setsockopt(L2CAP_OPTIONS): Invalid argument (22)
Feb 20 13:20:59 theaterretropie bluetoothd[515]: audio-avrcp-target: Protocol not supported (93)
Feb 20 13:20:59 theaterretropie bluetoothd[515]: Sap driver initialization failed.
Feb 20 13:20:59 theaterretropie bluetoothd[515]: sap-server: Operation not permitted (1)
Feb 20 13:21:01 theaterretropie bluetoothd[515]: Failed to set privacy: Rejected (0x0b)

psyke83

My daemon log shows similar (but not all of your) errors:

● bluetooth.service - Bluetooth service
   Loaded: loaded (/lib/systemd/system/bluetooth.service; enabled; vendor preset: enabled)
   Active: active (running) since Tue 2019-02-19 17:57:35 GMT; 24h ago
     Docs: man:bluetoothd(8)
 Main PID: 527 (bluetoothd)
   Status: "Running"
   CGroup: /system.slice/bluetooth.service
           └─527 /usr/lib/bluetooth/bluetoothd

Feb 19 17:57:35 retropie systemd[1]: Starting Bluetooth service...
Feb 19 17:57:35 retropie bluetoothd[527]: Bluetooth daemon 5.43
Feb 19 17:57:35 retropie systemd[1]: Started Bluetooth service.
Feb 19 17:57:35 retropie bluetoothd[527]: Starting SDP server
Feb 19 17:57:35 retropie bluetoothd[527]: Bluetooth management interface 1.14 initialized
Feb 19 17:57:35 retropie bluetoothd[527]: Failed to obtain handles for "Service Changed" characteristic
Feb 19 17:57:35 retropie bluetoothd[527]: Sap driver initialization failed.
Feb 19 17:57:35 retropie bluetoothd[527]: sap-server: Operation not permitted (1)
Feb 19 17:57:35 retropie bluetoothd[527]: Endpoint registered: sender=:1.5 path=/A2DP/SBC/Source/1
Feb 19 17:57:35 retropie bluetoothd[527]: Failed to set privacy: Rejected (0x0b)

Are you absolutely certain that you tested the latest master script, making sure to remove the device before registration?

Again, to return to master:

git checkout master

I can't really see how my changes would negatively affect the authentication phase, as I didn't change anything in that part of the script.

charleszimm

@psyke83 I'm positive. I looked through the commit log and I agree: It doesn't quite look like any of the changes that were made should really affect the handoff between the device and the service.

I removed the controller, checked back out to master, confirmed in the Setup script that we're at 5dff90ef, and tried to resync the controller through the Bluetooth menu. With the controller in the same mode (Switch) that worked on 179e2f37, I'm back to getting the message:

An error occurred connecting to the bluetooth device (Creating device failed: org.bluez.Error.AuthenicationFailed: Authentication Failed)

If I go into bluetoothctl, I get the familiar Yes/No:

[bluetooth]# connect 98:B6:E9:42:4B:35
Attempting to connect to 98:B6:E9:42:4B:35
[CHG] Device 98:B6:E9:42:4B:35 Connected: yes
[CHG] Device 98:B6:E9:42:4B:35 Connected: no

I'm not sure where you're located but I'm in the northeast of the US and we're getting pounded with snow so I'm going to start our digging out. Let me know if you want me try anything else today!