Jump to content
Have You Played Atari Today?
2600|5200|7800|Lynx|Jaguar|Forums|Store
IGNORED

Issue using FujiNet to update SIDE3

tsom

By tsom
in #FujiNet SIO Network Adapter

 Share

Recommended Posts

tsom Chopper Commander

tsom

Posted
Posted

This happened the last time I tried updating my Side3 cart. I have the s3loader.xex file on my local tnfs server (Raspberry Pi). I mount the xex into drive slot 1, reboot, then start the update process. It gets partway through then stops updating (with a constant "buzz" sound coming from the monitor speaker). This is part of the syslog from the TNFS server showing where it was going fine, then just started to fail: 

Dec 21 17:13:59 raspberrypi tnfsd[10873]: 192.168.7.95 s=4567 c=21 q=8f | REQUEST cmd=0x21 TNFS_READ
Dec 21 17:13:59 raspberrypi tnfsd[10873]: 192.168.7.95 s=4567 c=21 q=90 | REQUEST cmd=0x21 TNFS_READ
Dec 21 17:13:59 raspberrypi tnfsd[10873]: 192.168.7.95 s=4567 c=21 q=91 | REQUEST cmd=0x21 TNFS_READ
Dec 21 17:14:00 raspberrypi tnfsd[10873]: 192.168.7.95 s=4567 c=21 q=92 | REQUEST cmd=0x21 TNFS_READ
Dec 21 17:14:00 raspberrypi tnfsd[10873]: 192.168.7.95 s=4567 c=21 q=93 | REQUEST cmd=0x21 TNFS_READ
Dec 21 17:14:01 raspberrypi tnfsd[10873]: 192.168.7.95 s=4567 c=21 q=94 | REQUEST cmd=0x21 TNFS_READ
Dec 21 17:14:04 raspberrypi tnfsd[10873]: 192.168.7.95 s=4567 c=21 q=95 | REQUEST cmd=0x21 TNFS_READ
Dec 21 17:14:04 raspberrypi tnfsd[10873]: 192.168.7.95 s=4567 c=21 q=96 | REQUEST cmd=0x21 TNFS_READ
Dec 21 17:14:05 raspberrypi tnfsd[10873]: 192.168.7.95 s=4567 c=21 q=97 | REQUEST cmd=0x21 TNFS_READ
Dec 21 17:14:05 raspberrypi tnfsd[10873]: 192.168.7.95 s=4567 c=21 q=98 | REQUEST cmd=0x21 TNFS_READ
Dec 21 17:14:05 raspberrypi tnfsd[10873]: 192.168.7.95 s=4567 c=21 q=99 | REQUEST cmd=0x21 TNFS_READ
Dec 21 17:14:05 raspberrypi tnfsd[10873]: 192.168.7.95 s=4567 c=21 q=9a | REQUEST cmd=0x21 TNFS_READ
Dec 21 17:14:05 raspberrypi tnfsd[10873]: EOF
Dec 21 17:14:05 raspberrypi tnfsd[10873]: 192.168.7.95 s=4567 c=21 q=9b | REQUEST cmd=0x21 TNFS_READ
Dec 21 17:14:05 raspberrypi tnfsd[10873]: EOF
Dec 21 17:14:05 raspberrypi tnfsd[10873]: 192.168.7.95 s=4567 c=21 q=9c | REQUEST cmd=0x21 TNFS_READ
Dec 21 17:14:05 raspberrypi tnfsd[10873]: EOF
Dec 21 17:14:05 raspberrypi tnfsd[10873]: 192.168.7.95 s=4567 c=21 q=9d | REQUEST cmd=0x21 TNFS_READ
Dec 21 17:14:05 raspberrypi tnfsd[10873]: EOF
Dec 21 17:14:05 raspberrypi tnfsd[10873]: 192.168.7.95 s=4567 c=21 q=9e | REQUEST cmd=0x21 TNFS_READ
Dec 21 17:14:05 raspberrypi tnfsd[10873]: EOF
Dec 21 17:14:05 raspberrypi tnfsd[10873]: 192.168.7.95 s=4567 c=21 q=9f | REQUEST cmd=0x21 TNFS_READ
Dec 21 17:14:05 raspberrypi tnfsd[10873]: EOF
Dec 21 17:14:05 raspberrypi tnfsd[10873]: 192.168.7.95 s=4567 c=21 q=a0 | REQUEST cmd=0x21 TNFS_READ
Dec 21 17:14:05 raspberrypi tnfsd[10873]: EOF
Dec 21 17:14:05 raspberrypi tnfsd[10873]: 192.168.7.95 s=4567 c=21 q=a1 | REQUEST cmd=0x21 TNFS_READ
Dec 21 17:14:05 raspberrypi tnfsd[10873]: EOF
Dec 21 17:14:05 raspberrypi tnfsd[10873]: 192.168.7.95 s=4567 c=21 q=a2 | REQUEST cmd=0x21 TNFS_READ
Dec 21 17:14:05 raspberrypi tnfsd[10873]: EOF
Dec 21 17:14:06 raspberrypi tnfsd[10873]: 192.168.7.95 s=4567 c=21 q=a3 | REQUEST cmd=0x21 TNFS_READ
Dec 21 17:14:06 raspberrypi tnfsd[10873]: EOF
Dec 21 17:14:06 raspberrypi tnfsd[10873]: 192.168.7.95 s=4567 c=21 q=a4 | REQUEST cmd=0x21 TNFS_READ
Dec 21 17:14:06 raspberrypi tnfsd[10873]: EOF
Dec 21 17:14:06 raspberrypi tnfsd[10873]: 192.168.7.95 s=4567 c=21 q=a5 | REQUEST cmd=0x21 TNFS_READ
Dec 21 17:14:06 raspberrypi tnfsd[10873]: EOF
Dec 21 17:14:06 raspberrypi tnfsd[10873]: 192.168.7.95 s=4567 c=21 q=a6 | REQUEST cmd=0x21 TNFS_READ
Dec 21 17:14:06 raspberrypi tnfsd[10873]: EOF
Dec 21 17:14:06 raspberrypi tnfsd[10873]: 192.168.7.95 s=4567 c=21 q=a7 | REQUEST cmd=0x21 TNFS_READ

