[COMM]softbus server stub init(weak function).
[COMM]loop thread creating Loop-default id 1473889856
[COMM][Loop-default]wait looper start ok
[COMM]init looper success.
[CONN]tcp MaxConnNum is 30
[CONN]tcp MaxLen is 3072
[CONN]tcp TimeOut is 100
[CONN]init tcp ok 

[CONN]connect manager init success. 

[CONN]proxy auth byteSize[39992], messageSize[4096]
[TRAN]proxy channel init ok
[TRAN]p2p direct channel not support.
[TRAN]server trans udp channel init success.
[TRAN]InitQos virtual
[TRAN]trans session server list init succ
[AUTH]auth ability is 1
[COMM]LoopTask[Loop-default] running
[COMM]LoopTask[Loop-default] wait msg list empty
InitDeviceAuthService: [Service]: Start to init device auth service!
HksInitialize[119]: enter initialize

RegisterAbility[32]: register ability i = 0, id = 0x1010014

RegisterAbility[32]: register ability i = 1, id = 0x1010001

RegisterAbility[32]: register ability i = 2, id = 0x1010002

RegisterAbility[32]: register ability i = 3, id = 0x1010065

RegisterAbility[32]: register ability i = 4, id = 0x1010066

RegisterAbility[32]: register ability i = 5, id = 0x1010032

RegisterAbility[32]: register ability i = 6, id = 0x1010003

RegisterAbility[32]: register ability i = 7, id = 0x1010067

RegisterAbility[32]: register ability i = 8, id = 0x1020001

RegisterAbility[32]: register ability i = 9, id = 0x1020002

RegisterAbility[32]: register ability i = 10, id = 0x1020066

RegisterAbility[32]: register ability i = 11, id = 0x1020067

RegisterAbility[32]: register ability i = 12, id = 0x1020003

RegisterAbility[32]: register ability i = 13, id = 0x1050001

RegisterAbility[32]: register ability i = 14, id = 0x1050002

RegisterAbility[32]: register ability i = 15, id = 0x1050066

RegisterAbility[32]: register ability i = 16, id = 0x1050003

RegisterAbility[32]: register ability i = 17, id = 0x1060001

RegisterAbility[32]: register ability i = 18, id = 0x1060002

RegisterAbility[32]: register ability i = 19, id = 0x1060066

RegisterAbility[32]: register ability i = 20, id = 0x1060003

RegisterAbility[32]: register ability i = 21, id = 0x1170001

RegisterAbility[32]: register ability i = 22, id = 0x1170014

RegisterAbility[32]: register ability i = 23, id = 0x10d0014

RegisterAbility[32]: register ability i = 24, id = 0x10e0014

RegisterAbility[32]: register ability i = 25, id = 0x10f0014

RegisterAbility[32]: register ability i = 26, id = 0x11c0014

RegisterAbility[32]: register ability i = 27, id = 0x1180001

RegisterAbility[32]: register ability i = 28, id = 0x1180014

RegisterAbility[32]: register ability i = 29, id = 0x1100014

RegisterAbility[32]: register ability i = 30, id = 0x1110014

RegisterAbility[32]: register ability i = 31, id = 0x1120014

RegisterAbility[32]: register ability i = 32, id = 0x11d0014

RegisterAbility[32]: register ability i = 33, id = 0x1040064

RegisterAbility[32]: register ability i = 34, id = 0x1040065

RegisterAbility[32]: register ability i = 35, id = 0x1040066

RegisterAbility[32]: register ability i = 36, id = 0x1040067

RegisterAbility[32]: register ability i = 37, id = 0x1030033

RegisterAbility[32]: register ability i = 38, id = 0x1030034

RegisterAbility[32]: register ability i = 39, id = 0x1150000

RegisterAbility[32]: register ability i = 40, id = 0x1070000

RegisterAbility[32]: register ability i = 41, id = 0x1080000

RegisterAbility[32]: register ability i = 42, id = 0x1090000

RegisterAbility[32]: register ability i = 43, id = 0x11b0000

RegisterAbility[32]: register ability i = 44, id = 0x1160000

RegisterAbility[32]: register ability i = 45, id = 0x10a0000

RegisterAbility[32]: register ability i = 46, id = 0x10b0000

RegisterAbility[32]: register ability i = 47, id = 0x10c0000

RegisterAbility[32]: register ability i = 48, id = 0x11a0000

RegisterAbility[32]: register ability i = 49, id = 0x1140000

RegisterAbility[32]: register ability i = 50, id = 0x1190000

HksInitialize[121]: leave initialize, result = 0

InitModules: Init modules success!
GetStorageDirPath: [OS]: storageDirFile: /data/data/deviceauth
GetStorageDirPath: [OS]: storageDirFile: /data/data/deviceauth
LoadOsAccountDb: [DB]: Load os account db successfully! [Id]: 0
InitBroadcastManager: [Broadcaster]: Init broadcast manager module successfully!
MainRescInit: starting ...
InitIpcCallBackList: initializing ...
InitIpcCallBackList: initialized successful
AddListenerIfNotExist: [End]: Service register listener successfully!
MainRescInit: process done
AddDevAuthServiceToManager: AddSystemAbility to SA manager success
AddMethodMap: process done, ret 0
DeviceAuthIpcInit: device authentication service register to IPC manager done, service running...
InitDeviceAuthService: [End]: [Service]: Init device auth service successfully!
AddListenerIfNotExist: [End]: Service register listener successfully!
[AUTH]auth init succ!
5 nStackXDFinder: NSTACKX_Init:[220] :nstack ctrl create epollfd 6
5 nStackXCoAP: CoapServerInit:[260] :CoapServerInit is called
5 nStackXCoAP: CoapServerInit:[266] :wifi not connected
4 nStackXDFinder: NSTACKX_Init:[241] :DFinder init successfully
[DISC]coap discovery init success.
[DISC]init success
[LNN]lnn capbility is 30
[LNN]meta node init success
[COMM]loop thread creating NotifyLooper id 1473869376
[COMM][NotifyLooper]wait looper start ok
[COMM]LoopTask[NotifyLooper] running
[COMM]LoopTask[NotifyLooper] wait msg list empty
[LNN]netlink monitor thread start
[LNN]carrier result: 1

[LNN]GetNetworkIfIp ifName:eth0 ok!
[LNN]get ip success

[TRAN]register net listener ok
[LNN]lnn config is 10,2
[LNN]full path for 0 is /data/data/dsoftbus/uuid
[LNN]init net builder success
[LNN]InitLaneManager success
[LNN]time sync virtual init success
[LNN]ble heartbeat stub impl init
[COMM]loop thread creating Heartbeat-Looper id 1473848896
[COMM][Heartbeat-Looper]wait looper start ok
[LNN]heartbeat(HB) init success
[LNN]lnn delay init len is 0
[COMM][Loop-default]PostMessageAtTime what =0 time=1695105429174857 us
[COMM][Loop-default]PostMessageAtTime. insert
[COMM]DumpLooper. i=0,handler=LnnAsyncHandler,what =0,arg1=0 arg2=0, time=1695105429174857
[LNN]bus center server init ok
[COMM]p2p link not support
[COMM]softbus framework init success.
[COMM]LoopTask[Loop-default], get message. handle=LnnAsyncHandler,what=0,msgSize=0
[COMM]LoopTask[Loop-default], HandleMessage message. handle=LnnAsyncHandler,what=0
[COMM]LoopTask[Heartbeat-Looper] running
[COMM]LoopTask[Heartbeat-Looper] wait msg list empty
[LNN]carrier result: 1

[LNN]GetNetworkIfIp ifName:eth0 ok!
[LNN]get ip success

[LNN]open ip link and start discovery

[AUTH]auth open base listener
[CONN]create pthread now.
[CONN]StartBaseListener success, fd = 45893, module = 1
[CONN]StartBaseListener success, fd = 38131, module = 5
[CONN]ThreadPoolWorker Start
[CONN]StartBaseListener success, fd = 34871, module = 0
4 nStackXDFinder: NSTACKX_RegisterDevice:[387] :begin to NSTACKX_RegisterDevice!
[DISC]register input bitmap = [64].
[DISC]register all cap bitmap = [64].
4 nStackXDFinder: NSTACKX_RegisterCapability:[508] :Register Capability
5 nStackXCoAP: [DISC]coap start passive publish.
CoapServerInit:[260] :CoapServerInit is called
[DISC]register input bitmap = [64].
[DISC]register all cap bitmap = [64].
4 nStackXDFinder: NSTACKX_SetFilterCapability:[514] :Set Filter Capability
[DISC]coap start active discovery.
[LNN]update local role from 0 to 1
[LNN]heartbeat(HB) process start.
[LNN]HB post delay msg, what=1 delay=0 msec
[COMM][Heartbeat-Looper]PostMessageAtTime what =1 time=1695105429175159 us
[COMM][Heartbeat-Looper]PostMessageAtTime. insert
[COMM]DumpLooper. i=0,handler=heartbeat_handler,what =1,arg1=2 arg2=0, time=1695105429175159
[COMM]LoopTask[Loop-default], after HandleMessage message. handle=LnnAsyncHandler,what=0
[COMM]LoopTask[Loop-default] wait msg list empty
[COMM]LoopTask[Heartbeat-Looper], get message. handle=heartbeat_handler,what=1,msgSize=0
[COMM]LoopTask[Heartbeat-Looper], HandleMessage message. handle=heartbeat_handler,what=1
[LNN]heartbeat(HB) start in status: 2
[LNN]HB FSM process msg(1) done, ret=2, nowstatus=0
[LNN]HB post delay msg, what=7 delay=20000 msec
[COMM][Heartbeat-Looper]PostMessageAtTime what =7 time=1695105449175167 us
[COMM][Heartbeat-Looper]PostMessageAtTime. insert
[COMM]DumpLooper. i=0,handler=heartbeat_handler,what =7,arg1=0 arg2=0, time=1695105449175167
[COMM]LoopTask[Heartbeat-Looper], after HandleMessage message. handle=heartbeat_handler,what=1
4 nStackXDev: BindToDevice:[213] :device name: lo
4 nStackXDev: BindToDevice:[213] :device name: eth0
4 nStackXDev: BindToDeviceInner:[191] :binding interface eth0 success
5 nStackXCoAP: CoapInitResources:[965] :CoapInitResources g_wlanOrEthContext update
3 nStackXCoAP: CoapServiceDiscoverStop:[631] :clear device list backup
4 nStackXCoAP: CoapServiceDiscoverStopInner:[782] :device discover stopped
2 nStackXDFinder: BackupDeviceDB:[1180] :clear backupDB error
3 nStackXCoAP: CoapServiceDiscoverInner:[724] :clear device list
4 nStackXCoAP: CoapServiceDiscoverInner:[739] :the first time for device discover.
4 nStackXCoAP: CoapServiceDiscoverTimerHandle:[652] :the 2 times for device discover.
4 nStackXCoAP: CoapServiceDiscoverTimerHandle:[652] :the 3 times for device discover.
4 nStackXCoAP: CoapServiceDiscoverTimerHandle:[652] :the 4 times for device discover.
4 nStackXCoAP: CoapServiceDiscoverTimerHandle:[652] :the 5 times for device discover.
4 nStackXCoAP: CoapServiceDiscoverTimerHandle:[652] :the 6 times for device discover.
4 nStackXCoAP: CoapServiceDiscoverTimerHandle:[652] :the 7 times for device discover.
4 nStackXCoAP: CoapServiceDiscoverTimerHandle:[652] :the 8 times for device discover.
4 nStackXCoAP: CoapServiceDiscoverTimerHandle:[652] :the 9 times for device discover.
4 nStackXCoAP: CoapServiceDiscoverTimerHandle:[652] :the 10 times for device discover.
4 nStackXCoAP: CoapServiceDiscoverTimerHandle:[652] :the 11 times for device discover.
4 nStackXCoAP: CoapServiceDiscoverTimerHandle:[652] :the 12 times for device discover.
3 nStackXCoAP: CoapServiceDiscoverStop:[631] :clear device list backup
5 nStackXCoAP: ParseDeviceHashData:[224] :Cannot find device hash or invalid hash
5 nStackXCoAP: ParseServiceDiscover:[363] :new device join
4 nStackXDFinder: NotifyDeviceListChanged:[759] :notify callback: device list changed
[DISC]Server OnDeviceFound capabilityBitmap = 64
[DISC]find callback:id = 0
[LNN]DeviceFound enter, type = 3

