Skip to content
API

MM-60541 Don't save an unmodified draft when changing channels (#28620) #5

Sign in to view logs

MM-60541 Don't save an unmodified draft when changing channels (#28620)

MM-60541 Don't save an unmodified draft when changing channels (#28620) #5

GitHub Actions / Postgres (Results) failed Oct 11, 2024 in 0s

12973 tests run, 12929 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-10-11 15:37:13.806 Z","level":"debug","msg":"Advanced logging config not provided for notification logging","caller":"platform/config.go:165"}
{"timestamp":"2024-10-11 15:37:13.815 Z","level":"debug","msg":"Received HTTP request","caller":"web/handlers.go:185","method":"POST","url":"/api/v4/ldap/sync","request_id":"7y5ypg4aw7dwfy3q1fw4kx16so","user_id":"3654ac6b9tdk9m5fhds635noeh","status_code":"200"}
==================
WARNING: DATA RACE
Read at 0x00c0023e8c90 by goroutine 326405:
  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 0x00c0023e8c90 by goroutine 326348:
  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:25 +0xcf
  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 326405 (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 326348 (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-10-11 15:37:13.818 Z","level":"debug","msg":"Received HTTP request","caller":"web/handlers.go:185","method":"POST","url":"/api/v4/ldap/sync","request_id":"cucmz9awyfnfjbfaprka8rgwho","user_id":"3654ac6b9tdk9m5fhds635noeh","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-10-11 15:37:12.078 Z","level":"debug","msg":"Advanced logging config not provided for notification logging","caller":"platform/config.go:165"}
{"timestamp":"2024-10-11 15:37:12.078 Z","level":"info","msg":"Successfully connected to cache backend","caller":"platform/service.go:191","backend":"redis","result":"PONG"}
{"timestamp":"2024-10-11 15:37:12.078 Z","level":"info","msg":"Server is initializing...","caller":"platform/service.go:194","go_version":"go1.22.6"}
{"timestamp":"2024-10-11 15:37:12.082 Z","level":"info","msg":"Starting websocket hubs","caller":"platform/web_hub.go:106","number_of_hubs":4}
{"timestamp":"2024-10-11 15:37:12.082 Z","level":"debug","msg":"Hub is starting","caller":"platform/web_hub.go:386","index":1}
{"timestamp":"2024-10-11 15:37:12.082 Z","level":"debug","msg":"Hub is starting","caller":"platform/web_hub.go:386","index":0}
{"timestamp":"2024-10-11 15:37:12.082 Z","level":"debug","msg":"Hub is starting","caller":"platform/web_hub.go:386","index":2}
{"timestamp":"2024-10-11 15:37:12.082 Z","level":"debug","msg":"Hub is starting","caller":"platform/web_hub.go:386","index":3}
{"timestamp":"2024-10-11 15:37:12.083 Z","level":"info","msg":"Loaded system translations","caller":"i18n/i18n.go:175","for locale":"en","from locale":"/mattermost/server/i18n/en.json"}
{"timestamp":"2024-10-11 15:37:12.093 Z","level":"info","msg":"Ensuring the telemetry ID..","caller":"telemetry/telemetry.go:167"}
{"timestamp":"2024-10-11 15:37:12.094 Z","level":"info","msg":"telemetry ID is set","caller":"telemetry/telemetry.go:177","id":"f3q61qxnbtnojfxnq5zrj1sq6e"}
{"timestamp":"2024-10-11 15:37:12.119 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-10-11 15:37:12.119 Z","level":"info","msg":"Current version is 10.2.0 (///)","caller":"app/server.go:404","current_version":"10.2.0","build_number":"","build_date":"","build_hash":"","build_hash_enterprise":"","service_environment":"dev"}
{"timestamp":"2024-10-11 15:37:12.119 Z","level":"info","msg":"Team Edition Build","caller":"app/server.go:420","enterprise_build":false}
{"timestamp":"2024-10-11 15:37:12.119 Z","level":"info","msg":"Printing current working","caller":"app/server.go:424","directory":"/tmp/testlib4163536817"}
{"timestamp":"2024-10-11 15:37:12.119 Z","level":"info","msg":"Loaded config","caller":"app/server.go:425","source":"memory://"}
{"timestamp":"2024-10-11 15:37:12.427 Z","level":"debug","msg":"initElasticsearchChannelIndexCheck: calling elasticsearchChannelIndexCheckWithRetry before setting up config and license change listeners...","caller":"app/elasticsearch.go:21"}
{"timestamp":"2024-10-11 15:37:12.427 Z","level":"debug","msg":"elasticsearchChannelIndexCheckWithRetry: attempting to check channel index state...","caller":"app/elasticsearch.go:64"}
{"timestamp":"2024-10-11 15:37:12.427 Z","level":"debug","msg":"elasticsearchChannelIndexCheckWithRetry: skipping because elasticsearch indexing is disabled","caller":"app/elasticsearch.go:67"}
{"timestamp":"2024-10-11 15:37:12.463 Z","level":"debug","msg":"Fetching user count for first user account check","caller":"platform/config.go:356"}
{"timestamp":"2024-10-11 15:37:12.470 Z","level":"debug","msg":"Advanced logging config not provided for notification logging","caller":"platform/config.go:165"}
{"timestamp":"2024-10-11 15:37:12.470 Z","level":"info","msg":"Starting up plugins","caller":"app/plugin.go:191"}
{"timestamp":"2024-10-11 15:37:12.470 Z","level":"debug","msg":"Enabling plugin health check job","caller":"plugin/environment.go:661","interval_s":"30s"}
{"timestamp":"2024-10-11 15:37:12.470 Z","level":"info","msg":"Syncing plugins from the file store","caller":"app/plugin.go:268"}
{"timestamp":"2024-10-11 15:37:12.471 Z","level":"debug","msg":"Plugin health check job starting.","caller":"plugin/health_check.go:31"}
{"timestamp":"2024-10-11 15:37:12.471 Z","level":"info","msg":"No plugins to sync from the file store","caller":"app/plugin.go:311"}
{"timestamp":"2024-10-11 15:37:12.471 Z","level":"debug","msg":"No prepackaged plugins directory found","caller":"app/plugin.go:929"}
{"timestamp":"2024-10-11 15:37:12.471 Z","level":"debug","msg":"Not persisting transitionally prepackaged plugins: none found","caller":"app/plugin.go:1201"}
{"timestamp":"2024-10-11 15:37:12.479 Z","level":"debug","msg":"Able to write files to local storage.","caller":"filestore/localstore.go:82"}
{"timestamp":"2024-10-11 15:37:12.503 Z","level":"info","msg":"Starting Server...","caller":"app/server.go:887"}
{"timestamp":"2024-10-11 15:37:12.503 Z","level":"info","msg":"Server is listening on 127.0.0.1:40053","caller":"app/server.go:963","address":"127.0.0.1:40053"}
{"timestamp":"2024-10-11 15:37:12.503 Z","level":"debug","msg":"No license provided; Remote Cluster services disabled","caller":"app/server.go:580"}
{"timestamp":"2024-10-11 15:37:12.586 Z","level":"debug","msg":"Initializing web routes","caller":"web/web.go:26"}
{"timestamp":"2024-10-11 15:37:12.588 Z","level":"debug","msg":"Skipping update to assets subpath since CI build","caller":"utils/subpath.go:187"}
{"timestamp":"2024-10-11 15:37:12.588 Z","level":"debug","msg":"Using client directory","caller":"web/static.go:34","clientDir":"/tmp/testlib4163536817/client"}
{"timestamp":"2024-10-11 15:37:12.588 Z","level":"debug","msg":"Configured Client4 bool string values","caller":"api4/apitestlib.go:212","true":"t","false":"False"}
{"timestamp":"2024-10-11 15:37:13.704 Z","level":"debug","msg":"Received HTTP request","caller":"web/handlers.go:185","method":"POST","url":"/api/v4/users/login","request_id":"wk1d1kenhprodedh5idkxw4dne","user_id":"3654ac6b9tdk9m5fhds635noeh","status_code":"200"}
{"timestamp":"2024-10-11 15:37:13.746 Z","level":"debug","msg":"Received HTTP request","caller":"web/handlers.go:185","method":"POST","url":"/api/v4/users/login","request_id":"j3o6j4dss7rn8ntgur5n18u3iy","user_id":"7yn1eqxdpirg7yfw915abj57eh","status_code":"200"}
{"timestamp":"2024-10-11 15:37:13.750 Z","level":"info","msg":"Set license","caller":"platform/license.go:384","id":"","issued_at":"1970-01-01 00:00:00.000 Z","starts_at":"1970-01-01 00:00:00.000 Z","expires_at":"2025-01-09 15:37:13.750 Z","sku_name":"","sku_short_name":"","is_trial":false,"is_gov_sku":false,"customer_id":"some ID","features.users":0,"features":{"advanced_logging":true,"cloud":false,"cluster":true,"compliance":true,"custom_permissions_schemes":true,"data_retention":true,"elastic_search":true,"email_notification_contents":true,"enterprise_plugins":true,"future":true,"google":true,"guest_accounts":true,"guest_accounts_permissions":true,"id_loaded":true,"ldap":true,"ldap_groups":true,"lock_teammate_name_display":true,"message_export":true,"metrics":true,"mfa":true,"mhpns":true,"office365":true,"openid":true,"outgoing_oauth_connections":true,"remote_cluster_service":true,"saml":true,"shared_channels":true}}
{"timestamp":"2024-10-11 15:37:13.797 Z","level":"debug","msg":"Fetching user count for first user account check","caller":"platform/config.go:356"}
{"timestamp":"2024-10-11 15:37:13.824 Z","level":"debug","msg":"You do not have the appropriate permissions.","caller":"web/context.go:120","path":"/api/v4/ldap/sync","request_id":"4ig59ugk7tnydbdiyto14xwrsa","ip_addr":"127.0.0.1","user_id":"7yn1eqxdpirg7yfw915abj57eh","method":"POST","err_where":"Permissions","http_code":403,"error":"Permissions: You do not have the appropriate permissions., userId=7yn1eqxdpirg7yfw915abj57eh, permission=create_ldap_sync_job"}
{"timestamp":"2024-10-11 15:37:13.824 Z","level":"debug","msg":"Received HTTP request","caller":"web/handlers.go:185","method":"POST","url":"/api/v4/ldap/sync","request_id":"4ig59ugk7tnydbdiyto14xwrsa","user_id":"7yn1eqxdpirg7yfw915abj57eh","status_code":"403"}
{"timestamp":"2024-10-11 15:37:13.824 Z","level":"info","msg":"Purging all caches","caller":"platform/cluster_handlers.go:114"}
{"timestamp":"2024-10-11 15:37:13.827 Z","level":"info","msg":"License key has not been uploaded. Loading license key from disk.","caller":"utils/license.go:107","filename":"/tmp/testlib4163536817/config/mattermost.mattermost-license"}
{"timestamp":"2024-10-11 15:37:13.827 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/testlib4163536817/config/mattermost.mattermost-license: stat /tmp/testlib4163536817/config/mattermost.mattermost-license: no such file or directory"}
{"timestamp":"2024-10-11 15:37:13.827 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-10-11 15:37:13.828 Z","level":"info","msg":"Cleared license","caller":"platform/license.go:384","id":"","issued_at":"1970-01-01 00:00:00.000 Z","starts_at":"1970-01-01 00:00:00.000 Z","expires_at":"2025-01-09 15:37:13.750 Z","sku_name":"","sku_short_name":"","is_trial":false,"is_gov_sku":false,"customer_id":"some ID","features.users":0,"features":{"advanced_logging":true,"cloud":false,"cluster":true,"compliance":true,"custom_permissions_schemes":true,"data_retention":true,"elastic_search":true,"email_notification_contents":true,"enterprise_plugins":true,"future":true,"google":true,"guest_accounts":true,"guest_accounts_permissions":true,"id_loaded":true,"ldap":true,"ldap_groups":true,"lock_teammate_name_display":true,"message_export":true,"metrics":true,"mfa":true,"mhpns":true,"office365":true,"openid":true,"outgoing_oauth_connections":true,"remote_cluster_service":true,"saml":true,"shared_channels":true}}
{"timestamp":"2024-10-11 15:37:13.831 Z","level":"info","msg":"Stopping Server...","caller":"app/server.go:669"}
{"timestamp":"2024-10-11 15:37:13.835 Z","level":"info","msg":"Shutting down Email batching service...","caller":"email/service.go:85"}
{"timestamp":"2024-10-11 15:37:13.835 Z","level":"info","msg":"Shutting down plugins","caller":"app/plugin.go:362"}
{"timestamp":"2024-10-11 15:37:13.835 Z","level":"debug","msg":"Disabling plugin health check job","caller":"plugin/environment.go:670"}
{"timestamp":"2024-10-11 15:37:13.835 Z","level":"info","msg":"stopping websocket hub connections","caller":"platform/web_hub.go:127"}
{"timestamp":"2024-10-11 15:37:13.836 Z","level":"info","msg":"Server stopped","caller":"app/server.go:753"}
--- FAIL: TestSyncLdap (1.85s)

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-10-11 16:06:51.277 Z","level":"debug","msg":"Received HTTP request","caller":"web/handlers.go:185","method":"POST","url":"/api/v4/ldap/sync","request_id":"8xf1dzi3sjfq3mbhke9ebdwmby","user_id":"iwkmxwptxbrjdnmjq1ta8yozho","status_code":"200"}
==================
WARNING: DATA RACE
Read at 0x00c0029172c0 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 0x00c0029172c0 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:25 +0xcf
  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: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 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:1070 +0x224
==================
{"timestamp":"2024-10-11 16:06:51.281 Z","level":"debug","msg":"Received HTTP request","caller":"web/handlers.go:185","method":"POST","url":"/api/v4/ldap/sync","request_id":"caxqod5goignpcd3hrsf7mrbqw","user_id":"iwkmxwptxbrjdnmjq1ta8yozho","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-10-11 16:06:45.606 Z","level":"debug","msg":"Advanced logging config not provided for notification logging","caller":"platform/config.go:165"}
{"timestamp":"2024-10-11 16:06:45.606 Z","level":"info","msg":"Successfully connected to cache backend","caller":"platform/service.go:191","backend":"redis","result":"PONG"}
{"timestamp":"2024-10-11 16:06:45.606 Z","level":"info","msg":"Server is initializing...","caller":"platform/service.go:194","go_version":"go1.22.6"}
{"timestamp":"2024-10-11 16:06:45.608 Z","level":"info","msg":"Starting websocket hubs","caller":"platform/web_hub.go:106","number_of_hubs":4}
{"timestamp":"2024-10-11 16:06:45.608 Z","level":"debug","msg":"Hub is starting","caller":"platform/web_hub.go:386","index":0}
{"timestamp":"2024-10-11 16:06:45.608 Z","level":"debug","msg":"Hub is starting","caller":"platform/web_hub.go:386","index":1}
{"timestamp":"2024-10-11 16:06:45.608 Z","level":"debug","msg":"Hub is starting","caller":"platform/web_hub.go:386","index":2}
{"timestamp":"2024-10-11 16:06:45.608 Z","level":"debug","msg":"Hub is starting","caller":"platform/web_hub.go:386","index":3}
{"timestamp":"2024-10-11 16:06:45.609 Z","level":"info","msg":"Loaded system translations","caller":"i18n/i18n.go:175","for locale":"en","from locale":"/mattermost/server/i18n/en.json"}
{"timestamp":"2024-10-11 16:06:45.617 Z","level":"info","msg":"Ensuring the telemetry ID..","caller":"telemetry/telemetry.go:167"}
{"timestamp":"2024-10-11 16:06:45.618 Z","level":"info","msg":"telemetry ID is set","caller":"telemetry/telemetry.go:177","id":"oo6tb6c9ybbz889crgamh3h37o"}
{"timestamp":"2024-10-11 16:06:45.637 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-10-11 16:06:45.637 Z","level":"info","msg":"Current version is 10.2.0 (///)","caller":"app/server.go:404","current_version":"10.2.0","build_number":"","build_date":"","build_hash":"","build_hash_enterprise":"","service_environment":"dev"}
{"timestamp":"2024-10-11 16:06:45.637 Z","level":"info","msg":"Team Edition Build","caller":"app/server.go:420","enterprise_build":false}
{"timestamp":"2024-10-11 16:06:45.637 Z","level":"info","msg":"Printing current working","caller":"app/server.go:424","directory":"/tmp/testlib186311498"}
{"timestamp":"2024-10-11 16:06:45.637 Z","level":"info","msg":"Loaded config","caller":"app/server.go:425","source":"memory://"}
{"timestamp":"2024-10-11 16:06:45.885 Z","level":"debug","msg":"initElasticsearchChannelIndexCheck: calling elasticsearchChannelIndexCheckWithRetry before setting up config and license change listeners...","caller":"app/elasticsearch.go:21"}
{"timestamp":"2024-10-11 16:06:45.885 Z","level":"debug","msg":"elasticsearchChannelIndexCheckWithRetry: attempting to check channel index state...","caller":"app/elasticsearch.go:64"}
{"timestamp":"2024-10-11 16:06:45.885 Z","level":"debug","msg":"elasticsearchChannelIndexCheckWithRetry: skipping because elasticsearch indexing is disabled","caller":"app/elasticsearch.go:67"}
{"timestamp":"2024-10-11 16:06:45.919 Z","level":"debug","msg":"Fetching user count for first user account check","caller":"platform/config.go:356"}
{"timestamp":"2024-10-11 16:06:45.921 Z","level":"info","msg":"Post.Message has size restrictions","caller":"sqlstore/post_store.go:2628","max_characters":16383,"max_bytes":65535}
{"timestamp":"2024-10-11 16:06:45.926 Z","level":"debug","msg":"Advanced logging config not provided for notification logging","caller":"platform/config.go:165"}
{"timestamp":"2024-10-11 16:06:45.926 Z","level":"info","msg":"Starting up plugins","caller":"app/plugin.go:191"}
{"timestamp":"2024-10-11 16:06:45.927 Z","level":"debug","msg":"Enabling plugin health check job","caller":"plugin/environment.go:661","interval_s":"30s"}
{"timestamp":"2024-10-11 16:06:45.927 Z","level":"info","msg":"Syncing plugins from the file store","caller":"app/plugin.go:268"}
{"timestamp":"2024-10-11 16:06:45.927 Z","level":"debug","msg":"Plugin health check job starting.","caller":"plugin/health_check.go:31"}
{"timestamp":"2024-10-11 16:06:45.927 Z","level":"info","msg":"No plugins to sync from the file store","caller":"app/plugin.go:311"}
{"timestamp":"2024-10-11 16:06:45.927 Z","level":"debug","msg":"No prepackaged plugins directory found","caller":"app/plugin.go:929"}
{"timestamp":"2024-10-11 16:06:45.927 Z","level":"debug","msg":"Not persisting transitionally prepackaged plugins: none found","caller":"app/plugin.go:1201"}
{"timestamp":"2024-10-11 16:06:45.932 Z","level":"debug","msg":"Able to write files to local storage.","caller":"filestore/localstore.go:82"}
{"timestamp":"2024-10-11 16:06:45.950 Z","level":"info","msg":"Starting Server...","caller":"app/server.go:887"}
{"timestamp":"2024-10-11 16:06:45.951 Z","level":"info","msg":"Server is listening on 127.0.0.1:37903","caller":"app/server.go:963","address":"127.0.0.1:37903"}
{"timestamp":"2024-10-11 16:06:45.951 Z","level":"debug","msg":"No license provided; Remote Cluster services disabled","caller":"app/server.go:580"}
{"timestamp":"2024-10-11 16:06:46.015 Z","level":"debug","msg":"Initializing web routes","caller":"web/web.go:26"}
{"timestamp":"2024-10-11 16:06:46.016 Z","level":"debug","msg":"Skipping update to assets subpath since CI build","caller":"utils/subpath.go:187"}
{"timestamp":"2024-10-11 16:06:46.017 Z","level":"debug","msg":"Using client directory","caller":"web/static.go:34","clientDir":"/tmp/testlib186311498/client"}
{"timestamp":"2024-10-11 16:06:46.017 Z","level":"debug","msg":"Configured Client4 bool string values","caller":"api4/apitestlib.go:212","true":"True","false":"F"}
{"timestamp":"2024-10-11 16:06:46.020 Z","level":"debug","msg":"Fetching user count for first user account check","caller":"platform/config.go:356"}
{"timestamp":"2024-10-11 16:06:46.874 Z","level":"info","msg":"sending mail","caller":"mail/mail.go:295","to":"yxms51baubyadeyji7recy3mcc@localhost","subject":"[Mattermost] You joined "}
{"timestamp":"2024-10-11 16:06:46.896 Z","level":"debug","msg":"Received HTTP request","caller":"web/handlers.go:185","method":"POST","url":"/api/v4/users","request_id":"9hmx7xs6xfyoudg3131rqk3kiw","user_id":"","status_code":"201"}
{"timestamp":"2024-10-11 16:06:46.910 Z","level":"debug","msg":"Fetching user count for first user account check","caller":"platform/config.go:356"}
{"timestamp":"2024-10-11 16:06:47.736 Z","level":"info","msg":"sending mail","caller":"mail/mail.go:295","to":"up3p13r767nb8qhjq5eyubqwcw@localhost","subject":"[Mattermost] You joined "}
{"timestamp":"2024-10-11 16:06:47.764 Z","level":"debug","msg":"Received HTTP request","caller":"web/handlers.go:185","method":"POST","url":"/api/v4/users","request_id":"w49k3xkmnf878fojwpwua8i1ze","user_id":"","status_code":"201"}
{"timestamp":"2024-10-11 16:06:48.602 Z","level":"info","msg":"sending mail","caller":"mail/mail.go:295","to":"ydyigw6rapd9inbj9gbxbqf35c@localhost","subject":"[Mattermost] You joined "}
{"timestamp":"2024-10-11 16:06:48.618 Z","level":"debug","msg":"Received HTTP request","caller":"web/handlers.go:185","method":"POST","url":"/api/v4/users","request_id":"p8ocjogjhjb7jp3p5miqqz158r","user_id":"","status_code":"201"}
{"timestamp":"2024-10-11 16:06:49.475 Z","level":"info","msg":"sending mail","caller":"mail/mail.go:295","to":"hfjqgqtp9ibobpn45zgssh7dww@localhost","subject":"[Mattermost] You joined "}
{"timestamp":"2024-10-11 16:06:49.491 Z","level":"debug","msg":"Received HTTP request","caller":"web/handlers.go:185","method":"POST","url":"/api/v4/users","request_id":"1ccjugpf4pgyfyjgs8p3qkg33e","user_id":"","status_code":"201"}
{"timestamp":"2024-10-11 16:06:50.326 Z","level":"info","msg":"sending mail","caller":"mail/mail.go:295","to":"jayybkhiifdjbj4d7gq76toquy@localhost","subject":"[Mattermost] You joined "}
{"timestamp":"2024-10-11 16:06:50.343 Z","level":"debug","msg":"Received HTTP request","caller":"web/handlers.go:185","method":"POST","url":"/api/v4/users","request_id":"7d1f1uff9igztrdpzrkkdp6wzy","user_id":"","status_code":"201"}
{"timestamp":"2024-10-11 16:06:51.232 Z","level":"debug","msg":"Received HTTP request","caller":"web/handlers.go:185","method":"POST","url":"/api/v4/users/login","request_id":"hjfrsgek1igimx1ujeoqc3ifqc","user_id":"ubmzt7n8f3n1jf3xnsoywqbuky","status_code":"200"}
{"timestamp":"2024-10-11 16:06:51.237 Z","level":"debug","msg":"Received HTTP request","caller":"web/handlers.go:185","method":"POST","url":"/api/v4/users/login","request_id":"u7y13ood8j8e8n5qrdrsb5dute","user_id":"iwkmxwptxbrjdnmjq1ta8yozho","status_code":"200"}
{"timestamp":"2024-10-11 16:06:51.238 Z","level":"info","msg":"Set license","caller":"platform/license.go:384","id":"","issued_at":"1970-01-01 00:00:00.000 Z","starts_at":"1970-01-01 00:00:00.000 Z","expires_at":"2025-01-09 16:06:51.238 Z","sku_name":"","sku_short_name":"","is_trial":false,"is_gov_sku":false,"customer_id":"some ID","features.users":0,"features":{"advanced_logging":true,"cloud":false,"cluster":true,"compliance":true,"custom_permissions_schemes":true,"data_retention":true,"elastic_search":true,"email_notification_contents":true,"enterprise_plugins":true,"future":true,"google":true,"guest_accounts":true,"guest_accounts_permissions":true,"id_loaded":true,"ldap":true,"ldap_groups":true,"lock_teammate_name_display":true,"message_export":true,"metrics":true,"mfa":true,"mhpns":true,"office365":true,"openid":true,"outgoing_oauth_connections":true,"remote_cluster_service":true,"saml":true,"shared_channels":true}}
{"timestamp":"2024-10-11 16:06:51.275 Z","level":"debug","msg":"Advanced logging config not provided for notification logging","caller":"platform/config.go:165"}
{"timestamp":"2024-10-11 16:06:51.284 Z","level":"debug","msg":"You do not have the appropriate permissions.","caller":"web/context.go:120","path":"/api/v4/ldap/sync","request_id":"uzpdpx3bz78oiq897ijgaeif5h","ip_addr":"127.0.0.1","user_id":"ubmzt7n8f3n1jf3xnsoywqbuky","method":"POST","err_where":"Permissions","http_code":403,"error":"Permissions: You do not have the appropriate permissions., userId=ubmzt7n8f3n1jf3xnsoywqbuky, permission=create_ldap_sync_job"}
{"timestamp":"2024-10-11 16:06:51.284 Z","level":"debug","msg":"Received HTTP request","caller":"web/handlers.go:185","method":"POST","url":"/api/v4/ldap/sync","request_id":"uzpdpx3bz78oiq897ijgaeif5h","user_id":"ubmzt7n8f3n1jf3xnsoywqbuky","status_code":"403"}
{"timestamp":"2024-10-11 16:06:51.284 Z","level":"info","msg":"Purging all caches","caller":"platform/cluster_handlers.go:114"}
{"timestamp":"2024-10-11 16:06:51.287 Z","level":"info","msg":"License key has not been uploaded. Loading license key from disk.","caller":"utils/license.go:107","filename":"/tmp/testlib186311498/config/mattermost.mattermost-license"}
{"timestamp":"2024-10-11 16:06:51.287 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/testlib186311498/config/mattermost.mattermost-license: stat /tmp/testlib186311498/config/mattermost.mattermost-license: no such file or directory"}
{"timestamp":"2024-10-11 16:06:51.288 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-10-11 16:06:51.288 Z","level":"info","msg":"Cleared license","caller":"platform/license.go:384","id":"","issued_at":"1970-01-01 00:00:00.000 Z","starts_at":"1970-01-01 00:00:00.000 Z","expires_at":"2025-01-09 16:06:51.238 Z","sku_name":"","sku_short_name":"","is_trial":false,"is_gov_sku":false,"customer_id":"some ID","features.users":0,"features":{"advanced_logging":true,"cloud":false,"cluster":true,"compliance":true,"custom_permissions_schemes":true,"data_retention":true,"elastic_search":true,"email_notification_contents":true,"enterprise_plugins":true,"future":true,"google":true,"guest_accounts":true,"guest_accounts_permissions":true,"id_loaded":true,"ldap":true,"ldap_groups":true,"lock_teammate_name_display":true,"message_export":true,"metrics":true,"mfa":true,"mhpns":true,"office365":true,"openid":true,"outgoing_oauth_connections":true,"remote_cluster_service":true,"saml":true,"shared_channels":true}}
{"timestamp":"2024-10-11 16:06:51.291 Z","level":"info","msg":"Stopping Server...","caller":"app/server.go:669"}
{"timestamp":"2024-10-11 16:06:51.293 Z","level":"info","msg":"Shutting down Email batching service...","caller":"email/service.go:85"}
{"timestamp":"2024-10-11 16:06:51.293 Z","level":"info","msg":"Shutting down plugins","caller":"app/plugin.go:362"}
{"timestamp":"2024-10-11 16:06:51.293 Z","level":"debug","msg":"Disabling plugin health check job","caller":"plugin/environment.go:670"}
{"timestamp":"2024-10-11 16:06:51.293 Z","level":"info","msg":"stopping websocket hub connections","caller":"platform/web_hub.go:127"}
{"timestamp":"2024-10-11 16:06:51.294 Z","level":"info","msg":"Server stopped","caller":"app/server.go:753"}
--- FAIL: TestSyncLdap (5.77s)

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-10-11 16:07:02.113 Z","level":"debug","msg":"Received HTTP request","caller":"web/handlers.go:185","method":"POST","url":"/api/v4/ldap/sync","request_id":"8myfhzciqbddufb4spbr8jyyay","user_id":"umf39uqop7n3dxctyfd5wtig1o","status_code":"200"}
==================
WARNING: DATA RACE
Read at 0x00c00186f3b0 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 0x00c00186f3b0 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:25 +0xcf
  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: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 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:1070 +0x224
==================
{"timestamp":"2024-10-11 16:07:02.117 Z","level":"debug","msg":"Received HTTP request","caller":"web/handlers.go:185","method":"POST","url":"/api/v4/ldap/sync","request_id":"5f8hzkg9bfyh9qc8yhzrk3wxxc","user_id":"umf39uqop7n3dxctyfd5wtig1o","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-10-11 16:06:56.467 Z","level":"debug","msg":"Advanced logging config not provided for notification logging","caller":"platform/config.go:165"}
{"timestamp":"2024-10-11 16:06:56.467 Z","level":"info","msg":"Successfully connected to cache backend","caller":"platform/service.go:191","backend":"redis","result":"PONG"}
{"timestamp":"2024-10-11 16:06:56.467 Z","level":"info","msg":"Server is initializing...","caller":"platform/service.go:194","go_version":"go1.22.6"}
{"timestamp":"2024-10-11 16:06:56.470 Z","level":"info","msg":"Starting websocket hubs","caller":"platform/web_hub.go:106","number_of_hubs":4}
{"timestamp":"2024-10-11 16:06:56.470 Z","level":"debug","msg":"Hub is starting","caller":"platform/web_hub.go:386","index":1}
{"timestamp":"2024-10-11 16:06:56.470 Z","level":"debug","msg":"Hub is starting","caller":"platform/web_hub.go:386","index":3}
{"timestamp":"2024-10-11 16:06:56.470 Z","level":"debug","msg":"Hub is starting","caller":"platform/web_hub.go:386","index":0}
{"timestamp":"2024-10-11 16:06:56.470 Z","level":"debug","msg":"Hub is starting","caller":"platform/web_hub.go:386","index":2}
{"timestamp":"2024-10-11 16:06:56.471 Z","level":"info","msg":"Loaded system translations","caller":"i18n/i18n.go:175","for locale":"en","from locale":"/mattermost/server/i18n/en.json"}
{"timestamp":"2024-10-11 16:06:56.479 Z","level":"info","msg":"Ensuring the telemetry ID..","caller":"telemetry/telemetry.go:167"}
{"timestamp":"2024-10-11 16:06:56.480 Z","level":"info","msg":"telemetry ID is set","caller":"telemetry/telemetry.go:177","id":"69z5mst4m3dx3j3ys19or43t5e"}
{"timestamp":"2024-10-11 16:06:56.499 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-10-11 16:06:56.499 Z","level":"info","msg":"Current version is 10.2.0 (///)","caller":"app/server.go:404","current_version":"10.2.0","build_number":"","build_date":"","build_hash":"","build_hash_enterprise":"","service_environment":"dev"}
{"timestamp":"2024-10-11 16:06:56.499 Z","level":"info","msg":"Team Edition Build","caller":"app/server.go:420","enterprise_build":false}
{"timestamp":"2024-10-11 16:06:56.499 Z","level":"info","msg":"Printing current working","caller":"app/server.go:424","directory":"/tmp/testlib4248788654"}
{"timestamp":"2024-10-11 16:06:56.499 Z","level":"info","msg":"Loaded config","caller":"app/server.go:425","source":"memory://"}
{"timestamp":"2024-10-11 16:06:56.757 Z","level":"debug","msg":"initElasticsearchChannelIndexCheck: calling elasticsearchChannelIndexCheckWithRetry before setting up config and license change listeners...","caller":"app/elasticsearch.go:21"}
{"timestamp":"2024-10-11 16:06:56.758 Z","level":"debug","msg":"elasticsearchChannelIndexCheckWithRetry: attempting to check channel index state...","caller":"app/elasticsearch.go:64"}
{"timestamp":"2024-10-11 16:06:56.758 Z","level":"debug","msg":"elasticsearchChannelIndexCheckWithRetry: skipping because elasticsearch indexing is disabled","caller":"app/elasticsearch.go:67"}
{"timestamp":"2024-10-11 16:06:56.791 Z","level":"debug","msg":"Fetching user count for first user account check","caller":"platform/config.go:356"}
{"timestamp":"2024-10-11 16:06:56.793 Z","level":"info","msg":"Post.Message has size restrictions","caller":"sqlstore/post_store.go:2628","max_characters":16383,"max_bytes":65535}
{"timestamp":"2024-10-11 16:06:56.798 Z","level":"debug","msg":"Advanced logging config not provided for notification logging","caller":"platform/config.go:165"}
{"timestamp":"2024-10-11 16:06:56.798 Z","level":"info","msg":"Starting up plugins","caller":"app/plugin.go:191"}
{"timestamp":"2024-10-11 16:06:56.798 Z","level":"debug","msg":"Enabling plugin health check job","caller":"plugin/environment.go:661","interval_s":"30s"}
{"timestamp":"2024-10-11 16:06:56.798 Z","level":"info","msg":"Syncing plugins from the file store","caller":"app/plugin.go:268"}
{"timestamp":"2024-10-11 16:06:56.798 Z","level":"debug","msg":"Plugin health check job starting.","caller":"plugin/health_check.go:31"}
{"timestamp":"2024-10-11 16:06:56.799 Z","level":"info","msg":"No plugins to sync from the file store","caller":"app/plugin.go:311"}
{"timestamp":"2024-10-11 16:06:56.799 Z","level":"debug","msg":"No prepackaged plugins directory found","caller":"app/plugin.go:929"}
{"timestamp":"2024-10-11 16:06:56.799 Z","level":"debug","msg":"Not persisting transitionally prepackaged plugins: none found","caller":"app/plugin.go:1201"}
{"timestamp":"2024-10-11 16:06:56.804 Z","level":"debug","msg":"Able to write files to local storage.","caller":"filestore/localstore.go:82"}
{"timestamp":"2024-10-11 16:06:56.822 Z","level":"info","msg":"Starting Server...","caller":"app/server.go:887"}
{"timestamp":"2024-10-11 16:06:56.822 Z","level":"info","msg":"Server is listening on 127.0.0.1:32953","caller":"app/server.go:963","address":"127.0.0.1:32953"}
{"timestamp":"2024-10-11 16:06:56.822 Z","level":"debug","msg":"No license provided; Remote Cluster services disabled","caller":"app/server.go:580"}
{"timestamp":"2024-10-11 16:06:56.889 Z","level":"debug","msg":"Initializing web routes","caller":"web/web.go:26"}
{"timestamp":"2024-10-11 16:06:56.895 Z","level":"debug","msg":"Skipping update to assets subpath since CI build","caller":"utils/subpath.go:187"}
{"timestamp":"2024-10-11 16:06:56.895 Z","level":"debug","msg":"Using client directory","caller":"web/static.go:34","clientDir":"/tmp/testlib4248788654/client"}
{"timestamp":"2024-10-11 16:06:56.895 Z","level":"debug","msg":"Configured Client4 bool string values","caller":"api4/apitestlib.go:212","true":"true","false":"f"}
{"timestamp":"2024-10-11 16:06:56.904 Z","level":"debug","msg":"Fetching user count for first user account check","caller":"platform/config.go:356"}
{"timestamp":"2024-10-11 16:06:57.750 Z","level":"info","msg":"sending mail","caller":"mail/mail.go:295","to":"ahurchk9r3n5bn9jy8jneyqr1a@localhost","subject":"[Mattermost] You joined "}
{"timestamp":"2024-10-11 16:06:57.768 Z","level":"debug","msg":"Received HTTP request","caller":"web/handlers.go:185","method":"POST","url":"/api/v4/users","request_id":"s93ocmyrdpgo38xns1praczmqa","user_id":"","status_code":"201"}
{"timestamp":"2024-10-11 16:06:57.781 Z","level":"debug","msg":"Fetching user count for first user account check","caller":"platform/config.go:356"}
{"timestamp":"2024-10-11 16:06:58.608 Z","level":"info","msg":"sending mail","caller":"mail/mail.go:295","to":"igyg1y4kgtr1dnf7zpzrk7knzr@localhost","subject":"[Mattermost] You joined "}
{"timestamp":"2024-10-11 16:06:58.625 Z","level":"debug","msg":"Received HTTP request","caller":"web/handlers.go:185","method":"POST","url":"/api/v4/users","request_id":"gjjh3bkzbt8gxgrnxj1rjfujma","user_id":"","status_code":"201"}
{"timestamp":"2024-10-11 16:06:59.478 Z","level":"info","msg":"sending mail","caller":"mail/mail.go:295","to":"i4iz4i9cmbgo8ky7doyrxcor7y@localhost","subject":"[Mattermost] You joined "}
{"timestamp":"2024-10-11 16:06:59.496 Z","level":"debug","msg":"Received HTTP request","caller":"web/handlers.go:185","method":"POST","url":"/api/v4/users","request_id":"nptfs5d613de9gtkmtw7doz3ww","user_id":"","status_code":"201"}
{"timestamp":"2024-10-11 16:07:00.343 Z","level":"info","msg":"sending mail","caller":"mail/mail.go:295","to":"uq7dogxwaid97qx3kfguzrtxcc@localhost","subject":"[Mattermost] You joined "}
{"timestamp":"2024-10-11 16:07:00.360 Z","level":"debug","msg":"Received HTTP request","caller":"web/handlers.go:185","method":"POST","url":"/api/v4/users","request_id":"8j8dgstkot87txq5rni4tw6qjh","user_id":"","status_code":"201"}
{"timestamp":"2024-10-11 16:07:01.194 Z","level":"info","msg":"sending mail","caller":"mail/mail.go:295","to":"1qcxuazjb38q3rnc7gik8nq1uy@localhost","subject":"[Mattermost] You joined "}
{"timestamp":"2024-10-11 16:07:01.212 Z","level":"debug","msg":"Received HTTP request","caller":"web/handlers.go:185","method":"POST","url":"/api/v4/users","request_id":"r984zu81c3gwugg1ozw6j3k4ze","user_id":"","status_code":"201"}
{"timestamp":"2024-10-11 16:07:02.055 Z","level":"debug","msg":"Received HTTP request","caller":"web/handlers.go:185","method":"POST","url":"/api/v4/users/login","request_id":"qr7x8a4pkbggfnnwbr5xqytzio","user_id":"umf39uqop7n3dxctyfd5wtig1o","status_code":"200"}
{"timestamp":"2024-10-11 16:07:02.073 Z","level":"debug","msg":"Received HTTP request","caller":"web/handlers.go:185","method":"POST","url":"/api/v4/users/login","request_id":"t65nfuzmh3bz9n151eh6ge3pxr","user_id":"swwuq6j9ctyxdrogu8bp8d5jca","status_code":"200"}
{"timestamp":"2024-10-11 16:07:02.074 Z","level":"info","msg":"Set license","caller":"platform/license.go:384","id":"","issued_at":"1970-01-01 00:00:00.000 Z","starts_at":"1970-01-01 00:00:00.000 Z","expires_at":"2025-01-09 16:07:02.074 Z","sku_name":"","sku_short_name":"","is_trial":false,"is_gov_sku":false,"customer_id":"some ID","features.users":0,"features":{"advanced_logging":true,"cloud":false,"cluster":true,"compliance":true,"custom_permissions_schemes":true,"data_retention":true,"elastic_search":true,"email_notification_contents":true,"enterprise_plugins":true,"future":true,"google":true,"guest_accounts":true,"guest_accounts_permissions":true,"id_loaded":true,"ldap":true,"ldap_groups":true,"lock_teammate_name_display":true,"message_export":true,"metrics":true,"mfa":true,"mhpns":true,"office365":true,"openid":true,"outgoing_oauth_connections":true,"remote_cluster_service":true,"saml":true,"shared_channels":true}}
{"timestamp":"2024-10-11 16:07:02.110 Z","level":"debug","msg":"Advanced logging config not provided for notification logging","caller":"platform/config.go:165"}
{"timestamp":"2024-10-11 16:07:02.120 Z","level":"debug","msg":"You do not have the appropriate permissions.","caller":"web/context.go:120","path":"/api/v4/ldap/sync","request_id":"p416nyxhntrbp8un6ynuk4b6tw","ip_addr":"127.0.0.1","user_id":"swwuq6j9ctyxdrogu8bp8d5jca","method":"POST","err_where":"Permissions","http_code":403,"error":"Permissions: You do not have the appropriate permissions., userId=swwuq6j9ctyxdrogu8bp8d5jca, permission=create_ldap_sync_job"}
{"timestamp":"2024-10-11 16:07:02.120 Z","level":"debug","msg":"Received HTTP request","caller":"web/handlers.go:185","method":"POST","url":"/api/v4/ldap/sync","request_id":"p416nyxhntrbp8un6ynuk4b6tw","user_id":"swwuq6j9ctyxdrogu8bp8d5jca","status_code":"403"}
{"timestamp":"2024-10-11 16:07:02.121 Z","level":"info","msg":"Purging all caches","caller":"platform/cluster_handlers.go:114"}
{"timestamp":"2024-10-11 16:07:02.124 Z","level":"info","msg":"License key has not been uploaded. Loading license key from disk.","caller":"utils/license.go:107","filename":"/tmp/testlib4248788654/config/mattermost.mattermost-license"}
{"timestamp":"2024-10-11 16:07:02.124 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/testlib4248788654/config/mattermost.mattermost-license: stat /tmp/testlib4248788654/config/mattermost.mattermost-license: no such file or directory"}
{"timestamp":"2024-10-11 16:07:02.124 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-10-11 16:07:02.124 Z","level":"info","msg":"Cleared license","caller":"platform/license.go:384","id":"","issued_at":"1970-01-01 00:00:00.000 Z","starts_at":"1970-01-01 00:00:00.000 Z","expires_at":"2025-01-09 16:07:02.074 Z","sku_name":"","sku_short_name":"","is_trial":false,"is_gov_sku":false,"customer_id":"some ID","features.users":0,"features":{"advanced_logging":true,"cloud":false,"cluster":true,"compliance":true,"custom_permissions_schemes":true,"data_retention":true,"elastic_search":true,"email_notification_contents":true,"enterprise_plugins":true,"future":true,"google":true,"guest_accounts":true,"guest_accounts_permissions":true,"id_loaded":true,"ldap":true,"ldap_groups":true,"lock_teammate_name_display":true,"message_export":true,"metrics":true,"mfa":true,"mhpns":true,"office365":true,"openid":true,"outgoing_oauth_connections":true,"remote_cluster_service":true,"saml":true,"shared_channels":true}}
{"timestamp":"2024-10-11 16:07:02.128 Z","level":"info","msg":"Stopping Server...","caller":"app/server.go:669"}
{"timestamp":"2024-10-11 16:07:02.131 Z","level":"info","msg":"Shutting down Email batching service...","caller":"email/service.go:85"}
{"timestamp":"2024-10-11 16:07:02.131 Z","level":"info","msg":"Shutting down plugins","caller":"app/plugin.go:362"}
{"timestamp":"2024-10-11 16:07:02.131 Z","level":"debug","msg":"Disabling plugin health check job","caller":"plugin/environment.go:670"}
{"timestamp":"2024-10-11 16:07:02.131 Z","level":"info","msg":"stopping websocket hub connections","caller":"platform/web_hub.go:127"}
{"timestamp":"2024-10-11 16:07:02.132 Z","level":"info","msg":"Server stopped","caller":"app/server.go:753"}
--- FAIL: TestSyncLdap (5.74s)

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-10-11 16:07:12.902 Z","level":"debug","msg":"Received HTTP request","caller":"web/handlers.go:185","method":"POST","url":"/api/v4/ldap/sync","request_id":"bnaztx97ffg7zkfpgoenff5kaa","user_id":"eifb5m7o3jyufnwjof1w545b5a","status_code":"200"}
==================
WARNING: DATA RACE
Read at 0x00c002871560 by goroutine 1200:
  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 0x00c002871560 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:25 +0xcf
  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 1200 (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 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:1070 +0x224
==================
{"timestamp":"2024-10-11 16:07:12.906 Z","level":"debug","msg":"Received HTTP request","caller":"web/handlers.go:185","method":"POST","url":"/api/v4/ldap/sync","request_id":"no8bpstjhtdkzqaqdbfnyingoh","user_id":"eifb5m7o3jyufnwjof1w545b5a","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-10-11 16:07:07.345 Z","level":"debug","msg":"Advanced logging config not provided for notification logging","caller":"platform/config.go:165"}
{"timestamp":"2024-10-11 16:07:07.345 Z","level":"info","msg":"Successfully connected to cache backend","caller":"platform/service.go:191","backend":"redis","result":"PONG"}
{"timestamp":"2024-10-11 16:07:07.345 Z","level":"info","msg":"Server is initializing...","caller":"platform/service.go:194","go_version":"go1.22.6"}
{"timestamp":"2024-10-11 16:07:07.354 Z","level":"info","msg":"Starting websocket hubs","caller":"platform/web_hub.go:106","number_of_hubs":4}
{"timestamp":"2024-10-11 16:07:07.355 Z","level":"debug","msg":"Hub is starting","caller":"platform/web_hub.go:386","index":2}
{"timestamp":"2024-10-11 16:07:07.355 Z","level":"debug","msg":"Hub is starting","caller":"platform/web_hub.go:386","index":0}
{"timestamp":"2024-10-11 16:07:07.355 Z","level":"debug","msg":"Hub is starting","caller":"platform/web_hub.go:386","index":1}
{"timestamp":"2024-10-11 16:07:07.355 Z","level":"debug","msg":"Hub is starting","caller":"platform/web_hub.go:386","index":3}
{"timestamp":"2024-10-11 16:07:07.356 Z","level":"info","msg":"Loaded system translations","caller":"i18n/i18n.go:175","for locale":"en","from locale":"/mattermost/server/i18n/en.json"}
{"timestamp":"2024-10-11 16:07:07.363 Z","level":"info","msg":"Ensuring the telemetry ID..","caller":"telemetry/telemetry.go:167"}
{"timestamp":"2024-10-11 16:07:07.365 Z","level":"info","msg":"telemetry ID is set","caller":"telemetry/telemetry.go:177","id":"nwyx9hpu5bdombxo9c8srx7tca"}
{"timestamp":"2024-10-11 16:07:07.384 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-10-11 16:07:07.384 Z","level":"info","msg":"Current version is 10.2.0 (///)","caller":"app/server.go:404","current_version":"10.2.0","build_number":"","build_date":"","build_hash":"","build_hash_enterprise":"","service_environment":"dev"}
{"timestamp":"2024-10-11 16:07:07.384 Z","level":"info","msg":"Team Edition Build","caller":"app/server.go:420","enterprise_build":false}
{"timestamp":"2024-10-11 16:07:07.384 Z","level":"info","msg":"Printing current working","caller":"app/server.go:424","directory":"/tmp/testlib1716966364"}
{"timestamp":"2024-10-11 16:07:07.384 Z","level":"info","msg":"Loaded config","caller":"app/server.go:425","source":"memory://"}
{"timestamp":"2024-10-11 16:07:07.624 Z","level":"debug","msg":"initElasticsearchChannelIndexCheck: calling elasticsearchChannelIndexCheckWithRetry before setting up config and license change listeners...","caller":"app/elasticsearch.go:21"}
{"timestamp":"2024-10-11 16:07:07.624 Z","level":"debug","msg":"elasticsearchChannelIndexCheckWithRetry: attempting to check channel index state...","caller":"app/elasticsearch.go:64"}
{"timestamp":"2024-10-11 16:07:07.624 Z","level":"debug","msg":"elasticsearchChannelIndexCheckWithRetry: skipping because elasticsearch indexing is disabled","caller":"app/elasticsearch.go:67"}
{"timestamp":"2024-10-11 16:07:07.656 Z","level":"debug","msg":"Fetching user count for first user account check","caller":"platform/config.go:356"}
{"timestamp":"2024-10-11 16:07:07.659 Z","level":"info","msg":"Post.Message has size restrictions","caller":"sqlstore/post_store.go:2628","max_characters":16383,"max_bytes":65535}
{"timestamp":"2024-10-11 16:07:07.666 Z","level":"debug","msg":"Advanced logging config not provided for notification logging","caller":"platform/config.go:165"}
{"timestamp":"2024-10-11 16:07:07.666 Z","level":"info","msg":"Starting up plugins","caller":"app/plugin.go:191"}
{"timestamp":"2024-10-11 16:07:07.667 Z","level":"debug","msg":"Enabling plugin health check job","caller":"plugin/environment.go:661","interval_s":"30s"}
{"timestamp":"2024-10-11 16:07:07.667 Z","level":"info","msg":"Syncing plugins from the file store","caller":"app/plugin.go:268"}
{"timestamp":"2024-10-11 16:07:07.667 Z","level":"debug","msg":"Plugin health check job starting.","caller":"plugin/health_check.go:31"}
{"timestamp":"2024-10-11 16:07:07.667 Z","level":"info","msg":"No plugins to sync from the file store","caller":"app/plugin.go:311"}
{"timestamp":"2024-10-11 16:07:07.667 Z","level":"debug","msg":"No prepackaged plugins directory found","caller":"app/plugin.go:929"}
{"timestamp":"2024-10-11 16:07:07.667 Z","level":"debug","msg":"Not persisting transitionally prepackaged plugins: none found","caller":"app/plugin.go:1201"}
{"timestamp":"2024-10-11 16:07:07.672 Z","level":"debug","msg":"Able to write files to local storage.","caller":"filestore/localstore.go:82"}
{"timestamp":"2024-10-11 16:07:07.692 Z","level":"info","msg":"Starting Server...","caller":"app/server.go:887"}
{"timestamp":"2024-10-11 16:07:07.692 Z","level":"info","msg":"Server is listening on 127.0.0.1:36357","caller":"app/server.go:963","address":"127.0.0.1:36357"}
{"timestamp":"2024-10-11 16:07:07.693 Z","level":"debug","msg":"No license provided; Remote Cluster services disabled","caller":"app/server.go:580"}
{"timestamp":"2024-10-11 16:07:07.752 Z","level":"debug","msg":"Initializing web routes","caller":"web/web.go:26"}
{"timestamp":"2024-10-11 16:07:07.753 Z","level":"debug","msg":"Skipping update to assets subpath since CI build","caller":"utils/subpath.go:187"}
{"timestamp":"2024-10-11 16:07:07.754 Z","level":"debug","msg":"Using client directory","caller":"web/static.go:34","clientDir":"/tmp/testlib1716966364/client"}
{"timestamp":"2024-10-11 16:07:07.754 Z","level":"debug","msg":"Configured Client4 bool string values","caller":"api4/apitestlib.go:212","true":"TRUE","false":"f"}
{"timestamp":"2024-10-11 16:07:07.757 Z","level":"debug","msg":"Fetching user count for first user account check","caller":"platform/config.go:356"}
{"timestamp":"2024-10-11 16:07:08.596 Z","level":"info","msg":"sending mail","caller":"mail/mail.go:295","to":"tyjiypricfn3irfu9rc83r9yfh@localhost","subject":"[Mattermost] You joined "}
{"timestamp":"2024-10-11 16:07:08.623 Z","level":"debug","msg":"Received HTTP request","caller":"web/handlers.go:185","method":"POST","url":"/api/v4/users","request_id":"mb19pyantjgdzcq5to9t45khqa","user_id":"","status_code":"201"}
{"timestamp":"2024-10-11 16:07:08.636 Z","level":"debug","msg":"Fetching user count for first user account check","caller":"platform/config.go:356"}
{"timestamp":"2024-10-11 16:07:09.476 Z","level":"info","msg":"sending mail","caller":"mail/mail.go:295","to":"qb694em4hpgh38u3gnfbgapn8w@localhost","subject":"[Mattermost] You joined "}
{"timestamp":"2024-10-11 16:07:09.493 Z","level":"debug","msg":"Received HTTP request","caller":"web/handlers.go:185","method":"POST","url":"/api/v4/users","request_id":"6wkzwnzw7781mpmndqfdzxyjre","user_id":"","status_code":"201"}
{"timestamp":"2024-10-11 16:07:10.283 Z","level":"info","msg":"sending mail","caller":"mail/mail.go:295","to":"nzk5ukqfe7n1drwtcfq1jm7pdo@localhost","subject":"[Mattermost] You joined "}
{"timestamp":"2024-10-11 16:07:10.301 Z","level":"debug","msg":"Received HTTP request","caller":"web/handlers.go:185","method":"POST","url":"/api/v4/users","request_id":"bi4gq93tginwxxrdm6od5reccw","user_id":"","status_code":"201"}
{"timestamp":"2024-10-11 16:07:11.146 Z","level":"info","msg":"sending mail","caller":"mail/mail.go:295","to":"wxq5ihdiebbcjgaxpo6a9xdxfo@localhost","subject":"[Mattermost] You joined "}
{"timestamp":"2024-10-11 16:07:11.170 Z","level":"debug","msg":"Received HTTP request","caller":"web/handlers.go:185","method":"POST","url":"/api/v4/users","request_id":"c888m8f8rbbnpk9xye5jcqeohr","user_id":"","status_code":"201"}
{"timestamp":"2024-10-11 16:07:12.004 Z","level":"info","msg":"sending mail","caller":"mail/mail.go:295","to":"8huxwze647gxuqmhodimxr5cbc@localhost","subject":"[Mattermost] You joined "}
{"timestamp":"2024-10-11 16:07:12.022 Z","level":"debug","msg":"Received HTTP request","caller":"web/handlers.go:185","method":"POST","url":"/api/v4/users","request_id":"y7hqbgur97rzjnjaiw5wb5drga","user_id":"","status_code":"201"}
{"timestamp":"2024-10-11 16:07:12.860 Z","level":"debug","msg":"Received HTTP request","caller":"web/handlers.go:185","method":"POST","url":"/api/v4/users/login","request_id":"zn1nr5bojigfirb7iry8a8ygpy","user_id":"w9kch31xgbruiqai1efn4dzmyr","status_code":"200"}
{"timestamp":"2024-10-11 16:07:12.862 Z","level":"debug","msg":"Received HTTP request","caller":"web/handlers.go:185","method":"POST","url":"/api/v4/users/login","request_id":"u9ferfbtxfy39mgb6y9e49g9cc","user_id":"eifb5m7o3jyufnwjof1w545b5a","status_code":"200"}
{"timestamp":"2024-10-11 16:07:12.863 Z","level":"info","msg":"Set license","caller":"platform/license.go:384","id":"","issued_at":"1970-01-01 00:00:00.000 Z","starts_at":"1970-01-01 00:00:00.000 Z","expires_at":"2025-01-09 16:07:12.863 Z","sku_name":"","sku_short_name":"","is_trial":false,"is_gov_sku":false,"customer_id":"some ID","features.users":0,"features":{"advanced_logging":true,"cloud":false,"cluster":true,"compliance":true,"custom_permissions_schemes":true,"data_retention":true,"elastic_search":true,"email_notification_contents":true,"enterprise_plugins":true,"future":true,"google":true,"guest_accounts":true,"guest_accounts_permissions":true,"id_loaded":true,"ldap":true,"ldap_groups":true,"lock_teammate_name_display":true,"message_export":true,"metrics":true,"mfa":true,"mhpns":true,"office365":true,"openid":true,"outgoing_oauth_connections":true,"remote_cluster_service":true,"saml":true,"shared_channels":true}}
{"timestamp":"2024-10-11 16:07:12.899 Z","level":"debug","msg":"Advanced logging config not provided for notification logging","caller":"platform/config.go:165"}
{"timestamp":"2024-10-11 16:07:12.909 Z","level":"debug","msg":"You do not have the appropriate permissions.","caller":"web/context.go:120","path":"/api/v4/ldap/sync","request_id":"gxz8hpju4ibibr1enuom1np1xc","ip_addr":"127.0.0.1","user_id":"w9kch31xgbruiqai1efn4dzmyr","method":"POST","err_where":"Permissions","http_code":403,"error":"Permissions: You do not have the appropriate permissions., userId=w9kch31xgbruiqai1efn4dzmyr, permission=create_ldap_sync_job"}
{"timestamp":"2024-10-11 16:07:12.909 Z","level":"debug","msg":"Received HTTP request","caller":"web/handlers.go:185","method":"POST","url":"/api/v4/ldap/sync","request_id":"gxz8hpju4ibibr1enuom1np1xc","user_id":"w9kch31xgbruiqai1efn4dzmyr","status_code":"403"}
{"timestamp":"2024-10-11 16:07:12.909 Z","level":"info","msg":"Purging all caches","caller":"platform/cluster_handlers.go:114"}
{"timestamp":"2024-10-11 16:07:12.912 Z","level":"info","msg":"License key has not been uploaded. Loading license key from disk.","caller":"utils/license.go:107","filename":"/tmp/testlib1716966364/config/mattermost.mattermost-license"}
{"timestamp":"2024-10-11 16:07:12.912 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/testlib1716966364/config/mattermost.mattermost-license: stat /tmp/testlib1716966364/config/mattermost.mattermost-license: no such file or directory"}
{"timestamp":"2024-10-11 16:07:12.912 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-10-11 16:07:12.912 Z","level":"info","msg":"Cleared license","caller":"platform/license.go:384","id":"","issued_at":"1970-01-01 00:00:00.000 Z","starts_at":"1970-01-01 00:00:00.000 Z","expires_at":"2025-01-09 16:07:12.863 Z","sku_name":"","sku_short_name":"","is_trial":false,"is_gov_sku":false,"customer_id":"some ID","features.users":0,"features":{"advanced_logging":true,"cloud":false,"cluster":true,"compliance":true,"custom_permissions_schemes":true,"data_retention":true,"elastic_search":true,"email_notification_contents":true,"enterprise_plugins":true,"future":true,"google":true,"guest_accounts":true,"guest_accounts_permissions":true,"id_loaded":true,"ldap":true,"ldap_groups":true,"lock_teammate_name_display":true,"message_export":true,"metrics":true,"mfa":true,"mhpns":true,"office365":true,"openid":true,"outgoing_oauth_connections":true,"remote_cluster_service":true,"saml":true,"shared_channels":true}}
{"timestamp":"2024-10-11 16:07:12.915 Z","level":"info","msg":"Stopping Server...","caller":"app/server.go:669"}
{"timestamp":"2024-10-11 16:07:12.930 Z","level":"info","msg":"Shutting down Email batching service...","caller":"email/service.go:85"}
{"timestamp":"2024-10-11 16:07:12.930 Z","level":"info","msg":"Shutting down plugins","caller":"app/plugin.go:362"}
{"timestamp":"2024-10-11 16:07:12.930 Z","level":"debug","msg":"Disabling plugin health check job","caller":"plugin/environment.go:670"}
{"timestamp":"2024-10-11 16:07:12.930 Z","level":"info","msg":"stopping websocket hub connections","caller":"platform/web_hub.go:127"}
{"timestamp":"2024-10-11 16:07:12.931 Z","level":"info","msg":"Server stopped","caller":"app/server.go:753"}
--- FAIL: TestSyncLdap (5.67s)
View more details on GitHub Actions