jsreport forum

JannoSaks

Yes, it probably has to do with the postgres slowness.
I downgraded jsreport 3.2 back to jsreport 2.11 on the same kubernetes pod (same machine, same resources, same postgres server) to compare.

Below are the results.
But even if the postgres is slow to respond, I wonder why does the asset replacing take 3 times longer now in jsreport 3.2 compared to jsreport 2.11 with the same setup.

For now, I have to keep using jsreport 2.11.

+0      Starting rendering request 15 (user: root)
+71     Rendering template { name: tickets-default, recipe: chrome-pdf, engine: handlebars, preview: true }
+210    Adding sample data BMnrDZR
+211    Resources not defined for this template.
+246    Base url not specified, skipping its injection.
+592    Replaced assets ["../../watermark.css","./../images/train_icon.svg","test-styles.css","./../images/class_icon.svg","./../images/coach_icon.svg","./../images/seat_icon.svg","./../images/wheelchair_icon.svg","./../images/blank_logo.svg","./../images/route_icon.svg","./../images/od_icon.svg","./../images/arrow_icon.svg","./../images/test_link_logo.svg","./../images/date_icon.svg","./../images/person_icon.svg","./../images/time_icon.svg"]
+1006   Replaced assets ["/test/fonts/regular.ttf","/test/fonts/semibold.ttf"]
+1146   Replaced assets ["test-helper-functions.js"]
+1147   Rendering engine handlebars using http-server strategy
+1175   Taking compiled template from engine cache
+1226   Executing recipe chrome-pdf
+1241   Converting with chrome HeadlessChrome/79.0.3945.130 using chrome-pool strategy
+1291   Page request: GET (document) file:///tmp/jsreport/autocleanup/18dce46d-5d68-47ca-97af-a4259c7d64fd-chrome-pdf.html
+1319   Page request finished: GET (document) file:///tmp/jsreport/autocleanup/18dce46d-5d68-47ca-97af-a4259c7d64fd-chrome-pdf.html
+1331   Page request: GET (image) data:image/svg+xml;base64,PHN2ZyBpZD0iTGF5ZXJfMSIgZGF0YS1uYW1lPSJMYXllciAxIiB4bWxucz0iaHR0cDovL3d3dy...
+1333   Page request finished: GET (image) 200 data:image/svg+xml;base64,PHN2ZyBpZD0iTGF5ZXJfMSIgZGF0YS1uYW1lPSJMYXllciAxIiB4bWxucz0iaHR0cDovL3d3dy...
+1333   Page request: GET (image) data:image/svg+xml;base64,PHN2ZyB3aWR0aD0iNTM5IiBoZWlnaHQ9IjM1IiB4bWxucz0iaHR0cDovL3d3dy53My5vcmcvMj...
+1333   Page request finished: GET (image) 200 data:image/svg+xml;base64,PHN2ZyB3aWR0aD0iNTM5IiBoZWlnaHQ9IjM1IiB4bWxucz0iaHR0cDovL3d3dy53My5vcmcvMj...
+1334   Page request: GET (image) data:image/svg+xml;base64,PHN2ZyB3aWR0aD0iMTIzIiBoZWlnaHQ9IjE3MCIgeG1sbnM9Imh0dHA6Ly93d3cudzMub3JnLz...
+1334   Page request finished: GET (image) 200 data:image/svg+xml;base64,PHN2ZyB3aWR0aD0iMTIzIiBoZWlnaHQ9IjE3MCIgeG1sbnM9Imh0dHA6Ly93d3cudzMub3JnLz...
+1334   Page request: GET (image) data:image/svg+xml;base64,PHN2ZyB3aWR0aD0iMjkiIGhlaWdodD0iMTAiIHhtbG5zPSJodHRwOi8vd3d3LnczLm9yZy8yMD...
+1335   Page request finished: GET (image) 200 data:image/svg+xml;base64,PHN2ZyB3aWR0aD0iMjkiIGhlaWdodD0iMTAiIHhtbG5zPSJodHRwOi8vd3d3LnczLm9yZy8yMD...
+1335   Page request: GET (image) data:image/svg+xml;base64,PHN2ZyB3aWR0aD0iNzUiIGhlaWdodD0iNzguNzMiIHhtbG5zPSJodHRwOi8vd3d3LnczLm9yZy...
+1335   Page request finished: GET (image) 200 data:image/svg+xml;base64,PHN2ZyB3aWR0aD0iNzUiIGhlaWdodD0iNzguNzMiIHhtbG5zPSJodHRwOi8vd3d3LnczLm9yZy...
+1375   Page request: GET (font) data:font/ttf;base64,AAEAAAAPAIAAAwBwRkZUTYSLY84AAiesAAAAHEdERUYJMQupAAEbCAAAADZHUE9TukgglQABMfAAAPW6R1NVQjF/R20AARtAAAAWrk9TLzJr0XaZAAABeAAAAGBjbWFwgtKRBgAADOQAAAR2Z2FzcP//AAMAARsAAAAACGdseWYsBK6xAAAW5AAA5VxoZWFkEfGAogAAAPwAAAA2aGhlYQfTBbwAAAE0AAAAJGhtdHjOWDcbAAAB2AAACwxsb2NhDjFOIAAAEVwAAAWIbWF4cAPIChYAAAFYAAAAIG5hbWWca0aZAAD8QAAACLVwb3N08mvPcwABBPgAABYHAAEAAAADAELnx3lfXw889QALA+gAAAAA1z2Z4QAAAADXqaLk/o3+zgVbA+gAAQAIAAIAAAAAAAAAAQAAA+j+9AAABXf+jf6NBVsAAQAAAAAAAAAAAAAAAAAAAsMAAQAAAsMKEwDDAAAAAAACAAAAAQABAAAAQAAAAAAAAAADAl0CWAAFAAACvAKKAAAAjAK8AooAAAHdAEkBEwAAAgsHBAAAAAAAAKAAAn9QAAA7AAAAIAAAAABTd1R5ACAAIP7/Atz+9AAAA+gBDCAAAJcAAAAAAfQCxgAAACAADAKEAEgAAAAAAU0AAADkAAABIAArAbIAOgLWACACGAAoA9QAHAMCAD8A6AA6ASsAJwEqABYB7AAfAewAJAEaABsBkAA5ARcAJwIiABICdwAzAXAAAgI9ACkCTAAjAn0AEgI8AB8COQAjAh8AIgJMACoCOQAnASsAMQEuACYB3QAaAh0APAHdABsCBwAcAyMAKALnAAECegBPAwwAJgLMAE8COABPAh4ATwMlACYC9ABPAS8ATwIjABQCtgBPAicATwN0AE8DGABPAygAJQJPAE8DSAAlApAATwJRACICOAAVAtAARwLRAAMDwQASArn/+gKyAA...
+1387   Page request: GET (image) data:image/svg+xml;base64,PHN2ZyB3aWR0aD0iNzUiIGhlaWdodD0iNzIuOTk5OTk5OTk5OTk5OTkiIHhtbG5zPSJodHRwOi...
+1388   Page request finished: GET (image) 200 data:image/svg+xml;base64,PHN2ZyB3aWR0aD0iNzUiIGhlaWdodD0iNzIuOTk5OTk5OTk5OTk5OTkiIHhtbG5zPSJodHRwOi...
+1388   Page request: GET (image) data:image/svg+xml;base64,PHN2ZyB3aWR0aD0iNzUiIGhlaWdodD0iODAuNSIgeG1sbnM9Imh0dHA6Ly93d3cudzMub3JnLz...
+1388   Page request finished: GET (image) 200 data:image/svg+xml;base64,PHN2ZyB3aWR0aD0iNzUiIGhlaWdodD0iODAuNSIgeG1sbnM9Imh0dHA6Ly93d3cudzMub3JnLz...
+1389   Page request: GET (image) data:image/svg+xml;base64,PHN2ZyB3aWR0aD0iNzUiIGhlaWdodD0iODYiIHhtbG5zPSJodHRwOi8vd3d3LnczLm9yZy8yMD...
+1390   Page request finished: GET (image) 200 data:image/svg+xml;base64,PHN2ZyB3aWR0aD0iNzUiIGhlaWdodD0iODYiIHhtbG5zPSJodHRwOi8vd3d3LnczLm9yZy8yMD...
+1390   Page request: GET (image) data:image/svg+xml;base64,PHN2ZyB3aWR0aD0iNjgiIGhlaWdodD0iNzUiIHhtbG5zPSJodHRwOi8vd3d3LnczLm9yZy8yMD...
+1390   Page request finished: GET (image) 200 data:image/svg+xml;base64,PHN2ZyB3aWR0aD0iNjgiIGhlaWdodD0iNzUiIHhtbG5zPSJodHRwOi8vd3d3LnczLm9yZy8yMD...
+1391   Page request: GET (image) data:image/svg+xml;base64,PHN2ZyB3aWR0aD0iNjgiIGhlaWdodD0iNzkiIHhtbG5zPSJodHRwOi8vd3d3LnczLm9yZy8yMD...
+1391   Page request finished: GET (image) 200 data:image/svg+xml;base64,PHN2ZyB3aWR0aD0iNjgiIGhlaWdodD0iNzkiIHhtbG5zPSJodHRwOi8vd3d3LnczLm9yZy8yMD...
+1392   Page request: GET (image) data:image/svg+xml;base64,PHN2ZyB3aWR0aD0iOTkiIGhlaWdodD0iNjMiIHhtbG5zPSJodHRwOi8vd3d3LnczLm9yZy8yMD...
+1392   Page request finished: GET (image) 200 data:image/svg+xml;base64,PHN2ZyB3aWR0aD0iOTkiIGhlaWdodD0iNjMiIHhtbG5zPSJodHRwOi8vd3d3LnczLm9yZy8yMD...
+1392   Page request: GET (image) data:image/svg+xml;base64,PHN2ZyB3aWR0aD0iNzAiIGhlaWdodD0iODciIHhtbG5zPSJodHRwOi8vd3d3LnczLm9yZy8yMD...
+1392   Page request finished: GET (image) 200 data:image/svg+xml;base64,PHN2ZyB3aWR0aD0iNzAiIGhlaWdodD0iODciIHhtbG5zPSJodHRwOi8vd3d3LnczLm9yZy8yMD...
+1393   Page request: GET (image) data:image/png;base64,iVBORw0KGgoAAAANSUhEUgAAAGkAAABpCAYAAAA5gg06AAAAAXNSR0IArs4c6QAAAARnQU1BAACxjw...
+1393   Page request finished: GET (image) 200 data:image/png;base64,iVBORw0KGgoAAAANSUhEUgAAAGkAAABpCAYAAAA5gg06AAAAAXNSR0IArs4c6QAAAARnQU1BAACxjw...
+1393   Page request: GET (image) data:image/png;base64,iVBORw0KGgoAAAANSUhEUgAAAtAAAABkCAIAAAAg8ZCBAAAAAXNSR0IArs4c6QAAAARnQU1BAACxjw...
+1393   Page request finished: GET (image) 200 data:image/png;base64,iVBORw0KGgoAAAANSUhEUgAAAtAAAABkCAIAAAAg8ZCBAAAAAXNSR0IArs4c6QAAAARnQU1BAACxjw...
+1442   Page request finished: GET (font) 200 data:font/ttf;base64,AAEAAAAPAIAAAwBwRkZUTYSLY84AAiesAAAAHEdERUYJMQupAAEbCAAAADZHUE9TukgglQABMfAAAPW6R1NVQjF/R20AARtAAAAWrk9TLzJr0XaZAAABeAAAAGBjbWFwgtKRBgAADOQAAAR2Z2FzcP//AAMAARsAAAAACGdseWYsBK6xAAAW5AAA5VxoZWFkEfGAogAAAPwAAAA2aGhlYQfTBbwAAAE0AAAAJGhtdHjOWDcbAAAB2AAACwxsb2NhDjFOIAAAEVwAAAWIbWF4cAPIChYAAAFYAAAAIG5hbWWca0aZAAD8QAAACLVwb3N08mvPcwABBPgAABYHAAEAAAADAELnx3lfXw889QALA+gAAAAA1z2Z4QAAAADXqaLk/o3+zgVbA+gAAQAIAAIAAAAAAAAAAQAAA+j+9AAABXf+jf6NBVsAAQAAAAAAAAAAAAAAAAAAAsMAAQAAAsMKEwDDAAAAAAACAAAAAQABAAAAQAAAAAAAAAADAl0CWAAFAAACvAKKAAAAjAK8AooAAAHdAEkBEwAAAgsHBAAAAAAAAKAAAn9QAAA7AAAAIAAAAABTd1R5ACAAIP7/Atz+9AAAA+gBDCAAAJcAAAAAAfQCxgAAACAADAKEAEgAAAAAAU0AAADkAAABIAArAbIAOgLWACACGAAoA9QAHAMCAD8A6AA6ASsAJwEqABYB7AAfAewAJAEaABsBkAA5ARcAJwIiABICdwAzAXAAAgI9ACkCTAAjAn0AEgI8AB8COQAjAh8AIgJMACoCOQAnASsAMQEuACYB3QAaAh0APAHdABsCBwAcAyMAKALnAAECegBPAwwAJgLMAE8COABPAh4ATwMlACYC9ABPAS8ATwIjABQCtgBPAicATwN0AE8DGABPAygAJQJPAE8DSAAlApAATwJRACICOAAVAtAARwLRAAMDw...
+1447   Running chrome with params {"printBackground":true,"format":"A4","marginTop":"30px","marginBottom":"30px","mediaType":"print","margin":{"top":"30px","bottom":"30px"}}
+1628   Rendering request 15 finished in 1628 ms

