search

linyimin0812 / wechaty-puppet-ioscat

Puppet Ios Cat for Wechaty
https://www.npmjs.com/package/wechaty-puppet-ioscat
Apache License 2.0
37 stars 11 forks source link

Not reponse after start, cause watchdog timeout, finally program exit instead of reset itself. #17

Open huan opened 6 years ago

huan commented 6 years ago 
00:32:43 SILL PuppetIosCatManager syncContactsAndRooms() syncing Contact(9) & Room(8) ...
00:32:43 VERB PuppetIosCatManager syncContactsAndRooms() sync contact done!
00:32:43 VERB Wechaty on(heartbeat, function) registered
00:32:43 VERB Wechaty onFunction(heartbeat)
00:32:43 SILL StateSwitch <Wechaty> on() is pending
00:32:43 VERB StateSwitch <Wechaty> on(true) <- (pending)
00:33:41 SILL Puppet constructor() watchdog.on(reset) reason: {"data":"inited","type":"startWatchdog()","timeout":60000}
00:33:41 SILL Puppet constructor() this.on(reset) reason: {"data":"inited","type":"startWatchdog()","timeout":60000}
00:33:41 SILL Puppet constructor() resetThrottleQueue.subscribe() reason: {"data":"inited","type":"startWatchdog()","timeout":60000}
00:33:41 VERB Puppet reset({"data":"inited","type":"startWatchdog()","timeout":60000})
00:33:41 SILL StateSwitch <PuppetIoscat> off() is false
00:33:41 VERB PuppetIoscat stop()
00:33:41 SILL StateSwitch <PuppetIoscat> off() is false
00:33:41 SILL StateSwitch <PuppetIoscat> off() is false
00:33:41 VERB StateSwitch <PuppetIoscat> off(pending) <- (false)
00:33:43 VERB PuppetIoscat logout()
00:33:43 VERB PuppetIosCatManager releaseCache()
00:33:43 SILL PuppetIosCatManager releaseCache() closing caches ...
zixia:~/workspace (master) $
huan commented 6 years ago

After restart, it can be reproduced:

Please wait... I'm trying to login in...

