Broadband Related > FTTC and FTTP Issues

FTTC dropouts

(1/5) > >>

ads:
My BT FTTC has been dropping out this week, couple of times on Monday, again on Tuesday, and now twice so far today. Always between 5-7PM, rest of the time it seems fine.


--- Code: ---18:06:34, 09 Sep.

:HTTP UserAdmin login from 192.168.1.124 successfully

18:06:25, 09 Sep.

:HTTP UserBasic login from 192.168.1.124 successfully

18:05:55, 09 Sep.

:WAN DHCPv6 Client Prefix : 2a00:23c4:6e82:4600::/56 (valid time = 315360000 / preferred time = 315360000)

18:05:51, 09 Sep.

ppp1:TR69 connectivity to (pbthdm.bt.mo) has been closed

18:05:50, 09 Sep.

ppp1:The WAN DHCPv6 Client Process has successfully been launched on Vlan 36

18:05:50, 09 Sep.

ppp1:The WAN DHCPv6 Client Process has successfully been terminated on Vlan 36

18:05:49, 09 Sep.

ppp1:TR69 connectivity to (pbthdm.bt.mo) has been initiated

18:05:49, 09 Sep.

ppp1:TR69 receiving InformResponse message

18:05:49, 09 Sep.

ppp1:TR69 event found : 4 VALUE CHANGE

18:05:48, 09 Sep.

ppp1:TR69 sending Inform message

18:05:48, 09 Sep.

ppp1:TR69 event found : 4 VALUE CHANGE

18:05:47, 09 Sep.

ppp1:TR69 sending Inform message

18:05:41, 09 Sep.

BR_LAN: Allocated prefix = fdaa:bbcc:ddee::/64 (valid time = 4293967296 / preferred time = 4293967296)

18:05:41, 09 Sep.

BR_LAN: Allocated prefix = 2a00:23c4:6e82:4600::/64 (valid time = 2026291200 / preferred time = 2026291200)

18:05:41, 09 Sep.

BR_LAN: Allocated address = 2a00:23c4:6e82:4600:8aa6:c6ff:fe24:dadb (valid time = 2026291200 / preferred time = 2026291200)

18:05:41, 09 Sep.

BR_LAN: Allocated prefix = 2a00:23c4:6e82:4600::/64 (valid time = 2026291200 / preferred time = 2026291200)

18:05:41, 09 Sep.

ppp1: Allocated prefix = 2a00:23c4:6e82:4601::/64 (valid time = 2026291200 / preferred time = 2026291200)

18:05:41, 09 Sep.

ppp1: Allocated prefix = 2a00:23c4:6e82:4600::/56 (valid time = 2026291200 / preferred time = 2026291200)

18:05:41, 09 Sep.

ppp1: Allocated address = 2a00:23c4:6e82:4601:8aa6:c6ff:fe24:dad9 (valid time = 2026291200 / preferred time = 2026291200)

18:05:41, 09 Sep.

ppp1: Allocated prefix = 2a00:23c4:6e82:4601::/64 (valid time = 2026291200 / preferred time = 2026291200)

18:05:41, 09 Sep.

ppp1:TR69 creating new session with ACS

18:05:41, 09 Sep.

ppp1: Allocated prefix = 2a00:23c4:6e82:4601::/64 (valid time = 2026291200 / preferred time = 2026291200)

18:05:41, 09 Sep.

ppp1: Allocated prefix = 2a00:23c4:6e82:4600::/56 (valid time = 2026291200 / preferred time = 2026291200)

18:05:41, 09 Sep.

ppp1: Allocated prefix = 2a00:23c4:6e82:4600::/56 (valid time = 2026291200 / preferred time = 2026291200)

18:05:41, 09 Sep.

:WAN DHCPv6 Client Prefix : 2a00:23c4:6e82:4600::/56 (valid time = 315360000 / preferred time = 315360000)

18:05:39, 09 Sep.

ppp1:The WAN DHCPv6 Client Process has successfully been launched on Vlan 36

18:05:39, 09 Sep.

BR_LAN: Allocated prefix = fdaa:bbcc:ddee::/64 (valid time = 4293967296 / preferred time = 4293967296)

18:05:39, 09 Sep.

BR_LAN: Allocated prefix = 2a00:23c4:6e82:4600::/64 (valid time = 2026291200 / preferred time = 2026291200)

18:05:39, 09 Sep.

BR_LAN: Allocated address = 2a00:23c4:6e82:4600:8aa6:c6ff:fe24:dadb (valid time = 2026291200 / preferred time = 2026291200)

18:05:39, 09 Sep.

BR_LAN: Allocated prefix = 2a00:23c4:6e82:4600::/64 (valid time = 2026291200 / preferred time = 2026291200)