JannoSaks

Thank you.

JannoSaks

Of couse.
I sent you the email.

JannoSaks

Thanks for pointing that out... It seems I had actually used that same config typo in jsreport 2.11 as well.
Yes, I rendered the template over 10 times with the studio UI.
And everytime the "Replaced assets" debug lines had almost the same constant time +1500 to +1600 ms.

JannoSaks

The second issue I am having is about the rendering speed
I have a template that was rendered in jsreport 2.11 in about 0.5 - 1.5 seconds.
The same template in jsreport 3.2 takes arount 3-4 seconds.
For some reason the asset replacing is super slow.
Is it not caching the assets and asking the assets from DB every time I render?

One thing to also note here is that this is only slow when deployed to Kubernetes.
Both examples were using the same template and the same Kubernetes node/pod.

Debug profiler info in jsreport 3.2:
0_1642538407423_upload-5900a407-bc84-4da1-a451-f50b427bd42d

Debug profiler info in jsreport 2.11:
0_1642538603544_upload-cbefad50-49a6-40c5-9468-608a937b178e

Here is my jsreport.config.json for jsreport 3.2

{
    "httpPort": 5588,
    "store": {
      "provider": "postgres"
    },
    "blobStorage": {
      "provider": "fs"
    },
    "logger": {
      "console": {
        "transport": "console",
        "level": "debug"
      },
      "file": {
        "transport": "console",
        "level": "info"
      },
      "error": {
        "transport": "console",
        "level": "error"
      }
    },
    "allowLocalFilesAccess": true,
    "reportTimeout": 60000,
    "templatingEngines": {
      "strategy": "http-server"
    },
    "sandbox": {
      "allowedModules": "*"
    },
    "workers": {
      "numberOfWorkers": 5
    },
    "extensions": {
      "authentication": {
        "cookieSession": {
          "secret": "...",
          "cookie": { "secure": true }
        },
        "admin": {
          "username": "admin",
          "password": "admin"
        },
        "enabled": true
      },
      "sample-template": {
        "createSamples": true
      },
      "scripts": {
        "strategy": "http-server",
        "allowedModules": "*"
      },
      "chrome": {
        "strategy": "chrome-pool",
        "numberOfWorkers": 5 
      },
      "chrome-pdf": {
        "strategy": "chrome-pool",
        "numberOfWorkers": 5 
      },
      "postgres-store": {
        "host": "",
        "port": 5432,
        "database": "",
        "user": "",
        "password": ""
      }
    }
  }

JannoSaks

Hey, I'm having a few strange problems with jsreport 3.2 and Postgres store.
I can't use jsreport 3.3 right now because of another issue that I posted here: https://forum.jsreport.net/topic/2272/jsreport-3-3-error-with-postgres-store

I had a jsreport 2.11 instance deployed to kubernetes and it was working great.
I then upgraded to jsreport 3.2 (with a new/empty) postgres DB but for some odd reason almost all the logs are doubled.
It doesn't happen when I locally run the same jsreport with the same config on my windows machine.

