I0305 04:07:50.566] [2018-03-05 04:07:45.938][11377][debug][main] external/envoy/source/server/server.cc:136] flushing stats
I0305 04:07:50.566] SIGQUIT: quit
I0305 04:07:50.566] PC=0x45cf91 m=0 sigcode=0
I0305 04:07:50.566] 
I0305 04:07:50.566] goroutine 0 [idle]:
I0305 04:07:50.566] runtime.futex(0xdc5fc8, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x7ffd472a27e0, 0x410dfb, ...)
I0305 04:07:50.567] 	/usr/local/go/src/runtime/sys_linux_amd64.s:526 +0x21
I0305 04:07:50.567] runtime.futexsleep(0xdc5fc8, 0x0, 0xffffffffffffffff)
I0305 04:07:50.567] 	/usr/local/go/src/runtime/os_linux.go:45 +0x4b
I0305 04:07:50.567] runtime.notesleep(0xdc5fc8)
I0305 04:07:50.567] 	/usr/local/go/src/runtime/lock_futex.go:151 +0x9b
I0305 04:07:50.567] runtime.stopm()
I0305 04:07:50.567] 	/usr/local/go/src/runtime/proc.go:1947 +0xe5
I0305 04:07:50.567] runtime.findrunnable(0xc420036000, 0x0)
I0305 04:07:50.567] 	/usr/local/go/src/runtime/proc.go:2410 +0x50c
I0305 04:07:50.567] runtime.schedule()
I0305 04:07:50.567] 	/usr/local/go/src/runtime/proc.go:2536 +0x13b
I0305 04:07:50.567] runtime.goexit0(0xc420085c80)
I0305 04:07:50.567] 	/usr/local/go/src/runtime/proc.go:2708 +0x251
I0305 04:07:50.568] runtime.mcall(0x0)
I0305 04:07:50.568] 	/usr/local/go/src/runtime/asm_amd64.s:351 +0x5b
I0305 04:07:50.568] 
I0305 04:07:50.568] goroutine 1 [chan receive]:
I0305 04:07:50.568] testing.(*T).Run(0xc4201c01e0, 0xa617aa, 0x22, 0xa7c000, 0x47e006)
I0305 04:07:50.568] 	/usr/local/go/src/testing/testing.go:825 +0x301
I0305 04:07:50.568] testing.runTests.func1(0xc4201c00f0)
I0305 04:07:50.568] 	/usr/local/go/src/testing/testing.go:1063 +0x64
I0305 04:07:50.568] testing.tRunner(0xc4201c00f0, 0xc42006bdf8)
I0305 04:07:50.568] 	/usr/local/go/src/testing/testing.go:777 +0xd0
I0305 04:07:50.568] testing.runTests(0xc42019e620, 0xdb1d10, 0x1, 0x1, 0x411e19)
I0305 04:07:50.568] 	/usr/local/go/src/testing/testing.go:1061 +0x2c4
I0305 04:07:50.568] testing.(*M).Run(0xc4201c2080, 0x0)
I0305 04:07:50.568] 	/usr/local/go/src/testing/testing.go:978 +0x171
I0305 04:07:50.569] main.main()
I0305 04:07:50.569] 	_testmain.go:42 +0x151
I0305 04:07:50.569] 
I0305 04:07:50.569] goroutine 19 [chan receive]:
I0305 04:07:50.569] istio.io/istio/mixer/test/client/env.(*TestSetup).VerifyReport(0xc4200aca00, 0xa521c4, 0xb, 0xa7372c, 0x1c3)
I0305 04:07:50.569] 	/home/bootstrap/go/src/istio.io/istio/mixer/test/client/env/setup.go:183 +0x5f
I0305 04:07:50.569] istio.io/istio/mixer/test/client/tcp_filter_periodical_report.TestTCPMixerFilterPeriodicalReport(0xc4201c01e0)
I0305 04:07:50.569] 	/home/bootstrap/go/src/istio.io/istio/mixer/test/client/tcp_filter_periodical_report/tcp_filter_periodical_report_test.go:98 +0x3dd
I0305 04:07:50.569] testing.tRunner(0xc4201c01e0, 0xa7c000)
I0305 04:07:50.569] 	/usr/local/go/src/testing/testing.go:777 +0xd0
I0305 04:07:50.569] created by testing.(*T).Run
I0305 04:07:50.569] 	/usr/local/go/src/testing/testing.go:824 +0x2e0
I0305 04:07:50.570] 
I0305 04:07:50.570] goroutine 38 [IO wait]:
I0305 04:07:50.570] internal/poll.runtime_pollWait(0x7f6f27d33c90, 0x72, 0x0)
I0305 04:07:50.570] 	/usr/local/go/src/runtime/netpoll.go:173 +0x57
I0305 04:07:50.570] internal/poll.(*pollDesc).wait(0xc4201c3798, 0x72, 0xc4200ad100, 0x0, 0x0)
I0305 04:07:50.570] 	/usr/local/go/src/internal/poll/fd_poll_runtime.go:85 +0x9b
I0305 04:07:50.570] internal/poll.(*pollDesc).waitRead(0xc4201c3798, 0xffffffffffffff00, 0x0, 0x0)
I0305 04:07:50.570] 	/usr/local/go/src/internal/poll/fd_poll_runtime.go:90 +0x3d
I0305 04:07:50.570] internal/poll.(*FD).Accept(0xc4201c3780, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0)
I0305 04:07:50.570] 	/usr/local/go/src/internal/poll/fd_unix.go:372 +0x1a8
I0305 04:07:50.570] net.(*netFD).accept(0xc4201c3780, 0xc400000008, 0xef925c504fcac0e8, 0x9)
I0305 04:07:50.570] 	/usr/local/go/src/net/fd_unix.go:238 +0x42
I0305 04:07:50.571] net.(*TCPListener).accept(0xc4200a8298, 0x42b4c9, 0xc4200abfc0, 0xc420046668)
I0305 04:07:50.571] 	/usr/local/go/src/net/tcpsock_posix.go:136 +0x2e
I0305 04:07:50.571] net.(*TCPListener).Accept(0xc4200a8298, 0xa7cbd0, 0xc4200db340, 0xac73e0, 0xc4200a8298)
I0305 04:07:50.571] 	/usr/local/go/src/net/tcpsock.go:259 +0x49
I0305 04:07:50.571] istio.io/istio/vendor/google.golang.org/grpc.(*Server).Serve(0xc4200db340, 0xac73e0, 0xc4200a8298, 0x0, 0x0)
I0305 04:07:50.571] 	/home/bootstrap/go/src/istio.io/istio/vendor/google.golang.org/grpc/server.go:503 +0x1d5
I0305 04:07:50.571] istio.io/istio/mixer/test/client/env.(*MixerServer).Start.func1(0xc4201c6360)
I0305 04:07:50.571] 	/home/bootstrap/go/src/istio.io/istio/mixer/test/client/env/mixer_server.go:143 +0x45
I0305 04:07:50.571] created by istio.io/istio/mixer/test/client/env.(*MixerServer).Start
I0305 04:07:50.571] 	/home/bootstrap/go/src/istio.io/istio/mixer/test/client/env/mixer_server.go:142 +0x3f
I0305 04:07:50.571] 
I0305 04:07:50.571] goroutine 39 [IO wait]:
I0305 04:07:50.572] internal/poll.runtime_pollWait(0x7f6f27d33bc0, 0x72, 0x0)
I0305 04:07:50.572] 	/usr/local/go/src/runtime/netpoll.go:173 +0x57
I0305 04:07:50.572] internal/poll.(*pollDesc).wait(0xc4201c3818, 0x72, 0xc4200ad200, 0x0, 0x0)
I0305 04:07:50.572] 	/usr/local/go/src/internal/poll/fd_poll_runtime.go:85 +0x9b
I0305 04:07:50.572] internal/poll.(*pollDesc).waitRead(0xc4201c3818, 0xffffffffffffff00, 0x0, 0x0)
I0305 04:07:50.572] 	/usr/local/go/src/internal/poll/fd_poll_runtime.go:90 +0x3d
I0305 04:07:50.572] internal/poll.(*FD).Accept(0xc4201c3800, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0)
I0305 04:07:50.572] 	/usr/local/go/src/internal/poll/fd_unix.go:372 +0x1a8
I0305 04:07:50.572] net.(*netFD).accept(0xc4201c3800, 0x4019c7, 0xc420103b60, 0x983060)
I0305 04:07:50.572] 	/usr/local/go/src/net/fd_unix.go:238 +0x42
I0305 04:07:50.572] net.(*TCPListener).accept(0xc4200a82a0, 0x458450, 0xc420268eb0, 0xc420268eb8)
I0305 04:07:50.572] 	/usr/local/go/src/net/tcpsock_posix.go:136 +0x2e
I0305 04:07:50.573] net.(*TCPListener).Accept(0xc4200a82a0, 0xa7d000, 0xc420103ae0, 0xac8ba0, 0xc4202252f0)
I0305 04:07:50.573] 	/usr/local/go/src/net/tcpsock.go:259 +0x49
I0305 04:07:50.573] net/http.(*Server).Serve(0xc4201c9110, 0xac73e0, 0xc4200a82a0, 0x0, 0x0)
I0305 04:07:50.573] 	/usr/local/go/src/net/http/server.go:2770 +0x1a5
I0305 04:07:50.573] net/http.Serve(0xac73e0, 0xc4200a82a0, 0x0, 0x0, 0x0, 0x45b9f1)
I0305 04:07:50.573] 	/usr/local/go/src/net/http/server.go:2389 +0x73
I0305 04:07:50.573] istio.io/istio/mixer/test/client/env.(*HTTPServer).Start.func1(0xc42019f680)
I0305 04:07:50.573] 	/home/bootstrap/go/src/istio.io/istio/mixer/test/client/env/http_server.go:135 +0x8e
I0305 04:07:50.573] created by istio.io/istio/mixer/test/client/env.(*HTTPServer).Start
I0305 04:07:50.573] 	/home/bootstrap/go/src/istio.io/istio/mixer/test/client/env/http_server.go:132 +0x43
I0305 04:07:50.573] 
I0305 04:07:50.573] rax    0xca
I0305 04:07:50.574] rbx    0xdc5e80
I0305 04:07:50.574] rcx    0x45cf93
I0305 04:07:50.574] rdx    0x0
I0305 04:07:50.574] rdi    0xdc5fc8
I0305 04:07:50.574] rsi    0x0
I0305 04:07:50.574] rbp    0x7ffd472a27a8
I0305 04:07:50.574] rsp    0x7ffd472a2760
I0305 04:07:50.574] r8     0x0
I0305 04:07:50.574] r9     0x0
I0305 04:07:50.574] r10    0x0
I0305 04:07:50.574] r11    0x286
I0305 04:07:50.574] r12    0xc4200b79b8
I0305 04:07:50.574] r13    0x5
I0305 04:07:50.574] r14    0x4
I0305 04:07:50.574] r15    0x33
I0305 04:07:50.574] rip    0x45cf91
I0305 04:07:50.574] rflags 0x286
I0305 04:07:50.575] cs     0x33
I0305 04:07:50.575] fs     0x0
I0305 04:07:50.575] gs     0x0
I0305 04:07:50.575] [2018-03-05 04:07:50.415][11377][warning][main] external/envoy/source/server/server.cc:318] caught SIGTERM
I0305 04:07:50.575] [2018-03-05 04:07:50.416][11377][info][main] external/envoy/source/server/server.cc:363] main dispatch loop exited
I0305 04:07:50.575] [2018-03-05 04:07:50.416][11397][debug][main] external/envoy/source/server/worker_impl.cc:95] worker exited dispatch loop
I0305 04:07:50.575] [2018-03-05 04:07:50.416][11397][debug][connection] external/envoy/source/common/network/connection_impl.cc:99] [C3] closing data_to_write=0 type=1
I0305 04:07:50.575] [2018-03-05 04:07:50.416][11397][debug][connection] external/envoy/source/common/network/connection_impl.cc:134] [C3] closing socket: 1
I0305 04:07:50.575] [2018-03-05 04:07:50.416][11397][debug][main] external/envoy/source/server/connection_handler_impl.cc:54] [C3] adding to cleanup list
I0305 04:07:50.575] [2018-03-05 04:07:50.416][11397][debug][connection] external/envoy/source/common/network/connection_impl.cc:99] [C2] closing data_to_write=0 type=1
I0305 04:07:50.576] [2018-03-05 04:07:50.416][11397][debug][connection] external/envoy/source/common/network/connection_impl.cc:134] [C2] closing socket: 1
I0305 04:07:50.576] [2018-03-05 04:07:50.416][11397][debug][main] external/envoy/source/server/connection_handler_impl.cc:54] [C2] adding to cleanup list
I0305 04:07:50.576] [2018-03-05 04:07:50.416][11397][debug][grpc] external/envoy/source/common/grpc/google_async_client_impl.cc:24] Joining completionThread
I0305 04:07:50.576] [2018-03-05 04:07:50.416][11398][debug][grpc] external/envoy/source/common/grpc/google_async_client_impl.cc:56] completionThread exiting
I0305 04:07:50.576] [2018-03-05 04:07:50.416][11397][debug][grpc] external/envoy/source/common/grpc/google_async_client_impl.cc:26] Joined completionThread
I0305 04:07:50.576] [2018-03-05 04:07:50.416][11397][debug][upstream] external/envoy/source/common/upstream/cluster_manager_impl.cc:587] shutting down thread local cluster manager
I0305 04:07:50.576] [2018-03-05 04:07:50.416][11377][debug][main] external/envoy/source/server/server.cc:136] flushing stats
I0305 04:07:50.576] [2018-03-05 04:07:50.417][11380][debug][grpc] external/envoy/source/common/grpc/google_async_client_impl.cc:56] completionThread exiting
I0305 04:07:50.577] [2018-03-05 04:07:50.417][11377][debug][grpc] external/envoy/source/common/grpc/google_async_client_impl.cc:24] Joining completionThread
I0305 04:07:50.577] [2018-03-05 04:07:50.417][11377][debug][grpc] external/envoy/source/common/grpc/google_async_client_impl.cc:26] Joined completionThread
I0305 04:07:50.577] [2018-03-05 04:07:50.417][11377][debug][upstream] external/envoy/source/common/upstream/cluster_manager_impl.cc:587] shutting down thread local cluster manager
I0305 04:07:50.577] [2018-03-05 04:07:50.418][11377][info][main] external/envoy/source/server/server.cc:384] exiting
I0305 04:07:50.577] *** Test killed with quit: ran too long (10m0s).
I0305 04:07:50.577] FAIL	istio.io/istio/mixer/test/client/tcp_filter_periodical_report	600.097s