00:36:06 VERB Wechaty initPuppet() 
00:36:06 VERB MemoryCard multiplex(puppet)
00:36:06 VERB MemoryCard static multiplex(MemoryCard<ding-dong-bot>, puppet)
00:36:06 VERB MemoryCard constructor({"name":"ding-dong-bot","multiplex":{"name":"puppet","parent":{"options":{"name":"ding-dong-bot"},"name":"ding-dong-bot","payload":{"\rpuppet\nWECHATY_PUPPET_PADCHAT":{"device":{"wxid_a8d806dzznm822":{"data":"YnBsaXN0MDDUAQIDBAUGCQpYJHZlcnNpb25YJG9iamVjdHNZJGFyY2hpdmVyVCR0b3ASAAGGoKIHCFUkbnVsbF8QIDJlMWUwZDI5NjZkOGZhNzdkNjQ0YjcwYmFhYTA4NzVkXxAPTlNLZXllZEFyY2hpdmVy0QsMVHJvb3SAAQgRGiMtMjc6QGN1eH0AAAAAAAABAQAAAAAAAAANAAAAAAAAAAAAAAAAAAAAfw==","token":"eO46+NE7GFdMmEWPH1ciKp+WvjuMUmg7ULlO7zvoRrV35QJw6ibbq+RhlNgLwVH3Ca0q0GV4/SlxF9PQOsBUkqCl60yIojDS0zW0u4cb1hqTi1IFxIzvpIvEY9u9XLFPE3+Tra0EzLWcJ5OOZUqfSn+GiZVF2HQoQgE/oObl3TvTiYZPvSOGRILUriBBrbPnHJ45fyncDxgp+FFTQ+8EB8rRA8Fd4zjj+i7YcGMkGXK5uFgK8qtKjoUD+oZC1bcbxnCIvo3QxnVIm5rbGcziZnT6ou+j23tzqyg6beyEbbTO1caT1NrqDUGoWENtuxyT872K9B4rBixWhKIkTAJxo+npKPPS6o5m0twwjHCHFfBz15in7Q797eFXFx1Oxskwy7gwF1zWy9IoKOGFi32AE2NbdMNEG2lsMd7a0IeisSG0ji/sVFnZENtjhAT5sWkJ+5ndimPkGu++1UnAH35DsedIuFkai6rSb0aA6rdRlYPfoMnBGg9aN8RAQBucPtzgCec8eX2Xck4XFyAnN5CU1AQldEjz5kRaOKZll4I6XOZdBmxYiyqy1rtC5uF13MBkh+17UFpeyHFLYkQJ8VIw1D4UDKPOH5PIo60859E8jykDzjEEUkktaR7PFTQWz1DH3Ixua9AxxmUvGiL2wvCXCQ=="}},"currentUserId":"wxid_a8d806dzznm822"}},"multiplexNameList":[],"storage":{"name":"ding-dong-bot","options":{"type":"file"},"absFileName":"/home/ubuntu/workspace/ding-dong-bot.memory-card.json"}}}})
00:36:06 VERB PuppetManager resolve({wechaty: Wechaty#cjlgsjyr90000flej7vbf9ayh<>(ding-dong-bot), puppet: wechaty-puppet-ioscat, puppetOptions: undefined})
00:36:06 VERB PuppetManager resolveName(wechaty-puppet-ioscat)
00:36:06 VERB PuppetManager checkModule(wechaty-puppet-ioscat)
00:36:06 SILL PuppetManager checkModule() wechaty-puppet-ioscat installed version 0.5.19 satisfied range ^0.5.19
00:36:06 VERB Puppet constructor({}) #0
00:36:06 VERB StateSwitch constructor(name=PuppetIoscat)
00:36:06 VERB MemoryCard constructor(undefined)
00:36:06 VERB MemoryCard getStorage() for storage type: N/A
00:36:06 VERB MemoryCard load() from storage: N/A
00:36:06 VERB MemoryCard load() no storage
00:36:06 VERB Puppet constructor() watchdog timeout set to 60 seconds
00:36:06 VERB HotImport callerResolve(., /home/ubuntu/workspace/node_modules/wechaty-puppet/dist/src/puppet.js)
00:36:06 SILL HotImport callerResolve() callsites() file=/home/ubuntu/workspace/node_modules/hot-import/dist/src/hot-import.js, type=Object
00:36:06 SILL HotImport callerResolve() callsites() file=/home/ubuntu/workspace/node_modules/wechaty-puppet/dist/src/puppet.js, type=null
00:36:06 SILL HotImport callerResolve() callsites() file=/home/ubuntu/workspace/node_modules/wechaty-puppet-ioscat/dist/src/puppet-ioscat.js, type=null
00:36:06 SILL HotImport callerResolve() callerFile=/home/ubuntu/workspace/node_modules/wechaty-puppet-ioscat/dist/src/puppet-ioscat.js
00:36:06 VERB Puppet constructor() childClassPath=/home/ubuntu/workspace/node_modules/wechaty-puppet-ioscat/dist/src
00:36:06 VERB Puppet constructor() memory.load() done
00:36:06 VERB Puppet setMemory()
00:36:06 VERB Wechaty initPuppetEventBridge(Puppet#0<PuppetIoscat>(ding-dong-bot))
00:36:06 VERB Wechaty initPuppetEventBridge() puppet.on(friendship) registered
00:36:06 VERB Wechaty initPuppetEventBridge() puppet.on(login) registered
00:36:06 VERB Wechaty initPuppetEventBridge() puppet.on(logout) registered
00:36:06 VERB Wechaty initPuppetEventBridge() puppet.on(message) registered
00:36:06 VERB Wechaty initPuppetEventBridge() puppet.on(room-invite) registered
00:36:06 VERB Wechaty initPuppetEventBridge() puppet.on(room-join) registered
00:36:06 VERB Wechaty initPuppetEventBridge() puppet.on(room-leave) registered
00:36:06 VERB Wechaty initPuppetEventBridge() puppet.on(room-topic) registered
00:36:06 VERB Wechaty initPuppetEventBridge() puppet.on(scan) registered
00:36:06 VERB Wechaty initPuppetEventBridge() puppet.on(dong) registered
00:36:06 VERB Wechaty initPuppetEventBridge() puppet.on(error) registered
00:36:06 VERB Wechaty initPuppetEventBridge() puppet.on(ready) registered
00:36:06 VERB Wechaty initPuppetEventBridge() puppet.on(reset) registered
00:36:06 VERB Wechaty initPuppetEventBridge() puppet.on(watchdog) registered
00:36:06 VERB Wechaty initAccessory(Puppet#0<PuppetIoscat>(ding-dong-bot))
00:36:06 SILL Accessory <Contact> static set wechaty = "Wechaty#cjlgsjyr90000flej7vbf9ayh<>(ding-dong-bot)"
00:36:06 SILL Accessory <ContactSelf> static set wechaty = "Wechaty#cjlgsjyr90000flej7vbf9ayh<>(ding-dong-bot)"
00:36:06 SILL Accessory <Friendship> static set wechaty = "Wechaty#cjlgsjyr90000flej7vbf9ayh<>(ding-dong-bot)"
00:36:06 SILL Accessory <Message> static set wechaty = "Wechaty#cjlgsjyr90000flej7vbf9ayh<>(ding-dong-bot)"
00:36:06 SILL Accessory <Room> static set wechaty = "Wechaty#cjlgsjyr90000flej7vbf9ayh<>(ding-dong-bot)"
00:36:06 SILL Accessory <RoomInvitation> static set wechaty = "Wechaty#cjlgsjyr90000flej7vbf9ayh<>(ding-dong-bot)"
00:36:06 SILL Accessory <Contact> static set puppet = "Puppet#0<PuppetIoscat>(ding-dong-bot)"
00:36:06 SILL Accessory <ContactSelf> static set puppet = "Puppet#0<PuppetIoscat>(ding-dong-bot)"
00:36:06 SILL Accessory <Friendship> static set puppet = "Puppet#0<PuppetIoscat>(ding-dong-bot)"
00:36:06 SILL Accessory <Message> static set puppet = "Puppet#0<PuppetIoscat>(ding-dong-bot)"
00:36:06 SILL Accessory <Room> static set puppet = "Puppet#0<PuppetIoscat>(ding-dong-bot)"
00:36:06 SILL Accessory <RoomInvitation> static set puppet = "Puppet#0<PuppetIoscat>(ding-dong-bot)"
00:36:06 SILL Accessory <Wechaty> set puppet = "Puppet#0<PuppetIoscat>(ding-dong-bot)"
00:36:06 VERB PuppetIoscat start()
00:36:06 SILL StateSwitch <PuppetIoscat> on() is false
00:36:06 VERB StateSwitch <PuppetIoscat> on(pending) <- (false)
00:36:06 SILL topic:  im.topic.13.wxid_5zj4i5htp9ih22
00:36:06 SILL IMSink subscribe(im.topic.13.wxid_5zj4i5htp9ih22)
00:36:06 SILL IMSink getChannel()
00:36:06 SILL IMSink getConnection()
00:36:09 SILL StateSwitch <PuppetIoscat> on() is pending
00:36:09 VERB StateSwitch <PuppetIoscat> on(true) <- (pending)
00:36:09 VERB PuppetIoscat startWatchdog()
00:36:09 SILL IoscatMnager checkOnline()
00:36:09 VERB PuppetIoscat initCache(wxid_5zj4i5htp9ih22)
00:36:09 SILL PuppetIoscat initCache(wxid_5zj4i5htp9ih22)
00:36:09 VERB PuppetIosCatManager initCache() inited 9 Contacts, 367 RoomMembers, 8 Rooms, cachedir="/home/ubuntu/.wechaty/puppet-ioscat-cache/wxid_5zj4i5htp9ih22"
00:36:09 VERB Contact load(wxid_5zj4i5htp9ih22) init pool
00:36:09 SILL Accessory #1<ContactSelf> constructor()
00:36:09 SILL Contact constructor(wxid_5zj4i5htp9ih22)
00:36:09 SILL Contact ready() @ Puppet#0<PuppetIoscat>(ding-dong-bot)
00:36:09 SILL Puppet contactPayload(wxid_5zj4i5htp9ih22) cache MISS
00:36:09 VERB PuppetIoscat contactRawPayload(wxid_5zj4i5htp9ih22)
00:36:09 VERB PuppetIosCatManager syncContactsAndRooms()
00:36:09 SILL PuppetIosCatmanager syncContactAndRooms()
00:36:10 SILL PuppetIosCatManager syncRooms(), length 8
00:36:10 VERB PuppetIosCatManager roomMemberRawPayload(3453262102@chatroom)
00:36:10 VERB PuppetIosCatManager roomMemberRawPayload(5330379221@chatroom)
00:36:10 VERB PuppetIosCatManager roomMemberRawPayload(3612135636@chatroom)
00:36:10 VERB PuppetIosCatManager roomMemberRawPayload(6053138943@chatroom)
00:36:10 VERB PuppetIosCatManager roomMemberRawPayload(5729603967@chatroom)
00:36:10 VERB PuppetIosCatManager roomMemberRawPayload(5958138947@chatroom)
00:36:10 VERB PuppetIosCatManager roomMemberRawPayload(5907139882@chatroom)
00:36:10 VERB PuppetIosCatManager roomMemberRawPayload(8264954429@chatroom)
00:36:10 VERB PuppetIoscat rawPayload={"avatar":"http://wx.qlogo.cn/mmhead/P3UGRtJrgyEMkmOExtdq1xpGcic2z1b5wZuicFibfHNPnYttF9n9ZzE2Q/132","city":"San Francisco","country":"United States","ctime":1535633096,"customID":"huan-us","extra":"{\"FrontendControl\":{\"addToBlackList\":true,\"alertDuplicateContact\":true,\"autoAcceptGroupInvitation\":true,\"canClearMsg\":true,\"canLogout\":true,\"canOpenPaymentManage\":false,\"canRemoveRequestFriend\":true,\"canSendRedEnvelope\":false,\"canShareCard\":true,\"canTransferMoney\":false,\"canWithdraw\":true,\"closeSensitiveWord\":false,\"customLocation\":false,\"deleteFriend\":false,\"forbidReceiveRedEnvelope\":true,\"forbidReceiveTransferMoney\":true,\"showAccountQR\":true,\"showAccountView\":false,\"showAccountWxNo\":true,\"showContactWxNo\":false,\"uploadGroupMsg\":true},\"persistRoomMsg\":true}","gender":1,"id":"2300e6e969d2450fa28557c57c2383ae","nickname":"Huan LI","platformUid":"wxid_5zj4i5htp9ih22","serviceID":13,"signature":"angel invester, serial entrepreneur, machine learning Ph.D","state":"California","tags":[null]}
00:36:10 VERB PuppetIoscat contactRawPayloadParser()
00:36:10 SILL Puppet contactPayload(wxid_5zj4i5htp9ih22) cache SET
00:36:10 VERB ContactSelf name()
Huan LI login
00:36:10 VERB Wechaty say(Wechaty login)
00:36:10 VERB Puppet selfId()
00:36:10 VERB Contact say(Wechaty login)
00:36:10 VERB PuppetIoscat messageSend([object Object], Wechaty login)
00:36:10 VERB PuppetIoscat sendMessage([object Object], Wechaty login)
00:36:11 SILL PuppetIosCatManager syncContactsAndRooms() syncing Contact(9) & Room(8) ...
00:36:11 VERB PuppetIosCatManager syncContactsAndRooms() sync contact done!
00:36:11 VERB Wechaty on(heartbeat, function) registered
00:36:11 VERB Wechaty onFunction(heartbeat)
00:36:11 SILL StateSwitch <Wechaty> on() is pending
00:36:11 VERB StateSwitch <Wechaty> on(true) <- (pending)

00:37:09 SILL Puppet constructor() watchdog.on(reset) reason: {"data":"inited","type":"startWatchdog()","timeout":60000}
00:37:09 SILL Puppet constructor() this.on(reset) reason: {"data":"inited","type":"startWatchdog()","timeout":60000}
00:37:09 SILL Puppet constructor() resetThrottleQueue.subscribe() reason: {"data":"inited","type":"startWatchdog()","timeout":60000}
00:37:09 VERB Puppet reset({"data":"inited","type":"startWatchdog()","timeout":60000})
00:37:09 SILL StateSwitch <PuppetIoscat> off() is false
00:37:09 VERB PuppetIoscat stop()
00:37:09 SILL StateSwitch <PuppetIoscat> off() is false
00:37:09 SILL StateSwitch <PuppetIoscat> off() is false
00:37:09 VERB StateSwitch <PuppetIoscat> off(pending) <- (false)
00:37:11 VERB PuppetIoscat logout()
00:37:11 VERB PuppetIosCatManager releaseCache()
00:37:11 SILL PuppetIosCatManager releaseCache() closing caches ...
zixia:~/workspace (master) $