Skip to content

TestNewReadLogsCommandFileLogStreamProviderCorrect fails on Windows CI

TestNewReadLogsCommandFileLogStreamProviderCorrect times out after 10 minutes on Windows CI.

See build log at https://gitlab.com/gitlab-org/gitlab-runner/-/jobs/595057129#L1556
 === RUN   TestNewReadLogsCommandFileLogStreamProviderCorrect
 panic: test timed out after 10m0s
 goroutine 316 [running]:
 testing.(*M).startAlarm.func1()
 	C:/Go/src/testing/testing.go:1377 +0xe6
 created by time.goFunc
 	C:/Go/src/time/sleep.go:168 +0x4b
 goroutine 1 [chan receive, 7 minutes]:
 testing.(*T).Run(0xc000376c00, 0xe7ad05, 0x32, 0xeb4ad8, 0x49e901)
 	C:/Go/src/testing/testing.go:961 +0x37e
 testing.runTests.func1(0xc000376300)
 	C:/Go/src/testing/testing.go:1202 +0x7f
 testing.tRunner(0xc000376300, 0xc000235dc0)
 	C:/Go/src/testing/testing.go:909 +0xd0
 testing.runTests(0xc000005080, 0x1584aa0, 0x36, 0x36, 0x0)
 	C:/Go/src/testing/testing.go:1200 +0x2ae
 testing.(*M).Run(0xc000357700, 0x0)
 	C:/Go/src/testing/testing.go:1117 +0x17d
 main.main()
 	_testmain.go:150 +0x13c
 goroutine 19 [chan receive]:
 k8s.io/klog.(*loggingT).flushDaemon(0x158df00)
 	C:/GitLab-Runner/builds/gitlab-org/gitlab-runner/.gopath/pkg/mod/k8s.io/klog@v1.0.0/klog.go:1010 +0x92
 created by k8s.io/klog.init.0
 	C:/GitLab-Runner/builds/gitlab-org/gitlab-runner/.gopath/pkg/mod/k8s.io/klog@v1.0.0/klog.go:411 +0xdd
 goroutine 7 [syscall, 7 minutes]:
 os/signal.signal_recv(0x0)
 	C:/Go/src/runtime/sigqueue.go:147 +0xa3
 os/signal.loop()
 	C:/Go/src/os/signal/signal_unix.go:23 +0x29
 created by os/signal.init.0
 	C:/Go/src/os/signal/signal_unix.go:29 +0x48
 goroutine 34 [sleep]:
 runtime.goparkunlock(...)
 	C:/Go/src/runtime/proc.go:310
 time.Sleep(0x1dcd6500)
 	C:/Go/src/runtime/time.go:105 +0x16c
 gitlab.com/gitlab-org/gitlab-runner/commands/helpers.(*ReadLogsCommand).readLogs(0xc000371f18, 0x0, 0x0)
 	C:/GitLab-Runner/builds/gitlab-org/gitlab-runner/.gopath/src/gitlab.com/gitlab-org/gitlab-runner/commands/helpers/read_logs.go:158 +0x30c
 gitlab.com/gitlab-org/gitlab-runner/commands/helpers.(*ReadLogsCommand).execute(...)
 	C:/GitLab-Runner/builds/gitlab-org/gitlab-runner/.gopath/src/gitlab.com/gitlab-org/gitlab-runner/commands/helpers/read_logs.go:127
 gitlab.com/gitlab-org/gitlab-runner/commands/helpers.TestNewReadLogsCommandFileLogStreamProviderCorrect(0xc000376c00)
 	C:/GitLab-Runner/builds/gitlab-org/gitlab-runner/.gopath/src/gitlab.com/gitlab-org/gitlab-runner/commands/helpers/read_logs_test.go:70 +0x1c5
 testing.tRunner(0xc000376c00, 0xeb4ad8)
 	C:/Go/src/testing/testing.go:909 +0xd0
 created by testing.(*T).Run
 	C:/Go/src/testing/testing.go:960 +0x357
 goroutine 11 [IO wait]:
 internal/poll.runtime_pollWait(0x17d16d0, 0x77, 0xf8d340)
 	C:/Go/src/runtime/netpoll.go:184 +0x5c
 internal/poll.(*pollDesc).wait(0xc00013f5c8, 0x77, 0xc00019e200, 0x0, 0x0)
 	C:/Go/src/internal/poll/fd_poll_runtime.go:87 +0x4c
 internal/poll.(*ioSrv).ExecIO(0x15897e8, 0xc00013f4f0, 0xeb4d28, 0x20, 0xc0000b0c00, 0x6c2113)
 	C:/Go/src/internal/poll/fd_windows.go:228 +0x121
 internal/poll.(*FD).ConnectEx(0xc00013f400, 0xf8c700, 0xc0003cc420, 0xc000080100, 0xc00013f400)
 	C:/Go/src/internal/poll/fd_windows.go:886 +0x76
 net.(*netFD).connect(0xc00013f400, 0xfa7a40, 0xc000080100, 0x0, 0x0, 0xf8c700, 0xc0003cc420, 0x0, 0x0, 0x0, ...)
 	C:/Go/src/net/fd_windows.go:117 +0x1fe
 net.(*netFD).dial(0xc00013f400, 0xfa7a40, 0xc000080100, 0xfad9a0, 0x0, 0xfad9a0, 0xc000086930, 0x0, 0xc00019e201, 0xc0000a1898)
 	C:/Go/src/net/sock_posix.go:149 +0x109
 net.socket(0xfa7a40, 0xc000080100, 0xe50eb1, 0x3, 0x2, 0x1, 0x0, 0x0, 0xfad9a0, 0x0, ...)
 	C:/Go/src/net/sock_posix.go:70 +0x1d9
 net.internetSocket(0xfa7a40, 0xc000080100, 0xe50eb1, 0x3, 0xfad9a0, 0x0, 0xfad9a0, 0xc000086930, 0x1, 0x0, ...)
 	C:/Go/src/net/ipsock_posix.go:141 +0x178
 net.(*sysDialer).doDialTCP(0xc000357c00, 0xfa7a40, 0xc000080100, 0x0, 0xc000086930, 0x1, 0xdd3da0, 0x9)
 	C:/Go/src/net/tcpsock_posix.go:65 +0xc9
 net.(*sysDialer).dialTCP(0xc000357c00, 0xfa7a40, 0xc000080100, 0x0, 0xc000086930, 0xc000074630, 0x10, 0x10)
 	C:/Go/src/net/tcpsock_posix.go:61 +0xde
 net.(*sysDialer).dialSingle(0xc000357c00, 0xfa7a40, 0xc000080100, 0xf953c0, 0xc000086930, 0x0, 0x0, 0x0, 0x0)
 	C:/Go/src/net/dial.go:578 +0x375
 net.(*sysDialer).dialSerial(0xc000357c00, 0xfa7a40, 0xc000080100, 0xc000074630, 0x1, 0x1, 0x0, 0x0, 0x0, 0x0)
 	C:/Go/src/net/dial.go:546 +0x228
 net.(*Dialer).DialContext(0xc0000a1e48, 0xfa7a40, 0xc000080100, 0xe50eb1, 0x3, 0xc00019e290, 0xf, 0x0, 0x0, 0x0, ...)
 	C:/Go/src/net/dial.go:424 +0x66d
 net.(*Dialer).Dial(...)
 	C:/Go/src/net/dial.go:347
 net.Dial(0xe50eb1, 0x3, 0xc00019e290, 0xf, 0x1, 0xc00002fe71, 0x5, 0xc00019e290)
 	C:/Go/src/net/dial.go:318 +0xaf
 gitlab.com/gitlab-org/gitlab-runner/commands/helpers.(*HealthCheckCommand).Execute(0xc0003fdfc8, 0x0)
 	C:/GitLab-Runner/builds/gitlab-org/gitlab-runner/.gopath/src/gitlab.com/gitlab-org/gitlab-runner/commands/helpers/health_check.go:41 +0x34a
 gitlab.com/gitlab-org/gitlab-runner/commands/helpers.TestHealthCheckCommand_Execute.func1.1(0xc000038900)
 	C:/GitLab-Runner/builds/gitlab-org/gitlab-runner/.gopath/src/gitlab.com/gitlab-org/gitlab-runner/commands/helpers/health_check_test.go:74 +0x3b
 created by gitlab.com/gitlab-org/gitlab-runner/commands/helpers.TestHealthCheckCommand_Execute.func1
 	C:/GitLab-Runner/builds/gitlab-org/gitlab-runner/.gopath/src/gitlab.com/gitlab-org/gitlab-runner/commands/helpers/health_check_test.go:72 +0x292
 goroutine 315 [select]:
 net.(*netFD).connect.func2(0xfa7a40, 0xc000080100, 0xc00013f400, 0xc0000b23c0)
 	C:/Go/src/net/fd_windows.go:106 +0xbe
 created by net.(*netFD).connect
 	C:/Go/src/net/fd_windows.go:105 +0x1d3
 FAIL	gitlab.com/gitlab-org/gitlab-runner/commands/helpers	601.214s
 FAIL
Follow-up from !2212 (merged)