[LNN]LnnNotifyDiscoveryDevice enter!
[COMM][Loop-default]PostMessageAtTime what =1 time=1695105434983547 us
[COMM][Loop-default]PostMessageAtTime. insert
[COMM]DumpLooper. i=0,handler=NetBuilderHandler,what =1,arg1=0 arg2=0, time=1695105434983547
4 nStackXDFinder: NotifyDeviceListChanged:[761] :finish to notify device list changed
[COMM]LoopTask[Loop-default], get message. handle=NetBuilderHandler,what=1,msgSize=0
[COMM]LoopTask[Loop-default], HandleMessage message. handle=NetBuilderHandler,what=1
[LNN]net builder process msg: 1
[LNN]create a new connection fsm[id=1]
[COMM][Loop-default]PostMessageAtTime what =0 time=1695105434983562 us
[COMM][Loop-default]PostMessageAtTime. insert
[COMM]DumpLooper. i=0,handler=LnnConnFsm-1,what =0,arg1=0 arg2=0, time=1695105434983562
[LNN]connection fsm[id=1] is starting
[COMM][Loop-default]PostMessageAtTime what =1 time=1695105434983565 us
[COMM][Loop-default]PostMessageAtTime. insert
[COMM]DumpLooper. i=0,handler=LnnConnFsm-1,what =0,arg1=0 arg2=0, time=1695105434983562
[COMM]DumpLooper. i=1,handler=LnnConnFsm-1,what =1,arg1=0 arg2=0, time=1695105434983565
[LNN]net builder process msg(1) done, ret=0
[COMM]LoopTask[Loop-default], after HandleMessage message. handle=NetBuilderHandler,what=1
[COMM]LoopTask[Loop-default], get message. handle=LnnConnFsm-1,what=0,msgSize=1
[COMM]LoopTask[Loop-default], HandleMessage message. handle=LnnConnFsm-1,what=0
[LNN]process fsm ctrl msg: 0
[COMM]LoopTask[Loop-default], after HandleMessage message. handle=LnnConnFsm-1,what=0
[COMM]LoopTask[Loop-default], get message. handle=LnnConnFsm-1,what=1,msgSize=0
[COMM]LoopTask[Loop-default], HandleMessage message. handle=LnnConnFsm-1,what=1
[LNN][id=1]auth process message: 0
[LNN][id=1]begin join request
[AUTH]create auth as client side, authId = 2923849318402.
[CONN]fd=19 set to nonblock
connect :Operation now in progress
[CONN]AddTrigger fd:19 success, current fdcount:2, module:1, triggerType:1
[COMM][Loop-default]PostMessageAtTime what =0 time=1695105444983664 us
[COMM][Loop-default]PostMessageAtTime. insert
[COMM]DumpLooper. i=0,handler=auth_handler,what =0,arg1=1 arg2=0, time=1695105444983664
[AUTH]start authentication process, authId is 2923849318402
[COMM][Loop-default]PostMessageAtTime what =1 time=1695105449983667 us
[COMM][Loop-default]PostMessageAtTime. insert
[COMM]DumpLooper. i=0,handler=auth_handler,what =0,arg1=1 arg2=0, time=1695105444983664
[COMM]DumpLooper. i=1,handler=LnnConnFsm-1,what =1,arg1=9 arg2=0, time=1695105449983667
[LNN][id=1]verify request authId=2923849318402
[COMM]LoopTask[Loop-default], after HandleMessage message. handle=LnnConnFsm-1,what=1
5 nStackXCoAP: CoapMessageHandler:[153] :2.01
[CONN]AddTrigger fd:20 success, current fdcount:3, module:1, triggerType:0
[AUTH]create ip auth as server side
[AUTH]connect successful for authId: 2923849318402
[CONN]DelTrigger and node [fd:19] success, current fdcount:2, module:1, triggerType:1
[CONN]AddTrigger fd:19 success, current fdcount:3, module:1, triggerType:0
[CONN]fd=19 set to block
[AUTH]auth start post eth data, authId is 2923849318402, moduleId is 1, len is 221
[AUTH]auth recv eth data, head len is 221, module = 1, flag = 0, seq = 2159663906818
[AUTH]auth ip data module is 1
[AUTH]server ip authId is 2159663906818
[COMM][Loop-default]PostMessageAtTime what =0 time=1695105444984075 us
[COMM][Loop-default]PostMessageAtTime. insert
[COMM]DumpLooper. i=0,handler=auth_handler,what =0,arg1=1 arg2=0, time=1695105444983664
[COMM]DumpLooper. i=1,handler=auth_handler,what =0,arg1=2 arg2=0, time=1695105444984075
[COMM]DumpLooper. i=2,handler=LnnConnFsm-1,what =1,arg1=9 arg2=0, time=1695105449983667
[AUTH]auth start post eth data, authId is 2159663906818, moduleId is 1, len is 221
[AUTH]auth recv eth data, head len is 221, module = 1, flag = 1, seq = 2923849318402
[AUTH]auth ip data module is 1
[AUTH]start auth device, enter hichain process
AuthDevice: Begin AuthDevice.
AuthDevice: Push AuthDevice task successfully.
CreateSession: Current session num: 0
CreateClientAuthSession: Begin create client authSession.
GetCandidateGroupInfo: No input of groupId, extract group info without groupId.
GetGroupAuth: Account-related auth type.
GetAccountRelatedGroupAuth: Device auth do not support account related auth!
QueryGroups: [DB]: Number of groups queried: 1
QueryGroups: [DB]: Number of groups queried: 1
QueryGroups: [DB]: Number of groups queried: 1
QueryDevices: [DB]: Number of trusted devices queried: 1
QueryDevices: [DB]: Number of trusted devices queried: 1
GetGroupAuth: Non-account auth type.
QueryDevices: [DB]: Number of trusted devices queried: 1
HksGenerateRandom[305]: enter generate random

HksOpensslFillRandom[72]: generate random success

HksGenerateRandom[310]: leave generate random, result = 0

IsDasMsgNeedIgnore: There is no message code.
HksGenerateRandom[305]: enter generate random

HksOpensslFillRandom[72]: generate random success

HksGenerateRandom[310]: leave generate random, result = 0

CreateTask: Create task success, taskId: -367751945, moduleType: 1.
IsPeerErrMessage: There is no message code.
HksGenerateRandom[305]: enter generate random

HksOpensslFillRandom[72]: generate random success

HksGenerateRandom[310]: leave generate random, result = 0

HksGenerateRandom[305]: enter generate random

HksOpensslFillRandom[72]: generate random success

HksGenerateRandom[310]: leave generate random, result = 0

HksHash[541]: enter hash

[AUTH]auth recv eth data, head len is 610, module = 3, flag = 0, seq = 2159663906818
[AUTH]auth ip data module is 3
ProcessData: Begin ProcessData.
HksHash[546]: leave hash, result = 0

ProcessData: Push ProcessData task successfully.
ProcessTask: Process task success, taskId: -367751945, moduleType: 1.
ReturnTransmitData: Start to transmit data to peer for auth!
[AUTH]AuthOnTransmit authId=2923849318402, len=610
[AUTH]auth start post eth data, authId is 2923849318402, moduleId is 3, len is 610
ReturnTransmitData: End transmit data to peer for auth!
CreateClientAuthSession: End create client authSession.
CreateSession: Current session num: 1
GetGroupAuth: Non-account auth type.
GetServerConfirmation: Begin to invoke onRequest for auth!
GetServerConfirmation: End to invoke onRequest for auth!
GetGroupAuth: Non-account auth type.
GetGroupAuth: Non-account auth type.
GetDasAuthParamForServer: Begin get non-account auth params for server.
QueryGroups: [DB]: Number of groups queried: 1
QueryGroups: [DB]: Number of groups queried: 1
QueryDevices: [DB]: Number of trusted devices queried: 1
QueryDevices: [DB]: Number of trusted devices queried: 1
GetGroupAuth: Non-account auth type.
QueryDevices: [DB]: Number of trusted devices queried: 1
HksGenerateRandom[305]: enter generate random

HksOpensslFillRandom[72]: generate random success

HksGenerateRandom[310]: leave generate random, result = 0

HksGenerateRandom[305]: enter generate random

