modemwars/swiftlink/testLogs/realtimeRun2400first.txt
2026-08-23 02:09:40 -05:00

831 lines
31 KiB
Text

relay on 127.0.0.1:60019
[A] >>> warp on
(C:$ee60) (C:$ee60)
[B] >>> warp on
(C:$eea9) (C:$eea9)
[A] >>> break 0800
BREAK: 1 C:$0800 (Stop on exec)
(C:$ee60)
[A] loading under warp ...
[A] #1 (Stop on exec 0800) 16/$010, 15/$0f
.C:0800 4C 6C 0A JMP $0A6C - A:41 X:00 Y:02 SP:fe .V-B...C 73184750
(C:$0800)
[A] >>> del
Deleting all checkpoints
(C:$0800)
[A] >>> resourceset "WarpMode" "0"
Unknown resource "WarpMode".
(C:$0800)
[A] >>> resourceset "Warp" "0"
Unknown resource "Warp".
(C:$0800)
[A] >>> resourceset "WarpModeEnabled" "0"
Unknown resource "WarpModeEnabled".
(C:$0800)
[B] >>> break 0800
BREAK: 1 C:$0800 (Stop on exec)
(C:$eea9)
[B] loading under warp ...
[B] #1 (Stop on exec 0800) 15/$00f, 55/$37
.C:0800 4C 6C 0A JMP $0A6C - A:C7 X:00 Y:02 SP:fe NV-B...C 73218915
(C:$0800)
[B] >>> del
Deleting all checkpoints
(C:$0800)
[B] >>> resourceset "WarpMode" "0"
Unknown resource "WarpMode".
(C:$0800)
[B] >>> resourceset "Warp" "0"
Unknown resource "Warp".
(C:$0800)
[B] >>> resourceset "WarpModeEnabled" "0"
Unknown resource "WarpModeEnabled".
(C:$0800)
[A] >>> warp off
(C:$fd5f)
[A] >>> warp
Warp mode is off.
(C:$fd5f)
[A] Warp mode is off.
(C:$fd5f)
[B] >>> warp off
(C:$fd68)
[B] >>> warp
Warp mode is off.
(C:$fd68)
[B] Warp mode is off.
(C:$fd68)
[A] >>> screenshot "/home/scott/claude/modemwars/swiftlink/shots/rtb01aMenu.png" 2
(C:$4e44)
[A] shot /home/scott/claude/modemwars/swiftlink/shots/rtb01aMenu.png
[B] >>> screenshot "/home/scott/claude/modemwars/swiftlink/shots/rtb01bMenu.png" 2
(C:$5ff6)
[B] shot /home/scott/claude/modemwars/swiftlink/shots/rtb01bMenu.png
[A] >>> m 91d5 91d5
(C:$c699)
[A] >>> m 91d5 91d5
>C:91d5 01 .
(C:$91d6)
[A] menu row = 1
[A] >>> m 91d5 91d5
(C:$4e49)
[A] >>> m 91d5 91d5
>C:91d5 01 .
(C:$91d6)
[A] menu row = 1
[A] >>> m 91d5 91d5
(C:$6091) >C:91d5
[A] >>> m 91d5 91d5
00 .
(C:$91d6)
[A] >>> m 91d5 91d5
>C:91d5 00 .
(C:$91d6)
[A] menu row = 0
[B] >>> m 91d5 91d5
(C:$0eb1) >C:91d5 01
[B] menu row = 1
[B] >>> m 91d5 91d5
(C:$60b7) >C:91d5 00
[B] menu row = 0
[A] >>> m e013 e014
>C:e013 b7 0d ..
(C:$e015)
[A] >>> m e03b e047
>C:e03b 00 00 00 00 00 00 00 00 e0 01 d0 03 4c ............L
(C:$e048)
[A] >>> m e0a5 e0a5
>C:e0a5 20
(C:$e0a6)
[A] >>> m e055 e056
>C:e055 c0 8d ..
(C:$e057)
[A] >>> m e5bb e5be
>C:e5bb e8 84 18 ac ....
(C:$e5bf)
[A] >>> m de00 de03
>C:de00 00 30 00 00 .0..
(C:$de04)
[A] >>> m eab7 eab7
>C:eab7 88 .
(C:$eab8)
[A] >>> m 0b7d 0b7d
>C:0b7d 00 .
(C:$0b7e)
[A] phase=0 isLinkActive=0 linkErrorCount=76 linkStatus=$00 baudIndex=192 $DE03=$00 $DE01=$30 $DE02=$00 bitPeriodLo=$8D statusSave=$84 cmdShadow=$AC txCharActive=$E8 uartPending=$20 syncRound=$88 lastHotkey=$03 lockout=0
[A] >>> m e013 e014
>C:e013 b2 e3 ..
(C:$e015)
[A] the module's keyboard vector is still [178, 227] - waiting
[A] >>> m e013 e014
>C:e013 b7 0d ..
(C:$e015)
[A] >>> m e03b e047
>C:e03b 00 00 00 00 00 00 00 00 00 00 44 ff 48 ..........D.H
(C:$e048)
[A] >>> m e0a5 e0a5
>C:e0a5 00 .
(C:$e0a6)
[A] >>> m e055 e056
>C:e055 06 18 ..
(C:$e057)
[A] >>> m e5bb e5be
>C:e5bb 00 00 00 00 ....
(C:$e5bf)
[A] >>> m de00 de03
>C:de00 00 30 00 18 .0..
(C:$de04)
[A] >>> m eab7 eab7
>C:eab7 00 .
(C:$eab8)
[A] >>> m 0b7d 0b7d
>C:0b7d 00 .
(C:$0b7e)
[A] phase=0 isLinkActive=0 linkErrorCount=72 linkStatus=$00 baudIndex=6 $DE03=$18 $DE01=$30 $DE02=$00 bitPeriodLo=$18 statusSave=$00 cmdShadow=$00 txCharActive=$00 uartPending=$00 syncRound=$00 lastHotkey=$FF lockout=0
[A] 2400 baud selected before the link was opened
[B] >>> m e013 e014
>C:e013 b7 0d ..
(C:$e015)
[B] >>> m e03b e047
>C:e03b 00 00 00 00 00 00 00 00 00 00 44 ff 48 ..........D.H
(C:$e048)
[B] >>> m e0a5 e0a5
>C:e0a5 00 .
(C:$e0a6)
[B] >>> m e055 e056
>C:e055 06 18 ..
(C:$e057)
[B] >>> m e5bb e5be
>C:e5bb 00 00 00 00 ....
(C:$e5bf)
[B] >>> m de00 de03
>C:de00 00 30 00 18 .0..
(C:$de04)
[B] >>> m eab7 eab7
>C:eab7 00 .
(C:$eab8)
[B] >>> m 0b7d 0b7d
>C:0b7d 00 .
(C:$0b7e)
[B] phase=0 isLinkActive=0 linkErrorCount=72 linkStatus=$00 baudIndex=6 $DE03=$18 $DE01=$30 $DE02=$00 bitPeriodLo=$18 statusSave=$00 cmdShadow=$00 txCharActive=$00 uartPending=$00 syncRound=$00 lastHotkey=$FF lockout=0
[B] 2400 baud selected before the link was opened
[A] >>> m e5be e5be
(C:$0950)
[A] >>> m e5be e5be
>C:e5be 00 .
(C:$e5bf) >C:e5be 00 .
(C:$e5bf)
[relay] connection 1
[A] >>> m e5be e5be
(C:$6651) >C:e5be 09
[A] link opened after 2 attempt(s), command register = $09
[B] >>> m e5be e5be
(C:$0950)
[B] >>> m e5be e5be
>C:e5be 00 .
(C:$e5bf) >C:e5be 00 .
(C:$e5bf)
[relay] connection 2
[B] >>> m e5be e5be
(C:$1286)
[B] >>> m e5be e5be
>C:e5be 09 .
(C:$e5bf)
[B] link opened after 2 attempt(s), command register = $09
[A] >>> m e040 e040
>C:e040 02 .
(C:$e041)
[B] >>> m e040 e040
>C:e040 01 .
(C:$e041)
phases: {'A': 2, 'B': 1}
[A] >>> m e040 e040
>C:e040 03 .
(C:$e041)
[B] >>> m e040 e040
>C:e040 03 .
(C:$e041)
phases: {'A': 3, 'B': 3}
both in the packet phase: True ({'A': 3, 'B': 3})
[A] >>> screenshot "/home/scott/claude/modemwars/swiftlink/shots/rtb02aLinked.png" 2
(C:$12e8)
[A] shot /home/scott/claude/modemwars/swiftlink/shots/rtb02aLinked.png
[B] >>> screenshot "/home/scott/claude/modemwars/swiftlink/shots/rtb02bLinked.png" 2
(C:$e529)
[B] shot /home/scott/claude/modemwars/swiftlink/shots/rtb02bLinked.png
[A] >>> trace exec $e403
TRACE: 1 C:$e403 (Trace exec)
(C:$116a)
[A] >>> break
TRACE: 1 C:$e403 (Trace exec)
(C:$116a)
[B] >>> trace exec $e403
TRACE: 1 C:$e403 (Trace exec)
(C:$124f)
[B] >>> break
TRACE: 1 C:$e403 (Trace exec)
(C:$124f)
[A] >>> m e03b e047
>C:e03b 01 f8 f8 00 00 03 00 00 00 02 07 ff 00 .............
(C:$e048)
[A] >>> m e0a5 e0a5
>C:e0a5 00 .
(C:$e0a6)
[A] >>> m e055 e056
>C:e055 06 18 ..
(C:$e057)
[A] >>> m e5bb e5be
>C:e5bb 00 98 55 09 ..U.
(C:$e5bf)
[A] >>> m de00 de03
>C:de00 55 10 09 18 U...
(C:$de04)
[A] >>> m eab7 eab7
>C:eab7 02 .
(C:$eab8)
[A] >>> m 0b7d 0b7d
>C:0b7d 00 .
(C:$0b7e)
[B] >>> m e03b e047
>C:e03b 01 f8 f8 00 00 02 00 00 00 02 14 ff 00 .............
(C:$e048)
[B] >>> m e0a5 e0a5
>C:e0a5 01 .
(C:$e0a6)
[B] >>> m e055 e056
>C:e055 06 18 ..
(C:$e057)
[B] >>> m e5bb e5be
>C:e5bb 01 90 55 05 ..U.
(C:$e5bf)
[B] >>> m de00 de03
>C:de00 55 10 05 18 U...
(C:$de04)
[B] >>> m eab7 eab7
>C:eab7 00 .
(C:$eab8)
[B] >>> m 0b7d 0b7d
>C:0b7d 00 .
(C:$0b7e)
[A] phase=3 isLinkActive=1 linkErrorCount=0 linkStatus=$F8 baudIndex=6 $DE03=$18 $DE01=$10 $DE02=$09 bitPeriodLo=$18 statusSave=$98 cmdShadow=$09 txCharActive=$00 uartPending=$00 syncRound=$02 lastHotkey=$FF lockout=0
[B] phase=2 isLinkActive=1 linkErrorCount=0 linkStatus=$F8 baudIndex=6 $DE03=$18 $DE01=$10 $DE02=$05 bitPeriodLo=$18 statusSave=$90 cmdShadow=$05 txCharActive=$01 uartPending=$01 syncRound=$00 lastHotkey=$FF lockout=0
[A] >>> stopwatch
Stopwatch: 244766993
(C:$6640)
[B] >>> stopwatch
Stopwatch: 181874487
(C:$129f)
[A] >>> stopwatch
Stopwatch: 322327006
(C:$1225)
[B] >>> stopwatch
Stopwatch: 259143886
(C:$129f)
=== window '2400 baud': 75.14 s wall ===
[A] 77560013 emulated cycles = 75.84 emulated seconds = 100.9% of real time
[B] 77269399 emulated cycles = 75.55 emulated seconds = 100.6% of real time
conn0 -> peer: 0 bytes in 75.14 s = 0.00 bytes/s = 0 bit/s of 8N1 line time; wire: {'bytes': 0, 'zeroRuns8': 0, 'longestZeroRun': 0, 'leadBytes55': 0}
conn1 -> peer: 4495 bytes in 75.14 s = 59.82 bytes/s = 598 bit/s of 8N1 line time; wire: {'bytes': 4495, 'zeroRuns8': 1, 'longestZeroRun': 4495, 'leadBytes55': 0}
window '2400 baud' was not usable (speeds {'A': 1.009296186463543, 'B': 1.0055143974902363}, counts [0, 4495]) - measuring again
[A] >>> m e040 e040
>C:e040 02 .
(C:$e041)
[B] >>> m e040 e040
>C:e040 02 .
(C:$e041)
phases: {'A': 2, 'B': 2}
[A] >>> m e040 e040
>C:e040 02 .
(C:$e041)
[B] >>> m e040 e040
>C:e040 02 .
(C:$e041)
phases: {'A': 2, 'B': 2}
[A] >>> m e040 e040
>C:e040 02 .
(C:$e041)
[B] >>> m e040 e040
>C:e040 02 .
(C:$e041)
phases: {'A': 2, 'B': 2}
[A] >>> m e040 e040
>C:e040 02 .
(C:$e041)
[B] >>> m e040 e040
>C:e040 02 .
(C:$e041)
phases: {'A': 2, 'B': 2}
[A] >>> m e040 e040
>C:e040 02 .
(C:$e041)
[B] >>> m e040 e040
>C:e040 02 .
(C:$e041)
phases: {'A': 2, 'B': 2}
[A] >>> m e040 e040
>C:e040 02 .
(C:$e041)
[B] >>> m e040 e040
>C:e040 02 .
(C:$e041)
phases: {'A': 2, 'B': 2}
[A] >>> m e040 e040
>C:e040 02 .
(C:$e041)
[B] >>> m e040 e040
>C:e040 02 .
(C:$e041)
phases: {'A': 2, 'B': 2}
[A] >>> m e040 e040
>C:e040 02 .
(C:$e041)
[B] >>> m e040 e040
>C:e040 02 .
(C:$e041)
phases: {'A': 2, 'B': 2}
[A] >>> m e040 e040
>C:e040 02 .
(C:$e041)
[B] >>> m e040 e040
>C:e040 02 .
(C:$e041)
phases: {'A': 2, 'B': 2}
[A] >>> m e040 e040
>C:e040 02 .
(C:$e041)
[B] >>> m e040 e040
>C:e040 02 .
(C:$e041)
phases: {'A': 2, 'B': 2}
[A] >>> m e040 e040
>C:e040 02 .
(C:$e041)
[B] >>> m e040 e040
>C:e040 02 .
(C:$e041)
phases: {'A': 2, 'B': 2}
[A] >>> m e040 e040
>C:e040 02 .
(C:$e041)
[B] >>> m e040 e040
>C:e040 02 .
(C:$e041)
phases: {'A': 2, 'B': 2}
[A] >>> m e040 e040
>C:e040 02 .
(C:$e041)
[B] >>> m e040 e040
>C:e040 02 .
(C:$e041)
phases: {'A': 2, 'B': 2}
[A] >>> m e040 e040
>C:e040 02 .
(C:$e041)
[B] >>> m e040 e040
>C:e040 02 .
(C:$e041)
phases: {'A': 2, 'B': 2}
[A] >>> m e040 e040
>C:e040 02 .
(C:$e041)
[B] >>> m e040 e040
>C:e040 02 .
(C:$e041)
phases: {'A': 2, 'B': 2}
[A] >>> m e040 e040
>C:e040 02 .
(C:$e041)
[B] >>> m e040 e040
>C:e040 02 .
(C:$e041)
phases: {'A': 2, 'B': 2}
[A] >>> m e040 e040
>C:e040 02 .
(C:$e041)
[B] >>> m e040 e040
>C:e040 02 .
(C:$e041)
phases: {'A': 2, 'B': 2}
[A] >>> stopwatch
Stopwatch: 404588146
(C:$6640)
[B] >>> stopwatch
Stopwatch: 341046031
(C:$129f)
[A] >>> stopwatch
Stopwatch: 482165257
(C:$c8eb)
[B] >>> stopwatch
Stopwatch: 418315433
(C:$129f)
=== window '2400 baud': 75.14 s wall ===
[A] 77577111 emulated cycles = 75.85 emulated seconds = 100.9% of real time
[B] 77269402 emulated cycles = 75.55 emulated seconds = 100.5% of real time
conn0 -> peer: 0 bytes in 75.14 s = 0.00 bytes/s = 0 bit/s of 8N1 line time; wire: {'bytes': 0, 'zeroRuns8': 0, 'longestZeroRun': 0, 'leadBytes55': 0}
conn1 -> peer: 4495 bytes in 75.14 s = 59.82 bytes/s = 598 bit/s of 8N1 line time; wire: {'bytes': 4495, 'zeroRuns8': 1, 'longestZeroRun': 4495, 'leadBytes55': 0}
window '2400 baud' was not usable (speeds {'A': 1.0094991191865907, 'B': 1.0054949488783436}, counts [0, 4495]) - measuring again
[A] >>> m e040 e040
>C:e040 02 .
(C:$e041)
[B] >>> m e040 e040
>C:e040 02 .
(C:$e041)
phases: {'A': 2, 'B': 2}
[A] >>> m e040 e040
>C:e040 02 .
(C:$e041)
[B] >>> m e040 e040
>C:e040 02 .
(C:$e041)
phases: {'A': 2, 'B': 2}
[A] >>> m e040 e040
>C:e040 02 .
(C:$e041)
[B] >>> m e040 e040
>C:e040 02 .
(C:$e041)
phases: {'A': 2, 'B': 2}
[A] >>> m e040 e040
>C:e040 02 .
(C:$e041)
[B] >>> m e040 e040
>C:e040 02 .
(C:$e041)
phases: {'A': 2, 'B': 2}
[A] >>> m e040 e040
>C:e040 02 .
(C:$e041)
[B] >>> m e040 e040
>C:e040 02 .
(C:$e041)
phases: {'A': 2, 'B': 2}
[A] >>> m e040 e040
>C:e040 02 .
(C:$e041)
[B] >>> m e040 e040
>C:e040 02 .
(C:$e041)
phases: {'A': 2, 'B': 2}
[A] >>> m e040 e040
>C:e040 02 .
(C:$e041)
[B] >>> m e040 e040
>C:e040 02 .
(C:$e041)
phases: {'A': 2, 'B': 2}
[A] >>> m e040 e040
>C:e040 02 .
(C:$e041)
[B] >>> m e040 e040
>C:e040 02 .
(C:$e041)
phases: {'A': 2, 'B': 2}
[A] >>> m e040 e040
>C:e040 02 .
(C:$e041)
[B] >>> m e040 e040
>C:e040 02 .
(C:$e041)
phases: {'A': 2, 'B': 2}
[A] >>> m e040 e040
>C:e040 02 .
(C:$e041)
[B] >>> m e040 e040
>C:e040 02 .
(C:$e041)
phases: {'A': 2, 'B': 2}
[A] >>> m e040 e040
>C:e040 02 .
(C:$e041)
[B] >>> m e040 e040
>C:e040 02 .
(C:$e041)
phases: {'A': 2, 'B': 2}
[A] >>> m e040 e040
>C:e040 02 .
(C:$e041)
[B] >>> m e040 e040
>C:e040 02 .
(C:$e041)
phases: {'A': 2, 'B': 2}
[A] >>> m e040 e040
>C:e040 02 .
(C:$e041)
[B] >>> m e040 e040
>C:e040 02 .
(C:$e041)
phases: {'A': 2, 'B': 2}
[A] >>> m e040 e040
>C:e040 02 .
(C:$e041)
[B] >>> m e040 e040
>C:e040 02 .
(C:$e041)
phases: {'A': 2, 'B': 2}
[A] >>> m e040 e040
>C:e040 02 .
(C:$e041)
[B] >>> m e040 e040
>C:e040 02 .
(C:$e041)
phases: {'A': 2, 'B': 2}
[A] >>> m e040 e040
>C:e040 02 .
(C:$e041)
[B] >>> m e040 e040
>C:e040 02 .
(C:$e041)
phases: {'A': 2, 'B': 2}
[A] >>> m e040 e040
>C:e040 02 .
(C:$e041)
[B] >>> m e040 e040
>C:e040 02 .
(C:$e041)
phases: {'A': 2, 'B': 2}
[A] >>> stopwatch
Stopwatch: 564477682
(C:$6640)
[B] >>> stopwatch
Stopwatch: 500285959
(C:$129f)
[A] >>> stopwatch
Stopwatch: 642054790
(C:$0e44)
[B] >>> stopwatch
Stopwatch: 577555356
(C:$129f)
=== window '2400 baud': 75.15 s wall ===
[A] 77577108 emulated cycles = 75.85 emulated seconds = 100.9% of real time
[B] 77269397 emulated cycles = 75.55 emulated seconds = 100.5% of real time
conn0 -> peer: 0 bytes in 75.15 s = 0.00 bytes/s = 0 bit/s of 8N1 line time; wire: {'bytes': 0, 'zeroRuns8': 0, 'longestZeroRun': 0, 'leadBytes55': 0}
conn1 -> peer: 4495 bytes in 75.15 s = 59.81 bytes/s = 598 bit/s of 8N1 line time; wire: {'bytes': 4495, 'zeroRuns8': 1, 'longestZeroRun': 4495, 'leadBytes55': 0}
[A] >>> m e03b e047
>C:e03b 01 f8 f8 00 00 02 00 00 00 02 02 ff 00 .............
(C:$e048)
[A] >>> m e0a5 e0a5
>C:e0a5 03 .
(C:$e0a6)
[A] >>> m e055 e056
>C:e055 06 18 ..
(C:$e057)
[A] >>> m e5bb e5be
>C:e5bb 01 98 00 09 ....
(C:$e5bf)
[A] >>> m de00 de03
>C:de00 00 10 09 18 ....
(C:$de04)
[A] >>> m eab7 eab7
>C:eab7 09 .
(C:$eab8)
[A] >>> m 0b7d 0b7d
>C:0b7d 00 .
(C:$0b7e)
[B] >>> m e03b e047
>C:e03b 01 78 78 00 00 02 00 00 00 02 f8 ff 00 .xx..........
(C:$e048)
[B] >>> m e0a5 e0a5
>C:e0a5 01 .
(C:$e0a6)
[B] >>> m e055 e056
>C:e055 06 18 ..
(C:$e057)
[B] >>> m e5bb e5be
>C:e5bb 01 90 55 05 ..U.
(C:$e5bf)
[B] >>> m de00 de03
>C:de00 55 10 05 18 U...
(C:$de04)
[B] >>> m eab7 eab7
>C:eab7 00 .
(C:$eab8)
[B] >>> m 0b7d 0b7d
>C:0b7d 00 .
(C:$0b7e)
[A] phase=2 isLinkActive=1 linkErrorCount=0 linkStatus=$F8 baudIndex=6 $DE03=$18 $DE01=$10 $DE02=$09 bitPeriodLo=$18 statusSave=$98 cmdShadow=$09 txCharActive=$01 uartPending=$03 syncRound=$09 lastHotkey=$FF lockout=0
[B] phase=2 isLinkActive=1 linkErrorCount=0 linkStatus=$78 baudIndex=6 $DE03=$18 $DE01=$10 $DE02=$05 bitPeriodLo=$18 statusSave=$90 cmdShadow=$05 txCharActive=$01 uartPending=$01 syncRound=$00 lastHotkey=$FF lockout=0
[A] transmitter deadlock: clearing txCharActive $E5BB from the monitor
[A] >>> > e5bb 00
(C:$c8eb)
15 s after clearing txCharActive: conn0 37 bytes, conn1 98 bytes
[A] >>> screenshot "/home/scott/claude/modemwars/swiftlink/shots/rtb03aAfterFirst.png" 2
(C:$1331)
[A] shot /home/scott/claude/modemwars/swiftlink/shots/rtb03aAfterFirst.png
[B] >>> screenshot "/home/scott/claude/modemwars/swiftlink/shots/rtb03bAfterFirst.png" 2
(C:$1331)
[B] shot /home/scott/claude/modemwars/swiftlink/shots/rtb03bAfterFirst.png
[A] >>> m e03b e047
>C:e03b 01 78 78 00 00 03 00 00 00 02 f8 ff 00 .xx..........
(C:$e048)
[A] >>> m e0a5 e0a5
>C:e0a5 00 .
(C:$e0a6)
[A] >>> m e055 e056
>C:e055 00 15 ..
(C:$e057)
[A] >>> m e5bb e5be
>C:e5bb 00 98 53 09 ..S.
(C:$e5bf)
[A] >>> m de00 de03
>C:de00 53 10 09 15 S...
(C:$de04)
[A] >>> m eab7 eab7
>C:eab7 04 .
(C:$eab8)
[A] >>> m 0b7d 0b7d
>C:0b7d 00 .
(C:$0b7e)
[B] >>> m e03b e047
>C:e03b 01 78 78 00 00 03 00 00 00 02 f8 ff 00 .xx..........
(C:$e048)
[B] >>> m e0a5 e0a5
>C:e0a5 00 .
(C:$e0a6)
[B] >>> m e055 e056
>C:e055 00 15 ..
(C:$e057)
[B] >>> m e5bb e5be
>C:e5bb 00 90 d7 09 ....
(C:$e5bf)
[B] >>> m de00 de03
>C:de00 d7 10 09 15 ....
(C:$de04)
[B] >>> m eab7 eab7
>C:eab7 03 .
(C:$eab8)
[B] >>> m 0b7d 0b7d
>C:0b7d 00 .
(C:$0b7e)
[A] phase=3 isLinkActive=1 linkErrorCount=0 linkStatus=$78 baudIndex=0 $DE03=$15 $DE01=$10 $DE02=$09 bitPeriodLo=$15 statusSave=$98 cmdShadow=$09 txCharActive=$00 uartPending=$00 syncRound=$04 lastHotkey=$FF lockout=0
[B] phase=3 isLinkActive=1 linkErrorCount=0 linkStatus=$78 baudIndex=0 $DE03=$15 $DE01=$10 $DE02=$09 bitPeriodLo=$15 statusSave=$90 cmdShadow=$09 txCharActive=$00 uartPending=$00 syncRound=$03 lastHotkey=$FF lockout=0
switched to 300 baud by hot key C= + 3 (Commodore key = Tab)
[A] >>> m e040 e040
>C:e040 03 .
(C:$e041)
[B] >>> m e040 e040
>C:e040 03 .
(C:$e041)
phases: {'A': 3, 'B': 3}
back in the packet phase after the switch: True ({'A': 3, 'B': 3})
[A] >>> stopwatch
Stopwatch: 675680658
(C:$12e0)
[B] >>> stopwatch
Stopwatch: 611830834
(C:$1331)
[A] >>> stopwatch
Stopwatch: 753257768
(C:$1331)
[B] >>> stopwatch
Stopwatch: 689100234
(C:$1331)
=== window '300 baud, switched on a live link': 75.15 s wall ===
[A] 77577110 emulated cycles = 75.85 emulated seconds = 100.9% of real time
[B] 77269400 emulated cycles = 75.55 emulated seconds = 100.5% of real time
conn0 -> peer: 0 bytes in 75.15 s = 0.00 bytes/s = 0 bit/s of 8N1 line time; wire: {'bytes': 0, 'zeroRuns8': 0, 'longestZeroRun': 0, 'leadBytes55': 0}
conn1 -> peer: 0 bytes in 75.15 s = 0.00 bytes/s = 0 bit/s of 8N1 line time; wire: {'bytes': 0, 'zeroRuns8': 0, 'longestZeroRun': 0, 'leadBytes55': 0}
window '300 baud, switched on a live link' was not usable (speeds {'A': 1.009398882965619, 'B': 1.0053950971803876}, counts [0, 0]) - measuring again
[A] >>> m e040 e040
>C:e040 03 .
(C:$e041)
[B] >>> m e040 e040
>C:e040 03 .
(C:$e041)
phases: {'A': 3, 'B': 3}
[A] >>> stopwatch
Stopwatch: 755668163
(C:$1334)
[B] >>> stopwatch
Stopwatch: 691220015
(C:$1331)
[A] >>> stopwatch
Stopwatch: 833262368
(C:$1334)
[B] >>> stopwatch
Stopwatch: 768506509
(C:$127d)
=== window '300 baud, switched on a live link': 75.16 s wall ===
[A] 77594205 emulated cycles = 75.87 emulated seconds = 100.9% of real time
[B] 77286494 emulated cycles = 75.57 emulated seconds = 100.5% of real time
conn0 -> peer: 0 bytes in 75.16 s = 0.00 bytes/s = 0 bit/s of 8N1 line time; wire: {'bytes': 0, 'zeroRuns8': 0, 'longestZeroRun': 0, 'leadBytes55': 0}
conn1 -> peer: 0 bytes in 75.16 s = 0.00 bytes/s = 0 bit/s of 8N1 line time; wire: {'bytes': 0, 'zeroRuns8': 0, 'longestZeroRun': 0, 'leadBytes55': 0}
window '300 baud, switched on a live link' was not usable (speeds {'A': 1.009436766566858, 'B': 1.0054336996254922}, counts [0, 0]) - measuring again
[A] >>> m e040 e040
>C:e040 03 .
(C:$e041)
[B] >>> m e040 e040
>C:e040 03 .
(C:$e041)
phases: {'A': 3, 'B': 3}
[A] >>> stopwatch
Stopwatch: 835655665
(C:$1331)
[B] >>> stopwatch
Stopwatch: 770592097
(C:$1304)
[A] >>> stopwatch
Stopwatch: 913266968
(C:$1334)
[B] >>> stopwatch
Stopwatch: 847895690
(C:$1331)
=== window '300 baud, switched on a live link': 75.17 s wall ===
[A] 77611303 emulated cycles = 75.89 emulated seconds = 100.9% of real time
[B] 77303593 emulated cycles = 75.59 emulated seconds = 100.5% of real time
conn0 -> peer: 0 bytes in 75.17 s = 0.00 bytes/s = 0 bit/s of 8N1 line time; wire: {'bytes': 0, 'zeroRuns8': 0, 'longestZeroRun': 0, 'leadBytes55': 0}
conn1 -> peer: 0 bytes in 75.17 s = 0.00 bytes/s = 0 bit/s of 8N1 line time; wire: {'bytes': 0, 'zeroRuns8': 0, 'longestZeroRun': 0, 'leadBytes55': 0}
[A] >>> m e03b e047
>C:e03b 01 78 78 00 00 03 00 00 00 02 f8 ff 00 .xx..........
(C:$e048)
[A] >>> m e0a5 e0a5
>C:e0a5 00 .
(C:$e0a6)
[A] >>> m e055 e056
>C:e055 00 15 ..
(C:$e057)
[A] >>> m e5bb e5be
>C:e5bb 00 98 53 09 ..S.
(C:$e5bf)
[A] >>> m de00 de03
>C:de00 53 10 09 15 S...
(C:$de04)
[A] >>> m eab7 eab7
>C:eab7 04 .
(C:$eab8)
[A] >>> m 0b7d 0b7d
>C:0b7d 00 .
(C:$0b7e)
[B] >>> m e03b e047
>C:e03b 01 78 78 00 00 03 00 00 00 02 f8 ff 00 .xx..........
(C:$e048)
[B] >>> m e0a5 e0a5
>C:e0a5 00 .
(C:$e0a6)
[B] >>> m e055 e056
>C:e055 00 15 ..
(C:$e057)
[B] >>> m e5bb e5be
>C:e5bb 00 90 d7 09 ....
(C:$e5bf)
[B] >>> m de00 de03
>C:de00 d7 10 09 15 ....
(C:$de04)
[B] >>> m eab7 eab7
>C:eab7 03 .
(C:$eab8)
[B] >>> m 0b7d 0b7d
>C:0b7d 00 .
(C:$0b7e)
[A] phase=3 isLinkActive=1 linkErrorCount=0 linkStatus=$78 baudIndex=0 $DE03=$15 $DE01=$10 $DE02=$09 bitPeriodLo=$15 statusSave=$98 cmdShadow=$09 txCharActive=$00 uartPending=$00 syncRound=$04 lastHotkey=$FF lockout=0
[B] phase=3 isLinkActive=1 linkErrorCount=0 linkStatus=$78 baudIndex=0 $DE03=$15 $DE01=$10 $DE02=$09 bitPeriodLo=$15 statusSave=$90 cmdShadow=$09 txCharActive=$00 uartPending=$00 syncRound=$03 lastHotkey=$FF lockout=0
[A] >>> break
TRACE: 1 C:$e403 (Trace exec)
(C:$1331)
[A] >>> del
Deleting all checkpoints
(C:$1331)
[B] >>> break
TRACE: 1 C:$e403 (Trace exec)
(C:$1331)
[B] >>> del
Deleting all checkpoints
(C:$1331)
[A] >>> screenshot "/home/scott/claude/modemwars/swiftlink/shots/rtb04aAfterSecond.png" 2
(C:$12e0)
[A] shot /home/scott/claude/modemwars/swiftlink/shots/rtb04aAfterSecond.png
[B] >>> screenshot "/home/scott/claude/modemwars/swiftlink/shots/rtb04bAfterSecond.png" 2
(C:$12e0)
[B] shot /home/scott/claude/modemwars/swiftlink/shots/rtb04bAfterSecond.png
================ SUMMARY ================
2400 baud: 75.15 s wall, usable=False
[A] 77577108 cycles = 75.85 emulated s = 100.9% of real time
[B] 77269397 cycles = 75.55 emulated s = 100.5% of real time
conn0 -> peer 0 bytes, 0.00 B/s, 0 bit/s, 0.000 bytes per frame; wire {'bytes': 0, 'zeroRuns8': 0, 'longestZeroRun': 0, 'leadBytes55': 0}
conn1 -> peer 4495 bytes, 59.81 B/s, 598 bit/s, 1.000 bytes per frame; wire {'bytes': 4495, 'zeroRuns8': 1, 'longestZeroRun': 4495, 'leadBytes55': 0}
[A] control $18 = 8N1, internal baud generator, rate bits $8 = 2400 baud on a SwiftLink
[A] phase=2 isLinkActive=1 linkErrorCount=0 linkStatus=$F8 baudIndex=6 $DE03=$18 $DE01=$10 $DE02=$09 bitPeriodLo=$18 statusSave=$98 cmdShadow=$09 txCharActive=$01 uartPending=$03 syncRound=$09 lastHotkey=$FF lockout=0
[B] control $18 = 8N1, internal baud generator, rate bits $8 = 2400 baud on a SwiftLink
[B] phase=2 isLinkActive=1 linkErrorCount=0 linkStatus=$78 baudIndex=6 $DE03=$18 $DE01=$10 $DE02=$05 bitPeriodLo=$18 statusSave=$90 cmdShadow=$05 txCharActive=$01 uartPending=$01 syncRound=$00 lastHotkey=$FF lockout=0
countLinkError ($E403) tracepoint hits during the window: 0
transmitter deadlock probe: {'tags': ['A'], 'seconds': 15, 'bytes': [37, 98]}
300 baud, switched on a live link: 75.17 s wall, usable=False
[A] 77611303 cycles = 75.89 emulated s = 100.9% of real time
[B] 77303593 cycles = 75.59 emulated s = 100.5% of real time
conn0 -> peer 0 bytes, 0.00 B/s, 0 bit/s, 0.000 bytes per frame; wire {'bytes': 0, 'zeroRuns8': 0, 'longestZeroRun': 0, 'leadBytes55': 0}
conn1 -> peer 0 bytes, 0.00 B/s, 0 bit/s, 0.000 bytes per frame; wire {'bytes': 0, 'zeroRuns8': 0, 'longestZeroRun': 0, 'leadBytes55': 0}
[A] control $15 = 8N1, internal baud generator, rate bits $5 = 300 baud on a SwiftLink
[A] phase=3 isLinkActive=1 linkErrorCount=0 linkStatus=$78 baudIndex=0 $DE03=$15 $DE01=$10 $DE02=$09 bitPeriodLo=$15 statusSave=$98 cmdShadow=$09 txCharActive=$00 uartPending=$00 syncRound=$04 lastHotkey=$FF lockout=0
[B] control $15 = 8N1, internal baud generator, rate bits $5 = 300 baud on a SwiftLink
[B] phase=3 isLinkActive=1 linkErrorCount=0 linkStatus=$78 baudIndex=0 $DE03=$15 $DE01=$10 $DE02=$09 bitPeriodLo=$15 statusSave=$90 cmdShadow=$09 txCharActive=$00 uartPending=$00 syncRound=$03 lastHotkey=$FF lockout=0
countLinkError ($E403) tracepoint hits during the window: 0
transmitter deadlock probe: None
baud switch method: hot key C= + 3 (Commodore key = Tab)
[relay] conn0 total 712 bytes, tail b'\xedTU\xeeU\x00\xff\x00\xff\x00\xff\x00\xff\x00\xff\x00\xff\x00\xff\x00\xffUU\x00\xff\x00\xff\x00\xffU\xefVU\x0fuU\x0fuU\xefVU\x0fuY\x03\x8c\x05\xe3U\xecSU\xecSY\x00\x8c\x05\xd7'
[relay] conn1 total 23974 bytes, tail b'\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\xffU\xeeUU\npU\xeeUU\npU\xeeUY\x02\x8c\x05\xdfU\xefVY\x03\x8c\x05\xe3U\xefVU\xecSU\xecS'