2022-01-18T19:58:08.405Z - info: Initializing jsreport (version: 3.2.0, configuration file: jsreport.config.json, nodejs: 16.13.1)
2022-01-18T19:58:08.404Z - info: Initializing jsreport (version: 3.2.0, configuration file: jsreport.config.json, nodejs: 16.13.1)
2022-01-18T19:58:08.407Z - info: Searching for available extensions in /app/
2022-01-18T19:58:08.406Z - info: Searching for available extensions in /app/
2022-01-18T19:58:08.408Z - info: Extensions location cache not found, crawling directories
2022-01-18T19:58:08.408Z - info: Extensions location cache not found, crawling directories
2022-01-18T19:58:08.748Z - info: Found 36 extension(s)
2022-01-18T19:58:08.748Z - info: Found 36 extension(s)
2022-01-18T19:58:08.772Z - debug: Writing extension locations cache to /tmp/jsreport/core/locations.json
2022-01-18T19:58:08.773Z - debug: Discovered 36 extensions
2022-01-18T19:58:08.842Z - info: Using extension authentication@3.1.0
2022-01-18T19:58:08.842Z - info: Using extension authentication@3.1.0
2022-01-18T19:58:08.953Z - info: Using extension base@3.0.0
2022-01-18T19:58:08.953Z - info: Using extension base@3.0.0
2022-01-18T19:58:08.958Z - info: Using extension child-templates@3.0.1
2022-01-18T19:58:08.958Z - info: Using extension child-templates@3.0.1
2022-01-18T19:58:08.959Z - info: Using extension cli@3.0.0
2022-01-18T19:58:08.959Z - info: Using extension cli@3.0.0
2022-01-18T19:58:08.961Z - info: Using extension components@3.1.0
2022-01-18T19:58:08.961Z - info: Using extension components@3.1.0
2022-01-18T19:58:08.962Z - info: Using extension data@3.0.1
2022-01-18T19:58:08.962Z - info: Using extension data@3.0.1
2022-01-18T19:58:08.963Z - info: Using extension express@3.2.0
2022-01-18T19:58:08.963Z - info: Using extension express@3.2.0
2022-01-18T19:58:09.153Z - info: Using extension freeze@3.0.1
2022-01-18T19:58:09.153Z - info: Using extension freeze@3.0.1
2022-01-18T19:58:09.155Z - info: Using extension fs-store@3.0.0
2022-01-18T19:58:09.155Z - info: Using extension fs-store@3.0.0
2022-01-18T19:58:09.206Z - info: Using extension handlebars@3.0.0
2022-01-18T19:58:09.206Z - info: Using extension handlebars@3.0.0
2022-01-18T19:58:09.207Z - info: Using extension import-export@3.0.2
2022-01-18T19:58:09.207Z - info: Using extension import-export@3.0.2
2022-01-18T19:58:09.215Z - info: Using extension jsrender@3.0.0
2022-01-18T19:58:09.215Z - info: Using extension jsrender@3.0.0
2022-01-18T19:58:09.215Z - info: Using extension licensing@3.0.1
2022-01-18T19:58:09.215Z - info: Using extension licensing@3.0.1
2022-01-18T19:58:09.228Z - info: Using extension localization@3.1.0
2022-01-18T19:58:09.228Z - info: Using extension localization@3.1.0
2022-01-18T19:58:09.229Z - info: Using extension npm@3.1.0
2022-01-18T19:58:09.229Z - info: Using extension npm@3.1.0
2022-01-18T19:58:09.238Z - info: Using extension pdf-utils@3.1.0
2022-01-18T19:58:09.238Z - info: Using extension pdf-utils@3.1.0
2022-01-18T19:58:09.241Z - info: Using extension postgres-store@3.0.0
2022-01-18T19:58:09.241Z - info: Using extension postgres-store@3.0.0
2022-01-18T19:58:09.363Z - info: Using extension reports@3.0.0
2022-01-18T19:58:09.363Z - info: Using extension reports@3.0.0
2022-01-18T19:58:09.366Z - info: Using extension tags@3.0.0
2022-01-18T19:58:09.366Z - info: Using extension tags@3.0.0
2022-01-18T19:58:09.367Z - info: Using extension text@3.0.0
2022-01-18T19:58:09.367Z - info: Using extension text@3.0.0
2022-01-18T19:58:09.368Z - info: Using extension version-control@3.0.1
2022-01-18T19:58:09.368Z - info: Using extension version-control@3.0.1
2022-01-18T19:58:09.381Z - info: Using extension assets@3.1.0
2022-01-18T19:58:09.381Z - info: Using extension assets@3.1.0
2022-01-18T19:58:09.390Z - info: Using extension authorization@3.1.0
2022-01-18T19:58:09.390Z - info: Using extension authorization@3.1.0
2022-01-18T19:58:09.393Z - info: Using extension browser-client@3.1.0
2022-01-18T19:58:09.393Z - info: Using extension browser-client@3.1.0
2022-01-18T19:58:09.395Z - info: Using extension chrome-pdf@3.1.0
2022-01-18T19:58:09.395Z - info: Using extension chrome-pdf@3.1.0
2022-01-18T19:58:09.398Z - debug: Chrome strategy is chrome-pool, numberOfWorkers: 5
2022-01-18T19:58:09.399Z - debug: Chrome custom launch options are executablePath=/usr/lib/chromium/chrome, args=--no-sandbox,--disable-dev-shm-usage
2022-01-18T19:58:09.399Z - info: Using extension docx@3.1.0
2022-01-18T19:58:09.399Z - info: Using extension docx@3.1.0
2022-01-18T19:58:09.401Z - info: Using extension html-to-xlsx@3.1.0
2022-01-18T19:58:09.401Z - info: Using extension html-to-xlsx@3.1.0
2022-01-18T19:58:09.450Z - info: html-to-xlsx detected chrome as available html engine
2022-01-18T19:58:09.450Z - info: html-to-xlsx detected chrome as available html engine
2022-01-18T19:58:09.450Z - info: Using extension pptx@3.1.0
2022-01-18T19:58:09.450Z - info: Using extension pptx@3.1.0
2022-01-18T19:58:09.452Z - info: Using extension scheduling@3.0.1
2022-01-18T19:58:09.452Z - info: Using extension scheduling@3.0.1
2022-01-18T19:58:09.481Z - info: Using extension scripts@3.1.0
2022-01-18T19:58:09.480Z - info: Using extension scripts@3.1.0
2022-01-18T19:58:09.482Z - info: Using extension static-pdf@3.0.0
2022-01-18T19:58:09.482Z - info: Using extension static-pdf@3.0.0
2022-01-18T19:58:09.483Z - info: Using extension studio@3.2.0
2022-01-18T19:58:09.483Z - info: Using extension studio@3.2.0
2022-01-18T19:58:09.553Z - info: Using extension xlsx@3.1.0
2022-01-18T19:58:09.553Z - info: Using extension xlsx@3.1.0
2022-01-18T19:58:09.568Z - info: Using extension public-templates@3.0.0
2022-01-18T19:58:09.568Z - info: Using extension public-templates@3.0.0
2022-01-18T19:58:09.569Z - info: Using extension sample-template@3.1.0
2022-01-18T19:58:09.569Z - info: Using extension sample-template@3.1.0
2022-01-18T19:58:09.571Z - info: Using extension studio-theme-dark@3.0.1
2022-01-18T19:58:09.571Z - info: Using extension studio-theme-dark@3.0.1
2022-01-18T19:58:09.572Z - info: Using general timeout for rendering (reportTimeout: 60000)
2022-01-18T19:58:09.572Z - info: Using general timeout for rendering (reportTimeout: 60000)
2022-01-18T19:58:09.572Z - info: Using postgres provider for template store.
2022-01-18T19:58:09.572Z - info: Using postgres provider for template store.
2022-01-18T19:58:09.831Z - debug: studio default theme is: light
2022-01-18T19:58:09.831Z - debug: studio is using custom logo from base64 source
2022-01-18T19:58:10.051Z - info: Store contains user entities with deprecated username, migrating to name...
2022-01-18T19:58:10.051Z - info: Store contains user entities with deprecated username, migrating to name...
2022-01-18T19:58:10.556Z - info: Creating default express app.
2022-01-18T19:58:10.556Z - info: Creating default express app.
2022-01-18T19:58:10.572Z - info: jsreport server successfully started on http port: 5588
2022-01-18T19:58:10.572Z - info: jsreport server successfully started on http port: 5588
2022-01-18T19:58:10.573Z - info: Verifying license key free
2022-01-18T19:58:10.573Z - info: Verifying license key free
2022-01-18T19:58:10.611Z - info: Using free license
2022-01-18T19:58:10.611Z - info: Using free license
2022-01-18T19:58:10.731Z - info: Initializing worker threads
2022-01-18T19:58:10.731Z - info: Initializing worker threads
2022-01-18T19:58:10.731Z - debug: Extensions in workers: authentication, base, child-templates, components, data, express, handlebars, jsrender, localization, npm, pdf-utils, reports, text, version-control, assets, authorization, browser-client, chrome-pdf, docx, html-to-xlsx, pptx, scripts, static-pdf, studio, xlsx
2022-01-18T19:58:11.020Z - info: 2 worker threads initialized in 289ms
2022-01-18T19:58:11.020Z - info: 2 worker threads initialized in 289ms
2022-01-18T19:58:11.021Z - info: Starting temp files cleanup with 180000ms threshold
2022-01-18T19:58:11.021Z - info: Starting temp files cleanup with 180000ms threshold
2022-01-18T19:58:11.021Z - info: reporter initialized
2022-01-18T19:58:11.021Z - info: reporter initialized
2022-01-18T20:00:26.648Z - debug: OData query on templates
2022-01-18T20:00:26.653Z - debug: OData query on folders
2022-01-18T20:00:26.659Z - debug: OData query on data
2022-01-18T20:00:26.662Z - debug: OData query on tags
2022-01-18T20:00:26.665Z - debug: OData query on assets
2022-01-18T20:00:26.669Z - debug: OData query on components
2022-01-18T20:00:26.785Z - debug: OData query on scripts
2022-01-18T20:00:26.931Z - debug: OData query on usersGroups
2022-01-18T20:00:26.934Z - debug: OData query on users
2022-01-18T20:00:26.938Z - debug: OData query on schedules
2022-01-18T20:00:27.062Z - debug: OData query on settings
2022-01-18T20:00:27.246Z - debug: OData query on templates
2022-01-18T20:00:32.511Z - info: Starting rendering request 1 (user: root) rootId=2fr0j6eyrtmkcj1, id=2fr0j6eyrtmkcj1
2022-01-18T20:00:32.511Z - info: Starting rendering request 1 (user: root) rootId=2fr0j6eyrtmkcj1, id=2fr0j6eyrtmkcj1
2022-01-18T20:00:32.512Z - info: Rendering template { name: tickets-default, recipe: chrome-pdf, engine: handlebars, preview: true } rootId=2fr0j6eyrtmkcj1, id=2fr0j6eyrtmkcj1
2022-01-18T20:00:32.512Z - info: Rendering template { name: tickets-default, recipe: chrome-pdf, engine: handlebars, preview: true } rootId=2fr0j6eyrtmkcj1, id=2fr0j6eyrtmkcj1
2022-01-18T20:00:33.204Z - debug: Adding sample data BMnrDZR rootId=2fr0j6eyrtmkcj1, id=2fr0j6eyrtmkcj1
2022-01-18T20:00:33.205Z - debug: Base url not specified, skipping its injection. rootId=2fr0j6eyrtmkcj1, id=2fr0j6eyrtmkcj1
2022-01-18T20:00:34.232Z - debug: Replaced assets ["../../watermark.css","test-styles.css","./../images/test_link_logo.svg","./../images/blank_logo.svg","./../images/route_icon.svg","./../images/arrow_icon.svg","./../images/od_icon.svg","./../images/date_icon.svg","./../images/time_icon.svg","./../images/person_icon.svg","./../images/train_icon.svg","./../images/class_icon.svg","./../images/coach_icon.svg","./../images/seat_icon.svg","./../images/wheelchair_icon.svg"] rootId=2fr0j6eyrtmkcj1, id=2fr0j6eyrtmkcj1
2022-01-18T20:00:34.690Z - debug: Replaced assets ["/test/fonts/semibold.ttf","/test/fonts/regular.ttf"] rootId=2fr0j6eyrtmkcj1, id=2fr0j6eyrtmkcj1
2022-01-18T20:00:34.801Z - debug: Replaced assets ["test-helper-functions.js"] rootId=2fr0j6eyrtmkcj1, id=2fr0j6eyrtmkcj1
2022-01-18T20:00:34.801Z - debug: Rendering engine handlebars rootId=2fr0j6eyrtmkcj1, id=2fr0j6eyrtmkcj1
2022-01-18T20:00:35.608Z - debug: Executing recipe chrome-pdf rootId=2fr0j6eyrtmkcj1, id=2fr0j6eyrtmkcj1
2022-01-18T20:00:35.922Z - debug: Converting with chrome HeadlessChrome/93.0.4577.82 using chrome-pool strategy rootId=2fr0j6eyrtmkcj1, id=2fr0j6eyrtmkcj1
2022-01-18T20:00:35.922Z - debug: Page request: GET (document) file:///tmp/jsreport/autocleanup/21c1d620-a0ad-4718-a3b2-17106ec5210a-chrome-pdf.html rootId=2fr0j6eyrtmkcj1, id=2fr0j6eyrtmkcj1
2022-01-18T20:00:36.018Z - debug: Page request: GET (image) data:image/svg+xml;base64,PHN2ZyBpZD0iTGF5ZXJfMSIgZGF0YS1uYW1lPSJMYXllciAxIiB4bWxucz0iaHR0cDovL3d3dy... rootId=2fr0j6eyrtmkcj1, id=2fr0j6eyrtmkcj1
2022-01-18T20:00:36.019Z - debug: Page request finished: GET (image) 200 data:image/svg+xml;base64,PHN2ZyBpZD0iTGF5ZXJfMSIgZGF0YS1uYW1lPSJMYXllciAxIiB4bWxucz0iaHR0cDovL3d3dy... rootId=2fr0j6eyrtmkcj1, id=2fr0j6eyrtmkcj1
2022-01-18T20:00:36.019Z - debug: Page request: GET (image) data:image/svg+xml;base64,PHN2ZyB3aWR0aD0iNTM5IiBoZWlnaHQ9IjM1IiB4bWxucz0iaHR0cDovL3d3dy53My5vcmcvMj... rootId=2fr0j6eyrtmkcj1, id=2fr0j6eyrtmkcj1
2022-01-18T20:00:36.019Z - debug: Page request finished: GET (image) 200 data:image/svg+xml;base64,PHN2ZyB3aWR0aD0iNTM5IiBoZWlnaHQ9IjM1IiB4bWxucz0iaHR0cDovL3d3dy53My5vcmcvMj... rootId=2fr0j6eyrtmkcj1, id=2fr0j6eyrtmkcj1
2022-01-18T20:00:36.020Z - debug: Page request: GET (image) data:image/svg+xml;base64,PHN2ZyB3aWR0aD0iMTIzIiBoZWlnaHQ9IjE3MCIgeG1sbnM9Imh0dHA6Ly93d3cudzMub3JnLz... rootId=2fr0j6eyrtmkcj1, id=2fr0j6eyrtmkcj1
2022-01-18T20:00:36.020Z - debug: Page request finished: GET (image) 200 data:image/svg+xml;base64,PHN2ZyB3aWR0aD0iMTIzIiBoZWlnaHQ9IjE3MCIgeG1sbnM9Imh0dHA6Ly93d3cudzMub3JnLz... rootId=2fr0j6eyrtmkcj1, id=2fr0j6eyrtmkcj1
2022-01-18T20:00:36.020Z - debug: Page request: GET (image) data:image/svg+xml;base64,PHN2ZyB3aWR0aD0iMjkiIGhlaWdodD0iMTAiIHhtbG5zPSJodHRwOi8vd3d3LnczLm9yZy8yMD... rootId=2fr0j6eyrtmkcj1, id=2fr0j6eyrtmkcj1
2022-01-18T20:00:36.021Z - debug: Page request finished: GET (image) 200 data:image/svg+xml;base64,PHN2ZyB3aWR0aD0iMjkiIGhlaWdodD0iMTAiIHhtbG5zPSJodHRwOi8vd3d3LnczLm9yZy8yMD... rootId=2fr0j6eyrtmkcj1, id=2fr0j6eyrtmkcj1
2022-01-18T20:00:36.021Z - debug: Page request: GET (image) data:image/svg+xml;base64,PHN2ZyB3aWR0aD0iNzUiIGhlaWdodD0iNzguNzMiIHhtbG5zPSJodHRwOi8vd3d3LnczLm9yZy... rootId=2fr0j6eyrtmkcj1, id=2fr0j6eyrtmkcj1
2022-01-18T20:00:36.022Z - debug: Page request finished: GET (image) 200 data:image/svg+xml;base64,PHN2ZyB3aWR0aD0iNzUiIGhlaWdodD0iNzguNzMiIHhtbG5zPSJodHRwOi8vd3d3LnczLm9yZy... rootId=2fr0j6eyrtmkcj1, id=2fr0j6eyrtmkcj1
2022-01-18T20:00:36.022Z - debug: Page request finished: GET (document) file:///tmp/jsreport/autocleanup/21c1d620-a0ad-4718-a3b2-17106ec5210a-chrome-pdf.html rootId=2fr0j6eyrtmkcj1, id=2fr0j6eyrtmkcj1
2022-01-18T20:00:36.119Z - debug: Page request: GET (font) data:font/ttf;base64,AAEAAAAPAIAAAwBwRkZUTYSLY84AAiesAAAAHEdERUYJMQupAAEbCAAAADZHUE9TukgglQABMfAAAPW6R1NVQjF/R20AARtAAAAWrk9TLzJr0XaZAAABeAAAAGBjbWFwgtKRBgAADOQAAAR2Z2FzcP//AAMAARsAAAAACGdseWYsBK6xAAAW5AAA5VxoZWFkEfGAogAAAPwAAAA2aGhlYQfTBbwAAAE0AAAAJGhtdHjOWDcbAAAB2AAACwxsb2NhDjFOIAAAEVwAAAWIbWF4cAPIChYAAAFYAAAAIG5hbWWca0aZAAD8QAAACLVwb3N08mvPcwABBPgAABYHAAEAAAADAELnx3lfXw889QALA+gAAAAA1z2Z4QAAAADXqaLk/o3+zgVbA+gAAQAIAAIAAAAAAAAAAQAAA+j+9AAABXf+jf6NBVsAAQAAAAAAAAAAAAAAAAAAAsMAAQAAAsMKEwDDAAAAAAACAAAAAQABAAAAQAAAAAAAAAADAl0CWAAFAAACvAKKAAAAjAK8AooAAAHdAEkBEwAAAgsHBAAAAAAAAKAAAn9QAAA7AAAAIAAAAABTd1R5ACAAIP7/Atz+9AAAA+gBDCAAAJcAAAAAAfQCxgAAACAADAKEAEgAAAAAAU0AAADkAAABIAArAbIAOgLWACACGAAoA9QAHAMCAD8A6AA6ASsAJwEqABYB7AAfAewAJAEaABsBkAA5ARcAJwIiABICdwAzAXAAAgI9ACkCTAAjAn0AEgI8AB8COQAjAh8AIgJMACoCOQAnASsAMQEuACYB3QAaAh0APAHdABsCBwAcAyMAKALnAAECegBPAwwAJgLMAE8COABPAh4ATwMlACYC9ABPAS8ATwIjABQCtgBPAicATwN0AE8DGABPAygAJQJPAE8DSAAlApAATwJRACICOAAVAtAARwLRAAMDwQASArn/+gKyAA... rootId=2fr0j6eyrtmkcj1, id=2fr0j6eyrtmkcj1
2022-01-18T20:00:36.122Z - debug: Page request: GET (image) data:image/svg+xml;base64,PHN2ZyB3aWR0aD0iNzUiIGhlaWdodD0iNzIuOTk5OTk5OTk5OTk5OTkiIHhtbG5zPSJodHRwOi... rootId=2fr0j6eyrtmkcj1, id=2fr0j6eyrtmkcj1
2022-01-18T20:00:36.122Z - debug: Page request finished: GET (image) 200 data:image/svg+xml;base64,PHN2ZyB3aWR0aD0iNzUiIGhlaWdodD0iNzIuOTk5OTk5OTk5OTk5OTkiIHhtbG5zPSJodHRwOi... rootId=2fr0j6eyrtmkcj1, id=2fr0j6eyrtmkcj1
2022-01-18T20:00:36.122Z - debug: Page request finished: GET (image) 200 data:image/svg+xml;base64,PHN2ZyB3aWR0aD0iNzUiIGhlaWdodD0iODAuNSIgeG1sbnM9Imh0dHA6Ly93d3cudzMub3JnLz... rootId=2fr0j6eyrtmkcj1, id=2fr0j6eyrtmkcj1
2022-01-18T20:00:36.123Z - debug: Page request finished: GET (image) 200 data:image/svg+xml;base64,PHN2ZyB3aWR0aD0iNzUiIGhlaWdodD0iODYiIHhtbG5zPSJodHRwOi8vd3d3LnczLm9yZy8yMD... rootId=2fr0j6eyrtmkcj1, id=2fr0j6eyrtmkcj1
2022-01-18T20:00:36.123Z - debug: Page request: GET (image) data:image/svg+xml;base64,PHN2ZyB3aWR0aD0iNzUiIGhlaWdodD0iODAuNSIgeG1sbnM9Imh0dHA6Ly93d3cudzMub3JnLz... rootId=2fr0j6eyrtmkcj1, id=2fr0j6eyrtmkcj1
2022-01-18T20:00:36.123Z - debug: Page request: GET (image) data:image/svg+xml;base64,PHN2ZyB3aWR0aD0iNzUiIGhlaWdodD0iODYiIHhtbG5zPSJodHRwOi8vd3d3LnczLm9yZy8yMD... rootId=2fr0j6eyrtmkcj1, id=2fr0j6eyrtmkcj1
2022-01-18T20:00:36.123Z - debug: Page request: GET (image) data:image/svg+xml;base64,PHN2ZyB3aWR0aD0iNjgiIGhlaWdodD0iNzUiIHhtbG5zPSJodHRwOi8vd3d3LnczLm9yZy8yMD... rootId=2fr0j6eyrtmkcj1, id=2fr0j6eyrtmkcj1
2022-01-18T20:00:36.124Z - debug: Page request finished: GET (image) 200 data:image/svg+xml;base64,PHN2ZyB3aWR0aD0iNjgiIGhlaWdodD0iNzUiIHhtbG5zPSJodHRwOi8vd3d3LnczLm9yZy8yMD... rootId=2fr0j6eyrtmkcj1, id=2fr0j6eyrtmkcj1
2022-01-18T20:00:36.124Z - debug: Page request: GET (image) data:image/svg+xml;base64,PHN2ZyB3aWR0aD0iNjgiIGhlaWdodD0iNzkiIHhtbG5zPSJodHRwOi8vd3d3LnczLm9yZy8yMD... rootId=2fr0j6eyrtmkcj1, id=2fr0j6eyrtmkcj1
2022-01-18T20:00:36.124Z - debug: Page request finished: GET (image) 200 data:image/svg+xml;base64,PHN2ZyB3aWR0aD0iNjgiIGhlaWdodD0iNzkiIHhtbG5zPSJodHRwOi8vd3d3LnczLm9yZy8yMD... rootId=2fr0j6eyrtmkcj1, id=2fr0j6eyrtmkcj1
2022-01-18T20:00:36.124Z - debug: Page request finished: GET (image) 200 data:image/svg+xml;base64,PHN2ZyB3aWR0aD0iOTkiIGhlaWdodD0iNjMiIHhtbG5zPSJodHRwOi8vd3d3LnczLm9yZy8yMD... rootId=2fr0j6eyrtmkcj1, id=2fr0j6eyrtmkcj1
2022-01-18T20:00:36.125Z - debug: Page request finished: GET (image) 200 data:image/svg+xml;base64,PHN2ZyB3aWR0aD0iNzAiIGhlaWdodD0iODciIHhtbG5zPSJodHRwOi8vd3d3LnczLm9yZy8yMD... rootId=2fr0j6eyrtmkcj1, id=2fr0j6eyrtmkcj1
2022-01-18T20:00:36.125Z - debug: Page request: GET (image) data:image/svg+xml;base64,PHN2ZyB3aWR0aD0iOTkiIGhlaWdodD0iNjMiIHhtbG5zPSJodHRwOi8vd3d3LnczLm9yZy8yMD... rootId=2fr0j6eyrtmkcj1, id=2fr0j6eyrtmkcj1
2022-01-18T20:00:36.125Z - debug: Page request: GET (image) data:image/svg+xml;base64,PHN2ZyB3aWR0aD0iNzAiIGhlaWdodD0iODciIHhtbG5zPSJodHRwOi8vd3d3LnczLm9yZy8yMD... rootId=2fr0j6eyrtmkcj1, id=2fr0j6eyrtmkcj1
2022-01-18T20:00:36.126Z - debug: Page request: GET (image) data:image/png;base64,iVBORw0KGgoAAAANSUhEUgAAAGkAAABpCAYAAAA5gg06AAAAAXNSR0IArs4c6QAAAARnQU1BAACxjw... rootId=2fr0j6eyrtmkcj1, id=2fr0j6eyrtmkcj1
2022-01-18T20:00:36.126Z - debug: Page request finished: GET (image) 200 data:image/png;base64,iVBORw0KGgoAAAANSUhEUgAAAGkAAABpCAYAAAA5gg06AAAAAXNSR0IArs4c6QAAAARnQU1BAACxjw... rootId=2fr0j6eyrtmkcj1, id=2fr0j6eyrtmkcj1
2022-01-18T20:00:36.126Z - debug: Page request finished: GET (image) 200 data:image/png;base64,iVBORw0KGgoAAAANSUhEUgAAAtAAAABkCAIAAAAg8ZCBAAAAAXNSR0IArs4c6QAAAARnQU1BAACxjw... rootId=2fr0j6eyrtmkcj1, id=2fr0j6eyrtmkcj1
2022-01-18T20:00:36.126Z - debug: Page request: GET (image) data:image/png;base64,iVBORw0KGgoAAAANSUhEUgAAAtAAAABkCAIAAAAg8ZCBAAAAAXNSR0IArs4c6QAAAARnQU1BAACxjw... rootId=2fr0j6eyrtmkcj1, id=2fr0j6eyrtmkcj1
2022-01-18T20:00:36.127Z - debug: Page request finished: GET (font) 200 data:font/ttf;base64,AAEAAAAPAIAAAwBwRkZUTYSLY84AAiesAAAAHEdERUYJMQupAAEbCAAAADZHUE9TukgglQABMfAAAPW6R1NVQjF/R20AARtAAAAWrk9TLzJr0XaZAAABeAAAAGBjbWFwgtKRBgAADOQAAAR2Z2FzcP//AAMAARsAAAAACGdseWYsBK6xAAAW5AAA5VxoZWFkEfGAogAAAPwAAAA2aGhlYQfTBbwAAAE0AAAAJGhtdHjOWDcbAAAB2AAACwxsb2NhDjFOIAAAEVwAAAWIbWF4cAPIChYAAAFYAAAAIG5hbWWca0aZAAD8QAAACLVwb3N08mvPcwABBPgAABYHAAEAAAADAELnx3lfXw889QALA+gAAAAA1z2Z4QAAAADXqaLk/o3+zgVbA+gAAQAIAAIAAAAAAAAAAQAAA+j+9AAABXf+jf6NBVsAAQAAAAAAAAAAAAAAAAAAAsMAAQAAAsMKEwDDAAAAAAACAAAAAQABAAAAQAAAAAAAAAADAl0CWAAFAAACvAKKAAAAjAK8AooAAAHdAEkBEwAAAgsHBAAAAAAAAKAAAn9QAAA7AAAAIAAAAABTd1R5ACAAIP7/Atz+9AAAA+gBDCAAAJcAAAAAAfQCxgAAACAADAKEAEgAAAAAAU0AAADkAAABIAArAbIAOgLWACACGAAoA9QAHAMCAD8A6AA6ASsAJwEqABYB7AAfAewAJAEaABsBkAA5ARcAJwIiABICdwAzAXAAAgI9ACkCTAAjAn0AEgI8AB8COQAjAh8AIgJMACoCOQAnASsAMQEuACYB3QAaAh0APAHdABsCBwAcAyMAKALnAAECegBPAwwAJgLMAE8COABPAh4ATwMlACYC9ABPAS8ATwIjABQCtgBPAicATwN0AE8DGABPAygAJQJPAE8DSAAlApAATwJRACICOAAVAtAARwLRAAMDw... rootId=2fr0j6eyrtmkcj1, id=2fr0j6eyrtmkcj1
2022-01-18T20:00:36.127Z - debug: Running chrome with params {"printBackground":true,"format":"A4","marginTop":"30px","marginBottom":"30px","mediaType":"print","timeout":60000,"margin":{"top":"30px","bottom":"30px"}} rootId=2fr0j6eyrtmkcj1, id=2fr0j6eyrtmkcj1
2022-01-18T20:00:36.271Z - debug: Skipping storing report. rootId=2fr0j6eyrtmkcj1, id=2fr0j6eyrtmkcj1
2022-01-18T20:00:36.271Z - info: Rendering request 1 finished in 3833 ms rootId=2fr0j6eyrtmkcj1, id=2fr0j6eyrtmkcj1
2022-01-18T20:00:36.271Z - info: Rendering request 1 finished in 3833 ms rootId=2fr0j6eyrtmkcj1, id=2fr0j6eyrtmkcj1
2022-01-18T20:00:56.290Z - info: Starting rendering request 2 (user: root) rootId=1sp7y5p88rsuf5b, id=1sp7y5p88rsuf5b
2022-01-18T20:00:56.290Z - info: Starting rendering request 2 (user: root) rootId=1sp7y5p88rsuf5b, id=1sp7y5p88rsuf5b
2022-01-18T20:00:56.291Z - info: Rendering template { name: tickets-default, recipe: chrome-pdf, engine: handlebars, preview: true } rootId=1sp7y5p88rsuf5b, id=1sp7y5p88rsuf5b
2022-01-18T20:00:56.290Z - info: Rendering template { name: tickets-default, recipe: chrome-pdf, engine: handlebars, preview: true } rootId=1sp7y5p88rsuf5b, id=1sp7y5p88rsuf5b
2022-01-18T20:00:56.397Z - debug: Adding sample data BMnrDZR rootId=1sp7y5p88rsuf5b, id=1sp7y5p88rsuf5b
2022-01-18T20:00:56.959Z - debug: Base url not specified, skipping its injection. rootId=1sp7y5p88rsuf5b, id=1sp7y5p88rsuf5b
2022-01-18T20:00:58.021Z - debug: Replaced assets ["../../watermark.css","test-styles.css","./../images/test_link_logo.svg","./../images/blank_logo.svg","./../images/route_icon.svg","./../images/arrow_icon.svg","./../images/od_icon.svg","./../images/date_icon.svg","./../images/time_icon.svg","./../images/person_icon.svg","./../images/train_icon.svg","./../images/class_icon.svg","./../images/coach_icon.svg","./../images/seat_icon.svg","./../images/wheelchair_icon.svg"] rootId=1sp7y5p88rsuf5b, id=1sp7y5p88rsuf5b
2022-01-18T20:00:58.418Z - debug: Replaced assets ["/test/fonts/semibold.ttf","/test/fonts/regular.ttf"] rootId=1sp7y5p88rsuf5b, id=1sp7y5p88rsuf5b
2022-01-18T20:00:58.597Z - debug: Replaced assets ["test-helper-functions.js"] rootId=1sp7y5p88rsuf5b, id=1sp7y5p88rsuf5b
2022-01-18T20:00:58.597Z - debug: Rendering engine handlebars rootId=1sp7y5p88rsuf5b, id=1sp7y5p88rsuf5b
2022-01-18T20:00:58.734Z - debug: Executing recipe chrome-pdf rootId=1sp7y5p88rsuf5b, id=1sp7y5p88rsuf5b
2022-01-18T20:00:58.933Z - debug: Converting with chrome HeadlessChrome/93.0.4577.82 using chrome-pool strategy rootId=1sp7y5p88rsuf5b, id=1sp7y5p88rsuf5b
2022-01-18T20:00:59.034Z - debug: Page request: GET (document) file:///tmp/jsreport/autocleanup/527e237c-898a-4192-b069-85b3dac5c5f8-chrome-pdf.html rootId=1sp7y5p88rsuf5b, id=1sp7y5p88rsuf5b
2022-01-18T20:00:59.035Z - debug: Page request finished: GET (document) file:///tmp/jsreport/autocleanup/527e237c-898a-4192-b069-85b3dac5c5f8-chrome-pdf.html rootId=1sp7y5p88rsuf5b, id=1sp7y5p88rsuf5b
2022-01-18T20:00:59.139Z - debug: Page request: GET (image) data:image/svg+xml;base64,PHN2ZyBpZD0iTGF5ZXJfMSIgZGF0YS1uYW1lPSJMYXllciAxIiB4bWxucz0iaHR0cDovL3d3dy... rootId=1sp7y5p88rsuf5b, id=1sp7y5p88rsuf5b
2022-01-18T20:00:59.140Z - debug: Page request finished: GET (image) 200 data:image/svg+xml;base64,PHN2ZyBpZD0iTGF5ZXJfMSIgZGF0YS1uYW1lPSJMYXllciAxIiB4bWxucz0iaHR0cDovL3d3dy... rootId=1sp7y5p88rsuf5b, id=1sp7y5p88rsuf5b
2022-01-18T20:00:59.140Z - debug: Page request: GET (image) data:image/svg+xml;base64,PHN2ZyB3aWR0aD0iNTM5IiBoZWlnaHQ9IjM1IiB4bWxucz0iaHR0cDovL3d3dy53My5vcmcvMj... rootId=1sp7y5p88rsuf5b, id=1sp7y5p88rsuf5b
2022-01-18T20:00:59.141Z - debug: Page request finished: GET (image) 200 data:image/svg+xml;base64,PHN2ZyB3aWR0aD0iNTM5IiBoZWlnaHQ9IjM1IiB4bWxucz0iaHR0cDovL3d3dy53My5vcmcvMj... rootId=1sp7y5p88rsuf5b, id=1sp7y5p88rsuf5b
2022-01-18T20:00:59.141Z - debug: Page request: GET (image) data:image/svg+xml;base64,PHN2ZyB3aWR0aD0iMTIzIiBoZWlnaHQ9IjE3MCIgeG1sbnM9Imh0dHA6Ly93d3cudzMub3JnLz... rootId=1sp7y5p88rsuf5b, id=1sp7y5p88rsuf5b
2022-01-18T20:00:59.141Z - debug: Page request finished: GET (image) 200 data:image/svg+xml;base64,PHN2ZyB3aWR0aD0iMTIzIiBoZWlnaHQ9IjE3MCIgeG1sbnM9Imh0dHA6Ly93d3cudzMub3JnLz... rootId=1sp7y5p88rsuf5b, id=1sp7y5p88rsuf5b
2022-01-18T20:00:59.142Z - debug: Page request: GET (image) data:image/svg+xml;base64,PHN2ZyB3aWR0aD0iMjkiIGhlaWdodD0iMTAiIHhtbG5zPSJodHRwOi8vd3d3LnczLm9yZy8yMD... rootId=1sp7y5p88rsuf5b, id=1sp7y5p88rsuf5b
2022-01-18T20:00:59.142Z - debug: Page request finished: GET (image) 200 data:image/svg+xml;base64,PHN2ZyB3aWR0aD0iMjkiIGhlaWdodD0iMTAiIHhtbG5zPSJodHRwOi8vd3d3LnczLm9yZy8yMD... rootId=1sp7y5p88rsuf5b, id=1sp7y5p88rsuf5b
2022-01-18T20:00:59.142Z - debug: Page request: GET (image) data:image/svg+xml;base64,PHN2ZyB3aWR0aD0iNzUiIGhlaWdodD0iNzguNzMiIHhtbG5zPSJodHRwOi8vd3d3LnczLm9yZy... rootId=1sp7y5p88rsuf5b, id=1sp7y5p88rsuf5b
2022-01-18T20:00:59.142Z - debug: Page request finished: GET (image) 200 data:image/svg+xml;base64,PHN2ZyB3aWR0aD0iNzUiIGhlaWdodD0iNzguNzMiIHhtbG5zPSJodHRwOi8vd3d3LnczLm9yZy... rootId=1sp7y5p88rsuf5b, id=1sp7y5p88rsuf5b
2022-01-18T20:00:59.143Z - debug: Page request: GET (font) data:font/ttf;base64,AAEAAAAPAIAAAwBwRkZUTYSLY84AAiesAAAAHEdERUYJMQupAAEbCAAAADZHUE9TukgglQABMfAAAPW6R1NVQjF/R20AARtAAAAWrk9TLzJr0XaZAAABeAAAAGBjbWFwgtKRBgAADOQAAAR2Z2FzcP//AAMAARsAAAAACGdseWYsBK6xAAAW5AAA5VxoZWFkEfGAogAAAPwAAAA2aGhlYQfTBbwAAAE0AAAAJGhtdHjOWDcbAAAB2AAACwxsb2NhDjFOIAAAEVwAAAWIbWF4cAPIChYAAAFYAAAAIG5hbWWca0aZAAD8QAAACLVwb3N08mvPcwABBPgAABYHAAEAAAADAELnx3lfXw889QALA+gAAAAA1z2Z4QAAAADXqaLk/o3+zgVbA+gAAQAIAAIAAAAAAAAAAQAAA+j+9AAABXf+jf6NBVsAAQAAAAAAAAAAAAAAAAAAAsMAAQAAAsMKEwDDAAAAAAACAAAAAQABAAAAQAAAAAAAAAADAl0CWAAFAAACvAKKAAAAjAK8AooAAAHdAEkBEwAAAgsHBAAAAAAAAKAAAn9QAAA7AAAAIAAAAABTd1R5ACAAIP7/Atz+9AAAA+gBDCAAAJcAAAAAAfQCxgAAACAADAKEAEgAAAAAAU0AAADkAAABIAArAbIAOgLWACACGAAoA9QAHAMCAD8A6AA6ASsAJwEqABYB7AAfAewAJAEaABsBkAA5ARcAJwIiABICdwAzAXAAAgI9ACkCTAAjAn0AEgI8AB8COQAjAh8AIgJMACoCOQAnASsAMQEuACYB3QAaAh0APAHdABsCBwAcAyMAKALnAAECegBPAwwAJgLMAE8COABPAh4ATwMlACYC9ABPAS8ATwIjABQCtgBPAicATwN0AE8DGABPAygAJQJPAE8DSAAlApAATwJRACICOAAVAtAARwLRAAMDwQASArn/+gKyAA... rootId=1sp7y5p88rsuf5b, id=1sp7y5p88rsuf5b
2022-01-18T20:00:59.143Z - debug: Page request: GET (image) data:image/svg+xml;base64,PHN2ZyB3aWR0aD0iNzUiIGhlaWdodD0iNzIuOTk5OTk5OTk5OTk5OTkiIHhtbG5zPSJodHRwOi... rootId=1sp7y5p88rsuf5b, id=1sp7y5p88rsuf5b
2022-01-18T20:00:59.143Z - debug: Page request finished: GET (image) 200 data:image/svg+xml;base64,PHN2ZyB3aWR0aD0iNzUiIGhlaWdodD0iNzIuOTk5OTk5OTk5OTk5OTkiIHhtbG5zPSJodHRwOi... rootId=1sp7y5p88rsuf5b, id=1sp7y5p88rsuf5b
2022-01-18T20:00:59.144Z - debug: Page request: GET (image) data:image/svg+xml;base64,PHN2ZyB3aWR0aD0iNzUiIGhlaWdodD0iODAuNSIgeG1sbnM9Imh0dHA6Ly93d3cudzMub3JnLz... rootId=1sp7y5p88rsuf5b, id=1sp7y5p88rsuf5b
2022-01-18T20:00:59.144Z - debug: Page request finished: GET (image) 200 data:image/svg+xml;base64,PHN2ZyB3aWR0aD0iNzUiIGhlaWdodD0iODAuNSIgeG1sbnM9Imh0dHA6Ly93d3cudzMub3JnLz... rootId=1sp7y5p88rsuf5b, id=1sp7y5p88rsuf5b
2022-01-18T20:00:59.144Z - debug: Page request: GET (image) data:image/svg+xml;base64,PHN2ZyB3aWR0aD0iNzUiIGhlaWdodD0iODYiIHhtbG5zPSJodHRwOi8vd3d3LnczLm9yZy8yMD... rootId=1sp7y5p88rsuf5b, id=1sp7y5p88rsuf5b
2022-01-18T20:00:59.145Z - debug: Page request finished: GET (image) 200 data:image/svg+xml;base64,PHN2ZyB3aWR0aD0iNzUiIGhlaWdodD0iODYiIHhtbG5zPSJodHRwOi8vd3d3LnczLm9yZy8yMD... rootId=1sp7y5p88rsuf5b, id=1sp7y5p88rsuf5b
2022-01-18T20:00:59.145Z - debug: Page request: GET (image) data:image/svg+xml;base64,PHN2ZyB3aWR0aD0iNjgiIGhlaWdodD0iNzUiIHhtbG5zPSJodHRwOi8vd3d3LnczLm9yZy8yMD... rootId=1sp7y5p88rsuf5b, id=1sp7y5p88rsuf5b
2022-01-18T20:00:59.145Z - debug: Page request finished: GET (image) 200 data:image/svg+xml;base64,PHN2ZyB3aWR0aD0iNjgiIGhlaWdodD0iNzUiIHhtbG5zPSJodHRwOi8vd3d3LnczLm9yZy8yMD... rootId=1sp7y5p88rsuf5b, id=1sp7y5p88rsuf5b
2022-01-18T20:00:59.146Z - debug: Page request finished: GET (image) 200 data:image/svg+xml;base64,PHN2ZyB3aWR0aD0iNjgiIGhlaWdodD0iNzkiIHhtbG5zPSJodHRwOi8vd3d3LnczLm9yZy8yMD... rootId=1sp7y5p88rsuf5b, id=1sp7y5p88rsuf5b
2022-01-18T20:00:59.147Z - debug: Page request: GET (image) data:image/svg+xml;base64,PHN2ZyB3aWR0aD0iNjgiIGhlaWdodD0iNzkiIHhtbG5zPSJodHRwOi8vd3d3LnczLm9yZy8yMD... rootId=1sp7y5p88rsuf5b, id=1sp7y5p88rsuf5b
2022-01-18T20:00:59.147Z - debug: Page request: GET (image) data:image/svg+xml;base64,PHN2ZyB3aWR0aD0iOTkiIGhlaWdodD0iNjMiIHhtbG5zPSJodHRwOi8vd3d3LnczLm9yZy8yMD... rootId=1sp7y5p88rsuf5b, id=1sp7y5p88rsuf5b
2022-01-18T20:00:59.147Z - debug: Page request finished: GET (image) 200 data:image/svg+xml;base64,PHN2ZyB3aWR0aD0iOTkiIGhlaWdodD0iNjMiIHhtbG5zPSJodHRwOi8vd3d3LnczLm9yZy8yMD... rootId=1sp7y5p88rsuf5b, id=1sp7y5p88rsuf5b
2022-01-18T20:00:59.148Z - debug: Page request finished: GET (image) 200 data:image/svg+xml;base64,PHN2ZyB3aWR0aD0iNzAiIGhlaWdodD0iODciIHhtbG5zPSJodHRwOi8vd3d3LnczLm9yZy8yMD... rootId=1sp7y5p88rsuf5b, id=1sp7y5p88rsuf5b
2022-01-18T20:00:59.148Z - debug: Page request finished: GET (image) 200 data:image/png;base64,iVBORw0KGgoAAAANSUhEUgAAAGkAAABpCAYAAAA5gg06AAAAAXNSR0IArs4c6QAAAARnQU1BAACxjw... rootId=1sp7y5p88rsuf5b, id=1sp7y5p88rsuf5b
2022-01-18T20:00:59.148Z - debug: Page request: GET (image) data:image/svg+xml;base64,PHN2ZyB3aWR0aD0iNzAiIGhlaWdodD0iODciIHhtbG5zPSJodHRwOi8vd3d3LnczLm9yZy8yMD... rootId=1sp7y5p88rsuf5b, id=1sp7y5p88rsuf5b
2022-01-18T20:00:59.149Z - debug: Page request: GET (image) data:image/png;base64,iVBORw0KGgoAAAANSUhEUgAAAGkAAABpCAYAAAA5gg06AAAAAXNSR0IArs4c6QAAAARnQU1BAACxjw... rootId=1sp7y5p88rsuf5b, id=1sp7y5p88rsuf5b
2022-01-18T20:00:59.149Z - debug: Page request: GET (image) data:image/png;base64,iVBORw0KGgoAAAANSUhEUgAAAtAAAABkCAIAAAAg8ZCBAAAAAXNSR0IArs4c6QAAAARnQU1BAACxjw... rootId=1sp7y5p88rsuf5b, id=1sp7y5p88rsuf5b
2022-01-18T20:00:59.149Z - debug: Page request finished: GET (image) 200 data:image/png;base64,iVBORw0KGgoAAAANSUhEUgAAAtAAAABkCAIAAAAg8ZCBAAAAAXNSR0IArs4c6QAAAARnQU1BAACxjw... rootId=1sp7y5p88rsuf5b, id=1sp7y5p88rsuf5b
2022-01-18T20:00:59.234Z - debug: Page request finished: GET (font) 200 data:font/ttf;base64,AAEAAAAPAIAAAwBwRkZUTYSLY84AAiesAAAAHEdERUYJMQupAAEbCAAAADZHUE9TukgglQABMfAAAPW6R1NVQjF/R20AARtAAAAWrk9TLzJr0XaZAAABeAAAAGBjbWFwgtKRBgAADOQAAAR2Z2FzcP//AAMAARsAAAAACGdseWYsBK6xAAAW5AAA5VxoZWFkEfGAogAAAPwAAAA2aGhlYQfTBbwAAAE0AAAAJGhtdHjOWDcbAAAB2AAACwxsb2NhDjFOIAAAEVwAAAWIbWF4cAPIChYAAAFYAAAAIG5hbWWca0aZAAD8QAAACLVwb3N08mvPcwABBPgAABYHAAEAAAADAELnx3lfXw889QALA+gAAAAA1z2Z4QAAAADXqaLk/o3+zgVbA+gAAQAIAAIAAAAAAAAAAQAAA+j+9AAABXf+jf6NBVsAAQAAAAAAAAAAAAAAAAAAAsMAAQAAAsMKEwDDAAAAAAACAAAAAQABAAAAQAAAAAAAAAADAl0CWAAFAAACvAKKAAAAjAK8AooAAAHdAEkBEwAAAgsHBAAAAAAAAKAAAn9QAAA7AAAAIAAAAABTd1R5ACAAIP7/Atz+9AAAA+gBDCAAAJcAAAAAAfQCxgAAACAADAKEAEgAAAAAAU0AAADkAAABIAArAbIAOgLWACACGAAoA9QAHAMCAD8A6AA6ASsAJwEqABYB7AAfAewAJAEaABsBkAA5ARcAJwIiABICdwAzAXAAAgI9ACkCTAAjAn0AEgI8AB8COQAjAh8AIgJMACoCOQAnASsAMQEuACYB3QAaAh0APAHdABsCBwAcAyMAKALnAAECegBPAwwAJgLMAE8COABPAh4ATwMlACYC9ABPAS8ATwIjABQCtgBPAicATwN0AE8DGABPAygAJQJPAE8DSAAlApAATwJRACICOAAVAtAARwLRAAMDw... rootId=1sp7y5p88rsuf5b, id=1sp7y5p88rsuf5b
2022-01-18T20:00:59.234Z - debug: Running chrome with params {"printBackground":true,"format":"A4","marginTop":"30px","marginBottom":"30px","mediaType":"print","timeout":60000,"margin":{"top":"30px","bottom":"30px"}} rootId=1sp7y5p88rsuf5b, id=1sp7y5p88rsuf5b
2022-01-18T20:00:59.353Z - debug: Skipping storing report. rootId=1sp7y5p88rsuf5b, id=1sp7y5p88rsuf5b
2022-01-18T20:00:59.354Z - info: Rendering request 2 finished in 3130 ms rootId=1sp7y5p88rsuf5b, id=1sp7y5p88rsuf5b
2022-01-18T20:00:59.354Z - info: Rendering request 2 finished in 3130 ms rootId=1sp7y5p88rsuf5b, id=1sp7y5p88rsuf5b