HksOpensslFillRandom[72]: generate random success

HksGenerateRandom[310]: leave generate random, result = 0

CreateSingleSubTask: Server select protocolType: 2
CreateTask: Create task success, taskId: -962022865, moduleType: 1.
HksGenerateRandom[305]: enter generate random

HksOpensslFillRandom[72]: generate random success

HksGenerateRandom[310]: leave generate random, result = 0

HksHash[541]: enter hash

HksHash[546]: leave hash, result = 0

HksHash[541]: enter hash

HksHash[546]: leave hash, result = 0

FillPskWithDerivedKeyHex: Psk alias: 42354538****.
HksKeyExist[288]: enter check key exist

MakeSubPath[665]: MakeSubPath outPath = /data/data/maindata/hks_client

HksKeyExist[293]: leave check key exist, result = 0

HksDeriveKey[478]: enter derive key

MakeSubPath[665]: MakeSubPath outPath = /data/data/maindata/hks_client

MakeSubPath[665]: MakeSubPath outPath = /data/data/maindata/hks_client

RecordKeyOperation[925]: use key, storage path: /data/data/maindata/hks_client/key, key alias: B5E8645B1592CDA1E15EFB1FB371FDB2809C4983B38AB3BB1F61599C****BAC4

HksDeriveKey[492]: leave derive key with persistent key, result = 0

HksGenerateRandom[305]: enter generate random

HksOpensslFillRandom[72]: generate random success

HksGenerateRandom[310]: leave generate random, result = 0

HksGenerateRandom[305]: enter generate random

HksOpensslFillRandom[72]: generate random success

HksGenerateRandom[310]: leave generate random, result = 0

HksDeriveKey[478]: enter derive key

HksDeriveKey[487]: leave derive key with plain key, result = 0

HksGenerateRandom[305]: enter generate random

HksOpensslFillRandom[72]: generate random success

HksGenerateRandom[310]: leave generate random, result = 0

HksAgreeKey[440]: enter agree key

HksAgreeKey[449]: leave agree key with plain key, result = 0

ProcessTask: Process task success, taskId: -962022865, moduleType: 1.
ReturnTransmitData: Start to transmit data to peer for auth!
[AUTH]AuthOnTransmit authId=2159663906818, len=554
[AUTH]auth start post eth data, authId is 2159663906818, moduleId is 3, len is 554
ReturnTransmitData: End transmit data to peer for auth!
[AUTH]auth recv eth data, head len is 554, module = 3, flag = 1, seq = 2923849318402
[AUTH]auth ip data module is 3
ProcessData: Begin ProcessData.
ProcessData: Push ProcessData task successfully.
ProcessClientAuthSession: Begin process client authSession.
NegotiateAndProcessTask: Client select protocolType: 2
HksHash[541]: enter hash

HksHash[546]: leave hash, result = 0

HksHash[541]: enter hash

HksHash[546]: leave hash, result = 0

FillPskWithDerivedKeyHex: Psk alias: 42354538****.
HksKeyExist[288]: enter check key exist

MakeSubPath[665]: MakeSubPath outPath = /data/data/maindata/hks_client

HksKeyExist[293]: leave check key exist, result = 0

HksDeriveKey[478]: enter derive key

MakeSubPath[665]: MakeSubPath outPath = /data/data/maindata/hks_client

MakeSubPath[665]: MakeSubPath outPath = /data/data/maindata/hks_client

RecordKeyOperation[925]: use key, storage path: /data/data/maindata/hks_client/key, key alias: B5E8645B1592CDA1E15EFB1FB371FDB2809C4983B38AB3BB1F61599C****BAC4

HksDeriveKey[492]: leave derive key with persistent key, result = 0

HksGenerateRandom[305]: enter generate random

HksOpensslFillRandom[72]: generate random success

HksGenerateRandom[310]: leave generate random, result = 0

HksDeriveKey[478]: enter derive key

HksDeriveKey[487]: leave derive key with plain key, result = 0

HksGenerateRandom[305]: enter generate random

HksOpensslFillRandom[72]: generate random success

HksGenerateRandom[310]: leave generate random, result = 0

HksAgreeKey[440]: enter agree key

HksAgreeKey[449]: leave agree key with plain key, result = 0

HksAgreeKey[440]: enter agree key

HksAgreeKey[449]: leave agree key with plain key, result = 0

HksDeriveKey[478]: enter derive key

HksDeriveKey[487]: leave derive key with plain key, result = 0

HksMac[509]: enter mac

HksMac[518]: leave mac with plain key, result = 0

ProcessTask: Process task success, taskId: -367751945, moduleType: 1.
ReturnTransmitData: Start to transmit data to peer for auth!
[AUTH]AuthOnTransmit authId=2923849318402, len=350
[AUTH]auth start post eth data, authId is 2923849318402, moduleId is 3, len is 350
ReturnTransmitData: End transmit data to peer for auth!
[AUTH]auth recv eth data, head len is 350, module = 3, flag = 0, seq = 2159663906818
[AUTH]auth ip data module is 3
ProcessData: Begin ProcessData.
ProcessData: Push ProcessData task successfully.
ProcessServerAuthSession: Begin process server authSession.
HksAgreeKey[440]: enter agree key

HksAgreeKey[449]: leave agree key with plain key, result = 0

HksDeriveKey[478]: enter derive key

HksDeriveKey[487]: leave derive key with plain key, result = 0

HksMac[509]: enter mac

HksMac[518]: leave mac with plain key, result = 0

HksMac[509]: enter mac

HksMac[518]: leave mac with plain key, result = 0

HksDeriveKey[478]: enter derive key

HksDeriveKey[487]: leave derive key with plain key, result = 0

CreateNextTask: End server task successfully, opcode: 2.
ProcessTask: Process task success, taskId: -962022865, moduleType: 1.
GetGroupAuth: Non-account auth type.
OnDasFinish: Begin call onFinish for non-account auth.
DasOnFinishToPeer: Begin to transmit data to peer for auth in DasOnFinishToPeer.
[AUTH]AuthOnTransmit authId=2159663906818, len=211
[AUTH]auth start post eth data, authId is 2159663906818, moduleId is 3, len is 211
DasOnFinishToPeer: End to transmit data to peer for auth in DasOnFinishToPeer.
ReturnSessionKey: Begin invoke onSessionKeyReturned.
[AUTH]auth get session key succ, authId is 2159663906818
[AUTH]auth add sessionkey, seq is:-704643070
[AUTH]wait client send encrypt dev info
ReturnSessionKey: End invoke onSessionKeyReturned, res = 0.
DasOnFinishToSelf: Group auth call onFinish for account unrelated auth.
OnDasFinish: Call onFinish for non-account auth successfully.
ProcessServerAuthSession: End process server authSession.
[AUTH]auth recv eth data, head len is 211, module = 3, flag = 1, seq = 2923849318402
[AUTH]auth ip data module is 3
ProcessData: Begin ProcessData.
ProcessData: Push ProcessData task successfully.
ProcessClientAuthSession: Begin process client authSession.
HksMac[509]: enter mac

HksMac[518]: leave mac with plain key, result = 0

HksDeriveKey[478]: enter derive key

HksDeriveKey[487]: leave derive key with plain key, result = 0