The last time it happened, I rebooted, and ran the updater again and it seemed to go fine. I'm going to try again, but make sure I have the debug window open.

The second time it completed, but seemed to have problems part way through. This is part of the debug log:

  

[17:20:37]disk sio_process()
[17:20:37]ACK!
[17:20:37]XEX READ (539)
[17:20:37]requesting 253 bytes from XEX
[17:20:37]received 253 bytes
[17:20:37]->SIO write 256 bytes
[17:20:37]COMPLETE!
[17:20:37]
[17:20:37]CF: 31 52 1c 02 a1
[17:20:37]disk sio_process()
[17:20:37]ACK!
[17:20:37]XEX READ (540)
[17:20:37]requesting 253 bytes from XEX
[17:20:37]received 253 bytes
[17:20:37]->SIO write 256 bytes
[17:20:37]COMPLETE!
[17:20:37]
[17:20:37]CF: 31 52 1d 02 a2
[17:20:37]disk sio_process()
[17:20:37]ACK!
[17:20:37]XEX READ (541)
[17:20:37]requesting 253 bytes from XEX
[17:20:39]Timeout after 2000 milliseconds. Retrying
[17:20:40]TNFS OUT OF ORDER SEQUENCE! RETRYING
[17:20:42]Timeout after 2000 milliseconds. Retrying
[17:20:43]TNFS OUT OF ORDER SEQUENCE! RETRYING
[17:20:45]Timeout after 2000 milliseconds. Retrying
[17:20:46]TNFS OUT OF ORDER SEQUENCE! RETRYING
[17:20:46]received 253 bytes
[17:20:46]->SIO write 256 bytes
[17:20:46]COMPLETE!
[17:20:54]
[17:20:54]CF: 31 52 1d 02 a2
[17:20:54]disk sio_process()
[17:20:54]ACK!
[17:20:54]XEX READ (541)
[17:20:54]seeking to offset 43516 in XEX
[17:20:54]tnfs_lseek currpos=43776, pos=43008, typ=0
[17:20:54]_tnfs_cache_seek current=43776, destination=43008, cache_start=43520, cache_end=44032
[17:20:54]_tnfs_cache_seek outside cached region
[17:20:56]Timeout after 2000 milliseconds. Retrying
[17:20:57]TNFS OUT OF ORDER SEQUENCE! RETRYING
[17:20:59]Timeout after 2000 milliseconds. Retrying
[17:21:00]TNFS OUT OF ORDER SEQUENCE! RETRYING
[17:21:00]tnfs_lseek success, new pos=43008, response pos=168
[17:21:00]CALCULATED AND RESPONSE POS DON'T MATCH!
[17:21:07]Timeout after 2000 milliseconds. Retrying
[17:21:08]TNFS OUT OF ORDER SEQUENCE! RETRYING
[17:21:08]tnfs_lseek currpos=43136, pos=43008, typ=0
[17:21:08]_tnfs_cache_seek current=43136, destination=43008, cache_start=43008, cache_end=43520
[17:21:08]_tnfs_cache_seek within cached region
[17:21:08]tnfs_lseek currpos=43008, pos=43516, typ=0
[17:21:08]_tnfs_cache_seek current=43008, destination=43516, cache_start=43008, cache_end=43520
[17:21:08]_tnfs_cache_seek within cached region
[17:21:08]requesting 253 bytes from XEX
[17:21:08]received 253 bytes
[17:21:08]->SIO write 256 bytes
[17:21:08]COMPLETE!
[17:21:08]
[17:21:08]CF: 31 52 1d 02 a2
[17:21:08]disk sio_process()
[17:21:08]ACK!
[17:21:08]XEX READ (541)
[17:21:08]seeking to offset 43516 in XEX
[17:21:08]tnfs_lseek currpos=43772, pos=43008, typ=0
[17:21:08]_tnfs_cache_seek current=43772, destination=43008, cache_start=43520, cache_end=44032
[17:21:08]_tnfs_cache_seek outside cached region
[17:21:08]tnfs_lseek success, new pos=43008, response pos=43008
[17:21:08]tnfs_lseek currpos=43136, pos=43008, typ=0
[17:21:08]_tnfs_cache_seek current=43136, destination=43008, cache_start=43008, cache_end=43520
[17:21:08]_tnfs_cache_seek within cached region
[17:21:08]tnfs_lseek currpos=43008, pos=43516, typ=0
[17:21:08]_tnfs_cache_seek current=43008, destination=43516, cache_start=43008, cache_end=43520
[17:21:08]_tnfs_cache_seek within cached region
[17:21:08]requesting 253 bytes from XEX
[17:21:08]received 253 bytes
[17:21:08]->SIO write 256 bytes
[17:21:08]COMPLETE!
[17:21:08]
[17:21:08]CF: 31 52 1e 02 a3
[17:21:08]disk sio_process()
[17:21:08]ACK!
[17:21:08]XEX READ (542)
[17:21:08]requesting 253 bytes from XEX
[17:21:08]received 253 bytes
[17:21:08]->SIO write 256 bytes
[17:21:08]COMPLETE!
[17:21:08]
[17:21:08]CF: 31 52 1f 02 a4
[17:21:08]disk sio_process()
[17:21:08]ACK!
[17:21:08]XEX READ (543)
[17:21:08]requesting 253 bytes from XEX
[17:21:08]received 253 bytes
[17:21:08]->SIO write 256 bytes
[17:21:08]COMPLETE!
[17:21:08]
[17:21:08]CF: 31 52 20 02 a5
[17:21:08]disk sio_process()
[17:21:08]ACK!
[17:21:08]XEX READ (544)
[17:21:08]requesting 253 bytes from XEX
[17:21:08]received 253 bytes
[17:21:08]->SIO write 256 bytes
[17:21:08]COMPLETE!
[17:21:08]
[17:21:08]CF: 31 52 21 02 a6
[17:21:08]disk sio_process()
[17:21:08]ACK!
[17:21:08]XEX READ (545)
[17:21:08]requesting 253 bytes from XEX
[17:21:08]received 253 bytes
[17:21:08]->SIO write 256 bytes
[17:21:08]COMPLETE!
[17:21:09]
[17:21:09]CF: 31 52 22 02 a7
[17:21:09]disk sio_process()
[17:21:09]ACK!
[17:21:09]XEX READ (546)
[17:21:09]requesting 253 bytes from XEX
[17:21:09]received 253 bytes
[17:21:09]->SIO write 256 bytes
[17:21:09]COMPLETE!

 

