Skip to content
API

从offsoc/autofix/alert-109-1e8f24ea56合并拉取请求#6 #13

Sign in to view logs

从offsoc/autofix/alert-109-1e8f24ea56合并拉取请求#6

从offsoc/autofix/alert-109-1e8f24ea56合并拉取请求#6 #13

GitHub Actions / MySQL (Results) failed Sep 25, 2024 in 0s

12894 tests run, 12826 passed, 60 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 / MySQL (Results)

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

Failed
Raw output 
=== RUN   TestSyncLdap/SystemAdminClient#01
{"timestamp":"2024-09-25 18:50:01.974 Z","level":"debug","msg":"Advanced logging config not provided for notification logging","caller":"platform/config.go:165"}
{"timestamp":"2024-09-25 18:50:01.978 Z","level":"debug","msg":"Received HTTP request","caller":"web/handlers.go:185","method":"POST","url":"/api/v4/ldap/sync","request_id":"g1nmczyi5f8998sss3dqd8t46a","user_id":"oq1emqunt3ni8gesu3pze78x9a","status_code":"200"}
==================
WARNING: DATA RACE
Read at 0x00c004d4e570 by goroutine 141057:
  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 0x00c004d4e570 by goroutine 141020:
  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 141057 (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:806 +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 141020 (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:1070 +0x224
==================
{"timestamp":"2024-09-25 18:50:01.980 Z","level":"debug","msg":"Received HTTP request","caller":"web/handlers.go:185","method":"POST","url":"/api/v4/ldap/sync","request_id":"99rfcfekgtfgbmsdpiw63wi5kc","user_id":"oq1emqunt3ni8gesu3pze78x9a","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 / MySQL (Results)

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

Failed
Raw output 
=== RUN   TestSyncLdap
{"timestamp":"2024-09-25 18:50:00.677 Z","level":"debug","msg":"Advanced logging config not provided for notification logging","caller":"platform/config.go:165"}
{"timestamp":"2024-09-25 18:50:00.677 Z","level":"info","msg":"Successfully connected to cache backend","caller":"platform/service.go:191","backend":"lru","result":"OK"}
{"timestamp":"2024-09-25 18:50:00.677 Z","level":"info","msg":"Server is initializing...","caller":"platform/service.go:194","go_version":"go1.22.6"}
{"timestamp":"2024-09-25 18:50:00.682 Z","level":"info","msg":"Starting websocket hubs","caller":"platform/web_hub.go:106","number_of_hubs":4}
{"timestamp":"2024-09-25 18:50:00.682 Z","level":"debug","msg":"Hub is starting","caller":"platform/web_hub.go:386","index":1}
{"timestamp":"2024-09-25 18:50:00.682 Z","level":"debug","msg":"Hub is starting","caller":"platform/web_hub.go:386","index":0}
{"timestamp":"2024-09-25 18:50:00.682 Z","level":"debug","msg":"Hub is starting","caller":"platform/web_hub.go:386","index":2}
{"timestamp":"2024-09-25 18:50:00.682 Z","level":"debug","msg":"Hub is starting","caller":"platform/web_hub.go:386","index":3}
{"timestamp":"2024-09-25 18:50:00.683 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-25 18:50:00.690 Z","level":"info","msg":"Ensuring the telemetry ID..","caller":"telemetry/telemetry.go:147"}
{"timestamp":"2024-09-25 18:50:00.691 Z","level":"info","msg":"telemetry ID is set","caller":"telemetry/telemetry.go:157","id":"p5bqnhgg53r6u8r413g47i5g4h"}
{"timestamp":"2024-09-25 18:50:00.710 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:390"}
{"timestamp":"2024-09-25 18:50:00.710 Z","level":"info","msg":"Current version is 10.1.0 (///)","caller":"app/server.go:404","current_version":"10.1.0","build_number":"","build_date":"","build_hash":"","build_hash_enterprise":"","service_environment":"dev"}
{"timestamp":"2024-09-25 18:50:00.710 Z","level":"info","msg":"Team Edition Build","caller":"app/server.go:420","enterprise_build":false}
{"timestamp":"2024-09-25 18:50:00.710 Z","level":"info","msg":"Printing current working","caller":"app/server.go:424","directory":"/tmp/testlib2048900104"}
{"timestamp":"2024-09-25 18:50:00.710 Z","level":"info","msg":"Loaded config","caller":"app/server.go:425","source":"memory://"}
{"timestamp":"2024-09-25 18:50:00.919 Z","level":"debug","msg":"initElasticsearchChannelIndexCheck: calling elasticsearchChannelIndexCheckWithRetry before setting up config and license change listeners...","caller":"app/elasticsearch.go:21"}
{"timestamp":"2024-09-25 18:50:00.919 Z","level":"debug","msg":"elasticsearchChannelIndexCheckWithRetry: attempting to check channel index state...","caller":"app/elasticsearch.go:64"}
{"timestamp":"2024-09-25 18:50:00.919 Z","level":"debug","msg":"elasticsearchChannelIndexCheckWithRetry: skipping because elasticsearch indexing is disabled","caller":"app/elasticsearch.go:67"}
{"timestamp":"2024-09-25 18:50:00.951 Z","level":"debug","msg":"Fetching user count for first user account check","caller":"platform/config.go:356"}
{"timestamp":"2024-09-25 18:50:00.957 Z","level":"debug","msg":"Advanced logging config not provided for notification logging","caller":"platform/config.go:165"}
{"timestamp":"2024-09-25 18:50:00.957 Z","level":"info","msg":"Starting up plugins","caller":"app/plugin.go:191"}
{"timestamp":"2024-09-25 18:50:00.957 Z","level":"debug","msg":"Enabling plugin health check job","caller":"plugin/environment.go:661","interval_s":"30s"}
{"timestamp":"2024-09-25 18:50:00.957 Z","level":"info","msg":"Syncing plugins from the file store","caller":"app/plugin.go:268"}
{"timestamp":"2024-09-25 18:50:00.957 Z","level":"debug","msg":"Plugin health check job starting.","caller":"plugin/health_check.go:31"}
{"timestamp":"2024-09-25 18:50:00.958 Z","level":"info","msg":"No plugins to sync from the file store","caller":"app/plugin.go:311"}
{"timestamp":"2024-09-25 18:50:00.958 Z","level":"debug","msg":"No prepackaged plugins directory found","caller":"app/plugin.go:912"}
{"timestamp":"2024-09-25 18:50:00.958 Z","level":"debug","msg":"Not persisting transitionally prepackaged plugins: none found","caller":"app/plugin.go:1184"}
{"timestamp":"2024-09-25 18:50:00.963 Z","level":"debug","msg":"Able to write files to local storage.","caller":"filestore/localstore.go:82"}
{"timestamp":"2024-09-25 18:50:00.982 Z","level":"info","msg":"Starting Server...","caller":"app/server.go:887"}
{"timestamp":"2024-09-25 18:50:00.982 Z","level":"info","msg":"Server is listening on 127.0.0.1:37519","caller":"app/server.go:963","address":"127.0.0.1:37519"}
{"timestamp":"2024-09-25 18:50:00.982 Z","level":"debug","msg":"No license provided; Remote Cluster services disabled","caller":"app/server.go:580"}
{"timestamp":"2024-09-25 18:50:01.039 Z","level":"debug","msg":"Initializing web routes","caller":"web/web.go:26"}
{"timestamp":"2024-09-25 18:50:01.040 Z","level":"debug","msg":"Skipping update to assets subpath since CI build","caller":"utils/subpath.go:187"}
{"timestamp":"2024-09-25 18:50:01.040 Z","level":"debug","msg":"Using client directory","caller":"web/static.go:34","clientDir":"/tmp/testlib2048900104/client"}
{"timestamp":"2024-09-25 18:50:01.040 Z","level":"debug","msg":"Configured Client4 bool string values","caller":"api4/apitestlib.go:212","true":"1","false":"false"}
{"timestamp":"2024-09-25 18:50:01.928 Z","level":"debug","msg":"Received HTTP request","caller":"web/handlers.go:185","method":"POST","url":"/api/v4/users/login","request_id":"dc95qton9pbufjgdjzpju6qfcw","user_id":"oq1emqunt3ni8gesu3pze78x9a","status_code":"200"}
{"timestamp":"2024-09-25 18:50:01.932 Z","level":"debug","msg":"Received HTTP request","caller":"web/handlers.go:185","method":"POST","url":"/api/v4/users/login","request_id":"hboafybfmf8jugsy8jksojye4y","user_id":"jkqya8htxfynfqqdaha4u35raa","status_code":"200"}
{"timestamp":"2024-09-25 18:50:01.968 Z","level":"debug","msg":"Fetching user count for first user account check","caller":"platform/config.go:356"}
{"timestamp":"2024-09-25 18:50:01.985 Z","level":"debug","msg":"You do not have the appropriate permissions.","caller":"web/context.go:120","path":"/api/v4/ldap/sync","request_id":"9z658ho1xty73gsh8ycc4ytzrw","ip_addr":"127.0.0.1","user_id":"jkqya8htxfynfqqdaha4u35raa","method":"POST","err_where":"Permissions","http_code":403,"error":"Permissions: You do not have the appropriate permissions., userId=jkqya8htxfynfqqdaha4u35raa, permission=create_ldap_sync_job"}
{"timestamp":"2024-09-25 18:50:01.985 Z","level":"debug","msg":"Received HTTP request","caller":"web/handlers.go:185","method":"POST","url":"/api/v4/ldap/sync","request_id":"9z658ho1xty73gsh8ycc4ytzrw","user_id":"jkqya8htxfynfqqdaha4u35raa","status_code":"403"}
{"timestamp":"2024-09-25 18:50:01.986 Z","level":"info","msg":"Purging all caches","caller":"platform/cluster_handlers.go:114"}
{"timestamp":"2024-09-25 18:50:01.986 Z","level":"info","msg":"License key has not been uploaded. Loading license key from disk.","caller":"utils/license.go:107","filename":"/tmp/testlib2048900104/config/mattermost.mattermost-license"}
{"timestamp":"2024-09-25 18:50:01.986 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/testlib2048900104/config/mattermost.mattermost-license: stat /tmp/testlib2048900104/config/mattermost.mattermost-license: no such file or directory"}
{"timestamp":"2024-09-25 18:50:01.988 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-25 18:50:01.992 Z","level":"info","msg":"Stopping Server...","caller":"app/server.go:669"}
{"timestamp":"2024-09-25 18:50:01.998 Z","level":"info","msg":"Shutting down Email batching service...","caller":"email/service.go:85"}
{"timestamp":"2024-09-25 18:50:01.998 Z","level":"info","msg":"Shutting down plugins","caller":"app/plugin.go:362"}
{"timestamp":"2024-09-25 18:50:01.998 Z","level":"debug","msg":"Disabling plugin health check job","caller":"plugin/environment.go:670"}
{"timestamp":"2024-09-25 18:50:01.998 Z","level":"info","msg":"stopping websocket hub connections","caller":"platform/web_hub.go:127"}
{"timestamp":"2024-09-25 18:50:01.998 Z","level":"info","msg":"Server stopped","caller":"app/server.go:753"}
--- FAIL: TestSyncLdap (1.73s)

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

See this annotation in the file changed.

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

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

Failed
Raw output 
=== RUN   TestSyncLdap/SystemAdminClient#01
{"timestamp":"2024-09-25 19:54:08.771 Z","level":"debug","msg":"Received HTTP request","caller":"web/handlers.go:185","method":"POST","url":"/api/v4/ldap/sync","request_id":"1zwigmxgp7yo8ytnjfe1sgycga","user_id":"oszi9kocffna8q5w5i3znu66or","status_code":"200"}
==================
WARNING: DATA RACE
Read at 0x00c001eb9530 by goroutine 318:
  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 0x00c001eb9530 by goroutine 294:
  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 318 (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:806 +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 294 (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:1070 +0x224
==================
{"timestamp":"2024-09-25 19:54:08.775 Z","level":"debug","msg":"Received HTTP request","caller":"web/handlers.go:185","method":"POST","url":"/api/v4/ldap/sync","request_id":"yimp4ghb9pg6pbtaa19cdzib8a","user_id":"oszi9kocffna8q5w5i3znu66or","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 / MySQL (Results)

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

Failed
Raw output 
=== RUN   TestSyncLdap
{"timestamp":"2024-09-25 19:54:03.108 Z","level":"debug","msg":"Advanced logging config not provided for notification logging","caller":"platform/config.go:165"}
{"timestamp":"2024-09-25 19:54:03.108 Z","level":"info","msg":"Successfully connected to cache backend","caller":"platform/service.go:191","backend":"lru","result":"OK"}
{"timestamp":"2024-09-25 19:54:03.108 Z","level":"info","msg":"Server is initializing...","caller":"platform/service.go:194","go_version":"go1.22.6"}
{"timestamp":"2024-09-25 19:54:03.121 Z","level":"info","msg":"Starting websocket hubs","caller":"platform/web_hub.go:106","number_of_hubs":4}
{"timestamp":"2024-09-25 19:54:03.122 Z","level":"debug","msg":"Hub is starting","caller":"platform/web_hub.go:386","index":0}
{"timestamp":"2024-09-25 19:54:03.122 Z","level":"debug","msg":"Hub is starting","caller":"platform/web_hub.go:386","index":2}
{"timestamp":"2024-09-25 19:54:03.122 Z","level":"debug","msg":"Hub is starting","caller":"platform/web_hub.go:386","index":3}
{"timestamp":"2024-09-25 19:54:03.122 Z","level":"debug","msg":"Hub is starting","caller":"platform/web_hub.go:386","index":1}
{"timestamp":"2024-09-25 19:54:03.122 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-25 19:54:03.132 Z","level":"info","msg":"Ensuring the telemetry ID..","caller":"telemetry/telemetry.go:147"}
{"timestamp":"2024-09-25 19:54:03.133 Z","level":"info","msg":"telemetry ID is set","caller":"telemetry/telemetry.go:157","id":"ezbbxmceminjuc3psudoeuu5ao"}
{"timestamp":"2024-09-25 19:54:03.153 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:390"}
{"timestamp":"2024-09-25 19:54:03.153 Z","level":"info","msg":"Current version is 10.1.0 (///)","caller":"app/server.go:404","current_version":"10.1.0","build_number":"","build_date":"","build_hash":"","build_hash_enterprise":"","service_environment":"dev"}
{"timestamp":"2024-09-25 19:54:03.153 Z","level":"info","msg":"Team Edition Build","caller":"app/server.go:420","enterprise_build":false}
{"timestamp":"2024-09-25 19:54:03.153 Z","level":"info","msg":"Printing current working","caller":"app/server.go:424","directory":"/tmp/testlib3370940653"}
{"timestamp":"2024-09-25 19:54:03.153 Z","level":"info","msg":"Loaded config","caller":"app/server.go:425","source":"memory://"}
{"timestamp":"2024-09-25 19:54:03.389 Z","level":"debug","msg":"initElasticsearchChannelIndexCheck: calling elasticsearchChannelIndexCheckWithRetry before setting up config and license change listeners...","caller":"app/elasticsearch.go:21"}
{"timestamp":"2024-09-25 19:54:03.389 Z","level":"debug","msg":"elasticsearchChannelIndexCheckWithRetry: attempting to check channel index state...","caller":"app/elasticsearch.go:64"}
{"timestamp":"2024-09-25 19:54:03.389 Z","level":"debug","msg":"elasticsearchChannelIndexCheckWithRetry: skipping because elasticsearch indexing is disabled","caller":"app/elasticsearch.go:67"}
{"timestamp":"2024-09-25 19:54:03.423 Z","level":"debug","msg":"Fetching user count for first user account check","caller":"platform/config.go:356"}
{"timestamp":"2024-09-25 19:54:03.425 Z","level":"info","msg":"Post.Message has size restrictions","caller":"sqlstore/post_store.go:2615","max_characters":16383,"max_bytes":65535}
{"timestamp":"2024-09-25 19:54:03.430 Z","level":"debug","msg":"Advanced logging config not provided for notification logging","caller":"platform/config.go:165"}
{"timestamp":"2024-09-25 19:54:03.430 Z","level":"info","msg":"Starting up plugins","caller":"app/plugin.go:191"}
{"timestamp":"2024-09-25 19:54:03.431 Z","level":"debug","msg":"Enabling plugin health check job","caller":"plugin/environment.go:661","interval_s":"30s"}
{"timestamp":"2024-09-25 19:54:03.431 Z","level":"info","msg":"Syncing plugins from the file store","caller":"app/plugin.go:268"}
{"timestamp":"2024-09-25 19:54:03.431 Z","level":"debug","msg":"Plugin health check job starting.","caller":"plugin/health_check.go:31"}
{"timestamp":"2024-09-25 19:54:03.431 Z","level":"info","msg":"No plugins to sync from the file store","caller":"app/plugin.go:311"}
{"timestamp":"2024-09-25 19:54:03.431 Z","level":"debug","msg":"No prepackaged plugins directory found","caller":"app/plugin.go:912"}
{"timestamp":"2024-09-25 19:54:03.431 Z","level":"debug","msg":"Not persisting transitionally prepackaged plugins: none found","caller":"app/plugin.go:1184"}
{"timestamp":"2024-09-25 19:54:03.437 Z","level":"debug","msg":"Able to write files to local storage.","caller":"filestore/localstore.go:82"}
{"timestamp":"2024-09-25 19:54:03.457 Z","level":"info","msg":"Starting Server...","caller":"app/server.go:887"}
{"timestamp":"2024-09-25 19:54:03.457 Z","level":"info","msg":"Server is listening on 127.0.0.1:33871","caller":"app/server.go:963","address":"127.0.0.1:33871"}
{"timestamp":"2024-09-25 19:54:03.457 Z","level":"debug","msg":"No license provided; Remote Cluster services disabled","caller":"app/server.go:580"}
{"timestamp":"2024-09-25 19:54:03.524 Z","level":"debug","msg":"Initializing web routes","caller":"web/web.go:26"}
{"timestamp":"2024-09-25 19:54:03.525 Z","level":"debug","msg":"Skipping update to assets subpath since CI build","caller":"utils/subpath.go:187"}
{"timestamp":"2024-09-25 19:54:03.526 Z","level":"debug","msg":"Using client directory","caller":"web/static.go:34","clientDir":"/tmp/testlib3370940653/client"}
{"timestamp":"2024-09-25 19:54:03.526 Z","level":"debug","msg":"Configured Client4 bool string values","caller":"api4/apitestlib.go:212","true":"True","false":"0"}
{"timestamp":"2024-09-25 19:54:03.529 Z","level":"debug","msg":"Fetching user count for first user account check","caller":"platform/config.go:356"}
{"timestamp":"2024-09-25 19:54:04.377 Z","level":"debug","msg":"sending mail","caller":"mail/mail.go:295","to":"y4jniqeoqibc8yjown6iryhnwe@localhost","subject":"[Mattermost] You joined "}
{"timestamp":"2024-09-25 19:54:04.399 Z","level":"debug","msg":"Received HTTP request","caller":"web/handlers.go:185","method":"POST","url":"/api/v4/users","request_id":"jwzphc8fet898b1ys57jtx8nmc","user_id":"","status_code":"201"}
{"timestamp":"2024-09-25 19:54:04.419 Z","level":"debug","msg":"Fetching user count for first user account check","caller":"platform/config.go:356"}
{"timestamp":"2024-09-25 19:54:05.260 Z","level":"debug","msg":"sending mail","caller":"mail/mail.go:295","to":"rai18jeu87b3mm6iyp5q57fupr@localhost","subject":"[Mattermost] You joined "}
{"timestamp":"2024-09-25 19:54:05.278 Z","level":"debug","msg":"Received HTTP request","caller":"web/handlers.go:185","method":"POST","url":"/api/v4/users","request_id":"8e9wnqgd9tg5t8z41hf17zt8ye","user_id":"","status_code":"201"}
{"timestamp":"2024-09-25 19:54:06.119 Z","level":"debug","msg":"sending mail","caller":"mail/mail.go:295","to":"1qogdbbp47rampgpykoqng71ee@localhost","subject":"[Mattermost] You joined "}
{"timestamp":"2024-09-25 19:54:06.137 Z","level":"debug","msg":"Received HTTP request","caller":"web/handlers.go:185","method":"POST","url":"/api/v4/users","request_id":"casgd5yy4ifnuedse5koxem8hh","user_id":"","status_code":"201"}
{"timestamp":"2024-09-25 19:54:06.987 Z","level":"debug","msg":"sending mail","caller":"mail/mail.go:295","to":"hkzcfkzxzpbk9ptrq7inps9qye@localhost","subject":"[Mattermost] You joined "}
{"timestamp":"2024-09-25 19:54:07.006 Z","level":"debug","msg":"Received HTTP request","caller":"web/handlers.go:185","method":"POST","url":"/api/v4/users","request_id":"m7o418qagpra5cw561ztn5qp5o","user_id":"","status_code":"201"}
{"timestamp":"2024-09-25 19:54:07.860 Z","level":"debug","msg":"sending mail","caller":"mail/mail.go:295","to":"g3w9nohoo3re9d8fzq6zmpzzsa@localhost","subject":"[Mattermost] You joined "}
{"timestamp":"2024-09-25 19:54:07.879 Z","level":"debug","msg":"Received HTTP request","caller":"web/handlers.go:185","method":"POST","url":"/api/v4/users","request_id":"s9qeyhud8p8qfnwdcjfxneddwa","user_id":"","status_code":"201"}
{"timestamp":"2024-09-25 19:54:08.716 Z","level":"debug","msg":"Received HTTP request","caller":"web/handlers.go:185","method":"POST","url":"/api/v4/users/login","request_id":"xfw55spqkigd9fceu4kzd78h7e","user_id":"ye95r1yet386xerepbxtemyqih","status_code":"200"}
{"timestamp":"2024-09-25 19:54:08.729 Z","level":"debug","msg":"Received HTTP request","caller":"web/handlers.go:185","method":"POST","url":"/api/v4/users/login","request_id":"xttp8b1hd3b1mf4m7s5pjejscw","user_id":"oszi9kocffna8q5w5i3znu66or","status_code":"200"}
{"timestamp":"2024-09-25 19:54:08.768 Z","level":"debug","msg":"Advanced logging config not provided for notification logging","caller":"platform/config.go:165"}
{"timestamp":"2024-09-25 19:54:08.777 Z","level":"debug","msg":"You do not have the appropriate permissions.","caller":"web/context.go:120","path":"/api/v4/ldap/sync","request_id":"h53bfuhfjbrizxujszh88mg9cc","ip_addr":"127.0.0.1","user_id":"ye95r1yet386xerepbxtemyqih","method":"POST","err_where":"Permissions","http_code":403,"error":"Permissions: You do not have the appropriate permissions., userId=ye95r1yet386xerepbxtemyqih, permission=create_ldap_sync_job"}
{"timestamp":"2024-09-25 19:54:08.777 Z","level":"debug","msg":"Received HTTP request","caller":"web/handlers.go:185","method":"POST","url":"/api/v4/ldap/sync","request_id":"h53bfuhfjbrizxujszh88mg9cc","user_id":"ye95r1yet386xerepbxtemyqih","status_code":"403"}
{"timestamp":"2024-09-25 19:54:08.778 Z","level":"info","msg":"Purging all caches","caller":"platform/cluster_handlers.go:114"}
{"timestamp":"2024-09-25 19:54:08.779 Z","level":"info","msg":"License key has not been uploaded. Loading license key from disk.","caller":"utils/license.go:107","filename":"/tmp/testlib3370940653/config/mattermost.mattermost-license"}
{"timestamp":"2024-09-25 19:54:08.779 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/testlib3370940653/config/mattermost.mattermost-license: stat /tmp/testlib3370940653/config/mattermost.mattermost-license: no such file or directory"}
{"timestamp":"2024-09-25 19:54:08.780 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-25 19:54:08.783 Z","level":"info","msg":"Stopping Server...","caller":"app/server.go:669"}
{"timestamp":"2024-09-25 19:54:08.790 Z","level":"info","msg":"Shutting down Email batching service...","caller":"email/service.go:85"}
{"timestamp":"2024-09-25 19:54:08.790 Z","level":"info","msg":"Shutting down plugins","caller":"app/plugin.go:362"}
{"timestamp":"2024-09-25 19:54:08.790 Z","level":"debug","msg":"Disabling plugin health check job","caller":"plugin/environment.go:670"}
{"timestamp":"2024-09-25 19:54:08.790 Z","level":"info","msg":"stopping websocket hub connections","caller":"platform/web_hub.go:127"}
{"timestamp":"2024-09-25 19:54:08.790 Z","level":"info","msg":"Server stopped","caller":"app/server.go:753"}
--- FAIL: TestSyncLdap (6.09s)

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

See this annotation in the file changed.

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

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

Failed
Raw output 
=== RUN   TestSyncLdap/SystemAdminClient#01
{"timestamp":"2024-09-25 19:54:22.119 Z","level":"debug","msg":"Received HTTP request","caller":"web/handlers.go:185","method":"POST","url":"/api/v4/ldap/sync","request_id":"rthfrxrfop8tipipw37oxkz4tr","user_id":"jc7acctq6pb3trfejpi4zksxdw","status_code":"200"}
==================
WARNING: DATA RACE
Read at 0x00c0020ce7b0 by goroutine 318:
  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 0x00c0020ce7b0 by goroutine 189:
  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 318 (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:806 +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 189 (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:1070 +0x224
==================
{"timestamp":"2024-09-25 19:54:22.122 Z","level":"debug","msg":"Received HTTP request","caller":"web/handlers.go:185","method":"POST","url":"/api/v4/ldap/sync","request_id":"uip7oqdwzpdxbfpz1y5jhbam8y","user_id":"jc7acctq6pb3trfejpi4zksxdw","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 / MySQL (Results)

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

Failed
Raw output 
=== RUN   TestSyncLdap
{"timestamp":"2024-09-25 19:54:16.504 Z","level":"debug","msg":"Advanced logging config not provided for notification logging","caller":"platform/config.go:165"}
{"timestamp":"2024-09-25 19:54:16.504 Z","level":"info","msg":"Successfully connected to cache backend","caller":"platform/service.go:191","backend":"lru","result":"OK"}
{"timestamp":"2024-09-25 19:54:16.504 Z","level":"info","msg":"Server is initializing...","caller":"platform/service.go:194","go_version":"go1.22.6"}
{"timestamp":"2024-09-25 19:54:16.522 Z","level":"info","msg":"Starting websocket hubs","caller":"platform/web_hub.go:106","number_of_hubs":4}
{"timestamp":"2024-09-25 19:54:16.523 Z","level":"debug","msg":"Hub is starting","caller":"platform/web_hub.go:386","index":0}
{"timestamp":"2024-09-25 19:54:16.523 Z","level":"debug","msg":"Hub is starting","caller":"platform/web_hub.go:386","index":2}
{"timestamp":"2024-09-25 19:54:16.523 Z","level":"debug","msg":"Hub is starting","caller":"platform/web_hub.go:386","index":1}
{"timestamp":"2024-09-25 19:54:16.524 Z","level":"debug","msg":"Hub is starting","caller":"platform/web_hub.go:386","index":3}
{"timestamp":"2024-09-25 19:54:16.525 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-25 19:54:16.537 Z","level":"info","msg":"Ensuring the telemetry ID..","caller":"telemetry/telemetry.go:147"}
{"timestamp":"2024-09-25 19:54:16.539 Z","level":"info","msg":"telemetry ID is set","caller":"telemetry/telemetry.go:157","id":"pk3wotae4tr4uehiwon8nnepyc"}
{"timestamp":"2024-09-25 19:54:16.558 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:390"}
{"timestamp":"2024-09-25 19:54:16.558 Z","level":"info","msg":"Current version is 10.1.0 (///)","caller":"app/server.go:404","current_version":"10.1.0","build_number":"","build_date":"","build_hash":"","build_hash_enterprise":"","service_environment":"dev"}
{"timestamp":"2024-09-25 19:54:16.558 Z","level":"info","msg":"Team Edition Build","caller":"app/server.go:420","enterprise_build":false}
{"timestamp":"2024-09-25 19:54:16.558 Z","level":"info","msg":"Printing current working","caller":"app/server.go:424","directory":"/tmp/testlib324156220"}
{"timestamp":"2024-09-25 19:54:16.558 Z","level":"info","msg":"Loaded config","caller":"app/server.go:425","source":"memory://"}
{"timestamp":"2024-09-25 19:54:16.788 Z","level":"debug","msg":"initElasticsearchChannelIndexCheck: calling elasticsearchChannelIndexCheckWithRetry before setting up config and license change listeners...","caller":"app/elasticsearch.go:21"}
{"timestamp":"2024-09-25 19:54:16.788 Z","level":"debug","msg":"elasticsearchChannelIndexCheckWithRetry: attempting to check channel index state...","caller":"app/elasticsearch.go:64"}
{"timestamp":"2024-09-25 19:54:16.788 Z","level":"debug","msg":"elasticsearchChannelIndexCheckWithRetry: skipping because elasticsearch indexing is disabled","caller":"app/elasticsearch.go:67"}
{"timestamp":"2024-09-25 19:54:16.822 Z","level":"debug","msg":"Fetching user count for first user account check","caller":"platform/config.go:356"}
{"timestamp":"2024-09-25 19:54:16.824 Z","level":"info","msg":"Post.Message has size restrictions","caller":"sqlstore/post_store.go:2615","max_characters":16383,"max_bytes":65535}
{"timestamp":"2024-09-25 19:54:16.830 Z","level":"debug","msg":"Advanced logging config not provided for notification logging","caller":"platform/config.go:165"}
{"timestamp":"2024-09-25 19:54:16.830 Z","level":"info","msg":"Starting up plugins","caller":"app/plugin.go:191"}
{"timestamp":"2024-09-25 19:54:16.830 Z","level":"debug","msg":"Enabling plugin health check job","caller":"plugin/environment.go:661","interval_s":"30s"}
{"timestamp":"2024-09-25 19:54:16.830 Z","level":"info","msg":"Syncing plugins from the file store","caller":"app/plugin.go:268"}
{"timestamp":"2024-09-25 19:54:16.830 Z","level":"info","msg":"No plugins to sync from the file store","caller":"app/plugin.go:311"}
{"timestamp":"2024-09-25 19:54:16.830 Z","level":"debug","msg":"Plugin health check job starting.","caller":"plugin/health_check.go:31"}
{"timestamp":"2024-09-25 19:54:16.831 Z","level":"debug","msg":"No prepackaged plugins directory found","caller":"app/plugin.go:912"}
{"timestamp":"2024-09-25 19:54:16.831 Z","level":"debug","msg":"Not persisting transitionally prepackaged plugins: none found","caller":"app/plugin.go:1184"}
{"timestamp":"2024-09-25 19:54:16.837 Z","level":"debug","msg":"Able to write files to local storage.","caller":"filestore/localstore.go:82"}
{"timestamp":"2024-09-25 19:54:16.857 Z","level":"info","msg":"Starting Server...","caller":"app/server.go:887"}
{"timestamp":"2024-09-25 19:54:16.857 Z","level":"info","msg":"Server is listening on 127.0.0.1:43343","caller":"app/server.go:963","address":"127.0.0.1:43343"}
{"timestamp":"2024-09-25 19:54:16.857 Z","level":"debug","msg":"No license provided; Remote Cluster services disabled","caller":"app/server.go:580"}
{"timestamp":"2024-09-25 19:54:16.923 Z","level":"debug","msg":"Initializing web routes","caller":"web/web.go:26"}
{"timestamp":"2024-09-25 19:54:16.924 Z","level":"debug","msg":"Skipping update to assets subpath since CI build","caller":"utils/subpath.go:187"}
{"timestamp":"2024-09-25 19:54:16.924 Z","level":"debug","msg":"Using client directory","caller":"web/static.go:34","clientDir":"/tmp/testlib324156220/client"}
{"timestamp":"2024-09-25 19:54:16.925 Z","level":"debug","msg":"Configured Client4 bool string values","caller":"api4/apitestlib.go:212","true":"t","false":"false"}
{"timestamp":"2024-09-25 19:54:16.928 Z","level":"debug","msg":"Fetching user count for first user account check","caller":"platform/config.go:356"}
{"timestamp":"2024-09-25 19:54:17.784 Z","level":"debug","msg":"sending mail","caller":"mail/mail.go:295","to":"mg5qm93mg7f53kr9zu4znqixze@localhost","subject":"[Mattermost] You joined "}
{"timestamp":"2024-09-25 19:54:17.816 Z","level":"debug","msg":"Received HTTP request","caller":"web/handlers.go:185","method":"POST","url":"/api/v4/users","request_id":"ewgxezd4kfymucjzpid7kx4zth","user_id":"","status_code":"201"}
{"timestamp":"2024-09-25 19:54:17.825 Z","level":"debug","msg":"Fetching user count for first user account check","caller":"platform/config.go:356"}
{"timestamp":"2024-09-25 19:54:18.659 Z","level":"debug","msg":"sending mail","caller":"mail/mail.go:295","to":"zz3fp3snqf8xfb41e6bd1a7eio@localhost","subject":"[Mattermost] You joined "}
{"timestamp":"2024-09-25 19:54:18.676 Z","level":"debug","msg":"Received HTTP request","caller":"web/handlers.go:185","method":"POST","url":"/api/v4/users","request_id":"d798scbtjj8c9nigqudaws8f4o","user_id":"","status_code":"201"}
{"timestamp":"2024-09-25 19:54:19.518 Z","level":"debug","msg":"sending mail","caller":"mail/mail.go:295","to":"7prd45n7epne7fhs7rfbdomsda@localhost","subject":"[Mattermost] You joined "}
{"timestamp":"2024-09-25 19:54:19.536 Z","level":"debug","msg":"Received HTTP request","caller":"web/handlers.go:185","method":"POST","url":"/api/v4/users","request_id":"emdkxgusaf8t98h34u9cqbdexc","user_id":"","status_code":"201"}
{"timestamp":"2024-09-25 19:54:20.329 Z","level":"debug","msg":"sending mail","caller":"mail/mail.go:295","to":"j1cjm9879t89jqbewj9ri874yo@localhost","subject":"[Mattermost] You joined "}
{"timestamp":"2024-09-25 19:54:20.348 Z","level":"debug","msg":"Received HTTP request","caller":"web/handlers.go:185","method":"POST","url":"/api/v4/users","request_id":"9yfzw3ifdb8ftru8r4yx5qpocy","user_id":"","status_code":"201"}
{"timestamp":"2024-09-25 19:54:21.186 Z","level":"debug","msg":"sending mail","caller":"mail/mail.go:295","to":"f589eeybsp8pxkym76perbdkxy@localhost","subject":"[Mattermost] You joined "}
{"timestamp":"2024-09-25 19:54:21.205 Z","level":"debug","msg":"Received HTTP request","caller":"web/handlers.go:185","method":"POST","url":"/api/v4/users","request_id":"rquz9sgz3tgzmr5coh45cuen8e","user_id":"","status_code":"201"}
{"timestamp":"2024-09-25 19:54:22.064 Z","level":"debug","msg":"Received HTTP request","caller":"web/handlers.go:185","method":"POST","url":"/api/v4/users/login","request_id":"66ia9mf73bn4dm4p8ny5jjgh5y","user_id":"jc7acctq6pb3trfejpi4zksxdw","status_code":"200"}
{"timestamp":"2024-09-25 19:54:22.077 Z","level":"debug","msg":"Received HTTP request","caller":"web/handlers.go:185","method":"POST","url":"/api/v4/users/login","request_id":"st55r8q7ojg33eo4fyjjtyxika","user_id":"8x7gc94wx7ybzm8e8ydxx5amtc","status_code":"200"}
{"timestamp":"2024-09-25 19:54:22.116 Z","level":"debug","msg":"Advanced logging config not provided for notification logging","caller":"platform/config.go:165"}
{"timestamp":"2024-09-25 19:54:22.125 Z","level":"debug","msg":"You do not have the appropriate permissions.","caller":"web/context.go:120","path":"/api/v4/ldap/sync","request_id":"149qcpjbm3dzi8iwfi35ur9mdh","ip_addr":"127.0.0.1","user_id":"8x7gc94wx7ybzm8e8ydxx5amtc","method":"POST","err_where":"Permissions","http_code":403,"error":"Permissions: You do not have the appropriate permissions., userId=8x7gc94wx7ybzm8e8ydxx5amtc, permission=create_ldap_sync_job"}
{"timestamp":"2024-09-25 19:54:22.125 Z","level":"debug","msg":"Received HTTP request","caller":"web/handlers.go:185","method":"POST","url":"/api/v4/ldap/sync","request_id":"149qcpjbm3dzi8iwfi35ur9mdh","user_id":"8x7gc94wx7ybzm8e8ydxx5amtc","status_code":"403"}
{"timestamp":"2024-09-25 19:54:22.125 Z","level":"info","msg":"Purging all caches","caller":"platform/cluster_handlers.go:114"}
{"timestamp":"2024-09-25 19:54:22.126 Z","level":"info","msg":"License key has not been uploaded. Loading license key from disk.","caller":"utils/license.go:107","filename":"/tmp/testlib324156220/config/mattermost.mattermost-license"}
{"timestamp":"2024-09-25 19:54:22.126 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/testlib324156220/config/mattermost.mattermost-license: stat /tmp/testlib324156220/config/mattermost.mattermost-license: no such file or directory"}
{"timestamp":"2024-09-25 19:54:22.128 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-25 19:54:22.130 Z","level":"info","msg":"Stopping Server...","caller":"app/server.go:669"}
{"timestamp":"2024-09-25 19:54:22.133 Z","level":"info","msg":"Shutting down Email batching service...","caller":"email/service.go:85"}
{"timestamp":"2024-09-25 19:54:22.133 Z","level":"info","msg":"Shutting down plugins","caller":"app/plugin.go:362"}
{"timestamp":"2024-09-25 19:54:22.133 Z","level":"debug","msg":"Disabling plugin health check job","caller":"plugin/environment.go:670"}
{"timestamp":"2024-09-25 19:54:22.133 Z","level":"info","msg":"stopping websocket hub connections","caller":"platform/web_hub.go:127"}
{"timestamp":"2024-09-25 19:54:22.133 Z","level":"info","msg":"Server stopped","caller":"app/server.go:753"}
--- FAIL: TestSyncLdap (6.04s)

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

See this annotation in the file changed.

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

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

Failed
Raw output 
=== RUN   TestSyncLdap/SystemAdminClient#01
{"timestamp":"2024-09-25 19:54:35.529 Z","level":"debug","msg":"Received HTTP request","caller":"web/handlers.go:185","method":"POST","url":"/api/v4/ldap/sync","request_id":"wre14z39cjfhfq8sh1r1jnngoe","user_id":"tebgc9zdtbd8mypup4quxkpoyh","status_code":"200"}
==================
WARNING: DATA RACE
Read at 0x00c002218b10 by goroutine 317:
  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 0x00c002218b10 by goroutine 293:
  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 317 (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:806 +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 293 (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:1070 +0x224
==================
{"timestamp":"2024-09-25 19:54:35.532 Z","level":"debug","msg":"Received HTTP request","caller":"web/handlers.go:185","method":"POST","url":"/api/v4/ldap/sync","request_id":"ku1zuicrhiy1tndoemi5ssapjw","user_id":"tebgc9zdtbd8mypup4quxkpoyh","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 / MySQL (Results)

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

Failed
Raw output 
=== RUN   TestSyncLdap
{"timestamp":"2024-09-25 19:54:29.797 Z","level":"debug","msg":"Advanced logging config not provided for notification logging","caller":"platform/config.go:165"}
{"timestamp":"2024-09-25 19:54:29.797 Z","level":"info","msg":"Successfully connected to cache backend","caller":"platform/service.go:191","backend":"lru","result":"OK"}
{"timestamp":"2024-09-25 19:54:29.797 Z","level":"info","msg":"Server is initializing...","caller":"platform/service.go:194","go_version":"go1.22.6"}
{"timestamp":"2024-09-25 19:54:29.825 Z","level":"info","msg":"Starting websocket hubs","caller":"platform/web_hub.go:106","number_of_hubs":4}
{"timestamp":"2024-09-25 19:54:29.825 Z","level":"debug","msg":"Hub is starting","caller":"platform/web_hub.go:386","index":0}
{"timestamp":"2024-09-25 19:54:29.825 Z","level":"debug","msg":"Hub is starting","caller":"platform/web_hub.go:386","index":2}
{"timestamp":"2024-09-25 19:54:29.826 Z","level":"debug","msg":"Hub is starting","caller":"platform/web_hub.go:386","index":3}
{"timestamp":"2024-09-25 19:54:29.826 Z","level":"debug","msg":"Hub is starting","caller":"platform/web_hub.go:386","index":1}
{"timestamp":"2024-09-25 19:54:29.826 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-25 19:54:29.836 Z","level":"info","msg":"Ensuring the telemetry ID..","caller":"telemetry/telemetry.go:147"}
{"timestamp":"2024-09-25 19:54:29.837 Z","level":"info","msg":"telemetry ID is set","caller":"telemetry/telemetry.go:157","id":"gey143f8tjgdjneif74brt59iw"}
{"timestamp":"2024-09-25 19:54:29.857 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:390"}
{"timestamp":"2024-09-25 19:54:29.857 Z","level":"info","msg":"Current version is 10.1.0 (///)","caller":"app/server.go:404","current_version":"10.1.0","build_number":"","build_date":"","build_hash":"","build_hash_enterprise":"","service_environment":"dev"}
{"timestamp":"2024-09-25 19:54:29.857 Z","level":"info","msg":"Team Edition Build","caller":"app/server.go:420","enterprise_build":false}
{"timestamp":"2024-09-25 19:54:29.857 Z","level":"info","msg":"Printing current working","caller":"app/server.go:424","directory":"/tmp/testlib2506436167"}
{"timestamp":"2024-09-25 19:54:29.857 Z","level":"info","msg":"Loaded config","caller":"app/server.go:425","source":"memory://"}
{"timestamp":"2024-09-25 19:54:30.084 Z","level":"debug","msg":"initElasticsearchChannelIndexCheck: calling elasticsearchChannelIndexCheckWithRetry before setting up config and license change listeners...","caller":"app/elasticsearch.go:21"}
{"timestamp":"2024-09-25 19:54:30.084 Z","level":"debug","msg":"elasticsearchChannelIndexCheckWithRetry: attempting to check channel index state...","caller":"app/elasticsearch.go:64"}
{"timestamp":"2024-09-25 19:54:30.084 Z","level":"debug","msg":"elasticsearchChannelIndexCheckWithRetry: skipping because elasticsearch indexing is disabled","caller":"app/elasticsearch.go:67"}
{"timestamp":"2024-09-25 19:54:30.118 Z","level":"debug","msg":"Fetching user count for first user account check","caller":"platform/config.go:356"}
{"timestamp":"2024-09-25 19:54:30.120 Z","level":"info","msg":"Post.Message has size restrictions","caller":"sqlstore/post_store.go:2615","max_characters":16383,"max_bytes":65535}
{"timestamp":"2024-09-25 19:54:30.126 Z","level":"debug","msg":"Advanced logging config not provided for notification logging","caller":"platform/config.go:165"}
{"timestamp":"2024-09-25 19:54:30.126 Z","level":"info","msg":"Starting up plugins","caller":"app/plugin.go:191"}
{"timestamp":"2024-09-25 19:54:30.126 Z","level":"debug","msg":"Enabling plugin health check job","caller":"plugin/environment.go:661","interval_s":"30s"}
{"timestamp":"2024-09-25 19:54:30.126 Z","level":"info","msg":"Syncing plugins from the file store","caller":"app/plugin.go:268"}
{"timestamp":"2024-09-25 19:54:30.126 Z","level":"debug","msg":"Plugin health check job starting.","caller":"plugin/health_check.go:31"}
{"timestamp":"2024-09-25 19:54:30.126 Z","level":"info","msg":"No plugins to sync from the file store","caller":"app/plugin.go:311"}
{"timestamp":"2024-09-25 19:54:30.126 Z","level":"debug","msg":"No prepackaged plugins directory found","caller":"app/plugin.go:912"}
{"timestamp":"2024-09-25 19:54:30.126 Z","level":"debug","msg":"Not persisting transitionally prepackaged plugins: none found","caller":"app/plugin.go:1184"}
{"timestamp":"2024-09-25 19:54:30.132 Z","level":"debug","msg":"Able to write files to local storage.","caller":"filestore/localstore.go:82"}
{"timestamp":"2024-09-25 19:54:30.151 Z","level":"info","msg":"Starting Server...","caller":"app/server.go:887"}
{"timestamp":"2024-09-25 19:54:30.152 Z","level":"info","msg":"Server is listening on 127.0.0.1:36947","caller":"app/server.go:963","address":"127.0.0.1:36947"}
{"timestamp":"2024-09-25 19:54:30.152 Z","level":"debug","msg":"No license provided; Remote Cluster services disabled","caller":"app/server.go:580"}
{"timestamp":"2024-09-25 19:54:30.221 Z","level":"debug","msg":"Initializing web routes","caller":"web/web.go:26"}
{"timestamp":"2024-09-25 19:54:30.222 Z","level":"debug","msg":"Skipping update to assets subpath since CI build","caller":"utils/subpath.go:187"}
{"timestamp":"2024-09-25 19:54:30.222 Z","level":"debug","msg":"Using client directory","caller":"web/static.go:34","clientDir":"/tmp/testlib2506436167/client"}
{"timestamp":"2024-09-25 19:54:30.223 Z","level":"debug","msg":"Configured Client4 bool string values","caller":"api4/apitestlib.go:212","true":"t","false":"0"}
{"timestamp":"2024-09-25 19:54:30.226 Z","level":"debug","msg":"Fetching user count for first user account check","caller":"platform/config.go:356"}
{"timestamp":"2024-09-25 19:54:31.077 Z","level":"debug","msg":"sending mail","caller":"mail/mail.go:295","to":"spcaesug87f59n87q1kg8rsr4o@localhost","subject":"[Mattermost] You joined "}
{"timestamp":"2024-09-25 19:54:31.096 Z","level":"debug","msg":"Received HTTP request","caller":"web/handlers.go:185","method":"POST","url":"/api/v4/users","request_id":"iuwni9kgc7byxq3zeztfqguz1e","user_id":"","status_code":"201"}
{"timestamp":"2024-09-25 19:54:31.106 Z","level":"debug","msg":"Fetching user count for first user account check","caller":"platform/config.go:356"}
{"timestamp":"2024-09-25 19:54:31.948 Z","level":"debug","msg":"sending mail","caller":"mail/mail.go:295","to":"355w33bqmbyci8cd586donar3r@localhost","subject":"[Mattermost] You joined "}
{"timestamp":"2024-09-25 19:54:31.979 Z","level":"debug","msg":"Received HTTP request","caller":"web/handlers.go:185","method":"POST","url":"/api/v4/users","request_id":"q8bxcjx7ftd8mjp5t6q4tjrssa","user_id":"","status_code":"201"}
{"timestamp":"2024-09-25 19:54:32.843 Z","level":"debug","msg":"sending mail","caller":"mail/mail.go:295","to":"octt6t4sj7bjxqmkpysqc8jqgc@localhost","subject":"[Mattermost] You joined "}
{"timestamp":"2024-09-25 19:54:32.860 Z","level":"debug","msg":"Received HTTP request","caller":"web/handlers.go:185","method":"POST","url":"/api/v4/users","request_id":"1m9zybj6cibsfeuzfrw367qa5y","user_id":"","status_code":"201"}
{"timestamp":"2024-09-25 19:54:33.699 Z","level":"debug","msg":"sending mail","caller":"mail/mail.go:295","to":"uu8157uiptrhxre8s4xgcmjuaa@localhost","subject":"[Mattermost] You joined "}
{"timestamp":"2024-09-25 19:54:33.716 Z","level":"debug","msg":"Received HTTP request","caller":"web/handlers.go:185","method":"POST","url":"/api/v4/users","request_id":"bpuksb3x7bdc5j9i4q6kaepgpc","user_id":"","status_code":"201"}
{"timestamp":"2024-09-25 19:54:34.556 Z","level":"debug","msg":"sending mail","caller":"mail/mail.go:295","to":"99tcr9ii8ig5b868src73k4w8c@localhost","subject":"[Mattermost] You joined "}
{"timestamp":"2024-09-25 19:54:34.573 Z","level":"debug","msg":"Received HTTP request","caller":"web/handlers.go:185","method":"POST","url":"/api/v4/users","request_id":"4ng9oxq7ob84fn895fnntifeda","user_id":"","status_code":"201"}
{"timestamp":"2024-09-25 19:54:35.473 Z","level":"debug","msg":"Received HTTP request","caller":"web/handlers.go:185","method":"POST","url":"/api/v4/users/login","request_id":"bkqcsad5jidztmq16ddzaz3ria","user_id":"91gqa38miigt3pbsppt83oyuwh","status_code":"200"}
{"timestamp":"2024-09-25 19:54:35.486 Z","level":"debug","msg":"Received HTTP request","caller":"web/handlers.go:185","method":"POST","url":"/api/v4/users/login","request_id":"djyynh1frbdyzx1smb8qiy5rry","user_id":"tebgc9zdtbd8mypup4quxkpoyh","status_code":"200"}
{"timestamp":"2024-09-25 19:54:35.525 Z","level":"debug","msg":"Advanced logging config not provided for notification logging","caller":"platform/config.go:165"}
{"timestamp":"2024-09-25 19:54:35.535 Z","level":"debug","msg":"You do not have the appropriate permissions.","caller":"web/context.go:120","path":"/api/v4/ldap/sync","request_id":"xkahmeqhfpyyifgk9983jx5dew","ip_addr":"127.0.0.1","user_id":"91gqa38miigt3pbsppt83oyuwh","method":"POST","err_where":"Permissions","http_code":403,"error":"Permissions: You do not have the appropriate permissions., userId=91gqa38miigt3pbsppt83oyuwh, permission=create_ldap_sync_job"}
{"timestamp":"2024-09-25 19:54:35.535 Z","level":"debug","msg":"Received HTTP request","caller":"web/handlers.go:185","method":"POST","url":"/api/v4/ldap/sync","request_id":"xkahmeqhfpyyifgk9983jx5dew","user_id":"91gqa38miigt3pbsppt83oyuwh","status_code":"403"}
{"timestamp":"2024-09-25 19:54:35.535 Z","level":"info","msg":"Purging all caches","caller":"platform/cluster_handlers.go:114"}
{"timestamp":"2024-09-25 19:54:35.537 Z","level":"info","msg":"License key has not been uploaded. Loading license key from disk.","caller":"utils/license.go:107","filename":"/tmp/testlib2506436167/config/mattermost.mattermost-license"}
{"timestamp":"2024-09-25 19:54:35.537 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/testlib2506436167/config/mattermost.mattermost-license: stat /tmp/testlib2506436167/config/mattermost.mattermost-license: no such file or directory"}
{"timestamp":"2024-09-25 19:54:35.538 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-25 19:54:35.543 Z","level":"info","msg":"Stopping Server...","caller":"app/server.go:669"}
{"timestamp":"2024-09-25 19:54:35.549 Z","level":"info","msg":"Shutting down Email batching service...","caller":"email/service.go:85"}
{"timestamp":"2024-09-25 19:54:35.549 Z","level":"info","msg":"Shutting down plugins","caller":"app/plugin.go:362"}
{"timestamp":"2024-09-25 19:54:35.549 Z","level":"debug","msg":"Disabling plugin health check job","caller":"plugin/environment.go:670"}
{"timestamp":"2024-09-25 19:54:35.549 Z","level":"info","msg":"stopping websocket hub connections","caller":"platform/web_hub.go:127"}
{"timestamp":"2024-09-25 19:54:35.549 Z","level":"info","msg":"Server stopped","caller":"app/server.go:753"}
--- FAIL: TestSyncLdap (6.16s)
View more details on GitHub Actions