+x=usr(1536) Posted September 12, 2022 Share Posted September 12, 2022 Environment: FujiNet firmware 2022-09-06 0.5.f3905ead-SIO2BT, macOS Monterey (12.5.1), RespeQt r5.3, 600XL (64K internal). A few months ago, I did a scorch & burn reinstall and upgrade of the OS on this machine. One of the things that was lost in that: the bluetooth configuration that I'd been using with FujiNet. I'm trying to set it back up but am only having partial success. Here's what's happening: macOS sees the FujiNetSIO2BT bluetooth device It will connect to it, but no pairing request is ever made (i.e., I'm never prompted to enter a PIN, etc.) Bluetooth on the FujiNet is persistent between power cycles Sometimes it takes several attempts to establish a solid connection - toggling either FujiNet power or the Mac's Bluetooth adapter on and off will eventually make it happen The 600XL never boots any disk (or folder) I'm throwing at it; Folder Boot Options have been set to every option at one time or another Confirmed that RespeQt creates the correct serial & TTY entries in /dev Spoiler crw-rw-rw- 1 root wheel 0x16000001 Sep 12 18:19 /dev/cu.BLTH crw-rw-rw- 1 root wheel 0x16000009 Sep 12 17:19 /dev/cu.Bluetooth-Incoming-Port crw-rw-rw- 1 root wheel 0x16000007 Sep 12 18:15 /dev/cu.FujiNetSIO2BT crw-rw-rw- 1 root wheel 0x16000005 Aug 18 15:04 /dev/cu.URT1 crw-rw-rw- 1 root wheel 0x16000003 Aug 18 15:04 /dev/cu.URT2 crw-rw-rw- 1 root wheel 0x16000000 Aug 18 15:04 /dev/tty.BLTH crw-rw-rw- 1 root wheel 0x16000008 Sep 12 17:19 /dev/tty.Bluetooth-Incoming-Port crw-rw-rw- 1 root wheel 0x16000006 Sep 12 18:15 /dev/tty.FujiNetSIO2BT crw-rw-rw- 1 root wheel 0x16000004 Aug 18 15:04 /dev/tty.URT1 crw-rw-rw- 1 root wheel 0x16000002 Aug 18 15:04 /dev/tty.URT2 My suspicion is that either the FujiNet or Mac isn't handling a pairing request properly. Serial logs from boot to it's-not-doing-anything to I-turned-off-bluetooth-on-the-Mac: Spoiler Auto-detected serial port: /dev/cu.usbserial-1460 Showing logs: [18:26:29] [18:26:29] [18:26:29] --~--~--~-- [18:26:29] FujiNet 0.5.99a7a111 2022-09-06 18:28:39 Started @ 2 [18:26:29] Starting heap: 4350648 [18:26:29] Detected Hardware Version: 1.0 [18:26:30] SPIFFS mounted. [18:26:30] SD mounted. [18:26:30] fnConfig::load [18:26:30] Load fnconfig.ini from SD [18:26:30] fopen = ok [18:26:30] fnConfig::load read 1146 bytes from config file [18:26:30] SPIFFS Config Storage: Enabled [18:26:30] fnConfig::load read 1146 bytes from SPIFFS config file [18:26:30] disk UNMOUNT [18:26:30] disk MOUNT [18:26:30] ATR MOUNT [18:26:30] mounted ATR: paragraphs=5760, sect_size=128, sect_count=720, disk_size=0 [18:26:30] Creating a default printer using FS_SDFAT storage and type 2 [18:26:30] SSH client initialized. [18:26:30] ModemSniffer::ModemSniffer(FS_SDFAT) [18:26:30] SIO SETUP [18:26:30] Set HSIO baud from 0 to 67431 (index 6), alt=68209 [18:26:30] Available heap: 4258044 [18:26:30] Setup complete @ 874 (872ms) [18:26:30] Starting SIO2BT [18:26:31] ESP_SPP_INIT_EVT [18:26:31] ESP_SPP_INIT_EVT: client: start [18:26:31] ESP_SPP_START_EVT [18:26:31] Baudrate already at 19200 - nothing to do [18:27:59] W (90362) BT_APPL: new conn_srvc id:26, app_id:255 [18:27:59] ESP_SPP_SRV_OPEN_EVT [18:29:19] W (170682) BT_RFCOMM: port_rfc_closed RFCOMM connection in state 2 closed: Closed (res: 19) [18:29:19] ESP_SPP_CLOSE_EVT [18:29:20] W (171722) BT_RFCOMM: rfc_find_lcid_mcb LCID reused LCID:0x42 current:0x0 [18:29:20] W (171722) BT_RFCOMM: RFCOMM_DisconnectInd LCID:0x42 Not sure what to make of this. My recollection is that it had worked in the past, but that was some time ago and under a different version of macOS. Quote Link to comment Share on other sites More sharing options...
mozzwald Posted September 13, 2022 Share Posted September 13, 2022 45 minutes ago, x=usr(1536) said: Not sure what to make of this. My recollection is that it had worked in the past, Can you test with a couple of the older SIO2BT firmware versions to rule out an issue with the current one? I don't have a way of actually booting anything but when I get a moment can try pairing and see if that works. I don't recall if theres a pairing PIN, but I think probably not 1 Quote Link to comment Share on other sites More sharing options...
+x=usr(1536) Posted September 13, 2022 Author Share Posted September 13, 2022 2 hours ago, mozzwald said: Can you test with a couple of the older SIO2BT firmware versions to rule out an issue with the current one? Sure. Here're the results: Update to Version 0.5.24fbef77 (Version Date: 2022-05-22 02:44:12) Spoiler Retrieving firmware Downloading https://fujinet.online/firmware/releases_atari/fujinet-ATARI-0.5.24fbef77-SIO2BT.zip sha256 0d9ab00e60dee1ef652e3d0c3dddb1ee9e64bf4a3125157780cd37468b7d5edb OK Using '/dev/cu.usbserial-144330' as serial port. Starting firmware upgrade... File 1: bootloader.bin, Offset: 0x1000 File 2: partitions.bin, Offset: 0x8000 File 3: firmware.bin, Offset: 0x10000 File 4: spiffs.bin, Offset: 0x910000 FujiNet Version: 0.5.24fbef77 Version Date: 2022-05-22 02:44:12 Git Commit: 24fbef77 Connecting...[22:06:09] ets Jun 8 2016 00:22:57 [22:06:09] [22:06:09] rst:0x1 (POWERON_RESET),boot:0x3 (DOWNLOAD_BOOT(UART0/UART1/SDIO_REI_REO_V2)) [22:06:09] waiting for download .Serial port closed! . Chip Info: - Chip Family: ESP32 - Chip Model: ESP32D0WDQ5 (revision 1) - Number of Cores: 2 - Max CPU Frequency: 240MHz - Has Bluetooth: YES - Has Embedded Flash: NO - Has Factory-Calibrated ADC: YES - MAC Address: F0:08:D1:6D:DB:B8 Uploading stub... Running stub... Stub running... Changing baud rate to 460800 Changed. - Flash Size: 16MB - Flash Mode: dio - Flash Frequency: 40MHz Erasing flash (this may take a while)... Chip erase completed successfully in 18.2s Compressed 27360 bytes to 16587... Writing at 0x00005000... (100 %)Wrote 27360 bytes (16587 compressed) at 0x00001000 in 0.4 seconds (effective 531.3 kbit/s)... Hash of data verified. Compressed 3072 bytes to 118... Writing at 0x00008000... (100 %)Wrote 3072 bytes (118 compressed) at 0x00008000 in 0.0 seconds (effective 1463.6 kbit/s)... Hash of data verified. Compressed 2257008 bytes to 1309551... Writing at 0x0014c000... (100 %)Wrote 2257008 bytes (1309551 compressed) at 0x00010000 in 30.3 seconds (effective 596.4 kbit/s)... Hash of data verified. Compressed 5242880 bytes to 651898... Writing at 0x009ac000... (100 %)Wrote 5242880 bytes (651898 compressed) at 0x00910000 in 15.2 seconds (effective 2758.4 kbit/s)... Hash of data verified. Leaving... Hard Resetting... Done! Flashing is complete! Showing logs: [22:07:35] [22:07:35] [22:07:35] --~--~--~-- [22:07:35] FujiNet 0.5.24fbef77 2022-05-22 02:44:12 Started @ 2 [22:07:35] Starting heap: 4350696 [22:07:35] Detected Hardware Version: 1.0 [22:07:35] SPIFFS mounted. [22:07:35] SD mounted. [22:07:35] fnConfig::load [22:07:35] Load fnconfig.ini from SD [22:07:35] fopen = ok [22:07:35] fnConfig::load read 1165 bytes from config file [22:07:36] Config file dosn't exist on SPIFFS [22:07:36] Copying SD config file to SPIFFS [22:07:36] copy_file "/fnconfig.ini" -> "/fnconfig.ini" [22:07:36] fopen = ok [22:07:36] copy_file copied 1165 bytes [22:07:36] Starting SIO2BT [22:07:36] ESP_SPP_INIT_EVT [22:07:36] ESP_SPP_INIT_EVT: client: start [22:07:36] ESP_SPP_START_EVT [22:07:36] Baudrate already at 19200 - nothing to do [22:07:36] disk UNMOUNT [22:07:36] disk MOUNT [22:07:36] ATR MOUNT [22:07:36] mounted ATR: paragraphs=5760, sect_size=128, sect_count=720, disk_size=0 [22:07:36] Creating a default printer using FS_SDFAT storage and type 2 [22:07:36] SSH client initialized. [22:07:36] ModemSniffer::ModemSniffer(FS_SDFAT) [22:07:36] SIO SETUP [22:07:36] Set HSIO baud from 0 to 67431 (index 6), alt=68209 [22:07:36] Available heap: 4193704 [22:07:36] Setup complete @ 1608 (1606ms) Boot / Pair / Kill BT on Mac: Spoiler Using '/dev/cu.usbserial-144320' as serial port. Showing logs: [22:12:34] [22:12:34] [22:12:34] --~--~--~-- [22:12:34] FujiNet 0.5.24fbef77 2022-05-22 02:44:12 Started @ 2 [22:12:34] Starting heap: 4350696 [22:12:34] Detected Hardware Version: 1.0 [22:12:35] SPIFFS mounted. [22:12:35] SD mounted. [22:12:35] fnConfig::load [22:12:35] Load fnconfig.ini from SD [22:12:35] fopen = ok [22:12:35] fnConfig::load read 1165 bytes from config file [22:12:35] SPIFFS Config Storage: Enabled [22:12:35] fnConfig::load read 1165 bytes from SPIFFS config file [22:12:35] Starting SIO2BT [22:12:35] ESP_SPP_INIT_EVT [22:12:35] ESP_SPP_INIT_EVT: client: start [22:12:35] ESP_SPP_START_EVT [22:12:35] Baudrate already at 19200 - nothing to do [22:12:35] disk UNMOUNT [22:12:36] disk MOUNT [22:12:36] ATR MOUNT [22:12:36] mounted ATR: paragraphs=5760, sect_size=128, sect_count=720, disk_size=0 [22:12:36] Creating a default printer using FS_SDFAT storage and type 2 [22:12:36] SSH client initialized. [22:12:36] ModemSniffer::ModemSniffer(FS_SDFAT) [22:12:36] SIO SETUP [22:12:36] Set HSIO baud from 0 to 67431 (index 6), alt=68209 [22:12:36] Available heap: 4194352 [22:12:36] Setup complete @ 1318 (1316ms) [22:13:38] W (75635) BT_APPL: new conn_srvc id:26, app_id:255 [22:13:38] ESP_SPP_SRV_OPEN_EVT Serial port closed! Quote Link to comment Share on other sites More sharing options...
+x=usr(1536) Posted September 13, 2022 Author Share Posted September 13, 2022 The editor's acting weird, so apologies for the second post. Here's the oldest version I can obtain via the flasher. Update to Version 0.5.a60a0cbc (Version Date: 2022-01-12 03:23:22) Spoiler Retrieving firmware Downloading https://fujinet.online/firmware/releases_atari/fujinet-ATARI-0.5.a60a0cbc-SIO2BT.zip sha256 9d28763e0b0a2cd61e8d3bf624818734673ac7f0f0ecf1a0af6e15c0cf57e4de OK Using '/dev/cu.usbserial-144320' as serial port. Starting firmware upgrade... File 1: bootloader.bin, Offset: 0x1000 File 2: partitions.bin, Offset: 0x8000 File 3: boot_app0.bin, Offset: 0xE000 File 4: firmware.bin, Offset: 0x10000 File 5: spiffs.bin, Offset: 0xC10000 FujiNet Version: 0.5.a60a0cbc-SIO2BT Version Date: 2022-01-12 03:23:22 Git Commit: 700575d Connecting...[22:22:11] e Ju16 00:22 Connecting...[22:22:11] e Ju16 00:22 [22:22:11] tsn 8 20:57 Serial port closed! [22:22:11] P_RESET),boot:0 (DOWNLOAD_BOOT(UART0/UART1/SDIO_REI_REO_V2)) [22:22:11] waiting for download ..Serial port closed! Chip Info: - Chip Family: ESP32 - Chip Model: ESP32D0WDQ5 (revision 1) - Number of Cores: 2 - Max CPU Frequency: 240MHz - Has Bluetooth: YES - Has Embedded Flash: NO - Has Factory-Calibrated ADC: YES - MAC Address: F0:08:D1:6D:DB:B8 Uploading stub... Running stub... Stub running... Changing baud rate to 460800 Changed. - Flash Size: 16MB - Flash Mode: dio - Flash Frequency: 40MHz Erasing flash (this may take a while)... Chip erase completed successfully in 18.1s Compressed 27360 bytes to 16587... Writing at 0x00005000... (100 %)Wrote 27360 bytes (16587 compressed) at 0x00001000 in 0.4 seconds (effective 534.8 kbit/s)... Hash of data verified. Compressed 3072 bytes to 128... Wrote 3072 bytes (128 compressed) at 0x00008000 in 0.0 seconds (effective 2072.0 kbit/s)... Hash of data verified. Compressed 8192 bytes to 47... Writing at 0x0000e000... (100 %)Wrote 8192 bytes (47 compressed) at 0x0000e000 in 0.0 seconds (effective 6629.8 kbit/s)... Hash of data verified. Compressed 2249888 bytes to 1302252... Writing at 0x0014c000... (100 %)Wrote 2249888 bytes (1302252 compressed) at 0x00010000 in 30.2 seconds (effective 596.1 kbit/s)... Hash of data verified. Compressed 2097152 bytes to 648160... Writing at 0x00cac000... (100 %)Wrote 2097152 bytes (648160 compressed) at 0x00c10000 in 15.2 seconds (effective 1103.6 kbit/s)... Hash of data verified. Leaving... Hard Resetting... Done! Flashing is complete! Showing logs: [22:23:24] [22:23:24] [22:23:24] --~--~--~-- [22:23:24] FujiNet 0.5.a60a0cbc 2022-01-12 03:23:22 Started @ 4 [22:23:24] Starting heap: 4349996 [22:23:24] Detected Hardware Version: 1.0 [22:23:25] SPIFFS mounted. [22:23:25] SD mounted. [22:23:25] fnConfig::load [22:23:25] Load fnconfig.ini from SD [22:23:25] fnConfig::load read 1165 bytes from config file [22:23:25] Config file dosn't exist on SPIFFS [22:23:25] Copying SD config file to SPIFFS [22:23:25] copy_file "/fnconfig.ini" -> "/fnconfig.ini" [22:23:25] copy_file copied 1165 bytes [22:23:25] Starting SIO2BT [22:23:26] ESP_SPP_INIT_EVT [22:23:26] ESP_SPP_INIT_EVT: client: start [22:23:26] ESP_SPP_START_EVT [22:23:26] Baudrate already at 19200 - nothing to do [22:23:26] disk UNMOUNT [22:23:26] disk MOUNT [22:23:26] ATR MOUNT [22:23:26] mounted ATR: paragraphs=5760, sect_size=128, sect_count=720, disk_size=0 [22:23:26] Creating a default printer using FS_SDFAT storage and type 2 [22:23:26] SSH client initialized. [22:23:26] ModemSniffer::ModemSniffer(FS_SDFAT) [22:23:26] SIO SETUP [22:23:26] Set HSIO baud from 0 to 67431 (index 6), alt=68209 [22:23:26] Available heap: 4193448 [22:23:26] Setup complete @ 1172 (1168ms) Boot / Pair / Kill BT on Mac: Spoiler Using '/dev/cu.usbserial-144320' as serial port. Showing logs: Serial port closed! [22:25:16] [22:25:16] [22:25:16] --~--~--~-- [22:25:16] FujiNet 0.5.a60a0cbc 2022-01-12 03:23:22 Started @ 4 [22:25:16] Starting heap: 4349996 [22:25:16] Detected Hardware Version: 1.0 [22:25:16] SPIFFS mounted. [22:25:17] SD mounted. [22:25:17] fnConfig::load [22:25:17] Load fnconfig.ini from SD [22:25:17] fnConfig::load read 1165 bytes from config file [22:25:17] SPIFFS Config Storage: Enabled [22:25:17] fnConfig::load read 1165 bytes from SPIFFS config file [22:25:17] Starting SIO2BT [22:25:17] ESP_SPP_INIT_EVT [22:25:17] ESP_SPP_INIT_EVT: client: start [22:25:17] ESP_SPP_START_EVT [22:25:17] Baudrate already at 19200 - nothing to do [22:25:17] disk UNMOUNT [22:25:17] disk MOUNT [22:25:17] ATR MOUNT [22:25:17] mounted ATR: paragraphs=5760, sect_size=128, sect_count=720, disk_size=0 [22:25:17] Creating a default printer using FS_SDFAT storage and type 2 [22:25:17] SSH client initialized. [22:25:17] ModemSniffer::ModemSniffer(FS_SDFAT) [22:25:17] SIO SETUP [22:25:17] Set HSIO baud from 0 to 67431 (index 6), alt=68209 [22:25:17] Available heap: 4193720 [22:25:17] Setup complete @ 1035 (1031ms) [22:25:47] W (45006) BT_APPL: new conn_srvc id:26, app_id:255 [22:25:47] ESP_SPP_SRV_OPEN_EVT [22:26:12] W (69406) BT_RFCOMM: port_rfc_closed RFCOMM connection in state 2 closed: Closed (res: 19) [22:26:12] ESP_SPP_CLOSE_EVT [22:26:13] W (70916) BT_RFCOMM: rfc_find_lcid_mcb LCID reused LCID:0x42 current:0x0 [22:26:13] W (70916) BT_RFCOMM: RFCOMM_DisconnectInd LCID:0x42 Neither firmware was any more successful than any other at working with RespeQt. Flashing back to current since I am using this FujiNet at the moment. I'll dig out one of the others and dedicate that one to being the guinea pig. Quote Link to comment Share on other sites More sharing options...
+x=usr(1536) Posted September 14, 2022 Author Share Posted September 14, 2022 Just to add to the above: I set up a Windows 10 Pro VM, attached a Broadcom (BCM20702A0-based) Bluetooth 4.0 USB adapter to it, and retried the test with RespeQt and the same FujiNet on the 600XL. No change. Windows did see the FujiNet as paired, but never booted the disk image (DOS 2.5; known-good) that was mounted in RespeQt. FWIW, with the FujiNet in Bluetooth mode, I'd get several seconds of SIO farting noise followed by a few SIO beeps, followed by infinite SIO farting noise. Well, two minutes' worth, anyway - that was when I finally killed it. I'm somewhat disinclined to call this 100% definitive simply because I was testing with a VM using hardware passthrough, but I'd be willing to go, like, 99.7% Quote Link to comment Share on other sites More sharing options...
mozzwald Posted September 14, 2022 Share Posted September 14, 2022 13 minutes ago, x=usr(1536) said: FWIW, with the FujiNet in Bluetooth mode, I'd get several seconds of SIO farting noise followed by a few SIO beeps, followed by infinite SIO farting noise. Well, two minutes' worth, anyway - that was when I finally killed it. Are you running the modified SIO2BT OS on your Atari which is required? Quote Link to comment Share on other sites More sharing options...
+x=usr(1536) Posted September 14, 2022 Author Share Posted September 14, 2022 3 minutes ago, mozzwald said: Are you running the modified SIO2BT OS on your Atari which is required? *facepalm* No. Thank you for the reminder. Apologies for wasting your time on this. I had completely forgotten about that. It was switchable on the 800XL, which is currently awaiting repair, but not on the 600XL, which is the current daily driver. Pardon me while I go do something far less embarrassing Quote Link to comment Share on other sites More sharing options...
mozzwald Posted September 14, 2022 Share Posted September 14, 2022 1 hour ago, x=usr(1536) said: Thank you for the reminder. We've all been there 1 Quote Link to comment Share on other sites More sharing options...
tschak909 Posted September 18, 2022 Share Posted September 18, 2022 I'm hoping somebody will want to jump in and figure out why using later versions of ESP-IDF with the bluetooth stack overflows memory. It would allow us to retire this branch, and keep the feature that @TheMontezuma put so much love into, in the feature set 100% of the time. Anyone who wishes to try, I can provide guidance. -Thom Quote Link to comment Share on other sites More sharing options...
Recommended Posts
Join the conversation
You can post now and register later. If you have an account, sign in now to post with your account.
Note: Your post will require moderator approval before it will be visible.