CreateNextTask: End client task successfully, opcode: 2.
AddVersionToOut: Not find payload.
AddSingleVersionToJson: There is not sendToPeer in json.
ProcessTask: Process task success, taskId: -367751945, moduleType: 1.
GetGroupAuth: Non-account auth type.
OnDasFinish: Begin call onFinish for non-account auth.
DasOnFinishToPeer: No need to transmit data to peer.
ReturnSessionKey: Begin invoke onSessionKeyReturned.
[AUTH]auth get session key succ, authId is 2923849318402
[AUTH]auth add sessionkey, seq is:-1023410174
[COMM][Loop-default]PostMessageAtTime what =3 time=1695105434985915 us
[COMM][Loop-default]PostMessageAtTime. insert
[COMM]DumpLooper. i=0,handler=NetBuilderHandler,what =3,arg1=0 arg2=0, time=1695105434985915
[COMM]DumpLooper. i=1,handler=auth_handler,what =0,arg1=1 arg2=0, time=1695105444983664
[COMM]DumpLooper. i=2,handler=auth_handler,what =0,arg1=2 arg2=0, time=1695105444984075
[COMM]DumpLooper. i=3,handler=LnnConnFsm-1,what =1,arg1=9 arg2=0, time=1695105449983667
[LNN]auth key generated: 2923849318402
ReturnSessionKey: End invoke onSessionKeyReturned, res = 0.
[COMM]LoopTask[Loop-default], get message. handle=NetBuilderHandler,what=3,msgSize=3
[COMM]LoopTask[Loop-default], HandleMessage message. handle=NetBuilderHandler,what=3
[LNN]net builder process msg: 3
DasOnFinishToSelf: Group auth call onFinish for account unrelated auth.
OnDasFinish: Call onFinish for non-account auth successfully.
[COMM][Loop-default]PostMessageAtTime what =1 time=1695105434985933 us
[COMM][Loop-default]PostMessageAtTime. insert
ProcessClientAuthSession: End process client authSession.
[COMM]DumpLooper. i=0,handler=LnnConnFsm-1,what =1,arg1=1 arg2=0, time=1695105434985933
[COMM]DumpLooper. i=1,handler=auth_handler,what =0,arg1=1 arg2=0, time=1695105444983664
[COMM]DumpLooper. i=2,handler=auth_handler,what =0,arg1=2 arg2=0, time=1695105444984075
[COMM]DumpLooper. i=3,handler=LnnConnFsm-1,what =1,arg1=9 arg2=0, time=1695105449983667
[LNN][id=1]connection fsm auth key generated process done: 2923849318402, 0
[LNN]net builder process msg(3) done, ret=0
[COMM]LoopTask[Loop-default], after HandleMessage message. handle=NetBuilderHandler,what=3
[COMM]LoopTask[Loop-default], get message. handle=LnnConnFsm-1,what=1,msgSize=3
[COMM]LoopTask[Loop-default], HandleMessage message. handle=LnnConnFsm-1,what=1
[LNN][id=1]auth process message: 1
[LNN][id=1]active auth success, transact to syn_device_info state, authId=2923849318402
[COMM][Loop-default]PostMessageAtTime what =1 time=1695105434985938 us
[COMM][Loop-default]PostMessageAtTime. insert
[COMM]DumpLooper. i=0,handler=LnnConnFsm-1,what =1,arg1=3 arg2=0, time=1695105434985938
[COMM]DumpLooper. i=1,handler=auth_handler,what =0,arg1=1 arg2=0, time=1695105444983664
[COMM]DumpLooper. i=2,handler=auth_handler,what =0,arg1=2 arg2=0, time=1695105444984075
[COMM]DumpLooper. i=3,handler=LnnConnFsm-1,what =1,arg1=9 arg2=0, time=1695105449983667
[COMM]LoopTask[Loop-default], after HandleMessage message. handle=LnnConnFsm-1,what=1
[COMM]LoopTask[Loop-default], get message. handle=LnnConnFsm-1,what=1,msgSize=3
[COMM]LoopTask[Loop-default], HandleMessage message. handle=LnnConnFsm-1,what=1
[LNN][id=1]sync device info process message: 3
[LNN]PackWifi enter!
[AUTH]auth get session key by seq -1023410174
[AUTH]auth get session key by seq seccessfully.
[AUTH]auth start post eth data, authId is 2923849318402, moduleId is 5, len is 560
[LNN][id=1]sync device info process result: 0
[COMM]LoopTask[Loop-default], after HandleMessage message. handle=LnnConnFsm-1,what=1
[AUTH]auth recv eth data, head len is 560, module = 5, flag = 0, seq = 2159663906818
[AUTH]auth ip data module is 5
[AUTH]auth saved encrypted data first
[COMM][Loop-default]PostMessageAtTime what =3 time=1695105434985986 us
[COMM][Loop-default]PostMessageAtTime. insert
[COMM]DumpLooper. i=0,handler=NetBuilderHandler,what =3,arg1=0 arg2=0, time=1695105434985986
[COMM]DumpLooper. i=1,handler=auth_handler,what =0,arg1=1 arg2=0, time=1695105444983664
[COMM]DumpLooper. i=2,handler=auth_handler,what =0,arg1=2 arg2=0, time=1695105444984075
[COMM]DumpLooper. i=3,handler=LnnConnFsm-1,what =1,arg1=9 arg2=0, time=1695105449983667
[LNN]auth key generated: 2159663906818
[COMM]LoopTask[Loop-default], get message. handle=NetBuilderHandler,what=3,msgSize=3
[COMM]LoopTask[Loop-default], HandleMessage message. handle=NetBuilderHandler,what=3
[LNN]net builder process msg: 3
[LNN]create and start a new connection fsm as server side
[LNN]create a new connection fsm[id=2]
[COMM][Loop-default]PostMessageAtTime what =0 time=1695105434985993 us
[COMM][Loop-default]PostMessageAtTime. insert
[COMM]DumpLooper. i=0,handler=LnnConnFsm-2,what =0,arg1=0 arg2=0, time=1695105434985993
[COMM]DumpLooper. i=1,handler=auth_handler,what =0,arg1=1 arg2=0, time=1695105444983664
[COMM]DumpLooper. i=2,handler=auth_handler,what =0,arg1=2 arg2=0, time=1695105444984075
[COMM]DumpLooper. i=3,handler=LnnConnFsm-1,what =1,arg1=9 arg2=0, time=1695105449983667
[LNN]connection fsm[id=2] is starting
[COMM][Loop-default]PostMessageAtTime what =1 time=1695105434986003 us
[COMM][Loop-default]PostMessageAtTime. insert
[COMM]DumpLooper. i=0,handler=LnnConnFsm-2,what =0,arg1=0 arg2=0, time=1695105434985993
[COMM]DumpLooper. i=1,handler=LnnConnFsm-2,what =1,arg1=1 arg2=0, time=1695105434986003
[COMM]DumpLooper. i=2,handler=auth_handler,what =0,arg1=1 arg2=0, time=1695105444983664
[COMM]DumpLooper. i=3,handler=auth_handler,what =0,arg1=2 arg2=0, time=1695105444984075
[COMM]DumpLooper. i=4,handler=LnnConnFsm-1,what =1,arg1=9 arg2=0, time=1695105449983667
[LNN][id=2]connection fsm auth key generated process done: 2159663906818, 0
[LNN]net builder process msg(3) done, ret=0
[COMM]LoopTask[Loop-default], after HandleMessage message. handle=NetBuilderHandler,what=3
[COMM]LoopTask[Loop-default], get message. handle=LnnConnFsm-2,what=0,msgSize=4
[COMM]LoopTask[Loop-default], HandleMessage message. handle=LnnConnFsm-2,what=0
[LNN]process fsm ctrl msg: 0
[COMM]LoopTask[Loop-default], after HandleMessage message. handle=LnnConnFsm-2,what=0
[COMM]LoopTask[Loop-default], get message. handle=LnnConnFsm-2,what=1,msgSize=3
[COMM]LoopTask[Loop-default], HandleMessage message. handle=LnnConnFsm-2,what=1
[LNN][id=2]auth process message: 1
[LNN][id=2]passive auth success, transact to syn_device_info state, authId=2159663906818
[COMM][Loop-default]PostMessageAtTime what =1 time=1695105434986010 us
[COMM][Loop-default]PostMessageAtTime. insert
[COMM]DumpLooper. i=0,handler=LnnConnFsm-2,what =1,arg1=3 arg2=0, time=1695105434986010
[COMM]DumpLooper. i=1,handler=auth_handler,what =0,arg1=1 arg2=0, time=1695105444983664
[COMM]DumpLooper. i=2,handler=auth_handler,what =0,arg1=2 arg2=0, time=1695105444984075
[COMM]DumpLooper. i=3,handler=LnnConnFsm-1,what =1,arg1=9 arg2=0, time=1695105449983667
[COMM][Loop-default]PostMessageAtTime what =1 time=1695105449986012 us
[COMM][Loop-default]PostMessageAtTime. insert
[COMM]DumpLooper. i=0,handler=LnnConnFsm-2,what =1,arg1=3 arg2=0, time=1695105434986010
[COMM]DumpLooper. i=1,handler=auth_handler,what =0,arg1=1 arg2=0, time=1695105444983664
[COMM]DumpLooper. i=2,handler=auth_handler,what =0,arg1=2 arg2=0, time=1695105444984075
[COMM]DumpLooper. i=3,handler=LnnConnFsm-1,what =1,arg1=9 arg2=0, time=1695105449983667
[COMM]DumpLooper. i=4,handler=LnnConnFsm-2,what =1,arg1=9 arg2=0, time=1695105449986012
[COMM]LoopTask[Loop-default], after HandleMessage message. handle=LnnConnFsm-2,what=1
[COMM]LoopTask[Loop-default], get message. handle=LnnConnFsm-2,what=1,msgSize=4
[COMM]LoopTask[Loop-default], HandleMessage message. handle=LnnConnFsm-2,what=1
[LNN][id=2]sync device info process message: 3
[LNN]PackWifi enter!
[AUTH]auth get session key by seq -704643070
[AUTH]auth get session key by seq seccessfully.
[AUTH]auth start post eth data, authId is 2159663906818, moduleId is 5, len is 560
[COMM][Loop-default]PostMessageAtTime what =5 time=1695105434986037 us
[COMM][Loop-default]PostMessageAtTime. insert
[COMM]DumpLooper. i=0,handler=NetBuilderHandler,what =5,arg1=0 arg2=0, time=1695105434986037
[COMM]DumpLooper. i=1,handler=auth_handler,what =0,arg1=1 arg2=0, time=1695105444983664
[COMM]DumpLooper. i=2,handler=auth_handler,what =0,arg1=2 arg2=0, time=1695105444984075
[COMM]DumpLooper. i=3,handler=LnnConnFsm-1,what =1,arg1=9 arg2=0, time=1695105449983667
[COMM]DumpLooper. i=4,handler=LnnConnFsm-2,what =1,arg1=9 arg2=0, time=1695105449986012
[COMM][Loop-default]LooperRemoveMessage. handler=auth_handler, what =0
[AUTH]auth passed, authId = 2159663906818.
[COMM][Loop-default]PostMessageAtTime what =4 time=1695105434986040 us
[COMM][Loop-default]PostMessageAtTime. insert
[COMM]DumpLooper. i=0,handler=NetBuilderHandler,what =5,arg1=0 arg2=0, time=1695105434986037
[COMM]DumpLooper. i=1,handler=NetBuilderHandler,what =4,arg1=0 arg2=0, time=1695105434986040
[COMM]DumpLooper. i=2,handler=auth_handler,what =0,arg1=1 arg2=0, time=1695105444983664
[COMM]DumpLooper. i=3,handler=LnnConnFsm-1,what =1,arg1=9 arg2=0, time=1695105449983667
[COMM]DumpLooper. i=4,handler=LnnConnFsm-2,what =1,arg1=9 arg2=0, time=1695105449986012
[LNN]auth passed: 2159663906818
[LNN][id=2]sync device info process result: 0
[COMM]LoopTask[Loop-default], after HandleMessage message. handle=LnnConnFsm-2,what=1
[COMM]LoopTask[Loop-default], get message. handle=NetBuilderHandler,what=5,msgSize=4
[COMM]LoopTask[Loop-default], HandleMessage message. handle=NetBuilderHandler,what=5
[LNN]net builder process msg: 5
[COMM][Loop-default]PostMessageAtTime what =1 time=1695105434986048 us
[COMM][Loop-default]PostMessageAtTime. insert
[COMM]DumpLooper. i=0,handler=NetBuilderHandler,what =4,arg1=0 arg2=0, time=1695105434986040
[COMM]DumpLooper. i=1,handler=LnnConnFsm-2,what =1,arg1=4 arg2=0, time=1695105434986048
[COMM]DumpLooper. i=2,handler=auth_handler,what =0,arg1=1 arg2=0, time=1695105444983664
[COMM]DumpLooper. i=3,handler=LnnConnFsm-1,what =1,arg1=9 arg2=0, time=1695105449983667
[COMM]DumpLooper. i=4,handler=LnnConnFsm-2,what =1,arg1=9 arg2=0, time=1695105449986012
[LNN]send peer device info to connection fsm[id=2] result=0
[LNN]net builder process msg(5) done, ret=0
[COMM]LoopTask[Loop-default], after HandleMessage message. handle=NetBuilderHandler,what=5
[COMM]LoopTask[Loop-default], get message. handle=NetBuilderHandler,what=4,msgSize=4
[COMM]LoopTask[Loop-default], HandleMessage message. handle=NetBuilderHandler,what=4
[LNN]net builder process msg: 4
[LNN][id=2]connection fsm auth done: 2159663906818
[COMM][Loop-default]PostMessageAtTime what =1 time=1695105434986052 us
[COMM][Loop-default]PostMessageAtTime. insert
[COMM]DumpLooper. i=0,handler=LnnConnFsm-2,what =1,arg1=4 arg2=0, time=1695105434986048
[COMM]DumpLooper. i=1,handler=LnnConnFsm-2,what =1,arg1=2 arg2=0, time=1695105434986052
[COMM]DumpLooper. i=2,handler=auth_handler,what =0,arg1=1 arg2=0, time=1695105444983664
[COMM]DumpLooper. i=3,handler=LnnConnFsm-1,what =1,arg1=9 arg2=0, time=1695105449983667
[COMM]DumpLooper. i=4,handler=LnnConnFsm-2,what =1,arg1=9 arg2=0, time=1695105449986012
[LNN]net builder process msg(4) done, ret=0
[COMM]LoopTask[Loop-default], after HandleMessage message. handle=NetBuilderHandler,what=4
[COMM]LoopTask[Loop-default], get message. handle=LnnConnFsm-2,what=1,msgSize=4
[COMM]LoopTask[Loop-default], HandleMessage message. handle=LnnConnFsm-2,what=1
[LNN][id=2]sync device info process message: 4
[AUTH]auth get session key by dev info succ, seq is:-704643070
[LNN]unpack master weight: 490
[LNN][id=2]recv peer device info done, wait for auth done
[COMM]LoopTask[Loop-default], after HandleMessage message. handle=LnnConnFsm-2,what=1
[COMM]LoopTask[Loop-default], get message. handle=LnnConnFsm-2,what=1,msgSize=3
[COMM]LoopTask[Loop-default], HandleMessage message. handle=LnnConnFsm-2,what=1
[LNN][id=2]sync device info process message: 2
[LNN][id=2]auth done, authId=2159663906818, auth result=0
[COMM][Loop-default]PostMessageAtTime what =1 time=1695105434986073 us
[COMM][Loop-default]PostMessageAtTime. insert
[COMM]DumpLooper. i=0,handler=LnnConnFsm-2,what =1,arg1=5 arg2=0, time=1695105434986073
[COMM]DumpLooper. i=1,handler=auth_handler,what =0,arg1=1 arg2=0, time=1695105444983664
[COMM]DumpLooper. i=2,handler=LnnConnFsm-1,what =1,arg1=9 arg2=0, time=1695105449983667
[COMM]DumpLooper. i=3,handler=LnnConnFsm-2,what =1,arg1=9 arg2=0, time=1695105449986012
[COMM]LoopTask[Loop-default], after HandleMessage message. handle=LnnConnFsm-2,what=1
[COMM]LoopTask[Loop-default], get message. handle=LnnConnFsm-2,what=1,msgSize=3
[COMM]LoopTask[Loop-default], HandleMessage message. handle=LnnConnFsm-2,what=1
[LNN][id=2]clean invalid state process message: 5
[LNN]id not exist!
[LNN][id=2]no need clean invalid connection fsm
[LNN][id=2]online state enter
[LNN]remove fsm data message: 9
[COMM][Loop-default]LooperRemoveMessage. handler=LnnConnFsm-2, what =1
[LNN]notify node online
[COMM][NotifyLooper]PostMessageAtTime what =0 time=1695105434986080 us
[COMM][NotifyLooper]PostMessageAtTime. insert
[COMM]DumpLooper. i=0,handler=NotifyHandler,what =0,arg1=1 arg2=0, time=1695105434986080
[COMM][Loop-default]PostMessageAtTime what =10 time=1695105434986082 us
[COMM][Loop-default]PostMessageAtTime. insert
[COMM]DumpLooper. i=0,handler=NetBuilderHandler,what =10,arg1=0 arg2=0, time=1695105434986082
[COMM]DumpLooper. i=1,handler=auth_handler,what =0,arg1=1 arg2=0, time=1695105444983664
[COMM]DumpLooper. i=2,handler=LnnConnFsm-1,what =1,arg1=9 arg2=0, time=1695105449983667
[LNN]HB offline timing get invalid param, addrType:3
[COMM]LoopTask[NotifyLooper], get message. handle=NotifyHandler,what=0,msgSize=0
[COMM]LoopTask[NotifyLooper], HandleMessage message. handle=NotifyHandler,what=0
[COMM][Loop-default]PostMessageAtTime what =0 time=1695105439986088 us
[LNN]handle notify message, type = 0.
[COMM][Loop-default]PostMessageAtTime. insert
[COMM]DumpLooper. i=0,handler=NetBuilderHandler,what =10,arg1=0 arg2=0, time=1695105434986082
[COMM]DumpLooper. i=1,handler=LnnAsyncHandler,what =0,arg1=0 arg2=0, time=1695105439986088
[LNN]handle notify message done, type = 0.
[COMM]DumpLooper. i=2,handler=auth_handler,what =0,arg1=1 arg2=0, time=1695105444983664
[COMM]LoopTask[NotifyLooper], after HandleMessage message. handle=NotifyHandler,what=0
[COMM]DumpLooper. i=3,handler=LnnConnFsm-1,what =1,arg1=9 arg2=0, time=1695105449983667
[COMM]LoopTask[NotifyLooper] wait msg list empty
[LNN][id=2]complete join LNN done
[COMM]LoopTask[Loop-default], after HandleMessage message. handle=LnnConnFsm-2,what=1
[COMM]LoopTask[Loop-default], get message. handle=NetBuilderHandler,what=10,msgSize=3
[COMM]LoopTask[Loop-default], HandleMessage message. handle=NetBuilderHandler,what=10
[LNN]net builder process msg: 10
[LNN]local master(2) weight=894
[LNN]peer master(2) weight=490
[LNN]online node(2) weight less than current(compare result: 404), no need elect again
[LNN]net builder process msg(10) done, ret=0
[COMM]LoopTask[Loop-default], after HandleMessage message. handle=NetBuilderHandler,what=10
[AUTH]auth recv eth data, head len is 560, module = 5, flag = 1, seq = 0
[AUTH]auth ip data module is 5
[COMM][Loop-default]PostMessageAtTime what =5 time=1695105434986221 us
[COMM][Loop-default]PostMessageAtTime. insert
[COMM]DumpLooper. i=0,handler=NetBuilderHandler,what =5,arg1=0 arg2=0, time=1695105434986221
[COMM]DumpLooper. i=1,handler=LnnAsyncHandler,what =0,arg1=0 arg2=0, time=1695105439986088
[COMM]DumpLooper. i=2,handler=auth_handler,what =0,arg1=1 arg2=0, time=1695105444983664
[COMM]DumpLooper. i=3,handler=LnnConnFsm-1,what =1,arg1=9 arg2=0, time=1695105449983667
[COMM][Loop-default]LooperRemoveMessage. handler=auth_handler, what =0
[AUTH]auth passed, authId = 2923849318402.
[COMM][Loop-default]PostMessageAtTime what =4 time=1695105434986225 us
[COMM][Loop-default]PostMessageAtTime. insert
[COMM]DumpLooper. i=0,handler=NetBuilderHandler,what =5,arg1=0 arg2=0, time=1695105434986221
[COMM]DumpLooper. i=1,handler=NetBuilderHandler,what =4,arg1=0 arg2=0, time=1695105434986225
[COMM]DumpLooper. i=2,handler=LnnAsyncHandler,what =0,arg1=0 arg2=0, time=1695105439986088
[COMM]DumpLooper. i=3,handler=LnnConnFsm-1,what =1,arg1=9 arg2=0, time=1695105449983667
[LNN]auth passed: 2923849318402
[COMM]LoopTask[Loop-default], get message. handle=NetBuilderHandler,what=5,msgSize=3
[COMM]LoopTask[Loop-default], HandleMessage message. handle=NetBuilderHandler,what=5
[LNN]net builder process msg: 5
[COMM][Loop-default]PostMessageAtTime what =1 time=1695105434986230 us
[COMM][Loop-default]PostMessageAtTime. insert
[COMM]DumpLooper. i=0,handler=NetBuilderHandler,what =4,arg1=0 arg2=0, time=1695105434986225
[COMM]DumpLooper. i=1,handler=LnnConnFsm-1,what =1,arg1=4 arg2=0, time=1695105434986230
[COMM]DumpLooper. i=2,handler=LnnAsyncHandler,what =0,arg1=0 arg2=0, time=1695105439986088
[COMM]DumpLooper. i=3,handler=LnnConnFsm-1,what =1,arg1=9 arg2=0, time=1695105449983667
[LNN]send peer device info to connection fsm[id=1] result=0
[LNN]net builder process msg(5) done, ret=0
[COMM]LoopTask[Loop-default], after HandleMessage message. handle=NetBuilderHandler,what=5
[COMM]LoopTask[Loop-default], get message. handle=NetBuilderHandler,what=4,msgSize=3
[COMM]LoopTask[Loop-default], HandleMessage message. handle=NetBuilderHandler,what=4
[LNN]net builder process msg: 4
[LNN][id=1]connection fsm auth done: 2923849318402
[COMM][Loop-default]PostMessageAtTime what =1 time=1695105434986237 us
[COMM][Loop-default]PostMessageAtTime. insert
[COMM]DumpLooper. i=0,handler=LnnConnFsm-1,what =1,arg1=4 arg2=0, time=1695105434986230
[COMM]DumpLooper. i=1,handler=LnnConnFsm-1,what =1,arg1=2 arg2=0, time=1695105434986237
[COMM]DumpLooper. i=2,handler=LnnAsyncHandler,what =0,arg1=0 arg2=0, time=1695105439986088
[COMM]DumpLooper. i=3,handler=LnnConnFsm-1,what =1,arg1=9 arg2=0, time=1695105449983667
[LNN]net builder process msg(4) done, ret=0
[COMM]LoopTask[Loop-default], after HandleMessage message. handle=NetBuilderHandler,what=4
[COMM]LoopTask[Loop-default], get message. handle=LnnConnFsm-1,what=1,msgSize=3
[COMM]LoopTask[Loop-default], HandleMessage message. handle=LnnConnFsm-1,what=1
[LNN][id=1]sync device info process message: 4
[AUTH]auth get session key by dev info succ, seq is:-1023410174
[LNN]unpack master weight: 490
[LNN][id=1]recv peer device info done, wait for auth done
[COMM]LoopTask[Loop-default], after HandleMessage message. handle=LnnConnFsm-1,what=1
[COMM]LoopTask[Loop-default], get message. handle=LnnConnFsm-1,what=1,msgSize=2
[COMM]LoopTask[Loop-default], HandleMessage message. handle=LnnConnFsm-1,what=1
[LNN][id=1]sync device info process message: 2
[LNN][id=1]auth done, authId=2923849318402, auth result=0
[COMM][Loop-default]PostMessageAtTime what =1 time=1695105434986254 us
[COMM][Loop-default]PostMessageAtTime. insert
[COMM]DumpLooper. i=0,handler=LnnConnFsm-1,what =1,arg1=5 arg2=0, time=1695105434986254
[COMM]DumpLooper. i=1,handler=LnnAsyncHandler,what =0,arg1=0 arg2=0, time=1695105439986088
[COMM]DumpLooper. i=2,handler=LnnConnFsm-1,what =1,arg1=9 arg2=0, time=1695105449983667
[COMM]LoopTask[Loop-default], after HandleMessage message. handle=LnnConnFsm-1,what=1
[COMM]LoopTask[Loop-default], get message. handle=LnnConnFsm-1,what=1,msgSize=2
[COMM]LoopTask[Loop-default], HandleMessage message. handle=LnnConnFsm-1,what=1
[LNN][id=1]clean invalid state process message: 5
[LNN][id=1]no need clean invalid connection fsm
[LNN][id=1]online state enter
[LNN]remove fsm data message: 9
[COMM][Loop-default]LooperRemoveMessage. handler=LnnConnFsm-1, what =1
[LNN]addOnlineNode find online node
[LNN]flag error
[COMM][Loop-default]PostMessageAtTime what =10 time=1695105434986260 us
[COMM][Loop-default]PostMessageAtTime. insert
[COMM]DumpLooper. i=0,handler=NetBuilderHandler,what =10,arg1=0 arg2=0, time=1695105434986260
[COMM]DumpLooper. i=1,handler=LnnAsyncHandler,what =0,arg1=0 arg2=0, time=1695105439986088
[LNN]HB offline timing get invalid param, addrType:3
[COMM][Loop-default]PostMessageAtTime what =0 time=1695105439986262 us
[COMM][Loop-default]PostMessageAtTime. insert
[COMM]DumpLooper. i=0,handler=NetBuilderHandler,what =10,arg1=0 arg2=0, time=1695105434986260
[COMM]DumpLooper. i=1,handler=LnnAsyncHandler,what =0,arg1=0 arg2=0, time=1695105439986088
[COMM]DumpLooper. i=2,handler=LnnAsyncHandler,what =0,arg1=0 arg2=0, time=1695105439986262
[LNN][id=1]complete join LNN done
[COMM]LoopTask[Loop-default], after HandleMessage message. handle=LnnConnFsm-1,what=1
[COMM]LoopTask[Loop-default], get message. handle=NetBuilderHandler,what=10,msgSize=2
[COMM]LoopTask[Loop-default], HandleMessage message. handle=NetBuilderHandler,what=10
[LNN]net builder process msg: 10
[LNN]local master(1) weight=894
[LNN]peer master(1) weight=490
[LNN]online node(1) weight less than current(compare result: 404), no need elect again
[LNN]net builder process msg(10) done, ret=0
[COMM]LoopTask[Loop-default], after HandleMessage message. handle=NetBuilderHandler,what=10
5 nStackXCoAP: ParseDeviceHashData:[224] :Cannot find device hash or invalid hash
5 nStackXCoAP: ParseServiceDiscover:[363] :new device join
5 nStackXCoAP: CoapMessageHandler:[153] :2.01
5 nStackXCoAP: ParseDeviceHashData:[224] :Cannot find device hash or invalid hash
5 nStackXCoAP: ParseServiceDiscover:[363] :new device join
5 nStackXCoAP: CoapMessageHandler:[153] :2.01
5 nStackXCoAP: ParseDeviceHashData:[224] :Cannot find device hash or invalid hash
5 nStackXCoAP: ParseServiceDiscover:[363] :new device join
5 nStackXCoAP: CoapMessageHandler:[153] :2.01
5 nStackXCoAP: ParseDeviceHashData:[224] :Cannot find device hash or invalid hash
5 nStackXCoAP: ParseServiceDiscover:[363] :new device join
5 nStackXCoAP: CoapMessageHandler:[153] :2.01
5 nStackXCoAP: ParseDeviceHashData:[224] :Cannot find device hash or invalid hash
5 nStackXCoAP: ParseServiceDiscover:[363] :new device join
5 nStackXCoAP: CoapMessageHandler:[153] :2.01
5 nStackXCoAP: ParseDeviceHashData:[224] :Cannot find device hash or invalid hash
5 nStackXCoAP: ParseServiceDiscover:[363] :new device join
5 nStackXCoAP: CoapMessageHandler:[153] :2.01
5 nStackXCoAP: ParseDeviceHashData:[224] :Cannot find device hash or invalid hash
5 nStackXCoAP: ParseServiceDiscover:[363] :new device join
5 nStackXCoAP: CoapMessageHandler:[153] :2.01
5 nStackXCoAP: ParseDeviceHashData:[224] :Cannot find device hash or invalid hash
5 nStackXCoAP: ParseServiceDiscover:[363] :new device join
5 nStackXCoAP: CoapMessageHandler:[153] :2.01
5 nStackXCoAP: ParseDeviceHashData:[224] :Cannot find device hash or invalid hash
5 nStackXCoAP: ParseServiceDiscover:[363] :new device join
5 nStackXCoAP: CoapMessageHandler:[153] :2.01
[COMM]SoftBusServerStub::OnReceived, code = 0
[IPC LOG ../../depend/ipc/ipc_object_proxy.cpp:12]INSERT PROXY with handle=4f8d00000000
[IPC LOG ../../depend/ipc/ipc_proxy_manager.cpp:15]INSERT PROXY with handle=4f8d00000000
[COMM]softbus register service success softbus_sample

