Skip to content
New issue

Have a question about this project? Sign up for a free GitHub account to open an issue and contact its maintainers and the community.

By clicking “Sign up for GitHub”, you agree to our terms of service and privacy statement. We’ll occasionally send you account related emails.

Already on GitHub? Sign in to your account

vless tls server crash with "fatal error: concurrent map writes" #3904

Open
4 tasks done
fgggid opened this issue Oct 11, 2024 · 9 comments
Open
4 tasks done

vless tls server crash with "fatal error: concurrent map writes" #3904

fgggid opened this issue Oct 11, 2024 · 9 comments
Labels
bug Something isn't working

Comments

@fgggid
Copy link

fgggid commented Oct 11, 2024

Integrity requirements

  • I confirm that I have read the documentation, understand the meaning of all the configuration items I wrote, and did not pile up seemingly useful options or default values.
  • I provided the complete config and logs, rather than just providing the truncated parts based on my own judgment.
  • I searched issues and did not find any similar issues.
  • The problem can be successfully reproduced in the latest Release

Description

xray server crash when I do 'apt update' using vless + tls

I don't think I ever see this issue before v24. After I start using v24.9.30, I begin see such crash occasionally on my vps server.

This seems to be a timing issue, not always reproducible, but with time, you can reproduce it.

Reproduction Method

start 3 terminals

terminal 1: (xray server)
xray run -config ./config.json

terminal 2: (xray client)
xray run -config ./config.json