JannoSaks

Hi, I was trying out the new jsreport 3.3 with a fresh/empty Postgres database but I am getting an error when I try to log in to the studio UI.
It seems that the postgres db has some columns missing or with a bad name?

PS C:\Projects\jsreport3.3> jsreport start
2022-01-18T20:13:21.130Z - info: Initializing jsreport (version: 3.3.0, configuration file: jsreport.config.json, nodejs: 16.13.1)
2022-01-18T20:13:21.134Z - info: Searching for available extensions in C:\Projects\jsreport3.3\
2022-01-18T20:13:21.139Z - info: Extensions location cache doesn't contain entry yet, crawling
2022-01-18T20:13:22.750Z - info: Found 36 extension(s)
2022-01-18T20:13:22.775Z - debug: Writing extension locations cache to C:\Users\JANNO~1.SAK\AppData\Local\Temp\jsreport\core\locations.json
2022-01-18T20:13:22.778Z - debug: Discovered 36 extensions
2022-01-18T20:13:22.816Z - info: Using extension authentication@3.2.0
2022-01-18T20:13:23.003Z - info: Using extension base@3.0.0
2022-01-18T20:13:23.009Z - info: Using extension child-templates@3.0.1
2022-01-18T20:13:23.012Z - info: Using extension cli@3.0.0
2022-01-18T20:13:23.015Z - info: Using extension components@3.2.0
2022-01-18T20:13:23.017Z - info: Using extension data@3.0.1
2022-01-18T20:13:23.018Z - info: Using extension express@3.2.1
2022-01-18T20:13:23.269Z - info: Using extension freeze@3.0.1
2022-01-18T20:13:23.271Z - info: Using extension fs-store@3.0.0
2022-01-18T20:13:23.348Z - info: Using extension handlebars@3.0.0
2022-01-18T20:13:23.353Z - info: Using extension import-export@3.0.2
2022-01-18T20:13:23.363Z - info: Using extension jsrender@3.0.0
2022-01-18T20:13:23.365Z - info: Using extension licensing@3.0.1
2022-01-18T20:13:23.384Z - info: Using extension localization@3.1.1
2022-01-18T20:13:23.387Z - info: Using extension npm@3.1.0
2022-01-18T20:13:23.392Z - info: Using extension pdf-utils@3.2.0
2022-01-18T20:13:23.395Z - info: Using extension postgres-store@3.0.0
2022-01-18T20:13:23.547Z - info: Using extension reports@3.0.1
2022-01-18T20:13:23.553Z - info: Using extension tags@3.1.0
2022-01-18T20:13:23.556Z - info: Using extension text@3.0.0
2022-01-18T20:13:23.558Z - info: Using extension version-control@3.0.1
2022-01-18T20:13:23.571Z - info: Using extension assets@3.2.0
2022-01-18T20:13:23.584Z - info: Using extension authorization@3.2.0
2022-01-18T20:13:23.590Z - info: Using extension browser-client@3.1.0
2022-01-18T20:13:23.593Z - info: Using extension chrome-pdf@3.1.0
2022-01-18T20:13:23.598Z - debug: Chrome strategy is chrome-pool, numberOfWorkers: 5
2022-01-18T20:13:23.599Z - info: Using extension docx@3.1.0
2022-01-18T20:13:23.602Z - info: Using extension html-to-xlsx@3.1.0
2022-01-18T20:13:23.682Z - info: html-to-xlsx detected chrome as available html engine
2022-01-18T20:13:23.683Z - info: Using extension pptx@3.1.0
2022-01-18T20:13:23.686Z - info: Using extension scheduling@3.0.1
2022-01-18T20:13:23.716Z - info: Using extension scripts@3.2.0
2022-01-18T20:13:23.718Z - info: Using extension static-pdf@3.0.0
2022-01-18T20:13:23.719Z - info: Using extension studio@3.3.0
2022-01-18T20:13:23.775Z - info: Using extension xlsx@3.1.0
2022-01-18T20:13:23.798Z - info: Using extension public-templates@3.0.0
2022-01-18T20:13:23.800Z - info: Using extension sample-template@3.1.0
2022-01-18T20:13:23.803Z - info: Using extension studio-theme-dark@3.0.1
2022-01-18T20:13:23.805Z - info: Using general timeout for rendering (reportTimeout: 60000)
2022-01-18T20:13:23.806Z - info: Using postgres provider for template store.
2022-01-18T20:13:24.047Z - debug: studio default theme is: light
2022-01-18T20:13:24.049Z - debug: studio is using custom logo from base64 source
2022-01-18T20:13:24.077Z - info: Creating default express app.
2022-01-18T20:13:24.096Z - info: jsreport server successfully started on http port: 5588
2022-01-18T20:13:24.099Z - info: Verifying license key free
2022-01-18T20:13:24.102Z - info: Using free license
2022-01-18T20:13:24.113Z - info: Migrating templates chrome settings (waitForNetworkIddle -> waitForNetworkIdle)
2022-01-18T20:13:24.119Z - info: Migration successful
2022-01-18T20:13:24.122Z - debug: Inserting samples
2022-01-18T20:13:24.127Z - debug: Creating folder "samples" for sample entities
2022-01-18T20:13:24.141Z - debug: Inserting sample entity Invoice (entitySet: folders)
2022-01-18T20:13:24.158Z - debug: Inserting sample entity Orders (entitySet: folders)
2022-01-18T20:13:24.173Z - debug: Inserting sample entity Sales (entitySet: folders)
2022-01-18T20:13:24.189Z - debug: Inserting sample entity shared (entitySet: folders)
2022-01-18T20:13:24.207Z - debug: Inserting sample entity invoice-data (entitySet: data)
2022-01-18T20:13:24.227Z - debug: Inserting sample entity sales-data (entitySet: data)
2022-01-18T20:13:24.249Z - debug: Inserting sample entity sales-main (entitySet: templates)
2022-01-18T20:13:24.277Z - debug: Inserting sample entity invoice-main (entitySet: templates)
2022-01-18T20:13:24.301Z - debug: Inserting sample entity orders-header (entitySet: templates)
2022-01-18T20:13:24.320Z - debug: Inserting sample entity orders-main (entitySet: templates)
2022-01-18T20:13:24.336Z - debug: Inserting sample entity invoice-styles.css (entitySet: assets)
2022-01-18T20:13:24.358Z - debug: Inserting sample entity orders-styles.css (entitySet: assets)
2022-01-18T20:13:24.376Z - debug: Inserting sample entity sales-styles.css (entitySet: assets)
2022-01-18T20:13:24.391Z - debug: Inserting sample entity global helpers.js (entitySet: assets)
2022-01-18T20:13:24.408Z - debug: Inserting sample entity invoice-logo.png (entitySet: assets)
2022-01-18T20:13:24.428Z - debug: Inserting sample entity orders-script (entitySet: scripts)
2022-01-18T20:13:24.446Z - info: Initializing worker threads
2022-01-18T20:13:24.447Z - debug: Extensions in workers: authentication, base, child-templates, components, data, express, handlebars, jsrender, localization, npm, pdf-utils, reports, text, version-control, assets, authorization, browser-client, chrome-pdf, docx, html-to-xlsx, pptx, scripts, static-pdf, studio, xlsx
2022-01-18T20:13:24.646Z - info: 2 worker threads initialized in 200ms
2022-01-18T20:13:24.647Z - info: Starting temp files cleanup with 180000ms threshold
2022-01-18T20:13:24.648Z - info: reporter initialized
2022-01-18T20:14:02.710Z - info: Logging in user admin
2022-01-18T20:14:03.759Z - debug: OData query on templates
2022-01-18T20:14:03.765Z - debug: OData query on folders
2022-01-18T20:14:03.774Z - debug: OData query on components
2022-01-18T20:14:03.778Z - debug: OData query on data
2022-01-18T20:14:03.781Z - debug: OData query on tags
2022-01-18T20:14:03.785Z - debug: OData query on assets
2022-01-18T20:14:03.786Z - error: Error when processing OData GET: /odata/assets?$select=isSharedHelper,scope,name,shortid,tags,folder&$orderby=name TypeError: Cannot read properties of undefined (reading 'forEach')
    at module.exports (C:\Projects\jsreport3.3\node_modules\@jsreport\odata-to-sql\lib\query.js:54:28)
    at Object.query (C:\Projects\jsreport3.3\node_modules\@jsreport\odata-to-sql\lib\transformer.js:46:14)
    at Cursor.toArray (C:\Projects\jsreport3.3\node_modules\@jsreport\sql-store\lib\sqlProvider.js:22:29)
    at replay (C:\Projects\jsreport3.3\node_modules\@jsreport\jsreport-core\lib\main\store\collection.js:51:21)
    at C:\Projects\jsreport3.3\node_modules\@jsreport\jsreport-core\lib\main\store\collection.js:58:18
    at processTicksAndRejections (node:internal/process/task_queues:96:5)
