Xray-core icon indicating copy to clipboard operation
Xray-core copied to clipboard

Vision: 连接总是在服务端 connIdle 设置的 2 倍时间断线

Open MetaZuo opened this issue 9 months ago • 13 comments

完整性要求

  • [X] 我保证阅读了文档,了解所有我编写的配置文件项的含义,而不是大量堆砌看似有用的选项或默认值。
  • [X] 我搜索了issues,没有发现已提出的类似问题。

版本

1.8.11

描述

Windows 电脑 pip 走代理下载包的时候总是在一定进度断线,手动使用 curl 下载可复现问题。以下载 torch 包为例,命令:

curl -O https://download.pytorch.org/whl/cu121/torch-2.3.0%2Bcu121-cp311-cp311-win_amd64.whl -x "socks5://127.0.0.1:1181"

服务端配置的 connIdle 为 128,下载总是会在 4:17(即 256 s) 断线。服务端 connIdle 改为 20,则会在 40 s 时断线。尝试多组数字均满足规律。并且使用浏览器下载时能够正常完成,似乎仅影响 pip 和 上述 curl 命令等单条连接的情况。

客户端:最初在 Openwrt (arm64) 路由器透明代理(使用 passwall)时观察到,后为了排除路由器自身原因,使用多个设备连接公共 Wifi 测试,仅在 Windows 下仍然观察到此问题,Linux, ios, MacOS 无论自己的路由器/公共wifi均正常。可稳定复现。

服务器:切换使用2家云主机商的3台vps,现象相同。

重现方式

Server config:

{
  "log": {
    "loglevel": "debug",
    "error": "/var/log/xray/error.log",
    "access": "/var/log/xray/access.log"
  },
  "api": {
    "services": [
      "HandlerService",
      "LoggerService",
      "StatsService"
    ],
    "tag": "api"
  },
  "stats": {},
  "policy": {
    "levels": {
      "0": {
        "handshake": 2,
        "connIdle": 128,
        "statsUserUplink": true,
        "statsUserDownlink": true
      }
    },
    "system": {
      "statsInboundUplink": true,
      "statsInboundDownlink": true,
      "statsOutboundUplink": true,
      "statsOutboundDownlink": true
    }
  },
  "dns": {
    "servers": [
      "https+local://cloudflare-dns.com/dns-query",
      "1.1.1.1",
      "1.0.0.1",
      "8.8.8.8",
      "8.8.4.4",
      "localhost"
    ]
  },
  "routing": {
    省略
  },
  "inbounds": [
    {
      "listen": "127.0.0.1",
      "port": 32768,
      "protocol": "dokodemo-door",
      "settings": {
        "address": "127.0.0.1"
      },
      "tag": "api",
      "sniffing": null
    },
    {
      "tag": "xray-script-xtls-reality",
      "listen": "0.0.0.0",
      "port": 443,
      "protocol": "vless",
      "settings": {
        "clients": [
          {
            "email": "[email protected]",
            "id": 隐去,
            "flow": "xtls-rprx-vision",
            "level": 0
          }
        ],
        "decryption": "none"
      },
      "streamSettings": {
        "network": "tcp",
        "security": "reality",
        "realitySettings": {
          "show": false,
          "dest": "learn.microsoft.com:443",
          "xver": 0,
          "serverNames": [
            "learn.microsoft.com",
            "www.learn.microsoft.com"
          ],
          "privateKey": 隐去,
          "shortIds": 隐去
        }
      },
      "sniffing": {
        "enabled": true,
        "destOverride": [
          "http",
          "tls",
          "quic"
        ]
      }
    }
  ],
  "outbounds": [
    {
      "tag": "direct",
      "protocol": "freedom"
    },
    {
      "tag": "block",
      "protocol": "blackhole"
    }
  ]
}

Windows 电脑连接公共 wifi,使用以下配置,命令行运行 xray.exe Client config:

{
  "log": {
    "access": "Vaccess.txt",
    "error": "Verror.txt",
    "loglevel": "debug"
  },
  "inbounds": [
    {
      "tag": "socks",
      "port": 1181,
      "listen": "127.0.0.1",
      "protocol": "socks",
      "sniffing": {
        "enabled": true,
        "destOverride": [
          "http",
          "tls"
        ],
        "routeOnly": false
      },
      "settings": {
        "auth": "noauth",
        "udp": true,
        "allowTransparent": false
      }
    },
    {
      "tag": "http",
      "port": 1182,
      "listen": "127.0.0.1",
      "protocol": "http",
      "sniffing": {
        "enabled": true,
        "destOverride": [
          "http",
          "tls"
        ],
        "routeOnly": false
      },
      "settings": {
        "auth": "noauth",
        "udp": true,
        "allowTransparent": false
      }
    }
  ],
  "outbounds": [
    {
      "tag": "proxy",
      "protocol": "vless",
      "settings": {
        "vnext": [
          {
            "address": 隐去,
            "port": 443,
            "users": [
              {
                "id": "隐去",
                "security": "auto",
                "encryption": "none",
                "flow": "xtls-rprx-vision"
              }
            ]
          }
        ]
      },
      "streamSettings": {
        "network": "tcp",
        "security": "reality",
        "realitySettings": {
          "serverName": "www.learn.microsoft.com",
          "fingerprint": "chrome",
          "show": false,
          "publicKey": 隐去,
          "shortId": 隐去,
          "spiderX": ""
        }
      },
      "mux": {
        "enabled": false,
        "concurrency": -1
      }
    },
    {
      "tag": "direct",
      "protocol": "freedom",
      "settings": {}
    },
    {
      "tag": "block",
      "protocol": "blackhole",
      "settings": {
        "response": {
          "type": "http"
        }
      }
    }
  ],
  "dns": {
    "hosts": {
      "dns.google": "8.8.8.8"
    },
    "servers": [
      {
        "address": "223.5.5.5",
        "domains": [
          "geosite:cn",
          "geosite:geolocation-cn"
        ],
        "expectIPs": [
          "geoip:cn"
        ]
      },
      "1.1.1.1",
      "8.8.8.8",
      "https://dns.google/dns-query"
    ]
  },
  "routing": {
    省略
  }
}

日志

Server error.log:

