Skip to content
API

MM-59950 - add deletedAt column to users export (#28137) #175

Sign in to view logs

MM-59950 - add deletedAt column to users export (#28137)

MM-59950 - add deletedAt column to users export (#28137) #175

GitHub Actions / Postgres (Results) failed Sep 23, 2024 in 0s

12882 tests run, 12838 passed, 36 skipped, 8 failed, 2 retried.

Annotations

Check failure on line 1 in com/mattermost/mattermost/server/v8/channels/api4

See this annotation in the file changed.

@github-actions github-actions / Postgres (Results)

com/mattermost/mattermost/server/v8/channels/api4.TestSyncLdap/SystemAdminClient#01 

Failed
Raw output 
=== RUN   TestSyncLdap/SystemAdminClient#01
{"timestamp":"2024-09-23 13:57:23.153 Z","level":"debug","msg":"Received HTTP request","caller":"web/handlers.go:185","method":"POST","url":"/api/v4/ldap/sync","request_id":"ofcysfqqajbmukzksri339mpbw","user_id":"cenfjm9rnig7icosh6bj4whx5c","status_code":"200"}
==================
WARNING: DATA RACE
Read at 0x00c001ee7590 by goroutine 325525:
  reflect.maplen()
      /usr/local/go/src/runtime/map.go:1406 +0x0
  reflect.Value.lenNonSlice()
      /usr/local/go/src/reflect/value.go:1785 +0x1e9
  reflect.Value.Len()
      /usr/local/go/src/reflect/value.go:1774 +0x137
  internal/fmtsort.Sort()
      /usr/local/go/src/internal/fmtsort/sort.go:58 +0x121
  fmt.(*pp).printValue()
      /usr/local/go/src/fmt/print.go:816 +0x1144
  fmt.(*pp).printValue()
      /usr/local/go/src/fmt/print.go:853 +0x1d3e
  fmt.(*pp).printValue()
      /usr/local/go/src/fmt/print.go:853 +0x1d3e
  fmt.(*pp).printValue()
      /usr/local/go/src/fmt/print.go:921 +0x132a
  fmt.(*pp).printArg()
      /usr/local/go/src/fmt/print.go:759 +0xb84
  fmt.(*pp).doPrintf()
      /usr/local/go/src/fmt/print.go:1174 +0x10ce
  fmt.Sprintf()
      /usr/local/go/src/fmt/print.go:239 +0x5c
  github.com/stretchr/testify/mock.Arguments.Diff()
      /go/pkg/mod/github.com/stretchr/[email protected]/mock/mock.go:939 +0x1b2
  github.com/stretchr/testify/mock.(*Mock).findExpectedCall()
      /go/pkg/mod/github.com/stretchr/[email protected]/mock/mock.go:368 +0x147
  github.com/stretchr/testify/mock.(*Mock).MethodCalled()
      /go/pkg/mod/github.com/stretchr/[email protected]/mock/mock.go:476 +0xac
  github.com/stretchr/testify/mock.(*Mock).Called()
      /go/pkg/mod/github.com/stretchr/[email protected]/mock/mock.go:466 +0x195
  github.com/mattermost/mattermost/server/v8/einterfaces/mocks.(*LdapInterface).StartSynchronizeJob()
      /mattermost/server/einterfaces/mocks/LdapInterface.go:406 +0x1b0
  github.com/mattermost/mattermost/server/v8/channels/app.(*App).SyncLdap.func1()
      /mattermost/server/channels/app/ldap.go:33 +0x1d8
  github.com/mattermost/mattermost/server/v8/channels/app/platform.(*PlatformService).Go.func1()
      /mattermost/server/channels/app/platform/goroutines.go:14 +0x37

Previous write at 0x00c001ee7590 by goroutine 325464:
  runtime.mapclear()
      /usr/local/go/src/runtime/map.go:989 +0x0
  github.com/mattermost/mattermost/server/v8/channels/app/platform.(*PlatformService).ReturnSessionToPool()
      /mattermost/server/channels/app/platform/session.go:22 +0xd1
  github.com/mattermost/mattermost/server/v8/channels/app.(*App).ReturnSessionToPool()
      /mattermost/server/channels/app/session.go:227 +0x26
  github.com/mattermost/mattermost/server/v8/channels/web.Handler.ServeHTTP.deferwrap1()
      /mattermost/server/channels/web/handlers.go:295 +0x55
  runtime.deferreturn()
      /usr/local/go/src/runtime/panic.go:602 +0x5d
  github.com/mattermost/mattermost/server/v8/channels/web.(*Handler).ServeHTTP()
      <autogenerated>:1 +0xe7
  github.com/klauspost/compress/gzhttp.NewWrapper.func1.1()
      /go/pkg/mod/github.com/klauspost/[email protected]/gzhttp/compress.go:495 +0x7c6
  net/http.HandlerFunc.ServeHTTP()
      /usr/local/go/src/net/http/server.go:2171 +0x47
  github.com/gorilla/mux.(*Router).ServeHTTP()
      /go/pkg/mod/github.com/gorilla/[email protected]/mux.go:212 +0x371
  net/http.serverHandler.ServeHTTP()
      /usr/local/go/src/net/http/server.go:3142 +0x2a1
  net/http.(*conn).serve()
      /usr/local/go/src/net/http/server.go:2044 +0x13c4
  net/http.(*Server).Serve.gowrap3()
      /usr/local/go/src/net/http/server.go:3290 +0x4f

Goroutine 325525 (running) created at:
  github.com/mattermost/mattermost/server/v8/channels/app/platform.(*PlatformService).Go()
      /mattermost/server/channels/app/platform/goroutines.go:13 +0xec
  github.com/mattermost/mattermost/server/v8/channels/app.(*Server).Go()
      /mattermost/server/channels/app/server.go:805 +0x148
  github.com/mattermost/mattermost/server/v8/channels/app.(*App).SyncLdap()
      /mattermost/server/channels/app/ldap.go:21 +0x5d
  github.com/mattermost/mattermost/server/v8/channels/api4.syncLdap()
      /mattermost/server/channels/api4/ldap.go:69 +0x9de
  github.com/mattermost/mattermost/server/v8/channels/web.Handler.ServeHTTP()
      /mattermost/server/channels/web/handlers.go:387 +0x6645
  github.com/mattermost/mattermost/server/v8/channels/web.(*Handler).ServeHTTP()
      <autogenerated>:1 +0xe7
  github.com/klauspost/compress/gzhttp.NewWrapper.func1.1()
      /go/pkg/mod/github.com/klauspost/[email protected]/gzhttp/compress.go:495 +0x7c6
  net/http.HandlerFunc.ServeHTTP()
      /usr/local/go/src/net/http/server.go:2171 +0x47
  github.com/gorilla/mux.(*Router).ServeHTTP()
      /go/pkg/mod/github.com/gorilla/[email protected]/mux.go:212 +0x371
  net/http.serverHandler.ServeHTTP()
      /usr/local/go/src/net/http/server.go:3142 +0x2a1
  net/http.(*conn).serve()
      /usr/local/go/src/net/http/server.go:2044 +0x13c4
  net/http.(*Server).Serve.gowrap3()
      /usr/local/go/src/net/http/server.go:3290 +0x4f

Goroutine 325464 (running) created at:
  net/http.(*Server).Serve()
      /usr/local/go/src/net/http/server.go:3290 +0x8ec
  github.com/mattermost/mattermost/server/v8/channels/app.(*Server).Start.func2()
      /mattermost/server/channels/app/server.go:1069 +0x224
==================
{"timestamp":"2024-09-23 13:57:23.155 Z","level":"debug","msg":"Received HTTP request","caller":"web/handlers.go:185","method":"POST","url":"/api/v4/ldap/sync","request_id":"8x8iqx9ami8gdx4wio83kqmxio","user_id":"cenfjm9rnig7icosh6bj4whx5c","status_code":"200"}
    testing.go:1398: race detected during execution of test
--- FAIL: TestSyncLdap/SystemAdminClient#01 (0.01s)

Check failure on line 1 in com/mattermost/mattermost/server/v8/channels/api4

See this annotation in the file changed.

@github-actions github-actions / Postgres (Results)

com/mattermost/mattermost/server/v8/channels/api4.TestSyncLdap 

Failed
Raw output 
=== RUN   TestSyncLdap
{"timestamp":"2024-09-23 13:57:21.857 Z","level":"debug","msg":"Advanced logging config not provided for notification logging","caller":"platform/config.go:165"}
{"timestamp":"2024-09-23 13:57:21.857 Z","level":"info","msg":"Successfully connected to cache backend","caller":"platform/service.go:191","backend":"redis","result":"PONG"}
{"timestamp":"2024-09-23 13:57:21.857 Z","level":"info","msg":"Server is initializing...","caller":"platform/service.go:194","go_version":"go1.22.6"}
{"timestamp":"2024-09-23 13:57:21.859 Z","level":"info","msg":"Starting websocket hubs","caller":"platform/web_hub.go:106","number_of_hubs":4}
{"timestamp":"2024-09-23 13:57:21.860 Z","level":"debug","msg":"Hub is starting","caller":"platform/web_hub.go:386","index":0}
{"timestamp":"2024-09-23 13:57:21.860 Z","level":"debug","msg":"Hub is starting","caller":"platform/web_hub.go:386","index":3}
{"timestamp":"2024-09-23 13:57:21.860 Z","level":"debug","msg":"Hub is starting","caller":"platform/web_hub.go:386","index":1}
{"timestamp":"2024-09-23 13:57:21.860 Z","level":"debug","msg":"Hub is starting","caller":"platform/web_hub.go:386","index":2}
{"timestamp":"2024-09-23 13:57:21.860 Z","level":"info","msg":"Loaded system translations","caller":"i18n/i18n.go:175","for locale":"en","from locale":"/mattermost/server/i18n/en.json"}
{"timestamp":"2024-09-23 13:57:21.868 Z","level":"info","msg":"Ensuring the telemetry ID..","caller":"telemetry/telemetry.go:147"}
{"timestamp":"2024-09-23 13:57:21.869 Z","level":"info","msg":"telemetry ID is set","caller":"telemetry/telemetry.go:157","id":"g9wnmujteib5idamtxqz6aydte"}
{"timestamp":"2024-09-23 13:57:21.888 Z","level":"error","msg":"SiteURL must be set. Some features will operate incorrectly if the SiteURL is not set. See documentation for details: https://mattermost.com/pl/configure-site-url","caller":"app/server.go:389"}
{"timestamp":"2024-09-23 13:57:21.888 Z","level":"info","msg":"Current version is 10.1.0 (///)","caller":"app/server.go:403","current_version":"10.1.0","build_number":"","build_date":"","build_hash":"","build_hash_enterprise":"","service_environment":"dev"}
{"timestamp":"2024-09-23 13:57:21.888 Z","level":"info","msg":"Team Edition Build","caller":"app/server.go:419","enterprise_build":false}
{"timestamp":"2024-09-23 13:57:21.888 Z","level":"info","msg":"Printing current working","caller":"app/server.go:423","directory":"/tmp/testlib4032906887"}
{"timestamp":"2024-09-23 13:57:21.888 Z","level":"info","msg":"Loaded config","caller":"app/server.go:424","source":"memory://"}
{"timestamp":"2024-09-23 13:57:22.121 Z","level":"debug","msg":"initElasticsearchChannelIndexCheck: calling elasticsearchChannelIndexCheckWithRetry before setting up config and license change listeners...","caller":"app/elasticsearch.go:21"}
{"timestamp":"2024-09-23 13:57:22.121 Z","level":"debug","msg":"elasticsearchChannelIndexCheckWithRetry: attempting to check channel index state...","caller":"app/elasticsearch.go:64"}
{"timestamp":"2024-09-23 13:57:22.122 Z","level":"debug","msg":"elasticsearchChannelIndexCheckWithRetry: skipping because elasticsearch indexing is disabled","caller":"app/elasticsearch.go:67"}
{"timestamp":"2024-09-23 13:57:22.155 Z","level":"debug","msg":"Fetching user count for first user account check","caller":"platform/config.go:356"}
{"timestamp":"2024-09-23 13:57:22.160 Z","level":"debug","msg":"Advanced logging config not provided for notification logging","caller":"platform/config.go:165"}
{"timestamp":"2024-09-23 13:57:22.160 Z","level":"info","msg":"Starting up plugins","caller":"app/plugin.go:191"}
{"timestamp":"2024-09-23 13:57:22.160 Z","level":"debug","msg":"Enabling plugin health check job","caller":"plugin/environment.go:661","interval_s":"30s"}
{"timestamp":"2024-09-23 13:57:22.160 Z","level":"info","msg":"Syncing plugins from the file store","caller":"app/plugin.go:268"}
{"timestamp":"2024-09-23 13:57:22.160 Z","level":"debug","msg":"Plugin health check job starting.","caller":"plugin/health_check.go:31"}
{"timestamp":"2024-09-23 13:57:22.160 Z","level":"info","msg":"No plugins to sync from the file store","caller":"app/plugin.go:311"}
{"timestamp":"2024-09-23 13:57:22.161 Z","level":"debug","msg":"No prepackaged plugins directory found","caller":"app/plugin.go:912"}
{"timestamp":"2024-09-23 13:57:22.161 Z","level":"debug","msg":"Not persisting transitionally prepackaged plugins: none found","caller":"app/plugin.go:1184"}
{"timestamp":"2024-09-23 13:57:22.165 Z","level":"debug","msg":"Able to write files to local storage.","caller":"filestore/localstore.go:82"}
{"timestamp":"2024-09-23 13:57:22.184 Z","level":"info","msg":"Starting Server...","caller":"app/server.go:886"}
{"timestamp":"2024-09-23 13:57:22.184 Z","level":"info","msg":"Server is listening on 127.0.0.1:37753","caller":"app/server.go:962","address":"127.0.0.1:37753"}
{"timestamp":"2024-09-23 13:57:22.184 Z","level":"debug","msg":"No license provided; Remote Cluster services disabled","caller":"app/server.go:579"}
{"timestamp":"2024-09-23 13:57:22.256 Z","level":"debug","msg":"Initializing web routes","caller":"web/web.go:26"}
{"timestamp":"2024-09-23 13:57:22.257 Z","level":"debug","msg":"Skipping update to assets subpath since CI build","caller":"utils/subpath.go:187"}
{"timestamp":"2024-09-23 13:57:22.258 Z","level":"debug","msg":"Using client directory","caller":"web/static.go:34","clientDir":"/tmp/testlib4032906887/client"}
{"timestamp":"2024-09-23 13:57:22.258 Z","level":"debug","msg":"Configured Client4 bool string values","caller":"api4/apitestlib.go:212","true":"1","false":"F"}
{"timestamp":"2024-09-23 13:57:23.105 Z","level":"debug","msg":"Received HTTP request","caller":"web/handlers.go:185","method":"POST","url":"/api/v4/users/login","request_id":"sofoen77xtg9jecgj494k5i9po","user_id":"cenfjm9rnig7icosh6bj4whx5c","status_code":"200"}
{"timestamp":"2024-09-23 13:57:23.107 Z","level":"debug","msg":"Received HTTP request","caller":"web/handlers.go:185","method":"POST","url":"/api/v4/users/login","request_id":"cw9pb3w4m3d5jyuhtbhwfwot4y","user_id":"rujr3w5ya3b1dmpu6gai4g799r","status_code":"200"}
{"timestamp":"2024-09-23 13:57:23.141 Z","level":"debug","msg":"Fetching user count for first user account check","caller":"platform/config.go:356"}
{"timestamp":"2024-09-23 13:57:23.147 Z","level":"debug","msg":"Advanced logging config not provided for notification logging","caller":"platform/config.go:165"}
{"timestamp":"2024-09-23 13:57:23.162 Z","level":"debug","msg":"You do not have the appropriate permissions.","caller":"web/context.go:120","path":"/api/v4/ldap/sync","request_id":"aqhzuuupyircmnf3pzrtfbmwzh","ip_addr":"127.0.0.1","user_id":"rujr3w5ya3b1dmpu6gai4g799r","method":"POST","err_where":"Permissions","http_code":403,"error":"Permissions: You do not have the appropriate permissions., userId=rujr3w5ya3b1dmpu6gai4g799r, permission=create_ldap_sync_job"}
{"timestamp":"2024-09-23 13:57:23.162 Z","level":"debug","msg":"Received HTTP request","caller":"web/handlers.go:185","method":"POST","url":"/api/v4/ldap/sync","request_id":"aqhzuuupyircmnf3pzrtfbmwzh","user_id":"rujr3w5ya3b1dmpu6gai4g799r","status_code":"403"}
{"timestamp":"2024-09-23 13:57:23.163 Z","level":"info","msg":"Purging all caches","caller":"platform/cluster_handlers.go:114"}
{"timestamp":"2024-09-23 13:57:23.166 Z","level":"info","msg":"License key has not been uploaded. Loading license key from disk.","caller":"utils/license.go:107","filename":"/tmp/testlib4032906887/config/mattermost.mattermost-license"}
{"timestamp":"2024-09-23 13:57:23.166 Z","level":"warn","msg":"Failed to get license from disk","caller":"platform/license.go:93","error":"We could not find the license key on disk at /tmp/testlib4032906887/config/mattermost.mattermost-license: stat /tmp/testlib4032906887/config/mattermost.mattermost-license: no such file or directory"}
{"timestamp":"2024-09-23 13:57:23.166 Z","level":"warn","msg":"License key from https://mattermost.com required to unlock enterprise features.","caller":"platform/license.go:105","error":"resource \"License\" not found, id: "}
{"timestamp":"2024-09-23 13:57:23.170 Z","level":"info","msg":"Stopping Server...","caller":"app/server.go:668"}
{"timestamp":"2024-09-23 13:57:23.172 Z","level":"info","msg":"Shutting down Email batching service...","caller":"email/service.go:85"}
{"timestamp":"2024-09-23 13:57:23.172 Z","level":"info","msg":"Shutting down plugins","caller":"app/plugin.go:362"}
{"timestamp":"2024-09-23 13:57:23.172 Z","level":"debug","msg":"Disabling plugin health check job","caller":"plugin/environment.go:670"}
{"timestamp":"2024-09-23 13:57:23.172 Z","level":"info","msg":"stopping websocket hub connections","caller":"platform/web_hub.go:127"}
{"timestamp":"2024-09-23 13:57:23.173 Z","level":"info","msg":"Server stopped","caller":"app/server.go:752"}
--- FAIL: TestSyncLdap (1.39s)

Check failure on line 1 in com/mattermost/mattermost/server/v8/channels/api4

See this annotation in the file changed.

@github-actions github-actions / Postgres (Results)

com/mattermost/mattermost/server/v8/channels/api4.TestSyncLdap/SystemAdminClient#01 

Failed
Raw output 
=== RUN   TestSyncLdap/SystemAdminClient#01
{"timestamp":"2024-09-23 14:50:49.100 Z","level":"debug","msg":"Received HTTP request","caller":"web/handlers.go:185","method":"POST","url":"/api/v4/ldap/sync","request_id":"r6m5yopptfyszr9r5chp18jkdh","user_id":"8mc8e58ctf8h5qjk4r9pcre3cy","status_code":"200"}
==================
WARNING: DATA RACE
Read at 0x00c002ece9c0 by goroutine 1203:
  reflect.maplen()
      /usr/local/go/src/runtime/map.go:1406 +0x0
  reflect.Value.lenNonSlice()
      /usr/local/go/src/reflect/value.go:1785 +0x1e9
  reflect.Value.Len()
      /usr/local/go/src/reflect/value.go:1774 +0x137
  internal/fmtsort.Sort()
      /usr/local/go/src/internal/fmtsort/sort.go:58 +0x121
  fmt.(*pp).printValue()
      /usr/local/go/src/fmt/print.go:816 +0x1144
  fmt.(*pp).printValue()
      /usr/local/go/src/fmt/print.go:853 +0x1d3e
  fmt.(*pp).printValue()
      /usr/local/go/src/fmt/print.go:853 +0x1d3e
  fmt.(*pp).printValue()
      /usr/local/go/src/fmt/print.go:921 +0x132a
  fmt.(*pp).printArg()
      /usr/local/go/src/fmt/print.go:759 +0xb84
  fmt.(*pp).doPrintf()
      /usr/local/go/src/fmt/print.go:1174 +0x10ce
  fmt.Sprintf()
      /usr/local/go/src/fmt/print.go:239 +0x5c
  github.com/stretchr/testify/mock.Arguments.Diff()
      /go/pkg/mod/github.com/stretchr/[email protected]/mock/mock.go:939 +0x1b2
  github.com/stretchr/testify/mock.(*Mock).findExpectedCall()
      /go/pkg/mod/github.com/stretchr/[email protected]/mock/mock.go:368 +0x147
  github.com/stretchr/testify/mock.(*Mock).MethodCalled()
      /go/pkg/mod/github.com/stretchr/[email protected]/mock/mock.go:476 +0xac
  github.com/stretchr/testify/mock.(*Mock).Called()
      /go/pkg/mod/github.com/stretchr/[email protected]/mock/mock.go:466 +0x195
  github.com/mattermost/mattermost/server/v8/einterfaces/mocks.(*LdapInterface).StartSynchronizeJob()
      /mattermost/server/einterfaces/mocks/LdapInterface.go:406 +0x1b0
  github.com/mattermost/mattermost/server/v8/channels/app.(*App).SyncLdap.func1()
      /mattermost/server/channels/app/ldap.go:33 +0x1d8
  github.com/mattermost/mattermost/server/v8/channels/app/platform.(*PlatformService).Go.func1()
      /mattermost/server/channels/app/platform/goroutines.go:14 +0x37

Previous write at 0x00c002ece9c0 by goroutine 989:
  runtime.mapclear()
      /usr/local/go/src/runtime/map.go:989 +0x0
  github.com/mattermost/mattermost/server/v8/channels/app/platform.(*PlatformService).ReturnSessionToPool()
      /mattermost/server/channels/app/platform/session.go:22 +0xd1
  github.com/mattermost/mattermost/server/v8/channels/app.(*App).ReturnSessionToPool()
      /mattermost/server/channels/app/session.go:227 +0x26
  github.com/mattermost/mattermost/server/v8/channels/web.Handler.ServeHTTP.deferwrap1()
      /mattermost/server/channels/web/handlers.go:295 +0x55
  runtime.deferreturn()
      /usr/local/go/src/runtime/panic.go:602 +0x5d
  github.com/mattermost/mattermost/server/v8/channels/web.(*Handler).ServeHTTP()
      <autogenerated>:1 +0xe7
  github.com/klauspost/compress/gzhttp.NewWrapper.func1.1()
      /go/pkg/mod/github.com/klauspost/[email protected]/gzhttp/compress.go:495 +0x7c6
  net/http.HandlerFunc.ServeHTTP()
      /usr/local/go/src/net/http/server.go:2171 +0x47
  github.com/gorilla/mux.(*Router).ServeHTTP()
      /go/pkg/mod/github.com/gorilla/[email protected]/mux.go:212 +0x371
  net/http.serverHandler.ServeHTTP()
      /usr/local/go/src/net/http/server.go:3142 +0x2a1
  net/http.(*conn).serve()
      /usr/local/go/src/net/http/server.go:2044 +0x13c4
  net/http.(*Server).Serve.gowrap3()
      /usr/local/go/src/net/http/server.go:3290 +0x4f

Goroutine 1203 (running) created at:
  github.com/mattermost/mattermost/server/v8/channels/app/platform.(*PlatformService).Go()
      /mattermost/server/channels/app/platform/goroutines.go:13 +0xec
  github.com/mattermost/mattermost/server/v8/channels/app.(*Server).Go()
      /mattermost/server/channels/app/server.go:805 +0x148
  github.com/mattermost/mattermost/server/v8/channels/app.(*App).SyncLdap()
      /mattermost/server/channels/app/ldap.go:21 +0x5d
  github.com/mattermost/mattermost/server/v8/channels/api4.syncLdap()
      /mattermost/server/channels/api4/ldap.go:69 +0x9de
  github.com/mattermost/mattermost/server/v8/channels/web.Handler.ServeHTTP()
      /mattermost/server/channels/web/handlers.go:387 +0x6645
  github.com/mattermost/mattermost/server/v8/channels/web.(*Handler).ServeHTTP()
      <autogenerated>:1 +0xe7
  github.com/klauspost/compress/gzhttp.NewWrapper.func1.1()
      /go/pkg/mod/github.com/klauspost/[email protected]/gzhttp/compress.go:495 +0x7c6
  net/http.HandlerFunc.ServeHTTP()
      /usr/local/go/src/net/http/server.go:2171 +0x47
  github.com/gorilla/mux.(*Router).ServeHTTP()
      /go/pkg/mod/github.com/gorilla/[email protected]/mux.go:212 +0x371
  net/http.serverHandler.ServeHTTP()
      /usr/local/go/src/net/http/server.go:3142 +0x2a1
  net/http.(*conn).serve()
      /usr/local/go/src/net/http/server.go:2044 +0x13c4
  net/http.(*Server).Serve.gowrap3()
      /usr/local/go/src/net/http/server.go:3290 +0x4f

Goroutine 989 (running) created at:
  net/http.(*Server).Serve()
      /usr/local/go/src/net/http/server.go:3290 +0x8ec
  github.com/mattermost/mattermost/server/v8/channels/app.(*Server).Start.func2()
      /mattermost/server/channels/app/server.go:1069 +0x224
==================
{"timestamp":"2024-09-23 14:50:49.104 Z","level":"debug","msg":"Received HTTP request","caller":"web/handlers.go:185","method":"POST","url":"/api/v4/ldap/sync","request_id":"ac7nfi4bbf8e5b396z7mgx6rxr","user_id":"8mc8e58ctf8h5qjk4r9pcre3cy","status_code":"200"}
    testing.go:1398: race detected during execution of test
--- FAIL: TestSyncLdap/SystemAdminClient#01 (0.01s)

Check failure on line 1 in com/mattermost/mattermost/server/v8/channels/api4

See this annotation in the file changed.

@github-actions github-actions / Postgres (Results)

com/mattermost/mattermost/server/v8/channels/api4.TestSyncLdap 

Failed
Raw output 
=== RUN   TestSyncLdap
{"timestamp":"2024-09-23 14:50:43.391 Z","level":"debug","msg":"Advanced logging config not provided for notification logging","caller":"platform/config.go:165"}
{"timestamp":"2024-09-23 14:50:43.391 Z","level":"info","msg":"Successfully connected to cache backend","caller":"platform/service.go:191","backend":"redis","result":"PONG"}
{"timestamp":"2024-09-23 14:50:43.391 Z","level":"info","msg":"Server is initializing...","caller":"platform/service.go:194","go_version":"go1.22.6"}
{"timestamp":"2024-09-23 14:50:43.394 Z","level":"info","msg":"Starting websocket hubs","caller":"platform/web_hub.go:106","number_of_hubs":4}
{"timestamp":"2024-09-23 14:50:43.394 Z","level":"debug","msg":"Hub is starting","caller":"platform/web_hub.go:386","index":0}
{"timestamp":"2024-09-23 14:50:43.394 Z","level":"debug","msg":"Hub is starting","caller":"platform/web_hub.go:386","index":1}
{"timestamp":"2024-09-23 14:50:43.394 Z","level":"debug","msg":"Hub is starting","caller":"platform/web_hub.go:386","index":3}
{"timestamp":"2024-09-23 14:50:43.394 Z","level":"debug","msg":"Hub is starting","caller":"platform/web_hub.go:386","index":2}
{"timestamp":"2024-09-23 14:50:43.395 Z","level":"info","msg":"Loaded system translations","caller":"i18n/i18n.go:175","for locale":"en","from locale":"/mattermost/server/i18n/en.json"}
{"timestamp":"2024-09-23 14:50:43.403 Z","level":"info","msg":"Ensuring the telemetry ID..","caller":"telemetry/telemetry.go:147"}
{"timestamp":"2024-09-23 14:50:43.404 Z","level":"info","msg":"telemetry ID is set","caller":"telemetry/telemetry.go:157","id":"t1ngo5dwdbbtxrbbq6nkct3hwc"}
{"timestamp":"2024-09-23 14:50:43.424 Z","level":"error","msg":"SiteURL must be set. Some features will operate incorrectly if the SiteURL is not set. See documentation for details: https://mattermost.com/pl/configure-site-url","caller":"app/server.go:389"}
{"timestamp":"2024-09-23 14:50:43.424 Z","level":"info","msg":"Current version is 10.1.0 (///)","caller":"app/server.go:403","current_version":"10.1.0","build_number":"","build_date":"","build_hash":"","build_hash_enterprise":"","service_environment":"dev"}
{"timestamp":"2024-09-23 14:50:43.424 Z","level":"info","msg":"Team Edition Build","caller":"app/server.go:419","enterprise_build":false}
{"timestamp":"2024-09-23 14:50:43.424 Z","level":"info","msg":"Printing current working","caller":"app/server.go:423","directory":"/tmp/testlib542729183"}
{"timestamp":"2024-09-23 14:50:43.424 Z","level":"info","msg":"Loaded config","caller":"app/server.go:424","source":"memory://"}
{"timestamp":"2024-09-23 14:50:43.690 Z","level":"debug","msg":"initElasticsearchChannelIndexCheck: calling elasticsearchChannelIndexCheckWithRetry before setting up config and license change listeners...","caller":"app/elasticsearch.go:21"}
{"timestamp":"2024-09-23 14:50:43.690 Z","level":"debug","msg":"elasticsearchChannelIndexCheckWithRetry: attempting to check channel index state...","caller":"app/elasticsearch.go:64"}
{"timestamp":"2024-09-23 14:50:43.691 Z","level":"debug","msg":"elasticsearchChannelIndexCheckWithRetry: skipping because elasticsearch indexing is disabled","caller":"app/elasticsearch.go:67"}
{"timestamp":"2024-09-23 14:50:43.724 Z","level":"debug","msg":"Fetching user count for first user account check","caller":"platform/config.go:356"}
{"timestamp":"2024-09-23 14:50:43.727 Z","level":"info","msg":"Post.Message has size restrictions","caller":"sqlstore/post_store.go:2615","max_characters":16383,"max_bytes":65535}
{"timestamp":"2024-09-23 14:50:43.732 Z","level":"debug","msg":"Advanced logging config not provided for notification logging","caller":"platform/config.go:165"}
{"timestamp":"2024-09-23 14:50:43.732 Z","level":"info","msg":"Starting up plugins","caller":"app/plugin.go:191"}
{"timestamp":"2024-09-23 14:50:43.732 Z","level":"debug","msg":"Enabling plugin health check job","caller":"plugin/environment.go:661","interval_s":"30s"}
{"timestamp":"2024-09-23 14:50:43.732 Z","level":"info","msg":"Syncing plugins from the file store","caller":"app/plugin.go:268"}
{"timestamp":"2024-09-23 14:50:43.732 Z","level":"debug","msg":"Plugin health check job starting.","caller":"plugin/health_check.go:31"}
{"timestamp":"2024-09-23 14:50:43.732 Z","level":"info","msg":"No plugins to sync from the file store","caller":"app/plugin.go:311"}
{"timestamp":"2024-09-23 14:50:43.732 Z","level":"debug","msg":"No prepackaged plugins directory found","caller":"app/plugin.go:912"}
{"timestamp":"2024-09-23 14:50:43.732 Z","level":"debug","msg":"Not persisting transitionally prepackaged plugins: none found","caller":"app/plugin.go:1184"}
{"timestamp":"2024-09-23 14:50:43.737 Z","level":"debug","msg":"Able to write files to local storage.","caller":"filestore/localstore.go:82"}
{"timestamp":"2024-09-23 14:50:43.756 Z","level":"info","msg":"Starting Server...","caller":"app/server.go:886"}
{"timestamp":"2024-09-23 14:50:43.756 Z","level":"info","msg":"Server is listening on 127.0.0.1:44043","caller":"app/server.go:962","address":"127.0.0.1:44043"}
{"timestamp":"2024-09-23 14:50:43.756 Z","level":"debug","msg":"No license provided; Remote Cluster services disabled","caller":"app/server.go:579"}
{"timestamp":"2024-09-23 14:50:43.833 Z","level":"debug","msg":"Initializing web routes","caller":"web/web.go:26"}
{"timestamp":"2024-09-23 14:50:43.835 Z","level":"debug","msg":"Skipping update to assets subpath since CI build","caller":"utils/subpath.go:187"}
{"timestamp":"2024-09-23 14:50:43.835 Z","level":"debug","msg":"Using client directory","caller":"web/static.go:34","clientDir":"/tmp/testlib542729183/client"}
{"timestamp":"2024-09-23 14:50:43.835 Z","level":"debug","msg":"Configured Client4 bool string values","caller":"api4/apitestlib.go:212","true":"1","false":"0"}
{"timestamp":"2024-09-23 14:50:43.838 Z","level":"debug","msg":"Fetching user count for first user account check","caller":"platform/config.go:356"}
{"timestamp":"2024-09-23 14:50:44.699 Z","level":"debug","msg":"sending mail","caller":"mail/mail.go:295","to":"us1frbzb7igfpn6kp5c8gt8inh@localhost","subject":"[Mattermost] You joined "}
{"timestamp":"2024-09-23 14:50:44.716 Z","level":"debug","msg":"Received HTTP request","caller":"web/handlers.go:185","method":"POST","url":"/api/v4/users","request_id":"dupf9sk8djdrjfij1dz55emanr","user_id":"","status_code":"201"}
{"timestamp":"2024-09-23 14:50:44.730 Z","level":"debug","msg":"Fetching user count for first user account check","caller":"platform/config.go:356"}
{"timestamp":"2024-09-23 14:50:45.568 Z","level":"debug","msg":"sending mail","caller":"mail/mail.go:295","to":"rz3e8pja7pfrbm7usz3698ahta@localhost","subject":"[Mattermost] You joined "}
{"timestamp":"2024-09-23 14:50:45.585 Z","level":"debug","msg":"Received HTTP request","caller":"web/handlers.go:185","method":"POST","url":"/api/v4/users","request_id":"7838xy8qap8fdd81fpbrcxx3ce","user_id":"","status_code":"201"}
{"timestamp":"2024-09-23 14:50:46.435 Z","level":"debug","msg":"sending mail","caller":"mail/mail.go:295","to":"qphopyqnupfhx863jayk979uzh@localhost","subject":"[Mattermost] You joined "}
{"timestamp":"2024-09-23 14:50:46.452 Z","level":"debug","msg":"Received HTTP request","caller":"web/handlers.go:185","method":"POST","url":"/api/v4/users","request_id":"qkou5ttbqbgbxmzt8si1w6daco","user_id":"","status_code":"201"}
{"timestamp":"2024-09-23 14:50:47.303 Z","level":"debug","msg":"sending mail","caller":"mail/mail.go:295","to":"bot5zeo6hbbubn59rbcnj6nnza@localhost","subject":"[Mattermost] You joined "}
{"timestamp":"2024-09-23 14:50:47.321 Z","level":"debug","msg":"Received HTTP request","caller":"web/handlers.go:185","method":"POST","url":"/api/v4/users","request_id":"hu1btoho7p8jbks7k9cg5qa7ey","user_id":"","status_code":"201"}
{"timestamp":"2024-09-23 14:50:48.173 Z","level":"debug","msg":"sending mail","caller":"mail/mail.go:295","to":"owygzypp5pg85cj9t7y9cf35bh@localhost","subject":"[Mattermost] You joined "}
{"timestamp":"2024-09-23 14:50:48.191 Z","level":"debug","msg":"Received HTTP request","caller":"web/handlers.go:185","method":"POST","url":"/api/v4/users","request_id":"dritzghmk389dfdzzs1jz7o6wo","user_id":"","status_code":"201"}
{"timestamp":"2024-09-23 14:50:49.058 Z","level":"debug","msg":"Received HTTP request","caller":"web/handlers.go:185","method":"POST","url":"/api/v4/users/login","request_id":"7bebhrdccp8y9qzysgckfkxkcc","user_id":"tywdrer4qtyein5xejeyzzn6ga","status_code":"200"}
{"timestamp":"2024-09-23 14:50:49.059 Z","level":"debug","msg":"Received HTTP request","caller":"web/handlers.go:185","method":"POST","url":"/api/v4/users/login","request_id":"cwjs6afzjfg4fqqw4ngc8m6t5c","user_id":"8mc8e58ctf8h5qjk4r9pcre3cy","status_code":"200"}
{"timestamp":"2024-09-23 14:50:49.099 Z","level":"debug","msg":"Advanced logging config not provided for notification logging","caller":"platform/config.go:165"}
{"timestamp":"2024-09-23 14:50:49.106 Z","level":"debug","msg":"You do not have the appropriate permissions.","caller":"web/context.go:120","path":"/api/v4/ldap/sync","request_id":"odsg96ue9bnyjebsc86o5senye","ip_addr":"127.0.0.1","user_id":"tywdrer4qtyein5xejeyzzn6ga","method":"POST","err_where":"Permissions","http_code":403,"error":"Permissions: You do not have the appropriate permissions., userId=tywdrer4qtyein5xejeyzzn6ga, permission=create_ldap_sync_job"}
{"timestamp":"2024-09-23 14:50:49.106 Z","level":"debug","msg":"Received HTTP request","caller":"web/handlers.go:185","method":"POST","url":"/api/v4/ldap/sync","request_id":"odsg96ue9bnyjebsc86o5senye","user_id":"tywdrer4qtyein5xejeyzzn6ga","status_code":"403"}
{"timestamp":"2024-09-23 14:50:49.107 Z","level":"info","msg":"Purging all caches","caller":"platform/cluster_handlers.go:114"}
{"timestamp":"2024-09-23 14:50:49.109 Z","level":"info","msg":"License key has not been uploaded. Loading license key from disk.","caller":"utils/license.go:107","filename":"/tmp/testlib542729183/config/mattermost.mattermost-license"}
{"timestamp":"2024-09-23 14:50:49.109 Z","level":"warn","msg":"Failed to get license from disk","caller":"platform/license.go:93","error":"We could not find the license key on disk at /tmp/testlib542729183/config/mattermost.mattermost-license: stat /tmp/testlib542729183/config/mattermost.mattermost-license: no such file or directory"}
{"timestamp":"2024-09-23 14:50:49.110 Z","level":"warn","msg":"License key from https://mattermost.com required to unlock enterprise features.","caller":"platform/license.go:105","error":"resource \"License\" not found, id: "}
{"timestamp":"2024-09-23 14:50:49.115 Z","level":"info","msg":"Stopping Server...","caller":"app/server.go:668"}
{"timestamp":"2024-09-23 14:50:49.117 Z","level":"info","msg":"Shutting down Email batching service...","caller":"email/service.go:85"}
{"timestamp":"2024-09-23 14:50:49.117 Z","level":"info","msg":"Shutting down plugins","caller":"app/plugin.go:362"}
{"timestamp":"2024-09-23 14:50:49.117 Z","level":"debug","msg":"Disabling plugin health check job","caller":"plugin/environment.go:670"}
{"timestamp":"2024-09-23 14:50:49.118 Z","level":"info","msg":"stopping websocket hub connections","caller":"platform/web_hub.go:127"}
{"timestamp":"2024-09-23 14:50:49.118 Z","level":"info","msg":"Server stopped","caller":"app/server.go:752"}
--- FAIL: TestSyncLdap (5.81s)

Check failure on line 1 in com/mattermost/mattermost/server/v8/channels/api4

See this annotation in the file changed.

@github-actions github-actions / Postgres (Results)

com/mattermost/mattermost/server/v8/channels/api4.TestSyncLdap/SystemAdminClient#01 

Failed
Raw output 
=== RUN   TestSyncLdap/SystemAdminClient#01
{"timestamp":"2024-09-23 14:51:00.027 Z","level":"debug","msg":"Received HTTP request","caller":"web/handlers.go:185","method":"POST","url":"/api/v4/ldap/sync","request_id":"t1owkd6tz3dt3jfi49fytyqxjc","user_id":"7yoaxrex6ingfn8jk5ycwri8pr","status_code":"200"}
==================
WARNING: DATA RACE
Read at 0x00c0019e15f0 by goroutine 1202:
  reflect.maplen()
      /usr/local/go/src/runtime/map.go:1406 +0x0
  reflect.Value.lenNonSlice()
      /usr/local/go/src/reflect/value.go:1785 +0x1e9
  reflect.Value.Len()
      /usr/local/go/src/reflect/value.go:1774 +0x137
  internal/fmtsort.Sort()
      /usr/local/go/src/internal/fmtsort/sort.go:58 +0x121
  fmt.(*pp).printValue()
      /usr/local/go/src/fmt/print.go:816 +0x1144
  fmt.(*pp).printValue()
      /usr/local/go/src/fmt/print.go:853 +0x1d3e
  fmt.(*pp).printValue()
      /usr/local/go/src/fmt/print.go:853 +0x1d3e
  fmt.(*pp).printValue()
      /usr/local/go/src/fmt/print.go:921 +0x132a
  fmt.(*pp).printArg()
      /usr/local/go/src/fmt/print.go:759 +0xb84
  fmt.(*pp).doPrintf()
      /usr/local/go/src/fmt/print.go:1174 +0x10ce
  fmt.Sprintf()
      /usr/local/go/src/fmt/print.go:239 +0x5c
  github.com/stretchr/testify/mock.Arguments.Diff()
      /go/pkg/mod/github.com/stretchr/[email protected]/mock/mock.go:939 +0x1b2
  github.com/stretchr/testify/mock.(*Mock).findExpectedCall()
      /go/pkg/mod/github.com/stretchr/[email protected]/mock/mock.go:368 +0x147
  github.com/stretchr/testify/mock.(*Mock).MethodCalled()
      /go/pkg/mod/github.com/stretchr/[email protected]/mock/mock.go:476 +0xac
  github.com/stretchr/testify/mock.(*Mock).Called()
      /go/pkg/mod/github.com/stretchr/[email protected]/mock/mock.go:466 +0x195
  github.com/mattermost/mattermost/server/v8/einterfaces/mocks.(*LdapInterface).StartSynchronizeJob()
      /mattermost/server/einterfaces/mocks/LdapInterface.go:406 +0x1b0
  github.com/mattermost/mattermost/server/v8/channels/app.(*App).SyncLdap.func1()
      /mattermost/server/channels/app/ldap.go:33 +0x1d8
  github.com/mattermost/mattermost/server/v8/channels/app/platform.(*PlatformService).Go.func1()
      /mattermost/server/channels/app/platform/goroutines.go:14 +0x37

Previous write at 0x00c0019e15f0 by goroutine 988:
  runtime.mapclear()
      /usr/local/go/src/runtime/map.go:989 +0x0
  github.com/mattermost/mattermost/server/v8/channels/app/platform.(*PlatformService).ReturnSessionToPool()
      /mattermost/server/channels/app/platform/session.go:22 +0xd1
  github.com/mattermost/mattermost/server/v8/channels/app.(*App).ReturnSessionToPool()
      /mattermost/server/channels/app/session.go:227 +0x26
  github.com/mattermost/mattermost/server/v8/channels/web.Handler.ServeHTTP.deferwrap1()
      /mattermost/server/channels/web/handlers.go:295 +0x55
  runtime.deferreturn()
      /usr/local/go/src/runtime/panic.go:602 +0x5d
  github.com/mattermost/mattermost/server/v8/channels/web.(*Handler).ServeHTTP()
      <autogenerated>:1 +0xe7
  github.com/klauspost/compress/gzhttp.NewWrapper.func1.1()
      /go/pkg/mod/github.com/klauspost/[email protected]/gzhttp/compress.go:495 +0x7c6
  net/http.HandlerFunc.ServeHTTP()
      /usr/local/go/src/net/http/server.go:2171 +0x47
  github.com/gorilla/mux.(*Router).ServeHTTP()
      /go/pkg/mod/github.com/gorilla/[email protected]/mux.go:212 +0x371
  net/http.serverHandler.ServeHTTP()
      /usr/local/go/src/net/http/server.go:3142 +0x2a1
  net/http.(*conn).serve()
      /usr/local/go/src/net/http/server.go:2044 +0x13c4
  net/http.(*Server).Serve.gowrap3()
      /usr/local/go/src/net/http/server.go:3290 +0x4f

Goroutine 1202 (running) created at:
  github.com/mattermost/mattermost/server/v8/channels/app/platform.(*PlatformService).Go()
      /mattermost/server/channels/app/platform/goroutines.go:13 +0xec
  github.com/mattermost/mattermost/server/v8/channels/app.(*Server).Go()
      /mattermost/server/channels/app/server.go:805 +0x148
  github.com/mattermost/mattermost/server/v8/channels/app.(*App).SyncLdap()
      /mattermost/server/channels/app/ldap.go:21 +0x5d
  github.com/mattermost/mattermost/server/v8/channels/api4.syncLdap()
      /mattermost/server/channels/api4/ldap.go:69 +0x9de
  github.com/mattermost/mattermost/server/v8/channels/web.Handler.ServeHTTP()
      /mattermost/server/channels/web/handlers.go:387 +0x6645
  github.com/mattermost/mattermost/server/v8/channels/web.(*Handler).ServeHTTP()
      <autogenerated>:1 +0xe7
  github.com/klauspost/compress/gzhttp.NewWrapper.func1.1()
      /go/pkg/mod/github.com/klauspost/[email protected]/gzhttp/compress.go:495 +0x7c6
  net/http.HandlerFunc.ServeHTTP()
      /usr/local/go/src/net/http/server.go:2171 +0x47
  github.com/gorilla/mux.(*Router).ServeHTTP()
      /go/pkg/mod/github.com/gorilla/[email protected]/mux.go:212 +0x371
  net/http.serverHandler.ServeHTTP()
      /usr/local/go/src/net/http/server.go:3142 +0x2a1
  net/http.(*conn).serve()
      /usr/local/go/src/net/http/server.go:2044 +0x13c4
  net/http.(*Server).Serve.gowrap3()
      /usr/local/go/src/net/http/server.go:3290 +0x4f

Goroutine 988 (running) created at:
  net/http.(*Server).Serve()
      /usr/local/go/src/net/http/server.go:3290 +0x8ec
  github.com/mattermost/mattermost/server/v8/channels/app.(*Server).Start.func2()
      /mattermost/server/channels/app/server.go:1069 +0x224
==================
{"timestamp":"2024-09-23 14:51:00.031 Z","level":"debug","msg":"Received HTTP request","caller":"web/handlers.go:185","method":"POST","url":"/api/v4/ldap/sync","request_id":"cb3fitggbiyn9xrq6uenxi4ojy","user_id":"7yoaxrex6ingfn8jk5ycwri8pr","status_code":"200"}
    testing.go:1398: race detected during execution of test
--- FAIL: TestSyncLdap/SystemAdminClient#01 (0.01s)

Check failure on line 1 in com/mattermost/mattermost/server/v8/channels/api4

See this annotation in the file changed.

@github-actions github-actions / Postgres (Results)

com/mattermost/mattermost/server/v8/channels/api4.TestSyncLdap 

Failed
Raw output 
=== RUN   TestSyncLdap
{"timestamp":"2024-09-23 14:50:54.338 Z","level":"debug","msg":"Advanced logging config not provided for notification logging","caller":"platform/config.go:165"}
{"timestamp":"2024-09-23 14:50:54.338 Z","level":"info","msg":"Successfully connected to cache backend","caller":"platform/service.go:191","backend":"redis","result":"PONG"}
{"timestamp":"2024-09-23 14:50:54.338 Z","level":"info","msg":"Server is initializing...","caller":"platform/service.go:194","go_version":"go1.22.6"}
{"timestamp":"2024-09-23 14:50:54.341 Z","level":"info","msg":"Starting websocket hubs","caller":"platform/web_hub.go:106","number_of_hubs":4}
{"timestamp":"2024-09-23 14:50:54.341 Z","level":"debug","msg":"Hub is starting","caller":"platform/web_hub.go:386","index":0}
{"timestamp":"2024-09-23 14:50:54.341 Z","level":"debug","msg":"Hub is starting","caller":"platform/web_hub.go:386","index":2}
{"timestamp":"2024-09-23 14:50:54.341 Z","level":"debug","msg":"Hub is starting","caller":"platform/web_hub.go:386","index":1}
{"timestamp":"2024-09-23 14:50:54.341 Z","level":"debug","msg":"Hub is starting","caller":"platform/web_hub.go:386","index":3}
{"timestamp":"2024-09-23 14:50:54.342 Z","level":"info","msg":"Loaded system translations","caller":"i18n/i18n.go:175","for locale":"en","from locale":"/mattermost/server/i18n/en.json"}
{"timestamp":"2024-09-23 14:50:54.350 Z","level":"info","msg":"Ensuring the telemetry ID..","caller":"telemetry/telemetry.go:147"}
{"timestamp":"2024-09-23 14:50:54.351 Z","level":"info","msg":"telemetry ID is set","caller":"telemetry/telemetry.go:157","id":"8rn5sdq37td1txkfp5sdjard6w"}
{"timestamp":"2024-09-23 14:50:54.371 Z","level":"error","msg":"SiteURL must be set. Some features will operate incorrectly if the SiteURL is not set. See documentation for details: https://mattermost.com/pl/configure-site-url","caller":"app/server.go:389"}
{"timestamp":"2024-09-23 14:50:54.371 Z","level":"info","msg":"Current version is 10.1.0 (///)","caller":"app/server.go:403","current_version":"10.1.0","build_number":"","build_date":"","build_hash":"","build_hash_enterprise":"","service_environment":"dev"}
{"timestamp":"2024-09-23 14:50:54.371 Z","level":"info","msg":"Team Edition Build","caller":"app/server.go:419","enterprise_build":false}
{"timestamp":"2024-09-23 14:50:54.371 Z","level":"info","msg":"Printing current working","caller":"app/server.go:423","directory":"/tmp/testlib4078856353"}
{"timestamp":"2024-09-23 14:50:54.371 Z","level":"info","msg":"Loaded config","caller":"app/server.go:424","source":"memory://"}
{"timestamp":"2024-09-23 14:50:54.637 Z","level":"debug","msg":"initElasticsearchChannelIndexCheck: calling elasticsearchChannelIndexCheckWithRetry before setting up config and license change listeners...","caller":"app/elasticsearch.go:21"}
{"timestamp":"2024-09-23 14:50:54.637 Z","level":"debug","msg":"elasticsearchChannelIndexCheckWithRetry: attempting to check channel index state...","caller":"app/elasticsearch.go:64"}
{"timestamp":"2024-09-23 14:50:54.637 Z","level":"debug","msg":"elasticsearchChannelIndexCheckWithRetry: skipping because elasticsearch indexing is disabled","caller":"app/elasticsearch.go:67"}
{"timestamp":"2024-09-23 14:50:54.670 Z","level":"debug","msg":"Fetching user count for first user account check","caller":"platform/config.go:356"}
{"timestamp":"2024-09-23 14:50:54.673 Z","level":"info","msg":"Post.Message has size restrictions","caller":"sqlstore/post_store.go:2615","max_characters":16383,"max_bytes":65535}
{"timestamp":"2024-09-23 14:50:54.679 Z","level":"debug","msg":"Advanced logging config not provided for notification logging","caller":"platform/config.go:165"}
{"timestamp":"2024-09-23 14:50:54.679 Z","level":"info","msg":"Starting up plugins","caller":"app/plugin.go:191"}
{"timestamp":"2024-09-23 14:50:54.680 Z","level":"debug","msg":"Enabling plugin health check job","caller":"plugin/environment.go:661","interval_s":"30s"}
{"timestamp":"2024-09-23 14:50:54.680 Z","level":"info","msg":"Syncing plugins from the file store","caller":"app/plugin.go:268"}
{"timestamp":"2024-09-23 14:50:54.680 Z","level":"debug","msg":"Plugin health check job starting.","caller":"plugin/health_check.go:31"}
{"timestamp":"2024-09-23 14:50:54.680 Z","level":"info","msg":"No plugins to sync from the file store","caller":"app/plugin.go:311"}
{"timestamp":"2024-09-23 14:50:54.680 Z","level":"debug","msg":"No prepackaged plugins directory found","caller":"app/plugin.go:912"}
{"timestamp":"2024-09-23 14:50:54.680 Z","level":"debug","msg":"Not persisting transitionally prepackaged plugins: none found","caller":"app/plugin.go:1184"}
{"timestamp":"2024-09-23 14:50:54.685 Z","level":"debug","msg":"Able to write files to local storage.","caller":"filestore/localstore.go:82"}
{"timestamp":"2024-09-23 14:50:54.704 Z","level":"info","msg":"Starting Server...","caller":"app/server.go:886"}
{"timestamp":"2024-09-23 14:50:54.705 Z","level":"info","msg":"Server is listening on 127.0.0.1:36049","caller":"app/server.go:962","address":"127.0.0.1:36049"}
{"timestamp":"2024-09-23 14:50:54.705 Z","level":"debug","msg":"No license provided; Remote Cluster services disabled","caller":"app/server.go:579"}
{"timestamp":"2024-09-23 14:50:54.783 Z","level":"debug","msg":"Initializing web routes","caller":"web/web.go:26"}
{"timestamp":"2024-09-23 14:50:54.785 Z","level":"debug","msg":"Skipping update to assets subpath since CI build","caller":"utils/subpath.go:187"}
{"timestamp":"2024-09-23 14:50:54.785 Z","level":"debug","msg":"Using client directory","caller":"web/static.go:34","clientDir":"/tmp/testlib4078856353/client"}
{"timestamp":"2024-09-23 14:50:54.785 Z","level":"debug","msg":"Configured Client4 bool string values","caller":"api4/apitestlib.go:212","true":"T","false":"0"}
{"timestamp":"2024-09-23 14:50:54.788 Z","level":"debug","msg":"Fetching user count for first user account check","caller":"platform/config.go:356"}
{"timestamp":"2024-09-23 14:50:55.618 Z","level":"debug","msg":"sending mail","caller":"mail/mail.go:295","to":"tib3m6tmmjg6mcxotng33us9jc@localhost","subject":"[Mattermost] You joined "}
{"timestamp":"2024-09-23 14:50:55.636 Z","level":"debug","msg":"Received HTTP request","caller":"web/handlers.go:185","method":"POST","url":"/api/v4/users","request_id":"3x8tbhnw5fgouyepnztqj85xar","user_id":"","status_code":"201"}
{"timestamp":"2024-09-23 14:50:55.650 Z","level":"debug","msg":"Fetching user count for first user account check","caller":"platform/config.go:356"}
{"timestamp":"2024-09-23 14:50:56.488 Z","level":"debug","msg":"sending mail","caller":"mail/mail.go:295","to":"ti65amprzfn3bf8hdt3izx5qyy@localhost","subject":"[Mattermost] You joined "}
{"timestamp":"2024-09-23 14:50:56.505 Z","level":"debug","msg":"Received HTTP request","caller":"web/handlers.go:185","method":"POST","url":"/api/v4/users","request_id":"qh3z9iso37rhuphbnt4hzangty","user_id":"","status_code":"201"}
{"timestamp":"2024-09-23 14:50:57.361 Z","level":"debug","msg":"sending mail","caller":"mail/mail.go:295","to":"81kxesktjtgktr8akf5u8mqy9w@localhost","subject":"[Mattermost] You joined "}
{"timestamp":"2024-09-23 14:50:57.378 Z","level":"debug","msg":"Received HTTP request","caller":"web/handlers.go:185","method":"POST","url":"/api/v4/users","request_id":"p8xxg1uysffb5q8orfxxfxn3je","user_id":"","status_code":"201"}
{"timestamp":"2024-09-23 14:50:58.227 Z","level":"debug","msg":"sending mail","caller":"mail/mail.go:295","to":"75t5zgoswjn48q1a8x1m5zwdyo@localhost","subject":"[Mattermost] You joined "}
{"timestamp":"2024-09-23 14:50:58.245 Z","level":"debug","msg":"Received HTTP request","caller":"web/handlers.go:185","method":"POST","url":"/api/v4/users","request_id":"z58hhuwpmjguuka5sk9qorcg8o","user_id":"","status_code":"201"}
{"timestamp":"2024-09-23 14:50:59.090 Z","level":"debug","msg":"sending mail","caller":"mail/mail.go:295","to":"pke6qe3m7jnqxnmyzt15je314y@localhost","subject":"[Mattermost] You joined "}
{"timestamp":"2024-09-23 14:50:59.107 Z","level":"debug","msg":"Received HTTP request","caller":"web/handlers.go:185","method":"POST","url":"/api/v4/users","request_id":"s8z9wi8to7r6jb5cgydx5bxaow","user_id":"","status_code":"201"}
{"timestamp":"2024-09-23 14:50:59.982 Z","level":"debug","msg":"Received HTTP request","caller":"web/handlers.go:185","method":"POST","url":"/api/v4/users/login","request_id":"m6j9pbpbnb867jrdgnj7sfk1qa","user_id":"hmxgkmqtyi8qpc6mq4ngybf31e","status_code":"200"}
{"timestamp":"2024-09-23 14:50:59.985 Z","level":"debug","msg":"Received HTTP request","caller":"web/handlers.go:185","method":"POST","url":"/api/v4/users/login","request_id":"4egs4gku338b5p4fmktq37u61y","user_id":"7yoaxrex6ingfn8jk5ycwri8pr","status_code":"200"}
{"timestamp":"2024-09-23 14:51:00.023 Z","level":"debug","msg":"Advanced logging config not provided for notification logging","caller":"platform/config.go:165"}
{"timestamp":"2024-09-23 14:51:00.034 Z","level":"debug","msg":"You do not have the appropriate permissions.","caller":"web/context.go:120","path":"/api/v4/ldap/sync","request_id":"z54ugf7yjifhmbwhxxhbw6444c","ip_addr":"127.0.0.1","user_id":"hmxgkmqtyi8qpc6mq4ngybf31e","method":"POST","err_where":"Permissions","http_code":403,"error":"Permissions: You do not have the appropriate permissions., userId=hmxgkmqtyi8qpc6mq4ngybf31e, permission=create_ldap_sync_job"}
{"timestamp":"2024-09-23 14:51:00.034 Z","level":"debug","msg":"Received HTTP request","caller":"web/handlers.go:185","method":"POST","url":"/api/v4/ldap/sync","request_id":"z54ugf7yjifhmbwhxxhbw6444c","user_id":"hmxgkmqtyi8qpc6mq4ngybf31e","status_code":"403"}
{"timestamp":"2024-09-23 14:51:00.034 Z","level":"info","msg":"Purging all caches","caller":"platform/cluster_handlers.go:114"}
{"timestamp":"2024-09-23 14:51:00.037 Z","level":"info","msg":"License key has not been uploaded. Loading license key from disk.","caller":"utils/license.go:107","filename":"/tmp/testlib4078856353/config/mattermost.mattermost-license"}
{"timestamp":"2024-09-23 14:51:00.037 Z","level":"warn","msg":"Failed to get license from disk","caller":"platform/license.go:93","error":"We could not find the license key on disk at /tmp/testlib4078856353/config/mattermost.mattermost-license: stat /tmp/testlib4078856353/config/mattermost.mattermost-license: no such file or directory"}
{"timestamp":"2024-09-23 14:51:00.037 Z","level":"warn","msg":"License key from https://mattermost.com required to unlock enterprise features.","caller":"platform/license.go:105","error":"resource \"License\" not found, id: "}
{"timestamp":"2024-09-23 14:51:00.040 Z","level":"info","msg":"Stopping Server...","caller":"app/server.go:668"}
{"timestamp":"2024-09-23 14:51:00.046 Z","level":"info","msg":"Shutting down Email batching service...","caller":"email/service.go:85"}
{"timestamp":"2024-09-23 14:51:00.046 Z","level":"info","msg":"Shutting down plugins","caller":"app/plugin.go:362"}
{"timestamp":"2024-09-23 14:51:00.046 Z","level":"debug","msg":"Disabling plugin health check job","caller":"plugin/environment.go:670"}
{"timestamp":"2024-09-23 14:51:00.046 Z","level":"info","msg":"stopping websocket hub connections","caller":"platform/web_hub.go:127"}
{"timestamp":"2024-09-23 14:51:00.047 Z","level":"info","msg":"Server stopped","caller":"app/server.go:752"}
--- FAIL: TestSyncLdap (5.79s)

Check failure on line 1 in com/mattermost/mattermost/server/v8/channels/api4

See this annotation in the file changed.

@github-actions github-actions / Postgres (Results)

com/mattermost/mattermost/server/v8/channels/api4.TestSyncLdap/SystemAdminClient#01 

Failed
Raw output 
=== RUN   TestSyncLdap/SystemAdminClient#01
{"timestamp":"2024-09-23 14:51:11.018 Z","level":"debug","msg":"Received HTTP request","caller":"web/handlers.go:185","method":"POST","url":"/api/v4/ldap/sync","request_id":"8zmf7jcbc3d57qp93a7n3ot53e","user_id":"jhapyouz938pfjsgbcjjf9frph","status_code":"200"}
==================
WARNING: DATA RACE
Read at 0x00c00153a870 by goroutine 1201:
  reflect.maplen()
      /usr/local/go/src/runtime/map.go:1406 +0x0
  reflect.Value.lenNonSlice()
      /usr/local/go/src/reflect/value.go:1785 +0x1e9
  reflect.Value.Len()
      /usr/local/go/src/reflect/value.go:1774 +0x137
  internal/fmtsort.Sort()
      /usr/local/go/src/internal/fmtsort/sort.go:58 +0x121
  fmt.(*pp).printValue()
      /usr/local/go/src/fmt/print.go:816 +0x1144
  fmt.(*pp).printValue()
      /usr/local/go/src/fmt/print.go:853 +0x1d3e
  fmt.(*pp).printValue()
      /usr/local/go/src/fmt/print.go:853 +0x1d3e
  fmt.(*pp).printValue()
      /usr/local/go/src/fmt/print.go:921 +0x132a
  fmt.(*pp).printArg()
      /usr/local/go/src/fmt/print.go:759 +0xb84
  fmt.(*pp).doPrintf()
      /usr/local/go/src/fmt/print.go:1174 +0x10ce
  fmt.Sprintf()
      /usr/local/go/src/fmt/print.go:239 +0x5c
  github.com/stretchr/testify/mock.Arguments.Diff()
      /go/pkg/mod/github.com/stretchr/[email protected]/mock/mock.go:939 +0x1b2
  github.com/stretchr/testify/mock.(*Mock).findExpectedCall()
      /go/pkg/mod/github.com/stretchr/[email protected]/mock/mock.go:368 +0x147
  github.com/stretchr/testify/mock.(*Mock).MethodCalled()
      /go/pkg/mod/github.com/stretchr/[email protected]/mock/mock.go:476 +0xac
  github.com/stretchr/testify/mock.(*Mock).Called()
      /go/pkg/mod/github.com/stretchr/[email protected]/mock/mock.go:466 +0x195
  github.com/mattermost/mattermost/server/v8/einterfaces/mocks.(*LdapInterface).StartSynchronizeJob()
      /mattermost/server/einterfaces/mocks/LdapInterface.go:406 +0x1b0
  github.com/mattermost/mattermost/server/v8/channels/app.(*App).SyncLdap.func1()
      /mattermost/server/channels/app/ldap.go:33 +0x1d8
  github.com/mattermost/mattermost/server/v8/channels/app/platform.(*PlatformService).Go.func1()
      /mattermost/server/channels/app/platform/goroutines.go:14 +0x37

Previous write at 0x00c00153a870 by goroutine 1153:
  runtime.mapclear()
      /usr/local/go/src/runtime/map.go:989 +0x0
  github.com/mattermost/mattermost/server/v8/channels/app/platform.(*PlatformService).ReturnSessionToPool()
      /mattermost/server/channels/app/platform/session.go:22 +0xd1
  github.com/mattermost/mattermost/server/v8/channels/app.(*App).ReturnSessionToPool()
      /mattermost/server/channels/app/session.go:227 +0x26
  github.com/mattermost/mattermost/server/v8/channels/web.Handler.ServeHTTP.deferwrap1()
      /mattermost/server/channels/web/handlers.go:295 +0x55
  runtime.deferreturn()
      /usr/local/go/src/runtime/panic.go:602 +0x5d
  github.com/mattermost/mattermost/server/v8/channels/web.(*Handler).ServeHTTP()
      <autogenerated>:1 +0xe7
  github.com/klauspost/compress/gzhttp.NewWrapper.func1.1()
      /go/pkg/mod/github.com/klauspost/[email protected]/gzhttp/compress.go:495 +0x7c6
  net/http.HandlerFunc.ServeHTTP()
      /usr/local/go/src/net/http/server.go:2171 +0x47
  github.com/gorilla/mux.(*Router).ServeHTTP()
      /go/pkg/mod/github.com/gorilla/[email protected]/mux.go:212 +0x371
  net/http.serverHandler.ServeHTTP()
      /usr/local/go/src/net/http/server.go:3142 +0x2a1
  net/http.(*conn).serve()
      /usr/local/go/src/net/http/server.go:2044 +0x13c4
  net/http.(*Server).Serve.gowrap3()
      /usr/local/go/src/net/http/server.go:3290 +0x4f

Goroutine 1201 (running) created at:
  github.com/mattermost/mattermost/server/v8/channels/app/platform.(*PlatformService).Go()
      /mattermost/server/channels/app/platform/goroutines.go:13 +0xec
  github.com/mattermost/mattermost/server/v8/channels/app.(*Server).Go()
      /mattermost/server/channels/app/server.go:805 +0x148
  github.com/mattermost/mattermost/server/v8/channels/app.(*App).SyncLdap()
      /mattermost/server/channels/app/ldap.go:21 +0x5d
  github.com/mattermost/mattermost/server/v8/channels/api4.syncLdap()
      /mattermost/server/channels/api4/ldap.go:69 +0x9de
  github.com/mattermost/mattermost/server/v8/channels/web.Handler.ServeHTTP()
      /mattermost/server/channels/web/handlers.go:387 +0x6645
  github.com/mattermost/mattermost/server/v8/channels/web.(*Handler).ServeHTTP()
      <autogenerated>:1 +0xe7
  github.com/klauspost/compress/gzhttp.NewWrapper.func1.1()
      /go/pkg/mod/github.com/klauspost/[email protected]/gzhttp/compress.go:495 +0x7c6
  net/http.HandlerFunc.ServeHTTP()
      /usr/local/go/src/net/http/server.go:2171 +0x47
  github.com/gorilla/mux.(*Router).ServeHTTP()
      /go/pkg/mod/github.com/gorilla/[email protected]/mux.go:212 +0x371
  net/http.serverHandler.ServeHTTP()
      /usr/local/go/src/net/http/server.go:3142 +0x2a1
  net/http.(*conn).serve()
      /usr/local/go/src/net/http/server.go:2044 +0x13c4
  net/http.(*Server).Serve.gowrap3()
      /usr/local/go/src/net/http/server.go:3290 +0x4f

Goroutine 1153 (running) created at:
  net/http.(*Server).Serve()
      /usr/local/go/src/net/http/server.go:3290 +0x8ec
  github.com/mattermost/mattermost/server/v8/channels/app.(*Server).Start.func2()
      /mattermost/server/channels/app/server.go:1069 +0x224
==================
{"timestamp":"2024-09-23 14:51:11.021 Z","level":"debug","msg":"Received HTTP request","caller":"web/handlers.go:185","method":"POST","url":"/api/v4/ldap/sync","request_id":"e5q387um4t8kbfzp3zpumhdmte","user_id":"jhapyouz938pfjsgbcjjf9frph","status_code":"200"}
    testing.go:1398: race detected during execution of test
--- FAIL: TestSyncLdap/SystemAdminClient#01 (0.01s)

Check failure on line 1 in com/mattermost/mattermost/server/v8/channels/api4

See this annotation in the file changed.

@github-actions github-actions / Postgres (Results)

com/mattermost/mattermost/server/v8/channels/api4.TestSyncLdap 

Failed
Raw output 
=== RUN   TestSyncLdap
{"timestamp":"2024-09-23 14:51:05.291 Z","level":"debug","msg":"Advanced logging config not provided for notification logging","caller":"platform/config.go:165"}
{"timestamp":"2024-09-23 14:51:05.291 Z","level":"info","msg":"Successfully connected to cache backend","caller":"platform/service.go:191","backend":"redis","result":"PONG"}
{"timestamp":"2024-09-23 14:51:05.291 Z","level":"info","msg":"Server is initializing...","caller":"platform/service.go:194","go_version":"go1.22.6"}
{"timestamp":"2024-09-23 14:51:05.294 Z","level":"info","msg":"Starting websocket hubs","caller":"platform/web_hub.go:106","number_of_hubs":4}
{"timestamp":"2024-09-23 14:51:05.294 Z","level":"debug","msg":"Hub is starting","caller":"platform/web_hub.go:386","index":0}
{"timestamp":"2024-09-23 14:51:05.294 Z","level":"debug","msg":"Hub is starting","caller":"platform/web_hub.go:386","index":1}
{"timestamp":"2024-09-23 14:51:05.294 Z","level":"debug","msg":"Hub is starting","caller":"platform/web_hub.go:386","index":2}
{"timestamp":"2024-09-23 14:51:05.294 Z","level":"debug","msg":"Hub is starting","caller":"platform/web_hub.go:386","index":3}
{"timestamp":"2024-09-23 14:51:05.295 Z","level":"info","msg":"Loaded system translations","caller":"i18n/i18n.go:175","for locale":"en","from locale":"/mattermost/server/i18n/en.json"}
{"timestamp":"2024-09-23 14:51:05.303 Z","level":"info","msg":"Ensuring the telemetry ID..","caller":"telemetry/telemetry.go:147"}
{"timestamp":"2024-09-23 14:51:05.304 Z","level":"info","msg":"telemetry ID is set","caller":"telemetry/telemetry.go:157","id":"7oinha7atfbpubg9wjxbgqtbhy"}
{"timestamp":"2024-09-23 14:51:05.324 Z","level":"error","msg":"SiteURL must be set. Some features will operate incorrectly if the SiteURL is not set. See documentation for details: https://mattermost.com/pl/configure-site-url","caller":"app/server.go:389"}
{"timestamp":"2024-09-23 14:51:05.324 Z","level":"info","msg":"Current version is 10.1.0 (///)","caller":"app/server.go:403","current_version":"10.1.0","build_number":"","build_date":"","build_hash":"","build_hash_enterprise":"","service_environment":"dev"}
{"timestamp":"2024-09-23 14:51:05.324 Z","level":"info","msg":"Team Edition Build","caller":"app/server.go:419","enterprise_build":false}
{"timestamp":"2024-09-23 14:51:05.324 Z","level":"info","msg":"Printing current working","caller":"app/server.go:423","directory":"/tmp/testlib344760724"}
{"timestamp":"2024-09-23 14:51:05.324 Z","level":"info","msg":"Loaded config","caller":"app/server.go:424","source":"memory://"}
{"timestamp":"2024-09-23 14:51:05.589 Z","level":"debug","msg":"initElasticsearchChannelIndexCheck: calling elasticsearchChannelIndexCheckWithRetry before setting up config and license change listeners...","caller":"app/elasticsearch.go:21"}
{"timestamp":"2024-09-23 14:51:05.590 Z","level":"debug","msg":"elasticsearchChannelIndexCheckWithRetry: attempting to check channel index state...","caller":"app/elasticsearch.go:64"}
{"timestamp":"2024-09-23 14:51:05.590 Z","level":"debug","msg":"elasticsearchChannelIndexCheckWithRetry: skipping because elasticsearch indexing is disabled","caller":"app/elasticsearch.go:67"}
{"timestamp":"2024-09-23 14:51:05.623 Z","level":"debug","msg":"Fetching user count for first user account check","caller":"platform/config.go:356"}
{"timestamp":"2024-09-23 14:51:05.626 Z","level":"info","msg":"Post.Message has size restrictions","caller":"sqlstore/post_store.go:2615","max_characters":16383,"max_bytes":65535}
{"timestamp":"2024-09-23 14:51:05.631 Z","level":"debug","msg":"Advanced logging config not provided for notification logging","caller":"platform/config.go:165"}
{"timestamp":"2024-09-23 14:51:05.631 Z","level":"info","msg":"Starting up plugins","caller":"app/plugin.go:191"}
{"timestamp":"2024-09-23 14:51:05.631 Z","level":"debug","msg":"Enabling plugin health check job","caller":"plugin/environment.go:661","interval_s":"30s"}
{"timestamp":"2024-09-23 14:51:05.631 Z","level":"info","msg":"Syncing plugins from the file store","caller":"app/plugin.go:268"}
{"timestamp":"2024-09-23 14:51:05.631 Z","level":"debug","msg":"Plugin health check job starting.","caller":"plugin/health_check.go:31"}
{"timestamp":"2024-09-23 14:51:05.631 Z","level":"info","msg":"No plugins to sync from the file store","caller":"app/plugin.go:311"}
{"timestamp":"2024-09-23 14:51:05.632 Z","level":"debug","msg":"No prepackaged plugins directory found","caller":"app/plugin.go:912"}
{"timestamp":"2024-09-23 14:51:05.632 Z","level":"debug","msg":"Not persisting transitionally prepackaged plugins: none found","caller":"app/plugin.go:1184"}
{"timestamp":"2024-09-23 14:51:05.636 Z","level":"debug","msg":"Able to write files to local storage.","caller":"filestore/localstore.go:82"}
{"timestamp":"2024-09-23 14:51:05.655 Z","level":"info","msg":"Starting Server...","caller":"app/server.go:886"}
{"timestamp":"2024-09-23 14:51:05.655 Z","level":"info","msg":"Server is listening on 127.0.0.1:32979","caller":"app/server.go:962","address":"127.0.0.1:32979"}
{"timestamp":"2024-09-23 14:51:05.655 Z","level":"debug","msg":"No license provided; Remote Cluster services disabled","caller":"app/server.go:579"}
{"timestamp":"2024-09-23 14:51:05.720 Z","level":"debug","msg":"Initializing web routes","caller":"web/web.go:26"}
{"timestamp":"2024-09-23 14:51:05.722 Z","level":"debug","msg":"Skipping update to assets subpath since CI build","caller":"utils/subpath.go:187"}
{"timestamp":"2024-09-23 14:51:05.722 Z","level":"debug","msg":"Using client directory","caller":"web/static.go:34","clientDir":"/tmp/testlib344760724/client"}
{"timestamp":"2024-09-23 14:51:05.722 Z","level":"debug","msg":"Configured Client4 bool string values","caller":"api4/apitestlib.go:212","true":"T","false":"False"}
{"timestamp":"2024-09-23 14:51:05.726 Z","level":"debug","msg":"Fetching user count for first user account check","caller":"platform/config.go:356"}
{"timestamp":"2024-09-23 14:51:06.575 Z","level":"debug","msg":"sending mail","caller":"mail/mail.go:295","to":"wq1my197yiytu8kemgdsn5bteo@localhost","subject":"[Mattermost] You joined "}
{"timestamp":"2024-09-23 14:51:06.605 Z","level":"debug","msg":"Received HTTP request","caller":"web/handlers.go:185","method":"POST","url":"/api/v4/users","request_id":"8j56fc1b3byntf87bbo33iydth","user_id":"","status_code":"201"}
{"timestamp":"2024-09-23 14:51:06.619 Z","level":"debug","msg":"Fetching user count for first user account check","caller":"platform/config.go:356"}
{"timestamp":"2024-09-23 14:51:07.461 Z","level":"debug","msg":"sending mail","caller":"mail/mail.go:295","to":"ncg88xjaapdy9y7a3dxjkcxnmh@localhost","subject":"[Mattermost] You joined "}
{"timestamp":"2024-09-23 14:51:07.477 Z","level":"debug","msg":"Received HTTP request","caller":"web/handlers.go:185","method":"POST","url":"/api/v4/users","request_id":"d6y5cqs15ifb8rgayj4t6817ry","user_id":"","status_code":"201"}
{"timestamp":"2024-09-23 14:51:08.340 Z","level":"debug","msg":"sending mail","caller":"mail/mail.go:295","to":"rh443pz8ei8ribkdqp6n1yj8de@localhost","subject":"[Mattermost] You joined "}
{"timestamp":"2024-09-23 14:51:08.357 Z","level":"debug","msg":"Received HTTP request","caller":"web/handlers.go:185","method":"POST","url":"/api/v4/users","request_id":"du6cofhoj78xjmsiiwrpxcx3wa","user_id":"","status_code":"201"}
{"timestamp":"2024-09-23 14:51:09.198 Z","level":"debug","msg":"sending mail","caller":"mail/mail.go:295","to":"bsgqtiedubds5jd1f1c8mswoio@localhost","subject":"[Mattermost] You joined "}
{"timestamp":"2024-09-23 14:51:09.216 Z","level":"debug","msg":"Received HTTP request","caller":"web/handlers.go:185","method":"POST","url":"/api/v4/users","request_id":"wpdwctzgmfn3xddby1fsidb5ga","user_id":"","status_code":"201"}
{"timestamp":"2024-09-23 14:51:10.076 Z","level":"debug","msg":"sending mail","caller":"mail/mail.go:295","to":"u6wiw1bqyfbwj83e6dwota8sdc@localhost","subject":"[Mattermost] You joined "}
{"timestamp":"2024-09-23 14:51:10.094 Z","level":"debug","msg":"Received HTTP request","caller":"web/handlers.go:185","method":"POST","url":"/api/v4/users","request_id":"atto734ckpd9ijh77tugtssjcw","user_id":"","status_code":"201"}
{"timestamp":"2024-09-23 14:51:10.974 Z","level":"debug","msg":"Received HTTP request","caller":"web/handlers.go:185","method":"POST","url":"/api/v4/users/login","request_id":"6acncggeutgitp9pgr3je13buo","user_id":"k8dycik3qj89pxhq9pjrntwyjh","status_code":"200"}
{"timestamp":"2024-09-23 14:51:10.977 Z","level":"debug","msg":"Received HTTP request","caller":"web/handlers.go:185","method":"POST","url":"/api/v4/users/login","request_id":"p6nif7ct7byube8njmwo78b6ry","user_id":"jhapyouz938pfjsgbcjjf9frph","status_code":"200"}
{"timestamp":"2024-09-23 14:51:11.015 Z","level":"debug","msg":"Advanced logging config not provided for notification logging","caller":"platform/config.go:165"}
{"timestamp":"2024-09-23 14:51:11.024 Z","level":"debug","msg":"You do not have the appropriate permissions.","caller":"web/context.go:120","path":"/api/v4/ldap/sync","request_id":"7efwbnh8pjbo8rp3eoabwej9na","ip_addr":"127.0.0.1","user_id":"k8dycik3qj89pxhq9pjrntwyjh","method":"POST","err_where":"Permissions","http_code":403,"error":"Permissions: You do not have the appropriate permissions., userId=k8dycik3qj89pxhq9pjrntwyjh, permission=create_ldap_sync_job"}
{"timestamp":"2024-09-23 14:51:11.024 Z","level":"debug","msg":"Received HTTP request","caller":"web/handlers.go:185","method":"POST","url":"/api/v4/ldap/sync","request_id":"7efwbnh8pjbo8rp3eoabwej9na","user_id":"k8dycik3qj89pxhq9pjrntwyjh","status_code":"403"}
{"timestamp":"2024-09-23 14:51:11.025 Z","level":"info","msg":"Purging all caches","caller":"platform/cluster_handlers.go:114"}
{"timestamp":"2024-09-23 14:51:11.027 Z","level":"info","msg":"License key has not been uploaded. Loading license key from disk.","caller":"utils/license.go:107","filename":"/tmp/testlib344760724/config/mattermost.mattermost-license"}
{"timestamp":"2024-09-23 14:51:11.027 Z","level":"warn","msg":"Failed to get license from disk","caller":"platform/license.go:93","error":"We could not find the license key on disk at /tmp/testlib344760724/config/mattermost.mattermost-license: stat /tmp/testlib344760724/config/mattermost.mattermost-license: no such file or directory"}
{"timestamp":"2024-09-23 14:51:11.028 Z","level":"warn","msg":"License key from https://mattermost.com required to unlock enterprise features.","caller":"platform/license.go:105","error":"resource \"License\" not found, id: "}
{"timestamp":"2024-09-23 14:51:11.033 Z","level":"info","msg":"Stopping Server...","caller":"app/server.go:668"}
{"timestamp":"2024-09-23 14:51:11.036 Z","level":"info","msg":"Shutting down Email batching service...","caller":"email/service.go:85"}
{"timestamp":"2024-09-23 14:51:11.036 Z","level":"info","msg":"Shutting down plugins","caller":"app/plugin.go:362"}
{"timestamp":"2024-09-23 14:51:11.036 Z","level":"debug","msg":"Disabling plugin health check job","caller":"plugin/environment.go:670"}
{"timestamp":"2024-09-23 14:51:11.036 Z","level":"info","msg":"stopping websocket hub connections","caller":"platform/web_hub.go:127"}
{"timestamp":"2024-09-23 14:51:11.037 Z","level":"info","msg":"Server stopped","caller":"app/server.go:752"}
--- FAIL: TestSyncLdap (5.83s)
View more details on GitHub Actions