18:05:39, 09 Sep.

ppp1: Allocated prefix = 2a00:23c4:6e82:4601::/64 (valid time = 2026291200 / preferred time = 2026291200)

18:05:39, 09 Sep.

ppp1: Allocated prefix = 2a00:23c4:6e82:4600::/56 (valid time = 2026291200 / preferred time = 2026291200)

18:05:39, 09 Sep.

ppp1: Allocated address = 2a00:23c4:6e82:4601:8aa6:c6ff:fe24:dad9 (valid time = 2026291200 / preferred time = 2026291200)

18:05:39, 09 Sep.

ppp1: Allocated prefix = 2a00:23c4:6e82:4601::/64 (valid time = 2026291200 / preferred time = 2026291200)

18:05:38, 09 Sep.

ppp1:WAN DHCPv6 Mode : Statefull

18:05:38, 09 Sep.

BR_LAN:The LAN DHCPv6 Server is active

18:05:38, 09 Sep.

BR_LAN:LAN Router Advertisement Setting Updated : M_flag = 0, O_flag = 1

18:05:38, 09 Sep.

BR_LAN:The LAN DHCPv6 Server is inactive

18:05:38, 09 Sep.

ppp1:WAN Router Discovery Setting Updated : M_flag = 1, O_flag = 0

18:05:37, 09 Sep.

ppp1:The WAN DHCPv6 Client Process has successfully been terminated on Vlan 36

18:05:37, 09 Sep.

BR_LAN:The LAN DHCPv6 Server is active

18:05:37, 09 Sep.

BR_LAN:The LAN DHCPv6 Server is inactive

18:05:37, 09 Sep.

BR_LAN: Allocated prefix = fdaa:bbcc:ddee::/64 (valid time = 4293967296 / preferred time = 4293967296)

18:05:37, 09 Sep.

BR_LAN: Allocated prefix = 2a00:23c4:6e82:4600::/64 (valid time = 2026291200 / preferred time = 2026291200)

18:05:37, 09 Sep.

BR_LAN: Allocated address = 2a00:23c4:6e82:4600:8aa6:c6ff:fe24:dadb (valid time = 2026291200 / preferred time = 2026291200)

18:05:37, 09 Sep.

BR_LAN: Allocated prefix = 2a00:23c4:6e82:4600::/64 (valid time = 2026291200 / preferred time = 2026291200)

18:05:37, 09 Sep.

BR_LAN:LAN Router Advertisement Setting Updated : M_flag = 0, O_flag = 1

18:05:37, 09 Sep.

BR_LAN:The LAN DHCPv6 Server is active

18:05:36, 09 Sep.

BR_LAN:The LAN DHCPv6 Server is inactive

18:05:36, 09 Sep.

:WAN: SENSING AUTO VDSL

18:05:36, 09 Sep.

BR_LAN:The LAN DHCPv6 Server is active

18:05:36, 09 Sep.

ppp1:The WAN DHCPv6 Client Process has successfully been launched on Vlan 36

18:05:36, 09 Sep.

ppp1:New DYN ROUTE is added [81.139.57.100/32 gw 172.16.10.141]

18:05:35, 09 Sep.

ppp1:New DYN ROUTE is added [81.139.56.100/32 gw 172.16.10.141]

18:05:35, 09 Sep.

ppp1:PPP: PPP INFO 81.139.56.100,81.139.57.100

18:05:35, 09 Sep.

BR_LAN:The LAN DHCPv6 Server is inactive

18:05:35, 09 Sep.

BR_LAN: Allocated prefix = fdaa:bbcc:ddee::/64 (valid time = 4293967296 / preferred time = 4293967296)

18:05:35, 09 Sep.

BR_LAN: Allocated prefix = 2a00:23c4:6e82:4600::/64 (valid time = 2026291200 / preferred time = 2026291200)

18:05:35, 09 Sep.

ppp1: Allocated prefix = 2a00:23c4:6e82:4601::/64 (valid time = 2026291200 / preferred time = 2026291200)

18:05:35, 09 Sep.

ppp1: Allocated prefix = 2a00:23c4:6e82:4600::/56 (valid time = 2026291200 / preferred time = 2026291200)

18:05:35, 09 Sep.

ppp1:PPP: PPP INFO

18:05:35, 09 Sep.

ppp:PPP: IPCP_NAK

18:05:35, 09 Sep.

ppp:PPP: CHAP_SUCCESS

18:05:35, 09 Sep.

ppp:PPP: CHAP_RESPONSE

18:05:35, 09 Sep.

ppp:PPP: LCP_GOOD_ACK

18:05:35, 09 Sep.

