Hi, I have another case where I didn’t get notifications:
grep -R "task 101"
standard.log:2022-10-13T09:06:55.247189329+02:00: DEBUG ▶ models/Handle 724c Sending task assigned notifications to 0 subscribers for task 101
while in the UI it has assigned to me:
What else I can provide to debug the issue?
NOTE: This i what I have for now:
grep "/101" http.log
2022-10-13T09:06:16.431072017+02:00: WEB ▶ $IP OPTIONS 204 /api/v1/tasks/101 26.279µs - Mozilla/5.0 (Macintosh; Intel Mac OS X 10.15; rv:105.0) Gecko/20100101 Firefox/105.0
2022-10-13T09:06:16.431116531+02:00: WEB ▶ $IP OPTIONS 204 /api/v1/tasks/101/comments?page=1 40.776µs - Mozilla/5.0 (Macintosh; Intel Mac OS X 10.15; rv:105.0) Gecko/20100101 Firefox/105.0
2022-10-13T09:06:16.707982341+02:00: WEB ▶ $IP GET 200 /api/v1/tasks/101/comments?page=1 5.5427ms - Mozilla/5.0 (Macintosh; Intel Mac OS X 10.15; rv:105.0) Gecko/20100101 Firefox/105.0
2022-10-13T09:06:16.710810731+02:00: WEB ▶ $IP GET 200 /api/v1/tasks/101 8.715834ms - Mozilla/5.0 (Macintosh; Intel Mac OS X 10.15; rv:105.0) Gecko/20100101 Firefox/105.0
2022-10-13T09:06:23.189237366+02:00: WEB ▶ $IP OPTIONS 204 /api/v1/tasks/101 38.541µs - Mozilla/5.0 (Macintosh; Intel Mac OS X 10.15; rv:105.0) Gecko/20100101 Firefox/105.0
2022-10-13T09:06:23.219221758+02:00: WEB ▶ $IP POST 200 /api/v1/tasks/101 10.498331ms - Mozilla/5.0 (Macintosh; Intel Mac OS X 10.15; rv:105.0) Gecko/20100101 Firefox/105.0
2022-10-13T09:06:24.956039196+02:00: WEB ▶ $IP POST 200 /api/v1/tasks/101 8.743073ms - Mozilla/5.0 (Macintosh; Intel Mac OS X 10.15; rv:105.0) Gecko/20100101 Firefox/105.0
2022-10-13T09:06:29.303795352+02:00: WEB ▶ $IP OPTIONS 204 /api/v1/tasks/101 30.557µs - Mozilla/5.0 (Macintosh; Intel Mac OS X 10.15; rv:105.0) Gecko/20100101 Firefox/105.0
2022-10-13T09:06:29.331971709+02:00: WEB ▶ $IP POST 200 /api/v1/tasks/101 9.562534ms - Mozilla/5.0 (Macintosh; Intel Mac OS X 10.15; rv:105.0) Gecko/20100101 Firefox/105.0
2022-10-13T09:06:30.019190253+02:00: WEB ▶ $IP POST 200 /api/v1/tasks/101 8.194669ms - Mozilla/5.0 (Macintosh; Intel Mac OS X 10.15; rv:105.0) Gecko/20100101 Firefox/105.0
2022-10-13T09:06:34.733162331+02:00: WEB ▶ $IP OPTIONS 204 /api/v1/tasks/101 39.343µs - Mozilla/5.0 (Macintosh; Intel Mac OS X 10.15; rv:105.0) Gecko/20100101 Firefox/105.0
2022-10-13T09:06:34.761995414+02:00: WEB ▶ $IP POST 200 /api/v1/tasks/101 9.408367ms - Mozilla/5.0 (Macintosh; Intel Mac OS X 10.15; rv:105.0) Gecko/20100101 Firefox/105.0
2022-10-13T09:06:40.699308138+02:00: WEB ▶ $IP OPTIONS 204 /api/v1/tasks/101 33.603µs - Mozilla/5.0 (Macintosh; Intel Mac OS X 10.15; rv:105.0) Gecko/20100101 Firefox/105.0
2022-10-13T09:06:40.963698216+02:00: WEB ▶ $IP OPTIONS 204 /api/v1/tasks/101 39.543µs - Mozilla/5.0 (Macintosh; Intel Mac OS X 10.15; rv:105.0) Gecko/20100101 Firefox/105.0
2022-10-13T09:06:40.972666959+02:00: WEB ▶ $IP POST 200 /api/v1/tasks/101 9.545159ms - Mozilla/5.0 (Macintosh; Intel Mac OS X 10.15; rv:105.0) Gecko/20100101 Firefox/105.0
2022-10-13T09:06:40.993383134+02:00: WEB ▶ $IP POST 200 /api/v1/tasks/101 7.797057ms - Mozilla/5.0 (Macintosh; Intel Mac OS X 10.15; rv:105.0) Gecko/20100101 Firefox/105.0
2022-10-13T09:06:51.651770957+02:00: WEB ▶ $IP OPTIONS 204 /api/v1/tasks/101 37.65µs - Mozilla/5.0 (Macintosh; Intel Mac OS X 10.15; rv:105.0) Gecko/20100101 Firefox/105.0
2022-10-13T09:06:51.93403377+02:00: WEB ▶ $IP POST 200 /api/v1/tasks/101 7.71899ms - Mozilla/5.0 (Macintosh; Intel Mac OS X 10.15; rv:105.0) Gecko/20100101 Firefox/105.0
2022-10-13T09:06:55.218668329+02:00: WEB ▶ $IP OPTIONS 204 /api/v1/tasks/101/assignees 33.843µs - Mozilla/5.0 (Macintosh; Intel Mac OS X 10.15; rv:105.0) Gecko/20100101 Firefox/105.0
2022-10-13T09:06:55.246634341+02:00: WEB ▶ $IP PUT 201 /api/v1/tasks/101/assignees 9.461194ms - Mozilla/5.0 (Macintosh; Intel Mac OS X 10.15; rv:105.0) Gecko/20100101 Firefox/105.0
2022-10-13T09:06:56.856865051+02:00: WEB ▶ $IP OPTIONS 204 /api/v1/subscriptions/task/101 48.601µs - Mozilla/5.0 (Macintosh; Intel Mac OS X 10.15; rv:105.0) Gecko/20100101 Firefox/105.0
2022-10-13T09:06:56.880766474+02:00: WEB ▶ $IP PUT 201 /api/v1/subscriptions/task/101 4.809178ms - Mozilla/5.0 (Macintosh; Intel Mac OS X 10.15; rv:105.0) Gecko/20100101 Firefox/105.0
grep 'T09:06' events.log
2022-10-13T09:06:15.025668387+02:00: DEBUG ▶ [EVENTS] 709d Sending msg to subscriber, message_uuid=a1de219c-44f3-4b20-a901-22b03fb933fa, topic=task.created
2022-10-13T09:06:15.025721907+02:00: DEBUG ▶ [EVENTS] 709e Sent message to subscriber, topic=task.created, message_uuid=a1de219c-44f3-4b20-a901-22b03fb933fa
2022-10-13T09:06:15.025753996+02:00: DEBUG ▶ [EVENTS] 709f Received message, message_uuid=a1de219c-44f3-4b20-a901-22b03fb933fa
2022-10-13T09:06:15.025773393+02:00: DEBUG ▶ [EVENTS] 70a0 Message acked, message_uuid=a1de219c-44f3-4b20-a901-22b03fb933fa
2022-10-13T09:06:15.025783402+02:00: DEBUG ▶ [EVENTS] 70a1 Message acked, message_uuid=a1de219c-44f3-4b20-a901-22b03fb933fa, topic=task.created
2022-10-13T09:06:15.025793781+02:00: DEBUG ▶ [EVENTS] 70a2 Sending msg to subscriber, message_uuid=a1de219c-44f3-4b20-a901-22b03fb933fa, topic=task.created
2022-10-13T09:06:15.025803799+02:00: DEBUG ▶ [EVENTS] 70a3 Sent message to subscriber, topic=task.created, message_uuid=a1de219c-44f3-4b20-a901-22b03fb933fa
2022-10-13T09:06:15.025824828+02:00: DEBUG ▶ [EVENTS] 70a4 Received message, message_uuid=a1de219c-44f3-4b20-a901-22b03fb933fa
2022-10-13T09:06:15.025942067+02:00: DEBUG ▶ [EVENTS] 70a5 Message acked, message_uuid=a1de219c-44f3-4b20-a901-22b03fb933fa
2022-10-13T09:06:15.025955623+02:00: DEBUG ▶ [EVENTS] 70a6 Message acked, message_uuid=a1de219c-44f3-4b20-a901-22b03fb933fa, topic=task.created
2022-10-13T09:06:23.218946845+02:00: DEBUG ▶ [EVENTS] 70fb Sending msg to subscriber, message_uuid=ee0dc505-d247-4e0b-b96e-d07e3e19949b, topic=task.updated
2022-10-13T09:06:23.218975458+02:00: DEBUG ▶ [EVENTS] 70fc Sent message to subscriber, message_uuid=ee0dc505-d247-4e0b-b96e-d07e3e19949b, topic=task.updated
2022-10-13T09:06:23.219006877+02:00: DEBUG ▶ [EVENTS] 70fd Received message, message_uuid=ee0dc505-d247-4e0b-b96e-d07e3e19949b
2022-10-13T09:06:23.219124728+02:00: DEBUG ▶ [EVENTS] 70fe Message acked, message_uuid=ee0dc505-d247-4e0b-b96e-d07e3e19949b
2022-10-13T09:06:23.219143904+02:00: DEBUG ▶ [EVENTS] 70ff Message acked, message_uuid=ee0dc505-d247-4e0b-b96e-d07e3e19949b, topic=task.updated
2022-10-13T09:06:24.955584477+02:00: DEBUG ▶ [EVENTS] 711c Sending msg to subscriber, message_uuid=64deac97-4dab-457f-922e-002e7761fd43, topic=task.updated
2022-10-13T09:06:24.955635313+02:00: DEBUG ▶ [EVENTS] 711d Sent message to subscriber, message_uuid=64deac97-4dab-457f-922e-002e7761fd43, topic=task.updated
2022-10-13T09:06:24.95566094+02:00: DEBUG ▶ [EVENTS] 711e Received message, message_uuid=64deac97-4dab-457f-922e-002e7761fd43
2022-10-13T09:06:24.955754976+02:00: DEBUG ▶ [EVENTS] 711f Message acked, message_uuid=64deac97-4dab-457f-922e-002e7761fd43
2022-10-13T09:06:24.955763542+02:00: DEBUG ▶ [EVENTS] 7120 Message acked, message_uuid=64deac97-4dab-457f-922e-002e7761fd43, topic=task.updated
2022-10-13T09:06:29.331509046+02:00: DEBUG ▶ [EVENTS] 7147 Sending msg to subscriber, message_uuid=a19cdb3d-540d-4ae2-a9ce-86572a23e6a8, topic=task.updated
2022-10-13T09:06:29.331538971+02:00: DEBUG ▶ [EVENTS] 7148 Sent message to subscriber, message_uuid=a19cdb3d-540d-4ae2-a9ce-86572a23e6a8, topic=task.updated
2022-10-13T09:06:29.33157065+02:00: DEBUG ▶ [EVENTS] 7149 Received message, message_uuid=a19cdb3d-540d-4ae2-a9ce-86572a23e6a8
2022-10-13T09:06:29.331722985+02:00: DEBUG ▶ [EVENTS] 714a Message acked, message_uuid=a19cdb3d-540d-4ae2-a9ce-86572a23e6a8
2022-10-13T09:06:29.331735819+02:00: DEBUG ▶ [EVENTS] 714b Message acked, message_uuid=a19cdb3d-540d-4ae2-a9ce-86572a23e6a8, topic=task.updated
2022-10-13T09:06:30.018800446+02:00: DEBUG ▶ [EVENTS] 7168 Sending msg to subscriber, message_uuid=5dc1ef4f-5df1-487d-a43f-89bc651b28b3, topic=task.updated
2022-10-13T09:06:30.018836412+02:00: DEBUG ▶ [EVENTS] 7169 Sent message to subscriber, message_uuid=5dc1ef4f-5df1-487d-a43f-89bc651b28b3, topic=task.updated
2022-10-13T09:06:30.018878972+02:00: DEBUG ▶ [EVENTS] 716a Received message, message_uuid=5dc1ef4f-5df1-487d-a43f-89bc651b28b3
2022-10-13T09:06:30.01904397+02:00: DEBUG ▶ [EVENTS] 716b Message acked, message_uuid=5dc1ef4f-5df1-487d-a43f-89bc651b28b3
2022-10-13T09:06:30.019064288+02:00: DEBUG ▶ [EVENTS] 716c Message acked, message_uuid=5dc1ef4f-5df1-487d-a43f-89bc651b28b3, topic=task.updated
2022-10-13T09:06:34.761559248+02:00: DEBUG ▶ [EVENTS] 718f Sending msg to subscriber, message_uuid=39ce61d5-4f85-4dc7-ba63-56e427941140, topic=task.updated
2022-10-13T09:06:34.761598452+02:00: DEBUG ▶ [EVENTS] 7190 Sent message to subscriber, message_uuid=39ce61d5-4f85-4dc7-ba63-56e427941140, topic=task.updated
2022-10-13T09:06:34.761638797+02:00: DEBUG ▶ [EVENTS] 7191 Received message, message_uuid=39ce61d5-4f85-4dc7-ba63-56e427941140
2022-10-13T09:06:34.761802262+02:00: DEBUG ▶ [EVENTS] 7192 Message acked, message_uuid=39ce61d5-4f85-4dc7-ba63-56e427941140
2022-10-13T09:06:34.761822881+02:00: DEBUG ▶ [EVENTS] 7193 Message acked, topic=task.updated, message_uuid=39ce61d5-4f85-4dc7-ba63-56e427941140
2022-10-13T09:06:40.972165724+02:00: DEBUG ▶ [EVENTS] 71c0 Sending msg to subscriber, message_uuid=b0de6272-8d3a-4f72-bf10-f23d6523191e, topic=task.updated
2022-10-13T09:06:40.972214214+02:00: DEBUG ▶ [EVENTS] 71c1 Sent message to subscriber, message_uuid=b0de6272-8d3a-4f72-bf10-f23d6523191e, topic=task.updated
2022-10-13T09:06:40.972255801+02:00: DEBUG ▶ [EVENTS] 71c2 Received message, message_uuid=b0de6272-8d3a-4f72-bf10-f23d6523191e
2022-10-13T09:06:40.972386015+02:00: DEBUG ▶ [EVENTS] 71c3 Message acked, message_uuid=b0de6272-8d3a-4f72-bf10-f23d6523191e
2022-10-13T09:06:40.972398378+02:00: DEBUG ▶ [EVENTS] 71c4 Message acked, message_uuid=b0de6272-8d3a-4f72-bf10-f23d6523191e, topic=task.updated
2022-10-13T09:06:40.992860488+02:00: DEBUG ▶ [EVENTS] 71e1 Sending msg to subscriber, message_uuid=0ed676ea-5d87-415b-9e10-28fcc413d448, topic=task.updated
2022-10-13T09:06:40.992897958+02:00: DEBUG ▶ [EVENTS] 71e2 Sent message to subscriber, message_uuid=0ed676ea-5d87-415b-9e10-28fcc413d448, topic=task.updated
2022-10-13T09:06:40.992927603+02:00: DEBUG ▶ [EVENTS] 71e3 Received message, message_uuid=0ed676ea-5d87-415b-9e10-28fcc413d448
2022-10-13T09:06:40.993040854+02:00: DEBUG ▶ [EVENTS] 71e4 Message acked, message_uuid=0ed676ea-5d87-415b-9e10-28fcc413d448
2022-10-13T09:06:40.993058176+02:00: DEBUG ▶ [EVENTS] 71e5 Message acked, message_uuid=0ed676ea-5d87-415b-9e10-28fcc413d448, topic=task.updated
2022-10-13T09:06:51.933709806+02:00: DEBUG ▶ [EVENTS] 7212 Sending msg to subscriber, message_uuid=c0549c19-71c4-43fa-acd2-b56461fe30d8, topic=task.updated
2022-10-13T09:06:51.933737007+02:00: DEBUG ▶ [EVENTS] 7213 Sent message to subscriber, message_uuid=c0549c19-71c4-43fa-acd2-b56461fe30d8, topic=task.updated
2022-10-13T09:06:51.933785397+02:00: DEBUG ▶ [EVENTS] 7214 Received message, message_uuid=c0549c19-71c4-43fa-acd2-b56461fe30d8
2022-10-13T09:06:51.933904058+02:00: DEBUG ▶ [EVENTS] 7215 Message acked, message_uuid=c0549c19-71c4-43fa-acd2-b56461fe30d8
2022-10-13T09:06:51.93391607+02:00: DEBUG ▶ [EVENTS] 7216 Message acked, message_uuid=c0549c19-71c4-43fa-acd2-b56461fe30d8, topic=task.updated
2022-10-13T09:06:55.246019063+02:00: DEBUG ▶ [EVENTS] 7247 Sending msg to subscriber, message_uuid=40f5f3b1-4be1-4281-852f-f7affbc7e539, topic=task.assignee.created
2022-10-13T09:06:55.24604991+02:00: DEBUG ▶ [EVENTS] 7248 Sent message to subscriber, message_uuid=40f5f3b1-4be1-4281-852f-f7affbc7e539, topic=task.assignee.created
2022-10-13T09:06:55.246077342+02:00: DEBUG ▶ [EVENTS] 7249 Received message, message_uuid=40f5f3b1-4be1-4281-852f-f7affbc7e539
2022-10-13T09:06:55.247779199+02:00: DEBUG ▶ [EVENTS] 7250 Message acked, message_uuid=40f5f3b1-4be1-4281-852f-f7affbc7e539
2022-10-13T09:06:55.247810918+02:00: DEBUG ▶ [EVENTS] 7251 Message acked, message_uuid=40f5f3b1-4be1-4281-852f-f7affbc7e539, topic=task.assignee.created
2022-10-13T09:06:55.247828701+02:00: DEBUG ▶ [EVENTS] 7252 Sending msg to subscriber, message_uuid=40f5f3b1-4be1-4281-852f-f7affbc7e539, topic=task.assignee.created
2022-10-13T09:06:55.247841315+02:00: DEBUG ▶ [EVENTS] 7253 Sent message to subscriber, topic=task.assignee.created, message_uuid=40f5f3b1-4be1-4281-852f-f7affbc7e539
2022-10-13T09:06:55.247864909+02:00: DEBUG ▶ [EVENTS] 7254 Received message, message_uuid=40f5f3b1-4be1-4281-852f-f7affbc7e539
2022-10-13T09:06:55.249161519+02:00: DEBUG ▶ [EVENTS] 7257 Message acked, message_uuid=40f5f3b1-4be1-4281-852f-f7affbc7e539
2022-10-13T09:06:55.249175937+02:00: DEBUG ▶ [EVENTS] 7258 Message acked, message_uuid=40f5f3b1-4be1-4281-852f-f7affbc7e539, topic=task.assignee.created
grep "mail server" standard.log
2022-10-13T17:21:32.708303434+02:00: INFO ▶ mail/func1 12060 Closed connection to mail server
The last line indicates there weren’t connection to the mail server at ~ 09:06 but only at 17:21 that is the time when I closed that task.