Link to comment
https://forums.atariage.com/topic/314908-issue-using-fujinet-to-update-side3/
Share on other sites
tsom Chopper Commander

tsom

Posted
  • Author
Posted
1 hour ago, DrVenkman said:

I have not tried to duplicate this issue, but why not update your SIDE3 from SIDE3 itself? Isn’t that how Jon suggests you do it? 

Because it's easier to transfer the SIDE3 updater .xex to my TNFS server, then pull the sd card out of the SIDE3, get my laptop with SD Card reader, copy to sd card, then do the update....

 

All it's doing is reading the data from the file, I assume, so not sure why the FujiNet is having so many timeout issues.

DrVenkman Quadrunner

+DrVenkman

Posted
Posted

I’m going to go out on a limb and suggest you have a problem with your RPi server, your LAN or your Atari. I just moments ago updated my SIDE3 from my FujiNet. My local server is running on a Raspberry Pi Zero W.

 

 

07E81E0A-E43A-4837-9821-32A8558E3D8F.jpeg

E1C209A8-8024-4C56-8703-BCFF229085B1.jpeg

tsom Chopper Commander

tsom

Posted
  • Author
Posted

Yeah I’m not sure where the issue is. If I reboot and rerun the updated it will usually run just fine. I do see some slowness connecting to the rPi in general sometimes.. just selecting it from the host slot sometimes it will come right up, others it will take a bit of time. My wifi access point (an eero-the base station connected to the cable modem), the RPi and the FujiNet are all within about 5’ of each other. 

  • 1 year later...
