[start] 2022/05/23 19:45:18.851413 main.go:530: INFO: syncthing v1.20.1 "Fermium Flea" (go1.18.2 linux-amd64) abuild@openSUSE 2022-05-04 00:00:00 UTC [noupgrade] [N5DJ3] 2022/05/23 19:45:18.894610 syncthing.go:155: INFO: My ID: N5DJ3SN-YVQJJ3Z-C3OIBLN-DQJ7A6A-C2XSPUF-NEADUVR-J6AV6OU-DYZLNQ3 [N5DJ3] 2022/05/23 19:45:19.796785 sha256.go:88: INFO: Single thread SHA256 performance is 358 MB/s using crypto/sha256 (358 MB/s using minio/sha256-simd). [N5DJ3] 2022/05/23 19:45:20.257235 syncthing.go:187: INFO: Hashing performance is 306.85 MB/s [N5DJ3] 2022/05/23 19:45:20.257436 limiter.go:163: INFO: Overall send rate is unlimited, receive rate is unlimited [N5DJ3] 2022/05/23 19:45:20.257489 service.go:760: DEBUG: Starting listener tcp://0.0.0.0:22000 [N5DJ3] 2022/05/23 19:45:20.257530 service.go:760: DEBUG: Starting listener dynamic+https://relays.syncthing.net/endpoint [N5DJ3] 2022/05/23 19:45:20.257548 service.go:760: DEBUG: Starting listener quic://0.0.0.0:22000 2022/05/23 19:45:20 failed to sufficiently increase receive buffer size (was: 208 kiB, wanted: 2048 kiB, got: 416 kiB). See https://github.com/lucas-clemente/quic-go/wiki/UDP-Receive-Buffer-Size for details. [N5DJ3] 2022/05/23 19:45:20.257702 model.go:422: INFO: Ready to synchronize "University schedule" (92pnv-kvizm) (sendonly) [N5DJ3] 2022/05/23 19:45:20.257727 manager.go:92: INFO: Using discovery mechanism: global discovery server https://discovery.syncthing.net/v2/?noannounce&id=LYXKCHX-VI3NYZR-ALCJBHF-WMZYSPK-QG6QJA3-MPFYMSO-U56GTUK-NA2MIAW [N5DJ3] 2022/05/23 19:45:20.257749 manager.go:92: INFO: Using discovery mechanism: global discovery server https://discovery-v4.syncthing.net/v2/?nolookup&id=LYXKCHX-VI3NYZR-ALCJBHF-WMZYSPK-QG6QJA3-MPFYMSO-U56GTUK-NA2MIAW [N5DJ3] 2022/05/23 19:45:20.257764 manager.go:92: INFO: Using discovery mechanism: global discovery server https://discovery-v6.syncthing.net/v2/?nolookup&id=LYXKCHX-VI3NYZR-ALCJBHF-WMZYSPK-QG6QJA3-MPFYMSO-U56GTUK-NA2MIAW [N5DJ3] 2022/05/23 19:45:20.257803 manager.go:92: INFO: Using discovery mechanism: IPv4 local broadcast discovery on port 21027 [N5DJ3] 2022/05/23 19:45:20.257828 manager.go:92: INFO: Using discovery mechanism: IPv6 local multicast discovery on address [ff12::8384]:21027 [N5DJ3] 2022/05/23 19:45:20.257974 tcp_listen.go:76: INFO: TCP listener ([::]:22000) starting [N5DJ3] 2022/05/23 19:45:20.258024 relay_listen.go:58: INFO: Relay listener (dynamic+https://relays.syncthing.net/endpoint) starting [N5DJ3] 2022/05/23 19:45:20.258072 dynamic.go:49: DEBUG: DynamicClient:0xc0000950e0:@dynamic+https://relays.syncthing.net/endpoint looking up dynamic relays [N5DJ3] 2022/05/23 19:45:20.258768 quic_listen.go:117: INFO: QUIC listener ([::]:22000) starting [N5DJ3] 2022/05/23 19:45:20.259762 model.go:422: INFO: Ready to synchronize "Joplin" (qzr2y-ncqjk) (sendreceive) [N5DJ3] 2022/05/23 19:45:20.260363 folder.go:905: INFO: Completed initial scan of sendonly folder "University schedule" (92pnv-kvizm) [N5DJ3] 2022/05/23 19:45:20.261205 service.go:443: DEBUG: Connection loop [N5DJ3] 2022/05/23 19:45:20.261237 service.go:445: DEBUG: Connection loop in initial rampup [N5DJ3] 2022/05/23 19:45:20.261805 api.go:390: INFO: GUI and API listening on 127.0.0.1:8384 [N5DJ3] 2022/05/23 19:45:20.261834 api.go:391: INFO: Access the GUI via the following URL: https://127.0.0.1:8384/ [N5DJ3] 2022/05/23 19:45:20.261881 syncthing.go:316: INFO: My name is "DELLnode" [N5DJ3] 2022/05/23 19:45:20.261908 syncthing.go:319: INFO: Device IHZBZHW-FQQRCLX-ITF3TYR-M2EUVJ6-OFESXIV-KLWGC2T-TQHAOBN-M5GEBQR is "LenovoPH" at [dynamic] [N5DJ3] 2022/05/23 19:45:20.265539 folder.go:905: INFO: Completed initial scan of sendreceive folder "Joplin" (qzr2y-ncqjk) [N5DJ3] 2022/05/23 19:45:22.260732 global.go:259: DEBUG: global@https://discovery-v6.syncthing.net/v2/ Announcement: {[tcp://0.0.0.0:22000 tcp://192.168.0.11:22000 tcp://0.0.0.0:0 quic://0.0.0.0:22000 quic://192.168.0.11:22000]} [N5DJ3] 2022/05/23 19:45:22.261016 global.go:259: DEBUG: global@https://discovery-v4.syncthing.net/v2/ Announcement: {[quic://0.0.0.0:22000 quic://192.168.0.11:22000 tcp://0.0.0.0:22000 tcp://192.168.0.11:22000 tcp://0.0.0.0:0]} [N5DJ3] 2022/05/23 19:45:22.262693 global.go:263: DEBUG: global@https://discovery-v6.syncthing.net/v2/ announce POST: Post "https://discovery-v6.syncthing.net/v2/": dial tcp [2a03:b0c0:0:1010::bb:4001]:443: connect: network is unreachable [N5DJ3] 2022/05/23 19:45:34.314627 service.go:103: INFO: Detected 1 NAT service [N5DJ3] 2022/05/23 19:45:39.402092 quic_listen.go:57: INFO: quic://0.0.0.0:22000 detected NAT type: Port restricted NAT [N5DJ3] 2022/05/23 19:45:39.402165 quic_listen.go:76: INFO: quic://0.0.0.0:22000 resolved external address quic://85.93.60.210:3594 (via stun.syncthing.net:3478) [N5DJ3] 2022/05/23 19:45:41.403661 global.go:259: DEBUG: global@https://discovery-v6.syncthing.net/v2/ Announcement: {[quic://0.0.0.0:22000 quic://192.168.0.11:22000 quic://85.93.60.210:3594 tcp://0.0.0.0:22000 tcp://192.168.0.11:22000 tcp://0.0.0.0:0]} [N5DJ3] 2022/05/23 19:45:41.405770 global.go:263: DEBUG: global@https://discovery-v6.syncthing.net/v2/ announce POST: Post "https://discovery-v6.syncthing.net/v2/": dial tcp [2a03:b0c0:0:1010::bb:4001]:443: connect: network is unreachable [N5DJ3] 2022/05/23 19:45:50.260693 dynamic.go:59: DEBUG: DynamicClient:0xc0000950e0:@dynamic+https://relays.syncthing.net/endpoint failed to lookup dynamic relays Get "https://relays.syncthing.net/endpoint": dial tcp 82.196.13.137:443: i/o timeout [N5DJ3] 2022/05/23 19:45:50.260736 relay_listen.go:66: INFO: Relay listener (dynamic+https://relays.syncthing.net/endpoint) shutting down [N5DJ3] 2022/05/23 19:45:50.260795 svcutil.go:192: INFO: listenerSupervisor@dynamic+https://relays.syncthing.net/endpoint: service dynamic+https://relays.syncthing.net/endpoint failed: Get "https://relays.syncthing.net/endpoint": dial tcp 82.196.13.137:443: i/o timeout [N5DJ3] 2022/05/23 19:45:50.260823 svcutil.go:195: DEBUG: listenerSupervisor@dynamic+https://relays.syncthing.net/endpoint: Failed service 'dynamic+https://relays.syncthing.net/endpoint' (1.000000 failures of 2.000000), restarting: true, error: Get "https://relays.syncthing.net/endpoint": dial tcp 82.196.13.137:443: i/o timeout [N5DJ3] 2022/05/23 19:45:50.260856 relay_listen.go:58: INFO: Relay listener (dynamic+https://relays.syncthing.net/endpoint) starting [N5DJ3] 2022/05/23 19:45:50.260903 dynamic.go:49: DEBUG: DynamicClient:0xc0009660c0:@dynamic+https://relays.syncthing.net/endpoint looking up dynamic relays [N5DJ3] 2022/05/23 19:45:50.261213 local.go:196: DEBUG: discover: Received local announcement from 192.168.0.11:36750 for N5DJ3SN-YVQJJ3Z-C3OIBLN-DQJ7A6A-C2XSPUF-NEADUVR-J6AV6OU-DYZLNQ3 [N5DJ3] 2022/05/23 19:45:50.261679 local.go:196: DEBUG: discover: Received local announcement from [fe80::7df1:d85d:f8e5:b7e5%wlp0s20f3]:38633 for N5DJ3SN-YVQJJ3Z-C3OIBLN-DQJ7A6A-C2XSPUF-NEADUVR-J6AV6OU-DYZLNQ3 [N5DJ3] 2022/05/23 19:45:50.261823 global.go:167: DEBUG: globalClient.Lookup https://discovery.syncthing.net/v2/?device=IHZBZHW-FQQRCLX-ITF3TYR-M2EUVJ6-OFESXIV-KLWGC2T-TQHAOBN-M5GEBQR Get "https://discovery.syncthing.net/v2/?device=IHZBZHW-FQQRCLX-ITF3TYR-M2EUVJ6-OFESXIV-KLWGC2T-TQHAOBN-M5GEBQR": context deadline exceeded (Client.Timeout exceeded while awaiting headers) [N5DJ3] 2022/05/23 19:45:50.261873 manager.go:139: DEBUG: lookup for IHZBZHW-FQQRCLX-ITF3TYR-M2EUVJ6-OFESXIV-KLWGC2T-TQHAOBN-M5GEBQR at IPv4 local [N5DJ3] 2022/05/23 19:45:50.261884 manager.go:140: DEBUG: addresses: [] [N5DJ3] 2022/05/23 19:45:50.261894 manager.go:139: DEBUG: lookup for IHZBZHW-FQQRCLX-ITF3TYR-M2EUVJ6-OFESXIV-KLWGC2T-TQHAOBN-M5GEBQR at IPv6 local [N5DJ3] 2022/05/23 19:45:50.261901 manager.go:140: DEBUG: addresses: [] [N5DJ3] 2022/05/23 19:45:50.261913 manager.go:164: DEBUG: lookup results for IHZBZHW-FQQRCLX-ITF3TYR-M2EUVJ6-OFESXIV-KLWGC2T-TQHAOBN-M5GEBQR [N5DJ3] 2022/05/23 19:45:50.261920 manager.go:165: DEBUG: addresses: [] [N5DJ3] 2022/05/23 19:45:50.261929 service.go:614: DEBUG: Resolved device IHZBZHW-FQQRCLX-ITF3TYR-M2EUVJ6-OFESXIV-KLWGC2T-TQHAOBN-M5GEBQR addresses: [] [N5DJ3] 2022/05/23 19:45:50.261955 service.go:473: DEBUG: Next connection loop in 5s [N5DJ3] 2022/05/23 19:45:52.264733 global.go:263: DEBUG: global@https://discovery-v4.syncthing.net/v2/ announce POST: Post "https://discovery-v4.syncthing.net/v2/": context deadline exceeded (Client.Timeout exceeded while awaiting headers) [N5DJ3] 2022/05/23 19:45:52.265201 global.go:259: DEBUG: global@https://discovery-v6.syncthing.net/v2/ Announcement: {[tcp://0.0.0.0:22000 tcp://192.168.0.11:22000 tcp://0.0.0.0:0 quic://0.0.0.0:22000 quic://192.168.0.11:22000 quic://85.93.60.210:3594]} [N5DJ3] 2022/05/23 19:45:52.267210 global.go:263: DEBUG: global@https://discovery-v6.syncthing.net/v2/ announce POST: Post "https://discovery-v6.syncthing.net/v2/": dial tcp [2a03:b0c0:0:1010::bb:4001]:443: connect: network is unreachable [N5DJ3] 2022/05/23 19:45:54.265605 global.go:259: DEBUG: global@https://discovery-v4.syncthing.net/v2/ Announcement: {[tcp://0.0.0.0:22000 tcp://192.168.0.11:22000 tcp://0.0.0.0:0 quic://0.0.0.0:22000 quic://192.168.0.11:22000 quic://85.93.60.210:3594]} [N5DJ3] 2022/05/23 19:45:55.263988 service.go:443: DEBUG: Connection loop [N5DJ3] 2022/05/23 19:45:55.264053 service.go:445: DEBUG: Connection loop in initial rampup [N5DJ3] 2022/05/23 19:45:55.264229 manager.go:139: DEBUG: lookup for IHZBZHW-FQQRCLX-ITF3TYR-M2EUVJ6-OFESXIV-KLWGC2T-TQHAOBN-M5GEBQR at IPv6 local [N5DJ3] 2022/05/23 19:45:55.264261 manager.go:140: DEBUG: addresses: [] [N5DJ3] 2022/05/23 19:45:55.264330 manager.go:130: DEBUG: negative cache entry for IHZBZHW-FQQRCLX-ITF3TYR-M2EUVJ6-OFESXIV-KLWGC2T-TQHAOBN-M5GEBQR at global@https://discovery.syncthing.net/v2/ valid until 2022-05-23 19:46:50.261855627 +0300 MSK m=+91.420286441 or 0001-01-01 00:00:00 +0000 UTC [N5DJ3] 2022/05/23 19:45:55.264372 manager.go:130: DEBUG: negative cache entry for IHZBZHW-FQQRCLX-ITF3TYR-M2EUVJ6-OFESXIV-KLWGC2T-TQHAOBN-M5GEBQR at global@https://discovery-v4.syncthing.net/v2/ valid until 2022-05-23 19:46:50.261861191 +0300 MSK m=+91.420291998 or 2022-05-23 20:45:50.261862315 +0300 MSK m=+3631.420293135 [N5DJ3] 2022/05/23 19:45:55.264411 manager.go:130: DEBUG: negative cache entry for IHZBZHW-FQQRCLX-ITF3TYR-M2EUVJ6-OFESXIV-KLWGC2T-TQHAOBN-M5GEBQR at global@https://discovery-v6.syncthing.net/v2/ valid until 2022-05-23 19:46:50.261863321 +0300 MSK m=+91.420294128 or 2022-05-23 20:45:50.261863488 +0300 MSK m=+3631.420294296 [N5DJ3] 2022/05/23 19:45:55.264437 manager.go:139: DEBUG: lookup for IHZBZHW-FQQRCLX-ITF3TYR-M2EUVJ6-OFESXIV-KLWGC2T-TQHAOBN-M5GEBQR at IPv4 local [N5DJ3] 2022/05/23 19:45:55.264455 manager.go:140: DEBUG: addresses: [] [N5DJ3] 2022/05/23 19:45:55.264479 manager.go:164: DEBUG: lookup results for IHZBZHW-FQQRCLX-ITF3TYR-M2EUVJ6-OFESXIV-KLWGC2T-TQHAOBN-M5GEBQR [N5DJ3] 2022/05/23 19:45:55.264496 manager.go:165: DEBUG: addresses: [] [N5DJ3] 2022/05/23 19:45:55.264534 service.go:614: DEBUG: Resolved device IHZBZHW-FQQRCLX-ITF3TYR-M2EUVJ6-OFESXIV-KLWGC2T-TQHAOBN-M5GEBQR addresses: [] [N5DJ3] 2022/05/23 19:45:55.264572 service.go:473: DEBUG: Next connection loop in 5s [N5DJ3] 2022/05/23 19:46:00.264774 service.go:443: DEBUG: Connection loop [N5DJ3] 2022/05/23 19:46:00.264857 service.go:445: DEBUG: Connection loop in initial rampup [N5DJ3] 2022/05/23 19:46:00.265127 manager.go:139: DEBUG: lookup for IHZBZHW-FQQRCLX-ITF3TYR-M2EUVJ6-OFESXIV-KLWGC2T-TQHAOBN-M5GEBQR at IPv6 local [N5DJ3] 2022/05/23 19:46:00.265176 manager.go:140: DEBUG: addresses: [] [N5DJ3] 2022/05/23 19:46:00.265242 manager.go:130: DEBUG: negative cache entry for IHZBZHW-FQQRCLX-ITF3TYR-M2EUVJ6-OFESXIV-KLWGC2T-TQHAOBN-M5GEBQR at global@https://discovery.syncthing.net/v2/ valid until 2022-05-23 19:46:50.261855627 +0300 MSK m=+91.420286441 or 0001-01-01 00:00:00 +0000 UTC [N5DJ3] 2022/05/23 19:46:00.265282 manager.go:130: DEBUG: negative cache entry for IHZBZHW-FQQRCLX-ITF3TYR-M2EUVJ6-OFESXIV-KLWGC2T-TQHAOBN-M5GEBQR at global@https://discovery-v4.syncthing.net/v2/ valid until 2022-05-23 19:46:50.261861191 +0300 MSK m=+91.420291998 or 2022-05-23 20:45:50.261862315 +0300 MSK m=+3631.420293135 [N5DJ3] 2022/05/23 19:46:00.265321 manager.go:130: DEBUG: negative cache entry for IHZBZHW-FQQRCLX-ITF3TYR-M2EUVJ6-OFESXIV-KLWGC2T-TQHAOBN-M5GEBQR at global@https://discovery-v6.syncthing.net/v2/ valid until 2022-05-23 19:46:50.261863321 +0300 MSK m=+91.420294128 or 2022-05-23 20:45:50.261863488 +0300 MSK m=+3631.420294296 [N5DJ3] 2022/05/23 19:46:00.265353 manager.go:139: DEBUG: lookup for IHZBZHW-FQQRCLX-ITF3TYR-M2EUVJ6-OFESXIV-KLWGC2T-TQHAOBN-M5GEBQR at IPv4 local [N5DJ3] 2022/05/23 19:46:00.265372 manager.go:140: DEBUG: addresses: [] [N5DJ3] 2022/05/23 19:46:00.265400 manager.go:164: DEBUG: lookup results for IHZBZHW-FQQRCLX-ITF3TYR-M2EUVJ6-OFESXIV-KLWGC2T-TQHAOBN-M5GEBQR [N5DJ3] 2022/05/23 19:46:00.265422 manager.go:165: DEBUG: addresses: [] [N5DJ3] 2022/05/23 19:46:00.265450 service.go:614: DEBUG: Resolved device IHZBZHW-FQQRCLX-ITF3TYR-M2EUVJ6-OFESXIV-KLWGC2T-TQHAOBN-M5GEBQR addresses: [] [N5DJ3] 2022/05/23 19:46:00.265490 service.go:473: DEBUG: Next connection loop in 5s [N5DJ3] 2022/05/23 19:46:05.265928 service.go:443: DEBUG: Connection loop [N5DJ3] 2022/05/23 19:46:05.265984 service.go:445: DEBUG: Connection loop in initial rampup [N5DJ3] 2022/05/23 19:46:05.266235 manager.go:130: DEBUG: negative cache entry for IHZBZHW-FQQRCLX-ITF3TYR-M2EUVJ6-OFESXIV-KLWGC2T-TQHAOBN-M5GEBQR at global@https://discovery.syncthing.net/v2/ valid until 2022-05-23 19:46:50.261855627 +0300 MSK m=+91.420286441 or 0001-01-01 00:00:00 +0000 UTC [N5DJ3] 2022/05/23 19:46:05.266531 manager.go:130: DEBUG: negative cache entry for IHZBZHW-FQQRCLX-ITF3TYR-M2EUVJ6-OFESXIV-KLWGC2T-TQHAOBN-M5GEBQR at global@https://discovery-v4.syncthing.net/v2/ valid until 2022-05-23 19:46:50.261861191 +0300 MSK m=+91.420291998 or 2022-05-23 20:45:50.261862315 +0300 MSK m=+3631.420293135 [N5DJ3] 2022/05/23 19:46:05.266587 manager.go:130: DEBUG: negative cache entry for IHZBZHW-FQQRCLX-ITF3TYR-M2EUVJ6-OFESXIV-KLWGC2T-TQHAOBN-M5GEBQR at global@https://discovery-v6.syncthing.net/v2/ valid until 2022-05-23 19:46:50.261863321 +0300 MSK m=+91.420294128 or 2022-05-23 20:45:50.261863488 +0300 MSK m=+3631.420294296 [N5DJ3] 2022/05/23 19:46:05.266625 manager.go:139: DEBUG: lookup for IHZBZHW-FQQRCLX-ITF3TYR-M2EUVJ6-OFESXIV-KLWGC2T-TQHAOBN-M5GEBQR at IPv4 local [N5DJ3] 2022/05/23 19:46:05.266652 manager.go:140: DEBUG: addresses: [] [N5DJ3] 2022/05/23 19:46:05.266691 manager.go:139: DEBUG: lookup for IHZBZHW-FQQRCLX-ITF3TYR-M2EUVJ6-OFESXIV-KLWGC2T-TQHAOBN-M5GEBQR at IPv6 local [N5DJ3] 2022/05/23 19:46:05.266718 manager.go:140: DEBUG: addresses: [] [N5DJ3] 2022/05/23 19:46:05.266754 manager.go:164: DEBUG: lookup results for IHZBZHW-FQQRCLX-ITF3TYR-M2EUVJ6-OFESXIV-KLWGC2T-TQHAOBN-M5GEBQR [N5DJ3] 2022/05/23 19:46:05.266787 manager.go:165: DEBUG: addresses: [] [N5DJ3] 2022/05/23 19:46:05.266822 service.go:614: DEBUG: Resolved device IHZBZHW-FQQRCLX-ITF3TYR-M2EUVJ6-OFESXIV-KLWGC2T-TQHAOBN-M5GEBQR addresses: [] [N5DJ3] 2022/05/23 19:46:05.266872 service.go:473: DEBUG: Next connection loop in 8s [N5DJ3] 2022/05/23 19:46:13.267104 service.go:443: DEBUG: Connection loop [N5DJ3] 2022/05/23 19:46:13.267158 service.go:445: DEBUG: Connection loop in initial rampup [N5DJ3] 2022/05/23 19:46:13.267521 manager.go:130: DEBUG: negative cache entry for IHZBZHW-FQQRCLX-ITF3TYR-M2EUVJ6-OFESXIV-KLWGC2T-TQHAOBN-M5GEBQR at global@https://discovery.syncthing.net/v2/ valid until 2022-05-23 19:46:50.261855627 +0300 MSK m=+91.420286441 or 0001-01-01 00:00:00 +0000 UTC [N5DJ3] 2022/05/23 19:46:13.267594 manager.go:130: DEBUG: negative cache entry for IHZBZHW-FQQRCLX-ITF3TYR-M2EUVJ6-OFESXIV-KLWGC2T-TQHAOBN-M5GEBQR at global@https://discovery-v4.syncthing.net/v2/ valid until 2022-05-23 19:46:50.261861191 +0300 MSK m=+91.420291998 or 2022-05-23 20:45:50.261862315 +0300 MSK m=+3631.420293135 [N5DJ3] 2022/05/23 19:46:13.267639 manager.go:130: DEBUG: negative cache entry for IHZBZHW-FQQRCLX-ITF3TYR-M2EUVJ6-OFESXIV-KLWGC2T-TQHAOBN-M5GEBQR at global@https://discovery-v6.syncthing.net/v2/ valid until 2022-05-23 19:46:50.261863321 +0300 MSK m=+91.420294128 or 2022-05-23 20:45:50.261863488 +0300 MSK m=+3631.420294296 [N5DJ3] 2022/05/23 19:46:13.267672 manager.go:139: DEBUG: lookup for IHZBZHW-FQQRCLX-ITF3TYR-M2EUVJ6-OFESXIV-KLWGC2T-TQHAOBN-M5GEBQR at IPv4 local [N5DJ3] 2022/05/23 19:46:13.267693 manager.go:140: DEBUG: addresses: [] [N5DJ3] 2022/05/23 19:46:13.267722 manager.go:139: DEBUG: lookup for IHZBZHW-FQQRCLX-ITF3TYR-M2EUVJ6-OFESXIV-KLWGC2T-TQHAOBN-M5GEBQR at IPv6 local [N5DJ3] 2022/05/23 19:46:13.267744 manager.go:140: DEBUG: addresses: [] [N5DJ3] 2022/05/23 19:46:13.267772 manager.go:164: DEBUG: lookup results for IHZBZHW-FQQRCLX-ITF3TYR-M2EUVJ6-OFESXIV-KLWGC2T-TQHAOBN-M5GEBQR [N5DJ3] 2022/05/23 19:46:13.267794 manager.go:165: DEBUG: addresses: [] [N5DJ3] 2022/05/23 19:46:13.267823 service.go:614: DEBUG: Resolved device IHZBZHW-FQQRCLX-ITF3TYR-M2EUVJ6-OFESXIV-KLWGC2T-TQHAOBN-M5GEBQR addresses: [] [N5DJ3] 2022/05/23 19:46:13.267862 service.go:473: DEBUG: Next connection loop in 16s [N5DJ3] 2022/05/23 19:46:20.261447 dynamic.go:59: DEBUG: DynamicClient:0xc0009660c0:@dynamic+https://relays.syncthing.net/endpoint failed to lookup dynamic relays Get "https://relays.syncthing.net/endpoint": dial tcp 82.196.13.137:443: i/o timeout [N5DJ3] 2022/05/23 19:46:20.261545 relay_listen.go:66: INFO: Relay listener (dynamic+https://relays.syncthing.net/endpoint) shutting down [N5DJ3] 2022/05/23 19:46:20.261634 svcutil.go:192: INFO: listenerSupervisor@dynamic+https://relays.syncthing.net/endpoint: service dynamic+https://relays.syncthing.net/endpoint failed: Get "https://relays.syncthing.net/endpoint": dial tcp 82.196.13.137:443: i/o timeout [N5DJ3] 2022/05/23 19:46:20.261696 svcutil.go:195: DEBUG: listenerSupervisor@dynamic+https://relays.syncthing.net/endpoint: Failed service 'dynamic+https://relays.syncthing.net/endpoint' (1.499990 failures of 2.000000), restarting: true, error: Get "https://relays.syncthing.net/endpoint": dial tcp 82.196.13.137:443: i/o timeout [N5DJ3] 2022/05/23 19:46:20.261777 relay_listen.go:58: INFO: Relay listener (dynamic+https://relays.syncthing.net/endpoint) starting [N5DJ3] 2022/05/23 19:46:20.261911 dynamic.go:49: DEBUG: DynamicClient:0xc000101f20:@dynamic+https://relays.syncthing.net/endpoint looking up dynamic relays [N5DJ3] 2022/05/23 19:46:20.262518 local.go:196: DEBUG: discover: Received local announcement from 192.168.0.11:36750 for N5DJ3SN-YVQJJ3Z-C3OIBLN-DQJ7A6A-C2XSPUF-NEADUVR-J6AV6OU-DYZLNQ3 [N5DJ3] 2022/05/23 19:46:20.262584 local.go:196: DEBUG: discover: Received local announcement from [fe80::7df1:d85d:f8e5:b7e5%wlp0s20f3]:38633 for N5DJ3SN-YVQJJ3Z-C3OIBLN-DQJ7A6A-C2XSPUF-NEADUVR-J6AV6OU-DYZLNQ3 [N5DJ3] 2022/05/23 19:46:22.265125 global.go:259: DEBUG: global@https://discovery-v6.syncthing.net/v2/ Announcement: {[tcp://0.0.0.0:22000 tcp://192.168.0.11:22000 tcp://0.0.0.0:0 quic://0.0.0.0:22000 quic://192.168.0.11:22000 quic://85.93.60.210:3594]} [N5DJ3] 2022/05/23 19:46:22.267379 global.go:263: DEBUG: global@https://discovery-v6.syncthing.net/v2/ announce POST: Post "https://discovery-v6.syncthing.net/v2/": dial tcp [2a03:b0c0:0:1010::bb:4001]:443: connect: network is unreachable [N5DJ3] 2022/05/23 19:46:24.267509 global.go:263: DEBUG: global@https://discovery-v4.syncthing.net/v2/ announce POST: Post "https://discovery-v4.syncthing.net/v2/": context deadline exceeded (Client.Timeout exceeded while awaiting headers) [N5DJ3] 2022/05/23 19:46:26.269140 global.go:259: DEBUG: global@https://discovery-v4.syncthing.net/v2/ Announcement: {[tcp://0.0.0.0:22000 tcp://192.168.0.11:22000 tcp://0.0.0.0:0 quic://0.0.0.0:22000 quic://192.168.0.11:22000 quic://85.93.60.210:3594]} [N5DJ3] 2022/05/23 19:46:29.268672 service.go:443: DEBUG: Connection loop [N5DJ3] 2022/05/23 19:46:29.268724 service.go:445: DEBUG: Connection loop in initial rampup [N5DJ3] 2022/05/23 19:46:29.268978 manager.go:130: DEBUG: negative cache entry for IHZBZHW-FQQRCLX-ITF3TYR-M2EUVJ6-OFESXIV-KLWGC2T-TQHAOBN-M5GEBQR at global@https://discovery.syncthing.net/v2/ valid until 2022-05-23 19:46:50.261855627 +0300 MSK m=+91.420286441 or 0001-01-01 00:00:00 +0000 UTC [N5DJ3] 2022/05/23 19:46:29.269037 manager.go:130: DEBUG: negative cache entry for IHZBZHW-FQQRCLX-ITF3TYR-M2EUVJ6-OFESXIV-KLWGC2T-TQHAOBN-M5GEBQR at global@https://discovery-v4.syncthing.net/v2/ valid until 2022-05-23 19:46:50.261861191 +0300 MSK m=+91.420291998 or 2022-05-23 20:45:50.261862315 +0300 MSK m=+3631.420293135 [N5DJ3] 2022/05/23 19:46:29.269085 manager.go:130: DEBUG: negative cache entry for IHZBZHW-FQQRCLX-ITF3TYR-M2EUVJ6-OFESXIV-KLWGC2T-TQHAOBN-M5GEBQR at global@https://discovery-v6.syncthing.net/v2/ valid until 2022-05-23 19:46:50.261863321 +0300 MSK m=+91.420294128 or 2022-05-23 20:45:50.261863488 +0300 MSK m=+3631.420294296 [N5DJ3] 2022/05/23 19:46:29.269175 manager.go:139: DEBUG: lookup for IHZBZHW-FQQRCLX-ITF3TYR-M2EUVJ6-OFESXIV-KLWGC2T-TQHAOBN-M5GEBQR at IPv4 local [N5DJ3] 2022/05/23 19:46:29.269204 manager.go:140: DEBUG: addresses: [] [N5DJ3] 2022/05/23 19:46:29.269244 manager.go:139: DEBUG: lookup for IHZBZHW-FQQRCLX-ITF3TYR-M2EUVJ6-OFESXIV-KLWGC2T-TQHAOBN-M5GEBQR at IPv6 local [N5DJ3] 2022/05/23 19:46:29.269273 manager.go:140: DEBUG: addresses: [] [N5DJ3] 2022/05/23 19:46:29.269307 manager.go:164: DEBUG: lookup results for IHZBZHW-FQQRCLX-ITF3TYR-M2EUVJ6-OFESXIV-KLWGC2T-TQHAOBN-M5GEBQR [N5DJ3] 2022/05/23 19:46:29.269330 manager.go:165: DEBUG: addresses: [] [N5DJ3] 2022/05/23 19:46:29.269363 service.go:614: DEBUG: Resolved device IHZBZHW-FQQRCLX-ITF3TYR-M2EUVJ6-OFESXIV-KLWGC2T-TQHAOBN-M5GEBQR addresses: [] [N5DJ3] 2022/05/23 19:46:29.269410 service.go:473: DEBUG: Next connection loop in 32s [N5DJ3] 2022/05/23 19:46:50.263038 dynamic.go:59: DEBUG: DynamicClient:0xc000101f20:@dynamic+https://relays.syncthing.net/endpoint failed to lookup dynamic relays Get "https://relays.syncthing.net/endpoint": dial tcp 82.196.13.137:443: i/o timeout [N5DJ3] 2022/05/23 19:46:50.263160 relay_listen.go:66: INFO: Relay listener (dynamic+https://relays.syncthing.net/endpoint) shutting down [N5DJ3] 2022/05/23 19:46:50.263282 svcutil.go:192: INFO: listenerSupervisor@dynamic+https://relays.syncthing.net/endpoint: service dynamic+https://relays.syncthing.net/endpoint failed: Get "https://relays.syncthing.net/endpoint": dial tcp 82.196.13.137:443: i/o timeout [N5DJ3] 2022/05/23 19:46:50.263362 svcutil.go:195: DEBUG: listenerSupervisor@dynamic+https://relays.syncthing.net/endpoint: Failed service 'dynamic+https://relays.syncthing.net/endpoint' (1.749967 failures of 2.000000), restarting: true, error: Get "https://relays.syncthing.net/endpoint": dial tcp 82.196.13.137:443: i/o timeout [N5DJ3] 2022/05/23 19:46:50.263460 relay_listen.go:58: INFO: Relay listener (dynamic+https://relays.syncthing.net/endpoint) starting [N5DJ3] 2022/05/23 19:46:50.263647 dynamic.go:49: DEBUG: DynamicClient:0xc0006c4300:@dynamic+https://relays.syncthing.net/endpoint looking up dynamic relays [N5DJ3] 2022/05/23 19:46:50.264888 local.go:196: DEBUG: discover: Received local announcement from 192.168.0.11:36750 for N5DJ3SN-YVQJJ3Z-C3OIBLN-DQJ7A6A-C2XSPUF-NEADUVR-J6AV6OU-DYZLNQ3 [N5DJ3] 2022/05/23 19:46:50.264987 local.go:196: DEBUG: discover: Received local announcement from [fe80::7df1:d85d:f8e5:b7e5%wlp0s20f3]:38633 for N5DJ3SN-YVQJJ3Z-C3OIBLN-DQJ7A6A-C2XSPUF-NEADUVR-J6AV6OU-DYZLNQ3 [N5DJ3] 2022/05/23 19:46:52.268028 global.go:259: DEBUG: global@https://discovery-v6.syncthing.net/v2/ Announcement: {[tcp://0.0.0.0:22000 tcp://192.168.0.11:22000 tcp://0.0.0.0:0 quic://0.0.0.0:22000 quic://192.168.0.11:22000 quic://85.93.60.210:3594]} [N5DJ3] 2022/05/23 19:46:52.270312 global.go:263: DEBUG: global@https://discovery-v6.syncthing.net/v2/ announce POST: Post "https://discovery-v6.syncthing.net/v2/": dial tcp [2a03:b0c0:0:1010::bb:4001]:443: connect: network is unreachable [N5DJ3] 2022/05/23 19:46:56.272846 global.go:263: DEBUG: global@https://discovery-v4.syncthing.net/v2/ announce POST: Post "https://discovery-v4.syncthing.net/v2/": context deadline exceeded (Client.Timeout exceeded while awaiting headers) [N5DJ3] 2022/05/23 19:46:58.277128 global.go:259: DEBUG: global@https://discovery-v4.syncthing.net/v2/ Announcement: {[tcp://0.0.0.0:22000 tcp://192.168.0.11:22000 tcp://0.0.0.0:0 quic://0.0.0.0:22000 quic://192.168.0.11:22000 quic://85.93.60.210:3594]} [N5DJ3] 2022/05/23 19:47:01.271607 service.go:443: DEBUG: Connection loop [N5DJ3] 2022/05/23 19:47:01.271811 manager.go:139: DEBUG: lookup for IHZBZHW-FQQRCLX-ITF3TYR-M2EUVJ6-OFESXIV-KLWGC2T-TQHAOBN-M5GEBQR at IPv4 local [N5DJ3] 2022/05/23 19:47:01.271841 manager.go:140: DEBUG: addresses: [] [N5DJ3] 2022/05/23 19:47:01.271904 manager.go:139: DEBUG: lookup for IHZBZHW-FQQRCLX-ITF3TYR-M2EUVJ6-OFESXIV-KLWGC2T-TQHAOBN-M5GEBQR at IPv6 local [N5DJ3] 2022/05/23 19:47:01.271927 manager.go:140: DEBUG: addresses: [] [N5DJ3] 2022/05/23 19:47:20.260898 local.go:196: DEBUG: discover: Received local announcement from [fe80::7df1:d85d:f8e5:b7e5%wlp0s20f3]:38633 for N5DJ3SN-YVQJJ3Z-C3OIBLN-DQJ7A6A-C2XSPUF-NEADUVR-J6AV6OU-DYZLNQ3 [N5DJ3] 2022/05/23 19:47:20.260937 local.go:196: DEBUG: discover: Received local announcement from 192.168.0.11:36750 for N5DJ3SN-YVQJJ3Z-C3OIBLN-DQJ7A6A-C2XSPUF-NEADUVR-J6AV6OU-DYZLNQ3 [N5DJ3] 2022/05/23 19:47:20.264940 dynamic.go:59: DEBUG: DynamicClient:0xc0006c4300:@dynamic+https://relays.syncthing.net/endpoint failed to lookup dynamic relays Get "https://relays.syncthing.net/endpoint": dial tcp 82.196.13.137:443: i/o timeout [N5DJ3] 2022/05/23 19:47:20.264969 relay_listen.go:66: INFO: Relay listener (dynamic+https://relays.syncthing.net/endpoint) shutting down [N5DJ3] 2022/05/23 19:47:20.264999 svcutil.go:192: INFO: listenerSupervisor@dynamic+https://relays.syncthing.net/endpoint: service dynamic+https://relays.syncthing.net/endpoint failed: Get "https://relays.syncthing.net/endpoint": dial tcp 82.196.13.137:443: i/o timeout [N5DJ3] 2022/05/23 19:47:20.265015 svcutil.go:195: DEBUG: listenerSupervisor@dynamic+https://relays.syncthing.net/endpoint: Failed service 'dynamic+https://relays.syncthing.net/endpoint' (1.874948 failures of 2.000000), restarting: true, error: Get "https://relays.syncthing.net/endpoint": dial tcp 82.196.13.137:443: i/o timeout [N5DJ3] 2022/05/23 19:47:20.265036 relay_listen.go:58: INFO: Relay listener (dynamic+https://relays.syncthing.net/endpoint) starting [N5DJ3] 2022/05/23 19:47:20.265068 dynamic.go:49: DEBUG: DynamicClient:0xc00086fa40:@dynamic+https://relays.syncthing.net/endpoint looking up dynamic relays [N5DJ3] 2022/05/23 19:47:22.268684 global.go:259: DEBUG: global@https://discovery-v6.syncthing.net/v2/ Announcement: {[tcp://0.0.0.0:22000 tcp://192.168.0.11:22000 tcp://0.0.0.0:0 quic://0.0.0.0:22000 quic://192.168.0.11:22000 quic://85.93.60.210:3594]} [N5DJ3] 2022/05/23 19:47:22.269242 global.go:263: DEBUG: global@https://discovery-v6.syncthing.net/v2/ announce POST: Post "https://discovery-v6.syncthing.net/v2/": dial tcp [2a03:b0c0:0:1010::bb:4001]:443: connect: network is unreachable [N5DJ3] 2022/05/23 19:47:28.280700 global.go:263: DEBUG: global@https://discovery-v4.syncthing.net/v2/ announce POST: Post "https://discovery-v4.syncthing.net/v2/": context deadline exceeded (Client.Timeout exceeded while awaiting headers)