[COMM]SoftBusServerStub::OnReceived, code = 130
[TRAN]TransCreateSessionServer:pkgName=softbus_sample, sessionName=session_test
[TRAN]TransCreateSessionServer:uid=0, pid=20340
[TRAN]CreateSessionServer ok
[COMM]SoftBusServerStub::OnReceived, code = 128
[DISC]register input bitmap = [128].
[DISC]register all cap bitmap = [192].
4 nStackXDFinder: NSTACKX_RegisterCapability:[508] :Register Capability
[DISC]coap start passive publish.
[DISC]ServerPublishService success!
[COMM]SoftBusServerStub::OnReceived, code = 138
[DISC]register input bitmap = [128].
[DISC]register all cap bitmap = [192].
4 nStackXDFinder: NSTACKX_SetFilterCapability:[514] :Set Filter Capability
[DISC]coap start active discovery.
[DISC]ServerStartDiscovery success!
3 nStackXCoAP: CoapServiceDiscoverStop:[631] :clear device list backup
4 nStackXCoAP: CoapServiceDiscoverStopInner:[782] :device discover stopped
2 nStackXDFinder: BackupDeviceDB:[1180] :clear backupDB error
3 nStackXCoAP: CoapServiceDiscoverInner:[724] :clear device list
4 nStackXCoAP: CoapServiceDiscoverInner:[739] :the first time for device discover.
[COMM]SoftBusServerStub::OnReceived, code = 142
5 nStackXCoAP: ParseDeviceHashData:[224] :Cannot find device hash or invalid hash
4 nStackXDFinder: NotifyDeviceListChanged:[759] :notify callback: device list changed
[DISC]Server OnDeviceFound capabilityBitmap = 64
[DISC]find callback:id = 0
4 nStackXDFinder: NotifyDeviceListChanged:[761] :finish to notify device list changed
4 nStackXDFinder: NotifyDeviceFound:[774] :notify callback: device found callback is null
4 nStackXCoAP: CoapServiceDiscoverTimerHandle:[652] :the 2 times for device discover.
5 nStackXCoAP: ParseDeviceHashData:[224] :Cannot find device hash or invalid hash
4 nStackXCoAP: CoapServiceDiscoverTimerHandle:[652] :the 3 times for device discover.
5 nStackXCoAP: ParseDeviceHashData:[224] :Cannot find device hash or invalid hash
5 nStackXCoAP: ParseDeviceHashData:[224] :Cannot find device hash or invalid hash
5 nStackXCoAP: ParseServiceDiscover:[363] :new device join
5 nStackXCoAP: CoapMessageHandler:[153] :2.01
4 nStackXCoAP: CoapServiceDiscoverTimerHandle:[652] :the 4 times for device discover.
5 nStackXCoAP: ParseDeviceHashData:[224] :Cannot find device hash or invalid hash
5 nStackXCoAP: ParseDeviceHashData:[224] :Cannot find device hash or invalid hash
5 nStackXCoAP: ParseServiceDiscover:[363] :new device join
5 nStackXCoAP: CoapMessageHandler:[153] :2.01
4 nStackXCoAP: CoapServiceDiscoverTimerHandle:[652] :the 5 times for device discover.
5 nStackXCoAP: ParseDeviceHashData:[224] :Cannot find device hash or invalid hash
[COMM]LoopTask[Loop-default], get message. handle=LnnAsyncHandler,what=0,msgSize=1
[COMM]LoopTask[Loop-default], HandleMessage message. handle=LnnAsyncHandler,what=0
[LNN]OnLnnRelationChangedDelay: 3
[LNN]lnn join relaion is 1/2 for type:3
[LNN]topo item not exist
[LNN]add topo info: ***BDF425A06027D1915C3B1FCBC1410877F56677F5D9E4/***4CCD32438808B7AD331F10056BB3E347D9A2CDCC9EB8
[COMM]LoopTask[Loop-default], after HandleMessage message. handle=LnnAsyncHandler,what=0
[COMM]LoopTask[Loop-default], get message. handle=LnnAsyncHandler,what=0,msgSize=0
[COMM]LoopTask[Loop-default], HandleMessage message. handle=LnnAsyncHandler,what=0
[LNN]OnLnnRelationChangedDelay: 3
[LNN]lnn join relaion is 2/2 for type:3
[COMM]LoopTask[Loop-default], after HandleMessage message. handle=LnnAsyncHandler,what=0
[COMM]LoopTask[Loop-default] wait msg list empty
4 nStackXCoAP: CoapServiceDiscoverTimerHandle:[652] :the 6 times for device discover.
5 nStackXCoAP: ParseDeviceHashData:[224] :Cannot find device hash or invalid hash
4 nStackXCoAP: CoapServiceDiscoverTimerHandle:[652] :the 7 times for device discover.
5 nStackXCoAP: ParseDeviceHashData:[224] :Cannot find device hash or invalid hash
4 nStackXCoAP: CoapServiceDiscoverTimerHandle:[652] :the 8 times for device discover.
5 nStackXCoAP: ParseDeviceHashData:[224] :Cannot find device hash or invalid hash
4 nStackXCoAP: CoapServiceDiscoverTimerHandle:[652] :the 9 times for device discover.
5 nStackXCoAP: ParseDeviceHashData:[224] :Cannot find device hash or invalid hash
5 nStackXCoAP: ParseDeviceHashData:[224] :Cannot find device hash or invalid hash
5 nStackXCoAP: ParseServiceDiscover:[363] :new device join
4 nStackXDFinder: NotifyDeviceListChanged:[759] :notify callback: device list changed
[DISC]Server OnDeviceFound capabilityBitmap = 192
[DISC]find callback:id = 0
[DISC]find callback:id = 123
4 nStackXDFinder: NotifyDeviceListChanged:[761] :finish to notify device list changed
4 nStackXDFinder: NotifyDeviceFound:[774] :notify callback: device found callback is null
5 nStackXCoAP: CoapMessageHandler:[153] :2.01
4 nStackXCoAP: CoapServiceDiscoverTimerHandle:[652] :the 10 times for device discover.
5 nStackXCoAP: ParseDeviceHashData:[224] :Cannot find device hash or invalid hash
5 nStackXCoAP: ParseDeviceHashData:[224] :Cannot find device hash or invalid hash
5 nStackXCoAP: ParseServiceDiscover:[363] :new device join
5 nStackXCoAP: CoapMessageHandler:[153] :2.01
5 nStackXCoAP: ParseDeviceHashData:[224] :Cannot find device hash or invalid hash
5 nStackXCoAP: ParseServiceDiscover:[363] :new device join
5 nStackXCoAP: CoapMessageHandler:[153] :2.01
5 nStackXCoAP: ParseDeviceHashData:[224] :Cannot find device hash or invalid hash
5 nStackXCoAP: ParseServiceDiscover:[363] :new device join
5 nStackXCoAP: CoapMessageHandler:[153] :2.01
4 nStackXCoAP: CoapServiceDiscoverTimerHandle:[652] :the 11 times for device discover.
5 nStackXCoAP: ParseDeviceHashData:[224] :Cannot find device hash or invalid hash
5 nStackXCoAP: ParseDeviceHashData:[224] :Cannot find device hash or invalid hash
5 nStackXCoAP: ParseServiceDiscover:[363] :new device join
5 nStackXCoAP: CoapMessageHandler:[153] :2.01
4 nStackXCoAP: CoapServiceDiscoverTimerHandle:[652] :the 12 times for device discover.
5 nStackXCoAP: ParseDeviceHashData:[224] :Cannot find device hash or invalid hash
5 nStackXCoAP: ParseDeviceHashData:[224] :Cannot find device hash or invalid hash
5 nStackXCoAP: ParseServiceDiscover:[363] :new device join
5 nStackXCoAP: CoapMessageHandler:[153] :2.01
3 nStackXCoAP: CoapServiceDiscoverStop:[631] :clear device list backup
5 nStackXCoAP: ParseDeviceHashData:[224] :Cannot find device hash or invalid hash
5 nStackXCoAP: ParseServiceDiscover:[363] :new device join
5 nStackXCoAP: CoapMessageHandler:[153] :2.01
5 nStackXCoAP: ParseDeviceHashData:[224] :Cannot find device hash or invalid hash
5 nStackXCoAP: ParseServiceDiscover:[363] :new device join
5 nStackXCoAP: CoapMessageHandler:[153] :2.01
5 nStackXCoAP: ParseDeviceHashData:[224] :Cannot find device hash or invalid hash
5 nStackXCoAP: ParseServiceDiscover:[363] :new device join
5 nStackXCoAP: CoapMessageHandler:[153] :2.01
[COMM]SoftBusServerStub::OnReceived, code = 142
5 nStackXCoAP: ParseDeviceHashData:[224] :Cannot find device hash or invalid hash
5 nStackXCoAP: ParseServiceDiscover:[363] :new device join
5 nStackXCoAP: CoapMessageHandler:[153] :2.01
5 nStackXCoAP: ParseDeviceHashData:[224] :Cannot find device hash or invalid hash
5 nStackXCoAP: ParseServiceDiscover:[363] :new device join
5 nStackXCoAP: CoapMessageHandler:[153] :2.01
[COMM]SoftBusServerStub::OnReceived, code = 132
[TRAN]trans server opensession.
[TRAN]session server [session_test] is exist
[TRAN]server TransOpenChannel
[TRAN]GetAppInfo
[TRAN]TransGetUidAndPid: sessionName=session_test, uid=0, pid=20340
[TRAN]GetAppInfo ok
[LNN]PreferredLinkList num = 1.
[LNN]select lane with PreferredLinkList.
[TRAN]TransGetLaneInfo end
[TRAN]lane info: isSupportUdp=0, isProxy=0, connType=0
[TRAN]TransOpenDirectChannel
[TRAN]OpenTcpDirectChannel
[CONN]AddTrigger fd:21 success, current fdcount:2, module:5, triggerType:1
[TRAN]OpenTcpDirectChannel end: channelId=0
[TRAN]lane num is 1
[TRAN]server TransOpenChannel ok: channelId=0, channelType=0
[CONN]DelTrigger and node [fd:21] success, current fdcount:1, module:5, triggerType:1
[CONN]AddTrigger fd:21 success, current fdcount:2, module:5, triggerType:0
[TRAN]StartVerifySession
[TRAN]GetAuthSideFlag: flags=0, side=2, seq=2
[AUTH]auth get last session key succ, seq is:-1023410174
[TRAN]side=0, flag=0x0, seq=2
[TRAN]StartVerifySession ok
[CONN]DelTrigger and node [fd:21] success, current fdcount:1, module:5, triggerType:0
[AUTH]auth get session key by dev info succ, seq is:-1023410174
[TRAN]OpenDataBusReply: channelId=0
[TRAN]OpenDataBusReply ok
[TRAN]Trans Srv Recv Data ret 0. 
[CONN]close fd=21
[TRAN]TransDelSessionConnById: channelId=0
5 nStackXCoAP: ParseDeviceHashData:[224] :Cannot find device hash or invalid hash
5 nStackXCoAP: ParseServiceDiscover:[363] :new device join
5 nStackXCoAP: CoapMessageHandler:[153] :2.01
[COMM]SoftBusServerStub::OnReceived, code = 135
[TRAN]close channel: id=0, type=0
[TRAN]del trans land mgr.[chanid=0][type=0]
[COMM]SoftBusServerStub::OnReceived, code = 142
[COMM]LoopTask[Heartbeat-Looper], get message. handle=heartbeat_handler,what=7,msgSize=0
[COMM]LoopTask[Heartbeat-Looper], HandleMessage message. handle=heartbeat_handler,what=7
[LNN]LnnDumpHbMgrUpdateList count=0
[LNN]LnnDumpHbOnlineNodeList count:1 [i:1, deviceName:openEuler,deviceTypeId:0, masterWeight:490, discoveryType:2, oldTimeStamp:1695105434986]
[COMM][Heartbeat-Looper]PostMessageAtTime what =2 time=1695105449175277 us
[COMM][Heartbeat-Looper]PostMessageAtTime. insert
[COMM]DumpLooper. i=0,handler=heartbeat_handler,what =2,arg1=0 arg2=4, time=1695105449175277
[LNN]HB post delay msg, what=10 delay=15000 msec
[COMM][Heartbeat-Looper]PostMessageAtTime what =10 time=1695105464175279 us
[COMM][Heartbeat-Looper]PostMessageAtTime. insert
[COMM]DumpLooper. i=0,handler=heartbeat_handler,what =2,arg1=0 arg2=4, time=1695105449175277
[COMM]DumpLooper. i=1,handler=heartbeat_handler,what =10,arg1=0 arg2=0, time=1695105464175279
[LNN]HB post delay msg, what=7 delay=300000 msec
[COMM][Heartbeat-Looper]PostMessageAtTime what =7 time=1695105749175281 us
[COMM][Heartbeat-Looper]PostMessageAtTime. insert
[COMM]DumpLooper. i=0,handler=heartbeat_handler,what =2,arg1=0 arg2=4, time=1695105449175277
[COMM]DumpLooper. i=1,handler=heartbeat_handler,what =10,arg1=0 arg2=0, time=1695105464175279
[COMM]DumpLooper. i=2,handler=heartbeat_handler,what =7,arg1=0 arg2=0, time=1695105749175281
[LNN]heartbeat(HB) perform as master node
[LNN]HB FSM process msg(7) done, ret=2, nowstatus=2
[COMM]LoopTask[Heartbeat-Looper], after HandleMessage message. handle=heartbeat_handler,what=7
[COMM]LoopTask[Heartbeat-Looper], get message. handle=heartbeat_handler,what=2,msgSize=2
[COMM]LoopTask[Heartbeat-Looper], HandleMessage message. handle=heartbeat_handler,what=2
[LNN]ble heartbeat stub impl beat once
[COMM][Heartbeat-Looper]LooperRemoveMessage. handler=heartbeat_handler, what =10
[LNN]HB post delay msg, what=8 delay=10000 msec
[COMM][Heartbeat-Looper]PostMessageAtTime what =8 time=1695105459175310 us
[COMM][Heartbeat-Looper]PostMessageAtTime. insert
[COMM]DumpLooper. i=0,handler=heartbeat_handler,what =8,arg1=0 arg2=0, time=1695105459175310
[COMM]DumpLooper. i=1,handler=heartbeat_handler,what =7,arg1=0 arg2=0, time=1695105749175281
[LNN]HB post delay msg, what=6 delay=20000 msec
[COMM][Heartbeat-Looper]PostMessageAtTime what =6 time=1695105469175312 us
[COMM][Heartbeat-Looper]PostMessageAtTime. insert
[COMM]DumpLooper. i=0,handler=heartbeat_handler,what =8,arg1=0 arg2=0, time=1695105459175310
[COMM]DumpLooper. i=1,handler=heartbeat_handler,what =6,arg1=0 arg2=4, time=1695105469175312
[COMM]DumpLooper. i=2,handler=heartbeat_handler,what =7,arg1=0 arg2=0, time=1695105749175281
[LNN]HB FSM process msg(2) done, ret=2, nowstatus=2
[COMM]LoopTask[Heartbeat-Looper], after HandleMessage message. handle=heartbeat_handler,what=2
[COMM]SoftBusServerStub::OnReceived, code = 132
[TRAN]trans server opensession.
[TRAN]session server [session_test] is exist
[TRAN]server TransOpenChannel
[TRAN]GetAppInfo
[TRAN]TransGetUidAndPid: sessionName=session_test, uid=0, pid=20340
[TRAN]GetAppInfo ok
[LNN]PreferredLinkList num = 1.
[LNN]select lane with PreferredLinkList.
[TRAN]TransGetLaneInfo end
[TRAN]lane info: isSupportUdp=0, isProxy=1, connType=0
[TRAN]can not find proxy conn in list.
[TRAN]Connect dev reqid 5
[TRAN]conn ref = 21971
[CONN]AddTrigger fd:21 success, current fdcount:2, module:0, triggerType:1
[CONN]tcp connect add write trigger ok
[TRAN]lane num is 1
[TRAN]server TransOpenChannel ok: channelId=512, channelType=1
[CONN]recv tcp write events fd=21
[CONN]notfiy connect ok req 5
[TRAN]Connect Successe reqid 5, connectionId 65557
[TRAN]add conn ref 1
[COMM][Loop-default]PostMessageAtTime what =0 time=1695105449629331 us
[COMM][Loop-default]PostMessageAtTime. insert
[COMM]DumpLooper. i=0,handler=transProxyLoopName,what =0,arg1=0 arg2=0, time=1695105449629331
[CONN]DelTrigger and node [fd:21] success, current fdcount:1, module:0, triggerType:1
[CONN]AddTrigger fd:21 success, current fdcount:2, module:0, triggerType:0
[CONN]notfiy finish
[COMM]LoopTask[Loop-default], get message. handle=transProxyLoopName,what=0,msgSize=0
[COMM]LoopTask[Loop-default], HandleMessage message. handle=transProxyLoopName,what=0
[TRAN]trans loop process msg type 0
[TRAN]send handshake msg
[TRAN]handshake myId 512
[TRAN]mbedtls_base64_encode len 44
[AUTH]auth get session key succ, seq is:-1023410174, side is 0
[TRAN]send buf connid 65557 len 413 seq 1 pri 3
[COMM]LoopTask[Loop-default], after HandleMessage message. handle=transProxyLoopName,what=0
[COMM]LoopTask[Loop-default] wait msg list empty
[TRAN]data recv connid :65557, moduleId 13, seq : 1 len 231
[AUTH]auth get session key by dev info succ, seq is:-1023410174
[TRAN]recv ack msg
[TRAN]recv Handshake ack myid 512 peerid 512 identity 8099fa38cec242c5ec50f2412df3d80a
[TRAN]proxy channel opened: channeld=512, appType=1, isServer=0
[TRAN]proxy channel open, channelId = 512, ret = 0
[TRAN]open ret 0
[COMM]SoftBusServerStub::OnReceived, code = 136
[TRAN]send msg: id=512, type=1
[TRAN]trans proxy send packet seq 0 flag 2
[TRAN]InLen[25] seq[0] outLen[69] flags[2]
[TRAN]send syncmsg chanid[512] seq[0] dataLen[69] type[2]
[TRAN]slice: i:0
[TRAN]send buf connid 65557 len 117 seq 2 pri 0
[TRAN]data recv connid :65557, moduleId 13, seq : 2 len 72
[TRAN]no sub packets proc
[TRAN]NoSubPacketProc dataLen[32] inputLen[48]
[TRAN]ProcessData debug: len 4 

[TRAN]flags:1
[TRAN]TransProxyProcSendMsgAck. chanid 512,seq :0
[COMM]SoftBusServerStub::OnReceived, code = 135
[TRAN]close channel: id=512, type=1
[TRAN]del trans land mgr.[chanid=512][type=1]
[COMM][Loop-default]PostMessageAtTime what =5 time=1695105450513930 us
[COMM][Loop-default]PostMessageAtTime. insert
[COMM]DumpLooper. i=0,handler=transProxyLoopName,what =5,arg1=0 arg2=0, time=1695105450513930
[COMM][Loop-default]PostMessageAtTime what =1 time=1695105450513933 us
[COMM][Loop-default]PostMessageAtTime. insert
[COMM]DumpLooper. i=0,handler=transProxyLoopName,what =5,arg1=0 arg2=0, time=1695105450513930
[COMM]DumpLooper. i=1,handler=transProxyLoopName,what =1,arg1=0 arg2=65557, time=1695105450513933
[COMM]LoopTask[Loop-default], get message. handle=transProxyLoopName,what=5,msgSize=1
[COMM]LoopTask[Loop-default], HandleMessage message. handle=transProxyLoopName,what=5
[TRAN]trans loop process msg type 5
[TRAN]send reset msg myId 512 peerid 512
[AUTH]auth get session key succ, seq is:-1023410174, side is 0
[TRAN]send buf connid 65557 len 112 seq 3 pri 1
[COMM]LoopTask[Loop-default], after HandleMessage message. handle=transProxyLoopName,what=5
[COMM]LoopTask[Loop-default], get message. handle=transProxyLoopName,what=1,msgSize=0
[COMM]LoopTask[Loop-default], HandleMessage message. handle=transProxyLoopName,what=1
[TRAN]trans loop process msg type 1
[TRAN]conn ref is 0
[TRAN]disconnect device connid 65557
[CONN]DelTrigger and node [fd:21] success, current fdcount:1, module:0, triggerType:3
[CONN]shutdown fd=21
[AUTH]auth disconnect, connectionId = 65557.
[AUTH]auth already removed, connectionId = 65557.
[TRAN]connect disabled, id = 65557
[COMM]LoopTask[Loop-default], after HandleMessage message. handle=transProxyLoopName,what=1
[COMM]LoopTask[Loop-default] wait msg list empty
[COMM]LoopTask[Heartbeat-Looper], get message. handle=heartbeat_handler,what=8,msgSize=2
[COMM]LoopTask[Heartbeat-Looper], HandleMessage message. handle=heartbeat_handler,what=8
[LNN]ble heartbeat stub impl beat end
[LNN]HB FSM process msg(8) done, ret=2, nowstatus=2
[COMM]LoopTask[Heartbeat-Looper], after HandleMessage message. handle=heartbeat_handler,what=8
[COMM]SoftBusServerStub::OnReceived, code = 142
[COMM]SoftBusServerStub::OnReceived, code = 132
[TRAN]trans server opensession.
[TRAN]session server [session_test] is exist
[TRAN]server TransOpenChannel
[TRAN]GetAppInfo
[TRAN]TransGetUidAndPid: sessionName=session_test, uid=0, pid=20340
[TRAN]GetAppInfo ok
[LNN]PreferredLinkList num = 1.
[LNN]select lane with PreferredLinkList.
[TRAN]TransGetLaneInfo end
[TRAN]lane info: isSupportUdp=1, isProxy=0, connType=0
[TRAN]server trans open udp channel.
[TRAN]add udp channel success.[channelId = 0].
[TRAN]OpenAuthConnForUdpNegotiation
[AUTH]select wifi auth.
[AUTH]open wifi conn succ, authId = 2923849318402.
[TRAN]UdpOnAuthConnOpened: requestId=7, authId=2923849318402
[TRAN]start exchange udp info: channelId=0, authId=2923849318402
[TRAN]pack request udp info in negotiation.
[AUTH]auth get session key by seq -1023410174
[AUTH]auth get session key by seq seccessfully.
[AUTH]auth start post eth data, authId is 2923849318402, moduleId is 17, len is 361
[TRAN]UdpOnAuthConnOpened end
[TRAN]UdpOpenAuthConn ok: requestId=7
[TRAN]OpenAuthConnForUdpNegotiation end
[TRAN]lane num is 1
[TRAN]server TransOpenChannel ok: channelId=0, channelType=2
[TRAN]open udp channel time out, notify open failed.
[TRAN]notify udp channel open failed.
[TRAN]del trans land mgr.[chanid=0][type=2]
[TRAN]trasn server on channel open failed.[pkgname=softbus_sample][channid=0][type=2]
[COMM]LoopTask[Heartbeat-Looper], get message. handle=heartbeat_handler,what=6,msgSize=1
[COMM]LoopTask[Heartbeat-Looper], HandleMessage message. handle=heartbeat_handler,what=6
[LNN]HB FSM process msg(6) done, ret=2, nowstatus=2
[COMM]LoopTask[Heartbeat-Looper], after HandleMessage message. handle=heartbeat_handler,what=6
[COMM]SoftBusServerStub::OnReceived, code = 139
[COMM]StopDiscoveryInner softbus_sample, 123!

[DISC]unregister input bitmap = [128].
[DISC]register all cap bitmap = [64].
4 nStackXDFinder: NSTACKX_SetFilterCapability:[514] :Set Filter Capability
[DISC]coap stop active discovery.
[DISC]ServerStopDiscovery success!
[COMM]SoftBusServerStub::OnReceived, code = 129
[DISC]unregister input bitmap = [128].
[DISC]register all cap bitmap = [64].
4 nStackXDFinder: NSTACKX_RegisterCapability:[508] :Register Capability
[DISC]coap stop passive publish.
[DISC]ServerUnPublishService success!
[COMM]SoftBusServerStub::OnReceived, code = 131
[TRAN]destroy session server [session_test]
[COMM]client service softbus_sample died, remove it from softbus server
[TRAN]TransTdcDeathCallback: pk