macsonny Dragonstomper

macsonny

Posted
Posted
On 12/25/2020 at 1:07 PM, DrVenkman said:

I’m going to go out on a limb and suggest you have a problem with your RPi server, your LAN or your Atari. I just moments ago updated my SIDE3 from my FujiNet. My local server is running on a Raspberry Pi Zero W.

 

 

07E81E0A-E43A-4837-9821-32A8558E3D8F.jpeg

E1C209A8-8024-4C56-8703-BCFF229085B1.jpeg

How did you get the FujiNet to boot with the Side cart installed. My boot sequence causes the Side to always load before the FujiNet so can’t get to the flash app?

_The Doctor__ Quadrunner

_The Doctor__

Posted
Posted

Maybe letting him know more about you system, firmware levels and if the fujinet is externally powered/SIO powered...

also consider including the debug output from the fujinet...

 

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.

Guest
Reply to this topic...

×   Pasted as rich text.   Paste as plain text instead

  Only 75 emoji are allowed.

×   Your link has been automatically embedded.   Display as a link instead

×   Your previous content has been restored.   Clear editor

×   You cannot paste images directly. Upload or insert images from URL.

Loading...
×
 Share
Go to topic listing

  • Recently Browsing   0 members

    • No registered users viewing this page.
AtariAge
Forums
Store
General
Follow AtariAge

Copyright ©1998-2023 AtariAge

×
×
  • Create New...