2024/05/09 12:45:43 [Debug] app/log: Logger started
2024/05/09 12:45:43 [Info] app/dns: DNS: created Local DOH client for https://cloudflare-dns.com/dns-query
2024/05/09 12:45:43 [Info] app/dns: DNS: created UDP client initialized for 1.1.1.1:53
2024/05/09 12:45:43 [Info] app/dns: DNS: created UDP client initialized for 1.0.0.1:53
2024/05/09 12:45:43 [Info] app/dns: DNS: created UDP client initialized for 8.8.8.8:53
2024/05/09 12:45:43 [Info] app/dns: DNS: created UDP client initialized for 8.8.4.4:53
2024/05/09 12:45:43 [Info] app/dns: DNS: created localhost client
2024/05/09 12:45:44 [Debug] app/router: MphDomainMatcher is enabled for 76264 domain rule(s)
2024/05/09 12:45:44 [Debug] app/stats: create new counter inbound>>>api>>>traffic>>>uplink
2024/05/09 12:45:44 [Debug] app/stats: create new counter inbound>>>api>>>traffic>>>downlink
2024/05/09 12:45:44 [Debug] app/proxyman/inbound: creating stream worker on 127.0.0.1:32768
2024/05/09 12:45:44 [Debug] app/stats: create new counter inbound>>>xray-script-xtls-reality>>>traffic>>>uplink
2024/05/09 12:45:44 [Debug] app/stats: create new counter inbound>>>xray-script-xtls-reality>>>traffic>>>downlink
2024/05/09 12:45:44 [Debug] app/proxyman/inbound: creating stream worker on 0.0.0.0:443
2024/05/09 12:45:44 [Debug] app/stats: create new counter outbound>>>direct>>>traffic>>>uplink
2024/05/09 12:45:44 [Debug] app/stats: create new counter outbound>>>direct>>>traffic>>>downlink
2024/05/09 12:45:44 [Debug] app/stats: create new counter outbound>>>block>>>traffic>>>uplink
2024/05/09 12:45:44 [Debug] app/stats: create new counter outbound>>>block>>>traffic>>>downlink
2024/05/09 12:45:44 [Info] transport/internet/tcp: listening TCP on 127.0.0.1:32768
2024/05/09 12:45:44 [Info] transport/internet/tcp: listening TCP on 0.0.0.0:443
2024/05/09 12:45:44 [Warning] core: Xray 1.8.11 started
2024/05/09 12:46:05 [Info] [2259118787] proxy/vless/inbound: firstLen = 1186
2024/05/09 12:46:05 [Info] [2259118787] proxy/vless/inbound: received request for tcp:download.pytorch.org:443
2024/05/09 12:46:05 [Debug] app/stats: create new counter user>>>[email protected]>>>traffic>>>uplink
2024/05/09 12:46:05 [Debug] app/stats: create new counter user>>>[email protected]>>>traffic>>>downlink
2024/05/09 12:46:05 [Info] [2259118787] proxy: Xtls Unpadding new block, content 295 padding 1002 command 0
2024/05/09 12:46:05 [Info] [2259118787] proxy: XtlsFilterTls found tls client hello! 295
2024/05/09 12:46:05 [Info] [2259118787] app/dispatcher: sniffed domain: download.pytorch.org
2024/05/09 12:46:05 [Debug] app/dns: domain download.pytorch.org will use DNS in order: [DOHL//cloudflare-dns.com UDP:1.1.1.1:53 UDP:1.0.0.1:53 UDP:8.8.8.8:53 UDP:8.8.4.4:53 localhost]
2024/05/09 12:46:05 [Info] app/dns: DOHL//cloudflare-dns.com querying: download.pytorch.org.
2024/05/09 12:46:05 [Debug] transport/internet: dialing to tcp:cloudflare-dns.com:443
2024/05/09 12:46:05 [Debug] transport/internet: dialing to tcp:cloudflare-dns.com:443
2024/05/09 12:46:05 [Info] app/dns: DOHL//cloudflare-dns.com got answer: download.pytorch.org. TypeA -> [108.139.10.61 108.139.10.124 108.139.10.87 108.139.10.122] 41.367775ms
2024/05/09 12:46:05 [Info] app/dns: DOHL//cloudflare-dns.com got answer: download.pytorch.org. TypeAAAA -> [[2600:9000:234b:c600:d:607e:4540:93a1] [2600:9000:234b:8e00:d:607e:4540:93a1] [2600:9000:234b:5a00:d:607e:4540:93a1] [2600:9000:234b:7e00:d:607e:4540:93a1] [2600:9000:234b:1200:d:607e:4540:93a1] [2600:9000:234b:ca00:d:607e:4540:93a1] [2600:9000:234b:9a00:d:607e:4540:93a1] [2600:9000:234b:aa00:d:607e:4540:93a1]] 235.674685ms
2024/05/09 12:46:05 [Info] [2259118787] app/dispatcher: default route for tcp:download.pytorch.org:443
2024/05/09 12:46:05 [Info] [2259118787] transport/internet/tcp: dialing TCP to tcp:download.pytorch.org:443
2024/05/09 12:46:05 [Debug] transport/internet: dialing to tcp:download.pytorch.org:443
2024/05/09 12:46:06 [Info] [2259118787] proxy/freedom: connection opened to tcp:download.pytorch.org:443, local endpoint [隐去]:45818, remote endpoint [2600:9000:234b:fa00:d:607e:4540:93a1]:443
2024/05/09 12:46:06 [Info] [2259118787] proxy: XtlsFilterTls found tls 1.3! 4832 TLS_AES_128_GCM_SHA256
2024/05/09 12:46:06 [Info] [2259118787] proxy: XtlsPadding 4832 128 0
2024/05/09 12:46:06 [Info] [2259118787] proxy: XtlsPadding 1155 63 0
2024/05/09 12:46:06 [Info] [2259118787] proxy: Xtls Unpadding new block, content 64 padding 1206 command 0
2024/05/09 12:46:06 [Info] [2259118787] proxy: Xtls Unpadding new block, content 160 padding 803 command 2
2024/05/09 12:46:06 [Info] [2259118787] proxy: CopyRawConn readv
2024/05/09 12:46:06 [Info] [2259118787] proxy: XtlsPadding 146 1216 2
2024/05/09 12:46:06 [Info] [2259118787] proxy: CopyRawConn splice
2024/05/09 12:46:45 [Info] [2259118787] app/proxyman/inbound: connection ends > proxy/vless/inbound: connection ends > context canceled

Server access.log:

2024/05/09 12:46:05 DNS accepted https://cloudflare-dns.com/dns-query [local]
2024/05/09 12:46:05 DNS accepted https://cloudflare-dns.com/dns-query [local]
2024/05/09 12:46:05 隐去:62515 accepted tcp:download.pytorch.org:443 [xray-script-xtls-reality >> direct] email: [email protected]

Client Verror.txt:

2024/05/09 20:44:58 [Debug] app/log: Logger started
2024/05/09 20:44:58 [Info] app/dns: DNS: created UDP client initialized for 223.5.5.5:53
2024/05/09 20:44:58 [Info] app/dns: DNS: created UDP client initialized for 1.1.1.1:53
2024/05/09 20:44:58 [Info] app/dns: DNS: created UDP client initialized for 8.8.8.8:53
2024/05/09 20:44:58 [Info] app/dns: DNS: created Remote DOH client for https://dns.google/dns-query
2024/05/09 20:44:58 [Debug] app/proxyman/inbound: creating stream worker on 127.0.0.1:1181
2024/05/09 20:44:58 [Debug] app/proxyman/inbound: creating stream worker on 127.0.0.1:1182
2024/05/09 20:44:58 [Debug] app/proxyman/inbound: creating stream worker on 127.0.0.1:1186
2024/05/09 20:44:58 [Debug] app/stats: create new counter outbound>>>proxy>>>traffic>>>uplink
2024/05/09 20:44:58 [Debug] app/stats: create new counter outbound>>>proxy>>>traffic>>>downlink
2024/05/09 20:44:58 [Debug] app/stats: create new counter outbound>>>direct>>>traffic>>>uplink
2024/05/09 20:44:58 [Debug] app/stats: create new counter outbound>>>direct>>>traffic>>>downlink
2024/05/09 20:44:58 [Debug] app/stats: create new counter outbound>>>block>>>traffic>>>uplink
2024/05/09 20:44:58 [Debug] app/stats: create new counter outbound>>>block>>>traffic>>>downlink
2024/05/09 20:44:58 [Info] transport/internet/tcp: listening TCP on 127.0.0.1:1181
2024/05/09 20:44:58 [Info] transport/internet/udp: listening UDP on 127.0.0.1:1181
2024/05/09 20:44:58 [Info] transport/internet/tcp: listening TCP on 127.0.0.1:1182
2024/05/09 20:44:58 [Info] transport/internet/tcp: listening TCP on 127.0.0.1:1186
2024/05/09 20:44:58 [Warning] core: Xray 1.8.11 started
2024/05/09 20:45:06 [Debug] app/log: Logger closing
2024/05/09 20:45:57 [Debug] app/log: Logger started
2024/05/09 20:45:57 [Info] app/dns: DNS: created UDP client initialized for 223.5.5.5:53
2024/05/09 20:45:57 [Info] app/dns: DNS: created UDP client initialized for 1.1.1.1:53
2024/05/09 20:45:57 [Info] app/dns: DNS: created UDP client initialized for 8.8.8.8:53
2024/05/09 20:45:57 [Info] app/dns: DNS: created Remote DOH client for https://dns.google/dns-query
2024/05/09 20:45:57 [Debug] app/proxyman/inbound: creating stream worker on 127.0.0.1:1181
2024/05/09 20:45:57 [Debug] app/proxyman/inbound: creating stream worker on 127.0.0.1:1182
2024/05/09 20:45:57 [Debug] app/proxyman/inbound: creating stream worker on 127.0.0.1:1186
2024/05/09 20:45:57 [Debug] app/stats: create new counter outbound>>>proxy>>>traffic>>>uplink
2024/05/09 20:45:57 [Debug] app/stats: create new counter outbound>>>proxy>>>traffic>>>downlink
2024/05/09 20:45:57 [Debug] app/stats: create new counter outbound>>>direct>>>traffic>>>uplink
2024/05/09 20:45:57 [Debug] app/stats: create new counter outbound>>>direct>>>traffic>>>downlink
2024/05/09 20:45:57 [Debug] app/stats: create new counter outbound>>>block>>>traffic>>>uplink
2024/05/09 20:45:57 [Debug] app/stats: create new counter outbound>>>block>>>traffic>>>downlink
2024/05/09 20:45:57 [Info] transport/internet/tcp: listening TCP on 127.0.0.1:1181
2024/05/09 20:45:57 [Info] transport/internet/udp: listening UDP on 127.0.0.1:1181
2024/05/09 20:45:57 [Info] transport/internet/tcp: listening TCP on 127.0.0.1:1182
2024/05/09 20:45:57 [Info] transport/internet/tcp: listening TCP on 127.0.0.1:1186
2024/05/09 20:45:57 [Warning] core: Xray 1.8.11 started
2024/05/09 20:46:03 [Info] [3857171807] proxy/socks: TCP Connect request to tcp:[2600:9000:2135:1600:d:607e:4540:93a1]:443
2024/05/09 20:46:03 [Info] [3857171807] app/dispatcher: sniffed domain: download.pytorch.org
2024/05/09 20:46:03 [Info] [3857171807] app/dispatcher: taking detour [proxy] for [tcp:download.pytorch.org:443]
2024/05/09 20:46:03 [Info] [3857171807] transport/internet/tcp: dialing TCP to tcp:隐去:443
2024/05/09 20:46:03 [Debug] transport/internet: dialing to tcp:隐去:443
2024/05/09 20:46:03 [Info] [3857171807] proxy/vless/outbound: tunneling request to tcp:download.pytorch.org:443 via 隐去:443
2024/05/09 20:46:03 [Info] [3857171807] proxy: XtlsFilterTls found tls client hello! 295
2024/05/09 20:46:03 [Info] [3857171807] proxy: XtlsPadding 295 1002 0
2024/05/09 20:46:04 [Info] [3857171807] proxy: Xtls Unpadding new block, content 4832 padding 128 command 0
2024/05/09 20:46:04 [Info] [3857171807] proxy: XtlsFilterTls found tls 1.3! 1163 TLS_AES_128_GCM_SHA256
2024/05/09 20:46:04 [Info] [3857171807] proxy: Xtls Unpadding new block, content 1155 padding 63 command 0
2024/05/09 20:46:04 [Info] [3857171807] proxy: XtlsPadding 64 1206 0
2024/05/09 20:46:04 [Info] [3857171807] proxy: XtlsPadding 160 803 2
2024/05/09 20:46:04 [Info] [3857171807] proxy: Xtls Unpadding new block, content 146 padding 1216 command 2
2024/05/09 20:46:04 [Info] [3857171807] proxy: CopyRawConn readv
2024/05/09 20:46:49 [Info] [3857171807] app/proxyman/inbound: connection ends > proxy/socks: connection ends > context canceled
2024/05/09 20:46:54 [Debug] app/log: Logger closing

Client Vaccess.txt:

2024/05/09 20:46:03 tcp:127.0.0.1:62512 accepted tcp:[2600:9000:2135:1600:d:607e:4540:93a1]:443 [socks -> proxy]

MetaZuo avatar May 09 '24 13:05 MetaZuo

测试时只把 Server config 里面的 connIdle 改成了 20,写 issue 时忘记更新了。Server log 可见 2024/05/09 12:46:05 [Info] [2259118787] proxy/vless/inbound: received request for tcp:download.pytorch.org:443 40秒后 2024/05/09 12:46:45 [Info] [2259118787] app/proxyman/inbound: connection ends > proxy/vless/inbound: connection ends > context canceled (Server 时区 UTC+0,Client 时区 UTC+8)

MetaZuo avatar May 09 '24 13:05 MetaZuo

xtls对于timer的实现似乎不正确 关掉flow试一试

Fangliding avatar May 09 '24 15:05 Fangliding

xtls对于timer的实现似乎不正确 关掉flow试一试

服务端和客户端 flow 都置空,的确没有再断了

MetaZuo avatar May 09 '24 16:05 MetaZuo

xtls对于timer的实现似乎不正确 关掉flow试一试

服务端和客户端 flow 都置空,的确没有再断了

关掉flow不会失去安全性吗

WhyFear avatar May 11 '24 04:05 WhyFear

是bug 会修的 要关只是确认一下

Fangliding avatar May 11 '24 04:05 Fangliding

@MetaZuo 真牛逼,這麼隱藏的bug都被你發現了

UbiVPN avatar May 12 '24 09:05 UbiVPN

已知潜在问题,双向 Splice 会导致 timer 没被更新从而掐断连接 @yuhan6665

RPRX avatar May 15 '24 00:05 RPRX

可以吧 ~~这周再填一个坑~~

yuhan6665 avatar May 15 '24 01:05 yuhan6665

可以吧 ~这周再填一个坑~

这个坑挺好填的,Splice 又观察不了,~~不就只有把 timeout 扔掉这一个方法吗~~

RPRX avatar May 15 '24 02:05 RPRX

~~代码复杂 不知道timeout是咋运行的~~

yuhan6665 avatar May 15 '24 03:05 yuhan6665

~代码复杂 不知道timeout是咋运行的~

timer在 https://github.com/XTLS/Xray-core/blob/26d49df22e8f9839bd1b167b68aa7f7b90d9b293/proxy/vless/outbound/outbound.go#L238 被传入 encoding.XtlsWrite() 在其内部好像只有一个简单粗暴的 https://github.com/XTLS/Xray-core/blob/26d49df22e8f9839bd1b167b68aa7f7b90d9b293/proxy/vless/encoding/encoding.go#L248 在其他情况下 这个timer是这么用的 https://github.com/XTLS/Xray-core/blob/26d49df22e8f9839bd1b167b68aa7f7b90d9b293/proxy/vless/outbound/outbound.go#L241

Fangliding avatar May 15 '24 03:05 Fangliding

不知道 Linux 双向 Splice 后有没有自带不活跃超时机制,~~希望它有~~,或者有 syscall 能给单个 TCP socket 设置不活跃超时关闭也行

RPRX avatar May 15 '24 13:05 RPRX

yuhan6665:我没实现双向 splice。。只是加了 freedom 下行方向。。 R佬:这里说的那些软件 开始下载后上行不活跃的

yuhan6665 avatar May 15 '24 14:05 yuhan6665

@MetaZuo 能麻烦你两端换成最新构建试下 https://github.com/XTLS/Xray-core/actions/runs/9143464115

yuhan6665 avatar May 19 '24 00:05 yuhan6665

@MetaZuo 能麻烦你两端换成最新构建试下 https://github.com/XTLS/Xray-core/actions/runs/9143464115

@yuhan6665 bug依然存在,症状相同,已确认双端运行的构建版本都是3168d27

server error.log

2024/05/19 05:26:51 [Debug] app/log: Logger started
2024/05/19 05:26:51 [Info] app/dns: DNS: created Local DOH client for https://cloudflare-dns.com/dns-query
2024/05/19 05:26:51 [Info] app/dns: DNS: created UDP client initialized for 1.1.1.1:53
2024/05/19 05:26:51 [Info] app/dns: DNS: created UDP client initialized for 1.0.0.1:53
2024/05/19 05:26:51 [Info] app/dns: DNS: created UDP client initialized for 8.8.8.8:53
2024/05/19 05:26:51 [Info] app/dns: DNS: created UDP client initialized for 8.8.4.4:53
2024/05/19 05:26:51 [Info] app/dns: DNS: created localhost client
2024/05/19 05:26:51 [Debug] app/router: MphDomainMatcher is enabled for 76581 domain rule(s)
2024/05/19 05:26:51 [Debug] app/stats: create new counter inbound>>>api>>>traffic>>>uplink
2024/05/19 05:26:51 [Debug] app/stats: create new counter inbound>>>api>>>traffic>>>downlink
2024/05/19 05:26:51 [Debug] app/proxyman/inbound: creating stream worker on 127.0.0.1:32768
2024/05/19 05:26:51 [Debug] app/stats: create new counter inbound>>>xray-script-xtls-reality>>>traffic>>>uplink
2024/05/19 05:26:51 [Debug] app/stats: create new counter inbound>>>xray-script-xtls-reality>>>traffic>>>downlink
2024/05/19 05:26:51 [Debug] app/proxyman/inbound: creating stream worker on 0.0.0.0:443
2024/05/19 05:26:51 [Debug] app/stats: create new counter outbound>>>direct>>>traffic>>>uplink
2024/05/19 05:26:51 [Debug] app/stats: create new counter outbound>>>direct>>>traffic>>>downlink
2024/05/19 05:26:51 [Debug] app/stats: create new counter outbound>>>block>>>traffic>>>uplink
2024/05/19 05:26:51 [Debug] app/stats: create new counter outbound>>>block>>>traffic>>>downlink
2024/05/19 05:26:51 [Info] transport/internet/tcp: listening TCP on 127.0.0.1:32768
2024/05/19 05:26:51 [Info] transport/internet/tcp: listening TCP on 0.0.0.0:443
2024/05/19 05:26:51 [Warning] core: Xray 1.8.11 started
2024/05/19 05:27:10 [Info] [3895005955] proxy/vless/inbound: firstLen = 1186
2024/05/19 05:27:10 [Info] [3895005955] proxy/vless/inbound: received request for tcp:download.pytorch.org:443
2024/05/19 05:27:10 [Debug] app/stats: create new counter user>>>[email protected]>>>traffic>>>uplink
2024/05/19 05:27:10 [Debug] app/stats: create new counter user>>>[email protected]>>>traffic>>>downlink
2024/05/19 05:27:10 [Info] [3895005955] proxy: Xtls Unpadding new block, content 295 padding 847 command 0
2024/05/19 05:27:10 [Info] [3895005955] proxy: XtlsFilterTls found tls client hello! 295
2024/05/19 05:27:10 [Info] [3895005955] app/dispatcher: sniffed domain: download.pytorch.org
2024/05/19 05:27:10 [Debug] app/dns: domain download.pytorch.org will use DNS in order: [DOHL//cloudflare-dns.com UDP:1.1.1.1:53 UDP:1.0.0.1:53 UDP:8.8.8.8:53 UDP:8.8.4.4:53 localhost]
2024/05/19 05:27:10 [Info] app/dns: DOHL//cloudflare-dns.com querying: download.pytorch.org.
2024/05/19 05:27:10 [Debug] transport/internet: dialing to tcp:cloudflare-dns.com:443
2024/05/19 05:27:10 [Debug] transport/internet: dialing to tcp:cloudflare-dns.com:443
2024/05/19 05:27:10 [Info] app/dns: DOHL//cloudflare-dns.com got answer: download.pytorch.org. TypeAAAA -> [[2600:9000:2135:b200:d:607e:4540:93a1] [2600:9000:2135:3600:d:607e:4540:93a1] [2600:9000:2135:5000:d:607e:4540:93a1] [2600:9000:2135:5e00:d:607e:4540:93a1] [2600:9000:2135:1a00:d:607e:4540:93a1] [2600:9000:2135:9a00:d:607e:4540:93a1] [2600:9000:2135:7a00:d:607e:4540:93a1] [2600:9000:2135:d400:d:607e:4540:93a1]] 91.312846ms
2024/05/19 05:27:10 [Info] app/dns: DOHL//cloudflare-dns.com got answer: download.pytorch.org. TypeA -> [13.224.163.76 13.224.163.73 13.224.163.10 13.224.163.42] 173.108302ms
2024/05/19 05:27:10 [Info] [3895005955] app/dispatcher: default route for tcp:download.pytorch.org:443
2024/05/19 05:27:10 [Info] [3895005955] transport/internet/tcp: dialing TCP to tcp:download.pytorch.org:443
2024/05/19 05:27:10 [Debug] transport/internet: dialing to tcp:download.pytorch.org:443
2024/05/19 05:27:11 [Info] [3895005955] proxy/freedom: connection opened to tcp:download.pytorch.org:443, local endpoint [隐去]:54608, remote endpoint [2600:9000:2135:5c00:d:607e:4540:93a1]:443
2024/05/19 05:27:11 [Info] [3895005955] proxy: XtlsFilterTls found tls 1.3! 4832 TLS_AES_128_GCM_SHA256
2024/05/19 05:27:11 [Info] [3895005955] proxy: XtlsPadding 4832 124 0
2024/05/19 05:27:11 [Info] [3895005955] proxy: XtlsPadding 1155 214 0
2024/05/19 05:27:11 [Info] [3895005955] proxy: Xtls Unpadding new block, content 64 padding 849 command 0
2024/05/19 05:27:11 [Info] [3895005955] proxy: Xtls Unpadding new block, content 160 padding 752 command 2
2024/05/19 05:27:11 [Info] [3895005955] proxy: CopyRawConn readv
2024/05/19 05:27:11 [Info] [3895005955] proxy: XtlsPadding 146 1132 2
2024/05/19 05:27:11 [Info] [3895005955] proxy: CopyRawConn splice
2024/05/19 05:27:50 [Info] [3895005955] app/proxyman/inbound: connection ends > proxy/vless/inbound: connection ends > context canceled

client Verror.txt

2024/05/19 13:27:04 [Debug] app/log: Logger started
2024/05/19 13:27:04 [Info] app/dns: DNS: created UDP client initialized for 223.5.5.5:53
2024/05/19 13:27:04 [Info] app/dns: DNS: created UDP client initialized for 1.1.1.1:53
2024/05/19 13:27:04 [Info] app/dns: DNS: created UDP client initialized for 8.8.8.8:53
2024/05/19 13:27:04 [Info] app/dns: DNS: created Remote DOH client for https://dns.google/dns-query
2024/05/19 13:27:04 [Debug] app/proxyman/inbound: creating stream worker on 127.0.0.1:1181
2024/05/19 13:27:04 [Debug] app/proxyman/inbound: creating stream worker on 127.0.0.1:1182
2024/05/19 13:27:04 [Debug] app/proxyman/inbound: creating stream worker on 127.0.0.1:1186
2024/05/19 13:27:04 [Debug] app/stats: create new counter outbound>>>proxy>>>traffic>>>uplink
2024/05/19 13:27:04 [Debug] app/stats: create new counter outbound>>>proxy>>>traffic>>>downlink
2024/05/19 13:27:04 [Debug] app/stats: create new counter outbound>>>direct>>>traffic>>>uplink
2024/05/19 13:27:04 [Debug] app/stats: create new counter outbound>>>direct>>>traffic>>>downlink
2024/05/19 13:27:04 [Debug] app/stats: create new counter outbound>>>block>>>traffic>>>uplink
2024/05/19 13:27:04 [Debug] app/stats: create new counter outbound>>>block>>>traffic>>>downlink
2024/05/19 13:27:04 [Info] transport/internet/tcp: listening TCP on 127.0.0.1:1181
2024/05/19 13:27:04 [Info] transport/internet/udp: listening UDP on 127.0.0.1:1181
2024/05/19 13:27:04 [Info] transport/internet/tcp: listening TCP on 127.0.0.1:1182
2024/05/19 13:27:04 [Info] transport/internet/tcp: listening TCP on 127.0.0.1:1186
2024/05/19 13:27:04 [Warning] core: Xray 1.8.11 started
2024/05/19 13:27:09 [Info] [845647488] proxy/socks: TCP Connect request to tcp:18.65.3.71:443
2024/05/19 13:27:09 [Info] [845647488] app/dispatcher: sniffed domain: download.pytorch.org
2024/05/19 13:27:09 [Info] [845647488] app/dispatcher: taking detour [proxy] for [tcp:download.pytorch.org:443]
2024/05/19 13:27:09 [Info] [845647488] transport/internet/tcp: dialing TCP to tcp:隐去:443
2024/05/19 13:27:09 [Debug] transport/internet: dialing to tcp:隐去:443
2024/05/19 13:27:09 [Info] [845647488] proxy/vless/outbound: tunneling request to tcp:download.pytorch.org:443 via 隐去:443
2024/05/19 13:27:09 [Info] [845647488] proxy: XtlsFilterTls found tls client hello! 295
2024/05/19 13:27:09 [Info] [845647488] proxy: XtlsPadding 295 847 0
2024/05/19 13:27:10 [Info] [845647488] proxy: Xtls Unpadding new block, content 4832 padding 124 command 0
2024/05/19 13:27:10 [Info] [845647488] proxy: XtlsFilterTls found tls 1.3! 1163 TLS_AES_128_GCM_SHA256
2024/05/19 13:27:10 [Info] [845647488] proxy: Xtls Unpadding new block, content 1155 padding 214 command 0
2024/05/19 13:27:10 [Info] [845647488] proxy: XtlsPadding 64 849 0
2024/05/19 13:27:10 [Info] [845647488] proxy: XtlsPadding 160 752 2
2024/05/19 13:27:10 [Info] [845647488] proxy: Xtls Unpadding new block, content 146 padding 1132 command 2
2024/05/19 13:27:10 [Info] [845647488] proxy: CopyRawConn readv
2024/05/19 13:27:51 [Info] [845647488] app/proxyman/inbound: connection ends > proxy/socks: connection ends > context canceled
2024/05/19 13:28:45 [Debug] app/log: Logger closing

MetaZuo avatar May 19 '24 05:05 MetaZuo

@MetaZuo 你的日志帮我想起 inbound 缺了一个修复 你再试下 https://github.com/XTLS/Xray-core/actions/runs/9153291749

yuhan6665 avatar May 20 '24 04:05 yuhan6665

@MetaZuo 你的日志帮我想起 inbound 缺了一个修复 你再试下 https://github.com/XTLS/Xray-core/actions/runs/9153291749

@yuhan6665 经测试应该是解决了,感谢!

MetaZuo avatar May 20 '24 07:05 MetaZuo

Thanks all!

yuhan6665 avatar May 20 '24 13:05 yuhan6665