package testing import ( "cwtch.im/cwtch/event" "cwtch.im/cwtch/model" "cwtch.im/cwtch/peer" "cwtch.im/cwtch/protocol/connections" cwtchserver "cwtch.im/cwtch/server" "fmt" "git.openprivacy.ca/openprivacy/libricochet-go/connectivity" "git.openprivacy.ca/openprivacy/libricochet-go/log" "golang.org/x/net/proxy" "os" "runtime" "runtime/pprof" "testing" "time" ) const ( serverKeyfile = "./../server/app/private_key" localKeyfile = "./private_key" ) var ( aliceLines = []string{"Hello, I'm Alice", "bye"} bobLines = []string{"Hi, my name is Bob.", "toodles", "welcome"} carolLines = []string{"Howdy, thanks!"} ) func printAndCountVerifedTimeline(t *testing.T, timeline []model.Message) int { numVerified := 0 for _, message := range timeline { fmt.Printf("%v %v> %s\n", message.Timestamp, message.PeerID, message.Message) numVerified++ } return numVerified } func serverCheck(t *testing.T, serverAddr string) bool { torDialer, err := proxy.SOCKS5("tcp", "127.0.0.1:9050", nil, proxy.Direct) if err != nil { t.Logf("Could not get SOCKS5 proxy: %v", err) return false } // Doesn't seem to be a way to turn the default timeout of 2 minutes down conn, err := torDialer.Dial("tcp", serverAddr+".onion:9878") if err != nil { t.Logf("Could not dial %v: %v", serverAddr, err) return false } conn.Close() return true } func waitForPeerServerConnection(t *testing.T, peer peer.CwtchPeer, server string) { for { servers := peer.GetServers() state, ok := servers[server] if ok { if state == connections.FAILED { t.Fatalf("%v could not connect to %v", peer.GetProfile().Onion, server) } if state != connections.AUTHENTICATED { fmt.Printf("peer %v waiting connect to server %v, currently: %v\n", peer.GetProfile().Onion, server, connections.ConnectionStateName[state]) time.Sleep(time.Second * 5) continue } else { break } } // It might take a second for the server to show up as it is now going through the event bus time.Sleep(time.Second) } return } func waitForPeerPeerConnection(t *testing.T, peera peer.CwtchPeer, peerb peer.CwtchPeer) { for { peers := peera.GetPeers() state, ok := peers[peerb.GetProfile().Onion] if ok { if state == connections.FAILED { t.Fatalf("%v could not connect to %v", peera.GetProfile().Onion, peerb.GetProfile().Onion) } if state != connections.AUTHENTICATED { fmt.Printf("peer% v waiting connect to peer %v, currently: %v\n", peera.GetProfile().Onion, peerb.GetProfile().Onion, connections.ConnectionStateName[state]) time.Sleep(time.Second * 5) continue } else { break } } // It might take a second for the peer to show up as it is now going through the event bus time.Sleep(time.Second) } return } func TestCwtchPeerIntegration(t *testing.T) { // Hide logging "noise" numGoRoutinesStart := runtime.NumGoroutine() log.AddEverythingFromPattern("connectivity") acn, err := connectivity.StartTor(".", "") if err != nil { t.Fatalf("Could not start Tor: %v", err) } // ***** Cwtch Server management ***** var server *cwtchserver.Server serverOnline := false var serverAddr string if !serverOnline { // launch app with new key fmt.Println("No server found!") server = new(cwtchserver.Server) fmt.Println("Starting cwtch server...") os.Remove("server-test.json") config := cwtchserver.LoadConfig(".", "server-test.json") identity := config.Identity() serverAddr = identity.Hostname() go server.Run(acn, config) // let tor get established fmt.Printf("Establishing Tor hidden service: %v...\n", serverAddr) } else { fmt.Printf("Found existing cwtch server %v, using for tests...\n", serverAddr) } numGoRoutinesPostServer := runtime.NumGoroutine() // ***** cwtchPeer setup ***** // It's important that each Peer have their own EventBus aliceEventBus := new(event.Manager) aliceEventBus.Initialize() bobEventBus := new(event.Manager) bobEventBus.Initialize() carolEventBus := new(event.Manager) carolEventBus.Initialize() fmt.Println("Creating Alice...") alice := peer.NewCwtchPeer("Alice") alice.Init(acn, aliceEventBus) alice.Listen() fmt.Println("Alice created:", alice.GetProfile().Onion) fmt.Println("Creating Bob...") bob := peer.NewCwtchPeer("Bob") bob.Init(acn, bobEventBus) bob.Listen() fmt.Println("Bob created:", bob.GetProfile().Onion) fmt.Println("Creating Carol...") carol := peer.NewCwtchPeer("Carol") carol.Init(acn, carolEventBus) carol.Listen() fmt.Println("Carol created:", carol.GetProfile().Onion) fmt.Println("Waiting for Alice, Bob, and Carol to connection with onion network...") time.Sleep(time.Second * 90) numGoRoutinesPostPeerStart := runtime.NumGoroutine() // ***** Peering, server joining, group creation / invite ***** fmt.Println("Creating group on ", serverAddr, "...") groupID, _, err := alice.StartGroup(serverAddr) fmt.Printf("Created group: %v!\n", groupID) if err != nil { t.Errorf("Failed to init group: %v", err) return } fmt.Println("Alice peering with Bob...") alice.PeerWithOnion(bob.GetProfile().Onion) fmt.Println("Alice peering with Carol...") alice.PeerWithOnion(carol.GetProfile().Onion) fmt.Println("Alice joining server...") alice.JoinServer(serverAddr) fmt.Println("Bob joining server...") bob.JoinServer(serverAddr) fmt.Println("Waiting for alice to join server...") waitForPeerServerConnection(t, alice, serverAddr) fmt.Println("Waiting for bob to join server...") waitForPeerServerConnection(t, bob, serverAddr) fmt.Println("Waiting for alice and Bob to peer...") waitForPeerPeerConnection(t, alice, bob) /*fmt.Println("Waiting for peerings and server joins...") time.Sleep(time.Second * 240)*/ fmt.Println("Alice inviting Bob to group...") err = alice.InviteOnionToGroup(bob.GetProfile().Onion, groupID) if err != nil { t.Fatalf("Error for Alice inviting Bob to group: %v", err) } time.Sleep(time.Second * 10) fmt.Println("Bob examining groups and accepting invites...") for _, groupID := range bob.GetGroups() { group := bob.GetGroup(groupID) fmt.Printf("Bob group: %v (Accepted: %v)\n", group.GroupID, group.Accepted) if group.Accepted == false { fmt.Printf("Bob received and accepting group invite: %v\n", group.GroupID) bob.AcceptInvite(group.GroupID) } } time.Sleep(time.Second * 5) numGoRoutinesPostServerConnect := runtime.NumGoroutine() // ***** Fill up message history of server ****** /* // filler group will be used to fill up the servers message history a bit to stress test fetch later for carol fillerGroupId, _, err := alice.Profile.StartGroup(serverAddr) if err != nil { t.Errorf("Failed to init filler group: %v", err) return } fmt.Println("Alice filling message history of server...") for i := 0; i < 100; i++ { go func (x int) { time.Sleep(time.Second * time.Duration(x)) err := alice.SendMessageToGroup(fillerGroupId, aliceLines[0]) if err != nil { fmt.Println("SEND", x, "ERROR:", err) } else { fmt.Println("SEND", x, " SUCCESS!") } }(i) } time.Sleep(time.Second * 110) */ // Wait for them to join the server waitForPeerServerConnection(t, alice, serverAddr) waitForPeerServerConnection(t, bob, serverAddr) //numGouRoutinesPostServerConnect := runtime.NumGoroutine() // ***** Conversation ***** fmt.Println("Starting conversation in group...") // Conversation fmt.Println("Alice> ", aliceLines[0]) err = alice.SendMessageToGroup(groupID, aliceLines[0]) if err != nil { t.Fatalf("Alice failed to send a message to the group: %v", err) } time.Sleep(time.Second * 10) fmt.Println("Bob> ", bobLines[0]) err = bob.SendMessageToGroup(groupID, bobLines[0]) if err != nil { t.Fatalf("Bob failed to send a message to the group: %v", err) } time.Sleep(time.Second * 10) fmt.Println("Alice> ", aliceLines[1]) alice.SendMessageToGroup(groupID, aliceLines[1]) time.Sleep(time.Second * 10) fmt.Println("Bob> ", bobLines[1]) bob.SendMessageToGroup(groupID, bobLines[1]) time.Sleep(time.Second * 10) fmt.Println("Alice inviting Carol to group...") err = alice.InviteOnionToGroup(carol.GetProfile().Onion, groupID) if err != nil { t.Fatalf("Error for Alice inviting Carol to group: %v", err) } time.Sleep(time.Second * 10) fmt.Println("Carol examining groups and accepting invites...") for _, groupID := range carol.GetGroups() { group := carol.GetGroup(groupID) fmt.Printf("Carol group: %v (Accepted: %v)\n", group.GroupID, group.Accepted) if group.Accepted == false { fmt.Printf("Carol received and accepting group invite: %v\n", group.GroupID) carol.AcceptInvite(group.GroupID) } } fmt.Println("Shutting down Alice...") alice.Shutdown() aliceEventBus.Shutdown() time.Sleep(time.Second * 5) numGoRoutinesPostAlice := runtime.NumGoroutine() fmt.Println("Carol joining server...") carol.JoinServer(serverAddr) waitForPeerServerConnection(t, carol, serverAddr) numGoRotinesPostCarolConnect := runtime.NumGoroutine() fmt.Println("Bob> ", bobLines[2]) bob.SendMessageToGroup(groupID, bobLines[2]) time.Sleep(time.Second * 10) fmt.Println("Carol> ", carolLines[0]) carol.SendMessageToGroup(groupID, carolLines[0]) time.Sleep(time.Second * 10) // ***** Verify Test ***** fmt.Println("Final syncing time...") time.Sleep(time.Second * 30) alicesGroup := alice.GetGroup(groupID) if alicesGroup == nil { t.Error("aliceGroup == nil") return } fmt.Printf("Alice's TimeLine:\n") aliceVerified := printAndCountVerifedTimeline(t, alicesGroup.GetTimeline()) if aliceVerified != 4 { t.Errorf("Alice did not have 4 verified messages") } bobsGroup := bob.GetGroup(groupID) if bobsGroup == nil { t.Error("bobGroup == nil") return } fmt.Printf("Bob's TimeLine:\n") bobVerified := printAndCountVerifedTimeline(t, bobsGroup.GetTimeline()) if bobVerified != 6 { t.Errorf("Bob did not have 5 verified messages") } carolsGroup := carol.GetGroup(groupID) fmt.Printf("Carol's TimeLine:\n") carolVerified := printAndCountVerifedTimeline(t, carolsGroup.GetTimeline()) if carolVerified != 6 { t.Errorf("Carol did not have 3 verified messages") } if len(alicesGroup.GetTimeline()) != 4 { t.Errorf("Alice's timeline does not have all messages") } else { // check message 0,1,2,3 aliceGroupTimeline := alicesGroup.GetTimeline() if aliceGroupTimeline[0].Message != aliceLines[0] || aliceGroupTimeline[1].Message != bobLines[0] || aliceGroupTimeline[2].Message != aliceLines[1] || aliceGroupTimeline[3].Message != bobLines[1] { t.Errorf("Some of Alice's timeline messages did not have the expected content!") } } if len(bobsGroup.GetTimeline()) != 6 { t.Errorf("Bob's timeline does not have all messages") } else { // check message 0,1,2,3,4,5 bobGroupTimeline := bobsGroup.GetTimeline() if bobGroupTimeline[0].Message != aliceLines[0] || bobGroupTimeline[1].Message != bobLines[0] || bobGroupTimeline[2].Message != aliceLines[1] || bobGroupTimeline[3].Message != bobLines[1] || bobGroupTimeline[4].Message != bobLines[2] || bobGroupTimeline[5].Message != carolLines[0] { t.Errorf("Some of Bob's timeline messages did not have the expected content!") } } if len(carolsGroup.GetTimeline()) != 6 { t.Errorf("Carol's timeline does not have all messages") } else { // check message 0,1,2,3,4,5 carolGroupTimeline := carolsGroup.GetTimeline() if carolGroupTimeline[0].Message != aliceLines[0] || carolGroupTimeline[1].Message != bobLines[0] || carolGroupTimeline[2].Message != aliceLines[1] || carolGroupTimeline[3].Message != bobLines[1] || carolGroupTimeline[4].Message != bobLines[2] || carolGroupTimeline[5].Message != carolLines[0] { t.Errorf("Some of Carol's timeline messages did not have the expected content!") } } fmt.Println("Shutting down Bob...") bob.Shutdown() bobEventBus.Shutdown() time.Sleep(time.Second * 3) numGoRoutinesPostBob := runtime.NumGoroutine() if server != nil { fmt.Println("Shutting down server...") server.Shutdown() time.Sleep(time.Second * 3) } numGoRoutinesPostServerShutdown := runtime.NumGoroutine() fmt.Println("Shutting down Carol...") carol.Shutdown() carolEventBus.Shutdown() time.Sleep(time.Second * 3) numGoRoutinesPostCarol := runtime.NumGoroutine() fmt.Println("Shutting down ACN...") acn.Close() time.Sleep(time.Second * 2) // Server ^^ has a 5 second loop attempting reconnect before exiting numGoRoutinesPostACN := runtime.NumGoroutine() // Printing out the current goroutines // Very useful if we are leaking any. pprof.Lookup("goroutine").WriteTo(os.Stdout, 1) fmt.Printf("numGoRoutinesStart: %v\nnumGoRoutinesPostServer: %v\nnumGoRoutinesPostPeerStart: %v\nnumGoRoutinesPostPeerAndServerConnect: %v\n"+ "numGoRoutinesPostAlice: %v\nnumGoRotinesPostCarolConnect: %v\nnumGoRoutinesPostBob: %v\nnumGoRoutinesPostServerShutdown: %v\nnumGoRoutinesPostCarol: %v\nnumGoRoutinesPostACN: %v\n", numGoRoutinesStart, numGoRoutinesPostServer, numGoRoutinesPostPeerStart, numGoRoutinesPostServerConnect, numGoRoutinesPostAlice, numGoRotinesPostCarolConnect, numGoRoutinesPostBob, numGoRoutinesPostServerShutdown, numGoRoutinesPostCarol, numGoRoutinesPostACN) if numGoRoutinesStart != numGoRoutinesPostACN { t.Errorf("Number of GoRoutines at start (%v) does not match number of goRoutines after cleanup of peers and servers (%v), clean up failed, leak detected!", numGoRoutinesStart, numGoRoutinesPostACN) } }