Content
View differences
Updated by Oliver Günther over 2 years ago
**Steps to reproduce**
* Create a project with work packages, time and costs modules active
* Create a work package, log time with empty activity
* Create a cost report with that activity, hit export XLS
I have a problem with generating the report from December 14th, it displays an error as below. The same report generated from other days does not have this error. I don't see anything particularly different in the content of the report between days.
<figure class="image op-uc-figure"><div class="op-uc-figure--content"><img class="op-uc-image" src="/api/v3/attachments/84297/content"></div></figure>
<img class="op-uc-image op-uc-image_inline" src="/api/v3/attachments/84299/content">
openproject logs --tai
Dec 18 18:51:30 openproject openproject-web-1.service\[336221\]: I, \[2023-12-18T18:51:30.892433 #336221\] INFO -- : \[7a294a39-8045-4e90-932c-d32704e3727f\] duration=7.42 db=1.53 view=5.89 status=200 method=GET path=/api/v3/configuration params={} host=xxxx user=3
Dec 18 18:51:31 openproject openproject-web-1.service\[336221\]: I, \[2023-12-18T18:51:31.240478 #336221\] INFO -- : \[f5834bf3-6548-4cc2-b574-52383c1b8025\] duration=5.89 db=2.35 view=3.54 status=200 method=GET path=/api/v3/job\_statuses/d8fbfacf-6f46-4027-a166-e427d20f4e51 params={} host=xxx.xxx.pl user=3
Dec 18 18:51:31 openproject openproject-web-1.service\[336221\]: I, \[2023-12-18T18:51:31.245891 #336221\] INFO -- : \[3bc62838-2861-4f6e-8ed6-6faeb03a368e\] duration=9.89 db=3.28 view=6.61 status=302 method=GET path=/api/v3/users/3/avatar params={} host=xxxx user=3
Dec 18 18:51:31 openproject openproject-web-1.service\[336227\]: I, \[2023-12-18T18:51:31.245921 #336227\] INFO -- : \[bf181a3c-4beb-4541-90d3-bf2afbd5be69\] duration=11.37 db=3.84 view=7.53 status=200 method=GET path=/api/v3/notifications params={"pageSize"=>"0", "filters"=>"\[{\\"readIAN\\":{\\"operator\\":\\"=\\",\\"values\\":\[\\"f\\"\]}}\]"} host=xxxx user=3
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: I, \[2023-12-18T18:51:31.228828 #336202\] INFO -- : \[ActiveJob\] \[CostQuery::ExportJob\] \[d8fbfacf-6f46-4027-a166-e427d20f4e51\] Performing CostQuery::ExportJob (Job ID: d8fbfacf-6f46-4027-a166-e427d20f4e51) from DelayedJob(default) enqueued at 2023-12-18T17:51:29Z
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: E, \[2023-12-18T18:51:31.280269 #336202\] ERROR -- : \[ActiveJob\] \[CostQuery::ExportJob\] \[d8fbfacf-6f46-4027-a166-e427d20f4e51\] Failed to run export job for OpenProject Admin: Couldn't find Enumeration with 'id'=0
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: E, \[2023-12-18T18:51:31.280459 #336202\] ERROR -- : \[ActiveJob\] \[CostQuery::ExportJob\] \[d8fbfacf-6f46-4027-a166-e427d20f4e51\] Error performing CostQuery::ExportJob (Job ID: d8fbfacf-6f46-4027-a166-e427d20f4e51) from DelayedJob(default) in 55.36ms: ActiveRecord::RecordNotFound (Couldn't find Enumeration with 'id'=0):
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/activerecord-7.0.8/lib/active\_record/relation/finder\_methods.rb:381:in \`raise\_record\_not\_found\_exception!'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/activerecord-7.0.8/lib/active\_record/relation/finder\_methods.rb:475:in \`find\_one'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/activerecord-7.0.8/lib/active\_record/relation/finder\_methods.rb:457:in \`find\_with\_ids'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/activerecord-7.0.8/lib/active\_record/relation/finder\_methods.rb:69:in \`find'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/activerecord-7.0.8/lib/active\_record/querying.rb:22:in \`find'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/activerecord-7.0.8/lib/active\_record/core.rb:271:in \`find'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/modules/reporting/app/helpers/reporting\_helper.rb:48:in \`mapped'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/modules/xls\_export/lib/open\_project/xls\_export/xls\_views.rb:15:in \`field\_representation\_map'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/modules/reporting/app/helpers/reporting\_helper.rb:83:in \`show\_field'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/modules/reporting/lib/open\_project/reporting/cost\_entry\_xls\_table.rb:59:in \`block in cost\_row'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/modules/reporting/lib/open\_project/reporting/cost\_entry\_xls\_table.rb:59:in \`map'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/modules/reporting/lib/open\_project/reporting/cost\_entry\_xls\_table.rb:59:in \`cost\_row'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/modules/reporting/lib/open\_project/reporting/cost\_entry\_xls\_table.rb:44:in \`block in build\_cost\_rows'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/modules/reporting/lib/open\_project/reporting/cost\_entry\_xls\_table.rb:43:in \`each'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/modules/reporting/lib/open\_project/reporting/cost\_entry\_xls\_table.rb:43:in \`build\_cost\_rows'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/modules/reporting/lib/open\_project/reporting/cost\_entry\_xls\_table.rb:32:in \`build\_spreadsheet'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/modules/reporting/lib/open\_project/reporting/cost\_entry\_xls\_table.rb:10:in \`block in generate'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/modules/reporting/lib/open\_project/reporting/cost\_entry\_xls\_table.rb:6:in \`each'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/modules/reporting/lib/open\_project/reporting/cost\_entry\_xls\_table.rb:6:in \`each\_with\_index'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/modules/reporting/lib/open\_project/reporting/cost\_entry\_xls\_table.rb:6:in \`generate'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/modules/xls\_export/lib/open\_project/xls\_export/xls\_views.rb:54:in \`generate'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/modules/reporting/app/workers/cost\_query/export\_job.rb:32:in \`xls\_report\_result'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/modules/reporting/app/workers/cost\_query/export\_job.rb:27:in \`export!'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/app/workers/exports/export\_job.rb:16:in \`block in perform'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/lib/open\_project/locale\_helper.rb:36:in \`with\_locale\_for'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/app/models/user.rb:490:in \`execute\_as'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/app/workers/exports/export\_job.rb:14:in \`perform'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/activejob-7.0.8/lib/active\_job/execution.rb:65:in \`block in \_perform\_job'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/activesupport-7.0.8/lib/active\_support/callbacks.rb:118:in \`block in run\_callbacks'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/app/workers/application\_job.rb:102:in \`block in prepare\_job\_context'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/app/workers/application\_job.rb:79:in \`with\_clean\_request\_store'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/app/workers/application\_job.rb:98:in \`prepare\_job\_context'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/activesupport-7.0.8/lib/active\_support/callbacks.rb:127:in \`block in run\_callbacks'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/i18n-1.14.1/lib/i18n.rb:322:in \`with\_locale'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/activejob-7.0.8/lib/active\_job/translation.rb:9:in \`block (2 levels) in <module:Translation>'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/activesupport-7.0.8/lib/active\_support/callbacks.rb:127:in \`instance\_exec'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/activesupport-7.0.8/lib/active\_support/callbacks.rb:127:in \`block in run\_callbacks'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/activesupport-7.0.8/lib/active\_support/core\_ext/time/zones.rb:65:in \`use\_zone'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/activejob-7.0.8/lib/active\_job/timezones.rb:9:in \`block (2 levels) in <module:Timezones>'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/activesupport-7.0.8/lib/active\_support/callbacks.rb:127:in \`instance\_exec'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/activesupport-7.0.8/lib/active\_support/callbacks.rb:127:in \`block in run\_callbacks'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/activesupport-7.0.8/lib/active\_support/callbacks.rb:138:in \`run\_callbacks'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/activejob-7.0.8/lib/active\_job/execution.rb:64:in \`\_perform\_job'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/activejob-7.0.8/lib/active\_job/instrumentation.rb:20:in \`\_perform\_job'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/activejob-7.0.8/lib/active\_job/execution.rb:52:in \`perform\_now'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/activejob-7.0.8/lib/active\_job/instrumentation.rb:14:in \`block in perform\_now'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/activejob-7.0.8/lib/active\_job/instrumentation.rb:25:in \`block in instrument'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/activesupport-7.0.8/lib/active\_support/notifications.rb:206:in \`block in instrument'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/activesupport-7.0.8/lib/active\_support/notifications/instrumenter.rb:24:in \`instrument'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/activesupport-7.0.8/lib/active\_support/notifications.rb:206:in \`instrument'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/activejob-7.0.8/lib/active\_job/instrumentation.rb:35:in \`instrument'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/activejob-7.0.8/lib/active\_job/instrumentation.rb:14:in \`perform\_now'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/activejob-7.0.8/lib/active\_job/logging.rb:18:in \`block in perform\_now'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/activesupport-7.0.8/lib/active\_support/tagged\_logging.rb:99:in \`block in tagged'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/activesupport-7.0.8/lib/active\_support/tagged\_logging.rb:37:in \`tagged'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/activesupport-7.0.8/lib/active\_support/tagged\_logging.rb:99:in \`tagged'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/activejob-7.0.8/lib/active\_job/logging.rb:25:in \`tag\_logger'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/activejob-7.0.8/lib/active\_job/logging.rb:18:in \`perform\_now'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/activejob-7.0.8/lib/active\_job/execution.rb:30:in \`block in execute'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/activesupport-7.0.8/lib/active\_support/callbacks.rb:118:in \`block in run\_callbacks'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/activejob-7.0.8/lib/active\_job/railtie.rb:54:in \`block (4 levels) in <class:Railtie>'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/activesupport-7.0.8/lib/active\_support/execution\_wrapper.rb:92:in \`wrap'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/activesupport-7.0.8/lib/active\_support/reloader.rb:72:in \`block in wrap'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/activesupport-7.0.8/lib/active\_support/execution\_wrapper.rb:92:in \`wrap'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/activesupport-7.0.8/lib/active\_support/reloader.rb:71:in \`wrap'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/activejob-7.0.8/lib/active\_job/railtie.rb:53:in \`block (3 levels) in <class:Railtie>'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/activesupport-7.0.8/lib/active\_support/callbacks.rb:127:in \`instance\_exec'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/activesupport-7.0.8/lib/active\_support/callbacks.rb:127:in \`block in run\_callbacks'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/activesupport-7.0.8/lib/active\_support/callbacks.rb:138:in \`run\_callbacks'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/activejob-7.0.8/lib/active\_job/execution.rb:28:in \`execute'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/activejob-7.0.8/lib/active\_job/queue\_adapters/delayed\_job\_adapter.rb:47:in \`perform'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/delayed\_job-4.1.11/lib/delayed/backend/base.rb:81:in \`block in invoke\_job'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/delayed\_job-4.1.11/lib/delayed/lifecycle.rb:61:in \`block in initialize'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/delayed\_job-4.1.11/lib/delayed/lifecycle.rb:66:in \`execute'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/delayed\_job-4.1.11/lib/delayed/lifecycle.rb:40:in \`run\_callbacks'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/delayed\_job-4.1.11/lib/delayed/backend/base.rb:78:in \`invoke\_job'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/delayed\_job-4.1.11/lib/delayed/worker.rb:231:in \`block (2 levels) in run'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/timeout-0.4.1/lib/timeout.rb:186:in \`block in timeout'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/timeout-0.4.1/lib/timeout.rb:193:in \`timeout'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/delayed\_job-4.1.11/lib/delayed/worker.rb:231:in \`block in run'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/ruby-3.2.1/lib/ruby/3.2.0/benchmark.rb:311:in \`realtime'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/delayed\_job-4.1.11/lib/delayed/worker.rb:230:in \`run'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/delayed\_job-4.1.11/lib/delayed/worker.rb:313:in \`block in reserve\_and\_run\_one\_job'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/delayed\_job-4.1.11/lib/delayed/lifecycle.rb:61:in \`block in initialize'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/delayed\_job-4.1.11/lib/delayed/lifecycle.rb:66:in \`execute'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/delayed\_job-4.1.11/lib/delayed/lifecycle.rb:40:in \`run\_callbacks'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/delayed\_job-4.1.11/lib/delayed/worker.rb:313:in \`reserve\_and\_run\_one\_job'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/delayed\_job-4.1.11/lib/delayed/worker.rb:214:in \`block in work\_off'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/delayed\_job-4.1.11/lib/delayed/worker.rb:213:in \`times'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/delayed\_job-4.1.11/lib/delayed/worker.rb:213:in \`work\_off'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/delayed\_job-4.1.11/lib/delayed/worker.rb:176:in \`block (4 levels) in start'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/ruby-3.2.1/lib/ruby/3.2.0/benchmark.rb:311:in \`realtime'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/delayed\_job-4.1.11/lib/delayed/worker.rb:175:in \`block (3 levels) in start'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/delayed\_job-4.1.11/lib/delayed/lifecycle.rb:61:in \`block in initialize'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/delayed\_job-4.1.11/lib/delayed/lifecycle.rb:66:in \`execute'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/delayed\_job-4.1.11/lib/delayed/lifecycle.rb:40:in \`run\_callbacks'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/delayed\_job-4.1.11/lib/delayed/worker.rb:174:in \`block (2 levels) in start'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/delayed\_job-4.1.11/lib/delayed/worker.rb:173:in \`loop'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/delayed\_job-4.1.11/lib/delayed/worker.rb:173:in \`block in start'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/delayed\_job-4.1.11/lib/delayed/plugins/clear\_locks.rb:7:in \`block (2 levels) in <class:ClearLocks>'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/delayed\_job-4.1.11/lib/delayed/lifecycle.rb:79:in \`block (2 levels) in add'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/delayed\_job-4.1.11/lib/delayed/lifecycle.rb:61:in \`block in initialize'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/delayed\_job-4.1.11/lib/delayed/lifecycle.rb:79:in \`block in add'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/delayed\_job-4.1.11/lib/delayed/lifecycle.rb:66:in \`execute'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/delayed\_job-4.1.11/lib/delayed/lifecycle.rb:40:in \`run\_callbacks'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/delayed\_job-4.1.11/lib/delayed/worker.rb:172:in \`start'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/delayed\_job-4.1.11/lib/delayed/tasks.rb:9:in \`block (2 levels) in <top (required)>'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/rake-13.1.0/lib/rake/task.rb:281:in \`block in execute'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/rake-13.1.0/lib/rake/task.rb:281:in \`each'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/rake-13.1.0/lib/rake/task.rb:281:in \`execute'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/rake-13.1.0/lib/rake/task.rb:219:in \`block in invoke\_with\_call\_chain'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/rake-13.1.0/lib/rake/task.rb:199:in \`synchronize'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/rake-13.1.0/lib/rake/task.rb:199:in \`invoke\_with\_call\_chain'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/rake-13.1.0/lib/rake/task.rb:188:in \`invoke'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/rake-13.1.0/lib/rake/application.rb:182:in \`invoke\_task'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/rake-13.1.0/lib/rake/application.rb:138:in \`block (2 levels) in top\_level'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/rake-13.1.0/lib/rake/application.rb:138:in \`each'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/rake-13.1.0/lib/rake/application.rb:138:in \`block in top\_level'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/rake-13.1.0/lib/rake/application.rb:147:in \`run\_with\_threads'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/rake-13.1.0/lib/rake/application.rb:132:in \`top\_level'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/rake-13.1.0/lib/rake/application.rb:83:in \`block in run'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/rake-13.1.0/lib/rake/application.rb:208:in \`standard\_exception\_handling'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/rake-13.1.0/lib/rake/application.rb:80:in \`run'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/rake-13.1.0/exe/rake:27:in \`<top (required)>'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/bin/rake:25:in \`load'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/bin/rake:25:in \`<top (required)>'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/ruby-3.2.1/lib/ruby/3.2.0/bundler/cli/exec.rb:58:in \`load'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/ruby-3.2.1/lib/ruby/3.2.0/bundler/cli/exec.rb:58:in \`kernel\_load'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/ruby-3.2.1/lib/ruby/3.2.0/bundler/cli/exec.rb:23:in \`run'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/ruby-3.2.1/lib/ruby/3.2.0/bundler/cli.rb:491:in \`exec'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/ruby-3.2.1/lib/ruby/3.2.0/bundler/vendor/thor/lib/thor/command.rb:27:in \`run'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/ruby-3.2.1/lib/ruby/3.2.0/bundler/vendor/thor/lib/thor/invocation.rb:127:in \`invoke\_command'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/ruby-3.2.1/lib/ruby/3.2.0/bundler/vendor/thor/lib/thor.rb:392:in \`dispatch'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/ruby-3.2.1/lib/ruby/3.2.0/bundler/cli.rb:34:in \`dispatch'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/ruby-3.2.1/lib/ruby/3.2.0/bundler/vendor/thor/lib/thor/base.rb:485:in \`start'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/ruby-3.2.1/lib/ruby/3.2.0/bundler/cli.rb:28:in \`start'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/ruby-3.2.1/lib/ruby/gems/3.2.0/gems/bundler-2.4.6/libexec/bundle:45:in \`block in <top (required)>'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/ruby-3.2.1/lib/ruby/3.2.0/bundler/friendly\_errors.rb:117:in \`with\_friendly\_errors'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/ruby-3.2.1/lib/ruby/gems/3.2.0/gems/bundler-2.4.6/libexec/bundle:33:in \`<top (required)>'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/bin/bundle:110:in \`load'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/bin/bundle:110:in \`<main>'
* Create a project with work packages, time and costs modules active
* Create a work package, log time with empty activity
* Create a cost report with that activity, hit export XLS
I have a problem with generating the report from December 14th, it displays an error as below. The same report generated from other days does not have this error. I don't see anything particularly different in the content of the report between days.
Dec 18 18:51:31 openproject openproject-web-1.service\[336221\]: I, \[2023-12-18T18:51:31.240478 #336221\] INFO -- : \[f5834bf3-6548-4cc2-b574-52383c1b8025\] duration=5.89 db=2.35 view=3.54 status=200 method=GET path=/api/v3/job\_statuses/d8fbfacf-6f46-4027-a166-e427d20f4e51 params={} host=xxx.xxx.pl user=3
Dec 18 18:51:31 openproject openproject-web-1.service\[336221\]: I, \[2023-12-18T18:51:31.245891 #336221\] INFO -- : \[3bc62838-2861-4f6e-8ed6-6faeb03a368e\] duration=9.89 db=3.28 view=6.61 status=302 method=GET path=/api/v3/users/3/avatar params={} host=xxxx user=3
Dec 18 18:51:31 openproject openproject-web-1.service\[336227\]: I, \[2023-12-18T18:51:31.245921 #336227\] INFO -- : \[bf181a3c-4beb-4541-90d3-bf2afbd5be69\] duration=11.37 db=3.84 view=7.53 status=200 method=GET path=/api/v3/notifications params={"pageSize"=>"0", "filters"=>"\[{\\"readIAN\\":{\\"operator\\":\\"=\\",\\"values\\":\[\\"f\\"\]}}\]"} host=xxxx user=3
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: I, \[2023-12-18T18:51:31.228828 #336202\] INFO -- : \[ActiveJob\] \[CostQuery::ExportJob\] \[d8fbfacf-6f46-4027-a166-e427d20f4e51\] Performing CostQuery::ExportJob (Job ID: d8fbfacf-6f46-4027-a166-e427d20f4e51) from DelayedJob(default) enqueued at 2023-12-18T17:51:29Z
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: E, \[2023-12-18T18:51:31.280269 #336202\] ERROR -- : \[ActiveJob\] \[CostQuery::ExportJob\] \[d8fbfacf-6f46-4027-a166-e427d20f4e51\] Failed to run export job for OpenProject Admin: Couldn't find Enumeration with 'id'=0
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: E, \[2023-12-18T18:51:31.280459 #336202\] ERROR -- : \[ActiveJob\] \[CostQuery::ExportJob\] \[d8fbfacf-6f46-4027-a166-e427d20f4e51\] Error performing CostQuery::ExportJob (Job ID: d8fbfacf-6f46-4027-a166-e427d20f4e51) from DelayedJob(default) in 55.36ms: ActiveRecord::RecordNotFound (Couldn't find Enumeration with 'id'=0):
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/activerecord-7.0.8/lib/active\_record/relation/finder\_methods.rb:381:in \`raise\_record\_not\_found\_exception!'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/activerecord-7.0.8/lib/active\_record/relation/finder\_methods.rb:475:in \`find\_one'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/activerecord-7.0.8/lib/active\_record/relation/finder\_methods.rb:457:in \`find\_with\_ids'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/activerecord-7.0.8/lib/active\_record/relation/finder\_methods.rb:69:in \`find'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/activerecord-7.0.8/lib/active\_record/querying.rb:22:in \`find'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/activerecord-7.0.8/lib/active\_record/core.rb:271:in \`find'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/modules/reporting/app/helpers/reporting\_helper.rb:48:in \`mapped'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/modules/xls\_export/lib/open\_project/xls\_export/xls\_views.rb:15:in \`field\_representation\_map'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/modules/reporting/app/helpers/reporting\_helper.rb:83:in \`show\_field'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/modules/reporting/lib/open\_project/reporting/cost\_entry\_xls\_table.rb:59:in \`block in cost\_row'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/modules/reporting/lib/open\_project/reporting/cost\_entry\_xls\_table.rb:59:in \`map'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/modules/reporting/lib/open\_project/reporting/cost\_entry\_xls\_table.rb:59:in \`cost\_row'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/modules/reporting/lib/open\_project/reporting/cost\_entry\_xls\_table.rb:44:in \`block in build\_cost\_rows'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/modules/reporting/lib/open\_project/reporting/cost\_entry\_xls\_table.rb:43:in \`each'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/modules/reporting/lib/open\_project/reporting/cost\_entry\_xls\_table.rb:43:in \`build\_cost\_rows'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/modules/reporting/lib/open\_project/reporting/cost\_entry\_xls\_table.rb:32:in \`build\_spreadsheet'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/modules/reporting/lib/open\_project/reporting/cost\_entry\_xls\_table.rb:10:in \`block in generate'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/modules/reporting/lib/open\_project/reporting/cost\_entry\_xls\_table.rb:6:in \`each'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/modules/reporting/lib/open\_project/reporting/cost\_entry\_xls\_table.rb:6:in \`each\_with\_index'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/modules/reporting/lib/open\_project/reporting/cost\_entry\_xls\_table.rb:6:in \`generate'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/modules/xls\_export/lib/open\_project/xls\_export/xls\_views.rb:54:in \`generate'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/modules/reporting/app/workers/cost\_query/export\_job.rb:32:in \`xls\_report\_result'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/modules/reporting/app/workers/cost\_query/export\_job.rb:27:in \`export!'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/app/workers/exports/export\_job.rb:16:in \`block in perform'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/lib/open\_project/locale\_helper.rb:36:in \`with\_locale\_for'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/app/models/user.rb:490:in \`execute\_as'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/app/workers/exports/export\_job.rb:14:in \`perform'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/activejob-7.0.8/lib/active\_job/execution.rb:65:in \`block in \_perform\_job'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/activesupport-7.0.8/lib/active\_support/callbacks.rb:118:in \`block in run\_callbacks'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/app/workers/application\_job.rb:102:in \`block in prepare\_job\_context'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/app/workers/application\_job.rb:79:in \`with\_clean\_request\_store'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/app/workers/application\_job.rb:98:in \`prepare\_job\_context'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/activesupport-7.0.8/lib/active\_support/callbacks.rb:127:in \`block in run\_callbacks'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/i18n-1.14.1/lib/i18n.rb:322:in \`with\_locale'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/activejob-7.0.8/lib/active\_job/translation.rb:9:in \`block (2 levels) in <module:Translation>'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/activesupport-7.0.8/lib/active\_support/callbacks.rb:127:in \`instance\_exec'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/activesupport-7.0.8/lib/active\_support/callbacks.rb:127:in \`block in run\_callbacks'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/activesupport-7.0.8/lib/active\_support/core\_ext/time/zones.rb:65:in \`use\_zone'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/activejob-7.0.8/lib/active\_job/timezones.rb:9:in \`block (2 levels) in <module:Timezones>'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/activesupport-7.0.8/lib/active\_support/callbacks.rb:127:in \`instance\_exec'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/activesupport-7.0.8/lib/active\_support/callbacks.rb:127:in \`block in run\_callbacks'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/activesupport-7.0.8/lib/active\_support/callbacks.rb:138:in \`run\_callbacks'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/activejob-7.0.8/lib/active\_job/execution.rb:64:in \`\_perform\_job'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/activejob-7.0.8/lib/active\_job/instrumentation.rb:20:in \`\_perform\_job'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/activejob-7.0.8/lib/active\_job/execution.rb:52:in \`perform\_now'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/activejob-7.0.8/lib/active\_job/instrumentation.rb:14:in \`block in perform\_now'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/activejob-7.0.8/lib/active\_job/instrumentation.rb:25:in \`block in instrument'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/activesupport-7.0.8/lib/active\_support/notifications.rb:206:in \`block in instrument'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/activesupport-7.0.8/lib/active\_support/notifications/instrumenter.rb:24:in \`instrument'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/activesupport-7.0.8/lib/active\_support/notifications.rb:206:in \`instrument'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/activejob-7.0.8/lib/active\_job/instrumentation.rb:35:in \`instrument'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/activejob-7.0.8/lib/active\_job/instrumentation.rb:14:in \`perform\_now'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/activejob-7.0.8/lib/active\_job/logging.rb:18:in \`block in perform\_now'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/activesupport-7.0.8/lib/active\_support/tagged\_logging.rb:99:in \`block in tagged'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/activesupport-7.0.8/lib/active\_support/tagged\_logging.rb:37:in \`tagged'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/activesupport-7.0.8/lib/active\_support/tagged\_logging.rb:99:in \`tagged'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/activejob-7.0.8/lib/active\_job/logging.rb:25:in \`tag\_logger'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/activejob-7.0.8/lib/active\_job/logging.rb:18:in \`perform\_now'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/activejob-7.0.8/lib/active\_job/execution.rb:30:in \`block in execute'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/activesupport-7.0.8/lib/active\_support/callbacks.rb:118:in \`block in run\_callbacks'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/activejob-7.0.8/lib/active\_job/railtie.rb:54:in \`block (4 levels) in <class:Railtie>'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/activesupport-7.0.8/lib/active\_support/execution\_wrapper.rb:92:in \`wrap'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/activesupport-7.0.8/lib/active\_support/reloader.rb:72:in \`block in wrap'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/activesupport-7.0.8/lib/active\_support/execution\_wrapper.rb:92:in \`wrap'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/activesupport-7.0.8/lib/active\_support/reloader.rb:71:in \`wrap'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/activejob-7.0.8/lib/active\_job/railtie.rb:53:in \`block (3 levels) in <class:Railtie>'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/activesupport-7.0.8/lib/active\_support/callbacks.rb:127:in \`instance\_exec'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/activesupport-7.0.8/lib/active\_support/callbacks.rb:127:in \`block in run\_callbacks'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/activesupport-7.0.8/lib/active\_support/callbacks.rb:138:in \`run\_callbacks'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/activejob-7.0.8/lib/active\_job/execution.rb:28:in \`execute'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/activejob-7.0.8/lib/active\_job/queue\_adapters/delayed\_job\_adapter.rb:47:in \`perform'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/delayed\_job-4.1.11/lib/delayed/backend/base.rb:81:in \`block in invoke\_job'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/delayed\_job-4.1.11/lib/delayed/lifecycle.rb:61:in \`block in initialize'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/delayed\_job-4.1.11/lib/delayed/lifecycle.rb:66:in \`execute'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/delayed\_job-4.1.11/lib/delayed/lifecycle.rb:40:in \`run\_callbacks'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/delayed\_job-4.1.11/lib/delayed/backend/base.rb:78:in \`invoke\_job'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/delayed\_job-4.1.11/lib/delayed/worker.rb:231:in \`block (2 levels) in run'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/timeout-0.4.1/lib/timeout.rb:186:in \`block in timeout'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/timeout-0.4.1/lib/timeout.rb:193:in \`timeout'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/delayed\_job-4.1.11/lib/delayed/worker.rb:231:in \`block in run'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/ruby-3.2.1/lib/ruby/3.2.0/benchmark.rb:311:in \`realtime'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/delayed\_job-4.1.11/lib/delayed/worker.rb:230:in \`run'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/delayed\_job-4.1.11/lib/delayed/worker.rb:313:in \`block in reserve\_and\_run\_one\_job'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/delayed\_job-4.1.11/lib/delayed/lifecycle.rb:61:in \`block in initialize'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/delayed\_job-4.1.11/lib/delayed/lifecycle.rb:66:in \`execute'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/delayed\_job-4.1.11/lib/delayed/lifecycle.rb:40:in \`run\_callbacks'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/delayed\_job-4.1.11/lib/delayed/worker.rb:313:in \`reserve\_and\_run\_one\_job'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/delayed\_job-4.1.11/lib/delayed/worker.rb:214:in \`block in work\_off'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/delayed\_job-4.1.11/lib/delayed/worker.rb:213:in \`times'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/delayed\_job-4.1.11/lib/delayed/worker.rb:213:in \`work\_off'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/delayed\_job-4.1.11/lib/delayed/worker.rb:176:in \`block (4 levels) in start'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/ruby-3.2.1/lib/ruby/3.2.0/benchmark.rb:311:in \`realtime'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/delayed\_job-4.1.11/lib/delayed/worker.rb:175:in \`block (3 levels) in start'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/delayed\_job-4.1.11/lib/delayed/lifecycle.rb:61:in \`block in initialize'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/delayed\_job-4.1.11/lib/delayed/lifecycle.rb:66:in \`execute'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/delayed\_job-4.1.11/lib/delayed/lifecycle.rb:40:in \`run\_callbacks'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/delayed\_job-4.1.11/lib/delayed/worker.rb:174:in \`block (2 levels) in start'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/delayed\_job-4.1.11/lib/delayed/worker.rb:173:in \`loop'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/delayed\_job-4.1.11/lib/delayed/worker.rb:173:in \`block in start'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/delayed\_job-4.1.11/lib/delayed/plugins/clear\_locks.rb:7:in \`block (2 levels) in <class:ClearLocks>'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/delayed\_job-4.1.11/lib/delayed/lifecycle.rb:79:in \`block (2 levels) in add'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/delayed\_job-4.1.11/lib/delayed/lifecycle.rb:61:in \`block in initialize'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/delayed\_job-4.1.11/lib/delayed/lifecycle.rb:79:in \`block in add'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/delayed\_job-4.1.11/lib/delayed/lifecycle.rb:66:in \`execute'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/delayed\_job-4.1.11/lib/delayed/lifecycle.rb:40:in \`run\_callbacks'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/delayed\_job-4.1.11/lib/delayed/worker.rb:172:in \`start'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/delayed\_job-4.1.11/lib/delayed/tasks.rb:9:in \`block (2 levels) in <top (required)>'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/rake-13.1.0/lib/rake/task.rb:281:in \`block in execute'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/rake-13.1.0/lib/rake/task.rb:281:in \`each'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/rake-13.1.0/lib/rake/task.rb:281:in \`execute'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/rake-13.1.0/lib/rake/task.rb:219:in \`block in invoke\_with\_call\_chain'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/rake-13.1.0/lib/rake/task.rb:199:in \`synchronize'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/rake-13.1.0/lib/rake/task.rb:199:in \`invoke\_with\_call\_chain'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/rake-13.1.0/lib/rake/task.rb:188:in \`invoke'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/rake-13.1.0/lib/rake/application.rb:182:in \`invoke\_task'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/rake-13.1.0/lib/rake/application.rb:138:in \`block (2 levels) in top\_level'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/rake-13.1.0/lib/rake/application.rb:138:in \`each'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/rake-13.1.0/lib/rake/application.rb:138:in \`block in top\_level'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/rake-13.1.0/lib/rake/application.rb:147:in \`run\_with\_threads'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/rake-13.1.0/lib/rake/application.rb:132:in \`top\_level'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/rake-13.1.0/lib/rake/application.rb:83:in \`block in run'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/rake-13.1.0/lib/rake/application.rb:208:in \`standard\_exception\_handling'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/rake-13.1.0/lib/rake/application.rb:80:in \`run'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/gems/rake-13.1.0/exe/rake:27:in \`<top (required)>'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/bin/rake:25:in \`load'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/bundle/ruby/3.2.0/bin/rake:25:in \`<top (required)>'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/ruby-3.2.1/lib/ruby/3.2.0/bundler/cli/exec.rb:58:in \`load'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/ruby-3.2.1/lib/ruby/3.2.0/bundler/cli/exec.rb:58:in \`kernel\_load'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/ruby-3.2.1/lib/ruby/3.2.0/bundler/cli/exec.rb:23:in \`run'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/ruby-3.2.1/lib/ruby/3.2.0/bundler/cli.rb:491:in \`exec'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/ruby-3.2.1/lib/ruby/3.2.0/bundler/vendor/thor/lib/thor/command.rb:27:in \`run'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/ruby-3.2.1/lib/ruby/3.2.0/bundler/vendor/thor/lib/thor/invocation.rb:127:in \`invoke\_command'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/ruby-3.2.1/lib/ruby/3.2.0/bundler/vendor/thor/lib/thor.rb:392:in \`dispatch'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/ruby-3.2.1/lib/ruby/3.2.0/bundler/cli.rb:34:in \`dispatch'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/ruby-3.2.1/lib/ruby/3.2.0/bundler/vendor/thor/lib/thor/base.rb:485:in \`start'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/ruby-3.2.1/lib/ruby/3.2.0/bundler/cli.rb:28:in \`start'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/ruby-3.2.1/lib/ruby/gems/3.2.0/gems/bundler-2.4.6/libexec/bundle:45:in \`block in <top (required)>'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/ruby-3.2.1/lib/ruby/3.2.0/bundler/friendly\_errors.rb:117:in \`with\_friendly\_errors'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/vendor/ruby-3.2.1/lib/ruby/gems/3.2.0/gems/bundler-2.4.6/libexec/bundle:33:in \`<top (required)>'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/bin/bundle:110:in \`load'
Dec 18 18:51:31 openproject openproject-worker-1.service\[336202\]: /opt/openproject/bin/bundle:110:in \`<main>'