ubuntu@ip-172-31-25-82:~$ sudo docker logs grist Running Grist as user 1001 with primary group 1001 info [grist-omnibus] Calling traefik [ '--providers.file.filename=/settings/traefik.yaml', '--entryPoints.web.address=:80', '--certificatesResolvers.letsencrypt.acme.email=rhope@ej1899.com', '--certificatesResolvers.letsencrypt.acme.storage=/persist/acme.json', '--certificatesResolvers.letsencrypt.acme.tlschallenge=true', '--entrypoints.websecure.address=:443', '--entrypoints.web.http.redirections.entrypoint.scheme=https', '--entrypoints.web.http.redirections.entrypoint.to=websecure' ] 2024/08/19 10:52:40 Starting up on port 17102 time="2024-08-19T10:52:40Z" level=info msg="Configuration loaded from flags." info [grist-omnibus] Using /custom/dex.yaml info [grist-omnibus] Checking dex... at https://grist.ej1899.com/dex/.well-known/openid-configuration time="2024-08-19T10:52:40Z" level=info msg="Dex Version: v2.33.1-dirty, Go Version: go1.18.4, Go OS/ARCH: linux amd64" time="2024-08-19T10:52:40Z" level=info msg="config using log level: debug" time="2024-08-19T10:52:40Z" level=info msg="config issuer: https://grist.ej1899.com/dex" time="2024-08-19T10:52:40Z" level=info msg="config storage: sqlite3" time="2024-08-19T10:52:40Z" level=info msg="config static client: Grist" time="2024-08-19T10:52:40Z" level=info msg="config connector: microsoft" time="2024-08-19T10:52:40Z" level=info msg="config skipping approval screen" time="2024-08-19T10:52:40Z" level=info msg="config refresh tokens rotation enabled: true" gvisor check ok (flags: -unprivileged -ignore-cgroups) time="2024-08-19T10:52:40Z" level=info msg="listening (http) on 0.0.0.0:9999" debug [grist-omnibus] not ready: FetchError: request to https://grist.ej1899.com/dex/.well-known/openid-configuration failed, reason: Client network socket disconnected before secure TLS connection was established info [grist-omnibus] Checking dex... at https://grist.ej1899.com/dex/.well-known/openid-configuration debug [grist-omnibus] not ready: FetchError: request to https://grist.ej1899.com/dex/.well-known/openid-configuration failed, reason: Client network socket disconnected before secure TLS connection was established info [grist-omnibus] Checking dex... at https://grist.ej1899.com/dex/.well-known/openid-configuration debug [grist-omnibus] not ready: FetchError: request to https://grist.ej1899.com/dex/.well-known/openid-configuration failed, reason: Client network socket disconnected before secure TLS connection was established info [grist-omnibus] Checking dex... at https://grist.ej1899.com/dex/.well-known/openid-configuration debug [grist-omnibus] not ready: FetchError: request to https://grist.ej1899.com/dex/.well-known/openid-configuration failed, reason: self-signed certificate info [grist-omnibus] Checking dex... at https://grist.ej1899.com/dex/.well-known/openid-configuration debug [grist-omnibus] not ready: FetchError: request to https://grist.ej1899.com/dex/.well-known/openid-configuration failed, reason: self-signed certificate info [grist-omnibus] Checking dex... at https://grist.ej1899.com/dex/.well-known/openid-configuration debug [grist-omnibus] got: 200 info [grist-omnibus] Happy with dex info [grist-omnibus] Starting traefik-forward-auth 2024-08-19 10:52:42.453 - info: Loading config file from /persist/config.json 2024-08-19 10:52:42.464 - debug: 3-pipe Sandbox started sandboxPid=142, flavor=gvisor, command=undefined, entryPoint=(default) 2024-08-19 10:52:42.506 - info: Sandbox stderr: run.py: sandbox/gvisor/run.py -E PYTHONPATH=/grist/sandbox/grist -E PIPE_MODE=minimal -m /grist/sandbox --checkpoint /tmp/engine__grist python3 -- /grist/sandbox/grist/main.py sandboxPid=142, flavor=gvisor, command=undefined, entryPoint=(default) info [grist-omnibus] I think everything has started up now info [grist-omnibus] Listening internally on 80/443, externally at https://grist.ej1899.com 2024-08-19 10:52:43.956 - info: Sandbox stderr: Ready message: [INFO] [__main__] Ready sandboxPid=142, flavor=gvisor, command=undefined, entryPoint=(default) 2024-08-19 10:52:44.179 - warn: Sandbox unexpectedly exited with code 0 signal null sandboxPid=142, flavor=gvisor, command=undefined, entryPoint=(default) 2024-08-19 10:52:45.552 - info: Loading config file from /persist/config.json Welcome to Grist. In quiet mode, see http://localhost:17100 to use. For full logs, re-run with DEBUG=1 Setting up database... Database setup complete. 2024-08-19 10:52:46.551 - info: == Grist version is 1.1.17 (commit unknown) 2024-08-19 10:52:46.558 - debug: skipping incomplete language ar (set GRIST_OFFER_ALL_LANGUAGES if you want it) 2024-08-19 10:52:46.562 - debug: skipping incomplete language cs (set GRIST_OFFER_ALL_LANGUAGES if you want it) 2024-08-19 10:52:46.572 - debug: skipping incomplete language fa (set GRIST_OFFER_ALL_LANGUAGES if you want it) 2024-08-19 10:52:46.583 - debug: skipping incomplete language nl (set GRIST_OFFER_ALL_LANGUAGES if you want it) 2024-08-19 10:52:46.598 - debug: skipping incomplete language th (set GRIST_OFFER_ALL_LANGUAGES if you want it) 2024-08-19 10:52:46.625 - warn: did not find an appropriately named example workspace in deployment 2024-08-19 10:52:46.630 - info: No plugins found in directory: /grist/.grist/plugins 2024-08-19 10:52:46.638 - info: Found 2 valid plugins on the system 2024-08-19 10:52:46.638 - debug: PLUGIN builtIn/core -- /grist/plugins/core 2024-08-19 10:52:46.638 - debug: PLUGIN bundled/grist-bundled -- /grist/node_modules/@gristlabs/grist-widget/dist/plugins/grist-bundled 2024-08-19 10:52:46.646 - info: Server timeouts: keepAliveTimeout 305000 headersTimeout 306000 2024-08-19 10:52:46.650 - info: server(home,docs,static) available at 0.0.0.0:17100 2024-08-19 10:52:46.664 - warn: Failed to create GoogleAuth endpoint: GOOGLE_CLIENT_SECRET is not defined 2024-08-19 10:52:46.718 - info: activity docCount=15, orgCount=2, orgInGoodStandingCount=2, userCount=9, userWithLoginCount=7 2024-08-19 10:52:46.763 - info: Server timeouts: keepAliveTimeout 305000 headersTimeout 306000 2024-08-19 10:52:46.764 - info: pluginServer available at 0.0.0.0:43761 2024-08-19 10:52:46.767 - info: == appRoot: /grist 2024-08-19 10:52:46.767 - info: == i18:namespace: client,server 2024-08-19 10:52:46.767 - info: == docsRoot: /persist/docs 2024-08-19 10:52:46.767 - info: == defaultBaseDomain: grist.ej1899.com 2024-08-19 10:52:46.768 - info: == tag: unknown 2024-08-19 10:52:46.768 - info: == database: sqlite:///persist/home.sqlite3 2024-08-19 10:52:46.768 - info: == userRoot: /grist/.grist 2024-08-19 10:52:46.768 - info: == bundledRoot: /grist/node_modules/@gristlabs/grist-widget/dist 2024-08-19 10:52:46.768 - info: == instanceRoot: /persist 2024-08-19 10:52:46.768 - info: == loginMiddlewareComment: forward-auth 2024-08-19 10:52:46.768 - info: == docWorkerId: testDocWorkerId_17100 2024-08-19 10:52:46.768 - info: == pluginUrl: http://0.0.0.0:43761/ 2024-08-19 10:52:46.768 - info: == willServePlugins: true 2024-08-19 10:52:46.769 - info: == grist.access.supportEmail: support@getgrist.com [default] [GRIST_SUPPORT_EMAIL] 2024-08-19 10:52:46.769 - info: == grist.access.listPublicSites: false [default] [GRIST_LIST_PUBLIC_SITES] 2024-08-19 10:52:46.769 - info: == grist.access.installAdminEmail: rhope@ej1899.com [GRIST_DEFAULT_EMAIL] 2024-08-19 10:52:46.769 - info: == grist.integrations.sql.timeout: 1000 [default] [GRIST_SQL_TIMEOUT_MSEC] 2024-08-19 10:52:46.769 - info: == grist.integrations.allowedWebhookDomains: - [ALLOWED_WEBHOOK_DOMAINS] 2024-08-19 10:52:46.769 - info: == grist.integrations.proxy: - [GRIST_HTTPS_PROXY] 2024-08-19 10:52:46.769 - info: == grist.locale.offerAllLanguages: - [GRIST_OFFER_ALL_LANGUAGES] 2024-08-19 10:52:46.769 - info: == grist.login.system.forwardAuth.header: X-Forwarded-User [GRIST_FORWARD_AUTH_HEADER] 2024-08-19 10:52:46.769 - info: == grist.login.system.forwardAuth.active: true 2024-08-19 10:52:46.769 - info: == grist.login.system.forwardAuth.logoutPath: _oauth/logout [GRIST_FORWARD_AUTH_LOGOUT_PATH] 2024-08-19 10:52:46.769 - info: == grist.login.system.forwardAuth.loginPath: /auth/login [default] [GRIST_FORWARD_AUTH_LOGIN_PATH] 2024-08-19 10:52:46.769 - info: == grist.login.skipSession: - [GRIST_IGNORE_SESSION] 2024-08-19 10:52:46.769 - info: == grist.login.forced: true [GRIST_FORCE_LOGIN] 2024-08-19 10:52:46.770 - info: == grist.externalStorage.minio.bucket: gristbucket01 [GRIST_DOCS_MINIO_BUCKET] 2024-08-19 10:52:46.770 - info: == grist.externalStorage.minio.bucketRegion: us-east-1 [default] [GRIST_DOCS_MINIO_BUCKET_REGION] 2024-08-19 10:52:46.770 - info: == grist.externalStorage.minio.prefix: docs/ [default] [GRIST_DOCS_MINIO_PREFIX] 2024-08-19 10:52:46.770 - info: == grist.externalStorage.minio.endpoint: s3.amazonaws.com [GRIST_DOCS_MINIO_ENDPOINT] 2024-08-19 10:52:46.770 - info: == grist.externalStorage.minio.port: - [GRIST_DOCS_MINIO_PORT] 2024-08-19 10:52:46.770 - info: == grist.externalStorage.minio.useSsl: - [GRIST_DOCS_MINIO_USE_SSL] 2024-08-19 10:52:46.770 - info: == grist.externalStorage.minio.accessKey: ***** [GRIST_DOCS_MINIO_ACCESS_KEY] 2024-08-19 10:52:46.770 - info: == grist.externalStorage.minio.secretKey: ***** [GRIST_DOCS_MINIO_SECRET_KEY] 2024-08-19 10:52:46.770 - info: == grist.externalStorage.minio.url: minio://gristbucket01/docs/ 2024-08-19 10:52:46.770 - info: == grist.externalStorage.minio.active: true 2024-08-19 10:52:46.770 - info: == grist.externalStorage.disable: - [GRIST_DISABLE_S3] 2024-08-19 10:52:46.781 - debug: 3-pipe Sandbox started sandboxPid=240, flavor=gvisor, command=undefined, entryPoint=(default), docId=test 2024-08-19 10:52:46.817 - info: Sandbox stderr: run.py: sandbox/gvisor/run.py -E PYTHONPATH=/grist/sandbox/grist -E PIPE_MODE=minimal -m /grist/sandbox --restore /tmp/engine__grist python3 -- /grist/sandbox/grist/main.py test sandboxPid=240, flavor=gvisor, command=undefined, entryPoint=(default), docId=test 2024-08-19 10:52:47.077 - debug: NSandbox pyCall sandboxPid=240, flavor=gvisor, command=undefined, entryPoint=(default), docId=test, funcName=get_version, loadMs=296 2024-08-19 10:52:47.077 - debug: Sandbox shutdown starting sandboxPid=240, flavor=gvisor, command=undefined, entryPoint=(default), docId=test 2024-08-19 10:52:47.209 - debug: Sandbox exited with code 0 signal null sandboxPid=240, flavor=gvisor, command=undefined, entryPoint=(default), docId=test 2024-08-19 10:52:47.554 - debug: Auth[GET]: grist.ej1899.com / customHostSession=, method=GET, host=grist.ej1899.com, path=/, org=ej1899, email=rhope@ej1899.com, userId=6, altSessionId=qreFNDG48jsEyiwwEEwRHu 2024-08-19 10:52:47.787 - debug: Subprocess control failure: Error: not found flavor=gvisor, command=undefined, entryPoint=(default), docId=test 2024-08-19 10:52:47.869 - debug: Auth[GET]: grist.ej1899.com /session/access/all customHostSession=, method=GET, host=grist.ej1899.com, path=/session/access/all, org=ej1899, email=rhope@ej1899.com, userId=6, altSessionId=qreFNDG48jsEyiwwEEwRHu 2024-08-19 10:52:47.879 - debug: Auth[GET]: grist.ej1899.com /session/access/active customHostSession=, method=GET, host=grist.ej1899.com, path=/session/access/active, org=ej1899, email=rhope@ej1899.com, userId=6, altSessionId=qreFNDG48jsEyiwwEEwRHu 2024-08-19 10:52:47.926 - debug: Auth[GET]: grist.ej1899.com /orgs/5/workspaces customHostSession=, method=GET, host=grist.ej1899.com, path=/orgs/5/workspaces, org=ej1899, email=rhope@ej1899.com, userId=6, altSessionId=qreFNDG48jsEyiwwEEwRHu 2024-08-19 10:52:47.940 - debug: Auth[GET]: grist.ej1899.com /orgs/5/usage customHostSession=, method=GET, host=grist.ej1899.com, path=/orgs/5/usage, org=ej1899, email=rhope@ej1899.com, userId=6, altSessionId=qreFNDG48jsEyiwwEEwRHu 2024-08-19 10:52:56.124 - debug: Auth[GET]: grist.ej1899.com /orgs/5/workspaces customHostSession=, method=GET, host=grist.ej1899.com, path=/orgs/5/workspaces, org=ej1899, email=rhope@ej1899.com, userId=6, altSessionId=qreFNDG48jsEyiwwEEwRHu 2024-08-19 10:53:17.007 - debug: Auth[GET]: grist.ej1899.com /orgs/5/workspaces customHostSession=, method=GET, host=grist.ej1899.com, path=/orgs/5/workspaces, org=ej1899, email=rhope@ej1899.com, userId=6, altSessionId=qreFNDG48jsEyiwwEEwRHu 2024-08-19 10:53:18.845 - debug: Auth[GET]: grist.ej1899.com /orgs/5/workspaces customHostSession=, method=GET, host=grist.ej1899.com, path=/orgs/5/workspaces, org=ej1899, email=rhope@ej1899.com, userId=6, altSessionId=qreFNDG48jsEyiwwEEwRHu 2024-08-19 10:53:28.590 - debug: Auth[GET]: grist.ej1899.com /orgs/5/workspaces customHostSession=, method=GET, host=grist.ej1899.com, path=/orgs/5/workspaces, org=ej1899, email=rhope@ej1899.com, userId=6, altSessionId=qreFNDG48jsEyiwwEEwRHu 2024-08-19 10:53:30.168 - debug: Auth[GET]: grist.ej1899.com /orgs/5/workspaces customHostSession=, method=GET, host=grist.ej1899.com, path=/orgs/5/workspaces, org=ej1899, email=rhope@ej1899.com, userId=6, altSessionId=qreFNDG48jsEyiwwEEwRHu 2024-08-19 10:53:31.444 - debug: Auth[GET]: grist.ej1899.com /orgs/5/workspaces customHostSession=, method=GET, host=grist.ej1899.com, path=/orgs/5/workspaces, org=ej1899, email=rhope@ej1899.com, userId=6, altSessionId=qreFNDG48jsEyiwwEEwRHu 2024-08-19 10:53:36.360 - debug: Auth[GET]: grist.ej1899.com /orgs/5/access customHostSession=, method=GET, host=grist.ej1899.com, path=/orgs/5/access, org=ej1899, email=rhope@ej1899.com, userId=6, altSessionId=qreFNDG48jsEyiwwEEwRHu 2024-08-19 10:53:45.948 - debug: Auth[GET]: grist.ej1899.com /orgs/5/workspaces customHostSession=, method=GET, host=grist.ej1899.com, path=/orgs/5/workspaces, org=ej1899, email=rhope@ej1899.com, userId=6, altSessionId=qreFNDG48jsEyiwwEEwRHu 2024-08-19 10:53:54.684 - debug: Auth[GET]: grist.ej1899.com /fdjn8hxT6U2L/Hitachi-Analysis customHostSession=, method=GET, host=grist.ej1899.com, path=/fdjn8hxT6U2L/Hitachi-Analysis, org=ej1899, email=rhope@ej1899.com, userId=6, altSessionId=qreFNDG48jsEyiwwEEwRHu 2024-08-19 10:53:54.835 - debug: Auth[GET]: grist.ej1899.com /session/access/active customHostSession=, method=GET, host=grist.ej1899.com, path=/session/access/active, org=ej1899, email=rhope@ej1899.com, userId=6, altSessionId=qreFNDG48jsEyiwwEEwRHu 2024-08-19 10:53:54.842 - debug: Auth[GET]: grist.ej1899.com /session/access/all customHostSession=, method=GET, host=grist.ej1899.com, path=/session/access/all, org=ej1899, email=rhope@ej1899.com, userId=6, altSessionId=qreFNDG48jsEyiwwEEwRHu 2024-08-19 10:53:54.849 - debug: Auth[GET]: grist.ej1899.com /worker/fdjn8hxT6U2LvagFEu5wq2 customHostSession=, method=GET, host=grist.ej1899.com, path=/worker/fdjn8hxT6U2LvagFEu5wq2, org=ej1899, email=rhope@ej1899.com, userId=6, altSessionId=qreFNDG48jsEyiwwEEwRHu 2024-08-19 10:53:54.896 - debug: Auth[GET]: grist.ej1899.com /docs/fdjn8hxT6U2L customHostSession=, method=GET, host=grist.ej1899.com, path=/docs/fdjn8hxT6U2L, org=ej1899, email=rhope@ej1899.com, userId=6, altSessionId=qreFNDG48jsEyiwwEEwRHu 2024-08-19 10:53:54.991 - debug: allowHost: req=http://grist.ej1899.com/?clientId=0&counter=1&newClient=1&browserSettings=%7B%22timezone%22%3A%22America%2FNew_York%22%7D&user=rhope%40ej1899.com, origin=https://grist.ej1899.com, actualUrl=grist.ej1899.com, allowedUrl=grist.ej1899.com 2024-08-19 10:53:54.997 - info: Comm: Got Websocket connection clientId=ac611b44dc8dd7a0, counter=null, urlPath=/?clientId=0&counter=1&newClient=1&browserSettings=%7B%22timezone%22%3A%22America%2FNew_York%22%7D&user=rhope%40ej1899.com, reuseClient=false 2024-08-19 10:53:54.998 - debug: Client sending clientConnect newClient=true, needReload=false, docsClosed=0, missedMessages=undefined, email=rhope@ej1899.com, org=ej1899, altSessionId=qreFNDG48jsEyiwwEEwRHu, clientId=ac611b44dc8dd7a0, counter=1 2024-08-19 10:53:55.052 - info: Client onMessage '{"reqId":0,"method":"openDoc","args":["fdjn8hxT6U2LvagFEu5wq2",{"openMode":"defa... (118 length)' email=rhope@ej1899.com, org=ej1899, altSessionId=qreFNDG48jsEyiwwEEwRHu, clientId=ac611b44dc8dd7a0, counter=1 2024-08-19 10:53:55.056 - debug: DocManager.openDoc Authorizer key { urlId: 'fdjn8hxT6U2LvagFEu5wq2', userId: 6, org: 'ej1899' } 2024-08-19 10:53:55.062 - debug: DocManager.fetchDoc fdjn8hxT6U2LvagFEu5wq2 2024-08-19 10:53:55.073 - debug: ActiveDoc loadDoc access=owners, userId=6, email=rhope@ej1899.com, age=3, org=ej1899, altSessionId=qreFNDG48jsEyiwwEEwRHu, clientId=ac611b44dc8dd7a0, counter=1, docId=fdjn8hxT6U2LvagFEu5wq2 2024-08-19 10:53:55.075 - debug: backupSqliteDatabase: starting copy of /persist/docs/fdjn8hxT6U2LvagFEu5wq2.grist (backup) docId=fdjn8hxT6U2LvagFEu5wq2 2024-08-19 10:53:55.086 - info: backupSqliteDatabase: copy of /persist/docs/fdjn8hxT6U2LvagFEu5wq2.grist (backup) completed successfully docId=fdjn8hxT6U2LvagFEu5wq2 2024-08-19 10:53:55.087 - debug: backupSqliteDatabase: stopped copy of /persist/docs/fdjn8hxT6U2LvagFEu5wq2.grist (backup) docId=fdjn8hxT6U2LvagFEu5wq2, maxStepTimeMs=9, numSteps=1 2024-08-19 10:53:55.098 - info: HostedStorageManager Local hash does not match redis: 01238a232439a17c485c84ca3e664a54 vs unknown docId=fdjn8hxT6U2LvagFEu5wq2 2024-08-19 10:53:55.141 - debug: ActiveDoc createDoc access=owners, userId=6, email=rhope@ej1899.com, age=3, org=ej1899, altSessionId=qreFNDG48jsEyiwwEEwRHu, clientId=ac611b44dc8dd7a0, counter=1, docId=fdjn8hxT6U2LvagFEu5wq2 2024-08-19 10:53:55.165 - debug: DB fdjn8hxT6U2LvagFEu5wq2 open successfully 2024-08-19 10:53:55.172 - debug: ActiveDoc Loading 23 normal tables, skipping 0 on-demand tables access=owners, userId=6, email=rhope@ej1899.com, age=3, org=ej1899, altSessionId=qreFNDG48jsEyiwwEEwRHu, clientId=ac611b44dc8dd7a0, counter=1, docId=fdjn8hxT6U2LvagFEu5wq2 2024-08-19 10:53:55.173 - debug: ActiveDoc Normal tables: Table1, _grist_ACLMemberships, _grist_ACLPrincipals, _grist_ACLResources, _grist_ACLRules, _grist_Attachments, _grist_Cells, _grist_DocInfo, _grist_External_database, _grist_External_table, _grist_Filters, _grist_Imports, _grist_Pages, _grist_REPL_Hist, _grist_Shares, _grist_TabBar, _grist_TabItems, _grist_TableViews, _grist_Triggers, _grist_Validations, _grist_Views, _grist_Views_section, _grist_Views_section_field access=owners, userId=6, email=rhope@ej1899.com, age=3, org=ej1899, altSessionId=qreFNDG48jsEyiwwEEwRHu, clientId=ac611b44dc8dd7a0, counter=1, docId=fdjn8hxT6U2LvagFEu5wq2 2024-08-19 10:53:55.173 - debug: ActiveDoc On-demand tables: access=owners, userId=6, email=rhope@ej1899.com, age=3, org=ej1899, altSessionId=qreFNDG48jsEyiwwEEwRHu, clientId=ac611b44dc8dd7a0, counter=1, docId=fdjn8hxT6U2LvagFEu5wq2 2024-08-19 10:53:55.173 - debug: ActiveDoc starting to load 22 tables: _grist_ACLMemberships, _grist_ACLPrincipals, _grist_ACLResources, _grist_ACLRules, _grist_Attachments, _grist_Cells, _grist_DocInfo, _grist_External_database, _grist_External_table, _grist_Filters, _grist_Imports, _grist_Pages, _grist_REPL_Hist, _grist_Shares, _grist_TabBar, _grist_TabItems, _grist_TableViews, _grist_Triggers, _grist_Validations, _grist_Views, _grist_Views_section, _grist_Views_section_field access=owners, userId=6, email=rhope@ej1899.com, age=3, org=ej1899, altSessionId=qreFNDG48jsEyiwwEEwRHu, clientId=ac611b44dc8dd7a0, counter=1, docId=fdjn8hxT6U2LvagFEu5wq2 2024-08-19 10:53:55.190 - debug: 3-pipe Sandbox started sandboxPid=314, flavor=gvisor, command=undefined, entryPoint=(default), docId=fdjn8hxT6U2LvagFEu5wq2 2024-08-19 10:53:55.212 - debug: DocClients now 1 clients; new client is ac611b44dc8dd7a0 (fd 0) access=owners, userId=6, email=rhope@ej1899.com, age=3, org=ej1899, altSessionId=qreFNDG48jsEyiwwEEwRHu, clientId=ac611b44dc8dd7a0, counter=1, docId=fdjn8hxT6U2LvagFEu5wq2 2024-08-19 10:53:55.212 - info: ActiveDoc will stay open access=owners, userId=6, email=rhope@ej1899.com, age=3, org=ej1899, altSessionId=qreFNDG48jsEyiwwEEwRHu, clientId=ac611b44dc8dd7a0, counter=1, docId=fdjn8hxT6U2LvagFEu5wq2 2024-08-19 10:53:55.213 - info: ActiveDoc fetchMetaTables access=owners, userId=6, email=rhope@ej1899.com, age=3, org=ej1899, altSessionId=qreFNDG48jsEyiwwEEwRHu, clientId=ac611b44dc8dd7a0, counter=1, docId=fdjn8hxT6U2LvagFEu5wq2 2024-08-19 10:53:55.217 - debug: Time taken in getRecentMinimalActionGroups: 0 ms 2024-08-19 10:53:55.229 - info: Sandbox stderr: run.py: sandbox/gvisor/run.py -E PYTHONPATH=/grist/sandbox/grist -E PIPE_MODE=minimal -m /grist/sandbox --restore /tmp/engine__grist python3 -- /grist/sandbox/grist/main.py fdjn8hxT6U2LvagFEu5wq2 sandboxPid=314, flavor=gvisor, command=undefined, entryPoint=(default), docId=fdjn8hxT6U2LvagFEu5wq2 2024-08-19 10:53:55.257 - info: Client onMessage '{"reqId":1,"method":"fetchTable","args":[0,"Table1"]}' email=rhope@ej1899.com, userId=6, age=3, org=ej1899, altSessionId=qreFNDG48jsEyiwwEEwRHu, clientId=ac611b44dc8dd7a0, counter=1 2024-08-19 10:53:55.257 - debug: activeDocMethod access=owners, userId=6, email=rhope@ej1899.com, age=3, org=ej1899, altSessionId=qreFNDG48jsEyiwwEEwRHu, clientId=ac611b44dc8dd7a0, counter=1, docId=fdjn8hxT6U2LvagFEu5wq2, docMethod=fetchTable 2024-08-19 10:53:55.258 - info: ActiveDoc fetchQuery {"tableId":"Table1","filters":{}} (regular) access=owners, userId=6, email=rhope@ej1899.com, age=3, org=ej1899, altSessionId=qreFNDG48jsEyiwwEEwRHu, clientId=ac611b44dc8dd7a0, counter=1, docId=fdjn8hxT6U2LvagFEu5wq2 2024-08-19 10:53:55.260 - info: ActiveDoc fetchQuery -> 0 rows, cols: manualSort, A, B, C access=owners, userId=6, email=rhope@ej1899.com, age=3, org=ej1899, altSessionId=qreFNDG48jsEyiwwEEwRHu, clientId=ac611b44dc8dd7a0, counter=1, docId=fdjn8hxT6U2LvagFEu5wq2 2024-08-19 10:53:55.285 - info: Client onMessage '{"reqId":2,"method":"getUsersForViewAs","args":[0]}' email=rhope@ej1899.com, userId=6, age=3, org=ej1899, altSessionId=qreFNDG48jsEyiwwEEwRHu, clientId=ac611b44dc8dd7a0, counter=1 2024-08-19 10:53:55.285 - debug: activeDocMethod access=owners, userId=6, email=rhope@ej1899.com, age=3, org=ej1899, altSessionId=qreFNDG48jsEyiwwEEwRHu, clientId=ac611b44dc8dd7a0, counter=1, docId=fdjn8hxT6U2LvagFEu5wq2, docMethod=getUsersForViewAs 2024-08-19 10:53:55.410 - info: ext meta upload: minio://gristbucket01/docs/assets/unversioned/fdjn8hxT6U2LvagFEu5wq2/meta.json checksum d751713988987e9331980363e24189ce version 1DsoQuP_U30eiO9igtzZqRGNY0hSL7gD 2024-08-19 10:53:55.411 - info: Pruned 0 versions of 0 for document fdjn8hxT6U2LvagFEu5wq2 2024-08-19 10:53:55.644 - debug: NSandbox pyCall sandboxPid=314, flavor=gvisor, command=undefined, entryPoint=(default), docId=fdjn8hxT6U2LvagFEu5wq2, funcName=load_meta_tables, loadMs=453 2024-08-19 10:53:55.645 - debug: NSandbox pyCall sandboxPid=314, flavor=gvisor, command=undefined, entryPoint=(default), docId=fdjn8hxT6U2LvagFEu5wq2, funcName=load_table, loadMs=1 2024-08-19 10:53:55.645 - debug: NSandbox pyCall sandboxPid=314, flavor=gvisor, command=undefined, entryPoint=(default), docId=fdjn8hxT6U2LvagFEu5wq2, funcName=load_table, loadMs=0 2024-08-19 10:53:55.646 - debug: NSandbox pyCall sandboxPid=314, flavor=gvisor, command=undefined, entryPoint=(default), docId=fdjn8hxT6U2LvagFEu5wq2, funcName=load_table, loadMs=1 2024-08-19 10:53:55.646 - debug: NSandbox pyCall sandboxPid=314, flavor=gvisor, command=undefined, entryPoint=(default), docId=fdjn8hxT6U2LvagFEu5wq2, funcName=load_table, loadMs=1 2024-08-19 10:53:55.646 - debug: NSandbox pyCall sandboxPid=314, flavor=gvisor, command=undefined, entryPoint=(default), docId=fdjn8hxT6U2LvagFEu5wq2, funcName=load_table, loadMs=1 2024-08-19 10:53:55.646 - debug: NSandbox pyCall sandboxPid=314, flavor=gvisor, command=undefined, entryPoint=(default), docId=fdjn8hxT6U2LvagFEu5wq2, funcName=load_table, loadMs=1 2024-08-19 10:53:55.646 - debug: NSandbox pyCall sandboxPid=314, flavor=gvisor, command=undefined, entryPoint=(default), docId=fdjn8hxT6U2LvagFEu5wq2, funcName=load_table, loadMs=0 2024-08-19 10:53:55.647 - debug: NSandbox pyCall sandboxPid=314, flavor=gvisor, command=undefined, entryPoint=(default), docId=fdjn8hxT6U2LvagFEu5wq2, funcName=load_table, loadMs=1 2024-08-19 10:53:55.647 - debug: NSandbox pyCall sandboxPid=314, flavor=gvisor, command=undefined, entryPoint=(default), docId=fdjn8hxT6U2LvagFEu5wq2, funcName=load_table, loadMs=1 2024-08-19 10:53:55.648 - debug: NSandbox pyCall sandboxPid=314, flavor=gvisor, command=undefined, entryPoint=(default), docId=fdjn8hxT6U2LvagFEu5wq2, funcName=load_table, loadMs=1 2024-08-19 10:53:55.648 - debug: NSandbox pyCall sandboxPid=314, flavor=gvisor, command=undefined, entryPoint=(default), docId=fdjn8hxT6U2LvagFEu5wq2, funcName=load_table, loadMs=1 2024-08-19 10:53:55.648 - debug: NSandbox pyCall sandboxPid=314, flavor=gvisor, command=undefined, entryPoint=(default), docId=fdjn8hxT6U2LvagFEu5wq2, funcName=load_table, loadMs=1 2024-08-19 10:53:55.648 - debug: NSandbox pyCall sandboxPid=314, flavor=gvisor, command=undefined, entryPoint=(default), docId=fdjn8hxT6U2LvagFEu5wq2, funcName=load_table, loadMs=1 2024-08-19 10:53:55.649 - debug: NSandbox pyCall sandboxPid=314, flavor=gvisor, command=undefined, entryPoint=(default), docId=fdjn8hxT6U2LvagFEu5wq2, funcName=load_table, loadMs=2 2024-08-19 10:53:55.649 - debug: NSandbox pyCall sandboxPid=314, flavor=gvisor, command=undefined, entryPoint=(default), docId=fdjn8hxT6U2LvagFEu5wq2, funcName=load_table, loadMs=1 2024-08-19 10:53:55.649 - debug: NSandbox pyCall sandboxPid=314, flavor=gvisor, command=undefined, entryPoint=(default), docId=fdjn8hxT6U2LvagFEu5wq2, funcName=load_table, loadMs=1 2024-08-19 10:53:55.649 - debug: NSandbox pyCall sandboxPid=314, flavor=gvisor, command=undefined, entryPoint=(default), docId=fdjn8hxT6U2LvagFEu5wq2, funcName=load_table, loadMs=1 2024-08-19 10:53:55.649 - debug: NSandbox pyCall sandboxPid=314, flavor=gvisor, command=undefined, entryPoint=(default), docId=fdjn8hxT6U2LvagFEu5wq2, funcName=load_table, loadMs=1 2024-08-19 10:53:55.650 - debug: NSandbox pyCall sandboxPid=314, flavor=gvisor, command=undefined, entryPoint=(default), docId=fdjn8hxT6U2LvagFEu5wq2, funcName=load_table, loadMs=1 2024-08-19 10:53:55.650 - debug: NSandbox pyCall sandboxPid=314, flavor=gvisor, command=undefined, entryPoint=(default), docId=fdjn8hxT6U2LvagFEu5wq2, funcName=load_table, loadMs=1 2024-08-19 10:53:55.651 - debug: NSandbox pyCall sandboxPid=314, flavor=gvisor, command=undefined, entryPoint=(default), docId=fdjn8hxT6U2LvagFEu5wq2, funcName=load_table, loadMs=2 2024-08-19 10:53:55.651 - debug: NSandbox pyCall sandboxPid=314, flavor=gvisor, command=undefined, entryPoint=(default), docId=fdjn8hxT6U2LvagFEu5wq2, funcName=load_table, loadMs=2 2024-08-19 10:53:55.651 - debug: ActiveDoc loading 1 tables: Table1 access=owners, userId=6, email=rhope@ej1899.com, age=3, org=ej1899, altSessionId=qreFNDG48jsEyiwwEEwRHu, clientId=ac611b44dc8dd7a0, counter=1, docId=fdjn8hxT6U2LvagFEu5wq2 2024-08-19 10:53:55.653 - debug: NSandbox pyCall sandboxPid=314, flavor=gvisor, command=undefined, entryPoint=(default), docId=fdjn8hxT6U2LvagFEu5wq2, funcName=load_table, loadMs=0 2024-08-19 10:53:55.654 - debug: NSandbox pyCall sandboxPid=314, flavor=gvisor, command=undefined, entryPoint=(default), docId=fdjn8hxT6U2LvagFEu5wq2, funcName=get_table_stats, loadMs=0 2024-08-19 10:53:55.655 - info: Loading complete, table statistics retrieved... access=owners, userId=6, email=rhope@ej1899.com, age=3, org=ej1899, altSessionId=qreFNDG48jsEyiwwEEwRHu, clientId=ac611b44dc8dd7a0, counter=1, docId=fdjn8hxT6U2LvagFEu5wq2, num_user_tables=1, _grist_Tables_rows=1, _grist_Tables_bytes=202, _grist_Tables_column_rows=4, _grist_Tables_column_bytes=681, _grist_ACLMemberships_rows=0, _grist_ACLMemberships_bytes=45, _grist_ACLPrincipals_rows=4, _grist_ACLPrincipals_bytes=270, _grist_ACLResources_rows=1, _grist_ACLResources_bytes=62, _grist_ACLRules_rows=1, _grist_ACLRules_bytes=280, _grist_Attachments_rows=0, _grist_Attachments_bytes=188, _grist_Cells_rows=0, _grist_Cells_bytes=143, _grist_DocInfo_rows=1, _grist_DocInfo_bytes=217, _grist_External_database_rows=0, _grist_External_database_bytes=112, _grist_External_table_rows=0, _grist_External_table_bytes=72, _grist_Filters_rows=0, _grist_Filters_bytes=86, _grist_Imports_rows=0, _grist_Imports_bytes=219, _grist_Pages_rows=1, _grist_Pages_bytes=112, _grist_REPL_Hist_rows=0, _grist_REPL_Hist_bytes=67, _grist_Shares_rows=0, _grist_Shares_bytes=83, _grist_TabBar_rows=1, _grist_TabBar_bytes=62, _grist_TabItems_rows=0, _grist_TabItems_bytes=49, _grist_TableViews_rows=0, _grist_TableViews_bytes=49, _grist_Triggers_rows=0, _grist_Triggers_bytes=182, _grist_Validations_rows=0, _grist_Validations_bytes=63, _grist_Views_rows=1, _grist_Views_bytes=96, _grist_Views_section_rows=3, _grist_Views_section_bytes=698, _grist_Views_section_field_rows=9, _grist_Views_section_field_bytes=590, user_rows=0, user_columns=4, user_bytes=67, user_cells=0, num_on_demand_tables=0 2024-08-19 10:53:55.656 - debug: NSandbox pyCall sandboxPid=314, flavor=gvisor, command=undefined, entryPoint=(default), docId=fdjn8hxT6U2LvagFEu5wq2, funcName=initialize, loadMs=1 2024-08-19 10:53:55.656 - debug: ActiveDoc _applyUserActions(null, [['Calculate']]) access=owners, docId=fdjn8hxT6U2LvagFEu5wq2 2024-08-19 10:53:55.670 - debug: NSandbox pyCall sandboxPid=314, flavor=gvisor, command=undefined, entryPoint=(default), docId=fdjn8hxT6U2LvagFEu5wq2, funcName=apply_user_actions, loadMs=12 2024-08-19 10:53:56.246 - debug: Sandbox memory memory=31551488, sandboxPid=314, flavor=gvisor, command=undefined, entryPoint=(default), docId=fdjn8hxT6U2LvagFEu5wq2 2024-08-19 10:53:56.248 - debug: Sharing _doApplyUserActions access=owners, docId=fdjn8hxT6U2LvagFEu5wq2, actionNum=0, linkId=0, otherId=0, numDocActions=0, numRows=0, author=grist 2024-08-19 10:53:56.249 - info: Sandbox row count access=owners, docId=fdjn8hxT6U2LvagFEu5wq2, rowCount=0 2024-08-19 10:53:56.251 - debug: ActiveDoc _applyUserActions returning {actionNum: 0, retValues: [null], isModification: false} access=owners, docId=fdjn8hxT6U2LvagFEu5wq2 2024-08-19 10:53:56.251 - debug: ActiveDoc load timing access=owners, userId=6, email=rhope@ej1899.com, age=3, org=ej1899, altSessionId=qreFNDG48jsEyiwwEEwRHu, clientId=ac611b44dc8dd7a0, counter=1, docId=fdjn8hxT6U2LvagFEu5wq2, loadMs=1181, closeTimeout=5905 2024-08-19 10:53:56.254 - info: snapshot status access=owners, userId=6, email=rhope@ej1899.com, age=3, org=ej1899, altSessionId=qreFNDG48jsEyiwwEEwRHu, clientId=ac611b44dc8dd7a0, counter=1, docId=fdjn8hxT6U2LvagFEu5wq2, pushes=0, skippedPushes=0, errors=0, changes=8, windowsStarted=1, windowsDone=0, lastChangeAt=2024-08-19T10:53:55.211Z, lastWindowStartedAt=2024-08-19T10:53:55.144Z, lastWindowDoneAt=undefined, delay=1110 2024-08-19 10:54:02.004 - info: Client onMessage '{"reqId":3,"method":"closeDoc","args":[0]}' email=rhope@ej1899.com, userId=6, age=3, org=ej1899, altSessionId=qreFNDG48jsEyiwwEEwRHu, clientId=ac611b44dc8dd7a0, counter=1 2024-08-19 10:54:02.004 - debug: activeDocMethod access=owners, userId=6, email=rhope@ej1899.com, age=3, org=ej1899, altSessionId=qreFNDG48jsEyiwwEEwRHu, clientId=ac611b44dc8dd7a0, counter=1, docId=fdjn8hxT6U2LvagFEu5wq2, docMethod=closeDoc 2024-08-19 10:54:02.005 - debug: DocClients removeClient ac611b44dc8dd7a0 access=owners, userId=6, email=rhope@ej1899.com, age=3, org=ej1899, altSessionId=qreFNDG48jsEyiwwEEwRHu, clientId=ac611b44dc8dd7a0, counter=1, docId=fdjn8hxT6U2LvagFEu5wq2 2024-08-19 10:54:02.005 - debug: DocClients now 0 clients access=owners, userId=6, email=rhope@ej1899.com, age=3, org=ej1899, altSessionId=qreFNDG48jsEyiwwEEwRHu, clientId=ac611b44dc8dd7a0, counter=1, docId=fdjn8hxT6U2LvagFEu5wq2 2024-08-19 10:54:02.005 - info: ActiveDoc will self-close in 5905 ms access=owners, userId=6, email=rhope@ej1899.com, age=3, org=ej1899, altSessionId=qreFNDG48jsEyiwwEEwRHu, clientId=ac611b44dc8dd7a0, counter=1, docId=fdjn8hxT6U2LvagFEu5wq2 2024-08-19 10:54:02.008 - info: Client websocket closed; will discard client in 300 sec email=rhope@ej1899.com, userId=6, age=3, org=ej1899, altSessionId=qreFNDG48jsEyiwwEEwRHu, clientId=ac611b44dc8dd7a0, counter=1 2024-08-19 10:54:02.019 - debug: Auth[GET]: grist.ej1899.com /ws/13/ customHostSession=, method=GET, host=grist.ej1899.com, path=/ws/13/, org=ej1899, email=rhope@ej1899.com, userId=6, altSessionId=qreFNDG48jsEyiwwEEwRHu 2024-08-19 10:54:02.129 - debug: Auth[GET]: grist.ej1899.com /session/access/active customHostSession=, method=GET, host=grist.ej1899.com, path=/session/access/active, org=ej1899, email=rhope@ej1899.com, userId=6, altSessionId=qreFNDG48jsEyiwwEEwRHu 2024-08-19 10:54:02.136 - debug: Auth[GET]: grist.ej1899.com /session/access/all customHostSession=, method=GET, host=grist.ej1899.com, path=/session/access/all, org=ej1899, email=rhope@ej1899.com, userId=6, altSessionId=qreFNDG48jsEyiwwEEwRHu 2024-08-19 10:54:02.176 - debug: Auth[GET]: grist.ej1899.com /orgs/5/workspaces customHostSession=, method=GET, host=grist.ej1899.com, path=/orgs/5/workspaces, org=ej1899, email=rhope@ej1899.com, userId=6, altSessionId=qreFNDG48jsEyiwwEEwRHu 2024-08-19 10:54:02.185 - debug: Auth[GET]: grist.ej1899.com /orgs/5/usage customHostSession=, method=GET, host=grist.ej1899.com, path=/orgs/5/usage, org=ej1899, email=rhope@ej1899.com, userId=6, altSessionId=qreFNDG48jsEyiwwEEwRHu 2024-08-19 10:54:07.912 - debug: ActiveDoc inactivity timeout docId=fdjn8hxT6U2LvagFEu5wq2 2024-08-19 10:54:07.913 - debug: ActiveDoc shutdown starting access=owners, docId=fdjn8hxT6U2LvagFEu5wq2 2024-08-19 10:54:07.916 - debug: ActiveDoc _applyUserActions(null, [['RemoveTransformColumns']]) access=owners, docId=fdjn8hxT6U2LvagFEu5wq2 2024-08-19 10:54:07.918 - debug: NSandbox pyCall sandboxPid=314, flavor=gvisor, command=undefined, entryPoint=(default), docId=fdjn8hxT6U2LvagFEu5wq2, funcName=apply_user_actions, loadMs=1 2024-08-19 10:54:07.918 - debug: Sharing _doApplyUserActions access=owners, docId=fdjn8hxT6U2LvagFEu5wq2, actionNum=0, linkId=0, otherId=0, numDocActions=0, numRows=0, author=grist 2024-08-19 10:54:07.919 - info: Sandbox row count access=owners, docId=fdjn8hxT6U2LvagFEu5wq2, rowCount=0 2024-08-19 10:54:07.919 - debug: ActiveDoc _applyUserActions returning {actionNum: 0, retValues: [null], isModification: false} access=owners, docId=fdjn8hxT6U2LvagFEu5wq2 2024-08-19 10:54:07.921 - info: snapshot status access=owners, docId=fdjn8hxT6U2LvagFEu5wq2, pushes=0, skippedPushes=0, errors=0, changes=8, windowsStarted=1, windowsDone=0, lastChangeAt=2024-08-19T10:53:55.211Z, lastWindowStartedAt=2024-08-19T10:53:55.144Z, lastWindowDoneAt=undefined, delay=12776 2024-08-19 10:54:07.921 - info: HostedStorageManager waiting for document to finish docId=fdjn8hxT6U2LvagFEu5wq2 2024-08-19 10:54:07.921 - debug: backupSqliteDatabase: starting copy of /persist/docs/fdjn8hxT6U2LvagFEu5wq2.grist (backup) docId=fdjn8hxT6U2LvagFEu5wq2 2024-08-19 10:54:07.924 - info: backupSqliteDatabase: copy of /persist/docs/fdjn8hxT6U2LvagFEu5wq2.grist (backup) completed successfully docId=fdjn8hxT6U2LvagFEu5wq2 2024-08-19 10:54:07.924 - debug: backupSqliteDatabase: stopped copy of /persist/docs/fdjn8hxT6U2LvagFEu5wq2.grist (backup) docId=fdjn8hxT6U2LvagFEu5wq2, maxStepTimeMs=1, numSteps=1 2024-08-19 10:54:08.225 - info: ext doc upload: minio://gristbucket01/docs/fdjn8hxT6U2LvagFEu5wq2.grist checksum 7d7908bce315780740d1491334501807 version rnNYFOawGHFPde8eR3MKQx2hBEukSJ0G 2024-08-19 10:54:08.497 - info: ext meta upload: minio://gristbucket01/docs/assets/unversioned/fdjn8hxT6U2LvagFEu5wq2/meta.json checksum bac189d046de79316259a18b10599ab6 version Mlg_wgk6oZaJJEXGR4aEH..XUeGPz8mH 2024-08-19 10:54:08.498 - debug: DocPluginManager.shutdown cleaning up 2 plugins 2024-08-19 10:54:08.499 - debug: Sandbox shutdown starting sandboxPid=314, flavor=gvisor, command=undefined, entryPoint=(default), docId=fdjn8hxT6U2LvagFEu5wq2 2024-08-19 10:54:08.499 - debug: DocStorage shutdown success 2024-08-19 10:54:08.499 - debug: DocPluginManager.shutdown removing tmpDir /tmp/grist-tmp-22cGdwEhUKPILD 2024-08-19 10:54:08.649 - debug: Sandbox exited with code 0 signal null sandboxPid=314, flavor=gvisor, command=undefined, entryPoint=(default), docId=fdjn8hxT6U2LvagFEu5wq2 2024-08-19 10:54:08.649 - debug: ActiveDoc shutdown complete access=owners, docId=fdjn8hxT6U2LvagFEu5wq2 2024-08-19 10:54:10.127 - debug: Auth[POST]: grist.ej1899.com /orgs/5/workspaces customHostSession=, method=POST, host=grist.ej1899.com, path=/orgs/5/workspaces, org=ej1899, email=rhope@ej1899.com, userId=6, altSessionId=qreFNDG48jsEyiwwEEwRHu 2024-08-19 10:54:10.128 - debug: allowHost: req=http://grist.ej1899.com/orgs/5/workspaces, origin=https://grist.ej1899.com, actualUrl=grist.ej1899.com, allowedUrl=grist.ej1899.com 2024-08-19 10:54:10.207 - debug: Auth[GET]: grist.ej1899.com /orgs/5/workspaces customHostSession=, method=GET, host=grist.ej1899.com, path=/orgs/5/workspaces, org=ej1899, email=rhope@ej1899.com, userId=6, altSessionId=qreFNDG48jsEyiwwEEwRHu 2024-08-19 10:54:11.014 - debug: Auth[GET]: grist.ej1899.com /orgs/5/workspaces customHostSession=, method=GET, host=grist.ej1899.com, path=/orgs/5/workspaces, org=ej1899, email=rhope@ej1899.com, userId=6, altSessionId=qreFNDG48jsEyiwwEEwRHu 2024-08-19 10:54:20.562 - debug: Auth[GET]: grist.ej1899.com /worker/import customHostSession=, method=GET, host=grist.ej1899.com, path=/worker/import, org=ej1899, email=rhope@ej1899.com, userId=6, altSessionId=qreFNDG48jsEyiwwEEwRHu 2024-08-19 10:54:20.588 - debug: allowHost: req=http://grist.ej1899.com/uploads, origin=https://grist.ej1899.com, actualUrl=grist.ej1899.com, allowedUrl=grist.ej1899.com 2024-08-19 10:54:20.590 - debug: Auth[POST]: grist.ej1899.com /uploads customHostSession=, method=POST, host=grist.ej1899.com, path=/uploads, org=ej1899, email=rhope@ej1899.com, userId=6, altSessionId=qreFNDG48jsEyiwwEEwRHu 2024-08-19 10:54:20.591 - debug: Prepared to receive upload into tmp dir /tmp/grist-upload-22qNaROM3GW0ap org=ej1899, email=rhope@ej1899.com, userId=6, altSessionId=qreFNDG48jsEyiwwEEwRHu 2024-08-19 10:54:31.175 - debug: Received file Master Database_20240725.grist (253657088 bytes) org=ej1899, email=rhope@ej1899.com, userId=6, altSessionId=qreFNDG48jsEyiwwEEwRHu 2024-08-19 10:54:31.178 - debug: Created uploadId 0 in tmp dir /tmp/grist-upload-22qNaROM3GW0ap org=ej1899, email=rhope@ej1899.com, userId=6, altSessionId=qreFNDG48jsEyiwwEEwRHu 2024-08-19 10:54:31.207 - debug: Auth[POST]: grist.ej1899.com /workspaces/16/import customHostSession=, method=POST, host=grist.ej1899.com, path=/workspaces/16/import, org=ej1899, email=rhope@ej1899.com, userId=6, altSessionId=qreFNDG48jsEyiwwEEwRHu 2024-08-19 10:54:31.207 - debug: allowHost: req=http://grist.ej1899.com/workspaces/16/import, origin=https://grist.ej1899.com, actualUrl=grist.ej1899.com, allowedUrl=grist.ej1899.com 2024-08-19 10:54:31.263 - debug: DocManager._createNewDoc picked name 6GqbC1ujv1DK2TCtx58b43 2024-08-19 10:54:32.322 - debug: backupSqliteDatabase: starting copy of /persist/docs/6GqbC1ujv1DK2TCtx58b43.grist (backup) docId=6GqbC1ujv1DK2TCtx58b43 2024-08-19 10:54:33.437 - info: backupSqliteDatabase: copy of /persist/docs/6GqbC1ujv1DK2TCtx58b43.grist (backup) completed successfully docId=6GqbC1ujv1DK2TCtx58b43 2024-08-19 10:54:33.438 - debug: backupSqliteDatabase: stopped copy of /persist/docs/6GqbC1ujv1DK2TCtx58b43.grist (backup) docId=6GqbC1ujv1DK2TCtx58b43, maxStepTimeMs=9, numSteps=61 2024-08-19 10:54:34.398 - info: HostedStorageManager Local hash does not match redis: 77e15245609257038f9444fcbd167467 vs unknown docId=6GqbC1ujv1DK2TCtx58b43 2024-08-19 10:54:34.477 - debug: UploadSet: cleaning up uploadId 0 2024-08-19 10:54:34.551 - debug: Auth[GET]: grist.ej1899.com /docs/6GqbC1ujv1DK2TCtx58b43 customHostSession=, method=GET, host=grist.ej1899.com, path=/docs/6GqbC1ujv1DK2TCtx58b43, org=ej1899, email=rhope@ej1899.com, userId=6, altSessionId=qreFNDG48jsEyiwwEEwRHu 2024-08-19 10:54:34.588 - debug: Auth[GET]: grist.ej1899.com /6GqbC1ujv1DK/Master-Database20240725 customHostSession=, method=GET, host=grist.ej1899.com, path=/6GqbC1ujv1DK/Master-Database20240725, org=ej1899, email=rhope@ej1899.com, userId=6, altSessionId=qreFNDG48jsEyiwwEEwRHu 2024-08-19 10:54:34.689 - debug: Auth[GET]: grist.ej1899.com /session/access/all customHostSession=, method=GET, host=grist.ej1899.com, path=/session/access/all, org=ej1899, email=rhope@ej1899.com, userId=6, altSessionId=qreFNDG48jsEyiwwEEwRHu 2024-08-19 10:54:34.696 - debug: Auth[GET]: grist.ej1899.com /session/access/active customHostSession=, method=GET, host=grist.ej1899.com, path=/session/access/active, org=ej1899, email=rhope@ej1899.com, userId=6, altSessionId=qreFNDG48jsEyiwwEEwRHu 2024-08-19 10:54:34.703 - debug: Auth[GET]: grist.ej1899.com /worker/6GqbC1ujv1DK2TCtx58b43 customHostSession=, method=GET, host=grist.ej1899.com, path=/worker/6GqbC1ujv1DK2TCtx58b43, org=ej1899, email=rhope@ej1899.com, userId=6, altSessionId=qreFNDG48jsEyiwwEEwRHu 2024-08-19 10:54:34.758 - debug: Auth[GET]: grist.ej1899.com /docs/6GqbC1ujv1DK customHostSession=, method=GET, host=grist.ej1899.com, path=/docs/6GqbC1ujv1DK, org=ej1899, email=rhope@ej1899.com, userId=6, altSessionId=qreFNDG48jsEyiwwEEwRHu 2024-08-19 10:54:34.780 - debug: allowHost: req=http://grist.ej1899.com/?clientId=0&counter=3&newClient=1&browserSettings=%7B%22timezone%22%3A%22America%2FNew_York%22%7D&user=rhope%40ej1899.com, origin=https://grist.ej1899.com, actualUrl=grist.ej1899.com, allowedUrl=grist.ej1899.com 2024-08-19 10:54:34.784 - info: Comm: Got Websocket connection clientId=1c4d6630992ca22a, counter=null, urlPath=/?clientId=0&counter=3&newClient=1&browserSettings=%7B%22timezone%22%3A%22America%2FNew_York%22%7D&user=rhope%40ej1899.com, reuseClient=false 2024-08-19 10:54:34.784 - debug: Client sending clientConnect newClient=true, needReload=false, docsClosed=0, missedMessages=undefined, email=rhope@ej1899.com, org=ej1899, altSessionId=qreFNDG48jsEyiwwEEwRHu, clientId=1c4d6630992ca22a, counter=3 2024-08-19 10:54:34.796 - info: Client onMessage '{"reqId":0,"method":"openDoc","args":["6GqbC1ujv1DK2TCtx58b43",{"openMode":"defa... (118 length)' email=rhope@ej1899.com, org=ej1899, altSessionId=qreFNDG48jsEyiwwEEwRHu, clientId=1c4d6630992ca22a, counter=3 2024-08-19 10:54:34.799 - debug: DocManager.openDoc Authorizer key { urlId: '6GqbC1ujv1DK2TCtx58b43', userId: 6, org: 'ej1899' } 2024-08-19 10:54:34.800 - debug: DocManager.fetchDoc 6GqbC1ujv1DK2TCtx58b43 2024-08-19 10:54:34.808 - debug: ActiveDoc loadDoc access=owners, userId=6, email=rhope@ej1899.com, age=3, org=ej1899, altSessionId=qreFNDG48jsEyiwwEEwRHu, clientId=1c4d6630992ca22a, counter=3, docId=6GqbC1ujv1DK2TCtx58b43 2024-08-19 10:54:34.808 - info: HostedStorageManager waiting for document to finish docId=6GqbC1ujv1DK2TCtx58b43 2024-08-19 10:54:34.810 - debug: backupSqliteDatabase: starting copy of /persist/docs/6GqbC1ujv1DK2TCtx58b43.grist (backup) docId=6GqbC1ujv1DK2TCtx58b43 2024-08-19 10:54:34.851 - info: backupSqliteDatabase: copy of /persist/docs/6GqbC1ujv1DK2TCtx58b43.grist (backup) completed successfully docId=6GqbC1ujv1DK2TCtx58b43 2024-08-19 10:54:34.852 - debug: backupSqliteDatabase: stopped copy of /persist/docs/6GqbC1ujv1DK2TCtx58b43.grist (backup) docId=6GqbC1ujv1DK2TCtx58b43, maxStepTimeMs=0, numSteps=1 2024-08-19 10:54:35.122 - info: ext doc upload: minio://gristbucket01/docs/6GqbC1ujv1DK2TCtx58b43.grist checksum 2fd4d684b99f2c687c9fc524f6c5434e version hrY_aRRkZidyXq6iJ0hr8qSJpZOjfR9v 2024-08-19 10:54:35.511 - info: ext meta upload: minio://gristbucket01/docs/assets/unversioned/6GqbC1ujv1DK2TCtx58b43/meta.json checksum 62631151f3dbc2eba5ad8bed597b2b81 version wb0S1lyrnMp0ToK5TsTzSB2zBjKp62Q8 2024-08-19 10:54:35.517 - info: Pruned 0 versions of 1 for document 6GqbC1ujv1DK2TCtx58b43 2024-08-19 10:54:36.513 - debug: backupSqliteDatabase: starting copy of /persist/docs/6GqbC1ujv1DK2TCtx58b43.grist (backup) docId=6GqbC1ujv1DK2TCtx58b43 2024-08-19 10:54:36.514 - info: backupSqliteDatabase: copy of /persist/docs/6GqbC1ujv1DK2TCtx58b43.grist (backup) completed successfully docId=6GqbC1ujv1DK2TCtx58b43 2024-08-19 10:54:36.515 - debug: backupSqliteDatabase: stopped copy of /persist/docs/6GqbC1ujv1DK2TCtx58b43.grist (backup) docId=6GqbC1ujv1DK2TCtx58b43, maxStepTimeMs=0, numSteps=1 2024-08-19 10:54:36.515 - info: HostedStorageManager Local hash does not match redis: 2fd4d684b99f2c687c9fc524f6c5434e vs unknown docId=6GqbC1ujv1DK2TCtx58b43 2024-08-19 10:54:36.600 - info: ext doc download: 6GqbC1ujv1DK2TCtx58b43 with checksum 2fd4d684b99f2c687c9fc524f6c5434e and version hrY_aRRkZidyXq6iJ0hr8qSJpZOjfR9v 2024-08-19 10:54:36.614 - debug: DB 6GqbC1ujv1DK2TCtx58b43 open successfully 2024-08-19 10:54:36.616 - error: ActiveDoc Failed to load document [OperationalError: SQLITE_ERROR: no such table: _grist_Tables_column] { cause: [Error: SQLITE_ERROR: no such table: _grist_Tables_column] { errno: 1, code: 'NO_METADATA_ERROR' }, isOperational: true, errno: 1, code: 'SQLITE_ERROR' } access=owners, userId=6, email=rhope@ej1899.com, age=3, org=ej1899, altSessionId=qreFNDG48jsEyiwwEEwRHu, clientId=1c4d6630992ca22a, counter=3, docId=6GqbC1ujv1DK2TCtx58b43 2024-08-19 10:54:36.617 - debug: ActiveDoc shutdown starting access=owners, docId=6GqbC1ujv1DK2TCtx58b43 2024-08-19 10:54:36.620 - info: snapshot status access=owners, docId=6GqbC1ujv1DK2TCtx58b43, pushes=1, skippedPushes=0, errors=0, changes=1, windowsStarted=1, windowsDone=1, lastChangeAt=2024-08-19T10:54:34.477Z, lastWindowStartedAt=2024-08-19T10:54:34.477Z, lastWindowDoneAt=2024-08-19T10:54:35.123Z, delay=646 2024-08-19 10:54:36.620 - debug: DocPluginManager.shutdown cleaning up 2 plugins 2024-08-19 10:54:36.621 - debug: DocStorage shutdown success 2024-08-19 10:54:36.621 - debug: DocPluginManager.shutdown removing tmpDir /tmp/grist-tmp-22GAA7JCKe0OD9 2024-08-19 10:54:36.624 - error: ActiveDoc _granularAccess.close failed TypeError: Cannot read properties of undefined (reading 'close') at /grist/_build/app/server/lib/ActiveDoc.js:1827:83 at safeCallAndWait (/grist/_build/app/server/lib/ActiveDoc.js:1757:94) at ActiveDoc._doShutdownImpl (/grist/_build/app/server/lib/ActiveDoc.js:1827:15) at async ActiveDoc.shutdown (/grist/_build/app/server/lib/ActiveDoc.js:412:9) at async ActiveDoc.loadDoc (/grist/_build/app/server/lib/ActiveDoc.js:496:13) access=owners, docId=6GqbC1ujv1DK2TCtx58b43 2024-08-19 10:54:36.624 - debug: ActiveDoc shutdown complete access=owners, docId=6GqbC1ujv1DK2TCtx58b43 2024-08-19 10:54:36.624 - warn: Client Responding to method openDoc with error: Error: SQLITE_ERROR: no such table: _grist_Tables_column SQLITE_ERROR email=rhope@ej1899.com, userId=6, age=3, org=ej1899, altSessionId=qreFNDG48jsEyiwwEEwRHu, clientId=1c4d6630992ca22a, counter=3 2024-08-19 10:54:36.625 - warn: Client responding to #0 ERROR NO_METADATA_ERROR: 6GqbC1ujv1DK2TCtx58b43 has no metadata email=rhope@ej1899.com, userId=6, age=3, org=ej1899, altSessionId=qreFNDG48jsEyiwwEEwRHu, clientId=1c4d6630992ca22a, counter=3 2024-08-19 10:54:36.640 - info: Client websocket closed; will discard client in 300 sec email=rhope@ej1899.com, userId=6, age=3, org=ej1899, altSessionId=qreFNDG48jsEyiwwEEwRHu, clientId=1c4d6630992ca22a, counter=3 2024-08-19 10:54:36.642 - debug: Auth[POST]: grist.ej1899.com /log customHostSession=, method=POST, host=grist.ej1899.com, path=/log, org=ej1899, email=rhope@ej1899.com, userId=6, altSessionId=qreFNDG48jsEyiwwEEwRHu 2024-08-19 10:54:36.643 - debug: allowHost: req=http://grist.ej1899.com/log, origin=https://grist.ej1899.com, actualUrl=grist.ej1899.com, allowedUrl=grist.ej1899.com 2024-08-19 10:54:36.646 - warn: client error stack=Error: NO_METADATA_ERROR: 6GqbC1ujv1DK2TCtx58b43 has no metadata at ye._onServerMessage (https://grist.ej1899.com/v/unknown/main.bundle.js:2:41888) at b (https://grist.ej1899.com/v/unknown/main.bundle.js:2:885527) at g (https://grist.ej1899.com/v/unknown/main.bundle.js:2:885319) at d (https://grist.ej1899.com/v/unknown/main.bundle.js:2:883272) at c.trigger (https://grist.ej1899.com/v/unknown/main.bundle.js:2:885212) at fe._processReceivedMessage (https://grist.ej1899.com/v/unknown/main.bundle.js:2:35362) at fe.onmessage (https://grist.ej1899.com/v/unknown/main.bundle.js:2:33984) at ue._onWSMessage (https://grist.ej1899.com/v/unknown/main.bundle.js:2:30606), message=NO_METADATA_ERROR: 6GqbC1ujv1DK2TCtx58b43 has no metadata, code=SQLITE_ERROR, docId=6GqbC1ujv1DK2TCtx58b43, page=https://grist.ej1899.com/6GqbC1ujv1DK/Master-Database20240725, language=en-US, platform=Win32, userAgent=Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/127.0.0.0 Safari/537.36, org=ej1899, email=rhope@ej1899.com, userId=6, altSessionId=qreFNDG48jsEyiwwEEwRHu 2024-08-19 10:54:48.727 - debug: Auth[GET]: grist.ej1899.com /6GqbC1ujv1DK/Master-Database20240725 customHostSession=, method=GET, host=grist.ej1899.com, path=/6GqbC1ujv1DK/Master-Database20240725, org=ej1899, email=rhope@ej1899.com, userId=6, altSessionId=qreFNDG48jsEyiwwEEwRHu 2024-08-19 10:54:48.819 - debug: Auth[GET]: grist.ej1899.com /session/access/active customHostSession=, method=GET, host=grist.ej1899.com, path=/session/access/active, org=ej1899, email=rhope@ej1899.com, userId=6, altSessionId=qreFNDG48jsEyiwwEEwRHu 2024-08-19 10:54:48.825 - debug: Auth[GET]: grist.ej1899.com /session/access/all customHostSession=, method=GET, host=grist.ej1899.com, path=/session/access/all, org=ej1899, email=rhope@ej1899.com, userId=6, altSessionId=qreFNDG48jsEyiwwEEwRHu 2024-08-19 10:54:48.831 - debug: Auth[GET]: grist.ej1899.com /worker/6GqbC1ujv1DK2TCtx58b43 customHostSession=, method=GET, host=grist.ej1899.com, path=/worker/6GqbC1ujv1DK2TCtx58b43, org=ej1899, email=rhope@ej1899.com, userId=6, altSessionId=qreFNDG48jsEyiwwEEwRHu 2024-08-19 10:54:48.874 - debug: Auth[GET]: grist.ej1899.com /docs/6GqbC1ujv1DK customHostSession=, method=GET, host=grist.ej1899.com, path=/docs/6GqbC1ujv1DK, org=ej1899, email=rhope@ej1899.com, userId=6, altSessionId=qreFNDG48jsEyiwwEEwRHu 2024-08-19 10:54:48.909 - debug: allowHost: req=http://grist.ej1899.com/?clientId=1c4d6630992ca22a&counter=4&newClient=1&browserSettings=%7B%22timezone%22%3A%22America%2FNew_York%22%7D&user=rhope%40ej1899.com, origin=https://grist.ej1899.com, actualUrl=grist.ej1899.com, allowedUrl=grist.ej1899.com 2024-08-19 10:54:48.910 - info: Comm: Got Websocket connection email=rhope@ej1899.com, userId=6, age=3, org=ej1899, altSessionId=qreFNDG48jsEyiwwEEwRHu, clientId=1c4d6630992ca22a, counter=3, urlPath=/?clientId=1c4d6630992ca22a&counter=4&newClient=1&browserSettings=%7B%22timezone%22%3A%22America%2FNew_York%22%7D&user=rhope%40ej1899.com, reuseClient=true 2024-08-19 10:54:48.911 - debug: Client sending clientConnect newClient=true, needReload=false, docsClosed=0, missedMessages=undefined, email=rhope@ej1899.com, org=ej1899, altSessionId=qreFNDG48jsEyiwwEEwRHu, clientId=1c4d6630992ca22a, counter=4 2024-08-19 10:54:48.922 - info: Client onMessage '{"reqId":0,"method":"openDoc","args":["6GqbC1ujv1DK2TCtx58b43",{"openMode":"defa... (118 length)' email=rhope@ej1899.com, org=ej1899, altSessionId=qreFNDG48jsEyiwwEEwRHu, clientId=1c4d6630992ca22a, counter=4 2024-08-19 10:54:48.923 - debug: DocManager.openDoc Authorizer key { urlId: '6GqbC1ujv1DK2TCtx58b43', userId: 6, org: 'ej1899' } 2024-08-19 10:54:48.928 - debug: DocManager.fetchDoc 6GqbC1ujv1DK2TCtx58b43 2024-08-19 10:54:48.934 - debug: ActiveDoc loadDoc access=owners, userId=6, email=rhope@ej1899.com, age=3, org=ej1899, altSessionId=qreFNDG48jsEyiwwEEwRHu, clientId=1c4d6630992ca22a, counter=4, docId=6GqbC1ujv1DK2TCtx58b43 2024-08-19 10:54:48.934 - debug: backupSqliteDatabase: starting copy of /persist/docs/6GqbC1ujv1DK2TCtx58b43.grist (backup) docId=6GqbC1ujv1DK2TCtx58b43 2024-08-19 10:54:48.936 - info: backupSqliteDatabase: copy of /persist/docs/6GqbC1ujv1DK2TCtx58b43.grist (backup) completed successfully docId=6GqbC1ujv1DK2TCtx58b43 2024-08-19 10:54:48.936 - debug: backupSqliteDatabase: stopped copy of /persist/docs/6GqbC1ujv1DK2TCtx58b43.grist (backup) docId=6GqbC1ujv1DK2TCtx58b43, maxStepTimeMs=0, numSteps=1 2024-08-19 10:54:48.937 - info: HostedStorageManager Local hash does not match redis: 857e6403c8a55dc67a2cad02777c8856 vs unknown docId=6GqbC1ujv1DK2TCtx58b43 2024-08-19 10:54:49.027 - info: ext doc download: 6GqbC1ujv1DK2TCtx58b43 with checksum 2fd4d684b99f2c687c9fc524f6c5434e and version hrY_aRRkZidyXq6iJ0hr8qSJpZOjfR9v 2024-08-19 10:54:49.040 - debug: DB 6GqbC1ujv1DK2TCtx58b43 open successfully 2024-08-19 10:54:49.041 - error: ActiveDoc Failed to load document [OperationalError: SQLITE_ERROR: no such table: _grist_Tables_column] { cause: [Error: SQLITE_ERROR: no such table: _grist_Tables_column] { errno: 1, code: 'NO_METADATA_ERROR' }, isOperational: true, errno: 1, code: 'SQLITE_ERROR' } access=owners, userId=6, email=rhope@ej1899.com, age=3, org=ej1899, altSessionId=qreFNDG48jsEyiwwEEwRHu, clientId=1c4d6630992ca22a, counter=4, docId=6GqbC1ujv1DK2TCtx58b43 2024-08-19 10:54:49.041 - debug: ActiveDoc shutdown starting access=owners, docId=6GqbC1ujv1DK2TCtx58b43 2024-08-19 10:54:49.043 - info: snapshot status access=owners, docId=6GqbC1ujv1DK2TCtx58b43, pushes=1, skippedPushes=0, errors=0, changes=1, windowsStarted=1, windowsDone=1, lastChangeAt=2024-08-19T10:54:34.477Z, lastWindowStartedAt=2024-08-19T10:54:34.477Z, lastWindowDoneAt=2024-08-19T10:54:35.123Z, delay=646 2024-08-19 10:54:49.043 - debug: DocPluginManager.shutdown cleaning up 2 plugins 2024-08-19 10:54:49.043 - debug: DocStorage shutdown success 2024-08-19 10:54:49.043 - debug: DocPluginManager.shutdown removing tmpDir /tmp/grist-tmp-22QnfP767G40tX 2024-08-19 10:54:49.043 - error: ActiveDoc _granularAccess.close failed TypeError: Cannot read properties of undefined (reading 'close') at /grist/_build/app/server/lib/ActiveDoc.js:1827:83 at safeCallAndWait (/grist/_build/app/server/lib/ActiveDoc.js:1757:94) at ActiveDoc._doShutdownImpl (/grist/_build/app/server/lib/ActiveDoc.js:1827:15) at async ActiveDoc.shutdown (/grist/_build/app/server/lib/ActiveDoc.js:412:9) at async ActiveDoc.loadDoc (/grist/_build/app/server/lib/ActiveDoc.js:496:13) access=owners, docId=6GqbC1ujv1DK2TCtx58b43 2024-08-19 10:54:49.044 - debug: ActiveDoc shutdown complete access=owners, docId=6GqbC1ujv1DK2TCtx58b43 2024-08-19 10:54:49.044 - warn: Client Responding to method openDoc with error: Error: SQLITE_ERROR: no such table: _grist_Tables_column SQLITE_ERROR email=rhope@ej1899.com, userId=6, age=3, org=ej1899, altSessionId=qreFNDG48jsEyiwwEEwRHu, clientId=1c4d6630992ca22a, counter=4 2024-08-19 10:54:49.044 - warn: Client responding to #0 ERROR NO_METADATA_ERROR: 6GqbC1ujv1DK2TCtx58b43 has no metadata email=rhope@ej1899.com, userId=6, age=3, org=ej1899, altSessionId=qreFNDG48jsEyiwwEEwRHu, clientId=1c4d6630992ca22a, counter=4 2024-08-19 10:54:49.054 - info: Client websocket closed; will discard client in 300 sec email=rhope@ej1899.com, userId=6, age=3, org=ej1899, altSessionId=qreFNDG48jsEyiwwEEwRHu, clientId=1c4d6630992ca22a, counter=4 2024-08-19 10:54:49.057 - debug: Auth[POST]: grist.ej1899.com /log customHostSession=, method=POST, host=grist.ej1899.com, path=/log, org=ej1899, email=rhope@ej1899.com, userId=6, altSessionId=qreFNDG48jsEyiwwEEwRHu 2024-08-19 10:54:49.057 - debug: allowHost: req=http://grist.ej1899.com/log, origin=https://grist.ej1899.com, actualUrl=grist.ej1899.com, allowedUrl=grist.ej1899.com 2024-08-19 10:54:49.058 - warn: client error stack=Error: NO_METADATA_ERROR: 6GqbC1ujv1DK2TCtx58b43 has no metadata at ye._onServerMessage (https://grist.ej1899.com/v/unknown/main.bundle.js:2:41888) at b (https://grist.ej1899.com/v/unknown/main.bundle.js:2:885527) at g (https://grist.ej1899.com/v/unknown/main.bundle.js:2:885319) at d (https://grist.ej1899.com/v/unknown/main.bundle.js:2:883272) at c.trigger (https://grist.ej1899.com/v/unknown/main.bundle.js:2:885212) at fe._processReceivedMessage (https://grist.ej1899.com/v/unknown/main.bundle.js:2:35362) at fe.onmessage (https://grist.ej1899.com/v/unknown/main.bundle.js:2:33984) at ue._onWSMessage (https://grist.ej1899.com/v/unknown/main.bundle.js:2:30606), message=NO_METADATA_ERROR: 6GqbC1ujv1DK2TCtx58b43 has no metadata, code=SQLITE_ERROR, docId=6GqbC1ujv1DK2TCtx58b43, page=https://grist.ej1899.com/6GqbC1ujv1DK/Master-Database20240725, language=en-US, platform=Win32, userAgent=Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/127.0.0.0 Safari/537.36, org=ej1899, email=rhope@ej1899.com, userId=6, altSessionId=qreFNDG48jsEyiwwEEwRHu 2024-08-19 10:54:55.152 - info: Pruned 0 versions of 1 for document fdjn8hxT6U2LvagFEu5wq2 ubuntu@ip-172-31-25-82:~$