terminal 3: (do apt update with loop, in case you don't have env, my example is using docker/podman to reproduce)
docker run -ti --rm --network host ubuntu:noble bash
cat << \EOF | tee /etc/apt/apt.conf.d/99z-custom
Acquire::Queue-Mode "host";
Acquire::http { Pipeline-Depth "200"; }
Acquire::http::Proxy "http://127.0.0.1:8080";
Acquire::https::Proxy "http://127.0.0.1:8080";
EOF
while :; do apt update && sleep 60 || break ; done

Client config


{
  "log": {
    "loglevel": "debug",
    "dnsLog": true
  },
  "inbounds": [
       {
            "port": 8080,
            "protocol": "http",
            "tag": "http",
            "sniffing": {
                "enabled": true,
                "destOverride": ["http", "tls", "quic"]
            }
        }
  ],
  "outbounds": [
        {
            "protocol": "vless",
            "tag": "proxy",
            "settings": {
                "vnext": [
                    {
                        "address": "127.0.0.1",
                        "port": 1443,
                        "users": [
                            {
                                "id": "12345678-1234-1234-1234-1234567890ab",
                                "encryption": "none",
                                "level": 0
                            }
                        ]
                    }
                ]
            },
            "streamSettings": {
                "network": "raw",
                "security": "tls",
                "tlsSettings": {
                    "minVersion": "1.2",
                    "serverName": "127.0.0.1",
                    "allowInsecure": true
                }
            },
            "mux": {
                "enabled": true,
                "concurrency": 16,
                "xudpConcurrency": 4,
                "xudpProxyUDP443": "reject"
            }
        }
  ],
  "routing": {
    "domainStrategy": "IPIfNonMatch",
    "domainMatcher": "mph",
    "rules": [
      {
        "outboundTag": "proxy",
        "ip": ["0.0.0.0/0","::/0"]
      }
    ]
  }
}

Server config


{
  "log": {
    "loglevel": "debug",
    "dnsLog": true
  },
  "inbounds": [
    {
      "address": "127.0.0.1",
      "port": 1443,
      "protocol": "vless",
      "settings": {
        "clients": [
          {
            "id": "12345678-1234-1234-1234-1234567890ab",
            "level": 0,
            "email": "[email protected]"
          }
        ],
        "decryption": "none"
      },
      "streamSettings": {
        "network": "raw",
        "security": "tls",
        "tlsSettings": {
          "alpn": ["h2", "http/1.1"],
          "minVersion": "1.2",
          "certificates": [
            {
              "certificateFile": "/vps/etc/ssl/self-signed/server.crt",
              "keyFile": "/vps/etc/ssl/self-signed/server.key"
            }
          ]
        }
      },
      "sniffing": {
        "enabled": true,
        "destOverride": [
          "http",
          "tls",
          "quic"
        ]
      }
    }
  ],
  "outbounds": [
    {
      "tag": "Direct",
      "protocol": "freedom",
      "settings": {
        "domainStrategy": "UseIPv4"
      }
    }
  ],
  "routing": {
    "domainStrategy": "IPIfNonMatch",
    "domainMatcher": "mph",
    "rules": [
      {
        "outboundTag": "Direct",
        "ip": ["0.0.0.0/0","::/0"]
      }
    ]
  }
}

Client log


# /usr/local/bin/xray run -config ./config.json
Xray 24.9.30 (Xray, Penetrates Everything.) 3b06af8 (go1.23.1 linux/amd64)
A unified platform for anti-censorship.
2024/10/11 22:10:56 [Info] infra/conf/serial: Reading config: &{Name:./config.json Format:json}
2024/10/11 22:10:56 [Debug] app/log: Logger started
2024/10/11 22:10:56 [Debug] app/proxyman/inbound: creating stream worker on 0.0.0.0:8080
2024/10/11 22:10:56 [Info] transport/internet/tcp: listening TCP on 0.0.0.0:8080
2024/10/11 22:10:56 [Warning] core: Xray 24.9.30 started
2024/10/11 22:12:29 [Info] [358596750] proxy/http: request to Method [GET] Host [archive.ubuntu.com] with URL [http://archive.ubuntu.com/ubuntu/dists/noble/InRelease]
2024/10/11 22:12:29 [Info] [2744023973] proxy/http: request to Method [GET] Host [security.ubuntu.com] with URL [http://security.ubuntu.com/ubuntu/dists/noble-security/InRelease]
2024/10/11 22:12:29 [Info] [2744023973] app/dispatcher: taking detour [proxy] for [tcp:security.ubuntu.com:80]
2024/10/11 22:12:29 [Info] [2744023973] common/mux: dispatching request to tcp:security.ubuntu.com:80
2024/10/11 22:12:29 [Info] transport/internet/tcp: dialing TCP to tcp:127.0.0.1:1443
2024/10/11 22:12:29 [Debug] transport/internet: dialing to tcp:127.0.0.1:1443
2024/10/11 22:12:29 from 127.0.0.1:57058 accepted http://security.ubuntu.com/ubuntu/dists/noble-security/InRelease [http -> proxy]
2024/10/11 22:12:29 [Info] proxy/vless/outbound: tunneling request to tcp:v1.mux.cool:9527 via 127.0.0.1:1443
2024/10/11 22:12:29 [Info] [358596750] app/dispatcher: taking detour [proxy] for [tcp:archive.ubuntu.com:80]
2024/10/11 22:12:29 [Info] [358596750] common/mux: dispatching request to tcp:archive.ubuntu.com:80
2024/10/11 22:12:29 from 127.0.0.1:57060 accepted http://archive.ubuntu.com/ubuntu/dists/noble/InRelease [http -> proxy]
2024/10/11 22:12:30 [Info] [2744023973] common/mux: failed to fetch all input > io: read/write on closed pipe
2024/10/11 22:12:30 [Info] [358596750] common/mux: failed to fetch all input > io: read/write on closed pipe
2024/10/11 22:12:30 [Info] [1233581991] proxy/http: request to Method [GET] Host [archive.ubuntu.com] with URL [http://archive.ubuntu.com/ubuntu/dists/noble-updates/InRelease]
2024/10/11 22:12:30 [Info] [1233581991] app/dispatcher: taking detour [proxy] for [tcp:archive.ubuntu.com:80]
2024/10/11 22:12:30 [Info] [1233581991] common/mux: dispatching request to tcp:archive.ubuntu.com:80
2024/10/11 22:12:30 from 127.0.0.1:57072 accepted http://archive.ubuntu.com/ubuntu/dists/noble-updates/InRelease [http -> proxy]
2024/10/11 22:12:30 [Info] [1233581991] common/mux: failed to fetch all input > io: read/write on closed pipe
2024/10/11 22:12:30 [Info] [722960279] proxy/http: request to Method [GET] Host [archive.ubuntu.com] with URL [http://archive.ubuntu.com/ubuntu/dists/noble-backports/InRelease]
2024/10/11 22:12:30 [Info] [722960279] app/dispatcher: taking detour [proxy] for [tcp:archive.ubuntu.com:80]
2024/10/11 22:12:30 [Info] [722960279] common/mux: dispatching request to tcp:archive.ubuntu.com:80
2024/10/11 22:12:30 from 127.0.0.1:57084 accepted http://archive.ubuntu.com/ubuntu/dists/noble-backports/InRelease [http -> proxy]
2024/10/11 22:12:31 [Info] [722960279] common/mux: failed to fetch all input > io: read/write on closed pipe
2024/10/11 22:12:45 [Info] common/mux: failed to read metadata > io: read/write on closed pipe
2024/10/11 22:12:46 [Info] common/mux: failed to handler mux client connection > proxy/vless/outbound: connection ends > context canceled
2024/10/11 22:13:33 [Info] [4245685374] proxy/http: request to Method [GET] Host [archive.ubuntu.com] with URL [http://archive.ubuntu.com/ubuntu/dists/noble/InRelease]
2024/10/11 22:13:33 [Info] [807369052] proxy/http: request to Method [GET] Host [security.ubuntu.com] with URL [http://security.ubuntu.com/ubuntu/dists/noble-security/InRelease]
2024/10/11 22:13:33 [Info] [4245685374] app/dispatcher: taking detour [proxy] for [tcp:archive.ubuntu.com:80]
2024/10/11 22:13:33 [Info] [4245685374] common/mux: dispatching request to tcp:archive.ubuntu.com:80
2024/10/11 22:13:33 [Info] [807369052] app/dispatcher: taking detour [proxy] for [tcp:security.ubuntu.com:80]
2024/10/11 22:13:33 from 127.0.0.1:44000 accepted http://archive.ubuntu.com/ubuntu/dists/noble/InRelease [http -> proxy]
2024/10/11 22:13:33 from 127.0.0.1:43998 accepted http://security.ubuntu.com/ubuntu/dists/noble-security/InRelease [http -> proxy]
2024/10/11 22:13:33 [Info] [807369052] common/mux: dispatching request to tcp:security.ubuntu.com:80
2024/10/11 22:13:33 [Info] transport/internet/tcp: dialing TCP to tcp:127.0.0.1:1443
2024/10/11 22:13:33 [Debug] transport/internet: dialing to tcp:127.0.0.1:1443
2024/10/11 22:13:33 [Info] proxy/vless/outbound: tunneling request to tcp:v1.mux.cool:9527 via 127.0.0.1:1443
2024/10/11 22:13:33 [Info] [807369052] common/mux: failed to fetch all input > io: read/write on closed pipe
2024/10/11 22:13:33 [Info] [4245685374] common/mux: failed to fetch all input > io: read/write on closed pipe
2024/10/11 22:13:33 [Info] [4262921437] proxy/http: request to Method [GET] Host [archive.ubuntu.com] with URL [http://archive.ubuntu.com/ubuntu/dists/noble-updates/InRelease]
2024/10/11 22:13:33 [Info] [4262921437] app/dispatcher: taking detour [proxy] for [tcp:archive.ubuntu.com:80]
2024/10/11 22:13:33 [Info] [4262921437] common/mux: dispatching request to tcp:archive.ubuntu.com:80
2024/10/11 22:13:33 from 127.0.0.1:44024 accepted http://archive.ubuntu.com/ubuntu/dists/noble-updates/InRelease [http -> proxy]
2024/10/11 22:13:34 [Info] [4262921437] common/mux: failed to fetch all input > io: read/write on closed pipe
2024/10/11 22:13:34 [Info] [1619415218] proxy/http: request to Method [GET] Host [archive.ubuntu.com] with URL [http://archive.ubuntu.com/ubuntu/dists/noble-backports/InRelease]
2024/10/11 22:13:34 [Info] [1619415218] app/dispatcher: taking detour [proxy] for [tcp:archive.ubuntu.com:80]
2024/10/11 22:13:34 [Info] [1619415218] common/mux: dispatching request to tcp:archive.ubuntu.com:80
2024/10/11 22:13:34 from 127.0.0.1:44036 accepted http://archive.ubuntu.com/ubuntu/dists/noble-backports/InRelease [http -> proxy]
2024/10/11 22:13:34 [Info] [1619415218] common/mux: failed to fetch all input > io: read/write on closed pipe
2024/10/11 22:13:49 [Info] common/mux: failed to read metadata > io: read/write on closed pipe
2024/10/11 22:13:50 [Info] common/mux: failed to handler mux client connection > proxy/vless/outbound: connection ends > context canceled
2024/10/11 22:14:36 [Info] [2519341764] proxy/http: request to Method [GET] Host [archive.ubuntu.com] with URL [http://archive.ubuntu.com/ubuntu/dists/noble/InRelease]
2024/10/11 22:14:36 [Info] [3765660859] proxy/http: request to Method [GET] Host [security.ubuntu.com] with URL [http://security.ubuntu.com/ubuntu/dists/noble-security/InRelease]
2024/10/11 22:14:36 [Info] [2519341764] app/dispatcher: taking detour [proxy] for [tcp:archive.ubuntu.com:80]
2024/10/11 22:14:36 [Info] [2519341764] common/mux: dispatching request to tcp:archive.ubuntu.com:80
2024/10/11 22:14:36 [Info] transport/internet/tcp: dialing TCP to tcp:127.0.0.1:1443
2024/10/11 22:14:36 [Debug] transport/internet: dialing to tcp:127.0.0.1:1443
2024/10/11 22:14:36 [Info] proxy/vless/outbound: tunneling request to tcp:v1.mux.cool:9527 via 127.0.0.1:1443
2024/10/11 22:14:36 [Info] [3765660859] app/dispatcher: taking detour [proxy] for [tcp:security.ubuntu.com:80]
2024/10/11 22:14:36 [Info] [3765660859] common/mux: dispatching request to tcp:security.ubuntu.com:80
2024/10/11 22:14:36 from 127.0.0.1:47448 accepted http://archive.ubuntu.com/ubuntu/dists/noble/InRelease [http -> proxy]
2024/10/11 22:14:36 from 127.0.0.1:47450 accepted http://security.ubuntu.com/ubuntu/dists/noble-security/InRelease [http -> proxy]
2024/10/11 22:14:36 [Info] common/mux: failed to handler mux client connection > proxy/vless/outbound: connection ends > proxy/vless/outbound: failed to decode response header > proxy/vless/encoding: failed to read r
esponse version > EOF
2024/10/11 22:14:36 [Info] common/mux: failed to read metadata > io: read/write on closed pipe
2024/10/11 22:14:36 [Info] [2519341764] common/mux: failed to fetch all input > io: read/write on closed pipe
2024/10/11 22:14:36 [Warning] [2519341764] proxy/http: failed to read response from archive.ubuntu.com > unexpected EOF
2024/10/11 22:14:36 [Info] [3765660859] common/mux: failed to fetch all input > io: read/write on closed pipe
2024/10/11 22:14:36 [Warning] [3765660859] proxy/http: failed to read response from security.ubuntu.com > unexpected EOF
2024/10/11 22:14:36 [Info] [2845607368] proxy/http: request to Method [GET] Host [archive.ubuntu.com] with URL [http://archive.ubuntu.com/ubuntu/dists/noble-updates/InRelease]
2024/10/11 22:14:36 [Info] [2845607368] app/dispatcher: taking detour [proxy] for [tcp:archive.ubuntu.com:80]
2024/10/11 22:14:36 [Info] [2845607368] common/mux: dispatching request to tcp:archive.ubuntu.com:80
2024/10/11 22:14:36 [Info] transport/internet/tcp: dialing TCP to tcp:127.0.0.1:1443
2024/10/11 22:14:36 [Debug] transport/internet: dialing to tcp:127.0.0.1:1443
2024/10/11 22:14:36 from 127.0.0.1:47454 accepted http://archive.ubuntu.com/ubuntu/dists/noble-updates/InRelease [http -> proxy]
2024/10/11 22:14:36 [Info] transport/internet/tcp: dialing TCP to tcp:127.0.0.1:1443
2024/10/11 22:14:36 [Debug] transport/internet: dialing to tcp:127.0.0.1:1443
2024/10/11 22:14:36 [Info] transport/internet/tcp: dialing TCP to tcp:127.0.0.1:1443
2024/10/11 22:14:36 [Debug] transport/internet: dialing to tcp:127.0.0.1:1443
2024/10/11 22:14:37 [Info] transport/internet/tcp: dialing TCP to tcp:127.0.0.1:1443
2024/10/11 22:14:37 [Debug] transport/internet: dialing to tcp:127.0.0.1:1443
2024/10/11 22:14:37 [Info] transport/internet/tcp: dialing TCP to tcp:127.0.0.1:1443
2024/10/11 22:14:37 [Debug] transport/internet: dialing to tcp:127.0.0.1:1443
2024/10/11 22:14:38 [Warning] common/mux: failed to handler mux client connection > proxy/vless/outbound: failed to find an available destination > common/retry: [dial tcp 127.0.0.1:1443: connect: connection refused]
 > common/retry: all retry attempts failed
2024/10/11 22:14:38 [Info] common/mux: failed to read metadata > io: read/write on closed pipe
2024/10/11 22:14:38 [Info] [2845607368] common/mux: failed to fetch all input > io: read/write on closed pipe
2024/10/11 22:14:38 [Warning] [2845607368] proxy/http: failed to read response from archive.ubuntu.com > unexpected EOF
2024/10/11 22:14:38 [Info] [518179109] proxy/http: request to Method [GET] Host [archive.ubuntu.com] with URL [http://archive.ubuntu.com/ubuntu/dists/noble-backports/InRelease]
2024/10/11 22:14:38 [Info] [518179109] app/dispatcher: taking detour [proxy] for [tcp:archive.ubuntu.com:80]
2024/10/11 22:14:38 [Info] [518179109] common/mux: dispatching request to tcp:archive.ubuntu.com:80
2024/10/11 22:14:38 [Info] transport/internet/tcp: dialing TCP to tcp:127.0.0.1:1443
2024/10/11 22:14:38 [Debug] transport/internet: dialing to tcp:127.0.0.1:1443
2024/10/11 22:14:38 from 127.0.0.1:47468 accepted http://archive.ubuntu.com/ubuntu/dists/noble-backports/InRelease [http -> proxy]
2024/10/11 22:14:38 [Info] transport/internet/tcp: dialing TCP to tcp:127.0.0.1:1443
2024/10/11 22:14:38 [Debug] transport/internet: dialing to tcp:127.0.0.1:1443
2024/10/11 22:14:38 [Info] transport/internet/tcp: dialing TCP to tcp:127.0.0.1:1443
2024/10/11 22:14:38 [Debug] transport/internet: dialing to tcp:12716524841431652484143.0.0.1:1443
2024/10/11 22:14:39 [Info] transport/internet/tcp: dialing TCP to tcp:127.0.0.1:1443
2024/10/11 22:14:39 [Debug] transport/internet: dialing to tcp:127.0.0.1:1443
2024/10/11 22:14:39 [Info] transport/internet/tcp: dialing TCP to tcp:127.0.0.1:1443
2024/10/11 22:14:39 [Debug] transport/internet: dialing to tcp:127.0.0.1:1443
2024/10/11 22:14:40 [Warning] common/mux: failed to handler mux client connection > proxy/vless/outbound: failed to find an available destination > common/retry: [dial tcp 127.0.0.1:1443: connect: connection refused]
 > common/retry: all retry attempts failed
2024/10/11 22:14:40 [Info] common/mux: failed to read metadata > io: read/write on closed pipe
2024/10/11 22:14:40 [Info] [518179109] common/mux: failed to fetch all input > io: read/write on closed pipe
2024/10/11 22:14:40 [Warning] [518179109] proxy/http: failed to read response from archive.ubuntu.com > unexpected EOF

Server log


# /usr/local/bin/xray run -config ./config.json
Xray 24.9.30 (Xray, Penetrates Everything.) 3b06af8 (go1.23.1 linux/amd64)
A unified platform for anti-censorship.
2024/10/11 22:11:10 [Info] infra/conf/serial: Reading config: &{Name:./config.json Format:json}
2024/10/11 22:11:10 [Debug] app/log: Logger started
2024/10/11 22:11:10 [Debug] app/proxyman/inbound: creating stream worker on 0.0.0.0:1443
2024/10/11 22:11:10 [Info] transport/internet/tcp: listening TCP on 0.0.0.0:1443
2024/10/11 22:11:10 [Warning] core: Xray 24.9.30 started
2024/10/11 22:12:29 [Info] [567138702] proxy/vless/inbound: firstLen = 286
2024/10/11 22:12:29 [Info] [567138702] proxy/vless/inbound: received request for tcp:v1.mux.cool:0
2024/10/11 22:12:29 [Info] [567138702] common/mux: received request for tcp:security.ubuntu.com:80
2024/10/11 22:12:29 [Info] [567138702] app/dispatcher: sniffed domain: security.ubuntu.com
2024/10/11 22:12:29 [Info] [567138702] app/dispatcher: taking detour [Direct] for [tcp:security.ubuntu.com:80]
2024/10/11 22:12:29 from tcp:127.0.0.1:46438 accepted tcp:security.ubuntu.com:80 [Direct] email: [email protected]
2024/10/11 22:12:29 [Info] [567138702] proxy/freedom: dialing to tcp:185.125.190.83:80
2024/10/11 22:12:29 [Info] [567138702] transport/internet/tcp: dialing TCP to tcp:185.125.190.83:80
2024/10/11 22:12:29 [Debug] [567138702] transport/internet: dialing to tcp:185.125.190.83:80
2024/10/11 22:12:29 [Info] [567138702] common/mux: received request for tcp:archive.ubuntu.com:80
2024/10/11 22:12:29 [Info] [567138702] app/dispatcher: sniffed domain: archive.ubuntu.com
2024/10/11 22:12:29 [Info] [567138702] proxy/freedom: connection opened to tcp:security.ubuntu.com:80, local endpoint :48188, remote endpoint 185.125.190.83:80
2024/10/11 22:12:29 [Info] [567138702] proxy: CopyRawConn readv
2024/10/11 22:12:30 [Info] [567138702] app/dispatcher: taking detour [Direct] for [tcp:archive.ubuntu.com:80]
2024/10/11 22:12:30 from tcp:127.0.0.1:46438 accepted tcp:archive.ubuntu.com:80 [Direct] email: [email protected]
2024/10/11 22:12:30 [Info] [567138702] proxy/freedom: dialing to tcp:185.125.190.81:80
2024/10/11 22:12:30 [Info] [567138702] transport/internet/tcp: dialing TCP to tcp:185.125.190.81:80
2024/10/11 22:12:30 [Debug] [567138702] transport/internet: dialing to tcp:185.125.190.81:80
2024/10/11 22:12:30 [Info] [567138702] proxy/freedom: connection opened to tcp:archive.ubuntu.com:80, local endpoint :36654, remote endpoint 185.125.190.81:80
2024/10/11 22:12:30 [Info] [567138702] proxy: CopyRawConn readv
2024/10/11 22:12:30 [Info] [567138702] common/mux: received request for tcp:archive.ubuntu.com:80
2024/10/11 22:12:30 [Info] [567138702] app/dispatcher: sniffed domain: archive.ubuntu.com
2024/10/11 22:12:30 [Info] [567138702] app/dispatcher: taking detour [Direct] for [tcp:archive.ubuntu.com:80]
2024/10/11 22:12:30 from tcp:127.0.0.1:46438 accepted tcp:archive.ubuntu.com:80 [Direct] email: [email protected]
2024/10/11 22:12:30 [Info] [567138702] proxy/freedom: dialing to tcp:91.189.91.81:80
2024/10/11 22:12:30 [Info] [567138702] transport/internet/tcp: dialing TCP to tcp:91.189.91.81:80
2024/10/11 22:12:30 [Debug] [567138702] transport/internet: dialing to tcp:91.189.91.81:80
2024/10/11 22:12:30 [Info] [567138702] proxy/freedom: connection opened to tcp:archive.ubuntu.com:80, local endpoint :56582, remote endpoint 91.189.91.81:80
2024/10/11 22:12:30 [Info] [567138702] proxy: CopyRawConn readv
2024/10/11 22:12:30 [Info] [567138702] common/mux: received request for tcp:archive.ubuntu.com:80
2024/10/11 22:12:30 [Info] [567138702] app/dispatcher: sniffed domain: archive.ubuntu.com
2024/10/11 22:12:30 from tcp:127.0.0.1:46438 accepted tcp:archive.ubuntu.com:80 [Direct] email: [email protected]
2024/10/11 22:12:30 [Info] [567138702] app/dispatcher: taking detour [Direct] for [tcp:archive.ubuntu.com:80]
2024/10/11 22:12:30 [Info] [567138702] proxy/freedom: dialing to tcp:185.125.190.81:80
2024/10/11 22:12:30 [Info] [567138702] transport/internet/tcp: dialing TCP to tcp:185.125.190.81:80
2024/10/11 22:12:30 [Debug] [567138702] transport/internet: dialing to tcp:185.125.190.81:80
2024/10/11 22:12:31 [Info] [567138702] proxy/freedom: connection opened to tcp:archive.ubuntu.com:80, local endpoint :36668, remote endpoint 185.125.190.81:80
2024/10/11 22:12:31 [Info] [567138702] proxy: CopyRawConn readv
2024/10/11 22:12:47 [Info] [567138702] app/proxyman/inbound: connection ends > proxy/vless/inbound: connection ends > context canceled
2024/10/11 22:13:33 [Info] [930041937] proxy/vless/inbound: firstLen = 542
2024/10/11 22:13:33 [Info] [930041937] proxy/vless/inbound: received request for tcp:v1.mux.cool:0
2024/10/11 22:13:33 [Info] [930041937] common/mux: received request for tcp:archive.ubuntu.com:80
2024/10/11 22:13:33 [Info] [930041937] common/mux: received request for tcp:security.ubuntu.com:80
2024/10/11 22:13:33 [Info] [930041937] app/dispatcher: sniffed domain: archive.ubuntu.com
2024/10/11 22:13:33 [Info] [930041937] app/dispatcher: sniffed domain: security.ubuntu.com
2024/10/11 22:13:33 [Info] [930041937] app/dispatcher: taking detour [Direct] for [tcp:security.ubuntu.com:80]
2024/10/11 22:13:33 from tcp:127.0.0.1:50272 accepted tcp:security.ubuntu.com:80 [Direct] email: [email protected]
2024/10/11 22:13:33 [Info] [930041937] proxy/freedom: dialing to tcp:91.189.91.83:80
2024/10/11 22:13:33 [Info] [930041937] transport/internet/tcp: dialing TCP to tcp:91.189.91.83:80
2024/10/11 22:13:33 [Debug] [930041937] transport/internet: dialing to tcp:91.189.91.83:80
2024/10/11 22:13:33 [Info] [930041937] app/dispatcher: taking detour [Direct] for [tcp:archive.ubuntu.com:80]
2024/10/11 22:13:33 from tcp:127.0.0.1:50272 accepted tcp:archive.ubuntu.com:80 [Direct] email: [email protected]
2024/10/11 22:13:33 [Info] [930041937] proxy/freedom: dialing to tcp:185.125.190.81:80
2024/10/11 22:13:33 [Info] [930041937] transport/internet/tcp: dialing TCP to tcp:185.125.190.81:80
2024/10/11 22:13:33 [Debug] [930041937] transport/internet: dialing to tcp:185.125.190.81:80
2024/10/11 22:13:33 [Info] [930041937] proxy/freedom: connection opened to tcp:security.ubuntu.com:80, local endpoint :56108, remote endpoint 91.189.91.83:80
2024/10/11 22:13:33 [Info] [930041937] proxy: CopyRawConn readv
2024/10/11 22:13:33 [Info] [930041937] proxy/freedom: connection opened to tcp:archive.ubuntu.com:80, local endpoint :38668, remote endpoint 185.125.190.81:80
2024/10/11 22:13:33 [Info] [930041937] proxy: CopyRawConn readv
2024/10/11 22:13:33 [Info] [930041937] common/mux: received request for tcp:archive.ubuntu.com:80
2024/10/11 22:13:33 [Info] [930041937] app/dispatcher: sniffed domain: archive.ubuntu.com
2024/10/11 22:13:33 from tcp:127.0.0.1:50272 accepted tcp:archive.ubuntu.com:80 [Direct] email: [email protected]
2024/10/11 22:13:33 [Info] [930041937] app/dispatcher: taking detour [Direct] for [tcp:archive.ubuntu.com:80]
2024/10/11 22:13:33 [Info] [930041937] proxy/freedom: dialing to tcp:185.125.190.81:80
2024/10/11 22:13:33 [Info] [930041937] transport/internet/tcp: dialing TCP to tcp:185.125.190.81:80
2024/10/11 22:13:33 [Debug] [930041937] transport/internet: dialing to tcp:185.125.190.81:80
2024/10/11 22:13:34 [Info] [930041937] proxy/freedom: connection opened to tcp:archive.ubuntu.com:80, local endpoint :38680, remote endpoint 185.125.190.81:80
2024/10/11 22:13:34 [Info] [930041937] proxy: CopyRawConn readv
2024/10/11 22:13:34 [Info] [930041937] common/mux: received request for tcp:archive.ubuntu.com:80
2024/10/11 22:13:34 [Info] [930041937] app/dispatcher: sniffed domain: archive.ubuntu.com
2024/10/11 22:13:34 [Info] [930041937] app/dispatcher: taking detour [Direct] for [tcp:archive.ubuntu.com:80]
2024/10/11 22:13:34 from tcp:127.0.0.1:50272 accepted tcp:archive.ubuntu.com:80 [Direct] email: [email protected]
2024/10/11 22:13:34 [Info] [930041937] proxy/freedom: dialing to tcp:91.189.91.81:80
2024/10/11 22:13:34 [Info] [930041937] transport/internet/tcp: dialing TCP to tcp:91.189.91.81:80
2024/10/11 22:13:34 [Debug] [930041937] transport/internet: dialing to tcp:91.189.91.81:80
2024/10/11 22:13:34 [Info] [930041937] proxy/freedom: connection opened to tcp:archive.ubuntu.com:80, local endpoint :52042, remote endpoint 91.189.91.81:80
2024/10/11 22:13:34 [Info] [930041937] proxy: CopyRawConn readv
2024/10/11 22:13:51 [Info] [930041937] app/proxyman/inbound: connection ends > proxy/vless/inbound: connection ends > context canceled
2024/10/11 22:14:36 [Info] [1652484143] proxy/vless/inbound: firstLen = 275
2024/10/11 22:14:36 [Info] [1652484143] proxy/vless/inbound: received request for tcp:v1.mux.cool:0
2024/10/11 22:14:36 [Info] [1652484143] common/mux: received request for tcp:archive.ubuntu.com:80
2024/10/11 22:14:36 [Info] [1652484143] common/mux: received request for tcp:security.ubuntu.com:80
fatal error: concurrent map writes

goroutine 126 [running]:
github.com/xtls/xray-core/common/session.(*Content).SetAttribute(...)
github.com/xtls/xray-core/common/session/session.go:107
github.com/xtls/xray-core/common/protocol/http.SniffHTTP({0xc000338000, 0xe1, 0x2000}, {0x153d300?, 0xc00030cc30?})
github.com/xtls/xray-core/common/protocol/http/sniff.go:90 +0x288
github.com/xtls/xray-core/app/dispatcher.NewSniffer.func1({0x153d300?, 0xc00030cc30?}, {0xc000338000?, 0x1?, 0xe1?})
github.com/xtls/xray-core/app/dispatcher/sniffer.go:38 +0x37
github.com/xtls/xray-core/app/dispatcher.(*Sniffer).Sniff(0xc00026ab88, {0x153d300, 0xc00030cc30}, {0xc000338000, 0xe1, 0x2000}, 0x2)
github.com/xtls/xray-core/app/dispatcher/sniffer.go:65 +0xcc
github.com/xtls/xray-core/app/dispatcher.sniffer.func1({0x153d300, 0xc00030cc30}, 0xc0001fdb90, 0xc0001fdbc0, 0xc00026ab88, 0x2)
github.com/xtls/xray-core/app/dispatcher/default.go:371 +0x125
github.com/xtls/xray-core/app/dispatcher.sniffer({0x153d300, 0xc00030cc30}, 0xc0001fdb90, 0x0, 0x2)
github.com/xtls/xray-core/app/dispatcher/default.go:381 +0x116
github.com/xtls/xray-core/app/dispatcher.(*DefaultDispatcher).Dispatch.func1()
github.com/xtls/xray-core/app/dispatcher/default.go:263 +0x10f
created by github.com/xtls/xray-core/app/dispatcher.(*DefaultDispatcher).Dispatch in goroutine 123
github.com/xtls/xray-core/app/dispatcher/default.go:258 +0x47f

goroutine 1 [chan receive, 3 minutes]:
main.executeRun(0x1eae600?, {0xc0001400e0?, 0xc0001f7f40?, 0x10044c2c8?})
github.com/xtls/xray-core/main/run.go:108 +0x279
github.com/xtls/xray-core/main/commands/base.Execute()
github.com/xtls/xray-core/main/commands/base/execute.go:64 +0x5fd
main.main()
github.com/xtls/xray-core/main/main.go:22 +0x1a5

goroutine 5 [sleep]:
time.Sleep(0xdf8475800)
runtime/time.go:285 +0xf2
github.com/xtls/xray-core/common/mux.init.0.func1()
github.com/xtls/xray-core/common/mux/session.go:228 +0x29
created by github.com/xtls/xray-core/common/mux.init.0 in goroutine 1
github.com/xtls/xray-core/common/mux/session.go:226 +0x46

goroutine 122 [select]:
github.com/xtls/xray-core/common/task.Run({0x153d300, 0xc00030c9c0}, {0xc000387e30, 0x2, 0xc0001fea60?})
github.com/xtls/xray-core/common/task/task.go:48 +0x265
github.com/xtls/xray-core/proxy/vless/inbound.(*Handler).Process(0xc000333ae0, {0x153d300, 0xc00030c6c0}, 0x2?, {0x15442d0, 0xc000072658}, {0x153f720, 0xc000341240})
github.com/xtls/xray-core/proxy/vless/inbound/inbound.go:580 +0x2345
github.com/xtls/xray-core/app/proxyman/inbound.(*tcpWorker).callback(0xc0003234a0, {0x15442d0, 0xc000072658})
github.com/xtls/xray-core/app/proxyman/inbound/worker.go:109 +0x5e7
created by github.com/xtls/xray-core/app/proxyman/inbound.(*tcpWorker).Start.func1 in goroutine 135
github.com/xtls/xray-core/app/proxyman/inbound/worker.go:123 +0x7a

goroutine 7 [runnable]:
github.com/xtls/xray-core/common/log.(*generalLogger).run(0xc0000933a0)
github.com/xtls/xray-core/common/log/logger.go:85 +0x1ad
created by github.com/xtls/xray-core/common/log.(*generalLogger).Handle in goroutine 1
github.com/xtls/xray-core/common/log/logger.go:109 +0x8f

goroutine 10 [chan receive, 3 minutes]:
github.com/xtls/xray-core/transport/internet/tls.setupOcspTicker.func1()
github.com/xtls/xray-core/transport/internet/tls/config.go:127 +0x94
created by github.com/xtls/xray-core/transport/internet/tls.setupOcspTicker in goroutine 1
github.com/xtls/xray-core/transport/internet/tls/config.go:96 +0x67

goroutine 11 [IO wait]:
internal/poll.runtime_pollWait(0x7f396c003e28, 0x72)
runtime/netpoll.go:351 +0x85
internal/poll.(*pollDesc).wait(0xc000355200?, 0x900000036?, 0x0)
internal/poll/fd_poll_runtime.go:84 +0x27
internal/poll.(*pollDesc).waitRead(...)
internal/poll/fd_poll_runtime.go:89
internal/poll.(*FD).Accept(0xc000355200)
internal/poll/fd_unix.go:620 +0x295
net.(*netFD).accept(0xc000355200)
net/fd_unix.go:172 +0x29
net.(*TCPListener).accept(0xc0002d7880)
net/tcpsock_posix.go:159 +0x1e
net.(*TCPListener).Accept(0xc0002d7880)
net/tcpsock.go:372 +0x30
github.com/xtls/xray-core/transport/internet/tcp.(*Listener).keepAccepting(0xc0002d7800)
github.com/xtls/xray-core/transport/internet/tcp/hub.go:95 +0x54
created by github.com/xtls/xray-core/transport/internet/tcp.ListenTCP in goroutine 1
github.com/xtls/xray-core/transport/internet/tcp/hub.go:89 +0x7ff

goroutine 12 [syscall, 3 minutes]:
os/signal.signal_recv()
runtime/sigqueue.go:152 +0x29
os/signal.loop()
os/signal/signal_unix.go:23 +0x13
created by os/signal.Notify.func1.1 in goroutine 1
os/signal/signal.go:151 +0x1f

goroutine 124 [IO wait]:
internal/poll.runtime_pollWait(0x7f396c003d20, 0x72)
runtime/netpoll.go:351 +0x85
internal/poll.(*pollDesc).wait(0xc000274680?, 0xc00028fd40?, 0x0)
internal/poll/fd_poll_runtime.go:84 +0x27
internal/poll.(*pollDesc).waitRead(...)
internal/poll/fd_poll_runtime.go:89
internal/poll.(*FD).Read(0xc000274680, {0xc00028fd40, 0x240, 0x240})
internal/poll/fd_unix.go:165 +0x27a
net.(*netFD).Read(0xc000274680, {0xc00028fd40?, 0x1ea23c0?, 0xc00025d960?})
net/fd_posix.go:55 +0x25
net.(*conn).Read(0xc0001347e0, {0xc00028fd40?, 0xc00014ede0?, 0xc00028fd45?})
net/net.go:189 +0x45
crypto/tls.(*atLeastReader).Read(0xc00026ab58, {0xc00028fd40?, 0x0?, 0xc00026ab58?})
crypto/tls/conn.go:809 +0x3b
bytes.(*Buffer).ReadFrom(0xc00019e638, {0x152f2c0, 0xc00026ab58})
bytes/buffer.go:211 +0x98
crypto/tls.(*Conn).readFromUntil(0xc00019e388, {0x152d820, 0xc0001347e0}, 0xc00025d9d0?)
crypto/tls/conn.go:831 +0xde
crypto/tls.(*Conn).readRecordOrCCS(0xc00019e388, 0x0)
crypto/tls/conn.go:629 +0x3cf
crypto/tls.(*Conn).readRecord(...)
crypto/tls/conn.go:591
crypto/tls.(*Conn).Read(0xc00019e388, {0xc00019c000, 0x2000, 0xc00019c000?})
crypto/tls/conn.go:1385 +0x150
github.com/xtls/xray-core/common/buf.(*Buffer).ReadFrom(...)
github.com/xtls/xray-core/common/buf/buffer.go:295
github.com/xtls/xray-core/common/buf.ReadBuffer({0x7f396bdabf80, 0xc000072658})
github.com/xtls/xray-core/common/buf/reader.go:30 +0x66
github.com/xtls/xray-core/common/buf.(*SingleReader).ReadMultiBuffer(0x1?)
github.com/xtls/xray-core/common/buf/reader.go:158 +0x1d
github.com/xtls/xray-core/common/buf.(*BufferedReader).ReadMultiBuffer(0x1?)
github.com/xtls/xray-core/common/buf/reader.go:96 +0x84
github.com/xtls/xray-core/common/buf.copyInternal({0x152c9e0, 0xc00030c870}, {0x152b640, 0xc0000726c8}, 0xc0003163f0)
github.com/xtls/xray-core/common/buf/copy.go:93 +0x5b
github.com/xtls/xray-core/common/buf.Copy({0x152c9e0, 0xc00030c870}, {0x152b640, 0xc0000726c8}, {0xc00006ff48, 0x1, 0x7f39b2acc5b8?})
github.com/xtls/xray-core/common/buf/copy.go:116 +0x98
github.com/xtls/xray-core/proxy/vless/inbound.(*Handler).Process.func4()
github.com/xtls/xray-core/proxy/vless/inbound/inbound.go:530 +0x2a6
github.com/xtls/xray-core/proxy/vless/inbound.(*Handler).Process.OnSuccess.func12()
github.com/xtls/xray-core/common/task/task.go:12 +0x22
github.com/xtls/xray-core/common/task.Run.func1(0xc000072658?)
github.com/xtls/xray-core/common/task/task.go:28 +0x28
created by github.com/xtls/xray-core/common/task.Run in goroutine 122
github.com/xtls/xray-core/common/task/task.go:27 +0xdb

goroutine 123 [select]:
github.com/xtls/xray-core/transport/pipe.(*pipe).ReadMultiBuffer(0xc0000ae8c0)
github.com/xtls/xray-core/transport/pipe/impl.go:100 +0xeb
github.com/xtls/xray-core/transport/pipe.(*Reader).ReadMultiBuffer(0x2?)
github.com/xtls/xray-core/transport/pipe/reader.go:16 +0x16
github.com/xtls/xray-core/common/buf.(*BufferedReader).Read(0xc00030cab0, {0xc000479906, 0x2, 0x2})
github.com/xtls/xray-core/common/buf/reader.go:76 +0xd9
io.ReadAtLeast({0x152c840, 0xc00030cab0}, {0xc000479906, 0x2, 0x2}, 0x2)
io/io.go:335 +0x90
io.ReadFull(...)
io/io.go:354
github.com/xtls/xray-core/common/serial.ReadUint16({0x152c840, 0xc00030cab0})
github.com/xtls/xray-core/common/serial/serial.go:11 +0x47
github.com/xtls/xray-core/common/mux.(*FrameMetadata).Unmarshal(0xc00030d050, {0x152c840, 0xc00030cab0})
github.com/xtls/xray-core/common/mux/frame.go:101 +0x45
github.com/xtls/xray-core/common/mux.(*ServerWorker).handleFrame(0xc00014ee60, {0x153d300, 0xc00030c9c0}, 0xc00030cab0)
github.com/xtls/xray-core/common/mux/server.go:281 +0x48
github.com/xtls/xray-core/common/mux.(*ServerWorker).run(0xc00014ee60, {0x153d300, 0xc00030c9c0})
github.com/xtls/xray-core/common/mux/server.go:317 +0x10f
created by github.com/xtls/xray-core/common/mux.NewServerWorker in goroutine 122
github.com/xtls/xray-core/common/mux/server.go:90 +0x130

goroutine 24 [select]:
github.com/xtls/xray-core/common/log.(*generalLogger).run(0xc000093380)
github.com/xtls/xray-core/common/log/logger.go:85 +0x1ad
created by github.com/xtls/xray-core/common/log.(*generalLogger).Handle in goroutine 15
github.com/xtls/xray-core/common/log/logger.go:109 +0x8f

goroutine 125 [select]:
github.com/xtls/xray-core/transport/pipe.(*pipe).ReadMultiBuffer(0xc0000ae910)
github.com/xtls/xray-core/transport/pipe/impl.go:100 +0xeb
github.com/xtls/xray-core/transport/pipe.(*Reader).ReadMultiBuffer(0x152c820?)
github.com/xtls/xray-core/transport/pipe/reader.go:16 +0x16
github.com/xtls/xray-core/proxy/vless/inbound.(*Handler).Process.func5()
github.com/xtls/xray-core/proxy/vless/inbound/inbound.go:550 +0x2db
github.com/xtls/xray-core/common/task.Run.func1(0xc0001fd170?)
github.com/xtls/xray-core/common/task/task.go:28 +0x28
created by github.com/xtls/xray-core/common/task.Run in goroutine 122
github.com/xtls/xray-core/common/task/task.go:27 +0xdb

goroutine 127 [select]:
github.com/xtls/xray-core/transport/pipe.(*pipe).ReadMultiBuffer(0xc0000aea50)
github.com/xtls/xray-core/transport/pipe/impl.go:100 +0xeb
github.com/xtls/xray-core/transport/pipe.(*Reader).ReadMultiBuffer(0x18?)
github.com/xtls/xray-core/transport/pipe/reader.go:16 +0x16
github.com/xtls/xray-core/common/buf.copyInternal({0x152b600, 0xc0000727f8}, {0x152de80, 0xc0002d7600}, 0xc00026ab70)
github.com/xtls/xray-core/common/buf/copy.go:93 +0x5b
github.com/xtls/xray-core/common/buf.Copy({0x152b600, 0xc0000727f8}, {0x152de80, 0xc0002d7600}, {0x0, 0x0, 0x100000000000000?})
github.com/xtls/xray-core/common/buf/copy.go:116 +0x98
github.com/xtls/xray-core/common/mux.handle({0x153d300, 0xc00030cc30}, 0xc0002e61c0, {0x152b640, 0xc000072718})
github.com/xtls/xray-core/common/mux/server.go:96 +0xce
created by github.com/xtls/xray-core/common/mux.(*ServerWorker).handleStatusNew in goroutine 123
github.com/xtls/xray-core/common/mux/server.go:230 +0x10f4

goroutine 128 [select]:
net.(*Resolver).lookupIPAddr(0x1ec0140, {0x153ce30, 0x1ee4d60}, {0x1356fda, 0x2}, {0xc0004729a8, 0x13})
net/lookup.go:342 +0x3d9
net.(*Resolver).LookupIPAddr(...)
net/lookup.go:220
net.LookupIP({0xc0004729a8?, 0x0?})
net/lookup.go:206 +0x49
github.com/xtls/xray-core/features/dns/localdns.(*Client).LookupIP(0x7f396bdfe6f8?, {0xc0004729a8?, 0x10?}, {0xf0?, 0x4b?, 0x39?})
github.com/xtls/xray-core/features/dns/localdns/client.go:24 +0x43
github.com/xtls/xray-core/features/routing/dns.(*ResolvableContext).GetTargetIPs(0xc0002e6340)
github.com/xtls/xray-core/features/routing/dns/context.go:26 +0x6e
github.com/xtls/xray-core/app/router.(*MultiGeoIPMatcher).Apply(0xc0000934c0, {0x1547040?, 0xc0002e6340?})
github.com/xtls/xray-core/app/router/condition.go:143 +0x3e
github.com/xtls/xray-core/app/router.(*ConditionChan).Apply(0x47205f?, {0x1547040, 0xc0002e6340})
github.com/xtls/xray-core/app/router/condition.go:32 +0x5c
github.com/xtls/xray-core/app/router.(*Rule).Apply(...)
github.com/xtls/xray-core/app/router/config.go:29
github.com/xtls/xray-core/app/router.(*Router).pickRouteInternal(0xc00029bea0, {0x1547190, 0xc00038a288})
github.com/xtls/xray-core/app/router/router.go:208 +0x2b4
github.com/xtls/xray-core/app/router.(*Router).PickRoute(0x153d300?, {0x1547190?, 0xc00038a288?})
github.com/xtls/xray-core/app/router/router.go:83 +0x25
github.com/xtls/xray-core/app/dispatcher.(*DefaultDispatcher).routedDispatch(0xc000329c20, {0x153d300, 0xc00030ce10}, 0xc00014ef60, {{0x153d028, 0xc0001fec00}, 0x50, 0x2})
github.com/xtls/xray-core/app/dispatcher/default.go:424 +0x307
github.com/xtls/xray-core/app/dispatcher.(*DefaultDispatcher).Dispatch.func1()
github.com/xtls/xray-core/app/dispatcher/default.go:285 +0x36b
created by github.com/xtls/xray-core/app/dispatcher.(*DefaultDispatcher).Dispatch in goroutine 123
github.com/xtls/xray-core/app/dispatcher/default.go:258 +0x47f

goroutine 145 [select]:
github.com/xtls/xray-core/transport/pipe.(*pipe).ReadMultiBuffer(0xc0000aed20)
github.com/xtls/xray-core/transport/pipe/impl.go:100 +0xeb
github.com/xtls/xray-core/transport/pipe.(*Reader).ReadMultiBuffer(0x18?)
github.com/xtls/xray-core/transport/pipe/reader.go:16 +0x16
github.com/xtls/xray-core/common/buf.copyInternal({0x152b600, 0xc0000728c8}, {0x152de80, 0xc0002e62c0}, 0xc00038a1f8)
github.com/xtls/xray-core/common/buf/copy.go:93 +0x5b
github.com/xtls/xray-core/common/buf.Copy({0x152b600, 0xc0000728c8}, {0x152de80, 0xc0002e62c0}, {0x0, 0x0, 0xca0402?})
github.com/xtls/xray-core/common/buf/copy.go:116 +0x98
github.com/xtls/xray-core/common/mux.handle({0x153d300, 0xc00030ce10}, 0xc0002e6240, {0x152b640, 0xc000072718})
github.com/xtls/xray-core/common/mux/server.go:96 +0xce
created by github.com/xtls/xray-core/common/mux.(*ServerWorker).handleStatusNew in goroutine 123
github.com/xtls/xray-core/common/mux/server.go:230 +0x10f4

goroutine 146 [runnable]:
net.(*conf).lookupOrder(0x1ea4040, 0x1ec0140?, {0xc0004729a8, 0x13})
net/conf.go:231 +0x558
net.(*conf).hostLookupOrder(0x10?, 0x10?, {0xc0004729a8?, 0x414feb?})
net/conf.go:228 +0x85
net.(*Resolver).lookupIP(0x1ec0140, {0x153d338, 0xc0000aee10}, {0x1356fda, 0x2}, {0xc0004729a8, 0x13})
net/lookup_unix.go:64 +0xa7
net.init.func1({0x153d338?, 0xc0000aee10?}, 0xc00017bb20?, {0x1356fda?, 0x0?}, {0xc0004729a8?, 0xc000187e30?})
net/hook.go:21 +0x37
net.(*Resolver).lookupIPAddr.func1()
net/lookup.go:334 +0x37
internal/singleflight.(*Group).doCall(0x1ec0150, 0xc0000aef50, {0xc0004729f0, 0x16}, 0xc00038a198?)
internal/singleflight/singleflight.go:93 +0x35
created by internal/singleflight.(*Group).DoChan in goroutine 128
internal/singleflight/singleflight.go:86 +0x2d2

@fgggid
Copy link
Author

fgggid commented Oct 11, 2024

apt config Acquire::http { Pipeline-Depth "200"; } and "Acquire::Queue-Mode "host";" are irrelevant, can reproduce without these.

@Fangliding Fangliding added the bug Something isn't working label Oct 12, 2024
@Fangliding
Copy link
Member

Fangliding commented Oct 12, 2024

Thank for reporting. Try the version here https://github.com/XTLS/Xray-core/actions/runs/11303197293 for your server

@fgggid
Copy link
Author

fgggid commented Oct 12, 2024

Ok, I will try it on server from now.

@fgggid
Copy link
Author

fgggid commented Oct 12, 2024

I can see below errors occasionally. Does this mean the issue is successfully mitigated?


2024/10/13 00:08:44 [Error] common/session: Multiple goroutine is tring to access one routing content, tring to write host:security.ubuntu.com
2024/10/13 00:08:44 [Error] common/session: Multiple goroutine is tring to access one routing content, tring to write cache-control:max-age=0
...
2024/10/13 00:16:08 [Error] common/session: Multiple goroutine is tring to access one routing content, tring to write accept:text/*
2024/10/13 00:16:08 [Error] common/session: Multiple goroutine is tring to access one routing content, tring to write :method:GET
...
2024/10/13 00:18:15 [Error] common/session: Multiple goroutine is tring to access one routing content, tring to write host:security.ubuntu.com
2024/10/13 00:18:15 [Error] common/session: Multiple goroutine is tring to access one routing content, tring to write if-modified-since:Thu, 25 Apr 2024 15:11:21 GMT

@Fangliding
Copy link
Member

Yes, mitigate
This involves a fairly old problem, and what I can do is not let it panic. A complete fix may require more work

@fgggid
Copy link
Author

fgggid commented Oct 12, 2024

Ok, I'm fine for now.

@mmmray
Copy link
Collaborator

mmmray commented Oct 15, 2024

I would keep this issue open until the actual bug is fixed. Things are potentially getting mis-routed under mux.cool.

@RPRX
Copy link
Member

RPRX commented Nov 14, 2024

#3914 (comment)

@RPRX RPRX reopened this Nov 14, 2024
@BI7PRK
Copy link

BI7PRK commented Dec 3, 2024

客户端出现规律的日志:failed to set TCP_USER_TIMEOUT protocol not available 不知道哪里设置不对还是bug

Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment
Labels
bug Something isn't working
Projects
None yet
Development

No branches or pull requests

5 participants