ppp:PPP: LCP_REQUEST

18:05:34, 09 Sep.

:PPPoE error: timeout

18:05:26, 09 Sep.

:PPPoE error: timeout

18:05:21, 09 Sep.

:PPPoE error: timeout

18:05:16, 09 Sep.

ptm0.101:VLAN VLAN_DATA connected

18:05:16, 09 Sep.

:connection ATM_TV disconnected.[ERROR_USER_DISCONNECT]

18:05:16, 09 Sep.

:connection ATM_DATA disconnected.[ERROR_USER_DISCONNECT]

18:05:16, 09 Sep.

dsl:VDSL link Up: Down Rate=39706Kbps, Up Rate=12829Kbps, SNR Margin Down=0.00dB, SNR Margin Up=6.00dB

18:04:54, 09 Sep.

:VLAN VLAN_DATA disconnected

18:04:53, 09 Sep.

:Connection to the Internet has been terminated.(Reboot,Reconfiguration,forced termination)

18:04:53, 09 Sep.

BR_LAN:The LAN DHCPv6 Server is active

18:04:52, 09 Sep.

:Connection to the Internet has been terminated.(Reboot,Reconfiguration,forced termination)

18:04:52, 09 Sep.

ppp1:Request for a new authenticated connection

18:04:52, 09 Sep.

ppp1:TR69 ConnectionRequest: processing request from ACS

18:04:52, 09 Sep.

ppp1:The DYN ROUTE [81.139.56.100/32 gw 172.16.10.141] is deleted

18:04:52, 09 Sep.

ppp1:The DYN ROUTE [81.139.57.100/32 gw 172.16.10.141] is deleted

18:04:52, 09 Sep.

BR_LAN:The LAN DHCPv6 Server is inactive

18:04:51, 09 Sep.

BR_LAN:LAN Router Advertisement Setting Updated : M_flag = 0, O_flag = 1

18:04:51, 09 Sep.

BR_LAN:The LAN DHCPv6 Server is active

18:04:51, 09 Sep.

BR_LAN:The LAN DHCPv6 Server is inactive

18:04:51, 09 Sep.

ppp1:The WAN DHCPv6 Client Process has successfully been terminated on Vlan 36

18:04:51, 09 Sep.

BR_LAN:The LAN DHCPv6 Server is active

18:04:51, 09 Sep.

BR_LAN:The LAN DHCPv6 Server is inactive

18:04:51, 09 Sep.

BR_LAN: Allocated prefix = fdaa:bbcc:ddee::/64 (valid time = 4293967296 / preferred time = 4293967296)

18:04:51, 09 Sep.

BR_LAN: Revoked prefix = 2a00:23c4:6e82:4600::/64 (valid time = 2026291200 / preferred time = 2026291200)

18:04:51, 09 Sep.

ppp1: Revoked prefix = 2a00:23c4:6e82:4601::/64 (valid time = 2026291200 / preferred time = 2026291200)

18:04:51, 09 Sep.

ppp1: Revoked prefix = 2a00:23c4:6e82:4600::/56 (valid time = 2026291200 / preferred time = 2026291200)

18:04:50, 09 Sep.

dsl:VDSL Link Down: duration was 176582 seconds

17:06:05, 09 Sep.

:WAN DHCPv6 Client Prefix : 2a00:23c4:6e82:4600::/56 (valid time = 315360000 / preferred time = 315360000)

17:03:42, 09 Sep.

ppp1:The WAN DHCPv6 Client Process has successfully been launched on Vlan 36

17:03:42, 09 Sep.

ppp1:The WAN DHCPv6 Client Process has successfully been terminated on Vlan 36

--- End code ---

Log I grabbed from the last dropout, anything obvious there? BT website test says they found no issues.

[Moderator edited to change [pre][/pre] tags to [code][/code] tags.]

ads:

--- Code: ---Noise margin:
6.1 dB / 6.2 dB

Line attenuation:
37 dB

Signal attenuation:
23.1 dB / 37 dB

VPI / VCI:
0/38

Modulation:
G_993_2_ANNEX_B

Latency type:
Fast Path

--- End code ---

if that helps ^


Oh and for some reason a tab in Firefox opens; http://www.msftconnecttest.com/00000111500/gui/?item=redirect

Never seen that before

[Moderator edited: As preceding post.]

Alex Atkin UK:
There's not really enough to go on if your router isn't even showing the number of errors.

ads:
That's all the info the stupid BT Hub 6A tells me when the event log is set to all, is there a way to gather more info?

mofa2020:
are VPI / VCI used on FTTC lines? never seen it before when VDSL is the line modulation.

Navigation

[0] Message Index

[#] Next page

Go to full version