Ticket #17746: usb_rndis-working.txt

File usb_rndis-working.txt, 9.4 KB (added by bipolar, 3 months ago)

Syslog output when the driver works as intended, and steps taken to avoid getting KDL (need to disable usb_rndis on Network preflets before disabling usb-tethering, and unpluging the phone),

Line 
1Secuence of actions shown:
2
3- connected USB cable.
4- enabled USB-tethering on the phone.
5- installed usb_rndis driver.
6- attempted to `ping haiku-os.org` (failed as expected, internet was down at that moment).
7- disabled RNDIS device on the Network preflet.
8- disabled tethering on the phone.
9- unplugged USB cable.
10
11As long as I repeat those steps, can use the phone without KDLs!
12
13> tail -f /var/log/syslog
14KERN: usb hub 36: port 0: new device connected
15KERN: usb_audio:11.35.972:init_driver::ver.0.0.5
16KERN: usb hub 36: port 0: new device connected
17KERN: usb error hub 36: new device on a port that is already in use
18KERN: usb_audio:11.44.313:init_driver::ver.0.0.5
19KERN: driver "usb_rndis" added
20KERN: devfs: reload driver "usb_rndis" (3, 7865205)
21KERN: usb_rndis: init_hardware()
22KERN: usb_rndis: init_driver()
23KERN: usb_rndis: rndis device 0 added
24KERN: usb_rndis: publish_devices()
25KERN: usb_rndis: publishing net/usb_rndis/0
26KERN: usb_rndis: find_device(net/usb_rndis/0)
27KERN: usb_rndis: open(net/usb_rndis/0, 2, 0xffffffff8a2fd7d0)
28KERN: usb_rndis: Send init command results in No error
29KERN: usb_rndis: Received notification 1 0
30KERN: usb_rndis: Received notification after init command
31KERN: usb_rndis: Read init command results in No error
32KERN: usb_rndis: Type 80000002
33KERN: usb_rndis: Length 34
34KERN: usb_rndis: Req ID 0
35KERN: usb_rndis: Status 0
36KERN: usb_rndis: Vers Maj 1
37KERN: usb_rndis: Vers Min 0
38KERN: usb_rndis: DevFlags 1
39KERN: usb_rndis: Medium 0
40KERN: usb_rndis: Max Pkts 1
41KERN: usb_rndis: Max Bytes 62c
42KERN: usb_rndis: Alignment 0
43KERN: usb_rndis: Reserved usb_rndis: 0 KERN: usb_rndis: 0 usb_rndis:
44KERN: usb_rndis: Received notification 1 0
45KERN: usb_rndis: mac address: 02:02:63:37:37:6e
46KERN: usb_rndis: Received notification 1 0
47KERN: usb_rndis: max frame size: 1500
48KERN: usb_rndis: Received notification 1 0
49KERN: usb_rndis: media connect state: 0
50KERN: usb_rndis: Received notification 1 0
51KERN: usb_rndis: link speed: 4259840 * 100bps
52KERN: usb_rndis: Received notification 1 0
53KERN: usb_rndis: Initialization result: No error
54KERN: usb_rndis: control(0xffffffff8cc89000, 10000, 0xffffffff8174e928, 8)
55KERN: usb_rndis: control(0xffffffff8cc89000, 9999, 0xffffffff896c77f0, 6)
56KERN: usb_rndis: control(0xffffffff8cc89000, 10005, 0xffffffff896c7884, 4)
57KERN: usb_rndis: control(0xffffffff8cc89000, 10007, 0xffffffff8174e8f0, 16)
58KERN: usb_rndis: control(0xffffffff8cc89000, 10006, 0xffffffff8751fd8c, 4)
59KERN: usb_rndis: read(0xffffffff8cc89000, 0, 0xffffffff8cb4f928, 1500)
60KERN: register_domain(4, link)
61DAEMON 'DHCP': /dev/net/usb_rndis/0: Send DHCP_DISCOVER to 255.255.255.255:67
62KERN: usb_rndis: write(0xffffffff8cc89000, 0, 0xffffffff8cb4f0fe, 307)
63KERN: usb_rndis: Received data packet len 00000056 data [off 00000024 len 0000002a]
64KERN: usb_rndis: read(0xffffffff8cc89000, 42, 0xffffffff8cb4f128, 1500)
65DAEMON 'DHCP': /dev/net/usb_rndis/0: Timeout shift: 500 msecs (try 1)
66DAEMON 'DHCP': /dev/net/usb_rndis/0: Send DHCP_DISCOVER to 255.255.255.255:67
67KERN: usb_rndis: write(0xffffffff8cc89000, 42, 0xffffffff8cb4f8fe, 307)
68DAEMON 'DHCP': /dev/net/usb_rndis/0: Timeout shift: 1000 msecs (try 2)
69DAEMON 'DHCP': /dev/net/usb_rndis/0: Send DHCP_DISCOVER to 255.255.255.255:67
70KERN: usb_rndis: write(0xffffffff8cc89000, 393, 0xffffffff8cb4f8fe, 307)
71KERN: usb_rndis: control(0xffffffff8cc89000, 10007, 0xffffffff8763df60, 16)
72KERN: usb_rndis: Received data packet len 00000056 data [off 00000024 len 0000002a]
73KERN: usb_rndis: read(0xffffffff8cc89000, 84, 0xffffffff8cb4f928, 1500)
74DAEMON 'DHCP': /dev/net/usb_rndis/0: Timeout shift: 2000 msecs (try 3)
75DAEMON 'DHCP': /dev/net/usb_rndis/0: Send DHCP_DISCOVER to 255.255.255.255:67
76KERN: usb_rndis: write(0xffffffff8cc89000, 84, 0xffffffff8cb4f0fe, 307)
77KERN: usb_rndis: control(0xffffffff8cc89000, 10007, 0xffffffff8763df60, 16)
78KERN: usb_rndis: Received data packet len 00000056 data [off 00000024 len 0000002a]
79KERN: usb_rndis: read(0xffffffff8cc89000, 126, 0xffffffff8cb4f128, 1500)
80KERN: usb_rndis: control(0xffffffff8cc89000, 10007, 0xffffffff8763df60, 16)
81KERN: usb_rndis: Received data packet len 0000018b data [off 00000024 len 0000015f]
82KERN: usb_rndis: read(0xffffffff8cc89000, 477, 0xffffffff8cb4f928, 1500)
83KERN: usb_rndis: Received data packet len 0000018b data [off 00000024 len 0000015f]
84KERN: usb_rndis: read(0xffffffff8cc89000, 828, 0xffffffff8cb4e928, 1500)
85KERN: usb_rndis: Received data packet len 0000018b data [off 00000024 len 0000015f]
86KERN: usb_rndis: read(0xffffffff8cc89000, 1179, 0xffffffff8cb4e128, 1500)
87KERN: usb_rndis: Received data packet len 0000018b data [off 00000024 len 0000015f]
88KERN: usb_rndis: read(0xffffffff8cc89000, 1530, 0xffffffff8cb4d928, 1500)
89DAEMON 'DHCP': /dev/net/usb_rndis/0: Received DHCP_OFFER from 192.168.42.129
90DAEMON 'DHCP': your_address: 192.168.42.153
91DAEMON 'DHCP': server: 192.168.42.129
92DAEMON 'DHCP': lease time: 3600 seconds
93DAEMON 'DHCP': renewal time: 1800 seconds
94DAEMON 'DHCP': rebinding time: 3150 seconds
95DAEMON 'DHCP': subnet: 255.255.255.0
96DAEMON 'DHCP': broadcast: 192.168.42.255
97DAEMON 'DHCP': gateway: 192.168.42.129
98DAEMON 'DHCP': nameserver[0]: 192.168.42.129
99DAEMON 'DHCP': UNKNOWN OPTION 43 (0x2b)
100DAEMON 'DHCP': /dev/net/usb_rndis/0: Send DHCP_REQUEST for 192.168.42.153 to 255.255.255.255:67
101KERN: usb_rndis: write(0xffffffff8cc89000, 1530, 0xffffffff8cb4d0fe, 319)
102DAEMON 'DHCP': /dev/net/usb_rndis/0: Received DHCP_OFFER from 192.168.42.129
103Last message repeated 2 times
104DAEMON 'DHCP': /dev/net/usb_rndis/0: Received DHCP_ACK from 192.168.42.129
105DAEMON 'DHCP': server: 192.168.42.129
106DAEMON 'DHCP': lease time: 3600 seconds
107DAEMON 'DHCP': renewal time: 1800 seconds
108DAEMON 'DHCP': rebinding time: 3150 seconds
109DAEMON 'DHCP': subnet: 255.255.255.0
110DAEMON 'DHCP': broadcast: 192.168.42.255
111DAEMON 'DHCP': gateway: 192.168.42.129
112DAEMON 'DHCP': nameserver[0]: 192.168.42.129
113DAEMON 'DHCP': UNKNOWN OPTION 43 (0x2b)
114KERN: usb_rndis: Received data packet len 0000018b data [off 00000024 len 0000015f]
115KERN: usb_rndis: read(0xffffffff8cc89000, 1881, 0xffffffff8cb4b928, 1500)
116DAEMON 'DHCP': /dev/net/usb_rndis/0: DHCP status = No error
117KERN: usb_rndis: control(0xffffffff8cc89000, 10007, 0xffffffff8763df60, 16)
118KERN: Last message repeated 4 times.
119KERN: usb_rndis: Received data packet len 00000056 data [off 00000024 len 0000002a]
120KERN: usb_rndis: read(0xffffffff8cc89000, 1923, 0xffffffff8cb4e128, 1500)
121KERN: usb_rndis: write(0xffffffff8cc89000, 1923, 0xffffffff8cb4b928, 42)
122KERN: usb_rndis: control(0xffffffff8cc89000, 10007, 0xffffffff8763df60, 16)
123KERN: Last message repeated 4 times.
124Last message repeated 13 times
125KERN: usb_rndis: write(0xffffffff8cc89000, 2009, 0xffffffff8cb4b8fe, 71)
126KERN: usb_rndis: control(0xffffffff8cc89000, 10007, 0xffffffff8763df60, 16)
127KERN: Last message repeated 3 times.
128KERN: usb_rndis: Received data packet len 0000008f data [off 00000024 len 00000063]
129KERN: usb_rndis: read(0xffffffff8cc89000, 2022, 0xffffffff8cb4b928, 1500)
130KERN: usb_rndis: write(0xffffffff8cc89000, 2022, 0xffffffff8cb4c0fe, 71)
131KERN: usb_rndis: control(0xffffffff8cc89000, 10007, 0xffffffff8763df60, 16)
132KERN: usb_rndis: write(0xffffffff8cc89000, 2137, 0xffffffff8cb4c0fe, 71)
133KERN: usb_rndis: control(0xffffffff8cc89000, 10007, 0xffffffff8763df60, 16)
134KERN: usb_rndis: write(0xffffffff8cc89000, 2252, 0xffffffff8cb4c0fe, 71)
135KERN: usb_rndis: control(0xffffffff8cc89000, 10007, 0xffffffff8763df60, 16)
136KERN: usb_rndis: Received data packet len 0000008f data [off 00000024 len 00000063]
137KERN: usb_rndis: read(0xffffffff8cc89000, 2121, 0xffffffff8cb4c128, 1500)
138KERN: usb_rndis: Received data packet len 0000008f data [off 00000024 len 00000063]
139KERN: usb_rndis: read(0xffffffff8cc89000, 2220, 0xffffffff8cb4c928, 1500)
140KERN: usb_rndis: control(0xffffffff8cc89000, 10007, 0xffffffff8763df60, 16)
141KERN: usb_rndis: Received data packet len 00000056 data [off 00000024 len 0000002a]
142KERN: usb_rndis: read(0xffffffff8cc89000, 2262, 0xffffffff8cb4d128, 1500)
143KERN: usb_rndis: write(0xffffffff8cc89000, 2262, 0xffffffff8cb4c928, 42)
144KERN: usb_rndis: control(0xffffffff8cc89000, 10007, 0xffffffff8763df60, 16)
145KERN: usb_rndis: Received data packet len 0000008f data [off 00000024 len 00000063]
146KERN: usb_rndis: read(0xffffffff8cc89000, 2361, 0xffffffff8cb4c928, 1500)
147KERN: usb_rndis: write(0xffffffff8cc89000, 2361, 0xffffffff8cb4b0fe, 71)
148KERN: usb_rndis: control(0xffffffff8cc89000, 10007, 0xffffffff8763df60, 16)
149KERN: Last message repeated 2 times.
150KERN: usb_rndis: Received data packet len 0000008f data [off 00000024 len 00000063]
151KERN: usb_rndis: read(0xffffffff8cc89000, 2460, 0xffffffff8cb4f128, 1500)
152KERN: usb_rndis: control(0xffffffff8cc89000, 10007, 0xffffffff8763df60, 16)
153KERN: Last message repeated 4 times.
154-------------
155At this point, I've disabled the RNDIS interface on the Network preflet (before disabling tethering on the phone, and then disconecting it).
156-------------
157Last message repeated 6 times
158KERN: usb_rndis: control(0xffffffff8cc89000, 10007, 0xffffffff8763df60, 16)
159KERN: usb_rndis: close(0xffffffff8cc89000)
160KERN: usb_rndis: Received frame at 0 length 0000008f out of bounds of receive buffer00000000
161KERN: usb_rndis: Received data packet len 0000008f data [off 00000024 len 00000063]
162KERN: usb_rndis: free(0xffffffff8cc89000)
163KERN: usb hub 36: port 0: new device connected
164KERN: usb error hub 36: new device on a port that is already in use
165KERN: usb_rndis: publish_devices()
166KERN: usb_rndis: uninit_driver()
167KERN: usb_audio:14.06.688:init_driver::ver.0.0.5
168KERN: usb hub 36: KERN: port 0: device removed
169KERN: usb_audio:14.16.698:init_driver::ver.0.0.5
170>
171-------------
172All good! no KDLs!
173-------------