This bug has been migrated to another issue tracking site. It has been closed here and may no longer be being monitored.

If you would like to get updates for this issue, or to participate in it, you may do so at Red Hat Issue Tracker .
RHEL Engineering is moving the tracking of its product development work on RHEL 6 through RHEL 9 to Red Hat Jira (issues.redhat.com). If you're a Red Hat customer, please continue to file support cases via the Red Hat customer portal. If you're not, please head to the "RHEL project" in Red Hat Jira and file new tickets here. Individual Bugzilla bugs in the statuses "NEW", "ASSIGNED", and "POST" are being migrated throughout September 2023. Bugs of Red Hat partners with an assigned Engineering Partner Manager (EPM) are migrated in late September as per pre-agreed dates. Bugs against components "kernel", "kernel-rt", and "kpatch" are only migrated if still in "NEW" or "ASSIGNED". If you cannot log in to RH Jira, please consult article #7032570. That failing, please send an e-mail to the RH Jira admins at rh-issues@redhat.com to troubleshoot your issue as a user management inquiry. The email creates a ServiceNow ticket with Red Hat. Individual Bugzilla bugs that are migrated will be moved to status "CLOSED", resolution "MIGRATED", and set with "MigratedToJIRA" in "Keywords". The link to the successor Jira issue will be found under "Links", have a little "two-footprint" icon next to it, and direct you to the "RHEL project" in Red Hat Jira (issue links are of type "https://issues.redhat.com/browse/RHEL-XXXX", where "X" is a digit). This same link will be available in a blue banner at the top of the page informing you that that bug has been migrated.
Bug 2097342 - osbuild-composer: corrupted state data ("job does not exist")
Summary: osbuild-composer: corrupted state data ("job does not exist")
Keywords:
Status: CLOSED MIGRATED
Alias: None
Product: Red Hat Enterprise Linux 8
Classification: Red Hat
Component: osbuild-composer
Version: 8.6
Hardware: Unspecified
OS: Unspecified
high
high
Target Milestone: rc
: ---
Assignee: Image Builder team
QA Contact: Release Test Team
Eliane Ramos Pereira
URL:
Whiteboard:
Depends On:
Blocks:
TreeView+ depends on / blocked
 
Reported: 2022-06-15 13:29 UTC by Christophe Besson
Modified: 2023-09-18 12:27 UTC (History)
4 users (show)

Fixed In Version:
Doc Type: If docs needed, set a value
Doc Text:
Clone Of:
Environment:
Last Closed: 2023-09-18 12:25:39 UTC
Type: Bug
Target Upstream Version:
Embargoed:

Attachments (Terms of Use)


Links
System ID Private Priority Status Summary Last Updated
Red Hat Issue Tracker   RHEL-4574 0 None Migrated None 2023-09-18 12:25:34 UTC
Red Hat Issue Tracker RHELPLAN-125351 0 None None None 2022-06-15 13:37:41 UTC

Description Christophe Besson 2022-06-15 13:29:58 UTC 
Description of problem:
For an unexpected reason, `composer-cli compose status` fails and the daemon shows a traceback without much details except a "job does not exist".

Version-Release number of selected component (if applicable):
osbuild-composer-46.3-1.el8_6

How reproducible:
Always from the osbuild-composer/{state.json,jobs} customer data.

Steps to Reproduce:
1. On a fresh RHEL 8.6, unpack the tarball into /var/lib/osbuild-composer
2. Restart the composer daemon
3. Run a `composer-cli compose status`

Actual results:
1/ Output
ERROR: List Error: Get "http://localhost/api/v1/compose/queue": EOF