2022-01-18T20:14:03.798Z - debug: OData query on scripts
2022-01-18T20:14:03.806Z - debug: OData query on users
2022-01-18T20:14:03.817Z - debug: OData query on usersGroups
2022-01-18T20:14:03.825Z - debug: OData query on schedules
2022-01-18T20:14:03.848Z - debug: OData query on settings

JannoSaks

You're right, creating an empty database with the authentication enabled fixed it.
Thank you!

JannoSaks

I also tried importing a folder to jsreport 3.2 that I exported from jsreport 2.11
But I received another similar "inheritedReadPermissions" error but from a different database table.

Any ideas why the postgre DB is missing these "inheritedReadPermissions" columns?

Import failed: Unable to insert an entity (folders) "/TestFolder" during the import: error: column "inheritedReadPermissions" of relation "jsreport_FolderType" does not exist Error: Import failed: Unable to insert an entity (folders) "/TestFolder" during the import: error: column "inheritedReadPermissions" of relation "jsreport_FolderType" does not exist
    at Parser.parseErrorMessage (C:\Projects\jsreport3\node_modules\pg-protocol\dist\parser.js:287:98)
    at Parser.handlePacket (C:\Projects\jsreport3\node_modules\pg-protocol\dist\parser.js:126:29)
    at Parser.parse (C:\Projects\jsreport3\node_modules\pg-protocol\dist\parser.js:39:38)
    at Socket.<anonymous> (C:\Projects\jsreport3\node_modules\pg-protocol\dist\index.js:11:42)
    at Socket.emit (node:events:390:28)
    at addChunk (node:internal/streams/readable:315:12)
    at readableAddChunk (node:internal/streams/readable:289:9)
    at Socket.Readable.push (node:internal/streams/readable:228:10)
    at TCP.onStreamRead (node:internal/stream_base_commons:199:23)
