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.

Sign up for GitHub

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

Jump to bottom

海内外 连不上 repeat AutoLogin #172

Closed
Ran-Xing opened this issue May 31, 2022 · 8 comments
Closed

海内外 连不上 repeat AutoLogin #172

Ran-Xing opened this issue May 31, 2022 · 8 comments

Comments

@Ran-Xing
Copy link 

example yarn run debug
yarn run v1.22.18
$ GRPC_VERBOSITY=DEBUG GRPC_TRACE=all WECHATY_LOG_LEVEL=silly cross-env NODE_OPTIONS="--no-warnings --loader=ts-node/esm" node main.ts
2022-05-31T04:25:34.915Z | index | Loading @grpc/grpc-js version 1.6.7

12:25:35 VERB WechatyPluginContrib QRCodeTerminal("{"small":false}")
12:25:35 VERB WechatyPluginMixin use() total 1 plugins
12:25:35 VERB WechatyPluginMixin use() installing Plugin QRCodeTerminalPlugin on Wechaty dingbot ...
12:25:35 VERB WechatyPluginContrib QRCodeTerminal installing on Wechaty#xxx-xxxx-xxx-xxx-xxxx-xxxxxxxx<wechaty-puppet-padlocal>() ...
12:25:35 VERB WechatySkeleton on(scan, listener) registering... listenerCount: 0
12:25:35 VERB WechatySkeleton on(login, listener) registering... listenerCount: 0
12:25:35 VERB WechatyPluginMixin use() total 1 plugins
12:25:35 VERB WechatyPluginMixin use() installing Plugin New on Wechaty dingbot ...
12:25:35 VERB WechatySkeleton on(message, listener) registering... listenerCount: 0
12:25:35 VERB Wechaty start()
12:25:35 VERB WechatyLoginMixin init()
12:25:35 VERB WechatyPuppetMixin init()
12:25:35 VERB WechatifyUserModuleMixin init()
12:25:35 VERB WechatySkeleton init()
12:25:35 VERB Wechaty init() Raven disabled (import("raven") failed)
12:25:35 VERB WechatifyUserModuleMixin init() initializing Wechaty User Module (WUM) ...
12:25:35 VERB WechatifyMixin wechatifyUserModule(ContactImpl)
12:25:35 VERB WechatifyMixin wechatifyUserModule(ContactImpl)(Wechaty#xxx-xxxx-xxx-xxx-xxxx-xxxxxxxx<wechaty-puppet-padlocal>(dingbot))
12:25:35 VERB WechatifyMixin wechatifyUserModule(ContactSelfImpl)
12:25:35 VERB WechatifyMixin wechatifyUserModule(ContactSelfImpl)(Wechaty#xxx-xxxx-xxx-xxx-xxxx-xxxxxxxx<wechaty-puppet-padlocal>(dingbot))
12:25:35 VERB WechatifyMixin wechatifyUserModule(DelayImpl)
12:25:35 VERB WechatifyMixin wechatifyUserModule(DelayImpl)(Wechaty#xxx-xxxx-xxx-xxx-xxxx-xxxxxxxx<wechaty-puppet-padlocal>(dingbot))
12:25:35 VERB WechatifyMixin wechatifyUserModule(FriendshipImpl)
12:25:35 VERB WechatifyMixin wechatifyUserModule(FriendshipImpl)(Wechaty#xxx-xxxx-xxx-xxx-xxxx-xxxxxxxx<wechaty-puppet-padlocal>(dingbot))
12:25:35 VERB WechatifyMixin wechatifyUserModule(ImageImpl)
12:25:35 VERB WechatifyMixin wechatifyUserModule(ImageImpl)(Wechaty#xxx-xxxx-xxx-xxx-xxxx-xxxxxxxx<wechaty-puppet-padlocal>(dingbot))
12:25:35 VERB WechatifyMixin wechatifyUserModule(LocationImpl)
12:25:35 VERB WechatifyMixin wechatifyUserModule(LocationImpl)(Wechaty#xxx-xxxx-xxx-xxx-xxxx-xxxxxxxx<wechaty-puppet-padlocal>(dingbot))
12:25:35 VERB WechatifyMixin wechatifyUserModule(MessageImpl)
12:25:35 VERB WechatifyMixin wechatifyUserModule(MessageImpl)(Wechaty#xxx-xxxx-xxx-xxx-xxxx-xxxxxxxx<wechaty-puppet-padlocal>(dingbot))
12:25:35 VERB WechatifyMixin wechatifyUserModule(MiniProgramImpl)
12:25:35 VERB WechatifyMixin wechatifyUserModule(MiniProgramImpl)(Wechaty#xxx-xxxx-xxx-xxx-xxxx-xxxxxxxx<wechaty-puppet-padlocal>(dingbot))
12:25:35 VERB WechatifyMixin wechatifyUserModule(PostImpl)
12:25:35 VERB WechatifyMixin wechatifyUserModule(PostImpl)(Wechaty#xxx-xxxx-xxx-xxx-xxxx-xxxxxxxx<wechaty-puppet-padlocal>(dingbot))
12:25:35 VERB WechatifyMixin wechatifyUserModule(RoomImpl)
12:25:35 VERB WechatifyMixin wechatifyUserModule(RoomImpl)(Wechaty#xxx-xxxx-xxx-xxx-xxxx-xxxxxxxx<wechaty-puppet-padlocal>(dingbot))
12:25:35 VERB WechatifyMixin wechatifyUserModule(RoomInvitationImpl)
12:25:35 VERB WechatifyMixin wechatifyUserModule(RoomInvitationImpl)(Wechaty#xxx-xxxx-xxx-xxx-xxxx-xxxxxxxx<wechaty-puppet-padlocal>(dingbot))
12:25:35 VERB WechatifyMixin wechatifyUserModule(TagImpl)
12:25:35 VERB WechatifyMixin wechatifyUserModule(TagImpl)(Wechaty#xxx-xxxx-xxx-xxx-xxxx-xxxxxxxx<wechaty-puppet-padlocal>(dingbot))
12:25:35 VERB WechatifyMixin wechatifyUserModule(UrlLinkImpl)
12:25:35 VERB WechatifyMixin wechatifyUserModule(UrlLinkImpl)(Wechaty#xxx-xxxx-xxx-xxx-xxxx-xxxxxxxx<wechaty-puppet-padlocal>(dingbot))
12:25:35 VERB WechatifyUserModuleMixin init() initializing Wechaty User Module (WUM) ... done
12:25:35 VERB WechatyPuppetMixin init() instanciating puppet instance ...
12:25:35 VERB Puppet resolvePuppet({puppet: wechaty-puppet-padlocal, puppetOptions: {"profile":"dingbot","name":"dingbot","token":"xxx-xxxx-xxx-xxx-xxxx-xxxxxxxx","timeoutSeconds":60}})
12:25:35 VERB Puppet resolvePuppet() resolving name "wechaty-puppet-padlocal" ...
12:25:35 VERB Puppet resolvePuppetName(wechaty-puppet-padlocal)
12:25:35 VERB Puppet resolvePuppetName(wechaty-puppet-padlocal): ESM resolved
12:25:35 VERB Puppet resolvePuppet() resolving name "wechaty-puppet-padlocal" ... done
12:25:35 VERB Puppet resolvePuppet() instanciating puppet ...
12:25:35 VERB PuppetSkeleton constructor({"profile":"dingbot","name":"dingbot","token":"xxx-xxxx-xxx-xxx-xxxx-xxxxxxxx","timeoutSeconds":60})
12:25:35 VERB PuppetMemoryMixin constructor()
12:25:35 VERB PuppetLoginMixin constructor()
12:25:35 VERB PuppetCacheMixin constructor()
12:25:35 VERB PuppetCacheAgent constructor()
12:25:35 VERB PuppetContactMixin constructor()
12:25:35 VERB PuppetRoomMemberMixin constructor()
12:25:35 VERB PuppetRoomMixin constructor()
12:25:35 VERB PuppetFriendshipMixin constructor()
12:25:35 VERB PuppetTagMixin constructor()
12:25:35 VERB PuppetRoomInvitationMixin constructor()
12:25:35 VERB PuppetMessageMixin constructor()
12:25:35 VERB PuppetMiscMixin constructor()
12:25:35 VERB ServiceCtl<PuppetServiceMixin> constructor()
12:25:35 VERB StateSwitch constructor(PuppetServiceMixin, "{"log":{"enableTimestamp":true,"logLevel":5,"prefixFilter":{}}}")
12:25:35 VERB StateSwitch constructor(PuppetServiceMixinReset, "{"log":{"enableTimestamp":true,"logLevel":5,"prefixFilter":{}}}")
12:25:35 VERB PuppetServiceMixin constructor() #0
12:25:35 VERB PuppetWatchdogAgent constructor(f96e7d78-52c5-432b-a287-3047b3149153)
12:25:35 VERB PuppetWatchdogAgent constructor() timeout 60 seconds
12:25:35 VERB ReadyMixin constructor()
12:25:35 VERB PuppetPostMixin constructor()
12:25:35 VERB PuppetSayableMixin constructor()
12:25:35 VERB TapMixin constructor()
12:25:35 VERB Puppet constructor({"profile":"dingbot","name":"dingbot","token":"xxx-xxxx-xxx-xxx-xxxx-xxxxxxxx","timeoutSeconds":60})
12:25:35 VERB Puppet resolvePuppet() instanciating puppet ... done
12:25:35 VERB WechatyPuppetMixin init() instanciating puppet instance ... done
12:25:35 VERB WechatyPuppetMixin init() setting memory ...
12:25:35 VERB PuppetMemoryMixin setMemory(dingbot)
12:25:35 VERB WechatyPuppetMixin init() setting memory ... done
12:25:35 VERB WechatyPuppetMixin init() setting up events ...
12:25:35 VERB WechatyPuppetMixin __setupPuppetEvents(Puppet<PuppetPadlocal>(dingbot))
12:25:35 VERB PuppetMixin __setupPuppetEvents() puppet.on(friendship) (listenerCount:0) registering...
12:25:35 VERB PuppetMixin __setupPuppetEvents() puppet.on(login) (listenerCount:0) registering...
12:25:35 VERB PuppetMixin __setupPuppetEvents() puppet.on(logout) (listenerCount:0) registering...
12:25:35 VERB PuppetMixin __setupPuppetEvents() puppet.on(message) (listenerCount:0) registering...
12:25:35 VERB PuppetMixin __setupPuppetEvents() puppet.on(post) (listenerCount:0) registering...
12:25:35 VERB PuppetMixin __setupPuppetEvents() puppet.on(room-invite) (listenerCount:0) registering...
12:25:35 VERB PuppetMixin __setupPuppetEvents() puppet.on(room-join) (listenerCount:0) registering...
12:25:35 VERB PuppetMixin __setupPuppetEvents() puppet.on(room-leave) (listenerCount:0) registering...
12:25:35 VERB PuppetMixin __setupPuppetEvents() puppet.on(room-topic) (listenerCount:0) registering...
12:25:35 VERB PuppetMixin __setupPuppetEvents() puppet.on(scan) (listenerCount:0) registering...
12:25:35 VERB PuppetMixin __setupPuppetEvents() puppet.on(dirty) (listenerCount:0) registering...
12:25:35 VERB PuppetMixin __setupPuppetEvents() puppet.on(dong) (listenerCount:0) registering...
12:25:35 VERB PuppetMixin __setupPuppetEvents() puppet.on(error) (listenerCount:0) registering...
12:25:35 VERB PuppetMixin __setupPuppetEvents() puppet.on(heartbeat) (listenerCount:0) registering...
12:25:35 VERB PuppetMixin __setupPuppetEvents() puppet.on(ready) (listenerCount:0) registering...
12:25:35 VERB PuppetMixin __setupPuppetEvents() puppet.on(reset) (listenerCount:0) registering...
12:25:35 VERB WechatyPuppetMixin __setupPuppetEvents() ... done
12:25:35 VERB WechatyPuppetMixin init() setting up events ... done
12:25:35 VERB WechatyPuppetMixin init() emitting "puppet" event ...
12:25:35 VERB WechatyPuppetMixin init() emitting "puppet" event ... done
12:25:35 VERB ServiceCtl<Wechaty> start()
12:25:35 SILL StateSwitch <Wechaty> active() is false
12:25:35 SILL StateSwitch <Wechaty> inactive() is true
12:25:35 SILL StateSwitch <Wechaty> active() is false
12:25:35 VERB StateSwitch <Wechaty> active(pending) <- (false)
12:25:35 VERB ServiceCtl<Wechaty> start() super.start() ...
12:25:35 VERB WechatyPuppetMixin start()
12:25:35 VERB WechatyPuppetMixin start() super.start() ...
12:25:35 VERB WechatyIoMixin start()
12:25:35 VERB WechatySkeleton start()
12:25:35 VERB WechatyLoginMixin init()
12:25:35 VERB WechatyPuppetMixin init()
12:25:35 VERB WechatifyUserModuleMixin init()
12:25:35 VERB WechatySkeleton init()
12:25:35 VERB WechatifyUserModuleMixin init() Wechaty User Module (WUM)s have already wechatified: skip
12:25:35 VERB WechatyPuppetMixin init() skipped because this puppet has already been inited before.
12:25:35 VERB WechatyPuppetMixin start() super.start() ... done
12:25:35 SILL StateSwitch <WechatyReady> active() is false
12:25:35 VERB WechatyPuppetMixin start() starting puppet ...
12:25:35 VERB ReadyMixin start()
12:25:35 VERB PuppetServiceMixin start()
12:25:35 VERB ServiceCtl<PuppetServiceMixin> start()
12:25:35 SILL StateSwitch <PuppetServiceMixin> active() is false
12:25:35 SILL StateSwitch <PuppetServiceMixin> inactive() is true
12:25:35 SILL StateSwitch <PuppetServiceMixin> active() is false
12:25:35 VERB StateSwitch <PuppetServiceMixin> active(pending) <- (false)
12:25:35 VERB ServiceCtl<PuppetServiceMixin> start() super.start() ...
12:25:35 VERB PuppetCacheMixin start()
12:25:35 VERB PuppetLoginMixin start()
12:25:35 VERB PuppetMemoryMixin start()
12:25:35 VERB PuppetSkeleton start()
12:25:35 VERB PuppetCacheAgent start()
12:25:35 VERB PuppetCacheMixin start() "dirty" event listener added
12:25:35 VERB ServiceCtl<PuppetServiceMixin> start() super.start() ... done
12:25:35 VERB ServiceCtl<PuppetServiceMixin> start() this.onStart() ...
D 2022-05-31T04:25:35.109Z | resolving_load_balancer | dns:gateway.pad-local.com:31527 IDLE -> IDLE
D 2022-05-31T04:25:35.109Z | connectivity_state | (1) dns:gateway.pad-local.com:31527 IDLE -> IDLE
D 2022-05-31T04:25:35.109Z | dns_resolver | Resolver constructed for target dns:gateway.pad-local.com:31527
D 2022-05-31T04:25:35.110Z | channel | (1) dns:gateway.pad-local.com:31527 Channel constructed with options {
  "grpc.ssl_target_name_override": "client.pad-local.com",
  "grpc.default_compression_algorithm": 2,
  "grpc.default_compression_level": 2,
  "grpc.max_send_message_length": 20971520,
  "grpc.max_receive_message_length": 20971520
}
D 2022-05-31T04:25:35.119Z | channel_stacktrace | (1) Channel constructed
    at new ChannelImplementation (/Users/xr/IDEA/example/node_modules/@grpc/grpc-js/src/channel.ts:345:19)
    at new Client (/Users/xr/IDEA/example/node_modules/@grpc/grpc-js/src/client.ts:153:30)
    at new ServiceClientImpl (/Users/xr/IDEA/example/node_modules/@grpc/grpc-js/src/make-client.ts:129:3)
    at new GrpcClient (/Users/xr/IDEA/example/node_modules/padlocal-client-ts/src/GrpcClient.ts:32:17)
    at Object.<anonymous> (/Users/xr/IDEA/example/node_modules/padlocal-client-ts/src/utils/ServerInfo.ts:40:22)
    at Generator.next (<anonymous>)
    at /Users/xr/IDEA/example/node_modules/padlocal-client-ts/dist/utils/ServerInfo.js:8:71
    at new Promise (<anonymous>)
    at __awaiter (/Users/xr/IDEA/example/node_modules/padlocal-client-ts/dist/utils/ServerInfo.js:4:12)
    at Object.getServerInfo (/Users/xr/IDEA/example/node_modules/padlocal-client-ts/dist/utils/ServerInfo.js:20:12)
D 2022-05-31T04:25:35.119Z | channel | (1) dns:gateway.pad-local.com:31527 createCall [0] method="/padlocal.PadLocal/init", deadline=1653971195119
D 2022-05-31T04:25:35.120Z | call_stream | [0] Sending metadata
D 2022-05-31T04:25:35.120Z | dns_resolver | Looking up DNS hostname gateway.pad-local.com
D 2022-05-31T04:25:35.121Z | resolving_load_balancer | dns:gateway.pad-local.com:31527 IDLE -> CONNECTING
D 2022-05-31T04:25:35.121Z | connectivity_state | (1) dns:gateway.pad-local.com:31527 IDLE -> CONNECTING
D 2022-05-31T04:25:35.121Z | channel | (1) dns:gateway.pad-local.com:31527 callRefTimer.ref | configSelectionQueue.length=1 pickQueue.length=0
D 2022-05-31T04:25:35.121Z | call_stream | [0] write() called with message of length 50
D 2022-05-31T04:25:35.121Z | call_stream | [0] end() called
D 2022-05-31T04:25:35.125Z | call_stream | [0] deferring writing data chunk of length 75
D 2022-05-31T04:25:35.126Z | dns_resolver | Resolved addresses for target dns:gateway.pad-local.com:31527: [8.131.225.128:31527]
D 2022-05-31T04:25:35.127Z | pick_first | Connect to address list 8.131.225.128:31527
D 2022-05-31T04:25:35.127Z | subchannel | (2) 8.131.225.128:31527 Subchannel constructed with options {
  "grpc.ssl_target_name_override": "client.pad-local.com",
  "grpc.default_compression_algorithm": 2,
  "grpc.default_compression_level": 2,
  "grpc.max_send_message_length": 20971520,
  "grpc.max_receive_message_length": 20971520
}
D 2022-05-31T04:25:35.127Z | subchannel_refcount | (2) 8.131.225.128:31527 refcount 0 -> 1
D 2022-05-31T04:25:35.127Z | subchannel_refcount | (2) 8.131.225.128:31527 refcount 1 -> 2
D 2022-05-31T04:25:35.127Z | pick_first | Start connecting to subchannel with address 8.131.225.128:31527
D 2022-05-31T04:25:35.127Z | pick_first | IDLE -> CONNECTING
D 2022-05-31T04:25:35.127Z | resolving_load_balancer | dns:gateway.pad-local.com:31527 CONNECTING -> CONNECTING
D 2022-05-31T04:25:35.127Z | channel | (1) dns:gateway.pad-local.com:31527 callRefTimer.unref | configSelectionQueue.length=1 pickQueue.length=0
D 2022-05-31T04:25:35.127Z | connectivity_state | (1) dns:gateway.pad-local.com:31527 CONNECTING -> CONNECTING
D 2022-05-31T04:25:35.127Z | subchannel | (2) 8.131.225.128:31527 IDLE -> CONNECTING
D 2022-05-31T04:25:35.128Z | pick_first | CONNECTING -> CONNECTING
D 2022-05-31T04:25:35.128Z | resolving_load_balancer | dns:gateway.pad-local.com:31527 CONNECTING -> CONNECTING
D 2022-05-31T04:25:35.128Z | connectivity_state | (1) dns:gateway.pad-local.com:31527 CONNECTING -> CONNECTING
D 2022-05-31T04:25:35.128Z | channel | (1) dns:gateway.pad-local.com:31527 Pick result for call [0]: QUEUE subchannel: null status: undefined undefined
D 2022-05-31T04:25:35.128Z | channel | (1) dns:gateway.pad-local.com:31527 callRefTimer.ref | configSelectionQueue.length=0 pickQueue.length=1
D 2022-05-31T04:25:35.128Z | subchannel | (2) 8.131.225.128:31527 creating HTTP/2 session
D 2022-05-31T04:25:35.258Z | subchannel | (2) 8.131.225.128:31527 CONNECTING -> READY
D 2022-05-31T04:25:35.258Z | pick_first | Pick subchannel with address 8.131.225.128:31527
D 2022-05-31T04:25:35.258Z | pick_first | CONNECTING -> READY
D 2022-05-31T04:25:35.258Z | resolving_load_balancer | dns:gateway.pad-local.com:31527 CONNECTING -> READY
D 2022-05-31T04:25:35.259Z | channel | (1) dns:gateway.pad-local.com:31527 callRefTimer.unref | configSelectionQueue.length=0 pickQueue.length=0
D 2022-05-31T04:25:35.259Z | channel | (1) dns:gateway.pad-local.com:31527 Pick result for call [0]: COMPLETE subchannel: (2) 8.131.225.128:31527 status: undefined undefined
D 2022-05-31T04:25:35.259Z | connectivity_state | (1) dns:gateway.pad-local.com:31527 CONNECTING -> READY
D 2022-05-31T04:25:35.259Z | subchannel_refcount | (2) 8.131.225.128:31527 refcount 2 -> 3
D 2022-05-31T04:25:35.259Z | subchannel_refcount | (2) 8.131.225.128:31527 refcount 3 -> 2
D 2022-05-31T04:25:35.261Z | call_stream | Starting stream [0] on subchannel (2) 8.131.225.128:31527 with headers
		ct: ts
		cv: 0.5.2
		traceid: f153d776
		grpc-timeout: 59860m
		grpc-accept-encoding: identity,deflate,gzip
		accept-encoding: identity
		grpc-encoding: gzip
		:authority: gateway.pad-local.com:31527
		user-agent: grpc-node-js/1.6.7
		content-type: application/grpc
		:method: POST
		:path: /padlocal.PadLocal/init
		te: trailers

D 2022-05-31T04:25:35.261Z | subchannel_flowctrl | (2) 8.131.225.128:31527 local window size: 65535 remote window size: 65535
D 2022-05-31T04:25:35.261Z | subchannel_internals | (2) 8.131.225.128:31527 session.closed=false session.destroyed=false session.socket.destroyed=false
D 2022-05-31T04:25:35.262Z | call_stream | [0] attachHttp2Stream from subchannel 8.131.225.128:31527
D 2022-05-31T04:25:35.262Z | subchannel_refcount | (2) 8.131.225.128:31527 callRefcount 0 -> 1
D 2022-05-31T04:25:35.262Z | call_stream | [0] sending data chunk of length 75 (deferred)
D 2022-05-31T04:25:35.262Z | call_stream | [0] calling end() on HTTP/2 stream
D 2022-05-31T04:25:35.262Z | subchannel | (2) 8.131.225.128:31527 new settings received: {"headerTableSize":4096,"enablePush":true,"initialWindowSize":1048576,"maxFrameSize":16384,"maxConcurrentStreams":2147483647,"maxHeaderListSize":8192,"maxHeaderSize":8192,"enableConnectProtocol":false}
D 2022-05-31T04:25:35.303Z | subchannel | (2) 8.131.225.128:31527 local settings acknowledged by remote: {"headerTableSize":4096,"enablePush":true,"initialWindowSize":65535,"maxFrameSize":16384,"maxConcurrentStreams":4294967295,"maxHeaderListSize":4294967295,"maxHeaderSize":4294967295,"enableConnectProtocol":false}
D 2022-05-31T04:25:35.309Z | call_stream | [0] Received server headers:
		:status: 200
		content-type: application/grpc
		grpc-encoding: identity
		grpc-accept-encoding: gzip

D 2022-05-31T04:25:35.310Z | call_stream | [0] receive HTTP/2 data frame of length 1281
D 2022-05-31T04:25:35.310Z | call_stream | [0] parsed message of length 1281
D 2022-05-31T04:25:35.310Z | call_stream | [0] filterReceivedMessage of length 1281
D 2022-05-31T04:25:35.310Z | call_stream | [0] pushing to reader message of length 1276
D 2022-05-31T04:25:35.311Z | call_stream | [0] Received server trailers:
		grpc-status: 0

D 2022-05-31T04:25:35.311Z | call_stream | [0] received status code 0 from server
D 2022-05-31T04:25:35.311Z | call_stream | [0] close http2 stream with code 0
D 2022-05-31T04:25:35.311Z | call_stream | [0] ended with status: code=0 details=""
D 2022-05-31T04:25:35.312Z | subchannel_refcount | (2) 8.131.225.128:31527 callRefcount 1 -> 0
D 2022-05-31T04:25:35.312Z | call_stream | [0] HTTP/2 stream closed with code 0
D 2022-05-31T04:25:35.312Z | resolving_load_balancer | dns:8.131.225.128:31527 IDLE -> IDLE
D 2022-05-31T04:25:35.312Z | connectivity_state | (4) dns:8.131.225.128:31527 IDLE -> IDLE
D 2022-05-31T04:25:35.312Z | dns_resolver | Resolver constructed for target dns:8.131.225.128:31527
D 2022-05-31T04:25:35.312Z | channel | (4) dns:8.131.225.128:31527 Channel constructed with options {
  "grpc.ssl_target_name_override": "client.pad-local.com",
  "grpc.default_compression_algorithm": 2,
  "grpc.default_compression_level": 2,
  "grpc.max_send_message_length": 20971520,
  "grpc.max_receive_message_length": 20971520
}
D 2022-05-31T04:25:35.313Z | channel_stacktrace | (4) Channel constructed
    at new ChannelImplementation (/Users/xr/IDEA/example/node_modules/@grpc/grpc-js/src/channel.ts:345:19)
    at new Client (/Users/xr/IDEA/example/node_modules/@grpc/grpc-js/src/client.ts:153:30)
    at new ServiceClientImpl (/Users/xr/IDEA/example/node_modules/@grpc/grpc-js/src/make-client.ts:129:3)
    at new GrpcClient (/Users/xr/IDEA/example/node_modules/padlocal-client-ts/src/GrpcClient.ts:32:17)
    at new PadLocalClient (/Users/xr/IDEA/example/node_modules/padlocal-client-ts/src/PadLocalClient.ts:46:23)
    at Function.<anonymous> (/Users/xr/IDEA/example/node_modules/padlocal-client-ts/src/PadLocalClient.ts:36:12)
    at Generator.next (<anonymous>)
    at fulfilled (/Users/xr/IDEA/example/node_modules/padlocal-client-ts/dist/PadLocalClient.js:5:58)
    at processTicksAndRejections (node:internal/process/task_queues:96:5)
12:25:35 INFO
      ============================================================
       Welcome to Wechaty PadLocal puppet!

       - puppet-padlocal version: 1.11.15
       - padlocal-ts-client version: 0.5.2
      ============================================================

D 2022-05-31T04:25:35.314Z | channel | (4) dns:8.131.225.128:31527 createCall [1] method="/padlocal.PadLocal/action", deadline=1653971735314
D 2022-05-31T04:25:35.314Z | call_stream | [1] Sending metadata
D 2022-05-31T04:25:35.314Z | dns_resolver | Returning IP address for target dns:8.131.225.128:31527
D 2022-05-31T04:25:35.314Z | resolving_load_balancer | dns:8.131.225.128:31527 IDLE -> CONNECTING
D 2022-05-31T04:25:35.314Z | connectivity_state | (4) dns:8.131.225.128:31527 IDLE -> CONNECTING
D 2022-05-31T04:25:35.314Z | channel | (4) dns:8.131.225.128:31527 callRefTimer.ref | configSelectionQueue.length=1 pickQueue.length=0
D 2022-05-31T04:25:35.316Z | call_stream | [1] write() called with message of length 7
12:25:35 VERB ServiceCtl<PuppetServiceMixin> start() this.onStart() ... done
12:25:35 SILL StateSwitch <PuppetServiceMixin> active() is pending
12:25:35 VERB StateSwitch <PuppetServiceMixin> active(true) <- (pending)
12:25:35 VERB ServiceCtl<PuppetServiceMixin> start() ... done
12:25:35 VERB PuppetWatchdogAgent start() "heartbeat" event listener added
12:25:35 VERB PuppetWatchdogAgent start() "reset" event listener added
12:25:35 VERB WechatyPuppetMixin start() starting puppet ... done
12:25:35 VERB ServiceCtl<Wechaty> start() super.start() ... done
12:25:35 VERB ServiceCtl<Wechaty> start() this.onStart() ...
12:25:35 VERB Wechaty onStart()
12:25:35 VERB Wechaty <wechaty-puppet-padlocal>(dingbot) onStart() v1.20.2 is starting...
12:25:35 VERB Wechaty id: xxx-xxxx-xxx-xxx-xxxx-xxxxxxxx
12:25:35 VERB Wechaty onStart() ... done
12:25:35 VERB ServiceCtl<Wechaty> start() this.onStart() ... done
12:25:35 SILL StateSwitch <Wechaty> active() is pending
12:25:35 VERB StateSwitch <Wechaty> active(true) <- (pending)
12:25:35 VERB ServiceCtl<Wechaty> start() ... done
12:25:35 INFO StarterBot Starter Bot Started.
D 2022-05-31T04:25:35.317Z | pick_first | Connect to address list 8.131.225.128:31527
D 2022-05-31T04:25:35.317Z | subchannel | (5) 8.131.225.128:31527 Subchannel constructed with options {
  "grpc.ssl_target_name_override": "client.pad-local.com",
  "grpc.default_compression_algorithm": 2,
  "grpc.default_compression_level": 2,
  "grpc.max_send_message_length": 20971520,
  "grpc.max_receive_message_length": 20971520
}
D 2022-05-31T04:25:35.317Z | subchannel_refcount | (5) 8.131.225.128:31527 refcount 0 -> 1
D 2022-05-31T04:25:35.317Z | subchannel_refcount | (5) 8.131.225.128:31527 refcount 1 -> 2
D 2022-05-31T04:25:35.317Z | pick_first | Start connecting to subchannel with address 8.131.225.128:31527
D 2022-05-31T04:25:35.317Z | pick_first | IDLE -> CONNECTING
D 2022-05-31T04:25:35.317Z | resolving_load_balancer | dns:8.131.225.128:31527 CONNECTING -> CONNECTING
D 2022-05-31T04:25:35.317Z | channel | (4) dns:8.131.225.128:31527 callRefTimer.unref | configSelectionQueue.length=1 pickQueue.length=0
D 2022-05-31T04:25:35.317Z | connectivity_state | (4) dns:8.131.225.128:31527 CONNECTING -> CONNECTING
D 2022-05-31T04:25:35.317Z | subchannel | (5) 8.131.225.128:31527 IDLE -> CONNECTING
D 2022-05-31T04:25:35.317Z | pick_first | CONNECTING -> CONNECTING
D 2022-05-31T04:25:35.317Z | resolving_load_balancer | dns:8.131.225.128:31527 CONNECTING -> CONNECTING
D 2022-05-31T04:25:35.317Z | connectivity_state | (4) dns:8.131.225.128:31527 CONNECTING -> CONNECTING
D 2022-05-31T04:25:35.317Z | channel | (4) dns:8.131.225.128:31527 Pick result for call [1]: QUEUE subchannel: null status: undefined undefined
D 2022-05-31T04:25:35.317Z | channel | (4) dns:8.131.225.128:31527 callRefTimer.ref | configSelectionQueue.length=0 pickQueue.length=1
D 2022-05-31T04:25:35.317Z | subchannel | (5) 8.131.225.128:31527 creating HTTP/2 session
D 2022-05-31T04:25:35.318Z | call_stream | [1] deferring writing data chunk of length 32
D 2022-05-31T04:25:35.428Z | subchannel | (5) 8.131.225.128:31527 CONNECTING -> READY
D 2022-05-31T04:25:35.428Z | pick_first | Pick subchannel with address 8.131.225.128:31527
D 2022-05-31T04:25:35.428Z | pick_first | CONNECTING -> READY
D 2022-05-31T04:25:35.428Z | resolving_load_balancer | dns:8.131.225.128:31527 CONNECTING -> READY
D 2022-05-31T04:25:35.428Z | channel | (4) dns:8.131.225.128:31527 callRefTimer.unref | configSelectionQueue.length=0 pickQueue.length=0
D 2022-05-31T04:25:35.428Z | channel | (4) dns:8.131.225.128:31527 Pick result for call [1]: COMPLETE subchannel: (5) 8.131.225.128:31527 status: undefined undefined
D 2022-05-31T04:25:35.428Z | connectivity_state | (4) dns:8.131.225.128:31527 CONNECTING -> READY
D 2022-05-31T04:25:35.428Z | subchannel_refcount | (5) 8.131.225.128:31527 refcount 2 -> 3
D 2022-05-31T04:25:35.428Z | subchannel_refcount | (5) 8.131.225.128:31527 refcount 3 -> 2
D 2022-05-31T04:25:35.429Z | call_stream | Starting stream [1] on subchannel (5) 8.131.225.128:31527 with headers
		ct: ts
		cv: 0.5.2
		traceid: b2cc6756
		authorization: Bearer v2_xxx-xxxx-xxx-xxx-xxxx-xxxxxxxx
		grpc-timeout: 599885m
		grpc-accept-encoding: identity,deflate,gzip
		accept-encoding: identity
		grpc-encoding: gzip
		:authority: 8.131.225.128:31527
		user-agent: grpc-node-js/1.6.7
		content-type: application/grpc
		:method: POST
		:path: /padlocal.PadLocal/action
		te: trailers

D 2022-05-31T04:25:35.430Z | subchannel_flowctrl | (5) 8.131.225.128:31527 local window size: 65535 remote window size: 65535
D 2022-05-31T04:25:35.430Z | subchannel_internals | (5) 8.131.225.128:31527 session.closed=false session.destroyed=false session.socket.destroyed=false
D 2022-05-31T04:25:35.430Z | call_stream | [1] attachHttp2Stream from subchannel 8.131.225.128:31527
D 2022-05-31T04:25:35.430Z | subchannel_refcount | (5) 8.131.225.128:31527 callRefcount 0 -> 1
D 2022-05-31T04:25:35.430Z | call_stream | [1] sending data chunk of length 32 (deferred)
D 2022-05-31T04:25:35.430Z | subchannel | (5) 8.131.225.128:31527 new settings received: {"headerTableSize":4096,"enablePush":true,"initialWindowSize":1048576,"maxFrameSize":16384,"maxConcurrentStreams":2147483647,"maxHeaderListSize":8192,"maxHeaderSize":8192,"enableConnectProtocol":false}
D 2022-05-31T04:25:35.467Z | subchannel | (5) 8.131.225.128:31527 local settings acknowledged by remote: {"headerTableSize":4096,"enablePush":true,"initialWindowSize":65535,"maxFrameSize":16384,"maxConcurrentStreams":4294967295,"maxHeaderListSize":4294967295,"maxHeaderSize":4294967295,"enableConnectProtocol":false}
D 2022-05-31T04:25:35.517Z | call_stream | [1] Received server headers:
		:status: 200
		content-type: application/grpc
		grpc-encoding: identity
		grpc-accept-encoding: gzip

D 2022-05-31T04:25:35.518Z | call_stream | [1] receive HTTP/2 data frame of length 59
D 2022-05-31T04:25:35.518Z | call_stream | [1] parsed message of length 59
D 2022-05-31T04:25:35.518Z | call_stream | [1] filterReceivedMessage of length 59
D 2022-05-31T04:25:35.518Z | call_stream | [1] pushing to reader message of length 54
D 2022-05-31T04:25:35.523Z | call_stream | [1] write() called with message of length 7
D 2022-05-31T04:25:35.525Z | call_stream | [1] sending data chunk of length 32
D 2022-05-31T04:25:35.568Z | call_stream | [1] receive HTTP/2 data frame of length 12
D 2022-05-31T04:25:35.568Z | call_stream | [1] parsed message of length 12
D 2022-05-31T04:25:35.568Z | call_stream | [1] filterReceivedMessage of length 12
D 2022-05-31T04:25:35.568Z | call_stream | [1] pushing to reader message of length 7
12:25:35 INFO [PuppetPadlocal] start login with type: AutoLogin
D 2022-05-31T04:25:35.585Z | call_stream | [1] receive HTTP/2 data frame of length 47
D 2022-05-31T04:25:35.585Z | call_stream | [1] parsed message of length 47
D 2022-05-31T04:25:35.585Z | call_stream | [1] filterReceivedMessage of length 47
D 2022-05-31T04:25:35.586Z | call_stream | [1] pushing to reader message of length 42
D 2022-05-31T04:25:35.660Z | channel | (4) dns:8.131.225.128:31527 createCall [2] method="/padlocal.PadLocal/action", deadline=1653971195659
D 2022-05-31T04:25:35.660Z | call_stream | [2] Sending metadata
D 2022-05-31T04:25:35.660Z | channel | (4) dns:8.131.225.128:31527 Pick result for call [2]: COMPLETE subchannel: (5) 8.131.225.128:31527 status: undefined undefined
D 2022-05-31T04:25:35.661Z | call_stream | [2] write() called with message of length 16
D 2022-05-31T04:25:35.662Z | call_stream | Starting stream [2] on subchannel (5) 8.131.225.128:31527 with headers
		ct: ts
		cv: 0.5.2
		traceid: 5903ef98
		authorization: Bearer v2_xxx-xxxx-xxx-xxx-xxxx-xxxxxxxx
		grpc-timeout: 59998m
		grpc-accept-encoding: identity,deflate,gzip
		accept-encoding: identity
		grpc-encoding: gzip
		:authority: 8.131.225.128:31527
		user-agent: grpc-node-js/1.6.7
		content-type: application/grpc
		:method: POST
		:path: /padlocal.PadLocal/action
		te: trailers

D 2022-05-31T04:25:35.662Z | subchannel_flowctrl | (5) 8.131.225.128:31527 local window size: 65417 remote window size: 1048512
D 2022-05-31T04:25:35.662Z | subchannel_internals | (5) 8.131.225.128:31527 session.closed=false session.destroyed=false session.socket.destroyed=false
D 2022-05-31T04:25:35.662Z | call_stream | [2] attachHttp2Stream from subchannel 8.131.225.128:31527
D 2022-05-31T04:25:35.662Z | subchannel_refcount | (5) 8.131.225.128:31527 callRefcount 1 -> 2
D 2022-05-31T04:25:35.663Z | call_stream | [2] sending data chunk of length 41
D 2022-05-31T04:25:35.718Z | call_stream | [2] Received server headers:
		:status: 200
		content-type: application/grpc
		grpc-encoding: identity
		grpc-accept-encoding: gzip

D 2022-05-31T04:25:35.718Z | call_stream | [2] receive HTTP/2 data frame of length 248
D 2022-05-31T04:25:35.719Z | call_stream | [2] parsed message of length 248
D 2022-05-31T04:25:35.719Z | call_stream | [2] filterReceivedMessage of length 248
D 2022-05-31T04:25:35.719Z | call_stream | [2] pushing to reader message of length 243
D 2022-05-31T04:25:35.796Z | call_stream | [2] write() called with message of length 599
D 2022-05-31T04:25:35.797Z | call_stream | [2] sending data chunk of length 627
D 2022-05-31T04:25:35.848Z | call_stream | [2] receive HTTP/2 data frame of length 77
D 2022-05-31T04:25:35.848Z | call_stream | [2] parsed message of length 77
D 2022-05-31T04:25:35.849Z | call_stream | [2] filterReceivedMessage of length 77
D 2022-05-31T04:25:35.849Z | call_stream | [2] pushing to reader message of length 72
D 2022-05-31T04:25:35.852Z | call_stream | [2] receive HTTP/2 data frame of length 58
D 2022-05-31T04:25:35.852Z | call_stream | [2] parsed message of length 58
D 2022-05-31T04:25:35.852Z | call_stream | [2] filterReceivedMessage of length 58
D 2022-05-31T04:25:35.852Z | call_stream | [2] pushing to reader message of length 53
D 2022-05-31T04:25:35.854Z | channel | (4) dns:8.131.225.128:31527 createCall [3] method="/padlocal.PadLocal/action", deadline=1653971195853
D 2022-05-31T04:25:35.854Z | call_stream | [3] Sending metadata
D 2022-05-31T04:25:35.854Z | channel | (4) dns:8.131.225.128:31527 Pick result for call [3]: COMPLETE subchannel: (5) 8.131.225.128:31527 status: undefined undefined
D 2022-05-31T04:25:35.855Z | call_stream | [3] write() called with message of length 50
D 2022-05-31T04:25:35.856Z | call_stream | Starting stream [3] on subchannel (5) 8.131.225.128:31527 with headers
		ct: ts
		cv: 0.5.2
		traceid: 6c88d0e7
		authorization: Bearer v2_xxx-xxxx-xxx-xxx-xxxx-xxxxxxxx
		grpc-timeout: 59998m
		grpc-accept-encoding: identity,deflate,gzip
		accept-encoding: identity
		grpc-encoding: gzip
		:authority: 8.131.225.128:31527
		user-agent: grpc-node-js/1.6.7
		content-type: application/grpc
		:method: POST
		:path: /padlocal.PadLocal/action
		te: trailers

D 2022-05-31T04:25:35.856Z | subchannel_flowctrl | (5) 8.131.225.128:31527 local window size: 65034 remote window size: 1047844
D 2022-05-31T04:25:35.856Z | subchannel_internals | (5) 8.131.225.128:31527 session.closed=false session.destroyed=false session.socket.destroyed=false
D 2022-05-31T04:25:35.856Z | call_stream | [3] attachHttp2Stream from subchannel 8.131.225.128:31527
D 2022-05-31T04:25:35.856Z | subchannel_refcount | (5) 8.131.225.128:31527 callRefcount 2 -> 3
D 2022-05-31T04:25:35.857Z | call_stream | [3] sending data chunk of length 75
D 2022-05-31T04:25:35.947Z | call_stream | [3] Received server headers:
		:status: 200
		content-type: application/grpc
		grpc-encoding: identity
		grpc-accept-encoding: gzip

D 2022-05-31T04:25:35.947Z | call_stream | [3] receive HTTP/2 data frame of length 1080
D 2022-05-31T04:25:35.947Z | call_stream | [3] parsed message of length 1080
D 2022-05-31T04:25:35.947Z | call_stream | [3] filterReceivedMessage of length 1080
D 2022-05-31T04:25:35.948Z | call_stream | [3] pushing to reader message of length 1075
D 2022-05-31T04:25:36.122Z | resolving_load_balancer | dns:gateway.pad-local.com:31527 READY -> READY
D 2022-05-31T04:25:36.122Z | connectivity_state | (1) dns:gateway.pad-local.com:31527 READY -> READY
D 2022-05-31T04:25:36.316Z | resolving_load_balancer | dns:8.131.225.128:31527 READY -> READY
D 2022-05-31T04:25:36.316Z | connectivity_state | (4) dns:8.131.225.128:31527 READY -> READY
D 2022-05-31T04:25:48.002Z | call_stream | [3] cancelWithStatus code: 1 details: "Cancelled on client"
D 2022-05-31T04:25:48.002Z | call_stream | [3] ended with status: code=1 details="Cancelled on client"
D 2022-05-31T04:25:48.002Z | subchannel_refcount | (5) 8.131.225.128:31527 callRefcount 3 -> 2
D 2022-05-31T04:25:48.002Z | call_stream | [3] close http2 stream with code 8
D 2022-05-31T04:25:48.003Z | call_stream | [2] cancelWithStatus code: 1 details: "Cancelled on client"
D 2022-05-31T04:25:48.004Z | call_stream | [2] ended with status: code=1 details="Cancelled on client"
D 2022-05-31T04:25:48.004Z | subchannel_refcount | (5) 8.131.225.128:31527 callRefcount 2 -> 1
D 2022-05-31T04:25:48.004Z | call_stream | [2] close http2 stream with code 8
D 2022-05-31T04:25:48.004Z | call_stream | [3] HTTP/2 stream closed with code 8
D 2022-05-31T04:25:48.004Z | call_stream | [2] HTTP/2 stream closed with code 8
D 2022-05-31T04:25:49.087Z | channel | (4) dns:8.131.225.128:31527 createCall [4] method="/padlocal.PadLocal/action", deadline=1653971209087
D 2022-05-31T04:25:49.088Z | call_stream | [4] Sending metadata
D 2022-05-31T04:25:49.089Z | channel | (4) dns:8.131.225.128:31527 Pick result for call [4]: COMPLETE subchannel: (5) 8.131.225.128:31527 status: undefined undefined
D 2022-05-31T04:25:49.090Z | call_stream | [4] write() called with message of length 16
D 2022-05-31T04:25:49.091Z | call_stream | Starting stream [4] on subchannel (5) 8.131.225.128:31527 with headers
		ct: ts
		cv: 0.5.2
		traceid: 5f61f340
		authorization: Bearer v2_xxx-xxxx-xxx-xxx-xxxx-xxxxxxxx
		grpc-timeout: 59997m
		grpc-accept-encoding: identity,deflate,gzip
		accept-encoding: identity
		grpc-encoding: gzip
		:authority: 8.131.225.128:31527
		user-agent: grpc-node-js/1.6.7
		content-type: application/grpc
		:method: POST
		:path: /padlocal.PadLocal/action
		te: trailers

D 2022-05-31T04:25:49.092Z | subchannel_flowctrl | (5) 8.131.225.128:31527 local window size: 63954 remote window size: 1047769
D 2022-05-31T04:25:49.092Z | subchannel_internals | (5) 8.131.225.128:31527 session.closed=false session.destroyed=false session.socket.destroyed=false
D 2022-05-31T04:25:49.092Z | call_stream | [4] attachHttp2Stream from subchannel 8.131.225.128:31527
D 2022-05-31T04:25:49.092Z | subchannel_refcount | (5) 8.131.225.128:31527 callRefcount 1 -> 2
D 2022-05-31T04:25:49.093Z | call_stream | [4] sending data chunk of length 41
D 2022-05-31T04:25:49.149Z | call_stream | [4] Received server headers:
		:status: 200
		content-type: application/grpc
		grpc-encoding: identity
		grpc-accept-encoding: gzip

D 2022-05-31T04:25:49.150Z | call_stream | [4] receive HTTP/2 data frame of length 197
D 2022-05-31T04:25:49.150Z | call_stream | [4] parsed message of length 197
D 2022-05-31T04:25:49.150Z | call_stream | [4] filterReceivedMessage of length 197
D 2022-05-31T04:25:49.151Z | call_stream | [4] pushing to reader message of length 192
D 2022-05-31T04:25:49.233Z | call_stream | [4] write() called with message of length 123
D 2022-05-31T04:25:49.234Z | call_stream | [4] sending data chunk of length 151
D 2022-05-31T04:25:49.277Z | call_stream | [4] receive HTTP/2 data frame of length 77
D 2022-05-31T04:25:49.278Z | call_stream | [4] parsed message of length 77
D 2022-05-31T04:25:49.278Z | call_stream | [4] filterReceivedMessage of length 77
D 2022-05-31T04:25:49.278Z | call_stream | [4] pushing to reader message of length 72
D 2022-05-31T04:25:49.281Z | call_stream | [4] receive HTTP/2 data frame of length 58
D 2022-05-31T04:25:49.282Z | call_stream | [4] parsed message of length 58
D 2022-05-31T04:25:49.282Z | call_stream | [4] filterReceivedMessage of length 58
D 2022-05-31T04:25:49.282Z | call_stream | [4] pushing to reader message of length 53
D 2022-05-31T04:25:49.283Z | channel | (4) dns:8.131.225.128:31527 createCall [5] method="/padlocal.PadLocal/action", deadline=1653971209283
D 2022-05-31T04:25:49.284Z | call_stream | [5] Sending metadata
D 2022-05-31T04:25:49.284Z | channel | (4) dns:8.131.225.128:31527 Pick result for call [5]: COMPLETE subchannel: (5) 8.131.225.128:31527 status: undefined undefined
D 2022-05-31T04:25:49.285Z | call_stream | [5] write() called with message of length 50
D 2022-05-31T04:25:49.285Z | call_stream | Starting stream [5] on subchannel (5) 8.131.225.128:31527 with headers
		ct: ts
		cv: 0.5.2
		traceid: 55ef16c3
		authorization: Bearer v2_xxx-xxxx-xxx-xxx-xxxx-xxxxxxxx
		grpc-timeout: 59998m
		grpc-accept-encoding: identity,deflate,gzip
		accept-encoding: identity
		grpc-encoding: gzip
		:authority: 8.131.225.128:31527
		user-agent: grpc-node-js/1.6.7
		content-type: application/grpc
		:method: POST
		:path: /padlocal.PadLocal/action
		te: trailers

D 2022-05-31T04:25:49.286Z | subchannel_flowctrl | (5) 8.131.225.128:31527 local window size: 63622 remote window size: 1047577
D 2022-05-31T04:25:49.286Z | subchannel_internals | (5) 8.131.225.128:31527 session.closed=false session.destroyed=false session.socket.destroyed=false
D 2022-05-31T04:25:49.286Z | call_stream | [5] attachHttp2Stream from subchannel 8.131.225.128:31527
D 2022-05-31T04:25:49.286Z | subchannel_refcount | (5) 8.131.225.128:31527 callRefcount 2 -> 3
D 2022-05-31T04:25:49.287Z | call_stream | [5] sending data chunk of length 75
D 2022-05-31T04:25:49.380Z | call_stream | [5] Received server headers:
		:status: 200
		content-type: application/grpc
		grpc-encoding: identity
		grpc-accept-encoding: gzip

D 2022-05-31T04:25:49.380Z | call_stream | [5] receive HTTP/2 data frame of length 1080
D 2022-05-31T04:25:49.380Z | call_stream | [5] parsed message of length 1080
D 2022-05-31T04:25:49.380Z | call_stream | [5] filterReceivedMessage of length 1080
D 2022-05-31T04:25:49.380Z | call_stream | [5] pushing to reader message of length 1075
D 2022-05-31T04:26:01.421Z | call_stream | [5] cancelWithStatus code: 1 details: "Cancelled on client"
D 2022-05-31T04:26:01.421Z | call_stream | [5] ended with status: code=1 details="Cancelled on client"
D 2022-05-31T04:26:01.421Z | subchannel_refcount | (5) 8.131.225.128:31527 callRefcount 3 -> 2
D 2022-05-31T04:26:01.421Z | call_stream | [5] close http2 stream with code 8
D 2022-05-31T04:26:01.422Z | call_stream | [4] cancelWithStatus code: 1 details: "Cancelled on client"
D 2022-05-31T04:26:01.422Z | call_stream | [4] ended with status: code=1 details="Cancelled on client"
D 2022-05-31T04:26:01.422Z | subchannel_refcount | (5) 8.131.225.128:31527 callRefcount 2 -> 1
D 2022-05-31T04:26:01.422Z | call_stream | [4] close http2 stream with code 8
D 2022-05-31T04:26:01.422Z | call_stream | [5] HTTP/2 stream closed with code 8
D 2022-05-31T04:26:01.422Z | call_stream | [4] HTTP/2 stream closed with code 8
D 2022-05-31T04:26:02.508Z | channel | (4) dns:8.131.225.128:31527 createCall [6] method="/padlocal.PadLocal/action", deadline=1653971222508
D 2022-05-31T04:26:02.508Z | call_stream | [6] Sending metadata
D 2022-05-31T04:26:02.509Z | channel | (4) dns:8.131.225.128:31527 Pick result for call [6]: COMPLETE subchannel: (5) 8.131.225.128:31527 status: undefined undefined
D 2022-05-31T04:26:02.514Z | call_stream | [6] write() called with message of length 16
D 2022-05-31T04:26:02.516Z | call_stream | Starting stream [6] on subchannel (5) 8.131.225.128:31527 with headers
		ct: ts
		cv: 0.5.2
		traceid: 622d7c4c
		authorization: Bearer v2_xxx-xxxx-xxx-xxx-xxxx-xxxxxxxx
		grpc-timeout: 59993m
		grpc-accept-encoding: identity,deflate,gzip
		accept-encoding: identity
		grpc-encoding: gzip
		:authority: 8.131.225.128:31527
		user-agent: grpc-node-js/1.6.7
		content-type: application/grpc
		:method: POST
		:path: /padlocal.PadLocal/action
		te: trailers

D 2022-05-31T04:26:02.516Z | subchannel_flowctrl | (5) 8.131.225.128:31527 local window size: 62542 remote window size: 1047502
D 2022-05-31T04:26:02.516Z | subchannel_internals | (5) 8.131.225.128:31527 session.closed=false session.destroyed=false session.socket.destroyed=false
D 2022-05-31T04:26:02.516Z | call_stream | [6] attachHttp2Stream from subchannel 8.131.225.128:31527
D 2022-05-31T04:26:02.516Z | subchannel_refcount | (5) 8.131.225.128:31527 callRefcount 1 -> 2
D 2022-05-31T04:26:02.517Z | call_stream | [6] sending data chunk of length 41
D 2022-05-31T04:26:02.575Z | call_stream | [6] Received server headers:
		:status: 200
		content-type: application/grpc
		grpc-encoding: identity
		grpc-accept-encoding: gzip

D 2022-05-31T04:26:02.576Z | call_stream | [6] receive HTTP/2 data frame of length 197
D 2022-05-31T04:26:02.576Z | call_stream | [6] parsed message of length 197
D 2022-05-31T04:26:02.576Z | call_stream | [6] filterReceivedMessage of length 197
D 2022-05-31T04:26:02.576Z | call_stream | [6] pushing to reader message of length 192
D 2022-05-31T04:26:02.653Z | call_stream | [6] write() called with message of length 123
D 2022-05-31T04:26:02.654Z | call_stream | [6] sending data chunk of length 151
D 2022-05-31T04:26:02.697Z | call_stream | [6] receive HTTP/2 data frame of length 77
D 2022-05-31T04:26:02.697Z | call_stream | [6] parsed message of length 77
D 2022-05-31T04:26:02.698Z | call_stream | [6] filterReceivedMessage of length 77
D 2022-05-31T04:26:02.698Z | call_stream | [6] pushing to reader message of length 72
D 2022-05-31T04:26:02.701Z | call_stream | [6] receive HTTP/2 data frame of length 58
D 2022-05-31T04:26:02.701Z | call_stream | [6] parsed message of length 58
D 2022-05-31T04:26:02.701Z | call_stream | [6] filterReceivedMessage of length 58
D 2022-05-31T04:26:02.701Z | call_stream | [6] pushing to reader message of length 53
D 2022-05-31T04:26:02.702Z | channel | (4) dns:8.131.225.128:31527 createCall [7] method="/padlocal.PadLocal/action", deadline=1653971222702
D 2022-05-31T04:26:02.702Z | call_stream | [7] Sending metadata
D 2022-05-31T04:26:02.703Z | channel | (4) dns:8.131.225.128:31527 Pick result for call [7]: COMPLETE subchannel: (5) 8.131.225.128:31527 status: undefined undefined
D 2022-05-31T04:26:02.704Z | call_stream | [7] write() called with message of length 50
D 2022-05-31T04:26:02.704Z | call_stream | Starting stream [7] on subchannel (5) 8.131.225.128:31527 with headers
		ct: ts
		cv: 0.5.2
		traceid: a3308255
		authorization: Bearer v2_xxx-xxxx-xxx-xxx-xxxx-xxxxxxxx
		grpc-timeout: 59998m
		grpc-accept-encoding: identity,deflate,gzip
		accept-encoding: identity
		grpc-encoding: gzip
		:authority: 8.131.225.128:31527
		user-agent: grpc-node-js/1.6.7
		content-type: application/grpc
		:method: POST
		:path: /padlocal.PadLocal/action
		te: trailers

D 2022-05-31T04:26:02.704Z | subchannel_flowctrl | (5) 8.131.225.128:31527 local window size: 62210 remote window size: 1047310
D 2022-05-31T04:26:02.704Z | subchannel_internals | (5) 8.131.225.128:31527 session.closed=false session.destroyed=false session.socket.destroyed=false
D 2022-05-31T04:26:02.704Z | call_stream | [7] attachHttp2Stream from subchannel 8.131.225.128:31527
D 2022-05-31T04:26:02.704Z | subchannel_refcount | (5) 8.131.225.128:31527 callRefcount 2 -> 3
D 2022-05-31T04:26:02.705Z | call_stream | [7] sending data chunk of length 75
D 2022-05-31T04:26:02.798Z | call_stream | [7] Received server headers:
		:status: 200
		content-type: application/grpc
		grpc-encoding: identity
		grpc-accept-encoding: gzip

D 2022-05-31T04:26:02.799Z | call_stream | [7] receive HTTP/2 data frame of length 1080
D 2022-05-31T04:26:02.800Z | call_stream | [7] parsed message of length 1080
D 2022-05-31T04:26:02.800Z | call_stream | [7] filterReceivedMessage of length 1080
D 2022-05-31T04:26:02.800Z | call_stream | [7] pushing to reader message of length 1075
^C12:26:04 VERB ReadyMixin stop()
12:26:04 VERB PuppetServiceMixin stop()
12:26:04 VERB PuppetWatchdogAgent start() "heartbeat" event listener removed
12:26:04 VERB PuppetWatchdogAgent start() "reset" event listener removed
12:26:04 VERB ServiceCtl<PuppetServiceMixin> stop()
12:26:04 SILL StateSwitch <PuppetServiceMixin> inactive() is false
12:26:04 SILL StateSwitch <PuppetServiceMixin> active() is true
12:26:04 SILL StateSwitch <PuppetServiceMixin> inactive() is false
12:26:04 VERB StateSwitch <PuppetServiceMixin> inactive(pending) <- (false)
12:26:04 VERB ServiceCtl<PuppetServiceMixin> stop() this.onStop() ...
D 2022-05-31T04:26:04.678Z | channel | (4) dns:8.131.225.128:31527 createCall [8] method="/padlocal.PadLocal/action", deadline=1653971165678
D 2022-05-31T04:26:04.679Z | call_stream | [8] Sending metadata
D 2022-05-31T04:26:04.679Z | channel | (4) dns:8.131.225.128:31527 Pick result for call [8]: COMPLETE subchannel: (5) 8.131.225.128:31527 status: undefined undefined

D 2022-05-31T04:26:04.680Z | call_stream | [8] write() called with message of length 8
D 2022-05-31T04:26:04.681Z | call_stream | Starting stream [8] on subchannel (5) 8.131.225.128:31527 with headers
		ct: ts
		cv: 0.5.2
		traceid: f6cfa201
		authorization: Bearer v2_xxx-xxxx-xxx-xxx-xxxx-xxxxxxxx
		grpc-timeout: 997m
		grpc-accept-encoding: identity,deflate,gzip
		accept-encoding: identity
		grpc-encoding: gzip
		:authority: 8.131.225.128:31527
		user-agent: grpc-node-js/1.6.7
		content-type: application/grpc
		:method: POST
		:path: /padlocal.PadLocal/action
		te: trailers

D 2022-05-31T04:26:04.690Z | subchannel_flowctrl | (5) 8.131.225.128:31527 local window size: 61130 remote window size: 1047235
D 2022-05-31T04:26:04.690Z | subchannel_internals | (5) 8.131.225.128:31527 session.closed=false session.destroyed=false session.socket.destroyed=false
D 2022-05-31T04:26:04.690Z | call_stream | [8] attachHttp2Stream from subchannel 8.131.225.128:31527
D 2022-05-31T04:26:04.690Z | subchannel_refcount | (5) 8.131.225.128:31527 callRefcount 3 -> 4
12:26:04 VERB ReadyMixin stop()
12:26:04 VERB PuppetServiceMixin stop()
12:26:04 VERB ServiceCtl<PuppetServiceMixin> stop()
12:26:04 SILL StateSwitch <PuppetServiceMixin> inactive() is pending
12:26:04 WARN ServiceCtl<PuppetServiceMixin> stop() found that is stopping/stopped, wait stable ...
12:26:04 VERB StateSwitch <PuppetServiceMixin> stable(inactive, noCross=false)
D 2022-05-31T04:26:04.697Z | call_stream | [8] sending data chunk of length 33
➜  example D 2022-05-31T04:26:04.768Z | call_stream | [8] Received server headers:
		:status: 200
		content-type: application/grpc
		grpc-encoding: identity
		grpc-accept-encoding: gzip

D 2022-05-31T04:26:04.769Z | call_stream | [8] receive HTTP/2 data frame of length 1080
D 2022-05-31T04:26:04.769Z | call_stream | [8] parsed message of length 1080
D 2022-05-31T04:26:04.769Z | call_stream | [8] filterReceivedMessage of length 1080
D 2022-05-31T04:26:04.769Z | call_stream | [8] pushing to reader message of length 1075
D 2022-05-31T04:26:05.680Z | call_stream | [8] cancelWithStatus code: 4 details: "Deadline exceeded"
D 2022-05-31T04:26:05.681Z | call_stream | [8] ended with status: code=4 details="Deadline exceeded"
D 2022-05-31T04:26:05.681Z | subchannel_refcount | (5) 8.131.225.128:31527 callRefcount 4 -> 3
D 2022-05-31T04:26:05.681Z | call_stream | [8] close http2 stream with code 8
12:26:05 VERB ServiceCtl<PuppetServiceMixin> stop() this.onStop() ... done
12:26:05 VERB ServiceCtl<PuppetServiceMixin> stop() super.stop() ...
12:26:05 VERB PuppetCacheMixin stop()
12:26:05 VERB PuppetCacheAgent stop()
12:26:05 VERB PuppetCacheAgent clear()
12:26:05 VERB PuppetLoginMixin stop()
12:26:05 VERB PuppetMemoryMixin stop()
12:26:05 VERB PuppetSkeleton stop()
12:26:05 VERB ServiceCtl<PuppetServiceMixin> stop() super.stop() ... done
12:26:05 SILL StateSwitch <PuppetServiceMixin> inactive() is pending
12:26:05 VERB StateSwitch <PuppetServiceMixin> inactive(true) <- (pending)
12:26:05 VERB ServiceCtl<PuppetServiceMixin> stop() ... done
12:26:05 SILL StateSwitch <PuppetServiceMixin> stable(inactive, false) resolved.
12:26:05 WARN ServiceCtl<PuppetServiceMixin> stop() found that is stopping/stopped, wait stable ... done
^C
➜  example
@Ran-Xing Ran-Xing changed the title 海外海内 连不上 海内外 连不上 May 31, 2022
@Ran-Xing Ran-Xing changed the title 海内外 连不上 海内外 连不上 repeat AutoLogin May 31, 2022
@9cat
Copy link

9cat commented May 31, 2022

same here

@suntong
Copy link

suntong commented Jun 1, 2022

same here

Here is my log:

WECHATY_LOG=sillyoutput
23:23:38 VERB Wechaty wechatifyUserModules(Puppet#0(default))
23:23:38 SILL StateSwitch  on() is false
23:23:38 SILL StateSwitch  on() is false
23:23:38 VERB StateSwitch  on(pending) <- (false)
23:23:39 INFO 
      ============================================================
       Welcome to Wechaty PadLocal puppet!

   - wechaty-puppet-padlocal version: 0.4.2
   - padlocal-ts-client version: 0.4.1
  ============================================================



23:23:39 SILL [Request] [tid:2eed091e] send event to server, seq:1, ack:undefined, type: 200, payload: {"policy":0}

23:23:39 VERB Wechaty on(heartbeat, listener) registering... listenerCount: 0

23:23:39 SILL StateSwitch  on() is pending

23:23:39 VERB StateSwitch  on(true) <- (pending)

23:23:40 SILL [Request] [tid:2eed091e] receive event from server, seq:1 ack:0, type:15, payload:{"longlinkupdateevent":{"longlinkhost":{"host":"sglong.wechat.com","port":80},"reconnectimmediately":false}}

23:23:40 SILL [Request] [tid:2eed091e] send event to server, seq:undefined, ack:1, type: 16, payload: {}

23:23:40 SILL [LongLink] [undefined] update longlink host: sglong.wechat.com, port: 80

23:23:40 SILL [Request] [tid:2eed091e] receive event from server, seq:0 ack:0, type:201, payload:{"status":0,"logintype":1}


23:23:40 INFO [PuppetPadlocal] start login with type: AutoLogin


23:23:40 SILL [Request] [tid:2eed091e] receive event from server, seq:2 ack:0, type:10, payload:{"longlinkrequest":{"messageid":"a8dae428f5cf4a44b7523699998ab250","longlinkid":"","initphase":false}}

23:23:40 SILL [LongLink] [undefined] longlink start connect: sglong.wechat.com:80

23:23:41 SILL [LongLink] [26:febf] longlink connect success, cost 232ms

23:23:41 SILL [LongLink] [26:febf] longlink start init

23:23:41 SILL [Request] [tid:d589a6e4] send event to server, seq:1, ack:undefined, type: 80, payload: {"longlinkid":"26:febf"}

23:23:41 SILL [Request] [tid:d589a6e4] receive event from server, seq:1 ack:0, type:12, payload:{"eof":true,"longlinkrequest":{"payload":"FvEDANQAAADQAQPxAcArNSaf5AZa4sxu68Q4ZKsNixd/eOSaVunlkHWXHjLv4Zdiltu9AAAAogEAAACdABACAAAARwAAAAEAQQQKSuGMnU000fGbJWIenB08rwJnHQ2GXc9+abJmMuUXesF6VM5PnSXUdiSZLewswwaaGBt+XPNfJILrlBk61+R+AAAARwAAAAIAQQTUDSxMajbsijr2IHAuQZI5NZftqRLG/GVctl8K9Qk9OG6amz1n4zwo2hLOUr669Ljdp3kfm+WsVIKMAbVNIOXGAAAAAQ==","longlinkid":"26:febf","initphase":true}}

23:23:41 SILL [LongLink] [26:febf] socket send:16f10300d4000000d00103f101c02b35269fe4065ae2cc6eebc43864ab0d8b177f78e49a56e9e59075971e32efe1976296dbbd000000a2010000009d00100200000047000000010041040a4ae18c9d4d34d1f19b25621e9c1d3caf02671d0d865dcf7e69b26632e5177ac17a54ce4f9d25d47624992dec2cc3069a181b7e5cf35f2482eb94193ad7e47e0000004700000002004104d40d2c4c6a36ec8a3af620702e4192393597eda912c6fc655cb65f0af5093d386e9a9b3d67e33c28da12ce52bebaf4b8dda7791f9be5ac54828c01b54d20e5c600000001

23:23:41 SILL [LongLink] [26:febf] socket recv:16f103007b000000770203f1c02b1c9521b06570f6f793823e90ee6bd5493bf593f2f7afb6f0df80e2350178b9df0000004e0100000049001100000002004104f5f01af0dcf5e07e6f9e947d070796fcd9e4d3fc2735a1b602e35cd0631ed6d8f5383fc4d805589a5cd616b589e15b2f0741e27768a57153ed818ff05d79ba0516f103005ee0d9363aaf144449e93bf266eed8e87904d6c4afc261c74c2b624e03c5b20d1bd2181fe034591228c71581d6cb5ca929b12ecf0564417924e41196b8754a9e2613ac7ee81b24fbe241d7627a76a35224cb280e1fbc428ee4c95cbfb9e46616f103012556f910f92689da659a931f7eef24d8ebc3bbf646d502474a56554743503c666dc739a7125523aa428b03572aace5a05739067505586b84c91569adf9d96422216e71365aeb809458dfdc7ba900fea7c30f2b2bd50c8ec65961ab1d084f92de47f1477454dedf0f10ebf2da6be9bb1575c969661d4d7adb14213d543271c5636156486d036522a28d5cb8e76cdc4521fe379ebfa89a9b0327c776e966888aabc1390ba4061584be013d0f5a40be2ba659ebfb74d9c19f3c5515c6f0adf47d2541e48818fbf4ad28e0fe5a781e7a276d0830a922b7d58606c1edfd3c80ef3abbe33579dd3df37b8c950a902c0651600b53505031672ae6a2591aeebc0075a880e7db8f5235dee98c2eb3fd59d3b12cab5a5939ac02e0184098b0fc49b754bd28f4191a50f4d916f10300370fa46f6b23a29c60f141061d2cfa1232f85e2a4459c1489f9b0aa5306a269827bafee5d36a473a83228d122e179a6882241304d04b618a

23:23:41 SILL [Request] [tid:d589a6e4] send event to server, seq:2, ack:1, type: 13, payload: {"eof":false,"longlinkresponse":{"payload":"FvEDAHsAAAB3AgPxwCsclSGwZXD295OCPpDua9VJO/WT8vevtvDfgOI1AXi53wAAAE4BAAAASQARAAAAAgBBBPXwGvDc9eB+b56UfQcHlvzZ5NP8JzWhtgLjXNBjHtbY9Tg/xNgFWJpc1ha1ieFbLwdB4ndopXFT7YGP8F15ugUW8QMAXuDZNjqvFERJ6TvyZu7Y6HkE1sSvwmHHTCtiTgPFsg0b0hgf4DRZEijHFYHWy1ypKbEuzwVkQXkk5BGWuHVKniYTrH7oGyT74kHXYnp2o1IkyygOH7xCjuTJXL+55GYW8QMBJVb5EPkmidplmpMffu8k2OvDu/ZG1QJHSlZVR0NQPGZtxzmnElUjqkKLA1cqrOWgVzkGdQVYa4TJFWmt+dlkIiFucTZa64CUWN/ce6kA/qfDDysr1QyOxllhqx0IT5LeR/FHdFTe3w8Q6/Laa+m7FXXJaWYdTXrbFCE9VDJxxWNhVkhtA2Uioo1cuOds3EUh/jeev6iamwMnx3bpZoiKq8E5C6QGFYS+AT0PWkC+K6ZZ6/t02cGfPFUVxvCt9H0lQeSIGPv0rSjg/lp4HnonbQgwqSK31YYGwe39PIDvOrvjNXndPfN7jJUKkCwGUWALU1BQMWcq5qJZGu68AHWogOfbj1I13umMLrP9WdOxLKtaWTmsAuAYQJiw/Em3VL0o9BkaUPTZFvEDADcPpG9rI6KcYPFBBh0s+hIy+F4qRFnBSJ+bCqUwaiaYJ7r+5dNqRzqDIo0SLheaaIIkEwTQS2GK"}}

23:23:41 SILL [Request] [tid:d589a6e4] receive event from server, seq:0 ack:2, type:14, payload:{"eof":true,"longlinkresponsereply":{"payload":"FvEDADfkel+ixrM22EA/KlCKPMrLgLEx+KSSvemQbx9NbOH8H3ttFgp9umXLWXqJdEjLlaQ/WRvnvq4M"}}

23:23:41 SILL [LongLink] [26:febf] socket send:16f1030037e47a5fa2c6b336d8403f2a508a3ccacb80b131f8a492bde9906f1f4d6ce1fc1f7b6d160a7dba65cb597a897448cb95a43f591be7beae0c

23:23:41 SILL [Request] [tid:d589a6e4] receive event from server, seq:2 ack:0, type:10, payload:{"longlinkrequest":{"messageid":"e85147a7c8fe439ebd9deb58e2860825","longlinkid":"26:febf","initphase":true}}

23:23:41 SILL [Request] [tid:9cb11cd5] send event to server, seq:1, ack:undefined, type: 82, payload: {"longlinkid":"26:febf","messageid":"e85147a7c8fe439ebd9deb58e2860825"}

23:23:42 SILL [Request] [tid:9cb11cd5] receive event from server, seq:1 ack:0, type:10, payload:{"shortlinkrequest":{"host":{"host":"sgextshort.wechat.com","port":80},"path":"/mmtls/77f94","payload":"GfEDAKEAAACdAQPxAQCoTJsPpKpKcyRwA35c9tlYvZGANGTbTFvsfEacGoXGvIliltu9AAAAbwEAAABqAA8BAAAAYwEACTqAAAAAAAA9AAx8zIvupEx84BemHFoASNb+E+uCpF3lWhYGoDeje1nK+pjiCT6hWr7n2tppQUT2a0l8UtjEMHAVRhtrEOkzMdwsWWMZT3zow3aobOCYqYrJcRBGfRR+7hnxAwAk71skoxL2tQvDiQ8R0ux03/vO7vsO/DCsJr/1AXPgBx8wHlYWF/EDAv1F9gcjIFLolVI+mYHgwluwjP2BRydL8bg+FPfWwMXi5kNc+BygpSWDclB0jEp6cYxmzQFiwvMYd/QCRhjIysUVYOrk9n0rN0vOv8cH/06w7BiyQD0Pc3Uxs8wiOTM92TKQJG0gGu3Utm8qh8oIzqR+314ZvqDnQnKScNoSM8PluYWtrX4xUlowiqOoPsFXPfVC5q1+xr2dfnvkajwNQkWTjCc99FGVsOI4Shli5EBkcSTe02dlSa7cPZKVHV0Fbb8P2qHi1hpA10Xdsoap38Z9+1zLuIH5SriPLgXj4jRFCC1kPhgpB3+5Q6Y0tg4A39Xki5rAhW2OV/GJZ31EG4XQfVKAc5Y/Cp8YAeBJ/9wRxADY+coHjLomRKUJ4rD1AVXmEniEfxkjG8k1kT701GogfaA4r+v4ouBny9dDQZCiEA1A8Z8iEFSEwa2YnzJrRW8sJabcLWiPEtWGlnc5xznzKO1aOOxf9L+UIGj/xRQ+uk4OzGp0GMhL99s+rI1GqduEiF+tggaRN5EyNKXljxnIlSuL0DeWrD5pgelIGhKmjiIuW5oxsN08VN2huJreknqMoQK/HGD/dK7XFMJR41o3ruWmrnLx9UKYr6BDw48T/dTbrKWAiHZoWlrd9gYHjp0Z9g2tczyiPfK2EDibE+WMfOyZb7o4gHq2O529e+YGZ8KeQgLtUCQGvr3d8KgRGTxdvObbDItT5jzJrNuV3vXkp93Ame4U239hqEU2zTCeH0fTfXqV6eZ18+VJDx7xGNI5yLJHIVljNnIBY+2RvjkBDLDKTmVkYbAYd/jcNPwriCBylpDbnadDpJy5ukE+ZLP/wLwoDnGZhdQ0naPdyjpyN2dCNGDnbpKup17RGj2GR37JJ+EnlJS4lmsS2TGrXmz8/tGcgG/vvlAojHs//XWVFoYwkAQxARQGtl63uBartrAERlXfQsNdpTBX9R5JZoLddAc8e9bJoVoIiOBO1zAKRIjnSIDqRJyTXNrZB5hToWeHiirLhwpa1rNDY08V8QMAF40xFjYukTmhnO8DQ9ymg8fjBsZL4J4n"}}

23:23:42 SILL [ShortLink] [tid:9cb11cd5] short link send, sgextshort.wechat.com:80/mmtls/77f94, request: 19f10300a10000009d0103f10100a84c9b0fa4aa4a732470037e5cf6d958bd91803464db4c5bec7c469c1a85c6bc896296dbbd0000006f010000006a000f01000000630100093a8000000000003d000c7ccc8beea44c7ce017a61c5a0048d6fe13eb82a45de55a1606a037a37b59cafa98e2093ea15abee7dada694144f66b497c52d8c4307015461b6b10e93331dc2c5963194f7ce8c376a86ce098a98ac97110467d147eee19f1030024ef5b24a312f6b50bc3890f11d2ec74dffbceeefb0efc30ac26bff50173e0071f301e561617f10302fd45f607232052e895523e9981e0c25bb08cfd8147274bf1b83e14f7d6c0c5e2e6435cf81ca0a525837250748c4a7a718c66cd0162c2f31877f4024618c8cac51560eae4f67d2b374bcebfc707ff4eb0ec18b2403d0f737531b3cc2239333dd93290246d201aedd4b66f2a87ca08cea47edf5e19bea0e742729270da1233c3e5b985adad7e31525a308aa3a83ec1573df542e6ad7ec6bd9d7e7be46a3c0d4245938c273df45195b0e2384a1962e440647124ded3676549aedc3d92951d5d056dbf0fdaa1e2d61a40d745ddb286a9dfc67dfb5ccbb881f94ab88f2e05e3e23445082d643e1829077fb943a634b60e00dfd5e48b9ac0856d8e57f189677d441b85d07d528073963f0a9f1801e049ffdc11c400d8f9ca078cba2644a509e2b0f50155e61278847f19231bc935913ef4d46a207da038afebf8a2e067cbd7434190a2100d40f19f22105484c1ad989f326b456f2c25a6dc2d688f12d586967739c739f328ed5a38ec5ff4bf942068ffc5143eba4e0ecc6a7418c84bf7db3eac8d46a9db84885fad82069137913234a5e58f19c8952b8bd03796ac3e6981e9481a12a68e222e5b9a31b0dd3c54dda1b89ade927a8ca102bf1c60ff74aed714c251e35a37aee5a6ae72f1f54298afa043c38f13fdd4dbaca5808876685a5addf606078e9d19f60dad733ca23df2b610389b13e58c7cec996fba38807ab63b9dbd7be60667c29e4202ed502406bebdddf0a811193c5dbce6db0c8b53e63cc9acdb95def5e4a7ddc099ee14db7f61a84536cd309e1f47d37d7a95e9e675f3e5490f1ef118d239c8b24721596336720163ed91be39010cb0ca4e656461b01877f8dc34fc2b8820729690db9da743a49cb9ba413e64b3ffc0bc280e719985d4349da3ddca3a723767423460e76e92aea75ed11a3d86477ec927e1279494b8966b12d931ab5e6cfcfed19c806fefbe50288c7b3ffd7595168630900431011406b65eb7b816abb6b0044655df42c35da53057f51e496682dd74073c7bd6c9a15a0888e04ed7300a4488e74880ea449c935cdad9079853a167878a2acb870a5ad6b343634f15f10300178d3116362e9139a19cef0343dca683c7e306c64be09e27

23:23:42 SILL [ShortLink] [tid:9cb11cd5] short link #1 retry request, after delay: 1000ms, path: /mmtls/77f94 data: 19f10300a10000009d0103f10100a84c9b0fa4aa4a732470037e5cf6d958bd91803464db4c5bec7c469c1a85c6bc896296dbbd0000006f010000006a000f01000000630100093a8000000000003d000c7ccc8beea44c7ce017a61c5a0048d6fe13eb82a45de55a1606a037a37b59cafa98e2093ea15abee7dada694144f66b497c52d8c4307015461b6b10e93331dc2c5963194f7ce8c376a86ce098a98ac97110467d147eee19f1030024ef5b24a312f6b50bc3890f11d2ec74dffbceeefb0efc30ac26bff50173e0071f301e561617f10302fd45f607232052e895523e9981e0c25bb08cfd8147274bf1b83e14f7d6c0c5e2e6435cf81ca0a525837250748c4a7a718c66cd0162c2f31877f4024618c8cac51560eae4f67d2b374bcebfc707ff4eb0ec18b2403d0f737531b3cc2239333dd93290246d201aedd4b66f2a87ca08cea47edf5e19bea0e742729270da1233c3e5b985adad7e31525a308aa3a83ec1573df542e6ad7ec6bd9d7e7be46a3c0d4245938c273df45195b0e2384a1962e440647124ded3676549aedc3d92951d5d056dbf0fdaa1e2d61a40d745ddb286a9dfc67dfb5ccbb881f94ab88f2e05e3e23445082d643e1829077fb943a634b60e00dfd5e48b9ac0856d8e57f189677d441b85d07d528073963f0a9f1801e049ffdc11c400d8f9ca078cba2644a509e2b0f50155e61278847f19231bc935913ef4d46a207da038afebf8a2e067cbd7434190a2100d40f19f22105484c1ad989f326b456f2c25a6dc2d688f12d586967739c739f328ed5a38ec5ff4bf942068ffc5143eba4e0ecc6a7418c84bf7db3eac8d46a9db84885fad82069137913234a5e58f19c8952b8bd03796ac3e6981e9481a12a68e222e5b9a31b0dd3c54dda1b89ade927a8ca102bf1c60ff74aed714c251e35a37aee5a6ae72f1f54298afa043c38f13fdd4dbaca5808876685a5addf606078e9d19f60dad733ca23df2b610389b13e58c7cec996fba38807ab63b9dbd7be60667c29e4202ed502406bebdddf0a811193c5dbce6db0c8b53e63cc9acdb95def5e4a7ddc099ee14db7f61a84536cd309e1f47d37d7a95e9e675f3e5490f1ef118d239c8b24721596336720163ed91be39010cb0ca4e656461b01877f8dc34fc2b8820729690db9da743a49cb9ba413e64b3ffc0bc280e719985d4349da3ddca3a723767423460e76e92aea75ed11a3d86477ec927e1279494b8966b12d931ab5e6cfcfed19c806fefbe50288c7b3ffd7595168630900431011406b65eb7b816abb6b0044655df42c35da53057f51e496682dd74073c7bd6c9a15a0888e04ed7300a4488e74880ea449c935cdad9079853a167878a2acb870a5ad6b343634f15f10300178d3116362e9139a19cef0343dca683c7e306c64be09e27

23:23:43 SILL [ShortLink] [tid:9cb11cd5] short link send, sgextshort.wechat.com:80/mmtls/77f94, request: 19f10300a10000009d0103f10100a84c9b0fa4aa4a732470037e5cf6d958bd91803464db4c5bec7c469c1a85c6bc896296dbbd0000006f010000006a000f01000000630100093a8000000000003d000c7ccc8beea44c7ce017a61c5a0048d6fe13eb82a45de55a1606a037a37b59cafa98e2093ea15abee7dada694144f66b497c52d8c4307015461b6b10e93331dc2c5963194f7ce8c376a86ce098a98ac97110467d147eee19f1030024ef5b24a312f6b50bc3890f11d2ec74dffbceeefb0efc30ac26bff50173e0071f301e561617f10302fd45f607232052e895523e9981e0c25bb08cfd8147274bf1b83e14f7d6c0c5e2e6435cf81ca0a525837250748c4a7a718c66cd0162c2f31877f4024618c8cac51560eae4f67d2b374bcebfc707ff4eb0ec18b2403d0f737531b3cc2239333dd93290246d201aedd4b66f2a87ca08cea47edf5e19bea0e742729270da1233c3e5b985adad7e31525a308aa3a83ec1573df542e6ad7ec6bd9d7e7be46a3c0d4245938c273df45195b0e2384a1962e440647124ded3676549aedc3d92951d5d056dbf0fdaa1e2d61a40d745ddb286a9dfc67dfb5ccbb881f94ab88f2e05e3e23445082d643e1829077fb943a634b60e00dfd5e48b9ac0856d8e57f189677d441b85d07d528073963f0a9f1801e049ffdc11c400d8f9ca078cba2644a509e2b0f50155e61278847f19231bc935913ef4d46a207da038afebf8a2e067cbd7434190a2100d40f19f22105484c1ad989f326b456f2c25a6dc2d688f12d586967739c739f328ed5a38ec5ff4bf942068ffc5143eba4e0ecc6a7418c84bf7db3eac8d46a9db84885fad82069137913234a5e58f19c8952b8bd03796ac3e6981e9481a12a68e222e5b9a31b0dd3c54dda1b89ade927a8ca102bf1c60ff74aed714c251e35a37aee5a6ae72f1f54298afa043c38f13fdd4dbaca5808876685a5addf606078e9d19f60dad733ca23df2b610389b13e58c7cec996fba38807ab63b9dbd7be60667c29e4202ed502406bebdddf0a811193c5dbce6db0c8b53e63cc9acdb95def5e4a7ddc099ee14db7f61a84536cd309e1f47d37d7a95e9e675f3e5490f1ef118d239c8b24721596336720163ed91be39010cb0ca4e656461b01877f8dc34fc2b8820729690db9da743a49cb9ba413e64b3ffc0bc280e719985d4349da3ddca3a723767423460e76e92aea75ed11a3d86477ec927e1279494b8966b12d931ab5e6cfcfed19c806fefbe50288c7b3ffd7595168630900431011406b65eb7b816abb6b0044655df42c35da53057f51e496682dd74073c7bd6c9a15a0888e04ed7300a4488e74880ea449c935cdad9079853a167878a2acb870a5ad6b343634f15f10300178d3116362e9139a19cef0343dca683c7e306c64be09e27

23:23:43 SILL [ShortLink] [tid:9cb11cd5] short link #2 retry request, after delay: 1000ms, path: /mmtls/77f94 data: 19f10300a10000009d0103f10100a84c9b0fa4aa4a732470037e5cf6d958bd91803464db4c5bec7c469c1a85c6bc896296dbbd0000006f010000006a000f01000000630100093a8000000000003d000c7ccc8beea44c7ce017a61c5a0048d6fe13eb82a45de55a1606a037a37b59cafa98e2093ea15abee7dada694144f66b497c52d8c4307015461b6b10e93331dc2c5963194f7ce8c376a86ce098a98ac97110467d147eee19f1030024ef5b24a312f6b50bc3890f11d2ec74dffbceeefb0efc30ac26bff50173e0071f301e561617f10302fd45f607232052e895523e9981e0c25bb08cfd8147274bf1b83e14f7d6c0c5e2e6435cf81ca0a525837250748c4a7a718c66cd0162c2f31877f4024618c8cac51560eae4f67d2b374bcebfc707ff4eb0ec18b2403d0f737531b3cc2239333dd93290246d201aedd4b66f2a87ca08cea47edf5e19bea0e742729270da1233c3e5b985adad7e31525a308aa3a83ec1573df542e6ad7ec6bd9d7e7be46a3c0d4245938c273df45195b0e2384a1962e440647124ded3676549aedc3d92951d5d056dbf0fdaa1e2d61a40d745ddb286a9dfc67dfb5ccbb881f94ab88f2e05e3e23445082d643e1829077fb943a634b60e00dfd5e48b9ac0856d8e57f189677d441b85d07d528073963f0a9f1801e049ffdc11c400d8f9ca078cba2644a509e2b0f50155e61278847f19231bc935913ef4d46a207da038afebf8a2e067cbd7434190a2100d40f19f22105484c1ad989f326b456f2c25a6dc2d688f12d586967739c739f328ed5a38ec5ff4bf942068ffc5143eba4e0ecc6a7418c84bf7db3eac8d46a9db84885fad82069137913234a5e58f19c8952b8bd03796ac3e6981e9481a12a68e222e5b9a31b0dd3c54dda1b89ade927a8ca102bf1c60ff74aed714c251e35a37aee5a6ae72f1f54298afa043c38f13fdd4dbaca5808876685a5addf606078e9d19f60dad733ca23df2b610389b13e58c7cec996fba38807ab63b9dbd7be60667c29e4202ed502406bebdddf0a811193c5dbce6db0c8b53e63cc9acdb95def5e4a7ddc099ee14db7f61a84536cd309e1f47d37d7a95e9e675f3e5490f1ef118d239c8b24721596336720163ed91be39010cb0ca4e656461b01877f8dc34fc2b8820729690db9da743a49cb9ba413e64b3ffc0bc280e719985d4349da3ddca3a723767423460e76e92aea75ed11a3d86477ec927e1279494b8966b12d931ab5e6cfcfed19c806fefbe50288c7b3ffd7595168630900431011406b65eb7b816abb6b0044655df42c35da53057f51e496682dd74073c7bd6c9a15a0888e04ed7300a4488e74880ea449c935cdad9079853a167878a2acb870a5ad6b343634f15f10300178d3116362e9139a19cef0343dca683c7e306c64be09e27

23:23:44 SILL [ShortLink] [tid:9cb11cd5] short link send, sgextshort.wechat.com:80/mmtls/77f94, request: 19f10300a10000009d0103f10100a84c9b0fa4aa4a732470037e5cf6d958bd91803464db4c5bec7c469c1a85c6bc896296dbbd0000006f010000006a000f01000000630100093a8000000000003d000c7ccc8beea44c7ce017a61c5a0048d6fe13eb82a45de55a1606a037a37b59cafa98e2093ea15abee7dada694144f66b497c52d8c4307015461b6b10e93331dc2c5963194f7ce8c376a86ce098a98ac97110467d147eee19f1030024ef5b24a312f6b50bc3890f11d2ec74dffbceeefb0efc30ac26bff50173e0071f301e561617f10302fd45f607232052e895523e9981e0c25bb08cfd8147274bf1b83e14f7d6c0c5e2e6435cf81ca0a525837250748c4a7a718c66cd0162c2f31877f4024618c8cac51560eae4f67d2b374bcebfc707ff4eb0ec18b2403d0f737531b3cc2239333dd93290246d201aedd4b66f2a87ca08cea47edf5e19bea0e742729270da1233c3e5b985adad7e31525a308aa3a83ec1573df542e6ad7ec6bd9d7e7be46a3c0d4245938c273df45195b0e2384a1962e440647124ded3676549aedc3d92951d5d056dbf0fdaa1e2d61a40d745ddb286a9dfc67dfb5ccbb881f94ab88f2e05e3e23445082d643e1829077fb943a634b60e00dfd5e48b9ac0856d8e57f189677d441b85d07d528073963f0a9f1801e049ffdc11c400d8f9ca078cba2644a509e2b0f50155e61278847f19231bc935913ef4d46a207da038afebf8a2e067cbd7434190a2100d40f19f22105484c1ad989f326b456f2c25a6dc2d688f12d586967739c739f328ed5a38ec5ff4bf942068ffc5143eba4e0ecc6a7418c84bf7db3eac8d46a9db84885fad82069137913234a5e58f19c8952b8bd03796ac3e6981e9481a12a68e222e5b9a31b0dd3c54dda1b89ade927a8ca102bf1c60ff74aed714c251e35a37aee5a6ae72f1f54298afa043c38f13fdd4dbaca5808876685a5addf606078e9d19f60dad733ca23df2b610389b13e58c7cec996fba38807ab63b9dbd7be60667c29e4202ed502406bebdddf0a811193c5dbce6db0c8b53e63cc9acdb95def5e4a7ddc099ee14db7f61a84536cd309e1f47d37d7a95e9e675f3e5490f1ef118d239c8b24721596336720163ed91be39010cb0ca4e656461b01877f8dc34fc2b8820729690db9da743a49cb9ba413e64b3ffc0bc280e719985d4349da3ddca3a723767423460e76e92aea75ed11a3d86477ec927e1279494b8966b12d931ab5e6cfcfed19c806fefbe50288c7b3ffd7595168630900431011406b65eb7b816abb6b0044655df42c35da53057f51e496682dd74073c7bd6c9a15a0888e04ed7300a4488e74880ea449c935cdad9079853a167878a2acb870a5ad6b343634f15f10300178d3116362e9139a19cef0343dca683c7e306c64be09e27

23:23:44 SILL [ShortLink] [tid:9cb11cd5] short link #3 retry request, after delay: 2000ms, path: /mmtls/77f94 data: 19f10300a10000009d0103f10100a84c9b0fa4aa4a732470037e5cf6d958bd91803464db4c5bec7c469c1a85c6bc896296dbbd0000006f010000006a000f01000000630100093a8000000000003d000c7ccc8beea44c7ce017a61c5a0048d6fe13eb82a45de55a1606a037a37b59cafa98e2093ea15abee7dada694144f66b497c52d8c4307015461b6b10e93331dc2c5963194f7ce8c376a86ce098a98ac97110467d147eee19f1030024ef5b24a312f6b50bc3890f11d2ec74dffbceeefb0efc30ac26bff50173e0071f301e561617f10302fd45f607232052e895523e9981e0c25bb08cfd8147274bf1b83e14f7d6c0c5e2e6435cf81ca0a525837250748c4a7a718c66cd0162c2f31877f4024618c8cac51560eae4f67d2b374bcebfc707ff4eb0ec18b2403d0f737531b3cc2239333dd93290246d201aedd4b66f2a87ca08cea47edf5e19bea0e742729270da1233c3e5b985adad7e31525a308aa3a83ec1573df542e6ad7ec6bd9d7e7be46a3c0d4245938c273df45195b0e2384a1962e440647124ded3676549aedc3d92951d5d056dbf0fdaa1e2d61a40d745ddb286a9dfc67dfb5ccbb881f94ab88f2e05e3e23445082d643e1829077fb943a634b60e00dfd5e48b9ac0856d8e57f189677d441b85d07d528073963f0a9f1801e049ffdc11c400d8f9ca078cba2644a509e2b0f50155e61278847f19231bc935913ef4d46a207da038afebf8a2e067cbd7434190a2100d40f19f22105484c1ad989f326b456f2c25a6dc2d688f12d586967739c739f328ed5a38ec5ff4bf942068ffc5143eba4e0ecc6a7418c84bf7db3eac8d46a9db84885fad82069137913234a5e58f19c8952b8bd03796ac3e6981e9481a12a68e222e5b9a31b0dd3c54dda1b89ade927a8ca102bf1c60ff74aed714c251e35a37aee5a6ae72f1f54298afa043c38f13fdd4dbaca5808876685a5addf606078e9d19f60dad733ca23df2b610389b13e58c7cec996fba38807ab63b9dbd7be60667c29e4202ed502406bebdddf0a811193c5dbce6db0c8b53e63cc9acdb95def5e4a7ddc099ee14db7f61a84536cd309e1f47d37d7a95e9e675f3e5490f1ef118d239c8b24721596336720163ed91be39010cb0ca4e656461b01877f8dc34fc2b8820729690db9da743a49cb9ba413e64b3ffc0bc280e719985d4349da3ddca3a723767423460e76e92aea75ed11a3d86477ec927e1279494b8966b12d931ab5e6cfcfed19c806fefbe50288c7b3ffd7595168630900431011406b65eb7b816abb6b0044655df42c35da53057f51e496682dd74073c7bd6c9a15a0888e04ed7300a4488e74880ea449c935cdad9079853a167878a2acb870a5ad6b343634f15f10300178d3116362e9139a19cef0343dca683c7e306c64be09e27

23:23:46 SILL [ShortLink] [tid:9cb11cd5] short link send, sgextshort.wechat.com:80/mmtls/77f94, request: 19f10300a10000009d0103f10100a84c9b0fa4aa4a732470037e5cf6d958bd91803464db4c5bec7c469c1a85c6bc896296dbbd0000006f010000006a000f01000000630100093a8000000000003d000c7ccc8beea44c7ce017a61c5a0048d6fe13eb82a45de55a1606a037a37b59cafa98e2093ea15abee7dada694144f66b497c52d8c4307015461b6b10e93331dc2c5963194f7ce8c376a86ce098a98ac97110467d147eee19f1030024ef5b24a312f6b50bc3890f11d2ec74dffbceeefb0efc30ac26bff50173e0071f301e561617f10302fd45f607232052e895523e9981e0c25bb08cfd8147274bf1b83e14f7d6c0c5e2e6435cf81ca0a525837250748c4a7a718c66cd0162c2f31877f4024618c8cac51560eae4f67d2b374bcebfc707ff4eb0ec18b2403d0f737531b3cc2239333dd93290246d201aedd4b66f2a87ca08cea47edf5e19bea0e742729270da1233c3e5b985adad7e31525a308aa3a83ec1573df542e6ad7ec6bd9d7e7be46a3c0d4245938c273df45195b0e2384a1962e440647124ded3676549aedc3d92951d5d056dbf0fdaa1e2d61a40d745ddb286a9dfc67dfb5ccbb881f94ab88f2e05e3e23445082d643e1829077fb943a634b60e00dfd5e48b9ac0856d8e57f189677d441b85d07d528073963f0a9f1801e049ffdc11c400d8f9ca078cba2644a509e2b0f50155e61278847f19231bc935913ef4d46a207da038afebf8a2e067cbd7434190a2100d40f19f22105484c1ad989f326b456f2c25a6dc2d688f12d586967739c739f328ed5a38ec5ff4bf942068ffc5143eba4e0ecc6a7418c84bf7db3eac8d46a9db84885fad82069137913234a5e58f19c8952b8bd03796ac3e6981e9481a12a68e222e5b9a31b0dd3c54dda1b89ade927a8ca102bf1c60ff74aed714c251e35a37aee5a6ae72f1f54298afa043c38f13fdd4dbaca5808876685a5addf606078e9d19f60dad733ca23df2b610389b13e58c7cec996fba38807ab63b9dbd7be60667c29e4202ed502406bebdddf0a811193c5dbce6db0c8b53e63cc9acdb95def5e4a7ddc099ee14db7f61a84536cd309e1f47d37d7a95e9e675f3e5490f1ef118d239c8b24721596336720163ed91be39010cb0ca4e656461b01877f8dc34fc2b8820729690db9da743a49cb9ba413e64b3ffc0bc280e719985d4349da3ddca3a723767423460e76e92aea75ed11a3d86477ec927e1279494b8966b12d931ab5e6cfcfed19c806fefbe50288c7b3ffd7595168630900431011406b65eb7b816abb6b0044655df42c35da53057f51e496682dd74073c7bd6c9a15a0888e04ed7300a4488e74880ea449c935cdad9079853a167878a2acb870a5ad6b343634f15f10300178d3116362e9139a19cef0343dca683c7e306c64be09e27

23:23:46 SILL [ShortLink] [tid:9cb11cd5] short link #4 retry request, after delay: 3000ms, path: /mmtls/77f94 data: 19f10300a10000009d0103f10100a84c9b0fa4aa4a732470037e5cf6d958bd91803464db4c5bec7c469c1a85c6bc896296dbbd0000006f010000006a000f01000000630100093a8000000000003d000c7ccc8beea44c7ce017a61c5a0048d6fe13eb82a45de55a1606a037a37b59cafa98e2093ea15abee7dada694144f66b497c52d8c4307015461b6b10e93331dc2c5963194f7ce8c376a86ce098a98ac97110467d147eee19f1030024ef5b24a312f6b50bc3890f11d2ec74dffbceeefb0efc30ac26bff50173e0071f301e561617f10302fd45f607232052e895523e9981e0c25bb08cfd8147274bf1b83e14f7d6c0c5e2e6435cf81ca0a525837250748c4a7a718c66cd0162c2f31877f4024618c8cac51560eae4f67d2b374bcebfc707ff4eb0ec18b2403d0f737531b3cc2239333dd93290246d201aedd4b66f2a87ca08cea47edf5e19bea0e742729270da1233c3e5b985adad7e31525a308aa3a83ec1573df542e6ad7ec6bd9d7e7be46a3c0d4245938c273df45195b0e2384a1962e440647124ded3676549aedc3d92951d5d056dbf0fdaa1e2d61a40d745ddb286a9dfc67dfb5ccbb881f94ab88f2e05e3e23445082d643e1829077fb943a634b60e00dfd5e48b9ac0856d8e57f189677d441b85d07d528073963f0a9f1801e049ffdc11c400d8f9ca078cba2644a509e2b0f50155e61278847f19231bc935913ef4d46a207da038afebf8a2e067cbd7434190a2100d40f19f22105484c1ad989f326b456f2c25a6dc2d688f12d586967739c739f328ed5a38ec5ff4bf942068ffc5143eba4e0ecc6a7418c84bf7db3eac8d46a9db84885fad82069137913234a5e58f19c8952b8bd03796ac3e6981e9481a12a68e222e5b9a31b0dd3c54dda1b89ade927a8ca102bf1c60ff74aed714c251e35a37aee5a6ae72f1f54298afa043c38f13fdd4dbaca5808876685a5addf606078e9d19f60dad733ca23df2b610389b13e58c7cec996fba38807ab63b9dbd7be60667c29e4202ed502406bebdddf0a811193c5dbce6db0c8b53e63cc9acdb95def5e4a7ddc099ee14db7f61a84536cd309e1f47d37d7a95e9e675f3e5490f1ef118d239c8b24721596336720163ed91be39010cb0ca4e656461b01877f8dc34fc2b8820729690db9da743a49cb9ba413e64b3ffc0bc280e719985d4349da3ddca3a723767423460e76e92aea75ed11a3d86477ec927e1279494b8966b12d931ab5e6cfcfed19c806fefbe50288c7b3ffd7595168630900431011406b65eb7b816abb6b0044655df42c35da53057f51e496682dd74073c7bd6c9a15a0888e04ed7300a4488e74880ea449c935cdad9079853a167878a2acb870a5ad6b343634f15f10300178d3116362e9139a19cef0343dca683c7e306c64be09e27

23:23:49 SILL [ShortLink] [tid:9cb11cd5] short link send, sgextshort.wechat.com:80/mmtls/77f94, request: 19f10300a10000009d0103f10100a84c9b0fa4aa4a732470037e5cf6d958bd91803464db4c5bec7c469c1a85c6bc896296dbbd0000006f010000006a000f01000000630100093a8000000000003d000c7ccc8beea44c7ce017a61c5a0048d6fe13eb82a45de55a1606a037a37b59cafa98e2093ea15abee7dada694144f66b497c52d8c4307015461b6b10e93331dc2c5963194f7ce8c376a86ce098a98ac97110467d147eee19f1030024ef5b24a312f6b50bc3890f11d2ec74dffbceeefb0efc30ac26bff50173e0071f301e561617f10302fd45f607232052e895523e9981e0c25bb08cfd8147274bf1b83e14f7d6c0c5e2e6435cf81ca0a525837250748c4a7a718c66cd0162c2f31877f4024618c8cac51560eae4f67d2b374bcebfc707ff4eb0ec18b2403d0f737531b3cc2239333dd93290246d201aedd4b66f2a87ca08cea47edf5e19bea0e742729270da1233c3e5b985adad7e31525a308aa3a83ec1573df542e6ad7ec6bd9d7e7be46a3c0d4245938c273df45195b0e2384a1962e440647124ded3676549aedc3d92951d5d056dbf0fdaa1e2d61a40d745ddb286a9dfc67dfb5ccbb881f94ab88f2e05e3e23445082d643e1829077fb943a634b60e00dfd5e48b9ac0856d8e57f189677d441b85d07d528073963f0a9f1801e049ffdc11c400d8f9ca078cba2644a509e2b0f50155e61278847f19231bc935913ef4d46a207da038afebf8a2e067cbd7434190a2100d40f19f22105484c1ad989f326b456f2c25a6dc2d688f12d586967739c739f328ed5a38ec5ff4bf942068ffc5143eba4e0ecc6a7418c84bf7db3eac8d46a9db84885fad82069137913234a5e58f19c8952b8bd03796ac3e6981e9481a12a68e222e5b9a31b0dd3c54dda1b89ade927a8ca102bf1c60ff74aed714c251e35a37aee5a6ae72f1f54298afa043c38f13fdd4dbaca5808876685a5addf606078e9d19f60dad733ca23df2b610389b13e58c7cec996fba38807ab63b9dbd7be60667c29e4202ed502406bebdddf0a811193c5dbce6db0c8b53e63cc9acdb95def5e4a7ddc099ee14db7f61a84536cd309e1f47d37d7a95e9e675f3e5490f1ef118d239c8b24721596336720163ed91be39010cb0ca4e656461b01877f8dc34fc2b8820729690db9da743a49cb9ba413e64b3ffc0bc280e719985d4349da3ddca3a723767423460e76e92aea75ed11a3d86477ec927e1279494b8966b12d931ab5e6cfcfed19c806fefbe50288c7b3ffd7595168630900431011406b65eb7b816abb6b0044655df42c35da53057f51e496682dd74073c7bd6c9a15a0888e04ed7300a4488e74880ea449c935cdad9079853a167878a2acb870a5ad6b343634f15f10300178d3116362e9139a19cef0343dca683c7e306c64be09e27

23:23:49 SILL [ShortLink] [tid:9cb11cd5] short link #5 retry request, after delay: 5000ms, path: /mmtls/77f94 data: 19f10300a10000009d0103f10100a84c9b0fa4aa4a732470037e5cf6d958bd91803464db4c5bec7c469c1a85c6bc896296dbbd0000006f010000006a000f01000000630100093a8000000000003d000c7ccc8beea44c7ce017a61c5a0048d6fe13eb82a45de55a1606a037a37b59cafa98e2093ea15abee7dada694144f66b497c52d8c4307015461b6b10e93331dc2c5963194f7ce8c376a86ce098a98ac97110467d147eee19f1030024ef5b24a312f6b50bc3890f11d2ec74dffbceeefb0efc30ac26bff50173e0071f301e561617f10302fd45f607232052e895523e9981e0c25bb08cfd8147274bf1b83e14f7d6c0c5e2e6435cf81ca0a525837250748c4a7a718c66cd0162c2f31877f4024618c8cac51560eae4f67d2b374bcebfc707ff4eb0ec18b2403d0f737531b3cc2239333dd93290246d201aedd4b66f2a87ca08cea47edf5e19bea0e742729270da1233c3e5b985adad7e31525a308aa3a83ec1573df542e6ad7ec6bd9d7e7be46a3c0d4245938c273df45195b0e2384a1962e440647124ded3676549aedc3d92951d5d056dbf0fdaa1e2d61a40d745ddb286a9dfc67dfb5ccbb881f94ab88f2e05e3e23445082d643e1829077fb943a634b60e00dfd5e48b9ac0856d8e57f189677d441b85d07d528073963f0a9f1801e049ffdc11c400d8f9ca078cba2644a509e2b0f50155e61278847f19231bc935913ef4d46a207da038afebf8a2e067cbd7434190a2100d40f19f22105484c1ad989f326b456f2c25a6dc2d688f12d586967739c739f328ed5a38ec5ff4bf942068ffc5143eba4e0ecc6a7418c84bf7db3eac8d46a9db84885fad82069137913234a5e58f19c8952b8bd03796ac3e6981e9481a12a68e222e5b9a31b0dd3c54dda1b89ade927a8ca102bf1c60ff74aed714c251e35a37aee5a6ae72f1f54298afa043c38f13fdd4dbaca5808876685a5addf606078e9d19f60dad733ca23df2b610389b13e58c7cec996fba38807ab63b9dbd7be60667c29e4202ed502406bebdddf0a811193c5dbce6db0c8b53e63cc9acdb95def5e4a7ddc099ee14db7f61a84536cd309e1f47d37d7a95e9e675f3e5490f1ef118d239c8b24721596336720163ed91be39010cb0ca4e656461b01877f8dc34fc2b8820729690db9da743a49cb9ba413e64b3ffc0bc280e719985d4349da3ddca3a723767423460e76e92aea75ed11a3d86477ec927e1279494b8966b12d931ab5e6cfcfed19c806fefbe50288c7b3ffd7595168630900431011406b65eb7b816abb6b0044655df42c35da53057f51e496682dd74073c7bd6c9a15a0888e04ed7300a4488e74880ea449c935cdad9079853a167878a2acb870a5ad6b343634f15f10300178d3116362e9139a19cef0343dca683c7e306c64be09e27

23:23:53 SILL Wechaty memoryCheck() free: 3191 MB, require: 4 MB

23:23:54 SILL [ShortLink] [tid:9cb11cd5] short link send, sgextshort.wechat.com:80/mmtls/77f94, request: 19f10300a10000009d0103f10100a84c9b0fa4aa4a732470037e5cf6d958bd91803464db4c5bec7c469c1a85c6bc896296dbbd0000006f010000006a000f01000000630100093a8000000000003d000c7ccc8beea44c7ce017a61c5a0048d6fe13eb82a45de55a1606a037a37b59cafa98e2093ea15abee7dada694144f66b497c52d8c4307015461b6b10e93331dc2c5963194f7ce8c376a86ce098a98ac97110467d147eee19f1030024ef5b24a312f6b50bc3890f11d2ec74dffbceeefb0efc30ac26bff50173e0071f301e561617f10302fd45f607232052e895523e9981e0c25bb08cfd8147274bf1b83e14f7d6c0c5e2e6435cf81ca0a525837250748c4a7a718c66cd0162c2f31877f4024618c8cac51560eae4f67d2b374bcebfc707ff4eb0ec18b2403d0f737531b3cc2239333dd93290246d201aedd4b66f2a87ca08cea47edf5e19bea0e742729270da1233c3e5b985adad7e31525a308aa3a83ec1573df542e6ad7ec6bd9d7e7be46a3c0d4245938c273df45195b0e2384a1962e440647124ded3676549aedc3d92951d5d056dbf0fdaa1e2d61a40d745ddb286a9dfc67dfb5ccbb881f94ab88f2e05e3e23445082d643e1829077fb943a634b60e00dfd5e48b9ac0856d8e57f189677d441b85d07d528073963f0a9f1801e049ffdc11c400d8f9ca078cba2644a509e2b0f50155e61278847f19231bc935913ef4d46a207da038afebf8a2e067cbd7434190a2100d40f19f22105484c1ad989f326b456f2c25a6dc2d688f12d586967739c739f328ed5a38ec5ff4bf942068ffc5143eba4e0ecc6a7418c84bf7db3eac8d46a9db84885fad82069137913234a5e58f19c8952b8bd03796ac3e6981e9481a12a68e222e5b9a31b0dd3c54dda1b89ade927a8ca102bf1c60ff74aed714c251e35a37aee5a6ae72f1f54298afa043c38f13fdd4dbaca5808876685a5addf606078e9d19f60dad733ca23df2b610389b13e58c7cec996fba38807ab63b9dbd7be60667c29e4202ed502406bebdddf0a811193c5dbce6db0c8b53e63cc9acdb95def5e4a7ddc099ee14db7f61a84536cd309e1f47d37d7a95e9e675f3e5490f1ef118d239c8b24721596336720163ed91be39010cb0ca4e656461b01877f8dc34fc2b8820729690db9da743a49cb9ba413e64b3ffc0bc280e719985d4349da3ddca3a723767423460e76e92aea75ed11a3d86477ec927e1279494b8966b12d931ab5e6cfcfed19c806fefbe50288c7b3ffd7595168630900431011406b65eb7b816abb6b0044655df42c35da53057f51e496682dd74073c7bd6c9a15a0888e04ed7300a4488e74880ea449c935cdad9079853a167878a2acb870a5ad6b343634f15f10300178d3116362e9139a19cef0343dca683c7e306c64be09e27

23:23:54 SILL [LongLink] [26:febf] close connection on error

23:23:54 SILL [LongLink] [undefined] longlink reconnect [1] after delay:1000ms

23:23:55 SILL [LongLink] [undefined] longlink start connect: sglong.wechat.com:80

23:23:55 SILL [LongLink] [26:cdf6] longlink connect success, cost 226ms

23:23:55 SILL [LongLink] [26:cdf6] longlink start init

23:23:55 SILL [Request] [tid:46c35688] send event to server, seq:1, ack:undefined, type: 80, payload: {"longlinkid":"26:cdf6"}

23:23:55 SILL [Request] [tid:46c35688] receive event from server, seq:1 ack:0, type:12, payload:{"eof":true,"longlinkrequest":{"payload":"FvEDAKEAAACdAQPxAQCo2HsKa/APSD9PUWgeRhQ3M/C3nQEBnTmqGMSfTQQTUatiltvLAAAAbwEAAABqAA8BAAAAYwEACTqAAAAAAAA9AAx8zIvupEx84BemHFoASNb+E+uCpF3lWhYGoDeje1nK+pjiCT6hWr7n2tppQUT2a0l8UtjEMHAVRhtrEOkzMdwsWWMZT3zow3aobOCYqYrJcRBGfRR+7g==","longlinkid":"26:cdf6","initphase":true}}

23:23:55 SILL [LongLink] [26:cdf6] socket send:16f10300a10000009d0103f10100a8d87b0a6bf00f483f4f51681e46143733f0b79d01019d39aa18c49f4d041351ab6296dbcb0000006f010000006a000f01000000630100093a8000000000003d000c7ccc8beea44c7ce017a61c5a0048d6fe13eb82a45de55a1606a037a37b59cafa98e2093ea15abee7dada694144f66b497c52d8c4307015461b6b10e93331dc2c5963194f7ce8c376a86ce098a98ac97110467d147eee

23:23:55 SILL [LongLink] [26:cdf6] socket recv:16f103002e0000002a0203f100a896bdfc01dbb22a8f852bb1f03b3a3c85046bf3d9b6d9cbc156708ff64b09bd8f000000010016f1030037f9d1dfe51f175a979017f50e9a4c827404b05d286be0ddfe9f8ba73185db6b7d105e4c6a6eccfa6bad15c97987c6288273011d87107497

23:23:55 SILL [Request] [tid:46c35688] send event to server, seq:2, ack:1, type: 13, payload: {"eof":false,"longlinkresponse":{"payload":"FvEDAC4AAAAqAgPxAKiWvfwB27Iqj4UrsfA7OjyFBGvz2bbZy8FWcI/2Swm9jwAAAAEAFvEDADf50d/lHxdal5AX9Q6aTIJ0BLBdKGvg3f6fi6cxhdtrfRBeTGpuzPprrRXJeYfGKIJzAR2HEHSX"}}

23:23:56 SILL [Request] [tid:46c35688] receive event from server, seq:0 ack:2, type:14, payload:{"eof":true,"longlinkresponsereply":{"payload":"FvEDADdGTii7rRe2rslbw/YVIkxhfF5Joq3FPZx1QCwHge8zJzZ0E0OyuHcQz2U7VWPetrm57lCWZtrM"}}

23:23:56 SILL [LongLink] [26:cdf6] socket send:16f1030037464e28bbad17b6aec95bc3f615224c617c5e49a2adc53d9c75402c0781ef332736741343b2b87710cf653b5563deb6b9b9ee509666dacc

23:23:56 SILL [Request] [tid:46c35688] receive event from server, seq:2 ack:0, type:10, payload:{"longlinkrequest":{"messageid":"b5f0754d09384b8ca10513f5684ce431","longlinkid":"26:cdf6","initphase":true}}

23:23:56 SILL [Request] [tid:6b00a7cb] send event to server, seq:1, ack:undefined, type: 82, payload: {"longlinkid":"26:cdf6","messageid":"b5f0754d09384b8ca10513f5684ce431"}

23:23:56 SILL [Request] [tid:6b00a7cb] receive event from server, seq:1 ack:0, type:10, payload:{"shortlinkrequest":{"host":{"host":"sgextshort.wechat.com","port":80},"path":"/mmtls/77fa3","payload":"GfEDAKEAAACdAQPxAQCo5+f8IeSGhkD5KWbzM0VMjx5lDkQyo0exVXrcg36tlXZiltvMAAAAbwEAAABqAA8BAAAAYwEACTqAAAAAAAA9AAx8zIvupEx84BemHFoASNb+E+uCpF3lWhYGoDeje1nK+pjiCT6hWr7n2tppQUT2a0l8UtjEMHAVRhtrEOkzMdwsWWMZT3zow3aobOCYqYrJcRBGfRR+7hnxAwAk4sJmMIUlYYxpCMcvJ6wNl/SO9z9x39yo3OFid9xfNPZSUnk+F/EDAv2d4VQPzA5k81vK3E6BFd1nAh4Im1/IwcKxWLNtWYDO9LkMrAnjoEU+Msd/URqoAtk4/f6J1JSpfavhkU1DqeY/lJj/4TQ4yah94aecLxCeWTyww1tPZusqYmDbyetT9jgnsiB5vSZqxDnDul0cs+j33O8rnr1QiiCTDJyc2wypjj16dm7yvmu1fM4GHXJMOLzLR3vVKjltIP5VAh4dFbLeMNyMZ74gHrEmPlO+URICNpB+87BV8EFtEklHra98WdOcIUJcnZ3kWg6G95rr0fXTGo9RqooQtpyGfYQDVLkuRPfczZbHCbGydM2l6wHud2T+UlFWcRju2Cn5JAdQgvMJn1vEkYll8NdyVeLw/4M5Y18ATsHRBm/nyiyXwfXfk9z+GzMpg9y/ZFF42s9YF4nIfIlJ/8glTo9Xcu2El6+XqJq9DzVb0Fax4yAB5j4cTSytjbJNLuY/nFs8wsC96Wbcd9b1aSs+aW5lOGZJMix+UFmmAa5k+H5E7jNAUbJrYEriuuezzWXtc9VWPVhZIBgsBnE45BMJ50N6//xfXrZflNWMXWWdMPjIeQ9yVSicIHoDdnK8J/wERnCYJCJq5QOmMP0gjQoeBrHvq2Zu9V9jWZ1Q8jExeLFq5+RC2eFI+JkpaZDXwJ2lLuIFHht0ED2IF0HCnBh/v4cbwJhh1eygUj+s/mP/RySXmQrWcMTFWldvOmfEbkKI+KhPTIBXdK1WURYlpxSAnj8ZtRalCkFp9egdjsLCSbTgP7UM338Cc6tcW4ushuCVrvyGjnpCxGMs8hNYznKAARFImbLSBaJ9koXe1vZQgW8PxGjKPR56zKfoeyFqPjeEY8G1xq8Ijhw/bI0HzLuTa/e10+ieCPnQEwkzNUQJ3hMycmGcwgwCqGgziqr94qB4PuxJd3VayRvh0sxUq7219gL32gTZ+NC1NE/q0GdfPabyrBszIPb+qQthP7z0T5vb7IyBMC9yGQcKo0n6yJBAikaLV0Oj5+fLcs4Hgh/qCCF0X1sKWwoV8QMAF5w2Gh6fjzTLwu5rRtWIR8DWS10eJQOG"}}

23:23:56 SILL [ShortLink] [tid:6b00a7cb] short link send, sgextshort.wechat.com:80/mmtls/77fa3, request: 19f10300a10000009d0103f10100a8e7e7fc21e4868640f92966f333454c8f1e650e4432a347b1557adc837ead95766296dbcc0000006f010000006a000f01000000630100093a8000000000003d000c7ccc8beea44c7ce017a61c5a0048d6fe13eb82a45de55a1606a037a37b59cafa98e2093ea15abee7dada694144f66b497c52d8c4307015461b6b10e93331dc2c5963194f7ce8c376a86ce098a98ac97110467d147eee19f1030024e2c266308525618c6908c72f27ac0d97f48ef73f71dfdca8dce16277dc5f34f65252793e17f10302fd9de1540fcc0e64f35bcadc4e8115dd67021e089b5fc8c1c2b158b36d5980cef4b90cac09e3a0453e32c77f511aa802d938fdfe89d494a97dabe1914d43a9e63f9498ffe13438c9a87de1a79c2f109e593cb0c35b4f66eb2a6260dbc9eb53f63827b22079bd266ac439c3ba5d1cb3e8f7dcef2b9ebd508a20930c9c9cdb0ca98e3d7a766ef2be6bb57cce061d724c38bccb477bd52a396d20fe55021e1d15b2de30dc8c67be201eb1263e53be51120236907ef3b055f0416d124947adaf7c59d39c21425c9d9de45a0e86f79aebd1f5d31a8f51aa8a10b69c867d840354b92e44f7dccd96c709b1b274cda5eb01ee7764fe5251567118eed829f924075082f3099f5bc4918965f0d77255e2f0ff8339635f004ec1d1066fe7ca2c97c1f5df93dcfe1b332983dcbf645178dacf581789c87c8949ffc8254e8f5772ed8497af97a89abd0f355bd056b1e32001e63e1c4d2cad8db24d2ee63f9c5b3cc2c0bde966dc77d6f5692b3e696e65386649322c7e5059a601ae64f87e44ee334051b26b604ae2bae7b3cd65ed73d5563d585920182c067138e41309e7437afffc5f5eb65f94d58c5d659d30f8c8790f7255289c207a037672bc27fc0446709824226ae503a630fd208d0a1e06b1efab666ef55f63599d50f2313178b16ae7e442d9e148f899296990d7c09da52ee2051e1b74103d881741c29c187fbf871bc09861d5eca0523facfe63ff472497990ad670c4c55a576f3a67c46e4288f8a84f4c805774ad56511625a714809e3f19b516a50a4169f5e81d8ec2c249b4e03fb50cdf7f0273ab5c5b8bac86e095aefc868e7a42c4632cf21358ce728001114899b2d205a27d9285ded6f650816f0fc468ca3d1e7acca7e87b216a3e378463c1b5c6af088e1c3f6c8d07ccbb936bf7b5d3e89e08f9d0130933354409de133272619cc20c02a868338aaafde2a0783eec4977755ac91be1d2cc54abbdb5f602f7da04d9f8d0b5344fead0675f3da6f2ac1b3320f6fea90b613fbcf44f9bdbec8c81302f7219070aa349fac890408a468b5743a3e7e7cb72ce07821fea0821745f5b0a5b0a15f10300179c361a1e9f8f34cbc2ee6b46d58847c0d64b5d1e250386

23:23:56 SILL [ShortLink] [tid:6b00a7cb] short link #1 retry request, after delay: 1000ms, path: /mmtls/77fa3 data: 19f10300a10000009d0103f10100a8e7e7fc21e4868640f92966f333454c8f1e650e4432a347b1557adc837ead95766296dbcc0000006f010000006a000f01000000630100093a8000000000003d000c7ccc8beea44c7ce017a61c5a0048d6fe13eb82a45de55a1606a037a37b59cafa98e2093ea15abee7dada694144f66b497c52d8c4307015461b6b10e93331dc2c5963194f7ce8c376a86ce098a98ac97110467d147eee19f1030024e2c266308525618c6908c72f27ac0d97f48ef73f71dfdca8dce16277dc5f34f65252793e17f10302fd9de1540fcc0e64f35bcadc4e8115dd67021e089b5fc8c1c2b158b36d5980cef4b90cac09e3a0453e32c77f511aa802d938fdfe89d494a97dabe1914d43a9e63f9498ffe13438c9a87de1a79c2f109e593cb0c35b4f66eb2a6260dbc9eb53f63827b22079bd266ac439c3ba5d1cb3e8f7dcef2b9ebd508a20930c9c9cdb0ca98e3d7a766ef2be6bb57cce061d724c38bccb477bd52a396d20fe55021e1d15b2de30dc8c67be201eb1263e53be51120236907ef3b055f0416d124947adaf7c59d39c21425c9d9de45a0e86f79aebd1f5d31a8f51aa8a10b69c867d840354b92e44f7dccd96c709b1b274cda5eb01ee7764fe5251567118eed829f924075082f3099f5bc4918965f0d77255e2f0ff8339635f004ec1d1066fe7ca2c97c1f5df93dcfe1b332983dcbf645178dacf581789c87c8949ffc8254e8f5772ed8497af97a89abd0f355bd056b1e32001e63e1c4d2cad8db24d2ee63f9c5b3cc2c0bde966dc77d6f5692b3e696e65386649322c7e5059a601ae64f87e44ee334051b26b604ae2bae7b3cd65ed73d5563d585920182c067138e41309e7437afffc5f5eb65f94d58c5d659d30f8c8790f7255289c207a037672bc27fc0446709824226ae503a630fd208d0a1e06b1efab666ef55f63599d50f2313178b16ae7e442d9e148f899296990d7c09da52ee2051e1b74103d881741c29c187fbf871bc09861d5eca0523facfe63ff472497990ad670c4c55a576f3a67c46e4288f8a84f4c805774ad56511625a714809e3f19b516a50a4169f5e81d8ec2c249b4e03fb50cdf7f0273ab5c5b8bac86e095aefc868e7a42c4632cf21358ce728001114899b2d205a27d9285ded6f650816f0fc468ca3d1e7acca7e87b216a3e378463c1b5c6af088e1c3f6c8d07ccbb936bf7b5d3e89e08f9d0130933354409de133272619cc20c02a868338aaafde2a0783eec4977755ac91be1d2cc54abbdb5f602f7da04d9f8d0b5344fead0675f3da6f2ac1b3320f6fea90b613fbcf44f9bdbec8c81302f7219070aa349fac890408a468b5743a3e7e7cb72ce07821fea0821745f5b0a5b0a15f10300179c361a1e9f8f34cbc2ee6b46d58847c0d64b5d1e250386

23:23:57 SILL [ShortLink] [tid:6b00a7cb] short link send, sgextshort.wechat.com:80/mmtls/77fa3, request: 19f10300a10000009d0103f10100a8e7e7fc21e4868640f92966f333454c8f1e650e4432a347b1557adc837ead95766296dbcc0000006f010000006a000f01000000630100093a8000000000003d000c7ccc8beea44c7ce017a61c5a0048d6fe13eb82a45de55a1606a037a37b59cafa98e2093ea15abee7dada694144f66b497c52d8c4307015461b6b10e93331dc2c5963194f7ce8c376a86ce098a98ac97110467d147eee19f1030024e2c266308525618c6908c72f27ac0d97f48ef73f71dfdca8dce16277dc5f34f65252793e17f10302fd9de1540fcc0e64f35bcadc4e8115dd67021e089b5fc8c1c2b158b36d5980cef4b90cac09e3a0453e32c77f511aa802d938fdfe89d494a97dabe1914d43a9e63f9498ffe13438c9a87de1a79c2f109e593cb0c35b4f66eb2a6260dbc9eb53f63827b22079bd266ac439c3ba5d1cb3e8f7dcef2b9ebd508a20930c9c9cdb0ca98e3d7a766ef2be6bb57cce061d724c38bccb477bd52a396d20fe55021e1d15b2de30dc8c67be201eb1263e53be51120236907ef3b055f0416d124947adaf7c59d39c21425c9d9de45a0e86f79aebd1f5d31a8f51aa8a10b69c867d840354b92e44f7dccd96c709b1b274cda5eb01ee7764fe5251567118eed829f924075082f3099f5bc4918965f0d77255e2f0ff8339635f004ec1d1066fe7ca2c97c1f5df93dcfe1b332983dcbf645178dacf581789c87c8949ffc8254e8f5772ed8497af97a89abd0f355bd056b1e32001e63e1c4d2cad8db24d2ee63f9c5b3cc2c0bde966dc77d6f5692b3e696e65386649322c7e5059a601ae64f87e44ee334051b26b604ae2bae7b3cd65ed73d5563d585920182c067138e41309e7437afffc5f5eb65f94d58c5d659d30f8c8790f7255289c207a037672bc27fc0446709824226ae503a630fd208d0a1e06b1efab666ef55f63599d50f2313178b16ae7e442d9e148f899296990d7c09da52ee2051e1b74103d881741c29c187fbf871bc09861d5eca0523facfe63ff472497990ad670c4c55a576f3a67c46e4288f8a84f4c805774ad56511625a714809e3f19b516a50a4169f5e81d8ec2c249b4e03fb50cdf7f0273ab5c5b8bac86e095aefc868e7a42c4632cf21358ce728001114899b2d205a27d9285ded6f650816f0fc468ca3d1e7acca7e87b216a3e378463c1b5c6af088e1c3f6c8d07ccbb936bf7b5d3e89e08f9d0130933354409de133272619cc20c02a868338aaafde2a0783eec4977755ac91be1d2cc54abbdb5f602f7da04d9f8d0b5344fead0675f3da6f2ac1b3320f6fea90b613fbcf44f9bdbec8c81302f7219070aa349fac890408a468b5743a3e7e7cb72ce07821fea0821745f5b0a5b0a15f10300179c361a1e9f8f34cbc2ee6b46d58847c0d64b5d1e250386

23:23:57 SILL [ShortLink] [tid:6b00a7cb] short link #2 retry request, after delay: 1000ms, path: /mmtls/77fa3 data: 19f10300a10000009d0103f10100a8e7e7fc21e4868640f92966f333454c8f1e650e4432a347b1557adc837ead95766296dbcc0000006f010000006a000f01000000630100093a8000000000003d000c7ccc8beea44c7ce017a61c5a0048d6fe13eb82a45de55a1606a037a37b59cafa98e2093ea15abee7dada694144f66b497c52d8c4307015461b6b10e93331dc2c5963194f7ce8c376a86ce098a98ac97110467d147eee19f1030024e2c266308525618c6908c72f27ac0d97f48ef73f71dfdca8dce16277dc5f34f65252793e17f10302fd9de1540fcc0e64f35bcadc4e8115dd67021e089b5fc8c1c2b158b36d5980cef4b90cac09e3a0453e32c77f511aa802d938fdfe89d494a97dabe1914d43a9e63f9498ffe13438c9a87de1a79c2f109e593cb0c35b4f66eb2a6260dbc9eb53f63827b22079bd266ac439c3ba5d1cb3e8f7dcef2b9ebd508a20930c9c9cdb0ca98e3d7a766ef2be6bb57cce061d724c38bccb477bd52a396d20fe55021e1d15b2de30dc8c67be201eb1263e53be51120236907ef3b055f0416d124947adaf7c59d39c21425c9d9de45a0e86f79aebd1f5d31a8f51aa8a10b69c867d840354b92e44f7dccd96c709b1b274cda5eb01ee7764fe5251567118eed829f924075082f3099f5bc4918965f0d77255e2f0ff8339635f004ec1d1066fe7ca2c97c1f5df93dcfe1b332983dcbf645178dacf581789c87c8949ffc8254e8f5772ed8497af97a89abd0f355bd056b1e32001e63e1c4d2cad8db24d2ee63f9c5b3cc2c0bde966dc77d6f5692b3e696e65386649322c7e5059a601ae64f87e44ee334051b26b604ae2bae7b3cd65ed73d5563d585920182c067138e41309e7437afffc5f5eb65f94d58c5d659d30f8c8790f7255289c207a037672bc27fc0446709824226ae503a630fd208d0a1e06b1efab666ef55f63599d50f2313178b16ae7e442d9e148f899296990d7c09da52ee2051e1b74103d881741c29c187fbf871bc09861d5eca0523facfe63ff472497990ad670c4c55a576f3a67c46e4288f8a84f4c805774ad56511625a714809e3f19b516a50a4169f5e81d8ec2c249b4e03fb50cdf7f0273ab5c5b8bac86e095aefc868e7a42c4632cf21358ce728001114899b2d205a27d9285ded6f650816f0fc468ca3d1e7acca7e87b216a3e378463c1b5c6af088e1c3f6c8d07ccbb936bf7b5d3e89e08f9d0130933354409de133272619cc20c02a868338aaafde2a0783eec4977755ac91be1d2cc54abbdb5f602f7da04d9f8d0b5344fead0675f3da6f2ac1b3320f6fea90b613fbcf44f9bdbec8c81302f7219070aa349fac890408a468b5743a3e7e7cb72ce07821fea0821745f5b0a5b0a15f10300179c361a1e9f8f34cbc2ee6b46d58847c0d64b5d1e250386

Basically it will keep looping and output

start login with type: AutoLogin

on and on.

@9cat
Copy link

9cat commented Jun 2, 2022 •
edited
Loading

I have some other errors , wish might help .

06:41:34 ERR [PadLocalClient] error while syncing onpush: VError: [tid:14c5e2d5] request has been cancelled for reason: CLIENT_ERROR: [tid:14c5e2d5] Exception while handling wechat request: longlink reset
at Request._failAllPendingRequest (/root/projects/wechaty-puppet-padlocal-demo/node_modules/padlocal-client-ts/src/Request.ts:334:15)
at Request.error (/root/projects/wechaty-puppet-padlocal-demo/node_modules/padlocal-client-ts/src/Request.ts:347:10)
at Request. (/root/projects/wechaty-puppet-padlocal-demo/node_modules/padlocal-client-ts/src/Request.ts:221:16)
at Generator.throw ()
at rejected (/root/projects/wechaty-puppet-padlocal-demo/node_modules/padlocal-client-ts/dist/Request.js:6:65)
06:41:35 SILL [CacheManager] close()
06:41:35 SILL [CacheManager] close() closing caches ...
06:41:35 SILL [CacheManager] close() cache closed.

@9cat
Copy link

9cat commented Jun 3, 2022

@suntong Do you have any alternative solution to solve this?

@padlocal I guess you might want to invite more developers to the padlocal team

@Ran-Xing
Copy link
Author

Ran-Xing commented Jun 6, 2022

求求了，先解决这个bug吧，都10天了

@padlocal
Copy link
Collaborator

padlocal commented Jun 6, 2022

Working on this issue...

@suntong
Copy link

suntong commented Jun 6, 2022

Hi @padlocal, if you need me or my account to debug, you know where to find me ☺️.

@padlocal
Copy link
Collaborator

padlocal commented Jun 9, 2022

Fixed, reopen if still happening.

@padlocal padlocal closed this as completed Jun 9, 2022
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment
Assignees
No one assigned
Labels
None yet
Projects
None yet
Milestone
No milestone
Development

No branches or pull requests
4 participants
@suntong @9cat @padlocal @Ran-Xing