2/ composer logs:
Jun 15 10:05:29 localhost.localdomain osbuild-composer[84194]: 2022/06/15 10:05:29 GET /api/v1/compose/queue
Jun 15 10:05:29 localhost.localdomain osbuild-composer[84194]: 2022/06/15 10:05:29 http: panic serving @: job does not exist
Jun 15 10:05:29 localhost.localdomain osbuild-composer[84194]: goroutine 30 [running]:
Jun 15 10:05:29 localhost.localdomain osbuild-composer[84194]: net/http.(*conn).serve.func1()
Jun 15 10:05:29 localhost.localdomain osbuild-composer[84194]:         /usr/lib/golang/src/net/http/server.go:1802 +0xb9
Jun 15 10:05:29 localhost.localdomain osbuild-composer[84194]: panic({0x56375d99b0e0, 0xc000329530})
Jun 15 10:05:29 localhost.localdomain osbuild-composer[84194]:         /usr/lib/golang/src/runtime/panic.go:1047 +0x266
Jun 15 10:05:29 localhost.localdomain osbuild-composer[84194]: github.com/osbuild/osbuild-composer/internal/weldr.(*API).getComposeStatus(0xc000437d40, {0xc0005221b0, {0x0, {0x56375dae1ee0,>
Jun 15 10:05:29 localhost.localdomain osbuild-composer[84194]:         /builddir/build/BUILD/osbuild-composer-46.3/_build/src/github.com/osbuild/osbuild-composer/internal/weldr/api.go:350 +>
Jun 15 10:05:29 localhost.localdomain osbuild-composer[84194]: github.com/osbuild/osbuild-composer/internal/weldr.(*API).composeQueueHandler(0xc000437d40, {0x56375dac59e8, 0xc00024c000}, 0x>
Jun 15 10:05:29 localhost.localdomain osbuild-composer[84194]:         /builddir/build/BUILD/osbuild-composer-46.3/_build/src/github.com/osbuild/osbuild-composer/internal/weldr/api.go:2573 >
Jun 15 10:05:29 localhost.localdomain osbuild-composer[84194]: github.com/julienschmidt/httprouter.(*Router).ServeHTTP(0xc000096de0, {0x56375dac59e8, 0xc00024c000}, 0xc000218100)
Jun 15 10:05:29 localhost.localdomain osbuild-composer[84194]:         /builddir/build/BUILD/osbuild-composer-46.3/_build/src/github.com/osbuild/osbuild-composer/vendor/github.com/juliensch>
Jun 15 10:05:29 localhost.localdomain osbuild-composer[84194]: github.com/osbuild/osbuild-composer/internal/weldr.(*API).ServeHTTP(0xc000437d40, {0x56375dac59e8, 0xc00024c000}, 0xc000218100)
Jun 15 10:05:29 localhost.localdomain osbuild-composer[84194]:         /builddir/build/BUILD/osbuild-composer-46.3/_build/src/github.com/osbuild/osbuild-composer/internal/weldr/api.go:285 +>
Jun 15 10:05:29 localhost.localdomain osbuild-composer[84194]: net/http.serverHandler.ServeHTTP({0xc0002e4090}, {0x56375dac59e8, 0xc00024c000}, 0xc000218100)
Jun 15 10:05:29 localhost.localdomain osbuild-composer[84194]:         /usr/lib/golang/src/net/http/server.go:2879 +0x43b
Jun 15 10:05:29 localhost.localdomain osbuild-composer[84194]: net/http.(*conn).serve(0xc00022a000, {0x56375dacccd0, 0xc0001d5d10})
Jun 15 10:05:29 localhost.localdomain osbuild-composer[84194]:         /usr/lib/golang/src/net/http/server.go:1930 +0xb08
Jun 15 10:05:29 localhost.localdomain osbuild-composer[84194]: created by net/http.(*Server).Serve
Jun 15 10:05:29 localhost.localdomain osbuild-composer[84194]:         /usr/lib/golang/src/net/http/server.go:3034 +0x4e8


Additional info:
* stracing the issue, it seems a json file corresponding to a jobId is missing in /var/lib/osbuild-composer/jobs

84197 10:05:29.778722 openat(AT_FDCWD, "/var/lib/osbuild-composer/jobs/ca461a0c-2e45-40b1-8b53-8a09bbf7f9a9.json", O_RDONLY|O_CLOEXEC <unfinished ...>
 :
84197 10:05:29.779580 <... openat resumed>) = -1 ENOENT (No such file or directory) <0.000836>
 :
84197 10:05:29.780068 write(2<UNIX:[8049596->8049597]>, "2022/06/15 10:05:29 http: panic serving @: job does not exist\ngoroutine 30 [running]:\nnet/http.(*conn).serve.func1()\n\t/usr/lib/golang/src/net/http/server.go:1802 +0xb9\npanic({0x56375d99b0e0, 0xc000329530})\n\t/usr/lib/golang/src/runtime/panic.go:1047 +0x266\ngithub.com/osbuild/osbuild-composer/internal/weldr.(*API).getComposeStatus(0xc000437d40, {0xc0005221b0, {0x0, {0x56375dae1ee0, 0xc0003da870}, {0xc000480000, 0x3535b, 0x36000}, {0x0, 0x0, ...}, ...}, ...})\n\t/builddir/build/BUILD/osbuild-composer-46.3/_build/src/github.com/osbuild/osbuild-composer/internal/weldr/api.go:350 +0x2cd\ngithub.com/osbuild/osbuild-composer/internal/weldr.(*API).composeQueueHandler(0xc000437d40, {0x56375dac59e8, 0xc00024c000}, 0xc00064a03a, {0xc0001b6280, 0x1, 0x4})\n\t/builddir/build/BUILD/osbuild-composer-46.3/_build/src/github.com/osbuild/osbuild-composer/internal/weldr/api.go:2573 +0x1c5\ngithub.com/julienschmidt/httprouter.(*Router).ServeHTTP(0xc000096de0, {0x56375dac59e8, 0xc00024c000}, 0xc000218100)\n\t/builddir/build/BUILD/osbuild-composer-46.3/_build/src/github.com/osbuild/osbuild-composer/vendor/github.com/julienschmidt/httprouter/router.go:387 +0x84b\ngithub.com/osbuild/osbuild-composer/internal/weldr.(*API).ServeHTTP(0xc000437d40, {0x56375dac59e8, 0xc00024c000}, 0xc000218100)\n\t/builddir/build/BUILD/osbuild-composer-46.3/_build/src/github.com/osbuild/osbuild-composer/internal/weldr/api.go:285 +0x172\nnet/http.serverHandler.ServeHTTP({0xc0002e4090}, {0x56375dac59e8, 0xc00024c000}, 0xc000218100)\n\t/usr/lib/golang/src/net/http/server.go:2879 +0x43b\nnet/http.(*conn).serve(0xc00022a000, {0x56375dacccd0, 0xc0001d5d10})\n\t/usr/lib/golang/src/net/http/server.go:1930 +0xb08\ncreated by net/http.(*Server).Serve\n\t/usr/lib/golang/src/net/http/server.go:3034 +0x4e8\n", 1757 <unfinished ...>
84196 10:05:29.780103 futex(0xc000088150, FUTEX_WAKE_PRIVATE, 1 <unfinished ...>

* once this issue was fixed manually, I noticed another job was causing the same issue

* the 2 *compose-uuid* involved in this issue are: 0172feb8-ab86-45e0-b3dc-33f2a5252d75 and 2d9993e7-beb6-4da2-97ac-50fc9cc758bd

* to fix this issue, I replaced the faulty jobIds by an existing one in state.json and then I ran a composer-cli compose delete <COMPOSE-UUID>. Note this process is very laborious and cannot be suggested as a workaround.

* the only workaround we can offer for now is to delete all the content from /var/lib/osbuild-composer/* and restart the daemons. Hence raising the issue as high.
Comment 2 Christophe Besson 2022-06-15 13:33:23 UTC 
I forgot to tell they upgraded their version from el8.5 a few days ago, but I'm not sure it could be the root cause.
I downgraded osbuild* to the el8.5 versions and I got the same traceback (composer-cli output differs though)
Comment 4 RHEL Program Management 2023-09-18 12:23:51 UTC 
Issue migration from Bugzilla to Jira is in process at this time. This will be the last message in Jira copied from the Bugzilla bug.
Comment 5 RHEL Program Management 2023-09-18 12:25:39 UTC 
This BZ has been automatically migrated to the issues.redhat.com Red Hat Issue Tracker. All future work related to this report will be managed there.

Due to differences in account names between systems, some fields were not replicated.  Be sure to add yourself to Jira issue's "Watchers" field to continue receiving updates and add others to the "Need Info From" field to continue requesting information.

To find the migrated issue, look in the "Links" section for a direct link to the new issue location. The issue key will have an icon of 2 footprints next to it, and begin with "RHEL-" followed by an integer.  You can also find this issue by visiting https://issues.redhat.com/issues/?jql= and searching the "Bugzilla Bug" field for this BZ's number, e.g. a search like:

"Bugzilla Bug" = 1234567

In the event you have trouble locating or viewing this issue, you can file an issue by sending mail to rh-issues. You can also visit https://access.redhat.com/articles/7032570 for general account information.
Note You need to log in before you can comment on or make changes to this bug.