From previous event:
    at I.H [as _captureStackTrace] (http://localhost:5488/studio/assets/client.85292b4c92f95f8a8b29.js:8:197199)
    at I._resolveFromExecutor (http://localhost:5488/studio/assets/client.85292b4c92f95f8a8b29.js:8:227559)
    at new I (http://localhost:5488/studio/assets/client.85292b4c92f95f8a8b29.js:8:220636)
    at Object.d.forEach.h.<computed> [as post] (http://localhost:5488/studio/assets/client.85292b4c92f95f8a8b29.js:3:758186)
    at Object.b.methods.forEach.n.API.<computed> [as post] (http://localhost:5488/studio/assets/client.85292b4c92f95f8a8b29.js:402:34253)
    at ImportModal._callee2$ (http://localhost:5488/studio/assets/studio-extensions.client.7030b650bf29c89b7ddd.js:3182:53)
    at m (http://localhost:5488/studio/assets/client.85292b4c92f95f8a8b29.js:318:152940)
    at Generator._invoke (http://localhost:5488/studio/assets/client.85292b4c92f95f8a8b29.js:318:152693)
    at Generator.forEach.e.<computed> [as next] (http://localhost:5488/studio/assets/client.85292b4c92f95f8a8b29.js:318:153120)
    at step (http://localhost:5488/studio/assets/studio-extensions.client.7030b650bf29c89b7ddd.js:2923:191)
    at http://localhost:5488/studio/assets/studio-extensions.client.7030b650bf29c89b7ddd.js:2923:437
    at new Promise (<anonymous>)
    at ImportModal.<anonymous> (http://localhost:5488/studio/assets/studio-extensions.client.7030b650bf29c89b7ddd.js:2923:99)
    at ImportModal._import (http://localhost:5488/studio/assets/studio-extensions.client.7030b650bf29c89b7ddd.js:3229:22)
    at onClick (http://localhost:5488/studio/assets/studio-extensions.client.7030b650bf29c89b7ddd.js:3476:39)
    at Object.a (http://localhost:5488/studio/assets/client.85292b4c92f95f8a8b29.js:334:458)
    at f (http://localhost:5488/studio/assets/client.85292b4c92f95f8a8b29.js:334:601)
    at http://localhost:5488/studio/assets/client.85292b4c92f95f8a8b29.js:334:747
    at _ (http://localhost:5488/studio/assets/client.85292b4c92f95f8a8b29.js:334:833)
    at st (http://localhost:5488/studio/assets/client.85292b4c92f95f8a8b29.js:334:16338)
    at rt (http://localhost:5488/studio/assets/client.85292b4c92f95f8a8b29.js:334:16171)
    at at (http://localhost:5488/studio/assets/client.85292b4c92f95f8a8b29.js:334:16527)

JannoSaks

Hey, I was trying out the new jsreport 3 and encountered a warning while using postgres-store.

I'm using jsreport 3.2.0 with @jsreport/jsreport-postgres-store (from https://github.com/jsreport/jsreport/tree/master/packages/jsreport-postgres-store)
The error itself is:

error: column "inheritedReadPermissions" of relation "jsreport_MonitoringType" does not exist

Full logs from jsreport initialization:

PS C:\Projects\jsreport3> jsreport start
2022-01-08T13:21:44.688Z - info: Initializing jsreport (version: 3.2.0, configuration file: jsreport.config.json, nodejs: 16.13.1)
2022-01-08T13:21:44.690Z - info: Searching for available extensions in C:\Projects\jsreport3\
2022-01-08T13:21:44.695Z - info: Extensions location cache contains up to date information, skipping crawling in C:\Projects\jsreport3\
2022-01-08T13:21:44.705Z - info: Found 36 extension(s)
2022-01-08T13:21:44.731Z - debug: Writing extension locations cache to C:\Users\JANNO~1.SAK\AppData\Local\Temp\jsreport\core\locations.json
2022-01-08T13:21:44.733Z - debug: Discovered 36 extensions
2022-01-08T13:21:44.776Z - info: Using extension authentication@3.1.0
2022-01-08T13:21:44.957Z - info: Using extension base@3.0.0
2022-01-08T13:21:44.961Z - info: Using extension child-templates@3.0.1
2022-01-08T13:21:44.963Z - info: Using extension cli@3.0.0
2022-01-08T13:21:44.964Z - info: Using extension components@3.1.0
2022-01-08T13:21:44.966Z - info: Using extension data@3.0.1
2022-01-08T13:21:44.967Z - info: Using extension express@3.2.0
2022-01-08T13:21:45.233Z - info: Using extension freeze@3.0.1
2022-01-08T13:21:45.236Z - info: Using extension fs-store@3.0.0
2022-01-08T13:21:45.321Z - info: Using extension handlebars@3.0.0
2022-01-08T13:21:45.323Z - info: Using extension import-export@3.0.2
2022-01-08T13:21:45.333Z - info: Using extension jsrender@3.0.0
2022-01-08T13:21:45.334Z - info: Using extension licensing@3.0.1
2022-01-08T13:21:45.358Z - info: Using extension localization@3.1.0
2022-01-08T13:21:45.359Z - info: Using extension npm@3.1.0
2022-01-08T13:21:45.362Z - info: Using extension pdf-utils@3.1.0
2022-01-08T13:21:45.364Z - info: Using extension postgres-store@3.0.0
2022-01-08T13:21:45.508Z - info: Using extension reports@3.0.0
2022-01-08T13:21:45.513Z - info: Using extension tags@3.0.0
2022-01-08T13:21:45.515Z - info: Using extension text@3.0.0
2022-01-08T13:21:45.516Z - info: Using extension version-control@3.0.1
2022-01-08T13:21:45.546Z - info: Using extension assets@3.1.0
2022-01-08T13:21:45.558Z - info: Using extension authorization@3.1.0
2022-01-08T13:21:45.562Z - info: Using extension browser-client@3.1.0
2022-01-08T13:21:45.565Z - info: Using extension chrome-pdf@3.1.0
2022-01-08T13:21:45.568Z - debug: Chrome strategy is chrome-pool, numberOfWorkers: 5
2022-01-08T13:21:45.569Z - info: Using extension docx@3.1.0
2022-01-08T13:21:45.571Z - info: Using extension html-to-xlsx@3.1.0
2022-01-08T13:21:45.651Z - info: html-to-xlsx detected chrome as available html engine
2022-01-08T13:21:45.652Z - info: Using extension pptx@3.1.0
2022-01-08T13:21:45.655Z - info: Using extension scheduling@3.0.1
2022-01-08T13:21:45.687Z - info: Using extension scripts@3.1.0
2022-01-08T13:21:45.688Z - info: Using extension static-pdf@3.0.0
2022-01-08T13:21:45.690Z - info: Using extension studio@3.2.0
2022-01-08T13:21:45.747Z - info: Using extension xlsx@3.1.0
2022-01-08T13:21:45.771Z - info: Using extension public-templates@3.0.0
2022-01-08T13:21:45.772Z - info: Using extension sample-template@3.1.0
2022-01-08T13:21:45.775Z - info: Using extension studio-theme-dark@3.0.1
2022-01-08T13:21:45.777Z - info: Using general timeout for rendering (reportTimeout: 60000)
2022-01-08T13:21:45.777Z - info: Using postgres provider for template store.
2022-01-08T13:21:45.880Z - debug: studio default theme is: light
2022-01-08T13:21:45.880Z - debug: studio is using custom logo from base64 source
2022-01-08T13:21:45.896Z - info: Creating default express app.
2022-01-08T13:21:45.921Z - info: jsreport server successfully started on http port: 5488
2022-01-08T13:21:45.922Z - info: Verifying license key free
2022-01-08T13:21:45.924Z - info: Using free license
2022-01-08T13:21:45.931Z - info: Initializing worker threads
2022-01-08T13:21:45.933Z - debug: Extensions in workers: authentication, base, child-templates, components, data, express, handlebars, jsrender, localization, npm, pdf-utils, reports, text, version-control, assets, authorization, browser-client, chrome-pdf, docx, html-to-xlsx, pptx, scripts, static-pdf, studio, xlsx
2022-01-08T13:21:46.198Z - info: 5 worker threads initialized in 267ms
2022-01-08T13:21:46.198Z - info: Starting temp files cleanup with 180000ms threshold
2022-01-08T13:21:46.200Z - info: reporter initialized
2022-01-08T13:21:52.465Z - info: Logging in user admin
2022-01-08T13:21:53.016Z - debug: OData query on templates
2022-01-08T13:21:53.019Z - debug: OData query on folders
2022-01-08T13:21:53.023Z - debug: OData query on components
2022-01-08T13:21:53.025Z - debug: OData query on data
2022-01-08T13:21:53.028Z - debug: OData query on tags
2022-01-08T13:21:53.032Z - debug: OData query on assets
2022-01-08T13:21:53.045Z - debug: OData query on scripts
2022-01-08T13:21:53.047Z - debug: OData query on users
2022-01-08T13:21:53.049Z - debug: OData query on usersGroups
2022-01-08T13:21:53.052Z - debug: OData query on schedules
2022-01-08T13:21:53.066Z - debug: OData query on settings
2022-01-08T13:21:53.146Z - debug: OData query on templates
2022-01-08T13:21:53.167Z - debug: OData query on profiles
2022-01-08T13:21:53.201Z - debug: OData query on monitoring
2022-01-08T13:22:47.210Z - warn: unable to persist monitoring info, but no need to worry, we will retry, details:error: column "inheritedReadPermissions" of relation "jsreport_MonitoringType" does not exist
    at Parser.parseErrorMessage (C:\Projects\jsreport3\node_modules\pg-protocol\dist\parser.js:287:98)
    at Parser.handlePacket (C:\Projects\jsreport3\node_modules\pg-protocol\dist\parser.js:126:29)
    at Parser.parse (C:\Projects\jsreport3\node_modules\pg-protocol\dist\parser.js:39:38)
    at Socket.<anonymous> (C:\Projects\jsreport3\node_modules\pg-protocol\dist\index.js:11:42)
    at Socket.emit (node:events:390:28)
    at addChunk (node:internal/streams/readable:315:12)
    at readableAddChunk (node:internal/streams/readable:289:9)
    at Socket.Readable.push (node:internal/streams/readable:228:10)
    at TCP.onStreamRead (node:internal/stream_base_commons:199:23)
2022-01-08T13:23:47.205Z - warn: unable to persist monitoring info, but no need to worry, we will retry, details:error: column "inheritedReadPermissions" of relation "jsreport_MonitoringType" does not exist
    at Parser.parseErrorMessage (C:\Projects\jsreport3\node_modules\pg-protocol\dist\parser.js:287:98)
    at Parser.handlePacket (C:\Projects\jsreport3\node_modules\pg-protocol\dist\parser.js:126:29)
    at Parser.parse (C:\Projects\jsreport3\node_modules\pg-protocol\dist\parser.js:39:38)
    at Socket.<anonymous> (C:\Projects\jsreport3\node_modules\pg-protocol\dist\index.js:11:42)
    at Socket.emit (node:events:390:28)
    at addChunk (node:internal/streams/readable:315:12)
    at readableAddChunk (node:internal/streams/readable:289:9)
    at Socket.Readable.push (node:internal/streams/readable:228:10)
    at TCP.onStreamRead (node:internal/stream_base_commons:199:23)
2022-01-08T13:24:47.204Z - warn: unable to persist monitoring info, but no need to worry, we will retry, details:error: column "inheritedReadPermissions" of relation "jsreport_MonitoringType" does not exist
    at Parser.parseErrorMessage (C:\Projects\jsreport3\node_modules\pg-protocol\dist\parser.js:287:98)
    at Parser.handlePacket (C:\Projects\jsreport3\node_modules\pg-protocol\dist\parser.js:126:29)
    at Parser.parse (C:\Projects\jsreport3\node_modules\pg-protocol\dist\parser.js:39:38)
    at Socket.<anonymous> (C:\Projects\jsreport3\node_modules\pg-protocol\dist\index.js:11:42)
    at Socket.emit (node:events:390:28)
    at addChunk (node:internal/streams/readable:315:12)
    at readableAddChunk (node:internal/streams/readable:289:9)
    at Socket.Readable.push (node:internal/streams/readable:228:10)
    at TCP.onStreamRead (node:internal/stream_base_commons:199:23)
2022-01-08T13:25:47.206Z - warn: unable to persist monitoring info, but no need to worry, we will retry, details:error: column "inheritedReadPermissions" of relation "jsreport_MonitoringType" does not exist
    at Parser.parseErrorMessage (C:\Projects\jsreport3\node_modules\pg-protocol\dist\parser.js:287:98)
    at Parser.handlePacket (C:\Projects\jsreport3\node_modules\pg-protocol\dist\parser.js:126:29)
    at Parser.parse (C:\Projects\jsreport3\node_modules\pg-protocol\dist\parser.js:39:38)
    at Socket.<anonymous> (C:\Projects\jsreport3\node_modules\pg-protocol\dist\index.js:11:42)
    at Socket.emit (node:events:390:28)
    at addChunk (node:internal/streams/readable:315:12)
    at readableAddChunk (node:internal/streams/readable:289:9)
    at Socket.Readable.push (node:internal/streams/readable:228:10)
    at TCP.onStreamRead (node:internal/stream_base_commons:199:23)
2022-01-08T13:26:47.206Z - warn: unable to persist monitoring info, but no need to worry, we will retry, details:error: column "inheritedReadPermissions" of relation "jsreport_MonitoringType" does not exist
    at Parser.parseErrorMessage (C:\Projects\jsreport3\node_modules\pg-protocol\dist\parser.js:287:98)
    at Parser.handlePacket (C:\Projects\jsreport3\node_modules\pg-protocol\dist\parser.js:126:29)
    at Parser.parse (C:\Projects\jsreport3\node_modules\pg-protocol\dist\parser.js:39:38)
    at Socket.<anonymous> (C:\Projects\jsreport3\node_modules\pg-protocol\dist\index.js:11:42)
    at Socket.emit (node:events:390:28)
    at addChunk (node:internal/streams/readable:315:12)
    at readableAddChunk (node:internal/streams/readable:289:9)
    at Socket.Readable.push (node:internal/streams/readable:228:10)
    at TCP.onStreamRead (node:internal/stream_base_commons:199:23)

Any ideas? Is this just a bug?

JannoSaks

@JannoSaks

Posts made by JannoSaks